builder: fx-team_yosemite_test-dromaeojs slave: t-yosemite-r5-0050 starttime: 1447863023.9 results: success (0) buildid: 20151118062325 builduid: 5d0b600731194e44af48852715ead046 revision: 44f58c7fc121e68854da500798ef84c0f432a32a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-18 08:10:23.896832) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-18 08:10:23.897338) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-18 08:10:23.897692) ========= 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.F1wz69HD9j/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.HzbVF8jZEa/Listeners TMPDIR=/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006245 basedir: '/builds/slave/test' ========= master_lag: 0.34 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-18 08:10:24.241294) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-18 08:10:24.241629) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-18 08:10:24.263272) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 08:10:24.263613) ========= 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.F1wz69HD9j/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.HzbVF8jZEa/Listeners TMPDIR=/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False program finished with exit code 0 elapsedTime=0.014428 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 08:10:24.314243) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-18 08:10:24.314568) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-18 08:10:24.315003) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 08:10:24.315368) ========= 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.F1wz69HD9j/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.HzbVF8jZEa/Listeners TMPDIR=/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False --2015-11-18 08:10:24-- 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.25, 63.245.215.102, ... Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 8.69M=0.001s 2015-11-18 08:10:24 (8.69 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.178371 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 08:10:24.511713) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 08:10:24.512084) ========= 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.F1wz69HD9j/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.HzbVF8jZEa/Listeners TMPDIR=/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False program finished with exit code 0 elapsedTime=0.162319 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 08:10:24.689707) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 08:10:24.690137) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 44f58c7fc121e68854da500798ef84c0f432a32a --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 44f58c7fc121e68854da500798ef84c0f432a32a --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.F1wz69HD9j/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.HzbVF8jZEa/Listeners TMPDIR=/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False 2015-11-18 08:10:24,782 truncating revision to first 12 chars 2015-11-18 08:10:24,782 Setting DEBUG logging. 2015-11-18 08:10:24,782 attempt 1/10 2015-11-18 08:10:24,782 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/44f58c7fc121?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-18 08:10:25,104 unpacking tar archive at: fx-team-44f58c7fc121/testing/mozharness/ program finished with exit code 0 elapsedTime=0.582816 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 08:10:25.291096) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-18 08:10:25.291464) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-18 08:10:25.305297) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-18 08:10:25.305681) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-18 08:10:25.306180) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 8 secs) (at 2015-11-18 08:10:25.306500) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--system-bits', '64', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.F1wz69HD9j/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.HzbVF8jZEa/Listeners TMPDIR=/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False 08:10:25 INFO - MultiFileLogger online at 20151118 08:10:25 in /builds/slave/test 08:10:25 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 08:10:25 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:10:25 INFO - {'append_to_log': False, 08:10:25 INFO - 'base_work_dir': '/builds/slave/test', 08:10:25 INFO - 'blob_upload_branch': 'Fx-Team', 08:10:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:10:25 INFO - 'branch': 'Fx-Team', 08:10:25 INFO - 'buildbot_json_path': 'buildprops.json', 08:10:25 INFO - 'config_files': ('talos/mac_config.py',), 08:10:25 INFO - 'default_actions': ('clobber', 08:10:25 INFO - 'read-buildbot-config', 08:10:25 INFO - 'download-and-extract', 08:10:25 INFO - 'populate-webroot', 08:10:25 INFO - 'create-virtualenv', 08:10:25 INFO - 'install', 08:10:25 INFO - 'run-tests'), 08:10:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:10:25 INFO - 'download_minidump_stackwalk': True, 08:10:25 INFO - 'download_symbols': 'ondemand', 08:10:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:10:25 INFO - 'tooltool.py': '/tools/tooltool.py', 08:10:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:10:25 INFO - '/tools/misc-python/virtualenv.py')}, 08:10:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:10:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:10:25 INFO - 'installer_path': 'installer.exe', 08:10:25 INFO - 'log_level': 'info', 08:10:25 INFO - 'log_name': 'talos', 08:10:25 INFO - 'log_to_console': True, 08:10:25 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:10:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:10:25 INFO - 'opt_config_files': (), 08:10:25 INFO - 'pip_index': False, 08:10:25 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:10:25 INFO - 'cmd': ('bash', 08:10:25 INFO - '-c', 08:10:25 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:10:25 INFO - 'enabled': True, 08:10:25 INFO - 'halt_on_failure': False, 08:10:25 INFO - 'name': 'check_screen_resolution'},), 08:10:25 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:10:25 INFO - 'cmd': ('bash', 08:10:25 INFO - '-c', 08:10:25 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:10:25 INFO - 'enabled': True, 08:10:25 INFO - 'halt_on_failure': False, 08:10:25 INFO - 'name': 'check_screen_resolution'},), 08:10:25 INFO - 'run_cmd_checks_enabled': True, 08:10:25 INFO - 'sps_profile': False, 08:10:25 INFO - 'sps_profile_interval': 0, 08:10:25 INFO - 'suite': 'dromaeojs', 08:10:25 INFO - 'system_bits': '64', 08:10:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:10:25 INFO - 'title': 't-yosemite-r5-0050', 08:10:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:10:25 INFO - 'use_talos_json': True, 08:10:25 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:10:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:10:25 INFO - 'work_dir': 'build'} 08:10:25 INFO - ##### 08:10:25 INFO - ##### Running clobber step. 08:10:25 INFO - ##### 08:10:25 INFO - Running pre-action listener: _resource_record_pre_action 08:10:25 INFO - Running main action method: clobber 08:10:25 INFO - rmtree: /builds/slave/test/build 08:10:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:10:29 INFO - Running post-action listener: _resource_record_post_action 08:10:29 INFO - ##### 08:10:29 INFO - ##### Running read-buildbot-config step. 08:10:29 INFO - ##### 08:10:29 INFO - Running pre-action listener: _resource_record_pre_action 08:10:29 INFO - Running main action method: read_buildbot_config 08:10:29 INFO - Using buildbot properties: 08:10:29 INFO - { 08:10:29 INFO - "properties": { 08:10:29 INFO - "buildnumber": 1348, 08:10:29 INFO - "product": "firefox", 08:10:29 INFO - "script_repo_revision": "production", 08:10:29 INFO - "builddir": "fx-team_yosemite_test-dromaeojs", 08:10:29 INFO - "repository": "", 08:10:29 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 fx-team talos dromaeojs", 08:10:29 INFO - "buildid": "20151118062325", 08:10:29 INFO - "slavename": "t-yosemite-r5-0050", 08:10:29 INFO - "pgo_build": "False", 08:10:29 INFO - "basedir": "/builds/slave/test", 08:10:29 INFO - "project": "", 08:10:29 INFO - "platform": "yosemite", 08:10:29 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 08:10:29 INFO - "slavebuilddir": "test", 08:10:29 INFO - "scheduler": "tests-fx-team-macosx64-talos", 08:10:29 INFO - "branch": "fx-team", 08:10:29 INFO - "repo_path": "integration/fx-team", 08:10:29 INFO - "stage_platform": "macosx64", 08:10:29 INFO - "builduid": "5d0b600731194e44af48852715ead046", 08:10:29 INFO - "revision": "44f58c7fc121e68854da500798ef84c0f432a32a" 08:10:29 INFO - }, 08:10:29 INFO - "sourcestamp": { 08:10:29 INFO - "repository": "", 08:10:29 INFO - "hasPatch": false, 08:10:29 INFO - "project": "", 08:10:29 INFO - "branch": "fx-team-macosx64-talos", 08:10:29 INFO - "changes": [ 08:10:29 INFO - { 08:10:29 INFO - "category": null, 08:10:29 INFO - "files": [ 08:10:29 INFO - { 08:10:29 INFO - "url": null, 08:10:29 INFO - "name": "https://queue.taskcluster.net/v1/task/RBAZ_rkYSWmHDaun07unzA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 08:10:29 INFO - } 08:10:29 INFO - ], 08:10:29 INFO - "repository": "", 08:10:29 INFO - "rev": "44f58c7fc121e68854da500798ef84c0f432a32a", 08:10:29 INFO - "who": "cbook@mozilla.com", 08:10:29 INFO - "when": 1447862968, 08:10:29 INFO - "number": 6677436, 08:10:29 INFO - "comments": "Merge mozilla-central to fx-team", 08:10:29 INFO - "project": "", 08:10:29 INFO - "at": "Wed 18 Nov 2015 08:09:28", 08:10:29 INFO - "branch": "fx-team-macosx64-talos", 08:10:29 INFO - "revlink": "", 08:10:29 INFO - "properties": [ 08:10:29 INFO - [ 08:10:29 INFO - "buildid", 08:10:29 INFO - "20151118062325", 08:10:29 INFO - "Change" 08:10:29 INFO - ], 08:10:29 INFO - [ 08:10:29 INFO - "builduid", 08:10:29 INFO - "5d0b600731194e44af48852715ead046", 08:10:29 INFO - "Change" 08:10:29 INFO - ], 08:10:29 INFO - [ 08:10:29 INFO - "pgo_build", 08:10:29 INFO - "False", 08:10:29 INFO - "Change" 08:10:29 INFO - ] 08:10:29 INFO - ], 08:10:29 INFO - "revision": "44f58c7fc121e68854da500798ef84c0f432a32a" 08:10:29 INFO - } 08:10:29 INFO - ], 08:10:29 INFO - "revision": "44f58c7fc121e68854da500798ef84c0f432a32a" 08:10:29 INFO - } 08:10:29 INFO - } 08:10:29 INFO - Found installer url https://queue.taskcluster.net/v1/task/RBAZ_rkYSWmHDaun07unzA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 08:10:29 INFO - Running post-action listener: _resource_record_post_action 08:10:29 INFO - ##### 08:10:29 INFO - ##### Running download-and-extract step. 08:10:29 INFO - ##### 08:10:29 INFO - Running pre-action listener: _resource_record_pre_action 08:10:29 INFO - Running main action method: download_and_extract 08:10:29 INFO - mkdir: /builds/slave/test/build/tests 08:10:29 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')]} 08:10:29 INFO - https://queue.taskcluster.net/v1/task/RBAZ_rkYSWmHDaun07unzA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 08:10:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RBAZ_rkYSWmHDaun07unzA/artifacts/public/build/test_packages.json 08:10:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RBAZ_rkYSWmHDaun07unzA/artifacts/public/build/test_packages.json 08:10:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RBAZ_rkYSWmHDaun07unzA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 08:10:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RBAZ_rkYSWmHDaun07unzA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 08:10:43 INFO - Downloaded 1149 bytes. 08:10:43 INFO - Reading from file /builds/slave/test/build/test_packages.json 08:10:44 INFO - Using the following test package requirements: 08:10:44 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 08:10:44 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 08:10:44 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 08:10:44 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 08:10:44 INFO - u'jsshell-mac.zip'], 08:10:44 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 08:10:44 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 08:10:44 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 08:10:44 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 08:10:44 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 08:10:44 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 08:10:44 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 08:10:44 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 08:10:44 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 08:10:44 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 08:10:44 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 08:10:44 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 08:10:44 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 08:10:44 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')]} 08:10:44 INFO - https://queue.taskcluster.net/v1/task/RBAZ_rkYSWmHDaun07unzA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 08:10:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RBAZ_rkYSWmHDaun07unzA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 08:10:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RBAZ_rkYSWmHDaun07unzA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 08:10:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RBAZ_rkYSWmHDaun07unzA/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 08:10:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RBAZ_rkYSWmHDaun07unzA/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 08:10:48 INFO - Downloaded 17463580 bytes. 08:10:48 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 08:10:48 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 08:10:48 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 08:10:53 INFO - Return code: 0 08:10:53 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 08:10:53 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')]} 08:10:53 INFO - https://queue.taskcluster.net/v1/task/RBAZ_rkYSWmHDaun07unzA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 08:10:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RBAZ_rkYSWmHDaun07unzA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 08:10:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RBAZ_rkYSWmHDaun07unzA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 08:10:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RBAZ_rkYSWmHDaun07unzA/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 08:10:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RBAZ_rkYSWmHDaun07unzA/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 08:10:59 INFO - Downloaded 17463580 bytes. 08:10:59 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 08:10:59 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 08:10:59 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 08:11:05 INFO - Return code: 0 08:11:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:11:05 INFO - https://queue.taskcluster.net/v1/task/RBAZ_rkYSWmHDaun07unzA/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 08:11:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RBAZ_rkYSWmHDaun07unzA/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 08:11:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RBAZ_rkYSWmHDaun07unzA/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 08:11:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RBAZ_rkYSWmHDaun07unzA/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 08:11:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RBAZ_rkYSWmHDaun07unzA/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 08:11:06 INFO - Downloaded 11130997 bytes. 08:11:06 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 08:11:06 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 08:11:06 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 08:11:06 INFO - Return code: 0 08:11:06 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')]} 08:11:06 INFO - https://queue.taskcluster.net/v1/task/RBAZ_rkYSWmHDaun07unzA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 08:11:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RBAZ_rkYSWmHDaun07unzA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 08:11:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RBAZ_rkYSWmHDaun07unzA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 08:11:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RBAZ_rkYSWmHDaun07unzA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 08:11:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RBAZ_rkYSWmHDaun07unzA/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 08:11:10 INFO - Downloaded 108846386 bytes. 08:11:10 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RBAZ_rkYSWmHDaun07unzA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 08:11:10 INFO - mkdir: /builds/slave/test/properties 08:11:10 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:11:10 INFO - Writing to file /builds/slave/test/properties/build_url 08:11:10 INFO - Contents: 08:11:10 INFO - build_url:https://queue.taskcluster.net/v1/task/RBAZ_rkYSWmHDaun07unzA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 08:11:10 INFO - Running post-action listener: _resource_record_post_action 08:11:10 INFO - Running post-action listener: set_extra_try_arguments 08:11:10 INFO - ##### 08:11:10 INFO - ##### Running populate-webroot step. 08:11:10 INFO - ##### 08:11:10 INFO - Running pre-action listener: _resource_record_pre_action 08:11:10 INFO - Running main action method: populate_webroot 08:11:10 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:11:10 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:11:10 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 08:11:10 INFO - '../fennec_ids.txt'], 08:11:10 INFO - 'tests': ['tcheck2']}, 08:11:10 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:11:10 INFO - '--tppagecycles', 08:11:10 INFO - '7'], 08:11:10 INFO - 'tests': ['tsvgm']}}, 08:11:10 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 08:11:10 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 08:11:10 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:11:10 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 08:11:10 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 08:11:10 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 08:11:10 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:11:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:11:10 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:11:10 INFO - 'talos_options': ['--e10s'], 08:11:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:11:10 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:11:10 INFO - 'tests': ['damp', 'tps']}, 08:11:10 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:11:10 INFO - 'talos_options': ['--e10s'], 08:11:10 INFO - 'tests': ['damp', 'tps']}, 08:11:10 INFO - 'g3': {'tests': ['dromaeo_dom']}, 08:11:10 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:11:10 INFO - 'other': {'tests': ['a11yr', 08:11:10 INFO - 'ts_paint', 08:11:10 INFO - 'tpaint', 08:11:10 INFO - 'sessionrestore', 08:11:10 INFO - 'sessionrestore_no_auto_restore']}, 08:11:10 INFO - 'other-e10s': {'talos_options': ['--e10s'], 08:11:10 INFO - 'tests': ['a11yr', 08:11:10 INFO - 'ts_paint', 08:11:10 INFO - 'tpaint', 08:11:10 INFO - 'sessionrestore', 08:11:10 INFO - 'sessionrestore_no_auto_restore']}, 08:11:10 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 08:11:10 INFO - 'tests': ['a11yr', 08:11:10 INFO - 'ts_paint', 08:11:10 INFO - 'tpaint', 08:11:10 INFO - 'sessionrestore', 08:11:10 INFO - 'sessionrestore_no_auto_restore']}, 08:11:10 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 08:11:10 INFO - 'tests': ['a11yr', 08:11:10 INFO - 'ts_paint', 08:11:10 INFO - 'tpaint', 08:11:10 INFO - 'sessionrestore', 08:11:10 INFO - 'sessionrestore_no_auto_restore']}, 08:11:10 INFO - 'other_l64': {'tests': ['a11yr', 08:11:10 INFO - 'ts_paint', 08:11:10 INFO - 'tpaint', 08:11:10 INFO - 'sessionrestore', 08:11:10 INFO - 'sessionrestore_no_auto_restore']}, 08:11:10 INFO - 'other_nol64': {'tests': ['a11yr', 08:11:10 INFO - 'ts_paint', 08:11:10 INFO - 'tpaint', 08:11:10 INFO - 'sessionrestore', 08:11:10 INFO - 'sessionrestore_no_auto_restore']}, 08:11:10 INFO - 'svgr': {'tests': ['tsvgx', 08:11:10 INFO - 'tsvgr_opacity', 08:11:10 INFO - 'tart', 08:11:10 INFO - 'tscrollx', 08:11:10 INFO - 'cart']}, 08:11:10 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 08:11:10 INFO - 'tests': ['tsvgx', 08:11:10 INFO - 'tsvgr_opacity', 08:11:10 INFO - 'tart', 08:11:10 INFO - 'tscrollx', 08:11:10 INFO - 'cart']}, 08:11:10 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:11:10 INFO - 'tests': ['tp5o']}, 08:11:10 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:11:10 INFO - 'talos_options': ['--e10s'], 08:11:10 INFO - 'tests': ['tp5o']}, 08:11:10 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:11:10 INFO - 'talos_options': ['--xperf_path', 08:11:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:11:10 INFO - 'tests': ['tp5n']}, 08:11:10 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:11:10 INFO - 'talos_options': ['--e10s', 08:11:10 INFO - '--xperf_path', 08:11:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:11:10 INFO - 'tests': ['tp5n']}}, 08:11:10 INFO - 'talos.zip': {'path': '', 08:11:10 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:11:10 INFO - Running post-action listener: _resource_record_post_action 08:11:10 INFO - ##### 08:11:10 INFO - ##### Running create-virtualenv step. 08:11:10 INFO - ##### 08:11:10 INFO - Running pre-action listener: _resource_record_pre_action 08:11:10 INFO - Running main action method: create_virtualenv 08:11:10 INFO - Creating virtualenv /builds/slave/test/build/venv 08:11:10 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 08:11:10 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:11:10 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:11:10 INFO - Using real prefix '/tools/python27' 08:11:10 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:11:11 INFO - Installing distribute.............................................................................................................................................................................................done. 08:11:14 INFO - Installing pip.................done. 08:11:14 INFO - Return code: 0 08:11:14 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:11:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:11:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:11:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:11:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:11:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:14 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 0x10ec87490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec64228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f918ae48ba0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ebab9f0>, '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 0x10e90adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10eb9e8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.F1wz69HD9j/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.HzbVF8jZEa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:11:14 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 08:11:14 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 08:11:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.F1wz69HD9j/Render', 08:11:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:11:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:11:14 INFO - 'HOME': '/Users/cltbld', 08:11:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:11:14 INFO - 'LOGNAME': 'cltbld', 08:11:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:11:14 INFO - 'MOZ_NO_REMOTE': '1', 08:11:14 INFO - 'NO_EM_RESTART': '1', 08:11:14 INFO - 'PAGER': '/bin/cat', 08:11:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:11:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:11:14 INFO - 'PWD': '/builds/slave/test', 08:11:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:11:14 INFO - 'SHELL': '/bin/bash', 08:11:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HzbVF8jZEa/Listeners', 08:11:14 INFO - 'TMPDIR': '/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/', 08:11:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:11:14 INFO - 'USER': 'cltbld', 08:11:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:11:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:11:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:11:14 INFO - 'XPC_FLAGS': '0x0', 08:11:14 INFO - 'XPC_SERVICE_NAME': '0', 08:11:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 08:11:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:11: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 08:11:15 INFO - Cleaning up... 08:11:16 INFO - Return code: 0 08:11:16 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 08:11:16 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')]} 08:11:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:11:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:16 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')]} 08:11:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:11:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:16 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 0x10ec87490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec64228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f918ae48ba0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ebab9f0>, '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 0x10e90adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10eb9e8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.F1wz69HD9j/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.HzbVF8jZEa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:11:16 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 08:11:16 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 08:11:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.F1wz69HD9j/Render', 08:11:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:11:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:11:16 INFO - 'HOME': '/Users/cltbld', 08:11:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:11:16 INFO - 'LOGNAME': 'cltbld', 08:11:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:11:16 INFO - 'MOZ_NO_REMOTE': '1', 08:11:16 INFO - 'NO_EM_RESTART': '1', 08:11:16 INFO - 'PAGER': '/bin/cat', 08:11:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:11:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:11:16 INFO - 'PWD': '/builds/slave/test', 08:11:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:11:16 INFO - 'SHELL': '/bin/bash', 08:11:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HzbVF8jZEa/Listeners', 08:11:16 INFO - 'TMPDIR': '/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/', 08:11:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:11:16 INFO - 'USER': 'cltbld', 08:11:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:11:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:11:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:11:16 INFO - 'XPC_FLAGS': '0x0', 08:11:16 INFO - 'XPC_SERVICE_NAME': '0', 08:11:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 08:11:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:11:16 INFO - Downloading/unpacking psutil>=0.7.1 08:11:16 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 08:11:16 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 08:11:16 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 08:11:16 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 08:11:16 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 08:11:16 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 08:11:18 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 08:11:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 08:11:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:11:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:11:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:11:18 INFO - Installing collected packages: psutil 08:11:18 INFO - Running setup.py install for psutil 08:11:18 INFO - building 'psutil._psutil_osx' extension 08:11: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 08:11:20 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 08:11:20 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 08:11:21 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 08:11:21 INFO - building 'psutil._psutil_posix' extension 08:11:21 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 08:11:21 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:11:21 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:11:21 INFO - ^ 08:11:21 INFO - 1 warning generated. 08:11:21 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 08:11:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:11:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:11:21 INFO - Successfully installed psutil 08:11:21 INFO - Cleaning up... 08:11:21 INFO - Return code: 0 08:11:21 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 08:11:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:11:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:11:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:11:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:11:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x10ec87490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec64228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f918ae48ba0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ebab9f0>, '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 0x10e90adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10eb9e8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.F1wz69HD9j/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.HzbVF8jZEa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:11:21 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 08:11:21 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 08:11:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.F1wz69HD9j/Render', 08:11:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:11:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:11:21 INFO - 'HOME': '/Users/cltbld', 08:11:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:11:21 INFO - 'LOGNAME': 'cltbld', 08:11:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:11:21 INFO - 'MOZ_NO_REMOTE': '1', 08:11:21 INFO - 'NO_EM_RESTART': '1', 08:11:21 INFO - 'PAGER': '/bin/cat', 08:11:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:11:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:11:21 INFO - 'PWD': '/builds/slave/test', 08:11:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:11:21 INFO - 'SHELL': '/bin/bash', 08:11:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HzbVF8jZEa/Listeners', 08:11:21 INFO - 'TMPDIR': '/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/', 08:11:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:11:21 INFO - 'USER': 'cltbld', 08:11:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:11:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:11:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:11:21 INFO - 'XPC_FLAGS': '0x0', 08:11:21 INFO - 'XPC_SERVICE_NAME': '0', 08:11:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 08:11:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:11:21 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:11:21 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 08:11:21 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 08:11:21 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 08:11:21 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 08:11:21 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 08:11:21 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 08:11:24 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:11:24 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 08:11:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:11:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:11:24 INFO - Installing collected packages: mozsystemmonitor 08:11:24 INFO - Running setup.py install for mozsystemmonitor 08:11:24 INFO - Successfully installed mozsystemmonitor 08:11:24 INFO - Cleaning up... 08:11:24 INFO - Return code: 0 08:11:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:11:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:11:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:11:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:11:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:11:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10ec87490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec64228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f918ae48ba0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ebab9f0>, '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 0x10e90adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10eb9e8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.F1wz69HD9j/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.HzbVF8jZEa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:11:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:11:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:11:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.F1wz69HD9j/Render', 08:11:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:11:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:11:24 INFO - 'HOME': '/Users/cltbld', 08:11:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:11:24 INFO - 'LOGNAME': 'cltbld', 08:11:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:11:24 INFO - 'MOZ_NO_REMOTE': '1', 08:11:24 INFO - 'NO_EM_RESTART': '1', 08:11:24 INFO - 'PAGER': '/bin/cat', 08:11:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:11:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:11:24 INFO - 'PWD': '/builds/slave/test', 08:11:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:11:24 INFO - 'SHELL': '/bin/bash', 08:11:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HzbVF8jZEa/Listeners', 08:11:24 INFO - 'TMPDIR': '/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/', 08:11:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:11:24 INFO - 'USER': 'cltbld', 08:11:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:11:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:11:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:11:24 INFO - 'XPC_FLAGS': '0x0', 08:11:24 INFO - 'XPC_SERVICE_NAME': '0', 08:11:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 08:11:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:11:24 INFO - Downloading/unpacking blobuploader==1.2.4 08:11: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 08:11: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 08:11: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 08:11: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 08:11: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 08:11: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 08:11:27 INFO - Downloading blobuploader-1.2.4.tar.gz 08:11:27 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 08:11:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:11:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:11:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:11:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:11:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:11:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:11:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:11:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:11:27 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 08:11:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:11:28 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:11:28 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 08:11:28 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 08:11:28 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 08:11:28 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 08:11:28 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 08:11:28 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 08:11:28 INFO - Downloading docopt-0.6.1.tar.gz 08:11:28 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 08:11:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:11:28 INFO - Installing collected packages: blobuploader, requests, docopt 08:11:28 INFO - Running setup.py install for blobuploader 08:11:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:11:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:11:28 INFO - Running setup.py install for requests 08:11:29 INFO - Running setup.py install for docopt 08:11:29 INFO - Successfully installed blobuploader requests docopt 08:11:29 INFO - Cleaning up... 08:11:29 INFO - Return code: 0 08:11:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:11:29 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')]} 08:11:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:11:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:29 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')]} 08:11:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:11:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:29 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 0x10ec87490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec64228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f918ae48ba0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ebab9f0>, '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 0x10e90adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10eb9e8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.F1wz69HD9j/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.HzbVF8jZEa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:11:29 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 08:11:29 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 08:11:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.F1wz69HD9j/Render', 08:11:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:11:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:11:29 INFO - 'HOME': '/Users/cltbld', 08:11:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:11:29 INFO - 'LOGNAME': 'cltbld', 08:11:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:11:29 INFO - 'MOZ_NO_REMOTE': '1', 08:11:29 INFO - 'NO_EM_RESTART': '1', 08:11:29 INFO - 'PAGER': '/bin/cat', 08:11:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:11:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:11:29 INFO - 'PWD': '/builds/slave/test', 08:11:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:11:29 INFO - 'SHELL': '/bin/bash', 08:11:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HzbVF8jZEa/Listeners', 08:11:29 INFO - 'TMPDIR': '/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/', 08:11:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:11:29 INFO - 'USER': 'cltbld', 08:11:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:11:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:11:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:11:29 INFO - 'XPC_FLAGS': '0x0', 08:11:29 INFO - 'XPC_SERVICE_NAME': '0', 08:11:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 08:11:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:11:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:11:29 INFO - Running setup.py (path:/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/pip-h9Q9Es-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:11:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:11:30 INFO - Running setup.py (path:/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/pip-W11lT2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:11:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:11:30 INFO - Running setup.py (path:/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/pip-nL3waf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:11:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:11:30 INFO - Running setup.py (path:/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/pip-xJsqSa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:11:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:11:30 INFO - Running setup.py (path:/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/pip-RgT7yG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:11:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:11:30 INFO - Running setup.py (path:/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/pip-Mgkimh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:11:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:11:30 INFO - Running setup.py (path:/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/pip-40jcq_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:11:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:11:30 INFO - Running setup.py (path:/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/pip-61pAUZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:11:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:11:30 INFO - Running setup.py (path:/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/pip-dHspSM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:11:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:11:31 INFO - Running setup.py (path:/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/pip-78CV01-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:11:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:11:31 INFO - Running setup.py (path:/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/pip-IfjQOu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:11:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:11:31 INFO - Running setup.py (path:/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/pip-ca_J6u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:11:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:11:31 INFO - Running setup.py (path:/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/pip-sUaSaI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:11:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:11:31 INFO - Running setup.py (path:/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/pip-UhrIiz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:11:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:11:31 INFO - Running setup.py (path:/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/pip-PT8iNw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:11:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:11:31 INFO - Running setup.py (path:/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/pip-pUXp6r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:11:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:11:31 INFO - Running setup.py (path:/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/pip-w8WLge-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:11:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:11:32 INFO - Running setup.py install for manifestparser 08:11:32 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:11:32 INFO - Running setup.py install for mozcrash 08:11:32 INFO - Running setup.py install for mozdebug 08:11:32 INFO - Running setup.py install for mozdevice 08:11:32 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:11:32 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:11:32 INFO - Running setup.py install for mozfile 08:11:32 INFO - Running setup.py install for mozhttpd 08:11:33 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:11:33 INFO - Running setup.py install for mozinfo 08:11:33 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:11:33 INFO - Running setup.py install for mozInstall 08:11:33 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:11:33 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:11:33 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:11:33 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:11:33 INFO - Running setup.py install for mozleak 08:11:33 INFO - Running setup.py install for mozlog 08:11:33 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:11:33 INFO - Running setup.py install for moznetwork 08:11:33 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:11:33 INFO - Running setup.py install for mozprocess 08:11:34 INFO - Running setup.py install for mozprofile 08:11:34 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:11:34 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:11:34 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:11:34 INFO - Running setup.py install for mozrunner 08:11:34 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:11:34 INFO - Running setup.py install for mozscreenshot 08:11:34 INFO - Running setup.py install for moztest 08:11:34 INFO - Running setup.py install for mozversion 08:11:34 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:11:35 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:11:35 INFO - Cleaning up... 08:11:35 INFO - Return code: 0 08:11:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:11:35 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')]} 08:11:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:11:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:35 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')]} 08:11:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:11:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:35 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 0x10ec87490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec64228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f918ae48ba0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ebab9f0>, '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 0x10e90adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10eb9e8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.F1wz69HD9j/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.HzbVF8jZEa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:11:35 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 08:11:35 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 08:11:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.F1wz69HD9j/Render', 08:11:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:11:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:11:35 INFO - 'HOME': '/Users/cltbld', 08:11:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:11:35 INFO - 'LOGNAME': 'cltbld', 08:11:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:11:35 INFO - 'MOZ_NO_REMOTE': '1', 08:11:35 INFO - 'NO_EM_RESTART': '1', 08:11:35 INFO - 'PAGER': '/bin/cat', 08:11:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:11:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:11:35 INFO - 'PWD': '/builds/slave/test', 08:11:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:11:35 INFO - 'SHELL': '/bin/bash', 08:11:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HzbVF8jZEa/Listeners', 08:11:35 INFO - 'TMPDIR': '/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/', 08:11:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:11:35 INFO - 'USER': 'cltbld', 08:11:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:11:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:11:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:11:35 INFO - 'XPC_FLAGS': '0x0', 08:11:35 INFO - 'XPC_SERVICE_NAME': '0', 08:11:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 08:11:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:11:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:11:35 INFO - Running setup.py (path:/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/pip-VI_GAg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:11:35 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)) 08:11:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:11:35 INFO - Running setup.py (path:/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/pip-tZ_Ncz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:11:35 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)) 08:11:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:11:35 INFO - Running setup.py (path:/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/pip-f25cJf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:11:35 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)) 08:11:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:11:35 INFO - Running setup.py (path:/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/pip-8OsRr3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:11:35 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)) 08:11:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:11:35 INFO - Running setup.py (path:/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/pip-LN_DED-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:11:35 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)) 08:11:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:11:35 INFO - Running setup.py (path:/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/pip-8j7pen-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:11:36 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)) 08:11:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:11:36 INFO - Running setup.py (path:/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/pip-GAARi0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:11:36 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)) 08:11:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:11:36 INFO - Running setup.py (path:/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/pip-U4Xbs3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:11:36 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)) 08:11:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:11:36 INFO - Running setup.py (path:/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/pip-ajCgrH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:11:36 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)) 08:11:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:11:36 INFO - Running setup.py (path:/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/pip-Vq43W7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:11:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:11:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:11:36 INFO - Running setup.py (path:/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/pip-nEu_xH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:11:36 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)) 08:11:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:11:36 INFO - Running setup.py (path:/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/pip-xmVeft-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:11:36 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)) 08:11:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:11:36 INFO - Running setup.py (path:/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/pip-zAudK0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:11:37 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)) 08:11:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:11:37 INFO - Running setup.py (path:/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/pip-tPF_VN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:11:37 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)) 08:11:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:11:37 INFO - Running setup.py (path:/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/pip-oAmZY9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:11:37 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)) 08:11:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:11:37 INFO - Running setup.py (path:/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/pip-aiwQWs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:11:37 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)) 08:11:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:11:37 INFO - Running setup.py (path:/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/pip-5deONY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:11:37 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)) 08:11:37 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)) 08:11:37 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)) 08:11:37 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)) 08:11:37 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)) 08:11:37 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)) 08:11:37 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:11:37 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 08:11:37 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 08:11:37 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 08:11:37 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 08:11:37 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 08:11:37 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 08:11:39 INFO - Downloading blessings-1.5.1.tar.gz 08:11:39 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 08:11:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:11:40 INFO - Installing collected packages: blessings 08:11:40 INFO - Running setup.py install for blessings 08:11:40 INFO - Successfully installed blessings 08:11:40 INFO - Cleaning up... 08:11:40 INFO - Return code: 0 08:11:40 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:11:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:11:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:11:40 INFO - Reading from file tmpfile_stdout 08:11:40 INFO - Current package versions: 08:11:40 INFO - blessings == 1.5.1 08:11:40 INFO - blobuploader == 1.2.4 08:11:40 INFO - docopt == 0.6.1 08:11:40 INFO - manifestparser == 1.1 08:11:40 INFO - mozInstall == 1.12 08:11:40 INFO - mozcrash == 0.16 08:11:40 INFO - mozdebug == 0.1 08:11:40 INFO - mozdevice == 0.47 08:11:40 INFO - mozfile == 1.2 08:11:40 INFO - mozhttpd == 0.7 08:11:40 INFO - mozinfo == 0.9 08:11:40 INFO - mozleak == 0.1 08:11:40 INFO - mozlog == 3.0 08:11:40 INFO - moznetwork == 0.27 08:11:40 INFO - mozprocess == 0.22 08:11:40 INFO - mozprofile == 0.27 08:11:40 INFO - mozrunner == 6.11 08:11:40 INFO - mozscreenshot == 0.1 08:11:40 INFO - mozsystemmonitor == 0.0 08:11:40 INFO - moztest == 0.7 08:11:40 INFO - mozversion == 1.4 08:11:40 INFO - psutil == 3.1.1 08:11:40 INFO - requests == 1.2.3 08:11:40 INFO - wsgiref == 0.1.2 08:11:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:11:40 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')]} 08:11:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:11:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:40 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')]} 08:11:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:11:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:40 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 0x10ec87490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec64228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f918ae48ba0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ebab9f0>, '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 0x10e90adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10eb9e8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.F1wz69HD9j/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.HzbVF8jZEa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:11:40 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 08:11:40 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 08:11:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.F1wz69HD9j/Render', 08:11:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:11:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:11:40 INFO - 'HOME': '/Users/cltbld', 08:11:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:11:40 INFO - 'LOGNAME': 'cltbld', 08:11:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:11:40 INFO - 'MOZ_NO_REMOTE': '1', 08:11:40 INFO - 'NO_EM_RESTART': '1', 08:11:40 INFO - 'PAGER': '/bin/cat', 08:11:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:11:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:11:40 INFO - 'PWD': '/builds/slave/test', 08:11:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:11:40 INFO - 'SHELL': '/bin/bash', 08:11:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HzbVF8jZEa/Listeners', 08:11:40 INFO - 'TMPDIR': '/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/', 08:11:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:11:40 INFO - 'USER': 'cltbld', 08:11:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:11:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:11:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:11:40 INFO - 'XPC_FLAGS': '0x0', 08:11:40 INFO - 'XPC_SERVICE_NAME': '0', 08:11:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 08:11:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:11:40 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)) 08:11:40 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)) 08:11:40 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)) 08:11:40 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)) 08:11:40 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)) 08:11:40 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)) 08:11:40 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)) 08:11:40 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)) 08:11:40 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)) 08:11:40 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)) 08:11:40 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)) 08:11:40 INFO - Cleaning up... 08:11:40 INFO - Return code: 0 08:11:40 INFO - Running post-action listener: _resource_record_post_action 08:11:40 INFO - Running post-action listener: _start_resource_monitoring 08:11:40 INFO - Starting resource monitoring. 08:11:40 INFO - ##### 08:11:40 INFO - ##### Running install step. 08:11:40 INFO - ##### 08:11:40 INFO - Running pre-action listener: _resource_record_pre_action 08:11:40 INFO - Running main action method: install 08:11:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:11:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:11:41 INFO - Reading from file tmpfile_stdout 08:11:41 INFO - Detecting whether we're running mozinstall >=1.0... 08:11:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:11:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:11:41 INFO - Reading from file tmpfile_stdout 08:11:41 INFO - Output received: 08:11:41 INFO - Usage: mozinstall [options] installer 08:11:41 INFO - Options: 08:11:41 INFO - -h, --help show this help message and exit 08:11:41 INFO - -d DEST, --destination=DEST 08:11:41 INFO - Directory to install application into. [default: 08:11:41 INFO - "/builds/slave/test"] 08:11:41 INFO - --app=APP Application being installed. [default: firefox] 08:11:41 INFO - mkdir: /builds/slave/test/build/application 08:11:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 08:11:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 08:12:18 INFO - Reading from file tmpfile_stdout 08:12:18 INFO - Output received: 08:12:18 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 08:12:18 INFO - Running post-action listener: _resource_record_post_action 08:12:18 INFO - ##### 08:12:18 INFO - ##### Running run-tests step. 08:12:18 INFO - ##### 08:12:18 INFO - Running pre-action listener: _resource_record_pre_action 08:12:18 INFO - Running main action method: run_tests 08:12:18 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:12:18 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:12:18 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:12:18 INFO - 2015-11-18 08:12:18.911 screenresolution[1619:7881] starting screenresolution argv=screenresolution get 08:12:18 INFO - 2015-11-18 08:12:18.914 screenresolution[1619:7881] Display 0: 1600x1200x32@60 08:12:18 INFO - 2015-11-18 08:12:18.921 screenresolution[1620:7883] starting screenresolution argv=screenresolution list 08:12:18 INFO - Available Modes on Display 0 08:12:18 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:12:18 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:12:18 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:12:18 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:12:19 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:12:19 INFO - Intel HD Graphics 3000: 08:12:19 INFO - Chipset Model: Intel HD Graphics 3000 08:12:19 INFO - Type: GPU 08:12:19 INFO - Bus: Built-In 08:12:19 INFO - VRAM (Total): 512 MB 08:12:19 INFO - VRAM (Dynamic, Max): 10 08:12:19 INFO - Vendor: Intel (0x8086) 08:12:19 INFO - Device ID: 0x0116 08:12:19 INFO - Revision ID: 0x0009 08:12:19 INFO - Displays: 08:12:19 INFO - Display: 08:12:19 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:12:19 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:12:19 INFO - Display Serial Number: 1600x1200 60 08:12:19 INFO - Main Display: Yes 08:12:19 INFO - Mirror: Off 08:12:19 INFO - Online: Yes 08:12:19 INFO - Rotation: Supported 08:12:19 INFO - Return code: 0 08:12:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:12:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:12:19 INFO - Python 2.7.3 08:12:19 INFO - Return code: 0 08:12:19 INFO - grabbing minidump binary from tooltool 08:12: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')]} 08:12:19 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 0x10ebab9f0>, '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 0x10e90adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10eb9e8c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:12:19 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 08:12:19 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 08:12:19 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:12:19 INFO - Return code: 0 08:12:19 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:12:19 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:12:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:12:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:12:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:12:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RBAZ_rkYSWmHDaun07unzA/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0050', '--webServer', 'localhost'] in /builds/slave/test/build 08:12:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/RBAZ_rkYSWmHDaun07unzA/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0050 --webServer localhost 08:12:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.F1wz69HD9j/Render', 08:12:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:12:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:12:19 INFO - 'HOME': '/Users/cltbld', 08:12:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:12:19 INFO - 'LOGNAME': 'cltbld', 08:12:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:12:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:12:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:12:19 INFO - 'MOZ_NO_REMOTE': '1', 08:12:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:12:19 INFO - 'NO_EM_RESTART': '1', 08:12:19 INFO - 'PAGER': '/bin/cat', 08:12:19 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:12:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:12:19 INFO - 'PWD': '/builds/slave/test', 08:12:19 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:12:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:12:19 INFO - 'SHELL': '/bin/bash', 08:12:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HzbVF8jZEa/Listeners', 08:12:19 INFO - 'TMPDIR': '/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/', 08:12:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:12:19 INFO - 'USER': 'cltbld', 08:12:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:12:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:12:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:12:19 INFO - 'XPC_FLAGS': '0x0', 08:12:19 INFO - 'XPC_SERVICE_NAME': '0', 08:12:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 08:12:19 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RBAZ_rkYSWmHDaun07unzA/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0050', '--webServer', 'localhost'] with output_timeout 3600 08:12:19 INFO - mozversion INFO | application_buildid: 20151118062325 08:12:19 INFO - mozversion INFO | application_changeset: 44f58c7fc121e68854da500798ef84c0f432a32a 08:12:19 INFO - mozversion INFO | application_display_name: Nightly 08:12:19 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:12:19 INFO - mozversion INFO | application_name: Firefox 08:12:19 INFO - mozversion INFO | application_remotingname: firefox 08:12:19 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 08:12:19 INFO - mozversion INFO | application_vendor: Mozilla 08:12:19 INFO - mozversion INFO | application_version: 45.0a1 08:12:19 INFO - mozversion INFO | platform_buildid: 20151118062325 08:12:19 INFO - mozversion INFO | platform_changeset: 44f58c7fc121e68854da500798ef84c0f432a32a 08:12:19 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 08:12:19 INFO - mozversion INFO | platform_version: 45.0a1 08:12:19 INFO - 2015-11-18 08:12:19,597 DEBUG : using testdate: 1447863139 08:12:19 INFO - 2015-11-18 08:12:19,597 DEBUG : actual date: 1447863139 08:12:19 INFO - 2015-11-18 08:12:19,613 INFO : starting webserver on 'localhost:49272' 08:12:19 INFO - 2015-11-18 08:12:19,614 INFO : Starting test suite t-yosemite-r5-0050 08:12:19 INFO - 2015-11-18 08:12:19,614 INFO : Starting test dromaeo_css 08:12:19 INFO - 2015-11-18 08:12:19,614 DEBUG : operating with platform_type : mac_ 08:12:19 INFO - 2015-11-18 08:12:19,615 INFO : Initialising browser for dromaeo_css test... 08:12:19 INFO - 2015-11-18 08:12:19,636 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/tmpIG9Qny/profile http://localhost:49272/getInfo.html 08:12:23 INFO - 2015-11-18 08:12:23,581 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 08:12:23 INFO - 2015-11-18 08:12:23,581 DEBUG : BROWSER_OUTPUT: colorDepth:24 08:12:23 INFO - 2015-11-18 08:12:23,581 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 08:12:23 INFO - 2015-11-18 08:12:23,581 DEBUG : BROWSER_OUTPUT: __metrics 08:12:23 INFO - 2015-11-18 08:12:23,600 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:12:24 INFO - 2015-11-18 08:12:24,340 INFO : Browser initialized. 08:12:24 INFO - 2015-11-18 08:12:24,340 INFO : Running cycle 1/1 for dromaeo_css test... 08:12:24 INFO - 2015-11-18 08:12:24,340 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/tmpIG9Qny/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 08:12:36 INFO - 2015-11-18 08:12:36,366 DEBUG : BROWSER_OUTPUT: RSS: Main: 229924864 08:12:36 INFO - 2015-11-18 08:12:36,366 DEBUG : BROWSER_OUTPUT: 08:13:27 INFO - 2015-11-18 08:13:27,733 DEBUG : BROWSER_OUTPUT: 1447863207730 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] 08:15:37 INFO - 2015-11-18 08:15:37,762 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49272/tests/dromaeo/cssquery-ext.html) 08:15:39 INFO - 2015-11-18 08:15:39,128 DEBUG : BROWSER_OUTPUT: RSS: Main: 335745024 08:15:39 INFO - 2015-11-18 08:15:39,128 DEBUG : BROWSER_OUTPUT: 08:18:41 INFO - 2015-11-18 08:18:41,860 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-ext.html (next: http://localhost:49272/tests/dromaeo/cssquery-jquery.html) 08:18:42 INFO - 2015-11-18 08:18:42,442 DEBUG : BROWSER_OUTPUT: RSS: Main: 377884672 08:18:42 INFO - 2015-11-18 08:18:42,443 DEBUG : BROWSER_OUTPUT: 08:21:44 INFO - 2015-11-18 08:21:44,755 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49272/tests/dromaeo/cssquery-mootools.html) 08:21:45 INFO - 2015-11-18 08:21:45,339 DEBUG : BROWSER_OUTPUT: RSS: Main: 337235968 08:21:45 INFO - 2015-11-18 08:21:45,339 DEBUG : BROWSER_OUTPUT: 08:24:47 INFO - 2015-11-18 08:24:47,373 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49272/tests/dromaeo/cssquery-prototype.html) 08:24:47 INFO - 2015-11-18 08:24:47,954 DEBUG : BROWSER_OUTPUT: RSS: Main: 325107712 08:24:47 INFO - 2015-11-18 08:24:47,955 DEBUG : BROWSER_OUTPUT: 08:27:51 INFO - 2015-11-18 08:27:51,259 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49272/tests/dromaeo/cssquery-yui.html) 08:27:51 INFO - 2015-11-18 08:27:51,854 DEBUG : BROWSER_OUTPUT: RSS: Main: 332922880 08:27:51 INFO - 2015-11-18 08:27:51,855 DEBUG : BROWSER_OUTPUT: 08:30:54 INFO - 2015-11-18 08:30:54,633 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-yui.html (next: http://localhost:49272/tests/dromaeo/cssquery-dojo.html) 08:30:54 INFO - 2015-11-18 08:30:54,890 DEBUG : BROWSER_OUTPUT: RSS: Main: 399319040 08:30:54 INFO - 2015-11-18 08:30:54,890 DEBUG : BROWSER_OUTPUT: 08:30:54 INFO - 2015-11-18 08:30:54,890 DEBUG : BROWSER_OUTPUT: __start_tp_report 08:30:54 INFO - 2015-11-18 08:30:54,891 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 08:30:54 INFO - 2015-11-18 08:30:54,891 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 08:30:54 INFO - 2015-11-18 08:30:54,891 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 08:30:54 INFO - 2015-11-18 08:30:54,892 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3068.846557672116;3133.7493000559957;3174.285785698217;3176.221825652714;3196.248881512845;4889.144399730051;4896.045271172123;5175.611829112818;5186.377634683839;5262.315898933138;4959.504049595039;5023.874403139924;5148.48515148485;5165.81919632813;5222.3472065991755;4622.699524530912;4764.285357196413;4782.569568738812;4787.856364309059;4851.054044461332;4707.976460117695;4735.502772208903;4760.642951778613;4878.4145902491755;4904.48502907195;4868.9269660955115;4871;4874.561289483946;4886.071646387193;4939.506049395068;4711.575958163748;4821.445533763609;4822.590079843218;4858.732769697665;4906.460289368167;4750.50119737426;4777.641676874248;4792.664513484057;4795.640326975491;4888.242322440027;4954.603631709455;5017.7491125443585;5051.390327463938;5135.998480296344;5147.922781158286;5063.443021267658;5183.170692689189;5200.271961925334;5280.498352656491;5420.051490989101;5362.115250983583;5439.972800136014;5454.563634909197;5498.202760599731;5521.613487055908;5112.437631860493;5124.743762811881;5135.229715542699;5149.794008239628;5190.948090519047;5302.867428314323;5397.460253974571;5449.863753406117;5457.918131228034;5519.530839878575;5300.575953923677;5312;5313.707746074003;5331.200319952039;5362.865928351823;5441.619086663895;5447.509724124848;5478.643888147258;5558.055130627803;5575.0522411190195;5236.450172731885;5311.309529761106;5368.087425137736;5402.540784033401;5404.486573775485;5273.419923808378;5364.980653675789;5380.569554435636;5451.563874889999;5455.61810673257;4172.248995180897;4181.832726690959;4222.155568886235;4280.828766849353;4324.545922678137;3726.4037753959237;3771.4719939208535;3823.2162406706557;3841.058940559525;3931.1941052084253;5108.259302401206;5108.335916330853;5109.233614957711;5121.795128194831;5203.19350500673;5446;5471.534919531884;5473.808416705396;5513.779448822002;5564.415736347706;4965.280034395065;5004.949950500449;5093.286939828427;5120.18077107661;5128.051310507568;4664.207084795593;4714.22215334466;4810.062037902645;4811.759412029384;4871.074495845778;5459.945400545944;5497.47773961473;5568.693721845338;5573.526250268773;5574.052411090124;5230.555402790806;5324.893502130013;5370.62405631602;5372.221027950847;5426.430224826494;5615.803446879339;5640.943590564042;5660.971695141498;5662.688552129673;5680.744366503434;5424.53891419218;5436.7553460093595;5441.755121019484;5447.891042179055;5503.091989821794;5169.147090729987;5210.1142805723875;5240.7641656126325;5341.038613049688;5628.4090170533145;5394.298741163623;5399.163129714901;5421.566274698093;5422.9186562202385;5451.155070964007;5349;5361.571074313967;5362.0616392132;5436.0486914790545;5469.206964990134;5022.271770593316;5065.620078494054;5138.203578445347;5187.1181899078;5269.4730526947;4963.5780958618925;5181.222816577543;5190.658411371166;5209.244659524424;5320.680759154463;5217.50433708797;5219.5041471060185;5273.077211488051;5280.20796880471;5288.3918349390315 08:30:54 INFO - 2015-11-18 08:30:54,896 DEBUG : BROWSER_OUTPUT: |1;ext.html;548.9862753431162;561.9072852979257;564.0495764636586;568.1676344155811;573.4437595532332;29854.402911941776;30516.542251866213;30743.69256307436;30773.38453230934;31170.376592468165;38500.42249366262;38610;38709.225815483675;38757.80621096898;39325;8982.236509896651;9099.63601455941;9140.497272650035;9167.404118732295;9189.816203675922;8194.139615340393;8261.13258107899;8907.331950103735;8935.508547029911;8937.955310223473;10918;10965.232433729641;10989.175811814106;11096.722581935475;11104.61133860315;10560;10612.62855800051;10722.517486713117;10795.784084318348;10873.456327183689;8197.098319184885;8273.958630206871;10530.10494107994;10783.676489705322;10914.454277286104;37142;37256;37433.62566374329;37446.43830342547;37933.81033094817;2988.193187839271;3003.714647108521;3088.83011434371;3267.5098735189913;3507.7722797021092;26735.331616709544;28178.85910570434;28553.28616784597;29393.412131757457;30646.84676576625;2326.546323466908;2362.14962613459;2367.9526409471887;2369.9526009479887;2396.4727759892794;275022;278642;283022;283225;283623;55109.724451377486;55144.724276379166;59592.40407595955;59698.10452843211;59957.40042599606;63967;64110.679446603404;65553.67223163854;65609;65610;15699.136547489998;15881;15941.282642281125;15980.280887359864;16061.759073613905;12129.45417456199;12156.878431215751;12214.145009849226;12308.50765969369;12353.073519486075;19230.519885301084;19498.979698748935;19577.902110489642;19610.901945490466;19618.019099044992;8529.445586036887;8545.700900468453;8602.440841345293;8694.087120852346;8788.583139636523;881.6341218394294;949.0082863407755;956.6842941829319;960.4189465373488;966.5457235099492;27110.864445677646;27517;30845.84577077145;31174.68825311718;31815.363692726016;959.8704174936433;1027.024326889458;1041.6041904076403;1045.4511381524608;1103.7626910214342;13816.37826297819;14240.359183836752;14356.49752258666;16109;16458.341666333454;399440;407218;407679;408885;410136;54986;55241;55276.723616382464;55319.446805532236;55399;1382.5506710319187;1388.5834249725042;1402.0536138106534;1405.3816320818808;1408.5703860322494;29143.708562914948;30052.69947300499;31067.378652427276;31364.529532056582;31504.684953150176;49611.503884962134;50761.492385075675;50784;50790.74604626953;50847;281009;295002;298958;366156;382264;37301.81349093237;37738.62261377461;38189.2362152761;38266.6173338263;38406;39624.80187599044;40530.136383634155;42679.146417070864;42766.35850462308;42797;35738.64261357457;36094.278114438086;36654.81672591727;36937.81531092327;37149.81425092965;28208.85895570509;36616.81691591525;36739.44890826693;37623;38621.4206786904;34281.65718342884;34524.48213276752;35005.824970876005;35315;35519.822400888865;29357;30593.23516912095;30636;30768.230794230323;30843.69156308408;23339.53320933606;23494.530109397376;23530.17644382507;23611;23706.05175792949 08:30:54 INFO - 2015-11-18 08:30:54,897 DEBUG : BROWSER_OUTPUT: |2;jquery.html;334.4581777520417;336.43814829235174;337.5021842781899;339.2096415352229;340.93692666856623;14203.863690904729;14698.559043228694;16493.340266389347;16519;17356.30574777009;13015.479380824756;18210.635787284245;18262.80846298446;18459.630807383877;18748.250069997182;5417.864553386157;5643.5203007744185;5655.886882262353;5695.458931401531;5698;3954.584768599299;4178.997040710223;5514.889702205954;5569.192467092269;5989.88020239595;5928.940710592904;6103.542234332421;6129.509639228873;6196.16351792509;6213.378662133796;4366.257736184856;4521.773911304422;4527.524609915978;4585.679002469828;6122.54080943931;3826.598207188233;3846.2692088503095;3846.4038074098557;3846.7307288489815;3877.243937432202;11597;11829.171957962946;11930.761384772342;11959.820602690967;12155.392230388534;1664.1595994023062;1767.7083281258706;1812.7552780374613;1825;1887.5564242403025;8832.160944710307;8841.646334146626;9017.098290170996;9056.275932315108;9090.318226133066;1467.2810322941682;1486.3237227061768;1523.2612183091192;1553.8446155384484;1615.9111248881306;54940.72529637366;57082.429175708545;57341.42658573403;57805.710971444874;57898;6152.630842149485;6167.105769663373;6177.505799536027;6203.534734894811;6219.720112594944;7018.824529386806;7027.086478757728;7029;7034.507584469038;7045.612491312924;5040.36995375578;5067.417247016567;5151.201563757623;5326.493983071602;5340.813071542478;5664.291963504562;5717.342505611825;5734.311882574035;5825.456254092669;5828.941710582924;2722.7413395727376;2728.4815884982186;2748.5877118431995;2753.435545713164;2782.916512504628;931.1759093202564;933.1927882381826;951.5908159491347;977.9780129764413;1038.0864838941684;364.764726751244;384.25454618040914;402.4607026584391;413.6318676378026;445.30087762213014;10302.278840481094;10690.51892664832;11003.449827508754;11053.668389948314;11180.888191117985;378.7481324918898;415.7858702768077;428.76632235431765;436.53290978652535;443.79585390719984;5613.298337707786;5986;6004.54965877561;6037;6041.395860413923;539419;547734;549833;551515;558015;64107.35892641107;64463.67768161129;65547;65618.34381656218;67481;453.0350353746499;463.5318328488251;464.3104989091264;468.3583490617875;471.547314578009;10037.648682296085;10093.293469457067;10099.343542669703;10239.48802559884;10286.742831429274;31270.374592507567;31283.53074703927;31428;31760;32255.35489290248;44363.77818111018;44502.55497445114;44747.55252447434;45135.32297015482;45768.77115614401;5721.914171287517;5782.624129431573;5788.797392091256;5813.651180929158;5849.736761845812;10288.228382871164;10653.89346106529;11008.614698485515;11011.394373309546;11242.831357529807;8936.151065648754;9333.673321433716;9436.056394360508;9633;9752.609895604097;9163.587638556415;9364.344495885223;9436;9446.38598491096;9591.184749296388;9648.565814538222;9755.756106097404;9880.851787223053;9959.253056020683;10007.09936105754;5186.429492755869;5228.686278823283;5341.065313570188;5598.048331783525;13985.650358741113;13630.454781808616;14557.490487832874;15211.695766084838;15296.847031529542;15310.004849684736 08:30:54 INFO - 2015-11-18 08:30:54,900 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1373.395705889408;1382.5299398204609;1519.3618680154334;1673.2219517924163;1759.9120043997805;6295.968520157404;6680.86638267235;7025.473089518287;7116.5018448708615;7132.3580877721;6836.82907927302;6948.513604047719;6973.337532934376;6976.581405115697;7023.2625574314725;2017.3645301729982;2025.8480613953939;2033.613613413454;2036.725042119317;2052.0663098290315;2081.6669332906736;2086.582683463306;2129.7124888140133;2183.984447232037;2186.1364760919428;2040.081963116596;2049.477383267265;2051.897405129745;2061.0828181459256;2075.6056349293663;2068.369147410039;2093.591749608827;2098.318046634842;2114.1754715660904;2115.6509175985943;2000.3898810862681;2034.2269937423832;2041.6733322668451;2048.129544943408;2056.856020078595;6164.84587885302;6298.275698294663;6891.345322194384;6900.102986611759;6944.097267355211;4173.937390939138;4302.118065796504;4354.063876266586;4359.564043595647;4373.978130109329;2533.4173140177677;2538.352720056374;2539.3143851160266;2576.458943621823;2583.2379448062866;817.7937542125377;844.851002636414;859.9441036332681;869.7043005378139;870.2994089757742;8799.384043116985;8811.559422028873;8814.911850881474;8874.245689116433;8935.64257429702;3774.7735135891935;3790.9431358529646;3850.364689826203;3855.2867719471988;3857.4985251917633;7953.602319883983;7953.801154971172;8026.317762990095;8056.39577031725;8080.8383832323025;4321.783910804447;4341.804618792162;4358.389825424443;4364.367166760802;4424.0709451015;3941.5664276929515;3987.9003024924027;3988.12261302513;3989.4215338775716;4004.8598299059395;3131.5772370730115;3135.639401468815;3166.683331666815;3180.0459862041757;3211.309568442796;1028.4703377760459;1032.2670903658336;1035.7876635289747;1046.8639076920103;1048.695878195315;977.130353984954;982.9017098290257;1219.9268043917393;1277.3932382118605;1296.9870301296867;6408.03879418091;6469.256035555877;6491.091247225392;6595.0766892635065;6627.668616569153;410.3106780608606;411.05867563279753;415.14687317562095;416.71038628153747;443.42576363609203;4983.750812459362;5195.948040519622;5212.739363031833;5219.556337711261;5275.155975044051;7239.312265334785;7442.516236444722;7483.775486735407;7698.615069246515;8204;7873.133955264916;7987.400944929037;8000.079990801132;8004.199580041949;8080.474769139987;6342.365763423621;6511.3163117871945;6565.67171641416;6588.11060506835;6594.7032383542855;6530.151080359523;6544.705488253136;6553.5084868634085;6570;6577.473802095725;7073.752418665322;7255.274472552703;7378.114626244885;7457.552546847207;7476.738314158978;7403.037605111301;7622.885656715042;7640.503367281109;7647.120581133241;7694.692212311445;6126.663033533198;6128.417800308964;6168.1056246844855;6184.690765461799;6297.244330680348;6676.599404035774;6704.865902682017;6709.295523970108;6780.1524809398825;6799.150106236721;6154.846128846635;6217.875642487215;6346.111544383698;6429.6142231466265;6458.967705161444;6083.513318934386;6157.507399407947;6215.689215539295;6294.464970477561;6382.808515744535;6325.96837015812;6352.237731472253;6374.872502549831;6414.679266036773;6436.967815160894;5823.039198532195;5853.414658534112;5884.029135192645;5885.823425297248;5887.941120588739;5347.973260133675;5473.589480788877;5534.363548191848;5599.216109744558;5877.970610146922 08:30:54 INFO - 2015-11-18 08:30:54,901 DEBUG : BROWSER_OUTPUT: |4;prototype.html;299.4998352750906;309.8899890538858;313.8822941396976;320.3097325264054;326.56566766200956;6182.567220294575;6198.56610037297;6270;6297.905531417033;6300.117983482305;5946.435088666581;6087.573869829113;6189.350118237588;6194.535409844257;6286.842828929268;4830.2030165022725;4853.757312134388;4854.757262136896;4856.6357523185725;4883.560479556839;4686.320483529903;4829.661923665345;4832.444268909086;4850.466448690641;4899.632527560448;4626.583607475327;4714.50497697742;4767.666263361566;4801.2798080287885;4843.418789745236;4766.451858036301;4783.760811959423;4797.208460603996;4802.375691160162;4813.951860481386;4109.465769449952;4111.650509706648;4138.13099249158;4150.813213405374;4179.1014931789505;5864.530837532987;6051.364606716275;6051.818445446644;6097.817065488042;6153.846153846145;5147.047796157723;5258.39528454225;5347.25138480613;5355.437679043722;5357.624966252364;6421.197350331208;6440;6467.967660161669;6514.674266286715;6518.250401203827;4387.122575484884;4388;4393;4412.580804823537;4491.595756381941;6532.281449040602;6768.830779230559;6832.93167068328;6837.487188460836;6921.723131074751;4371.344298355209;4382.189294980439;4392.121575684876;4402.185595664812;4439.689221754446;4445.222086134913;4460.836494300262;4475.865724028285;4491.393661855608;4491.8203271869415;5195.610329225247;5203.5576975957465;5218.086834803894;5228.424873263938;5237.973810130925;6338.714757835908;6516.380943810331;6533.411992920564;6578.473722102221;6593.274739778621;1544.088987497382;1556.5719427157396;1566.2873392606336;1566.3108232377717;1566.7884835547284;996.950152492387;1000.5247507434057;1009.5810238750983;1015.8577799108131;1019.8317277649253;6223.377662233831;6263.342349053284;6269.341719119427;6276.811695649138;6293.2762732285455;6465.612063276219;6816.522843400914;6827.726890924407;6862.210845752802;6867.3476019778045;6099.603525770811;6163.722632481549;6303.3066362700065;6311.558190926683;6325.367463253638;3619.638036196412;3664.7984360859878;3689.3543629864666;3717.9442308365396;3739.046543131484;6865.347791959756;7018.157821061505;7019.403350715246;7064.364207221375;7122.608256545836;6945.236024037352;6990.09128813251;6995.755148569776;7031.542949708252;7110.431165506747;7080.6105664187935;7086.149662040588;7133.750318738923;7134.036905017756;7260.854782904418;6677.499187561049;6889.965550172217;6892.758753443605;6945.0971373721095;6967.930320696931;6734.292899245509;6743.224529179011;6773.864522709617;6831.658417079226;6867.828304292233;7027.147638527334;7132.358087772125;7140.107486564179;7189.496735228484;7190.209077001421;4454.7549884756645;4478.507364190002;4514.841980530666;4516.1419330327135;4529.501754806903;6823.795286141423;6846.623435711083;6862.073620061228;6891.965540172468;6972.1284839395075;6479.222493300834;6646.534742567974;6654.667266636746;6657.167854018247;6737.966310168418;6401.3598640135615;6626.138601981712;6630.668466576555;6645.568038077509;6666.366695163952;6359.268684101387;6421.454176395058;6422.197225346832;6432.35676432353;6525.7063432146615;6414.358564143548;6615.17310336208;6631.403173714196;6666.2333831609985;6698.966505167443;6468.676566171766;6487.221533415832;6498.480121590167;6501.284858665637;6514 08:30:54 INFO - 2015-11-18 08:30:54,904 DEBUG : BROWSER_OUTPUT: |5;yui.html;674.5109795398336;714.4820005496015;746.3879618712658;748.5770539645104;756.7237958145279;13839.238841863693;14016.579502614924;14040.508582199613;14048.64878378041;14070.507532236374;13836.308184590755;14311.212883291415;14316.35576399062;14452.277386130703;14545.054571452849;665.6771465839064;818.4475479051646;851.7615067781031;866.0257210638001;867.6832955971057;688.6797639097819;849.5667209723024;851.6082602003055;855.5679381912157;870.6256309786789;850.7660393391836;879.0462348352046;881.0352663833092;888.9866652000226;893.0935100872587;688.2738710660251;694.6839188169371;875.7372788163557;876.7106854737921;879.8944126704837;642.2581917884851;644.6100109433772;649.9870002599969;650.5381179362658;658.4995403493332;13280.402381892742;13287.335633218398;13290.3354832258;13369.799453008212;13504.189748615016;8810.86783698245;8889.19997200255;9010.45937243761;9142;9368.57841397132;8869.733907982707;8898.154675305836;8962.259440133446;8964;9048.909510904872;2749.3951330707414;2763.6130941668184;2822.280318518785;2850.5296626056675;2896.884124635012;45537.772311138564;45838.31242531365;45936.3109553357;45994.31008534875;46051.76974115142;6112.510999120149;6115.052166914135;6183.319834818167;6211.751529938751;6371.331010243857;10228.232882533839;10309.484525773682;10342.069213770797;10351.741206469898;10453.634122805664;5780.248567686258;5843.03589907669;5856.180134781134;5870.911936320958;6232.158658581034;3780.6030366811638;3804.1472586002387;3877.2439374321734;3908.5895980921596;3913.8043097844993;2381.1189859752003;2408.9518209636058;2415;2418.2986933789;2422.5397174536783;340.56067672701937;346.35059263880225;347.695766204571;349.85306171407564;356.71641045368995;477.60836114386564;523.7250443517185;562.1848319936109;569.831899589622;595.184597101973;7002.229754726976;7331.8533629328185;7459.8508029839095;7534.924650753532;7832.334251588679;566.1931747260138;583.125312031952;585.745200837637;586.2759492027428;600.3186383454723;3321.7045352312616;3610.151614370621;3642.617525159873;3692.2430901665093;3737.2338670572467;59235.11147332793;59758.103628445606;59809.70095149496;59819.401805982256;59820.10269845956;50201;51386.48613513892;51692;51865;52059;45214.77392613016;45445;45472.77263613727;45960;46674.29988550174;7209;7222.89165662526;7372.447066469929;7517.248275172439;7527.698892044257;34508.48237276392;34743.65256347505;34985.47521787226;35030.29939401147;35852;42531.78734106434;42632.5736742641;43249.78375108104;45630;47306.29040564463;6895.6552172392185;7062.858742825012;7068.611226382598;7098.751543695946;7235.529690570096;11058.248044094069;11159.944200278947;11246.775064498828;11279.236587036228;11496.94251528737;10406.895931040593;10532.526036328536;10761.5392635328;10878.129749619853;10936.12510999134;10173.96544597013;10397.532111055172;10398.636047738293;10817.945910270399;10935.671929842118;10456.529456174338;10701.946490267499;10766.569337226736;11037.613683521038;11058.11535077208;8867.822643546964;9181.632734690538;9187.127222913812;9258.583363748783;9553.61785528571;9171.678991235274;9228.492432916253;9234.307426942873;9368.34421590482;9371.109744574254 08:30:54 INFO - 2015-11-18 08:30:54,904 DEBUG : BROWSER_OUTPUT: __end_tp_report 08:30:54 INFO - 2015-11-18 08:30:54,905 DEBUG : BROWSER_OUTPUT: __start_cc_report 08:30:54 INFO - 2015-11-18 08:30:54,905 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1130 08:30:54 INFO - 2015-11-18 08:30:54,905 DEBUG : BROWSER_OUTPUT: __end_cc_report 08:30:54 INFO - 2015-11-18 08:30:54,905 DEBUG : BROWSER_OUTPUT: __startTimestamp1447864254889__endTimestamp 08:30:54 INFO - 2015-11-18 08:30:54,905 DEBUG : BROWSER_OUTPUT: 08:30:54 INFO - 2015-11-18 08:30:54,905 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 08:30:54 INFO - 2015-11-18 08:30:54,906 DEBUG : BROWSER_OUTPUT: Number of tests: 6 08:30:54 INFO - 2015-11-18 08:30:54,906 DEBUG : BROWSER_OUTPUT: 08:30:54 INFO - 2015-11-18 08:30:54,906 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5074.90 Median:5200.27 stddev:511.29 (9.8%) stddev-sans-first:488.04 08:30:54 INFO - 2015-11-18 08:30:54,906 DEBUG : BROWSER_OUTPUT: Values: 3068.8 3133.7 3174.3 3176.2 3196.2 4889.1 4896.0 5175.6 5186.4 5262.3 4959.5 5023.9 5148.5 5165.8 5222.3 4622.7 4764.3 4782.6 4787.9 4851.1 4708.0 4735.5 4760.6 4878.4 4904.5 4868.9 4871.0 4874.6 4886.1 4939.5 4711.6 4821.4 4822.6 4858.7 4906.5 4750.5 4777.6 4792.7 4795.6 4888.2 4954.6 5017.7 5051.4 5136.0 5147.9 5063.4 5183.2 5200.3 5280.5 5420.1 5362.1 5440.0 5454.6 5498.2 5521.6 5112.4 5124.7 5135.2 5149.8 5190.9 5302.9 5397.5 5449.9 5457.9 5519.5 5300.6 5312.0 5313.7 5331.2 5362.9 5441.6 5447.5 5478.6 5558.1 5575.1 5236.5 5311.3 5368.1 5402.5 5404.5 5273.4 5365.0 5380.6 5451.6 5455.6 4172.2 4181.8 4222.2 4280.8 4324.5 3726.4 3771.5 3823.2 3841.1 3931.2 5108.3 5108.3 5109.2 5121.8 5203.2 5446.0 5471.5 5473.8 5513.8 5564.4 4965.3 5004.9 5093.3 5120.2 5128.1 4664.2 4714.2 4810.1 4811.8 4871.1 5459.9 5497.5 5568.7 5573.5 5574.1 5230.6 5324.9 5370.6 5372.2 5426.4 5615.8 5640.9 5661.0 5662.7 5680.7 5424.5 5436.8 5441.8 5447.9 5503.1 5169.1 5210.1 5240.8 5341.0 5628.4 5394.3 5399.2 5421.6 5422.9 5451.2 5349.0 5361.6 5362.1 5436.0 5469.2 5022.3 5065.6 5138.2 5187.1 5269.5 4963.6 5181.2 5190.7 5209.2 5320.7 5217.5 5219.5 5273.1 5280.2 5288.4 08:30:54 INFO - 2015-11-18 08:30:54,906 DEBUG : BROWSER_OUTPUT: 08:30:54 INFO - 2015-11-18 08:30:54,906 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:50200.38 Median:34403.07 stddev:90059.54 (261.8%) stddev-sans-first:90235.02 08:30:54 INFO - 2015-11-18 08:30:54,906 DEBUG : BROWSER_OUTPUT: Values: 549.0 561.9 564.0 568.2 573.4 29854.4 30516.5 30743.7 30773.4 31170.4 38500.4 38610.0 38709.2 38757.8 39325.0 8982.2 9099.6 9140.5 9167.4 9189.8 8194.1 8261.1 8907.3 8935.5 8938.0 10918.0 10965.2 10989.2 11096.7 11104.6 10560.0 10612.6 10722.5 10795.8 10873.5 8197.1 8274.0 10530.1 10783.7 10914.5 37142.0 37256.0 37433.6 37446.4 37933.8 2988.2 3003.7 3088.8 3267.5 3507.8 26735.3 28178.9 28553.3 29393.4 30646.8 2326.5 2362.1 2368.0 2370.0 2396.5 275022.0 278642.0 283022.0 283225.0 283623.0 55109.7 55144.7 59592.4 59698.1 59957.4 63967.0 64110.7 65553.7 65609.0 65610.0 15699.1 15881.0 15941.3 15980.3 16061.8 12129.5 12156.9 12214.1 12308.5 12353.1 19230.5 19499.0 19577.9 19610.9 19618.0 8529.4 8545.7 8602.4 8694.1 8788.6 881.6 949.0 956.7 960.4 966.5 27110.9 27517.0 30845.8 31174.7 31815.4 959.9 1027.0 1041.6 1045.5 1103.8 13816.4 14240.4 14356.5 16109.0 16458.3 399440.0 407218.0 407679.0 408885.0 410136.0 54986.0 55241.0 55276.7 55319.4 55399.0 1382.6 1388.6 1402.1 1405.4 1408.6 29143.7 30052.7 31067.4 31364.5 31504.7 49611.5 50761.5 50784.0 50790.7 50847.0 281009.0 295002.0 298958.0 366156.0 382264.0 37301.8 37738.6 38189.2 38266.6 38406.0 39624.8 40530.1 42679.1 42766.4 42797.0 35738.6 36094.3 36654.8 36937.8 37149.8 28208.9 36616.8 36739.4 37623.0 38621.4 34281.7 34524.5 35005.8 35315.0 35519.8 29357.0 30593.2 30636.0 30768.2 30843.7 23339.5 23494.5 23530.2 23611.0 23706.1 08:30:54 INFO - 2015-11-18 08:30:54,908 DEBUG : BROWSER_OUTPUT: 08:30:54 INFO - 2015-11-18 08:30:54,908 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:26519.12 Median:463.92 stddev:89854.47 (19368.5%) stddev-sans-first:90085.02 08:30:54 INFO - 2015-11-18 08:30:54,908 DEBUG : BROWSER_OUTPUT: Values: 334.5 336.4 337.5 339.2 340.9 14203.9 14698.6 16493.3 16519.0 17356.3 13015.5 18210.6 18262.8 18459.6 18748.3 5417.9 5643.5 5655.9 5695.5 5698.0 3954.6 4179.0 5514.9 5569.2 5989.9 5928.9 6103.5 6129.5 6196.2 6213.4 4366.3 4521.8 4527.5 4585.7 6122.5 3826.6 3846.3 3846.4 3846.7 3877.2 11597.0 11829.2 11930.8 11959.8 12155.4 1664.2 1767.7 1812.8 1825.0 1887.6 8832.2 8841.6 9017.1 9056.3 9090.3 1467.3 1486.3 1523.3 1553.8 1615.9 54940.7 57082.4 57341.4 57805.7 57898.0 6152.6 6167.1 6177.5 6203.5 6219.7 7018.8 7027.1 7029.0 7034.5 7045.6 5040.4 5067.4 5151.2 5326.5 5340.8 5664.3 5717.3 5734.3 5825.5 5828.9 2722.7 2728.5 2748.6 2753.4 2782.9 931.2 933.2 951.6 978.0 1038.1 364.8 384.3 402.5 413.6 445.3 10302.3 10690.5 11003.4 11053.7 11180.9 378.7 415.8 428.8 436.5 443.8 5613.3 5986.0 6004.5 6037.0 6041.4 539419.0 547734.0 549833.0 551515.0 558015.0 64107.4 64463.7 65547.0 65618.3 67481.0 453.0 463.5 464.3 468.4 471.5 10037.6 10093.3 10099.3 10239.5 10286.7 31270.4 31283.5 31428.0 31760.0 32255.4 44363.8 44502.6 44747.6 45135.3 45768.8 5721.9 5782.6 5788.8 5813.7 5849.7 10288.2 10653.9 11008.6 11011.4 11242.8 8936.2 9333.7 9436.1 9633.0 9752.6 9163.6 9364.3 9436.0 9446.4 9591.2 9648.6 9755.8 9880.9 9959.3 10007.1 5186.4 5228.7 5341.1 5598.0 13985.7 13630.5 14557.5 15211.7 15296.8 15310.0 08:30:54 INFO - 2015-11-18 08:30:54,909 DEBUG : BROWSER_OUTPUT: 08:30:54 INFO - 2015-11-18 08:30:54,909 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4817.95 Median:6141.63 stddev:2450.50 (39.9%) stddev-sans-first:2443.70 08:30:54 INFO - 2015-11-18 08:30:54,910 DEBUG : BROWSER_OUTPUT: Values: 1373.4 1382.5 1519.4 1673.2 1759.9 6296.0 6680.9 7025.5 7116.5 7132.4 6836.8 6948.5 6973.3 6976.6 7023.3 2017.4 2025.8 2033.6 2036.7 2052.1 2081.7 2086.6 2129.7 2184.0 2186.1 2040.1 2049.5 2051.9 2061.1 2075.6 2068.4 2093.6 2098.3 2114.2 2115.7 2000.4 2034.2 2041.7 2048.1 2056.9 6164.8 6298.3 6891.3 6900.1 6944.1 4173.9 4302.1 4354.1 4359.6 4374.0 2533.4 2538.4 2539.3 2576.5 2583.2 817.8 844.9 859.9 869.7 870.3 8799.4 8811.6 8814.9 8874.2 8935.6 3774.8 3790.9 3850.4 3855.3 3857.5 7953.6 7953.8 8026.3 8056.4 8080.8 4321.8 4341.8 4358.4 4364.4 4424.1 3941.6 3987.9 3988.1 3989.4 4004.9 3131.6 3135.6 3166.7 3180.0 3211.3 1028.5 1032.3 1035.8 1046.9 1048.7 977.1 982.9 1219.9 1277.4 1297.0 6408.0 6469.3 6491.1 6595.1 6627.7 410.3 411.1 415.1 416.7 443.4 4983.8 5195.9 5212.7 5219.6 5275.2 7239.3 7442.5 7483.8 7698.6 8204.0 7873.1 7987.4 8000.1 8004.2 8080.5 6342.4 6511.3 6565.7 6588.1 6594.7 6530.2 6544.7 6553.5 6570.0 6577.5 7073.8 7255.3 7378.1 7457.6 7476.7 7403.0 7622.9 7640.5 7647.1 7694.7 6126.7 6128.4 6168.1 6184.7 6297.2 6676.6 6704.9 6709.3 6780.2 6799.2 6154.8 6217.9 6346.1 6429.6 6459.0 6083.5 6157.5 6215.7 6294.5 6382.8 6326.0 6352.2 6374.9 6414.7 6437.0 5823.0 5853.4 5884.0 5885.8 5887.9 5348.0 5473.6 5534.4 5599.2 5878.0 08:30:54 INFO - 2015-11-18 08:30:54,911 DEBUG : BROWSER_OUTPUT: 08:30:54 INFO - 2015-11-18 08:30:54,911 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5480.64 Median:6273.41 stddev:1696.25 (27.0%) stddev-sans-first:1655.83 08:30:54 INFO - 2015-11-18 08:30:54,911 DEBUG : BROWSER_OUTPUT: Values: 299.5 309.9 313.9 320.3 326.6 6182.6 6198.6 6270.0 6297.9 6300.1 5946.4 6087.6 6189.4 6194.5 6286.8 4830.2 4853.8 4854.8 4856.6 4883.6 4686.3 4829.7 4832.4 4850.5 4899.6 4626.6 4714.5 4767.7 4801.3 4843.4 4766.5 4783.8 4797.2 4802.4 4814.0 4109.5 4111.7 4138.1 4150.8 4179.1 5864.5 6051.4 6051.8 6097.8 6153.8 5147.0 5258.4 5347.3 5355.4 5357.6 6421.2 6440.0 6468.0 6514.7 6518.3 4387.1 4388.0 4393.0 4412.6 4491.6 6532.3 6768.8 6832.9 6837.5 6921.7 4371.3 4382.2 4392.1 4402.2 4439.7 4445.2 4460.8 4475.9 4491.4 4491.8 5195.6 5203.6 5218.1 5228.4 5238.0 6338.7 6516.4 6533.4 6578.5 6593.3 1544.1 1556.6 1566.3 1566.3 1566.8 997.0 1000.5 1009.6 1015.9 1019.8 6223.4 6263.3 6269.3 6276.8 6293.3 6465.6 6816.5 6827.7 6862.2 6867.3 6099.6 6163.7 6303.3 6311.6 6325.4 3619.6 3664.8 3689.4 3717.9 3739.0 6865.3 7018.2 7019.4 7064.4 7122.6 6945.2 6990.1 6995.8 7031.5 7110.4 7080.6 7086.1 7133.8 7134.0 7260.9 6677.5 6890.0 6892.8 6945.1 6967.9 6734.3 6743.2 6773.9 6831.7 6867.8 7027.1 7132.4 7140.1 7189.5 7190.2 4454.8 4478.5 4514.8 4516.1 4529.5 6823.8 6846.6 6862.1 6892.0 6972.1 6479.2 6646.5 6654.7 6657.2 6738.0 6401.4 6626.1 6630.7 6645.6 6666.4 6359.3 6421.5 6422.2 6432.4 6525.7 6414.4 6615.2 6631.4 6666.2 6699.0 6468.7 6487.2 6498.5 6501.3 6514.0 08:30:54 INFO - 2015-11-18 08:30:54,911 DEBUG : BROWSER_OUTPUT: 08:30:54 INFO - 2015-11-18 08:30:54,911 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12962.56 Median:26291.36 stddev:16130.73 (61.4%) stddev-sans-first:16149.59 08:30:54 INFO - 2015-11-18 08:30:54,913 DEBUG : BROWSER_OUTPUT: Values: 674.5 714.5 746.4 748.6 756.7 13839.2 14016.6 14040.5 14048.6 14070.5 13836.3 14311.2 14316.4 14452.3 14545.1 665.7 818.4 851.8 866.0 867.7 688.7 849.6 851.6 855.6 870.6 850.8 879.0 881.0 889.0 893.1 688.3 694.7 875.7 876.7 879.9 642.3 644.6 650.0 650.5 658.5 13280.4 13287.3 13290.3 13369.8 13504.2 8810.9 8889.2 9010.5 9142.0 9368.6 8869.7 8898.2 8962.3 8964.0 9048.9 2749.4 2763.6 2822.3 2850.5 2896.9 45537.8 45838.3 45936.3 45994.3 46051.8 6112.5 6115.1 6183.3 6211.8 6371.3 10228.2 10309.5 10342.1 10351.7 10453.6 5780.2 5843.0 5856.2 5870.9 6232.2 3780.6 3804.1 3877.2 3908.6 3913.8 2381.1 2409.0 2415.0 2418.3 2422.5 340.6 346.4 347.7 349.9 356.7 477.6 523.7 562.2 569.8 595.2 7002.2 7331.9 7459.9 7534.9 7832.3 566.2 583.1 585.7 586.3 600.3 3321.7 3610.2 3642.6 3692.2 3737.2 59235.1 59758.1 59809.7 59819.4 59820.1 50201.0 51386.5 51692.0 51865.0 52059.0 45214.8 45445.0 45472.8 45960.0 46674.3 7209.0 7222.9 7372.4 7517.2 7527.7 34508.5 34743.7 34985.5 35030.3 35852.0 42531.8 42632.6 43249.8 45630.0 47306.3 6895.7 7062.9 7068.6 7098.8 7235.5 11058.2 11159.9 11246.8 11279.2 11496.9 10406.9 10532.5 10761.5 10878.1 10936.1 10174.0 10397.5 10398.6 10817.9 10935.7 10456.5 10701.9 10766.6 11037.6 11058.1 8867.8 9181.6 9187.1 9258.6 9553.6 9171.7 9228.5 9234.3 9368.3 9371.1 08:30:54 INFO - 2015-11-18 08:30:54,913 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 08:30:54 INFO - 2015-11-18 08:30:54,913 DEBUG : BROWSER_OUTPUT: 08:30:55 INFO - 2015-11-18 08:30:55,588 INFO : Browser exited with error code: 0 08:30:55 INFO - 2015-11-18 08:30:55,615 INFO : Completed test dromaeo_css (00:18:36) 08:30:55 INFO - 2015-11-18 08:30:55,615 INFO : Starting test kraken 08:30:55 INFO - 2015-11-18 08:30:55,615 DEBUG : operating with platform_type : mac_ 08:30:55 INFO - 2015-11-18 08:30:55,615 INFO : Initialising browser for kraken test... 08:30:55 INFO - 2015-11-18 08:30:55,628 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/tmpzLGn5T/profile http://localhost:49272/getInfo.html 08:30:57 INFO - 2015-11-18 08:30:57,885 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 08:30:57 INFO - 2015-11-18 08:30:57,885 DEBUG : BROWSER_OUTPUT: colorDepth:24 08:30:57 INFO - 2015-11-18 08:30:57,885 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 08:30:57 INFO - 2015-11-18 08:30:57,887 DEBUG : BROWSER_OUTPUT: __metrics 08:30:57 INFO - 2015-11-18 08:30:57,903 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:30:58 INFO - 2015-11-18 08:30:58,580 INFO : Browser initialized. 08:30:58 INFO - 2015-11-18 08:30:58,580 INFO : Running cycle 1/1 for kraken test... 08:30:58 INFO - 2015-11-18 08:30:58,580 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/tmpzLGn5T/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 08:31:10 INFO - 2015-11-18 08:31:10,513 DEBUG : BROWSER_OUTPUT: RSS: Main: 229322752 08:31:10 INFO - 2015-11-18 08:31:10,513 DEBUG : BROWSER_OUTPUT: 08:31:13 INFO - 2015-11-18 08:31:13,095 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection) 08:31:13 INFO - 2015-11-18 08:31:13,685 DEBUG : BROWSER_OUTPUT: RSS: Main: 285982720 08:31:13 INFO - 2015-11-18 08:31:13,685 DEBUG : BROWSER_OUTPUT: 08:31:16 INFO - 2015-11-18 08:31:16,343 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-dft) 08:31:16 INFO - 2015-11-18 08:31:16,930 DEBUG : BROWSER_OUTPUT: RSS: Main: 298573824 08:31:16 INFO - 2015-11-18 08:31:16,930 DEBUG : BROWSER_OUTPUT: 08:31:19 INFO - 2015-11-18 08:31:19,912 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-fft) 08:31:20 INFO - 2015-11-18 08:31:20,488 DEBUG : BROWSER_OUTPUT: RSS: Main: 282673152 08:31:20 INFO - 2015-11-18 08:31:20,488 DEBUG : BROWSER_OUTPUT: 08:31:22 INFO - 2015-11-18 08:31:22,507 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator) 08:31:23 INFO - 2015-11-18 08:31:23,091 DEBUG : BROWSER_OUTPUT: RSS: Main: 284065792 08:31:23 INFO - 2015-11-18 08:31:23,091 DEBUG : BROWSER_OUTPUT: 08:31:25 INFO - 2015-11-18 08:31:25,281 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:31:25 INFO - 2015-11-18 08:31:25,855 DEBUG : BROWSER_OUTPUT: RSS: Main: 283942912 08:31:25 INFO - 2015-11-18 08:31:25,855 DEBUG : BROWSER_OUTPUT: 08:31:28 INFO - 2015-11-18 08:31:28,898 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom) 08:31:29 INFO - 2015-11-18 08:31:29,482 DEBUG : BROWSER_OUTPUT: RSS: Main: 285011968 08:31:29 INFO - 2015-11-18 08:31:29,482 DEBUG : BROWSER_OUTPUT: 08:31:32 INFO - 2015-11-18 08:31:32,624 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate) 08:31:33 INFO - 2015-11-18 08:31:33,209 DEBUG : BROWSER_OUTPUT: RSS: Main: 285433856 08:31:33 INFO - 2015-11-18 08:31:33,209 DEBUG : BROWSER_OUTPUT: 08:31:36 INFO - 2015-11-18 08:31:36,020 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial) 08:31:36 INFO - 2015-11-18 08:31:36,602 DEBUG : BROWSER_OUTPUT: RSS: Main: 284684288 08:31:36 INFO - 2015-11-18 08:31:36,603 DEBUG : BROWSER_OUTPUT: 08:31:38 INFO - 2015-11-18 08:31:38,229 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:31:38 INFO - 2015-11-18 08:31:38,798 DEBUG : BROWSER_OUTPUT: RSS: Main: 322256896 08:31:38 INFO - 2015-11-18 08:31:38,798 DEBUG : BROWSER_OUTPUT: 08:31:40 INFO - 2015-11-18 08:31:40,656 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:31:41 INFO - 2015-11-18 08:31:41,274 DEBUG : BROWSER_OUTPUT: RSS: Main: 319623168 08:31:41 INFO - 2015-11-18 08:31:41,274 DEBUG : BROWSER_OUTPUT: 08:31:43 INFO - 2015-11-18 08:31:43,376 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:31:43 INFO - 2015-11-18 08:31:43,968 DEBUG : BROWSER_OUTPUT: RSS: Main: 328794112 08:31:43 INFO - 2015-11-18 08:31:43,968 DEBUG : BROWSER_OUTPUT: 08:31:46 INFO - 2015-11-18 08:31:46,550 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:31:47 INFO - 2015-11-18 08:31:47,137 DEBUG : BROWSER_OUTPUT: RSS: Main: 330084352 08:31:47 INFO - 2015-11-18 08:31:47,137 DEBUG : BROWSER_OUTPUT: 08:31:49 INFO - 2015-11-18 08:31:49,765 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:31:50 INFO - 2015-11-18 08:31:50,347 DEBUG : BROWSER_OUTPUT: RSS: Main: 329334784 08:31:50 INFO - 2015-11-18 08:31:50,348 DEBUG : BROWSER_OUTPUT: 08:31:52 INFO - 2015-11-18 08:31:52,095 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49272/tests/kraken/driver.html?testName=ai-astar) 08:31:52 INFO - 2015-11-18 08:31:52,353 DEBUG : BROWSER_OUTPUT: RSS: Main: 387813376 08:31:52 INFO - 2015-11-18 08:31:52,353 DEBUG : BROWSER_OUTPUT: 08:31:52 INFO - 2015-11-18 08:31:52,353 DEBUG : BROWSER_OUTPUT: __start_tp_report 08:31:52 INFO - 2015-11-18 08:31:52,353 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 08:31:52 INFO - 2015-11-18 08:31:52,354 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 08:31:52 INFO - 2015-11-18 08:31:52,354 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 08:31:52 INFO - 2015-11-18 08:31:52,354 DEBUG : BROWSER_OUTPUT: |0;ai-astar;107;108;103;111;110;109;98;107;109;109 08:31:52 INFO - 2015-11-18 08:31:52,354 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;156;133;153;161;127;151;146;136;164;129 08:31:52 INFO - 2015-11-18 08:31:52,354 DEBUG : BROWSER_OUTPUT: |2;audio-dft;160;160;162;162;162;163;164;162;160;161 08:31:52 INFO - 2015-11-18 08:31:52,355 DEBUG : BROWSER_OUTPUT: |3;audio-fft;76;82;86;85;69;70;72;80;81;66 08:31:52 INFO - 2015-11-18 08:31:52,355 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;100;96;136;89;90;90;128;89;87;134 08:31:52 INFO - 2015-11-18 08:31:52,355 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;120;120;115;119;119;114;115;114;114;120 08:31:52 INFO - 2015-11-18 08:31:52,355 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;125;126;125;125;126;125;126;125;125;125 08:31:52 INFO - 2015-11-18 08:31:52,355 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;94;94;101;94;93;93;101;92;94;100 08:31:52 INFO - 2015-11-18 08:31:52,355 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;65;62;62;64;62;62;62;72;61;63 08:31:52 INFO - 2015-11-18 08:31:52,355 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;70;73;69;69;70;69;71;70;70 08:31:52 INFO - 2015-11-18 08:31:52,356 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;87;86;84;86;85;86;86;87;87;86 08:31:52 INFO - 2015-11-18 08:31:52,356 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;126;131;131;123;131;129;133;120;121;124 08:31:52 INFO - 2015-11-18 08:31:52,356 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;152;146;154;156;155;147;143;156;141;153 08:31:52 INFO - 2015-11-18 08:31:52,356 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;71;73;72;71;71;71;71;72;73;72 08:31:52 INFO - 2015-11-18 08:31:52,356 DEBUG : BROWSER_OUTPUT: __end_tp_report 08:31:52 INFO - 2015-11-18 08:31:52,356 DEBUG : BROWSER_OUTPUT: __start_cc_report 08:31:52 INFO - 2015-11-18 08:31:52,356 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,924 08:31:52 INFO - 2015-11-18 08:31:52,356 DEBUG : BROWSER_OUTPUT: __end_cc_report 08:31:52 INFO - 2015-11-18 08:31:52,357 DEBUG : BROWSER_OUTPUT: __startTimestamp1447864312348__endTimestamp 08:31:52 INFO - 2015-11-18 08:31:52,357 DEBUG : BROWSER_OUTPUT: 08:31:52 INFO - 2015-11-18 08:31:52,357 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 08:31:52 INFO - 2015-11-18 08:31:52,357 DEBUG : BROWSER_OUTPUT: Number of tests: 14 08:31:52 INFO - 2015-11-18 08:31:52,357 DEBUG : BROWSER_OUTPUT: 08:31:52 INFO - 2015-11-18 08:31:52,358 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:107.10 Median:109.00 stddev:3.87 (3.6%) stddev-sans-first:4.11 08:31:52 INFO - 2015-11-18 08:31:52,358 DEBUG : BROWSER_OUTPUT: Values: 107.0 108.0 103.0 111.0 110.0 109.0 98.0 107.0 109.0 109.0 08:31:52 INFO - 2015-11-18 08:31:52,358 DEBUG : BROWSER_OUTPUT: 08:31:52 INFO - 2015-11-18 08:31:52,358 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:145.60 Median:152.00 stddev:13.50 (8.9%) stddev-sans-first:13.79 08:31:52 INFO - 2015-11-18 08:31:52,358 DEBUG : BROWSER_OUTPUT: Values: 156.0 133.0 153.0 161.0 127.0 151.0 146.0 136.0 164.0 129.0 08:31:52 INFO - 2015-11-18 08:31:52,358 DEBUG : BROWSER_OUTPUT: 08:31:52 INFO - 2015-11-18 08:31:52,359 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.60 Median:162.00 stddev:1.35 (0.8%) stddev-sans-first:1.30 08:31:52 INFO - 2015-11-18 08:31:52,359 DEBUG : BROWSER_OUTPUT: Values: 160.0 160.0 162.0 162.0 162.0 163.0 164.0 162.0 160.0 161.0 08:31:52 INFO - 2015-11-18 08:31:52,359 DEBUG : BROWSER_OUTPUT: 08:31:52 INFO - 2015-11-18 08:31:52,359 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:76.70 Median:80.50 stddev:7.10 (8.8%) stddev-sans-first:7.53 08:31:52 INFO - 2015-11-18 08:31:52,359 DEBUG : BROWSER_OUTPUT: Values: 76.0 82.0 86.0 85.0 69.0 70.0 72.0 80.0 81.0 66.0 08:31:52 INFO - 2015-11-18 08:31:52,359 DEBUG : BROWSER_OUTPUT: 08:31:52 INFO - 2015-11-18 08:31:52,360 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:103.90 Median:89.00 stddev:20.31 (22.8%) stddev-sans-first:21.49 08:31:52 INFO - 2015-11-18 08:31:52,360 DEBUG : BROWSER_OUTPUT: Values: 100.0 96.0 136.0 89.0 90.0 90.0 128.0 89.0 87.0 134.0 08:31:52 INFO - 2015-11-18 08:31:52,360 DEBUG : BROWSER_OUTPUT: 08:31:52 INFO - 2015-11-18 08:31:52,360 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:119.00 stddev:2.79 (2.3%) stddev-sans-first:2.74 08:31:52 INFO - 2015-11-18 08:31:52,360 DEBUG : BROWSER_OUTPUT: Values: 120.0 120.0 115.0 119.0 119.0 114.0 115.0 114.0 114.0 120.0 08:31:52 INFO - 2015-11-18 08:31:52,360 DEBUG : BROWSER_OUTPUT: 08:31:52 INFO - 2015-11-18 08:31:52,361 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:125.30 Median:125.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 08:31:52 INFO - 2015-11-18 08:31:52,361 DEBUG : BROWSER_OUTPUT: Values: 125.0 126.0 125.0 125.0 126.0 125.0 126.0 125.0 125.0 125.0 08:31:52 INFO - 2015-11-18 08:31:52,361 DEBUG : BROWSER_OUTPUT: 08:31:52 INFO - 2015-11-18 08:31:52,361 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.60 Median:93.50 stddev:3.57 (3.8%) stddev-sans-first:3.73 08:31:52 INFO - 2015-11-18 08:31:52,361 DEBUG : BROWSER_OUTPUT: Values: 94.0 94.0 101.0 94.0 93.0 93.0 101.0 92.0 94.0 100.0 08:31:52 INFO - 2015-11-18 08:31:52,361 DEBUG : BROWSER_OUTPUT: 08:31:52 INFO - 2015-11-18 08:31:52,362 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:63.50 Median:62.50 stddev:3.21 (5.1%) stddev-sans-first:3.35 08:31:52 INFO - 2015-11-18 08:31:52,362 DEBUG : BROWSER_OUTPUT: Values: 65.0 62.0 62.0 64.0 62.0 62.0 62.0 72.0 61.0 63.0 08:31:52 INFO - 2015-11-18 08:31:52,362 DEBUG : BROWSER_OUTPUT: 08:31:52 INFO - 2015-11-18 08:31:52,362 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:70.00 Median:70.00 stddev:1.25 (1.8%) stddev-sans-first:1.27 08:31:52 INFO - 2015-11-18 08:31:52,362 DEBUG : BROWSER_OUTPUT: Values: 69.0 70.0 73.0 69.0 69.0 70.0 69.0 71.0 70.0 70.0 08:31:52 INFO - 2015-11-18 08:31:52,363 DEBUG : BROWSER_OUTPUT: 08:31:52 INFO - 2015-11-18 08:31:52,363 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:86.00 Median:86.00 stddev:0.94 (1.1%) stddev-sans-first:0.93 08:31:52 INFO - 2015-11-18 08:31:52,363 DEBUG : BROWSER_OUTPUT: Values: 87.0 86.0 84.0 86.0 85.0 86.0 86.0 87.0 87.0 86.0 08:31:52 INFO - 2015-11-18 08:31:52,363 DEBUG : BROWSER_OUTPUT: 08:31:52 INFO - 2015-11-18 08:31:52,363 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:126.90 Median:130.00 stddev:4.70 (3.6%) stddev-sans-first:4.97 08:31:52 INFO - 2015-11-18 08:31:52,363 DEBUG : BROWSER_OUTPUT: Values: 126.0 131.0 131.0 123.0 131.0 129.0 133.0 120.0 121.0 124.0 08:31:52 INFO - 2015-11-18 08:31:52,364 DEBUG : BROWSER_OUTPUT: 08:31:52 INFO - 2015-11-18 08:31:52,365 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:150.30 Median:153.50 stddev:5.58 (3.6%) stddev-sans-first:5.88 08:31:52 INFO - 2015-11-18 08:31:52,365 DEBUG : BROWSER_OUTPUT: Values: 152.0 146.0 154.0 156.0 155.0 147.0 143.0 156.0 141.0 153.0 08:31:52 INFO - 2015-11-18 08:31:52,365 DEBUG : BROWSER_OUTPUT: 08:31:52 INFO - 2015-11-18 08:31:52,365 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.70 Median:72.00 stddev:0.82 (1.1%) stddev-sans-first:0.83 08:31:52 INFO - 2015-11-18 08:31:52,366 DEBUG : BROWSER_OUTPUT: Values: 71.0 73.0 72.0 71.0 71.0 71.0 71.0 72.0 73.0 72.0 08:31:52 INFO - 2015-11-18 08:31:52,366 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 08:31:52 INFO - 2015-11-18 08:31:52,366 DEBUG : BROWSER_OUTPUT: 08:31:52 INFO - 2015-11-18 08:31:52,995 INFO : Browser exited with error code: 0 08:31:53 INFO - 2015-11-18 08:31:53,042 INFO : Completed test kraken (00:00:57) 08:31:53 INFO - 2015-11-18 08:31:53,042 INFO : Starting test v8_7 08:31:53 INFO - 2015-11-18 08:31:53,042 DEBUG : operating with platform_type : mac_ 08:31:53 INFO - 2015-11-18 08:31:53,042 INFO : Initialising browser for v8_7 test... 08:31:53 INFO - 2015-11-18 08:31:53,056 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/tmpnUxoXX/profile http://localhost:49272/getInfo.html 08:31:55 INFO - 2015-11-18 08:31:55,209 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 08:31:55 INFO - 2015-11-18 08:31:55,209 DEBUG : BROWSER_OUTPUT: colorDepth:24 08:31:55 INFO - 2015-11-18 08:31:55,209 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 08:31:55 INFO - 2015-11-18 08:31:55,209 DEBUG : BROWSER_OUTPUT: __metrics 08:31:55 INFO - 2015-11-18 08:31:55,229 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:31:55 INFO - 2015-11-18 08:31:55,888 INFO : Browser initialized. 08:31:55 INFO - 2015-11-18 08:31:55,888 INFO : Running cycle 1/1 for v8_7 test... 08:31:55 INFO - 2015-11-18 08:31:55,889 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/tmpnUxoXX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 08:32:07 INFO - 2015-11-18 08:32:07,793 DEBUG : BROWSER_OUTPUT: RSS: Main: 229269504 08:32:07 INFO - 2015-11-18 08:32:07,793 DEBUG : BROWSER_OUTPUT: 08:32:29 INFO - 2015-11-18 08:32:29,249 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49272/tests/v8_7/run.html (next: http://localhost:49272/tests/v8_7/run.html) 08:32:29 INFO - 2015-11-18 08:32:29,508 DEBUG : BROWSER_OUTPUT: RSS: Main: 304885760 08:32:29 INFO - 2015-11-18 08:32:29,508 DEBUG : BROWSER_OUTPUT: 08:32:29 INFO - 2015-11-18 08:32:29,508 DEBUG : BROWSER_OUTPUT: __start_tp_report 08:32:29 INFO - 2015-11-18 08:32:29,508 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 08:32:29 INFO - 2015-11-18 08:32:29,508 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 08:32:29 INFO - 2015-11-18 08:32:29,509 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 08:32:29 INFO - 2015-11-18 08:32:29,509 DEBUG : BROWSER_OUTPUT: |0;Richards;166.72224074691565 08:32:29 INFO - 2015-11-18 08:32:29,509 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;199.76028765481422 08:32:29 INFO - 2015-11-18 08:32:29,509 DEBUG : BROWSER_OUTPUT: |2;Encrypt;325.4149040026033 08:32:29 INFO - 2015-11-18 08:32:29,509 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5780.346820809248 08:32:29 INFO - 2015-11-18 08:32:29,509 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1972.3865877712033 08:32:29 INFO - 2015-11-18 08:32:29,509 DEBUG : BROWSER_OUTPUT: |5;Earley;923.3610341643582 08:32:29 INFO - 2015-11-18 08:32:29,510 DEBUG : BROWSER_OUTPUT: |6;Boyer;13077.922077922078 08:32:29 INFO - 2015-11-18 08:32:29,510 DEBUG : BROWSER_OUTPUT: |7;RegExp;29542.85714285714 08:32:29 INFO - 2015-11-18 08:32:29,510 DEBUG : BROWSER_OUTPUT: |8;Splay;626.1740763932373 08:32:29 INFO - 2015-11-18 08:32:29,510 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;5797.687861271676 08:32:29 INFO - 2015-11-18 08:32:29,510 DEBUG : BROWSER_OUTPUT: __end_tp_report 08:32:29 INFO - 2015-11-18 08:32:29,511 DEBUG : BROWSER_OUTPUT: __startTimestamp1447864349507__endTimestamp 08:32:29 INFO - 2015-11-18 08:32:29,511 DEBUG : BROWSER_OUTPUT: 08:32:29 INFO - 2015-11-18 08:32:29,511 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 08:32:29 INFO - 2015-11-18 08:32:29,511 DEBUG : BROWSER_OUTPUT: Number of tests: 10 08:32:29 INFO - 2015-11-18 08:32:29,511 DEBUG : BROWSER_OUTPUT: 08:32:29 INFO - 2015-11-18 08:32:29,511 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:166.72 Median:166.72 stddev:0.00 (0.0%) 08:32:29 INFO - 2015-11-18 08:32:29,512 DEBUG : BROWSER_OUTPUT: Values: 166.7 08:32:29 INFO - 2015-11-18 08:32:29,512 DEBUG : BROWSER_OUTPUT: 08:32:29 INFO - 2015-11-18 08:32:29,512 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:199.76 Median:199.76 stddev:0.00 (0.0%) 08:32:29 INFO - 2015-11-18 08:32:29,512 DEBUG : BROWSER_OUTPUT: Values: 199.8 08:32:29 INFO - 2015-11-18 08:32:29,512 DEBUG : BROWSER_OUTPUT: 08:32:29 INFO - 2015-11-18 08:32:29,512 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:325.41 Median:325.41 stddev:0.00 (0.0%) 08:32:29 INFO - 2015-11-18 08:32:29,513 DEBUG : BROWSER_OUTPUT: Values: 325.4 08:32:29 INFO - 2015-11-18 08:32:29,513 DEBUG : BROWSER_OUTPUT: 08:32:29 INFO - 2015-11-18 08:32:29,514 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5780.35 Median:5780.35 stddev:0.00 (0.0%) 08:32:29 INFO - 2015-11-18 08:32:29,514 DEBUG : BROWSER_OUTPUT: Values: 5780.3 08:32:29 INFO - 2015-11-18 08:32:29,514 DEBUG : BROWSER_OUTPUT: 08:32:29 INFO - 2015-11-18 08:32:29,514 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1972.39 Median:1972.39 stddev:0.00 (0.0%) 08:32:29 INFO - 2015-11-18 08:32:29,514 DEBUG : BROWSER_OUTPUT: Values: 1972.4 08:32:29 INFO - 2015-11-18 08:32:29,515 DEBUG : BROWSER_OUTPUT: 08:32:29 INFO - 2015-11-18 08:32:29,515 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:923.36 Median:923.36 stddev:0.00 (0.0%) 08:32:29 INFO - 2015-11-18 08:32:29,515 DEBUG : BROWSER_OUTPUT: Values: 923.4 08:32:29 INFO - 2015-11-18 08:32:29,515 DEBUG : BROWSER_OUTPUT: 08:32:29 INFO - 2015-11-18 08:32:29,515 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:13077.92 Median:13077.92 stddev:0.00 (0.0%) 08:32:29 INFO - 2015-11-18 08:32:29,515 DEBUG : BROWSER_OUTPUT: Values: 13077.9 08:32:29 INFO - 2015-11-18 08:32:29,515 DEBUG : BROWSER_OUTPUT: 08:32:29 INFO - 2015-11-18 08:32:29,515 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:29542.86 Median:29542.86 stddev:0.00 (0.0%) 08:32:29 INFO - 2015-11-18 08:32:29,516 DEBUG : BROWSER_OUTPUT: Values: 29542.9 08:32:29 INFO - 2015-11-18 08:32:29,516 DEBUG : BROWSER_OUTPUT: 08:32:29 INFO - 2015-11-18 08:32:29,516 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:626.17 Median:626.17 stddev:0.00 (0.0%) 08:32:29 INFO - 2015-11-18 08:32:29,516 DEBUG : BROWSER_OUTPUT: Values: 626.2 08:32:29 INFO - 2015-11-18 08:32:29,516 DEBUG : BROWSER_OUTPUT: 08:32:29 INFO - 2015-11-18 08:32:29,516 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:5797.69 Median:5797.69 stddev:0.00 (0.0%) 08:32:29 INFO - 2015-11-18 08:32:29,516 DEBUG : BROWSER_OUTPUT: Values: 5797.7 08:32:29 INFO - 2015-11-18 08:32:29,516 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 08:32:29 INFO - 2015-11-18 08:32:29,517 DEBUG : BROWSER_OUTPUT: 08:32:30 INFO - 2015-11-18 08:32:30,107 INFO : Browser exited with error code: 0 08:32:30 INFO - 2015-11-18 08:32:30,126 INFO : Completed test v8_7 (00:00:37) 08:32:30 INFO - 2015-11-18 08:32:30,145 INFO : Completed test suite (00:20:10) 08:32:30 INFO - 2015-11-18 08:32:30,145 DEBUG : Working with test: dromaeo_css 08:32:30 INFO - 2015-11-18 08:32:30,145 DEBUG : Generating results file: dromaeo_css 08:32:30 INFO - 2015-11-18 08:32:30,146 DEBUG : Working with test: kraken 08:32:30 INFO - 2015-11-18 08:32:30,146 DEBUG : Generating results file: kraken 08:32:30 INFO - 2015-11-18 08:32:30,147 INFO : javascript benchmark 08:32:30 INFO - 2015-11-18 08:32:30,147 DEBUG : Working with test: v8_7 08:32:30 INFO - 2015-11-18 08:32:30,147 DEBUG : Generating results file: v8_7 08:32:30 INFO - 2015-11-18 08:32:30,147 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:32:30 INFO - 2015-11-18 08:32:30,207 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,55]] 08:32:30 INFO - 2015-11-18 08:32:30,207 DEBUG : process_Request line: dromaeo_css 6366.97 graph.html#tests=[[72,64,55]] 08:32:30 INFO - 2015-11-18 08:32:30,207 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:32:30 INFO - 2015-11-18 08:32:30,238 DEBUG : process_Request line: kraken 1501.20 graph.html#tests=[[232,64,55]] 08:32:30 INFO - 2015-11-18 08:32:30,238 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:32:30 INFO - 2015-11-18 08:32:30,268 DEBUG : process_Request line: v8_7 18161.64 graph.html#tests=[[230,64,55]] 08:32:30 INFO - 2015-11-18 08:32:30,269 INFO : javascript benchmark 08:32:30 INFO - 2015-11-18 08:32:30,271 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3068.846557672116, 3133.7493000559957, 3174.285785698217, 3176.221825652714, 3196.248881512845, 4889.144399730051, 4896.045271172123, 5175.611829112818, 5186.377634683839, 5262.315898933138, 4959.504049595039, 5023.874403139924, 5148.48515148485, 5165.81919632813, 5222.3472065991755, 4622.699524530912, 4764.285357196413, 4782.569568738812, 4787.856364309059, 4851.054044461332, 4707.976460117695, 4735.502772208903, 4760.642951778613, 4878.4145902491755, 4904.48502907195, 4868.9269660955115, 4871.0, 4874.561289483946, 4886.071646387193, 4939.506049395068, 4711.575958163748, 4821.445533763609, 4822.590079843218, 4858.732769697665, 4906.460289368167, 4750.50119737426, 4777.641676874248, 4792.664513484057, 4795.640326975491, 4888.242322440027, 4954.603631709455, 5017.7491125443585, 5051.390327463938, 5135.998480296344, 5147.922781158286, 5063.443021267658, 5183.170692689189, 5200.271961925334, 5280.498352656491, 5420.051490989101, 5362.115250983583, 5439.972800136014, 5454.563634909197, 5498.202760599731, 5521.613487055908, 5112.437631860493, 5124.743762811881, 5135.229715542699, 5149.794008239628, 5190.948090519047, 5302.867428314323, 5397.460253974571, 5449.863753406117, 5457.918131228034, 5519.530839878575, 5300.575953923677, 5312.0, 5313.707746074003, 5331.200319952039, 5362.865928351823, 5441.619086663895, 5447.509724124848, 5478.643888147258, 5558.055130627803, 5575.0522411190195, 5236.450172731885, 5311.309529761106, 5368.087425137736, 5402.540784033401, 5404.486573775485, 5273.419923808378, 5364.980653675789, 5380.569554435636, 5451.563874889999, 5455.61810673257, 4172.248995180897, 4181.832726690959, 4222.155568886235, 4280.828766849353, 4324.545922678137, 3726.4037753959237, 3771.4719939208535, 3823.2162406706557, 3841.058940559525, 3931.1941052084253, 5108.259302401206, 5108.335916330853, 5109.233614957711, 5121.795128194831, 5203.19350500673, 5446.0, 5471.534919531884, 5473.808416705396, 5513.779448822002, 5564.415736347706, 4965.280034395065, 5004.949950500449, 5093.286939828427, 5120.18077107661, 5128.051310507568, 4664.207084795593, 4714.22215334466, 4810.062037902645, 4811.759412029384, 4871.074495845778, 5459.945400545944, 5497.47773961473, 5568.693721845338, 5573.526250268773, 5574.052411090124, 5230.555402790806, 5324.893502130013, 5370.62405631602, 5372.221027950847, 5426.430224826494, 5615.803446879339, 5640.943590564042, 5660.971695141498, 5662.688552129673, 5680.744366503434, 5424.53891419218, 5436.7553460093595, 5441.755121019484, 5447.891042179055, 5503.091989821794, 5169.147090729987, 5210.1142805723875, 5240.7641656126325, 5341.038613049688, 5628.4090170533145, 5394.298741163623, 5399.163129714901, 5421.566274698093, 5422.9186562202385, 5451.155070964007, 5349.0, 5361.571074313967, 5362.0616392132, 5436.0486914790545, 5469.206964990134, 5022.271770593316, 5065.620078494054, 5138.203578445347, 5187.1181899078, 5269.4730526947, 4963.5780958618925, 5181.222816577543, 5190.658411371166, 5209.244659524424, 5320.680759154463, 5217.50433708797, 5219.5041471060185, 5273.077211488051, 5280.20796880471, 5288.3918349390315], "unit": "ms", "name": "dojo.html", "value": 5044.98335523287}, {"lowerIsBetter": false, "replicates": [548.9862753431162, 561.9072852979257, 564.0495764636586, 568.1676344155811, 573.4437595532332, 29854.402911941776, 30516.542251866213, 30743.69256307436, 30773.38453230934, 31170.376592468165, 38500.42249366262, 38610.0, 38709.225815483675, 38757.80621096898, 39325.0, 8982.236509896651, 9099.63601455941, 9140.497272650035, 9167.404118732295, 9189.816203675922, 8194.139615340393, 8261.13258107899, 8907.331950103735, 8935.508547029911, 8937.955310223473, 10918.0, 10965.232433729641, 10989.175811814106, 11096.722581935475, 11104.61133860315, 10560.0, 10612.62855800051, 10722.517486713117, 10795.784084318348, 10873.456327183689, 8197.098319184885, 8273.958630206871, 10530.10494107994, 10783.676489705322, 10914.454277286104, 37142.0, 37256.0, 37433.62566374329, 37446.43830342547, 37933.81033094817, 2988.193187839271, 3003.714647108521, 3088.83011434371, 3267.5098735189913, 3507.7722797021092, 26735.331616709544, 28178.85910570434, 28553.28616784597, 29393.412131757457, 30646.84676576625, 2326.546323466908, 2362.14962613459, 2367.9526409471887, 2369.9526009479887, 2396.4727759892794, 275022.0, 278642.0, 283022.0, 283225.0, 283623.0, 55109.724451377486, 55144.724276379166, 59592.40407595955, 59698.10452843211, 59957.40042599606, 63967.0, 64110.679446603404, 65553.67223163854, 65609.0, 65610.0, 15699.136547489998, 15881.0, 15941.282642281125, 15980.280887359864, 16061.759073613905, 12129.45417456199, 12156.878431215751, 12214.145009849226, 12308.50765969369, 12353.073519486075, 19230.519885301084, 19498.979698748935, 19577.902110489642, 19610.901945490466, 19618.019099044992, 8529.445586036887, 8545.700900468453, 8602.440841345293, 8694.087120852346, 8788.583139636523, 881.6341218394294, 949.0082863407755, 956.6842941829319, 960.4189465373488, 966.5457235099492, 27110.864445677646, 27517.0, 30845.84577077145, 31174.68825311718, 31815.363692726016, 959.8704174936433, 1027.024326889458, 1041.6041904076403, 1045.4511381524608, 1103.7626910214342, 13816.37826297819, 14240.359183836752, 14356.49752258666, 16109.0, 16458.341666333454, 399440.0, 407218.0, 407679.0, 408885.0, 410136.0, 54986.0, 55241.0, 55276.723616382464, 55319.446805532236, 55399.0, 1382.5506710319187, 1388.5834249725042, 1402.0536138106534, 1405.3816320818808, 1408.5703860322494, 29143.708562914948, 30052.69947300499, 31067.378652427276, 31364.529532056582, 31504.684953150176, 49611.503884962134, 50761.492385075675, 50784.0, 50790.74604626953, 50847.0, 281009.0, 295002.0, 298958.0, 366156.0, 382264.0, 37301.81349093237, 37738.62261377461, 38189.2362152761, 38266.6173338263, 38406.0, 39624.80187599044, 40530.136383634155, 42679.146417070864, 42766.35850462308, 42797.0, 35738.64261357457, 36094.278114438086, 36654.81672591727, 36937.81531092327, 37149.81425092965, 28208.85895570509, 36616.81691591525, 36739.44890826693, 37623.0, 38621.4206786904, 34281.65718342884, 34524.48213276752, 35005.824970876005, 35315.0, 35519.822400888865, 29357.0, 30593.23516912095, 30636.0, 30768.230794230323, 30843.69156308408, 23339.53320933606, 23494.530109397376, 23530.17644382507, 23611.0, 23706.05175792949], "unit": "ms", "name": "ext.html", "value": 18689.63118388848}, {"lowerIsBetter": false, "replicates": [334.4581777520417, 336.43814829235174, 337.5021842781899, 339.2096415352229, 340.93692666856623, 14203.863690904729, 14698.559043228694, 16493.340266389347, 16519.0, 17356.30574777009, 13015.479380824756, 18210.635787284245, 18262.80846298446, 18459.630807383877, 18748.250069997182, 5417.864553386157, 5643.5203007744185, 5655.886882262353, 5695.458931401531, 5698.0, 3954.584768599299, 4178.997040710223, 5514.889702205954, 5569.192467092269, 5989.88020239595, 5928.940710592904, 6103.542234332421, 6129.509639228873, 6196.16351792509, 6213.378662133796, 4366.257736184856, 4521.773911304422, 4527.524609915978, 4585.679002469828, 6122.54080943931, 3826.598207188233, 3846.2692088503095, 3846.4038074098557, 3846.7307288489815, 3877.243937432202, 11597.0, 11829.171957962946, 11930.761384772342, 11959.820602690967, 12155.392230388534, 1664.1595994023062, 1767.7083281258706, 1812.7552780374613, 1825.0, 1887.5564242403025, 8832.160944710307, 8841.646334146626, 9017.098290170996, 9056.275932315108, 9090.318226133066, 1467.2810322941682, 1486.3237227061768, 1523.2612183091192, 1553.8446155384484, 1615.9111248881306, 54940.72529637366, 57082.429175708545, 57341.42658573403, 57805.710971444874, 57898.0, 6152.630842149485, 6167.105769663373, 6177.505799536027, 6203.534734894811, 6219.720112594944, 7018.824529386806, 7027.086478757728, 7029.0, 7034.507584469038, 7045.612491312924, 5040.36995375578, 5067.417247016567, 5151.201563757623, 5326.493983071602, 5340.813071542478, 5664.291963504562, 5717.342505611825, 5734.311882574035, 5825.456254092669, 5828.941710582924, 2722.7413395727376, 2728.4815884982186, 2748.5877118431995, 2753.435545713164, 2782.916512504628, 931.1759093202564, 933.1927882381826, 951.5908159491347, 977.9780129764413, 1038.0864838941684, 364.764726751244, 384.25454618040914, 402.4607026584391, 413.6318676378026, 445.30087762213014, 10302.278840481094, 10690.51892664832, 11003.449827508754, 11053.668389948314, 11180.888191117985, 378.7481324918898, 415.7858702768077, 428.76632235431765, 436.53290978652535, 443.79585390719984, 5613.298337707786, 5986.0, 6004.54965877561, 6037.0, 6041.395860413923, 539419.0, 547734.0, 549833.0, 551515.0, 558015.0, 64107.35892641107, 64463.67768161129, 65547.0, 65618.34381656218, 67481.0, 453.0350353746499, 463.5318328488251, 464.3104989091264, 468.3583490617875, 471.547314578009, 10037.648682296085, 10093.293469457067, 10099.343542669703, 10239.48802559884, 10286.742831429274, 31270.374592507567, 31283.53074703927, 31428.0, 31760.0, 32255.35489290248, 44363.77818111018, 44502.55497445114, 44747.55252447434, 45135.32297015482, 45768.77115614401, 5721.914171287517, 5782.624129431573, 5788.797392091256, 5813.651180929158, 5849.736761845812, 10288.228382871164, 10653.89346106529, 11008.614698485515, 11011.394373309546, 11242.831357529807, 8936.151065648754, 9333.673321433716, 9436.056394360508, 9633.0, 9752.609895604097, 9163.587638556415, 9364.344495885223, 9436.0, 9446.38598491096, 9591.184749296388, 9648.565814538222, 9755.756106097404, 9880.851787223053, 9959.253056020683, 10007.09936105754, 5186.429492755869, 5228.686278823283, 5341.065313570188, 5598.048331783525, 13985.650358741113, 13630.454781808616, 14557.490487832874, 15211.695766084838, 15296.847031529542, 15310.004849684736], "unit": "ms", "name": "jquery.html", "value": 6562.516546690887}, {"lowerIsBetter": false, "replicates": [1373.395705889408, 1382.5299398204609, 1519.3618680154334, 1673.2219517924163, 1759.9120043997805, 6295.968520157404, 6680.86638267235, 7025.473089518287, 7116.5018448708615, 7132.3580877721, 6836.82907927302, 6948.513604047719, 6973.337532934376, 6976.581405115697, 7023.2625574314725, 2017.3645301729982, 2025.8480613953939, 2033.613613413454, 2036.725042119317, 2052.0663098290315, 2081.6669332906736, 2086.582683463306, 2129.7124888140133, 2183.984447232037, 2186.1364760919428, 2040.081963116596, 2049.477383267265, 2051.897405129745, 2061.0828181459256, 2075.6056349293663, 2068.369147410039, 2093.591749608827, 2098.318046634842, 2114.1754715660904, 2115.6509175985943, 2000.3898810862681, 2034.2269937423832, 2041.6733322668451, 2048.129544943408, 2056.856020078595, 6164.84587885302, 6298.275698294663, 6891.345322194384, 6900.102986611759, 6944.097267355211, 4173.937390939138, 4302.118065796504, 4354.063876266586, 4359.564043595647, 4373.978130109329, 2533.4173140177677, 2538.352720056374, 2539.3143851160266, 2576.458943621823, 2583.2379448062866, 817.7937542125377, 844.851002636414, 859.9441036332681, 869.7043005378139, 870.2994089757742, 8799.384043116985, 8811.559422028873, 8814.911850881474, 8874.245689116433, 8935.64257429702, 3774.7735135891935, 3790.9431358529646, 3850.364689826203, 3855.2867719471988, 3857.4985251917633, 7953.602319883983, 7953.801154971172, 8026.317762990095, 8056.39577031725, 8080.8383832323025, 4321.783910804447, 4341.804618792162, 4358.389825424443, 4364.367166760802, 4424.0709451015, 3941.5664276929515, 3987.9003024924027, 3988.12261302513, 3989.4215338775716, 4004.8598299059395, 3131.5772370730115, 3135.639401468815, 3166.683331666815, 3180.0459862041757, 3211.309568442796, 1028.4703377760459, 1032.2670903658336, 1035.7876635289747, 1046.8639076920103, 1048.695878195315, 977.130353984954, 982.9017098290257, 1219.9268043917393, 1277.3932382118605, 1296.9870301296867, 6408.03879418091, 6469.256035555877, 6491.091247225392, 6595.0766892635065, 6627.668616569153, 410.3106780608606, 411.05867563279753, 415.14687317562095, 416.71038628153747, 443.42576363609203, 4983.750812459362, 5195.948040519622, 5212.739363031833, 5219.556337711261, 5275.155975044051, 7239.312265334785, 7442.516236444722, 7483.775486735407, 7698.615069246515, 8204.0, 7873.133955264916, 7987.400944929037, 8000.079990801132, 8004.199580041949, 8080.474769139987, 6342.365763423621, 6511.3163117871945, 6565.67171641416, 6588.11060506835, 6594.7032383542855, 6530.151080359523, 6544.705488253136, 6553.5084868634085, 6570.0, 6577.473802095725, 7073.752418665322, 7255.274472552703, 7378.114626244885, 7457.552546847207, 7476.738314158978, 7403.037605111301, 7622.885656715042, 7640.503367281109, 7647.120581133241, 7694.692212311445, 6126.663033533198, 6128.417800308964, 6168.1056246844855, 6184.690765461799, 6297.244330680348, 6676.599404035774, 6704.865902682017, 6709.295523970108, 6780.1524809398825, 6799.150106236721, 6154.846128846635, 6217.875642487215, 6346.111544383698, 6429.6142231466265, 6458.967705161444, 6083.513318934386, 6157.507399407947, 6215.689215539295, 6294.464970477561, 6382.808515744535, 6325.96837015812, 6352.237731472253, 6374.872502549831, 6414.679266036773, 6436.967815160894, 5823.039198532195, 5853.414658534112, 5884.029135192645, 5885.823425297248, 5887.941120588739, 5347.973260133675, 5473.589480788877, 5534.363548191848, 5599.216109744558, 5877.970610146922], "unit": "ms", "name": "mootools.html", "value": 3915.2077463028654}, {"lowerIsBetter": false, "replicates": [299.4998352750906, 309.8899890538858, 313.8822941396976, 320.3097325264054, 326.56566766200956, 6182.567220294575, 6198.56610037297, 6270.0, 6297.905531417033, 6300.117983482305, 5946.435088666581, 6087.573869829113, 6189.350118237588, 6194.535409844257, 6286.842828929268, 4830.2030165022725, 4853.757312134388, 4854.757262136896, 4856.6357523185725, 4883.560479556839, 4686.320483529903, 4829.661923665345, 4832.444268909086, 4850.466448690641, 4899.632527560448, 4626.583607475327, 4714.50497697742, 4767.666263361566, 4801.2798080287885, 4843.418789745236, 4766.451858036301, 4783.760811959423, 4797.208460603996, 4802.375691160162, 4813.951860481386, 4109.465769449952, 4111.650509706648, 4138.13099249158, 4150.813213405374, 4179.1014931789505, 5864.530837532987, 6051.364606716275, 6051.818445446644, 6097.817065488042, 6153.846153846145, 5147.047796157723, 5258.39528454225, 5347.25138480613, 5355.437679043722, 5357.624966252364, 6421.197350331208, 6440.0, 6467.967660161669, 6514.674266286715, 6518.250401203827, 4387.122575484884, 4388.0, 4393.0, 4412.580804823537, 4491.595756381941, 6532.281449040602, 6768.830779230559, 6832.93167068328, 6837.487188460836, 6921.723131074751, 4371.344298355209, 4382.189294980439, 4392.121575684876, 4402.185595664812, 4439.689221754446, 4445.222086134913, 4460.836494300262, 4475.865724028285, 4491.393661855608, 4491.8203271869415, 5195.610329225247, 5203.5576975957465, 5218.086834803894, 5228.424873263938, 5237.973810130925, 6338.714757835908, 6516.380943810331, 6533.411992920564, 6578.473722102221, 6593.274739778621, 1544.088987497382, 1556.5719427157396, 1566.2873392606336, 1566.3108232377717, 1566.7884835547284, 996.950152492387, 1000.5247507434057, 1009.5810238750983, 1015.8577799108131, 1019.8317277649253, 6223.377662233831, 6263.342349053284, 6269.341719119427, 6276.811695649138, 6293.2762732285455, 6465.612063276219, 6816.522843400914, 6827.726890924407, 6862.210845752802, 6867.3476019778045, 6099.603525770811, 6163.722632481549, 6303.3066362700065, 6311.558190926683, 6325.367463253638, 3619.638036196412, 3664.7984360859878, 3689.3543629864666, 3717.9442308365396, 3739.046543131484, 6865.347791959756, 7018.157821061505, 7019.403350715246, 7064.364207221375, 7122.608256545836, 6945.236024037352, 6990.09128813251, 6995.755148569776, 7031.542949708252, 7110.431165506747, 7080.6105664187935, 7086.149662040588, 7133.750318738923, 7134.036905017756, 7260.854782904418, 6677.499187561049, 6889.965550172217, 6892.758753443605, 6945.0971373721095, 6967.930320696931, 6734.292899245509, 6743.224529179011, 6773.864522709617, 6831.658417079226, 6867.828304292233, 7027.147638527334, 7132.358087772125, 7140.107486564179, 7189.496735228484, 7190.209077001421, 4454.7549884756645, 4478.507364190002, 4514.841980530666, 4516.1419330327135, 4529.501754806903, 6823.795286141423, 6846.623435711083, 6862.073620061228, 6891.965540172468, 6972.1284839395075, 6479.222493300834, 6646.534742567974, 6654.667266636746, 6657.167854018247, 6737.966310168418, 6401.3598640135615, 6626.138601981712, 6630.668466576555, 6645.568038077509, 6666.366695163952, 6359.268684101387, 6421.454176395058, 6422.197225346832, 6432.35676432353, 6525.7063432146615, 6414.358564143548, 6615.17310336208, 6631.403173714196, 6666.2333831609985, 6698.966505167443, 6468.676566171766, 6487.221533415832, 6498.480121590167, 6501.284858665637, 6514.0], "unit": "ms", "name": "prototype.html", "value": 4907.12685038919}, {"lowerIsBetter": false, "replicates": [674.5109795398336, 714.4820005496015, 746.3879618712658, 748.5770539645104, 756.7237958145279, 13839.238841863693, 14016.579502614924, 14040.508582199613, 14048.64878378041, 14070.507532236374, 13836.308184590755, 14311.212883291415, 14316.35576399062, 14452.277386130703, 14545.054571452849, 665.6771465839064, 818.4475479051646, 851.7615067781031, 866.0257210638001, 867.6832955971057, 688.6797639097819, 849.5667209723024, 851.6082602003055, 855.5679381912157, 870.6256309786789, 850.7660393391836, 879.0462348352046, 881.0352663833092, 888.9866652000226, 893.0935100872587, 688.2738710660251, 694.6839188169371, 875.7372788163557, 876.7106854737921, 879.8944126704837, 642.2581917884851, 644.6100109433772, 649.9870002599969, 650.5381179362658, 658.4995403493332, 13280.402381892742, 13287.335633218398, 13290.3354832258, 13369.799453008212, 13504.189748615016, 8810.86783698245, 8889.19997200255, 9010.45937243761, 9142.0, 9368.57841397132, 8869.733907982707, 8898.154675305836, 8962.259440133446, 8964.0, 9048.909510904872, 2749.3951330707414, 2763.6130941668184, 2822.280318518785, 2850.5296626056675, 2896.884124635012, 45537.772311138564, 45838.31242531365, 45936.3109553357, 45994.31008534875, 46051.76974115142, 6112.510999120149, 6115.052166914135, 6183.319834818167, 6211.751529938751, 6371.331010243857, 10228.232882533839, 10309.484525773682, 10342.069213770797, 10351.741206469898, 10453.634122805664, 5780.248567686258, 5843.03589907669, 5856.180134781134, 5870.911936320958, 6232.158658581034, 3780.6030366811638, 3804.1472586002387, 3877.2439374321734, 3908.5895980921596, 3913.8043097844993, 2381.1189859752003, 2408.9518209636058, 2415.0, 2418.2986933789, 2422.5397174536783, 340.56067672701937, 346.35059263880225, 347.695766204571, 349.85306171407564, 356.71641045368995, 477.60836114386564, 523.7250443517185, 562.1848319936109, 569.831899589622, 595.184597101973, 7002.229754726976, 7331.8533629328185, 7459.8508029839095, 7534.924650753532, 7832.334251588679, 566.1931747260138, 583.125312031952, 585.745200837637, 586.2759492027428, 600.3186383454723, 3321.7045352312616, 3610.151614370621, 3642.617525159873, 3692.2430901665093, 3737.2338670572467, 59235.11147332793, 59758.103628445606, 59809.70095149496, 59819.401805982256, 59820.10269845956, 50201.0, 51386.48613513892, 51692.0, 51865.0, 52059.0, 45214.77392613016, 45445.0, 45472.77263613727, 45960.0, 46674.29988550174, 7209.0, 7222.89165662526, 7372.447066469929, 7517.248275172439, 7527.698892044257, 34508.48237276392, 34743.65256347505, 34985.47521787226, 35030.29939401147, 35852.0, 42531.78734106434, 42632.5736742641, 43249.78375108104, 45630.0, 47306.29040564463, 6895.6552172392185, 7062.858742825012, 7068.611226382598, 7098.751543695946, 7235.529690570096, 11058.248044094069, 11159.944200278947, 11246.775064498828, 11279.236587036228, 11496.94251528737, 10406.895931040593, 10532.526036328536, 10761.5392635328, 10878.129749619853, 10936.12510999134, 10173.96544597013, 10397.532111055172, 10398.636047738293, 10817.945910270399, 10935.671929842118, 10456.529456174338, 10701.946490267499, 10766.569337226736, 11037.613683521038, 11058.11535077208, 8867.822643546964, 9181.632734690538, 9187.127222913812, 9258.583363748783, 9553.61785528571, 9171.678991235274, 9228.492432916253, 9234.307426942873, 9368.34421590482, 9371.109744574254], "unit": "ms", "name": "yui.html", "value": 5603.247151146077}], "name": "dromaeo_css", "value": 6366.967785347128}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [107.0, 108.0, 103.0, 111.0, 110.0, 109.0, 98.0, 107.0, 109.0, 109.0], "unit": "ms", "name": "ai-astar", "value": 107.1}, {"lowerIsBetter": true, "replicates": [156.0, 133.0, 153.0, 161.0, 127.0, 151.0, 146.0, 136.0, 164.0, 129.0], "unit": "ms", "name": "audio-beat-detection", "value": 145.6}, {"lowerIsBetter": true, "replicates": [160.0, 160.0, 162.0, 162.0, 162.0, 163.0, 164.0, 162.0, 160.0, 161.0], "unit": "ms", "name": "audio-dft", "value": 161.6}, {"lowerIsBetter": true, "replicates": [76.0, 82.0, 86.0, 85.0, 69.0, 70.0, 72.0, 80.0, 81.0, 66.0], "unit": "ms", "name": "audio-fft", "value": 76.7}, {"lowerIsBetter": true, "replicates": [100.0, 96.0, 136.0, 89.0, 90.0, 90.0, 128.0, 89.0, 87.0, 134.0], "unit": "ms", "name": "audio-oscillator", "value": 103.9}, {"lowerIsBetter": true, "replicates": [120.0, 120.0, 115.0, 119.0, 119.0, 114.0, 115.0, 114.0, 114.0, 120.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 117.0}, {"lowerIsBetter": true, "replicates": [125.0, 126.0, 125.0, 125.0, 126.0, 125.0, 126.0, 125.0, 125.0, 125.0], "unit": "ms", "name": "imaging-darkroom", "value": 125.3}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 101.0, 94.0, 93.0, 93.0, 101.0, 92.0, 94.0, 100.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.6}, {"lowerIsBetter": true, "replicates": [65.0, 62.0, 62.0, 64.0, 62.0, 62.0, 62.0, 72.0, 61.0, 63.0], "unit": "ms", "name": "json-parse-financial", "value": 63.5}, {"lowerIsBetter": true, "replicates": [69.0, 70.0, 73.0, 69.0, 69.0, 70.0, 69.0, 71.0, 70.0, 70.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 70.0}, {"lowerIsBetter": true, "replicates": [87.0, 86.0, 84.0, 86.0, 85.0, 86.0, 86.0, 87.0, 87.0, 86.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 86.0}, {"lowerIsBetter": true, "replicates": [126.0, 131.0, 131.0, 123.0, 131.0, 129.0, 133.0, 120.0, 121.0, 124.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 126.9}, {"lowerIsBetter": true, "replicates": [152.0, 146.0, 154.0, 156.0, 155.0, 147.0, 143.0, 156.0, 141.0, 153.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 150.3}, {"lowerIsBetter": true, "replicates": [71.0, 73.0, 72.0, 71.0, 71.0, 71.0, 71.0, 72.0, 73.0, 72.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 71.7}], "name": "kraken", "value": 1501.2}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.72224074691565], "unit": "score", "name": "Richards", "value": 211.74139599999998}, {"lowerIsBetter": false, "replicates": [199.76028765481422], "unit": "score", "name": "DeltaBlue", "value": 330.9867080000001}, {"lowerIsBetter": false, "replicates": [325.4149040026033], "unit": "score", "name": "Encrypt", "value": 817.9742130000002}, {"lowerIsBetter": false, "replicates": [5780.346820809248], "unit": "score", "name": "Decrypt", "value": 46.049312999999984}, {"lowerIsBetter": false, "replicates": [1972.3865877712033], "unit": "score", "name": "RayTrace", "value": 375.1744229999998}, {"lowerIsBetter": false, "replicates": [923.3610341643582], "unit": "score", "name": "Earley", "value": 721.7794289999998}, {"lowerIsBetter": false, "replicates": [13077.922077922078], "unit": "score", "name": "Boyer", "value": 50.960924528301874}, {"lowerIsBetter": false, "replicates": [29542.85714285714], "unit": "score", "name": "RegExp", "value": 30.836049323017406}, {"lowerIsBetter": false, "replicates": [626.1740763932373], "unit": "score", "name": "Splay", "value": 130.141127}, {"lowerIsBetter": false, "replicates": [5797.687861271676], "unit": "score", "name": "NavierStokes", "value": 255.96410767696923}], "name": "v8_7", "value": 18161.643813357092}]} 08:32:30 INFO - RETURN: dromaeo_css: 6366.97 08:32:30 INFO - RETURN: kraken: 1501.20 08:32:30 INFO - RETURN: v8_7: 18161.64 08:32:30 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,55]]", "result": "18161.64"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,55]]", "result": "1501.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,55]]", "result": "6366.97"}}} 08:32:30 INFO - Return code: 0 08:32:30 INFO - # TBPL SUCCESS # 08:32:30 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:32:30 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:32:30 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:32:30 INFO - 2015-11-18 08:32:30.365 screenresolution[1650:9997] starting screenresolution argv=screenresolution get 08:32:30 INFO - 2015-11-18 08:32:30.368 screenresolution[1650:9997] Display 0: 1600x1200x32@60 08:32:30 INFO - 2015-11-18 08:32:30.375 screenresolution[1651:10000] starting screenresolution argv=screenresolution list 08:32:30 INFO - Available Modes on Display 0 08:32:30 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:32:30 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:32:30 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:32:30 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:32:30 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:32:30 INFO - Intel HD Graphics 3000: 08:32:30 INFO - Chipset Model: Intel HD Graphics 3000 08:32:30 INFO - Type: GPU 08:32:30 INFO - Bus: Built-In 08:32:30 INFO - VRAM (Total): 512 MB 08:32:30 INFO - VRAM (Dynamic, Max): 10 08:32:30 INFO - Vendor: Intel (0x8086) 08:32:30 INFO - Device ID: 0x0116 08:32:30 INFO - Revision ID: 0x0009 08:32:30 INFO - Displays: 08:32:30 INFO - Display: 08:32:30 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:32:30 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:32:30 INFO - Display Serial Number: 1600x1200 60 08:32:30 INFO - Main Display: Yes 08:32:30 INFO - Mirror: Off 08:32:30 INFO - Online: Yes 08:32:30 INFO - Rotation: Supported 08:32:30 INFO - Return code: 0 08:32:30 INFO - Running post-action listener: _resource_record_post_action 08:32:30 INFO - Running post-run listener: _resource_record_post_run 08:32:31 INFO - Total resource usage - Wall time: 1250s; CPU: 30.0%; Read bytes: 43021312; Write bytes: 692034560; Read time: 7351; Write time: 57527 08:32:31 INFO - install - Wall time: 38s; CPU: 30.0%; Read bytes: 336116224; Write bytes: 337211392; Read time: 32716; Write time: 6779 08:32:31 INFO - run-tests - Wall time: 1212s; CPU: 30.0%; Read bytes: 41919488; Write bytes: 344456192; Read time: 6647; Write time: 50240 08:32:31 INFO - Running post-run listener: _upload_blobber_files 08:32:31 INFO - Blob upload gear active. 08:32:31 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 08:32:31 INFO - Copying logs to upload dir... 08:32:31 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1326.439564 ========= master_lag: 2.17 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 8 secs) (at 2015-11-18 08:32:33.919335) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-18 08:32:33.923234) ========= 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.F1wz69HD9j/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.HzbVF8jZEa/Listeners TMPDIR=/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False build_url:https://queue.taskcluster.net/v1/task/RBAZ_rkYSWmHDaun07unzA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010138 build_url: 'https://queue.taskcluster.net/v1/task/RBAZ_rkYSWmHDaun07unzA/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-18 08:32:33.955545) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 08:32:33.955890) ========= 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.F1wz69HD9j/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.HzbVF8jZEa/Listeners TMPDIR=/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False program finished with exit code 0 elapsedTime=0.005181 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 08:32:34.005918) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-18 08:32:34.006224) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-18 08:32:34.007471) ========= ========= Total master_lag: 2.67 =========