builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0038 starttime: 1448027481.51 results: success (0) buildid: 20151120034636 builduid: 89040fbae0d44899b170b2098a02271b revision: 2316f6179102f01468d577dfb13d074a85689a27 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-20 05:51:21.510039) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-20 05:51:21.510532) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-20 05:51:21.510823) ========= 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.A2KxRRwelS/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.UzyfVLRTNJ/Listeners TMPDIR=/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.005452 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-20 05:51:21.531831) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-20 05:51:21.532127) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-20 05:51:21.548196) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 05:51:21.549092) ========= 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.A2KxRRwelS/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.UzyfVLRTNJ/Listeners TMPDIR=/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005710 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 05:51:21.599240) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-20 05:51:21.599628) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-20 05:51:21.600081) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 05:51:21.600751) ========= 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.A2KxRRwelS/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.UzyfVLRTNJ/Listeners TMPDIR=/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2015-11-20 05:51:21-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 1.62G=0s 2015-11-20 05:51:21 (1.62 GB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.241587 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 05:51:21.859563) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 05:51:21.860257) ========= 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.A2KxRRwelS/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.UzyfVLRTNJ/Listeners TMPDIR=/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.026511 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 05:51:21.913577) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 05:51:21.913948) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 2316f6179102f01468d577dfb13d074a85689a27 --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 2316f6179102f01468d577dfb13d074a85689a27 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.A2KxRRwelS/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.UzyfVLRTNJ/Listeners TMPDIR=/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2015-11-20 05:51:21,994 truncating revision to first 12 chars 2015-11-20 05:51:21,994 Setting DEBUG logging. 2015-11-20 05:51:21,994 attempt 1/10 2015-11-20 05:51:21,994 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/2316f6179102?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-20 05:51:22,637 unpacking tar archive at: fx-team-2316f6179102/testing/mozharness/ program finished with exit code 0 elapsedTime=0.883393 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 05:51:22.813146) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-20 05:51:22.813518) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-20 05:51:22.825210) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-20 05:51:22.825526) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-20 05:51:22.825965) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 30 secs) (at 2015-11-20 05:51:22.826294) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--system-bits', '64', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.A2KxRRwelS/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.UzyfVLRTNJ/Listeners TMPDIR=/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 05:51:23 INFO - MultiFileLogger online at 20151120 05:51:23 in /builds/slave/test 05:51:23 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 05:51:23 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:51:23 INFO - {'append_to_log': False, 05:51:23 INFO - 'base_work_dir': '/builds/slave/test', 05:51:23 INFO - 'blob_upload_branch': 'Fx-Team', 05:51:23 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:51:23 INFO - 'branch': 'Fx-Team', 05:51:23 INFO - 'buildbot_json_path': 'buildprops.json', 05:51:23 INFO - 'config_files': ('talos/mac_config.py',), 05:51:23 INFO - 'default_actions': ('clobber', 05:51:23 INFO - 'read-buildbot-config', 05:51:23 INFO - 'download-and-extract', 05:51:23 INFO - 'populate-webroot', 05:51:23 INFO - 'create-virtualenv', 05:51:23 INFO - 'install', 05:51:23 INFO - 'run-tests'), 05:51:23 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:51:23 INFO - 'download_minidump_stackwalk': True, 05:51:23 INFO - 'download_symbols': 'ondemand', 05:51:23 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:51:23 INFO - 'tooltool.py': '/tools/tooltool.py', 05:51:23 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:51:23 INFO - '/tools/misc-python/virtualenv.py')}, 05:51:23 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:51:23 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:51:23 INFO - 'installer_path': 'installer.exe', 05:51:23 INFO - 'log_level': 'info', 05:51:23 INFO - 'log_name': 'talos', 05:51:23 INFO - 'log_to_console': True, 05:51:23 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:51:23 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:51:23 INFO - 'opt_config_files': (), 05:51:23 INFO - 'pip_index': False, 05:51:23 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:51:23 INFO - 'cmd': ('bash', 05:51:23 INFO - '-c', 05:51:23 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:51:23 INFO - 'enabled': True, 05:51:23 INFO - 'halt_on_failure': False, 05:51:23 INFO - 'name': 'check_screen_resolution'},), 05:51:23 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:51:23 INFO - 'cmd': ('bash', 05:51:23 INFO - '-c', 05:51:23 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:51:23 INFO - 'enabled': True, 05:51:23 INFO - 'halt_on_failure': False, 05:51:23 INFO - 'name': 'check_screen_resolution'},), 05:51:23 INFO - 'run_cmd_checks_enabled': True, 05:51:23 INFO - 'sps_profile': False, 05:51:23 INFO - 'sps_profile_interval': 0, 05:51:23 INFO - 'suite': 'dromaeojs', 05:51:23 INFO - 'system_bits': '64', 05:51:23 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:51:23 INFO - 'title': 't-yosemite-r7-0038', 05:51:23 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:51:23 INFO - 'use_talos_json': True, 05:51:23 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:51:23 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:51:23 INFO - 'work_dir': 'build'} 05:51:23 INFO - ##### 05:51:23 INFO - ##### Running clobber step. 05:51:23 INFO - ##### 05:51:23 INFO - Running pre-action listener: _resource_record_pre_action 05:51:23 INFO - Running main action method: clobber 05:51:23 INFO - rmtree: /builds/slave/test/build 05:51:23 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:51:24 INFO - Running post-action listener: _resource_record_post_action 05:51:24 INFO - ##### 05:51:24 INFO - ##### Running read-buildbot-config step. 05:51:24 INFO - ##### 05:51:24 INFO - Running pre-action listener: _resource_record_pre_action 05:51:24 INFO - Running main action method: read_buildbot_config 05:51:24 INFO - Using buildbot properties: 05:51:24 INFO - { 05:51:24 INFO - "properties": { 05:51:24 INFO - "buildnumber": 8, 05:51:24 INFO - "product": "firefox", 05:51:24 INFO - "script_repo_revision": "production", 05:51:24 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 05:51:24 INFO - "repository": "", 05:51:24 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 05:51:24 INFO - "buildid": "20151120034636", 05:51:24 INFO - "slavename": "t-yosemite-r7-0038", 05:51:24 INFO - "pgo_build": "False", 05:51:24 INFO - "basedir": "/builds/slave/test", 05:51:24 INFO - "project": "", 05:51:24 INFO - "platform": "yosemite_r7", 05:51:24 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 05:51:24 INFO - "slavebuilddir": "test", 05:51:24 INFO - "scheduler": "tests-fx-team-macosx64-talos", 05:51:24 INFO - "branch": "fx-team", 05:51:24 INFO - "repo_path": "integration/fx-team", 05:51:24 INFO - "stage_platform": "macosx64", 05:51:24 INFO - "builduid": "89040fbae0d44899b170b2098a02271b", 05:51:24 INFO - "revision": "2316f6179102f01468d577dfb13d074a85689a27" 05:51:24 INFO - }, 05:51:24 INFO - "sourcestamp": { 05:51:24 INFO - "repository": "", 05:51:24 INFO - "hasPatch": false, 05:51:24 INFO - "project": "", 05:51:24 INFO - "branch": "fx-team-macosx64-talos", 05:51:24 INFO - "changes": [ 05:51:24 INFO - { 05:51:24 INFO - "category": null, 05:51:24 INFO - "files": [ 05:51:24 INFO - { 05:51:24 INFO - "url": null, 05:51:24 INFO - "name": "https://queue.taskcluster.net/v1/task/dzXSc70PTIC5AYxLMqMDlA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 05:51:24 INFO - } 05:51:24 INFO - ], 05:51:24 INFO - "repository": "", 05:51:24 INFO - "rev": "2316f6179102f01468d577dfb13d074a85689a27", 05:51:24 INFO - "who": "georg.fritzsche@googlemail.com", 05:51:24 INFO - "when": 1448024979, 05:51:24 INFO - "number": 6688321, 05:51:24 INFO - "comments": "Bug 1226178 - Fix deprecated octal literals warnings in Telemetry tests. r=gfritzsche", 05:51:24 INFO - "project": "", 05:51:24 INFO - "at": "Fri 20 Nov 2015 05:09:39", 05:51:24 INFO - "branch": "fx-team-macosx64-talos", 05:51:24 INFO - "revlink": "", 05:51:24 INFO - "properties": [ 05:51:24 INFO - [ 05:51:24 INFO - "buildid", 05:51:24 INFO - "20151120034636", 05:51:24 INFO - "Change" 05:51:24 INFO - ], 05:51:24 INFO - [ 05:51:24 INFO - "builduid", 05:51:24 INFO - "89040fbae0d44899b170b2098a02271b", 05:51:24 INFO - "Change" 05:51:24 INFO - ], 05:51:24 INFO - [ 05:51:24 INFO - "pgo_build", 05:51:24 INFO - "False", 05:51:24 INFO - "Change" 05:51:24 INFO - ] 05:51:24 INFO - ], 05:51:24 INFO - "revision": "2316f6179102f01468d577dfb13d074a85689a27" 05:51:24 INFO - } 05:51:24 INFO - ], 05:51:24 INFO - "revision": "2316f6179102f01468d577dfb13d074a85689a27" 05:51:24 INFO - } 05:51:24 INFO - } 05:51:24 INFO - Found installer url https://queue.taskcluster.net/v1/task/dzXSc70PTIC5AYxLMqMDlA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 05:51:24 INFO - Running post-action listener: _resource_record_post_action 05:51:24 INFO - ##### 05:51:24 INFO - ##### Running download-and-extract step. 05:51:24 INFO - ##### 05:51:24 INFO - Running pre-action listener: _resource_record_pre_action 05:51:24 INFO - Running main action method: download_and_extract 05:51:24 INFO - mkdir: /builds/slave/test/build/tests 05:51:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:51:24 INFO - https://queue.taskcluster.net/v1/task/dzXSc70PTIC5AYxLMqMDlA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 05:51:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dzXSc70PTIC5AYxLMqMDlA/artifacts/public/build/test_packages.json 05:51:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dzXSc70PTIC5AYxLMqMDlA/artifacts/public/build/test_packages.json 05:51:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dzXSc70PTIC5AYxLMqMDlA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 05:51:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dzXSc70PTIC5AYxLMqMDlA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 05:51:25 INFO - Downloaded 1149 bytes. 05:51:25 INFO - Reading from file /builds/slave/test/build/test_packages.json 05:51:25 INFO - Using the following test package requirements: 05:51:25 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 05:51:25 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:51:25 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 05:51:25 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:51:25 INFO - u'jsshell-mac.zip'], 05:51:25 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:51:25 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 05:51:25 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 05:51:25 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:51:25 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 05:51:25 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:51:25 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 05:51:25 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:51:25 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 05:51:25 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 05:51:25 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:51:25 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 05:51:25 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:51:25 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')]} 05:51:25 INFO - https://queue.taskcluster.net/v1/task/dzXSc70PTIC5AYxLMqMDlA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:51:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dzXSc70PTIC5AYxLMqMDlA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:51:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dzXSc70PTIC5AYxLMqMDlA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:51:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dzXSc70PTIC5AYxLMqMDlA/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 05:51:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dzXSc70PTIC5AYxLMqMDlA/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 05:51:31 INFO - Downloaded 17525126 bytes. 05:51:31 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 05:51:31 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:51:31 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 05:51:34 INFO - Return code: 0 05:51:34 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 05:51:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:51:34 INFO - https://queue.taskcluster.net/v1/task/dzXSc70PTIC5AYxLMqMDlA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:51:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dzXSc70PTIC5AYxLMqMDlA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:51:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dzXSc70PTIC5AYxLMqMDlA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:51:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dzXSc70PTIC5AYxLMqMDlA/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 05:51:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dzXSc70PTIC5AYxLMqMDlA/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 05:51:35 INFO - Downloaded 17525126 bytes. 05:51:35 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 05:51:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:51:35 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 05:51:38 INFO - Return code: 0 05:51:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:51:38 INFO - https://queue.taskcluster.net/v1/task/dzXSc70PTIC5AYxLMqMDlA/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 05:51:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dzXSc70PTIC5AYxLMqMDlA/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 05:51:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dzXSc70PTIC5AYxLMqMDlA/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 05:51:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dzXSc70PTIC5AYxLMqMDlA/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 05:51:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dzXSc70PTIC5AYxLMqMDlA/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 05:51:39 INFO - Downloaded 11130997 bytes. 05:51:39 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 05:51:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 05:51:39 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 05:51:39 INFO - Return code: 0 05:51:39 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')]} 05:51:39 INFO - https://queue.taskcluster.net/v1/task/dzXSc70PTIC5AYxLMqMDlA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 05:51:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dzXSc70PTIC5AYxLMqMDlA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 05:51:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dzXSc70PTIC5AYxLMqMDlA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 05:51:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dzXSc70PTIC5AYxLMqMDlA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 05:51:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dzXSc70PTIC5AYxLMqMDlA/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 05:51:43 INFO - Downloaded 109413326 bytes. 05:51:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dzXSc70PTIC5AYxLMqMDlA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 05:51:43 INFO - mkdir: /builds/slave/test/properties 05:51:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:51:43 INFO - Writing to file /builds/slave/test/properties/build_url 05:51:43 INFO - Contents: 05:51:43 INFO - build_url:https://queue.taskcluster.net/v1/task/dzXSc70PTIC5AYxLMqMDlA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 05:51:43 INFO - Running post-action listener: _resource_record_post_action 05:51:43 INFO - Running post-action listener: set_extra_try_arguments 05:51:43 INFO - ##### 05:51:43 INFO - ##### Running populate-webroot step. 05:51:43 INFO - ##### 05:51:43 INFO - Running pre-action listener: _resource_record_pre_action 05:51:43 INFO - Running main action method: populate_webroot 05:51:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:51:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:51:43 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 05:51:43 INFO - '../fennec_ids.txt'], 05:51:43 INFO - 'tests': ['tcheck2']}, 05:51:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:51:43 INFO - '--tppagecycles', 05:51:43 INFO - '7'], 05:51:43 INFO - 'tests': ['tsvgm']}}, 05:51:43 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:51:43 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:51:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:51:43 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:51:43 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:51:43 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:51:43 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:51:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:51:43 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:51:43 INFO - 'talos_options': ['--e10s'], 05:51:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:51:43 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:51:43 INFO - 'tests': ['damp', 'tps']}, 05:51:43 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:51:43 INFO - 'talos_options': ['--e10s'], 05:51:43 INFO - 'tests': ['damp', 'tps']}, 05:51:43 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:51:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:51:43 INFO - 'other': {'tests': ['a11yr', 05:51:43 INFO - 'ts_paint', 05:51:43 INFO - 'tpaint', 05:51:43 INFO - 'sessionrestore', 05:51:43 INFO - 'sessionrestore_no_auto_restore']}, 05:51:43 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:51:43 INFO - 'tests': ['a11yr', 05:51:43 INFO - 'ts_paint', 05:51:43 INFO - 'tpaint', 05:51:43 INFO - 'sessionrestore', 05:51:43 INFO - 'sessionrestore_no_auto_restore']}, 05:51:43 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:51:43 INFO - 'tests': ['a11yr', 05:51:43 INFO - 'ts_paint', 05:51:43 INFO - 'tpaint', 05:51:43 INFO - 'sessionrestore', 05:51:43 INFO - 'sessionrestore_no_auto_restore']}, 05:51:43 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:51:43 INFO - 'tests': ['a11yr', 05:51:43 INFO - 'ts_paint', 05:51:43 INFO - 'tpaint', 05:51:43 INFO - 'sessionrestore', 05:51:43 INFO - 'sessionrestore_no_auto_restore']}, 05:51:43 INFO - 'other_l64': {'tests': ['a11yr', 05:51:43 INFO - 'ts_paint', 05:51:43 INFO - 'tpaint', 05:51:43 INFO - 'sessionrestore', 05:51:43 INFO - 'sessionrestore_no_auto_restore']}, 05:51:43 INFO - 'other_nol64': {'tests': ['a11yr', 05:51:43 INFO - 'ts_paint', 05:51:43 INFO - 'tpaint', 05:51:43 INFO - 'sessionrestore', 05:51:43 INFO - 'sessionrestore_no_auto_restore']}, 05:51:43 INFO - 'svgr': {'tests': ['tsvgx', 05:51:43 INFO - 'tsvgr_opacity', 05:51:43 INFO - 'tart', 05:51:43 INFO - 'tscrollx', 05:51:43 INFO - 'cart']}, 05:51:43 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:51:43 INFO - 'tests': ['tsvgx', 05:51:43 INFO - 'tsvgr_opacity', 05:51:43 INFO - 'tart', 05:51:43 INFO - 'tscrollx', 05:51:43 INFO - 'cart']}, 05:51:43 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:51:43 INFO - 'tests': ['tp5o']}, 05:51:43 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:51:43 INFO - 'talos_options': ['--e10s'], 05:51:43 INFO - 'tests': ['tp5o']}, 05:51:43 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:51:43 INFO - 'talos_options': ['--xperf_path', 05:51:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:51:43 INFO - 'tests': ['tp5n']}, 05:51:43 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:51:43 INFO - 'talos_options': ['--e10s', 05:51:43 INFO - '--xperf_path', 05:51:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:51:43 INFO - 'tests': ['tp5n']}}, 05:51:43 INFO - 'talos.zip': {'path': '', 05:51:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:51:43 INFO - Running post-action listener: _resource_record_post_action 05:51:43 INFO - ##### 05:51:43 INFO - ##### Running create-virtualenv step. 05:51:43 INFO - ##### 05:51:43 INFO - Running pre-action listener: _resource_record_pre_action 05:51:43 INFO - Running main action method: create_virtualenv 05:51:43 INFO - Creating virtualenv /builds/slave/test/build/venv 05:51:43 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 05:51:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:51:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:51:43 INFO - Using real prefix '/tools/python27' 05:51:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:51:43 INFO - Installing distribute.............................................................................................................................................................................................done. 05:51:46 INFO - Installing pip.................done. 05:51:46 INFO - Return code: 0 05:51:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:51:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:51:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:51:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:51:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:51:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:46 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 0x1058e7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1058c4228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f83e3d93180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10580b9f0>, '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 0x10556adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1057fe8c8>, '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.A2KxRRwelS/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.UzyfVLRTNJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:51:46 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 05:51:46 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 05:51:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.A2KxRRwelS/Render', 05:51:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:51:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:51:46 INFO - 'HOME': '/Users/cltbld', 05:51:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:51:46 INFO - 'LOGNAME': 'cltbld', 05:51:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:51:46 INFO - 'MOZ_NO_REMOTE': '1', 05:51:46 INFO - 'NO_EM_RESTART': '1', 05:51:46 INFO - 'PAGER': '/bin/cat', 05:51:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:51:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:51:46 INFO - 'PWD': '/builds/slave/test', 05:51:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:51:46 INFO - 'SHELL': '/bin/bash', 05:51:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UzyfVLRTNJ/Listeners', 05:51:46 INFO - 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', 05:51:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:51:46 INFO - 'USER': 'cltbld', 05:51:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:51:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:51:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:51:46 INFO - 'XPC_FLAGS': '0x0', 05:51:46 INFO - 'XPC_SERVICE_NAME': '0', 05:51:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:51:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:51:47 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 05:51:47 INFO - Cleaning up... 05:51:47 INFO - Return code: 0 05:51:47 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:51: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')]} 05:51:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:51:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51: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')]} 05:51:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:51:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:47 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 0x1058e7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1058c4228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f83e3d93180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10580b9f0>, '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 0x10556adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1057fe8c8>, '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.A2KxRRwelS/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.UzyfVLRTNJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:51:47 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 05:51:47 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 05:51:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.A2KxRRwelS/Render', 05:51:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:51:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:51:47 INFO - 'HOME': '/Users/cltbld', 05:51:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:51:47 INFO - 'LOGNAME': 'cltbld', 05:51:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:51:47 INFO - 'MOZ_NO_REMOTE': '1', 05:51:47 INFO - 'NO_EM_RESTART': '1', 05:51:47 INFO - 'PAGER': '/bin/cat', 05:51:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:51:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:51:47 INFO - 'PWD': '/builds/slave/test', 05:51:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:51:47 INFO - 'SHELL': '/bin/bash', 05:51:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UzyfVLRTNJ/Listeners', 05:51:47 INFO - 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', 05:51:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:51:47 INFO - 'USER': 'cltbld', 05:51:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:51:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:51:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:51:47 INFO - 'XPC_FLAGS': '0x0', 05:51:47 INFO - 'XPC_SERVICE_NAME': '0', 05:51:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:51:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:51:47 INFO - Downloading/unpacking psutil>=0.7.1 05:51:47 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 05:51:47 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 05:51:47 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 05:51:47 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 05:51:47 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 05:51:47 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 05:51:49 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 05:51:49 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 05:51:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:51:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:51:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:51:49 INFO - Installing collected packages: psutil 05:51:49 INFO - Running setup.py install for psutil 05:51:50 INFO - building 'psutil._psutil_osx' extension 05:51:50 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 05:51:50 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 05:51:50 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 05:51:50 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 05:51:50 INFO - building 'psutil._psutil_posix' extension 05:51:50 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 05:51:50 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:51:50 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:51:50 INFO - ^ 05:51:50 INFO - 1 warning generated. 05:51:50 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 05:51:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:51:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:51:51 INFO - Successfully installed psutil 05:51:51 INFO - Cleaning up... 05:51:51 INFO - Return code: 0 05:51:51 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:51:51 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')]} 05:51:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:51:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:51 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')]} 05:51:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:51:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:51 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 0x1058e7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1058c4228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f83e3d93180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10580b9f0>, '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 0x10556adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1057fe8c8>, '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.A2KxRRwelS/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.UzyfVLRTNJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:51:51 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 05:51:51 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 05:51:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.A2KxRRwelS/Render', 05:51:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:51:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:51:51 INFO - 'HOME': '/Users/cltbld', 05:51:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:51:51 INFO - 'LOGNAME': 'cltbld', 05:51:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:51:51 INFO - 'MOZ_NO_REMOTE': '1', 05:51:51 INFO - 'NO_EM_RESTART': '1', 05:51:51 INFO - 'PAGER': '/bin/cat', 05:51:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:51:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:51:51 INFO - 'PWD': '/builds/slave/test', 05:51:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:51:51 INFO - 'SHELL': '/bin/bash', 05:51:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UzyfVLRTNJ/Listeners', 05:51:51 INFO - 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', 05:51:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:51:51 INFO - 'USER': 'cltbld', 05:51:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:51:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:51:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:51:51 INFO - 'XPC_FLAGS': '0x0', 05:51:51 INFO - 'XPC_SERVICE_NAME': '0', 05:51:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:51:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:51:51 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:51:51 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 05:51:51 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 05:51:51 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 05:51:51 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 05:51:51 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 05:51:51 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 05:51:53 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:51:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 05:51:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:51:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:51:53 INFO - Installing collected packages: mozsystemmonitor 05:51:53 INFO - Running setup.py install for mozsystemmonitor 05:51:53 INFO - Successfully installed mozsystemmonitor 05:51:53 INFO - Cleaning up... 05:51:53 INFO - Return code: 0 05:51:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:51:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:51:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:51:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:51:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:51:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:53 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 0x1058e7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1058c4228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f83e3d93180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10580b9f0>, '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 0x10556adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1057fe8c8>, '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.A2KxRRwelS/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.UzyfVLRTNJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:51:53 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 05:51:53 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 05:51:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.A2KxRRwelS/Render', 05:51:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:51:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:51:53 INFO - 'HOME': '/Users/cltbld', 05:51:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:51:53 INFO - 'LOGNAME': 'cltbld', 05:51:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:51:53 INFO - 'MOZ_NO_REMOTE': '1', 05:51:53 INFO - 'NO_EM_RESTART': '1', 05:51:53 INFO - 'PAGER': '/bin/cat', 05:51:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:51:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:51:53 INFO - 'PWD': '/builds/slave/test', 05:51:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:51:53 INFO - 'SHELL': '/bin/bash', 05:51:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UzyfVLRTNJ/Listeners', 05:51:53 INFO - 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', 05:51:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:51:53 INFO - 'USER': 'cltbld', 05:51:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:51:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:51:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:51:53 INFO - 'XPC_FLAGS': '0x0', 05:51:53 INFO - 'XPC_SERVICE_NAME': '0', 05:51:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:51:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:51:54 INFO - Downloading/unpacking blobuploader==1.2.4 05:51:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:51:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:51:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:51:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:51:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:51:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:51:56 INFO - Downloading blobuploader-1.2.4.tar.gz 05:51:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 05:51:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:51:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:51: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 05:51: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 05:51: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 05:51: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 05:51: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 05:51: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 05:51:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 05:51:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:51:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:51: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 05:51: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 05:51: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 05:51: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 05:51: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 05:51: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 05:51:57 INFO - Downloading docopt-0.6.1.tar.gz 05:51:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 05:51:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:51:57 INFO - Installing collected packages: blobuploader, requests, docopt 05:51:57 INFO - Running setup.py install for blobuploader 05:51:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:51:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:51:57 INFO - Running setup.py install for requests 05:51:58 INFO - Running setup.py install for docopt 05:51:58 INFO - Successfully installed blobuploader requests docopt 05:51:58 INFO - Cleaning up... 05:51:58 INFO - Return code: 0 05:51:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:51:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:51:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:51:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:51:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:51:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:58 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 0x1058e7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1058c4228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f83e3d93180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10580b9f0>, '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 0x10556adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1057fe8c8>, '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.A2KxRRwelS/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.UzyfVLRTNJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:51:58 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 05:51:58 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 05:51:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.A2KxRRwelS/Render', 05:51:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:51:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:51:58 INFO - 'HOME': '/Users/cltbld', 05:51:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:51:58 INFO - 'LOGNAME': 'cltbld', 05:51:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:51:58 INFO - 'MOZ_NO_REMOTE': '1', 05:51:58 INFO - 'NO_EM_RESTART': '1', 05:51:58 INFO - 'PAGER': '/bin/cat', 05:51:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:51:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:51:58 INFO - 'PWD': '/builds/slave/test', 05:51:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:51:58 INFO - 'SHELL': '/bin/bash', 05:51:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UzyfVLRTNJ/Listeners', 05:51:58 INFO - 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', 05:51:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:51:58 INFO - 'USER': 'cltbld', 05:51:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:51:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:51:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:51:58 INFO - 'XPC_FLAGS': '0x0', 05:51:58 INFO - 'XPC_SERVICE_NAME': '0', 05:51:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:51:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:51:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:51:58 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-AiGizI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:51:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:51:58 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-OymDOH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:51:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:51:58 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-MP_IY0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:51:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:51:58 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-etLblp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:51:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:51:58 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-Do_4k7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:51:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:51:59 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-mJakoP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:51:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:51:59 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-RDkUAz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:51:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:51:59 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-FLY9Xj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:51:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:51:59 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-tILVfa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:51:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:51:59 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-RHou_E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:51:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:51:59 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-ew6A8v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:51:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:51:59 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-CkPwQM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:51:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:51:59 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-8PNnl2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:51:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:51:59 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-n7IISb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:51:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:51:59 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-RasaFE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:52:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:52:00 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-kCME9a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:52:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:52:00 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-wU6S8Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:52:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:52:00 INFO - Running setup.py install for manifestparser 05:52:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:52:00 INFO - Running setup.py install for mozcrash 05:52:00 INFO - Running setup.py install for mozdebug 05:52:00 INFO - Running setup.py install for mozdevice 05:52:00 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:52:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:52:00 INFO - Running setup.py install for mozfile 05:52:01 INFO - Running setup.py install for mozhttpd 05:52:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:52:01 INFO - Running setup.py install for mozinfo 05:52:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:52:01 INFO - Running setup.py install for mozInstall 05:52:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:52:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:52:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:52:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:52:01 INFO - Running setup.py install for mozleak 05:52:01 INFO - Running setup.py install for mozlog 05:52:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:52:01 INFO - Running setup.py install for moznetwork 05:52:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:52:01 INFO - Running setup.py install for mozprocess 05:52:02 INFO - Running setup.py install for mozprofile 05:52:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:52:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:52:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:52:02 INFO - Running setup.py install for mozrunner 05:52:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:52:02 INFO - Running setup.py install for mozscreenshot 05:52:02 INFO - Running setup.py install for moztest 05:52:02 INFO - Running setup.py install for mozversion 05:52:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:52:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:52:02 INFO - Cleaning up... 05:52:02 INFO - Return code: 0 05:52:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:52:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:52:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:52:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:52:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:52:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:02 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 0x1058e7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1058c4228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f83e3d93180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10580b9f0>, '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 0x10556adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1057fe8c8>, '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.A2KxRRwelS/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.UzyfVLRTNJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:52:02 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 05:52:02 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 05:52:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.A2KxRRwelS/Render', 05:52:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:52:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:52:02 INFO - 'HOME': '/Users/cltbld', 05:52:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:52:02 INFO - 'LOGNAME': 'cltbld', 05:52:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:52:02 INFO - 'MOZ_NO_REMOTE': '1', 05:52:02 INFO - 'NO_EM_RESTART': '1', 05:52:02 INFO - 'PAGER': '/bin/cat', 05:52:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:52:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:52:02 INFO - 'PWD': '/builds/slave/test', 05:52:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:52:02 INFO - 'SHELL': '/bin/bash', 05:52:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UzyfVLRTNJ/Listeners', 05:52:02 INFO - 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', 05:52:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:52:02 INFO - 'USER': 'cltbld', 05:52:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:52:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:52:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:52:02 INFO - 'XPC_FLAGS': '0x0', 05:52:02 INFO - 'XPC_SERVICE_NAME': '0', 05:52:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:52:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:52:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:52:03 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-SYsl80-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:52:03 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)) 05:52:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:52:03 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-7ND4pU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:52:03 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)) 05:52:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:52:03 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-yFwKaJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:52:03 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)) 05:52:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:52:03 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-BSqmU7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:52:03 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)) 05:52:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:52:03 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-l4Oqkm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:52:03 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)) 05:52:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:52:03 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-z5Ho0x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:52:03 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)) 05:52:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:52:03 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-SVG3h9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:52:03 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)) 05:52:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:52:03 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-ntMmiD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:52:04 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)) 05:52:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:52:04 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-Vow0rI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:52:04 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)) 05:52:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:52:04 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-GaBmwG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:52:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:52:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:52:04 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-nUCnoT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:52:04 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)) 05:52:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:52:04 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-lb6ZUc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:52:04 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)) 05:52:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:52:04 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-lWPBd9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:52:04 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)) 05:52:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:52:04 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-3fFZ74-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:52:04 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)) 05:52:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:52:04 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-XsA45B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:52:04 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)) 05:52:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:52:04 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-cGK9KN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:52:04 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)) 05:52:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:52:04 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-LDCxep-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:52:05 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)) 05:52:05 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)) 05:52:05 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)) 05:52:05 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)) 05:52:05 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)) 05:52:05 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)) 05:52:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:52: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 05:52: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 05:52: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 05:52: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 05:52: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 05:52: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 05:52:07 INFO - Downloading blessings-1.5.1.tar.gz 05:52:07 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 05:52:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:52:07 INFO - Installing collected packages: blessings 05:52:07 INFO - Running setup.py install for blessings 05:52:07 INFO - Successfully installed blessings 05:52:07 INFO - Cleaning up... 05:52:07 INFO - Return code: 0 05:52:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:52:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:52:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:52:07 INFO - Reading from file tmpfile_stdout 05:52:07 INFO - Current package versions: 05:52:07 INFO - blessings == 1.5.1 05:52:07 INFO - blobuploader == 1.2.4 05:52:07 INFO - docopt == 0.6.1 05:52:07 INFO - manifestparser == 1.1 05:52:07 INFO - mozInstall == 1.12 05:52:07 INFO - mozcrash == 0.16 05:52:07 INFO - mozdebug == 0.1 05:52:07 INFO - mozdevice == 0.47 05:52:07 INFO - mozfile == 1.2 05:52:07 INFO - mozhttpd == 0.7 05:52:07 INFO - mozinfo == 0.9 05:52:07 INFO - mozleak == 0.1 05:52:07 INFO - mozlog == 3.0 05:52:07 INFO - moznetwork == 0.27 05:52:07 INFO - mozprocess == 0.22 05:52:07 INFO - mozprofile == 0.27 05:52:07 INFO - mozrunner == 6.11 05:52:07 INFO - mozscreenshot == 0.1 05:52:07 INFO - mozsystemmonitor == 0.0 05:52:07 INFO - moztest == 0.7 05:52:07 INFO - mozversion == 1.4 05:52:07 INFO - psutil == 3.1.1 05:52:07 INFO - requests == 1.2.3 05:52:07 INFO - wsgiref == 0.1.2 05:52:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:52: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')]} 05:52:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:52:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52: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')]} 05:52:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:52:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:07 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 0x1058e7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1058c4228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f83e3d93180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10580b9f0>, '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 0x10556adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1057fe8c8>, '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.A2KxRRwelS/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.UzyfVLRTNJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:52:07 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 05:52:07 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 05:52:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.A2KxRRwelS/Render', 05:52:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:52:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:52:07 INFO - 'HOME': '/Users/cltbld', 05:52:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:52:07 INFO - 'LOGNAME': 'cltbld', 05:52:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:52:07 INFO - 'MOZ_NO_REMOTE': '1', 05:52:07 INFO - 'NO_EM_RESTART': '1', 05:52:07 INFO - 'PAGER': '/bin/cat', 05:52:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:52:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:52:07 INFO - 'PWD': '/builds/slave/test', 05:52:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:52:07 INFO - 'SHELL': '/bin/bash', 05:52:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UzyfVLRTNJ/Listeners', 05:52:07 INFO - 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', 05:52:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:52:07 INFO - 'USER': 'cltbld', 05:52:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:52:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:52:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:52:07 INFO - 'XPC_FLAGS': '0x0', 05:52:07 INFO - 'XPC_SERVICE_NAME': '0', 05:52:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:52:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:52:08 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)) 05:52:08 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)) 05:52:08 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)) 05:52:08 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)) 05:52:08 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)) 05:52:08 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)) 05:52:08 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)) 05:52:08 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)) 05:52:08 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)) 05:52:08 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)) 05:52:08 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)) 05:52:08 INFO - Cleaning up... 05:52:08 INFO - Return code: 0 05:52:08 INFO - Running post-action listener: _resource_record_post_action 05:52:08 INFO - Running post-action listener: _start_resource_monitoring 05:52:08 INFO - Starting resource monitoring. 05:52:08 INFO - ##### 05:52:08 INFO - ##### Running install step. 05:52:08 INFO - ##### 05:52:08 INFO - Running pre-action listener: _resource_record_pre_action 05:52:08 INFO - Running main action method: install 05:52:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:52:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:52:08 INFO - Reading from file tmpfile_stdout 05:52:08 INFO - Detecting whether we're running mozinstall >=1.0... 05:52:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:52:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:52:08 INFO - Reading from file tmpfile_stdout 05:52:08 INFO - Output received: 05:52:08 INFO - Usage: mozinstall [options] installer 05:52:08 INFO - Options: 05:52:08 INFO - -h, --help show this help message and exit 05:52:08 INFO - -d DEST, --destination=DEST 05:52:08 INFO - Directory to install application into. [default: 05:52:08 INFO - "/builds/slave/test"] 05:52:08 INFO - --app=APP Application being installed. [default: firefox] 05:52:08 INFO - mkdir: /builds/slave/test/build/application 05:52:08 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'] 05:52:08 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 05:52:39 INFO - Reading from file tmpfile_stdout 05:52:39 INFO - Output received: 05:52:39 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 05:52:39 INFO - Running post-action listener: _resource_record_post_action 05:52:39 INFO - ##### 05:52:39 INFO - ##### Running run-tests step. 05:52:39 INFO - ##### 05:52:39 INFO - Running pre-action listener: _resource_record_pre_action 05:52:39 INFO - Running main action method: run_tests 05:52:39 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:52:39 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:52:39 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:52:39 INFO - 2015-11-20 05:52:39.162 screenresolution[1740:9264] starting screenresolution argv=screenresolution get 05:52:39 INFO - 2015-11-20 05:52:39.165 screenresolution[1740:9264] Display 0: 1600x1200x32@60 05:52:39 INFO - 2015-11-20 05:52:39.170 screenresolution[1741:9267] starting screenresolution argv=screenresolution list 05:52:39 INFO - Available Modes on Display 0 05:52:39 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:52:39 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:52:39 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:52:39 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:52:39 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:52:39 INFO - Intel Iris: 05:52:39 INFO - Chipset Model: Intel Iris 05:52:39 INFO - Type: GPU 05:52:39 INFO - Bus: Built-In 05:52:39 INFO - VRAM (Dynamic, Max): 1536 MB 05:52:39 INFO - Vendor: Intel (0x8086) 05:52:39 INFO - Device ID: 0x0a2e 05:52:39 INFO - Revision ID: 0x0009 05:52:39 INFO - Displays: 05:52:39 INFO - Display: 05:52:39 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:52:39 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:52:39 INFO - Display Serial Number: 1600x1200 60 05:52:39 INFO - Main Display: Yes 05:52:39 INFO - Mirror: Off 05:52:39 INFO - Online: Yes 05:52:39 INFO - Rotation: Supported 05:52:39 INFO - Return code: 0 05:52:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:52:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:52:39 INFO - Python 2.7.3 05:52:39 INFO - Return code: 0 05:52:39 INFO - grabbing minidump binary from tooltool 05:52:39 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')]} 05:52:39 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 0x10580b9f0>, '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 0x10556adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1057fe8c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:52:39 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 05:52:39 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 05:52:39 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:52:39 INFO - Return code: 0 05:52:39 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:52:39 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:52:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:52:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:52:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:52:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dzXSc70PTIC5AYxLMqMDlA/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0038', '--webServer', 'localhost'] in /builds/slave/test/build 05:52:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/dzXSc70PTIC5AYxLMqMDlA/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0038 --webServer localhost 05:52:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.A2KxRRwelS/Render', 05:52:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:52:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:52:39 INFO - 'HOME': '/Users/cltbld', 05:52:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:52:39 INFO - 'LOGNAME': 'cltbld', 05:52:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:52:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:52:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:52:39 INFO - 'MOZ_NO_REMOTE': '1', 05:52:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:52:39 INFO - 'NO_EM_RESTART': '1', 05:52:39 INFO - 'PAGER': '/bin/cat', 05:52:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:52:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:52:39 INFO - 'PWD': '/builds/slave/test', 05:52:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:52:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:52:39 INFO - 'SHELL': '/bin/bash', 05:52:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UzyfVLRTNJ/Listeners', 05:52:39 INFO - 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', 05:52:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:52:39 INFO - 'USER': 'cltbld', 05:52:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:52:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:52:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:52:39 INFO - 'XPC_FLAGS': '0x0', 05:52:39 INFO - 'XPC_SERVICE_NAME': '0', 05:52:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:52:39 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dzXSc70PTIC5AYxLMqMDlA/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0038', '--webServer', 'localhost'] with output_timeout 3600 05:52:39 INFO - mozversion INFO | application_buildid: 20151120034636 05:52:39 INFO - mozversion INFO | application_changeset: 2316f6179102f01468d577dfb13d074a85689a27 05:52:39 INFO - mozversion INFO | application_display_name: Nightly 05:52:39 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:52:39 INFO - mozversion INFO | application_name: Firefox 05:52:39 INFO - mozversion INFO | application_remotingname: firefox 05:52:39 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 05:52:39 INFO - mozversion INFO | application_vendor: Mozilla 05:52:39 INFO - mozversion INFO | application_version: 45.0a1 05:52:39 INFO - mozversion INFO | platform_buildid: 20151120034636 05:52:39 INFO - mozversion INFO | platform_changeset: 2316f6179102f01468d577dfb13d074a85689a27 05:52:39 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 05:52:39 INFO - mozversion INFO | platform_version: 45.0a1 05:52:39 INFO - 2015-11-20 05:52:39,721 DEBUG : using testdate: 1448027559 05:52:39 INFO - 2015-11-20 05:52:39,721 DEBUG : actual date: 1448027559 05:52:40 INFO - 2015-11-20 05:52:40,203 INFO : starting webserver on 'localhost:49305' 05:52:40 INFO - 2015-11-20 05:52:40,204 INFO : Starting test suite t-yosemite-r7-0038 05:52:40 INFO - 2015-11-20 05:52:40,204 INFO : Starting test dromaeo_css 05:52:40 INFO - 2015-11-20 05:52:40,204 DEBUG : operating with platform_type : mac_ 05:52:40 INFO - 2015-11-20 05:52:40,205 INFO : Initialising browser for dromaeo_css test... 05:52:40 INFO - 2015-11-20 05:52:40,218 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/tmpVqnT9H/profile http://localhost:49305/getInfo.html 05:52:42 INFO - 2015-11-20 05:52:42,373 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:52:42 INFO - 2015-11-20 05:52:42,373 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:52:42 INFO - 2015-11-20 05:52:42,373 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 05:52:42 INFO - 2015-11-20 05:52:42,374 DEBUG : BROWSER_OUTPUT: __metrics 05:52:42 INFO - 2015-11-20 05:52:42,381 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:52:42 INFO - 2015-11-20 05:52:42,989 INFO : Browser initialized. 05:52:42 INFO - 2015-11-20 05:52:42,989 INFO : Running cycle 1/1 for dromaeo_css test... 05:52:42 INFO - 2015-11-20 05:52:42,989 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/tmpVqnT9H/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:52:54 INFO - 2015-11-20 05:52:54,779 DEBUG : BROWSER_OUTPUT: RSS: Main: 226344960 05:52:54 INFO - 2015-11-20 05:52:54,780 DEBUG : BROWSER_OUTPUT: 05:53:45 INFO - 2015-11-20 05:53:45,611 DEBUG : BROWSER_OUTPUT: 1448027625606 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] 05:55:57 INFO - 2015-11-20 05:55:57,456 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49305/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49305/tests/dromaeo/cssquery-ext.html) 05:55:58 INFO - 2015-11-20 05:55:58,627 DEBUG : BROWSER_OUTPUT: RSS: Main: 340430848 05:55:58 INFO - 2015-11-20 05:55:58,628 DEBUG : BROWSER_OUTPUT: 05:59:01 INFO - 2015-11-20 05:59:01,341 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49305/tests/dromaeo/cssquery-ext.html (next: http://localhost:49305/tests/dromaeo/cssquery-jquery.html) 05:59:01 INFO - 2015-11-20 05:59:01,931 DEBUG : BROWSER_OUTPUT: RSS: Main: 360009728 05:59:01 INFO - 2015-11-20 05:59:01,931 DEBUG : BROWSER_OUTPUT: 06:02:03 INFO - 2015-11-20 06:02:03,961 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49305/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49305/tests/dromaeo/cssquery-mootools.html) 06:02:04 INFO - 2015-11-20 06:02:04,545 DEBUG : BROWSER_OUTPUT: RSS: Main: 341045248 06:02:04 INFO - 2015-11-20 06:02:04,546 DEBUG : BROWSER_OUTPUT: 06:05:06 INFO - 2015-11-20 06:05:06,642 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49305/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49305/tests/dromaeo/cssquery-prototype.html) 06:05:07 INFO - 2015-11-20 06:05:07,233 DEBUG : BROWSER_OUTPUT: RSS: Main: 353058816 06:05:07 INFO - 2015-11-20 06:05:07,233 DEBUG : BROWSER_OUTPUT: 06:08:10 INFO - 2015-11-20 06:08:10,214 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49305/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49305/tests/dromaeo/cssquery-yui.html) 06:08:10 INFO - 2015-11-20 06:08:10,840 DEBUG : BROWSER_OUTPUT: RSS: Main: 321097728 06:08:10 INFO - 2015-11-20 06:08:10,840 DEBUG : BROWSER_OUTPUT: 06:11:13 INFO - 2015-11-20 06:11:13,801 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49305/tests/dromaeo/cssquery-yui.html (next: http://localhost:49305/tests/dromaeo/cssquery-dojo.html) 06:11:14 INFO - 2015-11-20 06:11:14,059 DEBUG : BROWSER_OUTPUT: RSS: Main: 371990528 06:11:14 INFO - 2015-11-20 06:11:14,059 DEBUG : BROWSER_OUTPUT: 06:11:14 INFO - 2015-11-20 06:11:14,060 DEBUG : BROWSER_OUTPUT: __start_tp_report 06:11:14 INFO - 2015-11-20 06:11:14,060 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 06:11:14 INFO - 2015-11-20 06:11:14,060 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 06:11:14 INFO - 2015-11-20 06:11:14,060 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 06:11:14 INFO - 2015-11-20 06:11:14,060 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3449.5860496740393;3518.173229291116;3540.539729835121;3547.1132216945757;3586.51582036425;5711.942880571193;5807.070868661015;5926.377730338311;5999.82000539984;6001.8499537511525;5834.737436815343;5897.823065308037;5902.291724992996;5970.34326224115;6016.458518733313;5334.733263336837;5409.5672346212405;5419.430959749228;5432.674039557639;5445.809396671118;5453.018456677796;5453.890922181554;5458.6724796512335;5474.644148130379;5492.615516913817;5216.713080780555;5328.987492376436;5340.439253878365;5416.8104116355935;5432.99999999998;5398.352197736297;5442.945570544283;5443.646162999393;5450.236966824647;5457.5633949283965;5314.309139811839;5382.515573598395;5395.082835917903;5400.864978375533;5402.648827826179;5799.333076696192;5815.883682326372;5823.883522329572;5846.327672317695;5855.795047173371;6148.600340977822;6246.781362652286;6287.937120628781;6289.496840252768;6300.243970723543;6355.968220158869;6395.552311338208;6421.389967953037;6423.389777971085;6429.22849258092;6123.020316749344;6127.908081378783;6133.110698948627;6148.323684394713;6153.476954458832;4815.927761083586;6391.904121438182;6401.487880969511;6506.577072490273;6556.868862622721;6292.528060395397;6296.685165741695;6311.400416960381;6313.337099604475;6326.810195694136;6426.228852537632;6435.549511534147;6436.774712885027;6439.871202575922;6454.838629034311;6113.3720062487255;6180.072989051589;6232.56372053961;6256.906146407808;6309.274433440121;6262.15460912771;6340.492760579143;6349.238091429058;6364.64994425311;6374.330695276929;4895.31465594817;5101.3298295907025;5120.692758434506;5127;5158.92261616076;4392.3411488277015;4510.143072816154;4530.546945305509;4536.387587675687;4571.3600095986585;4984.202527595639;5959.106134079922;5975.223220981245;5987.6108052976415;6014.0377539593455;6363.109164716943;6384.84037899047;6423.164988551458;6437.645929473924;6446.8388290293115;5841.912371314434;5895.056790913433;5955.940440595626;5969.552283578749;5998.940010599838;4832.637552183601;5507.779688812403;5596.2165296858475;5597.244372009808;5609.298837645294;6562;6566.376194261537;6581.276059633532;6586.670666466754;6593.571417857824;6144.95535758931;6245.500359971283;6248.968755156195;6283.120363149072;6418.326075761977;6486.254080780771;6486.9351306488215;6515.804525864231;6521.934780652133;6542.084108224757;6285.811425657238;6319.46284565817;6331.96834015827;6338.714757835816;6354.968225158845;6152.661603611844;6264.123022776724;6264.874702505833;6386.201724784402;6391.424771770563;6100.217864923719;6233.438990490878;6244.438000579969;6246.312905580474;6247.843803904939;5934.109883517507;6256.906146407899;6311.495080393649;6317.96841015792;6329.49364050884;5889.5582831286965;6003.643714592294;6073.210482637229;6201.255849298113;6204.472619827366;4741.810327586858;5085.931954289641;6254.843628909313;6280.842978925563;6298.338674439301;6156.815295540961;6195.473384762346;6200.3179650237535;6201.0388389799655;6213.720382582885 06:11:14 INFO - 2015-11-20 06:11:14,064 DEBUG : BROWSER_OUTPUT: |1;ext.html;544.6245277889744;561.1162419189777;569.7663957777312;610.9827137815537;639.1850390751794;31331.060068197934;39468.60531394685;39474.605253947455;39544.60455395445;39616.20767584647;39018;42899.994000839906;43159.78420107903;43174.70475885728;43592.3461148083;7484.812879677997;8858.247049000842;9723.951380243088;9936.453495057769;9940.40357578544;8731.083236260196;12044.397780111003;12146.39268036599;12149.02807775376;12151.39243037849;11810.409479526032;11913.344766037908;11913.523459061671;11924.582639607615;11932.16474846761;8716.738497845075;8838.911610883873;11803.645890623295;11826.231294965843;11845.881541184564;8765.868511972325;11889.762204755943;11989.88010119905;12006.759864802742;12026.098042646749;39955;40323;40387.19225615501;40387.39418908719;40434;3352.3462924729442;3421.4183588789965;3608.855645774166;3752.774833509998;3992.0818211811447;24454.755452445424;30347.848260758776;30625.081247562608;30762.692373076206;31294.530582041287;2831.433713257357;2878.8560571971316;2913.46100971321;2935.897243596485;3016.622922134733;503370;505419;507480;507484;507545;58778.706106469195;59769.402305976386;59956;68986.65506672434;69562;72933.2706672937;73034.63482682552;73746;73858;73935.63032184805;13273.800892986614;15752.842471575366;15895.205239737967;15917.204139792964;15917.363305467883;12538.874611253954;12626.116171868065;12626.55807046749;12675.239485630707;12802.359882005863;17516.38692645751;21495.78504214969;21594.89202553977;21679.67480487794;21755.34733957984;8477.74566762998;9250.583723732449;9401.388909720847;9628.422294662343;9636;940.6143481172686;958.9280803939592;999.7000899730052;1030.5877648940334;1032.700516850105;28843.278918027216;29346.615177871416;29430.852845735633;29715.405691886474;29730.851345743566;1034.4879284754095;1061.946902654864;1076.7684947736118;1077.8275475923815;1169.830374595679;14406.495772648117;14594.197319147337;14699.26503674812;14862.108273503625;14907.627309317137;650757;660108.6994565092;662006;662627;663660;56555.71722141363;56978;57032.14451783227;57178.42821571731;57233.71383143058;1453.6220582648375;1460.8831293496494;1477.460726834719;1484.6140003598925;1490.970180596382;27137.457250855266;28543.28641783972;30931;31146.164457506;31521.8423907879;52220.47779522156;52836.73581632067;52852.67868303169;52911.470885290655;52942.47057529375;498588;501001;501696;502510;502755.4586681276;27600.171994840188;27958.3010424741;31612.683873160975;31991;32312.35375292528;39356.80321598374;39747.40378894377;39984.4002339971;40467;40834;33290.833545832116;34599.82700086483;34850.30299394049;34952.65047349494;34969.30061398707;29686.540564017243;36173.638263617024;39513.60486395099;39778.60221397749;40767.59232407638;37167.814160929025;38597.20391966511;40006.999825004605;40217.79891100526;40222.39666404948;26956;32785.34429311448;32831.56124796087;33013.66986330106;33071.173220669676;24188.75811241865;24368.719048119172;25142.49715005653;25144.868480918038;25900.48199035971 06:11:14 INFO - 2015-11-20 06:11:14,064 DEBUG : BROWSER_OUTPUT: |2;jquery.html;354.76408188554626;359.4643980469101;362.87118073084036;365.5595008015341;367.86021311901476;15979.280932358042;16416.17919104043;19309.420717378485;20302.593948121048;21071.789282107173;18314.35899743509;21874.343769686897;21897.795621240824;22284.66573001406;22303.77696223037;5521.69630670314;6599.977003564455;6604.2405123410945;6607.20713514379;6627.734890604394;4674.335628691647;4675.672702910798;6573.868522629545;7191.029211056519;7425.702971881118;7058.788236352918;7349.448791340644;7357.0803649543805;7359.521631093989;7382.224866389032;7238.98654188414;7275.5448910218165;7285.599292038935;7286.234945330717;7290.927090729105;5342.198670199501;5485.0949593317055;5497.202905578709;5500.42245564218;6932.341427564424;12472;12492.437840297209;12670.416197975253;12678.87321126786;12694.936525317315;1914.1864707499258;2059.6292667319876;2065.0397565132134;2089.7910208979133;2136.060133541237;9088.68189613367;9091.863622045674;11744.884235997566;13892;14608.853911460961;1682.7728256685436;1754.3596587245563;1772.1050869311043;1781.7683701118901;1781.9287228510843;82353.58823205845;84526.57736711277;86711.26577468416;97162;98917;10242.846357304647;10449.164066874631;10556.208284378703;10589.947050264853;10654.840177397346;12571.371431428392;12595.181313214613;12605.810912836314;12607.306598137007;12623.368831558386;8096.919030809617;8115.310198633064;8152.6331315090965;8156.5106093633385;8202.179782021869;8285;8529.976402831577;8583.0129535103;8588.88344515209;8648.524331161847;3965.6827453803626;4233.153369326085;4249.851255206053;4252.978735106367;4275.294576394922;1713.126305584161;1742.7124524453577;1745.746866704346;1780.5904641932168;1781.358710864088;799.476342995339;915.9358844880927;924.9630014799467;951.7573018880141;968.3899143539525;18388;18639.068046597615;19769.308074217333;20397.592048158953;20958.89520552418;963.2775418436173;1004.1615251265275;1004.5981607357115;1037.4968140451874;1060.5311643373982;10925.776895815594;11013.2841365311;11131.610393636183;11210.439478026066;11790.528378864921;731209;733773;737272;742896.1420771554;751453;122163.77836221702;122278;122445;122851.3857430725;124368.75631243571;1227.9877201228053;1233.1614502138452;1242.9813552796716;1245.5951815659766;1251.605744190577;18234;18458.35395761142;18614.324710776094;19185.232590696214;19251.614967700847;46957.765211173726;46967.530324697684;47338.28992565183;47633.809154770024;47645.52354476411;60931;60959.47601310003;61483.07775383462;62017;63318.68340658267;7615.809604759704;9335.626574937198;9506.66726664591;9628.32601717873;9641.325107242707;11171.832422513831;11547.307161570332;11568.421578921188;13529.797053044016;14989.625259368602;14005.929970350084;15458.84541154574;15895.52313430599;16388.93471924321;16455.506334809976;15516.896620676136;15784.684306314039;15882.841171588136;15942.521724348288;15984.200789960689;16261.186940653157;16330.591735206715;16528.421505247257;16603.252853621376;16779.832201677826;9780.413175209225;9863.704088877344;9872.45701486425;9900.900990990285;9928.056834600702;15691.764623530427;15920.761188582412;16130.435434759727;16149.111798851176;16218.594535136244 06:11:14 INFO - 2015-11-20 06:11:14,065 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1558.1897413345068;1562.7733978573108;1692.8899621524592;1838.3473866777294;1850.9912097906645;6856.931430685698;7481.326680598745;7882.408819338551;8189.9762529683785;8210.712625058124;8162.14297498763;8279.13069127742;8314.043884953233;8322.375821813373;8335.791605209874;2131.0623325736706;2176.804087632113;2360.858348499087;2382.7498112698177;2386.570417324881;1886.7830199527093;2189.419803751999;2332.7084114485688;2377.6909001829736;2379.119725701484;2297;2342.882855857209;2343.5078633486987;2346.9178578749747;2361.197192954395;2111.841611879115;2164.188429338998;2347.389678683546;2372.3476044087843;2374.7387787343378;2139.9786002139936;2338.9064437422485;2378.595638741418;2379.4646204604;2381.13088722615;8105.189481051907;8302.916970830274;8309.542975136364;8314.542700151489;8320.251177394064;5105.540501354859;5155.149400348938;5155.226715992631;5174;5189.455107213764;3355.7147642450423;3383.7631365804405;3510.7717998330027;3512.227309991798;3520.3135388599235;991.7024892532212;1027.5357615398027;1028.3521381529663;1069.107295408335;1078.1321036565562;10910.454477276104;10915.672529824038;10920.836187457195;10930.01629853317;10943;4342.5874541918465;4452.109578084396;4606.216943119678;4668.883277918079;4699.107169637758;9532.952335238419;9535.47554884474;9539.90460095404;9543.33196676226;9565.808683826424;4978.950210497848;4980.078685443204;4990.90018199634;5013.047520971004;5024.899502009939;4500.977495112504;4504.076664283814;4523.072770082191;4527.4340707411575;4534.183846907522;3273.7053665170247;3770.7171962102952;3837.2517359115263;3874.96125038746;3876.980615096963;1224.8530176378893;1228.729679470515;1229.7601967616408;1236.6351926181799;1244.4337826289197;1055.2613170780485;1078.9514471848786;1078.978420431587;1104.9779004420027;1396.7346204221164;7493.55038697669;7521.210272921374;7568.167501574822;7602.163761986177;7656.655450504741;501.7390956702494;507.9111155547838;513.4352212566147;513.542946777361;513.8432778002744;5750.913736293959;5833.620814647034;5849.590528663038;6082;6267.96866015667;8131.5527645978855;9757.463339516253;9829.4102353859;10022.699319020441;10023.2482563808;9843.212542996544;9923.404595724136;9938.602455901828;9959.950200248952;9982.750431239278;7655.961720191363;7818.960905195438;7829.921700782919;7851.05787305527;7853.803654908559;7724.111727151225;7741.180822506819;7752.341051010501;7763.146053934176;7768.417368697484;8639.352048596254;8944.86582701273;9080.954595226982;9084.31867609945;9132.817343652956;8998.235150012322;9055.501947392957;9101.317401194805;9132.178103970675;9215.723528293895;7189.496735228484;7354.558726476428;7356.117265928123;7357.19070902211;7359.1169059713175;7866.898634191332;7918.524888506708;7930;7934.484258523177;7941.8411631768195;7006.474514411541;7355.485116042039;7383.667734952048;7493.850122997618;7534.39724822002;7125.572465652078;7265;7321.3776828968;7388.335049845539;7435.442341824277;7361.484696071224;7395.852082958419;7401.925980740124;7405.8148546286775;7409.518381305198;6573.375529324707;6736.932630673827;6738.764143254963;6793.048973143863;6794.252632210551;6824.897626535705;6900.102986611909;6901;6903.585784852925;6909.2745261746795 06:11:14 INFO - 2015-11-20 06:11:14,069 DEBUG : BROWSER_OUTPUT: |4;prototype.html;318.48564568222326;326.1357402882363;327.84099711639846;328.2597742091583;332.793667925886;6718.46252299816;6749.628770417625;6794.932050679492;6807.625580593071;6850.280720524348;6385.872282554346;6514.1205937198465;6517.92454245049;6623.701933412996;6774.796756097325;4070.61329173728;4081.5102187737366;4754.168020596399;5018.548330650232;5051.217061355477;4388.626966707834;5021.397432308128;5023.447420783711;5025.673331233458;5044.470330615288;3843.5579908310483;4180.912962629708;4779.856604301876;4905.822602575374;4911.975440122795;4673.1121086993535;4868.636781701111;4951.900961980777;5014.52362025607;5018.322526458918;4265.274903266452;4280.101178752435;4281.678874084456;4285.078708077778;4296.613304802551;5467.835964921059;6372;6382.680865956683;6386.2975072741965;6422.743090276384;5783.421657834225;5923.851903702442;5940.46535811779;5940.613860099123;5946.762129514815;6441.903371449432;6682.83292917681;7275.563466192046;7276.927230727678;7279.708811647528;4805.279208118775;4807.399075115611;4807.471178170398;4808.903821923577;4820.566149046567;7413.258674132544;7565.35694465971;7679.347255483291;7680.654370553282;7697.692092316301;4439.733615983051;4719.59883409914;4898.02039592083;4905.23968784839;4906.411230652345;4981.975090124526;5008.924866127011;5010.298558201855;5011.523905228997;5013.573846223112;4808.519148085164;5911.438413350725;5921.881562368814;5922.822315330547;5937.881242375129;7014.438844892396;7228.927710722825;7250.238724933912;7290.125184977836;7308.159561650478;1425.4796999095256;1719.2779032806252;1742.2072956804623;1742.3901634428103;1744.6510697860224;1060.734816295926;1071.9678409647568;1092.5247517329988;1120.1207052463776;1148.3282279866205;6674.432673222734;6676.232233293136;6686.3313668632745;6812.523123381316;6873.931260687329;6520.728457950654;7343.669534870837;7612.7716168515035;7617.6572054257695;7631.122420921665;6675.446210329919;6818.318168183142;6851.417629501449;6865.725370985205;6885.655717214119;3984.083660758042;4051.7771522565954;4053.7365071270274;4054.7972601369815;4061.472008638858;6919.619420931796;7381.224971378036;7914.169012253746;7926.603669816486;7945.324647405036;6939.687714052779;7612.238776122344;7895.9210407896335;7967.681292748341;7986.840263194704;7894.921050789533;7917.247861453153;7921.801954951173;7924.722634707758;7928.960355198187;7381.04046473955;7591.58246296459;7622.047244094489;7624.27569380908;7628.8855667163925;7480.812979675552;7501.962490187514;7512.211217822269;7520.473566850268;7530.209328020698;7282.96358518204;7383.778486645409;7870.5671188082915;7893.526388416713;7914.881276780738;4279.400883876322;4785.401824771903;4918.680285781413;4930.260460930889;4931.605471562339;7431.70273189088;7614.885776713243;7614.961925190339;7618.847623047619;7619.923800762143;7341.74303899361;7344.522606030591;7347.926520734724;7356.448266379936;7359.300866417681;7064.929350706427;7322.2677732228485;7323.9267607323245;7329.853402932018;7331.890021649573;6853.9314606853295;6983.266756990646;7152.928470715435;7170.67731952053;7185.497015208885;6202.85247229264;7116.512908674816;7136.5004449690105;7224.205337412775;7257.455690823103;7113.430925526049;7184.46116541251;7184.928150718426;7191.316824901626;7208.89186662211 06:11:14 INFO - 2015-11-20 06:11:14,069 DEBUG : BROWSER_OUTPUT: |5;yui.html;745.7539012125998;797.7287722174459;815.160384803652;829.6225217526027;831.4055450352998;14418.206998615085;14721.852781472182;14724.337404816783;14736.484223052195;14754.926225368858;13590.912726981842;13691.931540342284;13711.108777929428;13715;13743.969202309816;729.4565548666251;751.1511991449654;774.2103054884014;774.7753151586062;895.6641259527677;939.3002213351064;944.4286206844863;956.8421210500294;961.8653388525612;963.4363897120193;807.4791759315239;1000.9049140331657;1020.4999550220375;1020.5509575786667;1024.8718910136233;804.3565147881701;811.8579248631495;1002.1081237698454;1030.2530665267695;1035.7151783259665;747.5066456138976;757.5000499670191;759.2142132892429;760.0347558600602;760.1676164599754;14734.926325368411;14901.850981490155;14932.925335373362;14946.775798363033;14966.925165374212;12122.454489547903;12284.324362160078;12387.566435174816;12532.81200781989;12663.93668031654;8236.970378702663;9067.818643627157;9068.54657267134;9905.80188396228;9976.650817221362;3055.8472076396315;3565.0196196046036;3592.3713350163616;3638.272345530878;3661.7986010769396;82120.17879821185;82170.58914705388;82379;83968.16031839665;84360;9578.808423831484;9700.90299097014;9708.563114659857;9749.463779492196;9893.802123957625;21826.672599911013;21831.126754929624;21837.890810545847;21849.344519664435;21865;7522.548647081193;7528;7547.207543207884;7674.923250767532;7896.447248692652;4049.1091959768805;4051.736637118578;4054.7567145971334;4055.858044968412;4092.733972291851;3511.719062474996;3573.0710015396185;3579.1052236940764;3582.874599389009;3587.0852932502567;627.9340669229756;641.6374748267214;643.4369926314475;661.3683931845077;664.1963224498314;426.4392324093807;448.8204718112781;493.43008824807407;497.6566169343142;510.1480527519052;8347;8459.450135741281;8473.661053557911;8701.411228077195;8707.869381959275;532.2548432194958;581.4418158567738;600.1717629671026;628.955973081889;678.3928384096206;3761.3417651910804;3890.2608504384643;3952.6245006724316;3996.84012639497;4142.772147531854;95140.09719805703;96512;105514;106000.46999764952;106336;68373.55571887911;80989;82532.58733706293;84117.57941210255;86777.1322286769;57104.714476427354;57212.71393643005;58992.11511827326;75675.62162189154;76589;6876.965615171892;8774.824503510023;8802.95598522029;8910.331725120512;9173.633054677739;48790.75604621954;51923.48076519187;52564;55856.882862341714;56008.15987760105;72072.9189062154;72461;73062;75320.24679753352;75851.62074189594;10910.290831095954;10913.945430273116;10928.344299342065;11299.604513842305;11850.288982661068;11980.28118312904;12213.633590992284;12215.26708397499;12394.81407778902;12460.190087644274;11662.650120496399;11700.590479333523;11726.00328972047;11771.470283837076;11822.46798894069;11716.414179291172;11729.706757331134;11744.060475161796;11797;11816.172867899164;11011.44942752843;11059.926115091732;11211.943940280247;11559.711007224887;11891.702707432383;9207.217386522221;9292.488913109844;9311.557613956878;9494.477803720585;9496.620135194515;8587.65649374018;9968.651097211563;9981.800363992825;9989.168251496252;10100.595976160872 06:11:14 INFO - 2015-11-20 06:11:14,069 DEBUG : BROWSER_OUTPUT: __end_tp_report 06:11:14 INFO - 2015-11-20 06:11:14,069 DEBUG : BROWSER_OUTPUT: __start_cc_report 06:11:14 INFO - 2015-11-20 06:11:14,069 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,988 06:11:14 INFO - 2015-11-20 06:11:14,069 DEBUG : BROWSER_OUTPUT: __end_cc_report 06:11:14 INFO - 2015-11-20 06:11:14,070 DEBUG : BROWSER_OUTPUT: __startTimestamp1448028674056__endTimestamp 06:11:14 INFO - 2015-11-20 06:11:14,070 DEBUG : BROWSER_OUTPUT: 06:11:14 INFO - 2015-11-20 06:11:14,070 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 06:11:14 INFO - 2015-11-20 06:11:14,070 DEBUG : BROWSER_OUTPUT: Number of tests: 6 06:11:14 INFO - 2015-11-20 06:11:14,070 DEBUG : BROWSER_OUTPUT: 06:11:14 INFO - 2015-11-20 06:11:14,070 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5879.07 Median:6144.96 stddev:655.66 (10.7%) stddev-sans-first:629.37 06:11:14 INFO - 2015-11-20 06:11:14,071 DEBUG : BROWSER_OUTPUT: Values: 3449.6 3518.2 3540.5 3547.1 3586.5 5711.9 5807.1 5926.4 5999.8 6001.8 5834.7 5897.8 5902.3 5970.3 6016.5 5334.7 5409.6 5419.4 5432.7 5445.8 5453.0 5453.9 5458.7 5474.6 5492.6 5216.7 5329.0 5340.4 5416.8 5433.0 5398.4 5442.9 5443.6 5450.2 5457.6 5314.3 5382.5 5395.1 5400.9 5402.6 5799.3 5815.9 5823.9 5846.3 5855.8 6148.6 6246.8 6287.9 6289.5 6300.2 6356.0 6395.6 6421.4 6423.4 6429.2 6123.0 6127.9 6133.1 6148.3 6153.5 4815.9 6391.9 6401.5 6506.6 6556.9 6292.5 6296.7 6311.4 6313.3 6326.8 6426.2 6435.5 6436.8 6439.9 6454.8 6113.4 6180.1 6232.6 6256.9 6309.3 6262.2 6340.5 6349.2 6364.6 6374.3 4895.3 5101.3 5120.7 5127.0 5158.9 4392.3 4510.1 4530.5 4536.4 4571.4 4984.2 5959.1 5975.2 5987.6 6014.0 6363.1 6384.8 6423.2 6437.6 6446.8 5841.9 5895.1 5955.9 5969.6 5998.9 4832.6 5507.8 5596.2 5597.2 5609.3 6562.0 6566.4 6581.3 6586.7 6593.6 6145.0 6245.5 6249.0 6283.1 6418.3 6486.3 6486.9 6515.8 6521.9 6542.1 6285.8 6319.5 6332.0 6338.7 6355.0 6152.7 6264.1 6264.9 6386.2 6391.4 6100.2 6233.4 6244.4 6246.3 6247.8 5934.1 6256.9 6311.5 6318.0 6329.5 5889.6 6003.6 6073.2 6201.3 6204.5 4741.8 5085.9 6254.8 6280.8 6298.3 6156.8 6195.5 6200.3 6201.0 6213.7 06:11:14 INFO - 2015-11-20 06:11:14,072 DEBUG : BROWSER_OUTPUT: 06:11:14 INFO - 2015-11-20 06:11:14,072 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:69425.84 Median:34960.98 stddev:149724.40 (428.3%) stddev-sans-first:150055.10 06:11:14 INFO - 2015-11-20 06:11:14,073 DEBUG : BROWSER_OUTPUT: Values: 544.6 561.1 569.8 611.0 639.2 31331.1 39468.6 39474.6 39544.6 39616.2 39018.0 42900.0 43159.8 43174.7 43592.3 7484.8 8858.2 9724.0 9936.5 9940.4 8731.1 12044.4 12146.4 12149.0 12151.4 11810.4 11913.3 11913.5 11924.6 11932.2 8716.7 8838.9 11803.6 11826.2 11845.9 8765.9 11889.8 11989.9 12006.8 12026.1 39955.0 40323.0 40387.2 40387.4 40434.0 3352.3 3421.4 3608.9 3752.8 3992.1 24454.8 30347.8 30625.1 30762.7 31294.5 2831.4 2878.9 2913.5 2935.9 3016.6 503370.0 505419.0 507480.0 507484.0 507545.0 58778.7 59769.4 59956.0 68986.7 69562.0 72933.3 73034.6 73746.0 73858.0 73935.6 13273.8 15752.8 15895.2 15917.2 15917.4 12538.9 12626.1 12626.6 12675.2 12802.4 17516.4 21495.8 21594.9 21679.7 21755.3 8477.7 9250.6 9401.4 9628.4 9636.0 940.6 958.9 999.7 1030.6 1032.7 28843.3 29346.6 29430.9 29715.4 29730.9 1034.5 1061.9 1076.8 1077.8 1169.8 14406.5 14594.2 14699.3 14862.1 14907.6 650757.0 660108.7 662006.0 662627.0 663660.0 56555.7 56978.0 57032.1 57178.4 57233.7 1453.6 1460.9 1477.5 1484.6 1491.0 27137.5 28543.3 30931.0 31146.2 31521.8 52220.5 52836.7 52852.7 52911.5 52942.5 498588.0 501001.0 501696.0 502510.0 502755.5 27600.2 27958.3 31612.7 31991.0 32312.4 39356.8 39747.4 39984.4 40467.0 40834.0 33290.8 34599.8 34850.3 34952.7 34969.3 29686.5 36173.6 39513.6 39778.6 40767.6 37167.8 38597.2 40007.0 40217.8 40222.4 26956.0 32785.3 32831.6 33013.7 33071.2 24188.8 24368.7 25142.5 25144.9 25900.5 06:11:14 INFO - 2015-11-20 06:11:14,073 DEBUG : BROWSER_OUTPUT: 06:11:14 INFO - 2015-11-20 06:11:14,073 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:37677.88 Median:21015.34 stddev:121536.95 (578.3%) stddev-sans-first:121845.58 06:11:14 INFO - 2015-11-20 06:11:14,074 DEBUG : BROWSER_OUTPUT: Values: 354.8 359.5 362.9 365.6 367.9 15979.3 16416.2 19309.4 20302.6 21071.8 18314.4 21874.3 21897.8 22284.7 22303.8 5521.7 6600.0 6604.2 6607.2 6627.7 4674.3 4675.7 6573.9 7191.0 7425.7 7058.8 7349.4 7357.1 7359.5 7382.2 7239.0 7275.5 7285.6 7286.2 7290.9 5342.2 5485.1 5497.2 5500.4 6932.3 12472.0 12492.4 12670.4 12678.9 12694.9 1914.2 2059.6 2065.0 2089.8 2136.1 9088.7 9091.9 11744.9 13892.0 14608.9 1682.8 1754.4 1772.1 1781.8 1781.9 82353.6 84526.6 86711.3 97162.0 98917.0 10242.8 10449.2 10556.2 10589.9 10654.8 12571.4 12595.2 12605.8 12607.3 12623.4 8096.9 8115.3 8152.6 8156.5 8202.2 8285.0 8530.0 8583.0 8588.9 8648.5 3965.7 4233.2 4249.9 4253.0 4275.3 1713.1 1742.7 1745.7 1780.6 1781.4 799.5 915.9 925.0 951.8 968.4 18388.0 18639.1 19769.3 20397.6 20958.9 963.3 1004.2 1004.6 1037.5 1060.5 10925.8 11013.3 11131.6 11210.4 11790.5 731209.0 733773.0 737272.0 742896.1 751453.0 122163.8 122278.0 122445.0 122851.4 124368.8 1228.0 1233.2 1243.0 1245.6 1251.6 18234.0 18458.4 18614.3 19185.2 19251.6 46957.8 46967.5 47338.3 47633.8 47645.5 60931.0 60959.5 61483.1 62017.0 63318.7 7615.8 9335.6 9506.7 9628.3 9641.3 11171.8 11547.3 11568.4 13529.8 14989.6 14005.9 15458.8 15895.5 16388.9 16455.5 15516.9 15784.7 15882.8 15942.5 15984.2 16261.2 16330.6 16528.4 16603.3 16779.8 9780.4 9863.7 9872.5 9900.9 9928.1 15691.8 15920.8 16130.4 16149.1 16218.6 06:11:14 INFO - 2015-11-20 06:11:14,074 DEBUG : BROWSER_OUTPUT: 06:11:14 INFO - 2015-11-20 06:11:14,075 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5716.27 Median:6420.67 stddev:2998.46 (46.7%) stddev-sans-first:2990.59 06:11:14 INFO - 2015-11-20 06:11:14,076 DEBUG : BROWSER_OUTPUT: Values: 1558.2 1562.8 1692.9 1838.3 1851.0 6856.9 7481.3 7882.4 8190.0 8210.7 8162.1 8279.1 8314.0 8322.4 8335.8 2131.1 2176.8 2360.9 2382.7 2386.6 1886.8 2189.4 2332.7 2377.7 2379.1 2297.0 2342.9 2343.5 2346.9 2361.2 2111.8 2164.2 2347.4 2372.3 2374.7 2140.0 2338.9 2378.6 2379.5 2381.1 8105.2 8302.9 8309.5 8314.5 8320.3 5105.5 5155.1 5155.2 5174.0 5189.5 3355.7 3383.8 3510.8 3512.2 3520.3 991.7 1027.5 1028.4 1069.1 1078.1 10910.5 10915.7 10920.8 10930.0 10943.0 4342.6 4452.1 4606.2 4668.9 4699.1 9533.0 9535.5 9539.9 9543.3 9565.8 4979.0 4980.1 4990.9 5013.0 5024.9 4501.0 4504.1 4523.1 4527.4 4534.2 3273.7 3770.7 3837.3 3875.0 3877.0 1224.9 1228.7 1229.8 1236.6 1244.4 1055.3 1079.0 1079.0 1105.0 1396.7 7493.6 7521.2 7568.2 7602.2 7656.7 501.7 507.9 513.4 513.5 513.8 5750.9 5833.6 5849.6 6082.0 6268.0 8131.6 9757.5 9829.4 10022.7 10023.2 9843.2 9923.4 9938.6 9960.0 9982.8 7656.0 7819.0 7829.9 7851.1 7853.8 7724.1 7741.2 7752.3 7763.1 7768.4 8639.4 8944.9 9081.0 9084.3 9132.8 8998.2 9055.5 9101.3 9132.2 9215.7 7189.5 7354.6 7356.1 7357.2 7359.1 7866.9 7918.5 7930.0 7934.5 7941.8 7006.5 7355.5 7383.7 7493.9 7534.4 7125.6 7265.0 7321.4 7388.3 7435.4 7361.5 7395.9 7401.9 7405.8 7409.5 6573.4 6736.9 6738.8 6793.0 6794.3 6824.9 6900.1 6901.0 6903.6 6909.3 06:11:14 INFO - 2015-11-20 06:11:14,076 DEBUG : BROWSER_OUTPUT: 06:11:14 INFO - 2015-11-20 06:11:14,076 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5916.55 Median:6684.58 stddev:1909.72 (28.6%) stddev-sans-first:1868.28 06:11:14 INFO - 2015-11-20 06:11:14,076 DEBUG : BROWSER_OUTPUT: Values: 318.5 326.1 327.8 328.3 332.8 6718.5 6749.6 6794.9 6807.6 6850.3 6385.9 6514.1 6517.9 6623.7 6774.8 4070.6 4081.5 4754.2 5018.5 5051.2 4388.6 5021.4 5023.4 5025.7 5044.5 3843.6 4180.9 4779.9 4905.8 4912.0 4673.1 4868.6 4951.9 5014.5 5018.3 4265.3 4280.1 4281.7 4285.1 4296.6 5467.8 6372.0 6382.7 6386.3 6422.7 5783.4 5923.9 5940.5 5940.6 5946.8 6441.9 6682.8 7275.6 7276.9 7279.7 4805.3 4807.4 4807.5 4808.9 4820.6 7413.3 7565.4 7679.3 7680.7 7697.7 4439.7 4719.6 4898.0 4905.2 4906.4 4982.0 5008.9 5010.3 5011.5 5013.6 4808.5 5911.4 5921.9 5922.8 5937.9 7014.4 7228.9 7250.2 7290.1 7308.2 1425.5 1719.3 1742.2 1742.4 1744.7 1060.7 1072.0 1092.5 1120.1 1148.3 6674.4 6676.2 6686.3 6812.5 6873.9 6520.7 7343.7 7612.8 7617.7 7631.1 6675.4 6818.3 6851.4 6865.7 6885.7 3984.1 4051.8 4053.7 4054.8 4061.5 6919.6 7381.2 7914.2 7926.6 7945.3 6939.7 7612.2 7895.9 7967.7 7986.8 7894.9 7917.2 7921.8 7924.7 7929.0 7381.0 7591.6 7622.0 7624.3 7628.9 7480.8 7502.0 7512.2 7520.5 7530.2 7283.0 7383.8 7870.6 7893.5 7914.9 4279.4 4785.4 4918.7 4930.3 4931.6 7431.7 7614.9 7615.0 7618.8 7619.9 7341.7 7344.5 7347.9 7356.4 7359.3 7064.9 7322.3 7323.9 7329.9 7331.9 6853.9 6983.3 7152.9 7170.7 7185.5 6202.9 7116.5 7136.5 7224.2 7257.5 7113.4 7184.5 7184.9 7191.3 7208.9 06:11:14 INFO - 2015-11-20 06:11:14,076 DEBUG : BROWSER_OUTPUT: 06:11:14 INFO - 2015-11-20 06:11:14,077 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:18830.32 Median:55932.52 stddev:27058.99 (48.4%) stddev-sans-first:27100.83 06:11:14 INFO - 2015-11-20 06:11:14,078 DEBUG : BROWSER_OUTPUT: Values: 745.8 797.7 815.2 829.6 831.4 14418.2 14721.9 14724.3 14736.5 14754.9 13590.9 13691.9 13711.1 13715.0 13744.0 729.5 751.2 774.2 774.8 895.7 939.3 944.4 956.8 961.9 963.4 807.5 1000.9 1020.5 1020.6 1024.9 804.4 811.9 1002.1 1030.3 1035.7 747.5 757.5 759.2 760.0 760.2 14734.9 14901.9 14932.9 14946.8 14966.9 12122.5 12284.3 12387.6 12532.8 12663.9 8237.0 9067.8 9068.5 9905.8 9976.7 3055.8 3565.0 3592.4 3638.3 3661.8 82120.2 82170.6 82379.0 83968.2 84360.0 9578.8 9700.9 9708.6 9749.5 9893.8 21826.7 21831.1 21837.9 21849.3 21865.0 7522.5 7528.0 7547.2 7674.9 7896.4 4049.1 4051.7 4054.8 4055.9 4092.7 3511.7 3573.1 3579.1 3582.9 3587.1 627.9 641.6 643.4 661.4 664.2 426.4 448.8 493.4 497.7 510.1 8347.0 8459.5 8473.7 8701.4 8707.9 532.3 581.4 600.2 629.0 678.4 3761.3 3890.3 3952.6 3996.8 4142.8 95140.1 96512.0 105514.0 106000.5 106336.0 68373.6 80989.0 82532.6 84117.6 86777.1 57104.7 57212.7 58992.1 75675.6 76589.0 6877.0 8774.8 8803.0 8910.3 9173.6 48790.8 51923.5 52564.0 55856.9 56008.2 72072.9 72461.0 73062.0 75320.2 75851.6 10910.3 10913.9 10928.3 11299.6 11850.3 11980.3 12213.6 12215.3 12394.8 12460.2 11662.7 11700.6 11726.0 11771.5 11822.5 11716.4 11729.7 11744.1 11797.0 11816.2 11011.4 11059.9 11211.9 11559.7 11891.7 9207.2 9292.5 9311.6 9494.5 9496.6 8587.7 9968.7 9981.8 9989.2 10100.6 06:11:14 INFO - 2015-11-20 06:11:14,078 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 06:11:14 INFO - 2015-11-20 06:11:14,078 DEBUG : BROWSER_OUTPUT: 06:11:14 INFO - 2015-11-20 06:11:14,470 INFO : Browser exited with error code: 0 06:11:14 INFO - 2015-11-20 06:11:14,494 INFO : Completed test dromaeo_css (00:18:34) 06:11:14 INFO - 2015-11-20 06:11:14,494 INFO : Starting test kraken 06:11:14 INFO - 2015-11-20 06:11:14,494 DEBUG : operating with platform_type : mac_ 06:11:14 INFO - 2015-11-20 06:11:14,495 INFO : Initialising browser for kraken test... 06:11:14 INFO - 2015-11-20 06:11:14,507 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/tmpEB6qpm/profile http://localhost:49305/getInfo.html 06:11:16 INFO - 2015-11-20 06:11:16,428 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 06:11:16 INFO - 2015-11-20 06:11:16,428 DEBUG : BROWSER_OUTPUT: colorDepth:24 06:11:16 INFO - 2015-11-20 06:11:16,428 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 06:11:16 INFO - 2015-11-20 06:11:16,428 DEBUG : BROWSER_OUTPUT: __metrics 06:11:16 INFO - 2015-11-20 06:11:16,444 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:11:17 INFO - 2015-11-20 06:11:17,119 INFO : Browser initialized. 06:11:17 INFO - 2015-11-20 06:11:17,120 INFO : Running cycle 1/1 for kraken test... 06:11:17 INFO - 2015-11-20 06:11:17,120 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/tmpEB6qpm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 06:11:28 INFO - 2015-11-20 06:11:28,893 DEBUG : BROWSER_OUTPUT: RSS: Main: 225153024 06:11:28 INFO - 2015-11-20 06:11:28,893 DEBUG : BROWSER_OUTPUT: 06:11:31 INFO - 2015-11-20 06:11:31,413 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49305/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49305/tests/kraken/driver.html?testName=audio-beat-detection) 06:11:32 INFO - 2015-11-20 06:11:32,008 DEBUG : BROWSER_OUTPUT: RSS: Main: 275021824 06:11:32 INFO - 2015-11-20 06:11:32,008 DEBUG : BROWSER_OUTPUT: 06:11:34 INFO - 2015-11-20 06:11:34,618 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49305/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49305/tests/kraken/driver.html?testName=audio-dft) 06:11:35 INFO - 2015-11-20 06:11:35,210 DEBUG : BROWSER_OUTPUT: RSS: Main: 289779712 06:11:35 INFO - 2015-11-20 06:11:35,210 DEBUG : BROWSER_OUTPUT: 06:11:38 INFO - 2015-11-20 06:11:38,537 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49305/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49305/tests/kraken/driver.html?testName=audio-fft) 06:11:39 INFO - 2015-11-20 06:11:39,109 DEBUG : BROWSER_OUTPUT: RSS: Main: 273739776 06:11:39 INFO - 2015-11-20 06:11:39,109 DEBUG : BROWSER_OUTPUT: 06:11:40 INFO - 2015-11-20 06:11:40,983 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49305/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49305/tests/kraken/driver.html?testName=audio-oscillator) 06:11:41 INFO - 2015-11-20 06:11:41,566 DEBUG : BROWSER_OUTPUT: RSS: Main: 275849216 06:11:41 INFO - 2015-11-20 06:11:41,567 DEBUG : BROWSER_OUTPUT: 06:11:43 INFO - 2015-11-20 06:11:43,565 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49305/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49305/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:11:44 INFO - 2015-11-20 06:11:44,144 DEBUG : BROWSER_OUTPUT: RSS: Main: 277385216 06:11:44 INFO - 2015-11-20 06:11:44,144 DEBUG : BROWSER_OUTPUT: 06:11:46 INFO - 2015-11-20 06:11:46,940 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49305/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49305/tests/kraken/driver.html?testName=imaging-darkroom) 06:11:47 INFO - 2015-11-20 06:11:47,529 DEBUG : BROWSER_OUTPUT: RSS: Main: 279130112 06:11:47 INFO - 2015-11-20 06:11:47,529 DEBUG : BROWSER_OUTPUT: 06:11:50 INFO - 2015-11-20 06:11:50,288 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49305/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49305/tests/kraken/driver.html?testName=imaging-desaturate) 06:11:50 INFO - 2015-11-20 06:11:50,880 DEBUG : BROWSER_OUTPUT: RSS: Main: 278409216 06:11:50 INFO - 2015-11-20 06:11:50,880 DEBUG : BROWSER_OUTPUT: 06:11:53 INFO - 2015-11-20 06:11:53,553 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49305/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49305/tests/kraken/driver.html?testName=json-parse-financial) 06:11:54 INFO - 2015-11-20 06:11:54,138 DEBUG : BROWSER_OUTPUT: RSS: Main: 279310336 06:11:54 INFO - 2015-11-20 06:11:54,139 DEBUG : BROWSER_OUTPUT: 06:11:55 INFO - 2015-11-20 06:11:55,668 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49305/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49305/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:11:56 INFO - 2015-11-20 06:11:56,247 DEBUG : BROWSER_OUTPUT: RSS: Main: 313610240 06:11:56 INFO - 2015-11-20 06:11:56,247 DEBUG : BROWSER_OUTPUT: 06:11:58 INFO - 2015-11-20 06:11:58,032 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49305/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49305/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:11:58 INFO - 2015-11-20 06:11:58,663 DEBUG : BROWSER_OUTPUT: RSS: Main: 314892288 06:11:58 INFO - 2015-11-20 06:11:58,663 DEBUG : BROWSER_OUTPUT: 06:12:00 INFO - 2015-11-20 06:12:00,852 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49305/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49305/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:12:01 INFO - 2015-11-20 06:12:01,440 DEBUG : BROWSER_OUTPUT: RSS: Main: 323571712 06:12:01 INFO - 2015-11-20 06:12:01,440 DEBUG : BROWSER_OUTPUT: 06:12:03 INFO - 2015-11-20 06:12:03,953 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49305/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49305/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:12:04 INFO - 2015-11-20 06:12:04,583 DEBUG : BROWSER_OUTPUT: RSS: Main: 324374528 06:12:04 INFO - 2015-11-20 06:12:04,584 DEBUG : BROWSER_OUTPUT: 06:12:06 INFO - 2015-11-20 06:12:06,986 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49305/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49305/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:12:07 INFO - 2015-11-20 06:12:07,576 DEBUG : BROWSER_OUTPUT: RSS: Main: 322940928 06:12:07 INFO - 2015-11-20 06:12:07,576 DEBUG : BROWSER_OUTPUT: 06:12:09 INFO - 2015-11-20 06:12:09,233 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49305/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49305/tests/kraken/driver.html?testName=ai-astar) 06:12:09 INFO - 2015-11-20 06:12:09,492 DEBUG : BROWSER_OUTPUT: RSS: Main: 382238720 06:12:09 INFO - 2015-11-20 06:12:09,492 DEBUG : BROWSER_OUTPUT: 06:12:09 INFO - 2015-11-20 06:12:09,492 DEBUG : BROWSER_OUTPUT: __start_tp_report 06:12:09 INFO - 2015-11-20 06:12:09,492 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 06:12:09 INFO - 2015-11-20 06:12:09,492 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 06:12:09 INFO - 2015-11-20 06:12:09,492 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 06:12:09 INFO - 2015-11-20 06:12:09,492 DEBUG : BROWSER_OUTPUT: |0;ai-astar;109;107;101;110;110;107;109;108;105;108 06:12:09 INFO - 2015-11-20 06:12:09,492 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;168;147;144;151;119;142;146;127;155;119 06:12:09 INFO - 2015-11-20 06:12:09,492 DEBUG : BROWSER_OUTPUT: |2;audio-dft;184;180;181;185;184;185;183;185;185;182 06:12:09 INFO - 2015-11-20 06:12:09,493 DEBUG : BROWSER_OUTPUT: |3;audio-fft;67;66;71;72;54;56;55;71;74;55 06:12:09 INFO - 2015-11-20 06:12:09,493 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;85;84;113;74;74;75;106;73;75;109 06:12:09 INFO - 2015-11-20 06:12:09,493 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;115;132;96;85;85;85;86;86;85;84 06:12:09 INFO - 2015-11-20 06:12:09,493 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;94;93;93;94;93;94;93;93;93;92 06:12:09 INFO - 2015-11-20 06:12:09,493 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;86;87;82;85;86;86;86;88;85;85 06:12:09 INFO - 2015-11-20 06:12:09,493 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;55;54;53;53;55;53;54;65;53;53 06:12:09 INFO - 2015-11-20 06:12:09,493 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;65;63;63;63;68;68;68;69;69;68 06:12:09 INFO - 2015-11-20 06:12:09,493 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;81;82;82;85;95;105;105;107;84;83 06:12:09 INFO - 2015-11-20 06:12:09,493 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;121;130;126;120;118;123;124;121;127;130 06:12:09 INFO - 2015-11-20 06:12:09,493 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;135;135;135;134;134;117;136;134;134;122 06:12:09 INFO - 2015-11-20 06:12:09,493 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;65;64;65;66;65;65;67;65;66;65 06:12:09 INFO - 2015-11-20 06:12:09,493 DEBUG : BROWSER_OUTPUT: __end_tp_report 06:12:09 INFO - 2015-11-20 06:12:09,493 DEBUG : BROWSER_OUTPUT: __start_cc_report 06:12:09 INFO - 2015-11-20 06:12:09,493 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1057 06:12:09 INFO - 2015-11-20 06:12:09,494 DEBUG : BROWSER_OUTPUT: __end_cc_report 06:12:09 INFO - 2015-11-20 06:12:09,494 DEBUG : BROWSER_OUTPUT: __startTimestamp1448028729486__endTimestamp 06:12:09 INFO - 2015-11-20 06:12:09,494 DEBUG : BROWSER_OUTPUT: 06:12:09 INFO - 2015-11-20 06:12:09,494 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 06:12:09 INFO - 2015-11-20 06:12:09,494 DEBUG : BROWSER_OUTPUT: Number of tests: 14 06:12:09 INFO - 2015-11-20 06:12:09,494 DEBUG : BROWSER_OUTPUT: 06:12:09 INFO - 2015-11-20 06:12:09,494 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:107.40 Median:108.50 stddev:2.72 (2.5%) stddev-sans-first:2.82 06:12:09 INFO - 2015-11-20 06:12:09,494 DEBUG : BROWSER_OUTPUT: Values: 109.0 107.0 101.0 110.0 110.0 107.0 109.0 108.0 105.0 108.0 06:12:09 INFO - 2015-11-20 06:12:09,494 DEBUG : BROWSER_OUTPUT: 06:12:09 INFO - 2015-11-20 06:12:09,494 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:141.80 Median:146.50 stddev:15.82 (10.8%) stddev-sans-first:13.65 06:12:09 INFO - 2015-11-20 06:12:09,494 DEBUG : BROWSER_OUTPUT: Values: 168.0 147.0 144.0 151.0 119.0 142.0 146.0 127.0 155.0 119.0 06:12:09 INFO - 2015-11-20 06:12:09,494 DEBUG : BROWSER_OUTPUT: 06:12:09 INFO - 2015-11-20 06:12:09,494 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:183.40 Median:184.50 stddev:1.84 (1.0%) stddev-sans-first:1.94 06:12:09 INFO - 2015-11-20 06:12:09,494 DEBUG : BROWSER_OUTPUT: Values: 184.0 180.0 181.0 185.0 184.0 185.0 183.0 185.0 185.0 182.0 06:12:09 INFO - 2015-11-20 06:12:09,495 DEBUG : BROWSER_OUTPUT: 06:12:09 INFO - 2015-11-20 06:12:09,495 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:64.10 Median:69.00 stddev:8.17 (11.8%) stddev-sans-first:8.60 06:12:09 INFO - 2015-11-20 06:12:09,495 DEBUG : BROWSER_OUTPUT: Values: 67.0 66.0 71.0 72.0 54.0 56.0 55.0 71.0 74.0 55.0 06:12:09 INFO - 2015-11-20 06:12:09,495 DEBUG : BROWSER_OUTPUT: 06:12:09 INFO - 2015-11-20 06:12:09,495 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:86.80 Median:74.50 stddev:16.18 (21.7%) stddev-sans-first:17.15 06:12:09 INFO - 2015-11-20 06:12:09,495 DEBUG : BROWSER_OUTPUT: Values: 85.0 84.0 113.0 74.0 74.0 75.0 106.0 73.0 75.0 109.0 06:12:09 INFO - 2015-11-20 06:12:09,495 DEBUG : BROWSER_OUTPUT: 06:12:09 INFO - 2015-11-20 06:12:09,495 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:93.90 Median:85.00 stddev:16.47 (19.4%) stddev-sans-first:15.60 06:12:09 INFO - 2015-11-20 06:12:09,495 DEBUG : BROWSER_OUTPUT: Values: 115.0 132.0 96.0 85.0 85.0 85.0 86.0 86.0 85.0 84.0 06:12:09 INFO - 2015-11-20 06:12:09,495 DEBUG : BROWSER_OUTPUT: 06:12:09 INFO - 2015-11-20 06:12:09,495 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:93.20 Median:93.00 stddev:0.63 (0.7%) stddev-sans-first:0.60 06:12:09 INFO - 2015-11-20 06:12:09,495 DEBUG : BROWSER_OUTPUT: Values: 94.0 93.0 93.0 94.0 93.0 94.0 93.0 93.0 93.0 92.0 06:12:09 INFO - 2015-11-20 06:12:09,495 DEBUG : BROWSER_OUTPUT: 06:12:09 INFO - 2015-11-20 06:12:09,495 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:85.60 Median:86.00 stddev:1.58 (1.8%) stddev-sans-first:1.67 06:12:09 INFO - 2015-11-20 06:12:09,495 DEBUG : BROWSER_OUTPUT: Values: 86.0 87.0 82.0 85.0 86.0 86.0 86.0 88.0 85.0 85.0 06:12:09 INFO - 2015-11-20 06:12:09,496 DEBUG : BROWSER_OUTPUT: 06:12:09 INFO - 2015-11-20 06:12:09,496 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:54.80 Median:54.00 stddev:3.68 (6.8%) stddev-sans-first:3.90 06:12:09 INFO - 2015-11-20 06:12:09,496 DEBUG : BROWSER_OUTPUT: Values: 55.0 54.0 53.0 53.0 55.0 53.0 54.0 65.0 53.0 53.0 06:12:09 INFO - 2015-11-20 06:12:09,496 DEBUG : BROWSER_OUTPUT: 06:12:09 INFO - 2015-11-20 06:12:09,496 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:66.40 Median:68.00 stddev:2.59 (3.8%) stddev-sans-first:2.70 06:12:09 INFO - 2015-11-20 06:12:09,496 DEBUG : BROWSER_OUTPUT: Values: 65.0 63.0 63.0 63.0 68.0 68.0 68.0 69.0 69.0 68.0 06:12:09 INFO - 2015-11-20 06:12:09,496 DEBUG : BROWSER_OUTPUT: 06:12:09 INFO - 2015-11-20 06:12:09,496 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:90.90 Median:82.50 stddev:10.93 (13.2%) stddev-sans-first:10.99 06:12:09 INFO - 2015-11-20 06:12:09,496 DEBUG : BROWSER_OUTPUT: Values: 81.0 82.0 82.0 85.0 95.0 105.0 105.0 107.0 84.0 83.0 06:12:09 INFO - 2015-11-20 06:12:09,496 DEBUG : BROWSER_OUTPUT: 06:12:09 INFO - 2015-11-20 06:12:09,496 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:124.00 Median:125.00 stddev:4.16 (3.3%) stddev-sans-first:4.27 06:12:09 INFO - 2015-11-20 06:12:09,496 DEBUG : BROWSER_OUTPUT: Values: 121.0 130.0 126.0 120.0 118.0 123.0 124.0 121.0 127.0 130.0 06:12:09 INFO - 2015-11-20 06:12:09,496 DEBUG : BROWSER_OUTPUT: 06:12:09 INFO - 2015-11-20 06:12:09,496 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:131.60 Median:134.50 stddev:6.52 (4.8%) stddev-sans-first:6.80 06:12:09 INFO - 2015-11-20 06:12:09,497 DEBUG : BROWSER_OUTPUT: Values: 135.0 135.0 135.0 134.0 134.0 117.0 136.0 134.0 134.0 122.0 06:12:09 INFO - 2015-11-20 06:12:09,497 DEBUG : BROWSER_OUTPUT: 06:12:09 INFO - 2015-11-20 06:12:09,497 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.30 Median:65.00 stddev:0.82 (1.3%) stddev-sans-first:0.87 06:12:09 INFO - 2015-11-20 06:12:09,497 DEBUG : BROWSER_OUTPUT: Values: 65.0 64.0 65.0 66.0 65.0 65.0 67.0 65.0 66.0 65.0 06:12:09 INFO - 2015-11-20 06:12:09,497 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 06:12:09 INFO - 2015-11-20 06:12:09,497 DEBUG : BROWSER_OUTPUT: 06:12:10 INFO - 2015-11-20 06:12:10,100 INFO : Browser exited with error code: 0 06:12:10 INFO - 2015-11-20 06:12:10,146 INFO : Completed test kraken (00:00:55) 06:12:10 INFO - 2015-11-20 06:12:10,146 INFO : Starting test v8_7 06:12:10 INFO - 2015-11-20 06:12:10,146 DEBUG : operating with platform_type : mac_ 06:12:10 INFO - 2015-11-20 06:12:10,146 INFO : Initialising browser for v8_7 test... 06:12:10 INFO - 2015-11-20 06:12:10,158 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/tmp_MLBA0/profile http://localhost:49305/getInfo.html 06:12:12 INFO - 2015-11-20 06:12:12,175 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 06:12:12 INFO - 2015-11-20 06:12:12,175 DEBUG : BROWSER_OUTPUT: colorDepth:24 06:12:12 INFO - 2015-11-20 06:12:12,175 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 06:12:12 INFO - 2015-11-20 06:12:12,175 DEBUG : BROWSER_OUTPUT: __metrics 06:12:12 INFO - 2015-11-20 06:12:12,192 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:12:12 INFO - 2015-11-20 06:12:12,444 DEBUG : BROWSER_OUTPUT: console.error: 06:12:12 INFO - 2015-11-20 06:12:12,444 DEBUG : BROWSER_OUTPUT: Message: Error: Connection closed before committing the transaction. 06:12:12 INFO - 2015-11-20 06:12:12,444 DEBUG : BROWSER_OUTPUT: Stack: 06:12:12 INFO - 2015-11-20 06:12:12,444 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeTransaction/promise resource://gre/modules/Promise-backend.js:934:23 06:12:12 INFO - 2015-11-20 06:12:12,445 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:813:7 06:12:12 INFO - 2015-11-20 06:12:12,445 DEBUG : BROWSER_OUTPUT: Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:744:11 06:12:12 INFO - 2015-11-20 06:12:12,445 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:776:7 06:12:12 INFO - 2015-11-20 06:12:12,445 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:711:7 06:12:12 INFO - 2015-11-20 06:12:12,445 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:319:13 06:12:12 INFO - 2015-11-20 06:12:12,446 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:523:9 06:12:12 INFO - 2015-11-20 06:12:12,446 DEBUG : BROWSER_OUTPUT: nsAsyncShutdownBarrier.prototype.wait/<@resource://gre/components/nsAsyncShutdown.js:215:7 06:12:12 INFO - 2015-11-20 06:12:12,446 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:523:9 06:12:12 INFO - 2015-11-20 06:12:12,446 DEBUG : BROWSER_OUTPUT: 06:12:12 INFO - 2015-11-20 06:12:12,833 INFO : Browser initialized. 06:12:12 INFO - 2015-11-20 06:12:12,834 INFO : Running cycle 1/1 for v8_7 test... 06:12:12 INFO - 2015-11-20 06:12:12,834 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/tmp_MLBA0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 06:12:24 INFO - 2015-11-20 06:12:24,596 DEBUG : BROWSER_OUTPUT: RSS: Main: 226258944 06:12:24 INFO - 2015-11-20 06:12:24,596 DEBUG : BROWSER_OUTPUT: 06:12:46 INFO - 2015-11-20 06:12:46,092 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49305/tests/v8_7/run.html (next: http://localhost:49305/tests/v8_7/run.html) 06:12:46 INFO - 2015-11-20 06:12:46,351 DEBUG : BROWSER_OUTPUT: RSS: Main: 620273664 06:12:46 INFO - 2015-11-20 06:12:46,351 DEBUG : BROWSER_OUTPUT: 06:12:46 INFO - 2015-11-20 06:12:46,351 DEBUG : BROWSER_OUTPUT: __start_tp_report 06:12:46 INFO - 2015-11-20 06:12:46,351 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 06:12:46 INFO - 2015-11-20 06:12:46,352 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 06:12:46 INFO - 2015-11-20 06:12:46,352 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 06:12:46 INFO - 2015-11-20 06:12:46,352 DEBUG : BROWSER_OUTPUT: |0;Richards;147.25371815638346 06:12:46 INFO - 2015-11-20 06:12:46,352 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;161.91709844559585 06:12:46 INFO - 2015-11-20 06:12:46,352 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.9552071668533 06:12:46 INFO - 2015-11-20 06:12:46,352 DEBUG : BROWSER_OUTPUT: |3;Decrypt;4651.162790697675 06:12:46 INFO - 2015-11-20 06:12:46,352 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1697.792869269949 06:12:46 INFO - 2015-11-20 06:12:46,352 DEBUG : BROWSER_OUTPUT: |5;Earley;786.7820613690008 06:12:46 INFO - 2015-11-20 06:12:46,352 DEBUG : BROWSER_OUTPUT: |6;Boyer;12759.493670886075 06:12:46 INFO - 2015-11-20 06:12:46,352 DEBUG : BROWSER_OUTPUT: |7;RegExp;27027.027027027027 06:12:46 INFO - 2015-11-20 06:12:46,352 DEBUG : BROWSER_OUTPUT: |8;Splay;672.9475100942127 06:12:46 INFO - 2015-11-20 06:12:46,352 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4513.513513513513 06:12:46 INFO - 2015-11-20 06:12:46,353 DEBUG : BROWSER_OUTPUT: __end_tp_report 06:12:46 INFO - 2015-11-20 06:12:46,353 DEBUG : BROWSER_OUTPUT: __startTimestamp1448028766345__endTimestamp 06:12:46 INFO - 2015-11-20 06:12:46,353 DEBUG : BROWSER_OUTPUT: 06:12:46 INFO - 2015-11-20 06:12:46,353 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 06:12:46 INFO - 2015-11-20 06:12:46,353 DEBUG : BROWSER_OUTPUT: Number of tests: 10 06:12:46 INFO - 2015-11-20 06:12:46,353 DEBUG : BROWSER_OUTPUT: 06:12:46 INFO - 2015-11-20 06:12:46,353 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:147.25 Median:147.25 stddev:0.00 (0.0%) 06:12:46 INFO - 2015-11-20 06:12:46,353 DEBUG : BROWSER_OUTPUT: Values: 147.3 06:12:46 INFO - 2015-11-20 06:12:46,353 DEBUG : BROWSER_OUTPUT: 06:12:46 INFO - 2015-11-20 06:12:46,353 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:161.92 Median:161.92 stddev:0.00 (0.0%) 06:12:46 INFO - 2015-11-20 06:12:46,353 DEBUG : BROWSER_OUTPUT: Values: 161.9 06:12:46 INFO - 2015-11-20 06:12:46,353 DEBUG : BROWSER_OUTPUT: 06:12:46 INFO - 2015-11-20 06:12:46,353 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.96 Median:279.96 stddev:0.00 (0.0%) 06:12:46 INFO - 2015-11-20 06:12:46,354 DEBUG : BROWSER_OUTPUT: Values: 280.0 06:12:46 INFO - 2015-11-20 06:12:46,354 DEBUG : BROWSER_OUTPUT: 06:12:46 INFO - 2015-11-20 06:12:46,354 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:4651.16 Median:4651.16 stddev:0.00 (0.0%) 06:12:46 INFO - 2015-11-20 06:12:46,354 DEBUG : BROWSER_OUTPUT: Values: 4651.2 06:12:46 INFO - 2015-11-20 06:12:46,354 DEBUG : BROWSER_OUTPUT: 06:12:46 INFO - 2015-11-20 06:12:46,354 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1697.79 Median:1697.79 stddev:0.00 (0.0%) 06:12:46 INFO - 2015-11-20 06:12:46,354 DEBUG : BROWSER_OUTPUT: Values: 1697.8 06:12:46 INFO - 2015-11-20 06:12:46,354 DEBUG : BROWSER_OUTPUT: 06:12:46 INFO - 2015-11-20 06:12:46,354 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:786.78 Median:786.78 stddev:0.00 (0.0%) 06:12:46 INFO - 2015-11-20 06:12:46,354 DEBUG : BROWSER_OUTPUT: Values: 786.8 06:12:46 INFO - 2015-11-20 06:12:46,354 DEBUG : BROWSER_OUTPUT: 06:12:46 INFO - 2015-11-20 06:12:46,354 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12759.49 Median:12759.49 stddev:0.00 (0.0%) 06:12:46 INFO - 2015-11-20 06:12:46,355 DEBUG : BROWSER_OUTPUT: Values: 12759.5 06:12:46 INFO - 2015-11-20 06:12:46,355 DEBUG : BROWSER_OUTPUT: 06:12:46 INFO - 2015-11-20 06:12:46,355 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:27027.03 Median:27027.03 stddev:0.00 (0.0%) 06:12:46 INFO - 2015-11-20 06:12:46,355 DEBUG : BROWSER_OUTPUT: Values: 27027.0 06:12:46 INFO - 2015-11-20 06:12:46,355 DEBUG : BROWSER_OUTPUT: 06:12:46 INFO - 2015-11-20 06:12:46,355 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:672.95 Median:672.95 stddev:0.00 (0.0%) 06:12:46 INFO - 2015-11-20 06:12:46,355 DEBUG : BROWSER_OUTPUT: Values: 672.9 06:12:46 INFO - 2015-11-20 06:12:46,355 DEBUG : BROWSER_OUTPUT: 06:12:46 INFO - 2015-11-20 06:12:46,355 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4513.51 Median:4513.51 stddev:0.00 (0.0%) 06:12:46 INFO - 2015-11-20 06:12:46,355 DEBUG : BROWSER_OUTPUT: Values: 4513.5 06:12:46 INFO - 2015-11-20 06:12:46,355 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 06:12:46 INFO - 2015-11-20 06:12:46,355 DEBUG : BROWSER_OUTPUT: 06:12:47 INFO - 2015-11-20 06:12:47,001 INFO : Browser exited with error code: 0 06:12:47 INFO - 2015-11-20 06:12:47,019 INFO : Completed test v8_7 (00:00:36) 06:12:47 INFO - 2015-11-20 06:12:47,367 INFO : Completed test suite (00:20:07) 06:12:47 INFO - 2015-11-20 06:12:47,367 DEBUG : Working with test: dromaeo_css 06:12:47 INFO - 2015-11-20 06:12:47,368 DEBUG : Generating results file: dromaeo_css 06:12:47 INFO - 2015-11-20 06:12:47,368 DEBUG : Working with test: kraken 06:12:47 INFO - 2015-11-20 06:12:47,368 DEBUG : Generating results file: kraken 06:12:47 INFO - 2015-11-20 06:12:47,369 INFO : javascript benchmark 06:12:47 INFO - 2015-11-20 06:12:47,369 DEBUG : Working with test: v8_7 06:12:47 INFO - 2015-11-20 06:12:47,369 DEBUG : Generating results file: v8_7 06:12:47 INFO - 2015-11-20 06:12:47,369 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:12:47 INFO - 2015-11-20 06:12:47,773 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,59]] 06:12:47 INFO - 2015-11-20 06:12:47,773 DEBUG : process_Request line: dromaeo_css 7633.19 graph.html#tests=[[72,64,59]] 06:12:47 INFO - 2015-11-20 06:12:47,773 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:12:47 INFO - 2015-11-20 06:12:47,824 DEBUG : process_Request line: kraken 1389.20 graph.html#tests=[[232,64,59]] 06:12:47 INFO - 2015-11-20 06:12:47,824 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:12:47 INFO - 2015-11-20 06:12:47,865 DEBUG : process_Request line: v8_7 20685.53 graph.html#tests=[[230,64,59]] 06:12:47 INFO - 2015-11-20 06:12:47,866 INFO : javascript benchmark 06:12:47 INFO - 2015-11-20 06:12:47,868 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3449.5860496740393, 3518.173229291116, 3540.539729835121, 3547.1132216945757, 3586.51582036425, 5711.942880571193, 5807.070868661015, 5926.377730338311, 5999.82000539984, 6001.8499537511525, 5834.737436815343, 5897.823065308037, 5902.291724992996, 5970.34326224115, 6016.458518733313, 5334.733263336837, 5409.5672346212405, 5419.430959749228, 5432.674039557639, 5445.809396671118, 5453.018456677796, 5453.890922181554, 5458.6724796512335, 5474.644148130379, 5492.615516913817, 5216.713080780555, 5328.987492376436, 5340.439253878365, 5416.8104116355935, 5432.99999999998, 5398.352197736297, 5442.945570544283, 5443.646162999393, 5450.236966824647, 5457.5633949283965, 5314.309139811839, 5382.515573598395, 5395.082835917903, 5400.864978375533, 5402.648827826179, 5799.333076696192, 5815.883682326372, 5823.883522329572, 5846.327672317695, 5855.795047173371, 6148.600340977822, 6246.781362652286, 6287.937120628781, 6289.496840252768, 6300.243970723543, 6355.968220158869, 6395.552311338208, 6421.389967953037, 6423.389777971085, 6429.22849258092, 6123.020316749344, 6127.908081378783, 6133.110698948627, 6148.323684394713, 6153.476954458832, 4815.927761083586, 6391.904121438182, 6401.487880969511, 6506.577072490273, 6556.868862622721, 6292.528060395397, 6296.685165741695, 6311.400416960381, 6313.337099604475, 6326.810195694136, 6426.228852537632, 6435.549511534147, 6436.774712885027, 6439.871202575922, 6454.838629034311, 6113.3720062487255, 6180.072989051589, 6232.56372053961, 6256.906146407808, 6309.274433440121, 6262.15460912771, 6340.492760579143, 6349.238091429058, 6364.64994425311, 6374.330695276929, 4895.31465594817, 5101.3298295907025, 5120.692758434506, 5127.0, 5158.92261616076, 4392.3411488277015, 4510.143072816154, 4530.546945305509, 4536.387587675687, 4571.3600095986585, 4984.202527595639, 5959.106134079922, 5975.223220981245, 5987.6108052976415, 6014.0377539593455, 6363.109164716943, 6384.84037899047, 6423.164988551458, 6437.645929473924, 6446.8388290293115, 5841.912371314434, 5895.056790913433, 5955.940440595626, 5969.552283578749, 5998.940010599838, 4832.637552183601, 5507.779688812403, 5596.2165296858475, 5597.244372009808, 5609.298837645294, 6562.0, 6566.376194261537, 6581.276059633532, 6586.670666466754, 6593.571417857824, 6144.95535758931, 6245.500359971283, 6248.968755156195, 6283.120363149072, 6418.326075761977, 6486.254080780771, 6486.9351306488215, 6515.804525864231, 6521.934780652133, 6542.084108224757, 6285.811425657238, 6319.46284565817, 6331.96834015827, 6338.714757835816, 6354.968225158845, 6152.661603611844, 6264.123022776724, 6264.874702505833, 6386.201724784402, 6391.424771770563, 6100.217864923719, 6233.438990490878, 6244.438000579969, 6246.312905580474, 6247.843803904939, 5934.109883517507, 6256.906146407899, 6311.495080393649, 6317.96841015792, 6329.49364050884, 5889.5582831286965, 6003.643714592294, 6073.210482637229, 6201.255849298113, 6204.472619827366, 4741.810327586858, 5085.931954289641, 6254.843628909313, 6280.842978925563, 6298.338674439301, 6156.815295540961, 6195.473384762346, 6200.3179650237535, 6201.0388389799655, 6213.720382582885], "unit": "ms", "name": "dojo.html", "value": 5839.828628517423}, {"lowerIsBetter": false, "replicates": [544.6245277889744, 561.1162419189777, 569.7663957777312, 610.9827137815537, 639.1850390751794, 31331.060068197934, 39468.60531394685, 39474.605253947455, 39544.60455395445, 39616.20767584647, 39018.0, 42899.994000839906, 43159.78420107903, 43174.70475885728, 43592.3461148083, 7484.812879677997, 8858.247049000842, 9723.951380243088, 9936.453495057769, 9940.40357578544, 8731.083236260196, 12044.397780111003, 12146.39268036599, 12149.02807775376, 12151.39243037849, 11810.409479526032, 11913.344766037908, 11913.523459061671, 11924.582639607615, 11932.16474846761, 8716.738497845075, 8838.911610883873, 11803.645890623295, 11826.231294965843, 11845.881541184564, 8765.868511972325, 11889.762204755943, 11989.88010119905, 12006.759864802742, 12026.098042646749, 39955.0, 40323.0, 40387.19225615501, 40387.39418908719, 40434.0, 3352.3462924729442, 3421.4183588789965, 3608.855645774166, 3752.774833509998, 3992.0818211811447, 24454.755452445424, 30347.848260758776, 30625.081247562608, 30762.692373076206, 31294.530582041287, 2831.433713257357, 2878.8560571971316, 2913.46100971321, 2935.897243596485, 3016.622922134733, 503370.0, 505419.0, 507480.0, 507484.0, 507545.0, 58778.706106469195, 59769.402305976386, 59956.0, 68986.65506672434, 69562.0, 72933.2706672937, 73034.63482682552, 73746.0, 73858.0, 73935.63032184805, 13273.800892986614, 15752.842471575366, 15895.205239737967, 15917.204139792964, 15917.363305467883, 12538.874611253954, 12626.116171868065, 12626.55807046749, 12675.239485630707, 12802.359882005863, 17516.38692645751, 21495.78504214969, 21594.89202553977, 21679.67480487794, 21755.34733957984, 8477.74566762998, 9250.583723732449, 9401.388909720847, 9628.422294662343, 9636.0, 940.6143481172686, 958.9280803939592, 999.7000899730052, 1030.5877648940334, 1032.700516850105, 28843.278918027216, 29346.615177871416, 29430.852845735633, 29715.405691886474, 29730.851345743566, 1034.4879284754095, 1061.946902654864, 1076.7684947736118, 1077.8275475923815, 1169.830374595679, 14406.495772648117, 14594.197319147337, 14699.26503674812, 14862.108273503625, 14907.627309317137, 650757.0, 660108.6994565092, 662006.0, 662627.0, 663660.0, 56555.71722141363, 56978.0, 57032.14451783227, 57178.42821571731, 57233.71383143058, 1453.6220582648375, 1460.8831293496494, 1477.460726834719, 1484.6140003598925, 1490.970180596382, 27137.457250855266, 28543.28641783972, 30931.0, 31146.164457506, 31521.8423907879, 52220.47779522156, 52836.73581632067, 52852.67868303169, 52911.470885290655, 52942.47057529375, 498588.0, 501001.0, 501696.0, 502510.0, 502755.4586681276, 27600.171994840188, 27958.3010424741, 31612.683873160975, 31991.0, 32312.35375292528, 39356.80321598374, 39747.40378894377, 39984.4002339971, 40467.0, 40834.0, 33290.833545832116, 34599.82700086483, 34850.30299394049, 34952.65047349494, 34969.30061398707, 29686.540564017243, 36173.638263617024, 39513.60486395099, 39778.60221397749, 40767.59232407638, 37167.814160929025, 38597.20391966511, 40006.999825004605, 40217.79891100526, 40222.39666404948, 26956.0, 32785.34429311448, 32831.56124796087, 33013.66986330106, 33071.173220669676, 24188.75811241865, 24368.719048119172, 25142.49715005653, 25144.868480918038, 25900.48199035971], "unit": "ms", "name": "ext.html", "value": 20458.967219142058}, {"lowerIsBetter": false, "replicates": [354.76408188554626, 359.4643980469101, 362.87118073084036, 365.5595008015341, 367.86021311901476, 15979.280932358042, 16416.17919104043, 19309.420717378485, 20302.593948121048, 21071.789282107173, 18314.35899743509, 21874.343769686897, 21897.795621240824, 22284.66573001406, 22303.77696223037, 5521.69630670314, 6599.977003564455, 6604.2405123410945, 6607.20713514379, 6627.734890604394, 4674.335628691647, 4675.672702910798, 6573.868522629545, 7191.029211056519, 7425.702971881118, 7058.788236352918, 7349.448791340644, 7357.0803649543805, 7359.521631093989, 7382.224866389032, 7238.98654188414, 7275.5448910218165, 7285.599292038935, 7286.234945330717, 7290.927090729105, 5342.198670199501, 5485.0949593317055, 5497.202905578709, 5500.42245564218, 6932.341427564424, 12472.0, 12492.437840297209, 12670.416197975253, 12678.87321126786, 12694.936525317315, 1914.1864707499258, 2059.6292667319876, 2065.0397565132134, 2089.7910208979133, 2136.060133541237, 9088.68189613367, 9091.863622045674, 11744.884235997566, 13892.0, 14608.853911460961, 1682.7728256685436, 1754.3596587245563, 1772.1050869311043, 1781.7683701118901, 1781.9287228510843, 82353.58823205845, 84526.57736711277, 86711.26577468416, 97162.0, 98917.0, 10242.846357304647, 10449.164066874631, 10556.208284378703, 10589.947050264853, 10654.840177397346, 12571.371431428392, 12595.181313214613, 12605.810912836314, 12607.306598137007, 12623.368831558386, 8096.919030809617, 8115.310198633064, 8152.6331315090965, 8156.5106093633385, 8202.179782021869, 8285.0, 8529.976402831577, 8583.0129535103, 8588.88344515209, 8648.524331161847, 3965.6827453803626, 4233.153369326085, 4249.851255206053, 4252.978735106367, 4275.294576394922, 1713.126305584161, 1742.7124524453577, 1745.746866704346, 1780.5904641932168, 1781.358710864088, 799.476342995339, 915.9358844880927, 924.9630014799467, 951.7573018880141, 968.3899143539525, 18388.0, 18639.068046597615, 19769.308074217333, 20397.592048158953, 20958.89520552418, 963.2775418436173, 1004.1615251265275, 1004.5981607357115, 1037.4968140451874, 1060.5311643373982, 10925.776895815594, 11013.2841365311, 11131.610393636183, 11210.439478026066, 11790.528378864921, 731209.0, 733773.0, 737272.0, 742896.1420771554, 751453.0, 122163.77836221702, 122278.0, 122445.0, 122851.3857430725, 124368.75631243571, 1227.9877201228053, 1233.1614502138452, 1242.9813552796716, 1245.5951815659766, 1251.605744190577, 18234.0, 18458.35395761142, 18614.324710776094, 19185.232590696214, 19251.614967700847, 46957.765211173726, 46967.530324697684, 47338.28992565183, 47633.809154770024, 47645.52354476411, 60931.0, 60959.47601310003, 61483.07775383462, 62017.0, 63318.68340658267, 7615.809604759704, 9335.626574937198, 9506.66726664591, 9628.32601717873, 9641.325107242707, 11171.832422513831, 11547.307161570332, 11568.421578921188, 13529.797053044016, 14989.625259368602, 14005.929970350084, 15458.84541154574, 15895.52313430599, 16388.93471924321, 16455.506334809976, 15516.896620676136, 15784.684306314039, 15882.841171588136, 15942.521724348288, 15984.200789960689, 16261.186940653157, 16330.591735206715, 16528.421505247257, 16603.252853621376, 16779.832201677826, 9780.413175209225, 9863.704088877344, 9872.45701486425, 9900.900990990285, 9928.056834600702, 15691.764623530427, 15920.761188582412, 16130.435434759727, 16149.111798851176, 16218.594535136244], "unit": "ms", "name": "jquery.html", "value": 9819.025497747809}, {"lowerIsBetter": false, "replicates": [1558.1897413345068, 1562.7733978573108, 1692.8899621524592, 1838.3473866777294, 1850.9912097906645, 6856.931430685698, 7481.326680598745, 7882.408819338551, 8189.9762529683785, 8210.712625058124, 8162.14297498763, 8279.13069127742, 8314.043884953233, 8322.375821813373, 8335.791605209874, 2131.0623325736706, 2176.804087632113, 2360.858348499087, 2382.7498112698177, 2386.570417324881, 1886.7830199527093, 2189.419803751999, 2332.7084114485688, 2377.6909001829736, 2379.119725701484, 2297.0, 2342.882855857209, 2343.5078633486987, 2346.9178578749747, 2361.197192954395, 2111.841611879115, 2164.188429338998, 2347.389678683546, 2372.3476044087843, 2374.7387787343378, 2139.9786002139936, 2338.9064437422485, 2378.595638741418, 2379.4646204604, 2381.13088722615, 8105.189481051907, 8302.916970830274, 8309.542975136364, 8314.542700151489, 8320.251177394064, 5105.540501354859, 5155.149400348938, 5155.226715992631, 5174.0, 5189.455107213764, 3355.7147642450423, 3383.7631365804405, 3510.7717998330027, 3512.227309991798, 3520.3135388599235, 991.7024892532212, 1027.5357615398027, 1028.3521381529663, 1069.107295408335, 1078.1321036565562, 10910.454477276104, 10915.672529824038, 10920.836187457195, 10930.01629853317, 10943.0, 4342.5874541918465, 4452.109578084396, 4606.216943119678, 4668.883277918079, 4699.107169637758, 9532.952335238419, 9535.47554884474, 9539.90460095404, 9543.33196676226, 9565.808683826424, 4978.950210497848, 4980.078685443204, 4990.90018199634, 5013.047520971004, 5024.899502009939, 4500.977495112504, 4504.076664283814, 4523.072770082191, 4527.4340707411575, 4534.183846907522, 3273.7053665170247, 3770.7171962102952, 3837.2517359115263, 3874.96125038746, 3876.980615096963, 1224.8530176378893, 1228.729679470515, 1229.7601967616408, 1236.6351926181799, 1244.4337826289197, 1055.2613170780485, 1078.9514471848786, 1078.978420431587, 1104.9779004420027, 1396.7346204221164, 7493.55038697669, 7521.210272921374, 7568.167501574822, 7602.163761986177, 7656.655450504741, 501.7390956702494, 507.9111155547838, 513.4352212566147, 513.542946777361, 513.8432778002744, 5750.913736293959, 5833.620814647034, 5849.590528663038, 6082.0, 6267.96866015667, 8131.5527645978855, 9757.463339516253, 9829.4102353859, 10022.699319020441, 10023.2482563808, 9843.212542996544, 9923.404595724136, 9938.602455901828, 9959.950200248952, 9982.750431239278, 7655.961720191363, 7818.960905195438, 7829.921700782919, 7851.05787305527, 7853.803654908559, 7724.111727151225, 7741.180822506819, 7752.341051010501, 7763.146053934176, 7768.417368697484, 8639.352048596254, 8944.86582701273, 9080.954595226982, 9084.31867609945, 9132.817343652956, 8998.235150012322, 9055.501947392957, 9101.317401194805, 9132.178103970675, 9215.723528293895, 7189.496735228484, 7354.558726476428, 7356.117265928123, 7357.19070902211, 7359.1169059713175, 7866.898634191332, 7918.524888506708, 7930.0, 7934.484258523177, 7941.8411631768195, 7006.474514411541, 7355.485116042039, 7383.667734952048, 7493.850122997618, 7534.39724822002, 7125.572465652078, 7265.0, 7321.3776828968, 7388.335049845539, 7435.442341824277, 7361.484696071224, 7395.852082958419, 7401.925980740124, 7405.8148546286775, 7409.518381305198, 6573.375529324707, 6736.932630673827, 6738.764143254963, 6793.048973143863, 6794.252632210551, 6824.897626535705, 6900.102986611909, 6901.0, 6903.585784852925, 6909.2745261746795], "unit": "ms", "name": "mootools.html", "value": 4592.788030034669}, {"lowerIsBetter": false, "replicates": [318.48564568222326, 326.1357402882363, 327.84099711639846, 328.2597742091583, 332.793667925886, 6718.46252299816, 6749.628770417625, 6794.932050679492, 6807.625580593071, 6850.280720524348, 6385.872282554346, 6514.1205937198465, 6517.92454245049, 6623.701933412996, 6774.796756097325, 4070.61329173728, 4081.5102187737366, 4754.168020596399, 5018.548330650232, 5051.217061355477, 4388.626966707834, 5021.397432308128, 5023.447420783711, 5025.673331233458, 5044.470330615288, 3843.5579908310483, 4180.912962629708, 4779.856604301876, 4905.822602575374, 4911.975440122795, 4673.1121086993535, 4868.636781701111, 4951.900961980777, 5014.52362025607, 5018.322526458918, 4265.274903266452, 4280.101178752435, 4281.678874084456, 4285.078708077778, 4296.613304802551, 5467.835964921059, 6372.0, 6382.680865956683, 6386.2975072741965, 6422.743090276384, 5783.421657834225, 5923.851903702442, 5940.46535811779, 5940.613860099123, 5946.762129514815, 6441.903371449432, 6682.83292917681, 7275.563466192046, 7276.927230727678, 7279.708811647528, 4805.279208118775, 4807.399075115611, 4807.471178170398, 4808.903821923577, 4820.566149046567, 7413.258674132544, 7565.35694465971, 7679.347255483291, 7680.654370553282, 7697.692092316301, 4439.733615983051, 4719.59883409914, 4898.02039592083, 4905.23968784839, 4906.411230652345, 4981.975090124526, 5008.924866127011, 5010.298558201855, 5011.523905228997, 5013.573846223112, 4808.519148085164, 5911.438413350725, 5921.881562368814, 5922.822315330547, 5937.881242375129, 7014.438844892396, 7228.927710722825, 7250.238724933912, 7290.125184977836, 7308.159561650478, 1425.4796999095256, 1719.2779032806252, 1742.2072956804623, 1742.3901634428103, 1744.6510697860224, 1060.734816295926, 1071.9678409647568, 1092.5247517329988, 1120.1207052463776, 1148.3282279866205, 6674.432673222734, 6676.232233293136, 6686.3313668632745, 6812.523123381316, 6873.931260687329, 6520.728457950654, 7343.669534870837, 7612.7716168515035, 7617.6572054257695, 7631.122420921665, 6675.446210329919, 6818.318168183142, 6851.417629501449, 6865.725370985205, 6885.655717214119, 3984.083660758042, 4051.7771522565954, 4053.7365071270274, 4054.7972601369815, 4061.472008638858, 6919.619420931796, 7381.224971378036, 7914.169012253746, 7926.603669816486, 7945.324647405036, 6939.687714052779, 7612.238776122344, 7895.9210407896335, 7967.681292748341, 7986.840263194704, 7894.921050789533, 7917.247861453153, 7921.801954951173, 7924.722634707758, 7928.960355198187, 7381.04046473955, 7591.58246296459, 7622.047244094489, 7624.27569380908, 7628.8855667163925, 7480.812979675552, 7501.962490187514, 7512.211217822269, 7520.473566850268, 7530.209328020698, 7282.96358518204, 7383.778486645409, 7870.5671188082915, 7893.526388416713, 7914.881276780738, 4279.400883876322, 4785.401824771903, 4918.680285781413, 4930.260460930889, 4931.605471562339, 7431.70273189088, 7614.885776713243, 7614.961925190339, 7618.847623047619, 7619.923800762143, 7341.74303899361, 7344.522606030591, 7347.926520734724, 7356.448266379936, 7359.300866417681, 7064.929350706427, 7322.2677732228485, 7323.9267607323245, 7329.853402932018, 7331.890021649573, 6853.9314606853295, 6983.266756990646, 7152.928470715435, 7170.67731952053, 7185.497015208885, 6202.85247229264, 7116.512908674816, 7136.5004449690105, 7224.205337412775, 7257.455690823103, 7113.430925526049, 7184.46116541251, 7184.928150718426, 7191.316824901626, 7208.89186662211], "unit": "ms", "name": "prototype.html", "value": 5275.135952508286}, {"lowerIsBetter": false, "replicates": [745.7539012125998, 797.7287722174459, 815.160384803652, 829.6225217526027, 831.4055450352998, 14418.206998615085, 14721.852781472182, 14724.337404816783, 14736.484223052195, 14754.926225368858, 13590.912726981842, 13691.931540342284, 13711.108777929428, 13715.0, 13743.969202309816, 729.4565548666251, 751.1511991449654, 774.2103054884014, 774.7753151586062, 895.6641259527677, 939.3002213351064, 944.4286206844863, 956.8421210500294, 961.8653388525612, 963.4363897120193, 807.4791759315239, 1000.9049140331657, 1020.4999550220375, 1020.5509575786667, 1024.8718910136233, 804.3565147881701, 811.8579248631495, 1002.1081237698454, 1030.2530665267695, 1035.7151783259665, 747.5066456138976, 757.5000499670191, 759.2142132892429, 760.0347558600602, 760.1676164599754, 14734.926325368411, 14901.850981490155, 14932.925335373362, 14946.775798363033, 14966.925165374212, 12122.454489547903, 12284.324362160078, 12387.566435174816, 12532.81200781989, 12663.93668031654, 8236.970378702663, 9067.818643627157, 9068.54657267134, 9905.80188396228, 9976.650817221362, 3055.8472076396315, 3565.0196196046036, 3592.3713350163616, 3638.272345530878, 3661.7986010769396, 82120.17879821185, 82170.58914705388, 82379.0, 83968.16031839665, 84360.0, 9578.808423831484, 9700.90299097014, 9708.563114659857, 9749.463779492196, 9893.802123957625, 21826.672599911013, 21831.126754929624, 21837.890810545847, 21849.344519664435, 21865.0, 7522.548647081193, 7528.0, 7547.207543207884, 7674.923250767532, 7896.447248692652, 4049.1091959768805, 4051.736637118578, 4054.7567145971334, 4055.858044968412, 4092.733972291851, 3511.719062474996, 3573.0710015396185, 3579.1052236940764, 3582.874599389009, 3587.0852932502567, 627.9340669229756, 641.6374748267214, 643.4369926314475, 661.3683931845077, 664.1963224498314, 426.4392324093807, 448.8204718112781, 493.43008824807407, 497.6566169343142, 510.1480527519052, 8347.0, 8459.450135741281, 8473.661053557911, 8701.411228077195, 8707.869381959275, 532.2548432194958, 581.4418158567738, 600.1717629671026, 628.955973081889, 678.3928384096206, 3761.3417651910804, 3890.2608504384643, 3952.6245006724316, 3996.84012639497, 4142.772147531854, 95140.09719805703, 96512.0, 105514.0, 106000.46999764952, 106336.0, 68373.55571887911, 80989.0, 82532.58733706293, 84117.57941210255, 86777.1322286769, 57104.714476427354, 57212.71393643005, 58992.11511827326, 75675.62162189154, 76589.0, 6876.965615171892, 8774.824503510023, 8802.95598522029, 8910.331725120512, 9173.633054677739, 48790.75604621954, 51923.48076519187, 52564.0, 55856.882862341714, 56008.15987760105, 72072.9189062154, 72461.0, 73062.0, 75320.24679753352, 75851.62074189594, 10910.290831095954, 10913.945430273116, 10928.344299342065, 11299.604513842305, 11850.288982661068, 11980.28118312904, 12213.633590992284, 12215.26708397499, 12394.81407778902, 12460.190087644274, 11662.650120496399, 11700.590479333523, 11726.00328972047, 11771.470283837076, 11822.46798894069, 11716.414179291172, 11729.706757331134, 11744.060475161796, 11797.0, 11816.172867899164, 11011.44942752843, 11059.926115091732, 11211.943940280247, 11559.711007224887, 11891.702707432383, 9207.217386522221, 9292.488913109844, 9311.557613956878, 9494.477803720585, 9496.620135194515, 8587.65649374018, 9968.651097211563, 9981.800363992825, 9989.168251496252, 10100.595976160872], "unit": "ms", "name": "yui.html", "value": 6958.821485646885}], "name": "dromaeo_css", "value": 7633.1878204760715}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 107.0, 101.0, 110.0, 110.0, 107.0, 109.0, 108.0, 105.0, 108.0], "unit": "ms", "name": "ai-astar", "value": 107.4}, {"lowerIsBetter": true, "replicates": [168.0, 147.0, 144.0, 151.0, 119.0, 142.0, 146.0, 127.0, 155.0, 119.0], "unit": "ms", "name": "audio-beat-detection", "value": 141.8}, {"lowerIsBetter": true, "replicates": [184.0, 180.0, 181.0, 185.0, 184.0, 185.0, 183.0, 185.0, 185.0, 182.0], "unit": "ms", "name": "audio-dft", "value": 183.4}, {"lowerIsBetter": true, "replicates": [67.0, 66.0, 71.0, 72.0, 54.0, 56.0, 55.0, 71.0, 74.0, 55.0], "unit": "ms", "name": "audio-fft", "value": 64.1}, {"lowerIsBetter": true, "replicates": [85.0, 84.0, 113.0, 74.0, 74.0, 75.0, 106.0, 73.0, 75.0, 109.0], "unit": "ms", "name": "audio-oscillator", "value": 86.8}, {"lowerIsBetter": true, "replicates": [115.0, 132.0, 96.0, 85.0, 85.0, 85.0, 86.0, 86.0, 85.0, 84.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 93.9}, {"lowerIsBetter": true, "replicates": [94.0, 93.0, 93.0, 94.0, 93.0, 94.0, 93.0, 93.0, 93.0, 92.0], "unit": "ms", "name": "imaging-darkroom", "value": 93.2}, {"lowerIsBetter": true, "replicates": [86.0, 87.0, 82.0, 85.0, 86.0, 86.0, 86.0, 88.0, 85.0, 85.0], "unit": "ms", "name": "imaging-desaturate", "value": 85.6}, {"lowerIsBetter": true, "replicates": [55.0, 54.0, 53.0, 53.0, 55.0, 53.0, 54.0, 65.0, 53.0, 53.0], "unit": "ms", "name": "json-parse-financial", "value": 54.8}, {"lowerIsBetter": true, "replicates": [65.0, 63.0, 63.0, 63.0, 68.0, 68.0, 68.0, 69.0, 69.0, 68.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 66.4}, {"lowerIsBetter": true, "replicates": [81.0, 82.0, 82.0, 85.0, 95.0, 105.0, 105.0, 107.0, 84.0, 83.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 90.9}, {"lowerIsBetter": true, "replicates": [121.0, 130.0, 126.0, 120.0, 118.0, 123.0, 124.0, 121.0, 127.0, 130.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 124.0}, {"lowerIsBetter": true, "replicates": [135.0, 135.0, 135.0, 134.0, 134.0, 117.0, 136.0, 134.0, 134.0, 122.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 131.6}, {"lowerIsBetter": true, "replicates": [65.0, 64.0, 65.0, 66.0, 65.0, 65.0, 67.0, 65.0, 66.0, 65.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 65.3}], "name": "kraken", "value": 1389.1999999999998}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [147.25371815638346], "unit": "score", "name": "Richards", "value": 239.7358820000001}, {"lowerIsBetter": false, "replicates": [161.91709844559585], "unit": "score", "name": "DeltaBlue", "value": 408.34476799999993}, {"lowerIsBetter": false, "replicates": [279.9552071668533], "unit": "score", "name": "Encrypt", "value": 950.7985320000004}, {"lowerIsBetter": false, "replicates": [4651.162790697675], "unit": "score", "name": "Decrypt", "value": 57.228915}, {"lowerIsBetter": false, "replicates": [1697.792869269949], "unit": "score", "name": "RayTrace", "value": 435.85352100000017}, {"lowerIsBetter": false, "replicates": [786.7820613690008], "unit": "score", "name": "Earley", "value": 847.0744729999998}, {"lowerIsBetter": false, "replicates": [12759.493670886075], "unit": "score", "name": "Boyer", "value": 52.23271527777782}, {"lowerIsBetter": false, "replicates": [27027.027027027027], "unit": "score", "name": "RegExp", "value": 33.70644499999999}, {"lowerIsBetter": false, "replicates": [672.9475100942127], "unit": "score", "name": "Splay", "value": 121.09562600000001}, {"lowerIsBetter": false, "replicates": [4513.513513513513], "unit": "score", "name": "NavierStokes", "value": 328.7904191616765}], "name": "v8_7", "value": 20685.527575064625}]} 06:12:47 INFO - RETURN: dromaeo_css: 7633.19 06:12:47 INFO - RETURN: kraken: 1389.20 06:12:47 INFO - RETURN: v8_7: 20685.53 06:12:47 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,59]]", "result": "20685.53"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,59]]", "result": "1389.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,59]]", "result": "7633.19"}}} 06:12:47 INFO - Return code: 0 06:12:47 INFO - # TBPL SUCCESS # 06:12:47 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:12:47 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:12:47 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:12:47 INFO - 2015-11-20 06:12:47.985 screenresolution[1768:11525] starting screenresolution argv=screenresolution get 06:12:47 INFO - 2015-11-20 06:12:47.988 screenresolution[1768:11525] Display 0: 1600x1200x32@60 06:12:47 INFO - 2015-11-20 06:12:47.994 screenresolution[1769:11528] starting screenresolution argv=screenresolution list 06:12:47 INFO - Available Modes on Display 0 06:12:47 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:12:47 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:12:47 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:12:47 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:12:48 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:12:48 INFO - Intel Iris: 06:12:48 INFO - Chipset Model: Intel Iris 06:12:48 INFO - Type: GPU 06:12:48 INFO - Bus: Built-In 06:12:48 INFO - VRAM (Dynamic, Max): 1536 MB 06:12:48 INFO - Vendor: Intel (0x8086) 06:12:48 INFO - Device ID: 0x0a2e 06:12:48 INFO - Revision ID: 0x0009 06:12:48 INFO - Displays: 06:12:48 INFO - Display: 06:12:48 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:12:48 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:12:48 INFO - Display Serial Number: 1600x1200 60 06:12:48 INFO - Main Display: Yes 06:12:48 INFO - Mirror: Off 06:12:48 INFO - Online: Yes 06:12:48 INFO - Rotation: Supported 06:12:48 INFO - Return code: 0 06:12:48 INFO - Running post-action listener: _resource_record_post_action 06:12:48 INFO - Running post-run listener: _resource_record_post_run 06:12:49 INFO - Total resource usage - Wall time: 1239s; CPU: 53.0%; Read bytes: 33607168; Write bytes: 690382848; Read time: 348; Write time: 2177 06:12:49 INFO - install - Wall time: 31s; CPU: 54.0%; Read bytes: 345356800; Write bytes: 348554752; Read time: 27460; Write time: 717 06:12:49 INFO - run-tests - Wall time: 1209s; CPU: 53.0%; Read bytes: 31579648; Write bytes: 340771328; Read time: 326; Write time: 1458 06:12:49 INFO - Running post-run listener: _upload_blobber_files 06:12:49 INFO - Blob upload gear active. 06:12:49 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 06:12:49 INFO - Copying logs to upload dir... 06:12:49 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1286.482480 ========= master_lag: 3.81 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 30 secs) (at 2015-11-20 06:12:53.120189) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-20 06:12:53.123751) ========= 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.A2KxRRwelS/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.UzyfVLRTNJ/Listeners TMPDIR=/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False build_url:https://queue.taskcluster.net/v1/task/dzXSc70PTIC5AYxLMqMDlA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.009258 build_url: 'https://queue.taskcluster.net/v1/task/dzXSc70PTIC5AYxLMqMDlA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg' ========= master_lag: 0.22 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-20 06:12:53.357407) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 06:12:53.357688) ========= 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.A2KxRRwelS/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.UzyfVLRTNJ/Listeners TMPDIR=/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005110 ========= master_lag: 0.01 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 06:12:53.375923) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-20 06:12:53.376234) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-20 06:12:53.376661) ========= ========= Total master_lag: 4.17 =========