builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0057 starttime: 1448046152.99 results: success (0) buildid: 20151120083333 builduid: 8353a546a241491798788b4908a21888 revision: aef06cd725fc577d1b3449e15cec9fa9f578a286 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-20 11:02:32.988182) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-20 11:02:32.988812) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-20 11:02:32.989339) ========= 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.9OzVgWdEwF/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.PXXEdgHlIO/Listeners TMPDIR=/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/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.005726 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-20 11:02:33.013896) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-20 11:02:33.014336) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-20 11:02:33.035446) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 11:02:33.035859) ========= 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.9OzVgWdEwF/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.PXXEdgHlIO/Listeners TMPDIR=/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/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.005141 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 11:02:33.085195) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-20 11:02:33.085538) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-20 11:02:33.085952) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 11:02:33.086264) ========= 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.9OzVgWdEwF/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.PXXEdgHlIO/Listeners TMPDIR=/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/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-20 11:02:33-- 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.15M=0.001s 2015-11-20 11:02:33 (8.15 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.135468 ========= master_lag: 0.29 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 11:02:33.515773) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 11:02:33.516149) ========= 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.9OzVgWdEwF/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.PXXEdgHlIO/Listeners TMPDIR=/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/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.019372 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 11:02:33.548986) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 11:02:33.549475) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev aef06cd725fc577d1b3449e15cec9fa9f578a286 --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 aef06cd725fc577d1b3449e15cec9fa9f578a286 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.9OzVgWdEwF/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.PXXEdgHlIO/Listeners TMPDIR=/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/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-20 11:02:33,629 truncating revision to first 12 chars 2015-11-20 11:02:33,629 Setting DEBUG logging. 2015-11-20 11:02:33,630 attempt 1/10 2015-11-20 11:02:33,630 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/aef06cd725fc?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-20 11:02:34,269 unpacking tar archive at: fx-team-aef06cd725fc/testing/mozharness/ program finished with exit code 0 elapsedTime=0.883310 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 11:02:34.451264) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-20 11:02:34.451636) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-20 11:02:34.463583) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-20 11:02:34.463977) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-20 11:02:34.464459) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2015-11-20 11:02:34.464800) ========= /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.9OzVgWdEwF/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.PXXEdgHlIO/Listeners TMPDIR=/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/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 11:02:34 INFO - MultiFileLogger online at 20151120 11:02:34 in /builds/slave/test 11:02:34 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 11:02:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:02:34 INFO - {'append_to_log': False, 11:02:34 INFO - 'base_work_dir': '/builds/slave/test', 11:02:34 INFO - 'blob_upload_branch': 'Fx-Team', 11:02:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:02:34 INFO - 'branch': 'Fx-Team', 11:02:34 INFO - 'buildbot_json_path': 'buildprops.json', 11:02:34 INFO - 'config_files': ('talos/mac_config.py',), 11:02:34 INFO - 'default_actions': ('clobber', 11:02:34 INFO - 'read-buildbot-config', 11:02:34 INFO - 'download-and-extract', 11:02:34 INFO - 'populate-webroot', 11:02:34 INFO - 'create-virtualenv', 11:02:34 INFO - 'install', 11:02:34 INFO - 'run-tests'), 11:02:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:02:34 INFO - 'download_minidump_stackwalk': True, 11:02:34 INFO - 'download_symbols': 'ondemand', 11:02:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:02:34 INFO - 'tooltool.py': '/tools/tooltool.py', 11:02:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:02:34 INFO - '/tools/misc-python/virtualenv.py')}, 11:02:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:02:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:02:34 INFO - 'installer_path': 'installer.exe', 11:02:34 INFO - 'log_level': 'info', 11:02:34 INFO - 'log_name': 'talos', 11:02:34 INFO - 'log_to_console': True, 11:02:34 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 11:02:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 11:02:34 INFO - 'opt_config_files': (), 11:02:34 INFO - 'pip_index': False, 11:02:34 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:02:34 INFO - 'cmd': ('bash', 11:02:34 INFO - '-c', 11:02:34 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:02:34 INFO - 'enabled': True, 11:02:34 INFO - 'halt_on_failure': False, 11:02:34 INFO - 'name': 'check_screen_resolution'},), 11:02:34 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:02:34 INFO - 'cmd': ('bash', 11:02:34 INFO - '-c', 11:02:34 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:02:34 INFO - 'enabled': True, 11:02:34 INFO - 'halt_on_failure': False, 11:02:34 INFO - 'name': 'check_screen_resolution'},), 11:02:34 INFO - 'run_cmd_checks_enabled': True, 11:02:34 INFO - 'sps_profile': False, 11:02:34 INFO - 'sps_profile_interval': 0, 11:02:34 INFO - 'suite': 'dromaeojs-e10s', 11:02:34 INFO - 'system_bits': '64', 11:02:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:02:34 INFO - 'title': 't-yosemite-r7-0057', 11:02:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:02:34 INFO - 'use_talos_json': True, 11:02:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:02:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:02:34 INFO - 'work_dir': 'build'} 11:02:34 INFO - ##### 11:02:34 INFO - ##### Running clobber step. 11:02:34 INFO - ##### 11:02:34 INFO - Running pre-action listener: _resource_record_pre_action 11:02:34 INFO - Running main action method: clobber 11:02:34 INFO - rmtree: /builds/slave/test/build 11:02:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:02:36 INFO - Running post-action listener: _resource_record_post_action 11:02:36 INFO - ##### 11:02:36 INFO - ##### Running read-buildbot-config step. 11:02:36 INFO - ##### 11:02:36 INFO - Running pre-action listener: _resource_record_pre_action 11:02:36 INFO - Running main action method: read_buildbot_config 11:02:36 INFO - Using buildbot properties: 11:02:36 INFO - { 11:02:36 INFO - "properties": { 11:02:36 INFO - "buildnumber": 18, 11:02:36 INFO - "product": "firefox", 11:02:36 INFO - "script_repo_revision": "production", 11:02:36 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 11:02:36 INFO - "repository": "", 11:02:36 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 11:02:36 INFO - "buildid": "20151120083333", 11:02:36 INFO - "slavename": "t-yosemite-r7-0057", 11:02:36 INFO - "pgo_build": "False", 11:02:36 INFO - "basedir": "/builds/slave/test", 11:02:36 INFO - "project": "", 11:02:36 INFO - "platform": "yosemite_r7", 11:02:36 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 11:02:36 INFO - "slavebuilddir": "test", 11:02:36 INFO - "scheduler": "tests-fx-team-macosx64-talos", 11:02:36 INFO - "branch": "fx-team", 11:02:36 INFO - "repo_path": "integration/fx-team", 11:02:36 INFO - "stage_platform": "macosx64", 11:02:36 INFO - "builduid": "8353a546a241491798788b4908a21888", 11:02:36 INFO - "revision": "aef06cd725fc577d1b3449e15cec9fa9f578a286" 11:02:36 INFO - }, 11:02:36 INFO - "sourcestamp": { 11:02:36 INFO - "repository": "", 11:02:36 INFO - "hasPatch": false, 11:02:36 INFO - "project": "", 11:02:36 INFO - "branch": "fx-team-macosx64-talos", 11:02:36 INFO - "changes": [ 11:02:36 INFO - { 11:02:36 INFO - "category": null, 11:02:36 INFO - "files": [ 11:02:36 INFO - { 11:02:36 INFO - "url": null, 11:02:36 INFO - "name": "https://queue.taskcluster.net/v1/task/kgTAQ6WKSeSi8Ap5Whwfyg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 11:02:36 INFO - } 11:02:36 INFO - ], 11:02:36 INFO - "repository": "", 11:02:36 INFO - "rev": "aef06cd725fc577d1b3449e15cec9fa9f578a286", 11:02:36 INFO - "who": "ryanvm@gmail.com", 11:02:36 INFO - "when": 1448044253, 11:02:36 INFO - "number": 6689928, 11:02:36 INFO - "comments": "Bug 1226621 - Update pdf.js to version 1.3.14. r=bdahl", 11:02:36 INFO - "project": "", 11:02:36 INFO - "at": "Fri 20 Nov 2015 10:30:53", 11:02:36 INFO - "branch": "fx-team-macosx64-talos", 11:02:36 INFO - "revlink": "", 11:02:36 INFO - "properties": [ 11:02:36 INFO - [ 11:02:36 INFO - "buildid", 11:02:36 INFO - "20151120083333", 11:02:36 INFO - "Change" 11:02:36 INFO - ], 11:02:36 INFO - [ 11:02:36 INFO - "builduid", 11:02:36 INFO - "8353a546a241491798788b4908a21888", 11:02:36 INFO - "Change" 11:02:36 INFO - ], 11:02:36 INFO - [ 11:02:36 INFO - "pgo_build", 11:02:36 INFO - "False", 11:02:36 INFO - "Change" 11:02:36 INFO - ] 11:02:36 INFO - ], 11:02:36 INFO - "revision": "aef06cd725fc577d1b3449e15cec9fa9f578a286" 11:02:36 INFO - } 11:02:36 INFO - ], 11:02:36 INFO - "revision": "aef06cd725fc577d1b3449e15cec9fa9f578a286" 11:02:36 INFO - } 11:02:36 INFO - } 11:02:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/kgTAQ6WKSeSi8Ap5Whwfyg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 11:02:36 INFO - Running post-action listener: _resource_record_post_action 11:02:36 INFO - ##### 11:02:36 INFO - ##### Running download-and-extract step. 11:02:36 INFO - ##### 11:02:36 INFO - Running pre-action listener: _resource_record_pre_action 11:02:36 INFO - Running main action method: download_and_extract 11:02:36 INFO - mkdir: /builds/slave/test/build/tests 11:02: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')]} 11:02:36 INFO - https://queue.taskcluster.net/v1/task/kgTAQ6WKSeSi8Ap5Whwfyg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 11:02:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kgTAQ6WKSeSi8Ap5Whwfyg/artifacts/public/build/test_packages.json 11:02:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kgTAQ6WKSeSi8Ap5Whwfyg/artifacts/public/build/test_packages.json 11:02:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kgTAQ6WKSeSi8Ap5Whwfyg/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 11:02:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kgTAQ6WKSeSi8Ap5Whwfyg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 11:02:38 INFO - Downloaded 1149 bytes. 11:02:38 INFO - Reading from file /builds/slave/test/build/test_packages.json 11:02:38 INFO - Using the following test package requirements: 11:02:38 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 11:02:38 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 11:02:38 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 11:02:38 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 11:02:38 INFO - u'jsshell-mac.zip'], 11:02:38 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 11:02:38 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 11:02:38 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 11:02:38 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 11:02:38 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 11:02:38 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 11:02:38 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 11:02:38 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 11:02:38 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 11:02:38 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 11:02:38 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 11:02:38 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 11:02:38 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 11:02:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:02:38 INFO - https://queue.taskcluster.net/v1/task/kgTAQ6WKSeSi8Ap5Whwfyg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 11:02:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kgTAQ6WKSeSi8Ap5Whwfyg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 11:02:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kgTAQ6WKSeSi8Ap5Whwfyg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 11:02:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kgTAQ6WKSeSi8Ap5Whwfyg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 11:02:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kgTAQ6WKSeSi8Ap5Whwfyg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'}, attempt #1 11:02:39 INFO - Downloaded 17526135 bytes. 11:02:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 11:02:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 11:02:39 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 11:02:42 INFO - Return code: 0 11:02:42 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip', u'firefox-45.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 11:02:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:02:42 INFO - https://queue.taskcluster.net/v1/task/kgTAQ6WKSeSi8Ap5Whwfyg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 11:02:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kgTAQ6WKSeSi8Ap5Whwfyg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 11:02:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kgTAQ6WKSeSi8Ap5Whwfyg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 11:02:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kgTAQ6WKSeSi8Ap5Whwfyg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 11:02:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kgTAQ6WKSeSi8Ap5Whwfyg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'}, attempt #1 11:02:43 INFO - Downloaded 17526135 bytes. 11:02:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 11:02:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 11:02:43 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 11:02:46 INFO - Return code: 0 11:02:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:02:46 INFO - https://queue.taskcluster.net/v1/task/kgTAQ6WKSeSi8Ap5Whwfyg/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 11:02:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kgTAQ6WKSeSi8Ap5Whwfyg/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 11:02:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kgTAQ6WKSeSi8Ap5Whwfyg/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 11:02:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kgTAQ6WKSeSi8Ap5Whwfyg/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 11:02:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kgTAQ6WKSeSi8Ap5Whwfyg/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'}, attempt #1 11:02:47 INFO - Downloaded 11130997 bytes. 11:02:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] in /builds/slave/test/build/tests 11:02:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 11:02:47 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 11:02:47 INFO - Return code: 0 11:02:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:02:47 INFO - https://queue.taskcluster.net/v1/task/kgTAQ6WKSeSi8Ap5Whwfyg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 11:02:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kgTAQ6WKSeSi8Ap5Whwfyg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 11:02:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kgTAQ6WKSeSi8Ap5Whwfyg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 11:02:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kgTAQ6WKSeSi8Ap5Whwfyg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 11:02:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kgTAQ6WKSeSi8Ap5Whwfyg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg'}, attempt #1 11:02:50 INFO - Downloaded 109415340 bytes. 11:02:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/kgTAQ6WKSeSi8Ap5Whwfyg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 11:02:50 INFO - mkdir: /builds/slave/test/properties 11:02:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:02:50 INFO - Writing to file /builds/slave/test/properties/build_url 11:02:50 INFO - Contents: 11:02:50 INFO - build_url:https://queue.taskcluster.net/v1/task/kgTAQ6WKSeSi8Ap5Whwfyg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 11:02:50 INFO - Running post-action listener: _resource_record_post_action 11:02:50 INFO - Running post-action listener: set_extra_try_arguments 11:02:50 INFO - ##### 11:02:50 INFO - ##### Running populate-webroot step. 11:02:50 INFO - ##### 11:02:50 INFO - Running pre-action listener: _resource_record_pre_action 11:02:50 INFO - Running main action method: populate_webroot 11:02:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:02:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:02:50 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 11:02:50 INFO - '../fennec_ids.txt'], 11:02:50 INFO - 'tests': ['tcheck2']}, 11:02:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:02:50 INFO - '--tppagecycles', 11:02:50 INFO - '7'], 11:02:50 INFO - 'tests': ['tsvgm']}}, 11:02:50 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 11:02:50 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 11:02:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:02:50 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 11:02:50 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 11:02:50 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 11:02:50 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:02:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:02:50 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:02:50 INFO - 'talos_options': ['--e10s'], 11:02:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:02:50 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:02:50 INFO - 'tests': ['damp', 'tps']}, 11:02:50 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:02:50 INFO - 'talos_options': ['--e10s'], 11:02:50 INFO - 'tests': ['damp', 'tps']}, 11:02:50 INFO - 'g3': {'tests': ['dromaeo_dom']}, 11:02:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:02:50 INFO - 'other': {'tests': ['a11yr', 11:02:50 INFO - 'ts_paint', 11:02:50 INFO - 'tpaint', 11:02:50 INFO - 'sessionrestore', 11:02:50 INFO - 'sessionrestore_no_auto_restore']}, 11:02:50 INFO - 'other-e10s': {'talos_options': ['--e10s'], 11:02:50 INFO - 'tests': ['a11yr', 11:02:50 INFO - 'ts_paint', 11:02:50 INFO - 'tpaint', 11:02:50 INFO - 'sessionrestore', 11:02:50 INFO - 'sessionrestore_no_auto_restore']}, 11:02:50 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 11:02:50 INFO - 'tests': ['a11yr', 11:02:50 INFO - 'ts_paint', 11:02:50 INFO - 'tpaint', 11:02:50 INFO - 'sessionrestore', 11:02:50 INFO - 'sessionrestore_no_auto_restore']}, 11:02:50 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 11:02:50 INFO - 'tests': ['a11yr', 11:02:50 INFO - 'ts_paint', 11:02:50 INFO - 'tpaint', 11:02:50 INFO - 'sessionrestore', 11:02:50 INFO - 'sessionrestore_no_auto_restore']}, 11:02:50 INFO - 'other_l64': {'tests': ['a11yr', 11:02:50 INFO - 'ts_paint', 11:02:50 INFO - 'tpaint', 11:02:50 INFO - 'sessionrestore', 11:02:50 INFO - 'sessionrestore_no_auto_restore']}, 11:02:50 INFO - 'other_nol64': {'tests': ['a11yr', 11:02:50 INFO - 'ts_paint', 11:02:50 INFO - 'tpaint', 11:02:50 INFO - 'sessionrestore', 11:02:50 INFO - 'sessionrestore_no_auto_restore']}, 11:02:50 INFO - 'svgr': {'tests': ['tsvgx', 11:02:50 INFO - 'tsvgr_opacity', 11:02:50 INFO - 'tart', 11:02:50 INFO - 'tscrollx', 11:02:50 INFO - 'cart']}, 11:02:50 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 11:02:50 INFO - 'tests': ['tsvgx', 11:02:50 INFO - 'tsvgr_opacity', 11:02:50 INFO - 'tart', 11:02:50 INFO - 'tscrollx', 11:02:50 INFO - 'cart']}, 11:02:50 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:02:50 INFO - 'tests': ['tp5o']}, 11:02:50 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:02:50 INFO - 'talos_options': ['--e10s'], 11:02:50 INFO - 'tests': ['tp5o']}, 11:02:50 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:02:50 INFO - 'talos_options': ['--xperf_path', 11:02:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:02:50 INFO - 'tests': ['tp5n']}, 11:02:50 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:02:50 INFO - 'talos_options': ['--e10s', 11:02:50 INFO - '--xperf_path', 11:02:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:02:50 INFO - 'tests': ['tp5n']}}, 11:02:50 INFO - 'talos.zip': {'path': '', 11:02:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:02:50 INFO - Running post-action listener: _resource_record_post_action 11:02:50 INFO - ##### 11:02:50 INFO - ##### Running create-virtualenv step. 11:02:50 INFO - ##### 11:02:50 INFO - Running pre-action listener: _resource_record_pre_action 11:02:50 INFO - Running main action method: create_virtualenv 11:02:50 INFO - Creating virtualenv /builds/slave/test/build/venv 11:02:50 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:02:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:02:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:02:50 INFO - Using real prefix '/tools/python27' 11:02:50 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:02:51 INFO - Installing distribute.............................................................................................................................................................................................done. 11:02:54 INFO - Installing pip.................done. 11:02:54 INFO - Return code: 0 11:02:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:02:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:02:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:02:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:02:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:02:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:02:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:02:54 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 0x10261c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1025f9228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc570d75cf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1025409f0>, '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 0x10229fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1025338c8>, '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.9OzVgWdEwF/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.PXXEdgHlIO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/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 11:02:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:02:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:02:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9OzVgWdEwF/Render', 11:02:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:02:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:02:54 INFO - 'HOME': '/Users/cltbld', 11:02:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:02:54 INFO - 'LOGNAME': 'cltbld', 11:02:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:02:54 INFO - 'MOZ_NO_REMOTE': '1', 11:02:54 INFO - 'NO_EM_RESTART': '1', 11:02:54 INFO - 'PAGER': '/bin/cat', 11:02:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:02:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:02:54 INFO - 'PWD': '/builds/slave/test', 11:02:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:02:54 INFO - 'SHELL': '/bin/bash', 11:02:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PXXEdgHlIO/Listeners', 11:02:54 INFO - 'TMPDIR': '/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/', 11:02:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:02:54 INFO - 'USER': 'cltbld', 11:02:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:02:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:02:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:02:54 INFO - 'XPC_FLAGS': '0x0', 11:02:54 INFO - 'XPC_SERVICE_NAME': '0', 11:02:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:02:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:02:54 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 11:02:54 INFO - Cleaning up... 11:02:54 INFO - Return code: 0 11:02:54 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 11:02:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:02:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:02:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:02:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:02:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:02:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:02:54 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 0x10261c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1025f9228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc570d75cf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1025409f0>, '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 0x10229fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1025338c8>, '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.9OzVgWdEwF/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.PXXEdgHlIO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/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 11:02:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 11:02:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 11:02:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9OzVgWdEwF/Render', 11:02:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:02:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:02:54 INFO - 'HOME': '/Users/cltbld', 11:02:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:02:54 INFO - 'LOGNAME': 'cltbld', 11:02:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:02:54 INFO - 'MOZ_NO_REMOTE': '1', 11:02:54 INFO - 'NO_EM_RESTART': '1', 11:02:54 INFO - 'PAGER': '/bin/cat', 11:02:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:02:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:02:54 INFO - 'PWD': '/builds/slave/test', 11:02:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:02:54 INFO - 'SHELL': '/bin/bash', 11:02:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PXXEdgHlIO/Listeners', 11:02:54 INFO - 'TMPDIR': '/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/', 11:02:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:02:54 INFO - 'USER': 'cltbld', 11:02:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:02:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:02:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:02:54 INFO - 'XPC_FLAGS': '0x0', 11:02:54 INFO - 'XPC_SERVICE_NAME': '0', 11:02:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:02:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:02:54 INFO - Downloading/unpacking psutil>=0.7.1 11:02:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:02:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:02:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:02:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:02:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:02:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:02:57 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 11:02:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 11:02:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:02:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:02:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:02:57 INFO - Installing collected packages: psutil 11:02:57 INFO - Running setup.py install for psutil 11:02:57 INFO - building 'psutil._psutil_osx' extension 11:02:57 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 11:02:58 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 11:02:58 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 11:02:58 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 11:02:58 INFO - building 'psutil._psutil_posix' extension 11:02:58 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 11:02:58 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 11:02:58 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 11:02:58 INFO - ^ 11:02:58 INFO - 1 warning generated. 11:02:58 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 11:02:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:02:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:02:58 INFO - Successfully installed psutil 11:02:58 INFO - Cleaning up... 11:02:58 INFO - Return code: 0 11:02:58 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 11:02:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:02:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:02:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:02:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:02:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:02:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:02:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10261c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1025f9228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc570d75cf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1025409f0>, '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 0x10229fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1025338c8>, '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.9OzVgWdEwF/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.PXXEdgHlIO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/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 11:02:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 11:02:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 11:02:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9OzVgWdEwF/Render', 11:02:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:02:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:02:58 INFO - 'HOME': '/Users/cltbld', 11:02:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:02:58 INFO - 'LOGNAME': 'cltbld', 11:02:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:02:58 INFO - 'MOZ_NO_REMOTE': '1', 11:02:58 INFO - 'NO_EM_RESTART': '1', 11:02:58 INFO - 'PAGER': '/bin/cat', 11:02:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:02:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:02:58 INFO - 'PWD': '/builds/slave/test', 11:02:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:02:58 INFO - 'SHELL': '/bin/bash', 11:02:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PXXEdgHlIO/Listeners', 11:02:58 INFO - 'TMPDIR': '/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/', 11:02:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:02:58 INFO - 'USER': 'cltbld', 11:02:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:02:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:02:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:02:58 INFO - 'XPC_FLAGS': '0x0', 11:02:58 INFO - 'XPC_SERVICE_NAME': '0', 11:02:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:02:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:02:58 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:02:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:02:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:02:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:02:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:02:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:02:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:03:00 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:03:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 11:03:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:03:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 11:03:01 INFO - Installing collected packages: mozsystemmonitor 11:03:01 INFO - Running setup.py install for mozsystemmonitor 11:03:01 INFO - Successfully installed mozsystemmonitor 11:03:01 INFO - Cleaning up... 11:03:01 INFO - Return code: 0 11:03:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:03:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:03:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:03:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:03:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:03:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:03:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:03:01 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 0x10261c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1025f9228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc570d75cf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1025409f0>, '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 0x10229fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1025338c8>, '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.9OzVgWdEwF/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.PXXEdgHlIO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/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 11:03:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:03:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:03:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9OzVgWdEwF/Render', 11:03:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:03:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:03:01 INFO - 'HOME': '/Users/cltbld', 11:03:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:03:01 INFO - 'LOGNAME': 'cltbld', 11:03:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:03:01 INFO - 'MOZ_NO_REMOTE': '1', 11:03:01 INFO - 'NO_EM_RESTART': '1', 11:03:01 INFO - 'PAGER': '/bin/cat', 11:03:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:03:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:03:01 INFO - 'PWD': '/builds/slave/test', 11:03:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:03:01 INFO - 'SHELL': '/bin/bash', 11:03:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PXXEdgHlIO/Listeners', 11:03:01 INFO - 'TMPDIR': '/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/', 11:03:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:03:01 INFO - 'USER': 'cltbld', 11:03:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:03:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:03:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:03:01 INFO - 'XPC_FLAGS': '0x0', 11:03:01 INFO - 'XPC_SERVICE_NAME': '0', 11:03:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:03:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:03:01 INFO - Downloading/unpacking blobuploader==1.2.4 11:03:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:03:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:03:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:03:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:03:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:03:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:03:03 INFO - Downloading blobuploader-1.2.4.tar.gz 11:03:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 11:03:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:03:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:03:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:03:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:03:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:03:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:03:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:03:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:03:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 11:03:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:03:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:03:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:03:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:03:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:03:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:03:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:03:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:03:04 INFO - Downloading docopt-0.6.1.tar.gz 11:03:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 11:03:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:03:04 INFO - Installing collected packages: blobuploader, requests, docopt 11:03:04 INFO - Running setup.py install for blobuploader 11:03:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:03:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:03:04 INFO - Running setup.py install for requests 11:03:05 INFO - Running setup.py install for docopt 11:03:05 INFO - Successfully installed blobuploader requests docopt 11:03:05 INFO - Cleaning up... 11:03:05 INFO - Return code: 0 11:03:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:03:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:03:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:03:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:03:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:03:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:03:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:03:05 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 0x10261c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1025f9228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc570d75cf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1025409f0>, '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 0x10229fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1025338c8>, '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.9OzVgWdEwF/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.PXXEdgHlIO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/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 11:03:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:03:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:03:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9OzVgWdEwF/Render', 11:03:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:03:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:03:05 INFO - 'HOME': '/Users/cltbld', 11:03:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:03:05 INFO - 'LOGNAME': 'cltbld', 11:03:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:03:05 INFO - 'MOZ_NO_REMOTE': '1', 11:03:05 INFO - 'NO_EM_RESTART': '1', 11:03:05 INFO - 'PAGER': '/bin/cat', 11:03:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:03:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:03:05 INFO - 'PWD': '/builds/slave/test', 11:03:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:03:05 INFO - 'SHELL': '/bin/bash', 11:03:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PXXEdgHlIO/Listeners', 11:03:05 INFO - 'TMPDIR': '/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/', 11:03:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:03:05 INFO - 'USER': 'cltbld', 11:03:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:03:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:03:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:03:05 INFO - 'XPC_FLAGS': '0x0', 11:03:05 INFO - 'XPC_SERVICE_NAME': '0', 11:03:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:03:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:03:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:03:05 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-17bPX_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:03:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:03:06 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-dvDKQc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:03:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:03:06 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-2kYT1m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:03:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:03:06 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-yOX2dF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:03:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:03:06 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-8ffNtm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:03:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:03:06 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-6gWcjm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:03:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:03:06 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-7Rhv7F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:03:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:03:06 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-wsqG62-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:03:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:03:06 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-QpmN3j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:03:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:03:06 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-c7NSZI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:03:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:03:07 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-A1V4KC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:03:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:03:07 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-mn6EDf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:03:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:03:07 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-eABrTb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:03:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:03:07 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-pLaM1d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:03:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:03:07 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-M5Ql7q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:03:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:03:07 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-5Cb_3Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:03:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:03:07 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-wPONVf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:03:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:03:07 INFO - Running setup.py install for manifestparser 11:03:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:03:07 INFO - Running setup.py install for mozcrash 11:03:08 INFO - Running setup.py install for mozdebug 11:03:08 INFO - Running setup.py install for mozdevice 11:03:08 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:03:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:03:08 INFO - Running setup.py install for mozfile 11:03:08 INFO - Running setup.py install for mozhttpd 11:03:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:03:08 INFO - Running setup.py install for mozinfo 11:03:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:03:08 INFO - Running setup.py install for mozInstall 11:03:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:03:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:03:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:03:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:03:08 INFO - Running setup.py install for mozleak 11:03:09 INFO - Running setup.py install for mozlog 11:03:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:03:09 INFO - Running setup.py install for moznetwork 11:03:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:03:09 INFO - Running setup.py install for mozprocess 11:03:09 INFO - Running setup.py install for mozprofile 11:03:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:03:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:03:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:03:09 INFO - Running setup.py install for mozrunner 11:03:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:03:09 INFO - Running setup.py install for mozscreenshot 11:03:10 INFO - Running setup.py install for moztest 11:03:10 INFO - Running setup.py install for mozversion 11:03:10 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:03:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:03:10 INFO - Cleaning up... 11:03:10 INFO - Return code: 0 11:03:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:03:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:03:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:03:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:03:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:03:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:03:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:03:10 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 0x10261c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1025f9228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc570d75cf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1025409f0>, '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 0x10229fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1025338c8>, '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.9OzVgWdEwF/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.PXXEdgHlIO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/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 11:03:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:03:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:03:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9OzVgWdEwF/Render', 11:03:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:03:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:03:10 INFO - 'HOME': '/Users/cltbld', 11:03:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:03:10 INFO - 'LOGNAME': 'cltbld', 11:03:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:03:10 INFO - 'MOZ_NO_REMOTE': '1', 11:03:10 INFO - 'NO_EM_RESTART': '1', 11:03:10 INFO - 'PAGER': '/bin/cat', 11:03:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:03:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:03:10 INFO - 'PWD': '/builds/slave/test', 11:03:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:03:10 INFO - 'SHELL': '/bin/bash', 11:03:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PXXEdgHlIO/Listeners', 11:03:10 INFO - 'TMPDIR': '/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/', 11:03:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:03:10 INFO - 'USER': 'cltbld', 11:03:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:03:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:03:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:03:10 INFO - 'XPC_FLAGS': '0x0', 11:03:10 INFO - 'XPC_SERVICE_NAME': '0', 11:03:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:03:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:03:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:03:10 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-Yyrp2i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:03:10 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 11:03:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:03:10 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-D4Tp_i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:03:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:03:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:03:10 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-jt1s0o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:03:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:03:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:03:10 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-AhmD3L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:03:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:03:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:03:11 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-fuQtcy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:03:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 11:03:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:03:11 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-tlNJjy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:03:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 11:03:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:03:11 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-GfVutS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:03:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 11:03:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:03:11 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-PrvE51-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:03:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 11:03:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:03:11 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-n5cjfo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:03:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 11:03:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:03:11 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-MhZEGJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:03:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:03:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:03:11 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-uSCUYN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:03:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 11:03:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:03:11 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-ZH6vya-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:03:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 11:03:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:03:11 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-6omKal-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:03:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 11:03:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:03:11 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-oJRmQP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:03:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 11:03:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:03:12 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-vusweX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:03:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 11:03:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:03:12 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-dLBlQx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:03:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 11:03:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:03:12 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-lpVoL7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:03:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 11:03:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:03:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:03:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:03:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:03:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:03:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:03:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:03:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:03:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:03:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:03:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:03:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:03:14 INFO - Downloading blessings-1.5.1.tar.gz 11:03:14 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 11:03:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:03:14 INFO - Installing collected packages: blessings 11:03:14 INFO - Running setup.py install for blessings 11:03:14 INFO - Successfully installed blessings 11:03:14 INFO - Cleaning up... 11:03:14 INFO - Return code: 0 11:03:14 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:03:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:03:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:03:15 INFO - Reading from file tmpfile_stdout 11:03:15 INFO - Current package versions: 11:03:15 INFO - blessings == 1.5.1 11:03:15 INFO - blobuploader == 1.2.4 11:03:15 INFO - docopt == 0.6.1 11:03:15 INFO - manifestparser == 1.1 11:03:15 INFO - mozInstall == 1.12 11:03:15 INFO - mozcrash == 0.16 11:03:15 INFO - mozdebug == 0.1 11:03:15 INFO - mozdevice == 0.47 11:03:15 INFO - mozfile == 1.2 11:03:15 INFO - mozhttpd == 0.7 11:03:15 INFO - mozinfo == 0.9 11:03:15 INFO - mozleak == 0.1 11:03:15 INFO - mozlog == 3.0 11:03:15 INFO - moznetwork == 0.27 11:03:15 INFO - mozprocess == 0.22 11:03:15 INFO - mozprofile == 0.27 11:03:15 INFO - mozrunner == 6.11 11:03:15 INFO - mozscreenshot == 0.1 11:03:15 INFO - mozsystemmonitor == 0.0 11:03:15 INFO - moztest == 0.7 11:03:15 INFO - mozversion == 1.4 11:03:15 INFO - psutil == 3.1.1 11:03:15 INFO - requests == 1.2.3 11:03:15 INFO - wsgiref == 0.1.2 11:03:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:03:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:03:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:03:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:03:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:03:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:03:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:03:15 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 0x10261c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1025f9228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc570d75cf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1025409f0>, '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 0x10229fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1025338c8>, '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.9OzVgWdEwF/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.PXXEdgHlIO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/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 11:03:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 11:03:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:03:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9OzVgWdEwF/Render', 11:03:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:03:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:03:15 INFO - 'HOME': '/Users/cltbld', 11:03:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:03:15 INFO - 'LOGNAME': 'cltbld', 11:03:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:03:15 INFO - 'MOZ_NO_REMOTE': '1', 11:03:15 INFO - 'NO_EM_RESTART': '1', 11:03:15 INFO - 'PAGER': '/bin/cat', 11:03:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:03:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:03:15 INFO - 'PWD': '/builds/slave/test', 11:03:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:03:15 INFO - 'SHELL': '/bin/bash', 11:03:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PXXEdgHlIO/Listeners', 11:03:15 INFO - 'TMPDIR': '/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/', 11:03:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:03:15 INFO - 'USER': 'cltbld', 11:03:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:03:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:03:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:03:15 INFO - 'XPC_FLAGS': '0x0', 11:03:15 INFO - 'XPC_SERVICE_NAME': '0', 11:03:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:03:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:03:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:03:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 11:03:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 11:03:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:03:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 11:03:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 11:03:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 11:03:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 11:03:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:03:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 11:03:15 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:03:15 INFO - Cleaning up... 11:03:15 INFO - Return code: 0 11:03:15 INFO - Running post-action listener: _resource_record_post_action 11:03:15 INFO - Running post-action listener: _start_resource_monitoring 11:03:15 INFO - Starting resource monitoring. 11:03:15 INFO - ##### 11:03:15 INFO - ##### Running install step. 11:03:15 INFO - ##### 11:03:15 INFO - Running pre-action listener: _resource_record_pre_action 11:03:15 INFO - Running main action method: install 11:03:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:03:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:03:15 INFO - Reading from file tmpfile_stdout 11:03:15 INFO - Detecting whether we're running mozinstall >=1.0... 11:03:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:03:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:03:15 INFO - Reading from file tmpfile_stdout 11:03:15 INFO - Output received: 11:03:15 INFO - Usage: mozinstall [options] installer 11:03:15 INFO - Options: 11:03:15 INFO - -h, --help show this help message and exit 11:03:15 INFO - -d DEST, --destination=DEST 11:03:15 INFO - Directory to install application into. [default: 11:03:15 INFO - "/builds/slave/test"] 11:03:15 INFO - --app=APP Application being installed. [default: firefox] 11:03:15 INFO - mkdir: /builds/slave/test/build/application 11:03:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 11:03:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 11:03:46 INFO - Reading from file tmpfile_stdout 11:03:46 INFO - Output received: 11:03:46 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 11:03:46 INFO - Running post-action listener: _resource_record_post_action 11:03:46 INFO - ##### 11:03:46 INFO - ##### Running run-tests step. 11:03:46 INFO - ##### 11:03:46 INFO - Running pre-action listener: _resource_record_pre_action 11:03:46 INFO - Running main action method: run_tests 11:03:46 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:03:46 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:03:46 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:03:46 INFO - 2015-11-20 11:03:46.826 screenresolution[1929:19007] starting screenresolution argv=screenresolution get 11:03:46 INFO - 2015-11-20 11:03:46.828 screenresolution[1929:19007] Display 0: 1600x1200x32@60 11:03:46 INFO - 2015-11-20 11:03:46.835 screenresolution[1930:19009] starting screenresolution argv=screenresolution list 11:03:46 INFO - Available Modes on Display 0 11:03:46 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:03:46 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:03:46 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:03:46 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:03:47 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:03:47 INFO - Intel Iris: 11:03:47 INFO - Chipset Model: Intel Iris 11:03:47 INFO - Type: GPU 11:03:47 INFO - Bus: Built-In 11:03:47 INFO - VRAM (Dynamic, Max): 1536 MB 11:03:47 INFO - Vendor: Intel (0x8086) 11:03:47 INFO - Device ID: 0x0a2e 11:03:47 INFO - Revision ID: 0x0009 11:03:47 INFO - Displays: 11:03:47 INFO - Display: 11:03:47 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:03:47 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:03:47 INFO - Display Serial Number: 1600x1200 60 11:03:47 INFO - Main Display: Yes 11:03:47 INFO - Mirror: Off 11:03:47 INFO - Online: Yes 11:03:47 INFO - Rotation: Supported 11:03:47 INFO - Return code: 0 11:03:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:03:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:03:47 INFO - Python 2.7.3 11:03:47 INFO - Return code: 0 11:03:47 INFO - grabbing minidump binary from tooltool 11:03:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:03:47 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 0x1025409f0>, '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 0x10229fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1025338c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:03:47 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 11:03:47 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 11:03:47 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:03:47 INFO - Return code: 0 11:03:47 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 11:03:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:03:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:03:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 11:03:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:03:47 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/kgTAQ6WKSeSi8Ap5Whwfyg/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0057', '--webServer', 'localhost'] in /builds/slave/test/build 11:03:47 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/kgTAQ6WKSeSi8Ap5Whwfyg/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0057 --webServer localhost 11:03:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9OzVgWdEwF/Render', 11:03:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:03:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:03:47 INFO - 'HOME': '/Users/cltbld', 11:03:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:03:47 INFO - 'LOGNAME': 'cltbld', 11:03:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:03:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 11:03:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:03:47 INFO - 'MOZ_NO_REMOTE': '1', 11:03:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:03:47 INFO - 'NO_EM_RESTART': '1', 11:03:47 INFO - 'PAGER': '/bin/cat', 11:03:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:03:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:03:47 INFO - 'PWD': '/builds/slave/test', 11:03:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:03:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:03:47 INFO - 'SHELL': '/bin/bash', 11:03:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PXXEdgHlIO/Listeners', 11:03:47 INFO - 'TMPDIR': '/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/', 11:03:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:03:47 INFO - 'USER': 'cltbld', 11:03:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:03:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:03:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:03:47 INFO - 'XPC_FLAGS': '0x0', 11:03:47 INFO - 'XPC_SERVICE_NAME': '0', 11:03:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:03:47 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/kgTAQ6WKSeSi8Ap5Whwfyg/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0057', '--webServer', 'localhost'] with output_timeout 3600 11:03:47 INFO - mozversion INFO | application_buildid: 20151120083333 11:03:47 INFO - mozversion INFO | application_changeset: aef06cd725fc577d1b3449e15cec9fa9f578a286 11:03:47 INFO - mozversion INFO | application_display_name: Nightly 11:03:47 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:03:47 INFO - mozversion INFO | application_name: Firefox 11:03:47 INFO - mozversion INFO | application_remotingname: firefox 11:03:47 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 11:03:47 INFO - mozversion INFO | application_vendor: Mozilla 11:03:47 INFO - mozversion INFO | application_version: 45.0a1 11:03:47 INFO - mozversion INFO | platform_buildid: 20151120083333 11:03:47 INFO - mozversion INFO | platform_changeset: aef06cd725fc577d1b3449e15cec9fa9f578a286 11:03:47 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 11:03:47 INFO - mozversion INFO | platform_version: 45.0a1 11:03:47 INFO - 2015-11-20 11:03:47,376 DEBUG : using testdate: 1448046227 11:03:47 INFO - 2015-11-20 11:03:47,376 DEBUG : actual date: 1448046227 11:03:47 INFO - 2015-11-20 11:03:47,385 INFO : starting webserver on 'localhost:57262' 11:03:47 INFO - 2015-11-20 11:03:47,386 INFO : Starting test suite t-yosemite-r7-0057.e 11:03:47 INFO - 2015-11-20 11:03:47,386 INFO : Starting test dromaeo_css 11:03:47 INFO - 2015-11-20 11:03:47,386 DEBUG : operating with platform_type : mac_ 11:03:47 INFO - 2015-11-20 11:03:47,387 INFO : Initialising browser for dromaeo_css test... 11:03:47 INFO - 2015-11-20 11:03:47,398 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/tmpDDEQoF/profile http://localhost:57262/getInfo.html 11:03:50 INFO - 2015-11-20 11:03:50,093 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:03:50 INFO - 2015-11-20 11:03:50,093 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:03:50 INFO - 2015-11-20 11:03:50,093 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 11:03:50 INFO - 2015-11-20 11:03:50,093 DEBUG : BROWSER_OUTPUT: __metrics 11:03:50 INFO - 2015-11-20 11:03:50,684 INFO : Browser initialized. 11:03:50 INFO - 2015-11-20 11:03:50,685 INFO : Running cycle 1/1 for dromaeo_css test... 11:03:50 INFO - 2015-11-20 11:03:50,685 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/tmpDDEQoF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:04:02 INFO - 2015-11-20 11:04:02,547 DEBUG : BROWSER_OUTPUT: RSS: Main: 236097536 11:04:02 INFO - 2015-11-20 11:04:02,547 DEBUG : BROWSER_OUTPUT: 11:04:52 INFO - 2015-11-20 11:04:52,221 DEBUG : BROWSER_OUTPUT: 1448046292220 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 11:07:03 INFO - 2015-11-20 11:07:03,263 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57262/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57262/tests/dromaeo/cssquery-ext.html) 11:07:04 INFO - 2015-11-20 11:07:04,480 DEBUG : BROWSER_OUTPUT: RSS: Main: 253304832 11:07:04 INFO - 2015-11-20 11:07:04,481 DEBUG : BROWSER_OUTPUT: 11:10:06 INFO - 2015-11-20 11:10:06,423 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57262/tests/dromaeo/cssquery-ext.html (next: http://localhost:57262/tests/dromaeo/cssquery-jquery.html) 11:10:07 INFO - 2015-11-20 11:10:07,017 DEBUG : BROWSER_OUTPUT: RSS: Main: 263340032 11:10:07 INFO - 2015-11-20 11:10:07,017 DEBUG : BROWSER_OUTPUT: 11:13:08 INFO - 2015-11-20 11:13:08,664 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57262/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57262/tests/dromaeo/cssquery-mootools.html) 11:13:09 INFO - 2015-11-20 11:13:09,263 DEBUG : BROWSER_OUTPUT: RSS: Main: 265379840 11:13:09 INFO - 2015-11-20 11:13:09,263 DEBUG : BROWSER_OUTPUT: 11:16:10 INFO - 2015-11-20 11:16:10,858 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57262/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57262/tests/dromaeo/cssquery-prototype.html) 11:16:11 INFO - 2015-11-20 11:16:11,468 DEBUG : BROWSER_OUTPUT: RSS: Main: 266035200 11:16:11 INFO - 2015-11-20 11:16:11,468 DEBUG : BROWSER_OUTPUT: 11:19:13 INFO - 2015-11-20 11:19:13,969 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57262/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57262/tests/dromaeo/cssquery-yui.html) 11:19:14 INFO - 2015-11-20 11:19:14,573 DEBUG : BROWSER_OUTPUT: RSS: Main: 270274560 11:19:14 INFO - 2015-11-20 11:19:14,573 DEBUG : BROWSER_OUTPUT: 11:22:16 INFO - 2015-11-20 11:22:16,893 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57262/tests/dromaeo/cssquery-yui.html (next: http://localhost:57262/tests/dromaeo/cssquery-dojo.html) 11:22:17 INFO - 2015-11-20 11:22:17,149 DEBUG : BROWSER_OUTPUT: RSS: Main: 272199680 11:22:17 INFO - 2015-11-20 11:22:17,150 DEBUG : BROWSER_OUTPUT: 11:22:17 INFO - 2015-11-20 11:22:17,150 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:22:17 INFO - 2015-11-20 11:22:17,150 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:22:17 INFO - 2015-11-20 11:22:17,150 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:22:17 INFO - 2015-11-20 11:22:17,150 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:22:17 INFO - 2015-11-20 11:22:17,150 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3397.7621566490348;3469.68772810447;3482.895513134607;3516.3670539302916;3519.87680431185;5717.914231286529;5771.682557459338;5788;5792.362840087587;5800.245968024156;5622.690752008648;5785.247917770695;5785.652860828353;5795.82612521624;5896.557758168133;5212.582993360532;5230.843074707765;5286.154215325549;5347.518723314901;5361.08861493547;4834.444038935515;5373.731313434332;5393.460653934614;5401.27082843817;5401.297831281928;5154.742262886841;5157.974210128963;5245.921311180336;5292.444293349201;5301.628885977983;5277.736113194325;5287.074761916688;5305.920411193835;5316;5320.334958130234;5219.217117432378;5234.528892399664;5245.423003469616;5258.421573626898;5324.307839980777;5092.8217512387255;5472.015037293286;5663.4336566343445;5791.0734282514595;5826.912596311059;6261.87476250477;6278.49772018242;6309.179806625155;6316.463100636452;6341.80974570759;6330.588511746768;6352.587081839712;6356.173697419352;6360.491160707179;6384.585001974903;5756.28046494184;5804.158397032406;5877.647341159544;5882.441168089024;5941.22764040672;6336.936630633727;6390.764366044538;6439.742410303629;6446;6499.7400103995315;6016.548758843104;6280.183576135073;6290.685465726695;6302.401271879165;6302.432781049728;4881.731504767201;6204.37956204385;6238.563300568917;6269.373062693785;6269.686515674198;6243.219597550306;6251.9687401562705;6273.96863015682;6287.46556542699;6320.304766475684;6120.264288666148;6273.529485288622;6279.686015699197;6284.937150628435;6288.245410550763;4924.1875090610365;4964.081644895706;4966;4981.227909674007;5020.3724534433195;4478.6864919455975;4480.283154695298;4491.910161796745;4499.820007199741;4533.297338912408;5663.490285874291;5802.100674395476;5851.824445266649;6024.879502409927;6033.607815491979;6091;6250.124982502453;6319.905201421982;6325.05124231369;6326.430621244018;5192.428832828386;5253.894922101536;5904.084866845646;5968.641881487125;6003.099535069775;4185.476815398075;5350.036993341236;5439.211314359396;5503.752331145108;5542.307211598551;6421.678916054178;6423.953117944528;6425.614463132227;6432.839179020562;6449.451796597248;6343.365663433804;6356;6359.936400635935;6363.172787537591;6378.936210637834;6228.439440450381;6304.306526282197;6347.0479428086155;6361.491080713439;6370.74517019314;6282.874342513032;6294.433500984934;6298.1812364392335;6303.747850086129;6314.84212894663;6297.992321228581;6314.652694101868;6327.936720632919;6337.904931426125;6341.397567231105;6076.54425918049;6137.591499645514;6143.262808463013;6185.752569897334;6196.1015652731;6248.781292654735;6249.625022498664;6278.623282603058;6285.402886725937;6290.2766181889665;4512.842050528216;6084.209052823105;6100.115483254992;6143.508519318533;6163.599366041193;5847.473727364558;5852.707364631837;5894.233749612695;5935.495482883831;6150.446459818638;6136.23297087864;6175.320714721467;6209.59637623553;6211.782587609412;6215.533834962305 11:22:17 INFO - 2015-11-20 11:22:17,151 DEBUG : BROWSER_OUTPUT: |1;ext.html;564.7317524176019;565.9886802263954;593.0599999001582;629.5907660020986;632.5730132160792;39886.60113398865;40155.397669034915;40273.79863100687;40315.99210019751;40443.79778101109;41851;41991.79004104975;42214.7889260554;42323.57676423235;42408.36387454183;9754.512274386288;9916.603335866557;9930.90069099307;9946.154576860976;9968.451735154564;9747.805043899154;9851.310408271424;9856.162226210745;9881.654142105028;9886.851697224547;9797.461139637317;9859.866115396713;9871.210303175765;9894.40633561985;9896.109350158484;8334.291585215264;8878.644854205888;9714.077162669535;9825.459599722013;9831.65589204378;8378.622961966727;9810.166135878459;9823.214142868625;9824.754381140458;9825.066618671215;39142.80428597867;39368;39477.80261098705;39484.802575987225;39538.40692389617;3190.218396492851;3310.2882880180637;3407.4888766685194;3443;3527.9118022049397;28149.155525334274;28228.717712822814;28390.85804570964;28550;29456.705432945826;2731.289864635189;2820.8025438219333;2826.3499395139233;2851.985740071307;2866.154484427099;611347;689702;696582;699060.5046974733;699174.9999999949;61905;68980;69544.6522767393;69612.65193674101;69647.3035269651;61960.380396196364;73326.63336683389;73802.63098684473;73839.89240161402;74612;16409.6718065638;16420.4252851152;16473.423430180126;16630.6673866522;16651.33394664224;12549.749005019848;12634.052446066582;12683.556075537312;12737.55418560346;12741;20842.791572084087;20929;21154.47113822136;21171.364859054254;21741.021654025608;9404.742861713139;9635.759106022266;9641.807163856824;9650.95174524137;9665.405208140579;940.3840484482674;961.6297725375781;991.6727479931606;1000.5447521377756;1058.9099926506178;29732.851335743184;29734.553981690293;30341.69658303389;30344.241393965327;30367;914.3736540469799;1012.5696578953915;1050.5272627317738;1080.6271836216492;1084.7938891610727;12512.436940337706;14471.493497727739;14797.852021479863;14834.851651483563;14920.955533112578;670363;670415;672577;674406;683188;56177.87644247092;56264.71867640636;56691.433085668614;56845.71577142088;57244;1389.2914613547164;1444.3933547909903;1450.52132796177;1481.2815784344584;1537.3773621683235;28593.14220573386;28764.280892977844;29079.85460072686;29083.12750617485;29323.41353172967;49464.50535494743;49531.009379812924;49993.50006499889;50044.74977625089;50237.246441302676;518552;518738;519299;520333;522922;28959.276018098873;29455;32223.35553288968;32885.50671739878;32989.01032969015;39786.60213397829;40127;41327;41623.959401015214;41809.95475113147;33625;34988;35072.772452964025;35191.824040879634;35409.29181416306;35228.647713522536;35407.90328220992;35978.28043439169;36102.819485903456;36111.63888361083;35102.47346289859;35154;35196.824015879756;38362.80818595889;39111;32748.34503309873;34458.310833782685;34831.82584087063;42193.578064218964;42884.57115428806;26708.866455667598;32032.039038828872;32032.199195019377;32798.34403311873;33287 11:22:17 INFO - 2015-11-20 11:22:17,155 DEBUG : BROWSER_OUTPUT: |2;jquery.html;338.9779664321819;360.6763179132583;364.6207943738512;366.7982609564739;368.0834721543356;16192.927652130451;17466.388676396327;19384;20554.486137846543;21368.89315553424;19431.417057488263;20099.899500502514;20132;20348.59302813943;20763.377098687062;5649.0114230009785;5842.97078514609;5850.853728656796;5861.8569378971115;5868.970655146718;3933.3706606942897;4034.899127521821;5531.695756733378;5685.1756495308155;5829.650220986754;5798.362180160179;5800.332961709394;5808.099744539603;5827.796027139051;5828.300603927534;5835.649861008332;6391.392817682313;6435.066915297302;6441.0982462455295;6472.611643301417;5447.591430642718;5522.282103326542;5594.58040646949;5604;5606.074997625427;12796.61610151697;12956.028297877603;12981.41583628739;13031.152975056686;21026.369208923756;1931.5267759398896;2001.609686111209;2138.8182004529635;2262.9773702263096;2266.5466906618576;8592.785180370478;9029.96155442126;9534.380265282804;9964.402135871798;10032.94983525085;1696.2790813904041;1727.6890159771235;1749.2041121289783;1757.745126956597;1800.3608718904861;101210.49394753053;107218.46390768074;108547.91452085537;108754;109942;11190.944045279884;11226.158038147172;11279.548818047351;11403.885961140448;11404.973552380327;13269.535566255328;13291.110923308614;13324.200547967153;13372.130811497222;13404.664883377798;7288.96355518219;8643.870341944876;8670.263027642595;8687.131286871389;8738.650453981896;8824.470531768115;8853.29173666118;8911.287097032222;8918.554072296489;8979.77550561228;4313.245182093121;4361.127774445124;4372.825086996548;4403.427554417905;4421.53573874745;1480.9777853331993;1643.8931469454446;1797.8831375960522;1806.8102849200907;1843.741876137342;897.4525539420948;919.9448033118034;927.9257659387233;1005.9094681478703;1028.4497793680346;18606.255749769858;18651.440456786317;19069.427917162506;19633.31283405074;21155.942202889793;853.6201390381345;911.6991392840347;943.1228957069991;965.8599503072156;989.6635144051057;9748.46383448903;10449.529771160316;10610.734731631772;10673.092787113183;10724.356538607708;634039;663516;772634;774801;786633;126984.36507817401;127021;128551.71448285585;131578;133136;1170.7775522650838;1191.6246382389693;1193.3138445393934;1204.692803335144;1205.102198861836;18011.279548818424;18113.547161321072;18210.72683909716;18298.26806927708;18492.260309587466;51261.74369128131;51993;52180.73909630428;52418.73790631023;53070.73464632806;74626;75214;75316;75692;76948.61525692335;9511.619535218513;9633.843938727397;9693.854592180982;9736.95131524338;10115.848262275924;19219.615607688047;19221.807781922562;19461.026948652227;20534.383968480968;20628;15490.9225453872;15532.456364027204;15895.284712187748;16283.755743663618;16305.836941630907;15549.989250698669;15586.532404027897;15645.608859778597;15653.21733913277;15884.205789710237;15950.680986379975;16037.518874433787;16218.513444596681;16245.350185992427;16447.342106316093;8269.421140520106;8681.652733890574;9537.856932146162;9655.179309758749;9974.351667141902;15932.362705492114;16258.51224463268;16275.674486509966;16277.267522961258;16336.428225012067 11:22:17 INFO - 2015-11-20 11:22:17,155 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1559.0957244798012;1601.143388287266;1901.6577016137098;1924.788273289938;1930.64283107625;7784.3772498200005;7980.241877021674;8028.558429286387;8395.538245396501;8413.747587572376;8180;8272.751817445485;8352.832943341145;8354.874676879837;8394.916050839489;2398.688170537828;2417;2441.4750828571855;2448.2777580613674;2450.546648869956;2324.32594547581;2330.4406942333803;2382.273406610983;2383.0467812874904;2383.344580240439;2410.108259943823;2418.5283869645336;2437.756224377566;2452.1907770435714;2463.9651346434453;2397.712274527068;2410.554047501218;2420.576399130154;2423.4789520253144;2442.6336049592524;2126.319577735125;2400.2919138853904;2446.963295550568;2463.4580392313665;2477.2072936660275;8514.659413623447;8583.227509524111;8602.612882420306;8638.308935285162;8645.956770216171;4782.067496838118;5255.973720131413;5358.544523715489;5367.570594352482;5374.7043912584795;3262.8042317461027;3497.562804649419;3514.279572687593;3597.4963505109304;3614.132608174046;1022.892596277395;1051.1380667852363;1069.6309773128337;1088.9509972051198;1092.94535273236;11326.377049262288;11337.489812958436;11341.659750207507;11359.148063895242;11372;4291.699581029298;4689.343491911135;4814.422269327703;4817.614590832725;4819.638527110481;9704.951475242578;9820.803583928282;9839.163671088038;9840.507974601242;9863.802723945624;5228.4510126436935;5263.973680131575;5292.073887069748;5292.100342941709;5308.46915308466;4760.833370832004;4808.807647694123;4812.085703716282;4826.541478559531;4827.444843843003;3928.8035598220545;3946.5856085111222;3970.861019864291;3973.046468847456;3977.6618987386396;1258.6601617563206;1261.5773715805124;1276.6233960981347;1279.507389654971;1279.6864768131868;1372.1561239837627;1378.9655258618616;1402.3198748606917;1421.6588018875395;1422.4736847366335;7997.880296758459;8052.798680032929;8072.071711753106;8079;8101.837963240702;438.89247134451625;493.87159338571513;499.73264303598125;504.28895257686486;509.9031184075014;6015.218021657157;6150.415710507495;6150.969245153746;6163.322034576193;6210.254769427607;9721.659741909;10339.9483002586;10419.531121099568;10420.531076101443;10425.165986721044;10083.899161008296;10157.444894287088;10216;10273.332233404954;10346.32748871321;8025.438219324591;8046.718364857202;8140.552269625346;8152.918470815216;8166.836663266701;6695.4978376620975;6777.8983315249325;6882.8967565485555;6899.724011039502;7887.566183859943;9084.54577271147;9327.440353578808;9359.672411465566;9435.433873967584;9457.952710236405;9501;9510.952445238006;9643.132118109404;9715.36850104741;9750.171235444783;6628.403443690091;7390.29792169743;7520.699172033057;7530;7570.962145189239;7247.528910621004;8254.298384637374;8263.214994575506;8303.335733141213;8327.833443331221;7580.772576822704;7638.732644357421;7712;7718.92281077182;7775.455718099679;7551.509151905108;7559.357454616419;7578;7620.276073772982;7642.541447513167;7695.615219238904;7701.345385642283;7743.6515356810205;7758.262965018314;7768.805779855549;6959.234484206834;6966.12923384577;6983.6857341418745;7026.718931242693;7033.542819716702;7086.362227399559;7106.786796396116;7135.072440582691;7153.213146553979;7153.928460715326 11:22:17 INFO - 2015-11-20 11:22:17,158 DEBUG : BROWSER_OUTPUT: |4;prototype.html;317.16743548186014;322.7885734843678;323.7765941500366;329.35117817898737;330.1679766987194;7046.823829404268;7063.470239732022;7146.213916469191;7147.356737893595;7190.8561828763395;6987.30126987301;7033.824154396143;7075.46933979951;7106.147262328514;7117.430605551556;4407;5084.211947148188;5099.991005306868;5100.464451232604;5105.009046471879;4694.389729335182;5075.5178258065425;5092.745362731867;5099.949000510003;5121.513456221653;4943.678660887049;4962.42932062812;4985.476524964881;5009;5025.120603894322;4987.625928055392;4996.400431948153;4998.775055122528;5021.372328458942;5032.245163225509;4217.493900731901;4224.260754367973;4226.4716910386205;4231.8518851840345;4237.089025859455;4936.308916751622;5843.853903652443;6660;6720.899186512206;6735.955926831349;4929.383827021622;5858.062709966385;5866.823995280149;5879.970600146972;5893.5579831512805;7394.7411840585855;7398.260173982612;7405.407567394595;7406.07424071991;7411.925880741178;4691.038337140878;4710.882227944295;4717.268823332354;4731.550502702238;4760.738159401231;6751.628660423675;7814.960925195338;7878.80302992424;7943.205679432011;8005.07941586725;4257.40396344512;4886.99816537609;4960.355153829979;4971.602271818246;5000.39995200571;5090.10923088458;5094.057599344133;5110.71891045996;5120.257562653394;5145.279660847485;5933.199018132583;5958.106284057426;5969.880602387928;5976.551758618121;5977.163197152402;7485.663145158481;7495.850082998419;7541;7545.886811697829;7577.469577129548;1674.2884274183666;1706.9587551593518;1736.5050960476203;1765.9028753418686;1773.2552328022261;1122.6239209864787;1130.4121856634504;1141.902938250258;1149.7068247596976;1149.741308205647;7067.293270672892;7073.893891591631;7077.575345479185;7078.858422831515;7087.964560177166;7766.495177813424;7769.650365733555;7774.222577742294;7777.222277772177;7784.961075194701;6143.385661433821;6428.357164283628;6529.249136349381;6930.896036559456;7118.288171182944;3461.9228462922047;3991.560928297885;4120.587941205856;4144.026153853842;4149.564295748903;7440.330370266702;7687.424078063984;8047.798805029921;8162.877556836652;8177.2640462357485;7878.094019187753;8109.432339736162;8116.431849770577;8155.918440815516;8163.306118979954;8094.392920530984;8136.674533018731;8137.837243255101;8147.266745992889;8172.141925097898;7686.461947663834;7850;7858.410619203468;7862.2923936845955;7873.921260787319;7672.0409948756405;7688.8077798053255;7701;7704.229577042475;7742.225777422213;8114.634841432267;8127.715529956423;8132.471389359673;8137.79655508617;8147.063087744985;4717.174494463524;4770.928436073531;4822.614190864792;4840.588549973291;4842.15262329084;7572.507786993828;7686.961565192139;7867;7890.250426209501;7892.723754668559;5668.404817494104;7416.517926334771;7556.093268807558;7573.9242607575425;7612.276833700789;6414.198225221848;7324.864645979882;7512.511686740344;7545.358644515058;7591.278828511504;7077.009218709488;7355.264473552602;7366.116066072105;7379.446541509301;7391.593462359407;7563.205863384265;7578.583177925267;7584.734534291273;7591.810204744926;7597.278258565428;6432.517561182836;6937.965310173417;7399.96300018518;7405.148407932941;7431.888521672287 11:22:17 INFO - 2015-11-20 11:22:17,160 DEBUG : BROWSER_OUTPUT: |5;yui.html;737.2001378504323;743.0648936700035;752.2477522477523;783.3967844759532;824.7855557555034;15014.474493392734;15214;15319.004264722786;15319.540413787576;15364.769528457082;13763.449462021532;14045.157290562573;14087.366068526915;14089;14159.504417345395;740.566768440463;758.9772306830804;911.4121391702348;923.1276443760632;941.2799208605422;932.8181004704086;938.7746940734208;938.8732521109665;944.6882528765491;950.353759443578;985.7683444390562;986.0780170540531;992.8411454167334;998.0518507417946;998.8351921932872;983.6213057972697;983.6360546597733;985.7979114281555;996.1333639733479;999.1906555689915;712.2912701861629;718.8131085917647;719.5287086958051;723.1394640377986;724.5399171526119;14970.62573435662;14973.550793476214;14980.176090315028;14997.475088371855;15174.848251517455;10510.737231569196;12746.044046696443;12826.294553799537;12865.292408917507;12901.181073117643;9049.95925468573;9987.450690212036;10097.394156350643;10394.324368915995;10885.510152043098;3553.7690050146657;3582.8387722552548;3595.2449985502813;3632.56409230894;3645.453182022691;73983.26016739817;75106.62446687787;76158.23841761566;77342.61328693377;77662;9517.524123793783;9612.231021518262;9643.614255429844;9648.71053868371;10059.144972677259;21875.343739687836;21910.23314183996;22137.003834827472;22268.777312226994;22423.551528969656;7446.292602202782;7539.773806785805;7627.275408836152;7636.847263054708;7813.570253635991;3980.1641655252142;4032.2741906457118;4033.3143365627325;4048.2105989332385;4056.1887622475624;3523.841427135785;3557.2529768748855;3571.589267234301;3577.3918433866306;3578.588462326814;624.7376102037156;627.8775638750491;636.0713358496647;659.2583343738295;660.5145218264572;441.96022357987937;542.888707814897;575.9510441612426;584.1442287049493;617.7521406758323;8336.249737523653;8730;8847.955760221157;8891.110888911056;9054.637814487478;477.11971412743435;492.308306828906;516.5686651645842;527.5779376498785;528.8730704630938;4153.626173644387;4212.85255016073;4258.6380157686945;4259.87220383389;4299.527052024275;100821.49589252153;100999;101075;102813;103316.48341758244;80845;81074;81299.5935020321;81883;82673.17326826775;66692.66614667776;66948;68063.65968170227;68875;72697;7334.633268336668;8246.917530824854;8280.544570048705;8324.458910170819;8552.957235213784;48911;49791.75104124601;50208.48123668887;50789;51984.74007629938;66600;72830.63584682255;73397.63301183673;74086.25913740793;75185.62407187928;10178.440185789852;10251.282410231212;10316.845247321446;10448.58205671795;10581.735456613646;10562.683119506428;10740.892591073989;10890.61882834097;11012.063974562252;11914.702132446411;10244.897551024394;10413.791724165625;10827.783444331228;10838.67483975482;11325.830112548154;9664.130228279488;9836.803263934824;9883;9908.35595686278;10223.59105635796;10176.236782241509;10617.469126543487;10667.679969600924;10668.359898406121;11159.832602510807;9037;9054.818903622023;9263.675771347971;9386.342955993015;9576.616935322509;8645.394822362627;8720.563971801512;9391.389559678599;9394.077539046939;9520.381175223589 11:22:17 INFO - 2015-11-20 11:22:17,160 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:22:17 INFO - 2015-11-20 11:22:17,160 DEBUG : BROWSER_OUTPUT: __start_cc_report 11:22:17 INFO - 2015-11-20 11:22:17,160 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,341 11:22:17 INFO - 2015-11-20 11:22:17,160 DEBUG : BROWSER_OUTPUT: __end_cc_report 11:22:17 INFO - 2015-11-20 11:22:17,160 DEBUG : BROWSER_OUTPUT: __startTimestamp1448047337146__endTimestamp 11:22:17 INFO - 2015-11-20 11:22:17,160 DEBUG : BROWSER_OUTPUT: 11:22:17 INFO - 2015-11-20 11:22:17,160 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:22:17 INFO - 2015-11-20 11:22:17,160 DEBUG : BROWSER_OUTPUT: Number of tests: 6 11:22:17 INFO - 2015-11-20 11:22:17,160 DEBUG : BROWSER_OUTPUT: 11:22:17 INFO - 2015-11-20 11:22:17,161 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5793.32 Median:6076.54 stddev:671.13 (11.0%) stddev-sans-first:646.34 11:22:17 INFO - 2015-11-20 11:22:17,162 DEBUG : BROWSER_OUTPUT: Values: 3397.8 3469.7 3482.9 3516.4 3519.9 5717.9 5771.7 5788.0 5792.4 5800.2 5622.7 5785.2 5785.7 5795.8 5896.6 5212.6 5230.8 5286.2 5347.5 5361.1 4834.4 5373.7 5393.5 5401.3 5401.3 5154.7 5158.0 5245.9 5292.4 5301.6 5277.7 5287.1 5305.9 5316.0 5320.3 5219.2 5234.5 5245.4 5258.4 5324.3 5092.8 5472.0 5663.4 5791.1 5826.9 6261.9 6278.5 6309.2 6316.5 6341.8 6330.6 6352.6 6356.2 6360.5 6384.6 5756.3 5804.2 5877.6 5882.4 5941.2 6336.9 6390.8 6439.7 6446.0 6499.7 6016.5 6280.2 6290.7 6302.4 6302.4 4881.7 6204.4 6238.6 6269.4 6269.7 6243.2 6252.0 6274.0 6287.5 6320.3 6120.3 6273.5 6279.7 6284.9 6288.2 4924.2 4964.1 4966.0 4981.2 5020.4 4478.7 4480.3 4491.9 4499.8 4533.3 5663.5 5802.1 5851.8 6024.9 6033.6 6091.0 6250.1 6319.9 6325.1 6326.4 5192.4 5253.9 5904.1 5968.6 6003.1 4185.5 5350.0 5439.2 5503.8 5542.3 6421.7 6424.0 6425.6 6432.8 6449.5 6343.4 6356.0 6359.9 6363.2 6378.9 6228.4 6304.3 6347.0 6361.5 6370.7 6282.9 6294.4 6298.2 6303.7 6314.8 6298.0 6314.7 6327.9 6337.9 6341.4 6076.5 6137.6 6143.3 6185.8 6196.1 6248.8 6249.6 6278.6 6285.4 6290.3 4512.8 6084.2 6100.1 6143.5 6163.6 5847.5 5852.7 5894.2 5935.5 6150.4 6136.2 6175.3 6209.6 6211.8 6215.5 11:22:17 INFO - 2015-11-20 11:22:17,162 DEBUG : BROWSER_OUTPUT: 11:22:17 INFO - 2015-11-20 11:22:17,162 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:75275.44 Median:40006.80 stddev:168539.10 (421.3%) stddev-sans-first:168918.55 11:22:17 INFO - 2015-11-20 11:22:17,164 DEBUG : BROWSER_OUTPUT: Values: 564.7 566.0 593.1 629.6 632.6 39886.6 40155.4 40273.8 40316.0 40443.8 41851.0 41991.8 42214.8 42323.6 42408.4 9754.5 9916.6 9930.9 9946.2 9968.5 9747.8 9851.3 9856.2 9881.7 9886.9 9797.5 9859.9 9871.2 9894.4 9896.1 8334.3 8878.6 9714.1 9825.5 9831.7 8378.6 9810.2 9823.2 9824.8 9825.1 39142.8 39368.0 39477.8 39484.8 39538.4 3190.2 3310.3 3407.5 3443.0 3527.9 28149.2 28228.7 28390.9 28550.0 29456.7 2731.3 2820.8 2826.3 2852.0 2866.2 611347.0 689702.0 696582.0 699060.5 699175.0 61905.0 68980.0 69544.7 69612.7 69647.3 61960.4 73326.6 73802.6 73839.9 74612.0 16409.7 16420.4 16473.4 16630.7 16651.3 12549.7 12634.1 12683.6 12737.6 12741.0 20842.8 20929.0 21154.5 21171.4 21741.0 9404.7 9635.8 9641.8 9651.0 9665.4 940.4 961.6 991.7 1000.5 1058.9 29732.9 29734.6 30341.7 30344.2 30367.0 914.4 1012.6 1050.5 1080.6 1084.8 12512.4 14471.5 14797.9 14834.9 14921.0 670363.0 670415.0 672577.0 674406.0 683188.0 56177.9 56264.7 56691.4 56845.7 57244.0 1389.3 1444.4 1450.5 1481.3 1537.4 28593.1 28764.3 29079.9 29083.1 29323.4 49464.5 49531.0 49993.5 50044.7 50237.2 518552.0 518738.0 519299.0 520333.0 522922.0 28959.3 29455.0 32223.4 32885.5 32989.0 39786.6 40127.0 41327.0 41624.0 41810.0 33625.0 34988.0 35072.8 35191.8 35409.3 35228.6 35407.9 35978.3 36102.8 36111.6 35102.5 35154.0 35196.8 38362.8 39111.0 32748.3 34458.3 34831.8 42193.6 42884.6 26708.9 32032.0 32032.2 32798.3 33287.0 11:22:17 INFO - 2015-11-20 11:22:17,164 DEBUG : BROWSER_OUTPUT: 11:22:17 INFO - 2015-11-20 11:22:17,164 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:38568.22 Median:20695.69 stddev:120398.82 (581.8%) stddev-sans-first:120702.35 11:22:17 INFO - 2015-11-20 11:22:17,164 DEBUG : BROWSER_OUTPUT: Values: 339.0 360.7 364.6 366.8 368.1 16192.9 17466.4 19384.0 20554.5 21368.9 19431.4 20099.9 20132.0 20348.6 20763.4 5649.0 5843.0 5850.9 5861.9 5869.0 3933.4 4034.9 5531.7 5685.2 5829.7 5798.4 5800.3 5808.1 5827.8 5828.3 5835.6 6391.4 6435.1 6441.1 6472.6 5447.6 5522.3 5594.6 5604.0 5606.1 12796.6 12956.0 12981.4 13031.2 21026.4 1931.5 2001.6 2138.8 2263.0 2266.5 8592.8 9030.0 9534.4 9964.4 10032.9 1696.3 1727.7 1749.2 1757.7 1800.4 101210.5 107218.5 108547.9 108754.0 109942.0 11190.9 11226.2 11279.5 11403.9 11405.0 13269.5 13291.1 13324.2 13372.1 13404.7 7289.0 8643.9 8670.3 8687.1 8738.7 8824.5 8853.3 8911.3 8918.6 8979.8 4313.2 4361.1 4372.8 4403.4 4421.5 1481.0 1643.9 1797.9 1806.8 1843.7 897.5 919.9 927.9 1005.9 1028.4 18606.3 18651.4 19069.4 19633.3 21155.9 853.6 911.7 943.1 965.9 989.7 9748.5 10449.5 10610.7 10673.1 10724.4 634039.0 663516.0 772634.0 774801.0 786633.0 126984.4 127021.0 128551.7 131578.0 133136.0 1170.8 1191.6 1193.3 1204.7 1205.1 18011.3 18113.5 18210.7 18298.3 18492.3 51261.7 51993.0 52180.7 52418.7 53070.7 74626.0 75214.0 75316.0 75692.0 76948.6 9511.6 9633.8 9693.9 9737.0 10115.8 19219.6 19221.8 19461.0 20534.4 20628.0 15490.9 15532.5 15895.3 16283.8 16305.8 15550.0 15586.5 15645.6 15653.2 15884.2 15950.7 16037.5 16218.5 16245.4 16447.3 8269.4 8681.7 9537.9 9655.2 9974.4 15932.4 16258.5 16275.7 16277.3 16336.4 11:22:17 INFO - 2015-11-20 11:22:17,164 DEBUG : BROWSER_OUTPUT: 11:22:17 INFO - 2015-11-20 11:22:17,165 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5916.47 Median:5333.51 stddev:3092.22 (58.0%) stddev-sans-first:3083.55 11:22:17 INFO - 2015-11-20 11:22:17,166 DEBUG : BROWSER_OUTPUT: Values: 1559.1 1601.1 1901.7 1924.8 1930.6 7784.4 7980.2 8028.6 8395.5 8413.7 8180.0 8272.8 8352.8 8354.9 8394.9 2398.7 2417.0 2441.5 2448.3 2450.5 2324.3 2330.4 2382.3 2383.0 2383.3 2410.1 2418.5 2437.8 2452.2 2464.0 2397.7 2410.6 2420.6 2423.5 2442.6 2126.3 2400.3 2447.0 2463.5 2477.2 8514.7 8583.2 8602.6 8638.3 8646.0 4782.1 5256.0 5358.5 5367.6 5374.7 3262.8 3497.6 3514.3 3597.5 3614.1 1022.9 1051.1 1069.6 1089.0 1092.9 11326.4 11337.5 11341.7 11359.1 11372.0 4291.7 4689.3 4814.4 4817.6 4819.6 9705.0 9820.8 9839.2 9840.5 9863.8 5228.5 5264.0 5292.1 5292.1 5308.5 4760.8 4808.8 4812.1 4826.5 4827.4 3928.8 3946.6 3970.9 3973.0 3977.7 1258.7 1261.6 1276.6 1279.5 1279.7 1372.2 1379.0 1402.3 1421.7 1422.5 7997.9 8052.8 8072.1 8079.0 8101.8 438.9 493.9 499.7 504.3 509.9 6015.2 6150.4 6151.0 6163.3 6210.3 9721.7 10339.9 10419.5 10420.5 10425.2 10083.9 10157.4 10216.0 10273.3 10346.3 8025.4 8046.7 8140.6 8152.9 8166.8 6695.5 6777.9 6882.9 6899.7 7887.6 9084.5 9327.4 9359.7 9435.4 9458.0 9501.0 9511.0 9643.1 9715.4 9750.2 6628.4 7390.3 7520.7 7530.0 7571.0 7247.5 8254.3 8263.2 8303.3 8327.8 7580.8 7638.7 7712.0 7718.9 7775.5 7551.5 7559.4 7578.0 7620.3 7642.5 7695.6 7701.3 7743.7 7758.3 7768.8 6959.2 6966.1 6983.7 7026.7 7033.5 7086.4 7106.8 7135.1 7153.2 7153.9 11:22:17 INFO - 2015-11-20 11:22:17,166 DEBUG : BROWSER_OUTPUT: 11:22:17 INFO - 2015-11-20 11:22:17,166 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:6081.82 Median:7040.32 stddev:1991.68 (28.3%) stddev-sans-first:1949.70 11:22:17 INFO - 2015-11-20 11:22:17,167 DEBUG : BROWSER_OUTPUT: Values: 317.2 322.8 323.8 329.4 330.2 7046.8 7063.5 7146.2 7147.4 7190.9 6987.3 7033.8 7075.5 7106.1 7117.4 4407.0 5084.2 5100.0 5100.5 5105.0 4694.4 5075.5 5092.7 5099.9 5121.5 4943.7 4962.4 4985.5 5009.0 5025.1 4987.6 4996.4 4998.8 5021.4 5032.2 4217.5 4224.3 4226.5 4231.9 4237.1 4936.3 5843.9 6660.0 6720.9 6736.0 4929.4 5858.1 5866.8 5880.0 5893.6 7394.7 7398.3 7405.4 7406.1 7411.9 4691.0 4710.9 4717.3 4731.6 4760.7 6751.6 7815.0 7878.8 7943.2 8005.1 4257.4 4887.0 4960.4 4971.6 5000.4 5090.1 5094.1 5110.7 5120.3 5145.3 5933.2 5958.1 5969.9 5976.6 5977.2 7485.7 7495.9 7541.0 7545.9 7577.5 1674.3 1707.0 1736.5 1765.9 1773.3 1122.6 1130.4 1141.9 1149.7 1149.7 7067.3 7073.9 7077.6 7078.9 7088.0 7766.5 7769.7 7774.2 7777.2 7785.0 6143.4 6428.4 6529.2 6930.9 7118.3 3461.9 3991.6 4120.6 4144.0 4149.6 7440.3 7687.4 8047.8 8162.9 8177.3 7878.1 8109.4 8116.4 8155.9 8163.3 8094.4 8136.7 8137.8 8147.3 8172.1 7686.5 7850.0 7858.4 7862.3 7873.9 7672.0 7688.8 7701.0 7704.2 7742.2 8114.6 8127.7 8132.5 8137.8 8147.1 4717.2 4770.9 4822.6 4840.6 4842.2 7572.5 7687.0 7867.0 7890.3 7892.7 5668.4 7416.5 7556.1 7573.9 7612.3 6414.2 7324.9 7512.5 7545.4 7591.3 7077.0 7355.3 7366.1 7379.4 7391.6 7563.2 7578.6 7584.7 7591.8 7597.3 6432.5 6938.0 7400.0 7405.1 7431.9 11:22:17 INFO - 2015-11-20 11:22:17,167 DEBUG : BROWSER_OUTPUT: 11:22:17 INFO - 2015-11-20 11:22:17,167 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:18538.62 Median:626.31 stddev:26648.88 (4254.9%) stddev-sans-first:26690.12 11:22:17 INFO - 2015-11-20 11:22:17,169 DEBUG : BROWSER_OUTPUT: Values: 737.2 743.1 752.2 783.4 824.8 15014.5 15214.0 15319.0 15319.5 15364.8 13763.4 14045.2 14087.4 14089.0 14159.5 740.6 759.0 911.4 923.1 941.3 932.8 938.8 938.9 944.7 950.4 985.8 986.1 992.8 998.1 998.8 983.6 983.6 985.8 996.1 999.2 712.3 718.8 719.5 723.1 724.5 14970.6 14973.6 14980.2 14997.5 15174.8 10510.7 12746.0 12826.3 12865.3 12901.2 9050.0 9987.5 10097.4 10394.3 10885.5 3553.8 3582.8 3595.2 3632.6 3645.5 73983.3 75106.6 76158.2 77342.6 77662.0 9517.5 9612.2 9643.6 9648.7 10059.1 21875.3 21910.2 22137.0 22268.8 22423.6 7446.3 7539.8 7627.3 7636.8 7813.6 3980.2 4032.3 4033.3 4048.2 4056.2 3523.8 3557.3 3571.6 3577.4 3578.6 624.7 627.9 636.1 659.3 660.5 442.0 542.9 576.0 584.1 617.8 8336.2 8730.0 8848.0 8891.1 9054.6 477.1 492.3 516.6 527.6 528.9 4153.6 4212.9 4258.6 4259.9 4299.5 100821.5 100999.0 101075.0 102813.0 103316.5 80845.0 81074.0 81299.6 81883.0 82673.2 66692.7 66948.0 68063.7 68875.0 72697.0 7334.6 8246.9 8280.5 8324.5 8553.0 48911.0 49791.8 50208.5 50789.0 51984.7 66600.0 72830.6 73397.6 74086.3 75185.6 10178.4 10251.3 10316.8 10448.6 10581.7 10562.7 10740.9 10890.6 11012.1 11914.7 10244.9 10413.8 10827.8 10838.7 11325.8 9664.1 9836.8 9883.0 9908.4 10223.6 10176.2 10617.5 10667.7 10668.4 11159.8 9037.0 9054.8 9263.7 9386.3 9576.6 8645.4 8720.6 9391.4 9394.1 9520.4 11:22:17 INFO - 2015-11-20 11:22:17,169 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:22:17 INFO - 2015-11-20 11:22:17,169 DEBUG : BROWSER_OUTPUT: 11:22:17 INFO - 2015-11-20 11:22:17,575 INFO : Browser exited with error code: 0 11:22:17 INFO - 2015-11-20 11:22:17,600 INFO : Completed test dromaeo_css (00:18:30) 11:22:17 INFO - 2015-11-20 11:22:17,601 INFO : Starting test kraken 11:22:17 INFO - 2015-11-20 11:22:17,601 DEBUG : operating with platform_type : mac_ 11:22:17 INFO - 2015-11-20 11:22:17,601 INFO : Initialising browser for kraken test... 11:22:17 INFO - 2015-11-20 11:22:17,613 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/tmpVGpsRY/profile http://localhost:57262/getInfo.html 11:22:20 INFO - 2015-11-20 11:22:20,327 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:22:20 INFO - 2015-11-20 11:22:20,327 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:22:20 INFO - 2015-11-20 11:22:20,327 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 11:22:20 INFO - 2015-11-20 11:22:20,327 DEBUG : BROWSER_OUTPUT: __metrics 11:22:21 INFO - 2015-11-20 11:22:21,019 INFO : Browser initialized. 11:22:21 INFO - 2015-11-20 11:22:21,019 INFO : Running cycle 1/1 for kraken test... 11:22:21 INFO - 2015-11-20 11:22:21,020 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/tmpVGpsRY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:22:32 INFO - 2015-11-20 11:22:32,975 DEBUG : BROWSER_OUTPUT: RSS: Main: 237105152 11:22:32 INFO - 2015-11-20 11:22:32,975 DEBUG : BROWSER_OUTPUT: 11:22:35 INFO - 2015-11-20 11:22:35,674 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57262/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57262/tests/kraken/driver.html?testName=audio-beat-detection) 11:22:36 INFO - 2015-11-20 11:22:36,293 DEBUG : BROWSER_OUTPUT: RSS: Main: 249389056 11:22:36 INFO - 2015-11-20 11:22:36,293 DEBUG : BROWSER_OUTPUT: 11:22:38 INFO - 2015-11-20 11:22:38,945 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57262/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57262/tests/kraken/driver.html?testName=audio-dft) 11:22:39 INFO - 2015-11-20 11:22:39,553 DEBUG : BROWSER_OUTPUT: RSS: Main: 259084288 11:22:39 INFO - 2015-11-20 11:22:39,554 DEBUG : BROWSER_OUTPUT: 11:22:42 INFO - 2015-11-20 11:22:42,759 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57262/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57262/tests/kraken/driver.html?testName=audio-fft) 11:22:43 INFO - 2015-11-20 11:22:43,346 DEBUG : BROWSER_OUTPUT: RSS: Main: 261734400 11:22:43 INFO - 2015-11-20 11:22:43,347 DEBUG : BROWSER_OUTPUT: 11:22:45 INFO - 2015-11-20 11:22:45,415 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57262/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57262/tests/kraken/driver.html?testName=audio-oscillator) 11:22:46 INFO - 2015-11-20 11:22:46,005 DEBUG : BROWSER_OUTPUT: RSS: Main: 262631424 11:22:46 INFO - 2015-11-20 11:22:46,005 DEBUG : BROWSER_OUTPUT: 11:22:48 INFO - 2015-11-20 11:22:48,085 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57262/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57262/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:22:48 INFO - 2015-11-20 11:22:48,668 DEBUG : BROWSER_OUTPUT: RSS: Main: 263823360 11:22:48 INFO - 2015-11-20 11:22:48,669 DEBUG : BROWSER_OUTPUT: 11:22:51 INFO - 2015-11-20 11:22:51,392 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57262/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57262/tests/kraken/driver.html?testName=imaging-darkroom) 11:22:51 INFO - 2015-11-20 11:22:51,987 DEBUG : BROWSER_OUTPUT: RSS: Main: 265543680 11:22:51 INFO - 2015-11-20 11:22:51,988 DEBUG : BROWSER_OUTPUT: 11:22:54 INFO - 2015-11-20 11:22:54,818 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57262/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57262/tests/kraken/driver.html?testName=imaging-desaturate) 11:22:55 INFO - 2015-11-20 11:22:55,410 DEBUG : BROWSER_OUTPUT: RSS: Main: 265576448 11:22:55 INFO - 2015-11-20 11:22:55,411 DEBUG : BROWSER_OUTPUT: 11:22:58 INFO - 2015-11-20 11:22:58,341 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57262/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57262/tests/kraken/driver.html?testName=json-parse-financial) 11:22:58 INFO - 2015-11-20 11:22:58,941 DEBUG : BROWSER_OUTPUT: RSS: Main: 263696384 11:22:58 INFO - 2015-11-20 11:22:58,941 DEBUG : BROWSER_OUTPUT: 11:23:00 INFO - 2015-11-20 11:23:00,459 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57262/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57262/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:23:01 INFO - 2015-11-20 11:23:01,049 DEBUG : BROWSER_OUTPUT: RSS: Main: 263168000 11:23:01 INFO - 2015-11-20 11:23:01,049 DEBUG : BROWSER_OUTPUT: 11:23:02 INFO - 2015-11-20 11:23:02,958 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57262/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57262/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:23:03 INFO - 2015-11-20 11:23:03,582 DEBUG : BROWSER_OUTPUT: RSS: Main: 264695808 11:23:03 INFO - 2015-11-20 11:23:03,582 DEBUG : BROWSER_OUTPUT: 11:23:05 INFO - 2015-11-20 11:23:05,597 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57262/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57262/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:23:06 INFO - 2015-11-20 11:23:06,189 DEBUG : BROWSER_OUTPUT: RSS: Main: 264929280 11:23:06 INFO - 2015-11-20 11:23:06,189 DEBUG : BROWSER_OUTPUT: 11:23:08 INFO - 2015-11-20 11:23:08,713 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57262/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57262/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:23:09 INFO - 2015-11-20 11:23:09,325 DEBUG : BROWSER_OUTPUT: RSS: Main: 264470528 11:23:09 INFO - 2015-11-20 11:23:09,325 DEBUG : BROWSER_OUTPUT: 11:23:11 INFO - 2015-11-20 11:23:11,760 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57262/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57262/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:23:12 INFO - 2015-11-20 11:23:12,349 DEBUG : BROWSER_OUTPUT: RSS: Main: 264884224 11:23:12 INFO - 2015-11-20 11:23:12,350 DEBUG : BROWSER_OUTPUT: 11:23:14 INFO - 2015-11-20 11:23:14,031 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57262/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57262/tests/kraken/driver.html?testName=ai-astar) 11:23:14 INFO - 2015-11-20 11:23:14,288 DEBUG : BROWSER_OUTPUT: RSS: Main: 264929280 11:23:14 INFO - 2015-11-20 11:23:14,289 DEBUG : BROWSER_OUTPUT: 11:23:14 INFO - 2015-11-20 11:23:14,289 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:23:14 INFO - 2015-11-20 11:23:14,289 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:23:14 INFO - 2015-11-20 11:23:14,289 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:23:14 INFO - 2015-11-20 11:23:14,289 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:23:14 INFO - 2015-11-20 11:23:14,289 DEBUG : BROWSER_OUTPUT: |0;ai-astar;115;107;114;127;164;170;114;117;114;113 11:23:14 INFO - 2015-11-20 11:23:14,289 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;159;113;168;181;149;147;144;118;177;124 11:23:14 INFO - 2015-11-20 11:23:14,289 DEBUG : BROWSER_OUTPUT: |2;audio-dft;192;192;197;202;203;223;197;197;205;197 11:23:14 INFO - 2015-11-20 11:23:14,289 DEBUG : BROWSER_OUTPUT: |3;audio-fft;57;90;83;84;136;51;76;81;84;100 11:23:14 INFO - 2015-11-20 11:23:14,290 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;77;79;106;103;109;109;116;76;75;111 11:23:14 INFO - 2015-11-20 11:23:14,290 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;90;90;89;89;91;90;90;89;98;122 11:23:14 INFO - 2015-11-20 11:23:14,290 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;97;97;98;97;98;139;97;98;98;97 11:23:14 INFO - 2015-11-20 11:23:14,290 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;111;145;110;91;93;91;121;87;118;80 11:23:14 INFO - 2015-11-20 11:23:14,290 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;59;59;62;61;61;60;59;67;58;58 11:23:14 INFO - 2015-11-20 11:23:14,290 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;66;84;57;59;59;70;98;99;101;69 11:23:14 INFO - 2015-11-20 11:23:14,290 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;85;82;84;84;87;83;85;84;86;84 11:23:14 INFO - 2015-11-20 11:23:14,290 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;126;123;131;129;123;130;121;142;120;147 11:23:14 INFO - 2015-11-20 11:23:14,290 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;140;143;134;137;143;144;145;136;140;138 11:23:14 INFO - 2015-11-20 11:23:14,290 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;66;68;66;67;68;66;68;66;91;86 11:23:14 INFO - 2015-11-20 11:23:14,290 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:23:14 INFO - 2015-11-20 11:23:14,290 DEBUG : BROWSER_OUTPUT: __start_cc_report 11:23:14 INFO - 2015-11-20 11:23:14,290 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,833 11:23:14 INFO - 2015-11-20 11:23:14,291 DEBUG : BROWSER_OUTPUT: __end_cc_report 11:23:14 INFO - 2015-11-20 11:23:14,291 DEBUG : BROWSER_OUTPUT: __startTimestamp1448047394283__endTimestamp 11:23:14 INFO - 2015-11-20 11:23:14,291 DEBUG : BROWSER_OUTPUT: 11:23:14 INFO - 2015-11-20 11:23:14,291 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:23:14 INFO - 2015-11-20 11:23:14,291 DEBUG : BROWSER_OUTPUT: Number of tests: 14 11:23:14 INFO - 2015-11-20 11:23:14,291 DEBUG : BROWSER_OUTPUT: 11:23:14 INFO - 2015-11-20 11:23:14,291 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:125.50 Median:116.00 stddev:22.47 (19.4%) stddev-sans-first:23.51 11:23:14 INFO - 2015-11-20 11:23:14,291 DEBUG : BROWSER_OUTPUT: Values: 115.0 107.0 114.0 127.0 164.0 170.0 114.0 117.0 114.0 113.0 11:23:14 INFO - 2015-11-20 11:23:14,291 DEBUG : BROWSER_OUTPUT: 11:23:14 INFO - 2015-11-20 11:23:14,291 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:148.00 Median:154.00 stddev:23.97 (15.6%) stddev-sans-first:25.09 11:23:14 INFO - 2015-11-20 11:23:14,291 DEBUG : BROWSER_OUTPUT: Values: 159.0 113.0 168.0 181.0 149.0 147.0 144.0 118.0 177.0 124.0 11:23:14 INFO - 2015-11-20 11:23:14,291 DEBUG : BROWSER_OUTPUT: 11:23:14 INFO - 2015-11-20 11:23:14,291 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:200.50 Median:199.50 stddev:9.00 (4.5%) stddev-sans-first:9.00 11:23:14 INFO - 2015-11-20 11:23:14,292 DEBUG : BROWSER_OUTPUT: Values: 192.0 192.0 197.0 202.0 203.0 223.0 197.0 197.0 205.0 197.0 11:23:14 INFO - 2015-11-20 11:23:14,292 DEBUG : BROWSER_OUTPUT: 11:23:14 INFO - 2015-11-20 11:23:14,292 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:84.20 Median:82.00 stddev:23.30 (28.4%) stddev-sans-first:22.54 11:23:14 INFO - 2015-11-20 11:23:14,292 DEBUG : BROWSER_OUTPUT: Values: 57.0 90.0 83.0 84.0 136.0 51.0 76.0 81.0 84.0 100.0 11:23:14 INFO - 2015-11-20 11:23:14,292 DEBUG : BROWSER_OUTPUT: 11:23:14 INFO - 2015-11-20 11:23:14,292 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:96.10 Median:95.50 stddev:17.01 (17.8%) stddev-sans-first:16.57 11:23:14 INFO - 2015-11-20 11:23:14,292 DEBUG : BROWSER_OUTPUT: Values: 77.0 79.0 106.0 103.0 109.0 109.0 116.0 76.0 75.0 111.0 11:23:14 INFO - 2015-11-20 11:23:14,292 DEBUG : BROWSER_OUTPUT: 11:23:14 INFO - 2015-11-20 11:23:14,292 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:93.80 Median:90.00 stddev:10.26 (11.4%) stddev-sans-first:10.79 11:23:14 INFO - 2015-11-20 11:23:14,292 DEBUG : BROWSER_OUTPUT: Values: 90.0 90.0 89.0 89.0 91.0 90.0 90.0 89.0 98.0 122.0 11:23:14 INFO - 2015-11-20 11:23:14,292 DEBUG : BROWSER_OUTPUT: 11:23:14 INFO - 2015-11-20 11:23:14,292 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:101.60 Median:97.50 stddev:13.15 (13.5%) stddev-sans-first:13.84 11:23:14 INFO - 2015-11-20 11:23:14,292 DEBUG : BROWSER_OUTPUT: Values: 97.0 97.0 98.0 97.0 98.0 139.0 97.0 98.0 98.0 97.0 11:23:14 INFO - 2015-11-20 11:23:14,293 DEBUG : BROWSER_OUTPUT: 11:23:14 INFO - 2015-11-20 11:23:14,293 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:104.70 Median:83.50 stddev:19.92 (23.9%) stddev-sans-first:20.99 11:23:14 INFO - 2015-11-20 11:23:14,293 DEBUG : BROWSER_OUTPUT: Values: 111.0 145.0 110.0 91.0 93.0 91.0 121.0 87.0 118.0 80.0 11:23:14 INFO - 2015-11-20 11:23:14,293 DEBUG : BROWSER_OUTPUT: 11:23:14 INFO - 2015-11-20 11:23:14,293 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:60.40 Median:60.50 stddev:2.67 (4.4%) stddev-sans-first:2.79 11:23:14 INFO - 2015-11-20 11:23:14,293 DEBUG : BROWSER_OUTPUT: Values: 59.0 59.0 62.0 61.0 61.0 60.0 59.0 67.0 58.0 58.0 11:23:14 INFO - 2015-11-20 11:23:14,293 DEBUG : BROWSER_OUTPUT: 11:23:14 INFO - 2015-11-20 11:23:14,293 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:76.20 Median:69.50 stddev:17.72 (25.5%) stddev-sans-first:18.41 11:23:14 INFO - 2015-11-20 11:23:14,293 DEBUG : BROWSER_OUTPUT: Values: 66.0 84.0 57.0 59.0 59.0 70.0 98.0 99.0 101.0 69.0 11:23:14 INFO - 2015-11-20 11:23:14,293 DEBUG : BROWSER_OUTPUT: 11:23:14 INFO - 2015-11-20 11:23:14,293 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.40 Median:84.50 stddev:1.43 (1.7%) stddev-sans-first:1.50 11:23:14 INFO - 2015-11-20 11:23:14,293 DEBUG : BROWSER_OUTPUT: Values: 85.0 82.0 84.0 84.0 87.0 83.0 85.0 84.0 86.0 84.0 11:23:14 INFO - 2015-11-20 11:23:14,293 DEBUG : BROWSER_OUTPUT: 11:23:14 INFO - 2015-11-20 11:23:14,293 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:129.20 Median:129.50 stddev:8.97 (6.9%) stddev-sans-first:9.44 11:23:14 INFO - 2015-11-20 11:23:14,294 DEBUG : BROWSER_OUTPUT: Values: 126.0 123.0 131.0 129.0 123.0 130.0 121.0 142.0 120.0 147.0 11:23:14 INFO - 2015-11-20 11:23:14,294 DEBUG : BROWSER_OUTPUT: 11:23:14 INFO - 2015-11-20 11:23:14,294 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:140.00 Median:141.50 stddev:3.71 (2.6%) stddev-sans-first:3.94 11:23:14 INFO - 2015-11-20 11:23:14,294 DEBUG : BROWSER_OUTPUT: Values: 140.0 143.0 134.0 137.0 143.0 144.0 145.0 136.0 140.0 138.0 11:23:14 INFO - 2015-11-20 11:23:14,294 DEBUG : BROWSER_OUTPUT: 11:23:14 INFO - 2015-11-20 11:23:14,294 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.20 Median:68.00 stddev:9.24 (13.6%) stddev-sans-first:9.60 11:23:14 INFO - 2015-11-20 11:23:14,294 DEBUG : BROWSER_OUTPUT: Values: 66.0 68.0 66.0 67.0 68.0 66.0 68.0 66.0 91.0 86.0 11:23:14 INFO - 2015-11-20 11:23:14,294 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:23:14 INFO - 2015-11-20 11:23:14,294 DEBUG : BROWSER_OUTPUT: 11:23:14 INFO - 2015-11-20 11:23:14,937 INFO : Browser exited with error code: 0 11:23:14 INFO - 2015-11-20 11:23:14,982 INFO : Completed test kraken (00:00:57) 11:23:14 INFO - 2015-11-20 11:23:14,983 INFO : Starting test v8_7 11:23:14 INFO - 2015-11-20 11:23:14,983 DEBUG : operating with platform_type : mac_ 11:23:14 INFO - 2015-11-20 11:23:14,983 INFO : Initialising browser for v8_7 test... 11:23:14 INFO - 2015-11-20 11:23:14,995 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/tmpn_DzFZ/profile http://localhost:57262/getInfo.html 11:23:17 INFO - 2015-11-20 11:23:17,723 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:23:17 INFO - 2015-11-20 11:23:17,723 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:23:17 INFO - 2015-11-20 11:23:17,723 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 11:23:17 INFO - 2015-11-20 11:23:17,723 DEBUG : BROWSER_OUTPUT: __metrics 11:23:18 INFO - 2015-11-20 11:23:18,331 INFO : Browser initialized. 11:23:18 INFO - 2015-11-20 11:23:18,332 INFO : Running cycle 1/1 for v8_7 test... 11:23:18 INFO - 2015-11-20 11:23:18,332 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/tmpn_DzFZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:23:30 INFO - 2015-11-20 11:23:30,277 DEBUG : BROWSER_OUTPUT: RSS: Main: 237178880 11:23:30 INFO - 2015-11-20 11:23:30,277 DEBUG : BROWSER_OUTPUT: 11:23:51 INFO - 2015-11-20 11:23:51,704 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57262/tests/v8_7/run.html (next: http://localhost:57262/tests/v8_7/run.html) 11:23:51 INFO - 2015-11-20 11:23:51,961 DEBUG : BROWSER_OUTPUT: RSS: Main: 246976512 11:23:51 INFO - 2015-11-20 11:23:51,961 DEBUG : BROWSER_OUTPUT: 11:23:51 INFO - 2015-11-20 11:23:51,961 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:23:51 INFO - 2015-11-20 11:23:51,962 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:23:51 INFO - 2015-11-20 11:23:51,962 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:23:51 INFO - 2015-11-20 11:23:51,962 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:23:51 INFO - 2015-11-20 11:23:51,962 DEBUG : BROWSER_OUTPUT: |0;Richards;652.3157208088714 11:23:51 INFO - 2015-11-20 11:23:51,962 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;155.6662515566625 11:23:51 INFO - 2015-11-20 11:23:51,962 DEBUG : BROWSER_OUTPUT: |2;Encrypt;290.5287623474724 11:23:51 INFO - 2015-11-20 11:23:51,962 DEBUG : BROWSER_OUTPUT: |3;Decrypt;4835.748792270531 11:23:51 INFO - 2015-11-20 11:23:51,962 DEBUG : BROWSER_OUTPUT: |4;RayTrace;945.179584120983 11:23:51 INFO - 2015-11-20 11:23:51,962 DEBUG : BROWSER_OUTPUT: |5;Earley;739.6449704142012 11:23:51 INFO - 2015-11-20 11:23:51,962 DEBUG : BROWSER_OUTPUT: |6;Boyer;12512.5 11:23:51 INFO - 2015-11-20 11:23:51,962 DEBUG : BROWSER_OUTPUT: |7;RegExp;26789.473684210527 11:23:51 INFO - 2015-11-20 11:23:51,963 DEBUG : BROWSER_OUTPUT: |8;Splay;654.8788474132285 11:23:51 INFO - 2015-11-20 11:23:51,963 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4643.518518518518 11:23:51 INFO - 2015-11-20 11:23:51,963 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:23:51 INFO - 2015-11-20 11:23:51,963 DEBUG : BROWSER_OUTPUT: __startTimestamp1448047431955__endTimestamp 11:23:51 INFO - 2015-11-20 11:23:51,963 DEBUG : BROWSER_OUTPUT: 11:23:51 INFO - 2015-11-20 11:23:51,963 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:23:51 INFO - 2015-11-20 11:23:51,963 DEBUG : BROWSER_OUTPUT: Number of tests: 10 11:23:51 INFO - 2015-11-20 11:23:51,963 DEBUG : BROWSER_OUTPUT: 11:23:51 INFO - 2015-11-20 11:23:51,963 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:652.32 Median:652.32 stddev:0.00 (0.0%) 11:23:51 INFO - 2015-11-20 11:23:51,963 DEBUG : BROWSER_OUTPUT: Values: 652.3 11:23:51 INFO - 2015-11-20 11:23:51,963 DEBUG : BROWSER_OUTPUT: 11:23:51 INFO - 2015-11-20 11:23:51,963 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:155.67 Median:155.67 stddev:0.00 (0.0%) 11:23:51 INFO - 2015-11-20 11:23:51,963 DEBUG : BROWSER_OUTPUT: Values: 155.7 11:23:51 INFO - 2015-11-20 11:23:51,963 DEBUG : BROWSER_OUTPUT: 11:23:51 INFO - 2015-11-20 11:23:51,964 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:290.53 Median:290.53 stddev:0.00 (0.0%) 11:23:51 INFO - 2015-11-20 11:23:51,964 DEBUG : BROWSER_OUTPUT: Values: 290.5 11:23:51 INFO - 2015-11-20 11:23:51,964 DEBUG : BROWSER_OUTPUT: 11:23:51 INFO - 2015-11-20 11:23:51,964 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 11:23:51 INFO - 2015-11-20 11:23:51,964 DEBUG : BROWSER_OUTPUT: Values: 4835.7 11:23:51 INFO - 2015-11-20 11:23:51,964 DEBUG : BROWSER_OUTPUT: 11:23:51 INFO - 2015-11-20 11:23:51,964 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:945.18 Median:945.18 stddev:0.00 (0.0%) 11:23:51 INFO - 2015-11-20 11:23:51,964 DEBUG : BROWSER_OUTPUT: Values: 945.2 11:23:51 INFO - 2015-11-20 11:23:51,964 DEBUG : BROWSER_OUTPUT: 11:23:51 INFO - 2015-11-20 11:23:51,964 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:739.64 Median:739.64 stddev:0.00 (0.0%) 11:23:51 INFO - 2015-11-20 11:23:51,964 DEBUG : BROWSER_OUTPUT: Values: 739.6 11:23:51 INFO - 2015-11-20 11:23:51,964 DEBUG : BROWSER_OUTPUT: 11:23:51 INFO - 2015-11-20 11:23:51,964 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12512.50 Median:12512.50 stddev:0.00 (0.0%) 11:23:51 INFO - 2015-11-20 11:23:51,964 DEBUG : BROWSER_OUTPUT: Values: 12512.5 11:23:51 INFO - 2015-11-20 11:23:51,964 DEBUG : BROWSER_OUTPUT: 11:23:51 INFO - 2015-11-20 11:23:51,965 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26789.47 Median:26789.47 stddev:0.00 (0.0%) 11:23:51 INFO - 2015-11-20 11:23:51,965 DEBUG : BROWSER_OUTPUT: Values: 26789.5 11:23:51 INFO - 2015-11-20 11:23:51,965 DEBUG : BROWSER_OUTPUT: 11:23:51 INFO - 2015-11-20 11:23:51,965 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:654.88 Median:654.88 stddev:0.00 (0.0%) 11:23:51 INFO - 2015-11-20 11:23:51,965 DEBUG : BROWSER_OUTPUT: Values: 654.9 11:23:51 INFO - 2015-11-20 11:23:51,965 DEBUG : BROWSER_OUTPUT: 11:23:51 INFO - 2015-11-20 11:23:51,965 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4643.52 Median:4643.52 stddev:0.00 (0.0%) 11:23:51 INFO - 2015-11-20 11:23:51,965 DEBUG : BROWSER_OUTPUT: Values: 4643.5 11:23:51 INFO - 2015-11-20 11:23:51,965 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:23:51 INFO - 2015-11-20 11:23:51,965 DEBUG : BROWSER_OUTPUT: 11:23:52 INFO - 2015-11-20 11:23:52,573 INFO : Browser exited with error code: 0 11:23:52 INFO - 2015-11-20 11:23:52,591 INFO : Completed test v8_7 (00:00:37) 11:23:53 INFO - 2015-11-20 11:23:53,010 INFO : Completed test suite (00:20:05) 11:23:53 INFO - 2015-11-20 11:23:53,010 DEBUG : Working with test: dromaeo_css 11:23:53 INFO - 2015-11-20 11:23:53,010 DEBUG : Generating results file: dromaeo_css 11:23:53 INFO - 2015-11-20 11:23:53,011 DEBUG : Working with test: kraken 11:23:53 INFO - 2015-11-20 11:23:53,011 DEBUG : Generating results file: kraken 11:23:53 INFO - 2015-11-20 11:23:53,011 INFO : javascript benchmark 11:23:53 INFO - 2015-11-20 11:23:53,011 DEBUG : Working with test: v8_7 11:23:53 INFO - 2015-11-20 11:23:53,011 DEBUG : Generating results file: v8_7 11:23:53 INFO - 2015-11-20 11:23:53,012 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:23:53 INFO - 2015-11-20 11:23:53,065 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,61]] 11:23:53 INFO - 2015-11-20 11:23:53,065 DEBUG : process_Request line: dromaeo_css 7688.98 graph.html#tests=[[72,64,61]] 11:23:53 INFO - 2015-11-20 11:23:53,065 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:23:53 INFO - 2015-11-20 11:23:53,097 DEBUG : process_Request line: kraken 1515.80 graph.html#tests=[[232,64,61]] 11:23:53 INFO - 2015-11-20 11:23:53,097 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:23:53 INFO - 2015-11-20 11:23:53,125 DEBUG : process_Request line: v8_7 19015.89 graph.html#tests=[[230,64,61]] 11:23:53 INFO - 2015-11-20 11:23:53,126 INFO : javascript benchmark 11:23:53 INFO - 2015-11-20 11:23:53,127 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3397.7621566490348, 3469.68772810447, 3482.895513134607, 3516.3670539302916, 3519.87680431185, 5717.914231286529, 5771.682557459338, 5788.0, 5792.362840087587, 5800.245968024156, 5622.690752008648, 5785.247917770695, 5785.652860828353, 5795.82612521624, 5896.557758168133, 5212.582993360532, 5230.843074707765, 5286.154215325549, 5347.518723314901, 5361.08861493547, 4834.444038935515, 5373.731313434332, 5393.460653934614, 5401.27082843817, 5401.297831281928, 5154.742262886841, 5157.974210128963, 5245.921311180336, 5292.444293349201, 5301.628885977983, 5277.736113194325, 5287.074761916688, 5305.920411193835, 5316.0, 5320.334958130234, 5219.217117432378, 5234.528892399664, 5245.423003469616, 5258.421573626898, 5324.307839980777, 5092.8217512387255, 5472.015037293286, 5663.4336566343445, 5791.0734282514595, 5826.912596311059, 6261.87476250477, 6278.49772018242, 6309.179806625155, 6316.463100636452, 6341.80974570759, 6330.588511746768, 6352.587081839712, 6356.173697419352, 6360.491160707179, 6384.585001974903, 5756.28046494184, 5804.158397032406, 5877.647341159544, 5882.441168089024, 5941.22764040672, 6336.936630633727, 6390.764366044538, 6439.742410303629, 6446.0, 6499.7400103995315, 6016.548758843104, 6280.183576135073, 6290.685465726695, 6302.401271879165, 6302.432781049728, 4881.731504767201, 6204.37956204385, 6238.563300568917, 6269.373062693785, 6269.686515674198, 6243.219597550306, 6251.9687401562705, 6273.96863015682, 6287.46556542699, 6320.304766475684, 6120.264288666148, 6273.529485288622, 6279.686015699197, 6284.937150628435, 6288.245410550763, 4924.1875090610365, 4964.081644895706, 4966.0, 4981.227909674007, 5020.3724534433195, 4478.6864919455975, 4480.283154695298, 4491.910161796745, 4499.820007199741, 4533.297338912408, 5663.490285874291, 5802.100674395476, 5851.824445266649, 6024.879502409927, 6033.607815491979, 6091.0, 6250.124982502453, 6319.905201421982, 6325.05124231369, 6326.430621244018, 5192.428832828386, 5253.894922101536, 5904.084866845646, 5968.641881487125, 6003.099535069775, 4185.476815398075, 5350.036993341236, 5439.211314359396, 5503.752331145108, 5542.307211598551, 6421.678916054178, 6423.953117944528, 6425.614463132227, 6432.839179020562, 6449.451796597248, 6343.365663433804, 6356.0, 6359.936400635935, 6363.172787537591, 6378.936210637834, 6228.439440450381, 6304.306526282197, 6347.0479428086155, 6361.491080713439, 6370.74517019314, 6282.874342513032, 6294.433500984934, 6298.1812364392335, 6303.747850086129, 6314.84212894663, 6297.992321228581, 6314.652694101868, 6327.936720632919, 6337.904931426125, 6341.397567231105, 6076.54425918049, 6137.591499645514, 6143.262808463013, 6185.752569897334, 6196.1015652731, 6248.781292654735, 6249.625022498664, 6278.623282603058, 6285.402886725937, 6290.2766181889665, 4512.842050528216, 6084.209052823105, 6100.115483254992, 6143.508519318533, 6163.599366041193, 5847.473727364558, 5852.707364631837, 5894.233749612695, 5935.495482883831, 6150.446459818638, 6136.23297087864, 6175.320714721467, 6209.59637623553, 6211.782587609412, 6215.533834962305], "unit": "ms", "name": "dojo.html", "value": 5752.193144260496}, {"lowerIsBetter": false, "replicates": [564.7317524176019, 565.9886802263954, 593.0599999001582, 629.5907660020986, 632.5730132160792, 39886.60113398865, 40155.397669034915, 40273.79863100687, 40315.99210019751, 40443.79778101109, 41851.0, 41991.79004104975, 42214.7889260554, 42323.57676423235, 42408.36387454183, 9754.512274386288, 9916.603335866557, 9930.90069099307, 9946.154576860976, 9968.451735154564, 9747.805043899154, 9851.310408271424, 9856.162226210745, 9881.654142105028, 9886.851697224547, 9797.461139637317, 9859.866115396713, 9871.210303175765, 9894.40633561985, 9896.109350158484, 8334.291585215264, 8878.644854205888, 9714.077162669535, 9825.459599722013, 9831.65589204378, 8378.622961966727, 9810.166135878459, 9823.214142868625, 9824.754381140458, 9825.066618671215, 39142.80428597867, 39368.0, 39477.80261098705, 39484.802575987225, 39538.40692389617, 3190.218396492851, 3310.2882880180637, 3407.4888766685194, 3443.0, 3527.9118022049397, 28149.155525334274, 28228.717712822814, 28390.85804570964, 28550.0, 29456.705432945826, 2731.289864635189, 2820.8025438219333, 2826.3499395139233, 2851.985740071307, 2866.154484427099, 611347.0, 689702.0, 696582.0, 699060.5046974733, 699174.9999999949, 61905.0, 68980.0, 69544.6522767393, 69612.65193674101, 69647.3035269651, 61960.380396196364, 73326.63336683389, 73802.63098684473, 73839.89240161402, 74612.0, 16409.6718065638, 16420.4252851152, 16473.423430180126, 16630.6673866522, 16651.33394664224, 12549.749005019848, 12634.052446066582, 12683.556075537312, 12737.55418560346, 12741.0, 20842.791572084087, 20929.0, 21154.47113822136, 21171.364859054254, 21741.021654025608, 9404.742861713139, 9635.759106022266, 9641.807163856824, 9650.95174524137, 9665.405208140579, 940.3840484482674, 961.6297725375781, 991.6727479931606, 1000.5447521377756, 1058.9099926506178, 29732.851335743184, 29734.553981690293, 30341.69658303389, 30344.241393965327, 30367.0, 914.3736540469799, 1012.5696578953915, 1050.5272627317738, 1080.6271836216492, 1084.7938891610727, 12512.436940337706, 14471.493497727739, 14797.852021479863, 14834.851651483563, 14920.955533112578, 670363.0, 670415.0, 672577.0, 674406.0, 683188.0, 56177.87644247092, 56264.71867640636, 56691.433085668614, 56845.71577142088, 57244.0, 1389.2914613547164, 1444.3933547909903, 1450.52132796177, 1481.2815784344584, 1537.3773621683235, 28593.14220573386, 28764.280892977844, 29079.85460072686, 29083.12750617485, 29323.41353172967, 49464.50535494743, 49531.009379812924, 49993.50006499889, 50044.74977625089, 50237.246441302676, 518552.0, 518738.0, 519299.0, 520333.0, 522922.0, 28959.276018098873, 29455.0, 32223.35553288968, 32885.50671739878, 32989.01032969015, 39786.60213397829, 40127.0, 41327.0, 41623.959401015214, 41809.95475113147, 33625.0, 34988.0, 35072.772452964025, 35191.824040879634, 35409.29181416306, 35228.647713522536, 35407.90328220992, 35978.28043439169, 36102.819485903456, 36111.63888361083, 35102.47346289859, 35154.0, 35196.824015879756, 38362.80818595889, 39111.0, 32748.34503309873, 34458.310833782685, 34831.82584087063, 42193.578064218964, 42884.57115428806, 26708.866455667598, 32032.039038828872, 32032.199195019377, 32798.34403311873, 33287.0], "unit": "ms", "name": "ext.html", "value": 20491.273976186658}, {"lowerIsBetter": false, "replicates": [338.9779664321819, 360.6763179132583, 364.6207943738512, 366.7982609564739, 368.0834721543356, 16192.927652130451, 17466.388676396327, 19384.0, 20554.486137846543, 21368.89315553424, 19431.417057488263, 20099.899500502514, 20132.0, 20348.59302813943, 20763.377098687062, 5649.0114230009785, 5842.97078514609, 5850.853728656796, 5861.8569378971115, 5868.970655146718, 3933.3706606942897, 4034.899127521821, 5531.695756733378, 5685.1756495308155, 5829.650220986754, 5798.362180160179, 5800.332961709394, 5808.099744539603, 5827.796027139051, 5828.300603927534, 5835.649861008332, 6391.392817682313, 6435.066915297302, 6441.0982462455295, 6472.611643301417, 5447.591430642718, 5522.282103326542, 5594.58040646949, 5604.0, 5606.074997625427, 12796.61610151697, 12956.028297877603, 12981.41583628739, 13031.152975056686, 21026.369208923756, 1931.5267759398896, 2001.609686111209, 2138.8182004529635, 2262.9773702263096, 2266.5466906618576, 8592.785180370478, 9029.96155442126, 9534.380265282804, 9964.402135871798, 10032.94983525085, 1696.2790813904041, 1727.6890159771235, 1749.2041121289783, 1757.745126956597, 1800.3608718904861, 101210.49394753053, 107218.46390768074, 108547.91452085537, 108754.0, 109942.0, 11190.944045279884, 11226.158038147172, 11279.548818047351, 11403.885961140448, 11404.973552380327, 13269.535566255328, 13291.110923308614, 13324.200547967153, 13372.130811497222, 13404.664883377798, 7288.96355518219, 8643.870341944876, 8670.263027642595, 8687.131286871389, 8738.650453981896, 8824.470531768115, 8853.29173666118, 8911.287097032222, 8918.554072296489, 8979.77550561228, 4313.245182093121, 4361.127774445124, 4372.825086996548, 4403.427554417905, 4421.53573874745, 1480.9777853331993, 1643.8931469454446, 1797.8831375960522, 1806.8102849200907, 1843.741876137342, 897.4525539420948, 919.9448033118034, 927.9257659387233, 1005.9094681478703, 1028.4497793680346, 18606.255749769858, 18651.440456786317, 19069.427917162506, 19633.31283405074, 21155.942202889793, 853.6201390381345, 911.6991392840347, 943.1228957069991, 965.8599503072156, 989.6635144051057, 9748.46383448903, 10449.529771160316, 10610.734731631772, 10673.092787113183, 10724.356538607708, 634039.0, 663516.0, 772634.0, 774801.0, 786633.0, 126984.36507817401, 127021.0, 128551.71448285585, 131578.0, 133136.0, 1170.7775522650838, 1191.6246382389693, 1193.3138445393934, 1204.692803335144, 1205.102198861836, 18011.279548818424, 18113.547161321072, 18210.72683909716, 18298.26806927708, 18492.260309587466, 51261.74369128131, 51993.0, 52180.73909630428, 52418.73790631023, 53070.73464632806, 74626.0, 75214.0, 75316.0, 75692.0, 76948.61525692335, 9511.619535218513, 9633.843938727397, 9693.854592180982, 9736.95131524338, 10115.848262275924, 19219.615607688047, 19221.807781922562, 19461.026948652227, 20534.383968480968, 20628.0, 15490.9225453872, 15532.456364027204, 15895.284712187748, 16283.755743663618, 16305.836941630907, 15549.989250698669, 15586.532404027897, 15645.608859778597, 15653.21733913277, 15884.205789710237, 15950.680986379975, 16037.518874433787, 16218.513444596681, 16245.350185992427, 16447.342106316093, 8269.421140520106, 8681.652733890574, 9537.856932146162, 9655.179309758749, 9974.351667141902, 15932.362705492114, 16258.51224463268, 16275.674486509966, 16277.267522961258, 16336.428225012067], "unit": "ms", "name": "jquery.html", "value": 9877.557729086055}, {"lowerIsBetter": false, "replicates": [1559.0957244798012, 1601.143388287266, 1901.6577016137098, 1924.788273289938, 1930.64283107625, 7784.3772498200005, 7980.241877021674, 8028.558429286387, 8395.538245396501, 8413.747587572376, 8180.0, 8272.751817445485, 8352.832943341145, 8354.874676879837, 8394.916050839489, 2398.688170537828, 2417.0, 2441.4750828571855, 2448.2777580613674, 2450.546648869956, 2324.32594547581, 2330.4406942333803, 2382.273406610983, 2383.0467812874904, 2383.344580240439, 2410.108259943823, 2418.5283869645336, 2437.756224377566, 2452.1907770435714, 2463.9651346434453, 2397.712274527068, 2410.554047501218, 2420.576399130154, 2423.4789520253144, 2442.6336049592524, 2126.319577735125, 2400.2919138853904, 2446.963295550568, 2463.4580392313665, 2477.2072936660275, 8514.659413623447, 8583.227509524111, 8602.612882420306, 8638.308935285162, 8645.956770216171, 4782.067496838118, 5255.973720131413, 5358.544523715489, 5367.570594352482, 5374.7043912584795, 3262.8042317461027, 3497.562804649419, 3514.279572687593, 3597.4963505109304, 3614.132608174046, 1022.892596277395, 1051.1380667852363, 1069.6309773128337, 1088.9509972051198, 1092.94535273236, 11326.377049262288, 11337.489812958436, 11341.659750207507, 11359.148063895242, 11372.0, 4291.699581029298, 4689.343491911135, 4814.422269327703, 4817.614590832725, 4819.638527110481, 9704.951475242578, 9820.803583928282, 9839.163671088038, 9840.507974601242, 9863.802723945624, 5228.4510126436935, 5263.973680131575, 5292.073887069748, 5292.100342941709, 5308.46915308466, 4760.833370832004, 4808.807647694123, 4812.085703716282, 4826.541478559531, 4827.444843843003, 3928.8035598220545, 3946.5856085111222, 3970.861019864291, 3973.046468847456, 3977.6618987386396, 1258.6601617563206, 1261.5773715805124, 1276.6233960981347, 1279.507389654971, 1279.6864768131868, 1372.1561239837627, 1378.9655258618616, 1402.3198748606917, 1421.6588018875395, 1422.4736847366335, 7997.880296758459, 8052.798680032929, 8072.071711753106, 8079.0, 8101.837963240702, 438.89247134451625, 493.87159338571513, 499.73264303598125, 504.28895257686486, 509.9031184075014, 6015.218021657157, 6150.415710507495, 6150.969245153746, 6163.322034576193, 6210.254769427607, 9721.659741909, 10339.9483002586, 10419.531121099568, 10420.531076101443, 10425.165986721044, 10083.899161008296, 10157.444894287088, 10216.0, 10273.332233404954, 10346.32748871321, 8025.438219324591, 8046.718364857202, 8140.552269625346, 8152.918470815216, 8166.836663266701, 6695.4978376620975, 6777.8983315249325, 6882.8967565485555, 6899.724011039502, 7887.566183859943, 9084.54577271147, 9327.440353578808, 9359.672411465566, 9435.433873967584, 9457.952710236405, 9501.0, 9510.952445238006, 9643.132118109404, 9715.36850104741, 9750.171235444783, 6628.403443690091, 7390.29792169743, 7520.699172033057, 7530.0, 7570.962145189239, 7247.528910621004, 8254.298384637374, 8263.214994575506, 8303.335733141213, 8327.833443331221, 7580.772576822704, 7638.732644357421, 7712.0, 7718.92281077182, 7775.455718099679, 7551.509151905108, 7559.357454616419, 7578.0, 7620.276073772982, 7642.541447513167, 7695.615219238904, 7701.345385642283, 7743.6515356810205, 7758.262965018314, 7768.805779855549, 6959.234484206834, 6966.12923384577, 6983.6857341418745, 7026.718931242693, 7033.542819716702, 7086.362227399559, 7106.786796396116, 7135.072440582691, 7153.213146553979, 7153.928460715326], "unit": "ms", "name": "mootools.html", "value": 4767.907492940921}, {"lowerIsBetter": false, "replicates": [317.16743548186014, 322.7885734843678, 323.7765941500366, 329.35117817898737, 330.1679766987194, 7046.823829404268, 7063.470239732022, 7146.213916469191, 7147.356737893595, 7190.8561828763395, 6987.30126987301, 7033.824154396143, 7075.46933979951, 7106.147262328514, 7117.430605551556, 4407.0, 5084.211947148188, 5099.991005306868, 5100.464451232604, 5105.009046471879, 4694.389729335182, 5075.5178258065425, 5092.745362731867, 5099.949000510003, 5121.513456221653, 4943.678660887049, 4962.42932062812, 4985.476524964881, 5009.0, 5025.120603894322, 4987.625928055392, 4996.400431948153, 4998.775055122528, 5021.372328458942, 5032.245163225509, 4217.493900731901, 4224.260754367973, 4226.4716910386205, 4231.8518851840345, 4237.089025859455, 4936.308916751622, 5843.853903652443, 6660.0, 6720.899186512206, 6735.955926831349, 4929.383827021622, 5858.062709966385, 5866.823995280149, 5879.970600146972, 5893.5579831512805, 7394.7411840585855, 7398.260173982612, 7405.407567394595, 7406.07424071991, 7411.925880741178, 4691.038337140878, 4710.882227944295, 4717.268823332354, 4731.550502702238, 4760.738159401231, 6751.628660423675, 7814.960925195338, 7878.80302992424, 7943.205679432011, 8005.07941586725, 4257.40396344512, 4886.99816537609, 4960.355153829979, 4971.602271818246, 5000.39995200571, 5090.10923088458, 5094.057599344133, 5110.71891045996, 5120.257562653394, 5145.279660847485, 5933.199018132583, 5958.106284057426, 5969.880602387928, 5976.551758618121, 5977.163197152402, 7485.663145158481, 7495.850082998419, 7541.0, 7545.886811697829, 7577.469577129548, 1674.2884274183666, 1706.9587551593518, 1736.5050960476203, 1765.9028753418686, 1773.2552328022261, 1122.6239209864787, 1130.4121856634504, 1141.902938250258, 1149.7068247596976, 1149.741308205647, 7067.293270672892, 7073.893891591631, 7077.575345479185, 7078.858422831515, 7087.964560177166, 7766.495177813424, 7769.650365733555, 7774.222577742294, 7777.222277772177, 7784.961075194701, 6143.385661433821, 6428.357164283628, 6529.249136349381, 6930.896036559456, 7118.288171182944, 3461.9228462922047, 3991.560928297885, 4120.587941205856, 4144.026153853842, 4149.564295748903, 7440.330370266702, 7687.424078063984, 8047.798805029921, 8162.877556836652, 8177.2640462357485, 7878.094019187753, 8109.432339736162, 8116.431849770577, 8155.918440815516, 8163.306118979954, 8094.392920530984, 8136.674533018731, 8137.837243255101, 8147.266745992889, 8172.141925097898, 7686.461947663834, 7850.0, 7858.410619203468, 7862.2923936845955, 7873.921260787319, 7672.0409948756405, 7688.8077798053255, 7701.0, 7704.229577042475, 7742.225777422213, 8114.634841432267, 8127.715529956423, 8132.471389359673, 8137.79655508617, 8147.063087744985, 4717.174494463524, 4770.928436073531, 4822.614190864792, 4840.588549973291, 4842.15262329084, 7572.507786993828, 7686.961565192139, 7867.0, 7890.250426209501, 7892.723754668559, 5668.404817494104, 7416.517926334771, 7556.093268807558, 7573.9242607575425, 7612.276833700789, 6414.198225221848, 7324.864645979882, 7512.511686740344, 7545.358644515058, 7591.278828511504, 7077.009218709488, 7355.264473552602, 7366.116066072105, 7379.446541509301, 7391.593462359407, 7563.205863384265, 7578.583177925267, 7584.734534291273, 7591.810204744926, 7597.278258565428, 6432.517561182836, 6937.965310173417, 7399.96300018518, 7405.148407932941, 7431.888521672287], "unit": "ms", "name": "prototype.html", "value": 5411.654682191907}, {"lowerIsBetter": false, "replicates": [737.2001378504323, 743.0648936700035, 752.2477522477523, 783.3967844759532, 824.7855557555034, 15014.474493392734, 15214.0, 15319.004264722786, 15319.540413787576, 15364.769528457082, 13763.449462021532, 14045.157290562573, 14087.366068526915, 14089.0, 14159.504417345395, 740.566768440463, 758.9772306830804, 911.4121391702348, 923.1276443760632, 941.2799208605422, 932.8181004704086, 938.7746940734208, 938.8732521109665, 944.6882528765491, 950.353759443578, 985.7683444390562, 986.0780170540531, 992.8411454167334, 998.0518507417946, 998.8351921932872, 983.6213057972697, 983.6360546597733, 985.7979114281555, 996.1333639733479, 999.1906555689915, 712.2912701861629, 718.8131085917647, 719.5287086958051, 723.1394640377986, 724.5399171526119, 14970.62573435662, 14973.550793476214, 14980.176090315028, 14997.475088371855, 15174.848251517455, 10510.737231569196, 12746.044046696443, 12826.294553799537, 12865.292408917507, 12901.181073117643, 9049.95925468573, 9987.450690212036, 10097.394156350643, 10394.324368915995, 10885.510152043098, 3553.7690050146657, 3582.8387722552548, 3595.2449985502813, 3632.56409230894, 3645.453182022691, 73983.26016739817, 75106.62446687787, 76158.23841761566, 77342.61328693377, 77662.0, 9517.524123793783, 9612.231021518262, 9643.614255429844, 9648.71053868371, 10059.144972677259, 21875.343739687836, 21910.23314183996, 22137.003834827472, 22268.777312226994, 22423.551528969656, 7446.292602202782, 7539.773806785805, 7627.275408836152, 7636.847263054708, 7813.570253635991, 3980.1641655252142, 4032.2741906457118, 4033.3143365627325, 4048.2105989332385, 4056.1887622475624, 3523.841427135785, 3557.2529768748855, 3571.589267234301, 3577.3918433866306, 3578.588462326814, 624.7376102037156, 627.8775638750491, 636.0713358496647, 659.2583343738295, 660.5145218264572, 441.96022357987937, 542.888707814897, 575.9510441612426, 584.1442287049493, 617.7521406758323, 8336.249737523653, 8730.0, 8847.955760221157, 8891.110888911056, 9054.637814487478, 477.11971412743435, 492.308306828906, 516.5686651645842, 527.5779376498785, 528.8730704630938, 4153.626173644387, 4212.85255016073, 4258.6380157686945, 4259.87220383389, 4299.527052024275, 100821.49589252153, 100999.0, 101075.0, 102813.0, 103316.48341758244, 80845.0, 81074.0, 81299.5935020321, 81883.0, 82673.17326826775, 66692.66614667776, 66948.0, 68063.65968170227, 68875.0, 72697.0, 7334.633268336668, 8246.917530824854, 8280.544570048705, 8324.458910170819, 8552.957235213784, 48911.0, 49791.75104124601, 50208.48123668887, 50789.0, 51984.74007629938, 66600.0, 72830.63584682255, 73397.63301183673, 74086.25913740793, 75185.62407187928, 10178.440185789852, 10251.282410231212, 10316.845247321446, 10448.58205671795, 10581.735456613646, 10562.683119506428, 10740.892591073989, 10890.61882834097, 11012.063974562252, 11914.702132446411, 10244.897551024394, 10413.791724165625, 10827.783444331228, 10838.67483975482, 11325.830112548154, 9664.130228279488, 9836.803263934824, 9883.0, 9908.35595686278, 10223.59105635796, 10176.236782241509, 10617.469126543487, 10667.679969600924, 10668.359898406121, 11159.832602510807, 9037.0, 9054.818903622023, 9263.675771347971, 9386.342955993015, 9576.616935322509, 8645.394822362627, 8720.563971801512, 9391.389559678599, 9394.077539046939, 9520.381175223589], "unit": "ms", "name": "yui.html", "value": 6878.077351876994}], "name": "dromaeo_css", "value": 7688.98236101906}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [115.0, 107.0, 114.0, 127.0, 164.0, 170.0, 114.0, 117.0, 114.0, 113.0], "unit": "ms", "name": "ai-astar", "value": 125.5}, {"lowerIsBetter": true, "replicates": [159.0, 113.0, 168.0, 181.0, 149.0, 147.0, 144.0, 118.0, 177.0, 124.0], "unit": "ms", "name": "audio-beat-detection", "value": 148.0}, {"lowerIsBetter": true, "replicates": [192.0, 192.0, 197.0, 202.0, 203.0, 223.0, 197.0, 197.0, 205.0, 197.0], "unit": "ms", "name": "audio-dft", "value": 200.5}, {"lowerIsBetter": true, "replicates": [57.0, 90.0, 83.0, 84.0, 136.0, 51.0, 76.0, 81.0, 84.0, 100.0], "unit": "ms", "name": "audio-fft", "value": 84.2}, {"lowerIsBetter": true, "replicates": [77.0, 79.0, 106.0, 103.0, 109.0, 109.0, 116.0, 76.0, 75.0, 111.0], "unit": "ms", "name": "audio-oscillator", "value": 96.1}, {"lowerIsBetter": true, "replicates": [90.0, 90.0, 89.0, 89.0, 91.0, 90.0, 90.0, 89.0, 98.0, 122.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 93.8}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 98.0, 97.0, 98.0, 139.0, 97.0, 98.0, 98.0, 97.0], "unit": "ms", "name": "imaging-darkroom", "value": 101.6}, {"lowerIsBetter": true, "replicates": [111.0, 145.0, 110.0, 91.0, 93.0, 91.0, 121.0, 87.0, 118.0, 80.0], "unit": "ms", "name": "imaging-desaturate", "value": 104.7}, {"lowerIsBetter": true, "replicates": [59.0, 59.0, 62.0, 61.0, 61.0, 60.0, 59.0, 67.0, 58.0, 58.0], "unit": "ms", "name": "json-parse-financial", "value": 60.4}, {"lowerIsBetter": true, "replicates": [66.0, 84.0, 57.0, 59.0, 59.0, 70.0, 98.0, 99.0, 101.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 76.2}, {"lowerIsBetter": true, "replicates": [85.0, 82.0, 84.0, 84.0, 87.0, 83.0, 85.0, 84.0, 86.0, 84.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 84.4}, {"lowerIsBetter": true, "replicates": [126.0, 123.0, 131.0, 129.0, 123.0, 130.0, 121.0, 142.0, 120.0, 147.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 129.2}, {"lowerIsBetter": true, "replicates": [140.0, 143.0, 134.0, 137.0, 143.0, 144.0, 145.0, 136.0, 140.0, 138.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 140.0}, {"lowerIsBetter": true, "replicates": [66.0, 68.0, 66.0, 67.0, 68.0, 66.0, 68.0, 66.0, 91.0, 86.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 71.2}], "name": "kraken", "value": 1515.8000000000002}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [652.3157208088714], "unit": "score", "name": "Richards", "value": 54.117965999999996}, {"lowerIsBetter": false, "replicates": [155.6662515566625], "unit": "score", "name": "DeltaBlue", "value": 424.74203200000017}, {"lowerIsBetter": false, "replicates": [290.5287623474724], "unit": "score", "name": "Encrypt", "value": 916.1950020000002}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "Decrypt", "value": 55.0444225774226}, {"lowerIsBetter": false, "replicates": [945.179584120983], "unit": "score", "name": "RayTrace", "value": 782.908362}, {"lowerIsBetter": false, "replicates": [739.6449704142012], "unit": "score", "name": "Earley", "value": 901.0579759999997}, {"lowerIsBetter": false, "replicates": [12512.5], "unit": "score", "name": "Boyer", "value": 53.26377622377621}, {"lowerIsBetter": false, "replicates": [26789.473684210527], "unit": "score", "name": "RegExp", "value": 34.0053339882122}, {"lowerIsBetter": false, "replicates": [654.8788474132285], "unit": "score", "name": "Splay", "value": 124.43675700000003}, {"lowerIsBetter": false, "replicates": [4643.518518518518], "unit": "score", "name": "NavierStokes", "value": 319.58524426719833}], "name": "v8_7", "value": 19015.89394041361}]} 11:23:53 INFO - RETURN: dromaeo_css: 7688.98 11:23:53 INFO - RETURN: kraken: 1515.80 11:23:53 INFO - RETURN: v8_7: 19015.89 11:23:53 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,61]]", "result": "19015.89"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,61]]", "result": "1515.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,61]]", "result": "7688.98"}}} 11:23:53 INFO - Return code: 0 11:23:53 INFO - # TBPL SUCCESS # 11:23:53 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:23:53 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:23:53 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:23:53 INFO - 2015-11-20 11:23:53.226 screenresolution[1963:22205] starting screenresolution argv=screenresolution get 11:23:53 INFO - 2015-11-20 11:23:53.228 screenresolution[1963:22205] Display 0: 1600x1200x32@60 11:23:53 INFO - 2015-11-20 11:23:53.234 screenresolution[1964:22208] starting screenresolution argv=screenresolution list 11:23:53 INFO - Available Modes on Display 0 11:23:53 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:23:53 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:23:53 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:23:53 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:23:53 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:23:53 INFO - Intel Iris: 11:23:53 INFO - Chipset Model: Intel Iris 11:23:53 INFO - Type: GPU 11:23:53 INFO - Bus: Built-In 11:23:53 INFO - VRAM (Dynamic, Max): 1536 MB 11:23:53 INFO - Vendor: Intel (0x8086) 11:23:53 INFO - Device ID: 0x0a2e 11:23:53 INFO - Revision ID: 0x0009 11:23:53 INFO - Displays: 11:23:53 INFO - Display: 11:23:53 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:23:53 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:23:53 INFO - Display Serial Number: 1600x1200 60 11:23:53 INFO - Main Display: Yes 11:23:53 INFO - Mirror: Off 11:23:53 INFO - Online: Yes 11:23:53 INFO - Rotation: Supported 11:23:53 INFO - Return code: 0 11:23:53 INFO - Running post-action listener: _resource_record_post_action 11:23:53 INFO - Running post-run listener: _resource_record_post_run 11:23:54 INFO - Total resource usage - Wall time: 1237s; CPU: 54.0%; Read bytes: 139264; Write bytes: 695303680; Read time: 5; Write time: 2399 11:23:54 INFO - install - Wall time: 31s; CPU: 54.0%; Read bytes: 340511232; Write bytes: 337106944; Read time: 26647; Write time: 630 11:23:54 INFO - run-tests - Wall time: 1207s; CPU: 54.0%; Read bytes: 139264; Write bytes: 346768896; Read time: 5; Write time: 1732 11:23:54 INFO - Running post-run listener: _upload_blobber_files 11:23:54 INFO - Blob upload gear active. 11:23:54 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 11:23:54 INFO - Copying logs to upload dir... 11:23:54 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1280.081008 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2015-11-20 11:23:54.586807) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-20 11:23:54.590450) ========= 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.9OzVgWdEwF/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.PXXEdgHlIO/Listeners TMPDIR=/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/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/kgTAQ6WKSeSi8Ap5Whwfyg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.009357 build_url: 'https://queue.taskcluster.net/v1/task/kgTAQ6WKSeSi8Ap5Whwfyg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg' ========= master_lag: 0.02 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-20 11:23:54.615681) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 11:23:54.616072) ========= 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.9OzVgWdEwF/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.PXXEdgHlIO/Listeners TMPDIR=/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/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.004582 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 11:23:54.668199) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-20 11:23:54.668549) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-20 11:23:54.668995) ========= ========= Total master_lag: 0.49 =========