builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0038 starttime: 1447979632.31 results: success (0) buildid: 20151119131411 builduid: 3e485fdec53b4a5fb7cdd2775c91ef0e revision: 3e7e43113775c7af1076908eb33b8664241c0af9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-19 16:33:52.308994) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-19 16:33:52.309493) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-19 16:33:52.309824) ========= 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.TIGoEd1942/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.lamYHtLWcH/Listeners TMPDIR=/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.005303 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-19 16:33:52.330142) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-19 16:33:52.330504) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-19 16:33:52.346785) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 16:33:52.347179) ========= 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.TIGoEd1942/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.lamYHtLWcH/Listeners TMPDIR=/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005108 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 16:33:52.395547) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-19 16:33:52.395886) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-19 16:33:52.396346) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 16:33:52.396662) ========= 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.TIGoEd1942/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.lamYHtLWcH/Listeners TMPDIR=/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2015-11-19 16:33:52-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 6.46M=0.002s 2015-11-19 16:33:52 (6.46 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.112726 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 16:33:52.523505) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 16:33:52.523864) ========= 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.TIGoEd1942/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.lamYHtLWcH/Listeners TMPDIR=/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.019635 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 16:33:52.573226) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-19 16:33:52.573642) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 3e7e43113775c7af1076908eb33b8664241c0af9 --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 3e7e43113775c7af1076908eb33b8664241c0af9 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.TIGoEd1942/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.lamYHtLWcH/Listeners TMPDIR=/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2015-11-19 16:33:52,647 truncating revision to first 12 chars 2015-11-19 16:33:52,647 Setting DEBUG logging. 2015-11-19 16:33:52,647 attempt 1/10 2015-11-19 16:33:52,647 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/3e7e43113775?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-19 16:33:53,857 unpacking tar archive at: fx-team-3e7e43113775/testing/mozharness/ program finished with exit code 0 elapsedTime=1.441203 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-19 16:33:54.028192) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-19 16:33:54.028597) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-19 16:33:54.039047) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-19 16:33:54.039415) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-19 16:33:54.039897) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2015-11-19 16:33:54.040225) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--system-bits', '64', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.TIGoEd1942/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.lamYHtLWcH/Listeners TMPDIR=/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 16:33:54 INFO - MultiFileLogger online at 20151119 16:33:54 in /builds/slave/test 16:33:54 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 16:33:54 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:33:54 INFO - {'append_to_log': False, 16:33:54 INFO - 'base_work_dir': '/builds/slave/test', 16:33:54 INFO - 'blob_upload_branch': 'Fx-Team', 16:33:54 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:33:54 INFO - 'branch': 'Fx-Team', 16:33:54 INFO - 'buildbot_json_path': 'buildprops.json', 16:33:54 INFO - 'config_files': ('talos/mac_config.py',), 16:33:54 INFO - 'default_actions': ('clobber', 16:33:54 INFO - 'read-buildbot-config', 16:33:54 INFO - 'download-and-extract', 16:33:54 INFO - 'populate-webroot', 16:33:54 INFO - 'create-virtualenv', 16:33:54 INFO - 'install', 16:33:54 INFO - 'run-tests'), 16:33:54 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:33:54 INFO - 'download_minidump_stackwalk': True, 16:33:54 INFO - 'download_symbols': 'ondemand', 16:33:54 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:33:54 INFO - 'tooltool.py': '/tools/tooltool.py', 16:33:54 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:33:54 INFO - '/tools/misc-python/virtualenv.py')}, 16:33:54 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:33:54 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:33:54 INFO - 'installer_path': 'installer.exe', 16:33:54 INFO - 'log_level': 'info', 16:33:54 INFO - 'log_name': 'talos', 16:33:54 INFO - 'log_to_console': True, 16:33:54 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 16:33:54 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 16:33:54 INFO - 'opt_config_files': (), 16:33:54 INFO - 'pip_index': False, 16:33:54 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:33:54 INFO - 'cmd': ('bash', 16:33:54 INFO - '-c', 16:33:54 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:33:54 INFO - 'enabled': True, 16:33:54 INFO - 'halt_on_failure': False, 16:33:54 INFO - 'name': 'check_screen_resolution'},), 16:33:54 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:33:54 INFO - 'cmd': ('bash', 16:33:54 INFO - '-c', 16:33:54 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:33:54 INFO - 'enabled': True, 16:33:54 INFO - 'halt_on_failure': False, 16:33:54 INFO - 'name': 'check_screen_resolution'},), 16:33:54 INFO - 'run_cmd_checks_enabled': True, 16:33:54 INFO - 'sps_profile': False, 16:33:54 INFO - 'sps_profile_interval': 0, 16:33:54 INFO - 'suite': 'dromaeojs-e10s', 16:33:54 INFO - 'system_bits': '64', 16:33:54 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:33:54 INFO - 'title': 't-yosemite-r7-0038', 16:33:54 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:33:54 INFO - 'use_talos_json': True, 16:33:54 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:33:54 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:33:54 INFO - 'work_dir': 'build'} 16:33:54 INFO - ##### 16:33:54 INFO - ##### Running clobber step. 16:33:54 INFO - ##### 16:33:54 INFO - Running pre-action listener: _resource_record_pre_action 16:33:54 INFO - Running main action method: clobber 16:33:54 INFO - rmtree: /builds/slave/test/build 16:33:54 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:33:56 INFO - Running post-action listener: _resource_record_post_action 16:33:56 INFO - ##### 16:33:56 INFO - ##### Running read-buildbot-config step. 16:33:56 INFO - ##### 16:33:56 INFO - Running pre-action listener: _resource_record_pre_action 16:33:56 INFO - Running main action method: read_buildbot_config 16:33:56 INFO - Using buildbot properties: 16:33:56 INFO - { 16:33:56 INFO - "properties": { 16:33:56 INFO - "buildnumber": 7, 16:33:56 INFO - "product": "firefox", 16:33:56 INFO - "script_repo_revision": "production", 16:33:56 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 16:33:56 INFO - "repository": "", 16:33:56 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 16:33:56 INFO - "buildid": "20151119131411", 16:33:56 INFO - "slavename": "t-yosemite-r7-0038", 16:33:56 INFO - "pgo_build": "False", 16:33:56 INFO - "basedir": "/builds/slave/test", 16:33:56 INFO - "project": "", 16:33:56 INFO - "platform": "yosemite_r7", 16:33:56 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 16:33:56 INFO - "slavebuilddir": "test", 16:33:56 INFO - "scheduler": "tests-fx-team-macosx64-talos", 16:33:56 INFO - "branch": "fx-team", 16:33:56 INFO - "repo_path": "integration/fx-team", 16:33:56 INFO - "stage_platform": "macosx64", 16:33:56 INFO - "builduid": "3e485fdec53b4a5fb7cdd2775c91ef0e", 16:33:56 INFO - "revision": "3e7e43113775c7af1076908eb33b8664241c0af9" 16:33:56 INFO - }, 16:33:56 INFO - "sourcestamp": { 16:33:56 INFO - "repository": "", 16:33:56 INFO - "hasPatch": false, 16:33:56 INFO - "project": "", 16:33:56 INFO - "branch": "fx-team-macosx64-talos", 16:33:56 INFO - "changes": [ 16:33:56 INFO - { 16:33:56 INFO - "category": null, 16:33:56 INFO - "files": [ 16:33:56 INFO - { 16:33:56 INFO - "url": null, 16:33:56 INFO - "name": "https://queue.taskcluster.net/v1/task/gQRM5_W8Rke8DVgKxHbI3w/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 16:33:56 INFO - } 16:33:56 INFO - ], 16:33:56 INFO - "repository": "", 16:33:56 INFO - "rev": "3e7e43113775c7af1076908eb33b8664241c0af9", 16:33:56 INFO - "who": "mdeboer@mozilla.com", 16:33:56 INFO - "when": 1447973902, 16:33:56 INFO - "number": 6685564, 16:33:56 INFO - "comments": "No bug: Array.slice not supported by Chrome, which the link clicker doesn't like. Use Array.prototype.slice instead. rs=Standard8", 16:33:56 INFO - "project": "", 16:33:56 INFO - "at": "Thu 19 Nov 2015 14:58:22", 16:33:56 INFO - "branch": "fx-team-macosx64-talos", 16:33:56 INFO - "revlink": "", 16:33:56 INFO - "properties": [ 16:33:56 INFO - [ 16:33:56 INFO - "buildid", 16:33:56 INFO - "20151119131411", 16:33:56 INFO - "Change" 16:33:56 INFO - ], 16:33:56 INFO - [ 16:33:56 INFO - "builduid", 16:33:56 INFO - "3e485fdec53b4a5fb7cdd2775c91ef0e", 16:33:56 INFO - "Change" 16:33:56 INFO - ], 16:33:56 INFO - [ 16:33:56 INFO - "pgo_build", 16:33:56 INFO - "False", 16:33:56 INFO - "Change" 16:33:56 INFO - ] 16:33:56 INFO - ], 16:33:56 INFO - "revision": "3e7e43113775c7af1076908eb33b8664241c0af9" 16:33:56 INFO - } 16:33:56 INFO - ], 16:33:56 INFO - "revision": "3e7e43113775c7af1076908eb33b8664241c0af9" 16:33:56 INFO - } 16:33:56 INFO - } 16:33:56 INFO - Found installer url https://queue.taskcluster.net/v1/task/gQRM5_W8Rke8DVgKxHbI3w/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 16:33:56 INFO - Running post-action listener: _resource_record_post_action 16:33:56 INFO - ##### 16:33:56 INFO - ##### Running download-and-extract step. 16:33:56 INFO - ##### 16:33:56 INFO - Running pre-action listener: _resource_record_pre_action 16:33:56 INFO - Running main action method: download_and_extract 16:33:56 INFO - mkdir: /builds/slave/test/build/tests 16:33:56 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')]} 16:33:56 INFO - https://queue.taskcluster.net/v1/task/gQRM5_W8Rke8DVgKxHbI3w/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 16:33:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gQRM5_W8Rke8DVgKxHbI3w/artifacts/public/build/test_packages.json 16:33:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gQRM5_W8Rke8DVgKxHbI3w/artifacts/public/build/test_packages.json 16:33:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gQRM5_W8Rke8DVgKxHbI3w/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 16:33:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gQRM5_W8Rke8DVgKxHbI3w/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 16:33:57 INFO - Downloaded 1149 bytes. 16:33:57 INFO - Reading from file /builds/slave/test/build/test_packages.json 16:33:57 INFO - Using the following test package requirements: 16:33:57 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 16:33:57 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 16:33:57 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 16:33:57 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 16:33:57 INFO - u'jsshell-mac.zip'], 16:33:57 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 16:33:57 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 16:33:57 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 16:33:57 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 16:33:57 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 16:33:57 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 16:33:57 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 16:33:57 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 16:33:57 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 16:33:57 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 16:33:57 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 16:33:57 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 16:33:57 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 16:33:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:33:57 INFO - https://queue.taskcluster.net/v1/task/gQRM5_W8Rke8DVgKxHbI3w/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 16:33:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gQRM5_W8Rke8DVgKxHbI3w/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 16:33:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gQRM5_W8Rke8DVgKxHbI3w/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 16:33:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gQRM5_W8Rke8DVgKxHbI3w/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 16:33:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gQRM5_W8Rke8DVgKxHbI3w/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 16:33:58 INFO - Downloaded 17522700 bytes. 16:33:58 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 16:33:58 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 16:33:58 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 16:34:01 INFO - Return code: 0 16:34:01 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 16:34:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:34:01 INFO - https://queue.taskcluster.net/v1/task/gQRM5_W8Rke8DVgKxHbI3w/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 16:34:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gQRM5_W8Rke8DVgKxHbI3w/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 16:34:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gQRM5_W8Rke8DVgKxHbI3w/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 16:34:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gQRM5_W8Rke8DVgKxHbI3w/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 16:34:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gQRM5_W8Rke8DVgKxHbI3w/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 16:34:02 INFO - Downloaded 17522700 bytes. 16:34:02 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 16:34:02 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 16:34:02 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 16:34:05 INFO - Return code: 0 16:34: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')]} 16:34:05 INFO - https://queue.taskcluster.net/v1/task/gQRM5_W8Rke8DVgKxHbI3w/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 16:34:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gQRM5_W8Rke8DVgKxHbI3w/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 16:34:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gQRM5_W8Rke8DVgKxHbI3w/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 16:34:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gQRM5_W8Rke8DVgKxHbI3w/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 16:34:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gQRM5_W8Rke8DVgKxHbI3w/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 16:34:06 INFO - Downloaded 11130997 bytes. 16:34: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 16:34:06 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 16:34:06 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 16:34:06 INFO - Return code: 0 16:34: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')]} 16:34:06 INFO - https://queue.taskcluster.net/v1/task/gQRM5_W8Rke8DVgKxHbI3w/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 16:34:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gQRM5_W8Rke8DVgKxHbI3w/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 16:34:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gQRM5_W8Rke8DVgKxHbI3w/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 16:34:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gQRM5_W8Rke8DVgKxHbI3w/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 16:34:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gQRM5_W8Rke8DVgKxHbI3w/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 16:34:09 INFO - Downloaded 109368101 bytes. 16:34:09 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/gQRM5_W8Rke8DVgKxHbI3w/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 16:34:09 INFO - mkdir: /builds/slave/test/properties 16:34:09 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:34:09 INFO - Writing to file /builds/slave/test/properties/build_url 16:34:09 INFO - Contents: 16:34:09 INFO - build_url:https://queue.taskcluster.net/v1/task/gQRM5_W8Rke8DVgKxHbI3w/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 16:34:09 INFO - Running post-action listener: _resource_record_post_action 16:34:09 INFO - Running post-action listener: set_extra_try_arguments 16:34:09 INFO - ##### 16:34:09 INFO - ##### Running populate-webroot step. 16:34:09 INFO - ##### 16:34:09 INFO - Running pre-action listener: _resource_record_pre_action 16:34:09 INFO - Running main action method: populate_webroot 16:34:09 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:34:09 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:34:09 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 16:34:09 INFO - '../fennec_ids.txt'], 16:34:09 INFO - 'tests': ['tcheck2']}, 16:34:09 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:34:09 INFO - '--tppagecycles', 16:34:09 INFO - '7'], 16:34:09 INFO - 'tests': ['tsvgm']}}, 16:34:09 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 16:34:09 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 16:34:09 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:34:09 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 16:34:09 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 16:34:09 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 16:34:09 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:34:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:34:09 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:34:09 INFO - 'talos_options': ['--e10s'], 16:34:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:34:09 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:34:09 INFO - 'tests': ['damp', 'tps']}, 16:34:09 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:34:09 INFO - 'talos_options': ['--e10s'], 16:34:09 INFO - 'tests': ['damp', 'tps']}, 16:34:09 INFO - 'g3': {'tests': ['dromaeo_dom']}, 16:34:09 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:34:09 INFO - 'other': {'tests': ['a11yr', 16:34:09 INFO - 'ts_paint', 16:34:09 INFO - 'tpaint', 16:34:09 INFO - 'sessionrestore', 16:34:09 INFO - 'sessionrestore_no_auto_restore']}, 16:34:09 INFO - 'other-e10s': {'talos_options': ['--e10s'], 16:34:09 INFO - 'tests': ['a11yr', 16:34:09 INFO - 'ts_paint', 16:34:09 INFO - 'tpaint', 16:34:09 INFO - 'sessionrestore', 16:34:09 INFO - 'sessionrestore_no_auto_restore']}, 16:34:09 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 16:34:09 INFO - 'tests': ['a11yr', 16:34:09 INFO - 'ts_paint', 16:34:09 INFO - 'tpaint', 16:34:09 INFO - 'sessionrestore', 16:34:09 INFO - 'sessionrestore_no_auto_restore']}, 16:34:09 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 16:34:09 INFO - 'tests': ['a11yr', 16:34:09 INFO - 'ts_paint', 16:34:09 INFO - 'tpaint', 16:34:09 INFO - 'sessionrestore', 16:34:09 INFO - 'sessionrestore_no_auto_restore']}, 16:34:09 INFO - 'other_l64': {'tests': ['a11yr', 16:34:09 INFO - 'ts_paint', 16:34:09 INFO - 'tpaint', 16:34:09 INFO - 'sessionrestore', 16:34:09 INFO - 'sessionrestore_no_auto_restore']}, 16:34:09 INFO - 'other_nol64': {'tests': ['a11yr', 16:34:09 INFO - 'ts_paint', 16:34:09 INFO - 'tpaint', 16:34:09 INFO - 'sessionrestore', 16:34:09 INFO - 'sessionrestore_no_auto_restore']}, 16:34:09 INFO - 'svgr': {'tests': ['tsvgx', 16:34:09 INFO - 'tsvgr_opacity', 16:34:09 INFO - 'tart', 16:34:09 INFO - 'tscrollx', 16:34:09 INFO - 'cart']}, 16:34:09 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 16:34:09 INFO - 'tests': ['tsvgx', 16:34:09 INFO - 'tsvgr_opacity', 16:34:09 INFO - 'tart', 16:34:09 INFO - 'tscrollx', 16:34:09 INFO - 'cart']}, 16:34:09 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:34:09 INFO - 'tests': ['tp5o']}, 16:34:09 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:34:09 INFO - 'talos_options': ['--e10s'], 16:34:09 INFO - 'tests': ['tp5o']}, 16:34:09 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:34:09 INFO - 'talos_options': ['--xperf_path', 16:34:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:34:09 INFO - 'tests': ['tp5n']}, 16:34:09 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:34:09 INFO - 'talos_options': ['--e10s', 16:34:09 INFO - '--xperf_path', 16:34:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:34:09 INFO - 'tests': ['tp5n']}}, 16:34:09 INFO - 'talos.zip': {'path': '', 16:34:09 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:34:09 INFO - Running post-action listener: _resource_record_post_action 16:34:09 INFO - ##### 16:34:09 INFO - ##### Running create-virtualenv step. 16:34:09 INFO - ##### 16:34:09 INFO - Running pre-action listener: _resource_record_pre_action 16:34:09 INFO - Running main action method: create_virtualenv 16:34:09 INFO - Creating virtualenv /builds/slave/test/build/venv 16:34:09 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 16:34:09 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:34:09 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:34:09 INFO - Using real prefix '/tools/python27' 16:34:09 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:34:10 INFO - Installing distribute.............................................................................................................................................................................................done. 16:34:13 INFO - Installing pip.................done. 16:34:13 INFO - Return code: 0 16:34:13 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:34:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:34:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:34:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:34:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:34:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:34:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:34:13 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 0x108fe4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108fc1228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb65ad8b3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108f089f0>, '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 0x108c67db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108efb8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TIGoEd1942/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.lamYHtLWcH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:34:13 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 16:34:13 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 16:34:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TIGoEd1942/Render', 16:34:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:34:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:34:13 INFO - 'HOME': '/Users/cltbld', 16:34:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:34:13 INFO - 'LOGNAME': 'cltbld', 16:34:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:34:13 INFO - 'MOZ_NO_REMOTE': '1', 16:34:13 INFO - 'NO_EM_RESTART': '1', 16:34:13 INFO - 'PAGER': '/bin/cat', 16:34:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:34:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:34:13 INFO - 'PWD': '/builds/slave/test', 16:34:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:34:13 INFO - 'SHELL': '/bin/bash', 16:34:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lamYHtLWcH/Listeners', 16:34:13 INFO - 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', 16:34:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:34:13 INFO - 'USER': 'cltbld', 16:34:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:34:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:34:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:34:13 INFO - 'XPC_FLAGS': '0x0', 16:34:13 INFO - 'XPC_SERVICE_NAME': '0', 16:34:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:34:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:34:13 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 16:34:13 INFO - Cleaning up... 16:34:13 INFO - Return code: 0 16:34:13 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 16:34:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:34:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:34:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:34:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:34:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:34:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:34:13 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 0x108fe4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108fc1228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb65ad8b3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108f089f0>, '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 0x108c67db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108efb8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TIGoEd1942/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.lamYHtLWcH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:34:13 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 16:34:13 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 16:34:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TIGoEd1942/Render', 16:34:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:34:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:34:13 INFO - 'HOME': '/Users/cltbld', 16:34:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:34:13 INFO - 'LOGNAME': 'cltbld', 16:34:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:34:13 INFO - 'MOZ_NO_REMOTE': '1', 16:34:13 INFO - 'NO_EM_RESTART': '1', 16:34:13 INFO - 'PAGER': '/bin/cat', 16:34:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:34:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:34:13 INFO - 'PWD': '/builds/slave/test', 16:34:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:34:13 INFO - 'SHELL': '/bin/bash', 16:34:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lamYHtLWcH/Listeners', 16:34:13 INFO - 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', 16:34:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:34:13 INFO - 'USER': 'cltbld', 16:34:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:34:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:34:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:34:13 INFO - 'XPC_FLAGS': '0x0', 16:34:13 INFO - 'XPC_SERVICE_NAME': '0', 16:34:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:34:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:34:14 INFO - Downloading/unpacking psutil>=0.7.1 16:34:14 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 16:34:14 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 16:34:14 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 16:34:14 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 16:34:14 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 16:34:14 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 16:34:16 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 16:34:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 16:34:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:34:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:34:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:34:16 INFO - Installing collected packages: psutil 16:34:16 INFO - Running setup.py install for psutil 16:34:16 INFO - building 'psutil._psutil_osx' extension 16:34:16 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 16:34:17 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 16:34:17 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 16:34:17 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 16:34:17 INFO - building 'psutil._psutil_posix' extension 16:34:17 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 16:34:17 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 16:34:17 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 16:34:17 INFO - ^ 16:34:17 INFO - 1 warning generated. 16:34:17 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 16:34:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:34:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:34:17 INFO - Successfully installed psutil 16:34:17 INFO - Cleaning up... 16:34:17 INFO - Return code: 0 16:34:17 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 16:34:17 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')]} 16:34:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:34:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:34:17 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')]} 16:34:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:34:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:34:17 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 0x108fe4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108fc1228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb65ad8b3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108f089f0>, '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 0x108c67db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108efb8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TIGoEd1942/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.lamYHtLWcH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:34:17 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 16:34:17 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 16:34:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TIGoEd1942/Render', 16:34:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:34:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:34:17 INFO - 'HOME': '/Users/cltbld', 16:34:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:34:17 INFO - 'LOGNAME': 'cltbld', 16:34:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:34:17 INFO - 'MOZ_NO_REMOTE': '1', 16:34:17 INFO - 'NO_EM_RESTART': '1', 16:34:17 INFO - 'PAGER': '/bin/cat', 16:34:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:34:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:34:17 INFO - 'PWD': '/builds/slave/test', 16:34:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:34:17 INFO - 'SHELL': '/bin/bash', 16:34:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lamYHtLWcH/Listeners', 16:34:17 INFO - 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', 16:34:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:34:17 INFO - 'USER': 'cltbld', 16:34:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:34:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:34:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:34:17 INFO - 'XPC_FLAGS': '0x0', 16:34:17 INFO - 'XPC_SERVICE_NAME': '0', 16:34:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:34:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:34:17 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:34:17 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 16:34:17 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 16:34:17 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 16:34:17 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 16:34:17 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 16:34:17 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 16:34:20 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:34:20 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 16:34:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:34:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 16:34:20 INFO - Installing collected packages: mozsystemmonitor 16:34:20 INFO - Running setup.py install for mozsystemmonitor 16:34:20 INFO - Successfully installed mozsystemmonitor 16:34:20 INFO - Cleaning up... 16:34:20 INFO - Return code: 0 16:34:20 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:34:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:34:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:34:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:34:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:34:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:34:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:34:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x108fe4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108fc1228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb65ad8b3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108f089f0>, '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 0x108c67db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108efb8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TIGoEd1942/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.lamYHtLWcH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:34:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:34:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:34:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TIGoEd1942/Render', 16:34:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:34:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:34:20 INFO - 'HOME': '/Users/cltbld', 16:34:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:34:20 INFO - 'LOGNAME': 'cltbld', 16:34:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:34:20 INFO - 'MOZ_NO_REMOTE': '1', 16:34:20 INFO - 'NO_EM_RESTART': '1', 16:34:20 INFO - 'PAGER': '/bin/cat', 16:34:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:34:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:34:20 INFO - 'PWD': '/builds/slave/test', 16:34:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:34:20 INFO - 'SHELL': '/bin/bash', 16:34:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lamYHtLWcH/Listeners', 16:34:20 INFO - 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', 16:34:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:34:20 INFO - 'USER': 'cltbld', 16:34:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:34:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:34:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:34:20 INFO - 'XPC_FLAGS': '0x0', 16:34:20 INFO - 'XPC_SERVICE_NAME': '0', 16:34:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:34:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:34:20 INFO - Downloading/unpacking blobuploader==1.2.4 16:34:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:34:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:34:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:34:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:34:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:34:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:34:22 INFO - Downloading blobuploader-1.2.4.tar.gz 16:34:22 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 16:34:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:34:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:34:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:34:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:34:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:34:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:34:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:34:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:34:23 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 16:34:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:34:23 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:34:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:34:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:34:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:34:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:34:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:34:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:34:23 INFO - Downloading docopt-0.6.1.tar.gz 16:34:23 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 16:34:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:34:23 INFO - Installing collected packages: blobuploader, requests, docopt 16:34:23 INFO - Running setup.py install for blobuploader 16:34:24 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:34:24 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:34:24 INFO - Running setup.py install for requests 16:34:24 INFO - Running setup.py install for docopt 16:34:24 INFO - Successfully installed blobuploader requests docopt 16:34:24 INFO - Cleaning up... 16:34:24 INFO - Return code: 0 16:34:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:34: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')]} 16:34:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:34:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:34: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')]} 16:34:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:34:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:34:24 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 0x108fe4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108fc1228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb65ad8b3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108f089f0>, '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 0x108c67db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108efb8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TIGoEd1942/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.lamYHtLWcH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:34:24 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 16:34:24 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 16:34:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TIGoEd1942/Render', 16:34:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:34:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:34:24 INFO - 'HOME': '/Users/cltbld', 16:34:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:34:24 INFO - 'LOGNAME': 'cltbld', 16:34:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:34:24 INFO - 'MOZ_NO_REMOTE': '1', 16:34:24 INFO - 'NO_EM_RESTART': '1', 16:34:24 INFO - 'PAGER': '/bin/cat', 16:34:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:34:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:34:24 INFO - 'PWD': '/builds/slave/test', 16:34:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:34:24 INFO - 'SHELL': '/bin/bash', 16:34:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lamYHtLWcH/Listeners', 16:34:24 INFO - 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', 16:34:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:34:24 INFO - 'USER': 'cltbld', 16:34:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:34:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:34:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:34:24 INFO - 'XPC_FLAGS': '0x0', 16:34:24 INFO - 'XPC_SERVICE_NAME': '0', 16:34:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:34:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:34:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:34:25 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-pAYAto-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:34:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:34:25 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-82v9D5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:34:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:34:25 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-oKbsVv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:34:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:34:25 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-WybQXE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:34:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:34:25 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-FyFZ8x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:34:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:34:25 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-0yZPig-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:34:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:34:25 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-X_fxh9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:34:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:34:25 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-RRyHdi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:34:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:34:25 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-1pb59i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:34:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:34:26 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-SBiohX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:34:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:34:26 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-CLsGdz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:34:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:34:26 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-5fnhOx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:34:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:34:26 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-403GPu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:34:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:34:26 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-NoACSf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:34:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:34:26 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-iEAoUQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:34:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:34:26 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-e19lsL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:34:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:34:26 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-yQv1O0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:34:26 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:34:26 INFO - Running setup.py install for manifestparser 16:34:26 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:34:26 INFO - Running setup.py install for mozcrash 16:34:27 INFO - Running setup.py install for mozdebug 16:34:27 INFO - Running setup.py install for mozdevice 16:34:27 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:34:27 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:34:27 INFO - Running setup.py install for mozfile 16:34:27 INFO - Running setup.py install for mozhttpd 16:34:27 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:34:27 INFO - Running setup.py install for mozinfo 16:34:27 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:34:27 INFO - Running setup.py install for mozInstall 16:34:27 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:34:27 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:34:27 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:34:27 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:34:27 INFO - Running setup.py install for mozleak 16:34:28 INFO - Running setup.py install for mozlog 16:34:28 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:34:28 INFO - Running setup.py install for moznetwork 16:34:28 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:34:28 INFO - Running setup.py install for mozprocess 16:34:28 INFO - Running setup.py install for mozprofile 16:34:28 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:34:28 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:34:28 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:34:28 INFO - Running setup.py install for mozrunner 16:34:28 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:34:28 INFO - Running setup.py install for mozscreenshot 16:34:29 INFO - Running setup.py install for moztest 16:34:29 INFO - Running setup.py install for mozversion 16:34:29 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:34:29 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:34:29 INFO - Cleaning up... 16:34:29 INFO - Return code: 0 16:34:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:34: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')]} 16:34:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:34:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:34: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')]} 16:34:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:34:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:34:29 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 0x108fe4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108fc1228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb65ad8b3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108f089f0>, '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 0x108c67db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108efb8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TIGoEd1942/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.lamYHtLWcH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:34:29 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 16:34:29 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 16:34:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TIGoEd1942/Render', 16:34:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:34:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:34:29 INFO - 'HOME': '/Users/cltbld', 16:34:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:34:29 INFO - 'LOGNAME': 'cltbld', 16:34:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:34:29 INFO - 'MOZ_NO_REMOTE': '1', 16:34:29 INFO - 'NO_EM_RESTART': '1', 16:34:29 INFO - 'PAGER': '/bin/cat', 16:34:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:34:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:34:29 INFO - 'PWD': '/builds/slave/test', 16:34:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:34:29 INFO - 'SHELL': '/bin/bash', 16:34:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lamYHtLWcH/Listeners', 16:34:29 INFO - 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', 16:34:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:34:29 INFO - 'USER': 'cltbld', 16:34:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:34:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:34:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:34:29 INFO - 'XPC_FLAGS': '0x0', 16:34:29 INFO - 'XPC_SERVICE_NAME': '0', 16:34:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:34:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:34:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:34:29 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-nu7kyZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:34:29 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)) 16:34:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:34:29 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-KeUuhZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:34:29 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)) 16:34:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:34:29 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-qn3JEN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:34:29 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)) 16:34:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:34:29 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-q428GW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:34:30 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)) 16:34:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:34:30 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-tSsPha-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:34:30 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)) 16:34:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:34:30 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-ejm9Uh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:34:30 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)) 16:34:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:34:30 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-jEhIFA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:34:30 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)) 16:34:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:34:30 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-oGZnPL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:34:30 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)) 16:34:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:34:30 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-ikdloX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:34:30 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)) 16:34:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:34:30 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-wJenps-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:34:30 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)) 16:34:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:34:30 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-dOQ8nC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:34:30 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)) 16:34:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:34:30 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-s6MNvm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:34:30 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)) 16:34:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:34:30 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-kcxjPG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:34:31 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)) 16:34:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:34:31 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-5Q7N7v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:34:31 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)) 16:34:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:34:31 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-a3xXXv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:34:31 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)) 16:34:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:34:31 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-Hnd_6o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:34:31 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)) 16:34:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:34:31 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-K9Wn89-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:34:31 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)) 16:34:31 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)) 16:34:31 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)) 16:34:31 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)) 16:34:31 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)) 16:34:31 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)) 16:34:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:34:31 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 16:34:31 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 16:34:31 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 16:34:31 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 16:34:31 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 16:34:31 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 16:34:33 INFO - Downloading blessings-1.5.1.tar.gz 16:34:33 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 16:34:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:34:33 INFO - Installing collected packages: blessings 16:34:33 INFO - Running setup.py install for blessings 16:34:33 INFO - Successfully installed blessings 16:34:33 INFO - Cleaning up... 16:34:33 INFO - Return code: 0 16:34:33 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:34:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:34:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:34:34 INFO - Reading from file tmpfile_stdout 16:34:34 INFO - Current package versions: 16:34:34 INFO - blessings == 1.5.1 16:34:34 INFO - blobuploader == 1.2.4 16:34:34 INFO - docopt == 0.6.1 16:34:34 INFO - manifestparser == 1.1 16:34:34 INFO - mozInstall == 1.12 16:34:34 INFO - mozcrash == 0.16 16:34:34 INFO - mozdebug == 0.1 16:34:34 INFO - mozdevice == 0.47 16:34:34 INFO - mozfile == 1.2 16:34:34 INFO - mozhttpd == 0.7 16:34:34 INFO - mozinfo == 0.9 16:34:34 INFO - mozleak == 0.1 16:34:34 INFO - mozlog == 3.0 16:34:34 INFO - moznetwork == 0.27 16:34:34 INFO - mozprocess == 0.22 16:34:34 INFO - mozprofile == 0.27 16:34:34 INFO - mozrunner == 6.11 16:34:34 INFO - mozscreenshot == 0.1 16:34:34 INFO - mozsystemmonitor == 0.0 16:34:34 INFO - moztest == 0.7 16:34:34 INFO - mozversion == 1.4 16:34:34 INFO - psutil == 3.1.1 16:34:34 INFO - requests == 1.2.3 16:34:34 INFO - wsgiref == 0.1.2 16:34:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:34:34 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')]} 16:34:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:34:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:34:34 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')]} 16:34:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:34:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:34:34 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 0x108fe4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108fc1228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb65ad8b3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108f089f0>, '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 0x108c67db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108efb8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TIGoEd1942/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.lamYHtLWcH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:34:34 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 16:34:34 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 16:34:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TIGoEd1942/Render', 16:34:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:34:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:34:34 INFO - 'HOME': '/Users/cltbld', 16:34:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:34:34 INFO - 'LOGNAME': 'cltbld', 16:34:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:34:34 INFO - 'MOZ_NO_REMOTE': '1', 16:34:34 INFO - 'NO_EM_RESTART': '1', 16:34:34 INFO - 'PAGER': '/bin/cat', 16:34:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:34:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:34:34 INFO - 'PWD': '/builds/slave/test', 16:34:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:34:34 INFO - 'SHELL': '/bin/bash', 16:34:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lamYHtLWcH/Listeners', 16:34:34 INFO - 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', 16:34:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:34:34 INFO - 'USER': 'cltbld', 16:34:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:34:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:34:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:34:34 INFO - 'XPC_FLAGS': '0x0', 16:34:34 INFO - 'XPC_SERVICE_NAME': '0', 16:34:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:34:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:34:34 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)) 16:34:34 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)) 16:34:34 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)) 16:34:34 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)) 16:34:34 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)) 16:34:34 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)) 16:34:34 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)) 16:34:34 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)) 16:34:34 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)) 16:34:34 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)) 16:34:34 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)) 16:34:34 INFO - Cleaning up... 16:34:34 INFO - Return code: 0 16:34:34 INFO - Running post-action listener: _resource_record_post_action 16:34:34 INFO - Running post-action listener: _start_resource_monitoring 16:34:34 INFO - Starting resource monitoring. 16:34:34 INFO - ##### 16:34:34 INFO - ##### Running install step. 16:34:34 INFO - ##### 16:34:34 INFO - Running pre-action listener: _resource_record_pre_action 16:34:34 INFO - Running main action method: install 16:34:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:34:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:34:34 INFO - Reading from file tmpfile_stdout 16:34:34 INFO - Detecting whether we're running mozinstall >=1.0... 16:34:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:34:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:34:34 INFO - Reading from file tmpfile_stdout 16:34:34 INFO - Output received: 16:34:34 INFO - Usage: mozinstall [options] installer 16:34:34 INFO - Options: 16:34:34 INFO - -h, --help show this help message and exit 16:34:34 INFO - -d DEST, --destination=DEST 16:34:34 INFO - Directory to install application into. [default: 16:34:34 INFO - "/builds/slave/test"] 16:34:34 INFO - --app=APP Application being installed. [default: firefox] 16:34:34 INFO - mkdir: /builds/slave/test/build/application 16:34:34 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'] 16:34:34 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 16:35:05 INFO - Reading from file tmpfile_stdout 16:35:05 INFO - Output received: 16:35:05 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 16:35:05 INFO - Running post-action listener: _resource_record_post_action 16:35:05 INFO - ##### 16:35:05 INFO - ##### Running run-tests step. 16:35:05 INFO - ##### 16:35:05 INFO - Running pre-action listener: _resource_record_pre_action 16:35:05 INFO - Running main action method: run_tests 16:35:05 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:35:05 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:35:05 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:35:05 INFO - 2015-11-19 16:35:05.245 screenresolution[1931:18472] starting screenresolution argv=screenresolution get 16:35:05 INFO - 2015-11-19 16:35:05.248 screenresolution[1931:18472] Display 0: 1600x1200x32@60 16:35:05 INFO - 2015-11-19 16:35:05.254 screenresolution[1932:18475] starting screenresolution argv=screenresolution list 16:35:05 INFO - Available Modes on Display 0 16:35:05 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:35:05 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:35:05 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:35:05 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:35:05 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:35:05 INFO - Intel Iris: 16:35:05 INFO - Chipset Model: Intel Iris 16:35:05 INFO - Type: GPU 16:35:05 INFO - Bus: Built-In 16:35:05 INFO - VRAM (Dynamic, Max): 1536 MB 16:35:05 INFO - Vendor: Intel (0x8086) 16:35:05 INFO - Device ID: 0x0a2e 16:35:05 INFO - Revision ID: 0x0009 16:35:05 INFO - Displays: 16:35:05 INFO - Display: 16:35:05 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:35:05 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:35:05 INFO - Display Serial Number: 1600x1200 60 16:35:05 INFO - Main Display: Yes 16:35:05 INFO - Mirror: Off 16:35:05 INFO - Online: Yes 16:35:05 INFO - Rotation: Supported 16:35:05 INFO - Return code: 0 16:35:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:35:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:35:05 INFO - Python 2.7.3 16:35:05 INFO - Return code: 0 16:35:05 INFO - grabbing minidump binary from tooltool 16:35: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')]} 16:35:05 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 0x108f089f0>, '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 0x108c67db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108efb8c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:35:05 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 16:35:05 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 16:35:05 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:35:05 INFO - Return code: 0 16:35:05 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 16:35:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:35:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:35:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 16:35:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:35:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/gQRM5_W8Rke8DVgKxHbI3w/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0038', '--webServer', 'localhost'] in /builds/slave/test/build 16:35:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/gQRM5_W8Rke8DVgKxHbI3w/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0038 --webServer localhost 16:35:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TIGoEd1942/Render', 16:35:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:35:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:35:05 INFO - 'HOME': '/Users/cltbld', 16:35:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:35:05 INFO - 'LOGNAME': 'cltbld', 16:35:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:35:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 16:35:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:35:05 INFO - 'MOZ_NO_REMOTE': '1', 16:35:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:35:05 INFO - 'NO_EM_RESTART': '1', 16:35:05 INFO - 'PAGER': '/bin/cat', 16:35:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:35:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:35:05 INFO - 'PWD': '/builds/slave/test', 16:35:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:35:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:35:05 INFO - 'SHELL': '/bin/bash', 16:35:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lamYHtLWcH/Listeners', 16:35:05 INFO - 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', 16:35:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:35:05 INFO - 'USER': 'cltbld', 16:35:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:35:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:35:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:35:05 INFO - 'XPC_FLAGS': '0x0', 16:35:05 INFO - 'XPC_SERVICE_NAME': '0', 16:35:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:35:05 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/gQRM5_W8Rke8DVgKxHbI3w/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0038', '--webServer', 'localhost'] with output_timeout 3600 16:35:05 INFO - mozversion INFO | application_buildid: 20151119131411 16:35:05 INFO - mozversion INFO | application_changeset: 3e7e43113775c7af1076908eb33b8664241c0af9 16:35:05 INFO - mozversion INFO | application_display_name: Nightly 16:35:05 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:35:05 INFO - mozversion INFO | application_name: Firefox 16:35:05 INFO - mozversion INFO | application_remotingname: firefox 16:35:05 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 16:35:05 INFO - mozversion INFO | application_vendor: Mozilla 16:35:05 INFO - mozversion INFO | application_version: 45.0a1 16:35:05 INFO - mozversion INFO | platform_buildid: 20151119131411 16:35:05 INFO - mozversion INFO | platform_changeset: 3e7e43113775c7af1076908eb33b8664241c0af9 16:35:05 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 16:35:05 INFO - mozversion INFO | platform_version: 45.0a1 16:35:05 INFO - 2015-11-19 16:35:05,789 DEBUG : using testdate: 1447979705 16:35:05 INFO - 2015-11-19 16:35:05,789 DEBUG : actual date: 1447979705 16:35:06 INFO - 2015-11-19 16:35:06,265 INFO : starting webserver on 'localhost:57090' 16:35:06 INFO - 2015-11-19 16:35:06,265 INFO : Starting test suite t-yosemite-r7-0038.e 16:35:06 INFO - 2015-11-19 16:35:06,265 INFO : Starting test dromaeo_css 16:35:06 INFO - 2015-11-19 16:35:06,266 DEBUG : operating with platform_type : mac_ 16:35:06 INFO - 2015-11-19 16:35:06,267 INFO : Initialising browser for dromaeo_css test... 16:35:06 INFO - 2015-11-19 16:35:06,278 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/tmpnkRk0B/profile http://localhost:57090/getInfo.html 16:35:08 INFO - 2015-11-19 16:35:08,739 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 16:35:08 INFO - 2015-11-19 16:35:08,739 DEBUG : BROWSER_OUTPUT: colorDepth:24 16:35:08 INFO - 2015-11-19 16:35:08,739 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 16:35:08 INFO - 2015-11-19 16:35:08,739 DEBUG : BROWSER_OUTPUT: __metrics 16:35:09 INFO - 2015-11-19 16:35:09,322 INFO : Browser initialized. 16:35:09 INFO - 2015-11-19 16:35:09,322 INFO : Running cycle 1/1 for dromaeo_css test... 16:35:09 INFO - 2015-11-19 16:35:09,322 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/tmpnkRk0B/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 16:35:21 INFO - 2015-11-19 16:35:21,393 DEBUG : BROWSER_OUTPUT: RSS: Main: 236183552 16:35:21 INFO - 2015-11-19 16:35:21,393 DEBUG : BROWSER_OUTPUT: 16:36:11 INFO - 2015-11-19 16:36:11,136 DEBUG : BROWSER_OUTPUT: 1447979771129 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] 16:38:21 INFO - 2015-11-19 16:38:21,625 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57090/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57090/tests/dromaeo/cssquery-ext.html) 16:38:22 INFO - 2015-11-19 16:38:22,837 DEBUG : BROWSER_OUTPUT: RSS: Main: 252235776 16:38:22 INFO - 2015-11-19 16:38:22,837 DEBUG : BROWSER_OUTPUT: 16:41:24 INFO - 2015-11-19 16:41:24,785 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57090/tests/dromaeo/cssquery-ext.html (next: http://localhost:57090/tests/dromaeo/cssquery-jquery.html) 16:41:25 INFO - 2015-11-19 16:41:25,383 DEBUG : BROWSER_OUTPUT: RSS: Main: 262815744 16:41:25 INFO - 2015-11-19 16:41:25,383 DEBUG : BROWSER_OUTPUT: 16:44:27 INFO - 2015-11-19 16:44:27,050 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57090/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57090/tests/dromaeo/cssquery-mootools.html) 16:44:27 INFO - 2015-11-19 16:44:27,653 DEBUG : BROWSER_OUTPUT: RSS: Main: 262791168 16:44:27 INFO - 2015-11-19 16:44:27,653 DEBUG : BROWSER_OUTPUT: 16:47:29 INFO - 2015-11-19 16:47:29,299 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57090/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57090/tests/dromaeo/cssquery-prototype.html) 16:47:29 INFO - 2015-11-19 16:47:29,891 DEBUG : BROWSER_OUTPUT: RSS: Main: 265678848 16:47:29 INFO - 2015-11-19 16:47:29,892 DEBUG : BROWSER_OUTPUT: 16:50:32 INFO - 2015-11-19 16:50:32,393 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57090/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57090/tests/dromaeo/cssquery-yui.html) 16:50:32 INFO - 2015-11-19 16:50:32,992 DEBUG : BROWSER_OUTPUT: RSS: Main: 268926976 16:50:32 INFO - 2015-11-19 16:50:32,992 DEBUG : BROWSER_OUTPUT: 16:53:35 INFO - 2015-11-19 16:53:35,342 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57090/tests/dromaeo/cssquery-yui.html (next: http://localhost:57090/tests/dromaeo/cssquery-dojo.html) 16:53:35 INFO - 2015-11-19 16:53:35,599 DEBUG : BROWSER_OUTPUT: RSS: Main: 271507456 16:53:35 INFO - 2015-11-19 16:53:35,599 DEBUG : BROWSER_OUTPUT: 16:53:35 INFO - 2015-11-19 16:53:35,599 DEBUG : BROWSER_OUTPUT: __start_tp_report 16:53:35 INFO - 2015-11-19 16:53:35,599 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 16:53:35 INFO - 2015-11-19 16:53:35,599 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 16:53:35 INFO - 2015-11-19 16:53:35,600 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 16:53:35 INFO - 2015-11-19 16:53:35,600 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2581.7160112387646;3002.9849850750743;3377.54403155574;3471.30573885223;3518.982405087975;4594.74728889911;5700.429957004298;5725.971370143148;5741.110127930167;5761.107028410593;5639.943600563993;5752.769889204437;5760.62555933864;5783.942160578393;5803.506701930341;5286.207068939651;5292.126799078157;5309.761060752276;5376.758045887945;5427.592930530206;5372.435894231108;5379.112446446332;5393.19102134681;5401;5409.053415652264;5159.71621560814;5190.143626301693;5283.821854582492;5414;5430.56555475561;5311.867203319909;5322.760475778599;5331.093714068579;5353.437889021636;5354.437784032699;5280.2343660169445;5307.920381194285;5309.522143007148;5310.787568497255;5311.575073994071;4168;4301.462317210348;5406.8918621627345;5524.640898341635;5570.6657600543695;6257.342978987186;6262.123302737575;6318.304986451487;6320.74717011319;6333.461655759266;6180.351063138396;6364.681765911732;6367.140436041122;6367.554271201017;6369.140166077566;5821.27234095738;5864.237649105632;5949.405059494016;5952.107183922403;5995.310539288038;6329.7468101275435;6401.647909364937;6480.57876238043;6484.481241500669;6507;5964.522838172936;6292.968535157295;6317.431431171217;6323.841903952438;6340.112384266206;6248.218972628421;6277.089821975788;6316.589421687576;6372.776952806722;6379.553431259767;6254.468370188494;6316.431521163117;6322.146510221061;6328.398802113792;6410.326915673881;5226.869328266824;6125.081237814364;6214.067889816563;6342.682865856781;6362.6500542469685;4906.803727850846;5011.824586139541;5016.724080175625;5027.271045698353;5069.619778516626;4486.573775491388;4507.8196872124745;4522.796474158671;4523.705959112647;4547.772611369418;5676.801311954062;5859.414058594107;5863.413658634187;5990.670513121733;6006.339302676702;6230.376962303733;6288.182536270256;6344.619322840645;6365.204349456318;6371.681415929185;5982.102684597346;5983.700814959235;5989.221401217814;6001;6015.368386319461;5368.355797304349;5391.272178255886;5506.64206826555;5559.666420014732;5576.302962129734;6480.25477070143;6508.088867558451;6511.023346498063;6519.674016299166;6539.607623542603;6336.651484168415;6362.459190968634;6367.649779262185;6380.1067850501895;6394.872102558016;6223.844403889939;6285.685715714288;6346.619202847844;6441.194850643669;6494.902576461452;6261.68691565429;6308.779192728232;6311.526635502264;6312.810615681537;6315.621062736251;6313.305536391085;6318.304986451579;6367.013112967497;6370.331115232834;6427.260865000585;6084.874298254837;6150.538709596709;6168.506519478341;6283.622982621057;6284.151639528605;5256.291705195903;6284.088807123033;6293.3391993841815;6295.811125666054;6323.304436512072;5804.042333015005;6081.422264884829;6178.62928224308;6185.195924529782;6199.349068347939;4402.911941761211;4454.443194600675;6048;6115.908261375994;6157.568970172045;6095.878082438415;6147.538934580014;6156.538259630456;6157.784477543443;6181.567290289637 16:53:35 INFO - 2015-11-19 16:53:35,600 DEBUG : BROWSER_OUTPUT: |1;ext.html;546.6692650946178;567.486424785569;586.7213073789948;595.309441048384;620.2216218645599;40935.59064409355;41348.37977430341;41467.37798933018;41572.79213603928;41627.16745665089;42582.78708606453;42990;42991.78504107483;43118.13763724724;43308;9765.365251258663;9851.359661621971;9956.701298961007;9959.25305602079;9986.400815951067;9835.65575204868;9938.751531211705;9952.552135153936;9990.90009099907;9997.550110245056;9844.655437059704;9855.802883942317;9891.159251463634;9929.801403971916;9975.700728978143;9838.90161098387;9921.90078099217;9923.206143508502;9965.850512242323;9981.700548983543;9701.757456063584;9785.972472890315;9851.90148098517;9858.704238872846;9863.30956833022;39520.20959580792;39712.404313935316;40082.59917400818;40116.59883401158;40245;3232.434323993292;3279.622843372995;3294.884679036222;3316.7844090134063;3484.1986343140966;24034.639480407808;27506;27997.860010699816;28763.137105886857;28953.42093158125;2530.4812513434704;2543.910963116282;2544.732803055671;2570.7943364530793;2616.856072915989;513012;514695;515523;516132;516662;58170;59176.704116479144;63023.6848815753;63334;63803.680981595724;60509.39490605125;60763;61233;61311.38688613146;61506;16423;16493.917530412513;16514.174291285388;16597.83402165963;16610.169491525376;12633.684157895943;12673.366331683379;12772.233665979886;12785.872141278654;12796.23222606628;19303.055984844763;19373.4187974361;19572.804271957382;19801;20095;8936.006437843265;9147.54262286883;9151.757819334172;9153.947296060906;9157.077013827171;976.4483067067226;986.9654562090436;1048.5124417145912;1074.301703892476;1097.2483848563759;21885.343439696833;25168.370790730012;27907.860460697568;28142.43715125686;28371.432571348458;1012.5139932832282;1048.4600430778155;1101.6694991502518;1168.720251324798;1175.588544009607;13877.791833122512;14233.35949882237;14279.714405711828;15368.692626147415;15456.149911754961;552716;554372.2281388567;560016;561015;563041.1847940816;57964.42035579675;58207;58433.41566584365;58496;58748.11877821836;1413.1450472464217;1433.9139651620935;1443.8483959184343;1444.075791493424;1450.4923276853017;28490.857545712966;29160.562591561567;29253;29357.559636605896;29776.702232977394;49136.01727965349;49292.01415971732;49338.506614933394;49567.75216123896;49578.75210623924;523368;525621.371893138;528122;528285;529464;30675;33184.834075829465;33910.15224619404;33912.32175356529;33931.49102763411;42960.57039429565;43282;43493.3475997854;44539.33191002073;45782;37150.0943034725;37467;37624.811875940446;37673;37934.62065379311;35795.82102089473;35818.462723059696;36048.459273111446;36591.08522286964;36660.266794664494;36256.81871590625;36707.26585468329;36735.63264367322;36796.63203367932;37089.44365834461;30447;31337.542709852667;31724.20689482689;32025;32248.83875580607;19173.90413047926;24000;24052.15817446381;24248;24539.386515336544 16:53:35 INFO - 2015-11-19 16:53:35,602 DEBUG : BROWSER_OUTPUT: |2;jquery.html;350.8736854732297;352.10565164482216;354.503694827242;354.5178557162259;357.88547664747273;16670.083145426997;20334.89832550837;20551.691724624143;21072;21784.346469605916;16916.66166676669;18473;20222.696659550118;20534.794652053475;20746.48133796652;5730.169125476803;5740.339860916007;5916.171735956969;5924.644521328734;5928.2293301870695;4213.262679031172;4351.173277077345;5833.212516310307;6274.4353008229255;6427.357264273559;6270.278917924452;6281.780137695182;6358.68206589671;6363.936360636404;6384.680765961706;4813.66304358695;4913.434954980169;4932.654714170009;4936.950630493685;4945.505449455061;3767.963809952285;3962.346212874872;4127.855525056639;4158.459400277975;4235.512916014636;11351.659450216506;12357.62927112179;13937;14021.579352619336;14182.219977901212;1883.7174423836398;1942.6211888681712;1958.4222654317011;2008.2167954497756;2070.943818652483;10136.847947280796;10227;10258.230632702576;10554.788904221949;10610.363378197333;1364.3519328319069;1380.3305396882504;1601.7666396874458;1609.3803885504049;1646.2838665180566;96812;100712.49643751807;100777;101983;102389.48805256074;5660.320761508646;6703.162104736908;6741.1236539249585;6813.182418109759;6845.691943862538;7670.961645191738;7708.421868359896;7733.072031356273;7767.262110099645;7782;5721.485066344049;5724.484796368347;5764.106563482667;5784.942150578525;6057.42454466825;5039.319691841554;6230.06549017651;6253.624782513064;6262.436380725757;6267.71795269214;3005.353848922492;3026.803257788281;3032.696730326994;3059;3059.969400306013;1071.2554774431694;1092.8470463660756;1097.7859317433183;1099.0712847643729;1136.9772604547863;360.3855426497867;427.088166763955;427.6536005835283;433.82213292549903;436.8165370544379;9325.673601423918;11815.232009919328;12355.38223088842;12455.501779928702;12528.185667931555;456.9497355290915;463.9164950308909;473.03500858249475;474.20570544338096;511.6929842094713;6345.841353966188;6485.935140648533;6556.24603170632;6615.834604134935;6672.332766723386;753387;763685;765249;774727;777575;116012;122033;129967.35016325046;133389;139776;463.9095376401637;479.38638542665444;480.34672844930867;481.5569675898182;482.351237585447;11124.61063862761;11596.94201528987;11791.585009798879;12076.21504602198;12209.473815773028;49668;52997.67505812385;53824;54531.636709081;56895.431045689016;70788.64605676939;70865;71913.64043179751;76829;77326.61336693281;7979.5611241382285;8111.878321825296;8189.385796065199;8256.669733210605;8307.6676932922;10616.416097114425;12448.377581121089;12491.875731184236;12577.30824804608;12636.3681815907;10695.5187016586;10988.395638239654;11031.613893513688;11093;11154.609588664358;9762;10778.946105269424;11104.278221915549;11117.83323250168;11178;10740.570377184826;10822.188335874684;11026.779464410507;11248.100151987985;11462.14033947474;8023.558704271321;8114.715984940499;8243.340532757245;8284.088750237348;8286.917130828855;10469.110125639101;10855.728606784893;11025.393603351893;11028.503717332578;11076.39079850616 16:53:35 INFO - 2015-11-19 16:53:35,605 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1523.6190952261934;1565.9921700391496;1577.0537677393559;1877.6338613970277;1896.0804010055126;6953.582785032895;7836.412269079828;7965.362770978322;8778.4732916025;8786.912130878698;8293.04629967554;8424.326053915687;8507.404481686284;8538.87191692125;8541.487510749359;2387.224152150545;2431.3921519620094;2432.793212576933;2441.011390386896;2443.780059794618;2413.662087307778;2449.6570480132796;2463.7289898111194;2469.172827102923;2475.9876200618974;2403.7836594706473;2432.0393444589463;2435.488547405047;2442.0598069743187;2446.840955337906;2379.928602141921;2405.1702162753822;2422.152246713645;2427.611582146857;2438.146648672968;2436.8903399347073;2449.30194894456;2471.0980492120425;2475.4553998120564;2476.863772492512;8455.873161902577;8509.149085091442;8547.786305342353;8554.914450855536;8595.613197406132;4714.198586240347;5176.508231718019;5271.472852714698;5272.235525848769;5285.2600635911;2896.9130926072253;3250.30118524516;3546.202104526487;3586.4620306953907;3636.8181590920613;1034.3586976074882;1040.1990467340106;1052.4316868890867;1078.5524007536862;1083.8699356077243;9828.705138845775;10532.473376331152;10924.235303528756;11009.064229540418;11034.282771619819;4670.2533153339045;4696.694714843524;4759.143354196209;4814.807407703653;4819.325294458778;9809.950950245204;9830.672859163922;9832.164266037324;9834.754131146636;9842.704718858302;5179.326687530597;5266.868328291746;5267.473252674702;5284.656497327662;5312.73436328182;4803.735794531264;4821.987382649683;4828.46886842447;4842.782074806642;4843.95156048435;3779.149691319431;3819.8854034379015;3827.234553089393;3855.807209639563;3860.5560360558334;1235.734317121823;1255.1465003797505;1264.740728150727;1266.771981043421;1267.6197140857705;1338.3575883575938;1351.6688411339285;1382.3088455771913;1415.2357726827397;1421.3674914663081;7762.068551773823;7799.18108598589;7906.407019473562;7924.683012679428;7935.325497332676;498.2750098606519;504.23104765233313;512.1217112651821;513.1456125550991;517.0254071076049;5878.559108066912;6189.938100619026;6230;6240;6243.719032643542;9264.861027084598;10084.949575252076;10119.988001199821;10152.898471015344;10198;9781.804363912683;9971.45157016371;9978.550965206583;9989.100980911608;10037.598496060076;7800.531968081933;7864.41016923733;7893.250141236574;7920.049594048751;7920.128785833554;7711.537307761552;7711.768646940601;7774.494657847448;7790.727324543614;7807.063152421746;8863.645454182019;9063.954680226556;9067.68263110788;9160.221381182673;9173.633054678005;8304.128066553167;9173.35786494939;9197;9360.11078947499;9464.716058518256;7293.890591641236;7339.229380914927;7363.852722945619;7365.705371785283;7416.48084634092;7966.243206895336;8047.597620119088;8049.637766300413;8061.153578874134;8068.152843951535;7508.2867127622785;7528.585927774025;7530.058742657168;7633.007708997795;7689.538627682357;7370.152432470334;7385.852282954418;7460.9927659765235;7485.401167906445;7572.129205141479;7399.741009064657;7527.774166775005;7575.280348366897;7585.241475852371;7587.089549253904;6838.111045564045;6851.486138539729;6890.758823441155;6922.965385173042;6936.375726184668;6908.516403851682;6961.095057642474;6980.685869136003;6985.615791131537;6991.615461149686 16:53:35 INFO - 2015-11-19 16:53:35,606 DEBUG : BROWSER_OUTPUT: |4;prototype.html;280.0869166517154;322.30864795014696;326.8757872008637;328.25813661125846;334.2429397414857;6792.830179245515;6831.965840170792;6970.8257293567685;7030.648467576626;7069.575825450476;6720.438167771089;6932.549384290018;6938.271481494447;6958.756443524478;6982.301769823015;5067.949320506794;5088.745562721849;5089.938574877181;5089.974550127245;5094.923576146361;4900.436449808282;5057.519535644126;5067.467915868836;5073.365829271341;5075.7715902784275;4982.950170498285;4985.700857948516;4991.975040124794;5006.499350065001;5024.296598476216;4975.502449755014;4988.002399520111;4992.350994370727;4997.450280469164;5014.122528557488;4121.825279795244;4193.22425351311;4211.368294755781;4235.851745188935;4240.575942405766;5843.948089343959;6640.535162538624;6658.600483970978;6675.833104172386;6692.598444093322;5633.6619802811965;5967.6121052131475;5969.074793407029;5986.491148252404;6021.277446706379;6354.3963323484195;7202.459815513805;7338.633068346561;7460.850782984364;7478.2895624915545;4149.734331029035;4438.556144385568;4704.811807527695;4718.669693121483;4721.102990431841;7810.648520816577;7918.337149198675;7928.524288542706;7947.08608510023;7957.811601809491;4636.304554316879;4764.95235047652;4772.236442169236;4776.259679749575;4781.2111001685025;4129.752214867118;4845.103655823684;4921.680090794087;4932.4081110267;4945.901081978341;5885.793997210077;5954.970225148933;5960.374160713062;5971.970140149271;6015.4586087252355;7536.284053014955;7538.246175382527;7544.170141284454;7555.811104722316;7582.54504729707;1614.7335689611082;1673.046363572752;1674.5311312832425;1677.8825482216128;1685.056368433681;1011.726833754882;1060.8037513059953;1069.1446842525947;1081.464674985887;1088.5972190289644;6939.791806245821;6961.860762784716;6962.094927659473;6974.616396098263;6993.440524758007;7522.247775222434;7629.7329593463965;7639.350655194371;7644.6942122315595;7690.923090769021;5367.677939323653;5592.552595792326;5821.679807610537;6751.797446076625;6990.4757143214465;3307.818070006125;3966.781826999485;3985.960140398617;4040.6565441937764;4071.9389209161886;6426.421622053944;6463.578012837168;7951.284384405431;8077.151899050633;8139.633716482773;8133.633986470623;8142.918570814334;8147.837043259102;8152.225538573826;8168.224018718212;7959.681612735426;8097;8164.918350816534;8171.591420429074;8172.550509721904;7647.808804779925;7827.25641064098;7828.5694286812495;7870.763877083697;7880.487768295043;7154.534955227893;7464.216257292906;7669.118051424158;7715.807104822425;7727.652255648622;6924.169099708067;7032.980217868483;8127.75616731499;8142.918570814216;8165.020197576328;4823.252395878644;4825.831095911626;4826.758662066953;4832.251001094836;4851.393575803025;7587.544747315179;7799.610019499116;7819.765407037798;7822.474617449543;7850.528968261922;7496.175420703609;7512.774616761506;7518.097828260644;7526.435517336112;7532.698692052257;6391.93608063932;7472.14070381913;7500.9249907500225;7503.662335195038;7525.548467091992;7092.25531319204;7302.123745150403;7321.59731214767;7395.630218488946;7441.218672039358;7580.279873412017;7583.544987300779;7589.772306830804;7590.430717696085;7597.772066838003;7146.464015198777;7379.3358597726465;7411.2588741125455;7412.481126321106;7447.925520744723 16:53:35 INFO - 2015-11-19 16:53:35,608 DEBUG : BROWSER_OUTPUT: |5;yui.html;710.0556260173965;723.609251004458;797.401948538596;802.3060053054108;815.824597711492;13502.459901603936;13627.93186034071;13670.316484175777;13700.931495342535;13776.173429594219;13917.373718182705;13999.30003499826;14076.57770266891;14104.929475352634;14123.57629271121;754.6566312327891;772.9265719756614;937.4843835890233;960.8894977077656;961.0149596663441;946.3281070439996;953.823542644613;957.286821318119;959.8608201810733;963.3978763272954;998.5706146357063;1003.2325271167563;1004.196642685852;1014.4167103915241;1020.6835880876915;991.5736233419626;997.6907158780801;1008.991008991009;1012.0335079998583;1012.8835183953865;732.9560226386434;737.8192342875976;741.1958025542293;744.5681504727245;745.2137994415889;14741.852581474155;14854.628634284121;14898.702025959421;14957.850421495754;14992.925035374863;12434.316112613802;12500.937495312466;12759.362031898461;12976.221426714428;13082.672933176651;10084.2436817239;10184.28709990301;10417.166626669925;10620.513128162063;11008.449577521093;3500.5974312953826;3505.631908649606;3516.1209697575605;3519.5248641433336;3522.3307571561577;78289.60855195687;79489.60255198687;80567.58297251092;81558;82126;8654.78363040929;9708.417494950325;9774.462404567676;9828.655997040069;10010.64962726301;21508.354749357546;21681.56636867254;21915.67126493104;22021.33935981923;22088.33734987953;6655.101561289164;6701.798946031627;6951.131108611424;6971.407430368476;7574.924250757532;3392.6437724039115;4118.9476560753355;4162.354835000579;4173.895652608649;4178.1643671265265;3088.583041289442;3128.8122712637314;3132.7963682360573;3135.1064946490596;3135.623725152996;491.95818355439474;494.38942905512386;495.7397366382678;502.19147173051357;506.3139446050622;491.54992771324737;493.70377773335713;502.69586899925747;511.7697036333665;512.8410192840231;7707.653155608011;8518.57407129641;8622.180892815173;8669.176428239307;8861.512616806009;508.98982020359387;531.2615464504343;593.8597892047279;630.4735545819201;654.8199245207607;3818.3317919364;4070.4911886014247;4150.113012914288;4171.624553790113;4217.557156498585;90702;92453.07546924445;93105.5344723272;94812.0518794817;102121;85534.14465855261;86371.56814215888;86664.70002949961;87415.25169496574;87542;76934;77717;78126.60936695394;78892.81660774979;80095.59952200201;8811.955940220514;8894.911050889667;9020.124580737818;9076.773080672772;9275.026122257066;52048;53479.7326013383;54397;54803.451965479835;55012;74712.13219669335;74793.25206747864;75135.62432187804;75798.24201758133;76280;8099.635516401659;8125.918740812753;8184.427090103635;8231.876521852297;8302.83394332122;11973.10201734856;12179.939100304442;12187.57343493009;12633.115681902178;13154.21074735519;11440.313581185155;11488.368139752394;11905;12102.092343074128;12195.024398048312;11787.998020168381;12028;12038.75922481528;12103.394830258276;12248.571300004458;11622.88377116218;11750.70623234426;11753.764924701629;11776.941115294369;12043.916047555762;9396;9662.661806836726;9778.266630002921;9864.210863131077;10050.145737612092;9667.129958303787;10025.649102281384;10049.346792458467;10081.596736130472;10089.142422894136 16:53:35 INFO - 2015-11-19 16:53:35,608 DEBUG : BROWSER_OUTPUT: __end_tp_report 16:53:35 INFO - 2015-11-19 16:53:35,608 DEBUG : BROWSER_OUTPUT: __start_cc_report 16:53:35 INFO - 2015-11-19 16:53:35,608 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,318 16:53:35 INFO - 2015-11-19 16:53:35,608 DEBUG : BROWSER_OUTPUT: __end_cc_report 16:53:35 INFO - 2015-11-19 16:53:35,608 DEBUG : BROWSER_OUTPUT: __startTimestamp1447980815594__endTimestamp 16:53:35 INFO - 2015-11-19 16:53:35,608 DEBUG : BROWSER_OUTPUT: 16:53:35 INFO - 2015-11-19 16:53:35,608 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 16:53:35 INFO - 2015-11-19 16:53:35,609 DEBUG : BROWSER_OUTPUT: Number of tests: 6 16:53:35 INFO - 2015-11-19 16:53:35,609 DEBUG : BROWSER_OUTPUT: 16:53:35 INFO - 2015-11-19 16:53:35,609 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5790.62 Median:6081.42 stddev:725.48 (11.9%) stddev-sans-first:682.64 16:53:35 INFO - 2015-11-19 16:53:35,610 DEBUG : BROWSER_OUTPUT: Values: 2581.7 3003.0 3377.5 3471.3 3519.0 4594.7 5700.4 5726.0 5741.1 5761.1 5639.9 5752.8 5760.6 5783.9 5803.5 5286.2 5292.1 5309.8 5376.8 5427.6 5372.4 5379.1 5393.2 5401.0 5409.1 5159.7 5190.1 5283.8 5414.0 5430.6 5311.9 5322.8 5331.1 5353.4 5354.4 5280.2 5307.9 5309.5 5310.8 5311.6 4168.0 4301.5 5406.9 5524.6 5570.7 6257.3 6262.1 6318.3 6320.7 6333.5 6180.4 6364.7 6367.1 6367.6 6369.1 5821.3 5864.2 5949.4 5952.1 5995.3 6329.7 6401.6 6480.6 6484.5 6507.0 5964.5 6293.0 6317.4 6323.8 6340.1 6248.2 6277.1 6316.6 6372.8 6379.6 6254.5 6316.4 6322.1 6328.4 6410.3 5226.9 6125.1 6214.1 6342.7 6362.7 4906.8 5011.8 5016.7 5027.3 5069.6 4486.6 4507.8 4522.8 4523.7 4547.8 5676.8 5859.4 5863.4 5990.7 6006.3 6230.4 6288.2 6344.6 6365.2 6371.7 5982.1 5983.7 5989.2 6001.0 6015.4 5368.4 5391.3 5506.6 5559.7 5576.3 6480.3 6508.1 6511.0 6519.7 6539.6 6336.7 6362.5 6367.6 6380.1 6394.9 6223.8 6285.7 6346.6 6441.2 6494.9 6261.7 6308.8 6311.5 6312.8 6315.6 6313.3 6318.3 6367.0 6370.3 6427.3 6084.9 6150.5 6168.5 6283.6 6284.2 5256.3 6284.1 6293.3 6295.8 6323.3 5804.0 6081.4 6178.6 6185.2 6199.3 4402.9 4454.4 6048.0 6115.9 6157.6 6095.9 6147.5 6156.5 6157.8 6181.6 16:53:35 INFO - 2015-11-19 16:53:35,610 DEBUG : BROWSER_OUTPUT: 16:53:35 INFO - 2015-11-19 16:53:35,610 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:67014.90 Median:40099.60 stddev:142229.61 (354.7%) stddev-sans-first:142541.05 16:53:35 INFO - 2015-11-19 16:53:35,612 DEBUG : BROWSER_OUTPUT: Values: 546.7 567.5 586.7 595.3 620.2 40935.6 41348.4 41467.4 41572.8 41627.2 42582.8 42990.0 42991.8 43118.1 43308.0 9765.4 9851.4 9956.7 9959.3 9986.4 9835.7 9938.8 9952.6 9990.9 9997.6 9844.7 9855.8 9891.2 9929.8 9975.7 9838.9 9921.9 9923.2 9965.9 9981.7 9701.8 9786.0 9851.9 9858.7 9863.3 39520.2 39712.4 40082.6 40116.6 40245.0 3232.4 3279.6 3294.9 3316.8 3484.2 24034.6 27506.0 27997.9 28763.1 28953.4 2530.5 2543.9 2544.7 2570.8 2616.9 513012.0 514695.0 515523.0 516132.0 516662.0 58170.0 59176.7 63023.7 63334.0 63803.7 60509.4 60763.0 61233.0 61311.4 61506.0 16423.0 16493.9 16514.2 16597.8 16610.2 12633.7 12673.4 12772.2 12785.9 12796.2 19303.1 19373.4 19572.8 19801.0 20095.0 8936.0 9147.5 9151.8 9153.9 9157.1 976.4 987.0 1048.5 1074.3 1097.2 21885.3 25168.4 27907.9 28142.4 28371.4 1012.5 1048.5 1101.7 1168.7 1175.6 13877.8 14233.4 14279.7 15368.7 15456.1 552716.0 554372.2 560016.0 561015.0 563041.2 57964.4 58207.0 58433.4 58496.0 58748.1 1413.1 1433.9 1443.8 1444.1 1450.5 28490.9 29160.6 29253.0 29357.6 29776.7 49136.0 49292.0 49338.5 49567.8 49578.8 523368.0 525621.4 528122.0 528285.0 529464.0 30675.0 33184.8 33910.2 33912.3 33931.5 42960.6 43282.0 43493.3 44539.3 45782.0 37150.1 37467.0 37624.8 37673.0 37934.6 35795.8 35818.5 36048.5 36591.1 36660.3 36256.8 36707.3 36735.6 36796.6 37089.4 30447.0 31337.5 31724.2 32025.0 32248.8 19173.9 24000.0 24052.2 24248.0 24539.4 16:53:35 INFO - 2015-11-19 16:53:35,612 DEBUG : BROWSER_OUTPUT: 16:53:35 INFO - 2015-11-19 16:53:35,612 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:37501.86 Median:4143.16 stddev:126735.89 (3058.9%) stddev-sans-first:127060.71 16:53:35 INFO - 2015-11-19 16:53:35,613 DEBUG : BROWSER_OUTPUT: Values: 350.9 352.1 354.5 354.5 357.9 16670.1 20334.9 20551.7 21072.0 21784.3 16916.7 18473.0 20222.7 20534.8 20746.5 5730.2 5740.3 5916.2 5924.6 5928.2 4213.3 4351.2 5833.2 6274.4 6427.4 6270.3 6281.8 6358.7 6363.9 6384.7 4813.7 4913.4 4932.7 4937.0 4945.5 3768.0 3962.3 4127.9 4158.5 4235.5 11351.7 12357.6 13937.0 14021.6 14182.2 1883.7 1942.6 1958.4 2008.2 2070.9 10136.8 10227.0 10258.2 10554.8 10610.4 1364.4 1380.3 1601.8 1609.4 1646.3 96812.0 100712.5 100777.0 101983.0 102389.5 5660.3 6703.2 6741.1 6813.2 6845.7 7671.0 7708.4 7733.1 7767.3 7782.0 5721.5 5724.5 5764.1 5784.9 6057.4 5039.3 6230.1 6253.6 6262.4 6267.7 3005.4 3026.8 3032.7 3059.0 3060.0 1071.3 1092.8 1097.8 1099.1 1137.0 360.4 427.1 427.7 433.8 436.8 9325.7 11815.2 12355.4 12455.5 12528.2 456.9 463.9 473.0 474.2 511.7 6345.8 6485.9 6556.2 6615.8 6672.3 753387.0 763685.0 765249.0 774727.0 777575.0 116012.0 122033.0 129967.4 133389.0 139776.0 463.9 479.4 480.3 481.6 482.4 11124.6 11596.9 11791.6 12076.2 12209.5 49668.0 52997.7 53824.0 54531.6 56895.4 70788.6 70865.0 71913.6 76829.0 77326.6 7979.6 8111.9 8189.4 8256.7 8307.7 10616.4 12448.4 12491.9 12577.3 12636.4 10695.5 10988.4 11031.6 11093.0 11154.6 9762.0 10778.9 11104.3 11117.8 11178.0 10740.6 10822.2 11026.8 11248.1 11462.1 8023.6 8114.7 8243.3 8284.1 8286.9 10469.1 10855.7 11025.4 11028.5 11076.4 16:53:35 INFO - 2015-11-19 16:53:35,613 DEBUG : BROWSER_OUTPUT: 16:53:35 INFO - 2015-11-19 16:53:35,613 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5844.30 Median:6209.97 stddev:3012.30 (48.5%) stddev-sans-first:3003.24 16:53:35 INFO - 2015-11-19 16:53:35,614 DEBUG : BROWSER_OUTPUT: Values: 1523.6 1566.0 1577.1 1877.6 1896.1 6953.6 7836.4 7965.4 8778.5 8786.9 8293.0 8424.3 8507.4 8538.9 8541.5 2387.2 2431.4 2432.8 2441.0 2443.8 2413.7 2449.7 2463.7 2469.2 2476.0 2403.8 2432.0 2435.5 2442.1 2446.8 2379.9 2405.2 2422.2 2427.6 2438.1 2436.9 2449.3 2471.1 2475.5 2476.9 8455.9 8509.1 8547.8 8554.9 8595.6 4714.2 5176.5 5271.5 5272.2 5285.3 2896.9 3250.3 3546.2 3586.5 3636.8 1034.4 1040.2 1052.4 1078.6 1083.9 9828.7 10532.5 10924.2 11009.1 11034.3 4670.3 4696.7 4759.1 4814.8 4819.3 9810.0 9830.7 9832.2 9834.8 9842.7 5179.3 5266.9 5267.5 5284.7 5312.7 4803.7 4822.0 4828.5 4842.8 4844.0 3779.1 3819.9 3827.2 3855.8 3860.6 1235.7 1255.1 1264.7 1266.8 1267.6 1338.4 1351.7 1382.3 1415.2 1421.4 7762.1 7799.2 7906.4 7924.7 7935.3 498.3 504.2 512.1 513.1 517.0 5878.6 6189.9 6230.0 6240.0 6243.7 9264.9 10084.9 10120.0 10152.9 10198.0 9781.8 9971.5 9978.6 9989.1 10037.6 7800.5 7864.4 7893.3 7920.0 7920.1 7711.5 7711.8 7774.5 7790.7 7807.1 8863.6 9064.0 9067.7 9160.2 9173.6 8304.1 9173.4 9197.0 9360.1 9464.7 7293.9 7339.2 7363.9 7365.7 7416.5 7966.2 8047.6 8049.6 8061.2 8068.2 7508.3 7528.6 7530.1 7633.0 7689.5 7370.2 7385.9 7461.0 7485.4 7572.1 7399.7 7527.8 7575.3 7585.2 7587.1 6838.1 6851.5 6890.8 6923.0 6936.4 6908.5 6961.1 6980.7 6985.6 6991.6 16:53:35 INFO - 2015-11-19 16:53:35,615 DEBUG : BROWSER_OUTPUT: 16:53:35 INFO - 2015-11-19 16:53:35,615 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:6033.40 Median:6878.07 stddev:1988.20 (28.9%) stddev-sans-first:1946.31 16:53:35 INFO - 2015-11-19 16:53:35,615 DEBUG : BROWSER_OUTPUT: Values: 280.1 322.3 326.9 328.3 334.2 6792.8 6832.0 6970.8 7030.6 7069.6 6720.4 6932.5 6938.3 6958.8 6982.3 5067.9 5088.7 5089.9 5090.0 5094.9 4900.4 5057.5 5067.5 5073.4 5075.8 4983.0 4985.7 4992.0 5006.5 5024.3 4975.5 4988.0 4992.4 4997.5 5014.1 4121.8 4193.2 4211.4 4235.9 4240.6 5843.9 6640.5 6658.6 6675.8 6692.6 5633.7 5967.6 5969.1 5986.5 6021.3 6354.4 7202.5 7338.6 7460.9 7478.3 4149.7 4438.6 4704.8 4718.7 4721.1 7810.6 7918.3 7928.5 7947.1 7957.8 4636.3 4765.0 4772.2 4776.3 4781.2 4129.8 4845.1 4921.7 4932.4 4945.9 5885.8 5955.0 5960.4 5972.0 6015.5 7536.3 7538.2 7544.2 7555.8 7582.5 1614.7 1673.0 1674.5 1677.9 1685.1 1011.7 1060.8 1069.1 1081.5 1088.6 6939.8 6961.9 6962.1 6974.6 6993.4 7522.2 7629.7 7639.4 7644.7 7690.9 5367.7 5592.6 5821.7 6751.8 6990.5 3307.8 3966.8 3986.0 4040.7 4071.9 6426.4 6463.6 7951.3 8077.2 8139.6 8133.6 8142.9 8147.8 8152.2 8168.2 7959.7 8097.0 8164.9 8171.6 8172.6 7647.8 7827.3 7828.6 7870.8 7880.5 7154.5 7464.2 7669.1 7715.8 7727.7 6924.2 7033.0 8127.8 8142.9 8165.0 4823.3 4825.8 4826.8 4832.3 4851.4 7587.5 7799.6 7819.8 7822.5 7850.5 7496.2 7512.8 7518.1 7526.4 7532.7 6391.9 7472.1 7500.9 7503.7 7525.5 7092.3 7302.1 7321.6 7395.6 7441.2 7580.3 7583.5 7589.8 7590.4 7597.8 7146.5 7379.3 7411.3 7412.5 7447.9 16:53:35 INFO - 2015-11-19 16:53:35,615 DEBUG : BROWSER_OUTPUT: 16:53:35 INFO - 2015-11-19 16:53:35,615 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:19132.57 Median:504.50 stddev:27492.46 (5449.4%) stddev-sans-first:27534.79 16:53:35 INFO - 2015-11-19 16:53:35,616 DEBUG : BROWSER_OUTPUT: Values: 710.1 723.6 797.4 802.3 815.8 13502.5 13627.9 13670.3 13700.9 13776.2 13917.4 13999.3 14076.6 14104.9 14123.6 754.7 772.9 937.5 960.9 961.0 946.3 953.8 957.3 959.9 963.4 998.6 1003.2 1004.2 1014.4 1020.7 991.6 997.7 1009.0 1012.0 1012.9 733.0 737.8 741.2 744.6 745.2 14741.9 14854.6 14898.7 14957.9 14992.9 12434.3 12500.9 12759.4 12976.2 13082.7 10084.2 10184.3 10417.2 10620.5 11008.4 3500.6 3505.6 3516.1 3519.5 3522.3 78289.6 79489.6 80567.6 81558.0 82126.0 8654.8 9708.4 9774.5 9828.7 10010.6 21508.4 21681.6 21915.7 22021.3 22088.3 6655.1 6701.8 6951.1 6971.4 7574.9 3392.6 4118.9 4162.4 4173.9 4178.2 3088.6 3128.8 3132.8 3135.1 3135.6 492.0 494.4 495.7 502.2 506.3 491.5 493.7 502.7 511.8 512.8 7707.7 8518.6 8622.2 8669.2 8861.5 509.0 531.3 593.9 630.5 654.8 3818.3 4070.5 4150.1 4171.6 4217.6 90702.0 92453.1 93105.5 94812.1 102121.0 85534.1 86371.6 86664.7 87415.3 87542.0 76934.0 77717.0 78126.6 78892.8 80095.6 8812.0 8894.9 9020.1 9076.8 9275.0 52048.0 53479.7 54397.0 54803.5 55012.0 74712.1 74793.3 75135.6 75798.2 76280.0 8099.6 8125.9 8184.4 8231.9 8302.8 11973.1 12179.9 12187.6 12633.1 13154.2 11440.3 11488.4 11905.0 12102.1 12195.0 11788.0 12028.0 12038.8 12103.4 12248.6 11622.9 11750.7 11753.8 11776.9 12043.9 9396.0 9662.7 9778.3 9864.2 10050.1 9667.1 10025.6 10049.3 10081.6 10089.1 16:53:35 INFO - 2015-11-19 16:53:35,616 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 16:53:35 INFO - 2015-11-19 16:53:35,616 DEBUG : BROWSER_OUTPUT: 16:53:36 INFO - 2015-11-19 16:53:36,105 INFO : Browser exited with error code: 0 16:53:36 INFO - 2015-11-19 16:53:36,130 INFO : Completed test dromaeo_css (00:18:29) 16:53:36 INFO - 2015-11-19 16:53:36,130 INFO : Starting test kraken 16:53:36 INFO - 2015-11-19 16:53:36,130 DEBUG : operating with platform_type : mac_ 16:53:36 INFO - 2015-11-19 16:53:36,130 INFO : Initialising browser for kraken test... 16:53:36 INFO - 2015-11-19 16:53:36,142 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/tmpPjrXsv/profile http://localhost:57090/getInfo.html 16:53:38 INFO - 2015-11-19 16:53:38,517 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 16:53:38 INFO - 2015-11-19 16:53:38,517 DEBUG : BROWSER_OUTPUT: colorDepth:24 16:53:38 INFO - 2015-11-19 16:53:38,517 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 16:53:38 INFO - 2015-11-19 16:53:38,517 DEBUG : BROWSER_OUTPUT: __metrics 16:53:39 INFO - 2015-11-19 16:53:39,164 INFO : Browser initialized. 16:53:39 INFO - 2015-11-19 16:53:39,164 INFO : Running cycle 1/1 for kraken test... 16:53:39 INFO - 2015-11-19 16:53:39,165 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/tmpPjrXsv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 16:53:51 INFO - 2015-11-19 16:53:51,135 DEBUG : BROWSER_OUTPUT: RSS: Main: 237129728 16:53:51 INFO - 2015-11-19 16:53:51,135 DEBUG : BROWSER_OUTPUT: 16:53:53 INFO - 2015-11-19 16:53:53,826 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57090/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57090/tests/kraken/driver.html?testName=audio-beat-detection) 16:53:54 INFO - 2015-11-19 16:53:54,444 DEBUG : BROWSER_OUTPUT: RSS: Main: 248930304 16:53:54 INFO - 2015-11-19 16:53:54,445 DEBUG : BROWSER_OUTPUT: 16:53:57 INFO - 2015-11-19 16:53:57,064 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57090/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57090/tests/kraken/driver.html?testName=audio-dft) 16:53:57 INFO - 2015-11-19 16:53:57,674 DEBUG : BROWSER_OUTPUT: RSS: Main: 258433024 16:53:57 INFO - 2015-11-19 16:53:57,674 DEBUG : BROWSER_OUTPUT: 16:54:01 INFO - 2015-11-19 16:54:01,100 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57090/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57090/tests/kraken/driver.html?testName=audio-fft) 16:54:01 INFO - 2015-11-19 16:54:01,680 DEBUG : BROWSER_OUTPUT: RSS: Main: 260714496 16:54:01 INFO - 2015-11-19 16:54:01,680 DEBUG : BROWSER_OUTPUT: 16:54:03 INFO - 2015-11-19 16:54:03,662 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57090/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57090/tests/kraken/driver.html?testName=audio-oscillator) 16:54:04 INFO - 2015-11-19 16:54:04,272 DEBUG : BROWSER_OUTPUT: RSS: Main: 263114752 16:54:04 INFO - 2015-11-19 16:54:04,272 DEBUG : BROWSER_OUTPUT: 16:54:06 INFO - 2015-11-19 16:54:06,228 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57090/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57090/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:54:06 INFO - 2015-11-19 16:54:06,826 DEBUG : BROWSER_OUTPUT: RSS: Main: 263565312 16:54:06 INFO - 2015-11-19 16:54:06,827 DEBUG : BROWSER_OUTPUT: 16:54:09 INFO - 2015-11-19 16:54:09,629 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57090/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57090/tests/kraken/driver.html?testName=imaging-darkroom) 16:54:10 INFO - 2015-11-19 16:54:10,216 DEBUG : BROWSER_OUTPUT: RSS: Main: 265097216 16:54:10 INFO - 2015-11-19 16:54:10,217 DEBUG : BROWSER_OUTPUT: 16:54:12 INFO - 2015-11-19 16:54:12,945 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57090/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57090/tests/kraken/driver.html?testName=imaging-desaturate) 16:54:13 INFO - 2015-11-19 16:54:13,532 DEBUG : BROWSER_OUTPUT: RSS: Main: 265207808 16:54:13 INFO - 2015-11-19 16:54:13,532 DEBUG : BROWSER_OUTPUT: 16:54:16 INFO - 2015-11-19 16:54:16,337 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57090/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57090/tests/kraken/driver.html?testName=json-parse-financial) 16:54:16 INFO - 2015-11-19 16:54:16,939 DEBUG : BROWSER_OUTPUT: RSS: Main: 263168000 16:54:16 INFO - 2015-11-19 16:54:16,939 DEBUG : BROWSER_OUTPUT: 16:54:18 INFO - 2015-11-19 16:54:18,583 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57090/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57090/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:54:19 INFO - 2015-11-19 16:54:19,173 DEBUG : BROWSER_OUTPUT: RSS: Main: 264790016 16:54:19 INFO - 2015-11-19 16:54:19,173 DEBUG : BROWSER_OUTPUT: 16:54:20 INFO - 2015-11-19 16:54:20,931 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57090/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57090/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:54:21 INFO - 2015-11-19 16:54:21,557 DEBUG : BROWSER_OUTPUT: RSS: Main: 263512064 16:54:21 INFO - 2015-11-19 16:54:21,558 DEBUG : BROWSER_OUTPUT: 16:54:23 INFO - 2015-11-19 16:54:23,588 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57090/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57090/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:54:24 INFO - 2015-11-19 16:54:24,190 DEBUG : BROWSER_OUTPUT: RSS: Main: 264257536 16:54:24 INFO - 2015-11-19 16:54:24,190 DEBUG : BROWSER_OUTPUT: 16:54:26 INFO - 2015-11-19 16:54:26,713 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57090/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57090/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:54:27 INFO - 2015-11-19 16:54:27,331 DEBUG : BROWSER_OUTPUT: RSS: Main: 263876608 16:54:27 INFO - 2015-11-19 16:54:27,332 DEBUG : BROWSER_OUTPUT: 16:54:29 INFO - 2015-11-19 16:54:29,809 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57090/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57090/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:54:30 INFO - 2015-11-19 16:54:30,397 DEBUG : BROWSER_OUTPUT: RSS: Main: 264224768 16:54:30 INFO - 2015-11-19 16:54:30,397 DEBUG : BROWSER_OUTPUT: 16:54:32 INFO - 2015-11-19 16:54:32,119 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57090/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57090/tests/kraken/driver.html?testName=ai-astar) 16:54:32 INFO - 2015-11-19 16:54:32,377 DEBUG : BROWSER_OUTPUT: RSS: Main: 264413184 16:54:32 INFO - 2015-11-19 16:54:32,378 DEBUG : BROWSER_OUTPUT: 16:54:32 INFO - 2015-11-19 16:54:32,378 DEBUG : BROWSER_OUTPUT: __start_tp_report 16:54:32 INFO - 2015-11-19 16:54:32,378 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 16:54:32 INFO - 2015-11-19 16:54:32,378 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 16:54:32 INFO - 2015-11-19 16:54:32,378 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 16:54:32 INFO - 2015-11-19 16:54:32,378 DEBUG : BROWSER_OUTPUT: |0;ai-astar;118;150;169;114;115;125;113;117;116;116 16:54:32 INFO - 2015-11-19 16:54:32,378 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;146;124;148;154;122;151;128;167;162;149 16:54:32 INFO - 2015-11-19 16:54:32,378 DEBUG : BROWSER_OUTPUT: |2;audio-dft;222;204;208;167;179;250;246;166;248;287 16:54:32 INFO - 2015-11-19 16:54:32,378 DEBUG : BROWSER_OUTPUT: |3;audio-fft;75;97;65;134;48;59;51;58;136;83 16:54:32 INFO - 2015-11-19 16:54:32,378 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;77;78;110;76;78;77;111;76;78;111 16:54:32 INFO - 2015-11-19 16:54:32,379 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;103;118;87;94;122;88;90;88;88;87 16:54:32 INFO - 2015-11-19 16:54:32,379 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;95;95;95;95;95;96;95;95;96;96 16:54:32 INFO - 2015-11-19 16:54:32,379 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;97;98;94;93;100;94;97;105;80;149 16:54:32 INFO - 2015-11-19 16:54:32,379 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;59;59;64;78;85;89;77;66;59;59 16:54:32 INFO - 2015-11-19 16:54:32,379 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;68;66;66;68;63;65;66;71;72 16:54:32 INFO - 2015-11-19 16:54:32,379 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;84;87;87;87;86;86;83;86;83;85 16:54:32 INFO - 2015-11-19 16:54:32,379 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;129;125;133;131;133;130;124;122;131;129 16:54:32 INFO - 2015-11-19 16:54:32,379 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;135;141;139;137;151;141;135;142;153;172 16:54:32 INFO - 2015-11-19 16:54:32,379 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;62;68;87;90;96;68;66;69;67;67 16:54:32 INFO - 2015-11-19 16:54:32,379 DEBUG : BROWSER_OUTPUT: __end_tp_report 16:54:32 INFO - 2015-11-19 16:54:32,379 DEBUG : BROWSER_OUTPUT: __start_cc_report 16:54:32 INFO - 2015-11-19 16:54:32,379 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,835 16:54:32 INFO - 2015-11-19 16:54:32,379 DEBUG : BROWSER_OUTPUT: __end_cc_report 16:54:32 INFO - 2015-11-19 16:54:32,380 DEBUG : BROWSER_OUTPUT: __startTimestamp1447980872372__endTimestamp 16:54:32 INFO - 2015-11-19 16:54:32,380 DEBUG : BROWSER_OUTPUT: 16:54:32 INFO - 2015-11-19 16:54:32,380 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 16:54:32 INFO - 2015-11-19 16:54:32,380 DEBUG : BROWSER_OUTPUT: Number of tests: 14 16:54:32 INFO - 2015-11-19 16:54:32,380 DEBUG : BROWSER_OUTPUT: 16:54:32 INFO - 2015-11-19 16:54:32,380 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:125.30 Median:117.50 stddev:18.86 (16.0%) stddev-sans-first:19.81 16:54:32 INFO - 2015-11-19 16:54:32,380 DEBUG : BROWSER_OUTPUT: Values: 118.0 150.0 169.0 114.0 115.0 125.0 113.0 117.0 116.0 116.0 16:54:32 INFO - 2015-11-19 16:54:32,380 DEBUG : BROWSER_OUTPUT: 16:54:32 INFO - 2015-11-19 16:54:32,380 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:145.10 Median:150.00 stddev:15.55 (10.4%) stddev-sans-first:16.48 16:54:32 INFO - 2015-11-19 16:54:32,380 DEBUG : BROWSER_OUTPUT: Values: 146.0 124.0 148.0 154.0 122.0 151.0 128.0 167.0 162.0 149.0 16:54:32 INFO - 2015-11-19 16:54:32,380 DEBUG : BROWSER_OUTPUT: 16:54:32 INFO - 2015-11-19 16:54:32,380 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:217.70 Median:234.00 stddev:40.29 (17.2%) stddev-sans-first:42.70 16:54:32 INFO - 2015-11-19 16:54:32,380 DEBUG : BROWSER_OUTPUT: Values: 222.0 204.0 208.0 167.0 179.0 250.0 246.0 166.0 248.0 287.0 16:54:32 INFO - 2015-11-19 16:54:32,380 DEBUG : BROWSER_OUTPUT: 16:54:32 INFO - 2015-11-19 16:54:32,380 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.60 Median:62.00 stddev:32.29 (52.1%) stddev-sans-first:34.19 16:54:32 INFO - 2015-11-19 16:54:32,381 DEBUG : BROWSER_OUTPUT: Values: 75.0 97.0 65.0 134.0 48.0 59.0 51.0 58.0 136.0 83.0 16:54:32 INFO - 2015-11-19 16:54:32,381 DEBUG : BROWSER_OUTPUT: 16:54:32 INFO - 2015-11-19 16:54:32,381 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:87.20 Median:77.00 stddev:16.21 (21.1%) stddev-sans-first:16.77 16:54:32 INFO - 2015-11-19 16:54:32,381 DEBUG : BROWSER_OUTPUT: Values: 77.0 78.0 110.0 76.0 78.0 77.0 111.0 76.0 78.0 111.0 16:54:32 INFO - 2015-11-19 16:54:32,381 DEBUG : BROWSER_OUTPUT: 16:54:32 INFO - 2015-11-19 16:54:32,381 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:96.50 Median:88.00 stddev:13.34 (15.2%) stddev-sans-first:13.94 16:54:32 INFO - 2015-11-19 16:54:32,381 DEBUG : BROWSER_OUTPUT: Values: 103.0 118.0 87.0 94.0 122.0 88.0 90.0 88.0 88.0 87.0 16:54:32 INFO - 2015-11-19 16:54:32,381 DEBUG : BROWSER_OUTPUT: 16:54:32 INFO - 2015-11-19 16:54:32,381 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 16:54:32 INFO - 2015-11-19 16:54:32,381 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 96.0 96.0 16:54:32 INFO - 2015-11-19 16:54:32,381 DEBUG : BROWSER_OUTPUT: 16:54:32 INFO - 2015-11-19 16:54:32,381 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:100.70 Median:94.00 stddev:18.15 (19.3%) stddev-sans-first:19.20 16:54:32 INFO - 2015-11-19 16:54:32,381 DEBUG : BROWSER_OUTPUT: Values: 97.0 98.0 94.0 93.0 100.0 94.0 97.0 105.0 80.0 149.0 16:54:32 INFO - 2015-11-19 16:54:32,381 DEBUG : BROWSER_OUTPUT: 16:54:32 INFO - 2015-11-19 16:54:32,382 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:69.50 Median:71.50 stddev:11.70 (16.4%) stddev-sans-first:11.78 16:54:32 INFO - 2015-11-19 16:54:32,382 DEBUG : BROWSER_OUTPUT: Values: 59.0 59.0 64.0 78.0 85.0 89.0 77.0 66.0 59.0 59.0 16:54:32 INFO - 2015-11-19 16:54:32,382 DEBUG : BROWSER_OUTPUT: 16:54:32 INFO - 2015-11-19 16:54:32,382 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:67.30 Median:68.00 stddev:2.71 (4.0%) stddev-sans-first:2.86 16:54:32 INFO - 2015-11-19 16:54:32,382 DEBUG : BROWSER_OUTPUT: Values: 68.0 68.0 66.0 66.0 68.0 63.0 65.0 66.0 71.0 72.0 16:54:32 INFO - 2015-11-19 16:54:32,382 DEBUG : BROWSER_OUTPUT: 16:54:32 INFO - 2015-11-19 16:54:32,382 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.40 Median:86.00 stddev:1.58 (1.8%) stddev-sans-first:1.59 16:54:32 INFO - 2015-11-19 16:54:32,382 DEBUG : BROWSER_OUTPUT: Values: 84.0 87.0 87.0 87.0 86.0 86.0 83.0 86.0 83.0 85.0 16:54:32 INFO - 2015-11-19 16:54:32,382 DEBUG : BROWSER_OUTPUT: 16:54:32 INFO - 2015-11-19 16:54:32,382 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:128.70 Median:130.50 stddev:3.80 (2.9%) stddev-sans-first:4.03 16:54:32 INFO - 2015-11-19 16:54:32,382 DEBUG : BROWSER_OUTPUT: Values: 129.0 125.0 133.0 131.0 133.0 130.0 124.0 122.0 131.0 129.0 16:54:32 INFO - 2015-11-19 16:54:32,382 DEBUG : BROWSER_OUTPUT: 16:54:32 INFO - 2015-11-19 16:54:32,382 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:144.60 Median:141.50 stddev:11.39 (8.1%) stddev-sans-first:11.54 16:54:32 INFO - 2015-11-19 16:54:32,382 DEBUG : BROWSER_OUTPUT: Values: 135.0 141.0 139.0 137.0 151.0 141.0 135.0 142.0 153.0 172.0 16:54:32 INFO - 2015-11-19 16:54:32,383 DEBUG : BROWSER_OUTPUT: 16:54:32 INFO - 2015-11-19 16:54:32,383 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.00 Median:68.50 stddev:12.07 (17.6%) stddev-sans-first:12.00 16:54:32 INFO - 2015-11-19 16:54:32,383 DEBUG : BROWSER_OUTPUT: Values: 62.0 68.0 87.0 90.0 96.0 68.0 66.0 69.0 67.0 67.0 16:54:32 INFO - 2015-11-19 16:54:32,383 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 16:54:32 INFO - 2015-11-19 16:54:32,383 DEBUG : BROWSER_OUTPUT: 16:54:32 INFO - 2015-11-19 16:54:32,995 INFO : Browser exited with error code: 0 16:54:33 INFO - 2015-11-19 16:54:33,039 INFO : Completed test kraken (00:00:56) 16:54:33 INFO - 2015-11-19 16:54:33,039 INFO : Starting test v8_7 16:54:33 INFO - 2015-11-19 16:54:33,039 DEBUG : operating with platform_type : mac_ 16:54:33 INFO - 2015-11-19 16:54:33,039 INFO : Initialising browser for v8_7 test... 16:54:33 INFO - 2015-11-19 16:54:33,052 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/tmp5AN4nV/profile http://localhost:57090/getInfo.html 16:54:35 INFO - 2015-11-19 16:54:35,727 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 16:54:35 INFO - 2015-11-19 16:54:35,727 DEBUG : BROWSER_OUTPUT: colorDepth:24 16:54:35 INFO - 2015-11-19 16:54:35,727 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 16:54:35 INFO - 2015-11-19 16:54:35,727 DEBUG : BROWSER_OUTPUT: __metrics 16:54:36 INFO - 2015-11-19 16:54:36,345 INFO : Browser initialized. 16:54:36 INFO - 2015-11-19 16:54:36,346 INFO : Running cycle 1/1 for v8_7 test... 16:54:36 INFO - 2015-11-19 16:54:36,346 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/tmp5AN4nV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 16:54:48 INFO - 2015-11-19 16:54:48,473 DEBUG : BROWSER_OUTPUT: RSS: Main: 236859392 16:54:48 INFO - 2015-11-19 16:54:48,473 DEBUG : BROWSER_OUTPUT: 16:55:09 INFO - 2015-11-19 16:55:09,840 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57090/tests/v8_7/run.html (next: http://localhost:57090/tests/v8_7/run.html) 16:55:10 INFO - 2015-11-19 16:55:10,088 DEBUG : BROWSER_OUTPUT: RSS: Main: 247590912 16:55:10 INFO - 2015-11-19 16:55:10,089 DEBUG : BROWSER_OUTPUT: 16:55:10 INFO - 2015-11-19 16:55:10,089 DEBUG : BROWSER_OUTPUT: __start_tp_report 16:55:10 INFO - 2015-11-19 16:55:10,089 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 16:55:10 INFO - 2015-11-19 16:55:10,089 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 16:55:10 INFO - 2015-11-19 16:55:10,089 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 16:55:10 INFO - 2015-11-19 16:55:10,089 DEBUG : BROWSER_OUTPUT: |0;Richards;148.5663348685188 16:55:10 INFO - 2015-11-19 16:55:10,089 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;159.4387755102041 16:55:10 INFO - 2015-11-19 16:55:10,089 DEBUG : BROWSER_OUTPUT: |2;Encrypt;283.60748723766307 16:55:10 INFO - 2015-11-19 16:55:10,089 DEBUG : BROWSER_OUTPUT: |3;Decrypt;4911.764705882353 16:55:10 INFO - 2015-11-19 16:55:10,089 DEBUG : BROWSER_OUTPUT: |4;RayTrace;943.3962264150944 16:55:10 INFO - 2015-11-19 16:55:10,089 DEBUG : BROWSER_OUTPUT: |5;Earley;717.3601147776184 16:55:10 INFO - 2015-11-19 16:55:10,089 DEBUG : BROWSER_OUTPUT: |6;Boyer;13157.894736842105 16:55:10 INFO - 2015-11-19 16:55:10,090 DEBUG : BROWSER_OUTPUT: |7;RegExp;26815.78947368421 16:55:10 INFO - 2015-11-19 16:55:10,090 DEBUG : BROWSER_OUTPUT: |8;Splay;799.3605115907275 16:55:10 INFO - 2015-11-19 16:55:10,090 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4545.454545454545 16:55:10 INFO - 2015-11-19 16:55:10,090 DEBUG : BROWSER_OUTPUT: __end_tp_report 16:55:10 INFO - 2015-11-19 16:55:10,090 DEBUG : BROWSER_OUTPUT: __startTimestamp1447980910088__endTimestamp 16:55:10 INFO - 2015-11-19 16:55:10,090 DEBUG : BROWSER_OUTPUT: 16:55:10 INFO - 2015-11-19 16:55:10,090 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 16:55:10 INFO - 2015-11-19 16:55:10,090 DEBUG : BROWSER_OUTPUT: Number of tests: 10 16:55:10 INFO - 2015-11-19 16:55:10,090 DEBUG : BROWSER_OUTPUT: 16:55:10 INFO - 2015-11-19 16:55:10,090 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:148.57 Median:148.57 stddev:0.00 (0.0%) 16:55:10 INFO - 2015-11-19 16:55:10,092 DEBUG : BROWSER_OUTPUT: Values: 148.6 16:55:10 INFO - 2015-11-19 16:55:10,092 DEBUG : BROWSER_OUTPUT: 16:55:10 INFO - 2015-11-19 16:55:10,092 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:159.44 Median:159.44 stddev:0.00 (0.0%) 16:55:10 INFO - 2015-11-19 16:55:10,092 DEBUG : BROWSER_OUTPUT: Values: 159.4 16:55:10 INFO - 2015-11-19 16:55:10,092 DEBUG : BROWSER_OUTPUT: 16:55:10 INFO - 2015-11-19 16:55:10,092 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:283.61 Median:283.61 stddev:0.00 (0.0%) 16:55:10 INFO - 2015-11-19 16:55:10,092 DEBUG : BROWSER_OUTPUT: Values: 283.6 16:55:10 INFO - 2015-11-19 16:55:10,092 DEBUG : BROWSER_OUTPUT: 16:55:10 INFO - 2015-11-19 16:55:10,092 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:4911.76 Median:4911.76 stddev:0.00 (0.0%) 16:55:10 INFO - 2015-11-19 16:55:10,092 DEBUG : BROWSER_OUTPUT: Values: 4911.8 16:55:10 INFO - 2015-11-19 16:55:10,092 DEBUG : BROWSER_OUTPUT: 16:55:10 INFO - 2015-11-19 16:55:10,092 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:943.40 Median:943.40 stddev:0.00 (0.0%) 16:55:10 INFO - 2015-11-19 16:55:10,092 DEBUG : BROWSER_OUTPUT: Values: 943.4 16:55:10 INFO - 2015-11-19 16:55:10,093 DEBUG : BROWSER_OUTPUT: 16:55:10 INFO - 2015-11-19 16:55:10,093 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:717.36 Median:717.36 stddev:0.00 (0.0%) 16:55:10 INFO - 2015-11-19 16:55:10,093 DEBUG : BROWSER_OUTPUT: Values: 717.4 16:55:10 INFO - 2015-11-19 16:55:10,093 DEBUG : BROWSER_OUTPUT: 16:55:10 INFO - 2015-11-19 16:55:10,093 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:13157.89 Median:13157.89 stddev:0.00 (0.0%) 16:55:10 INFO - 2015-11-19 16:55:10,093 DEBUG : BROWSER_OUTPUT: Values: 13157.9 16:55:10 INFO - 2015-11-19 16:55:10,093 DEBUG : BROWSER_OUTPUT: 16:55:10 INFO - 2015-11-19 16:55:10,093 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26815.79 Median:26815.79 stddev:0.00 (0.0%) 16:55:10 INFO - 2015-11-19 16:55:10,093 DEBUG : BROWSER_OUTPUT: Values: 26815.8 16:55:10 INFO - 2015-11-19 16:55:10,093 DEBUG : BROWSER_OUTPUT: 16:55:10 INFO - 2015-11-19 16:55:10,093 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:799.36 Median:799.36 stddev:0.00 (0.0%) 16:55:10 INFO - 2015-11-19 16:55:10,093 DEBUG : BROWSER_OUTPUT: Values: 799.4 16:55:10 INFO - 2015-11-19 16:55:10,093 DEBUG : BROWSER_OUTPUT: 16:55:10 INFO - 2015-11-19 16:55:10,093 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4545.45 Median:4545.45 stddev:0.00 (0.0%) 16:55:10 INFO - 2015-11-19 16:55:10,093 DEBUG : BROWSER_OUTPUT: Values: 4545.5 16:55:10 INFO - 2015-11-19 16:55:10,094 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 16:55:10 INFO - 2015-11-19 16:55:10,094 DEBUG : BROWSER_OUTPUT: 16:55:10 INFO - 2015-11-19 16:55:10,721 INFO : Browser exited with error code: 0 16:55:10 INFO - 2015-11-19 16:55:10,738 INFO : Completed test v8_7 (00:00:37) 16:55:11 INFO - 2015-11-19 16:55:11,215 INFO : Completed test suite (00:20:04) 16:55:11 INFO - 2015-11-19 16:55:11,215 DEBUG : Working with test: dromaeo_css 16:55:11 INFO - 2015-11-19 16:55:11,215 DEBUG : Generating results file: dromaeo_css 16:55:11 INFO - 2015-11-19 16:55:11,216 DEBUG : Working with test: kraken 16:55:11 INFO - 2015-11-19 16:55:11,216 DEBUG : Generating results file: kraken 16:55:11 INFO - 2015-11-19 16:55:11,216 INFO : javascript benchmark 16:55:11 INFO - 2015-11-19 16:55:11,217 DEBUG : Working with test: v8_7 16:55:11 INFO - 2015-11-19 16:55:11,217 DEBUG : Generating results file: v8_7 16:55:11 INFO - 2015-11-19 16:55:11,217 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:55:11 INFO - 2015-11-19 16:55:11,835 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,61]] 16:55:11 INFO - 2015-11-19 16:55:11,835 DEBUG : process_Request line: dromaeo_css 7309.24 graph.html#tests=[[72,64,61]] 16:55:11 INFO - 2015-11-19 16:55:11,835 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:55:11 INFO - 2015-11-19 16:55:11,949 DEBUG : process_Request line: kraken 1517.90 graph.html#tests=[[232,64,61]] 16:55:11 INFO - 2015-11-19 16:55:11,949 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:55:12 INFO - 2015-11-19 16:55:12,065 DEBUG : process_Request line: v8_7 21574.34 graph.html#tests=[[230,64,61]] 16:55:12 INFO - 2015-11-19 16:55:12,066 INFO : javascript benchmark 16:55:12 INFO - 2015-11-19 16:55:12,068 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2581.7160112387646, 3002.9849850750743, 3377.54403155574, 3471.30573885223, 3518.982405087975, 4594.74728889911, 5700.429957004298, 5725.971370143148, 5741.110127930167, 5761.107028410593, 5639.943600563993, 5752.769889204437, 5760.62555933864, 5783.942160578393, 5803.506701930341, 5286.207068939651, 5292.126799078157, 5309.761060752276, 5376.758045887945, 5427.592930530206, 5372.435894231108, 5379.112446446332, 5393.19102134681, 5401.0, 5409.053415652264, 5159.71621560814, 5190.143626301693, 5283.821854582492, 5414.0, 5430.56555475561, 5311.867203319909, 5322.760475778599, 5331.093714068579, 5353.437889021636, 5354.437784032699, 5280.2343660169445, 5307.920381194285, 5309.522143007148, 5310.787568497255, 5311.575073994071, 4168.0, 4301.462317210348, 5406.8918621627345, 5524.640898341635, 5570.6657600543695, 6257.342978987186, 6262.123302737575, 6318.304986451487, 6320.74717011319, 6333.461655759266, 6180.351063138396, 6364.681765911732, 6367.140436041122, 6367.554271201017, 6369.140166077566, 5821.27234095738, 5864.237649105632, 5949.405059494016, 5952.107183922403, 5995.310539288038, 6329.7468101275435, 6401.647909364937, 6480.57876238043, 6484.481241500669, 6507.0, 5964.522838172936, 6292.968535157295, 6317.431431171217, 6323.841903952438, 6340.112384266206, 6248.218972628421, 6277.089821975788, 6316.589421687576, 6372.776952806722, 6379.553431259767, 6254.468370188494, 6316.431521163117, 6322.146510221061, 6328.398802113792, 6410.326915673881, 5226.869328266824, 6125.081237814364, 6214.067889816563, 6342.682865856781, 6362.6500542469685, 4906.803727850846, 5011.824586139541, 5016.724080175625, 5027.271045698353, 5069.619778516626, 4486.573775491388, 4507.8196872124745, 4522.796474158671, 4523.705959112647, 4547.772611369418, 5676.801311954062, 5859.414058594107, 5863.413658634187, 5990.670513121733, 6006.339302676702, 6230.376962303733, 6288.182536270256, 6344.619322840645, 6365.204349456318, 6371.681415929185, 5982.102684597346, 5983.700814959235, 5989.221401217814, 6001.0, 6015.368386319461, 5368.355797304349, 5391.272178255886, 5506.64206826555, 5559.666420014732, 5576.302962129734, 6480.25477070143, 6508.088867558451, 6511.023346498063, 6519.674016299166, 6539.607623542603, 6336.651484168415, 6362.459190968634, 6367.649779262185, 6380.1067850501895, 6394.872102558016, 6223.844403889939, 6285.685715714288, 6346.619202847844, 6441.194850643669, 6494.902576461452, 6261.68691565429, 6308.779192728232, 6311.526635502264, 6312.810615681537, 6315.621062736251, 6313.305536391085, 6318.304986451579, 6367.013112967497, 6370.331115232834, 6427.260865000585, 6084.874298254837, 6150.538709596709, 6168.506519478341, 6283.622982621057, 6284.151639528605, 5256.291705195903, 6284.088807123033, 6293.3391993841815, 6295.811125666054, 6323.304436512072, 5804.042333015005, 6081.422264884829, 6178.62928224308, 6185.195924529782, 6199.349068347939, 4402.911941761211, 4454.443194600675, 6048.0, 6115.908261375994, 6157.568970172045, 6095.878082438415, 6147.538934580014, 6156.538259630456, 6157.784477543443, 6181.567290289637], "unit": "ms", "name": "dojo.html", "value": 5741.878987123853}, {"lowerIsBetter": false, "replicates": [546.6692650946178, 567.486424785569, 586.7213073789948, 595.309441048384, 620.2216218645599, 40935.59064409355, 41348.37977430341, 41467.37798933018, 41572.79213603928, 41627.16745665089, 42582.78708606453, 42990.0, 42991.78504107483, 43118.13763724724, 43308.0, 9765.365251258663, 9851.359661621971, 9956.701298961007, 9959.25305602079, 9986.400815951067, 9835.65575204868, 9938.751531211705, 9952.552135153936, 9990.90009099907, 9997.550110245056, 9844.655437059704, 9855.802883942317, 9891.159251463634, 9929.801403971916, 9975.700728978143, 9838.90161098387, 9921.90078099217, 9923.206143508502, 9965.850512242323, 9981.700548983543, 9701.757456063584, 9785.972472890315, 9851.90148098517, 9858.704238872846, 9863.30956833022, 39520.20959580792, 39712.404313935316, 40082.59917400818, 40116.59883401158, 40245.0, 3232.434323993292, 3279.622843372995, 3294.884679036222, 3316.7844090134063, 3484.1986343140966, 24034.639480407808, 27506.0, 27997.860010699816, 28763.137105886857, 28953.42093158125, 2530.4812513434704, 2543.910963116282, 2544.732803055671, 2570.7943364530793, 2616.856072915989, 513012.0, 514695.0, 515523.0, 516132.0, 516662.0, 58170.0, 59176.704116479144, 63023.6848815753, 63334.0, 63803.680981595724, 60509.39490605125, 60763.0, 61233.0, 61311.38688613146, 61506.0, 16423.0, 16493.917530412513, 16514.174291285388, 16597.83402165963, 16610.169491525376, 12633.684157895943, 12673.366331683379, 12772.233665979886, 12785.872141278654, 12796.23222606628, 19303.055984844763, 19373.4187974361, 19572.804271957382, 19801.0, 20095.0, 8936.006437843265, 9147.54262286883, 9151.757819334172, 9153.947296060906, 9157.077013827171, 976.4483067067226, 986.9654562090436, 1048.5124417145912, 1074.301703892476, 1097.2483848563759, 21885.343439696833, 25168.370790730012, 27907.860460697568, 28142.43715125686, 28371.432571348458, 1012.5139932832282, 1048.4600430778155, 1101.6694991502518, 1168.720251324798, 1175.588544009607, 13877.791833122512, 14233.35949882237, 14279.714405711828, 15368.692626147415, 15456.149911754961, 552716.0, 554372.2281388567, 560016.0, 561015.0, 563041.1847940816, 57964.42035579675, 58207.0, 58433.41566584365, 58496.0, 58748.11877821836, 1413.1450472464217, 1433.9139651620935, 1443.8483959184343, 1444.075791493424, 1450.4923276853017, 28490.857545712966, 29160.562591561567, 29253.0, 29357.559636605896, 29776.702232977394, 49136.01727965349, 49292.01415971732, 49338.506614933394, 49567.75216123896, 49578.75210623924, 523368.0, 525621.371893138, 528122.0, 528285.0, 529464.0, 30675.0, 33184.834075829465, 33910.15224619404, 33912.32175356529, 33931.49102763411, 42960.57039429565, 43282.0, 43493.3475997854, 44539.33191002073, 45782.0, 37150.0943034725, 37467.0, 37624.811875940446, 37673.0, 37934.62065379311, 35795.82102089473, 35818.462723059696, 36048.459273111446, 36591.08522286964, 36660.266794664494, 36256.81871590625, 36707.26585468329, 36735.63264367322, 36796.63203367932, 37089.44365834461, 30447.0, 31337.542709852667, 31724.20689482689, 32025.0, 32248.83875580607, 19173.90413047926, 24000.0, 24052.15817446381, 24248.0, 24539.386515336544], "unit": "ms", "name": "ext.html", "value": 19887.066275846464}, {"lowerIsBetter": false, "replicates": [350.8736854732297, 352.10565164482216, 354.503694827242, 354.5178557162259, 357.88547664747273, 16670.083145426997, 20334.89832550837, 20551.691724624143, 21072.0, 21784.346469605916, 16916.66166676669, 18473.0, 20222.696659550118, 20534.794652053475, 20746.48133796652, 5730.169125476803, 5740.339860916007, 5916.171735956969, 5924.644521328734, 5928.2293301870695, 4213.262679031172, 4351.173277077345, 5833.212516310307, 6274.4353008229255, 6427.357264273559, 6270.278917924452, 6281.780137695182, 6358.68206589671, 6363.936360636404, 6384.680765961706, 4813.66304358695, 4913.434954980169, 4932.654714170009, 4936.950630493685, 4945.505449455061, 3767.963809952285, 3962.346212874872, 4127.855525056639, 4158.459400277975, 4235.512916014636, 11351.659450216506, 12357.62927112179, 13937.0, 14021.579352619336, 14182.219977901212, 1883.7174423836398, 1942.6211888681712, 1958.4222654317011, 2008.2167954497756, 2070.943818652483, 10136.847947280796, 10227.0, 10258.230632702576, 10554.788904221949, 10610.363378197333, 1364.3519328319069, 1380.3305396882504, 1601.7666396874458, 1609.3803885504049, 1646.2838665180566, 96812.0, 100712.49643751807, 100777.0, 101983.0, 102389.48805256074, 5660.320761508646, 6703.162104736908, 6741.1236539249585, 6813.182418109759, 6845.691943862538, 7670.961645191738, 7708.421868359896, 7733.072031356273, 7767.262110099645, 7782.0, 5721.485066344049, 5724.484796368347, 5764.106563482667, 5784.942150578525, 6057.42454466825, 5039.319691841554, 6230.06549017651, 6253.624782513064, 6262.436380725757, 6267.71795269214, 3005.353848922492, 3026.803257788281, 3032.696730326994, 3059.0, 3059.969400306013, 1071.2554774431694, 1092.8470463660756, 1097.7859317433183, 1099.0712847643729, 1136.9772604547863, 360.3855426497867, 427.088166763955, 427.6536005835283, 433.82213292549903, 436.8165370544379, 9325.673601423918, 11815.232009919328, 12355.38223088842, 12455.501779928702, 12528.185667931555, 456.9497355290915, 463.9164950308909, 473.03500858249475, 474.20570544338096, 511.6929842094713, 6345.841353966188, 6485.935140648533, 6556.24603170632, 6615.834604134935, 6672.332766723386, 753387.0, 763685.0, 765249.0, 774727.0, 777575.0, 116012.0, 122033.0, 129967.35016325046, 133389.0, 139776.0, 463.9095376401637, 479.38638542665444, 480.34672844930867, 481.5569675898182, 482.351237585447, 11124.61063862761, 11596.94201528987, 11791.585009798879, 12076.21504602198, 12209.473815773028, 49668.0, 52997.67505812385, 53824.0, 54531.636709081, 56895.431045689016, 70788.64605676939, 70865.0, 71913.64043179751, 76829.0, 77326.61336693281, 7979.5611241382285, 8111.878321825296, 8189.385796065199, 8256.669733210605, 8307.6676932922, 10616.416097114425, 12448.377581121089, 12491.875731184236, 12577.30824804608, 12636.3681815907, 10695.5187016586, 10988.395638239654, 11031.613893513688, 11093.0, 11154.609588664358, 9762.0, 10778.946105269424, 11104.278221915549, 11117.83323250168, 11178.0, 10740.570377184826, 10822.188335874684, 11026.779464410507, 11248.100151987985, 11462.14033947474, 8023.558704271321, 8114.715984940499, 8243.340532757245, 8284.088750237348, 8286.917130828855, 10469.110125639101, 10855.728606784893, 11025.393603351893, 11028.503717332578, 11076.39079850616], "unit": "ms", "name": "jquery.html", "value": 7602.338687622406}, {"lowerIsBetter": false, "replicates": [1523.6190952261934, 1565.9921700391496, 1577.0537677393559, 1877.6338613970277, 1896.0804010055126, 6953.582785032895, 7836.412269079828, 7965.362770978322, 8778.4732916025, 8786.912130878698, 8293.04629967554, 8424.326053915687, 8507.404481686284, 8538.87191692125, 8541.487510749359, 2387.224152150545, 2431.3921519620094, 2432.793212576933, 2441.011390386896, 2443.780059794618, 2413.662087307778, 2449.6570480132796, 2463.7289898111194, 2469.172827102923, 2475.9876200618974, 2403.7836594706473, 2432.0393444589463, 2435.488547405047, 2442.0598069743187, 2446.840955337906, 2379.928602141921, 2405.1702162753822, 2422.152246713645, 2427.611582146857, 2438.146648672968, 2436.8903399347073, 2449.30194894456, 2471.0980492120425, 2475.4553998120564, 2476.863772492512, 8455.873161902577, 8509.149085091442, 8547.786305342353, 8554.914450855536, 8595.613197406132, 4714.198586240347, 5176.508231718019, 5271.472852714698, 5272.235525848769, 5285.2600635911, 2896.9130926072253, 3250.30118524516, 3546.202104526487, 3586.4620306953907, 3636.8181590920613, 1034.3586976074882, 1040.1990467340106, 1052.4316868890867, 1078.5524007536862, 1083.8699356077243, 9828.705138845775, 10532.473376331152, 10924.235303528756, 11009.064229540418, 11034.282771619819, 4670.2533153339045, 4696.694714843524, 4759.143354196209, 4814.807407703653, 4819.325294458778, 9809.950950245204, 9830.672859163922, 9832.164266037324, 9834.754131146636, 9842.704718858302, 5179.326687530597, 5266.868328291746, 5267.473252674702, 5284.656497327662, 5312.73436328182, 4803.735794531264, 4821.987382649683, 4828.46886842447, 4842.782074806642, 4843.95156048435, 3779.149691319431, 3819.8854034379015, 3827.234553089393, 3855.807209639563, 3860.5560360558334, 1235.734317121823, 1255.1465003797505, 1264.740728150727, 1266.771981043421, 1267.6197140857705, 1338.3575883575938, 1351.6688411339285, 1382.3088455771913, 1415.2357726827397, 1421.3674914663081, 7762.068551773823, 7799.18108598589, 7906.407019473562, 7924.683012679428, 7935.325497332676, 498.2750098606519, 504.23104765233313, 512.1217112651821, 513.1456125550991, 517.0254071076049, 5878.559108066912, 6189.938100619026, 6230.0, 6240.0, 6243.719032643542, 9264.861027084598, 10084.949575252076, 10119.988001199821, 10152.898471015344, 10198.0, 9781.804363912683, 9971.45157016371, 9978.550965206583, 9989.100980911608, 10037.598496060076, 7800.531968081933, 7864.41016923733, 7893.250141236574, 7920.049594048751, 7920.128785833554, 7711.537307761552, 7711.768646940601, 7774.494657847448, 7790.727324543614, 7807.063152421746, 8863.645454182019, 9063.954680226556, 9067.68263110788, 9160.221381182673, 9173.633054678005, 8304.128066553167, 9173.35786494939, 9197.0, 9360.11078947499, 9464.716058518256, 7293.890591641236, 7339.229380914927, 7363.852722945619, 7365.705371785283, 7416.48084634092, 7966.243206895336, 8047.597620119088, 8049.637766300413, 8061.153578874134, 8068.152843951535, 7508.2867127622785, 7528.585927774025, 7530.058742657168, 7633.007708997795, 7689.538627682357, 7370.152432470334, 7385.852282954418, 7460.9927659765235, 7485.401167906445, 7572.129205141479, 7399.741009064657, 7527.774166775005, 7575.280348366897, 7585.241475852371, 7587.089549253904, 6838.111045564045, 6851.486138539729, 6890.758823441155, 6922.965385173042, 6936.375726184668, 6908.516403851682, 6961.095057642474, 6980.685869136003, 6985.615791131537, 6991.615461149686], "unit": "ms", "name": "mootools.html", "value": 4729.2201360203735}, {"lowerIsBetter": false, "replicates": [280.0869166517154, 322.30864795014696, 326.8757872008637, 328.25813661125846, 334.2429397414857, 6792.830179245515, 6831.965840170792, 6970.8257293567685, 7030.648467576626, 7069.575825450476, 6720.438167771089, 6932.549384290018, 6938.271481494447, 6958.756443524478, 6982.301769823015, 5067.949320506794, 5088.745562721849, 5089.938574877181, 5089.974550127245, 5094.923576146361, 4900.436449808282, 5057.519535644126, 5067.467915868836, 5073.365829271341, 5075.7715902784275, 4982.950170498285, 4985.700857948516, 4991.975040124794, 5006.499350065001, 5024.296598476216, 4975.502449755014, 4988.002399520111, 4992.350994370727, 4997.450280469164, 5014.122528557488, 4121.825279795244, 4193.22425351311, 4211.368294755781, 4235.851745188935, 4240.575942405766, 5843.948089343959, 6640.535162538624, 6658.600483970978, 6675.833104172386, 6692.598444093322, 5633.6619802811965, 5967.6121052131475, 5969.074793407029, 5986.491148252404, 6021.277446706379, 6354.3963323484195, 7202.459815513805, 7338.633068346561, 7460.850782984364, 7478.2895624915545, 4149.734331029035, 4438.556144385568, 4704.811807527695, 4718.669693121483, 4721.102990431841, 7810.648520816577, 7918.337149198675, 7928.524288542706, 7947.08608510023, 7957.811601809491, 4636.304554316879, 4764.95235047652, 4772.236442169236, 4776.259679749575, 4781.2111001685025, 4129.752214867118, 4845.103655823684, 4921.680090794087, 4932.4081110267, 4945.901081978341, 5885.793997210077, 5954.970225148933, 5960.374160713062, 5971.970140149271, 6015.4586087252355, 7536.284053014955, 7538.246175382527, 7544.170141284454, 7555.811104722316, 7582.54504729707, 1614.7335689611082, 1673.046363572752, 1674.5311312832425, 1677.8825482216128, 1685.056368433681, 1011.726833754882, 1060.8037513059953, 1069.1446842525947, 1081.464674985887, 1088.5972190289644, 6939.791806245821, 6961.860762784716, 6962.094927659473, 6974.616396098263, 6993.440524758007, 7522.247775222434, 7629.7329593463965, 7639.350655194371, 7644.6942122315595, 7690.923090769021, 5367.677939323653, 5592.552595792326, 5821.679807610537, 6751.797446076625, 6990.4757143214465, 3307.818070006125, 3966.781826999485, 3985.960140398617, 4040.6565441937764, 4071.9389209161886, 6426.421622053944, 6463.578012837168, 7951.284384405431, 8077.151899050633, 8139.633716482773, 8133.633986470623, 8142.918570814334, 8147.837043259102, 8152.225538573826, 8168.224018718212, 7959.681612735426, 8097.0, 8164.918350816534, 8171.591420429074, 8172.550509721904, 7647.808804779925, 7827.25641064098, 7828.5694286812495, 7870.763877083697, 7880.487768295043, 7154.534955227893, 7464.216257292906, 7669.118051424158, 7715.807104822425, 7727.652255648622, 6924.169099708067, 7032.980217868483, 8127.75616731499, 8142.918570814216, 8165.020197576328, 4823.252395878644, 4825.831095911626, 4826.758662066953, 4832.251001094836, 4851.393575803025, 7587.544747315179, 7799.610019499116, 7819.765407037798, 7822.474617449543, 7850.528968261922, 7496.175420703609, 7512.774616761506, 7518.097828260644, 7526.435517336112, 7532.698692052257, 6391.93608063932, 7472.14070381913, 7500.9249907500225, 7503.662335195038, 7525.548467091992, 7092.25531319204, 7302.123745150403, 7321.59731214767, 7395.630218488946, 7441.218672039358, 7580.279873412017, 7583.544987300779, 7589.772306830804, 7590.430717696085, 7597.772066838003, 7146.464015198777, 7379.3358597726465, 7411.2588741125455, 7412.481126321106, 7447.925520744723], "unit": "ms", "name": "prototype.html", "value": 5354.388646600966}, {"lowerIsBetter": false, "replicates": [710.0556260173965, 723.609251004458, 797.401948538596, 802.3060053054108, 815.824597711492, 13502.459901603936, 13627.93186034071, 13670.316484175777, 13700.931495342535, 13776.173429594219, 13917.373718182705, 13999.30003499826, 14076.57770266891, 14104.929475352634, 14123.57629271121, 754.6566312327891, 772.9265719756614, 937.4843835890233, 960.8894977077656, 961.0149596663441, 946.3281070439996, 953.823542644613, 957.286821318119, 959.8608201810733, 963.3978763272954, 998.5706146357063, 1003.2325271167563, 1004.196642685852, 1014.4167103915241, 1020.6835880876915, 991.5736233419626, 997.6907158780801, 1008.991008991009, 1012.0335079998583, 1012.8835183953865, 732.9560226386434, 737.8192342875976, 741.1958025542293, 744.5681504727245, 745.2137994415889, 14741.852581474155, 14854.628634284121, 14898.702025959421, 14957.850421495754, 14992.925035374863, 12434.316112613802, 12500.937495312466, 12759.362031898461, 12976.221426714428, 13082.672933176651, 10084.2436817239, 10184.28709990301, 10417.166626669925, 10620.513128162063, 11008.449577521093, 3500.5974312953826, 3505.631908649606, 3516.1209697575605, 3519.5248641433336, 3522.3307571561577, 78289.60855195687, 79489.60255198687, 80567.58297251092, 81558.0, 82126.0, 8654.78363040929, 9708.417494950325, 9774.462404567676, 9828.655997040069, 10010.64962726301, 21508.354749357546, 21681.56636867254, 21915.67126493104, 22021.33935981923, 22088.33734987953, 6655.101561289164, 6701.798946031627, 6951.131108611424, 6971.407430368476, 7574.924250757532, 3392.6437724039115, 4118.9476560753355, 4162.354835000579, 4173.895652608649, 4178.1643671265265, 3088.583041289442, 3128.8122712637314, 3132.7963682360573, 3135.1064946490596, 3135.623725152996, 491.95818355439474, 494.38942905512386, 495.7397366382678, 502.19147173051357, 506.3139446050622, 491.54992771324737, 493.70377773335713, 502.69586899925747, 511.7697036333665, 512.8410192840231, 7707.653155608011, 8518.57407129641, 8622.180892815173, 8669.176428239307, 8861.512616806009, 508.98982020359387, 531.2615464504343, 593.8597892047279, 630.4735545819201, 654.8199245207607, 3818.3317919364, 4070.4911886014247, 4150.113012914288, 4171.624553790113, 4217.557156498585, 90702.0, 92453.07546924445, 93105.5344723272, 94812.0518794817, 102121.0, 85534.14465855261, 86371.56814215888, 86664.70002949961, 87415.25169496574, 87542.0, 76934.0, 77717.0, 78126.60936695394, 78892.81660774979, 80095.59952200201, 8811.955940220514, 8894.911050889667, 9020.124580737818, 9076.773080672772, 9275.026122257066, 52048.0, 53479.7326013383, 54397.0, 54803.451965479835, 55012.0, 74712.13219669335, 74793.25206747864, 75135.62432187804, 75798.24201758133, 76280.0, 8099.635516401659, 8125.918740812753, 8184.427090103635, 8231.876521852297, 8302.83394332122, 11973.10201734856, 12179.939100304442, 12187.57343493009, 12633.115681902178, 13154.21074735519, 11440.313581185155, 11488.368139752394, 11905.0, 12102.092343074128, 12195.024398048312, 11787.998020168381, 12028.0, 12038.75922481528, 12103.394830258276, 12248.571300004458, 11622.88377116218, 11750.70623234426, 11753.764924701629, 11776.941115294369, 12043.916047555762, 9396.0, 9662.661806836726, 9778.266630002921, 9864.210863131077, 10050.145737612092, 9667.129958303787, 10025.649102281384, 10049.346792458467, 10081.596736130472, 10089.142422894136], "unit": "ms", "name": "yui.html", "value": 6936.2985266593805}], "name": "dromaeo_css", "value": 7309.238533680764}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [118.0, 150.0, 169.0, 114.0, 115.0, 125.0, 113.0, 117.0, 116.0, 116.0], "unit": "ms", "name": "ai-astar", "value": 125.3}, {"lowerIsBetter": true, "replicates": [146.0, 124.0, 148.0, 154.0, 122.0, 151.0, 128.0, 167.0, 162.0, 149.0], "unit": "ms", "name": "audio-beat-detection", "value": 145.1}, {"lowerIsBetter": true, "replicates": [222.0, 204.0, 208.0, 167.0, 179.0, 250.0, 246.0, 166.0, 248.0, 287.0], "unit": "ms", "name": "audio-dft", "value": 217.7}, {"lowerIsBetter": true, "replicates": [75.0, 97.0, 65.0, 134.0, 48.0, 59.0, 51.0, 58.0, 136.0, 83.0], "unit": "ms", "name": "audio-fft", "value": 80.6}, {"lowerIsBetter": true, "replicates": [77.0, 78.0, 110.0, 76.0, 78.0, 77.0, 111.0, 76.0, 78.0, 111.0], "unit": "ms", "name": "audio-oscillator", "value": 87.2}, {"lowerIsBetter": true, "replicates": [103.0, 118.0, 87.0, 94.0, 122.0, 88.0, 90.0, 88.0, 88.0, 87.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 96.5}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 96.0, 96.0], "unit": "ms", "name": "imaging-darkroom", "value": 95.3}, {"lowerIsBetter": true, "replicates": [97.0, 98.0, 94.0, 93.0, 100.0, 94.0, 97.0, 105.0, 80.0, 149.0], "unit": "ms", "name": "imaging-desaturate", "value": 100.7}, {"lowerIsBetter": true, "replicates": [59.0, 59.0, 64.0, 78.0, 85.0, 89.0, 77.0, 66.0, 59.0, 59.0], "unit": "ms", "name": "json-parse-financial", "value": 69.5}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 66.0, 66.0, 68.0, 63.0, 65.0, 66.0, 71.0, 72.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 67.3}, {"lowerIsBetter": true, "replicates": [84.0, 87.0, 87.0, 87.0, 86.0, 86.0, 83.0, 86.0, 83.0, 85.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 85.4}, {"lowerIsBetter": true, "replicates": [129.0, 125.0, 133.0, 131.0, 133.0, 130.0, 124.0, 122.0, 131.0, 129.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 128.7}, {"lowerIsBetter": true, "replicates": [135.0, 141.0, 139.0, 137.0, 151.0, 141.0, 135.0, 142.0, 153.0, 172.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 144.6}, {"lowerIsBetter": true, "replicates": [62.0, 68.0, 87.0, 90.0, 96.0, 68.0, 66.0, 69.0, 67.0, 67.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 74.0}], "name": "kraken", "value": 1517.9}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [148.5663348685188], "unit": "score", "name": "Richards", "value": 237.617762}, {"lowerIsBetter": false, "replicates": [159.4387755102041], "unit": "score", "name": "DeltaBlue", "value": 414.6920960000001}, {"lowerIsBetter": false, "replicates": [283.60748723766307], "unit": "score", "name": "Encrypt", "value": 938.5542060000004}, {"lowerIsBetter": false, "replicates": [4911.764705882353], "unit": "score", "name": "Decrypt", "value": 54.192538922155705}, {"lowerIsBetter": false, "replicates": [943.3962264150944], "unit": "score", "name": "RayTrace", "value": 784.3883400000002}, {"lowerIsBetter": false, "replicates": [717.3601147776184], "unit": "score", "name": "Earley", "value": 929.0494220000003}, {"lowerIsBetter": false, "replicates": [13157.894736842105], "unit": "score", "name": "Boyer", "value": 50.65118800000001}, {"lowerIsBetter": false, "replicates": [26815.78947368421], "unit": "score", "name": "RegExp", "value": 33.97196270853777}, {"lowerIsBetter": false, "replicates": [799.3605115907275], "unit": "score", "name": "Splay", "value": 101.94524099999997}, {"lowerIsBetter": false, "replicates": [4545.454545454545], "unit": "score", "name": "NavierStokes", "value": 326.4799999999998}], "name": "v8_7", "value": 21574.338929917263}]} 16:55:12 INFO - RETURN: dromaeo_css: 7309.24 16:55:12 INFO - RETURN: kraken: 1517.90 16:55:12 INFO - RETURN: v8_7: 21574.34 16:55:12 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,61]]", "result": "21574.34"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,61]]", "result": "1517.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,61]]", "result": "7309.24"}}} 16:55:12 INFO - Return code: 0 16:55:12 INFO - # TBPL SUCCESS # 16:55:12 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:55:12 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:55:12 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:55:12 INFO - 2015-11-19 16:55:12.165 screenresolution[1963:21452] starting screenresolution argv=screenresolution get 16:55:12 INFO - 2015-11-19 16:55:12.168 screenresolution[1963:21452] Display 0: 1600x1200x32@60 16:55:12 INFO - 2015-11-19 16:55:12.174 screenresolution[1964:21455] starting screenresolution argv=screenresolution list 16:55:12 INFO - Available Modes on Display 0 16:55:12 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:55:12 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:55:12 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:55:12 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:55:12 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:55:12 INFO - Intel Iris: 16:55:12 INFO - Chipset Model: Intel Iris 16:55:12 INFO - Type: GPU 16:55:12 INFO - Bus: Built-In 16:55:12 INFO - VRAM (Dynamic, Max): 1536 MB 16:55:12 INFO - Vendor: Intel (0x8086) 16:55:12 INFO - Device ID: 0x0a2e 16:55:12 INFO - Revision ID: 0x0009 16:55:12 INFO - Displays: 16:55:12 INFO - Display: 16:55:12 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:55:12 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:55:12 INFO - Display Serial Number: 1600x1200 60 16:55:12 INFO - Main Display: Yes 16:55:12 INFO - Mirror: Off 16:55:12 INFO - Online: Yes 16:55:12 INFO - Rotation: Supported 16:55:12 INFO - Return code: 0 16:55:12 INFO - Running post-action listener: _resource_record_post_action 16:55:12 INFO - Running post-run listener: _resource_record_post_run 16:55:13 INFO - Total resource usage - Wall time: 1237s; CPU: 53.0%; Read bytes: 114688; Write bytes: 697311744; Read time: 5; Write time: 2102 16:55:13 INFO - install - Wall time: 31s; CPU: 54.0%; Read bytes: 336288256; Write bytes: 339421184; Read time: 25888; Write time: 646 16:55:13 INFO - run-tests - Wall time: 1207s; CPU: 53.0%; Read bytes: 114688; Write bytes: 346679808; Read time: 5; Write time: 1414 16:55:13 INFO - Running post-run listener: _upload_blobber_files 16:55:13 INFO - Blob upload gear active. 16:55:13 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 16:55:13 INFO - Copying logs to upload dir... 16:55:13 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1279.449457 ========= master_lag: 0.07 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2015-11-19 16:55:13.564584) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-19 16:55:13.568736) ========= 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.TIGoEd1942/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.lamYHtLWcH/Listeners TMPDIR=/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False build_url:https://queue.taskcluster.net/v1/task/gQRM5_W8Rke8DVgKxHbI3w/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.009434 build_url: 'https://queue.taskcluster.net/v1/task/gQRM5_W8Rke8DVgKxHbI3w/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg' ========= master_lag: 0.01 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-19 16:55:13.592093) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 16:55:13.594502) ========= 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.TIGoEd1942/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.lamYHtLWcH/Listeners TMPDIR=/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005121 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 16:55:13.643158) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-19 16:55:13.643478) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-19 16:55:13.643853) ========= ========= Total master_lag: 0.25 =========