builder: mozilla-central_yosemite_test-dromaeojs-e10s slave: t-yosemite-r5-0002 starttime: 1447506551.63 results: success (0) buildid: 20151114030404 builduid: 568447c2ffd94f3882ec6291393c705d revision: 202b199b9fcf37a687bef882f2513e191f079622 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-14 05:09:11.630668) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-14 05:09:11.631134) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-14 05:09:11.631458) ========= 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.0kv5II4Bqc/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.3l5unflI0n/Listeners TMPDIR=/var/folders/45/v0hy50tj6n16mg96l0s6z6wm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.005987 basedir: '/builds/slave/test' ========= master_lag: 0.10 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-14 05:09:11.738299) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-14 05:09:11.738626) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-14 05:09:11.783767) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-14 05:09:11.784069) ========= 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.0kv5II4Bqc/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.3l5unflI0n/Listeners TMPDIR=/var/folders/45/v0hy50tj6n16mg96l0s6z6wm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False program finished with exit code 0 elapsedTime=0.015670 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-14 05:09:11.834471) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-14 05:09:11.834922) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-14 05:09:11.835360) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-14 05:09:11.835759) ========= 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.0kv5II4Bqc/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.3l5unflI0n/Listeners TMPDIR=/var/folders/45/v0hy50tj6n16mg96l0s6z6wm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False --2015-11-14 05:09:11-- 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, 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.41G=0s 2015-11-14 05:09:12 (1.41 GB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.269706 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-14 05:09:12.125817) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-14 05:09:12.126166) ========= 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.0kv5II4Bqc/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.3l5unflI0n/Listeners TMPDIR=/var/folders/45/v0hy50tj6n16mg96l0s6z6wm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False program finished with exit code 0 elapsedTime=0.136605 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-14 05:09:12.286731) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-14 05:09:12.287091) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 202b199b9fcf37a687bef882f2513e191f079622 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 202b199b9fcf37a687bef882f2513e191f079622 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.0kv5II4Bqc/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.3l5unflI0n/Listeners TMPDIR=/var/folders/45/v0hy50tj6n16mg96l0s6z6wm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False 2015-11-14 05:09:12,372 truncating revision to first 12 chars 2015-11-14 05:09:12,372 Setting DEBUG logging. 2015-11-14 05:09:12,372 attempt 1/10 2015-11-14 05:09:12,372 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/202b199b9fcf?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-14 05:09:12,621 unpacking tar archive at: mozilla-central-202b199b9fcf/testing/mozharness/ program finished with exit code 0 elapsedTime=0.744538 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-14 05:09:13.048012) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-14 05:09:13.048341) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-14 05:09:13.064369) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-14 05:09:13.064717) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-14 05:09:13.065162) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 27 secs) (at 2015-11-14 05:09:13.065485) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--system-bits', '64', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.0kv5II4Bqc/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.3l5unflI0n/Listeners TMPDIR=/var/folders/45/v0hy50tj6n16mg96l0s6z6wm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False 05:09:13 INFO - MultiFileLogger online at 20151114 05:09:13 in /builds/slave/test 05:09:13 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:09:13 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:09:13 INFO - {'append_to_log': False, 05:09:13 INFO - 'base_work_dir': '/builds/slave/test', 05:09:13 INFO - 'blob_upload_branch': 'Firefox', 05:09:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:09:13 INFO - 'branch': 'Firefox', 05:09:13 INFO - 'buildbot_json_path': 'buildprops.json', 05:09:13 INFO - 'config_files': ('talos/mac_config.py',), 05:09:13 INFO - 'default_actions': ('clobber', 05:09:13 INFO - 'read-buildbot-config', 05:09:13 INFO - 'download-and-extract', 05:09:13 INFO - 'populate-webroot', 05:09:13 INFO - 'create-virtualenv', 05:09:13 INFO - 'install', 05:09:13 INFO - 'run-tests'), 05:09:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:09:13 INFO - 'download_minidump_stackwalk': True, 05:09:13 INFO - 'download_symbols': 'ondemand', 05:09:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:09:13 INFO - 'tooltool.py': '/tools/tooltool.py', 05:09:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:09:13 INFO - '/tools/misc-python/virtualenv.py')}, 05:09:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:09:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:09:13 INFO - 'installer_path': 'installer.exe', 05:09:13 INFO - 'log_level': 'info', 05:09:13 INFO - 'log_name': 'talos', 05:09:13 INFO - 'log_to_console': True, 05:09:13 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:09:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:09:13 INFO - 'opt_config_files': (), 05:09:13 INFO - 'pip_index': False, 05:09:13 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:09:13 INFO - 'cmd': ('bash', 05:09:13 INFO - '-c', 05:09:13 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:09:13 INFO - 'enabled': True, 05:09:13 INFO - 'halt_on_failure': False, 05:09:13 INFO - 'name': 'check_screen_resolution'},), 05:09:13 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:09:13 INFO - 'cmd': ('bash', 05:09:13 INFO - '-c', 05:09:13 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:09:13 INFO - 'enabled': True, 05:09:13 INFO - 'halt_on_failure': False, 05:09:13 INFO - 'name': 'check_screen_resolution'},), 05:09:13 INFO - 'run_cmd_checks_enabled': True, 05:09:13 INFO - 'sps_profile': False, 05:09:13 INFO - 'sps_profile_interval': 0, 05:09:13 INFO - 'suite': 'dromaeojs-e10s', 05:09:13 INFO - 'system_bits': '64', 05:09:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:09:13 INFO - 'title': 't-yosemite-r5-0002', 05:09:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:09:13 INFO - 'use_talos_json': True, 05:09:13 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:09:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:09:13 INFO - 'work_dir': 'build'} 05:09:13 INFO - ##### 05:09:13 INFO - ##### Running clobber step. 05:09:13 INFO - ##### 05:09:13 INFO - Running pre-action listener: _resource_record_pre_action 05:09:13 INFO - Running main action method: clobber 05:09:13 INFO - rmtree: /builds/slave/test/build 05:09:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:09:18 INFO - Running post-action listener: _resource_record_post_action 05:09:18 INFO - ##### 05:09:18 INFO - ##### Running read-buildbot-config step. 05:09:18 INFO - ##### 05:09:18 INFO - Running pre-action listener: _resource_record_pre_action 05:09:18 INFO - Running main action method: read_buildbot_config 05:09:18 INFO - Using buildbot properties: 05:09:18 INFO - { 05:09:18 INFO - "properties": { 05:09:18 INFO - "buildnumber": 9, 05:09:18 INFO - "product": "firefox", 05:09:18 INFO - "script_repo_revision": "production", 05:09:18 INFO - "builddir": "mozilla-central_yosemite_test-dromaeojs-e10s", 05:09:18 INFO - "repository": "", 05:09:18 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 mozilla-central talos dromaeojs-e10s", 05:09:18 INFO - "buildid": "20151114030404", 05:09:18 INFO - "slavename": "t-yosemite-r5-0002", 05:09:18 INFO - "stage_platform": "macosx64", 05:09:18 INFO - "basedir": "/builds/slave/test", 05:09:18 INFO - "nightly_build": "True", 05:09:18 INFO - "project": "", 05:09:18 INFO - "platform": "yosemite", 05:09:18 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 05:09:18 INFO - "slavebuilddir": "test", 05:09:18 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 05:09:18 INFO - "branch": "mozilla-central", 05:09:18 INFO - "repo_path": "mozilla-central", 05:09:18 INFO - "pgo_build": "False", 05:09:18 INFO - "builduid": "568447c2ffd94f3882ec6291393c705d", 05:09:18 INFO - "revision": "202b199b9fcf37a687bef882f2513e191f079622" 05:09:18 INFO - }, 05:09:18 INFO - "sourcestamp": { 05:09:18 INFO - "repository": "", 05:09:18 INFO - "hasPatch": false, 05:09:18 INFO - "project": "", 05:09:18 INFO - "branch": "mozilla-central-macosx64-talos", 05:09:18 INFO - "changes": [ 05:09:18 INFO - { 05:09:18 INFO - "category": null, 05:09:18 INFO - "files": [ 05:09:18 INFO - { 05:09:18 INFO - "url": null, 05:09:18 INFO - "name": "https://queue.taskcluster.net/v1/task/aPTj2c3WQSOjwP_30wV6RQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 05:09:18 INFO - } 05:09:18 INFO - ], 05:09:18 INFO - "repository": "", 05:09:18 INFO - "rev": "202b199b9fcf37a687bef882f2513e191f079622", 05:09:18 INFO - "who": "sendchange", 05:09:18 INFO - "when": 1447506467, 05:09:18 INFO - "number": 6662077, 05:09:18 INFO - "comments": "", 05:09:18 INFO - "project": "", 05:09:18 INFO - "at": "Sat 14 Nov 2015 05:07:47", 05:09:18 INFO - "branch": "mozilla-central-macosx64-talos", 05:09:18 INFO - "revlink": "", 05:09:18 INFO - "properties": [ 05:09:18 INFO - [ 05:09:18 INFO - "buildid", 05:09:18 INFO - "20151114030404", 05:09:18 INFO - "Change" 05:09:18 INFO - ], 05:09:18 INFO - [ 05:09:18 INFO - "builduid", 05:09:18 INFO - "568447c2ffd94f3882ec6291393c705d", 05:09:18 INFO - "Change" 05:09:18 INFO - ], 05:09:18 INFO - [ 05:09:18 INFO - "nightly_build", 05:09:18 INFO - "True", 05:09:18 INFO - "Change" 05:09:18 INFO - ], 05:09:18 INFO - [ 05:09:18 INFO - "pgo_build", 05:09:18 INFO - "False", 05:09:18 INFO - "Change" 05:09:18 INFO - ] 05:09:18 INFO - ], 05:09:18 INFO - "revision": "202b199b9fcf37a687bef882f2513e191f079622" 05:09:18 INFO - } 05:09:18 INFO - ], 05:09:18 INFO - "revision": "202b199b9fcf37a687bef882f2513e191f079622" 05:09:18 INFO - } 05:09:18 INFO - } 05:09:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/aPTj2c3WQSOjwP_30wV6RQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 05:09:18 INFO - Running post-action listener: _resource_record_post_action 05:09:18 INFO - ##### 05:09:18 INFO - ##### Running download-and-extract step. 05:09:18 INFO - ##### 05:09:18 INFO - Running pre-action listener: _resource_record_pre_action 05:09:18 INFO - Running main action method: download_and_extract 05:09:18 INFO - mkdir: /builds/slave/test/build/tests 05:09:18 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:09:18 INFO - https://queue.taskcluster.net/v1/task/aPTj2c3WQSOjwP_30wV6RQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 05:09:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aPTj2c3WQSOjwP_30wV6RQ/artifacts/public/build/test_packages.json 05:09:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aPTj2c3WQSOjwP_30wV6RQ/artifacts/public/build/test_packages.json 05:09:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aPTj2c3WQSOjwP_30wV6RQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 05:09:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aPTj2c3WQSOjwP_30wV6RQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 05:09:40 INFO - Downloaded 1149 bytes. 05:09:40 INFO - Reading from file /builds/slave/test/build/test_packages.json 05:09:40 INFO - Using the following test package requirements: 05:09:40 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 05:09:40 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:09:40 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 05:09:40 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:09:40 INFO - u'jsshell-mac.zip'], 05:09:40 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:09:40 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 05:09:40 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 05:09:40 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:09:40 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 05:09:40 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:09:40 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 05:09:40 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:09:40 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 05:09:40 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 05:09:40 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:09:40 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 05:09:40 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:09:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:09:40 INFO - https://queue.taskcluster.net/v1/task/aPTj2c3WQSOjwP_30wV6RQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:09:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aPTj2c3WQSOjwP_30wV6RQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:09:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aPTj2c3WQSOjwP_30wV6RQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:09:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aPTj2c3WQSOjwP_30wV6RQ/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:09:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aPTj2c3WQSOjwP_30wV6RQ/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:09:45 INFO - Downloaded 17460030 bytes. 05:09:45 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:09:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:09:45 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 05:09:57 INFO - Return code: 0 05:09:57 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:09:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:09:57 INFO - https://queue.taskcluster.net/v1/task/aPTj2c3WQSOjwP_30wV6RQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:09:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aPTj2c3WQSOjwP_30wV6RQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:09:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aPTj2c3WQSOjwP_30wV6RQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:09:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aPTj2c3WQSOjwP_30wV6RQ/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:09:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aPTj2c3WQSOjwP_30wV6RQ/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:09:58 INFO - Downloaded 17460030 bytes. 05:09:58 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 05:09:58 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:09:58 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 05:10:12 INFO - Return code: 0 05:10:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:10:12 INFO - https://queue.taskcluster.net/v1/task/aPTj2c3WQSOjwP_30wV6RQ/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 05:10:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aPTj2c3WQSOjwP_30wV6RQ/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 05:10:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aPTj2c3WQSOjwP_30wV6RQ/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 05:10:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aPTj2c3WQSOjwP_30wV6RQ/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:10:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aPTj2c3WQSOjwP_30wV6RQ/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:10:13 INFO - Downloaded 11131693 bytes. 05:10:13 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:10:13 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 05:10:13 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 05:10:14 INFO - Return code: 0 05:10:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:10:14 INFO - https://queue.taskcluster.net/v1/task/aPTj2c3WQSOjwP_30wV6RQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 05:10:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aPTj2c3WQSOjwP_30wV6RQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 05:10:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aPTj2c3WQSOjwP_30wV6RQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 05:10:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aPTj2c3WQSOjwP_30wV6RQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 05:10:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aPTj2c3WQSOjwP_30wV6RQ/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:10:17 INFO - Downloaded 108813146 bytes. 05:10:17 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/aPTj2c3WQSOjwP_30wV6RQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 05:10:17 INFO - mkdir: /builds/slave/test/properties 05:10:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:10:17 INFO - Writing to file /builds/slave/test/properties/build_url 05:10:17 INFO - Contents: 05:10:17 INFO - build_url:https://queue.taskcluster.net/v1/task/aPTj2c3WQSOjwP_30wV6RQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 05:10:17 INFO - Running post-action listener: _resource_record_post_action 05:10:17 INFO - Running post-action listener: set_extra_try_arguments 05:10:17 INFO - ##### 05:10:17 INFO - ##### Running populate-webroot step. 05:10:17 INFO - ##### 05:10:17 INFO - Running pre-action listener: _resource_record_pre_action 05:10:17 INFO - Running main action method: populate_webroot 05:10:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:10:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:10:17 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 05:10:17 INFO - '../fennec_ids.txt'], 05:10:17 INFO - 'tests': ['tcheck2']}, 05:10:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:10:17 INFO - '--tppagecycles', 05:10:17 INFO - '7'], 05:10:17 INFO - 'tests': ['tsvgm']}}, 05:10:17 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:10:17 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:10:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:10:17 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:10:17 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:10:17 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:10:17 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:10:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:10:17 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:10:17 INFO - 'talos_options': ['--e10s'], 05:10:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:10:17 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:10:17 INFO - 'tests': ['damp', 'tps']}, 05:10:17 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:10:17 INFO - 'talos_options': ['--e10s'], 05:10:17 INFO - 'tests': ['damp', 'tps']}, 05:10:17 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:10:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:10:17 INFO - 'other': {'tests': ['a11yr', 05:10:17 INFO - 'ts_paint', 05:10:17 INFO - 'tpaint', 05:10:17 INFO - 'sessionrestore', 05:10:17 INFO - 'sessionrestore_no_auto_restore']}, 05:10:17 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:10:17 INFO - 'tests': ['a11yr', 05:10:17 INFO - 'ts_paint', 05:10:17 INFO - 'tpaint', 05:10:17 INFO - 'sessionrestore', 05:10:17 INFO - 'sessionrestore_no_auto_restore']}, 05:10:17 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:10:17 INFO - 'tests': ['a11yr', 05:10:17 INFO - 'ts_paint', 05:10:17 INFO - 'tpaint', 05:10:17 INFO - 'sessionrestore', 05:10:17 INFO - 'sessionrestore_no_auto_restore']}, 05:10:17 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:10:17 INFO - 'tests': ['a11yr', 05:10:17 INFO - 'ts_paint', 05:10:17 INFO - 'tpaint', 05:10:17 INFO - 'sessionrestore', 05:10:17 INFO - 'sessionrestore_no_auto_restore']}, 05:10:17 INFO - 'other_l64': {'tests': ['a11yr', 05:10:17 INFO - 'ts_paint', 05:10:17 INFO - 'tpaint', 05:10:17 INFO - 'sessionrestore', 05:10:17 INFO - 'sessionrestore_no_auto_restore']}, 05:10:17 INFO - 'other_nol64': {'tests': ['a11yr', 05:10:17 INFO - 'ts_paint', 05:10:17 INFO - 'tpaint', 05:10:17 INFO - 'sessionrestore', 05:10:17 INFO - 'sessionrestore_no_auto_restore']}, 05:10:17 INFO - 'svgr': {'tests': ['tsvgx', 05:10:17 INFO - 'tsvgr_opacity', 05:10:17 INFO - 'tart', 05:10:17 INFO - 'tscrollx', 05:10:17 INFO - 'cart']}, 05:10:17 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:10:17 INFO - 'tests': ['tsvgx', 05:10:17 INFO - 'tsvgr_opacity', 05:10:17 INFO - 'tart', 05:10:17 INFO - 'tscrollx', 05:10:17 INFO - 'cart']}, 05:10:17 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:10:17 INFO - 'tests': ['tp5o']}, 05:10:17 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:10:17 INFO - 'talos_options': ['--e10s'], 05:10:17 INFO - 'tests': ['tp5o']}, 05:10:17 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:10:17 INFO - 'talos_options': ['--xperf_path', 05:10:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:10:17 INFO - 'tests': ['tp5n']}, 05:10:17 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:10:17 INFO - 'talos_options': ['--e10s', 05:10:17 INFO - '--xperf_path', 05:10:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:10:17 INFO - 'tests': ['tp5n']}}, 05:10:17 INFO - 'talos.zip': {'path': '', 05:10:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:10:17 INFO - Running post-action listener: _resource_record_post_action 05:10:17 INFO - ##### 05:10:17 INFO - ##### Running create-virtualenv step. 05:10:17 INFO - ##### 05:10:17 INFO - Running pre-action listener: _resource_record_pre_action 05:10:17 INFO - Running main action method: create_virtualenv 05:10:17 INFO - Creating virtualenv /builds/slave/test/build/venv 05:10:17 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:10:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:10:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:10:17 INFO - Using real prefix '/tools/python27' 05:10:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:10:19 INFO - Installing distribute.............................................................................................................................................................................................done. 05:10:23 INFO - Installing pip.................done. 05:10:23 INFO - Return code: 0 05:10:23 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:10:23 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:10:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:10:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:23 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:10:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:10:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:23 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 0x102065490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102042228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7b148b2f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f889f0>, '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 0x101ce8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101f7c8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0kv5II4Bqc/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.3l5unflI0n/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/45/v0hy50tj6n16mg96l0s6z6wm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:10:23 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:10:23 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:10:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0kv5II4Bqc/Render', 05:10:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:10:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:10:23 INFO - 'HOME': '/Users/cltbld', 05:10:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:10:23 INFO - 'LOGNAME': 'cltbld', 05:10:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:23 INFO - 'MOZ_NO_REMOTE': '1', 05:10:23 INFO - 'NO_EM_RESTART': '1', 05:10:23 INFO - 'PAGER': '/bin/cat', 05:10:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:10:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:10:23 INFO - 'PWD': '/builds/slave/test', 05:10:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:10:23 INFO - 'SHELL': '/bin/bash', 05:10:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3l5unflI0n/Listeners', 05:10:23 INFO - 'TMPDIR': '/var/folders/45/v0hy50tj6n16mg96l0s6z6wm00000w/T/', 05:10:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:10:23 INFO - 'USER': 'cltbld', 05:10:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:10:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:10:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:23 INFO - 'XPC_FLAGS': '0x0', 05:10:23 INFO - 'XPC_SERVICE_NAME': '0', 05:10:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:10:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:23 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:10:23 INFO - Cleaning up... 05:10:23 INFO - Return code: 0 05:10:23 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:10:23 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:10:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:10:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:23 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:10:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:10:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:23 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 0x102065490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102042228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7b148b2f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f889f0>, '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 0x101ce8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101f7c8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0kv5II4Bqc/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.3l5unflI0n/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/45/v0hy50tj6n16mg96l0s6z6wm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:10:23 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:10:23 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:10:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0kv5II4Bqc/Render', 05:10:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:10:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:10:23 INFO - 'HOME': '/Users/cltbld', 05:10:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:10:23 INFO - 'LOGNAME': 'cltbld', 05:10:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:23 INFO - 'MOZ_NO_REMOTE': '1', 05:10:23 INFO - 'NO_EM_RESTART': '1', 05:10:23 INFO - 'PAGER': '/bin/cat', 05:10:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:10:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:10:23 INFO - 'PWD': '/builds/slave/test', 05:10:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:10:23 INFO - 'SHELL': '/bin/bash', 05:10:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3l5unflI0n/Listeners', 05:10:23 INFO - 'TMPDIR': '/var/folders/45/v0hy50tj6n16mg96l0s6z6wm00000w/T/', 05:10:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:10:23 INFO - 'USER': 'cltbld', 05:10:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:10:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:10:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:23 INFO - 'XPC_FLAGS': '0x0', 05:10:23 INFO - 'XPC_SERVICE_NAME': '0', 05:10:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:10:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:24 INFO - Downloading/unpacking psutil>=0.7.1 05:10:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:10:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:10:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:10:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:10:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:10:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:10:26 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 05:10:26 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 05:10:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:10:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:10:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:10:26 INFO - Installing collected packages: psutil 05:10:26 INFO - Running setup.py install for psutil 05:10:26 INFO - building 'psutil._psutil_osx' extension 05:10:26 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:10:28 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:10:28 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:10:28 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:10:29 INFO - building 'psutil._psutil_posix' extension 05:10:29 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:10:29 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:10:29 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:10:29 INFO - ^ 05:10:29 INFO - 1 warning generated. 05:10:29 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:10:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:10:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:10:29 INFO - Successfully installed psutil 05:10:29 INFO - Cleaning up... 05:10:29 INFO - Return code: 0 05:10:29 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:10:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:10:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:10:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:10:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:10:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x102065490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102042228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7b148b2f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f889f0>, '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 0x101ce8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101f7c8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0kv5II4Bqc/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.3l5unflI0n/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/45/v0hy50tj6n16mg96l0s6z6wm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:10:29 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:10:29 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:10:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0kv5II4Bqc/Render', 05:10:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:10:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:10:29 INFO - 'HOME': '/Users/cltbld', 05:10:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:10:29 INFO - 'LOGNAME': 'cltbld', 05:10:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:29 INFO - 'MOZ_NO_REMOTE': '1', 05:10:29 INFO - 'NO_EM_RESTART': '1', 05:10:29 INFO - 'PAGER': '/bin/cat', 05:10:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:10:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:10:29 INFO - 'PWD': '/builds/slave/test', 05:10:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:10:29 INFO - 'SHELL': '/bin/bash', 05:10:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3l5unflI0n/Listeners', 05:10:29 INFO - 'TMPDIR': '/var/folders/45/v0hy50tj6n16mg96l0s6z6wm00000w/T/', 05:10:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:10:29 INFO - 'USER': 'cltbld', 05:10:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:10:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:10:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:29 INFO - 'XPC_FLAGS': '0x0', 05:10:29 INFO - 'XPC_SERVICE_NAME': '0', 05:10:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:10:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:29 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:10:29 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:10:29 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:10:29 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:10:29 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:10:29 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:10:29 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:10:32 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:10:32 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 05:10:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:10:32 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:10:32 INFO - Installing collected packages: mozsystemmonitor 05:10:32 INFO - Running setup.py install for mozsystemmonitor 05:10:32 INFO - Successfully installed mozsystemmonitor 05:10:32 INFO - Cleaning up... 05:10:32 INFO - Return code: 0 05:10:32 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:10:32 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:10:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:10:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:32 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:10:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:10:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:32 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 0x102065490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102042228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7b148b2f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f889f0>, '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 0x101ce8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101f7c8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0kv5II4Bqc/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.3l5unflI0n/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/45/v0hy50tj6n16mg96l0s6z6wm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:10:32 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:10:32 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:10:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0kv5II4Bqc/Render', 05:10:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:10:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:10:32 INFO - 'HOME': '/Users/cltbld', 05:10:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:10:32 INFO - 'LOGNAME': 'cltbld', 05:10:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:32 INFO - 'MOZ_NO_REMOTE': '1', 05:10:32 INFO - 'NO_EM_RESTART': '1', 05:10:32 INFO - 'PAGER': '/bin/cat', 05:10:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:10:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:10:32 INFO - 'PWD': '/builds/slave/test', 05:10:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:10:32 INFO - 'SHELL': '/bin/bash', 05:10:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3l5unflI0n/Listeners', 05:10:32 INFO - 'TMPDIR': '/var/folders/45/v0hy50tj6n16mg96l0s6z6wm00000w/T/', 05:10:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:10:32 INFO - 'USER': 'cltbld', 05:10:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:10:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:10:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:32 INFO - 'XPC_FLAGS': '0x0', 05:10:32 INFO - 'XPC_SERVICE_NAME': '0', 05:10:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:10:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:32 INFO - Downloading/unpacking blobuploader==1.2.4 05:10:32 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:10:32 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:10:32 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:10:32 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:10:32 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:10:32 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:10:35 INFO - Downloading blobuploader-1.2.4.tar.gz 05:10:35 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 05:10:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:10:35 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:10:35 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:10:35 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:10:35 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:10:35 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:10:35 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:10:35 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:10:35 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 05:10:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:10:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:10:36 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:10:36 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:10:36 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:10:36 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:10:36 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:10:36 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:10:36 INFO - Downloading docopt-0.6.1.tar.gz 05:10:36 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 05:10:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:10:36 INFO - Installing collected packages: blobuploader, requests, docopt 05:10:36 INFO - Running setup.py install for blobuploader 05:10:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:10:36 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:10:36 INFO - Running setup.py install for requests 05:10:37 INFO - Running setup.py install for docopt 05:10:37 INFO - Successfully installed blobuploader requests docopt 05:10:37 INFO - Cleaning up... 05:10:37 INFO - Return code: 0 05:10:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:10:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:10:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:10:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:10:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:10:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:37 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 0x102065490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102042228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7b148b2f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f889f0>, '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 0x101ce8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101f7c8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0kv5II4Bqc/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.3l5unflI0n/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/45/v0hy50tj6n16mg96l0s6z6wm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:10:37 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:10:37 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:10:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0kv5II4Bqc/Render', 05:10:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:10:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:10:37 INFO - 'HOME': '/Users/cltbld', 05:10:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:10:37 INFO - 'LOGNAME': 'cltbld', 05:10:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:37 INFO - 'MOZ_NO_REMOTE': '1', 05:10:37 INFO - 'NO_EM_RESTART': '1', 05:10:37 INFO - 'PAGER': '/bin/cat', 05:10:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:10:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:10:37 INFO - 'PWD': '/builds/slave/test', 05:10:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:10:37 INFO - 'SHELL': '/bin/bash', 05:10:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3l5unflI0n/Listeners', 05:10:37 INFO - 'TMPDIR': '/var/folders/45/v0hy50tj6n16mg96l0s6z6wm00000w/T/', 05:10:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:10:37 INFO - 'USER': 'cltbld', 05:10:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:10:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:10:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:37 INFO - 'XPC_FLAGS': '0x0', 05:10:37 INFO - 'XPC_SERVICE_NAME': '0', 05:10:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:10:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:10:37 INFO - Running setup.py (path:/var/folders/45/v0hy50tj6n16mg96l0s6z6wm00000w/T/pip-p9omzm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:10:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:10:38 INFO - Running setup.py (path:/var/folders/45/v0hy50tj6n16mg96l0s6z6wm00000w/T/pip-LBq9ph-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:10:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:10:38 INFO - Running setup.py (path:/var/folders/45/v0hy50tj6n16mg96l0s6z6wm00000w/T/pip-AYldXn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:10:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:10:38 INFO - Running setup.py (path:/var/folders/45/v0hy50tj6n16mg96l0s6z6wm00000w/T/pip-lQ7gD0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:10:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:10:38 INFO - Running setup.py (path:/var/folders/45/v0hy50tj6n16mg96l0s6z6wm00000w/T/pip-ztCgIR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:10:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:10:38 INFO - Running setup.py (path:/var/folders/45/v0hy50tj6n16mg96l0s6z6wm00000w/T/pip-Oi7LKG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:10:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:10:38 INFO - Running setup.py (path:/var/folders/45/v0hy50tj6n16mg96l0s6z6wm00000w/T/pip-IiqX6b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:10:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:10:38 INFO - Running setup.py (path:/var/folders/45/v0hy50tj6n16mg96l0s6z6wm00000w/T/pip-hHdRBt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:10:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:10:38 INFO - Running setup.py (path:/var/folders/45/v0hy50tj6n16mg96l0s6z6wm00000w/T/pip-d0hAPV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:10:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:10:39 INFO - Running setup.py (path:/var/folders/45/v0hy50tj6n16mg96l0s6z6wm00000w/T/pip-d4yy_k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:10:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:10:39 INFO - Running setup.py (path:/var/folders/45/v0hy50tj6n16mg96l0s6z6wm00000w/T/pip-ivamoU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:10:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:10:39 INFO - Running setup.py (path:/var/folders/45/v0hy50tj6n16mg96l0s6z6wm00000w/T/pip-KbwZt4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:10:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:10:39 INFO - Running setup.py (path:/var/folders/45/v0hy50tj6n16mg96l0s6z6wm00000w/T/pip-AUgIYC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:10:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:10:39 INFO - Running setup.py (path:/var/folders/45/v0hy50tj6n16mg96l0s6z6wm00000w/T/pip-GmbC52-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:10:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:10:39 INFO - Running setup.py (path:/var/folders/45/v0hy50tj6n16mg96l0s6z6wm00000w/T/pip-RJQoN6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:10:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:10:39 INFO - Running setup.py (path:/var/folders/45/v0hy50tj6n16mg96l0s6z6wm00000w/T/pip-oaSwQh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:10:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:10:39 INFO - Running setup.py (path:/var/folders/45/v0hy50tj6n16mg96l0s6z6wm00000w/T/pip-N2ulvY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:10:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:10:40 INFO - Running setup.py install for manifestparser 05:10:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:10:40 INFO - Running setup.py install for mozcrash 05:10:40 INFO - Running setup.py install for mozdebug 05:10:40 INFO - Running setup.py install for mozdevice 05:10:40 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:10:40 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:10:40 INFO - Running setup.py install for mozfile 05:10:40 INFO - Running setup.py install for mozhttpd 05:10:41 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:10:41 INFO - Running setup.py install for mozinfo 05:10:41 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:10:41 INFO - Running setup.py install for mozInstall 05:10:41 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:10:41 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:10:41 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:10:41 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:10:41 INFO - Running setup.py install for mozleak 05:10:41 INFO - Running setup.py install for mozlog 05:10:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:10:41 INFO - Running setup.py install for moznetwork 05:10:42 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:10:42 INFO - Running setup.py install for mozprocess 05:10:42 INFO - Running setup.py install for mozprofile 05:10:42 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:10:42 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:10:42 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:10:42 INFO - Running setup.py install for mozrunner 05:10:42 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:10:42 INFO - Running setup.py install for mozscreenshot 05:10:42 INFO - Running setup.py install for moztest 05:10:42 INFO - Running setup.py install for mozversion 05:10:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:10:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:10:43 INFO - Cleaning up... 05:10:43 INFO - Return code: 0 05:10:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:10:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:10:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:10:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:10:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:10:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:43 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 0x102065490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102042228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7b148b2f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f889f0>, '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 0x101ce8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101f7c8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0kv5II4Bqc/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.3l5unflI0n/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/45/v0hy50tj6n16mg96l0s6z6wm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:10:43 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:10:43 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:10:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0kv5II4Bqc/Render', 05:10:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:10:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:10:43 INFO - 'HOME': '/Users/cltbld', 05:10:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:10:43 INFO - 'LOGNAME': 'cltbld', 05:10:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:43 INFO - 'MOZ_NO_REMOTE': '1', 05:10:43 INFO - 'NO_EM_RESTART': '1', 05:10:43 INFO - 'PAGER': '/bin/cat', 05:10:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:10:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:10:43 INFO - 'PWD': '/builds/slave/test', 05:10:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:10:43 INFO - 'SHELL': '/bin/bash', 05:10:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3l5unflI0n/Listeners', 05:10:43 INFO - 'TMPDIR': '/var/folders/45/v0hy50tj6n16mg96l0s6z6wm00000w/T/', 05:10:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:10:43 INFO - 'USER': 'cltbld', 05:10:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:10:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:10:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:43 INFO - 'XPC_FLAGS': '0x0', 05:10:43 INFO - 'XPC_SERVICE_NAME': '0', 05:10:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:10:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:10:43 INFO - Running setup.py (path:/var/folders/45/v0hy50tj6n16mg96l0s6z6wm00000w/T/pip-ht2pkj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:10:43 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:10:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:10:43 INFO - Running setup.py (path:/var/folders/45/v0hy50tj6n16mg96l0s6z6wm00000w/T/pip-75q2ID-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:10:43 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:10:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:10:43 INFO - Running setup.py (path:/var/folders/45/v0hy50tj6n16mg96l0s6z6wm00000w/T/pip-n3N5yF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:10:43 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:10:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:10:43 INFO - Running setup.py (path:/var/folders/45/v0hy50tj6n16mg96l0s6z6wm00000w/T/pip-0h1t3V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:10:43 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:10:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:10:43 INFO - Running setup.py (path:/var/folders/45/v0hy50tj6n16mg96l0s6z6wm00000w/T/pip-tCWn3F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:10:44 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:10:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:10:44 INFO - Running setup.py (path:/var/folders/45/v0hy50tj6n16mg96l0s6z6wm00000w/T/pip-5g3o0I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:10:44 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:10:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:10:44 INFO - Running setup.py (path:/var/folders/45/v0hy50tj6n16mg96l0s6z6wm00000w/T/pip-JJkMOS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:10:44 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:10:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:10:44 INFO - Running setup.py (path:/var/folders/45/v0hy50tj6n16mg96l0s6z6wm00000w/T/pip-7iQ1qy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:10:44 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:10:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:10:44 INFO - Running setup.py (path:/var/folders/45/v0hy50tj6n16mg96l0s6z6wm00000w/T/pip-DOttMB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:10:44 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:10:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:10:44 INFO - Running setup.py (path:/var/folders/45/v0hy50tj6n16mg96l0s6z6wm00000w/T/pip-OP1ICd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:10:44 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:10:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:10:44 INFO - Running setup.py (path:/var/folders/45/v0hy50tj6n16mg96l0s6z6wm00000w/T/pip-z6Qpiq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:10:44 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:10:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:10:44 INFO - Running setup.py (path:/var/folders/45/v0hy50tj6n16mg96l0s6z6wm00000w/T/pip-s44uWH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:10:44 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:10:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:10:44 INFO - Running setup.py (path:/var/folders/45/v0hy50tj6n16mg96l0s6z6wm00000w/T/pip-D3sDcE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:10:45 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:10:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:10:45 INFO - Running setup.py (path:/var/folders/45/v0hy50tj6n16mg96l0s6z6wm00000w/T/pip-a1i_aD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:10:45 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:10:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:10:45 INFO - Running setup.py (path:/var/folders/45/v0hy50tj6n16mg96l0s6z6wm00000w/T/pip-z2HCCO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:10:45 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:10:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:10:45 INFO - Running setup.py (path:/var/folders/45/v0hy50tj6n16mg96l0s6z6wm00000w/T/pip-l2rxZo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:10:45 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:10:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:10:45 INFO - Running setup.py (path:/var/folders/45/v0hy50tj6n16mg96l0s6z6wm00000w/T/pip-Nnvc60-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:10:45 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:10:45 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:10:45 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:10:45 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:10:45 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:10:45 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:10:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:10:45 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:10:45 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:10:45 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:10:45 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:10:45 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:10:45 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:10:47 INFO - Downloading blessings-1.5.1.tar.gz 05:10:47 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:10:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:10:48 INFO - Installing collected packages: blessings 05:10:48 INFO - Running setup.py install for blessings 05:10:48 INFO - Successfully installed blessings 05:10:48 INFO - Cleaning up... 05:10:48 INFO - Return code: 0 05:10:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:10:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:10:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:10:48 INFO - Reading from file tmpfile_stdout 05:10:48 INFO - Current package versions: 05:10:48 INFO - blessings == 1.5.1 05:10:48 INFO - blobuploader == 1.2.4 05:10:48 INFO - docopt == 0.6.1 05:10:48 INFO - manifestparser == 1.1 05:10:48 INFO - mozInstall == 1.12 05:10:48 INFO - mozcrash == 0.16 05:10:48 INFO - mozdebug == 0.1 05:10:48 INFO - mozdevice == 0.47 05:10:48 INFO - mozfile == 1.2 05:10:48 INFO - mozhttpd == 0.7 05:10:48 INFO - mozinfo == 0.9 05:10:48 INFO - mozleak == 0.1 05:10:48 INFO - mozlog == 3.0 05:10:48 INFO - moznetwork == 0.27 05:10:48 INFO - mozprocess == 0.22 05:10:48 INFO - mozprofile == 0.27 05:10:48 INFO - mozrunner == 6.11 05:10:48 INFO - mozscreenshot == 0.1 05:10:48 INFO - mozsystemmonitor == 0.0 05:10:48 INFO - moztest == 0.7 05:10:48 INFO - mozversion == 1.4 05:10:48 INFO - psutil == 3.1.1 05:10:48 INFO - requests == 1.2.3 05:10:48 INFO - wsgiref == 0.1.2 05:10:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:10:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:10:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:10:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:10:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:10:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:48 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 0x102065490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102042228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7b148b2f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f889f0>, '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 0x101ce8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101f7c8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0kv5II4Bqc/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.3l5unflI0n/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/45/v0hy50tj6n16mg96l0s6z6wm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:10:48 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:10:48 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:10:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0kv5II4Bqc/Render', 05:10:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:10:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:10:48 INFO - 'HOME': '/Users/cltbld', 05:10:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:10:48 INFO - 'LOGNAME': 'cltbld', 05:10:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:48 INFO - 'MOZ_NO_REMOTE': '1', 05:10:48 INFO - 'NO_EM_RESTART': '1', 05:10:48 INFO - 'PAGER': '/bin/cat', 05:10:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:10:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:10:48 INFO - 'PWD': '/builds/slave/test', 05:10:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:10:48 INFO - 'SHELL': '/bin/bash', 05:10:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3l5unflI0n/Listeners', 05:10:48 INFO - 'TMPDIR': '/var/folders/45/v0hy50tj6n16mg96l0s6z6wm00000w/T/', 05:10:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:10:48 INFO - 'USER': 'cltbld', 05:10:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:10:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:10:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:48 INFO - 'XPC_FLAGS': '0x0', 05:10:48 INFO - 'XPC_SERVICE_NAME': '0', 05:10:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:10:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:49 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:10:49 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:10:49 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:10:49 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:10:49 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:10:49 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:10:49 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:10:49 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:10:49 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:10:49 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:10:49 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:10:49 INFO - Cleaning up... 05:10:49 INFO - Return code: 0 05:10:49 INFO - Running post-action listener: _resource_record_post_action 05:10:49 INFO - Running post-action listener: _start_resource_monitoring 05:10:49 INFO - Starting resource monitoring. 05:10:49 INFO - ##### 05:10:49 INFO - ##### Running install step. 05:10:49 INFO - ##### 05:10:49 INFO - Running pre-action listener: _resource_record_pre_action 05:10:49 INFO - Running main action method: install 05:10:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:10:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:10:49 INFO - Reading from file tmpfile_stdout 05:10:49 INFO - Detecting whether we're running mozinstall >=1.0... 05:10:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:10:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:10:49 INFO - Reading from file tmpfile_stdout 05:10:49 INFO - Output received: 05:10:49 INFO - Usage: mozinstall [options] installer 05:10:49 INFO - Options: 05:10:49 INFO - -h, --help show this help message and exit 05:10:49 INFO - -d DEST, --destination=DEST 05:10:49 INFO - Directory to install application into. [default: 05:10:49 INFO - "/builds/slave/test"] 05:10:49 INFO - --app=APP Application being installed. [default: firefox] 05:10:49 INFO - mkdir: /builds/slave/test/build/application 05:10:49 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:10:49 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:11:27 INFO - Reading from file tmpfile_stdout 05:11:27 INFO - Output received: 05:11:27 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 05:11:27 INFO - Running post-action listener: _resource_record_post_action 05:11:27 INFO - ##### 05:11:27 INFO - ##### Running run-tests step. 05:11:27 INFO - ##### 05:11:27 INFO - Running pre-action listener: _resource_record_pre_action 05:11:27 INFO - Running main action method: run_tests 05:11:27 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:11:27 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:11:27 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:11:27 INFO - 2015-11-14 05:11:27.363 screenresolution[1667:10569] starting screenresolution argv=screenresolution get 05:11:27 INFO - 2015-11-14 05:11:27.366 screenresolution[1667:10569] Display 0: 1600x1200x32@60 05:11:27 INFO - 2015-11-14 05:11:27.373 screenresolution[1668:10571] starting screenresolution argv=screenresolution list 05:11:27 INFO - Available Modes on Display 0 05:11:27 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:11:27 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:11:27 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:11:27 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:11:27 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:11:27 INFO - Intel HD Graphics 3000: 05:11:27 INFO - Chipset Model: Intel HD Graphics 3000 05:11:27 INFO - Type: GPU 05:11:27 INFO - Bus: Built-In 05:11:27 INFO - VRAM (Total): 512 MB 05:11:27 INFO - VRAM (Dynamic, Max): 10 05:11:27 INFO - Vendor: Intel (0x8086) 05:11:27 INFO - Device ID: 0x0116 05:11:27 INFO - Revision ID: 0x0009 05:11:27 INFO - Displays: 05:11:27 INFO - Display: 05:11:27 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:11:27 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:11:27 INFO - Display Serial Number: 1600x1200 60 05:11:27 INFO - Main Display: Yes 05:11:27 INFO - Mirror: Off 05:11:27 INFO - Online: Yes 05:11:27 INFO - Rotation: Supported 05:11:27 INFO - Return code: 0 05:11:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:11:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:11:27 INFO - Python 2.7.3 05:11:27 INFO - Return code: 0 05:11:27 INFO - grabbing minidump binary from tooltool 05:11:27 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:11:27 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 0x101f889f0>, '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 0x101ce8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101f7c8c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:11:27 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:11:27 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:11:27 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:11:27 INFO - Return code: 0 05:11:27 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:11:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:11:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:11:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:11:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:11:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aPTj2c3WQSOjwP_30wV6RQ/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0002', '--webServer', 'localhost'] in /builds/slave/test/build 05:11:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/aPTj2c3WQSOjwP_30wV6RQ/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0002 --webServer localhost 05:11:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0kv5II4Bqc/Render', 05:11:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:11:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:11:27 INFO - 'HOME': '/Users/cltbld', 05:11:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:11:27 INFO - 'LOGNAME': 'cltbld', 05:11:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:11:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:11:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:27 INFO - 'MOZ_NO_REMOTE': '1', 05:11:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:11:27 INFO - 'NO_EM_RESTART': '1', 05:11:27 INFO - 'PAGER': '/bin/cat', 05:11:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:11:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:27 INFO - 'PWD': '/builds/slave/test', 05:11:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:11:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:11:27 INFO - 'SHELL': '/bin/bash', 05:11:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3l5unflI0n/Listeners', 05:11:27 INFO - 'TMPDIR': '/var/folders/45/v0hy50tj6n16mg96l0s6z6wm00000w/T/', 05:11:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:11:27 INFO - 'USER': 'cltbld', 05:11:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:11:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:11:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:27 INFO - 'XPC_FLAGS': '0x0', 05:11:27 INFO - 'XPC_SERVICE_NAME': '0', 05:11:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:11:27 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aPTj2c3WQSOjwP_30wV6RQ/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0002', '--webServer', 'localhost'] with output_timeout 3600 05:11:28 INFO - mozversion INFO | application_buildid: 20151114030404 05:11:28 INFO - mozversion INFO | application_changeset: 202b199b9fcf37a687bef882f2513e191f079622 05:11:28 INFO - mozversion INFO | application_display_name: Nightly 05:11:28 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:11:28 INFO - mozversion INFO | application_name: Firefox 05:11:28 INFO - mozversion INFO | application_remotingname: firefox 05:11:28 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 05:11:28 INFO - mozversion INFO | application_vendor: Mozilla 05:11:28 INFO - mozversion INFO | application_version: 45.0a1 05:11:28 INFO - mozversion INFO | platform_buildid: 20151114030404 05:11:28 INFO - mozversion INFO | platform_changeset: 202b199b9fcf37a687bef882f2513e191f079622 05:11:28 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 05:11:28 INFO - mozversion INFO | platform_version: 45.0a1 05:11:28 INFO - 2015-11-14 05:11:28,080 DEBUG : using testdate: 1447506688 05:11:28 INFO - 2015-11-14 05:11:28,080 DEBUG : actual date: 1447506688 05:11:28 INFO - 2015-11-14 05:11:28,092 INFO : starting webserver on 'localhost:49282' 05:11:28 INFO - 2015-11-14 05:11:28,093 INFO : Starting test suite t-yosemite-r5-0002.e 05:11:28 INFO - 2015-11-14 05:11:28,093 INFO : Starting test dromaeo_css 05:11:28 INFO - 2015-11-14 05:11:28,093 DEBUG : operating with platform_type : mac_ 05:11:28 INFO - 2015-11-14 05:11:28,100 INFO : Initialising browser for dromaeo_css test... 05:11:28 INFO - 2015-11-14 05:11:28,168 DEBUG : command line: /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/45/v0hy50tj6n16mg96l0s6z6wm00000w/T/tmpZY5Jli/profile http://localhost:49282/getInfo.html 05:11:33 INFO - 2015-11-14 05:11:33,674 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:11:33 INFO - 2015-11-14 05:11:33,675 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:11:33 INFO - 2015-11-14 05:11:33,675 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/663 05:11:33 INFO - 2015-11-14 05:11:33,675 DEBUG : BROWSER_OUTPUT: __metrics 05:11:35 INFO - 2015-11-14 05:11:35,573 INFO : Browser initialized. 05:11:35 INFO - 2015-11-14 05:11:35,574 INFO : Running cycle 1/1 for dromaeo_css test... 05:11:35 INFO - 2015-11-14 05:11:35,574 DEBUG : command line: /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/45/v0hy50tj6n16mg96l0s6z6wm00000w/T/tmpZY5Jli/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:11:47 INFO - 2015-11-14 05:11:47,567 DEBUG : BROWSER_OUTPUT: RSS: Main: 241033216 05:11:47 INFO - 2015-11-14 05:11:47,567 DEBUG : BROWSER_OUTPUT: 05:12:37 INFO - 2015-11-14 05:12:37,398 DEBUG : BROWSER_OUTPUT: 1447506757394 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:14:46 INFO - 2015-11-14 05:14:46,918 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49282/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49282/tests/dromaeo/cssquery-ext.html) 05:14:48 INFO - 2015-11-14 05:14:48,038 DEBUG : BROWSER_OUTPUT: RSS: Main: 267526144 05:14:48 INFO - 2015-11-14 05:14:48,039 DEBUG : BROWSER_OUTPUT: 05:17:50 INFO - 2015-11-14 05:17:50,061 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49282/tests/dromaeo/cssquery-ext.html (next: http://localhost:49282/tests/dromaeo/cssquery-jquery.html) 05:17:50 INFO - 2015-11-14 05:17:50,649 DEBUG : BROWSER_OUTPUT: RSS: Main: 271925248 05:17:50 INFO - 2015-11-14 05:17:50,649 DEBUG : BROWSER_OUTPUT: 05:20:52 INFO - 2015-11-14 05:20:52,294 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49282/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49282/tests/dromaeo/cssquery-mootools.html) 05:20:52 INFO - 2015-11-14 05:20:52,883 DEBUG : BROWSER_OUTPUT: RSS: Main: 273223680 05:20:52 INFO - 2015-11-14 05:20:52,883 DEBUG : BROWSER_OUTPUT: 05:23:54 INFO - 2015-11-14 05:23:54,692 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49282/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49282/tests/dromaeo/cssquery-prototype.html) 05:23:55 INFO - 2015-11-14 05:23:55,297 DEBUG : BROWSER_OUTPUT: RSS: Main: 277839872 05:23:55 INFO - 2015-11-14 05:23:55,297 DEBUG : BROWSER_OUTPUT: 05:26:57 INFO - 2015-11-14 05:26:57,736 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49282/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49282/tests/dromaeo/cssquery-yui.html) 05:26:58 INFO - 2015-11-14 05:26:58,339 DEBUG : BROWSER_OUTPUT: RSS: Main: 283250688 05:26:58 INFO - 2015-11-14 05:26:58,339 DEBUG : BROWSER_OUTPUT: 05:30:00 INFO - 2015-11-14 05:30:00,571 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49282/tests/dromaeo/cssquery-yui.html (next: http://localhost:49282/tests/dromaeo/cssquery-dojo.html) 05:30:00 INFO - 2015-11-14 05:30:00,817 DEBUG : BROWSER_OUTPUT: RSS: Main: 287637504 05:30:00 INFO - 2015-11-14 05:30:00,817 DEBUG : BROWSER_OUTPUT: 05:30:00 INFO - 2015-11-14 05:30:00,818 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:30:00 INFO - 2015-11-14 05:30:00,818 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:30:00 INFO - 2015-11-14 05:30:00,818 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:30:00 INFO - 2015-11-14 05:30:00,818 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:30:00 INFO - 2015-11-14 05:30:00,818 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3198.1844629619445;3257.1531401835514;3288.4738441849295;3305.5041743738434;3322.4351860183774;5347.759350829212;5403.8108666196695;5408.2428460015535;5423.2136340230645;5454.427285135058;5213.661112027725;5321.574274058075;5340.359156901177;5462.371827239868;5483.424240454755;4854.611631069515;5005.974970125144;5065.392152941652;5079.847604571869;5087.389513258414;74.15682631837291;4993.151164302078;5013;5075.898482030358;5093.617978651598;5007.84976450707;5011.448740638527;5018.121828679985;5022;5058.898822023557;5027.974860125712;5040.269160971675;5041.470645582234;5045.545900868903;5046.293518907356;4799.424069111694;4837.467878533358;4917.5574198321965;4960.429550601691;5019.347484826949;5232.3459567554055;5340.786368545292;5377.569794416477;5395.865103372408;5398.217258497496;5745.6265342753;5787.189793428924;5803.883922321572;5807.332156801979;5816.069428891399;5575.442455754433;5676;5732.168835518868;5787.971060144714;5855.326637436707;5419.810306639249;5481.75332110056;5489;5490.203920431555;5507.99999999996;5757;5897.823065308047;5990.341062483123;5996.970015149896;5997.70011499432;5564.610477266633;5575.0522411190195;5603.327600687943;5638.689872056994;5644.350899646511;5854.092615644582;5876.44173803488;5885.205497257815;5888.970555147197;5910.320313164041;5574.275344205227;5692.544596432275;5759.51044161251;5802.245708057925;5815.389384114692;5626.156076588544;5702.087665973424;5711.828645140652;5712.514436272881;5748.971255143698;4516.345129956138;4546.204414227497;4561.2245918193985;4563.885902852388;4597.7241365518175;4007.458993035961;4097.733647312915;4124.711270211056;4142.71001029925;4191.077962848169;5474.7262636868;5501.4223506532035;5505.779768809283;5509.146082357161;5510.366307874566;5862.501687356623;5866.325372582122;5867.119932010232;5869.090291004901;5872.677002764804;5298.2052692096495;5398.46015398457;5429.131338985743;5534.4742249486235;5543.251661025791;5117.181250999822;5192.662476938987;5205.115130427836;5210.505002024802;5211.739413029333;6042.154098426224;6062.454379105813;6063.272407311151;6068.908966365508;6072.666003369857;5608;5703.771849126155;5777.24895763548;5866.530677545701;5928.67392293428;6040.969795150996;6043.848903777265;6047.758089676364;6064.151018857452;6080.391960803884;5515.696636685021;5746.569007324551;5765.164051212634;5767.798127065533;5770.6249093808765;5715.628484148517;5801.680907550125;5809.767609295581;5810.4189581041555;5817.360090390139;5650.378458369494;5680.261565996394;5689.6586204827845;5697.658140511582;5699.9145012825675;5349.705766182898;5672.971635141798;5675.0636145035605;5678.2050512929045;5682;5401.3248343957;5478.178273259043;5551.167324901297;5558.221848941233;5608.971955140199;5586.273784408001;5618.634788738719;5639.379668236573;5640.32316122068;5641.887162256649;5320.095583750849;5396.0556902542685;5438.891222175455;5551.805686800943;5598.916016259841 05:30:00 INFO - 2015-11-14 05:30:00,820 DEBUG : BROWSER_OUTPUT: |1;ext.html;534.4201541327659;540.7674699879053;553.6456667732651;557.8633234857458;567.1775924908883;38101.618983810156;39499.60500394995;39545.604543954585;39556.20887582246;39623.207535849266;42264;42920.57079429205;42925.35611965823;42948.57051429485;43035.56964430355;9197.90802091979;9367.203787678056;9378.577963991602;9406.52967351633;9406.905930940671;9156.725298241063;9261.536923153815;9262.212711919461;9283.907160928371;9284;9181.357304988653;9262.675806346779;9272.211861991738;9273.07269273074;9288.256939444862;9198.126178013077;9275.536223188847;9283.814323713488;9289.442633442015;9301.488418137034;9093.77265568366;9198.448093114368;9199.954000229956;9201.079892010812;9225.953870230673;39346.80326598377;39862;39865;39879.401808972885;39907.40138897919;2344.5310937812337;2629.6747846600774;2723.482538317713;2951.5720220567896;2993.3863557970562;26747.465050698876;27509.86245068782;27520.17439476819;27644.447111057867;28408.147755567366;2385.7852793248517;2413.1312727418117;2424.5756992526235;2433.549793288247;2561.2700380391498;242529;242914;243701.99999999822;243775;243987;49613.75193124011;50776.238356424685;57217.71391143101;59023.40976590265;59135.11297330543;59576;59609;59823.70088149618;60104;60139.69930150321;16240.350385984428;16450.095244761655;16451.177441127897;16464.341426342813;16475.093869837034;12300.200486968319;12354.691132721753;12369.134160608852;12529.997600191962;12535.811962820566;18691.626167476847;18880.356750055;18888.150033248538;18907.716384254247;18964.715529267072;8526.488410695254;8734.432261902955;8768.123187681182;8770.122987701307;8814.382993190415;860.350435421253;919.5494207838111;964.4406244378243;986.1913231150531;1045.596316649342;28729.994450194143;28800.71199288022;28833.855830720713;28944;29228.269293267414;955.5556666150273;1015.97460063499;1036.549101141006;1062.18211976779;1064.5688496159069;13615.455381784815;13638.249896255602;13673.521426750016;13727.45090196381;13782;319465;327871;328145;328274;328512;51987;52108.739456303236;52464;52481.7375913118;52482.999999999236;1398.293861599906;1400.733860566489;1419.0350561617993;1425.0737020936267;1425.743366194095;26740.19779406621;26891.929628595553;27053.1884043479;27096.32259193536;27191.320216994733;45047.549524504335;45328.77335613301;45359;45438;45456;297733;300132;300605;300767;301168;29914.551281730357;32769.180770480925;33765.493517597744;33866.66133338635;33908.830455847565;40474.59525404708;41316.586834131274;41389.379159313234;41517.339306427406;41539;34781.826090869385;35341;35517.467237991965;35629;35767.28465430729;34799.826000870846;34811;34977;35141.82429087838;35159;33597.160070997445;35291.823540882135;35394.46908296429;35417;35503;27753.583696244976;30837.149114075968;33208;33455.49816752799;33458.49812252867;24243.636345455187;24264;24301.39246518851;24553;24618 05:30:00 INFO - 2015-11-14 05:30:00,823 DEBUG : BROWSER_OUTPUT: |2;jquery.html;338.22546368815415;339.4483963559215;339.4941537109706;341.0501752618957;341.689062952713;11734.765304693901;12188.756224875497;17219.311227550897;17356;18011.099445027747;11730.35483048432;11742.882571174287;11949.641510754669;12069.637910862666;12085.879141208585;4335.783210839453;4447.710898791568;4453.020335526179;4462.44219472566;4471.1728330259;4318.956810431902;4440.666949978749;4443.46678398591;4448.97775511122;4452.532484089173;4400.987772812255;4402.845900393487;4412.1175764847;6518;6832.45340372769;6792.45660347171;6798.218204906425;6802.3537763912345;6818.624975626339;6823.795286141399;6382.489400847921;6566.244881838602;6585.473162147016;6586.37429444202;6587.275399706028;23185.884070579537;23868.880655596786;23956.640650390083;24315.933145682637;24526.509469810684;1982.2764690887866;2072.2332736887297;2083.4687154775434;2133.2107120365563;2151.128792838903;14272.714545709132;14551;14631.780523292158;14702.411903523845;14915.477958271409;1557.4471062772666;1634.6158652716601;1640.261882153036;1679.554917946745;1743.8730133407742;62368;65040.349596503904;65890;66037;66069.3393066068;16165.59586010359;16180;16564.6687066258;16640.3343866244;16682.33270669184;24028.51942961131;24047.759522404904;24048.87975560111;24062.87968560146;24139.879300603738;9923.454210018519;9942.353747006422;9950.303478756417;9964.451955142536;9999.450030248407;8447.239748422671;8484.236418722345;8503.149685031447;8523.616437260338;8544.145585441405;7873.448858579844;7974.960125199337;8014.959925200336;8025.919740802634;8037.919620803717;3237.174520497258;3325.617553981275;3361.680640339164;3488.947665785015;3518.225990282185;388.7725680476896;389.3867159224233;403.3526190464321;418.45600719065095;473.6968340262235;10029.297949143636;10525.157987360994;10599.576016959389;10641.946790266154;10718.35689858611;403.5198114244099;406.6177792874688;408.985685501012;416.5834165834166;418.39541862009105;5728.570357223141;5758.107493338455;5843.211166492469;5975.731092100866;5980.790672326448;355665;362169;363944;434770;520325;74216;74671.62664186645;75346.24653753501;76196.23803761891;76342;426.86767102198417;430.47482071872264;431.53609869390533;432.01500578680657;432.29104268998867;10046.598136074475;10363.119134873621;10369.9481502592;10435.269531132748;10440.947795260976;34741.74178678378;35526.28947420985;35551.46672799962;35751.82124089363;35812.82093589516;47233;47783.761081194374;47936.5206347946;48272;48434.515654843;7759.806004849924;7964.960175199087;7970.960145199237;7971.402144839276;7981.8802717958115;11748.530058797553;11804.468798904241;12065.517379304729;12084.577039803564;12090;10146.949265253626;10356.948215259177;10452.529636166542;10471.94764026175;10501.737456563647;10031.29780915358;10072.194224461879;10209.438480883326;10213.08082272599;10415.479226038819;9921.851172232278;10472.424016679155;10483.68548943533;10540.15678745714;10683.51924163399;7475.476716629783;7728.381729461742;7817.609119544114;7817.882731758915;7835.960820195863;10100.393976361442;10177.796444071226;10311.278210525192;10351.844722329322;10363.533640986023 05:30:00 INFO - 2015-11-14 05:30:00,824 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1459.5913144319588;1472.8379878213398;1671.6907372136156;1853.1938606706083;1864.7109697996798;6615.073889655446;6791.185057793059;6803.421709154722;7170.318819712132;7405;7649.617519124049;7734.961325193381;7837.921620783791;7850.607469626524;7885.250901164381;2220.6446968485047;2252.3468194223656;2253.661950707399;2255.605269077913;2257.1310045632385;2249.527599204161;2266.5240299537118;2305.4121199094293;2309.4688221709016;2313.699219101523;2179.7384313882358;2185.8579192352445;2201.9009144588454;2206.922757703481;2212.0930418528405;2211.314492507328;2224.9110035598637;2244.584751820902;2245.7754224577493;2249.3701763506165;2252.31304452142;2269.8184145268337;2274.8180145588312;2283.041122728458;2288.6795848581214;8084.434089613729;8150.959245203795;8169.30560902324;8178.304844088259;8182;4097.651699605537;4682.461516925529;4761.95238047622;4762.976185119052;4770.952290477086;2618.3585021669624;2944.4258369617933;2995.4009198160456;2998.565208044843;3008.0374280230335;880.3485420788635;881.8368601808686;925.1534845616253;956.8947415784328;990.7671697151163;10699.679009629723;10826.67519974402;10834.67495975122;10878.292910960763;10883.564657413774;4213.073123912734;4253.680973926906;4256.616904478612;4325.545817689161;4336.089421221579;9454.101860323259;9464.384814987141;9476.194523465445;9491.952540237255;9531.094546018256;4773.188557945157;4790.0180463005;4797.976010119997;4802.903941921212;4802.927956080662;4290.184864875664;4300.290452075373;4313.094250207429;4313.741175529415;4319.416878721332;3566.6433356664124;3591.6587924147166;3597.964020359815;3600.117971097098;3614.909627259287;1117.279354816139;1122.8428020077197;1122.971925701864;1136.8806275341135;1138.1975707126455;1295.6307452376027;1309.7576948264411;1323.966900827487;1346.2999240395136;1346.811446397505;7486.663100160397;7498.475106742476;7524.021877155935;7524.209957954446;7525.8118547036765;418.5396064329274;426.46052743279773;430.21700505081077;431.0839466134464;431.7366406492037;5916.615419997686;5980.611260268069;5987.670678112659;5987.850303742354;5992.131140984533;8528.147185281547;9293.117153870508;9503.192228660502;9571.473568953636;9599.184069354043;9362.438253704799;9379.296552758435;9387.295952803566;9421.38760980534;9457.763555911157;7220.819479513054;7486.363659088929;7521.7743467696055;7532.811679708051;7544.585047822313;7057.400120989773;7443.032405787213;7480.625968701434;7495;7502.474826762293;8288.461250018729;8450;8575.099614540384;8598.140185981352;8607.48355098696;8630.136986301572;8885.777855553662;8902.243309318781;8921.107889211027;8930.419522731001;7189.209186989531;7248.347648711641;7264.382527485223;7270.272972702899;7275.417966562768;7394.112706475257;7652.464327497022;7799.181085986117;7834.764957051298;7853.842923141619;7056.929430705833;7241.131064272321;7268.309510596485;7342;7360.852782944418;7090.893636595352;7124.893126603209;7154.463415243981;7218.458615603746;7236.20401755796;7312.451566132668;7329.890051649123;7335.266473352622;7352.37504812097;7353.485256032241;6254.2807577129215;6495.675216239075;6532.738690452328;6535.248446428532;6585.1439312889015;6571.244306904576;6584.407403333723;6596.769113081019;6597.439217666552;6617.900731488935 05:30:00 INFO - 2015-11-14 05:30:00,826 DEBUG : BROWSER_OUTPUT: |4;prototype.html;310.40402427339507;317.9443597370461;318.98405079746004;322.44861287198887;324.5035096302658;6378.712957916893;6424.8072557823225;6461.9999999999945;6486.124373209621;6552.082708420825;6353.205849268841;6360.809175724724;6381.649009304487;6385.457236134923;6406.519511036679;4573.7713114344315;4729.503402142777;4738.71567705937;4787.999999999991;4796.83211087612;4724.220503616899;4741.407324084489;4742.857714268577;4749.643776716743;4753.405824271966;4677.06458708258;4679.859604211879;4683.250679891218;4687.2969054641735;4711.552402521772;4666.066786642668;4667.043256132485;4667.1599112159965;4672.55610716983;4680.531946805327;3857.1321452673205;3992.4629017828056;3993.4409182714444;3996.300647386696;4026.6577340926056;6060.424259695322;6070.423309785563;6075.696215189267;6077.939220607782;6102.847428814315;5345.866353341159;5353.9196912046355;5353.973230133864;5355.4109048005075;5357.651752636066;6590.275069742324;6594.53838231324;6595.6372399518;6596.175478065242;6620.668966551653;4203.096334288112;4286.721363111388;4296.076343586113;4318.913621727579;4335.046289816235;6907.861842763167;6965.686544105527;6969.407600354027;6972.163340399134;6977.860442791167;4333.934990975138;4344.391785150018;4345.435093437833;4346.847860324873;4347.56524347569;4299.677524185636;4412.889677758018;4413.470383553929;4417.602415782595;4418.977905110518;5247.2653828464045;5250.343707036621;5251.474852514718;5257.579393648499;5265.78936842522;6621.702023408958;6639.734410623618;6643.734250630017;6646.4350530205475;6648.933510664831;1573.6931298396933;1590.0618635005171;1590.9124998125214;1594.1391648509907;1594.7767312576248;1017.0947856407803;1030.3611760708259;1040.890706475809;1044.6865940217904;1046.4610725476387;6298.527610429236;6359.618422894641;6397.840053998687;6398.392152745481;6484.967575162094;6957.304269573104;6992.986017027502;6995.650217489105;7015.649217539102;7017.754378596826;6437.259715132726;6448.967755161288;6453.257875344396;6460.806175814639;6466.450351720063;3677.3380791457794;3727.627237276305;3773.8867833965023;3782.0355809268463;3785.1861849702445;7178.676959536833;7194.784156475314;7205.89191162133;7209.567425954459;7216.134063912364;7131.393831524275;7134.464915131386;7137.785866423912;7141.107361579802;7156.82107947295;6977.860442791116;7181.569105853666;7182.174049984214;7194.712211511481;7208.96395518019;6945.513814032969;6953.165620125617;6956.930430695628;6972.44220462372;6975.197852247056;6794.388505034571;6799.490038247052;6800.081988931431;6804.387605115563;6823.897641535282;6949.791506254821;7190.640467976685;7196.8920466192;7208.387287080657;7217.24218957002;4456.286994080931;4506.053728717006;4507.684462087623;4520.660950428665;4524.185646583646;6874.690638921161;6897.793066208022;6904.13698287714;6912;6916.930830691628;6553.737850485927;6700.631465269457;6726.159230096238;6742.8651426972165;6743.898841517479;6716;6718.596884186769;6720.563163394364;6723.226828914738;6728.226253980855;6401.55189136756;6549;6559.770408035696;6577.3422657733845;6593.934060659332;6555.410013098844;6678.298778628368;6686.331366863469;6728.259891411843;6734.090897728744;6568.540202185801;6608.801735947929;6624.138861947916;6624.370684784938;6630.5027122965 05:30:00 INFO - 2015-11-14 05:30:00,830 DEBUG : BROWSER_OUTPUT: |5;yui.html;746.1866565443665;756.8940348351232;773.1881524399381;775.724617760695;819.1849110135416;14030.92984535077;14282.428702851874;14320.06919550231;14332.928335358334;14349.856501434982;13104.14823036502;13330.200187988727;13587.660308492292;13609.455621775141;13638.727225455485;879.1560102301783;908.2869947091534;910.3536489092752;911.7857303533664;913.70761356366;875.1598465473154;898.7887846356134;900.9594568244412;901.5807649443008;901.7430032440756;912.338554547954;933.351320832022;934.5654270764094;935.3826474526813;935.4013431403907;917.9311551633655;932.2821427500786;932.580338847518;932.9020452852454;933.3000249812641;681.465049935798;688.9655517224119;692.9653517324114;693.0609024771412;693.8057343943703;12795.680107997281;12948.676283092904;12961.351932403342;12968.610941671765;12977.545785897542;10417.843732344021;10438.321509101885;10523.10553602937;10551;10754.623588174376;9063.229625481841;9072.818543629157;9117.544122793834;9151.542422878829;9455.763605909839;3271.2312606537444;3312.271300313927;3323.418401779679;3380.983095084509;3386.813725245135;40530;41119.1776164475;49167.75416122932;50287.49712502865;51221.99999999963;9207.125323094295;9300.837395325585;9506.334556580972;9546.90453095474;9877.802443951081;19987.80073195613;20137.09383077765;20140.89929550372;20179.899100504404;20196;6968.0941477607585;7037.22590515043;7098.538594991309;7144.928550714426;7220.241874603196;3659.8170091495317;3724.571674257441;3728.291624591319;3785.413260944503;3810.904727381838;3000.9549856752164;3035.4536183487185;3035.4991426414836;3043.3456806786203;3048.1008102609785;426.5265555233688;432.7944226492391;435.77122010943873;447.5703324808155;447.75597299471866;418.8523051694699;455.76300323831424;460.67292222522383;546.2461802712231;554.789180111555;7978.481398709066;8213.54825484604;8594.78513037179;8856.557172141367;9024.729258122266;557.2727590494444;588.4586180713753;609.2780055634088;610.3865615056928;626.4017862940972;3845.4616353710503;3941;3984.7011474139554;3996.660283875903;4055.5842504668653;61277.38722612806;62170.68914655398;62329.37670623326;62355.6882215586;62376.376236237964;51929.480705192465;52536.73731631317;52549.2117618236;52713.7364313176;52764;43465.348019779725;44723.55276447259;45953.54046459559;47370.289445657654;47492.28761568579;7721.420893432903;8158.224968627971;8288.875666865122;8557.101504341954;8739.56302184901;34270.31459370749;34274.65725342715;34513.65486345205;35410;35468.11329716778;45945.54054459413;46176.07647846957;46191.538084618725;46318;47212.291815622106;7613.390928725578;7640.3505702015955;7664;7684.8463030740195;7900.68397264103;10828.404437755684;10932.890671093188;11000.179172224374;11568.190226684388;11883.881161188623;9808.166305863797;10252.948735256276;10254.897451025394;10964.835527466936;11284.09727221804;9521.714348569554;9685.806283874424;10002.499875006075;10100.242481813746;11251.381174035507;9454.905450945678;9462.479563624067;9464.290178236522;9598.32811703202;10330.535125919201;8670.739877803677;8812.898387701538;8829.11708829112;9175.816483670156;9280.303977201602;8254.513329107378;8320.16798320163;8355.707550235955;8802.427842190236;9040.90959090427 05:30:00 INFO - 2015-11-14 05:30:00,830 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:30:00 INFO - 2015-11-14 05:30:00,830 DEBUG : BROWSER_OUTPUT: __start_cc_report 05:30:00 INFO - 2015-11-14 05:30:00,830 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,283 05:30:00 INFO - 2015-11-14 05:30:00,831 DEBUG : BROWSER_OUTPUT: __end_cc_report 05:30:00 INFO - 2015-11-14 05:30:00,831 DEBUG : BROWSER_OUTPUT: __startTimestamp1447507800814__endTimestamp 05:30:00 INFO - 2015-11-14 05:30:00,831 DEBUG : BROWSER_OUTPUT: 05:30:00 INFO - 2015-11-14 05:30:00,831 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:30:00 INFO - 2015-11-14 05:30:00,831 DEBUG : BROWSER_OUTPUT: Number of tests: 6 05:30:00 INFO - 2015-11-14 05:30:00,831 DEBUG : BROWSER_OUTPUT: 05:30:00 INFO - 2015-11-14 05:30:00,832 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5370.92 Median:5551.81 stddev:702.33 (12.7%) stddev-sans-first:683.49 05:30:00 INFO - 2015-11-14 05:30:00,832 DEBUG : BROWSER_OUTPUT: Values: 3198.2 3257.2 3288.5 3305.5 3322.4 5347.8 5403.8 5408.2 5423.2 5454.4 5213.7 5321.6 5340.4 5462.4 5483.4 4854.6 5006.0 5065.4 5079.8 5087.4 74.2 4993.2 5013.0 5075.9 5093.6 5007.8 5011.4 5018.1 5022.0 5058.9 5028.0 5040.3 5041.5 5045.5 5046.3 4799.4 4837.5 4917.6 4960.4 5019.3 5232.3 5340.8 5377.6 5395.9 5398.2 5745.6 5787.2 5803.9 5807.3 5816.1 5575.4 5676.0 5732.2 5788.0 5855.3 5419.8 5481.8 5489.0 5490.2 5508.0 5757.0 5897.8 5990.3 5997.0 5997.7 5564.6 5575.1 5603.3 5638.7 5644.4 5854.1 5876.4 5885.2 5889.0 5910.3 5574.3 5692.5 5759.5 5802.2 5815.4 5626.2 5702.1 5711.8 5712.5 5749.0 4516.3 4546.2 4561.2 4563.9 4597.7 4007.5 4097.7 4124.7 4142.7 4191.1 5474.7 5501.4 5505.8 5509.1 5510.4 5862.5 5866.3 5867.1 5869.1 5872.7 5298.2 5398.5 5429.1 5534.5 5543.3 5117.2 5192.7 5205.1 5210.5 5211.7 6042.2 6062.5 6063.3 6068.9 6072.7 5608.0 5703.8 5777.2 5866.5 5928.7 6041.0 6043.8 6047.8 6064.2 6080.4 5515.7 5746.6 5765.2 5767.8 5770.6 5715.6 5801.7 5809.8 5810.4 5817.4 5650.4 5680.3 5689.7 5697.7 5699.9 5349.7 5673.0 5675.1 5678.2 5682.0 5401.3 5478.2 5551.2 5558.2 5609.0 5586.3 5618.6 5639.4 5640.3 5641.9 5320.1 5396.1 5438.9 5551.8 5598.9 05:30:00 INFO - 2015-11-14 05:30:00,832 DEBUG : BROWSER_OUTPUT: 05:30:00 INFO - 2015-11-14 05:30:00,832 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:45807.52 Median:35150.41 stddev:76338.76 (217.2%) stddev-sans-first:76477.23 05:30:00 INFO - 2015-11-14 05:30:00,832 DEBUG : BROWSER_OUTPUT: Values: 534.4 540.8 553.6 557.9 567.2 38101.6 39499.6 39545.6 39556.2 39623.2 42264.0 42920.6 42925.4 42948.6 43035.6 9197.9 9367.2 9378.6 9406.5 9406.9 9156.7 9261.5 9262.2 9283.9 9284.0 9181.4 9262.7 9272.2 9273.1 9288.3 9198.1 9275.5 9283.8 9289.4 9301.5 9093.8 9198.4 9200.0 9201.1 9226.0 39346.8 39862.0 39865.0 39879.4 39907.4 2344.5 2629.7 2723.5 2951.6 2993.4 26747.5 27509.9 27520.2 27644.4 28408.1 2385.8 2413.1 2424.6 2433.5 2561.3 242529.0 242914.0 243702.0 243775.0 243987.0 49613.8 50776.2 57217.7 59023.4 59135.1 59576.0 59609.0 59823.7 60104.0 60139.7 16240.4 16450.1 16451.2 16464.3 16475.1 12300.2 12354.7 12369.1 12530.0 12535.8 18691.6 18880.4 18888.2 18907.7 18964.7 8526.5 8734.4 8768.1 8770.1 8814.4 860.4 919.5 964.4 986.2 1045.6 28730.0 28800.7 28833.9 28944.0 29228.3 955.6 1016.0 1036.5 1062.2 1064.6 13615.5 13638.2 13673.5 13727.5 13782.0 319465.0 327871.0 328145.0 328274.0 328512.0 51987.0 52108.7 52464.0 52481.7 52483.0 1398.3 1400.7 1419.0 1425.1 1425.7 26740.2 26891.9 27053.2 27096.3 27191.3 45047.5 45328.8 45359.0 45438.0 45456.0 297733.0 300132.0 300605.0 300767.0 301168.0 29914.6 32769.2 33765.5 33866.7 33908.8 40474.6 41316.6 41389.4 41517.3 41539.0 34781.8 35341.0 35517.5 35629.0 35767.3 34799.8 34811.0 34977.0 35141.8 35159.0 33597.2 35291.8 35394.5 35417.0 35503.0 27753.6 30837.1 33208.0 33455.5 33458.5 24243.6 24264.0 24301.4 24553.0 24618.0 05:30:00 INFO - 2015-11-14 05:30:00,832 DEBUG : BROWSER_OUTPUT: 05:30:00 INFO - 2015-11-14 05:30:00,832 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:24882.82 Median:363056.50 stddev:67793.77 (18.7%) stddev-sans-first:67958.90 05:30:00 INFO - 2015-11-14 05:30:00,834 DEBUG : BROWSER_OUTPUT: Values: 338.2 339.4 339.5 341.1 341.7 11734.8 12188.8 17219.3 17356.0 18011.1 11730.4 11742.9 11949.6 12069.6 12085.9 4335.8 4447.7 4453.0 4462.4 4471.2 4319.0 4440.7 4443.5 4449.0 4452.5 4401.0 4402.8 4412.1 6518.0 6832.5 6792.5 6798.2 6802.4 6818.6 6823.8 6382.5 6566.2 6585.5 6586.4 6587.3 23185.9 23868.9 23956.6 24315.9 24526.5 1982.3 2072.2 2083.5 2133.2 2151.1 14272.7 14551.0 14631.8 14702.4 14915.5 1557.4 1634.6 1640.3 1679.6 1743.9 62368.0 65040.3 65890.0 66037.0 66069.3 16165.6 16180.0 16564.7 16640.3 16682.3 24028.5 24047.8 24048.9 24062.9 24139.9 9923.5 9942.4 9950.3 9964.5 9999.5 8447.2 8484.2 8503.1 8523.6 8544.1 7873.4 7975.0 8015.0 8025.9 8037.9 3237.2 3325.6 3361.7 3488.9 3518.2 388.8 389.4 403.4 418.5 473.7 10029.3 10525.2 10599.6 10641.9 10718.4 403.5 406.6 409.0 416.6 418.4 5728.6 5758.1 5843.2 5975.7 5980.8 355665.0 362169.0 363944.0 434770.0 520325.0 74216.0 74671.6 75346.2 76196.2 76342.0 426.9 430.5 431.5 432.0 432.3 10046.6 10363.1 10369.9 10435.3 10440.9 34741.7 35526.3 35551.5 35751.8 35812.8 47233.0 47783.8 47936.5 48272.0 48434.5 7759.8 7965.0 7971.0 7971.4 7981.9 11748.5 11804.5 12065.5 12084.6 12090.0 10146.9 10356.9 10452.5 10471.9 10501.7 10031.3 10072.2 10209.4 10213.1 10415.5 9921.9 10472.4 10483.7 10540.2 10683.5 7475.5 7728.4 7817.6 7817.9 7836.0 10100.4 10177.8 10311.3 10351.8 10363.5 05:30:00 INFO - 2015-11-14 05:30:00,834 DEBUG : BROWSER_OUTPUT: 05:30:00 INFO - 2015-11-14 05:30:00,834 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5516.96 Median:6584.78 stddev:2920.66 (44.4%) stddev-sans-first:2912.93 05:30:00 INFO - 2015-11-14 05:30:00,834 DEBUG : BROWSER_OUTPUT: Values: 1459.6 1472.8 1671.7 1853.2 1864.7 6615.1 6791.2 6803.4 7170.3 7405.0 7649.6 7735.0 7837.9 7850.6 7885.3 2220.6 2252.3 2253.7 2255.6 2257.1 2249.5 2266.5 2305.4 2309.5 2313.7 2179.7 2185.9 2201.9 2206.9 2212.1 2211.3 2224.9 2244.6 2245.8 2249.4 2252.3 2269.8 2274.8 2283.0 2288.7 8084.4 8151.0 8169.3 8178.3 8182.0 4097.7 4682.5 4762.0 4763.0 4771.0 2618.4 2944.4 2995.4 2998.6 3008.0 880.3 881.8 925.2 956.9 990.8 10699.7 10826.7 10834.7 10878.3 10883.6 4213.1 4253.7 4256.6 4325.5 4336.1 9454.1 9464.4 9476.2 9492.0 9531.1 4773.2 4790.0 4798.0 4802.9 4802.9 4290.2 4300.3 4313.1 4313.7 4319.4 3566.6 3591.7 3598.0 3600.1 3614.9 1117.3 1122.8 1123.0 1136.9 1138.2 1295.6 1309.8 1324.0 1346.3 1346.8 7486.7 7498.5 7524.0 7524.2 7525.8 418.5 426.5 430.2 431.1 431.7 5916.6 5980.6 5987.7 5987.9 5992.1 8528.1 9293.1 9503.2 9571.5 9599.2 9362.4 9379.3 9387.3 9421.4 9457.8 7220.8 7486.4 7521.8 7532.8 7544.6 7057.4 7443.0 7480.6 7495.0 7502.5 8288.5 8450.0 8575.1 8598.1 8607.5 8630.1 8885.8 8902.2 8921.1 8930.4 7189.2 7248.3 7264.4 7270.3 7275.4 7394.1 7652.5 7799.2 7834.8 7853.8 7056.9 7241.1 7268.3 7342.0 7360.9 7090.9 7124.9 7154.5 7218.5 7236.2 7312.5 7329.9 7335.3 7352.4 7353.5 6254.3 6495.7 6532.7 6535.2 6585.1 6571.2 6584.4 6596.8 6597.4 6617.9 05:30:00 INFO - 2015-11-14 05:30:00,834 DEBUG : BROWSER_OUTPUT: 05:30:00 INFO - 2015-11-14 05:30:00,836 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5531.28 Median:6415.66 stddev:1746.19 (27.2%) stddev-sans-first:1706.55 05:30:00 INFO - 2015-11-14 05:30:00,836 DEBUG : BROWSER_OUTPUT: Values: 310.4 317.9 319.0 322.4 324.5 6378.7 6424.8 6462.0 6486.1 6552.1 6353.2 6360.8 6381.6 6385.5 6406.5 4573.8 4729.5 4738.7 4788.0 4796.8 4724.2 4741.4 4742.9 4749.6 4753.4 4677.1 4679.9 4683.3 4687.3 4711.6 4666.1 4667.0 4667.2 4672.6 4680.5 3857.1 3992.5 3993.4 3996.3 4026.7 6060.4 6070.4 6075.7 6077.9 6102.8 5345.9 5353.9 5354.0 5355.4 5357.7 6590.3 6594.5 6595.6 6596.2 6620.7 4203.1 4286.7 4296.1 4318.9 4335.0 6907.9 6965.7 6969.4 6972.2 6977.9 4333.9 4344.4 4345.4 4346.8 4347.6 4299.7 4412.9 4413.5 4417.6 4419.0 5247.3 5250.3 5251.5 5257.6 5265.8 6621.7 6639.7 6643.7 6646.4 6648.9 1573.7 1590.1 1590.9 1594.1 1594.8 1017.1 1030.4 1040.9 1044.7 1046.5 6298.5 6359.6 6397.8 6398.4 6485.0 6957.3 6993.0 6995.7 7015.6 7017.8 6437.3 6449.0 6453.3 6460.8 6466.5 3677.3 3727.6 3773.9 3782.0 3785.2 7178.7 7194.8 7205.9 7209.6 7216.1 7131.4 7134.5 7137.8 7141.1 7156.8 6977.9 7181.6 7182.2 7194.7 7209.0 6945.5 6953.2 6956.9 6972.4 6975.2 6794.4 6799.5 6800.1 6804.4 6823.9 6949.8 7190.6 7196.9 7208.4 7217.2 4456.3 4506.1 4507.7 4520.7 4524.2 6874.7 6897.8 6904.1 6912.0 6916.9 6553.7 6700.6 6726.2 6742.9 6743.9 6716.0 6718.6 6720.6 6723.2 6728.2 6401.6 6549.0 6559.8 6577.3 6593.9 6555.4 6678.3 6686.3 6728.3 6734.1 6568.5 6608.8 6624.1 6624.4 6630.5 05:30:00 INFO - 2015-11-14 05:30:00,836 DEBUG : BROWSER_OUTPUT: 05:30:00 INFO - 2015-11-14 05:30:00,836 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13593.83 Median:26655.12 stddev:16492.67 (61.9%) stddev-sans-first:16510.72 05:30:00 INFO - 2015-11-14 05:30:00,838 DEBUG : BROWSER_OUTPUT: Values: 746.2 756.9 773.2 775.7 819.2 14030.9 14282.4 14320.1 14332.9 14349.9 13104.1 13330.2 13587.7 13609.5 13638.7 879.2 908.3 910.4 911.8 913.7 875.2 898.8 901.0 901.6 901.7 912.3 933.4 934.6 935.4 935.4 917.9 932.3 932.6 932.9 933.3 681.5 689.0 693.0 693.1 693.8 12795.7 12948.7 12961.4 12968.6 12977.5 10417.8 10438.3 10523.1 10551.0 10754.6 9063.2 9072.8 9117.5 9151.5 9455.8 3271.2 3312.3 3323.4 3381.0 3386.8 40530.0 41119.2 49167.8 50287.5 51222.0 9207.1 9300.8 9506.3 9546.9 9877.8 19987.8 20137.1 20140.9 20179.9 20196.0 6968.1 7037.2 7098.5 7144.9 7220.2 3659.8 3724.6 3728.3 3785.4 3810.9 3001.0 3035.5 3035.5 3043.3 3048.1 426.5 432.8 435.8 447.6 447.8 418.9 455.8 460.7 546.2 554.8 7978.5 8213.5 8594.8 8856.6 9024.7 557.3 588.5 609.3 610.4 626.4 3845.5 3941.0 3984.7 3996.7 4055.6 61277.4 62170.7 62329.4 62355.7 62376.4 51929.5 52536.7 52549.2 52713.7 52764.0 43465.3 44723.6 45953.5 47370.3 47492.3 7721.4 8158.2 8288.9 8557.1 8739.6 34270.3 34274.7 34513.7 35410.0 35468.1 45945.5 46176.1 46191.5 46318.0 47212.3 7613.4 7640.4 7664.0 7684.8 7900.7 10828.4 10932.9 11000.2 11568.2 11883.9 9808.2 10252.9 10254.9 10964.8 11284.1 9521.7 9685.8 10002.5 10100.2 11251.4 9454.9 9462.5 9464.3 9598.3 10330.5 8670.7 8812.9 8829.1 9175.8 9280.3 8254.5 8320.2 8355.7 8802.4 9040.9 05:30:00 INFO - 2015-11-14 05:30:00,838 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:30:00 INFO - 2015-11-14 05:30:00,838 DEBUG : BROWSER_OUTPUT: 05:30:01 INFO - 2015-11-14 05:30:01,630 INFO : Browser exited with error code: 0 05:30:01 INFO - 2015-11-14 05:30:01,657 INFO : Completed test dromaeo_css (00:18:33) 05:30:01 INFO - 2015-11-14 05:30:01,658 INFO : Starting test kraken 05:30:01 INFO - 2015-11-14 05:30:01,658 DEBUG : operating with platform_type : mac_ 05:30:01 INFO - 2015-11-14 05:30:01,658 INFO : Initialising browser for kraken test... 05:30:01 INFO - 2015-11-14 05:30:01,670 DEBUG : command line: /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/45/v0hy50tj6n16mg96l0s6z6wm00000w/T/tmpsiqRfd/profile http://localhost:49282/getInfo.html 05:30:05 INFO - 2015-11-14 05:30:05,248 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:30:05 INFO - 2015-11-14 05:30:05,248 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:30:05 INFO - 2015-11-14 05:30:05,248 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/663 05:30:05 INFO - 2015-11-14 05:30:05,248 DEBUG : BROWSER_OUTPUT: __metrics 05:30:05 INFO - 2015-11-14 05:30:05,966 INFO : Browser initialized. 05:30:05 INFO - 2015-11-14 05:30:05,967 INFO : Running cycle 1/1 for kraken test... 05:30:05 INFO - 2015-11-14 05:30:05,967 DEBUG : command line: /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/45/v0hy50tj6n16mg96l0s6z6wm00000w/T/tmpsiqRfd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:30:17 INFO - 2015-11-14 05:30:17,903 DEBUG : BROWSER_OUTPUT: RSS: Main: 240521216 05:30:17 INFO - 2015-11-14 05:30:17,903 DEBUG : BROWSER_OUTPUT: 05:30:20 INFO - 2015-11-14 05:30:20,508 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49282/tests/kraken/driver.html?testName=audio-beat-detection) 05:30:21 INFO - 2015-11-14 05:30:21,115 DEBUG : BROWSER_OUTPUT: RSS: Main: 259358720 05:30:21 INFO - 2015-11-14 05:30:21,115 DEBUG : BROWSER_OUTPUT: 05:30:23 INFO - 2015-11-14 05:30:23,728 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49282/tests/kraken/driver.html?testName=audio-dft) 05:30:24 INFO - 2015-11-14 05:30:24,325 DEBUG : BROWSER_OUTPUT: RSS: Main: 266899456 05:30:24 INFO - 2015-11-14 05:30:24,326 DEBUG : BROWSER_OUTPUT: 05:30:27 INFO - 2015-11-14 05:30:27,196 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49282/tests/kraken/driver.html?testName=audio-fft) 05:30:27 INFO - 2015-11-14 05:30:27,780 DEBUG : BROWSER_OUTPUT: RSS: Main: 266264576 05:30:27 INFO - 2015-11-14 05:30:27,781 DEBUG : BROWSER_OUTPUT: 05:30:29 INFO - 2015-11-14 05:30:29,728 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49282/tests/kraken/driver.html?testName=audio-oscillator) 05:30:30 INFO - 2015-11-14 05:30:30,338 DEBUG : BROWSER_OUTPUT: RSS: Main: 266924032 05:30:30 INFO - 2015-11-14 05:30:30,338 DEBUG : BROWSER_OUTPUT: 05:30:32 INFO - 2015-11-14 05:30:32,455 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49282/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:30:33 INFO - 2015-11-14 05:30:33,028 DEBUG : BROWSER_OUTPUT: RSS: Main: 267747328 05:30:33 INFO - 2015-11-14 05:30:33,028 DEBUG : BROWSER_OUTPUT: 05:30:36 INFO - 2015-11-14 05:30:36,026 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49282/tests/kraken/driver.html?testName=imaging-darkroom) 05:30:36 INFO - 2015-11-14 05:30:36,611 DEBUG : BROWSER_OUTPUT: RSS: Main: 269070336 05:30:36 INFO - 2015-11-14 05:30:36,611 DEBUG : BROWSER_OUTPUT: 05:30:39 INFO - 2015-11-14 05:30:39,707 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49282/tests/kraken/driver.html?testName=imaging-desaturate) 05:30:40 INFO - 2015-11-14 05:30:40,294 DEBUG : BROWSER_OUTPUT: RSS: Main: 269287424 05:30:40 INFO - 2015-11-14 05:30:40,294 DEBUG : BROWSER_OUTPUT: 05:30:43 INFO - 2015-11-14 05:30:43,112 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49282/tests/kraken/driver.html?testName=json-parse-financial) 05:30:43 INFO - 2015-11-14 05:30:43,708 DEBUG : BROWSER_OUTPUT: RSS: Main: 267722752 05:30:43 INFO - 2015-11-14 05:30:43,708 DEBUG : BROWSER_OUTPUT: 05:30:45 INFO - 2015-11-14 05:30:45,295 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49282/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:30:45 INFO - 2015-11-14 05:30:45,872 DEBUG : BROWSER_OUTPUT: RSS: Main: 267624448 05:30:45 INFO - 2015-11-14 05:30:45,872 DEBUG : BROWSER_OUTPUT: 05:30:47 INFO - 2015-11-14 05:30:47,663 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49282/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:30:48 INFO - 2015-11-14 05:30:48,290 DEBUG : BROWSER_OUTPUT: RSS: Main: 268201984 05:30:48 INFO - 2015-11-14 05:30:48,290 DEBUG : BROWSER_OUTPUT: 05:30:50 INFO - 2015-11-14 05:30:50,360 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49282/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:30:50 INFO - 2015-11-14 05:30:50,949 DEBUG : BROWSER_OUTPUT: RSS: Main: 268677120 05:30:50 INFO - 2015-11-14 05:30:50,949 DEBUG : BROWSER_OUTPUT: 05:30:53 INFO - 2015-11-14 05:30:53,481 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49282/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:30:54 INFO - 2015-11-14 05:30:54,075 DEBUG : BROWSER_OUTPUT: RSS: Main: 267853824 05:30:54 INFO - 2015-11-14 05:30:54,075 DEBUG : BROWSER_OUTPUT: 05:30:56 INFO - 2015-11-14 05:30:56,699 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49282/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:30:57 INFO - 2015-11-14 05:30:57,287 DEBUG : BROWSER_OUTPUT: RSS: Main: 268554240 05:30:57 INFO - 2015-11-14 05:30:57,287 DEBUG : BROWSER_OUTPUT: 05:30:58 INFO - 2015-11-14 05:30:58,998 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49282/tests/kraken/driver.html?testName=ai-astar) 05:30:59 INFO - 2015-11-14 05:30:59,248 DEBUG : BROWSER_OUTPUT: RSS: Main: 269746176 05:30:59 INFO - 2015-11-14 05:30:59,248 DEBUG : BROWSER_OUTPUT: 05:30:59 INFO - 2015-11-14 05:30:59,249 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:30:59 INFO - 2015-11-14 05:30:59,249 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:30:59 INFO - 2015-11-14 05:30:59,249 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:30:59 INFO - 2015-11-14 05:30:59,249 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:30:59 INFO - 2015-11-14 05:30:59,249 DEBUG : BROWSER_OUTPUT: |0;ai-astar;110;100;110;109;109;118;110;109;109;108 05:30:59 INFO - 2015-11-14 05:30:59,249 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;156;132;150;163;127;150;145;128;160;129 05:30:59 INFO - 2015-11-14 05:30:59,250 DEBUG : BROWSER_OUTPUT: |2;audio-dft;164;166;163;164;163;168;169;169;168;167 05:30:59 INFO - 2015-11-14 05:30:59,250 DEBUG : BROWSER_OUTPUT: |3;audio-fft;76;71;76;65;70;70;69;121;64;68 05:30:59 INFO - 2015-11-14 05:30:59,250 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;89;90;126;87;89;89;122;87;89;136 05:30:59 INFO - 2015-11-14 05:30:59,250 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;121;115;115;114;120;114;115;114;114;115 05:30:59 INFO - 2015-11-14 05:30:59,250 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;127;127;126;127;126;127;127;127;127;127 05:30:59 INFO - 2015-11-14 05:30:59,251 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;99;105;97;104;99;96;96;104;104;97 05:30:59 INFO - 2015-11-14 05:30:59,251 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;62;62;63;62;62;62;63;70;62;62 05:30:59 INFO - 2015-11-14 05:30:59,251 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;67;67;68;65;66;65;66;67;67;67 05:30:59 INFO - 2015-11-14 05:30:59,251 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;86;87;88;85;87;86;87;86;88;86 05:30:59 INFO - 2015-11-14 05:30:59,251 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;135;125;125;132;126;124;124;125;129;125 05:30:59 INFO - 2015-11-14 05:30:59,251 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;162;159;156;156;149;147;157;159;156;155 05:30:59 INFO - 2015-11-14 05:30:59,252 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;72;72;71;73;76;72;73;73;74;74 05:30:59 INFO - 2015-11-14 05:30:59,252 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:30:59 INFO - 2015-11-14 05:30:59,252 DEBUG : BROWSER_OUTPUT: __start_cc_report 05:30:59 INFO - 2015-11-14 05:30:59,252 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,712 05:30:59 INFO - 2015-11-14 05:30:59,252 DEBUG : BROWSER_OUTPUT: __end_cc_report 05:30:59 INFO - 2015-11-14 05:30:59,252 DEBUG : BROWSER_OUTPUT: __startTimestamp1447507859248__endTimestamp 05:30:59 INFO - 2015-11-14 05:30:59,252 DEBUG : BROWSER_OUTPUT: 05:30:59 INFO - 2015-11-14 05:30:59,254 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:30:59 INFO - 2015-11-14 05:30:59,254 DEBUG : BROWSER_OUTPUT: Number of tests: 14 05:30:59 INFO - 2015-11-14 05:30:59,254 DEBUG : BROWSER_OUTPUT: 05:30:59 INFO - 2015-11-14 05:30:59,254 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:109.20 Median:109.50 stddev:4.29 (3.9%) stddev-sans-first:4.54 05:30:59 INFO - 2015-11-14 05:30:59,254 DEBUG : BROWSER_OUTPUT: Values: 110.0 100.0 110.0 109.0 109.0 118.0 110.0 109.0 109.0 108.0 05:30:59 INFO - 2015-11-14 05:30:59,255 DEBUG : BROWSER_OUTPUT: 05:30:59 INFO - 2015-11-14 05:30:59,255 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:144.00 Median:150.00 stddev:13.94 (9.3%) stddev-sans-first:14.09 05:30:59 INFO - 2015-11-14 05:30:59,255 DEBUG : BROWSER_OUTPUT: Values: 156.0 132.0 150.0 163.0 127.0 150.0 145.0 128.0 160.0 129.0 05:30:59 INFO - 2015-11-14 05:30:59,255 DEBUG : BROWSER_OUTPUT: 05:30:59 INFO - 2015-11-14 05:30:59,255 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:166.10 Median:167.50 stddev:2.42 (1.4%) stddev-sans-first:2.45 05:30:59 INFO - 2015-11-14 05:30:59,255 DEBUG : BROWSER_OUTPUT: Values: 164.0 166.0 163.0 164.0 163.0 168.0 169.0 169.0 168.0 167.0 05:30:59 INFO - 2015-11-14 05:30:59,255 DEBUG : BROWSER_OUTPUT: 05:30:59 INFO - 2015-11-14 05:30:59,256 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:75.00 Median:70.00 stddev:16.63 (23.8%) stddev-sans-first:17.64 05:30:59 INFO - 2015-11-14 05:30:59,256 DEBUG : BROWSER_OUTPUT: Values: 76.0 71.0 76.0 65.0 70.0 70.0 69.0 121.0 64.0 68.0 05:30:59 INFO - 2015-11-14 05:30:59,256 DEBUG : BROWSER_OUTPUT: 05:30:59 INFO - 2015-11-14 05:30:59,256 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:100.40 Median:89.00 stddev:19.37 (21.8%) stddev-sans-first:20.10 05:30:59 INFO - 2015-11-14 05:30:59,256 DEBUG : BROWSER_OUTPUT: Values: 89.0 90.0 126.0 87.0 89.0 89.0 122.0 87.0 89.0 136.0 05:30:59 INFO - 2015-11-14 05:30:59,257 DEBUG : BROWSER_OUTPUT: 05:30:59 INFO - 2015-11-14 05:30:59,257 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:115.70 Median:115.00 stddev:2.58 (2.2%) stddev-sans-first:1.90 05:30:59 INFO - 2015-11-14 05:30:59,257 DEBUG : BROWSER_OUTPUT: Values: 121.0 115.0 115.0 114.0 120.0 114.0 115.0 114.0 114.0 115.0 05:30:59 INFO - 2015-11-14 05:30:59,257 DEBUG : BROWSER_OUTPUT: 05:30:59 INFO - 2015-11-14 05:30:59,257 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:126.80 Median:127.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 05:30:59 INFO - 2015-11-14 05:30:59,258 DEBUG : BROWSER_OUTPUT: Values: 127.0 127.0 126.0 127.0 126.0 127.0 127.0 127.0 127.0 127.0 05:30:59 INFO - 2015-11-14 05:30:59,258 DEBUG : BROWSER_OUTPUT: 05:30:59 INFO - 2015-11-14 05:30:59,258 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:100.10 Median:96.50 stddev:3.73 (3.9%) stddev-sans-first:3.93 05:30:59 INFO - 2015-11-14 05:30:59,258 DEBUG : BROWSER_OUTPUT: Values: 99.0 105.0 97.0 104.0 99.0 96.0 96.0 104.0 104.0 97.0 05:30:59 INFO - 2015-11-14 05:30:59,258 DEBUG : BROWSER_OUTPUT: 05:30:59 INFO - 2015-11-14 05:30:59,258 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:63.00 Median:62.00 stddev:2.49 (4.0%) stddev-sans-first:2.62 05:30:59 INFO - 2015-11-14 05:30:59,259 DEBUG : BROWSER_OUTPUT: Values: 62.0 62.0 63.0 62.0 62.0 62.0 63.0 70.0 62.0 62.0 05:30:59 INFO - 2015-11-14 05:30:59,259 DEBUG : BROWSER_OUTPUT: 05:30:59 INFO - 2015-11-14 05:30:59,259 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:66.50 Median:67.00 stddev:0.97 (1.5%) stddev-sans-first:1.01 05:30:59 INFO - 2015-11-14 05:30:59,259 DEBUG : BROWSER_OUTPUT: Values: 67.0 67.0 68.0 65.0 66.0 65.0 66.0 67.0 67.0 67.0 05:30:59 INFO - 2015-11-14 05:30:59,259 DEBUG : BROWSER_OUTPUT: 05:30:59 INFO - 2015-11-14 05:30:59,259 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:86.60 Median:87.00 stddev:0.97 (1.1%) stddev-sans-first:1.00 05:30:59 INFO - 2015-11-14 05:30:59,260 DEBUG : BROWSER_OUTPUT: Values: 86.0 87.0 88.0 85.0 87.0 86.0 87.0 86.0 88.0 86.0 05:30:59 INFO - 2015-11-14 05:30:59,260 DEBUG : BROWSER_OUTPUT: 05:30:59 INFO - 2015-11-14 05:30:59,261 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:127.00 Median:125.50 stddev:3.77 (3.0%) stddev-sans-first:2.67 05:30:59 INFO - 2015-11-14 05:30:59,261 DEBUG : BROWSER_OUTPUT: Values: 135.0 125.0 125.0 132.0 126.0 124.0 124.0 125.0 129.0 125.0 05:30:59 INFO - 2015-11-14 05:30:59,261 DEBUG : BROWSER_OUTPUT: 05:30:59 INFO - 2015-11-14 05:30:59,262 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.60 Median:156.50 stddev:4.53 (2.9%) stddev-sans-first:4.17 05:30:59 INFO - 2015-11-14 05:30:59,262 DEBUG : BROWSER_OUTPUT: Values: 162.0 159.0 156.0 156.0 149.0 147.0 157.0 159.0 156.0 155.0 05:30:59 INFO - 2015-11-14 05:30:59,262 DEBUG : BROWSER_OUTPUT: 05:30:59 INFO - 2015-11-14 05:30:59,262 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.00 Median:73.00 stddev:1.41 (1.9%) stddev-sans-first:1.45 05:30:59 INFO - 2015-11-14 05:30:59,262 DEBUG : BROWSER_OUTPUT: Values: 72.0 72.0 71.0 73.0 76.0 72.0 73.0 73.0 74.0 74.0 05:30:59 INFO - 2015-11-14 05:30:59,262 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:30:59 INFO - 2015-11-14 05:30:59,262 DEBUG : BROWSER_OUTPUT: 05:30:59 INFO - 2015-11-14 05:30:59,951 INFO : Browser exited with error code: 0 05:30:59 INFO - 2015-11-14 05:30:59,998 INFO : Completed test kraken (00:00:58) 05:30:59 INFO - 2015-11-14 05:30:59,998 INFO : Starting test v8_7 05:30:59 INFO - 2015-11-14 05:30:59,998 DEBUG : operating with platform_type : mac_ 05:30:59 INFO - 2015-11-14 05:30:59,999 INFO : Initialising browser for v8_7 test... 05:31:00 INFO - 2015-11-14 05:31:00,012 DEBUG : command line: /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/45/v0hy50tj6n16mg96l0s6z6wm00000w/T/tmp_lDrAv/profile http://localhost:49282/getInfo.html 05:31:03 INFO - 2015-11-14 05:31:03,296 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:31:03 INFO - 2015-11-14 05:31:03,296 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:31:03 INFO - 2015-11-14 05:31:03,296 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/663 05:31:03 INFO - 2015-11-14 05:31:03,296 DEBUG : BROWSER_OUTPUT: __metrics 05:31:04 INFO - 2015-11-14 05:31:04,063 INFO : Browser initialized. 05:31:04 INFO - 2015-11-14 05:31:04,063 INFO : Running cycle 1/1 for v8_7 test... 05:31:04 INFO - 2015-11-14 05:31:04,063 DEBUG : command line: /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/45/v0hy50tj6n16mg96l0s6z6wm00000w/T/tmp_lDrAv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:31:16 INFO - 2015-11-14 05:31:16,014 DEBUG : BROWSER_OUTPUT: RSS: Main: 240406528 05:31:16 INFO - 2015-11-14 05:31:16,014 DEBUG : BROWSER_OUTPUT: 05:31:37 INFO - 2015-11-14 05:31:37,525 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49282/tests/v8_7/run.html (next: http://localhost:49282/tests/v8_7/run.html) 05:31:37 INFO - 2015-11-14 05:31:37,783 DEBUG : BROWSER_OUTPUT: RSS: Main: 260612096 05:31:37 INFO - 2015-11-14 05:31:37,783 DEBUG : BROWSER_OUTPUT: 05:31:37 INFO - 2015-11-14 05:31:37,783 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:31:37 INFO - 2015-11-14 05:31:37,783 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:31:37 INFO - 2015-11-14 05:31:37,783 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:31:37 INFO - 2015-11-14 05:31:37,783 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:31:37 INFO - 2015-11-14 05:31:37,783 DEBUG : BROWSER_OUTPUT: |0;Richards;166.22340425531914 05:31:37 INFO - 2015-11-14 05:31:37,783 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;197.43336623889437 05:31:37 INFO - 2015-11-14 05:31:37,783 DEBUG : BROWSER_OUTPUT: |2;Encrypt;326.6906239790918 05:31:37 INFO - 2015-11-14 05:31:37,783 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5825.581395348837 05:31:37 INFO - 2015-11-14 05:31:37,784 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1119.8208286674133 05:31:37 INFO - 2015-11-14 05:31:37,784 DEBUG : BROWSER_OUTPUT: |5;Earley;798.7220447284345 05:31:37 INFO - 2015-11-14 05:31:37,784 DEBUG : BROWSER_OUTPUT: |6;Boyer;12721.518987341773 05:31:37 INFO - 2015-11-14 05:31:37,784 DEBUG : BROWSER_OUTPUT: |7;RegExp;28194.444444444445 05:31:37 INFO - 2015-11-14 05:31:37,784 DEBUG : BROWSER_OUTPUT: |8;Splay;717.0487106017192 05:31:37 INFO - 2015-11-14 05:31:37,784 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;5803.468208092486 05:31:37 INFO - 2015-11-14 05:31:37,784 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:31:37 INFO - 2015-11-14 05:31:37,784 DEBUG : BROWSER_OUTPUT: __startTimestamp1447507897777__endTimestamp 05:31:37 INFO - 2015-11-14 05:31:37,784 DEBUG : BROWSER_OUTPUT: 05:31:37 INFO - 2015-11-14 05:31:37,784 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:31:37 INFO - 2015-11-14 05:31:37,784 DEBUG : BROWSER_OUTPUT: Number of tests: 10 05:31:37 INFO - 2015-11-14 05:31:37,784 DEBUG : BROWSER_OUTPUT: 05:31:37 INFO - 2015-11-14 05:31:37,784 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:166.22 Median:166.22 stddev:0.00 (0.0%) 05:31:37 INFO - 2015-11-14 05:31:37,784 DEBUG : BROWSER_OUTPUT: Values: 166.2 05:31:37 INFO - 2015-11-14 05:31:37,785 DEBUG : BROWSER_OUTPUT: 05:31:37 INFO - 2015-11-14 05:31:37,785 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:197.43 Median:197.43 stddev:0.00 (0.0%) 05:31:37 INFO - 2015-11-14 05:31:37,785 DEBUG : BROWSER_OUTPUT: Values: 197.4 05:31:37 INFO - 2015-11-14 05:31:37,785 DEBUG : BROWSER_OUTPUT: 05:31:37 INFO - 2015-11-14 05:31:37,785 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:326.69 Median:326.69 stddev:0.00 (0.0%) 05:31:37 INFO - 2015-11-14 05:31:37,785 DEBUG : BROWSER_OUTPUT: Values: 326.7 05:31:37 INFO - 2015-11-14 05:31:37,785 DEBUG : BROWSER_OUTPUT: 05:31:37 INFO - 2015-11-14 05:31:37,785 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5825.58 Median:5825.58 stddev:0.00 (0.0%) 05:31:37 INFO - 2015-11-14 05:31:37,785 DEBUG : BROWSER_OUTPUT: Values: 5825.6 05:31:37 INFO - 2015-11-14 05:31:37,785 DEBUG : BROWSER_OUTPUT: 05:31:37 INFO - 2015-11-14 05:31:37,785 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1119.82 Median:1119.82 stddev:0.00 (0.0%) 05:31:37 INFO - 2015-11-14 05:31:37,785 DEBUG : BROWSER_OUTPUT: Values: 1119.8 05:31:37 INFO - 2015-11-14 05:31:37,785 DEBUG : BROWSER_OUTPUT: 05:31:37 INFO - 2015-11-14 05:31:37,785 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:798.72 Median:798.72 stddev:0.00 (0.0%) 05:31:37 INFO - 2015-11-14 05:31:37,785 DEBUG : BROWSER_OUTPUT: Values: 798.7 05:31:37 INFO - 2015-11-14 05:31:37,786 DEBUG : BROWSER_OUTPUT: 05:31:37 INFO - 2015-11-14 05:31:37,786 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12721.52 Median:12721.52 stddev:0.00 (0.0%) 05:31:37 INFO - 2015-11-14 05:31:37,786 DEBUG : BROWSER_OUTPUT: Values: 12721.5 05:31:37 INFO - 2015-11-14 05:31:37,786 DEBUG : BROWSER_OUTPUT: 05:31:37 INFO - 2015-11-14 05:31:37,786 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:28194.44 Median:28194.44 stddev:0.00 (0.0%) 05:31:37 INFO - 2015-11-14 05:31:37,786 DEBUG : BROWSER_OUTPUT: Values: 28194.4 05:31:37 INFO - 2015-11-14 05:31:37,786 DEBUG : BROWSER_OUTPUT: 05:31:37 INFO - 2015-11-14 05:31:37,786 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:717.05 Median:717.05 stddev:0.00 (0.0%) 05:31:37 INFO - 2015-11-14 05:31:37,786 DEBUG : BROWSER_OUTPUT: Values: 717.0 05:31:37 INFO - 2015-11-14 05:31:37,786 DEBUG : BROWSER_OUTPUT: 05:31:37 INFO - 2015-11-14 05:31:37,786 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:5803.47 Median:5803.47 stddev:0.00 (0.0%) 05:31:37 INFO - 2015-11-14 05:31:37,786 DEBUG : BROWSER_OUTPUT: Values: 5803.5 05:31:37 INFO - 2015-11-14 05:31:37,786 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:31:37 INFO - 2015-11-14 05:31:37,786 DEBUG : BROWSER_OUTPUT: 05:31:38 INFO - 2015-11-14 05:31:38,462 INFO : Browser exited with error code: 0 05:31:38 INFO - 2015-11-14 05:31:38,481 INFO : Completed test v8_7 (00:00:38) 05:31:38 INFO - 2015-11-14 05:31:38,789 INFO : Completed test suite (00:20:10) 05:31:38 INFO - 2015-11-14 05:31:38,789 DEBUG : Working with test: dromaeo_css 05:31:38 INFO - 2015-11-14 05:31:38,789 DEBUG : Generating results file: dromaeo_css 05:31:38 INFO - 2015-11-14 05:31:38,790 DEBUG : Working with test: kraken 05:31:38 INFO - 2015-11-14 05:31:38,790 DEBUG : Generating results file: kraken 05:31:38 INFO - 2015-11-14 05:31:38,790 INFO : javascript benchmark 05:31:38 INFO - 2015-11-14 05:31:38,790 DEBUG : Working with test: v8_7 05:31:38 INFO - 2015-11-14 05:31:38,790 DEBUG : Generating results file: v8_7 05:31:38 INFO - 2015-11-14 05:31:38,791 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:31:38 INFO - 2015-11-14 05:31:38,850 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,1,57]] 05:31:38 INFO - 2015-11-14 05:31:38,850 DEBUG : process_Request line: dromaeo_css 6840.94 graph.html#tests=[[72,1,57]] 05:31:38 INFO - 2015-11-14 05:31:38,850 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:31:38 INFO - 2015-11-14 05:31:38,972 DEBUG : process_Request line: kraken 1509.00 graph.html#tests=[[232,1,57]] 05:31:38 INFO - 2015-11-14 05:31:38,973 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:31:39 INFO - 2015-11-14 05:31:39,102 DEBUG : process_Request line: v8_7 19387.81 graph.html#tests=[[230,1,57]] 05:31:39 INFO - 2015-11-14 05:31:39,103 INFO : javascript benchmark 05:31:39 INFO - 2015-11-14 05:31:39,105 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [338.22546368815415, 339.4483963559215, 339.4941537109706, 341.0501752618957, 341.689062952713, 11734.765304693901, 12188.756224875497, 17219.311227550897, 17356.0, 18011.099445027747, 11730.35483048432, 11742.882571174287, 11949.641510754669, 12069.637910862666, 12085.879141208585, 4335.783210839453, 4447.710898791568, 4453.020335526179, 4462.44219472566, 4471.1728330259, 4318.956810431902, 4440.666949978749, 4443.46678398591, 4448.97775511122, 4452.532484089173, 4400.987772812255, 4402.845900393487, 4412.1175764847, 6518.0, 6832.45340372769, 6792.45660347171, 6798.218204906425, 6802.3537763912345, 6818.624975626339, 6823.795286141399, 6382.489400847921, 6566.244881838602, 6585.473162147016, 6586.37429444202, 6587.275399706028, 23185.884070579537, 23868.880655596786, 23956.640650390083, 24315.933145682637, 24526.509469810684, 1982.2764690887866, 2072.2332736887297, 2083.4687154775434, 2133.2107120365563, 2151.128792838903, 14272.714545709132, 14551.0, 14631.780523292158, 14702.411903523845, 14915.477958271409, 1557.4471062772666, 1634.6158652716601, 1640.261882153036, 1679.554917946745, 1743.8730133407742, 62368.0, 65040.349596503904, 65890.0, 66037.0, 66069.3393066068, 16165.59586010359, 16180.0, 16564.6687066258, 16640.3343866244, 16682.33270669184, 24028.51942961131, 24047.759522404904, 24048.87975560111, 24062.87968560146, 24139.879300603738, 9923.454210018519, 9942.353747006422, 9950.303478756417, 9964.451955142536, 9999.450030248407, 8447.239748422671, 8484.236418722345, 8503.149685031447, 8523.616437260338, 8544.145585441405, 7873.448858579844, 7974.960125199337, 8014.959925200336, 8025.919740802634, 8037.919620803717, 3237.174520497258, 3325.617553981275, 3361.680640339164, 3488.947665785015, 3518.225990282185, 388.7725680476896, 389.3867159224233, 403.3526190464321, 418.45600719065095, 473.6968340262235, 10029.297949143636, 10525.157987360994, 10599.576016959389, 10641.946790266154, 10718.35689858611, 403.5198114244099, 406.6177792874688, 408.985685501012, 416.5834165834166, 418.39541862009105, 5728.570357223141, 5758.107493338455, 5843.211166492469, 5975.731092100866, 5980.790672326448, 355665.0, 362169.0, 363944.0, 434770.0, 520325.0, 74216.0, 74671.62664186645, 75346.24653753501, 76196.23803761891, 76342.0, 426.86767102198417, 430.47482071872264, 431.53609869390533, 432.01500578680657, 432.29104268998867, 10046.598136074475, 10363.119134873621, 10369.9481502592, 10435.269531132748, 10440.947795260976, 34741.74178678378, 35526.28947420985, 35551.46672799962, 35751.82124089363, 35812.82093589516, 47233.0, 47783.761081194374, 47936.5206347946, 48272.0, 48434.515654843, 7759.806004849924, 7964.960175199087, 7970.960145199237, 7971.402144839276, 7981.8802717958115, 11748.530058797553, 11804.468798904241, 12065.517379304729, 12084.577039803564, 12090.0, 10146.949265253626, 10356.948215259177, 10452.529636166542, 10471.94764026175, 10501.737456563647, 10031.29780915358, 10072.194224461879, 10209.438480883326, 10213.08082272599, 10415.479226038819, 9921.851172232278, 10472.424016679155, 10483.68548943533, 10540.15678745714, 10683.51924163399, 7475.476716629783, 7728.381729461742, 7817.609119544114, 7817.882731758915, 7835.960820195863, 10100.393976361442, 10177.796444071226, 10311.278210525192, 10351.844722329322, 10363.533640986023], "dojo.html": [3198.1844629619445, 3257.1531401835514, 3288.4738441849295, 3305.5041743738434, 3322.4351860183774, 5347.759350829212, 5403.8108666196695, 5408.2428460015535, 5423.2136340230645, 5454.427285135058, 5213.661112027725, 5321.574274058075, 5340.359156901177, 5462.371827239868, 5483.424240454755, 4854.611631069515, 5005.974970125144, 5065.392152941652, 5079.847604571869, 5087.389513258414, 74.15682631837291, 4993.151164302078, 5013.0, 5075.898482030358, 5093.617978651598, 5007.84976450707, 5011.448740638527, 5018.121828679985, 5022.0, 5058.898822023557, 5027.974860125712, 5040.269160971675, 5041.470645582234, 5045.545900868903, 5046.293518907356, 4799.424069111694, 4837.467878533358, 4917.5574198321965, 4960.429550601691, 5019.347484826949, 5232.3459567554055, 5340.786368545292, 5377.569794416477, 5395.865103372408, 5398.217258497496, 5745.6265342753, 5787.189793428924, 5803.883922321572, 5807.332156801979, 5816.069428891399, 5575.442455754433, 5676.0, 5732.168835518868, 5787.971060144714, 5855.326637436707, 5419.810306639249, 5481.75332110056, 5489.0, 5490.203920431555, 5507.99999999996, 5757.0, 5897.823065308047, 5990.341062483123, 5996.970015149896, 5997.70011499432, 5564.610477266633, 5575.0522411190195, 5603.327600687943, 5638.689872056994, 5644.350899646511, 5854.092615644582, 5876.44173803488, 5885.205497257815, 5888.970555147197, 5910.320313164041, 5574.275344205227, 5692.544596432275, 5759.51044161251, 5802.245708057925, 5815.389384114692, 5626.156076588544, 5702.087665973424, 5711.828645140652, 5712.514436272881, 5748.971255143698, 4516.345129956138, 4546.204414227497, 4561.2245918193985, 4563.885902852388, 4597.7241365518175, 4007.458993035961, 4097.733647312915, 4124.711270211056, 4142.71001029925, 4191.077962848169, 5474.7262636868, 5501.4223506532035, 5505.779768809283, 5509.146082357161, 5510.366307874566, 5862.501687356623, 5866.325372582122, 5867.119932010232, 5869.090291004901, 5872.677002764804, 5298.2052692096495, 5398.46015398457, 5429.131338985743, 5534.4742249486235, 5543.251661025791, 5117.181250999822, 5192.662476938987, 5205.115130427836, 5210.505002024802, 5211.739413029333, 6042.154098426224, 6062.454379105813, 6063.272407311151, 6068.908966365508, 6072.666003369857, 5608.0, 5703.771849126155, 5777.24895763548, 5866.530677545701, 5928.67392293428, 6040.969795150996, 6043.848903777265, 6047.758089676364, 6064.151018857452, 6080.391960803884, 5515.696636685021, 5746.569007324551, 5765.164051212634, 5767.798127065533, 5770.6249093808765, 5715.628484148517, 5801.680907550125, 5809.767609295581, 5810.4189581041555, 5817.360090390139, 5650.378458369494, 5680.261565996394, 5689.6586204827845, 5697.658140511582, 5699.9145012825675, 5349.705766182898, 5672.971635141798, 5675.0636145035605, 5678.2050512929045, 5682.0, 5401.3248343957, 5478.178273259043, 5551.167324901297, 5558.221848941233, 5608.971955140199, 5586.273784408001, 5618.634788738719, 5639.379668236573, 5640.32316122068, 5641.887162256649, 5320.095583750849, 5396.0556902542685, 5438.891222175455, 5551.805686800943, 5598.916016259841], "mootools.html": [1459.5913144319588, 1472.8379878213398, 1671.6907372136156, 1853.1938606706083, 1864.7109697996798, 6615.073889655446, 6791.185057793059, 6803.421709154722, 7170.318819712132, 7405.0, 7649.617519124049, 7734.961325193381, 7837.921620783791, 7850.607469626524, 7885.250901164381, 2220.6446968485047, 2252.3468194223656, 2253.661950707399, 2255.605269077913, 2257.1310045632385, 2249.527599204161, 2266.5240299537118, 2305.4121199094293, 2309.4688221709016, 2313.699219101523, 2179.7384313882358, 2185.8579192352445, 2201.9009144588454, 2206.922757703481, 2212.0930418528405, 2211.314492507328, 2224.9110035598637, 2244.584751820902, 2245.7754224577493, 2249.3701763506165, 2252.31304452142, 2269.8184145268337, 2274.8180145588312, 2283.041122728458, 2288.6795848581214, 8084.434089613729, 8150.959245203795, 8169.30560902324, 8178.304844088259, 8182.0, 4097.651699605537, 4682.461516925529, 4761.95238047622, 4762.976185119052, 4770.952290477086, 2618.3585021669624, 2944.4258369617933, 2995.4009198160456, 2998.565208044843, 3008.0374280230335, 880.3485420788635, 881.8368601808686, 925.1534845616253, 956.8947415784328, 990.7671697151163, 10699.679009629723, 10826.67519974402, 10834.67495975122, 10878.292910960763, 10883.564657413774, 4213.073123912734, 4253.680973926906, 4256.616904478612, 4325.545817689161, 4336.089421221579, 9454.101860323259, 9464.384814987141, 9476.194523465445, 9491.952540237255, 9531.094546018256, 4773.188557945157, 4790.0180463005, 4797.976010119997, 4802.903941921212, 4802.927956080662, 4290.184864875664, 4300.290452075373, 4313.094250207429, 4313.741175529415, 4319.416878721332, 3566.6433356664124, 3591.6587924147166, 3597.964020359815, 3600.117971097098, 3614.909627259287, 1117.279354816139, 1122.8428020077197, 1122.971925701864, 1136.8806275341135, 1138.1975707126455, 1295.6307452376027, 1309.7576948264411, 1323.966900827487, 1346.2999240395136, 1346.811446397505, 7486.663100160397, 7498.475106742476, 7524.021877155935, 7524.209957954446, 7525.8118547036765, 418.5396064329274, 426.46052743279773, 430.21700505081077, 431.0839466134464, 431.7366406492037, 5916.615419997686, 5980.611260268069, 5987.670678112659, 5987.850303742354, 5992.131140984533, 8528.147185281547, 9293.117153870508, 9503.192228660502, 9571.473568953636, 9599.184069354043, 9362.438253704799, 9379.296552758435, 9387.295952803566, 9421.38760980534, 9457.763555911157, 7220.819479513054, 7486.363659088929, 7521.7743467696055, 7532.811679708051, 7544.585047822313, 7057.400120989773, 7443.032405787213, 7480.625968701434, 7495.0, 7502.474826762293, 8288.461250018729, 8450.0, 8575.099614540384, 8598.140185981352, 8607.48355098696, 8630.136986301572, 8885.777855553662, 8902.243309318781, 8921.107889211027, 8930.419522731001, 7189.209186989531, 7248.347648711641, 7264.382527485223, 7270.272972702899, 7275.417966562768, 7394.112706475257, 7652.464327497022, 7799.181085986117, 7834.764957051298, 7853.842923141619, 7056.929430705833, 7241.131064272321, 7268.309510596485, 7342.0, 7360.852782944418, 7090.893636595352, 7124.893126603209, 7154.463415243981, 7218.458615603746, 7236.20401755796, 7312.451566132668, 7329.890051649123, 7335.266473352622, 7352.37504812097, 7353.485256032241, 6254.2807577129215, 6495.675216239075, 6532.738690452328, 6535.248446428532, 6585.1439312889015, 6571.244306904576, 6584.407403333723, 6596.769113081019, 6597.439217666552, 6617.900731488935], "ext.html": [534.4201541327659, 540.7674699879053, 553.6456667732651, 557.8633234857458, 567.1775924908883, 38101.618983810156, 39499.60500394995, 39545.604543954585, 39556.20887582246, 39623.207535849266, 42264.0, 42920.57079429205, 42925.35611965823, 42948.57051429485, 43035.56964430355, 9197.90802091979, 9367.203787678056, 9378.577963991602, 9406.52967351633, 9406.905930940671, 9156.725298241063, 9261.536923153815, 9262.212711919461, 9283.907160928371, 9284.0, 9181.357304988653, 9262.675806346779, 9272.211861991738, 9273.07269273074, 9288.256939444862, 9198.126178013077, 9275.536223188847, 9283.814323713488, 9289.442633442015, 9301.488418137034, 9093.77265568366, 9198.448093114368, 9199.954000229956, 9201.079892010812, 9225.953870230673, 39346.80326598377, 39862.0, 39865.0, 39879.401808972885, 39907.40138897919, 2344.5310937812337, 2629.6747846600774, 2723.482538317713, 2951.5720220567896, 2993.3863557970562, 26747.465050698876, 27509.86245068782, 27520.17439476819, 27644.447111057867, 28408.147755567366, 2385.7852793248517, 2413.1312727418117, 2424.5756992526235, 2433.549793288247, 2561.2700380391498, 242529.0, 242914.0, 243701.99999999822, 243775.0, 243987.0, 49613.75193124011, 50776.238356424685, 57217.71391143101, 59023.40976590265, 59135.11297330543, 59576.0, 59609.0, 59823.70088149618, 60104.0, 60139.69930150321, 16240.350385984428, 16450.095244761655, 16451.177441127897, 16464.341426342813, 16475.093869837034, 12300.200486968319, 12354.691132721753, 12369.134160608852, 12529.997600191962, 12535.811962820566, 18691.626167476847, 18880.356750055, 18888.150033248538, 18907.716384254247, 18964.715529267072, 8526.488410695254, 8734.432261902955, 8768.123187681182, 8770.122987701307, 8814.382993190415, 860.350435421253, 919.5494207838111, 964.4406244378243, 986.1913231150531, 1045.596316649342, 28729.994450194143, 28800.71199288022, 28833.855830720713, 28944.0, 29228.269293267414, 955.5556666150273, 1015.97460063499, 1036.549101141006, 1062.18211976779, 1064.5688496159069, 13615.455381784815, 13638.249896255602, 13673.521426750016, 13727.45090196381, 13782.0, 319465.0, 327871.0, 328145.0, 328274.0, 328512.0, 51987.0, 52108.739456303236, 52464.0, 52481.7375913118, 52482.999999999236, 1398.293861599906, 1400.733860566489, 1419.0350561617993, 1425.0737020936267, 1425.743366194095, 26740.19779406621, 26891.929628595553, 27053.1884043479, 27096.32259193536, 27191.320216994733, 45047.549524504335, 45328.77335613301, 45359.0, 45438.0, 45456.0, 297733.0, 300132.0, 300605.0, 300767.0, 301168.0, 29914.551281730357, 32769.180770480925, 33765.493517597744, 33866.66133338635, 33908.830455847565, 40474.59525404708, 41316.586834131274, 41389.379159313234, 41517.339306427406, 41539.0, 34781.826090869385, 35341.0, 35517.467237991965, 35629.0, 35767.28465430729, 34799.826000870846, 34811.0, 34977.0, 35141.82429087838, 35159.0, 33597.160070997445, 35291.823540882135, 35394.46908296429, 35417.0, 35503.0, 27753.583696244976, 30837.149114075968, 33208.0, 33455.49816752799, 33458.49812252867, 24243.636345455187, 24264.0, 24301.39246518851, 24553.0, 24618.0], "prototype.html": [310.40402427339507, 317.9443597370461, 318.98405079746004, 322.44861287198887, 324.5035096302658, 6378.712957916893, 6424.8072557823225, 6461.9999999999945, 6486.124373209621, 6552.082708420825, 6353.205849268841, 6360.809175724724, 6381.649009304487, 6385.457236134923, 6406.519511036679, 4573.7713114344315, 4729.503402142777, 4738.71567705937, 4787.999999999991, 4796.83211087612, 4724.220503616899, 4741.407324084489, 4742.857714268577, 4749.643776716743, 4753.405824271966, 4677.06458708258, 4679.859604211879, 4683.250679891218, 4687.2969054641735, 4711.552402521772, 4666.066786642668, 4667.043256132485, 4667.1599112159965, 4672.55610716983, 4680.531946805327, 3857.1321452673205, 3992.4629017828056, 3993.4409182714444, 3996.300647386696, 4026.6577340926056, 6060.424259695322, 6070.423309785563, 6075.696215189267, 6077.939220607782, 6102.847428814315, 5345.866353341159, 5353.9196912046355, 5353.973230133864, 5355.4109048005075, 5357.651752636066, 6590.275069742324, 6594.53838231324, 6595.6372399518, 6596.175478065242, 6620.668966551653, 4203.096334288112, 4286.721363111388, 4296.076343586113, 4318.913621727579, 4335.046289816235, 6907.861842763167, 6965.686544105527, 6969.407600354027, 6972.163340399134, 6977.860442791167, 4333.934990975138, 4344.391785150018, 4345.435093437833, 4346.847860324873, 4347.56524347569, 4299.677524185636, 4412.889677758018, 4413.470383553929, 4417.602415782595, 4418.977905110518, 5247.2653828464045, 5250.343707036621, 5251.474852514718, 5257.579393648499, 5265.78936842522, 6621.702023408958, 6639.734410623618, 6643.734250630017, 6646.4350530205475, 6648.933510664831, 1573.6931298396933, 1590.0618635005171, 1590.9124998125214, 1594.1391648509907, 1594.7767312576248, 1017.0947856407803, 1030.3611760708259, 1040.890706475809, 1044.6865940217904, 1046.4610725476387, 6298.527610429236, 6359.618422894641, 6397.840053998687, 6398.392152745481, 6484.967575162094, 6957.304269573104, 6992.986017027502, 6995.650217489105, 7015.649217539102, 7017.754378596826, 6437.259715132726, 6448.967755161288, 6453.257875344396, 6460.806175814639, 6466.450351720063, 3677.3380791457794, 3727.627237276305, 3773.8867833965023, 3782.0355809268463, 3785.1861849702445, 7178.676959536833, 7194.784156475314, 7205.89191162133, 7209.567425954459, 7216.134063912364, 7131.393831524275, 7134.464915131386, 7137.785866423912, 7141.107361579802, 7156.82107947295, 6977.860442791116, 7181.569105853666, 7182.174049984214, 7194.712211511481, 7208.96395518019, 6945.513814032969, 6953.165620125617, 6956.930430695628, 6972.44220462372, 6975.197852247056, 6794.388505034571, 6799.490038247052, 6800.081988931431, 6804.387605115563, 6823.897641535282, 6949.791506254821, 7190.640467976685, 7196.8920466192, 7208.387287080657, 7217.24218957002, 4456.286994080931, 4506.053728717006, 4507.684462087623, 4520.660950428665, 4524.185646583646, 6874.690638921161, 6897.793066208022, 6904.13698287714, 6912.0, 6916.930830691628, 6553.737850485927, 6700.631465269457, 6726.159230096238, 6742.8651426972165, 6743.898841517479, 6716.0, 6718.596884186769, 6720.563163394364, 6723.226828914738, 6728.226253980855, 6401.55189136756, 6549.0, 6559.770408035696, 6577.3422657733845, 6593.934060659332, 6555.410013098844, 6678.298778628368, 6686.331366863469, 6728.259891411843, 6734.090897728744, 6568.540202185801, 6608.801735947929, 6624.138861947916, 6624.370684784938, 6630.5027122965], "yui.html": [746.1866565443665, 756.8940348351232, 773.1881524399381, 775.724617760695, 819.1849110135416, 14030.92984535077, 14282.428702851874, 14320.06919550231, 14332.928335358334, 14349.856501434982, 13104.14823036502, 13330.200187988727, 13587.660308492292, 13609.455621775141, 13638.727225455485, 879.1560102301783, 908.2869947091534, 910.3536489092752, 911.7857303533664, 913.70761356366, 875.1598465473154, 898.7887846356134, 900.9594568244412, 901.5807649443008, 901.7430032440756, 912.338554547954, 933.351320832022, 934.5654270764094, 935.3826474526813, 935.4013431403907, 917.9311551633655, 932.2821427500786, 932.580338847518, 932.9020452852454, 933.3000249812641, 681.465049935798, 688.9655517224119, 692.9653517324114, 693.0609024771412, 693.8057343943703, 12795.680107997281, 12948.676283092904, 12961.351932403342, 12968.610941671765, 12977.545785897542, 10417.843732344021, 10438.321509101885, 10523.10553602937, 10551.0, 10754.623588174376, 9063.229625481841, 9072.818543629157, 9117.544122793834, 9151.542422878829, 9455.763605909839, 3271.2312606537444, 3312.271300313927, 3323.418401779679, 3380.983095084509, 3386.813725245135, 40530.0, 41119.1776164475, 49167.75416122932, 50287.49712502865, 51221.99999999963, 9207.125323094295, 9300.837395325585, 9506.334556580972, 9546.90453095474, 9877.802443951081, 19987.80073195613, 20137.09383077765, 20140.89929550372, 20179.899100504404, 20196.0, 6968.0941477607585, 7037.22590515043, 7098.538594991309, 7144.928550714426, 7220.241874603196, 3659.8170091495317, 3724.571674257441, 3728.291624591319, 3785.413260944503, 3810.904727381838, 3000.9549856752164, 3035.4536183487185, 3035.4991426414836, 3043.3456806786203, 3048.1008102609785, 426.5265555233688, 432.7944226492391, 435.77122010943873, 447.5703324808155, 447.75597299471866, 418.8523051694699, 455.76300323831424, 460.67292222522383, 546.2461802712231, 554.789180111555, 7978.481398709066, 8213.54825484604, 8594.78513037179, 8856.557172141367, 9024.729258122266, 557.2727590494444, 588.4586180713753, 609.2780055634088, 610.3865615056928, 626.4017862940972, 3845.4616353710503, 3941.0, 3984.7011474139554, 3996.660283875903, 4055.5842504668653, 61277.38722612806, 62170.68914655398, 62329.37670623326, 62355.6882215586, 62376.376236237964, 51929.480705192465, 52536.73731631317, 52549.2117618236, 52713.7364313176, 52764.0, 43465.348019779725, 44723.55276447259, 45953.54046459559, 47370.289445657654, 47492.28761568579, 7721.420893432903, 8158.224968627971, 8288.875666865122, 8557.101504341954, 8739.56302184901, 34270.31459370749, 34274.65725342715, 34513.65486345205, 35410.0, 35468.11329716778, 45945.54054459413, 46176.07647846957, 46191.538084618725, 46318.0, 47212.291815622106, 7613.390928725578, 7640.3505702015955, 7664.0, 7684.8463030740195, 7900.68397264103, 10828.404437755684, 10932.890671093188, 11000.179172224374, 11568.190226684388, 11883.881161188623, 9808.166305863797, 10252.948735256276, 10254.897451025394, 10964.835527466936, 11284.09727221804, 9521.714348569554, 9685.806283874424, 10002.499875006075, 10100.242481813746, 11251.381174035507, 9454.905450945678, 9462.479563624067, 9464.290178236522, 9598.32811703202, 10330.535125919201, 8670.739877803677, 8812.898387701538, 8829.11708829112, 9175.816483670156, 9280.303977201602, 8254.513329107378, 8320.16798320163, 8355.707550235955, 8802.427842190236, 9040.90959090427]}, "summary": {"lowerIsBetter": false, "suite": 6840.936438667556, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 8055.858311557659, "unit": "ms", "value": 8055.858311557659}, "dojo.html": {"lowerIsBetter": false, "filtered": 5330.715324098551, "unit": "ms", "value": 5330.715324098551}, "mootools.html": {"lowerIsBetter": false, "filtered": 4413.67770932623, "unit": "ms", "value": 4413.67770932623}, "ext.html": {"lowerIsBetter": false, "filtered": 18117.524959836013, "unit": "ms", "value": 18117.524959836013}, "prototype.html": {"lowerIsBetter": false, "filtered": 4945.318276080277, "unit": "ms", "value": 4945.318276080277}, "yui.html": {"lowerIsBetter": false, "filtered": 6034.838794465663, "unit": "ms", "value": 6034.838794465663}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2.e", "os": "mac", "name": "t-yosemite-r5-0002.e"}, "testrun": {"date": 1447506688, "suite": "dromaeo_css", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151114030404", "branch": "Firefox", "revision": "202b199b9fcf37a687bef882f2513e191f079622"}}, {"talos_counters": {}, "results": {"audio-dft": [164.0, 166.0, 163.0, 164.0, 163.0, 168.0, 169.0, 169.0, 168.0, 167.0], "ai-astar": [110.0, 100.0, 110.0, 109.0, 109.0, 118.0, 110.0, 109.0, 109.0, 108.0], "imaging-gaussian-blur": [121.0, 115.0, 115.0, 114.0, 120.0, 114.0, 115.0, 114.0, 114.0, 115.0], "audio-beat-detection": [156.0, 132.0, 150.0, 163.0, 127.0, 150.0, 145.0, 128.0, 160.0, 129.0], "json-stringify-tinderbox": [67.0, 67.0, 68.0, 65.0, 66.0, 65.0, 66.0, 67.0, 67.0, 67.0], "stanford-crypto-pbkdf2": [162.0, 159.0, 156.0, 156.0, 149.0, 147.0, 157.0, 159.0, 156.0, 155.0], "json-parse-financial": [62.0, 62.0, 63.0, 62.0, 62.0, 62.0, 63.0, 70.0, 62.0, 62.0], "stanford-crypto-sha256-iterative": [72.0, 72.0, 71.0, 73.0, 76.0, 72.0, 73.0, 73.0, 74.0, 74.0], "audio-fft": [76.0, 71.0, 76.0, 65.0, 70.0, 70.0, 69.0, 121.0, 64.0, 68.0], "imaging-darkroom": [127.0, 127.0, 126.0, 127.0, 126.0, 127.0, 127.0, 127.0, 127.0, 127.0], "stanford-crypto-ccm": [135.0, 125.0, 125.0, 132.0, 126.0, 124.0, 124.0, 125.0, 129.0, 125.0], "audio-oscillator": [89.0, 90.0, 126.0, 87.0, 89.0, 89.0, 122.0, 87.0, 89.0, 136.0], "stanford-crypto-aes": [86.0, 87.0, 88.0, 85.0, 87.0, 86.0, 87.0, 86.0, 88.0, 86.0], "imaging-desaturate": [99.0, 105.0, 97.0, 104.0, 99.0, 96.0, 96.0, 104.0, 104.0, 97.0]}, "summary": {"lowerIsBetter": true, "suite": 1508.9999999999998, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 75.0, "unit": "ms", "value": 75.0}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 155.6, "unit": "ms", "value": 155.6}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 144.0, "unit": "ms", "value": 144.0}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 127.0, "unit": "ms", "value": 127.0}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 126.8, "unit": "ms", "value": 126.8}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 63.0, "unit": "ms", "value": 63.0}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 100.4, "unit": "ms", "value": 100.4}, "ai-astar": {"lowerIsBetter": true, "filtered": 109.2, "unit": "ms", "value": 109.2}, "audio-dft": {"lowerIsBetter": true, "filtered": 166.1, "unit": "ms", "value": 166.1}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 73.0, "unit": "ms", "value": 73.0}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 66.5, "unit": "ms", "value": 66.5}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 115.7, "unit": "ms", "value": 115.7}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 86.6, "unit": "ms", "value": 86.6}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 100.1, "unit": "ms", "value": 100.1}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2.e", "os": "mac", "name": "t-yosemite-r5-0002.e"}, "testrun": {"date": 1447506688, "suite": "kraken", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151114030404", "branch": "Firefox", "revision": "202b199b9fcf37a687bef882f2513e191f079622"}}, {"talos_counters": {}, "results": {"DeltaBlue": [197.43336623889437], "Encrypt": [326.6906239790918], "NavierStokes": [5803.468208092486], "Decrypt": [5825.581395348837], "Splay": [717.0487106017192], "Richards": [166.22340425531914], "RegExp": [28194.444444444445], "Earley": [798.7220447284345], "Boyer": [12721.518987341773], "RayTrace": [1119.8208286674133]}, "summary": {"lowerIsBetter": false, "suite": 19387.80573505167, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 334.88766999999984, "unit": "score", "value": 334.88766999999984}, "Encrypt": {"lowerIsBetter": false, "filtered": 814.7800409999996, "unit": "score", "value": 814.7800409999996}, "NavierStokes": {"lowerIsBetter": false, "filtered": 255.70916334661337, "unit": "score", "value": 255.70916334661337}, "Decrypt": {"lowerIsBetter": false, "filtered": 45.691748502993995, "unit": "score", "value": 45.691748502993995}, "Splay": {"lowerIsBetter": false, "filtered": 113.64778821178822, "unit": "score", "value": 113.64778821178822}, "RegExp": {"lowerIsBetter": false, "filtered": 32.31079802955666, "unit": "score", "value": 32.31079802955666}, "Richards": {"lowerIsBetter": false, "filtered": 212.37683199999995, "unit": "score", "value": 212.37683199999995}, "Earley": {"lowerIsBetter": false, "filtered": 834.4116759999996, "unit": "score", "value": 834.4116759999996}, "Boyer": {"lowerIsBetter": false, "filtered": 52.38863383084579, "unit": "score", "value": 52.38863383084579}, "RayTrace": {"lowerIsBetter": false, "filtered": 660.8101769999998, "unit": "score", "value": 660.8101769999998}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2.e", "os": "mac", "name": "t-yosemite-r5-0002.e"}, "testrun": {"date": 1447506688, "suite": "v8_7", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151114030404", "branch": "Firefox", "revision": "202b199b9fcf37a687bef882f2513e191f079622"}}] 05:31:39 INFO - RETURN: dromaeo_css: 6840.94 05:31:39 INFO - RETURN: kraken: 1509.00 05:31:39 INFO - RETURN: v8_7: 19387.81 05:31:39 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,57]]", "result": "19387.81"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,57]]", "result": "1509.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,57]]", "result": "6840.94"}}} 05:31:39 INFO - Return code: 0 05:31:39 INFO - # TBPL SUCCESS # 05:31:39 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:31:39 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:31:39 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:31:39 INFO - 2015-11-14 05:31:39.198 screenresolution[1707:13674] starting screenresolution argv=screenresolution get 05:31:39 INFO - 2015-11-14 05:31:39.201 screenresolution[1707:13674] Display 0: 1600x1200x32@60 05:31:39 INFO - 2015-11-14 05:31:39.207 screenresolution[1708:13677] starting screenresolution argv=screenresolution list 05:31:39 INFO - Available Modes on Display 0 05:31:39 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:31:39 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:31:39 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:31:39 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:31:39 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:31:39 INFO - Intel HD Graphics 3000: 05:31:39 INFO - Chipset Model: Intel HD Graphics 3000 05:31:39 INFO - Type: GPU 05:31:39 INFO - Bus: Built-In 05:31:39 INFO - VRAM (Total): 512 MB 05:31:39 INFO - VRAM (Dynamic, Max): 10 05:31:39 INFO - Vendor: Intel (0x8086) 05:31:39 INFO - Device ID: 0x0116 05:31:39 INFO - Revision ID: 0x0009 05:31:39 INFO - Displays: 05:31:39 INFO - Display: 05:31:39 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:31:39 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:31:39 INFO - Display Serial Number: 1600x1200 60 05:31:39 INFO - Main Display: Yes 05:31:39 INFO - Mirror: Off 05:31:39 INFO - Online: Yes 05:31:39 INFO - Rotation: Supported 05:31:39 INFO - Return code: 0 05:31:39 INFO - Running post-action listener: _resource_record_post_action 05:31:39 INFO - Running post-run listener: _resource_record_post_run 05:31:40 INFO - Total resource usage - Wall time: 1250s; CPU: 30.0%; Read bytes: 41559040; Write bytes: 691519488; Read time: 6562; Write time: 190811 05:31:40 INFO - install - Wall time: 38s; CPU: 30.0%; Read bytes: 342211072; Write bytes: 339548160; Read time: 33493; Write time: 19674 05:31:40 INFO - run-tests - Wall time: 1212s; CPU: 30.0%; Read bytes: 39498752; Write bytes: 346740736; Read time: 6132; Write time: 168064 05:31:40 INFO - Running post-run listener: _upload_blobber_files 05:31:40 INFO - Blob upload gear active. 05:31:40 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 05:31:40 INFO - Copying logs to upload dir... 05:31:40 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1347.510911 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 27 secs) (at 2015-11-14 05:31:40.611243) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-14 05:31:40.615161) ========= 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.0kv5II4Bqc/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.3l5unflI0n/Listeners TMPDIR=/var/folders/45/v0hy50tj6n16mg96l0s6z6wm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False build_url:https://queue.taskcluster.net/v1/task/aPTj2c3WQSOjwP_30wV6RQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010069 build_url: 'https://queue.taskcluster.net/v1/task/aPTj2c3WQSOjwP_30wV6RQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg' ========= master_lag: 0.02 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-14 05:31:40.641288) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-14 05:31:40.641634) ========= 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.0kv5II4Bqc/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.3l5unflI0n/Listeners TMPDIR=/var/folders/45/v0hy50tj6n16mg96l0s6z6wm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False program finished with exit code 0 elapsedTime=0.005195 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-14 05:31:40.691311) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-14 05:31:40.691704) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-14 05:31:40.692169) ========= ========= Total master_lag: 0.29 =========