builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0051 starttime: 1448333455.58 results: success (0) buildid: 20151123173633 builduid: d1c54936b1de4e088d7f88ca1df7cec1 revision: eb7962bf88a8517d92c21263f3982fe95ff80eb4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-23 18:50:55.581215) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-23 18:50:55.581664) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-23 18:50:55.582029) ========= 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.2ru3ViqQUC/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.A15TgHtWVw/Listeners TMPDIR=/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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.005616 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-23 18:50:55.605492) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-23 18:50:55.605806) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-23 18:50:55.622103) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 18:50:55.622535) ========= 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.2ru3ViqQUC/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.A15TgHtWVw/Listeners TMPDIR=/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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.005144 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 18:50:55.670272) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-23 18:50:55.670573) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-23 18:50:55.672932) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 18:50:55.673240) ========= 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.2ru3ViqQUC/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.A15TgHtWVw/Listeners TMPDIR=/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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-23 18:50:55-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 1.62G=0s 2015-11-23 18:50:55 (1.62 GB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.165091 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 18:50:55.851311) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 18:50:55.852085) ========= 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.2ru3ViqQUC/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.A15TgHtWVw/Listeners TMPDIR=/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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.019640 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 18:50:55.900367) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 18:50:55.901070) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev eb7962bf88a8517d92c21263f3982fe95ff80eb4 --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 eb7962bf88a8517d92c21263f3982fe95ff80eb4 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.2ru3ViqQUC/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.A15TgHtWVw/Listeners TMPDIR=/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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-23 18:50:55,978 truncating revision to first 12 chars 2015-11-23 18:50:55,978 Setting DEBUG logging. 2015-11-23 18:50:55,978 attempt 1/10 2015-11-23 18:50:55,979 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/eb7962bf88a8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-23 18:50:56,348 unpacking tar archive at: fx-team-eb7962bf88a8/testing/mozharness/ program finished with exit code 0 elapsedTime=0.607869 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 18:50:56.526759) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-23 18:50:56.527069) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-23 18:50:56.540015) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-23 18:50:56.540280) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-23 18:50:56.540665) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2015-11-23 18:50:56.540944) ========= /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.2ru3ViqQUC/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.A15TgHtWVw/Listeners TMPDIR=/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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 18:50:56 INFO - MultiFileLogger online at 20151123 18:50:56 in /builds/slave/test 18:50:56 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 18:50:56 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:50:56 INFO - {'append_to_log': False, 18:50:56 INFO - 'base_work_dir': '/builds/slave/test', 18:50:56 INFO - 'blob_upload_branch': 'Fx-Team', 18:50:56 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:50:56 INFO - 'branch': 'Fx-Team', 18:50:56 INFO - 'buildbot_json_path': 'buildprops.json', 18:50:56 INFO - 'config_files': ('talos/mac_config.py',), 18:50:56 INFO - 'default_actions': ('clobber', 18:50:56 INFO - 'read-buildbot-config', 18:50:56 INFO - 'download-and-extract', 18:50:56 INFO - 'populate-webroot', 18:50:56 INFO - 'create-virtualenv', 18:50:56 INFO - 'install', 18:50:56 INFO - 'run-tests'), 18:50:56 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:50:56 INFO - 'download_minidump_stackwalk': True, 18:50:56 INFO - 'download_symbols': 'ondemand', 18:50:56 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:50:56 INFO - 'tooltool.py': '/tools/tooltool.py', 18:50:56 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:50:56 INFO - '/tools/misc-python/virtualenv.py')}, 18:50:56 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:50:56 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:50:56 INFO - 'installer_path': 'installer.exe', 18:50:56 INFO - 'log_level': 'info', 18:50:56 INFO - 'log_name': 'talos', 18:50:56 INFO - 'log_to_console': True, 18:50:56 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 18:50:56 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 18:50:56 INFO - 'opt_config_files': (), 18:50:56 INFO - 'pip_index': False, 18:50:56 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:50:56 INFO - 'cmd': ('bash', 18:50:56 INFO - '-c', 18:50:56 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:50:56 INFO - 'enabled': True, 18:50:56 INFO - 'halt_on_failure': False, 18:50:56 INFO - 'name': 'check_screen_resolution'},), 18:50:56 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:50:56 INFO - 'cmd': ('bash', 18:50:56 INFO - '-c', 18:50:56 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:50:56 INFO - 'enabled': True, 18:50:56 INFO - 'halt_on_failure': False, 18:50:56 INFO - 'name': 'check_screen_resolution'},), 18:50:56 INFO - 'run_cmd_checks_enabled': True, 18:50:56 INFO - 'sps_profile': False, 18:50:56 INFO - 'sps_profile_interval': 0, 18:50:56 INFO - 'suite': 'dromaeojs-e10s', 18:50:56 INFO - 'system_bits': '64', 18:50:56 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:50:56 INFO - 'title': 't-yosemite-r7-0051', 18:50:56 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:50:56 INFO - 'use_talos_json': True, 18:50:56 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:50:56 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:50:56 INFO - 'work_dir': 'build'} 18:50:56 INFO - ##### 18:50:56 INFO - ##### Running clobber step. 18:50:56 INFO - ##### 18:50:56 INFO - Running pre-action listener: _resource_record_pre_action 18:50:56 INFO - Running main action method: clobber 18:50:56 INFO - rmtree: /builds/slave/test/build 18:50:56 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:50:57 INFO - Running post-action listener: _resource_record_post_action 18:50:57 INFO - ##### 18:50:57 INFO - ##### Running read-buildbot-config step. 18:50:57 INFO - ##### 18:50:57 INFO - Running pre-action listener: _resource_record_pre_action 18:50:57 INFO - Running main action method: read_buildbot_config 18:50:57 INFO - Using buildbot properties: 18:50:57 INFO - { 18:50:57 INFO - "properties": { 18:50:57 INFO - "buildnumber": 20, 18:50:57 INFO - "product": "firefox", 18:50:57 INFO - "script_repo_revision": "production", 18:50:57 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 18:50:57 INFO - "repository": "", 18:50:57 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 18:50:57 INFO - "buildid": "20151123173633", 18:50:57 INFO - "slavename": "t-yosemite-r7-0051", 18:50:57 INFO - "pgo_build": "False", 18:50:57 INFO - "basedir": "/builds/slave/test", 18:50:57 INFO - "project": "", 18:50:57 INFO - "platform": "yosemite_r7", 18:50:57 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 18:50:57 INFO - "slavebuilddir": "test", 18:50:57 INFO - "scheduler": "tests-fx-team-macosx64-talos", 18:50:57 INFO - "branch": "fx-team", 18:50:57 INFO - "repo_path": "integration/fx-team", 18:50:57 INFO - "stage_platform": "macosx64", 18:50:57 INFO - "builduid": "d1c54936b1de4e088d7f88ca1df7cec1", 18:50:57 INFO - "revision": "eb7962bf88a8517d92c21263f3982fe95ff80eb4" 18:50:57 INFO - }, 18:50:57 INFO - "sourcestamp": { 18:50:57 INFO - "repository": "", 18:50:57 INFO - "hasPatch": false, 18:50:57 INFO - "project": "", 18:50:57 INFO - "branch": "fx-team-macosx64-talos", 18:50:57 INFO - "changes": [ 18:50:57 INFO - { 18:50:57 INFO - "category": null, 18:50:57 INFO - "files": [ 18:50:57 INFO - { 18:50:57 INFO - "url": null, 18:50:57 INFO - "name": "https://queue.taskcluster.net/v1/task/xWPFeFVQShqXjHmHRW7FCQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 18:50:57 INFO - } 18:50:57 INFO - ], 18:50:57 INFO - "repository": "", 18:50:57 INFO - "rev": "eb7962bf88a8517d92c21263f3982fe95ff80eb4", 18:50:57 INFO - "who": "maglione.k@gmail.com", 18:50:57 INFO - "when": 1448331943, 18:50:57 INFO - "number": 6698494, 18:50:57 INFO - "comments": "Bug 1209184: Part 1a - [webext] Make localization work in content processes. r=billm", 18:50:57 INFO - "project": "", 18:50:57 INFO - "at": "Mon 23 Nov 2015 18:25:43", 18:50:57 INFO - "branch": "fx-team-macosx64-talos", 18:50:57 INFO - "revlink": "", 18:50:57 INFO - "properties": [ 18:50:57 INFO - [ 18:50:57 INFO - "buildid", 18:50:57 INFO - "20151123173633", 18:50:57 INFO - "Change" 18:50:57 INFO - ], 18:50:57 INFO - [ 18:50:57 INFO - "builduid", 18:50:57 INFO - "d1c54936b1de4e088d7f88ca1df7cec1", 18:50:57 INFO - "Change" 18:50:57 INFO - ], 18:50:57 INFO - [ 18:50:57 INFO - "pgo_build", 18:50:57 INFO - "False", 18:50:57 INFO - "Change" 18:50:57 INFO - ] 18:50:57 INFO - ], 18:50:57 INFO - "revision": "eb7962bf88a8517d92c21263f3982fe95ff80eb4" 18:50:57 INFO - } 18:50:57 INFO - ], 18:50:57 INFO - "revision": "eb7962bf88a8517d92c21263f3982fe95ff80eb4" 18:50:57 INFO - } 18:50:57 INFO - } 18:50:57 INFO - Found installer url https://queue.taskcluster.net/v1/task/xWPFeFVQShqXjHmHRW7FCQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 18:50:57 INFO - Running post-action listener: _resource_record_post_action 18:50:57 INFO - ##### 18:50:57 INFO - ##### Running download-and-extract step. 18:50:57 INFO - ##### 18:50:57 INFO - Running pre-action listener: _resource_record_pre_action 18:50:57 INFO - Running main action method: download_and_extract 18:50:57 INFO - mkdir: /builds/slave/test/build/tests 18:50:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:50:57 INFO - https://queue.taskcluster.net/v1/task/xWPFeFVQShqXjHmHRW7FCQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 18:50:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xWPFeFVQShqXjHmHRW7FCQ/artifacts/public/build/test_packages.json 18:50:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xWPFeFVQShqXjHmHRW7FCQ/artifacts/public/build/test_packages.json 18:50:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xWPFeFVQShqXjHmHRW7FCQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 18:50:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xWPFeFVQShqXjHmHRW7FCQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 18:50:59 INFO - Downloaded 1149 bytes. 18:50:59 INFO - Reading from file /builds/slave/test/build/test_packages.json 18:50:59 INFO - Using the following test package requirements: 18:50:59 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 18:50:59 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 18:50:59 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 18:50:59 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 18:50:59 INFO - u'jsshell-mac.zip'], 18:50:59 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 18:50:59 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 18:50:59 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 18:50:59 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 18:50:59 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 18:50:59 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 18:50:59 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 18:50:59 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 18:50:59 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 18:50:59 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 18:50:59 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 18:50:59 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 18:50:59 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 18:50:59 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')]} 18:50:59 INFO - https://queue.taskcluster.net/v1/task/xWPFeFVQShqXjHmHRW7FCQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 18:50:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xWPFeFVQShqXjHmHRW7FCQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 18:50:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xWPFeFVQShqXjHmHRW7FCQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 18:50:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xWPFeFVQShqXjHmHRW7FCQ/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 18:50:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xWPFeFVQShqXjHmHRW7FCQ/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 18:51:00 INFO - Downloaded 17526952 bytes. 18:51:00 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 18:51:00 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 18:51:00 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 18:51:02 INFO - Return code: 0 18:51:02 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 18:51:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:51:02 INFO - https://queue.taskcluster.net/v1/task/xWPFeFVQShqXjHmHRW7FCQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 18:51:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xWPFeFVQShqXjHmHRW7FCQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 18:51:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xWPFeFVQShqXjHmHRW7FCQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 18:51:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xWPFeFVQShqXjHmHRW7FCQ/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 18:51:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xWPFeFVQShqXjHmHRW7FCQ/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 18:51:04 INFO - Downloaded 17526952 bytes. 18:51:04 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 18:51:04 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 18:51:04 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 18:51:07 INFO - Return code: 0 18:51:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:51:07 INFO - https://queue.taskcluster.net/v1/task/xWPFeFVQShqXjHmHRW7FCQ/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 18:51:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xWPFeFVQShqXjHmHRW7FCQ/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 18:51:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xWPFeFVQShqXjHmHRW7FCQ/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 18:51:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xWPFeFVQShqXjHmHRW7FCQ/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 18:51:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xWPFeFVQShqXjHmHRW7FCQ/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 18:51:08 INFO - Downloaded 11130997 bytes. 18:51:08 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 18:51:08 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 18:51:08 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 18:51:08 INFO - Return code: 0 18:51:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:51:08 INFO - https://queue.taskcluster.net/v1/task/xWPFeFVQShqXjHmHRW7FCQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 18:51:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xWPFeFVQShqXjHmHRW7FCQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 18:51:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xWPFeFVQShqXjHmHRW7FCQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 18:51:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xWPFeFVQShqXjHmHRW7FCQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 18:51:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xWPFeFVQShqXjHmHRW7FCQ/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 18:51:11 INFO - Downloaded 109908876 bytes. 18:51:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/xWPFeFVQShqXjHmHRW7FCQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 18:51:11 INFO - mkdir: /builds/slave/test/properties 18:51:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:51:11 INFO - Writing to file /builds/slave/test/properties/build_url 18:51:11 INFO - Contents: 18:51:11 INFO - build_url:https://queue.taskcluster.net/v1/task/xWPFeFVQShqXjHmHRW7FCQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 18:51:11 INFO - Running post-action listener: _resource_record_post_action 18:51:11 INFO - Running post-action listener: set_extra_try_arguments 18:51:11 INFO - ##### 18:51:11 INFO - ##### Running populate-webroot step. 18:51:11 INFO - ##### 18:51:11 INFO - Running pre-action listener: _resource_record_pre_action 18:51:11 INFO - Running main action method: populate_webroot 18:51:11 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:51:11 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:51:11 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 18:51:11 INFO - '../fennec_ids.txt'], 18:51:11 INFO - 'tests': ['tcheck2']}, 18:51:11 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:51:11 INFO - '--tppagecycles', 18:51:11 INFO - '7'], 18:51:11 INFO - 'tests': ['tsvgm']}}, 18:51:11 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 18:51:11 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 18:51:11 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:51:11 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 18:51:11 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 18:51:11 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 18:51:11 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:51:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:51:11 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:51:11 INFO - 'talos_options': ['--e10s'], 18:51:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:51:11 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:51:11 INFO - 'tests': ['damp', 'tps']}, 18:51:11 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:51:11 INFO - 'talos_options': ['--e10s'], 18:51:11 INFO - 'tests': ['damp', 'tps']}, 18:51:11 INFO - 'g3': {'tests': ['dromaeo_dom']}, 18:51:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:51:11 INFO - 'other': {'tests': ['a11yr', 18:51:11 INFO - 'ts_paint', 18:51:11 INFO - 'tpaint', 18:51:11 INFO - 'sessionrestore', 18:51:11 INFO - 'sessionrestore_no_auto_restore']}, 18:51:11 INFO - 'other-e10s': {'talos_options': ['--e10s'], 18:51:11 INFO - 'tests': ['a11yr', 18:51:11 INFO - 'ts_paint', 18:51:11 INFO - 'tpaint', 18:51:11 INFO - 'sessionrestore', 18:51:11 INFO - 'sessionrestore_no_auto_restore']}, 18:51:11 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 18:51:11 INFO - 'tests': ['a11yr', 18:51:11 INFO - 'ts_paint', 18:51:11 INFO - 'tpaint', 18:51:11 INFO - 'sessionrestore', 18:51:11 INFO - 'sessionrestore_no_auto_restore']}, 18:51:11 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 18:51:11 INFO - 'tests': ['a11yr', 18:51:11 INFO - 'ts_paint', 18:51:11 INFO - 'tpaint', 18:51:11 INFO - 'sessionrestore', 18:51:11 INFO - 'sessionrestore_no_auto_restore']}, 18:51:11 INFO - 'other_l64': {'tests': ['a11yr', 18:51:11 INFO - 'ts_paint', 18:51:11 INFO - 'tpaint', 18:51:11 INFO - 'sessionrestore', 18:51:11 INFO - 'sessionrestore_no_auto_restore']}, 18:51:11 INFO - 'other_nol64': {'tests': ['a11yr', 18:51:11 INFO - 'ts_paint', 18:51:11 INFO - 'tpaint', 18:51:11 INFO - 'sessionrestore', 18:51:11 INFO - 'sessionrestore_no_auto_restore']}, 18:51:11 INFO - 'svgr': {'tests': ['tsvgx', 18:51:11 INFO - 'tsvgr_opacity', 18:51:11 INFO - 'tart', 18:51:11 INFO - 'tscrollx', 18:51:11 INFO - 'cart']}, 18:51:11 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 18:51:11 INFO - 'tests': ['tsvgx', 18:51:11 INFO - 'tsvgr_opacity', 18:51:11 INFO - 'tart', 18:51:11 INFO - 'tscrollx', 18:51:11 INFO - 'cart']}, 18:51:11 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:51:11 INFO - 'tests': ['tp5o']}, 18:51:11 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:51:11 INFO - 'talos_options': ['--e10s'], 18:51:11 INFO - 'tests': ['tp5o']}, 18:51:11 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:51:11 INFO - 'talos_options': ['--xperf_path', 18:51:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:51:11 INFO - 'tests': ['tp5n']}, 18:51:11 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:51:11 INFO - 'talos_options': ['--e10s', 18:51:11 INFO - '--xperf_path', 18:51:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:51:11 INFO - 'tests': ['tp5n']}}, 18:51:11 INFO - 'talos.zip': {'path': '', 18:51:11 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:51:11 INFO - Running post-action listener: _resource_record_post_action 18:51:11 INFO - ##### 18:51:11 INFO - ##### Running create-virtualenv step. 18:51:11 INFO - ##### 18:51:11 INFO - Running pre-action listener: _resource_record_pre_action 18:51:11 INFO - Running main action method: create_virtualenv 18:51:11 INFO - Creating virtualenv /builds/slave/test/build/venv 18:51:11 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 18:51:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:51:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:51:11 INFO - Using real prefix '/tools/python27' 18:51:11 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:51:12 INFO - Installing distribute.............................................................................................................................................................................................done. 18:51:15 INFO - Installing pip.................done. 18:51:15 INFO - Return code: 0 18:51:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:51: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')]} 18:51:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:51:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:51: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')]} 18:51:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:51:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:51: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', '--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 0x11034e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11032b228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee0ada2d20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1102729f0>, '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 0x10ffd1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1102658c8>, '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.2ru3ViqQUC/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.A15TgHtWVw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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 18:51:15 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 18:51:15 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 18:51:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2ru3ViqQUC/Render', 18:51:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:51:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:51:15 INFO - 'HOME': '/Users/cltbld', 18:51:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:51:15 INFO - 'LOGNAME': 'cltbld', 18:51:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:51:15 INFO - 'MOZ_NO_REMOTE': '1', 18:51:15 INFO - 'NO_EM_RESTART': '1', 18:51:15 INFO - 'PAGER': '/bin/cat', 18:51:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:51:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:51:15 INFO - 'PWD': '/builds/slave/test', 18:51:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:51:15 INFO - 'SHELL': '/bin/bash', 18:51:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.A15TgHtWVw/Listeners', 18:51:15 INFO - 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/', 18:51:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:51:15 INFO - 'USER': 'cltbld', 18:51:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:51:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:51:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:51:15 INFO - 'XPC_FLAGS': '0x0', 18:51:15 INFO - 'XPC_SERVICE_NAME': '0', 18:51:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:51:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:51:15 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 18:51:15 INFO - Cleaning up... 18:51:15 INFO - Return code: 0 18:51:15 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 18:51: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')]} 18:51:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:51:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:51: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')]} 18:51:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:51:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:51: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', '--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 0x11034e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11032b228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee0ada2d20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1102729f0>, '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 0x10ffd1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1102658c8>, '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.2ru3ViqQUC/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.A15TgHtWVw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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 18:51:15 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 18:51:15 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 18:51:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2ru3ViqQUC/Render', 18:51:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:51:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:51:15 INFO - 'HOME': '/Users/cltbld', 18:51:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:51:15 INFO - 'LOGNAME': 'cltbld', 18:51:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:51:15 INFO - 'MOZ_NO_REMOTE': '1', 18:51:15 INFO - 'NO_EM_RESTART': '1', 18:51:15 INFO - 'PAGER': '/bin/cat', 18:51:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:51:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:51:15 INFO - 'PWD': '/builds/slave/test', 18:51:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:51:15 INFO - 'SHELL': '/bin/bash', 18:51:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.A15TgHtWVw/Listeners', 18:51:15 INFO - 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/', 18:51:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:51:15 INFO - 'USER': 'cltbld', 18:51:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:51:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:51:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:51:15 INFO - 'XPC_FLAGS': '0x0', 18:51:15 INFO - 'XPC_SERVICE_NAME': '0', 18:51:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:51:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:51:15 INFO - Downloading/unpacking psutil>=0.7.1 18:51:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:51:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:51:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:51:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:51:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:51:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:51:18 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 18:51:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 18:51:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:51:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:51:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:51:18 INFO - Installing collected packages: psutil 18:51:18 INFO - Running setup.py install for psutil 18:51:18 INFO - building 'psutil._psutil_osx' extension 18:51:18 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 18:51:18 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 18:51:18 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 18:51:18 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 18:51:18 INFO - building 'psutil._psutil_posix' extension 18:51:18 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 18:51:19 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 18:51:19 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 18:51:19 INFO - ^ 18:51:19 INFO - 1 warning generated. 18:51:19 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 18:51:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:51:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:51:19 INFO - Successfully installed psutil 18:51:19 INFO - Cleaning up... 18:51:19 INFO - Return code: 0 18:51:19 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 18:51:19 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')]} 18:51:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:51:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:51:19 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')]} 18:51:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:51:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:51:19 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 0x11034e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11032b228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee0ada2d20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1102729f0>, '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 0x10ffd1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1102658c8>, '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.2ru3ViqQUC/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.A15TgHtWVw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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 18:51:19 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 18:51:19 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 18:51:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2ru3ViqQUC/Render', 18:51:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:51:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:51:19 INFO - 'HOME': '/Users/cltbld', 18:51:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:51:19 INFO - 'LOGNAME': 'cltbld', 18:51:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:51:19 INFO - 'MOZ_NO_REMOTE': '1', 18:51:19 INFO - 'NO_EM_RESTART': '1', 18:51:19 INFO - 'PAGER': '/bin/cat', 18:51:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:51:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:51:19 INFO - 'PWD': '/builds/slave/test', 18:51:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:51:19 INFO - 'SHELL': '/bin/bash', 18:51:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.A15TgHtWVw/Listeners', 18:51:19 INFO - 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/', 18:51:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:51:19 INFO - 'USER': 'cltbld', 18:51:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:51:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:51:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:51:19 INFO - 'XPC_FLAGS': '0x0', 18:51:19 INFO - 'XPC_SERVICE_NAME': '0', 18:51:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:51:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:51:19 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 18:51:19 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 18:51:19 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 18:51:19 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 18:51:19 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 18:51:19 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 18:51:19 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 18:51:21 INFO - Downloading mozsystemmonitor-0.0.tar.gz 18:51:21 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 18:51:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:51:21 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 18:51:21 INFO - Installing collected packages: mozsystemmonitor 18:51:21 INFO - Running setup.py install for mozsystemmonitor 18:51:21 INFO - Successfully installed mozsystemmonitor 18:51:21 INFO - Cleaning up... 18:51:22 INFO - Return code: 0 18:51:22 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:51:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:51:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:51:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:51:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:51:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:51:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:51:22 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 0x11034e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11032b228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee0ada2d20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1102729f0>, '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 0x10ffd1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1102658c8>, '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.2ru3ViqQUC/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.A15TgHtWVw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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 18:51:22 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 18:51:22 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 18:51:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2ru3ViqQUC/Render', 18:51:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:51:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:51:22 INFO - 'HOME': '/Users/cltbld', 18:51:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:51:22 INFO - 'LOGNAME': 'cltbld', 18:51:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:51:22 INFO - 'MOZ_NO_REMOTE': '1', 18:51:22 INFO - 'NO_EM_RESTART': '1', 18:51:22 INFO - 'PAGER': '/bin/cat', 18:51:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:51:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:51:22 INFO - 'PWD': '/builds/slave/test', 18:51:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:51:22 INFO - 'SHELL': '/bin/bash', 18:51:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.A15TgHtWVw/Listeners', 18:51:22 INFO - 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/', 18:51:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:51:22 INFO - 'USER': 'cltbld', 18:51:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:51:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:51:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:51:22 INFO - 'XPC_FLAGS': '0x0', 18:51:22 INFO - 'XPC_SERVICE_NAME': '0', 18:51:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:51:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:51:22 INFO - Downloading/unpacking blobuploader==1.2.4 18:51:22 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 18:51:22 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 18:51:22 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 18:51:22 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 18:51:22 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 18:51:22 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 18:51:24 INFO - Downloading blobuploader-1.2.4.tar.gz 18:51:24 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 18:51:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:51:24 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:51:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:51:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:51:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:51:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:51:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:51:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:51:24 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 18:51:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:51:25 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:51:25 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 18:51:25 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 18:51:25 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 18:51:25 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 18:51:25 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 18:51:25 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 18:51:25 INFO - Downloading docopt-0.6.1.tar.gz 18:51:25 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 18:51:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:51:25 INFO - Installing collected packages: blobuploader, requests, docopt 18:51:25 INFO - Running setup.py install for blobuploader 18:51:25 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:51:25 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:51:25 INFO - Running setup.py install for requests 18:51:26 INFO - Running setup.py install for docopt 18:51:26 INFO - Successfully installed blobuploader requests docopt 18:51:26 INFO - Cleaning up... 18:51:26 INFO - Return code: 0 18:51:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:51:26 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')]} 18:51:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:51:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:51:26 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')]} 18:51:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:51:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:51:26 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 0x11034e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11032b228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee0ada2d20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1102729f0>, '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 0x10ffd1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1102658c8>, '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.2ru3ViqQUC/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.A15TgHtWVw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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 18:51:26 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 18:51:26 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 18:51:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2ru3ViqQUC/Render', 18:51:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:51:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:51:26 INFO - 'HOME': '/Users/cltbld', 18:51:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:51:26 INFO - 'LOGNAME': 'cltbld', 18:51:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:51:26 INFO - 'MOZ_NO_REMOTE': '1', 18:51:26 INFO - 'NO_EM_RESTART': '1', 18:51:26 INFO - 'PAGER': '/bin/cat', 18:51:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:51:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:51:26 INFO - 'PWD': '/builds/slave/test', 18:51:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:51:26 INFO - 'SHELL': '/bin/bash', 18:51:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.A15TgHtWVw/Listeners', 18:51:26 INFO - 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/', 18:51:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:51:26 INFO - 'USER': 'cltbld', 18:51:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:51:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:51:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:51:26 INFO - 'XPC_FLAGS': '0x0', 18:51:26 INFO - 'XPC_SERVICE_NAME': '0', 18:51:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:51:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:51:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:51:27 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-9oQIi8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:51:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:51:27 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-lEE2yn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:51:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:51:27 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-u9XOn3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:51:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:51:27 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-o21q4I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:51:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:51:27 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-v8hVeo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:51:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:51:27 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-p6fWzX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:51:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:51:27 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-Idp4gw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:51:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:51:27 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-2Hzz7m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:51:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:51:27 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-uy3viL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:51:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:51:27 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-PR1dMI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:51:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:51:28 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-PEqJIr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:51:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:51:28 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-HXEQPR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:51:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:51:28 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-WCeQpy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:51:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:51:28 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-sjVOHb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:51:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:51:28 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-w1u9_z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:51:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:51:28 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-yUfENk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:51:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:51:28 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-_ZnWYu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:51:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:51:28 INFO - Running setup.py install for manifestparser 18:51:28 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:51:28 INFO - Running setup.py install for mozcrash 18:51:29 INFO - Running setup.py install for mozdebug 18:51:29 INFO - Running setup.py install for mozdevice 18:51:29 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:51:29 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:51:29 INFO - Running setup.py install for mozfile 18:51:29 INFO - Running setup.py install for mozhttpd 18:51:29 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:51:29 INFO - Running setup.py install for mozinfo 18:51:29 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:51:29 INFO - Running setup.py install for mozInstall 18:51:29 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:51:29 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:51:29 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:51:29 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:51:29 INFO - Running setup.py install for mozleak 18:51:30 INFO - Running setup.py install for mozlog 18:51:30 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:51:30 INFO - Running setup.py install for moznetwork 18:51:30 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:51:30 INFO - Running setup.py install for mozprocess 18:51:30 INFO - Running setup.py install for mozprofile 18:51:30 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:51:30 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:51:30 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:51:30 INFO - Running setup.py install for mozrunner 18:51:30 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:51:30 INFO - Running setup.py install for mozscreenshot 18:51:31 INFO - Running setup.py install for moztest 18:51:31 INFO - Running setup.py install for mozversion 18:51:31 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:51:31 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:51:31 INFO - Cleaning up... 18:51:31 INFO - Return code: 0 18:51:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:51:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:51:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:51:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:51:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:51:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:51:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:51:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x11034e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11032b228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee0ada2d20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1102729f0>, '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 0x10ffd1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1102658c8>, '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.2ru3ViqQUC/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.A15TgHtWVw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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 18:51:31 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 18:51:31 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 18:51:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2ru3ViqQUC/Render', 18:51:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:51:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:51:31 INFO - 'HOME': '/Users/cltbld', 18:51:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:51:31 INFO - 'LOGNAME': 'cltbld', 18:51:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:51:31 INFO - 'MOZ_NO_REMOTE': '1', 18:51:31 INFO - 'NO_EM_RESTART': '1', 18:51:31 INFO - 'PAGER': '/bin/cat', 18:51:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:51:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:51:31 INFO - 'PWD': '/builds/slave/test', 18:51:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:51:31 INFO - 'SHELL': '/bin/bash', 18:51:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.A15TgHtWVw/Listeners', 18:51:31 INFO - 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/', 18:51:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:51:31 INFO - 'USER': 'cltbld', 18:51:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:51:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:51:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:51:31 INFO - 'XPC_FLAGS': '0x0', 18:51:31 INFO - 'XPC_SERVICE_NAME': '0', 18:51:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:51:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:51:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:51:31 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-sox7UH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:51:31 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)) 18:51:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:51:31 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-HLMyIH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:51:31 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)) 18:51:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:51:31 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-5klhjj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:51:31 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)) 18:51:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:51:31 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-GUY0rA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:51:32 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)) 18:51:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:51:32 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-8yxBNZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:51:32 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)) 18:51:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:51:32 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-tb14IO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:51:32 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)) 18:51:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:51:32 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-SKAQyB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:51:32 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)) 18:51:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:51:32 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-Rt3Kor-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:51:32 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)) 18:51:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:51:32 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-yCW4EE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:51:32 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)) 18:51:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:51:32 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-c1w6Nl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:51:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 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)) 18:51:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:51:32 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-4phN3G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:51:32 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)) 18:51:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:51:32 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-aAZWvk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:51:32 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)) 18:51:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:51:32 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-Qs9SvP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:51:33 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)) 18:51:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:51:33 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-Yci5e_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:51:33 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)) 18:51:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:51:33 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-huRSHT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:51:33 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)) 18:51:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:51:33 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-zdUE4B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:51:33 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)) 18:51:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:51:33 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-UnRftq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:51:33 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)) 18:51:33 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)) 18:51:33 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)) 18:51:33 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)) 18:51:33 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)) 18:51:33 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)) 18:51:33 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:51:33 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 18:51:33 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 18:51:33 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 18:51:33 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 18:51:33 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 18:51:33 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 18:51:36 INFO - Downloading blessings-1.5.1.tar.gz 18:51:36 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 18:51:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:51:36 INFO - Installing collected packages: blessings 18:51:36 INFO - Running setup.py install for blessings 18:51:36 INFO - Successfully installed blessings 18:51:36 INFO - Cleaning up... 18:51:36 INFO - Return code: 0 18:51:36 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:51:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:51:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:51:36 INFO - Reading from file tmpfile_stdout 18:51:36 INFO - Current package versions: 18:51:36 INFO - blessings == 1.5.1 18:51:36 INFO - blobuploader == 1.2.4 18:51:36 INFO - docopt == 0.6.1 18:51:36 INFO - manifestparser == 1.1 18:51:36 INFO - mozInstall == 1.12 18:51:36 INFO - mozcrash == 0.16 18:51:36 INFO - mozdebug == 0.1 18:51:36 INFO - mozdevice == 0.47 18:51:36 INFO - mozfile == 1.2 18:51:36 INFO - mozhttpd == 0.7 18:51:36 INFO - mozinfo == 0.9 18:51:36 INFO - mozleak == 0.1 18:51:36 INFO - mozlog == 3.1 18:51:36 INFO - moznetwork == 0.27 18:51:36 INFO - mozprocess == 0.22 18:51:36 INFO - mozprofile == 0.27 18:51:36 INFO - mozrunner == 6.11 18:51:36 INFO - mozscreenshot == 0.1 18:51:36 INFO - mozsystemmonitor == 0.0 18:51:36 INFO - moztest == 0.7 18:51:36 INFO - mozversion == 1.4 18:51:36 INFO - psutil == 3.1.1 18:51:36 INFO - requests == 1.2.3 18:51:36 INFO - wsgiref == 0.1.2 18:51:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:51: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')]} 18:51:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:51:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:51: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')]} 18:51:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:51:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:51:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/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 0x11034e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11032b228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee0ada2d20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1102729f0>, '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 0x10ffd1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1102658c8>, '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.2ru3ViqQUC/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.A15TgHtWVw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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 18:51:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/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 18:51:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/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 18:51:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2ru3ViqQUC/Render', 18:51:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:51:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:51:36 INFO - 'HOME': '/Users/cltbld', 18:51:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:51:36 INFO - 'LOGNAME': 'cltbld', 18:51:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:51:36 INFO - 'MOZ_NO_REMOTE': '1', 18:51:36 INFO - 'NO_EM_RESTART': '1', 18:51:36 INFO - 'PAGER': '/bin/cat', 18:51:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:51:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:51:36 INFO - 'PWD': '/builds/slave/test', 18:51:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:51:36 INFO - 'SHELL': '/bin/bash', 18:51:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.A15TgHtWVw/Listeners', 18:51:36 INFO - 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/', 18:51:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:51:36 INFO - 'USER': 'cltbld', 18:51:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:51:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:51:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:51:36 INFO - 'XPC_FLAGS': '0x0', 18:51:36 INFO - 'XPC_SERVICE_NAME': '0', 18:51:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:51:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:51:36 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)) 18:51:36 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)) 18:51:36 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)) 18:51:36 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)) 18:51:36 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)) 18:51:36 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)) 18:51:36 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)) 18:51:36 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)) 18:51:36 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)) 18:51:36 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)) 18:51:36 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)) 18:51:36 INFO - Cleaning up... 18:51:36 INFO - Return code: 0 18:51:36 INFO - Running post-action listener: _resource_record_post_action 18:51:36 INFO - Running post-action listener: _start_resource_monitoring 18:51:36 INFO - Starting resource monitoring. 18:51:36 INFO - ##### 18:51:36 INFO - ##### Running install step. 18:51:36 INFO - ##### 18:51:36 INFO - Running pre-action listener: _resource_record_pre_action 18:51:36 INFO - Running main action method: install 18:51:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:51:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:51:37 INFO - Reading from file tmpfile_stdout 18:51:37 INFO - Detecting whether we're running mozinstall >=1.0... 18:51:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:51:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:51:37 INFO - Reading from file tmpfile_stdout 18:51:37 INFO - Output received: 18:51:37 INFO - Usage: mozinstall [options] installer 18:51:37 INFO - Options: 18:51:37 INFO - -h, --help show this help message and exit 18:51:37 INFO - -d DEST, --destination=DEST 18:51:37 INFO - Directory to install application into. [default: 18:51:37 INFO - "/builds/slave/test"] 18:51:37 INFO - --app=APP Application being installed. [default: firefox] 18:51:37 INFO - mkdir: /builds/slave/test/build/application 18:51:37 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'] 18:51:37 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 18:52:08 INFO - Reading from file tmpfile_stdout 18:52:08 INFO - Output received: 18:52:08 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 18:52:08 INFO - Running post-action listener: _resource_record_post_action 18:52:08 INFO - ##### 18:52:08 INFO - ##### Running run-tests step. 18:52:08 INFO - ##### 18:52:08 INFO - Running pre-action listener: _resource_record_pre_action 18:52:08 INFO - Running main action method: run_tests 18:52:08 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:52:08 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:52:08 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:52:08 INFO - 2015-11-23 18:52:08.022 screenresolution[1954:12658] starting screenresolution argv=screenresolution get 18:52:08 INFO - 2015-11-23 18:52:08.024 screenresolution[1954:12658] Display 0: 1600x1200x32@60 18:52:08 INFO - 2015-11-23 18:52:08.030 screenresolution[1955:12660] starting screenresolution argv=screenresolution list 18:52:08 INFO - Available Modes on Display 0 18:52:08 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:52:08 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:52:08 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:52:08 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:52:08 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:52:08 INFO - Intel Iris: 18:52:08 INFO - Chipset Model: Intel Iris 18:52:08 INFO - Type: GPU 18:52:08 INFO - Bus: Built-In 18:52:08 INFO - VRAM (Dynamic, Max): 1536 MB 18:52:08 INFO - Vendor: Intel (0x8086) 18:52:08 INFO - Device ID: 0x0a2e 18:52:08 INFO - Revision ID: 0x0009 18:52:08 INFO - Displays: 18:52:08 INFO - Display: 18:52:08 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:52:08 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:52:08 INFO - Display Serial Number: 1600x1200 60 18:52:08 INFO - Main Display: Yes 18:52:08 INFO - Mirror: Off 18:52:08 INFO - Online: Yes 18:52:08 INFO - Rotation: Supported 18:52:08 INFO - Return code: 0 18:52:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:52:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:52:08 INFO - Python 2.7.3 18:52:08 INFO - Return code: 0 18:52:08 INFO - grabbing minidump binary from tooltool 18:52:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:52:08 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 0x1102729f0>, '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 0x10ffd1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1102658c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:52:08 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 18:52:08 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 18:52:08 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:52:08 INFO - Return code: 0 18:52:08 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 18:52:08 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:52:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:52:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 18:52:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:52:08 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/xWPFeFVQShqXjHmHRW7FCQ/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0051', '--webServer', 'localhost'] in /builds/slave/test/build 18:52:08 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/xWPFeFVQShqXjHmHRW7FCQ/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0051 --webServer localhost 18:52:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2ru3ViqQUC/Render', 18:52:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:52:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:52:08 INFO - 'HOME': '/Users/cltbld', 18:52:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:52:08 INFO - 'LOGNAME': 'cltbld', 18:52:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:52:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 18:52:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:52:08 INFO - 'MOZ_NO_REMOTE': '1', 18:52:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:52:08 INFO - 'NO_EM_RESTART': '1', 18:52:08 INFO - 'PAGER': '/bin/cat', 18:52:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:52:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:52:08 INFO - 'PWD': '/builds/slave/test', 18:52:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:52:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:52:08 INFO - 'SHELL': '/bin/bash', 18:52:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.A15TgHtWVw/Listeners', 18:52:08 INFO - 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/', 18:52:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:52:08 INFO - 'USER': 'cltbld', 18:52:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:52:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:52:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:52:08 INFO - 'XPC_FLAGS': '0x0', 18:52:08 INFO - 'XPC_SERVICE_NAME': '0', 18:52:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:52:08 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/xWPFeFVQShqXjHmHRW7FCQ/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0051', '--webServer', 'localhost'] with output_timeout 3600 18:52:08 INFO - mozversion INFO | application_buildid: 20151123173633 18:52:08 INFO - mozversion INFO | application_changeset: eb7962bf88a8517d92c21263f3982fe95ff80eb4 18:52:08 INFO - mozversion INFO | application_display_name: Nightly 18:52:08 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:52:08 INFO - mozversion INFO | application_name: Firefox 18:52:08 INFO - mozversion INFO | application_remotingname: firefox 18:52:08 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 18:52:08 INFO - mozversion INFO | application_vendor: Mozilla 18:52:08 INFO - mozversion INFO | application_version: 45.0a1 18:52:08 INFO - mozversion INFO | platform_buildid: 20151123173633 18:52:08 INFO - mozversion INFO | platform_changeset: eb7962bf88a8517d92c21263f3982fe95ff80eb4 18:52:08 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 18:52:08 INFO - mozversion INFO | platform_version: 45.0a1 18:52:08 INFO - 2015-11-23 18:52:08,573 DEBUG : using testdate: 1448333528 18:52:08 INFO - 2015-11-23 18:52:08,573 DEBUG : actual date: 1448333528 18:52:08 INFO - 2015-11-23 18:52:08,926 INFO : starting webserver on 'localhost:49489' 18:52:08 INFO - 2015-11-23 18:52:08,927 INFO : Starting test suite t-yosemite-r7-0051.e 18:52:08 INFO - 2015-11-23 18:52:08,927 INFO : Starting test dromaeo_css 18:52:08 INFO - 2015-11-23 18:52:08,927 DEBUG : operating with platform_type : mac_ 18:52:08 INFO - 2015-11-23 18:52:08,928 INFO : Initialising browser for dromaeo_css test... 18:52:08 INFO - 2015-11-23 18:52:08,943 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/tmpPsqAAL/profile http://localhost:49489/getInfo.html 18:52:11 INFO - 2015-11-23 18:52:11,616 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 18:52:11 INFO - 2015-11-23 18:52:11,616 DEBUG : BROWSER_OUTPUT: colorDepth:24 18:52:11 INFO - 2015-11-23 18:52:11,616 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 18:52:11 INFO - 2015-11-23 18:52:11,616 DEBUG : BROWSER_OUTPUT: __metrics 18:52:12 INFO - 2015-11-23 18:52:12,299 INFO : Browser initialized. 18:52:12 INFO - 2015-11-23 18:52:12,299 INFO : Running cycle 1/1 for dromaeo_css test... 18:52:12 INFO - 2015-11-23 18:52:12,299 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/tmpPsqAAL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 18:52:24 INFO - 2015-11-23 18:52:24,326 DEBUG : BROWSER_OUTPUT: RSS: Main: 236453888 18:52:24 INFO - 2015-11-23 18:52:24,326 DEBUG : BROWSER_OUTPUT: 18:53:14 INFO - 2015-11-23 18:53:14,004 DEBUG : BROWSER_OUTPUT: 1448333594001 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] 18:55:24 INFO - 2015-11-23 18:55:24,919 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49489/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49489/tests/dromaeo/cssquery-ext.html) 18:55:26 INFO - 2015-11-23 18:55:26,085 DEBUG : BROWSER_OUTPUT: RSS: Main: 253706240 18:55:26 INFO - 2015-11-23 18:55:26,086 DEBUG : BROWSER_OUTPUT: 18:58:28 INFO - 2015-11-23 18:58:28,014 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49489/tests/dromaeo/cssquery-ext.html (next: http://localhost:49489/tests/dromaeo/cssquery-jquery.html) 18:58:28 INFO - 2015-11-23 18:58:28,605 DEBUG : BROWSER_OUTPUT: RSS: Main: 263622656 18:58:28 INFO - 2015-11-23 18:58:28,605 DEBUG : BROWSER_OUTPUT: 19:01:30 INFO - 2015-11-23 19:01:30,214 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49489/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49489/tests/dromaeo/cssquery-mootools.html) 19:01:30 INFO - 2015-11-23 19:01:30,812 DEBUG : BROWSER_OUTPUT: RSS: Main: 264372224 19:01:30 INFO - 2015-11-23 19:01:30,812 DEBUG : BROWSER_OUTPUT: 19:04:32 INFO - 2015-11-23 19:04:32,411 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49489/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49489/tests/dromaeo/cssquery-prototype.html) 19:04:33 INFO - 2015-11-23 19:04:33,001 DEBUG : BROWSER_OUTPUT: RSS: Main: 266354688 19:04:33 INFO - 2015-11-23 19:04:33,002 DEBUG : BROWSER_OUTPUT: 19:07:35 INFO - 2015-11-23 19:07:35,425 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49489/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49489/tests/dromaeo/cssquery-yui.html) 19:07:36 INFO - 2015-11-23 19:07:36,026 DEBUG : BROWSER_OUTPUT: RSS: Main: 269631488 19:07:36 INFO - 2015-11-23 19:07:36,026 DEBUG : BROWSER_OUTPUT: 19:10:38 INFO - 2015-11-23 19:10:38,570 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49489/tests/dromaeo/cssquery-yui.html (next: http://localhost:49489/tests/dromaeo/cssquery-dojo.html) 19:10:38 INFO - 2015-11-23 19:10:38,821 DEBUG : BROWSER_OUTPUT: RSS: Main: 272347136 19:10:38 INFO - 2015-11-23 19:10:38,821 DEBUG : BROWSER_OUTPUT: 19:10:38 INFO - 2015-11-23 19:10:38,821 DEBUG : BROWSER_OUTPUT: __start_tp_report 19:10:38 INFO - 2015-11-23 19:10:38,821 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 19:10:38 INFO - 2015-11-23 19:10:38,821 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 19:10:38 INFO - 2015-11-23 19:10:38,821 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 19:10:38 INFO - 2015-11-23 19:10:38,823 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3457.757956943014;3547.7161827053837;3566.5006899034156;3596.85612575497;3599.8380072896716;5891.4108589141115;5897.174395584616;5906.468417842393;5910.438508341706;5974.283086029672;5678.0978372245345;5811.924793913118;5814.534837213024;5841.948449279128;5951.137085122655;5143.871403214922;5227.921581176285;5259.447757985395;5273.077211487994;5300.549453296455;5254.474552544734;5267.86830329241;5337.733113344337;5341.973290133544;5348.545373643245;5042.924356134661;5066.442691303972;5139.640225184238;5218.269442278084;5275.182346736262;4471.374007638933;5122.359705036871;5328.333958255218;5330.466953304677;5331.626786124973;4438.889027774299;5110.901156251423;5306.734663266821;5325.041492531343;5330.546903513206;5357.4106848246665;5535.142052981794;5563.332400111972;5780.132980052984;5828.912566311508;6237.656928868911;6264.592801467936;6337.6197428154;6345.873082538324;6352.777652782177;6118.204633397674;6266.997280435108;6272.1219029335925;6293.653849038301;6301.4328710416285;5961.493273071794;6008.459238668497;6078.635281883101;6082.087686847009;6129.509639228895;5460.071787796084;5895.263092113486;6190.7523699052435;6306.1171435998995;6355.777547785898;6101;6117.766507567544;6132.141500189977;6137.9079313810325;6162.7226774795245;6093.969530152321;6200.224971878515;6275.6548389839;6276.560640755103;6370.904436433457;6279.591826531261;6287.528435367366;6307.211598550181;6310.432061114522;6318.241810982711;6154.907676384858;6156.569040167235;6291.245050593958;6320.273168585672;6339.492840572743;4007.899802504961;4975.875603109879;5006.774695138727;5027.748612569357;5048.0913435581215;4488.573585509372;4493.1013797240685;4500.639948804153;4520.570545798144;4543.54564543543;5766.654000759968;5808.535317174616;5845.473907348274;5857.7949771757785;6004.669743164168;6273.887574968338;6349.238091428966;6356.682165891687;6359.3640635936035;6368.522360822864;5935.7625694972585;5950.702464876739;5960.956832554286;5963.403659634088;5969.492593129546;5356.571474282048;5373.838784836461;5464.480874316933;5478.863028424321;5503.174523821459;5430.511253987082;6420.550561460653;6425.8714825704155;6463.9980802975615;6475.3200913903365;6233.127362169209;6310.6213627182515;6372.713227904663;6377;6393.968030160006;6307.211598550181;6313.526485513513;6376.553641245068;6378.45783108441;6391.96804015977;5119.28330033803;6231.657258850625;6276;6278.434940855345;6293.181886354744;5712.143178523254;6135.845176233341;6305.684715764285;6328.968355158195;6336.17629708135;5409.864753381197;5677.914831277617;6078.936186167314;6243.219597550306;6275.874482510233;6272.780452684134;6283.183186185766;6299.803037422875;6301;6323.1463752394675;5107.310513080686;5850.297964244148;6034.064719968412;6162.845928851814;6172.382761723792;6254.28075771274;6258.812235632939;6273.592216505913;6301.7164227608955;6333.90499142504;6167.475764559883;6188.44304012623;6196.597221180609;6208.317085120723;6211.472024877936 19:10:38 INFO - 2015-11-23 19:10:38,826 DEBUG : BROWSER_OUTPUT: |1;ext.html;541.3747122074003;575.2062154227166;588.0444278048171;591.5711109445651;593.0836857055848;41643.95890102749;42194.78902605483;42230.7888460558;42356.57643423565;42423.78788106059;45845.54154458454;46246.306305405444;46253.306200406936;46323;46375.768121159344;9755.122039016505;9870.259730520203;9908.455034973074;9912.504374781269;9968.850467242997;9802.117809397152;9861.950690246575;9862.408255504693;9907.157891579225;9911.355761875491;9783.119519243266;9855.852162217572;9864.506774661275;9880.752981175456;9891.159251463634;9797.510124493783;9840.704778856645;9854.113129818315;9899.554520046544;9939.05578969993;9738.220942324597;9783.266255030901;9860.30977831552;9890.258230632659;9897.15874150698;34736;41895.74312770622;42238.577614223774;42688.57311426877;42919.57080429187;3140.8743650253964;3411.675890790371;3472.392331342005;3503.1592417819793;3903.316919539069;29214.415711685648;29279.68241429141;30087.247818804488;30088.548671769942;30589.92935247278;2757.7242275772264;2791.8185317954267;2861.3275880168144;2913.2862448700203;2986.925326866824;471002;472595;473265;474361;475253.99999999657;56048.719756400955;59204.703976480705;60423.697881510314;74587;75004.87492687615;70331.64834175899;70572.64713676501;70613;70980.64509677418;70993.16027358951;16123;16352.018878867306;16393.508194754177;16435.424760133337;16502.2573984171;12465.626031219077;12466.314352710506;12539.122261441611;12560.874391255971;12660.430280637393;21799.564008719735;22246.887655617476;22260.666090008664;22370.76960767141;22435.43911402228;7180.425565954711;7264.491485596063;7431.777046688608;8272.37957153216;8789;897.4749771383683;980.3823591137538;1002.7688393324939;1102.399192440122;1188.2395267029108;28947.131586052452;31339;31409.11545307289;31620.209494762814;32815.34369312648;1030.9484525773682;1042.7705904700954;1073.1468482556386;1085.8045551800594;1104.3594715065242;14686;14810.481633142788;15037.398504059714;15165.924170379298;15294.770578441332;488449;490510;493029;493978;495773;59221;59377.406225937186;60060;60303.98480075978;60792.39207607956;1251.6432816647211;1334.3194970565082;1416.9574912752635;1417.0576566583313;1446.949356772529;24348.756512435357;29202.415951681272;29324.853375732986;29486;29599.556006659488;52944.470555293956;52986.73506632442;53260.66848328668;53433;53458.73270633622;457175;461600;463114;464224.67887660343;467905;31854.68145318517;31891.883784067446;32103.357932840747;32322.83838580792;32395.35209295848;46063;46167;46236;46279.76860115678;46395.76802115968;38426.61573384342;38554.80722596481;39143.41284880786;39248.2150356997;39491.40762888501;38094.23811523809;38246.617533824305;38895;38948.6105138945;39025.024374390865;37491.250174996894;38571.614283856805;38633;38826.417603735405;38846.61153388543;33164.83417582897;35696.821515892254;35828.643893160515;36076.27847442984;36104.819475902455;25212.99148034058;25327.87336063308;25393.619095713948;25831.225063248134;25942.610860836725 19:10:38 INFO - 2015-11-23 19:10:38,826 DEBUG : BROWSER_OUTPUT: |2;jquery.html;352.965810176184;361.20354618067165;361.4668364162862;362.76601591973173;363.19552191894957;16219.83780162198;16383.754243686355;19749.913754743502;21312.040958156882;21984.670229946543;20233.291834785785;20457.488562785937;20850;20900.477488062807;21044.789552104474;5715.657060576379;5721.284839395075;5865.384134665863;5872.853178670524;5881.294244690643;5539.473749993744;5655.151727240926;5708.828735137952;5731.942680573183;5792.131180322943;5391.514763671269;5441;5638.577106716992;5694.145878118295;5706.686132262724;5474.890502189974;5494.2582751328455;5564.749586268607;5584.329880414336;5615.606907516475;5464.4262352452815;5504.0643090674685;5507.697076660782;5514.117741161435;5522.530584900288;21671.891640541697;23439.88280058606;24521.50956980868;24531.14141005056;24913.252602421955;1981.3316739265713;2000.6998950157447;2053.691946208066;2070.9171633134656;2080.1887263967064;9813.01869813013;10013.49932503372;10134;11432.256903301342;14844.554663360117;1464.7363474574572;1599.3362754456887;1674.5143908266589;1760.0935518208132;1781.7683701118901;87795.3661390153;101981;103944;105345.94654053438;107822;10965.122790176927;11069.05912997388;11079.778404431867;11103.666889993314;11149.442527873574;13162.670933226746;13255.536056237985;13262.270575118268;13289.069765116348;13311.467541298432;8356.832863342699;8360.45657032291;8388.203120703523;8388.748337549883;8414.368922330726;8413.663453461793;8419.831603367898;8420.621072051772;8451;8469.491830490068;4016.3975403689096;4132.421460995463;4262.360645903077;4313.41768861206;4363.301871700576;1797.694391953371;1851.0304268733496;1851.416803706828;1852.536865783554;1853.2772218834666;860.6213266162869;889.768660148366;970.4225985538593;1015.5176291261739;1021.4484178543652;18193.271639194256;19943;20100.79899200989;21111.050002749915;21444.678329825067;811.7118422959883;908.836409446306;948.9952550237205;973.3770386952356;1051.4164638625637;11170.664880053611;11282.210245282915;11397.829032564518;11423.314601123793;11485.827712584318;735878;742689;745646;747701;774408;122654;122952;124714;126757.36621317019;130145;938.5354249646332;1095.802755504001;1101.3171833463305;1109.4064675398622;1141.891520305553;18447.815521845147;18806.965616890655;19464.513387165433;19878;19902.402927912186;49534.50465495443;49572.50427495679;50513.49486505088;51371.74314128405;52793.20810187773;67296.6635166821;68953;69529;69614.65192674207;70331;9449.19681827025;9656.37233579815;9716.9797171296;9851.408915465096;9892.653757118467;11633.883661163618;17399;19611.411657650293;19769.209231630575;20321.59356812885;15320.310586023434;15535.223238838238;15803.920980395025;15951.840481595036;16117.758233626739;15294.094122116761;15566.844331556993;15615.687686245985;15669;15695;16426.589335266715;16439.342426302814;16815.663686726442;16931.492055238363;17077.743833842254;8405.95797021011;9909.216341058678;10020.448875311928;10095.44475053879;10173.643922462677;8328.625211865601;10483.580656773644;13557.457701691821;16278.267477963756;16555.92386494874 19:10:38 INFO - 2015-11-23 19:10:38,830 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1576.6137296362401;1581.8022747156606;1685.8398452147048;1857.5541869951217;1924.4226731980407;7740.690372385112;7829.138794732575;8332.250097491225;8695.043545210021;8784.472931624106;6910.723571057164;8251.793705157374;8289.046759622644;8320.167983201676;8354.415190936637;2055.825254853339;2294.7819957104048;2334.6498025296173;2366.5148644527917;2375.2755409600063;2336.778006089419;2389.844660097097;2396.2332053742807;2398.292503711409;2402.1952645863657;1992.3026940570758;2333.6966194394704;2359.091749676378;2365.550545396369;2371.5968285391436;2008.4376374615058;2326.430024643956;2343.496148328109;2367.9763202368013;2368.135630494874;2390.008146619151;2402.699662542182;2410.301012706313;2410.529946660402;2416.2147302126878;8359.373047021438;8482.109378515228;8485.151484851527;8505.319574434092;8505.829883402359;4611.262198048296;5137.871553211162;5234.110201265756;5246.396664383607;5255.5795536357;3207.1661368044242;3427.8628854845774;3455.550778398792;3522.3131489359585;3525.471179323122;1013.6857574151962;1026.1277913773308;1056.5668076088843;1071.0467683761458;1072.3619446429361;11014.669559913216;11048.447577621168;11069.723256918642;11086.778264434746;11123.666290011313;4705.082508910729;4715.8403869407575;4718.693284936468;4778.068276686083;4795.184818580849;9608.13526782593;9621.759456013655;9632.75918102053;9637.855432168522;9687.41875487473;5155.845324640267;5172.224166374998;5184.092783762826;5190.974045129826;5244.265802787613;4687.086018226481;4703.6942598730975;4711.693739906895;4727.976360118246;4742.715437073718;3914.628110329514;3914.942965399326;3922.058705910618;3928.5678575356687;3937.4290727844873;1290.3548225887057;1293.340396397825;1293.3921057103146;1297.4096785962365;1300.6033159886326;1136.8635763708407;1336.6992426703914;1357.9592612221452;1405.7118290750373;1407.90848594841;7901.881471777928;7950.204979502004;7976.840463190703;7988.640511177011;8009.31920786728;497.7113274300897;510.7471801458302;511.575392424287;515.1422880903255;515.399559513163;6009.669468179292;6242.344553821874;6247.468965138014;6293;6304.180456540712;8557.614907329185;9473.384230025027;10108.949455252823;10116;10288.742781430374;9771.609135634637;9966.750831229132;10047.59809607622;10082.647107351208;10114.59541618327;6619.271880093186;7841.86292987525;7869.645865936047;7924.326432253208;7929.762107136795;7666.2333766625125;7702.614869256403;7787.377009839086;7796.4932279401655;7803.570803605856;8894.59974301171;8948.194662480408;8951.239144672776;8953.328500362368;8999.955000224956;9133.132352426508;9190.540472976458;9319.347645664739;9459.905400945903;9491.240700743785;6221.4089661482085;7269.781906542812;7308.744193953186;7329.377002954809;7359.153697324876;7162.713491460283;7403.5928023959195;7778.844423111619;7819.530828150329;7831.138574756887;7489.66296516669;7501.587412692136;7530.359919406693;7543.3965282778345;7647.847043059219;7263.6005019724425;7464.290892365217;7466.775996720107;7515.173330933702;7517.548947063194;6414.422701956846;7445.4415918805225;7535.54786712799;7551.546907185587;7589.354904833151;6364.204474440695;6383.489320854414;6874.896876546756;6880.2431732508385;6912.412444942035;6743.8988415172835;6898.2756810536175;6919.37725604698;6943.826404339729;6999.020137180697 19:10:38 INFO - 2015-11-23 19:10:38,831 DEBUG : BROWSER_OUTPUT: |4;prototype.html;320.9021248519201;322.65637096492236;330.18279757599936;331.74455669134767;332.8502174021691;6655.733770649168;6869.381755641991;6895.241713363092;6913.343232392927;7046.2601426850215;6588.341165883409;6770.848955677534;6786.049953006571;6830.897536536956;6842.657867106637;5009.749512524378;5018.272350509174;5034.82378116766;5049.77276022578;5070.645054846163;4900.828471003516;5042.142835717937;5046.84859454217;5047.798088076473;5081.644284900059;4659.673822832403;4979.128652485819;4990.975045124769;5005.824796132136;5009.899802003958;4977.900441991176;4982.00359928014;4983.601311895058;4985.526374994406;5032.0690672225755;4114.670826333886;4191.434156388879;4198.727082739642;4296.119295544406;4296.205202037633;6556.639384833832;6567.605943643397;6569.211694596631;6570.211574611029;6593.670316484205;5058.949410505921;5754.913676294859;5953.58324917256;5964.493018093467;5974.253218347707;7019.333163349474;7221.711131554732;7278.563286202845;7281.089863767029;7284.125904891447;4803.423589169322;4806.375171227753;4809.75951202442;4820.373351464287;4838.080764654739;7724.111727151337;7748;7748.341390981774;7766.223377662245;7768.223177682186;4772.475027746945;4852.539008794159;4880.82917097907;4903.950960490421;4908.460069392364;4065.57311482296;4294.355846622969;4410.25025745624;4694.037722266995;4835.670190697516;4520.88697782558;4752.809887604457;5931.73307201177;5947.791827286024;5949.940500595025;5996.430339117776;7354.301341372561;7376;7378.5941773202985;7407.148177959496;1416;1688.4934519644057;1718.1666891557584;1726.7237242041213;1733.6966030944534;1122.1359553144034;1131.0047357096385;1135.6933627920416;1141.9942900285612;1143.5140065472142;6876.315302750758;6891.483138764613;6892.172939247323;6897.896531552031;6903.0680858083515;6165.568410211332;7623.733169339046;7625.961870190725;7653.732119375906;7656.578888161204;6747.797566073025;6879.105716256855;6884.621345825927;6934.237233904267;7017.4035207006955;3934.429507721364;4037.273290807624;4040.696947728932;4060.4924384451942;4096.467459230281;7917.445778795429;7961.203879612109;7985.041794984639;7996.960015199887;7997.200279971957;7934.56359900211;7954.761357159179;7960.800979975547;7981.441299109007;7992.3606111510935;7745.8450830983065;7939.444238903221;7950.602469876483;7953.642086106139;7982;7669.079710434784;7672.539647621161;7683.116441609286;7691.30804218519;7712.498687585514;5784.652920824764;7265.455090868311;7502.899188227305;7541.43439242048;7542.962285188539;7922.7227047053075;7950.165232650488;7956.443048986515;7962.601869906597;7989.640466178919;3680.7239457040296;4671;4703.20045592257;4717.599004084691;4721.669483136285;7436;7579.886301705368;7594.772156835304;7631.007968963999;7631.3894888407685;7309.853802923805;7324.487285889936;7335.376492998155;7335.559866408033;7356.66894989716;7304.233055529306;7308.634568271672;7321.597312147883;7338.339549440576;7347.19180890091;6898.930665746817;7101.7159313628945;7117.964410177916;7127.251638578082;7130.643467826691;7307.342339189286;7309.744158954411;7318.743843965436;7331.890021649786;7347.302006309392;5431.864203394946;7135.928640713526;7153.391961683107;7154;7177.533460325062 19:10:38 INFO - 2015-11-23 19:10:38,833 DEBUG : BROWSER_OUTPUT: |5;yui.html;719.4999475364622;720.3480849830902;789.6288744290183;790.0479921694359;813.3574476163831;15071.397144114237;15276.694466110699;15400.998935069227;15403.69192616147;15410.229488525585;12078.818817717742;13946.88424926006;14418.927905360459;14515.274236288196;14581.781273280883;934.4907025671008;947.327397547742;961.7211008807437;968.7626531499792;972.7811242470458;947.1522986926697;955.2310390135938;961.0581630002602;965.0494263150791;970.7281961050917;992.1120597065621;1004.8794144702609;1007.3301254665638;1007.8135544924176;1010.0606436014504;823.4194892600702;830.9086000539936;986.6941248213077;992.7369247149475;1010.711947095078;733.6075199768152;741.4846681556321;744.7281742164125;746.5520687587458;750.9061367329084;15305.31126099317;15423;15506;15553.611159721098;15676;12330.5067797288;12377.133600647958;12437.93781031089;12469.688257793629;12523.56167534141;9888.159506441889;10011.549480273405;10239.334443261165;10337.37975721459;10947.34315941046;3447.1382154461385;3476.2699833035094;3478.3565040467593;3481.094915322009;3489.94765078524;78830.42339153241;79278;79495.8075628866;80226.59886700587;82282.59456648931;8679.696210632597;9368.39105458143;9393.812123757623;9415.387999779992;9729;20520.692189616868;20734;20924.372268831958;20924.686129708065;21111.894440528005;7099.858002839915;7151.53515021522;7356.521826081287;7439.2188820173105;7443.925560744432;3896.0454688601476;4037.414574886625;4044.919101617951;4057.3102572562734;4061;3153.8265395403014;3185.331080473127;3186.537951996994;3190.840457977092;3202.551642770014;597.5697497801576;608.2640005593282;613.6471528870917;615.3723202333595;622.8691974685277;408.3813023269749;529.4387948774312;541.3747122074011;573.952536620669;608.2974164839617;8289.751307460665;8788.121187881288;9281.30390220736;9368.953155234316;9407.670731524364;519.8856251624712;529.5657560800184;549.7471163264863;552.4585905812327;576.5704550110111;4040.393940908887;4128.4632997710705;4134.37984302357;4161.375793630979;4287.142571485653;80515.19484805193;80536;80664.59667701741;81192.59403702944;94450.52774736083;82787.5860620693;83609.58195209107;83657;84167.5791621038;84759;72573.637131814;72957;73557;74991.62504187445;76190.23809761832;8064.798380040546;8191.303739182236;8261.876071858807;8263.669453221804;9149.817003660022;49723.50276497189;50017.49982500274;50070.24894626511;53407.46592534025;53726.46273537371;52112.739436302574;63854.44582216659;74226.51546968923;76657.46685066378;77072;10829.837552436877;10903.945480272549;11133.665990020312;11304.886951130384;11801.881981180422;12049.457774400349;12091.879081209076;12392;12510.437030333474;13027.674308142372;11989.700257493632;11990.640280791591;12057.03543716483;12077.456514456695;12200.389980501117;11943;12085.522199822997;12125.574885022854;12128.75742485163;12227.493363860565;11588.362640054878;11662;11830.290182589073;11850.407479625812;12090.45592948337;9736;10138.341007834468;10156.44139572301;10198.184145268213;10263.538140783832;8508;9302.906970930204;9948.35335703177;10152.137068348977;10298.897011029794 19:10:38 INFO - 2015-11-23 19:10:38,833 DEBUG : BROWSER_OUTPUT: __end_tp_report 19:10:38 INFO - 2015-11-23 19:10:38,833 DEBUG : BROWSER_OUTPUT: __start_cc_report 19:10:38 INFO - 2015-11-23 19:10:38,833 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,336 19:10:38 INFO - 2015-11-23 19:10:38,833 DEBUG : BROWSER_OUTPUT: __end_cc_report 19:10:38 INFO - 2015-11-23 19:10:38,833 DEBUG : BROWSER_OUTPUT: __startTimestamp1448334638820__endTimestamp 19:10:38 INFO - 2015-11-23 19:10:38,833 DEBUG : BROWSER_OUTPUT: 19:10:38 INFO - 2015-11-23 19:10:38,833 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 19:10:38 INFO - 2015-11-23 19:10:38,833 DEBUG : BROWSER_OUTPUT: Number of tests: 6 19:10:38 INFO - 2015-11-23 19:10:38,833 DEBUG : BROWSER_OUTPUT: 19:10:38 INFO - 2015-11-23 19:10:38,833 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5788.70 Median:6078.64 stddev:662.63 (10.9%) stddev-sans-first:638.94 19:10:38 INFO - 2015-11-23 19:10:38,835 DEBUG : BROWSER_OUTPUT: Values: 3457.8 3547.7 3566.5 3596.9 3599.8 5891.4 5897.2 5906.5 5910.4 5974.3 5678.1 5811.9 5814.5 5841.9 5951.1 5143.9 5227.9 5259.4 5273.1 5300.5 5254.5 5267.9 5337.7 5342.0 5348.5 5042.9 5066.4 5139.6 5218.3 5275.2 4471.4 5122.4 5328.3 5330.5 5331.6 4438.9 5110.9 5306.7 5325.0 5330.5 5357.4 5535.1 5563.3 5780.1 5828.9 6237.7 6264.6 6337.6 6345.9 6352.8 6118.2 6267.0 6272.1 6293.7 6301.4 5961.5 6008.5 6078.6 6082.1 6129.5 5460.1 5895.3 6190.8 6306.1 6355.8 6101.0 6117.8 6132.1 6137.9 6162.7 6094.0 6200.2 6275.7 6276.6 6370.9 6279.6 6287.5 6307.2 6310.4 6318.2 6154.9 6156.6 6291.2 6320.3 6339.5 4007.9 4975.9 5006.8 5027.7 5048.1 4488.6 4493.1 4500.6 4520.6 4543.5 5766.7 5808.5 5845.5 5857.8 6004.7 6273.9 6349.2 6356.7 6359.4 6368.5 5935.8 5950.7 5961.0 5963.4 5969.5 5356.6 5373.8 5464.5 5478.9 5503.2 5430.5 6420.6 6425.9 6464.0 6475.3 6233.1 6310.6 6372.7 6377.0 6394.0 6307.2 6313.5 6376.6 6378.5 6392.0 5119.3 6231.7 6276.0 6278.4 6293.2 5712.1 6135.8 6305.7 6329.0 6336.2 5409.9 5677.9 6078.9 6243.2 6275.9 6272.8 6283.2 6299.8 6301.0 6323.1 5107.3 5850.3 6034.1 6162.8 6172.4 6254.3 6258.8 6273.6 6301.7 6333.9 6167.5 6188.4 6196.6 6208.3 6211.5 19:10:38 INFO - 2015-11-23 19:10:38,835 DEBUG : BROWSER_OUTPUT: 19:10:38 INFO - 2015-11-23 19:10:38,835 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:63474.32 Median:42045.27 stddev:126276.52 (300.3%) stddev-sans-first:126542.36 19:10:38 INFO - 2015-11-23 19:10:38,836 DEBUG : BROWSER_OUTPUT: Values: 541.4 575.2 588.0 591.6 593.1 41644.0 42194.8 42230.8 42356.6 42423.8 45845.5 46246.3 46253.3 46323.0 46375.8 9755.1 9870.3 9908.5 9912.5 9968.9 9802.1 9862.0 9862.4 9907.2 9911.4 9783.1 9855.9 9864.5 9880.8 9891.2 9797.5 9840.7 9854.1 9899.6 9939.1 9738.2 9783.3 9860.3 9890.3 9897.2 34736.0 41895.7 42238.6 42688.6 42919.6 3140.9 3411.7 3472.4 3503.2 3903.3 29214.4 29279.7 30087.2 30088.5 30589.9 2757.7 2791.8 2861.3 2913.3 2986.9 471002.0 472595.0 473265.0 474361.0 475254.0 56048.7 59204.7 60423.7 74587.0 75004.9 70331.6 70572.6 70613.0 70980.6 70993.2 16123.0 16352.0 16393.5 16435.4 16502.3 12465.6 12466.3 12539.1 12560.9 12660.4 21799.6 22246.9 22260.7 22370.8 22435.4 7180.4 7264.5 7431.8 8272.4 8789.0 897.5 980.4 1002.8 1102.4 1188.2 28947.1 31339.0 31409.1 31620.2 32815.3 1030.9 1042.8 1073.1 1085.8 1104.4 14686.0 14810.5 15037.4 15165.9 15294.8 488449.0 490510.0 493029.0 493978.0 495773.0 59221.0 59377.4 60060.0 60304.0 60792.4 1251.6 1334.3 1417.0 1417.1 1446.9 24348.8 29202.4 29324.9 29486.0 29599.6 52944.5 52986.7 53260.7 53433.0 53458.7 457175.0 461600.0 463114.0 464224.7 467905.0 31854.7 31891.9 32103.4 32322.8 32395.4 46063.0 46167.0 46236.0 46279.8 46395.8 38426.6 38554.8 39143.4 39248.2 39491.4 38094.2 38246.6 38895.0 38948.6 39025.0 37491.3 38571.6 38633.0 38826.4 38846.6 33164.8 35696.8 35828.6 36076.3 36104.8 25213.0 25327.9 25393.6 25831.2 25942.6 19:10:38 INFO - 2015-11-23 19:10:38,836 DEBUG : BROWSER_OUTPUT: 19:10:38 INFO - 2015-11-23 19:10:38,836 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:38953.07 Median:20875.24 stddev:123369.93 (591.0%) stddev-sans-first:123681.97 19:10:38 INFO - 2015-11-23 19:10:38,838 DEBUG : BROWSER_OUTPUT: Values: 353.0 361.2 361.5 362.8 363.2 16219.8 16383.8 19749.9 21312.0 21984.7 20233.3 20457.5 20850.0 20900.5 21044.8 5715.7 5721.3 5865.4 5872.9 5881.3 5539.5 5655.2 5708.8 5731.9 5792.1 5391.5 5441.0 5638.6 5694.1 5706.7 5474.9 5494.3 5564.7 5584.3 5615.6 5464.4 5504.1 5507.7 5514.1 5522.5 21671.9 23439.9 24521.5 24531.1 24913.3 1981.3 2000.7 2053.7 2070.9 2080.2 9813.0 10013.5 10134.0 11432.3 14844.6 1464.7 1599.3 1674.5 1760.1 1781.8 87795.4 101981.0 103944.0 105345.9 107822.0 10965.1 11069.1 11079.8 11103.7 11149.4 13162.7 13255.5 13262.3 13289.1 13311.5 8356.8 8360.5 8388.2 8388.7 8414.4 8413.7 8419.8 8420.6 8451.0 8469.5 4016.4 4132.4 4262.4 4313.4 4363.3 1797.7 1851.0 1851.4 1852.5 1853.3 860.6 889.8 970.4 1015.5 1021.4 18193.3 19943.0 20100.8 21111.1 21444.7 811.7 908.8 949.0 973.4 1051.4 11170.7 11282.2 11397.8 11423.3 11485.8 735878.0 742689.0 745646.0 747701.0 774408.0 122654.0 122952.0 124714.0 126757.4 130145.0 938.5 1095.8 1101.3 1109.4 1141.9 18447.8 18807.0 19464.5 19878.0 19902.4 49534.5 49572.5 50513.5 51371.7 52793.2 67296.7 68953.0 69529.0 69614.7 70331.0 9449.2 9656.4 9717.0 9851.4 9892.7 11633.9 17399.0 19611.4 19769.2 20321.6 15320.3 15535.2 15803.9 15951.8 16117.8 15294.1 15566.8 15615.7 15669.0 15695.0 16426.6 16439.3 16815.7 16931.5 17077.7 8406.0 9909.2 10020.4 10095.4 10173.6 8328.6 10483.6 13557.5 16278.3 16555.9 19:10:38 INFO - 2015-11-23 19:10:38,838 DEBUG : BROWSER_OUTPUT: 19:10:38 INFO - 2015-11-23 19:10:38,838 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5784.55 Median:5632.62 stddev:3012.13 (53.5%) stddev-sans-first:3003.98 19:10:38 INFO - 2015-11-23 19:10:38,839 DEBUG : BROWSER_OUTPUT: Values: 1576.6 1581.8 1685.8 1857.6 1924.4 7740.7 7829.1 8332.3 8695.0 8784.5 6910.7 8251.8 8289.0 8320.2 8354.4 2055.8 2294.8 2334.6 2366.5 2375.3 2336.8 2389.8 2396.2 2398.3 2402.2 1992.3 2333.7 2359.1 2365.6 2371.6 2008.4 2326.4 2343.5 2368.0 2368.1 2390.0 2402.7 2410.3 2410.5 2416.2 8359.4 8482.1 8485.2 8505.3 8505.8 4611.3 5137.9 5234.1 5246.4 5255.6 3207.2 3427.9 3455.6 3522.3 3525.5 1013.7 1026.1 1056.6 1071.0 1072.4 11014.7 11048.4 11069.7 11086.8 11123.7 4705.1 4715.8 4718.7 4778.1 4795.2 9608.1 9621.8 9632.8 9637.9 9687.4 5155.8 5172.2 5184.1 5191.0 5244.3 4687.1 4703.7 4711.7 4728.0 4742.7 3914.6 3914.9 3922.1 3928.6 3937.4 1290.4 1293.3 1293.4 1297.4 1300.6 1136.9 1336.7 1358.0 1405.7 1407.9 7901.9 7950.2 7976.8 7988.6 8009.3 497.7 510.7 511.6 515.1 515.4 6009.7 6242.3 6247.5 6293.0 6304.2 8557.6 9473.4 10108.9 10116.0 10288.7 9771.6 9966.8 10047.6 10082.6 10114.6 6619.3 7841.9 7869.6 7924.3 7929.8 7666.2 7702.6 7787.4 7796.5 7803.6 8894.6 8948.2 8951.2 8953.3 9000.0 9133.1 9190.5 9319.3 9459.9 9491.2 6221.4 7269.8 7308.7 7329.4 7359.2 7162.7 7403.6 7778.8 7819.5 7831.1 7489.7 7501.6 7530.4 7543.4 7647.8 7263.6 7464.3 7466.8 7515.2 7517.5 6414.4 7445.4 7535.5 7551.5 7589.4 6364.2 6383.5 6874.9 6880.2 6912.4 6743.9 6898.3 6919.4 6943.8 6999.0 19:10:38 INFO - 2015-11-23 19:10:38,840 DEBUG : BROWSER_OUTPUT: 19:10:38 INFO - 2015-11-23 19:10:38,840 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5961.83 Median:6856.02 stddev:1947.00 (28.4%) stddev-sans-first:1905.87 19:10:38 INFO - 2015-11-23 19:10:38,840 DEBUG : BROWSER_OUTPUT: Values: 320.9 322.7 330.2 331.7 332.9 6655.7 6869.4 6895.2 6913.3 7046.3 6588.3 6770.8 6786.0 6830.9 6842.7 5009.7 5018.3 5034.8 5049.8 5070.6 4900.8 5042.1 5046.8 5047.8 5081.6 4659.7 4979.1 4991.0 5005.8 5009.9 4977.9 4982.0 4983.6 4985.5 5032.1 4114.7 4191.4 4198.7 4296.1 4296.2 6556.6 6567.6 6569.2 6570.2 6593.7 5058.9 5754.9 5953.6 5964.5 5974.3 7019.3 7221.7 7278.6 7281.1 7284.1 4803.4 4806.4 4809.8 4820.4 4838.1 7724.1 7748.0 7748.3 7766.2 7768.2 4772.5 4852.5 4880.8 4904.0 4908.5 4065.6 4294.4 4410.3 4694.0 4835.7 4520.9 4752.8 5931.7 5947.8 5949.9 5996.4 7354.3 7376.0 7378.6 7407.1 1416.0 1688.5 1718.2 1726.7 1733.7 1122.1 1131.0 1135.7 1142.0 1143.5 6876.3 6891.5 6892.2 6897.9 6903.1 6165.6 7623.7 7626.0 7653.7 7656.6 6747.8 6879.1 6884.6 6934.2 7017.4 3934.4 4037.3 4040.7 4060.5 4096.5 7917.4 7961.2 7985.0 7997.0 7997.2 7934.6 7954.8 7960.8 7981.4 7992.4 7745.8 7939.4 7950.6 7953.6 7982.0 7669.1 7672.5 7683.1 7691.3 7712.5 5784.7 7265.5 7502.9 7541.4 7543.0 7922.7 7950.2 7956.4 7962.6 7989.6 3680.7 4671.0 4703.2 4717.6 4721.7 7436.0 7579.9 7594.8 7631.0 7631.4 7309.9 7324.5 7335.4 7335.6 7356.7 7304.2 7308.6 7321.6 7338.3 7347.2 6898.9 7101.7 7118.0 7127.3 7130.6 7307.3 7309.7 7318.7 7331.9 7347.3 5431.9 7135.9 7153.4 7154.0 7177.5 19:10:38 INFO - 2015-11-23 19:10:38,840 DEBUG : BROWSER_OUTPUT: 19:10:38 INFO - 2015-11-23 19:10:38,840 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:18472.59 Median:26321.09 stddev:25739.43 (97.8%) stddev-sans-first:25777.12 19:10:38 INFO - 2015-11-23 19:10:38,841 DEBUG : BROWSER_OUTPUT: Values: 719.5 720.3 789.6 790.0 813.4 15071.4 15276.7 15401.0 15403.7 15410.2 12078.8 13946.9 14418.9 14515.3 14581.8 934.5 947.3 961.7 968.8 972.8 947.2 955.2 961.1 965.0 970.7 992.1 1004.9 1007.3 1007.8 1010.1 823.4 830.9 986.7 992.7 1010.7 733.6 741.5 744.7 746.6 750.9 15305.3 15423.0 15506.0 15553.6 15676.0 12330.5 12377.1 12437.9 12469.7 12523.6 9888.2 10011.5 10239.3 10337.4 10947.3 3447.1 3476.3 3478.4 3481.1 3489.9 78830.4 79278.0 79495.8 80226.6 82282.6 8679.7 9368.4 9393.8 9415.4 9729.0 20520.7 20734.0 20924.4 20924.7 21111.9 7099.9 7151.5 7356.5 7439.2 7443.9 3896.0 4037.4 4044.9 4057.3 4061.0 3153.8 3185.3 3186.5 3190.8 3202.6 597.6 608.3 613.6 615.4 622.9 408.4 529.4 541.4 574.0 608.3 8289.8 8788.1 9281.3 9369.0 9407.7 519.9 529.6 549.7 552.5 576.6 4040.4 4128.5 4134.4 4161.4 4287.1 80515.2 80536.0 80664.6 81192.6 94450.5 82787.6 83609.6 83657.0 84167.6 84759.0 72573.6 72957.0 73557.0 74991.6 76190.2 8064.8 8191.3 8261.9 8263.7 9149.8 49723.5 50017.5 50070.2 53407.5 53726.5 52112.7 63854.4 74226.5 76657.5 77072.0 10829.8 10903.9 11133.7 11304.9 11801.9 12049.5 12091.9 12392.0 12510.4 13027.7 11989.7 11990.6 12057.0 12077.5 12200.4 11943.0 12085.5 12125.6 12128.8 12227.5 11588.4 11662.0 11830.3 11850.4 12090.5 9736.0 10138.3 10156.4 10198.2 10263.5 8508.0 9302.9 9948.4 10152.1 10298.9 19:10:38 INFO - 2015-11-23 19:10:38,841 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 19:10:38 INFO - 2015-11-23 19:10:38,841 DEBUG : BROWSER_OUTPUT: 19:10:39 INFO - 2015-11-23 19:10:39,231 INFO : Browser exited with error code: 0 19:10:39 INFO - 2015-11-23 19:10:39,256 INFO : Completed test dromaeo_css (00:18:30) 19:10:39 INFO - 2015-11-23 19:10:39,256 INFO : Starting test kraken 19:10:39 INFO - 2015-11-23 19:10:39,256 DEBUG : operating with platform_type : mac_ 19:10:39 INFO - 2015-11-23 19:10:39,256 INFO : Initialising browser for kraken test... 19:10:39 INFO - 2015-11-23 19:10:39,268 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/tmprjU_m5/profile http://localhost:49489/getInfo.html 19:10:41 INFO - 2015-11-23 19:10:41,845 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 19:10:41 INFO - 2015-11-23 19:10:41,845 DEBUG : BROWSER_OUTPUT: colorDepth:24 19:10:41 INFO - 2015-11-23 19:10:41,845 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 19:10:41 INFO - 2015-11-23 19:10:41,846 DEBUG : BROWSER_OUTPUT: __metrics 19:10:42 INFO - 2015-11-23 19:10:42,443 INFO : Browser initialized. 19:10:42 INFO - 2015-11-23 19:10:42,443 INFO : Running cycle 1/1 for kraken test... 19:10:42 INFO - 2015-11-23 19:10:42,444 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/tmprjU_m5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 19:10:54 INFO - 2015-11-23 19:10:54,302 DEBUG : BROWSER_OUTPUT: RSS: Main: 237113344 19:10:54 INFO - 2015-11-23 19:10:54,303 DEBUG : BROWSER_OUTPUT: 19:10:57 INFO - 2015-11-23 19:10:57,268 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49489/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49489/tests/kraken/driver.html?testName=audio-beat-detection) 19:10:57 INFO - 2015-11-23 19:10:57,891 DEBUG : BROWSER_OUTPUT: RSS: Main: 250630144 19:10:57 INFO - 2015-11-23 19:10:57,891 DEBUG : BROWSER_OUTPUT: 19:11:00 INFO - 2015-11-23 19:11:00,540 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49489/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49489/tests/kraken/driver.html?testName=audio-dft) 19:11:01 INFO - 2015-11-23 19:11:01,142 DEBUG : BROWSER_OUTPUT: RSS: Main: 259612672 19:11:01 INFO - 2015-11-23 19:11:01,143 DEBUG : BROWSER_OUTPUT: 19:11:04 INFO - 2015-11-23 19:11:04,731 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49489/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49489/tests/kraken/driver.html?testName=audio-fft) 19:11:05 INFO - 2015-11-23 19:11:05,314 DEBUG : BROWSER_OUTPUT: RSS: Main: 262008832 19:11:05 INFO - 2015-11-23 19:11:05,314 DEBUG : BROWSER_OUTPUT: 19:11:07 INFO - 2015-11-23 19:11:07,162 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49489/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49489/tests/kraken/driver.html?testName=audio-oscillator) 19:11:07 INFO - 2015-11-23 19:11:07,771 DEBUG : BROWSER_OUTPUT: RSS: Main: 263290880 19:11:07 INFO - 2015-11-23 19:11:07,771 DEBUG : BROWSER_OUTPUT: 19:11:09 INFO - 2015-11-23 19:11:09,789 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49489/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49489/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:11:10 INFO - 2015-11-23 19:11:10,376 DEBUG : BROWSER_OUTPUT: RSS: Main: 265240576 19:11:10 INFO - 2015-11-23 19:11:10,376 DEBUG : BROWSER_OUTPUT: 19:11:13 INFO - 2015-11-23 19:11:13,190 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49489/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49489/tests/kraken/driver.html?testName=imaging-darkroom) 19:11:13 INFO - 2015-11-23 19:11:13,784 DEBUG : BROWSER_OUTPUT: RSS: Main: 263532544 19:11:13 INFO - 2015-11-23 19:11:13,784 DEBUG : BROWSER_OUTPUT: 19:11:16 INFO - 2015-11-23 19:11:16,508 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49489/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49489/tests/kraken/driver.html?testName=imaging-desaturate) 19:11:17 INFO - 2015-11-23 19:11:17,112 DEBUG : BROWSER_OUTPUT: RSS: Main: 263233536 19:11:17 INFO - 2015-11-23 19:11:17,112 DEBUG : BROWSER_OUTPUT: 19:11:20 INFO - 2015-11-23 19:11:20,041 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49489/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49489/tests/kraken/driver.html?testName=json-parse-financial) 19:11:20 INFO - 2015-11-23 19:11:20,648 DEBUG : BROWSER_OUTPUT: RSS: Main: 263991296 19:11:20 INFO - 2015-11-23 19:11:20,649 DEBUG : BROWSER_OUTPUT: 19:11:22 INFO - 2015-11-23 19:11:22,160 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49489/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49489/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:11:22 INFO - 2015-11-23 19:11:22,745 DEBUG : BROWSER_OUTPUT: RSS: Main: 264876032 19:11:22 INFO - 2015-11-23 19:11:22,745 DEBUG : BROWSER_OUTPUT: 19:11:24 INFO - 2015-11-23 19:11:24,705 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49489/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49489/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:11:25 INFO - 2015-11-23 19:11:25,330 DEBUG : BROWSER_OUTPUT: RSS: Main: 263421952 19:11:25 INFO - 2015-11-23 19:11:25,330 DEBUG : BROWSER_OUTPUT: 19:11:27 INFO - 2015-11-23 19:11:27,489 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49489/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49489/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:11:28 INFO - 2015-11-23 19:11:28,095 DEBUG : BROWSER_OUTPUT: RSS: Main: 265396224 19:11:28 INFO - 2015-11-23 19:11:28,095 DEBUG : BROWSER_OUTPUT: 19:11:30 INFO - 2015-11-23 19:11:30,677 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49489/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49489/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:11:31 INFO - 2015-11-23 19:11:31,276 DEBUG : BROWSER_OUTPUT: RSS: Main: 264769536 19:11:31 INFO - 2015-11-23 19:11:31,276 DEBUG : BROWSER_OUTPUT: 19:11:33 INFO - 2015-11-23 19:11:33,764 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49489/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49489/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:11:34 INFO - 2015-11-23 19:11:34,358 DEBUG : BROWSER_OUTPUT: RSS: Main: 265453568 19:11:34 INFO - 2015-11-23 19:11:34,359 DEBUG : BROWSER_OUTPUT: 19:11:36 INFO - 2015-11-23 19:11:36,118 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49489/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49489/tests/kraken/driver.html?testName=ai-astar) 19:11:36 INFO - 2015-11-23 19:11:36,360 DEBUG : BROWSER_OUTPUT: RSS: Main: 266153984 19:11:36 INFO - 2015-11-23 19:11:36,360 DEBUG : BROWSER_OUTPUT: 19:11:36 INFO - 2015-11-23 19:11:36,361 DEBUG : BROWSER_OUTPUT: __start_tp_report 19:11:36 INFO - 2015-11-23 19:11:36,362 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 19:11:36 INFO - 2015-11-23 19:11:36,362 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 19:11:36 INFO - 2015-11-23 19:11:36,362 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 19:11:36 INFO - 2015-11-23 19:11:36,362 DEBUG : BROWSER_OUTPUT: |0;ai-astar;115;107;153;167;120;132;164;131;114;115 19:11:36 INFO - 2015-11-23 19:11:36,362 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;145;124;153;182;146;143;127;190;145;123 19:11:36 INFO - 2015-11-23 19:11:36,362 DEBUG : BROWSER_OUTPUT: |2;audio-dft;191;196;202;205;246;284;239;231;284;242 19:11:36 INFO - 2015-11-23 19:11:36,362 DEBUG : BROWSER_OUTPUT: |3;audio-fft;63;63;70;106;58;58;64;52;123;49 19:11:36 INFO - 2015-11-23 19:11:36,362 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;78;76;107;77;76;79;133;103;89;105 19:11:36 INFO - 2015-11-23 19:11:36,362 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;91;92;76;134;131;88;89;89;88;107 19:11:36 INFO - 2015-11-23 19:11:36,362 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;95;96;95;95;95;97;96;96;95;96 19:11:36 INFO - 2015-11-23 19:11:36,362 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;92;97;103;142;135;118;95;92;93;87 19:11:36 INFO - 2015-11-23 19:11:36,362 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;58;60;57;59;62;58;59;66;59;59 19:11:36 INFO - 2015-11-23 19:11:36,363 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;87;83;81;58;57;61;100;103;100 19:11:36 INFO - 2015-11-23 19:11:36,363 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;77;77;111;110;110;85;87;86;84;90 19:11:36 INFO - 2015-11-23 19:11:36,363 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;123;138;133;126;121;134;127;137;132;133 19:11:36 INFO - 2015-11-23 19:11:36,363 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;137;142;137;140;135;131;181;174;139;136 19:11:36 INFO - 2015-11-23 19:11:36,363 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;67;67;66;64;64;70;89;94;96;91 19:11:36 INFO - 2015-11-23 19:11:36,363 DEBUG : BROWSER_OUTPUT: __end_tp_report 19:11:36 INFO - 2015-11-23 19:11:36,363 DEBUG : BROWSER_OUTPUT: __start_cc_report 19:11:36 INFO - 2015-11-23 19:11:36,363 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,833 19:11:36 INFO - 2015-11-23 19:11:36,363 DEBUG : BROWSER_OUTPUT: __end_cc_report 19:11:36 INFO - 2015-11-23 19:11:36,363 DEBUG : BROWSER_OUTPUT: __startTimestamp1448334696360__endTimestamp 19:11:36 INFO - 2015-11-23 19:11:36,363 DEBUG : BROWSER_OUTPUT: 19:11:36 INFO - 2015-11-23 19:11:36,365 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 19:11:36 INFO - 2015-11-23 19:11:36,366 DEBUG : BROWSER_OUTPUT: Number of tests: 14 19:11:36 INFO - 2015-11-23 19:11:36,366 DEBUG : BROWSER_OUTPUT: 19:11:36 INFO - 2015-11-23 19:11:36,366 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:131.80 Median:131.50 stddev:22.01 (16.7%) stddev-sans-first:22.49 19:11:36 INFO - 2015-11-23 19:11:36,366 DEBUG : BROWSER_OUTPUT: Values: 115.0 107.0 153.0 167.0 120.0 132.0 164.0 131.0 114.0 115.0 19:11:36 INFO - 2015-11-23 19:11:36,366 DEBUG : BROWSER_OUTPUT: 19:11:36 INFO - 2015-11-23 19:11:36,366 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:147.80 Median:145.50 stddev:22.69 (15.6%) stddev-sans-first:24.04 19:11:36 INFO - 2015-11-23 19:11:36,366 DEBUG : BROWSER_OUTPUT: Values: 145.0 124.0 153.0 182.0 146.0 143.0 127.0 190.0 145.0 123.0 19:11:36 INFO - 2015-11-23 19:11:36,366 DEBUG : BROWSER_OUTPUT: 19:11:36 INFO - 2015-11-23 19:11:36,366 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:232.00 Median:240.50 stddev:33.93 (14.1%) stddev-sans-first:32.58 19:11:36 INFO - 2015-11-23 19:11:36,366 DEBUG : BROWSER_OUTPUT: Values: 191.0 196.0 202.0 205.0 246.0 284.0 239.0 231.0 284.0 242.0 19:11:36 INFO - 2015-11-23 19:11:36,367 DEBUG : BROWSER_OUTPUT: 19:11:36 INFO - 2015-11-23 19:11:36,367 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:70.60 Median:60.50 stddev:24.24 (40.1%) stddev-sans-first:25.55 19:11:36 INFO - 2015-11-23 19:11:36,367 DEBUG : BROWSER_OUTPUT: Values: 63.0 63.0 70.0 106.0 58.0 58.0 64.0 52.0 123.0 49.0 19:11:36 INFO - 2015-11-23 19:11:36,367 DEBUG : BROWSER_OUTPUT: 19:11:36 INFO - 2015-11-23 19:11:36,367 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:92.30 Median:76.50 stddev:19.17 (25.1%) stddev-sans-first:19.62 19:11:36 INFO - 2015-11-23 19:11:36,367 DEBUG : BROWSER_OUTPUT: Values: 78.0 76.0 107.0 77.0 76.0 79.0 133.0 103.0 89.0 105.0 19:11:36 INFO - 2015-11-23 19:11:36,367 DEBUG : BROWSER_OUTPUT: 19:11:36 INFO - 2015-11-23 19:11:36,367 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:98.50 Median:88.50 stddev:19.42 (21.9%) stddev-sans-first:20.41 19:11:36 INFO - 2015-11-23 19:11:36,367 DEBUG : BROWSER_OUTPUT: Values: 91.0 92.0 76.0 134.0 131.0 88.0 89.0 89.0 88.0 107.0 19:11:36 INFO - 2015-11-23 19:11:36,367 DEBUG : BROWSER_OUTPUT: 19:11:36 INFO - 2015-11-23 19:11:36,367 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:95.60 Median:96.00 stddev:0.70 (0.7%) stddev-sans-first:0.71 19:11:36 INFO - 2015-11-23 19:11:36,368 DEBUG : BROWSER_OUTPUT: Values: 95.0 96.0 95.0 95.0 95.0 97.0 96.0 96.0 95.0 96.0 19:11:36 INFO - 2015-11-23 19:11:36,368 DEBUG : BROWSER_OUTPUT: 19:11:36 INFO - 2015-11-23 19:11:36,369 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:105.40 Median:92.00 stddev:19.47 (21.2%) stddev-sans-first:20.03 19:11:36 INFO - 2015-11-23 19:11:36,369 DEBUG : BROWSER_OUTPUT: Values: 92.0 97.0 103.0 142.0 135.0 118.0 95.0 92.0 93.0 87.0 19:11:36 INFO - 2015-11-23 19:11:36,369 DEBUG : BROWSER_OUTPUT: 19:11:36 INFO - 2015-11-23 19:11:36,369 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:59.70 Median:59.00 stddev:2.58 (4.4%) stddev-sans-first:2.67 19:11:36 INFO - 2015-11-23 19:11:36,369 DEBUG : BROWSER_OUTPUT: Values: 58.0 60.0 57.0 59.0 62.0 58.0 59.0 66.0 59.0 59.0 19:11:36 INFO - 2015-11-23 19:11:36,369 DEBUG : BROWSER_OUTPUT: 19:11:36 INFO - 2015-11-23 19:11:36,369 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:79.80 Median:64.50 stddev:17.97 (27.9%) stddev-sans-first:18.54 19:11:36 INFO - 2015-11-23 19:11:36,369 DEBUG : BROWSER_OUTPUT: Values: 68.0 87.0 83.0 81.0 58.0 57.0 61.0 100.0 103.0 100.0 19:11:36 INFO - 2015-11-23 19:11:36,369 DEBUG : BROWSER_OUTPUT: 19:11:36 INFO - 2015-11-23 19:11:36,370 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:91.70 Median:84.50 stddev:13.48 (16.0%) stddev-sans-first:13.21 19:11:36 INFO - 2015-11-23 19:11:36,370 DEBUG : BROWSER_OUTPUT: Values: 77.0 77.0 111.0 110.0 110.0 85.0 87.0 86.0 84.0 90.0 19:11:36 INFO - 2015-11-23 19:11:36,370 DEBUG : BROWSER_OUTPUT: 19:11:36 INFO - 2015-11-23 19:11:36,370 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:130.40 Median:133.00 stddev:5.82 (4.4%) stddev-sans-first:5.52 19:11:36 INFO - 2015-11-23 19:11:36,370 DEBUG : BROWSER_OUTPUT: Values: 123.0 138.0 133.0 126.0 121.0 134.0 127.0 137.0 132.0 133.0 19:11:36 INFO - 2015-11-23 19:11:36,370 DEBUG : BROWSER_OUTPUT: 19:11:36 INFO - 2015-11-23 19:11:36,370 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.20 Median:139.50 stddev:17.36 (12.4%) stddev-sans-first:18.16 19:11:36 INFO - 2015-11-23 19:11:36,370 DEBUG : BROWSER_OUTPUT: Values: 137.0 142.0 137.0 140.0 135.0 131.0 181.0 174.0 139.0 136.0 19:11:36 INFO - 2015-11-23 19:11:36,370 DEBUG : BROWSER_OUTPUT: 19:11:36 INFO - 2015-11-23 19:11:36,370 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:76.80 Median:79.50 stddev:13.73 (17.3%) stddev-sans-first:14.10 19:11:36 INFO - 2015-11-23 19:11:36,370 DEBUG : BROWSER_OUTPUT: Values: 67.0 67.0 66.0 64.0 64.0 70.0 89.0 94.0 96.0 91.0 19:11:36 INFO - 2015-11-23 19:11:36,370 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 19:11:36 INFO - 2015-11-23 19:11:36,370 DEBUG : BROWSER_OUTPUT: 19:11:37 INFO - 2015-11-23 19:11:37,012 INFO : Browser exited with error code: 0 19:11:37 INFO - 2015-11-23 19:11:37,059 INFO : Completed test kraken (00:00:57) 19:11:37 INFO - 2015-11-23 19:11:37,059 INFO : Starting test v8_7 19:11:37 INFO - 2015-11-23 19:11:37,059 DEBUG : operating with platform_type : mac_ 19:11:37 INFO - 2015-11-23 19:11:37,059 INFO : Initialising browser for v8_7 test... 19:11:37 INFO - 2015-11-23 19:11:37,074 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/tmpE9GknA/profile http://localhost:49489/getInfo.html 19:11:39 INFO - 2015-11-23 19:11:39,768 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 19:11:39 INFO - 2015-11-23 19:11:39,768 DEBUG : BROWSER_OUTPUT: colorDepth:24 19:11:39 INFO - 2015-11-23 19:11:39,768 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 19:11:39 INFO - 2015-11-23 19:11:39,768 DEBUG : BROWSER_OUTPUT: __metrics 19:11:40 INFO - 2015-11-23 19:11:40,403 INFO : Browser initialized. 19:11:40 INFO - 2015-11-23 19:11:40,403 INFO : Running cycle 1/1 for v8_7 test... 19:11:40 INFO - 2015-11-23 19:11:40,403 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/tmpE9GknA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 19:11:52 INFO - 2015-11-23 19:11:52,439 DEBUG : BROWSER_OUTPUT: RSS: Main: 238178304 19:11:52 INFO - 2015-11-23 19:11:52,439 DEBUG : BROWSER_OUTPUT: 19:12:13 INFO - 2015-11-23 19:12:13,928 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49489/tests/v8_7/run.html (next: http://localhost:49489/tests/v8_7/run.html) 19:12:14 INFO - 2015-11-23 19:12:14,175 DEBUG : BROWSER_OUTPUT: RSS: Main: 249778176 19:12:14 INFO - 2015-11-23 19:12:14,175 DEBUG : BROWSER_OUTPUT: 19:12:14 INFO - 2015-11-23 19:12:14,175 DEBUG : BROWSER_OUTPUT: __start_tp_report 19:12:14 INFO - 2015-11-23 19:12:14,175 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 19:12:14 INFO - 2015-11-23 19:12:14,175 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 19:12:14 INFO - 2015-11-23 19:12:14,175 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 19:12:14 INFO - 2015-11-23 19:12:14,175 DEBUG : BROWSER_OUTPUT: |0;Richards;178.25311942959001 19:12:14 INFO - 2015-11-23 19:12:14,176 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;157.0598397989634 19:12:14 INFO - 2015-11-23 19:12:14,176 DEBUG : BROWSER_OUTPUT: |2;Encrypt;282.0078962210942 19:12:14 INFO - 2015-11-23 19:12:14,176 DEBUG : BROWSER_OUTPUT: |3;Decrypt;4794.258373205742 19:12:14 INFO - 2015-11-23 19:12:14,176 DEBUG : BROWSER_OUTPUT: |4;RayTrace;936.3295880149813 19:12:14 INFO - 2015-11-23 19:12:14,176 DEBUG : BROWSER_OUTPUT: |5;Earley;740.1924500370096 19:12:14 INFO - 2015-11-23 19:12:14,176 DEBUG : BROWSER_OUTPUT: |6;Boyer;13328.947368421053 19:12:14 INFO - 2015-11-23 19:12:14,176 DEBUG : BROWSER_OUTPUT: |7;RegExp;29852.941176470587 19:12:14 INFO - 2015-11-23 19:12:14,176 DEBUG : BROWSER_OUTPUT: |8;Splay;686.8131868131868 19:12:14 INFO - 2015-11-23 19:12:14,176 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4524.886877828054 19:12:14 INFO - 2015-11-23 19:12:14,176 DEBUG : BROWSER_OUTPUT: __end_tp_report 19:12:14 INFO - 2015-11-23 19:12:14,176 DEBUG : BROWSER_OUTPUT: __startTimestamp1448334734174__endTimestamp 19:12:14 INFO - 2015-11-23 19:12:14,176 DEBUG : BROWSER_OUTPUT: 19:12:14 INFO - 2015-11-23 19:12:14,178 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 19:12:14 INFO - 2015-11-23 19:12:14,178 DEBUG : BROWSER_OUTPUT: Number of tests: 10 19:12:14 INFO - 2015-11-23 19:12:14,178 DEBUG : BROWSER_OUTPUT: 19:12:14 INFO - 2015-11-23 19:12:14,178 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:178.25 Median:178.25 stddev:0.00 (0.0%) 19:12:14 INFO - 2015-11-23 19:12:14,178 DEBUG : BROWSER_OUTPUT: Values: 178.3 19:12:14 INFO - 2015-11-23 19:12:14,179 DEBUG : BROWSER_OUTPUT: 19:12:14 INFO - 2015-11-23 19:12:14,179 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:157.06 Median:157.06 stddev:0.00 (0.0%) 19:12:14 INFO - 2015-11-23 19:12:14,179 DEBUG : BROWSER_OUTPUT: Values: 157.1 19:12:14 INFO - 2015-11-23 19:12:14,179 DEBUG : BROWSER_OUTPUT: 19:12:14 INFO - 2015-11-23 19:12:14,179 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:282.01 Median:282.01 stddev:0.00 (0.0%) 19:12:14 INFO - 2015-11-23 19:12:14,179 DEBUG : BROWSER_OUTPUT: Values: 282.0 19:12:14 INFO - 2015-11-23 19:12:14,179 DEBUG : BROWSER_OUTPUT: 19:12:14 INFO - 2015-11-23 19:12:14,179 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:4794.26 Median:4794.26 stddev:0.00 (0.0%) 19:12:14 INFO - 2015-11-23 19:12:14,179 DEBUG : BROWSER_OUTPUT: Values: 4794.3 19:12:14 INFO - 2015-11-23 19:12:14,179 DEBUG : BROWSER_OUTPUT: 19:12:14 INFO - 2015-11-23 19:12:14,179 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:936.33 Median:936.33 stddev:0.00 (0.0%) 19:12:14 INFO - 2015-11-23 19:12:14,179 DEBUG : BROWSER_OUTPUT: Values: 936.3 19:12:14 INFO - 2015-11-23 19:12:14,179 DEBUG : BROWSER_OUTPUT: 19:12:14 INFO - 2015-11-23 19:12:14,180 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:740.19 Median:740.19 stddev:0.00 (0.0%) 19:12:14 INFO - 2015-11-23 19:12:14,180 DEBUG : BROWSER_OUTPUT: Values: 740.2 19:12:14 INFO - 2015-11-23 19:12:14,180 DEBUG : BROWSER_OUTPUT: 19:12:14 INFO - 2015-11-23 19:12:14,180 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:13328.95 Median:13328.95 stddev:0.00 (0.0%) 19:12:14 INFO - 2015-11-23 19:12:14,180 DEBUG : BROWSER_OUTPUT: Values: 13328.9 19:12:14 INFO - 2015-11-23 19:12:14,180 DEBUG : BROWSER_OUTPUT: 19:12:14 INFO - 2015-11-23 19:12:14,180 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:29852.94 Median:29852.94 stddev:0.00 (0.0%) 19:12:14 INFO - 2015-11-23 19:12:14,180 DEBUG : BROWSER_OUTPUT: Values: 29852.9 19:12:14 INFO - 2015-11-23 19:12:14,180 DEBUG : BROWSER_OUTPUT: 19:12:14 INFO - 2015-11-23 19:12:14,180 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:686.81 Median:686.81 stddev:0.00 (0.0%) 19:12:14 INFO - 2015-11-23 19:12:14,180 DEBUG : BROWSER_OUTPUT: Values: 686.8 19:12:14 INFO - 2015-11-23 19:12:14,180 DEBUG : BROWSER_OUTPUT: 19:12:14 INFO - 2015-11-23 19:12:14,180 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4524.89 Median:4524.89 stddev:0.00 (0.0%) 19:12:14 INFO - 2015-11-23 19:12:14,181 DEBUG : BROWSER_OUTPUT: Values: 4524.9 19:12:14 INFO - 2015-11-23 19:12:14,181 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 19:12:14 INFO - 2015-11-23 19:12:14,181 DEBUG : BROWSER_OUTPUT: 19:12:14 INFO - 2015-11-23 19:12:14,801 INFO : Browser exited with error code: 0 19:12:14 INFO - 2015-11-23 19:12:14,819 INFO : Completed test v8_7 (00:00:37) 19:12:15 INFO - 2015-11-23 19:12:15,177 INFO : Completed test suite (00:20:06) 19:12:15 INFO - 2015-11-23 19:12:15,178 DEBUG : Working with test: dromaeo_css 19:12:15 INFO - 2015-11-23 19:12:15,178 DEBUG : Generating results file: dromaeo_css 19:12:15 INFO - 2015-11-23 19:12:15,179 DEBUG : Working with test: kraken 19:12:15 INFO - 2015-11-23 19:12:15,179 DEBUG : Generating results file: kraken 19:12:15 INFO - 2015-11-23 19:12:15,179 INFO : javascript benchmark 19:12:15 INFO - 2015-11-23 19:12:15,179 DEBUG : Working with test: v8_7 19:12:15 INFO - 2015-11-23 19:12:15,179 DEBUG : Generating results file: v8_7 19:12:15 INFO - 2015-11-23 19:12:15,179 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:12:15 INFO - 2015-11-23 19:12:15,224 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,61]] 19:12:15 INFO - 2015-11-23 19:12:15,224 DEBUG : process_Request line: dromaeo_css 7650.58 graph.html#tests=[[72,64,61]] 19:12:15 INFO - 2015-11-23 19:12:15,224 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:12:15 INFO - 2015-11-23 19:12:15,323 DEBUG : process_Request line: kraken 1557.60 graph.html#tests=[[232,64,61]] 19:12:15 INFO - 2015-11-23 19:12:15,323 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:12:15 INFO - 2015-11-23 19:12:15,345 DEBUG : process_Request line: v8_7 21310.41 graph.html#tests=[[230,64,61]] 19:12:15 INFO - 2015-11-23 19:12:15,346 INFO : javascript benchmark 19:12:15 INFO - 2015-11-23 19:12:15,348 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3457.757956943014, 3547.7161827053837, 3566.5006899034156, 3596.85612575497, 3599.8380072896716, 5891.4108589141115, 5897.174395584616, 5906.468417842393, 5910.438508341706, 5974.283086029672, 5678.0978372245345, 5811.924793913118, 5814.534837213024, 5841.948449279128, 5951.137085122655, 5143.871403214922, 5227.921581176285, 5259.447757985395, 5273.077211487994, 5300.549453296455, 5254.474552544734, 5267.86830329241, 5337.733113344337, 5341.973290133544, 5348.545373643245, 5042.924356134661, 5066.442691303972, 5139.640225184238, 5218.269442278084, 5275.182346736262, 4471.374007638933, 5122.359705036871, 5328.333958255218, 5330.466953304677, 5331.626786124973, 4438.889027774299, 5110.901156251423, 5306.734663266821, 5325.041492531343, 5330.546903513206, 5357.4106848246665, 5535.142052981794, 5563.332400111972, 5780.132980052984, 5828.912566311508, 6237.656928868911, 6264.592801467936, 6337.6197428154, 6345.873082538324, 6352.777652782177, 6118.204633397674, 6266.997280435108, 6272.1219029335925, 6293.653849038301, 6301.4328710416285, 5961.493273071794, 6008.459238668497, 6078.635281883101, 6082.087686847009, 6129.509639228895, 5460.071787796084, 5895.263092113486, 6190.7523699052435, 6306.1171435998995, 6355.777547785898, 6101.0, 6117.766507567544, 6132.141500189977, 6137.9079313810325, 6162.7226774795245, 6093.969530152321, 6200.224971878515, 6275.6548389839, 6276.560640755103, 6370.904436433457, 6279.591826531261, 6287.528435367366, 6307.211598550181, 6310.432061114522, 6318.241810982711, 6154.907676384858, 6156.569040167235, 6291.245050593958, 6320.273168585672, 6339.492840572743, 4007.899802504961, 4975.875603109879, 5006.774695138727, 5027.748612569357, 5048.0913435581215, 4488.573585509372, 4493.1013797240685, 4500.639948804153, 4520.570545798144, 4543.54564543543, 5766.654000759968, 5808.535317174616, 5845.473907348274, 5857.7949771757785, 6004.669743164168, 6273.887574968338, 6349.238091428966, 6356.682165891687, 6359.3640635936035, 6368.522360822864, 5935.7625694972585, 5950.702464876739, 5960.956832554286, 5963.403659634088, 5969.492593129546, 5356.571474282048, 5373.838784836461, 5464.480874316933, 5478.863028424321, 5503.174523821459, 5430.511253987082, 6420.550561460653, 6425.8714825704155, 6463.9980802975615, 6475.3200913903365, 6233.127362169209, 6310.6213627182515, 6372.713227904663, 6377.0, 6393.968030160006, 6307.211598550181, 6313.526485513513, 6376.553641245068, 6378.45783108441, 6391.96804015977, 5119.28330033803, 6231.657258850625, 6276.0, 6278.434940855345, 6293.181886354744, 5712.143178523254, 6135.845176233341, 6305.684715764285, 6328.968355158195, 6336.17629708135, 5409.864753381197, 5677.914831277617, 6078.936186167314, 6243.219597550306, 6275.874482510233, 6272.780452684134, 6283.183186185766, 6299.803037422875, 6301.0, 6323.1463752394675, 5107.310513080686, 5850.297964244148, 6034.064719968412, 6162.845928851814, 6172.382761723792, 6254.28075771274, 6258.812235632939, 6273.592216505913, 6301.7164227608955, 6333.90499142504, 6167.475764559883, 6188.44304012623, 6196.597221180609, 6208.317085120723, 6211.472024877936], "unit": "ms", "name": "dojo.html", "value": 5748.766492506725}, {"lowerIsBetter": false, "replicates": [541.3747122074003, 575.2062154227166, 588.0444278048171, 591.5711109445651, 593.0836857055848, 41643.95890102749, 42194.78902605483, 42230.7888460558, 42356.57643423565, 42423.78788106059, 45845.54154458454, 46246.306305405444, 46253.306200406936, 46323.0, 46375.768121159344, 9755.122039016505, 9870.259730520203, 9908.455034973074, 9912.504374781269, 9968.850467242997, 9802.117809397152, 9861.950690246575, 9862.408255504693, 9907.157891579225, 9911.355761875491, 9783.119519243266, 9855.852162217572, 9864.506774661275, 9880.752981175456, 9891.159251463634, 9797.510124493783, 9840.704778856645, 9854.113129818315, 9899.554520046544, 9939.05578969993, 9738.220942324597, 9783.266255030901, 9860.30977831552, 9890.258230632659, 9897.15874150698, 34736.0, 41895.74312770622, 42238.577614223774, 42688.57311426877, 42919.57080429187, 3140.8743650253964, 3411.675890790371, 3472.392331342005, 3503.1592417819793, 3903.316919539069, 29214.415711685648, 29279.68241429141, 30087.247818804488, 30088.548671769942, 30589.92935247278, 2757.7242275772264, 2791.8185317954267, 2861.3275880168144, 2913.2862448700203, 2986.925326866824, 471002.0, 472595.0, 473265.0, 474361.0, 475253.99999999657, 56048.719756400955, 59204.703976480705, 60423.697881510314, 74587.0, 75004.87492687615, 70331.64834175899, 70572.64713676501, 70613.0, 70980.64509677418, 70993.16027358951, 16123.0, 16352.018878867306, 16393.508194754177, 16435.424760133337, 16502.2573984171, 12465.626031219077, 12466.314352710506, 12539.122261441611, 12560.874391255971, 12660.430280637393, 21799.564008719735, 22246.887655617476, 22260.666090008664, 22370.76960767141, 22435.43911402228, 7180.425565954711, 7264.491485596063, 7431.777046688608, 8272.37957153216, 8789.0, 897.4749771383683, 980.3823591137538, 1002.7688393324939, 1102.399192440122, 1188.2395267029108, 28947.131586052452, 31339.0, 31409.11545307289, 31620.209494762814, 32815.34369312648, 1030.9484525773682, 1042.7705904700954, 1073.1468482556386, 1085.8045551800594, 1104.3594715065242, 14686.0, 14810.481633142788, 15037.398504059714, 15165.924170379298, 15294.770578441332, 488449.0, 490510.0, 493029.0, 493978.0, 495773.0, 59221.0, 59377.406225937186, 60060.0, 60303.98480075978, 60792.39207607956, 1251.6432816647211, 1334.3194970565082, 1416.9574912752635, 1417.0576566583313, 1446.949356772529, 24348.756512435357, 29202.415951681272, 29324.853375732986, 29486.0, 29599.556006659488, 52944.470555293956, 52986.73506632442, 53260.66848328668, 53433.0, 53458.73270633622, 457175.0, 461600.0, 463114.0, 464224.67887660343, 467905.0, 31854.68145318517, 31891.883784067446, 32103.357932840747, 32322.83838580792, 32395.35209295848, 46063.0, 46167.0, 46236.0, 46279.76860115678, 46395.76802115968, 38426.61573384342, 38554.80722596481, 39143.41284880786, 39248.2150356997, 39491.40762888501, 38094.23811523809, 38246.617533824305, 38895.0, 38948.6105138945, 39025.024374390865, 37491.250174996894, 38571.614283856805, 38633.0, 38826.417603735405, 38846.61153388543, 33164.83417582897, 35696.821515892254, 35828.643893160515, 36076.27847442984, 36104.819475902455, 25212.99148034058, 25327.87336063308, 25393.619095713948, 25831.225063248134, 25942.610860836725], "unit": "ms", "name": "ext.html", "value": 20278.864663151824}, {"lowerIsBetter": false, "replicates": [352.965810176184, 361.20354618067165, 361.4668364162862, 362.76601591973173, 363.19552191894957, 16219.83780162198, 16383.754243686355, 19749.913754743502, 21312.040958156882, 21984.670229946543, 20233.291834785785, 20457.488562785937, 20850.0, 20900.477488062807, 21044.789552104474, 5715.657060576379, 5721.284839395075, 5865.384134665863, 5872.853178670524, 5881.294244690643, 5539.473749993744, 5655.151727240926, 5708.828735137952, 5731.942680573183, 5792.131180322943, 5391.514763671269, 5441.0, 5638.577106716992, 5694.145878118295, 5706.686132262724, 5474.890502189974, 5494.2582751328455, 5564.749586268607, 5584.329880414336, 5615.606907516475, 5464.4262352452815, 5504.0643090674685, 5507.697076660782, 5514.117741161435, 5522.530584900288, 21671.891640541697, 23439.88280058606, 24521.50956980868, 24531.14141005056, 24913.252602421955, 1981.3316739265713, 2000.6998950157447, 2053.691946208066, 2070.9171633134656, 2080.1887263967064, 9813.01869813013, 10013.49932503372, 10134.0, 11432.256903301342, 14844.554663360117, 1464.7363474574572, 1599.3362754456887, 1674.5143908266589, 1760.0935518208132, 1781.7683701118901, 87795.3661390153, 101981.0, 103944.0, 105345.94654053438, 107822.0, 10965.122790176927, 11069.05912997388, 11079.778404431867, 11103.666889993314, 11149.442527873574, 13162.670933226746, 13255.536056237985, 13262.270575118268, 13289.069765116348, 13311.467541298432, 8356.832863342699, 8360.45657032291, 8388.203120703523, 8388.748337549883, 8414.368922330726, 8413.663453461793, 8419.831603367898, 8420.621072051772, 8451.0, 8469.491830490068, 4016.3975403689096, 4132.421460995463, 4262.360645903077, 4313.41768861206, 4363.301871700576, 1797.694391953371, 1851.0304268733496, 1851.416803706828, 1852.536865783554, 1853.2772218834666, 860.6213266162869, 889.768660148366, 970.4225985538593, 1015.5176291261739, 1021.4484178543652, 18193.271639194256, 19943.0, 20100.79899200989, 21111.050002749915, 21444.678329825067, 811.7118422959883, 908.836409446306, 948.9952550237205, 973.3770386952356, 1051.4164638625637, 11170.664880053611, 11282.210245282915, 11397.829032564518, 11423.314601123793, 11485.827712584318, 735878.0, 742689.0, 745646.0, 747701.0, 774408.0, 122654.0, 122952.0, 124714.0, 126757.36621317019, 130145.0, 938.5354249646332, 1095.802755504001, 1101.3171833463305, 1109.4064675398622, 1141.891520305553, 18447.815521845147, 18806.965616890655, 19464.513387165433, 19878.0, 19902.402927912186, 49534.50465495443, 49572.50427495679, 50513.49486505088, 51371.74314128405, 52793.20810187773, 67296.6635166821, 68953.0, 69529.0, 69614.65192674207, 70331.0, 9449.19681827025, 9656.37233579815, 9716.9797171296, 9851.408915465096, 9892.653757118467, 11633.883661163618, 17399.0, 19611.411657650293, 19769.209231630575, 20321.59356812885, 15320.310586023434, 15535.223238838238, 15803.920980395025, 15951.840481595036, 16117.758233626739, 15294.094122116761, 15566.844331556993, 15615.687686245985, 15669.0, 15695.0, 16426.589335266715, 16439.342426302814, 16815.663686726442, 16931.492055238363, 17077.743833842254, 8405.95797021011, 9909.216341058678, 10020.448875311928, 10095.44475053879, 10173.643922462677, 8328.625211865601, 10483.580656773644, 13557.457701691821, 16278.267477963756, 16555.92386494874], "unit": "ms", "name": "jquery.html", "value": 9920.153469505933}, {"lowerIsBetter": false, "replicates": [1576.6137296362401, 1581.8022747156606, 1685.8398452147048, 1857.5541869951217, 1924.4226731980407, 7740.690372385112, 7829.138794732575, 8332.250097491225, 8695.043545210021, 8784.472931624106, 6910.723571057164, 8251.793705157374, 8289.046759622644, 8320.167983201676, 8354.415190936637, 2055.825254853339, 2294.7819957104048, 2334.6498025296173, 2366.5148644527917, 2375.2755409600063, 2336.778006089419, 2389.844660097097, 2396.2332053742807, 2398.292503711409, 2402.1952645863657, 1992.3026940570758, 2333.6966194394704, 2359.091749676378, 2365.550545396369, 2371.5968285391436, 2008.4376374615058, 2326.430024643956, 2343.496148328109, 2367.9763202368013, 2368.135630494874, 2390.008146619151, 2402.699662542182, 2410.301012706313, 2410.529946660402, 2416.2147302126878, 8359.373047021438, 8482.109378515228, 8485.151484851527, 8505.319574434092, 8505.829883402359, 4611.262198048296, 5137.871553211162, 5234.110201265756, 5246.396664383607, 5255.5795536357, 3207.1661368044242, 3427.8628854845774, 3455.550778398792, 3522.3131489359585, 3525.471179323122, 1013.6857574151962, 1026.1277913773308, 1056.5668076088843, 1071.0467683761458, 1072.3619446429361, 11014.669559913216, 11048.447577621168, 11069.723256918642, 11086.778264434746, 11123.666290011313, 4705.082508910729, 4715.8403869407575, 4718.693284936468, 4778.068276686083, 4795.184818580849, 9608.13526782593, 9621.759456013655, 9632.75918102053, 9637.855432168522, 9687.41875487473, 5155.845324640267, 5172.224166374998, 5184.092783762826, 5190.974045129826, 5244.265802787613, 4687.086018226481, 4703.6942598730975, 4711.693739906895, 4727.976360118246, 4742.715437073718, 3914.628110329514, 3914.942965399326, 3922.058705910618, 3928.5678575356687, 3937.4290727844873, 1290.3548225887057, 1293.340396397825, 1293.3921057103146, 1297.4096785962365, 1300.6033159886326, 1136.8635763708407, 1336.6992426703914, 1357.9592612221452, 1405.7118290750373, 1407.90848594841, 7901.881471777928, 7950.204979502004, 7976.840463190703, 7988.640511177011, 8009.31920786728, 497.7113274300897, 510.7471801458302, 511.575392424287, 515.1422880903255, 515.399559513163, 6009.669468179292, 6242.344553821874, 6247.468965138014, 6293.0, 6304.180456540712, 8557.614907329185, 9473.384230025027, 10108.949455252823, 10116.0, 10288.742781430374, 9771.609135634637, 9966.750831229132, 10047.59809607622, 10082.647107351208, 10114.59541618327, 6619.271880093186, 7841.86292987525, 7869.645865936047, 7924.326432253208, 7929.762107136795, 7666.2333766625125, 7702.614869256403, 7787.377009839086, 7796.4932279401655, 7803.570803605856, 8894.59974301171, 8948.194662480408, 8951.239144672776, 8953.328500362368, 8999.955000224956, 9133.132352426508, 9190.540472976458, 9319.347645664739, 9459.905400945903, 9491.240700743785, 6221.4089661482085, 7269.781906542812, 7308.744193953186, 7329.377002954809, 7359.153697324876, 7162.713491460283, 7403.5928023959195, 7778.844423111619, 7819.530828150329, 7831.138574756887, 7489.66296516669, 7501.587412692136, 7530.359919406693, 7543.3965282778345, 7647.847043059219, 7263.6005019724425, 7464.290892365217, 7466.775996720107, 7515.173330933702, 7517.548947063194, 6414.422701956846, 7445.4415918805225, 7535.54786712799, 7551.546907185587, 7589.354904833151, 6364.204474440695, 6383.489320854414, 6874.896876546756, 6880.2431732508385, 6912.412444942035, 6743.8988415172835, 6898.2756810536175, 6919.37725604698, 6943.826404339729, 6999.020137180697], "unit": "ms", "name": "mootools.html", "value": 4671.405253063584}, {"lowerIsBetter": false, "replicates": [320.9021248519201, 322.65637096492236, 330.18279757599936, 331.74455669134767, 332.8502174021691, 6655.733770649168, 6869.381755641991, 6895.241713363092, 6913.343232392927, 7046.2601426850215, 6588.341165883409, 6770.848955677534, 6786.049953006571, 6830.897536536956, 6842.657867106637, 5009.749512524378, 5018.272350509174, 5034.82378116766, 5049.77276022578, 5070.645054846163, 4900.828471003516, 5042.142835717937, 5046.84859454217, 5047.798088076473, 5081.644284900059, 4659.673822832403, 4979.128652485819, 4990.975045124769, 5005.824796132136, 5009.899802003958, 4977.900441991176, 4982.00359928014, 4983.601311895058, 4985.526374994406, 5032.0690672225755, 4114.670826333886, 4191.434156388879, 4198.727082739642, 4296.119295544406, 4296.205202037633, 6556.639384833832, 6567.605943643397, 6569.211694596631, 6570.211574611029, 6593.670316484205, 5058.949410505921, 5754.913676294859, 5953.58324917256, 5964.493018093467, 5974.253218347707, 7019.333163349474, 7221.711131554732, 7278.563286202845, 7281.089863767029, 7284.125904891447, 4803.423589169322, 4806.375171227753, 4809.75951202442, 4820.373351464287, 4838.080764654739, 7724.111727151337, 7748.0, 7748.341390981774, 7766.223377662245, 7768.223177682186, 4772.475027746945, 4852.539008794159, 4880.82917097907, 4903.950960490421, 4908.460069392364, 4065.57311482296, 4294.355846622969, 4410.25025745624, 4694.037722266995, 4835.670190697516, 4520.88697782558, 4752.809887604457, 5931.73307201177, 5947.791827286024, 5949.940500595025, 5996.430339117776, 7354.301341372561, 7376.0, 7378.5941773202985, 7407.148177959496, 1416.0, 1688.4934519644057, 1718.1666891557584, 1726.7237242041213, 1733.6966030944534, 1122.1359553144034, 1131.0047357096385, 1135.6933627920416, 1141.9942900285612, 1143.5140065472142, 6876.315302750758, 6891.483138764613, 6892.172939247323, 6897.896531552031, 6903.0680858083515, 6165.568410211332, 7623.733169339046, 7625.961870190725, 7653.732119375906, 7656.578888161204, 6747.797566073025, 6879.105716256855, 6884.621345825927, 6934.237233904267, 7017.4035207006955, 3934.429507721364, 4037.273290807624, 4040.696947728932, 4060.4924384451942, 4096.467459230281, 7917.445778795429, 7961.203879612109, 7985.041794984639, 7996.960015199887, 7997.200279971957, 7934.56359900211, 7954.761357159179, 7960.800979975547, 7981.441299109007, 7992.3606111510935, 7745.8450830983065, 7939.444238903221, 7950.602469876483, 7953.642086106139, 7982.0, 7669.079710434784, 7672.539647621161, 7683.116441609286, 7691.30804218519, 7712.498687585514, 5784.652920824764, 7265.455090868311, 7502.899188227305, 7541.43439242048, 7542.962285188539, 7922.7227047053075, 7950.165232650488, 7956.443048986515, 7962.601869906597, 7989.640466178919, 3680.7239457040296, 4671.0, 4703.20045592257, 4717.599004084691, 4721.669483136285, 7436.0, 7579.886301705368, 7594.772156835304, 7631.007968963999, 7631.3894888407685, 7309.853802923805, 7324.487285889936, 7335.376492998155, 7335.559866408033, 7356.66894989716, 7304.233055529306, 7308.634568271672, 7321.597312147883, 7338.339549440576, 7347.19180890091, 6898.930665746817, 7101.7159313628945, 7117.964410177916, 7127.251638578082, 7130.643467826691, 7307.342339189286, 7309.744158954411, 7318.743843965436, 7331.890021649786, 7347.302006309392, 5431.864203394946, 7135.928640713526, 7153.391961683107, 7154.0, 7177.533460325062], "unit": "ms", "name": "prototype.html", "value": 5310.801988486772}, {"lowerIsBetter": false, "replicates": [719.4999475364622, 720.3480849830902, 789.6288744290183, 790.0479921694359, 813.3574476163831, 15071.397144114237, 15276.694466110699, 15400.998935069227, 15403.69192616147, 15410.229488525585, 12078.818817717742, 13946.88424926006, 14418.927905360459, 14515.274236288196, 14581.781273280883, 934.4907025671008, 947.327397547742, 961.7211008807437, 968.7626531499792, 972.7811242470458, 947.1522986926697, 955.2310390135938, 961.0581630002602, 965.0494263150791, 970.7281961050917, 992.1120597065621, 1004.8794144702609, 1007.3301254665638, 1007.8135544924176, 1010.0606436014504, 823.4194892600702, 830.9086000539936, 986.6941248213077, 992.7369247149475, 1010.711947095078, 733.6075199768152, 741.4846681556321, 744.7281742164125, 746.5520687587458, 750.9061367329084, 15305.31126099317, 15423.0, 15506.0, 15553.611159721098, 15676.0, 12330.5067797288, 12377.133600647958, 12437.93781031089, 12469.688257793629, 12523.56167534141, 9888.159506441889, 10011.549480273405, 10239.334443261165, 10337.37975721459, 10947.34315941046, 3447.1382154461385, 3476.2699833035094, 3478.3565040467593, 3481.094915322009, 3489.94765078524, 78830.42339153241, 79278.0, 79495.8075628866, 80226.59886700587, 82282.59456648931, 8679.696210632597, 9368.39105458143, 9393.812123757623, 9415.387999779992, 9729.0, 20520.692189616868, 20734.0, 20924.372268831958, 20924.686129708065, 21111.894440528005, 7099.858002839915, 7151.53515021522, 7356.521826081287, 7439.2188820173105, 7443.925560744432, 3896.0454688601476, 4037.414574886625, 4044.919101617951, 4057.3102572562734, 4061.0, 3153.8265395403014, 3185.331080473127, 3186.537951996994, 3190.840457977092, 3202.551642770014, 597.5697497801576, 608.2640005593282, 613.6471528870917, 615.3723202333595, 622.8691974685277, 408.3813023269749, 529.4387948774312, 541.3747122074011, 573.952536620669, 608.2974164839617, 8289.751307460665, 8788.121187881288, 9281.30390220736, 9368.953155234316, 9407.670731524364, 519.8856251624712, 529.5657560800184, 549.7471163264863, 552.4585905812327, 576.5704550110111, 4040.393940908887, 4128.4632997710705, 4134.37984302357, 4161.375793630979, 4287.142571485653, 80515.19484805193, 80536.0, 80664.59667701741, 81192.59403702944, 94450.52774736083, 82787.5860620693, 83609.58195209107, 83657.0, 84167.5791621038, 84759.0, 72573.637131814, 72957.0, 73557.0, 74991.62504187445, 76190.23809761832, 8064.798380040546, 8191.303739182236, 8261.876071858807, 8263.669453221804, 9149.817003660022, 49723.50276497189, 50017.49982500274, 50070.24894626511, 53407.46592534025, 53726.46273537371, 52112.739436302574, 63854.44582216659, 74226.51546968923, 76657.46685066378, 77072.0, 10829.837552436877, 10903.945480272549, 11133.665990020312, 11304.886951130384, 11801.881981180422, 12049.457774400349, 12091.879081209076, 12392.0, 12510.437030333474, 13027.674308142372, 11989.700257493632, 11990.640280791591, 12057.03543716483, 12077.456514456695, 12200.389980501117, 11943.0, 12085.522199822997, 12125.574885022854, 12128.75742485163, 12227.493363860565, 11588.362640054878, 11662.0, 11830.290182589073, 11850.407479625812, 12090.45592948337, 9736.0, 10138.341007834468, 10156.44139572301, 10198.184145268213, 10263.538140783832, 8508.0, 9302.906970930204, 9948.35335703177, 10152.137068348977, 10298.897011029794], "unit": "ms", "name": "yui.html", "value": 6988.509562271258}], "name": "dromaeo_css", "value": 7650.579330515201}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [115.0, 107.0, 153.0, 167.0, 120.0, 132.0, 164.0, 131.0, 114.0, 115.0], "unit": "ms", "name": "ai-astar", "value": 131.8}, {"lowerIsBetter": true, "replicates": [145.0, 124.0, 153.0, 182.0, 146.0, 143.0, 127.0, 190.0, 145.0, 123.0], "unit": "ms", "name": "audio-beat-detection", "value": 147.8}, {"lowerIsBetter": true, "replicates": [191.0, 196.0, 202.0, 205.0, 246.0, 284.0, 239.0, 231.0, 284.0, 242.0], "unit": "ms", "name": "audio-dft", "value": 232.0}, {"lowerIsBetter": true, "replicates": [63.0, 63.0, 70.0, 106.0, 58.0, 58.0, 64.0, 52.0, 123.0, 49.0], "unit": "ms", "name": "audio-fft", "value": 70.6}, {"lowerIsBetter": true, "replicates": [78.0, 76.0, 107.0, 77.0, 76.0, 79.0, 133.0, 103.0, 89.0, 105.0], "unit": "ms", "name": "audio-oscillator", "value": 92.3}, {"lowerIsBetter": true, "replicates": [91.0, 92.0, 76.0, 134.0, 131.0, 88.0, 89.0, 89.0, 88.0, 107.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 98.5}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 95.0, 95.0, 95.0, 97.0, 96.0, 96.0, 95.0, 96.0], "unit": "ms", "name": "imaging-darkroom", "value": 95.6}, {"lowerIsBetter": true, "replicates": [92.0, 97.0, 103.0, 142.0, 135.0, 118.0, 95.0, 92.0, 93.0, 87.0], "unit": "ms", "name": "imaging-desaturate", "value": 105.4}, {"lowerIsBetter": true, "replicates": [58.0, 60.0, 57.0, 59.0, 62.0, 58.0, 59.0, 66.0, 59.0, 59.0], "unit": "ms", "name": "json-parse-financial", "value": 59.7}, {"lowerIsBetter": true, "replicates": [68.0, 87.0, 83.0, 81.0, 58.0, 57.0, 61.0, 100.0, 103.0, 100.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 79.8}, {"lowerIsBetter": true, "replicates": [77.0, 77.0, 111.0, 110.0, 110.0, 85.0, 87.0, 86.0, 84.0, 90.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 91.7}, {"lowerIsBetter": true, "replicates": [123.0, 138.0, 133.0, 126.0, 121.0, 134.0, 127.0, 137.0, 132.0, 133.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 130.4}, {"lowerIsBetter": true, "replicates": [137.0, 142.0, 137.0, 140.0, 135.0, 131.0, 181.0, 174.0, 139.0, 136.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 145.2}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 66.0, 64.0, 64.0, 70.0, 89.0, 94.0, 96.0, 91.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 76.8}], "name": "kraken", "value": 1557.6000000000001}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [178.25311942959001], "unit": "score", "name": "Richards", "value": 198.04422000000002}, {"lowerIsBetter": false, "replicates": [157.0598397989634], "unit": "score", "name": "DeltaBlue", "value": 420.9733059999999}, {"lowerIsBetter": false, "replicates": [282.0078962210942], "unit": "score", "name": "Encrypt", "value": 943.8778259999998}, {"lowerIsBetter": false, "replicates": [4794.258373205742], "unit": "score", "name": "Decrypt", "value": 55.52078742514974}, {"lowerIsBetter": false, "replicates": [936.3295880149813], "unit": "score", "name": "RayTrace", "value": 790.3082519999997}, {"lowerIsBetter": false, "replicates": [740.1924500370096], "unit": "score", "name": "Earley", "value": 900.3915129999997}, {"lowerIsBetter": false, "replicates": [13328.947368421053], "unit": "score", "name": "Boyer", "value": 50.00117275419543}, {"lowerIsBetter": false, "replicates": [29852.941176470587], "unit": "score", "name": "RegExp", "value": 30.5157536945813}, {"lowerIsBetter": false, "replicates": [686.8131868131868], "unit": "score", "name": "Splay", "value": 118.65089600000005}, {"lowerIsBetter": false, "replicates": [4524.886877828054], "unit": "score", "name": "NavierStokes", "value": 327.9640000000003}], "name": "v8_7", "value": 21310.409602774213}]} 19:12:15 INFO - RETURN: dromaeo_css: 7650.58 19:12:15 INFO - RETURN: kraken: 1557.60 19:12:15 INFO - RETURN: v8_7: 21310.41 19:12:15 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,61]]", "result": "21310.41"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,61]]", "result": "1557.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,61]]", "result": "7650.58"}}} 19:12:15 INFO - Return code: 0 19:12:15 INFO - # TBPL SUCCESS # 19:12:15 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:12:15 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:12:15 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:12:15 INFO - 2015-11-23 19:12:15.444 screenresolution[1986:15719] starting screenresolution argv=screenresolution get 19:12:15 INFO - 2015-11-23 19:12:15.446 screenresolution[1986:15719] Display 0: 1600x1200x32@60 19:12:15 INFO - 2015-11-23 19:12:15.452 screenresolution[1987:15722] starting screenresolution argv=screenresolution list 19:12:15 INFO - Available Modes on Display 0 19:12:15 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:12:15 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:12:15 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:12:15 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:12:15 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:12:15 INFO - Intel Iris: 19:12:15 INFO - Chipset Model: Intel Iris 19:12:15 INFO - Type: GPU 19:12:15 INFO - Bus: Built-In 19:12:15 INFO - VRAM (Dynamic, Max): 1536 MB 19:12:15 INFO - Vendor: Intel (0x8086) 19:12:15 INFO - Device ID: 0x0a2e 19:12:15 INFO - Revision ID: 0x0009 19:12:15 INFO - Displays: 19:12:15 INFO - Display: 19:12:15 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:12:15 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:12:15 INFO - Display Serial Number: 1600x1200 60 19:12:15 INFO - Main Display: Yes 19:12:15 INFO - Mirror: Off 19:12:15 INFO - Online: Yes 19:12:15 INFO - Rotation: Supported 19:12:15 INFO - Return code: 0 19:12:15 INFO - Running post-action listener: _resource_record_post_action 19:12:15 INFO - Running post-run listener: _resource_record_post_run 19:12:16 INFO - Total resource usage - Wall time: 1238s; CPU: 53.0%; Read bytes: 1093632; Write bytes: 692940800; Read time: 14; Write time: 1907 19:12:16 INFO - install - Wall time: 31s; CPU: 55.0%; Read bytes: 345166336; Write bytes: 347866624; Read time: 27128; Write time: 634 19:12:16 INFO - run-tests - Wall time: 1208s; CPU: 53.0%; Read bytes: 1089536; Write bytes: 343874048; Read time: 14; Write time: 1267 19:12:16 INFO - Running post-run listener: _upload_blobber_files 19:12:16 INFO - Blob upload gear active. 19:12:16 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 19:12:16 INFO - Copying logs to upload dir... 19:12:16 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1280.231503 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2015-11-23 19:12:16.802229) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-23 19:12:16.805998) ========= 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.2ru3ViqQUC/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.A15TgHtWVw/Listeners TMPDIR=/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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/xWPFeFVQShqXjHmHRW7FCQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.008953 build_url: 'https://queue.taskcluster.net/v1/task/xWPFeFVQShqXjHmHRW7FCQ/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-23 19:12:16.831275) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 19:12:16.831813) ========= 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.2ru3ViqQUC/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.A15TgHtWVw/Listeners TMPDIR=/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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.005167 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 19:12:16.881876) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-23 19:12:16.882163) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-23 19:12:16.882491) ========= ========= Total master_lag: 0.21 =========