builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0033 starttime: 1448363291.27 results: success (0) buildid: 20151124012131 builduid: e5f74d643fef453f9a894c006d40420f revision: 9d1be94ff95a2252405ae5ec6fb4a8d083440dbe ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-24 03:08:11.266913) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-24 03:08:11.271402) ========= ========= Started set props: basedir (results: 0, elapsed: 10 secs) (at 2015-11-24 03:08:11.271795) ========= 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.YcOeaCfrTj/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.x1niOHBkIw/Listeners TMPDIR=/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/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.005901 basedir: '/builds/slave/test' ========= master_lag: 10.11 ========= ========= Finished set props: basedir (results: 0, elapsed: 10 secs) (at 2015-11-24 03:08:21.391542) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 8 secs) (at 2015-11-24 03:08:21.391873) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 8 secs) (at 2015-11-24 03:08:29.735902) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 03:08:29.736195) ========= 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.YcOeaCfrTj/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.x1niOHBkIw/Listeners TMPDIR=/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/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.005329 ========= master_lag: 0.40 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 03:08:30.140075) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-24 03:08:30.140674) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-24 03:08:30.141215) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-24 03:08:30.147827) ========= 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.YcOeaCfrTj/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.x1niOHBkIw/Listeners TMPDIR=/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/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-24 03:08:30-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 8.17M=0.001s 2015-11-24 03:08:30 (8.17 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.561487 ========= master_lag: 0.78 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-24 03:08:31.490834) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 03:08:31.491101) ========= 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.YcOeaCfrTj/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.x1niOHBkIw/Listeners TMPDIR=/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/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.019728 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 03:08:31.532928) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-24 03:08:31.533249) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 9d1be94ff95a2252405ae5ec6fb4a8d083440dbe --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 9d1be94ff95a2252405ae5ec6fb4a8d083440dbe --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.YcOeaCfrTj/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.x1niOHBkIw/Listeners TMPDIR=/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/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-24 03:08:31,698 truncating revision to first 12 chars 2015-11-24 03:08:31,698 Setting DEBUG logging. 2015-11-24 03:08:31,698 attempt 1/10 2015-11-24 03:08:31,698 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/9d1be94ff95a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-24 03:08:32,384 unpacking tar archive at: fx-team-9d1be94ff95a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.928735 ========= master_lag: 0.10 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-24 03:08:32.561872) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-24 03:08:32.562170) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-24 03:08:32.576699) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-24 03:08:32.577003) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-24 03:08:32.577434) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2015-11-24 03:08:32.577713) ========= /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.YcOeaCfrTj/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.x1niOHBkIw/Listeners TMPDIR=/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/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 03:08:32 INFO - MultiFileLogger online at 20151124 03:08:32 in /builds/slave/test 03:08:32 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 03:08:32 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:08:32 INFO - {'append_to_log': False, 03:08:32 INFO - 'base_work_dir': '/builds/slave/test', 03:08:32 INFO - 'blob_upload_branch': 'Fx-Team', 03:08:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:08:32 INFO - 'branch': 'Fx-Team', 03:08:32 INFO - 'buildbot_json_path': 'buildprops.json', 03:08:32 INFO - 'config_files': ('talos/mac_config.py',), 03:08:32 INFO - 'default_actions': ('clobber', 03:08:32 INFO - 'read-buildbot-config', 03:08:32 INFO - 'download-and-extract', 03:08:32 INFO - 'populate-webroot', 03:08:32 INFO - 'create-virtualenv', 03:08:32 INFO - 'install', 03:08:32 INFO - 'run-tests'), 03:08:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:08:32 INFO - 'download_minidump_stackwalk': True, 03:08:32 INFO - 'download_symbols': 'ondemand', 03:08:32 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:08:32 INFO - 'tooltool.py': '/tools/tooltool.py', 03:08:32 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:08:32 INFO - '/tools/misc-python/virtualenv.py')}, 03:08:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:08:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:08:32 INFO - 'installer_path': 'installer.exe', 03:08:32 INFO - 'log_level': 'info', 03:08:32 INFO - 'log_name': 'talos', 03:08:32 INFO - 'log_to_console': True, 03:08:32 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 03:08:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 03:08:32 INFO - 'opt_config_files': (), 03:08:32 INFO - 'pip_index': False, 03:08:32 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:08:32 INFO - 'cmd': ('bash', 03:08:32 INFO - '-c', 03:08:32 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:08:32 INFO - 'enabled': True, 03:08:32 INFO - 'halt_on_failure': False, 03:08:32 INFO - 'name': 'check_screen_resolution'},), 03:08:32 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:08:32 INFO - 'cmd': ('bash', 03:08:32 INFO - '-c', 03:08:32 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:08:32 INFO - 'enabled': True, 03:08:32 INFO - 'halt_on_failure': False, 03:08:32 INFO - 'name': 'check_screen_resolution'},), 03:08:32 INFO - 'run_cmd_checks_enabled': True, 03:08:32 INFO - 'sps_profile': False, 03:08:32 INFO - 'sps_profile_interval': 0, 03:08:32 INFO - 'suite': 'dromaeojs-e10s', 03:08:32 INFO - 'system_bits': '64', 03:08:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:08:32 INFO - 'title': 't-yosemite-r7-0033', 03:08:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:08:32 INFO - 'use_talos_json': True, 03:08:32 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:08:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:08:32 INFO - 'work_dir': 'build'} 03:08:32 INFO - ##### 03:08:32 INFO - ##### Running clobber step. 03:08:32 INFO - ##### 03:08:32 INFO - Running pre-action listener: _resource_record_pre_action 03:08:32 INFO - Running main action method: clobber 03:08:32 INFO - rmtree: /builds/slave/test/build 03:08:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:08:33 INFO - Running post-action listener: _resource_record_post_action 03:08:33 INFO - ##### 03:08:33 INFO - ##### Running read-buildbot-config step. 03:08:33 INFO - ##### 03:08:33 INFO - Running pre-action listener: _resource_record_pre_action 03:08:33 INFO - Running main action method: read_buildbot_config 03:08:33 INFO - Using buildbot properties: 03:08:33 INFO - { 03:08:33 INFO - "properties": { 03:08:33 INFO - "buildnumber": 25, 03:08:33 INFO - "product": "firefox", 03:08:33 INFO - "script_repo_revision": "production", 03:08:33 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 03:08:33 INFO - "repository": "", 03:08:33 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 03:08:33 INFO - "buildid": "20151124012131", 03:08:33 INFO - "slavename": "t-yosemite-r7-0033", 03:08:33 INFO - "pgo_build": "False", 03:08:33 INFO - "basedir": "/builds/slave/test", 03:08:33 INFO - "project": "", 03:08:33 INFO - "platform": "yosemite_r7", 03:08:33 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 03:08:33 INFO - "slavebuilddir": "test", 03:08:33 INFO - "scheduler": "tests-fx-team-macosx64-talos", 03:08:33 INFO - "branch": "fx-team", 03:08:33 INFO - "repo_path": "integration/fx-team", 03:08:33 INFO - "stage_platform": "macosx64", 03:08:33 INFO - "builduid": "e5f74d643fef453f9a894c006d40420f", 03:08:33 INFO - "revision": "9d1be94ff95a2252405ae5ec6fb4a8d083440dbe" 03:08:33 INFO - }, 03:08:33 INFO - "sourcestamp": { 03:08:33 INFO - "repository": "", 03:08:33 INFO - "hasPatch": false, 03:08:33 INFO - "project": "", 03:08:33 INFO - "branch": "fx-team-macosx64-talos", 03:08:33 INFO - "changes": [ 03:08:33 INFO - { 03:08:33 INFO - "category": null, 03:08:33 INFO - "files": [ 03:08:33 INFO - { 03:08:33 INFO - "url": null, 03:08:33 INFO - "name": "https://queue.taskcluster.net/v1/task/5scwinrvRay9hPVQh31uYA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 03:08:33 INFO - } 03:08:33 INFO - ], 03:08:33 INFO - "repository": "", 03:08:33 INFO - "rev": "9d1be94ff95a2252405ae5ec6fb4a8d083440dbe", 03:08:33 INFO - "who": "gijskruitbosch@gmail.com", 03:08:33 INFO - "when": 1448363237, 03:08:33 INFO - "number": 6699658, 03:08:33 INFO - "comments": "Bug 1227116 - fix cmd-click on SVG links as well, r=felipe", 03:08:33 INFO - "project": "", 03:08:33 INFO - "at": "Tue 24 Nov 2015 03:07:17", 03:08:33 INFO - "branch": "fx-team-macosx64-talos", 03:08:33 INFO - "revlink": "", 03:08:33 INFO - "properties": [ 03:08:33 INFO - [ 03:08:33 INFO - "buildid", 03:08:33 INFO - "20151124012131", 03:08:33 INFO - "Change" 03:08:33 INFO - ], 03:08:33 INFO - [ 03:08:33 INFO - "builduid", 03:08:33 INFO - "e5f74d643fef453f9a894c006d40420f", 03:08:33 INFO - "Change" 03:08:33 INFO - ], 03:08:33 INFO - [ 03:08:33 INFO - "pgo_build", 03:08:33 INFO - "False", 03:08:33 INFO - "Change" 03:08:33 INFO - ] 03:08:33 INFO - ], 03:08:33 INFO - "revision": "9d1be94ff95a2252405ae5ec6fb4a8d083440dbe" 03:08:33 INFO - } 03:08:33 INFO - ], 03:08:33 INFO - "revision": "9d1be94ff95a2252405ae5ec6fb4a8d083440dbe" 03:08:33 INFO - } 03:08:33 INFO - } 03:08:33 INFO - Found installer url https://queue.taskcluster.net/v1/task/5scwinrvRay9hPVQh31uYA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 03:08:33 INFO - Running post-action listener: _resource_record_post_action 03:08:33 INFO - ##### 03:08:33 INFO - ##### Running download-and-extract step. 03:08:33 INFO - ##### 03:08:33 INFO - Running pre-action listener: _resource_record_pre_action 03:08:33 INFO - Running main action method: download_and_extract 03:08:33 INFO - mkdir: /builds/slave/test/build/tests 03:08:33 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')]} 03:08:33 INFO - https://queue.taskcluster.net/v1/task/5scwinrvRay9hPVQh31uYA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 03:08:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/5scwinrvRay9hPVQh31uYA/artifacts/public/build/test_packages.json 03:08:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/5scwinrvRay9hPVQh31uYA/artifacts/public/build/test_packages.json 03:08:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/5scwinrvRay9hPVQh31uYA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 03:08:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/5scwinrvRay9hPVQh31uYA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 03:08:37 INFO - Downloaded 1149 bytes. 03:08:37 INFO - Reading from file /builds/slave/test/build/test_packages.json 03:08:37 INFO - Using the following test package requirements: 03:08:37 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 03:08:37 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 03:08:37 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 03:08:37 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 03:08:37 INFO - u'jsshell-mac.zip'], 03:08:37 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 03:08:37 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 03:08:37 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 03:08:37 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 03:08:37 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 03:08:37 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 03:08:37 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 03:08:37 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 03:08:37 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 03:08:37 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 03:08:37 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 03:08:37 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 03:08:37 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 03:08:37 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')]} 03:08:37 INFO - https://queue.taskcluster.net/v1/task/5scwinrvRay9hPVQh31uYA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 03:08:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/5scwinrvRay9hPVQh31uYA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 03:08:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/5scwinrvRay9hPVQh31uYA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 03:08:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/5scwinrvRay9hPVQh31uYA/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 03:08:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/5scwinrvRay9hPVQh31uYA/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 03:08:40 INFO - Downloaded 17526942 bytes. 03:08:40 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 03:08:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 03:08:40 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 03:08:43 INFO - Return code: 0 03:08:43 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 03:08:43 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')]} 03:08:43 INFO - https://queue.taskcluster.net/v1/task/5scwinrvRay9hPVQh31uYA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 03:08:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/5scwinrvRay9hPVQh31uYA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 03:08:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/5scwinrvRay9hPVQh31uYA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 03:08:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/5scwinrvRay9hPVQh31uYA/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 03:08:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/5scwinrvRay9hPVQh31uYA/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 03:08:44 INFO - Downloaded 17526942 bytes. 03:08:44 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 03:08:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 03:08:44 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 03:08:47 INFO - Return code: 0 03:08:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:08:47 INFO - https://queue.taskcluster.net/v1/task/5scwinrvRay9hPVQh31uYA/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 03:08:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/5scwinrvRay9hPVQh31uYA/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 03:08:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/5scwinrvRay9hPVQh31uYA/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 03:08:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/5scwinrvRay9hPVQh31uYA/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 03:08:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/5scwinrvRay9hPVQh31uYA/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 03:08:49 INFO - Downloaded 11130997 bytes. 03:08:49 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 03:08:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 03:08:49 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 03:08:49 INFO - Return code: 0 03:08:49 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')]} 03:08:49 INFO - https://queue.taskcluster.net/v1/task/5scwinrvRay9hPVQh31uYA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 03:08:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/5scwinrvRay9hPVQh31uYA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 03:08:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/5scwinrvRay9hPVQh31uYA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 03:08:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/5scwinrvRay9hPVQh31uYA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 03:08:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/5scwinrvRay9hPVQh31uYA/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 03:08:52 INFO - Downloaded 109909323 bytes. 03:08:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/5scwinrvRay9hPVQh31uYA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 03:08:52 INFO - mkdir: /builds/slave/test/properties 03:08:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:08:52 INFO - Writing to file /builds/slave/test/properties/build_url 03:08:52 INFO - Contents: 03:08:52 INFO - build_url:https://queue.taskcluster.net/v1/task/5scwinrvRay9hPVQh31uYA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 03:08:52 INFO - Running post-action listener: _resource_record_post_action 03:08:52 INFO - Running post-action listener: set_extra_try_arguments 03:08:52 INFO - ##### 03:08:52 INFO - ##### Running populate-webroot step. 03:08:52 INFO - ##### 03:08:52 INFO - Running pre-action listener: _resource_record_pre_action 03:08:52 INFO - Running main action method: populate_webroot 03:08:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:08:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:08:52 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 03:08:52 INFO - '../fennec_ids.txt'], 03:08:52 INFO - 'tests': ['tcheck2']}, 03:08:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:08:52 INFO - '--tppagecycles', 03:08:52 INFO - '7'], 03:08:52 INFO - 'tests': ['tsvgm']}}, 03:08:52 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 03:08:52 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 03:08:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:08:52 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 03:08:52 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 03:08:52 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 03:08:52 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:08:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:08:52 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:08:52 INFO - 'talos_options': ['--e10s'], 03:08:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:08:52 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:08:52 INFO - 'tests': ['damp', 'tps']}, 03:08:52 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:08:52 INFO - 'talos_options': ['--e10s'], 03:08:52 INFO - 'tests': ['damp', 'tps']}, 03:08:52 INFO - 'g3': {'tests': ['dromaeo_dom']}, 03:08:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:08:52 INFO - 'other': {'tests': ['a11yr', 03:08:52 INFO - 'ts_paint', 03:08:52 INFO - 'tpaint', 03:08:52 INFO - 'sessionrestore', 03:08:52 INFO - 'sessionrestore_no_auto_restore']}, 03:08:52 INFO - 'other-e10s': {'talos_options': ['--e10s'], 03:08:52 INFO - 'tests': ['a11yr', 03:08:52 INFO - 'ts_paint', 03:08:52 INFO - 'tpaint', 03:08:52 INFO - 'sessionrestore', 03:08:52 INFO - 'sessionrestore_no_auto_restore']}, 03:08:52 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 03:08:52 INFO - 'tests': ['a11yr', 03:08:52 INFO - 'ts_paint', 03:08:52 INFO - 'tpaint', 03:08:52 INFO - 'sessionrestore', 03:08:52 INFO - 'sessionrestore_no_auto_restore']}, 03:08:52 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 03:08:52 INFO - 'tests': ['a11yr', 03:08:52 INFO - 'ts_paint', 03:08:52 INFO - 'tpaint', 03:08:52 INFO - 'sessionrestore', 03:08:52 INFO - 'sessionrestore_no_auto_restore']}, 03:08:52 INFO - 'other_l64': {'tests': ['a11yr', 03:08:52 INFO - 'ts_paint', 03:08:52 INFO - 'tpaint', 03:08:52 INFO - 'sessionrestore', 03:08:52 INFO - 'sessionrestore_no_auto_restore']}, 03:08:52 INFO - 'other_nol64': {'tests': ['a11yr', 03:08:52 INFO - 'ts_paint', 03:08:52 INFO - 'tpaint', 03:08:52 INFO - 'sessionrestore', 03:08:52 INFO - 'sessionrestore_no_auto_restore']}, 03:08:52 INFO - 'svgr': {'tests': ['tsvgx', 03:08:52 INFO - 'tsvgr_opacity', 03:08:52 INFO - 'tart', 03:08:52 INFO - 'tscrollx', 03:08:52 INFO - 'cart']}, 03:08:52 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 03:08:52 INFO - 'tests': ['tsvgx', 03:08:52 INFO - 'tsvgr_opacity', 03:08:52 INFO - 'tart', 03:08:52 INFO - 'tscrollx', 03:08:52 INFO - 'cart']}, 03:08:52 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:08:52 INFO - 'tests': ['tp5o']}, 03:08:52 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:08:52 INFO - 'talos_options': ['--e10s'], 03:08:52 INFO - 'tests': ['tp5o']}, 03:08:52 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:08:52 INFO - 'talos_options': ['--xperf_path', 03:08:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:08:52 INFO - 'tests': ['tp5n']}, 03:08:52 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:08:52 INFO - 'talos_options': ['--e10s', 03:08:52 INFO - '--xperf_path', 03:08:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:08:52 INFO - 'tests': ['tp5n']}}, 03:08:52 INFO - 'talos.zip': {'path': '', 03:08:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:08:52 INFO - Running post-action listener: _resource_record_post_action 03:08:52 INFO - ##### 03:08:52 INFO - ##### Running create-virtualenv step. 03:08:52 INFO - ##### 03:08:52 INFO - Running pre-action listener: _resource_record_pre_action 03:08:52 INFO - Running main action method: create_virtualenv 03:08:52 INFO - Creating virtualenv /builds/slave/test/build/venv 03:08:52 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 03:08:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:08:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:08:52 INFO - Using real prefix '/tools/python27' 03:08:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:08:53 INFO - Installing distribute.............................................................................................................................................................................................done. 03:08:56 INFO - Installing pip.................done. 03:08:56 INFO - Return code: 0 03:08:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:08: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')]} 03:08:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:08:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:08: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')]} 03:08:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:08:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:08:56 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 0x1092db490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1092b8228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb3e3d87c50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1091ff9f0>, '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 0x108f5edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1091f28c8>, '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.YcOeaCfrTj/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.x1niOHBkIw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/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 03:08:56 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 03:08:56 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 03:08:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YcOeaCfrTj/Render', 03:08:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:08:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:08:56 INFO - 'HOME': '/Users/cltbld', 03:08:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:08:56 INFO - 'LOGNAME': 'cltbld', 03:08:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:08:56 INFO - 'MOZ_NO_REMOTE': '1', 03:08:56 INFO - 'NO_EM_RESTART': '1', 03:08:56 INFO - 'PAGER': '/bin/cat', 03:08:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:08:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:08:56 INFO - 'PWD': '/builds/slave/test', 03:08:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:08:56 INFO - 'SHELL': '/bin/bash', 03:08:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.x1niOHBkIw/Listeners', 03:08:56 INFO - 'TMPDIR': '/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/', 03:08:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:08:56 INFO - 'USER': 'cltbld', 03:08:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:08:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:08:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:08:56 INFO - 'XPC_FLAGS': '0x0', 03:08:56 INFO - 'XPC_SERVICE_NAME': '0', 03:08:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:08:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:08:56 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 03:08:56 INFO - Cleaning up... 03:08:56 INFO - Return code: 0 03:08:56 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 03:08: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')]} 03:08:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:08:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:08: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')]} 03:08:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:08:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:08:56 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 0x1092db490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1092b8228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb3e3d87c50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1091ff9f0>, '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 0x108f5edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1091f28c8>, '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.YcOeaCfrTj/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.x1niOHBkIw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/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 03:08:56 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 03:08:56 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 03:08:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YcOeaCfrTj/Render', 03:08:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:08:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:08:56 INFO - 'HOME': '/Users/cltbld', 03:08:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:08:56 INFO - 'LOGNAME': 'cltbld', 03:08:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:08:56 INFO - 'MOZ_NO_REMOTE': '1', 03:08:56 INFO - 'NO_EM_RESTART': '1', 03:08:56 INFO - 'PAGER': '/bin/cat', 03:08:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:08:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:08:56 INFO - 'PWD': '/builds/slave/test', 03:08:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:08:56 INFO - 'SHELL': '/bin/bash', 03:08:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.x1niOHBkIw/Listeners', 03:08:56 INFO - 'TMPDIR': '/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/', 03:08:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:08:56 INFO - 'USER': 'cltbld', 03:08:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:08:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:08:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:08:56 INFO - 'XPC_FLAGS': '0x0', 03:08:56 INFO - 'XPC_SERVICE_NAME': '0', 03:08:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:08:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:08:56 INFO - Downloading/unpacking psutil>=0.7.1 03:08:56 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 03:08:56 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 03:08:56 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 03:08:56 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 03:08:56 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 03:08:56 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 03:08:59 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 03:08:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 03:08:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:08:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:08:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:08:59 INFO - Installing collected packages: psutil 03:08:59 INFO - Running setup.py install for psutil 03:08:59 INFO - building 'psutil._psutil_osx' extension 03:08:59 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 03:09:00 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 03:09:00 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 03:09:00 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 03:09:00 INFO - building 'psutil._psutil_posix' extension 03:09:00 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 03:09:00 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 03:09:00 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 03:09:00 INFO - ^ 03:09:00 INFO - 1 warning generated. 03:09:00 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 03:09:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:09:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:09:00 INFO - Successfully installed psutil 03:09:00 INFO - Cleaning up... 03:09:00 INFO - Return code: 0 03:09:00 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 03:09:00 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')]} 03:09:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:09:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:09:00 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')]} 03:09:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:09:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:09:00 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 0x1092db490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1092b8228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb3e3d87c50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1091ff9f0>, '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 0x108f5edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1091f28c8>, '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.YcOeaCfrTj/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.x1niOHBkIw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/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 03:09:00 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 03:09:00 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 03:09:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YcOeaCfrTj/Render', 03:09:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:09:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:09:00 INFO - 'HOME': '/Users/cltbld', 03:09:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:09:00 INFO - 'LOGNAME': 'cltbld', 03:09:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:09:00 INFO - 'MOZ_NO_REMOTE': '1', 03:09:00 INFO - 'NO_EM_RESTART': '1', 03:09:00 INFO - 'PAGER': '/bin/cat', 03:09:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:09:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:09:00 INFO - 'PWD': '/builds/slave/test', 03:09:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:09:00 INFO - 'SHELL': '/bin/bash', 03:09:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.x1niOHBkIw/Listeners', 03:09:00 INFO - 'TMPDIR': '/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/', 03:09:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:09:00 INFO - 'USER': 'cltbld', 03:09:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:09:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:09:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:09:00 INFO - 'XPC_FLAGS': '0x0', 03:09:00 INFO - 'XPC_SERVICE_NAME': '0', 03:09:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:09:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:09:00 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:09:00 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 03:09:00 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 03:09:00 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 03:09:00 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 03:09:00 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 03:09:00 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 03:09:03 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:09:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 03:09:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:09:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:09:03 INFO - Installing collected packages: mozsystemmonitor 03:09:03 INFO - Running setup.py install for mozsystemmonitor 03:09:03 INFO - Successfully installed mozsystemmonitor 03:09:03 INFO - Cleaning up... 03:09:03 INFO - Return code: 0 03:09:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:09:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:09:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:09:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:09:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:09:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:09:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:09:03 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 0x1092db490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1092b8228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb3e3d87c50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1091ff9f0>, '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 0x108f5edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1091f28c8>, '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.YcOeaCfrTj/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.x1niOHBkIw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/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 03:09:03 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 03:09:03 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 03:09:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YcOeaCfrTj/Render', 03:09:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:09:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:09:03 INFO - 'HOME': '/Users/cltbld', 03:09:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:09:03 INFO - 'LOGNAME': 'cltbld', 03:09:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:09:03 INFO - 'MOZ_NO_REMOTE': '1', 03:09:03 INFO - 'NO_EM_RESTART': '1', 03:09:03 INFO - 'PAGER': '/bin/cat', 03:09:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:09:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:09:03 INFO - 'PWD': '/builds/slave/test', 03:09:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:09:03 INFO - 'SHELL': '/bin/bash', 03:09:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.x1niOHBkIw/Listeners', 03:09:03 INFO - 'TMPDIR': '/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/', 03:09:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:09:03 INFO - 'USER': 'cltbld', 03:09:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:09:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:09:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:09:03 INFO - 'XPC_FLAGS': '0x0', 03:09:03 INFO - 'XPC_SERVICE_NAME': '0', 03:09:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:09:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:09:03 INFO - Downloading/unpacking blobuploader==1.2.4 03:09:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:09:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:09:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:09:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:09:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:09:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:09:05 INFO - Downloading blobuploader-1.2.4.tar.gz 03:09:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 03:09:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:09:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:09:05 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 03:09:05 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 03:09:05 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 03:09:05 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 03:09:05 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 03:09:05 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 03:09:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 03:09:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:09:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:09:06 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 03:09:06 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 03:09:06 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 03:09:06 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 03:09:06 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 03:09:06 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 03:09:06 INFO - Downloading docopt-0.6.1.tar.gz 03:09:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 03:09:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:09:07 INFO - Installing collected packages: blobuploader, requests, docopt 03:09:07 INFO - Running setup.py install for blobuploader 03:09:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:09:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:09:07 INFO - Running setup.py install for requests 03:09:07 INFO - Running setup.py install for docopt 03:09:07 INFO - Successfully installed blobuploader requests docopt 03:09:07 INFO - Cleaning up... 03:09:07 INFO - Return code: 0 03:09:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:09:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:09:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:09:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:09:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:09:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:09:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:09:07 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 0x1092db490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1092b8228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb3e3d87c50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1091ff9f0>, '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 0x108f5edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1091f28c8>, '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.YcOeaCfrTj/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.x1niOHBkIw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/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 03:09:07 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 03:09:07 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 03:09:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YcOeaCfrTj/Render', 03:09:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:09:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:09:07 INFO - 'HOME': '/Users/cltbld', 03:09:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:09:07 INFO - 'LOGNAME': 'cltbld', 03:09:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:09:07 INFO - 'MOZ_NO_REMOTE': '1', 03:09:07 INFO - 'NO_EM_RESTART': '1', 03:09:07 INFO - 'PAGER': '/bin/cat', 03:09:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:09:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:09:07 INFO - 'PWD': '/builds/slave/test', 03:09:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:09:07 INFO - 'SHELL': '/bin/bash', 03:09:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.x1niOHBkIw/Listeners', 03:09:07 INFO - 'TMPDIR': '/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/', 03:09:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:09:07 INFO - 'USER': 'cltbld', 03:09:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:09:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:09:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:09:07 INFO - 'XPC_FLAGS': '0x0', 03:09:07 INFO - 'XPC_SERVICE_NAME': '0', 03:09:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:09:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:09:08 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-epPXOZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:09:08 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-KzQE12-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:09:08 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-_li492-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:09:08 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-4SoH2H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:09:08 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-Tw5Z8K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:09:08 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-uWiBKd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:09:08 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-HgljTt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:09:08 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-SuShDE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:09:08 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-BW9nn7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:09:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:09:09 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-WUMViu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:09:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:09:09 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-RRrcCW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:09:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:09:09 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-ChqQoi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:09:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:09:09 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-g7Yf1j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:09:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:09:09 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-FmcxJM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:09:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:09:09 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-NChgIt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:09:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:09:09 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-tXk7Va-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:09:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:09:09 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-qsB59G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:09:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:09:09 INFO - Running setup.py install for manifestparser 03:09:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:09:09 INFO - Running setup.py install for mozcrash 03:09:10 INFO - Running setup.py install for mozdebug 03:09:10 INFO - Running setup.py install for mozdevice 03:09:10 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:09:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:09:10 INFO - Running setup.py install for mozfile 03:09:10 INFO - Running setup.py install for mozhttpd 03:09:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:09:10 INFO - Running setup.py install for mozinfo 03:09:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:09:10 INFO - Running setup.py install for mozInstall 03:09:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:09:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:09:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:09:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:09:11 INFO - Running setup.py install for mozleak 03:09:11 INFO - Running setup.py install for mozlog 03:09:11 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:09:11 INFO - Running setup.py install for moznetwork 03:09:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:09:11 INFO - Running setup.py install for mozprocess 03:09:11 INFO - Running setup.py install for mozprofile 03:09:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:09:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:09:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:09:11 INFO - Running setup.py install for mozrunner 03:09:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:09:11 INFO - Running setup.py install for mozscreenshot 03:09:12 INFO - Running setup.py install for moztest 03:09:12 INFO - Running setup.py install for mozversion 03:09:12 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:09:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:09:12 INFO - Cleaning up... 03:09:12 INFO - Return code: 0 03:09:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:09:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:09:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:09:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:09:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:09:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:09:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:09:12 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 0x1092db490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1092b8228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb3e3d87c50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1091ff9f0>, '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 0x108f5edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1091f28c8>, '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.YcOeaCfrTj/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.x1niOHBkIw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/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 03:09:12 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 03:09:12 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 03:09:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YcOeaCfrTj/Render', 03:09:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:09:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:09:12 INFO - 'HOME': '/Users/cltbld', 03:09:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:09:12 INFO - 'LOGNAME': 'cltbld', 03:09:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:09:12 INFO - 'MOZ_NO_REMOTE': '1', 03:09:12 INFO - 'NO_EM_RESTART': '1', 03:09:12 INFO - 'PAGER': '/bin/cat', 03:09:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:09:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:09:12 INFO - 'PWD': '/builds/slave/test', 03:09:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:09:12 INFO - 'SHELL': '/bin/bash', 03:09:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.x1niOHBkIw/Listeners', 03:09:12 INFO - 'TMPDIR': '/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/', 03:09:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:09:12 INFO - 'USER': 'cltbld', 03:09:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:09:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:09:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:09:12 INFO - 'XPC_FLAGS': '0x0', 03:09:12 INFO - 'XPC_SERVICE_NAME': '0', 03:09:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:09:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:09:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:09:12 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-uUyGjl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:09:12 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)) 03:09:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:09:12 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-4fmCCu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:09:12 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)) 03:09:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:09:12 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-XVQ832-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:09:13 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)) 03:09:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:09:13 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-mMLiym-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:09:13 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)) 03:09:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:09:13 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-B0JbOT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:09:13 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)) 03:09:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:09:13 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-cv60TX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:09:13 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)) 03:09:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:09:13 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-FUlHWw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:09:13 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)) 03:09:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:09:13 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-OSxuhh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:09:13 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)) 03:09:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:09:13 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-ThROLT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:09:13 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)) 03:09:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:09:13 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-Qw3FuE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:09:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:09:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:09:13 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-QBuzrk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:09:13 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)) 03:09:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:09:13 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-zWp4Vx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:09:13 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)) 03:09:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:09:13 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-GYY2Ow-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:09:14 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)) 03:09:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:09:14 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-qtbnAf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:09:14 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)) 03:09:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:09:14 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-c8K03Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:09:14 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)) 03:09:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:09:14 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-brLyv7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:09:14 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)) 03:09:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:09:14 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-ckHpbS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:09:14 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)) 03:09:14 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)) 03:09:14 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)) 03:09:14 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)) 03:09:14 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)) 03:09:14 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)) 03:09:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:09: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 03:09: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 03:09: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 03:09: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 03:09: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 03:09: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 03:09:16 INFO - Downloading blessings-1.5.1.tar.gz 03:09:16 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 03:09:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:09:16 INFO - Installing collected packages: blessings 03:09:16 INFO - Running setup.py install for blessings 03:09:16 INFO - Successfully installed blessings 03:09:16 INFO - Cleaning up... 03:09:16 INFO - Return code: 0 03:09:16 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:09:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:09:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:09:17 INFO - Reading from file tmpfile_stdout 03:09:17 INFO - Current package versions: 03:09:17 INFO - blessings == 1.5.1 03:09:17 INFO - blobuploader == 1.2.4 03:09:17 INFO - docopt == 0.6.1 03:09:17 INFO - manifestparser == 1.1 03:09:17 INFO - mozInstall == 1.12 03:09:17 INFO - mozcrash == 0.16 03:09:17 INFO - mozdebug == 0.1 03:09:17 INFO - mozdevice == 0.47 03:09:17 INFO - mozfile == 1.2 03:09:17 INFO - mozhttpd == 0.7 03:09:17 INFO - mozinfo == 0.9 03:09:17 INFO - mozleak == 0.1 03:09:17 INFO - mozlog == 3.1 03:09:17 INFO - moznetwork == 0.27 03:09:17 INFO - mozprocess == 0.22 03:09:17 INFO - mozprofile == 0.27 03:09:17 INFO - mozrunner == 6.11 03:09:17 INFO - mozscreenshot == 0.1 03:09:17 INFO - mozsystemmonitor == 0.0 03:09:17 INFO - moztest == 0.7 03:09:17 INFO - mozversion == 1.4 03:09:17 INFO - psutil == 3.1.1 03:09:17 INFO - requests == 1.2.3 03:09:17 INFO - wsgiref == 0.1.2 03:09:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:09: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')]} 03:09:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:09:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:09: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')]} 03:09:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:09:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:09: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', '-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 0x1092db490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1092b8228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb3e3d87c50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1091ff9f0>, '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 0x108f5edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1091f28c8>, '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.YcOeaCfrTj/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.x1niOHBkIw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/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 03:09:17 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 03:09:17 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 03:09:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YcOeaCfrTj/Render', 03:09:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:09:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:09:17 INFO - 'HOME': '/Users/cltbld', 03:09:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:09:17 INFO - 'LOGNAME': 'cltbld', 03:09:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:09:17 INFO - 'MOZ_NO_REMOTE': '1', 03:09:17 INFO - 'NO_EM_RESTART': '1', 03:09:17 INFO - 'PAGER': '/bin/cat', 03:09:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:09:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:09:17 INFO - 'PWD': '/builds/slave/test', 03:09:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:09:17 INFO - 'SHELL': '/bin/bash', 03:09:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.x1niOHBkIw/Listeners', 03:09:17 INFO - 'TMPDIR': '/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/', 03:09:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:09:17 INFO - 'USER': 'cltbld', 03:09:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:09:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:09:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:09:17 INFO - 'XPC_FLAGS': '0x0', 03:09:17 INFO - 'XPC_SERVICE_NAME': '0', 03:09:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:09:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:09:17 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)) 03:09:17 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)) 03:09:17 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)) 03:09:17 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)) 03:09:17 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)) 03:09:17 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)) 03:09:17 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)) 03:09:17 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)) 03:09:17 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)) 03:09:17 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)) 03:09:17 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)) 03:09:17 INFO - Cleaning up... 03:09:17 INFO - Return code: 0 03:09:17 INFO - Running post-action listener: _resource_record_post_action 03:09:17 INFO - Running post-action listener: _start_resource_monitoring 03:09:17 INFO - Starting resource monitoring. 03:09:17 INFO - ##### 03:09:17 INFO - ##### Running install step. 03:09:17 INFO - ##### 03:09:17 INFO - Running pre-action listener: _resource_record_pre_action 03:09:17 INFO - Running main action method: install 03:09:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:09:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:09:17 INFO - Reading from file tmpfile_stdout 03:09:17 INFO - Detecting whether we're running mozinstall >=1.0... 03:09:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:09:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:09:17 INFO - Reading from file tmpfile_stdout 03:09:17 INFO - Output received: 03:09:17 INFO - Usage: mozinstall [options] installer 03:09:17 INFO - Options: 03:09:17 INFO - -h, --help show this help message and exit 03:09:17 INFO - -d DEST, --destination=DEST 03:09:17 INFO - Directory to install application into. [default: 03:09:17 INFO - "/builds/slave/test"] 03:09:17 INFO - --app=APP Application being installed. [default: firefox] 03:09:17 INFO - mkdir: /builds/slave/test/build/application 03:09:17 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'] 03:09:17 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 03:09:48 INFO - Reading from file tmpfile_stdout 03:09:48 INFO - Output received: 03:09:48 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 03:09:48 INFO - Running post-action listener: _resource_record_post_action 03:09:48 INFO - ##### 03:09:48 INFO - ##### Running run-tests step. 03:09:48 INFO - ##### 03:09:48 INFO - Running pre-action listener: _resource_record_pre_action 03:09:48 INFO - Running main action method: run_tests 03:09:48 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:09:48 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:09:48 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:09:48 INFO - 2015-11-24 03:09:48.067 screenresolution[1993:14241] starting screenresolution argv=screenresolution get 03:09:48 INFO - 2015-11-24 03:09:48.070 screenresolution[1993:14241] Display 0: 1600x1200x32@60 03:09:48 INFO - 2015-11-24 03:09:48.076 screenresolution[1994:14243] starting screenresolution argv=screenresolution list 03:09:48 INFO - Available Modes on Display 0 03:09:48 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:09:48 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:09:48 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:09:48 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:09:48 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:09:48 INFO - Intel Iris: 03:09:48 INFO - Chipset Model: Intel Iris 03:09:48 INFO - Type: GPU 03:09:48 INFO - Bus: Built-In 03:09:48 INFO - VRAM (Dynamic, Max): 1536 MB 03:09:48 INFO - Vendor: Intel (0x8086) 03:09:48 INFO - Device ID: 0x0a2e 03:09:48 INFO - Revision ID: 0x0009 03:09:48 INFO - Displays: 03:09:48 INFO - Display: 03:09:48 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:09:48 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:09:48 INFO - Display Serial Number: 1600x1200 60 03:09:48 INFO - Main Display: Yes 03:09:48 INFO - Mirror: Off 03:09:48 INFO - Online: Yes 03:09:48 INFO - Rotation: Supported 03:09:48 INFO - Return code: 0 03:09:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:09:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:09:48 INFO - Python 2.7.3 03:09:48 INFO - Return code: 0 03:09:48 INFO - grabbing minidump binary from tooltool 03:09:48 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')]} 03:09:48 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 0x1091ff9f0>, '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 0x108f5edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1091f28c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:09:48 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 03:09:48 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 03:09:48 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:09:48 INFO - Return code: 0 03:09:48 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 03:09:48 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:09:48 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:09:48 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 03:09:48 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:09:48 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/5scwinrvRay9hPVQh31uYA/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0033', '--webServer', 'localhost'] in /builds/slave/test/build 03:09:48 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/5scwinrvRay9hPVQh31uYA/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0033 --webServer localhost 03:09:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YcOeaCfrTj/Render', 03:09:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:09:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:09:48 INFO - 'HOME': '/Users/cltbld', 03:09:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:09:48 INFO - 'LOGNAME': 'cltbld', 03:09:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:09:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 03:09:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:09:48 INFO - 'MOZ_NO_REMOTE': '1', 03:09:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:09:48 INFO - 'NO_EM_RESTART': '1', 03:09:48 INFO - 'PAGER': '/bin/cat', 03:09:48 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:09:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:09:48 INFO - 'PWD': '/builds/slave/test', 03:09:48 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:09:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:09:48 INFO - 'SHELL': '/bin/bash', 03:09:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.x1niOHBkIw/Listeners', 03:09:48 INFO - 'TMPDIR': '/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/', 03:09:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:09:48 INFO - 'USER': 'cltbld', 03:09:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:09:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:09:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:09:48 INFO - 'XPC_FLAGS': '0x0', 03:09:48 INFO - 'XPC_SERVICE_NAME': '0', 03:09:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:09:48 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/5scwinrvRay9hPVQh31uYA/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0033', '--webServer', 'localhost'] with output_timeout 3600 03:09:48 INFO - mozversion INFO | application_buildid: 20151124012131 03:09:48 INFO - mozversion INFO | application_changeset: 9d1be94ff95a2252405ae5ec6fb4a8d083440dbe 03:09:48 INFO - mozversion INFO | application_display_name: Nightly 03:09:48 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:09:48 INFO - mozversion INFO | application_name: Firefox 03:09:48 INFO - mozversion INFO | application_remotingname: firefox 03:09:48 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 03:09:48 INFO - mozversion INFO | application_vendor: Mozilla 03:09:48 INFO - mozversion INFO | application_version: 45.0a1 03:09:48 INFO - mozversion INFO | platform_buildid: 20151124012131 03:09:48 INFO - mozversion INFO | platform_changeset: 9d1be94ff95a2252405ae5ec6fb4a8d083440dbe 03:09:48 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 03:09:48 INFO - mozversion INFO | platform_version: 45.0a1 03:09:48 INFO - 2015-11-24 03:09:48,616 DEBUG : using testdate: 1448363388 03:09:48 INFO - 2015-11-24 03:09:48,616 DEBUG : actual date: 1448363388 03:09:48 INFO - 2015-11-24 03:09:48,625 INFO : starting webserver on 'localhost:49711' 03:09:48 INFO - 2015-11-24 03:09:48,625 INFO : Starting test suite t-yosemite-r7-0033.e 03:09:48 INFO - 2015-11-24 03:09:48,625 INFO : Starting test dromaeo_css 03:09:48 INFO - 2015-11-24 03:09:48,626 DEBUG : operating with platform_type : mac_ 03:09:48 INFO - 2015-11-24 03:09:48,626 INFO : Initialising browser for dromaeo_css test... 03:09:48 INFO - 2015-11-24 03:09:48,639 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/tmpKhT1DV/profile http://localhost:49711/getInfo.html 03:09:51 INFO - 2015-11-24 03:09:51,624 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 03:09:51 INFO - 2015-11-24 03:09:51,624 DEBUG : BROWSER_OUTPUT: colorDepth:24 03:09:51 INFO - 2015-11-24 03:09:51,624 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 03:09:51 INFO - 2015-11-24 03:09:51,624 DEBUG : BROWSER_OUTPUT: __metrics 03:09:52 INFO - 2015-11-24 03:09:52,263 INFO : Browser initialized. 03:09:52 INFO - 2015-11-24 03:09:52,264 INFO : Running cycle 1/1 for dromaeo_css test... 03:09:52 INFO - 2015-11-24 03:09:52,264 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/tmpKhT1DV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 03:10:04 INFO - 2015-11-24 03:10:04,124 DEBUG : BROWSER_OUTPUT: RSS: Main: 237219840 03:10:04 INFO - 2015-11-24 03:10:04,124 DEBUG : BROWSER_OUTPUT: 03:10:53 INFO - 2015-11-24 03:10:53,794 DEBUG : BROWSER_OUTPUT: 1448363453793 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] 03:13:04 INFO - 2015-11-24 03:13:04,287 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49711/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49711/tests/dromaeo/cssquery-ext.html) 03:13:05 INFO - 2015-11-24 03:13:05,614 DEBUG : BROWSER_OUTPUT: RSS: Main: 254144512 03:13:05 INFO - 2015-11-24 03:13:05,614 DEBUG : BROWSER_OUTPUT: 03:16:07 INFO - 2015-11-24 03:16:07,538 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49711/tests/dromaeo/cssquery-ext.html (next: http://localhost:49711/tests/dromaeo/cssquery-jquery.html) 03:16:08 INFO - 2015-11-24 03:16:08,127 DEBUG : BROWSER_OUTPUT: RSS: Main: 264392704 03:16:08 INFO - 2015-11-24 03:16:08,128 DEBUG : BROWSER_OUTPUT: 03:19:09 INFO - 2015-11-24 03:19:09,830 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49711/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49711/tests/dromaeo/cssquery-mootools.html) 03:19:10 INFO - 2015-11-24 03:19:10,440 DEBUG : BROWSER_OUTPUT: RSS: Main: 266219520 03:19:10 INFO - 2015-11-24 03:19:10,440 DEBUG : BROWSER_OUTPUT: 03:22:12 INFO - 2015-11-24 03:22:12,083 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49711/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49711/tests/dromaeo/cssquery-prototype.html) 03:22:12 INFO - 2015-11-24 03:22:12,684 DEBUG : BROWSER_OUTPUT: RSS: Main: 267395072 03:22:12 INFO - 2015-11-24 03:22:12,684 DEBUG : BROWSER_OUTPUT: 03:25:15 INFO - 2015-11-24 03:25:15,081 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49711/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49711/tests/dromaeo/cssquery-yui.html) 03:25:15 INFO - 2015-11-24 03:25:15,685 DEBUG : BROWSER_OUTPUT: RSS: Main: 271319040 03:25:15 INFO - 2015-11-24 03:25:15,685 DEBUG : BROWSER_OUTPUT: 03:28:18 INFO - 2015-11-24 03:28:18,030 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49711/tests/dromaeo/cssquery-yui.html (next: http://localhost:49711/tests/dromaeo/cssquery-dojo.html) 03:28:18 INFO - 2015-11-24 03:28:18,286 DEBUG : BROWSER_OUTPUT: RSS: Main: 273448960 03:28:18 INFO - 2015-11-24 03:28:18,286 DEBUG : BROWSER_OUTPUT: 03:28:18 INFO - 2015-11-24 03:28:18,288 DEBUG : BROWSER_OUTPUT: __start_tp_report 03:28:18 INFO - 2015-11-24 03:28:18,288 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 03:28:18 INFO - 2015-11-24 03:28:18,288 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 03:28:18 INFO - 2015-11-24 03:28:18,288 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 03:28:18 INFO - 2015-11-24 03:28:18,289 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3172.2069482629345;3538.027042563296;3555.395582750932;3577.7137828973687;3594.4248920172777;5577.079781835992;5826.271716035496;5968.5523585731025;5978.461938425541;5984.88030239395;5751.769929202837;5884.117382392643;5963.582549221556;6008.489278411329;6098.512119030478;5290.65610735301;5358.866028349284;5378.381486129106;5429.67421954684;5436.130219164935;941.7244597714155;5352.678839269637;5389.272448219499;5417;5465.890682186374;5337.626366154371;5349.839504814842;5356.598255130862;5368.4631536846;5379.354477462691;5379.946200538023;5401.3248343957;5415;5427.851845929391;5428;5189.143791274435;5190.610704197163;5283.445238249967;5284.10170271051;5346.984073026151;4586.770661466947;4847.709137451764;5117.360329958755;5898.203742494794;5908.704564771787;6145.139680444741;6341.365863413622;6342.873142537123;6346.904796428057;6352.555321127523;6263.937360626381;6289.528285378569;6291.748330066792;6448.484121270287;6482.57863238888;5064.442911279756;5975.312839023524;5982.641041537521;5996.190514280604;6010.939890601126;6144.433169541739;6301.338359472281;6317.052442133717;6334.461570766536;6350.269718982377;6104.671374792629;6188.752449902044;6198.442140207313;6210.689465526705;6213.068039794067;6353.841153971188;6383.234011918599;6383.680815959184;6389.7763578274535;6403.807885763435;5342.091844386464;5650.689212093293;6198.2252218472695;6243.157173781481;6273.592216505913;5546.389897111315;6100.298465676416;6254.093156492283;6261.436470717657;6274.247090349188;5093.770780314895;5093.847184584469;5110.897782044338;5132.999065182328;5133.12736834739;4374.168907907488;4486.6186374157905;4507.5267096955;4634.536546345338;4651.139539185261;5997.760089596367;6012.038073908241;6026.939730602726;6038.516918646497;6046.758129674852;6366.904496432558;6377.17096777416;6378.553501254961;6382.617042977344;6392.648404337806;5485.424030476823;5909.084091965752;5913.2608423947;5913.9112913306335;5925.229720136354;5525.977694126599;5541.806036788693;5576.358718747396;5578.63738856973;5587.022271102541;6374.808755737336;6415.101885736;6437.324080971431;6454.838629034311;6462.095306657072;5523.6409633373705;6226.128342032029;6301.306856245901;6322.8735425290315;6348.396902294275;6332.113504109337;6434.099226108255;6511.120998665119;6517.706703198272;6548.148740663683;6160.291566469913;6264.906026409699;6265.216847894013;6282.183316168869;6286.7799627014665;6319.96840015797;6341.365863413622;6385;6401.679916004088;6413.551051426542;5293.364796224478;6075.605085669417;6137.35557766446;6231.4391704746795;6309.558330916791;5157.690538567698;5613.961417137679;5906.793262235801;6249.78125765596;6269.592476489013;6050.42520960508;6180.6909654517995;6204.720787564661;6207.534434917489;6220.222472190976;6128.693565321805;6149.292831324276;6218.657973811303;6219.471344935731;6283.183186185766;6180.783672571439;6182.505399568114;6227.688615569294;6244.625322480666;6251.6874156292915 03:28:18 INFO - 2015-11-24 03:28:18,291 DEBUG : BROWSER_OUTPUT: |1;ext.html;535.3709391465028;554.282204545114;597.853525886158;606.9015082700312;608.6530677513816;40832.59167408325;41085;41446.99999999996;41454;41501.79249103758;43988.90027749308;44229.7788511057;44450.88872778182;44483.77758111213;44502.33246501297;9828.213742900587;9954.60181592739;10000;10029.899701003005;10037.749056273578;9708;9835.803283934318;9846.212303015778;9867.309288349818;9958.452285124315;8377.664893404288;8876.778080547974;9739.75650608737;9815.411075335467;9894.50527473627;8397.370197235232;8575.82848343036;8788.033316335199;9777.90222097777;9832.213422926185;9707.757306067404;9796.118349348593;9796.412215267035;9829.21366290695;9829.754256143582;39964.20071598552;40096.59903400958;40266;40292.39561406552;40552.391714124315;3282.6427904945363;3507.1582820122985;3786;3867.903302417462;4044.8027423742874;28651.57022644662;29713.25716857074;29801.211927284432;29876.55185172224;29991.70008299911;2829.4906916754976;2837.60803107903;2875.928101797451;2878.5250433678416;2917.4456853197826;487277;488174;488951.99999999645;489879;490112;55519;58556.70721646365;66135;67236;69028.96456553155;65796;65884.67057664681;66370.672586548;66471;66556.00165997514;14105.012649114464;15247.237638118271;16129.435469758502;16143.192840357935;16180.352785888432;12050.397480126134;12100.273983561014;12110.636680899586;12185.147039707135;12229.143959922898;20814.479638009172;21557.56884862294;21595.892020540112;21598;21621.783782161976;8425.07324194338;8652.480851148952;8669.08974557675;8669.566521674018;8733.781655458537;948.8719022931816;991.7768502086973;993.9353941993747;1030.0111892583054;1105.1103861391657;23964.40088997789;26041.869790651304;28316.575251371247;28377.29056773597;28594.14217573476;1074.505727365405;1108.5288752280248;1115.9107271418268;1234.1237721218035;1241.1064033895582;12915;13778.586642400744;13798.896088312911;14604.05073670208;14833.332500037524;487948;508569;510932;516036;516202;58336;58490.70754646284;58803.70598147067;58906.11640825391;59033;1427.336288625794;1436.6264771159365;1470.7058588282387;1473.6463248820205;1474.2481334519257;28162.577561337006;29127.7087229125;33043.66956330502;33740.83129584337;34719.13202169865;56423;56823.43176568182;57009;57454;57480.71259643675;461279;469120.6543967258;469723;472286;474440.6277968588;44437;45056.0988780216;46271.07457850892;46468.7676561615;46585.835354115065;47736;47984.04031919412;48002;49429;49711.50288497069;37959.14309856311;38575.807120964215;40281.395779062754;40548.594514055665;40707.796461017504;38221.61778382181;39144.41283380695;39196.8407475845;39625.80187099046;39737.80131099326;38327.80836095801;38401.65594204189;39203.41194882136;39222.2155556893;39332.80333598314;28237;32804.835975819966;35129;35182;35408.29183416369;24830.751692482845;26173;26239.950401983708;26425.075122370625;26464.338391540365 03:28:18 INFO - 2015-11-24 03:28:18,294 DEBUG : BROWSER_OUTPUT: |2;jquery.html;364.33327011568815;372.7763341994803;373.2311438436819;373.5405451294908;374.5093926955688;15752.921235393836;19359.903200483994;20641.896790516064;20842.791572084276;21260.043298051587;20052.498687532818;20558.486037849063;20608.69086963693;20726.48183795402;21325;5703.914441283384;5735.397783232763;5880.970830104736;5882.941170588304;5900.822975310726;5820.068788993762;5826.359100498942;5826.533877289828;5859.6777177255235;5885.676287804169;4448.799804008828;5817.272840894888;5819.505342045931;5829.708514574276;6309.3690630937;6247.7188526515965;6291.874162516747;6297.527685423589;6305.432511074003;6339.175907132089;5357.303550538444;5470.5350045246205;5477.904419116193;5487.368952570426;5508.3114610673665;25484;25591.48817023649;25750.613740793902;25845.224643260543;26035.73964260352;2117.7141085953353;2153.020375729055;2314.0975019742314;2328.278233747527;2356.575816353056;14717.55847324582;14829.18439485828;15244.695106097815;15267.312970916335;15565.29956151976;1656.6935117003272;1742.0941110622532;1773.6098058427126;1778.0931724820305;1778.9288428462976;97958.5102074485;101426;101903.9809601902;102254;103029;10106.14097801695;10312.278140530241;10459;10514.421706806199;10543.20925930543;12538.623841284776;12560.30918299484;12564;12568.81146782799;12572.811407828889;8164.510129392255;8206.138355472589;8218.671253149927;8264.504129752235;8265.586720664063;7309.269073092648;7492.213317601682;8279.172082791792;8326.70856520031;8336.374771892133;5140.203268493315;5994;6101.298350689727;6146.262448506208;6196.721147548371;1614.555997100783;1829.9112028343116;1831.7435559021746;1860.7674040744907;1876.080720446971;381.6584157179309;384.2890652293235;384.93840985442193;1018.1447584029303;1040.0379648824808;10296.845547316647;10510.633617629659;11611.129165312635;20902.58194836095;21106.472338191666;822.9218224268685;893.4594570285014;971.7376308396694;992.4491906991689;1030.1141018723893;9514.143727064597;11187.664370068911;11687.532498699957;11753.823692644617;11839.526418943318;707477;713010;728438;754079;757301;123228.1515777264;127206.45587088207;127328;128048;128180;1223.7980733179104;1233.4264566976399;1234.2902830872285;1235.882591153839;1255.4727014653868;18589.44231673052;18747.625047499245;18905.621887561898;19293;19417.902910485358;38530.65142719991;49422.752886235336;49560;49638.50361496483;50844.237336440725;71836.64081679558;72236.44750869485;73765.6311718438;75748.62125689337;76632.61683691769;9234.492102934402;9488.335816493056;9645.131938125602;9843.310968232441;9871.851922221029;11368.147388946027;13254.867451325363;18990.905045474683;19490.220391184193;19765.901170494057;15515.37938482448;15543.300551474984;15698.136602486973;15737.055776653437;15955.20223988819;15090.54728358151;15296.541103766906;15327;15338.309776059881;15523.611909702347;16100.838991609933;16232;16453.259603318118;16525.66948661044;16580.917095414447;8071.273585377344;8919.910800892168;9071.909280907106;9779.26655500826;10132.392056476636;12056.51773929033;15179.772303415237;15870.52388428349;16182.867199295937;16513 03:28:18 INFO - 2015-11-24 03:28:18,295 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1577.3927038090333;1608.5656872644386;1716.3134746101557;1876.3526583328746;1927.9903600481998;7953.602319883998;8110.067342255627;8623.663332183514;8869.733907982754;8891.510966896825;8379.622916968736;8592.05487396386;8676.73969780906;8704.260137888286;8708.477491350523;2376.572217000935;2407.879606019701;2420.1529464687396;2420.745821688724;2427.66012758214;2384.4277373430427;2414.8792560372;2447.571674956884;2448.9387765305833;2453.877306134695;2363.61000434928;2384.3562238195677;2400.063975049732;2410.770976757205;2416.4925365673143;2109;2356.8114550835894;2382.5711371953043;2410.6625072489865;2414.5895197816326;2394.4492766663766;2420.370703617072;2434.184548176363;2443.132687895807;2444.8899799508886;8557.229849313591;8616.224539791448;8658.090900455425;8693.087225841258;8703.260222881063;4693.718376897397;5160.14857548504;5239.528442440199;5273.789048438058;5276.947230527684;3008.6540047894555;3197.0089272325654;3486.8493397178872;3538.115471132217;3638.6361363863402;1034.5551412892453;1052;1058.4760543530924;1081.9505080072395;1084.219362059316;11441.713957151054;11469.254498457574;11473.541058357656;11483.598074067451;11508.827367589492;4761.714297142183;4768.57082862544;4805.014971930746;4831.51684831514;4856.053069651454;9861.457619830835;9863.210943124677;9887.901120988841;9898.059684329977;9906.306558540833;4575.588197062214;5259;5262.184361423985;5270.973645131749;5303.098473259555;4825.372701548847;4826.227803551415;4835.661503694708;4842.539958703917;4930.852074437773;3750.362438385481;3869.129445874712;3950.051987522974;3951.05174758056;3964.0288129408477;1299.7595444842734;1312.3831799054428;1319.901007424447;1320.9867901320863;1325.15190278222;1399.9370028348749;1404.9438022479192;1405.206058576901;1429.6140042188551;1440.8991370603958;7987.201279871966;8023.759287221393;8032;8054.476459030145;8093.797655058553;513.358302122347;515.8143068495339;515.9509846564571;516.2772119033383;522.068108426457;6087.05650624154;6234.657093859791;6239.095331176954;6257.217847769029;6261.96869015652;9741;10318.019788120117;10372.481375931173;10501.842472362921;10509.738831340288;10266.897331026743;10312.071913527669;10370.014848589371;10385.117265032557;10438.269321147447;6771.932280677229;7420.886866969998;7461.5523068614975;7951.880721789178;8005.919940800634;7066.8233294166;7703.537787732754;7710.498817576839;7886.487378320391;7908.327792137733;7817.687292508236;9160.725178244664;9316.20812230968;9447;9506.096920792514;9576.377535460173;9588.952055239959;9623.711288661352;9627.59310172457;9713.931467538707;6444.387783160592;7532.359749421361;7574.242575742382;7589.962050189713;7601.961990190013;8140.348772098337;8189.877151842608;8209.83580328402;8247.21651443112;8262.380321476034;7584.431167662337;7706.691732330644;7715.112762032438;7742.496737712256;7838.137804841577;7517.473776835788;7580.0145981022115;7629.122650895218;7642.8089297768;7669.5398276103615;7698.230176982257;7716.807079823049;7725.188855170126;7727.188645192174;7727.9227207729455;6916.685829692342;6995.055667484824;7012.614306213207;7027.262137475492;7032.1912980007955;7073.646317684198;7073.858522829411;7121.6439178039855;7139.500234983501;7146 03:28:18 INFO - 2015-11-24 03:28:18,297 DEBUG : BROWSER_OUTPUT: |4;prototype.html;315.6512054180129;332.87184433992905;333.26515034349256;341.771013421008;344.2272099137437;5478.698671573062;7024.402925751311;7031;7039.929600703985;7050.25972272911;6823.7611683591085;6944.305569443053;7020.157581090263;7029.086218791563;7044.330788575077;4136.172765446908;5019.447860735326;5092.497713174623;5141.562967147797;5143.382794064718;4977.054359671669;5127.282180494715;5127.3078134451935;5134.332536770215;5147.4080480744815;5078.822241221558;5085.618578606601;5091.032703786269;5092.872678183038;5101.69389836611;4481.3726078349055;4969.527894849984;5089.3638295213095;5095.796168153288;5095.936145860932;4369.366441865944;4384.430024096879;4386.780660966971;4390.868273951754;4394.36281739146;5007.749612519359;6410.839729006812;6619.073329733841;6763.898541521881;6786.185657721056;6035.577509574332;6038.2150320458495;6042.57701960863;6051.515878729691;6060;7504.249575042507;7521.323080922743;7523.887141692879;7544.886826697604;7572.129205141424;4823.13183626947;4925.605951523869;4932.679375840559;4939.283803848458;4945.406551213878;7732.8787325838;7883.448158628898;8029.558374289411;8031.598420078973;8032.638531266049;4295.978520107442;5001.7499125043605;5010.398752149766;5014.749262536859;5030.346055012825;4176.934881605232;4973.278874563241;5109.821156259587;5114.386273647112;5115.616328775357;5004.724740139254;5958.970205148947;6049.971504844187;6054.273487181566;6057.666828324484;7583.696652133964;7613.390928725688;7622.237776222333;7636.579988100597;7646.044244469442;1508.585139086738;1728.9049102299493;1761.2338632694562;1778.3242367900116;1782.0911335219132;1127.498263272852;1157.120588352841;1158.901493373056;1162.5291756838494;1170.789257933563;6852.109225800614;6865.244823069458;6868.347506986828;6885.036094946711;6890.414314783299;6321.905171422432;7721.725915223925;7740.148583655793;7740.961295193601;7758.107817601048;6719.227288861844;6852;6888.690008949609;6903.75836845718;6918.8616227676175;4087.734297270668;4100.2414553307735;4106.178764247163;4114.567970363129;4115.135821477464;7071.8939215911805;7354.191038985708;7940.722074727357;7970.920290797134;7987.520748755093;5667.886642267132;6507.479401647857;7988.360931125496;8015.238552337519;8017.198280171936;7934.127246002935;7942.245486678757;7956.363490920712;7971.72452407612;7974.681012759424;7557;7667.619828430713;7706.884396733942;7769.223077692185;7777.300042996158;7566.470347075652;7568.470207085451;7590.620468976639;7595.442934198587;7595.810104747426;7931.325837303893;7964.402669799672;7970.003749531309;7980.92019079825;7982;4692.601128903945;4855.878603034952;4872.317875497362;5006.87482812918;5009.699418034929;6254.593451425642;7860.803479912819;7864.4888082274465;7868;7935.603219838869;7622.733204337822;7634.351080158249;7643.503172293783;7657.272559106876;7660.616969151632;7472.813179670552;7608.923910760822;7610.238976102345;7625;7643.88534171999;6358.014507751121;7171.282871712787;7421.3691836192365;7443.106827180773;7446.101244182699;7599;7603.0876294844975;7611.4291428142005;7616;7623.237676232332;7260.600666963156;7399.075115610549;7456.47804653669;7459.962700186465;7465.954766332827 03:28:18 INFO - 2015-11-24 03:28:18,300 DEBUG : BROWSER_OUTPUT: |5;yui.html;612.8866159760441;723.8769409200436;744.6611791634807;764.4190415284386;808.216030450463;14955.327010284536;15158.84841151588;15251.847481525181;15284.930054896147;15344.079355238693;14027.509037183701;16310.918445407786;16553.503394898144;16555.006699598;16605.08672023038;968.0658164870898;982.130814229405;984.0798853072364;986.4870267460916;987.782687808681;769.253823790922;783.3380793229712;954.6229239450413;975.0103644800533;983.7245571240064;1021.0453226233495;1021.6475316016;1026.209818439801;1030.4229631406436;1036.0778906772978;945.0832692288469;1013.6756238003842;1021.7803172317913;1024.1243736605206;1028.8353863381824;751.4889874885076;754.9698012079565;759.1232126893447;761.6115780951754;766.9760869239572;15442.845571544252;15581.92209038959;15628.921855390763;15644.296006679726;15712.842871571367;10762.569497220102;10913.39976301303;12475.313857737821;12797.808032879515;13539.916806655445;9943.8508422373;10203.948980255125;10858.565657373696;11031.393273369962;11675.591354302558;3498.1254686328416;3500.982495087508;3577.213013137132;3578.6600272974024;3587.7488575799703;67936.6603166981;69676.303236968;69861.99999999949;70378.29621703768;83705.16294837034;9746.220302375934;9762.828460584633;9764.072413120743;9796.216302695768;9820.263480239011;22612.434689132573;22684.432889177904;22925.656115158286;22999.080036798674;23055.077796888272;7466.85066298671;7651.655675494505;7703.306702396699;7826.178251283647;7847.843043139105;4100.446439730598;4103.4050062740735;4155.792210389468;4157.147784704129;4300.182965236595;3272.869085236564;3284.392387408337;3288.556044933903;3308.8180150091493;3308.8676452941613;614.2628845385556;621.7512994802025;626.1203009771278;626.6052386996163;634.8666779976164;465.27881783236523;471.8230663501187;485.4247716456011;503.65751289123017;537.2666310486159;8601.924759405074;8631.870521942175;8680.6527738891;8685.913140868637;8763.255123314462;473.9312799644101;518.2821791818284;560.5487582496048;575.9424057594207;661.867626474707;3956.3274243378696;4036.9370762638064;4258.276093064186;4418.734875907456;4496.64026877849;80519;100011;100382.4980875091;101989;102503;62165.68917155476;83411.58294208611;83960.58019709862;84753.57623211844;85678;75242.49515009669;75778;76124.61937690387;76244.0938976519;78130;9091.363604547618;9114.453132812052;9182.219511341344;9203.493807840365;9256.444613322952;55067;55089.72455137699;55593.72203138958;55742;56056;72833;77758;77957;78127.60936195283;78437.60781196058;10221.131203847755;10560.627118474857;11028.28316159447;11045.558177673125;11618.396950343942;11956.521739130338;12484.687882803002;12550.309732964775;12603.74792504163;12867.356632168541;11575.42122893835;11797.587084452003;11830.704232393915;11841.940790295994;11850.822237666614;11302.886971130512;11525.711857203301;11610.24533405326;11955;12375.75248495043;10955.45222738844;11307.943460282646;11589;11657.300561966309;12279.079069069678;9525.904740952501;9686.275289951693;10064.245181611555;10079.647212347532;10249.641262555775;9341.346105772802;9739.756506087404;10026.345652967471;10037.69886903394;10117.19062475015 03:28:18 INFO - 2015-11-24 03:28:18,300 DEBUG : BROWSER_OUTPUT: __end_tp_report 03:28:18 INFO - 2015-11-24 03:28:18,300 DEBUG : BROWSER_OUTPUT: __start_cc_report 03:28:18 INFO - 2015-11-24 03:28:18,300 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,344 03:28:18 INFO - 2015-11-24 03:28:18,300 DEBUG : BROWSER_OUTPUT: __end_cc_report 03:28:18 INFO - 2015-11-24 03:28:18,301 DEBUG : BROWSER_OUTPUT: __startTimestamp1448364498286__endTimestamp 03:28:18 INFO - 2015-11-24 03:28:18,301 DEBUG : BROWSER_OUTPUT: 03:28:18 INFO - 2015-11-24 03:28:18,301 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 03:28:18 INFO - 2015-11-24 03:28:18,301 DEBUG : BROWSER_OUTPUT: Number of tests: 6 03:28:18 INFO - 2015-11-24 03:28:18,301 DEBUG : BROWSER_OUTPUT: 03:28:18 INFO - 2015-11-24 03:28:18,301 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5799.48 Median:6075.61 stddev:750.12 (12.3%) stddev-sans-first:723.55 03:28:18 INFO - 2015-11-24 03:28:18,301 DEBUG : BROWSER_OUTPUT: Values: 3172.2 3538.0 3555.4 3577.7 3594.4 5577.1 5826.3 5968.6 5978.5 5984.9 5751.8 5884.1 5963.6 6008.5 6098.5 5290.7 5358.9 5378.4 5429.7 5436.1 941.7 5352.7 5389.3 5417.0 5465.9 5337.6 5349.8 5356.6 5368.5 5379.4 5379.9 5401.3 5415.0 5427.9 5428.0 5189.1 5190.6 5283.4 5284.1 5347.0 4586.8 4847.7 5117.4 5898.2 5908.7 6145.1 6341.4 6342.9 6346.9 6352.6 6263.9 6289.5 6291.7 6448.5 6482.6 5064.4 5975.3 5982.6 5996.2 6010.9 6144.4 6301.3 6317.1 6334.5 6350.3 6104.7 6188.8 6198.4 6210.7 6213.1 6353.8 6383.2 6383.7 6389.8 6403.8 5342.1 5650.7 6198.2 6243.2 6273.6 5546.4 6100.3 6254.1 6261.4 6274.2 5093.8 5093.8 5110.9 5133.0 5133.1 4374.2 4486.6 4507.5 4634.5 4651.1 5997.8 6012.0 6026.9 6038.5 6046.8 6366.9 6377.2 6378.6 6382.6 6392.6 5485.4 5909.1 5913.3 5913.9 5925.2 5526.0 5541.8 5576.4 5578.6 5587.0 6374.8 6415.1 6437.3 6454.8 6462.1 5523.6 6226.1 6301.3 6322.9 6348.4 6332.1 6434.1 6511.1 6517.7 6548.1 6160.3 6264.9 6265.2 6282.2 6286.8 6320.0 6341.4 6385.0 6401.7 6413.6 5293.4 6075.6 6137.4 6231.4 6309.6 5157.7 5614.0 5906.8 6249.8 6269.6 6050.4 6180.7 6204.7 6207.5 6220.2 6128.7 6149.3 6218.7 6219.5 6283.2 6180.8 6182.5 6227.7 6244.6 6251.7 03:28:18 INFO - 2015-11-24 03:28:18,301 DEBUG : BROWSER_OUTPUT: 03:28:18 INFO - 2015-11-24 03:28:18,301 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:64657.13 Median:40958.80 stddev:129724.36 (316.7%) stddev-sans-first:129998.93 03:28:18 INFO - 2015-11-24 03:28:18,303 DEBUG : BROWSER_OUTPUT: Values: 535.4 554.3 597.9 606.9 608.7 40832.6 41085.0 41447.0 41454.0 41501.8 43988.9 44229.8 44450.9 44483.8 44502.3 9828.2 9954.6 10000.0 10029.9 10037.7 9708.0 9835.8 9846.2 9867.3 9958.5 8377.7 8876.8 9739.8 9815.4 9894.5 8397.4 8575.8 8788.0 9777.9 9832.2 9707.8 9796.1 9796.4 9829.2 9829.8 39964.2 40096.6 40266.0 40292.4 40552.4 3282.6 3507.2 3786.0 3867.9 4044.8 28651.6 29713.3 29801.2 29876.6 29991.7 2829.5 2837.6 2875.9 2878.5 2917.4 487277.0 488174.0 488952.0 489879.0 490112.0 55519.0 58556.7 66135.0 67236.0 69029.0 65796.0 65884.7 66370.7 66471.0 66556.0 14105.0 15247.2 16129.4 16143.2 16180.4 12050.4 12100.3 12110.6 12185.1 12229.1 20814.5 21557.6 21595.9 21598.0 21621.8 8425.1 8652.5 8669.1 8669.6 8733.8 948.9 991.8 993.9 1030.0 1105.1 23964.4 26041.9 28316.6 28377.3 28594.1 1074.5 1108.5 1115.9 1234.1 1241.1 12915.0 13778.6 13798.9 14604.1 14833.3 487948.0 508569.0 510932.0 516036.0 516202.0 58336.0 58490.7 58803.7 58906.1 59033.0 1427.3 1436.6 1470.7 1473.6 1474.2 28162.6 29127.7 33043.7 33740.8 34719.1 56423.0 56823.4 57009.0 57454.0 57480.7 461279.0 469120.7 469723.0 472286.0 474440.6 44437.0 45056.1 46271.1 46468.8 46585.8 47736.0 47984.0 48002.0 49429.0 49711.5 37959.1 38575.8 40281.4 40548.6 40707.8 38221.6 39144.4 39196.8 39625.8 39737.8 38327.8 38401.7 39203.4 39222.2 39332.8 28237.0 32804.8 35129.0 35182.0 35408.3 24830.8 26173.0 26240.0 26425.1 26464.3 03:28:18 INFO - 2015-11-24 03:28:18,303 DEBUG : BROWSER_OUTPUT: 03:28:18 INFO - 2015-11-24 03:28:18,303 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:38583.56 Median:11688.88 stddev:120678.21 (1032.4%) stddev-sans-first:120982.62 03:28:18 INFO - 2015-11-24 03:28:18,303 DEBUG : BROWSER_OUTPUT: Values: 364.3 372.8 373.2 373.5 374.5 15752.9 19359.9 20641.9 20842.8 21260.0 20052.5 20558.5 20608.7 20726.5 21325.0 5703.9 5735.4 5881.0 5882.9 5900.8 5820.1 5826.4 5826.5 5859.7 5885.7 4448.8 5817.3 5819.5 5829.7 6309.4 6247.7 6291.9 6297.5 6305.4 6339.2 5357.3 5470.5 5477.9 5487.4 5508.3 25484.0 25591.5 25750.6 25845.2 26035.7 2117.7 2153.0 2314.1 2328.3 2356.6 14717.6 14829.2 15244.7 15267.3 15565.3 1656.7 1742.1 1773.6 1778.1 1778.9 97958.5 101426.0 101904.0 102254.0 103029.0 10106.1 10312.3 10459.0 10514.4 10543.2 12538.6 12560.3 12564.0 12568.8 12572.8 8164.5 8206.1 8218.7 8264.5 8265.6 7309.3 7492.2 8279.2 8326.7 8336.4 5140.2 5994.0 6101.3 6146.3 6196.7 1614.6 1829.9 1831.7 1860.8 1876.1 381.7 384.3 384.9 1018.1 1040.0 10296.8 10510.6 11611.1 20902.6 21106.5 822.9 893.5 971.7 992.4 1030.1 9514.1 11187.7 11687.5 11753.8 11839.5 707477.0 713010.0 728438.0 754079.0 757301.0 123228.2 127206.5 127328.0 128048.0 128180.0 1223.8 1233.4 1234.3 1235.9 1255.5 18589.4 18747.6 18905.6 19293.0 19417.9 38530.7 49422.8 49560.0 49638.5 50844.2 71836.6 72236.4 73765.6 75748.6 76632.6 9234.5 9488.3 9645.1 9843.3 9871.9 11368.1 13254.9 18990.9 19490.2 19765.9 15515.4 15543.3 15698.1 15737.1 15955.2 15090.5 15296.5 15327.0 15338.3 15523.6 16100.8 16232.0 16453.3 16525.7 16580.9 8071.3 8919.9 9071.9 9779.3 10132.4 12056.5 15179.8 15870.5 16182.9 16513.0 03:28:18 INFO - 2015-11-24 03:28:18,303 DEBUG : BROWSER_OUTPUT: 03:28:18 INFO - 2015-11-24 03:28:18,303 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5939.10 Median:5272.38 stddev:3121.20 (59.2%) stddev-sans-first:3112.74 03:28:18 INFO - 2015-11-24 03:28:18,305 DEBUG : BROWSER_OUTPUT: Values: 1577.4 1608.6 1716.3 1876.4 1928.0 7953.6 8110.1 8623.7 8869.7 8891.5 8379.6 8592.1 8676.7 8704.3 8708.5 2376.6 2407.9 2420.2 2420.7 2427.7 2384.4 2414.9 2447.6 2448.9 2453.9 2363.6 2384.4 2400.1 2410.8 2416.5 2109.0 2356.8 2382.6 2410.7 2414.6 2394.4 2420.4 2434.2 2443.1 2444.9 8557.2 8616.2 8658.1 8693.1 8703.3 4693.7 5160.1 5239.5 5273.8 5276.9 3008.7 3197.0 3486.8 3538.1 3638.6 1034.6 1052.0 1058.5 1082.0 1084.2 11441.7 11469.3 11473.5 11483.6 11508.8 4761.7 4768.6 4805.0 4831.5 4856.1 9861.5 9863.2 9887.9 9898.1 9906.3 4575.6 5259.0 5262.2 5271.0 5303.1 4825.4 4826.2 4835.7 4842.5 4930.9 3750.4 3869.1 3950.1 3951.1 3964.0 1299.8 1312.4 1319.9 1321.0 1325.2 1399.9 1404.9 1405.2 1429.6 1440.9 7987.2 8023.8 8032.0 8054.5 8093.8 513.4 515.8 516.0 516.3 522.1 6087.1 6234.7 6239.1 6257.2 6262.0 9741.0 10318.0 10372.5 10501.8 10509.7 10266.9 10312.1 10370.0 10385.1 10438.3 6771.9 7420.9 7461.6 7951.9 8005.9 7066.8 7703.5 7710.5 7886.5 7908.3 7817.7 9160.7 9316.2 9447.0 9506.1 9576.4 9589.0 9623.7 9627.6 9713.9 6444.4 7532.4 7574.2 7590.0 7602.0 8140.3 8189.9 8209.8 8247.2 8262.4 7584.4 7706.7 7715.1 7742.5 7838.1 7517.5 7580.0 7629.1 7642.8 7669.5 7698.2 7716.8 7725.2 7727.2 7727.9 6916.7 6995.1 7012.6 7027.3 7032.2 7073.6 7073.9 7121.6 7139.5 7146.0 03:28:18 INFO - 2015-11-24 03:28:18,305 DEBUG : BROWSER_OUTPUT: 03:28:18 INFO - 2015-11-24 03:28:18,305 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:6071.01 Median:6866.80 stddev:1958.41 (28.5%) stddev-sans-first:1915.67 03:28:18 INFO - 2015-11-24 03:28:18,306 DEBUG : BROWSER_OUTPUT: Values: 315.7 332.9 333.3 341.8 344.2 5478.7 7024.4 7031.0 7039.9 7050.3 6823.8 6944.3 7020.2 7029.1 7044.3 4136.2 5019.4 5092.5 5141.6 5143.4 4977.1 5127.3 5127.3 5134.3 5147.4 5078.8 5085.6 5091.0 5092.9 5101.7 4481.4 4969.5 5089.4 5095.8 5095.9 4369.4 4384.4 4386.8 4390.9 4394.4 5007.7 6410.8 6619.1 6763.9 6786.2 6035.6 6038.2 6042.6 6051.5 6060.0 7504.2 7521.3 7523.9 7544.9 7572.1 4823.1 4925.6 4932.7 4939.3 4945.4 7732.9 7883.4 8029.6 8031.6 8032.6 4296.0 5001.7 5010.4 5014.7 5030.3 4176.9 4973.3 5109.8 5114.4 5115.6 5004.7 5959.0 6050.0 6054.3 6057.7 7583.7 7613.4 7622.2 7636.6 7646.0 1508.6 1728.9 1761.2 1778.3 1782.1 1127.5 1157.1 1158.9 1162.5 1170.8 6852.1 6865.2 6868.3 6885.0 6890.4 6321.9 7721.7 7740.1 7741.0 7758.1 6719.2 6852.0 6888.7 6903.8 6918.9 4087.7 4100.2 4106.2 4114.6 4115.1 7071.9 7354.2 7940.7 7970.9 7987.5 5667.9 6507.5 7988.4 8015.2 8017.2 7934.1 7942.2 7956.4 7971.7 7974.7 7557.0 7667.6 7706.9 7769.2 7777.3 7566.5 7568.5 7590.6 7595.4 7595.8 7931.3 7964.4 7970.0 7980.9 7982.0 4692.6 4855.9 4872.3 5006.9 5009.7 6254.6 7860.8 7864.5 7868.0 7935.6 7622.7 7634.4 7643.5 7657.3 7660.6 7472.8 7608.9 7610.2 7625.0 7643.9 6358.0 7171.3 7421.4 7443.1 7446.1 7599.0 7603.1 7611.4 7616.0 7623.2 7260.6 7399.1 7456.5 7460.0 7466.0 03:28:18 INFO - 2015-11-24 03:28:18,306 DEBUG : BROWSER_OUTPUT: 03:28:18 INFO - 2015-11-24 03:28:18,306 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:19072.59 Median:4359.46 stddev:26824.17 (615.3%) stddev-sans-first:26863.60 03:28:18 INFO - 2015-11-24 03:28:18,308 DEBUG : BROWSER_OUTPUT: Values: 612.9 723.9 744.7 764.4 808.2 14955.3 15158.8 15251.8 15284.9 15344.1 14027.5 16310.9 16553.5 16555.0 16605.1 968.1 982.1 984.1 986.5 987.8 769.3 783.3 954.6 975.0 983.7 1021.0 1021.6 1026.2 1030.4 1036.1 945.1 1013.7 1021.8 1024.1 1028.8 751.5 755.0 759.1 761.6 767.0 15442.8 15581.9 15628.9 15644.3 15712.8 10762.6 10913.4 12475.3 12797.8 13539.9 9943.9 10203.9 10858.6 11031.4 11675.6 3498.1 3501.0 3577.2 3578.7 3587.7 67936.7 69676.3 69862.0 70378.3 83705.2 9746.2 9762.8 9764.1 9796.2 9820.3 22612.4 22684.4 22925.7 22999.1 23055.1 7466.9 7651.7 7703.3 7826.2 7847.8 4100.4 4103.4 4155.8 4157.1 4300.2 3272.9 3284.4 3288.6 3308.8 3308.9 614.3 621.8 626.1 626.6 634.9 465.3 471.8 485.4 503.7 537.3 8601.9 8631.9 8680.7 8685.9 8763.3 473.9 518.3 560.5 575.9 661.9 3956.3 4036.9 4258.3 4418.7 4496.6 80519.0 100011.0 100382.5 101989.0 102503.0 62165.7 83411.6 83960.6 84753.6 85678.0 75242.5 75778.0 76124.6 76244.1 78130.0 9091.4 9114.5 9182.2 9203.5 9256.4 55067.0 55089.7 55593.7 55742.0 56056.0 72833.0 77758.0 77957.0 78127.6 78437.6 10221.1 10560.6 11028.3 11045.6 11618.4 11956.5 12484.7 12550.3 12603.7 12867.4 11575.4 11797.6 11830.7 11841.9 11850.8 11302.9 11525.7 11610.2 11955.0 12375.8 10955.5 11307.9 11589.0 11657.3 12279.1 9525.9 9686.3 10064.2 10079.6 10249.6 9341.3 9739.8 10026.3 10037.7 10117.2 03:28:18 INFO - 2015-11-24 03:28:18,308 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 03:28:18 INFO - 2015-11-24 03:28:18,308 DEBUG : BROWSER_OUTPUT: 03:28:18 INFO - 2015-11-24 03:28:18,731 INFO : Browser exited with error code: 0 03:28:18 INFO - 2015-11-24 03:28:18,756 INFO : Completed test dromaeo_css (00:18:30) 03:28:18 INFO - 2015-11-24 03:28:18,756 INFO : Starting test kraken 03:28:18 INFO - 2015-11-24 03:28:18,756 DEBUG : operating with platform_type : mac_ 03:28:18 INFO - 2015-11-24 03:28:18,757 INFO : Initialising browser for kraken test... 03:28:18 INFO - 2015-11-24 03:28:18,768 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/tmppHgyH_/profile http://localhost:49711/getInfo.html 03:28:21 INFO - 2015-11-24 03:28:21,339 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 03:28:21 INFO - 2015-11-24 03:28:21,339 DEBUG : BROWSER_OUTPUT: colorDepth:24 03:28:21 INFO - 2015-11-24 03:28:21,339 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 03:28:21 INFO - 2015-11-24 03:28:21,340 DEBUG : BROWSER_OUTPUT: __metrics 03:28:22 INFO - 2015-11-24 03:28:22,071 INFO : Browser initialized. 03:28:22 INFO - 2015-11-24 03:28:22,072 INFO : Running cycle 1/1 for kraken test... 03:28:22 INFO - 2015-11-24 03:28:22,072 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/tmppHgyH_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 03:28:34 INFO - 2015-11-24 03:28:34,167 DEBUG : BROWSER_OUTPUT: RSS: Main: 236544000 03:28:34 INFO - 2015-11-24 03:28:34,167 DEBUG : BROWSER_OUTPUT: 03:28:36 INFO - 2015-11-24 03:28:36,722 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49711/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49711/tests/kraken/driver.html?testName=audio-beat-detection) 03:28:37 INFO - 2015-11-24 03:28:37,342 DEBUG : BROWSER_OUTPUT: RSS: Main: 249245696 03:28:37 INFO - 2015-11-24 03:28:37,342 DEBUG : BROWSER_OUTPUT: 03:28:40 INFO - 2015-11-24 03:28:40,117 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49711/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49711/tests/kraken/driver.html?testName=audio-dft) 03:28:40 INFO - 2015-11-24 03:28:40,717 DEBUG : BROWSER_OUTPUT: RSS: Main: 259543040 03:28:40 INFO - 2015-11-24 03:28:40,717 DEBUG : BROWSER_OUTPUT: 03:28:43 INFO - 2015-11-24 03:28:43,901 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49711/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49711/tests/kraken/driver.html?testName=audio-fft) 03:28:44 INFO - 2015-11-24 03:28:44,487 DEBUG : BROWSER_OUTPUT: RSS: Main: 261910528 03:28:44 INFO - 2015-11-24 03:28:44,487 DEBUG : BROWSER_OUTPUT: 03:28:46 INFO - 2015-11-24 03:28:46,481 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49711/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49711/tests/kraken/driver.html?testName=audio-oscillator) 03:28:47 INFO - 2015-11-24 03:28:47,079 DEBUG : BROWSER_OUTPUT: RSS: Main: 263741440 03:28:47 INFO - 2015-11-24 03:28:47,079 DEBUG : BROWSER_OUTPUT: 03:28:49 INFO - 2015-11-24 03:28:49,232 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49711/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49711/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:28:49 INFO - 2015-11-24 03:28:49,815 DEBUG : BROWSER_OUTPUT: RSS: Main: 264871936 03:28:49 INFO - 2015-11-24 03:28:49,815 DEBUG : BROWSER_OUTPUT: 03:28:52 INFO - 2015-11-24 03:28:52,673 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49711/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49711/tests/kraken/driver.html?testName=imaging-darkroom) 03:28:53 INFO - 2015-11-24 03:28:53,272 DEBUG : BROWSER_OUTPUT: RSS: Main: 265707520 03:28:53 INFO - 2015-11-24 03:28:53,272 DEBUG : BROWSER_OUTPUT: 03:28:56 INFO - 2015-11-24 03:28:56,070 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49711/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49711/tests/kraken/driver.html?testName=imaging-desaturate) 03:28:56 INFO - 2015-11-24 03:28:56,669 DEBUG : BROWSER_OUTPUT: RSS: Main: 264003584 03:28:56 INFO - 2015-11-24 03:28:56,669 DEBUG : BROWSER_OUTPUT: 03:28:59 INFO - 2015-11-24 03:28:59,721 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49711/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49711/tests/kraken/driver.html?testName=json-parse-financial) 03:29:00 INFO - 2015-11-24 03:29:00,311 DEBUG : BROWSER_OUTPUT: RSS: Main: 263692288 03:29:00 INFO - 2015-11-24 03:29:00,311 DEBUG : BROWSER_OUTPUT: 03:29:01 INFO - 2015-11-24 03:29:01,850 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49711/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49711/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:29:02 INFO - 2015-11-24 03:29:02,434 DEBUG : BROWSER_OUTPUT: RSS: Main: 265355264 03:29:02 INFO - 2015-11-24 03:29:02,434 DEBUG : BROWSER_OUTPUT: 03:29:04 INFO - 2015-11-24 03:29:04,422 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49711/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49711/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:29:05 INFO - 2015-11-24 03:29:05,045 DEBUG : BROWSER_OUTPUT: RSS: Main: 265015296 03:29:05 INFO - 2015-11-24 03:29:05,045 DEBUG : BROWSER_OUTPUT: 03:29:07 INFO - 2015-11-24 03:29:07,098 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49711/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49711/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:29:07 INFO - 2015-11-24 03:29:07,695 DEBUG : BROWSER_OUTPUT: RSS: Main: 265814016 03:29:07 INFO - 2015-11-24 03:29:07,695 DEBUG : BROWSER_OUTPUT: 03:29:10 INFO - 2015-11-24 03:29:10,365 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49711/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49711/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:29:10 INFO - 2015-11-24 03:29:10,966 DEBUG : BROWSER_OUTPUT: RSS: Main: 265310208 03:29:10 INFO - 2015-11-24 03:29:10,966 DEBUG : BROWSER_OUTPUT: 03:29:13 INFO - 2015-11-24 03:29:13,515 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49711/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49711/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:29:14 INFO - 2015-11-24 03:29:14,110 DEBUG : BROWSER_OUTPUT: RSS: Main: 265306112 03:29:14 INFO - 2015-11-24 03:29:14,110 DEBUG : BROWSER_OUTPUT: 03:29:15 INFO - 2015-11-24 03:29:15,731 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49711/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49711/tests/kraken/driver.html?testName=ai-astar) 03:29:15 INFO - 2015-11-24 03:29:15,987 DEBUG : BROWSER_OUTPUT: RSS: Main: 264814592 03:29:15 INFO - 2015-11-24 03:29:15,988 DEBUG : BROWSER_OUTPUT: 03:29:15 INFO - 2015-11-24 03:29:15,988 DEBUG : BROWSER_OUTPUT: __start_tp_report 03:29:15 INFO - 2015-11-24 03:29:15,988 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 03:29:15 INFO - 2015-11-24 03:29:15,988 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 03:29:15 INFO - 2015-11-24 03:29:15,988 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 03:29:15 INFO - 2015-11-24 03:29:15,988 DEBUG : BROWSER_OUTPUT: |0;ai-astar;114;107;114;113;114;126;113;113;116;112 03:29:15 INFO - 2015-11-24 03:29:15,988 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;130;157;182;184;140;173;175;124;171;147 03:29:15 INFO - 2015-11-24 03:29:15,988 DEBUG : BROWSER_OUTPUT: |2;audio-dft;193;198;197;205;210;192;196;199;203;201 03:29:15 INFO - 2015-11-24 03:29:15,988 DEBUG : BROWSER_OUTPUT: |3;audio-fft;61;63;58;68;101;66;83;84;88;124 03:29:15 INFO - 2015-11-24 03:29:15,988 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;79;86;140;61;89;112;93;109;113;140 03:29:15 INFO - 2015-11-24 03:29:15,988 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;86;86;105;115;87;78;134;133;85;91 03:29:15 INFO - 2015-11-24 03:29:15,989 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;95;94;105;95;95;94;93;94;145;94 03:29:15 INFO - 2015-11-24 03:29:15,989 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;117;114;93;91;92;124;135;112;149;143 03:29:15 INFO - 2015-11-24 03:29:15,989 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;60;60;59;59;58;60;60;67;59;58 03:29:15 INFO - 2015-11-24 03:29:15,989 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;65;65;58;96;100;60;84;101;106;105 03:29:15 INFO - 2015-11-24 03:29:15,989 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;85;87;85;84;82;86;93;83;86;96 03:29:15 INFO - 2015-11-24 03:29:15,989 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;156;136;118;109;165;140;134;139;134;130 03:29:15 INFO - 2015-11-24 03:29:15,989 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;134;169;140;138;128;172;175;171;140;138 03:29:15 INFO - 2015-11-24 03:29:15,989 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;69;67;66;66;66;66;64;69;67;68 03:29:15 INFO - 2015-11-24 03:29:15,989 DEBUG : BROWSER_OUTPUT: __end_tp_report 03:29:15 INFO - 2015-11-24 03:29:15,989 DEBUG : BROWSER_OUTPUT: __start_cc_report 03:29:15 INFO - 2015-11-24 03:29:15,989 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,835 03:29:15 INFO - 2015-11-24 03:29:15,989 DEBUG : BROWSER_OUTPUT: __end_cc_report 03:29:15 INFO - 2015-11-24 03:29:15,989 DEBUG : BROWSER_OUTPUT: __startTimestamp1448364555983__endTimestamp 03:29:15 INFO - 2015-11-24 03:29:15,990 DEBUG : BROWSER_OUTPUT: 03:29:15 INFO - 2015-11-24 03:29:15,990 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 03:29:15 INFO - 2015-11-24 03:29:15,990 DEBUG : BROWSER_OUTPUT: Number of tests: 14 03:29:15 INFO - 2015-11-24 03:29:15,990 DEBUG : BROWSER_OUTPUT: 03:29:15 INFO - 2015-11-24 03:29:15,990 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:114.20 Median:114.00 stddev:4.76 (4.2%) stddev-sans-first:5.04 03:29:15 INFO - 2015-11-24 03:29:15,990 DEBUG : BROWSER_OUTPUT: Values: 114.0 107.0 114.0 113.0 114.0 126.0 113.0 113.0 116.0 112.0 03:29:15 INFO - 2015-11-24 03:29:15,990 DEBUG : BROWSER_OUTPUT: 03:29:15 INFO - 2015-11-24 03:29:15,990 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:158.30 Median:172.00 stddev:21.91 (12.7%) stddev-sans-first:20.71 03:29:15 INFO - 2015-11-24 03:29:15,990 DEBUG : BROWSER_OUTPUT: Values: 130.0 157.0 182.0 184.0 140.0 173.0 175.0 124.0 171.0 147.0 03:29:15 INFO - 2015-11-24 03:29:15,990 DEBUG : BROWSER_OUTPUT: 03:29:15 INFO - 2015-11-24 03:29:15,990 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:199.40 Median:200.00 stddev:5.52 (2.8%) stddev-sans-first:5.35 03:29:15 INFO - 2015-11-24 03:29:15,990 DEBUG : BROWSER_OUTPUT: Values: 193.0 198.0 197.0 205.0 210.0 192.0 196.0 199.0 203.0 201.0 03:29:15 INFO - 2015-11-24 03:29:15,990 DEBUG : BROWSER_OUTPUT: 03:29:15 INFO - 2015-11-24 03:29:15,991 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:79.60 Median:67.00 stddev:20.92 (31.2%) stddev-sans-first:21.08 03:29:15 INFO - 2015-11-24 03:29:15,991 DEBUG : BROWSER_OUTPUT: Values: 61.0 63.0 58.0 68.0 101.0 66.0 83.0 84.0 88.0 124.0 03:29:15 INFO - 2015-11-24 03:29:15,991 DEBUG : BROWSER_OUTPUT: 03:29:15 INFO - 2015-11-24 03:29:15,991 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:102.20 Median:70.00 stddev:25.55 (36.5%) stddev-sans-first:25.68 03:29:15 INFO - 2015-11-24 03:29:15,991 DEBUG : BROWSER_OUTPUT: Values: 79.0 86.0 140.0 61.0 89.0 112.0 93.0 109.0 113.0 140.0 03:29:15 INFO - 2015-11-24 03:29:15,991 DEBUG : BROWSER_OUTPUT: 03:29:15 INFO - 2015-11-24 03:29:15,991 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:100.00 Median:85.50 stddev:20.67 (24.2%) stddev-sans-first:21.30 03:29:15 INFO - 2015-11-24 03:29:15,991 DEBUG : BROWSER_OUTPUT: Values: 86.0 86.0 105.0 115.0 87.0 78.0 134.0 133.0 85.0 91.0 03:29:15 INFO - 2015-11-24 03:29:15,991 DEBUG : BROWSER_OUTPUT: 03:29:15 INFO - 2015-11-24 03:29:15,991 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:100.40 Median:94.00 stddev:16.04 (17.1%) stddev-sans-first:16.90 03:29:15 INFO - 2015-11-24 03:29:15,991 DEBUG : BROWSER_OUTPUT: Values: 95.0 94.0 105.0 95.0 95.0 94.0 93.0 94.0 145.0 94.0 03:29:15 INFO - 2015-11-24 03:29:15,991 DEBUG : BROWSER_OUTPUT: 03:29:15 INFO - 2015-11-24 03:29:15,993 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:117.00 Median:146.00 stddev:21.04 (14.4%) stddev-sans-first:22.32 03:29:15 INFO - 2015-11-24 03:29:15,993 DEBUG : BROWSER_OUTPUT: Values: 117.0 114.0 93.0 91.0 92.0 124.0 135.0 112.0 149.0 143.0 03:29:15 INFO - 2015-11-24 03:29:15,993 DEBUG : BROWSER_OUTPUT: 03:29:15 INFO - 2015-11-24 03:29:15,993 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:60.00 Median:60.00 stddev:2.58 (4.3%) stddev-sans-first:2.74 03:29:15 INFO - 2015-11-24 03:29:15,993 DEBUG : BROWSER_OUTPUT: Values: 60.0 60.0 59.0 59.0 58.0 60.0 60.0 67.0 59.0 58.0 03:29:15 INFO - 2015-11-24 03:29:15,993 DEBUG : BROWSER_OUTPUT: 03:29:15 INFO - 2015-11-24 03:29:15,993 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:84.00 Median:62.50 stddev:19.97 (31.9%) stddev-sans-first:19.96 03:29:15 INFO - 2015-11-24 03:29:15,993 DEBUG : BROWSER_OUTPUT: Values: 65.0 65.0 58.0 96.0 100.0 60.0 84.0 101.0 106.0 105.0 03:29:15 INFO - 2015-11-24 03:29:15,993 DEBUG : BROWSER_OUTPUT: 03:29:15 INFO - 2015-11-24 03:29:15,993 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:86.70 Median:86.00 stddev:4.42 (5.1%) stddev-sans-first:4.65 03:29:15 INFO - 2015-11-24 03:29:15,993 DEBUG : BROWSER_OUTPUT: Values: 85.0 87.0 85.0 84.0 82.0 86.0 93.0 83.0 86.0 96.0 03:29:15 INFO - 2015-11-24 03:29:15,994 DEBUG : BROWSER_OUTPUT: 03:29:15 INFO - 2015-11-24 03:29:15,994 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:136.10 Median:137.50 stddev:16.20 (11.8%) stddev-sans-first:15.50 03:29:15 INFO - 2015-11-24 03:29:15,994 DEBUG : BROWSER_OUTPUT: Values: 156.0 136.0 118.0 109.0 165.0 140.0 134.0 139.0 134.0 130.0 03:29:15 INFO - 2015-11-24 03:29:15,994 DEBUG : BROWSER_OUTPUT: 03:29:15 INFO - 2015-11-24 03:29:15,994 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:150.50 Median:154.50 stddev:18.67 (12.1%) stddev-sans-first:18.82 03:29:15 INFO - 2015-11-24 03:29:15,994 DEBUG : BROWSER_OUTPUT: Values: 134.0 169.0 140.0 138.0 128.0 172.0 175.0 171.0 140.0 138.0 03:29:15 INFO - 2015-11-24 03:29:15,994 DEBUG : BROWSER_OUTPUT: 03:29:15 INFO - 2015-11-24 03:29:15,994 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.80 Median:67.00 stddev:1.55 (2.3%) stddev-sans-first:1.42 03:29:15 INFO - 2015-11-24 03:29:15,994 DEBUG : BROWSER_OUTPUT: Values: 69.0 67.0 66.0 66.0 66.0 66.0 64.0 69.0 67.0 68.0 03:29:16 INFO - 2015-11-24 03:29:15,994 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 03:29:16 INFO - 2015-11-24 03:29:15,994 DEBUG : BROWSER_OUTPUT: 03:29:16 INFO - 2015-11-24 03:29:16,612 INFO : Browser exited with error code: 0 03:29:16 INFO - 2015-11-24 03:29:16,659 INFO : Completed test kraken (00:00:57) 03:29:16 INFO - 2015-11-24 03:29:16,659 INFO : Starting test v8_7 03:29:16 INFO - 2015-11-24 03:29:16,660 DEBUG : operating with platform_type : mac_ 03:29:16 INFO - 2015-11-24 03:29:16,660 INFO : Initialising browser for v8_7 test... 03:29:16 INFO - 2015-11-24 03:29:16,672 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/tmpqjMOc1/profile http://localhost:49711/getInfo.html 03:29:19 INFO - 2015-11-24 03:29:19,498 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 03:29:19 INFO - 2015-11-24 03:29:19,498 DEBUG : BROWSER_OUTPUT: colorDepth:24 03:29:19 INFO - 2015-11-24 03:29:19,499 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 03:29:19 INFO - 2015-11-24 03:29:19,499 DEBUG : BROWSER_OUTPUT: __metrics 03:29:20 INFO - 2015-11-24 03:29:20,108 INFO : Browser initialized. 03:29:20 INFO - 2015-11-24 03:29:20,108 INFO : Running cycle 1/1 for v8_7 test... 03:29:20 INFO - 2015-11-24 03:29:20,109 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/tmpqjMOc1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 03:29:31 INFO - 2015-11-24 03:29:31,972 DEBUG : BROWSER_OUTPUT: RSS: Main: 237727744 03:29:31 INFO - 2015-11-24 03:29:31,973 DEBUG : BROWSER_OUTPUT: 03:29:53 INFO - 2015-11-24 03:29:53,375 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49711/tests/v8_7/run.html (next: http://localhost:49711/tests/v8_7/run.html) 03:29:53 INFO - 2015-11-24 03:29:53,623 DEBUG : BROWSER_OUTPUT: RSS: Main: 248246272 03:29:53 INFO - 2015-11-24 03:29:53,623 DEBUG : BROWSER_OUTPUT: 03:29:53 INFO - 2015-11-24 03:29:53,623 DEBUG : BROWSER_OUTPUT: __start_tp_report 03:29:53 INFO - 2015-11-24 03:29:53,623 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 03:29:53 INFO - 2015-11-24 03:29:53,623 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 03:29:53 INFO - 2015-11-24 03:29:53,623 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 03:29:53 INFO - 2015-11-24 03:29:53,623 DEBUG : BROWSER_OUTPUT: |0;Richards;174.21602787456445 03:29:53 INFO - 2015-11-24 03:29:53,624 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;168.12373907195695 03:29:53 INFO - 2015-11-24 03:29:53,624 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.09572983533354 03:29:53 INFO - 2015-11-24 03:29:53,624 DEBUG : BROWSER_OUTPUT: |3;Decrypt;4739.336492890995 03:29:53 INFO - 2015-11-24 03:29:53,624 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1021.4285714285714 03:29:53 INFO - 2015-11-24 03:29:53,624 DEBUG : BROWSER_OUTPUT: |5;Earley;727.2727272727273 03:29:53 INFO - 2015-11-24 03:29:53,624 DEBUG : BROWSER_OUTPUT: |6;Boyer;13000 03:29:53 INFO - 2015-11-24 03:29:53,624 DEBUG : BROWSER_OUTPUT: |7;RegExp;26421.052631578947 03:29:53 INFO - 2015-11-24 03:29:53,624 DEBUG : BROWSER_OUTPUT: |8;Splay;687.7982276755283 03:29:53 INFO - 2015-11-24 03:29:53,624 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4513.513513513513 03:29:53 INFO - 2015-11-24 03:29:53,624 DEBUG : BROWSER_OUTPUT: __end_tp_report 03:29:53 INFO - 2015-11-24 03:29:53,624 DEBUG : BROWSER_OUTPUT: __startTimestamp1448364593620__endTimestamp 03:29:53 INFO - 2015-11-24 03:29:53,624 DEBUG : BROWSER_OUTPUT: 03:29:53 INFO - 2015-11-24 03:29:53,625 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 03:29:53 INFO - 2015-11-24 03:29:53,625 DEBUG : BROWSER_OUTPUT: Number of tests: 10 03:29:53 INFO - 2015-11-24 03:29:53,625 DEBUG : BROWSER_OUTPUT: 03:29:53 INFO - 2015-11-24 03:29:53,625 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:174.22 Median:174.22 stddev:0.00 (0.0%) 03:29:53 INFO - 2015-11-24 03:29:53,625 DEBUG : BROWSER_OUTPUT: Values: 174.2 03:29:53 INFO - 2015-11-24 03:29:53,625 DEBUG : BROWSER_OUTPUT: 03:29:53 INFO - 2015-11-24 03:29:53,625 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:168.12 Median:168.12 stddev:0.00 (0.0%) 03:29:53 INFO - 2015-11-24 03:29:53,625 DEBUG : BROWSER_OUTPUT: Values: 168.1 03:29:53 INFO - 2015-11-24 03:29:53,625 DEBUG : BROWSER_OUTPUT: 03:29:53 INFO - 2015-11-24 03:29:53,625 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.10 Median:279.10 stddev:0.00 (0.0%) 03:29:53 INFO - 2015-11-24 03:29:53,625 DEBUG : BROWSER_OUTPUT: Values: 279.1 03:29:53 INFO - 2015-11-24 03:29:53,625 DEBUG : BROWSER_OUTPUT: 03:29:53 INFO - 2015-11-24 03:29:53,625 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:4739.34 Median:4739.34 stddev:0.00 (0.0%) 03:29:53 INFO - 2015-11-24 03:29:53,626 DEBUG : BROWSER_OUTPUT: Values: 4739.3 03:29:53 INFO - 2015-11-24 03:29:53,626 DEBUG : BROWSER_OUTPUT: 03:29:53 INFO - 2015-11-24 03:29:53,626 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1021.43 Median:1021.43 stddev:0.00 (0.0%) 03:29:53 INFO - 2015-11-24 03:29:53,626 DEBUG : BROWSER_OUTPUT: Values: 1021.4 03:29:53 INFO - 2015-11-24 03:29:53,626 DEBUG : BROWSER_OUTPUT: 03:29:53 INFO - 2015-11-24 03:29:53,626 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:727.27 Median:727.27 stddev:0.00 (0.0%) 03:29:53 INFO - 2015-11-24 03:29:53,626 DEBUG : BROWSER_OUTPUT: Values: 727.3 03:29:53 INFO - 2015-11-24 03:29:53,626 DEBUG : BROWSER_OUTPUT: 03:29:53 INFO - 2015-11-24 03:29:53,626 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:13000.00 Median:13000.00 stddev:0.00 (0.0%) 03:29:53 INFO - 2015-11-24 03:29:53,626 DEBUG : BROWSER_OUTPUT: Values: 13000.0 03:29:53 INFO - 2015-11-24 03:29:53,626 DEBUG : BROWSER_OUTPUT: 03:29:53 INFO - 2015-11-24 03:29:53,626 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26421.05 Median:26421.05 stddev:0.00 (0.0%) 03:29:53 INFO - 2015-11-24 03:29:53,626 DEBUG : BROWSER_OUTPUT: Values: 26421.1 03:29:53 INFO - 2015-11-24 03:29:53,626 DEBUG : BROWSER_OUTPUT: 03:29:53 INFO - 2015-11-24 03:29:53,627 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:687.80 Median:687.80 stddev:0.00 (0.0%) 03:29:53 INFO - 2015-11-24 03:29:53,627 DEBUG : BROWSER_OUTPUT: Values: 687.8 03:29:53 INFO - 2015-11-24 03:29:53,627 DEBUG : BROWSER_OUTPUT: 03:29:53 INFO - 2015-11-24 03:29:53,627 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4513.51 Median:4513.51 stddev:0.00 (0.0%) 03:29:53 INFO - 2015-11-24 03:29:53,627 DEBUG : BROWSER_OUTPUT: Values: 4513.5 03:29:53 INFO - 2015-11-24 03:29:53,627 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 03:29:53 INFO - 2015-11-24 03:29:53,627 DEBUG : BROWSER_OUTPUT: 03:29:54 INFO - 2015-11-24 03:29:54,245 INFO : Browser exited with error code: 0 03:29:54 INFO - 2015-11-24 03:29:54,263 INFO : Completed test v8_7 (00:00:37) 03:29:54 INFO - 2015-11-24 03:29:54,724 INFO : Completed test suite (00:20:06) 03:29:54 INFO - 2015-11-24 03:29:54,724 DEBUG : Working with test: dromaeo_css 03:29:54 INFO - 2015-11-24 03:29:54,724 DEBUG : Generating results file: dromaeo_css 03:29:54 INFO - 2015-11-24 03:29:54,725 DEBUG : Working with test: kraken 03:29:54 INFO - 2015-11-24 03:29:54,725 DEBUG : Generating results file: kraken 03:29:54 INFO - 2015-11-24 03:29:54,725 INFO : javascript benchmark 03:29:54 INFO - 2015-11-24 03:29:54,725 DEBUG : Working with test: v8_7 03:29:54 INFO - 2015-11-24 03:29:54,726 DEBUG : Generating results file: v8_7 03:29:54 INFO - 2015-11-24 03:29:54,726 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:29:55 INFO - 2015-11-24 03:29:55,249 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,61]] 03:29:55 INFO - 2015-11-24 03:29:55,249 DEBUG : process_Request line: dromaeo_css 7749.98 graph.html#tests=[[72,64,61]] 03:29:55 INFO - 2015-11-24 03:29:55,249 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:29:55 INFO - 2015-11-24 03:29:55,279 DEBUG : process_Request line: kraken 1555.20 graph.html#tests=[[232,64,61]] 03:29:55 INFO - 2015-11-24 03:29:55,279 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:29:55 INFO - 2015-11-24 03:29:55,303 DEBUG : process_Request line: v8_7 21420.64 graph.html#tests=[[230,64,61]] 03:29:55 INFO - 2015-11-24 03:29:55,304 INFO : javascript benchmark 03:29:55 INFO - 2015-11-24 03:29:55,305 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3172.2069482629345, 3538.027042563296, 3555.395582750932, 3577.7137828973687, 3594.4248920172777, 5577.079781835992, 5826.271716035496, 5968.5523585731025, 5978.461938425541, 5984.88030239395, 5751.769929202837, 5884.117382392643, 5963.582549221556, 6008.489278411329, 6098.512119030478, 5290.65610735301, 5358.866028349284, 5378.381486129106, 5429.67421954684, 5436.130219164935, 941.7244597714155, 5352.678839269637, 5389.272448219499, 5417.0, 5465.890682186374, 5337.626366154371, 5349.839504814842, 5356.598255130862, 5368.4631536846, 5379.354477462691, 5379.946200538023, 5401.3248343957, 5415.0, 5427.851845929391, 5428.0, 5189.143791274435, 5190.610704197163, 5283.445238249967, 5284.10170271051, 5346.984073026151, 4586.770661466947, 4847.709137451764, 5117.360329958755, 5898.203742494794, 5908.704564771787, 6145.139680444741, 6341.365863413622, 6342.873142537123, 6346.904796428057, 6352.555321127523, 6263.937360626381, 6289.528285378569, 6291.748330066792, 6448.484121270287, 6482.57863238888, 5064.442911279756, 5975.312839023524, 5982.641041537521, 5996.190514280604, 6010.939890601126, 6144.433169541739, 6301.338359472281, 6317.052442133717, 6334.461570766536, 6350.269718982377, 6104.671374792629, 6188.752449902044, 6198.442140207313, 6210.689465526705, 6213.068039794067, 6353.841153971188, 6383.234011918599, 6383.680815959184, 6389.7763578274535, 6403.807885763435, 5342.091844386464, 5650.689212093293, 6198.2252218472695, 6243.157173781481, 6273.592216505913, 5546.389897111315, 6100.298465676416, 6254.093156492283, 6261.436470717657, 6274.247090349188, 5093.770780314895, 5093.847184584469, 5110.897782044338, 5132.999065182328, 5133.12736834739, 4374.168907907488, 4486.6186374157905, 4507.5267096955, 4634.536546345338, 4651.139539185261, 5997.760089596367, 6012.038073908241, 6026.939730602726, 6038.516918646497, 6046.758129674852, 6366.904496432558, 6377.17096777416, 6378.553501254961, 6382.617042977344, 6392.648404337806, 5485.424030476823, 5909.084091965752, 5913.2608423947, 5913.9112913306335, 5925.229720136354, 5525.977694126599, 5541.806036788693, 5576.358718747396, 5578.63738856973, 5587.022271102541, 6374.808755737336, 6415.101885736, 6437.324080971431, 6454.838629034311, 6462.095306657072, 5523.6409633373705, 6226.128342032029, 6301.306856245901, 6322.8735425290315, 6348.396902294275, 6332.113504109337, 6434.099226108255, 6511.120998665119, 6517.706703198272, 6548.148740663683, 6160.291566469913, 6264.906026409699, 6265.216847894013, 6282.183316168869, 6286.7799627014665, 6319.96840015797, 6341.365863413622, 6385.0, 6401.679916004088, 6413.551051426542, 5293.364796224478, 6075.605085669417, 6137.35557766446, 6231.4391704746795, 6309.558330916791, 5157.690538567698, 5613.961417137679, 5906.793262235801, 6249.78125765596, 6269.592476489013, 6050.42520960508, 6180.6909654517995, 6204.720787564661, 6207.534434917489, 6220.222472190976, 6128.693565321805, 6149.292831324276, 6218.657973811303, 6219.471344935731, 6283.183186185766, 6180.783672571439, 6182.505399568114, 6227.688615569294, 6244.625322480666, 6251.6874156292915], "unit": "ms", "name": "dojo.html", "value": 5756.351774122694}, {"lowerIsBetter": false, "replicates": [535.3709391465028, 554.282204545114, 597.853525886158, 606.9015082700312, 608.6530677513816, 40832.59167408325, 41085.0, 41446.99999999996, 41454.0, 41501.79249103758, 43988.90027749308, 44229.7788511057, 44450.88872778182, 44483.77758111213, 44502.33246501297, 9828.213742900587, 9954.60181592739, 10000.0, 10029.899701003005, 10037.749056273578, 9708.0, 9835.803283934318, 9846.212303015778, 9867.309288349818, 9958.452285124315, 8377.664893404288, 8876.778080547974, 9739.75650608737, 9815.411075335467, 9894.50527473627, 8397.370197235232, 8575.82848343036, 8788.033316335199, 9777.90222097777, 9832.213422926185, 9707.757306067404, 9796.118349348593, 9796.412215267035, 9829.21366290695, 9829.754256143582, 39964.20071598552, 40096.59903400958, 40266.0, 40292.39561406552, 40552.391714124315, 3282.6427904945363, 3507.1582820122985, 3786.0, 3867.903302417462, 4044.8027423742874, 28651.57022644662, 29713.25716857074, 29801.211927284432, 29876.55185172224, 29991.70008299911, 2829.4906916754976, 2837.60803107903, 2875.928101797451, 2878.5250433678416, 2917.4456853197826, 487277.0, 488174.0, 488951.99999999645, 489879.0, 490112.0, 55519.0, 58556.70721646365, 66135.0, 67236.0, 69028.96456553155, 65796.0, 65884.67057664681, 66370.672586548, 66471.0, 66556.00165997514, 14105.012649114464, 15247.237638118271, 16129.435469758502, 16143.192840357935, 16180.352785888432, 12050.397480126134, 12100.273983561014, 12110.636680899586, 12185.147039707135, 12229.143959922898, 20814.479638009172, 21557.56884862294, 21595.892020540112, 21598.0, 21621.783782161976, 8425.07324194338, 8652.480851148952, 8669.08974557675, 8669.566521674018, 8733.781655458537, 948.8719022931816, 991.7768502086973, 993.9353941993747, 1030.0111892583054, 1105.1103861391657, 23964.40088997789, 26041.869790651304, 28316.575251371247, 28377.29056773597, 28594.14217573476, 1074.505727365405, 1108.5288752280248, 1115.9107271418268, 1234.1237721218035, 1241.1064033895582, 12915.0, 13778.586642400744, 13798.896088312911, 14604.05073670208, 14833.332500037524, 487948.0, 508569.0, 510932.0, 516036.0, 516202.0, 58336.0, 58490.70754646284, 58803.70598147067, 58906.11640825391, 59033.0, 1427.336288625794, 1436.6264771159365, 1470.7058588282387, 1473.6463248820205, 1474.2481334519257, 28162.577561337006, 29127.7087229125, 33043.66956330502, 33740.83129584337, 34719.13202169865, 56423.0, 56823.43176568182, 57009.0, 57454.0, 57480.71259643675, 461279.0, 469120.6543967258, 469723.0, 472286.0, 474440.6277968588, 44437.0, 45056.0988780216, 46271.07457850892, 46468.7676561615, 46585.835354115065, 47736.0, 47984.04031919412, 48002.0, 49429.0, 49711.50288497069, 37959.14309856311, 38575.807120964215, 40281.395779062754, 40548.594514055665, 40707.796461017504, 38221.61778382181, 39144.41283380695, 39196.8407475845, 39625.80187099046, 39737.80131099326, 38327.80836095801, 38401.65594204189, 39203.41194882136, 39222.2155556893, 39332.80333598314, 28237.0, 32804.835975819966, 35129.0, 35182.0, 35408.29183416369, 24830.751692482845, 26173.0, 26239.950401983708, 26425.075122370625, 26464.338391540365], "unit": "ms", "name": "ext.html", "value": 20437.715913113847}, {"lowerIsBetter": false, "replicates": [364.33327011568815, 372.7763341994803, 373.2311438436819, 373.5405451294908, 374.5093926955688, 15752.921235393836, 19359.903200483994, 20641.896790516064, 20842.791572084276, 21260.043298051587, 20052.498687532818, 20558.486037849063, 20608.69086963693, 20726.48183795402, 21325.0, 5703.914441283384, 5735.397783232763, 5880.970830104736, 5882.941170588304, 5900.822975310726, 5820.068788993762, 5826.359100498942, 5826.533877289828, 5859.6777177255235, 5885.676287804169, 4448.799804008828, 5817.272840894888, 5819.505342045931, 5829.708514574276, 6309.3690630937, 6247.7188526515965, 6291.874162516747, 6297.527685423589, 6305.432511074003, 6339.175907132089, 5357.303550538444, 5470.5350045246205, 5477.904419116193, 5487.368952570426, 5508.3114610673665, 25484.0, 25591.48817023649, 25750.613740793902, 25845.224643260543, 26035.73964260352, 2117.7141085953353, 2153.020375729055, 2314.0975019742314, 2328.278233747527, 2356.575816353056, 14717.55847324582, 14829.18439485828, 15244.695106097815, 15267.312970916335, 15565.29956151976, 1656.6935117003272, 1742.0941110622532, 1773.6098058427126, 1778.0931724820305, 1778.9288428462976, 97958.5102074485, 101426.0, 101903.9809601902, 102254.0, 103029.0, 10106.14097801695, 10312.278140530241, 10459.0, 10514.421706806199, 10543.20925930543, 12538.623841284776, 12560.30918299484, 12564.0, 12568.81146782799, 12572.811407828889, 8164.510129392255, 8206.138355472589, 8218.671253149927, 8264.504129752235, 8265.586720664063, 7309.269073092648, 7492.213317601682, 8279.172082791792, 8326.70856520031, 8336.374771892133, 5140.203268493315, 5994.0, 6101.298350689727, 6146.262448506208, 6196.721147548371, 1614.555997100783, 1829.9112028343116, 1831.7435559021746, 1860.7674040744907, 1876.080720446971, 381.6584157179309, 384.2890652293235, 384.93840985442193, 1018.1447584029303, 1040.0379648824808, 10296.845547316647, 10510.633617629659, 11611.129165312635, 20902.58194836095, 21106.472338191666, 822.9218224268685, 893.4594570285014, 971.7376308396694, 992.4491906991689, 1030.1141018723893, 9514.143727064597, 11187.664370068911, 11687.532498699957, 11753.823692644617, 11839.526418943318, 707477.0, 713010.0, 728438.0, 754079.0, 757301.0, 123228.1515777264, 127206.45587088207, 127328.0, 128048.0, 128180.0, 1223.7980733179104, 1233.4264566976399, 1234.2902830872285, 1235.882591153839, 1255.4727014653868, 18589.44231673052, 18747.625047499245, 18905.621887561898, 19293.0, 19417.902910485358, 38530.65142719991, 49422.752886235336, 49560.0, 49638.50361496483, 50844.237336440725, 71836.64081679558, 72236.44750869485, 73765.6311718438, 75748.62125689337, 76632.61683691769, 9234.492102934402, 9488.335816493056, 9645.131938125602, 9843.310968232441, 9871.851922221029, 11368.147388946027, 13254.867451325363, 18990.905045474683, 19490.220391184193, 19765.901170494057, 15515.37938482448, 15543.300551474984, 15698.136602486973, 15737.055776653437, 15955.20223988819, 15090.54728358151, 15296.541103766906, 15327.0, 15338.309776059881, 15523.611909702347, 16100.838991609933, 16232.0, 16453.259603318118, 16525.66948661044, 16580.917095414447, 8071.273585377344, 8919.910800892168, 9071.909280907106, 9779.26655500826, 10132.392056476636, 12056.51773929033, 15179.772303415237, 15870.52388428349, 16182.867199295937, 16513.0], "unit": "ms", "name": "jquery.html", "value": 9986.976557562486}, {"lowerIsBetter": false, "replicates": [1577.3927038090333, 1608.5656872644386, 1716.3134746101557, 1876.3526583328746, 1927.9903600481998, 7953.602319883998, 8110.067342255627, 8623.663332183514, 8869.733907982754, 8891.510966896825, 8379.622916968736, 8592.05487396386, 8676.73969780906, 8704.260137888286, 8708.477491350523, 2376.572217000935, 2407.879606019701, 2420.1529464687396, 2420.745821688724, 2427.66012758214, 2384.4277373430427, 2414.8792560372, 2447.571674956884, 2448.9387765305833, 2453.877306134695, 2363.61000434928, 2384.3562238195677, 2400.063975049732, 2410.770976757205, 2416.4925365673143, 2109.0, 2356.8114550835894, 2382.5711371953043, 2410.6625072489865, 2414.5895197816326, 2394.4492766663766, 2420.370703617072, 2434.184548176363, 2443.132687895807, 2444.8899799508886, 8557.229849313591, 8616.224539791448, 8658.090900455425, 8693.087225841258, 8703.260222881063, 4693.718376897397, 5160.14857548504, 5239.528442440199, 5273.789048438058, 5276.947230527684, 3008.6540047894555, 3197.0089272325654, 3486.8493397178872, 3538.115471132217, 3638.6361363863402, 1034.5551412892453, 1052.0, 1058.4760543530924, 1081.9505080072395, 1084.219362059316, 11441.713957151054, 11469.254498457574, 11473.541058357656, 11483.598074067451, 11508.827367589492, 4761.714297142183, 4768.57082862544, 4805.014971930746, 4831.51684831514, 4856.053069651454, 9861.457619830835, 9863.210943124677, 9887.901120988841, 9898.059684329977, 9906.306558540833, 4575.588197062214, 5259.0, 5262.184361423985, 5270.973645131749, 5303.098473259555, 4825.372701548847, 4826.227803551415, 4835.661503694708, 4842.539958703917, 4930.852074437773, 3750.362438385481, 3869.129445874712, 3950.051987522974, 3951.05174758056, 3964.0288129408477, 1299.7595444842734, 1312.3831799054428, 1319.901007424447, 1320.9867901320863, 1325.15190278222, 1399.9370028348749, 1404.9438022479192, 1405.206058576901, 1429.6140042188551, 1440.8991370603958, 7987.201279871966, 8023.759287221393, 8032.0, 8054.476459030145, 8093.797655058553, 513.358302122347, 515.8143068495339, 515.9509846564571, 516.2772119033383, 522.068108426457, 6087.05650624154, 6234.657093859791, 6239.095331176954, 6257.217847769029, 6261.96869015652, 9741.0, 10318.019788120117, 10372.481375931173, 10501.842472362921, 10509.738831340288, 10266.897331026743, 10312.071913527669, 10370.014848589371, 10385.117265032557, 10438.269321147447, 6771.932280677229, 7420.886866969998, 7461.5523068614975, 7951.880721789178, 8005.919940800634, 7066.8233294166, 7703.537787732754, 7710.498817576839, 7886.487378320391, 7908.327792137733, 7817.687292508236, 9160.725178244664, 9316.20812230968, 9447.0, 9506.096920792514, 9576.377535460173, 9588.952055239959, 9623.711288661352, 9627.59310172457, 9713.931467538707, 6444.387783160592, 7532.359749421361, 7574.242575742382, 7589.962050189713, 7601.961990190013, 8140.348772098337, 8189.877151842608, 8209.83580328402, 8247.21651443112, 8262.380321476034, 7584.431167662337, 7706.691732330644, 7715.112762032438, 7742.496737712256, 7838.137804841577, 7517.473776835788, 7580.0145981022115, 7629.122650895218, 7642.8089297768, 7669.5398276103615, 7698.230176982257, 7716.807079823049, 7725.188855170126, 7727.188645192174, 7727.9227207729455, 6916.685829692342, 6995.055667484824, 7012.614306213207, 7027.262137475492, 7032.1912980007955, 7073.646317684198, 7073.858522829411, 7121.6439178039855, 7139.500234983501, 7146.0], "unit": "ms", "name": "mootools.html", "value": 4784.772783123191}, {"lowerIsBetter": false, "replicates": [315.6512054180129, 332.87184433992905, 333.26515034349256, 341.771013421008, 344.2272099137437, 5478.698671573062, 7024.402925751311, 7031.0, 7039.929600703985, 7050.25972272911, 6823.7611683591085, 6944.305569443053, 7020.157581090263, 7029.086218791563, 7044.330788575077, 4136.172765446908, 5019.447860735326, 5092.497713174623, 5141.562967147797, 5143.382794064718, 4977.054359671669, 5127.282180494715, 5127.3078134451935, 5134.332536770215, 5147.4080480744815, 5078.822241221558, 5085.618578606601, 5091.032703786269, 5092.872678183038, 5101.69389836611, 4481.3726078349055, 4969.527894849984, 5089.3638295213095, 5095.796168153288, 5095.936145860932, 4369.366441865944, 4384.430024096879, 4386.780660966971, 4390.868273951754, 4394.36281739146, 5007.749612519359, 6410.839729006812, 6619.073329733841, 6763.898541521881, 6786.185657721056, 6035.577509574332, 6038.2150320458495, 6042.57701960863, 6051.515878729691, 6060.0, 7504.249575042507, 7521.323080922743, 7523.887141692879, 7544.886826697604, 7572.129205141424, 4823.13183626947, 4925.605951523869, 4932.679375840559, 4939.283803848458, 4945.406551213878, 7732.8787325838, 7883.448158628898, 8029.558374289411, 8031.598420078973, 8032.638531266049, 4295.978520107442, 5001.7499125043605, 5010.398752149766, 5014.749262536859, 5030.346055012825, 4176.934881605232, 4973.278874563241, 5109.821156259587, 5114.386273647112, 5115.616328775357, 5004.724740139254, 5958.970205148947, 6049.971504844187, 6054.273487181566, 6057.666828324484, 7583.696652133964, 7613.390928725688, 7622.237776222333, 7636.579988100597, 7646.044244469442, 1508.585139086738, 1728.9049102299493, 1761.2338632694562, 1778.3242367900116, 1782.0911335219132, 1127.498263272852, 1157.120588352841, 1158.901493373056, 1162.5291756838494, 1170.789257933563, 6852.109225800614, 6865.244823069458, 6868.347506986828, 6885.036094946711, 6890.414314783299, 6321.905171422432, 7721.725915223925, 7740.148583655793, 7740.961295193601, 7758.107817601048, 6719.227288861844, 6852.0, 6888.690008949609, 6903.75836845718, 6918.8616227676175, 4087.734297270668, 4100.2414553307735, 4106.178764247163, 4114.567970363129, 4115.135821477464, 7071.8939215911805, 7354.191038985708, 7940.722074727357, 7970.920290797134, 7987.520748755093, 5667.886642267132, 6507.479401647857, 7988.360931125496, 8015.238552337519, 8017.198280171936, 7934.127246002935, 7942.245486678757, 7956.363490920712, 7971.72452407612, 7974.681012759424, 7557.0, 7667.619828430713, 7706.884396733942, 7769.223077692185, 7777.300042996158, 7566.470347075652, 7568.470207085451, 7590.620468976639, 7595.442934198587, 7595.810104747426, 7931.325837303893, 7964.402669799672, 7970.003749531309, 7980.92019079825, 7982.0, 4692.601128903945, 4855.878603034952, 4872.317875497362, 5006.87482812918, 5009.699418034929, 6254.593451425642, 7860.803479912819, 7864.4888082274465, 7868.0, 7935.603219838869, 7622.733204337822, 7634.351080158249, 7643.503172293783, 7657.272559106876, 7660.616969151632, 7472.813179670552, 7608.923910760822, 7610.238976102345, 7625.0, 7643.88534171999, 6358.014507751121, 7171.282871712787, 7421.3691836192365, 7443.106827180773, 7446.101244182699, 7599.0, 7603.0876294844975, 7611.4291428142005, 7616.0, 7623.237676232332, 7260.600666963156, 7399.075115610549, 7456.47804653669, 7459.962700186465, 7465.954766332827], "unit": "ms", "name": "prototype.html", "value": 5417.704476219997}, {"lowerIsBetter": false, "replicates": [612.8866159760441, 723.8769409200436, 744.6611791634807, 764.4190415284386, 808.216030450463, 14955.327010284536, 15158.84841151588, 15251.847481525181, 15284.930054896147, 15344.079355238693, 14027.509037183701, 16310.918445407786, 16553.503394898144, 16555.006699598, 16605.08672023038, 968.0658164870898, 982.130814229405, 984.0798853072364, 986.4870267460916, 987.782687808681, 769.253823790922, 783.3380793229712, 954.6229239450413, 975.0103644800533, 983.7245571240064, 1021.0453226233495, 1021.6475316016, 1026.209818439801, 1030.4229631406436, 1036.0778906772978, 945.0832692288469, 1013.6756238003842, 1021.7803172317913, 1024.1243736605206, 1028.8353863381824, 751.4889874885076, 754.9698012079565, 759.1232126893447, 761.6115780951754, 766.9760869239572, 15442.845571544252, 15581.92209038959, 15628.921855390763, 15644.296006679726, 15712.842871571367, 10762.569497220102, 10913.39976301303, 12475.313857737821, 12797.808032879515, 13539.916806655445, 9943.8508422373, 10203.948980255125, 10858.565657373696, 11031.393273369962, 11675.591354302558, 3498.1254686328416, 3500.982495087508, 3577.213013137132, 3578.6600272974024, 3587.7488575799703, 67936.6603166981, 69676.303236968, 69861.99999999949, 70378.29621703768, 83705.16294837034, 9746.220302375934, 9762.828460584633, 9764.072413120743, 9796.216302695768, 9820.263480239011, 22612.434689132573, 22684.432889177904, 22925.656115158286, 22999.080036798674, 23055.077796888272, 7466.85066298671, 7651.655675494505, 7703.306702396699, 7826.178251283647, 7847.843043139105, 4100.446439730598, 4103.4050062740735, 4155.792210389468, 4157.147784704129, 4300.182965236595, 3272.869085236564, 3284.392387408337, 3288.556044933903, 3308.8180150091493, 3308.8676452941613, 614.2628845385556, 621.7512994802025, 626.1203009771278, 626.6052386996163, 634.8666779976164, 465.27881783236523, 471.8230663501187, 485.4247716456011, 503.65751289123017, 537.2666310486159, 8601.924759405074, 8631.870521942175, 8680.6527738891, 8685.913140868637, 8763.255123314462, 473.9312799644101, 518.2821791818284, 560.5487582496048, 575.9424057594207, 661.867626474707, 3956.3274243378696, 4036.9370762638064, 4258.276093064186, 4418.734875907456, 4496.64026877849, 80519.0, 100011.0, 100382.4980875091, 101989.0, 102503.0, 62165.68917155476, 83411.58294208611, 83960.58019709862, 84753.57623211844, 85678.0, 75242.49515009669, 75778.0, 76124.61937690387, 76244.0938976519, 78130.0, 9091.363604547618, 9114.453132812052, 9182.219511341344, 9203.493807840365, 9256.444613322952, 55067.0, 55089.72455137699, 55593.72203138958, 55742.0, 56056.0, 72833.0, 77758.0, 77957.0, 78127.60936195283, 78437.60781196058, 10221.131203847755, 10560.627118474857, 11028.28316159447, 11045.558177673125, 11618.396950343942, 11956.521739130338, 12484.687882803002, 12550.309732964775, 12603.74792504163, 12867.356632168541, 11575.42122893835, 11797.587084452003, 11830.704232393915, 11841.940790295994, 11850.822237666614, 11302.886971130512, 11525.711857203301, 11610.24533405326, 11955.0, 12375.75248495043, 10955.45222738844, 11307.943460282646, 11589.0, 11657.300561966309, 12279.079069069678, 9525.904740952501, 9686.275289951693, 10064.245181611555, 10079.647212347532, 10249.641262555775, 9341.346105772802, 9739.756506087404, 10026.345652967471, 10037.69886903394, 10117.19062475015], "unit": "ms", "name": "yui.html", "value": 7113.428842257203}], "name": "dromaeo_css", "value": 7749.985268939974}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [114.0, 107.0, 114.0, 113.0, 114.0, 126.0, 113.0, 113.0, 116.0, 112.0], "unit": "ms", "name": "ai-astar", "value": 114.2}, {"lowerIsBetter": true, "replicates": [130.0, 157.0, 182.0, 184.0, 140.0, 173.0, 175.0, 124.0, 171.0, 147.0], "unit": "ms", "name": "audio-beat-detection", "value": 158.3}, {"lowerIsBetter": true, "replicates": [193.0, 198.0, 197.0, 205.0, 210.0, 192.0, 196.0, 199.0, 203.0, 201.0], "unit": "ms", "name": "audio-dft", "value": 199.4}, {"lowerIsBetter": true, "replicates": [61.0, 63.0, 58.0, 68.0, 101.0, 66.0, 83.0, 84.0, 88.0, 124.0], "unit": "ms", "name": "audio-fft", "value": 79.6}, {"lowerIsBetter": true, "replicates": [79.0, 86.0, 140.0, 61.0, 89.0, 112.0, 93.0, 109.0, 113.0, 140.0], "unit": "ms", "name": "audio-oscillator", "value": 102.2}, {"lowerIsBetter": true, "replicates": [86.0, 86.0, 105.0, 115.0, 87.0, 78.0, 134.0, 133.0, 85.0, 91.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 100.0}, {"lowerIsBetter": true, "replicates": [95.0, 94.0, 105.0, 95.0, 95.0, 94.0, 93.0, 94.0, 145.0, 94.0], "unit": "ms", "name": "imaging-darkroom", "value": 100.4}, {"lowerIsBetter": true, "replicates": [117.0, 114.0, 93.0, 91.0, 92.0, 124.0, 135.0, 112.0, 149.0, 143.0], "unit": "ms", "name": "imaging-desaturate", "value": 117.0}, {"lowerIsBetter": true, "replicates": [60.0, 60.0, 59.0, 59.0, 58.0, 60.0, 60.0, 67.0, 59.0, 58.0], "unit": "ms", "name": "json-parse-financial", "value": 60.0}, {"lowerIsBetter": true, "replicates": [65.0, 65.0, 58.0, 96.0, 100.0, 60.0, 84.0, 101.0, 106.0, 105.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 84.0}, {"lowerIsBetter": true, "replicates": [85.0, 87.0, 85.0, 84.0, 82.0, 86.0, 93.0, 83.0, 86.0, 96.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 86.7}, {"lowerIsBetter": true, "replicates": [156.0, 136.0, 118.0, 109.0, 165.0, 140.0, 134.0, 139.0, 134.0, 130.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 136.1}, {"lowerIsBetter": true, "replicates": [134.0, 169.0, 140.0, 138.0, 128.0, 172.0, 175.0, 171.0, 140.0, 138.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 150.5}, {"lowerIsBetter": true, "replicates": [69.0, 67.0, 66.0, 66.0, 66.0, 66.0, 64.0, 69.0, 67.0, 68.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 66.8}], "name": "kraken", "value": 1555.1999999999998}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [174.21602787456445], "unit": "score", "name": "Richards", "value": 202.63348000000005}, {"lowerIsBetter": false, "replicates": [168.12373907195695], "unit": "score", "name": "DeltaBlue", "value": 393.26986400000015}, {"lowerIsBetter": false, "replicates": [279.09572983533354], "unit": "score", "name": "Encrypt", "value": 953.7265229999995}, {"lowerIsBetter": false, "replicates": [4739.336492890995], "unit": "score", "name": "Decrypt", "value": 56.16419099999998}, {"lowerIsBetter": false, "replicates": [1021.4285714285714], "unit": "score", "name": "RayTrace", "value": 724.4647552447555}, {"lowerIsBetter": false, "replicates": [727.2727272727273], "unit": "score", "name": "Earley", "value": 916.3866250000003}, {"lowerIsBetter": false, "replicates": [13000.0], "unit": "score", "name": "Boyer", "value": 51.26638461538464}, {"lowerIsBetter": false, "replicates": [26421.052631578947], "unit": "score", "name": "RegExp", "value": 34.47951195219122}, {"lowerIsBetter": false, "replicates": [687.7982276755283], "unit": "score", "name": "Splay", "value": 118.48096828543113}, {"lowerIsBetter": false, "replicates": [4513.513513513513], "unit": "score", "name": "NavierStokes", "value": 328.7904191616765}], "name": "v8_7", "value": 21420.6379043405}]} 03:29:55 INFO - RETURN: dromaeo_css: 7749.98 03:29:55 INFO - RETURN: kraken: 1555.20 03:29:55 INFO - RETURN: v8_7: 21420.64 03:29:55 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,61]]", "result": "21420.64"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,61]]", "result": "1555.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,61]]", "result": "7749.98"}}} 03:29:55 INFO - Return code: 0 03:29:55 INFO - # TBPL SUCCESS # 03:29:55 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:29:55 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:29:55 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:29:55 INFO - 2015-11-24 03:29:55.374 screenresolution[2025:17292] starting screenresolution argv=screenresolution get 03:29:55 INFO - 2015-11-24 03:29:55.377 screenresolution[2025:17292] Display 0: 1600x1200x32@60 03:29:55 INFO - 2015-11-24 03:29:55.383 screenresolution[2026:17295] starting screenresolution argv=screenresolution list 03:29:55 INFO - Available Modes on Display 0 03:29:55 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:29:55 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:29:55 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:29:55 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:29:55 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:29:55 INFO - Intel Iris: 03:29:55 INFO - Chipset Model: Intel Iris 03:29:55 INFO - Type: GPU 03:29:55 INFO - Bus: Built-In 03:29:55 INFO - VRAM (Dynamic, Max): 1536 MB 03:29:55 INFO - Vendor: Intel (0x8086) 03:29:55 INFO - Device ID: 0x0a2e 03:29:55 INFO - Revision ID: 0x0009 03:29:55 INFO - Displays: 03:29:55 INFO - Display: 03:29:55 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:29:55 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:29:55 INFO - Display Serial Number: 1600x1200 60 03:29:55 INFO - Main Display: Yes 03:29:55 INFO - Mirror: Off 03:29:55 INFO - Online: Yes 03:29:55 INFO - Rotation: Supported 03:29:55 INFO - Return code: 0 03:29:55 INFO - Running post-action listener: _resource_record_post_action 03:29:55 INFO - Running post-run listener: _resource_record_post_run 03:29:56 INFO - Total resource usage - Wall time: 1237s; CPU: 54.0%; Read bytes: 430080; Write bytes: 695924224; Read time: 6; Write time: 2537 03:29:56 INFO - install - Wall time: 31s; CPU: 54.0%; Read bytes: 339038720; Write bytes: 337647104; Read time: 26016; Write time: 688 03:29:56 INFO - run-tests - Wall time: 1208s; CPU: 54.0%; Read bytes: 430080; Write bytes: 346910720; Read time: 6; Write time: 1812 03:29:56 INFO - Running post-run listener: _upload_blobber_files 03:29:56 INFO - Blob upload gear active. 03:29:56 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 03:29:56 INFO - Copying logs to upload dir... 03:29:56 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1284.116804 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2015-11-24 03:29:56.735436) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-24 03:29:56.739026) ========= 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.YcOeaCfrTj/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.x1niOHBkIw/Listeners TMPDIR=/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/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/5scwinrvRay9hPVQh31uYA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.009514 build_url: 'https://queue.taskcluster.net/v1/task/5scwinrvRay9hPVQh31uYA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg' ========= master_lag: 0.02 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-24 03:29:56.767539) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 03:29:56.768162) ========= 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.YcOeaCfrTj/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.x1niOHBkIw/Listeners TMPDIR=/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/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.004758 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 03:29:56.823557) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-24 03:29:56.824096) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-24 03:29:56.824854) ========= ========= Total master_lag: 11.53 =========