builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0006 starttime: 1448003312.08 results: success (0) buildid: 20151119205634 builduid: 704f9cb67ce845c4a415f3bc386b24e4 revision: 3835b568092ae3b71adc931d24928670ad7141a7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-19 23:08:32.075738) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-19 23:08:32.076144) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-19 23:08:32.076472) ========= 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.JWy3XbC9ts/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.W1eElHHrlW/Listeners TMPDIR=/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.005426 basedir: '/builds/slave/test' ========= master_lag: 0.21 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-19 23:08:32.290416) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-19 23:08:32.290712) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-19 23:08:32.548279) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 23:08:32.548671) ========= 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.JWy3XbC9ts/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.W1eElHHrlW/Listeners TMPDIR=/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005784 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 23:08:32.626588) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-19 23:08:32.626852) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-19 23:08:32.627173) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 23:08:32.627508) ========= 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.JWy3XbC9ts/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.W1eElHHrlW/Listeners TMPDIR=/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2015-11-19 23:08:32-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 1.62G=0s 2015-11-19 23:08:33 (1.62 GB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.603223 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 23:08:33.279272) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 23:08:33.279589) ========= 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.JWy3XbC9ts/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.W1eElHHrlW/Listeners TMPDIR=/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.023353 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 23:08:33.327351) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-19 23:08:33.327765) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 3835b568092ae3b71adc931d24928670ad7141a7 --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 3835b568092ae3b71adc931d24928670ad7141a7 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.JWy3XbC9ts/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.W1eElHHrlW/Listeners TMPDIR=/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2015-11-19 23:08:33,387 truncating revision to first 12 chars 2015-11-19 23:08:33,387 Setting DEBUG logging. 2015-11-19 23:08:33,387 attempt 1/10 2015-11-19 23:08:33,387 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/3835b568092a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-19 23:08:34,479 unpacking tar archive at: mozilla-central-3835b568092a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.430980 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-19 23:08:34.772707) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-19 23:08:34.773047) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-19 23:08:34.791297) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-19 23:08:34.791615) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-19 23:08:34.792067) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 27 secs) (at 2015-11-19 23:08:34.792422) ========= /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.JWy3XbC9ts/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.W1eElHHrlW/Listeners TMPDIR=/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 23:08:34 INFO - MultiFileLogger online at 20151119 23:08:34 in /builds/slave/test 23:08:34 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 23:08:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:08:34 INFO - {'append_to_log': False, 23:08:34 INFO - 'base_work_dir': '/builds/slave/test', 23:08:34 INFO - 'blob_upload_branch': 'Firefox', 23:08:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:08:34 INFO - 'branch': 'Firefox', 23:08:34 INFO - 'buildbot_json_path': 'buildprops.json', 23:08:34 INFO - 'config_files': ('talos/mac_config.py',), 23:08:34 INFO - 'default_actions': ('clobber', 23:08:34 INFO - 'read-buildbot-config', 23:08:34 INFO - 'download-and-extract', 23:08:34 INFO - 'populate-webroot', 23:08:34 INFO - 'create-virtualenv', 23:08:34 INFO - 'install', 23:08:34 INFO - 'run-tests'), 23:08:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:08:34 INFO - 'download_minidump_stackwalk': True, 23:08:34 INFO - 'download_symbols': 'ondemand', 23:08:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:08:34 INFO - 'tooltool.py': '/tools/tooltool.py', 23:08:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:08:34 INFO - '/tools/misc-python/virtualenv.py')}, 23:08:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:08:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:08:34 INFO - 'installer_path': 'installer.exe', 23:08:34 INFO - 'log_level': 'info', 23:08:34 INFO - 'log_name': 'talos', 23:08:34 INFO - 'log_to_console': True, 23:08:34 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 23:08:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 23:08:34 INFO - 'opt_config_files': (), 23:08:34 INFO - 'pip_index': False, 23:08:34 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 23:08:34 INFO - 'cmd': ('bash', 23:08:34 INFO - '-c', 23:08:34 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 23:08:34 INFO - 'enabled': True, 23:08:34 INFO - 'halt_on_failure': False, 23:08:34 INFO - 'name': 'check_screen_resolution'},), 23:08:34 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 23:08:34 INFO - 'cmd': ('bash', 23:08:34 INFO - '-c', 23:08:34 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 23:08:34 INFO - 'enabled': True, 23:08:34 INFO - 'halt_on_failure': False, 23:08:34 INFO - 'name': 'check_screen_resolution'},), 23:08:34 INFO - 'run_cmd_checks_enabled': True, 23:08:34 INFO - 'sps_profile': False, 23:08:34 INFO - 'sps_profile_interval': 0, 23:08:34 INFO - 'suite': 'dromaeojs-e10s', 23:08:34 INFO - 'system_bits': '64', 23:08:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:08:34 INFO - 'title': 't-yosemite-r7-0006', 23:08:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:08:34 INFO - 'use_talos_json': True, 23:08:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:08:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:08:34 INFO - 'work_dir': 'build'} 23:08:34 INFO - ##### 23:08:34 INFO - ##### Running clobber step. 23:08:34 INFO - ##### 23:08:34 INFO - Running pre-action listener: _resource_record_pre_action 23:08:34 INFO - Running main action method: clobber 23:08:34 INFO - rmtree: /builds/slave/test/build 23:08:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:08:36 INFO - Running post-action listener: _resource_record_post_action 23:08:36 INFO - ##### 23:08:36 INFO - ##### Running read-buildbot-config step. 23:08:36 INFO - ##### 23:08:36 INFO - Running pre-action listener: _resource_record_pre_action 23:08:36 INFO - Running main action method: read_buildbot_config 23:08:36 INFO - Using buildbot properties: 23:08:36 INFO - { 23:08:36 INFO - "properties": { 23:08:36 INFO - "buildnumber": 2, 23:08:36 INFO - "product": "firefox", 23:08:36 INFO - "script_repo_revision": "production", 23:08:36 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 23:08:36 INFO - "repository": "", 23:08:36 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 23:08:36 INFO - "buildid": "20151119205634", 23:08:36 INFO - "slavename": "t-yosemite-r7-0006", 23:08:36 INFO - "pgo_build": "False", 23:08:36 INFO - "basedir": "/builds/slave/test", 23:08:36 INFO - "project": "", 23:08:36 INFO - "platform": "yosemite_r7", 23:08:36 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 23:08:36 INFO - "slavebuilddir": "test", 23:08:36 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 23:08:36 INFO - "branch": "mozilla-central", 23:08:36 INFO - "repo_path": "mozilla-central", 23:08:36 INFO - "stage_platform": "macosx64", 23:08:36 INFO - "builduid": "704f9cb67ce845c4a415f3bc386b24e4", 23:08:36 INFO - "revision": "3835b568092ae3b71adc931d24928670ad7141a7" 23:08:36 INFO - }, 23:08:36 INFO - "sourcestamp": { 23:08:36 INFO - "repository": "", 23:08:36 INFO - "hasPatch": false, 23:08:36 INFO - "project": "", 23:08:36 INFO - "branch": "mozilla-central-macosx64-talos", 23:08:36 INFO - "changes": [ 23:08:36 INFO - { 23:08:36 INFO - "category": null, 23:08:36 INFO - "files": [ 23:08:36 INFO - { 23:08:36 INFO - "url": null, 23:08:36 INFO - "name": "https://queue.taskcluster.net/v1/task/wBB41CzbQO2t37TsTWPMtw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 23:08:36 INFO - } 23:08:36 INFO - ], 23:08:36 INFO - "repository": "", 23:08:36 INFO - "rev": "3835b568092ae3b71adc931d24928670ad7141a7", 23:08:36 INFO - "who": "philringnalda@gmail.com", 23:08:36 INFO - "when": 1448002552, 23:08:36 INFO - "number": 6687115, 23:08:36 INFO - "comments": "Backed out 2 changesets (bug 1225007) for frequent OS X \"Shouldn't return empty rect\" assertion failures, a=backout\n\nBacked out changeset c5b352c74b35 (bug 1225007)\nBacked out changeset 8a513c70ce7c (bug 1225007)", 23:08:36 INFO - "project": "", 23:08:36 INFO - "at": "Thu 19 Nov 2015 22:55:52", 23:08:36 INFO - "branch": "mozilla-central-macosx64-talos", 23:08:36 INFO - "revlink": "", 23:08:36 INFO - "properties": [ 23:08:36 INFO - [ 23:08:36 INFO - "buildid", 23:08:36 INFO - "20151119205634", 23:08:36 INFO - "Change" 23:08:36 INFO - ], 23:08:36 INFO - [ 23:08:36 INFO - "builduid", 23:08:36 INFO - "704f9cb67ce845c4a415f3bc386b24e4", 23:08:36 INFO - "Change" 23:08:36 INFO - ], 23:08:36 INFO - [ 23:08:36 INFO - "pgo_build", 23:08:36 INFO - "False", 23:08:36 INFO - "Change" 23:08:36 INFO - ] 23:08:36 INFO - ], 23:08:36 INFO - "revision": "3835b568092ae3b71adc931d24928670ad7141a7" 23:08:36 INFO - } 23:08:36 INFO - ], 23:08:36 INFO - "revision": "3835b568092ae3b71adc931d24928670ad7141a7" 23:08:36 INFO - } 23:08:36 INFO - } 23:08:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/wBB41CzbQO2t37TsTWPMtw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 23:08:36 INFO - Running post-action listener: _resource_record_post_action 23:08:36 INFO - ##### 23:08:36 INFO - ##### Running download-and-extract step. 23:08:36 INFO - ##### 23:08:36 INFO - Running pre-action listener: _resource_record_pre_action 23:08:36 INFO - Running main action method: download_and_extract 23:08:36 INFO - mkdir: /builds/slave/test/build/tests 23:08:36 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')]} 23:08:36 INFO - https://queue.taskcluster.net/v1/task/wBB41CzbQO2t37TsTWPMtw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 23:08:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wBB41CzbQO2t37TsTWPMtw/artifacts/public/build/test_packages.json 23:08:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wBB41CzbQO2t37TsTWPMtw/artifacts/public/build/test_packages.json 23:08:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wBB41CzbQO2t37TsTWPMtw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 23:08:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wBB41CzbQO2t37TsTWPMtw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 23:08:37 INFO - Downloaded 1149 bytes. 23:08:37 INFO - Reading from file /builds/slave/test/build/test_packages.json 23:08:37 INFO - Using the following test package requirements: 23:08:37 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 23:08:37 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 23:08:37 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 23:08:37 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 23:08:37 INFO - u'jsshell-mac.zip'], 23:08:37 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 23:08:37 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 23:08:37 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 23:08:37 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 23:08:37 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 23:08:37 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 23:08:37 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 23:08:37 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 23:08:37 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 23:08:37 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 23:08:37 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 23:08:37 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 23:08:37 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 23:08:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:08:37 INFO - https://queue.taskcluster.net/v1/task/wBB41CzbQO2t37TsTWPMtw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 23:08:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wBB41CzbQO2t37TsTWPMtw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 23:08:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wBB41CzbQO2t37TsTWPMtw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 23:08:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wBB41CzbQO2t37TsTWPMtw/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 23:08:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wBB41CzbQO2t37TsTWPMtw/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 23:08:39 INFO - Downloaded 17522529 bytes. 23:08:39 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 23:08:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 23:08:39 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 23:08:42 INFO - Return code: 0 23:08:42 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 23:08:42 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')]} 23:08:42 INFO - https://queue.taskcluster.net/v1/task/wBB41CzbQO2t37TsTWPMtw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 23:08:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wBB41CzbQO2t37TsTWPMtw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 23:08:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wBB41CzbQO2t37TsTWPMtw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 23:08:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wBB41CzbQO2t37TsTWPMtw/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 23:08:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wBB41CzbQO2t37TsTWPMtw/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 23:08:47 INFO - Downloaded 17522529 bytes. 23:08:47 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 23:08:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 23:08:47 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 23:08:50 INFO - Return code: 0 23:08:50 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')]} 23:08:50 INFO - https://queue.taskcluster.net/v1/task/wBB41CzbQO2t37TsTWPMtw/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 23:08:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wBB41CzbQO2t37TsTWPMtw/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 23:08:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wBB41CzbQO2t37TsTWPMtw/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 23:08:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wBB41CzbQO2t37TsTWPMtw/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 23:08:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wBB41CzbQO2t37TsTWPMtw/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 23:08:51 INFO - Downloaded 11130997 bytes. 23:08:51 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 23:08:51 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 23:08:51 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 23:08:52 INFO - Return code: 0 23:08:52 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')]} 23:08:52 INFO - https://queue.taskcluster.net/v1/task/wBB41CzbQO2t37TsTWPMtw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 23:08:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wBB41CzbQO2t37TsTWPMtw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 23:08:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wBB41CzbQO2t37TsTWPMtw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 23:08:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wBB41CzbQO2t37TsTWPMtw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 23:08:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wBB41CzbQO2t37TsTWPMtw/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 23:08:55 INFO - Downloaded 109421022 bytes. 23:08:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/wBB41CzbQO2t37TsTWPMtw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 23:08:55 INFO - mkdir: /builds/slave/test/properties 23:08:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:08:55 INFO - Writing to file /builds/slave/test/properties/build_url 23:08:55 INFO - Contents: 23:08:55 INFO - build_url:https://queue.taskcluster.net/v1/task/wBB41CzbQO2t37TsTWPMtw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 23:08:55 INFO - Running post-action listener: _resource_record_post_action 23:08:55 INFO - Running post-action listener: set_extra_try_arguments 23:08:55 INFO - ##### 23:08:55 INFO - ##### Running populate-webroot step. 23:08:55 INFO - ##### 23:08:55 INFO - Running pre-action listener: _resource_record_pre_action 23:08:55 INFO - Running main action method: populate_webroot 23:08:55 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:08:55 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:08:55 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 23:08:55 INFO - '../fennec_ids.txt'], 23:08:55 INFO - 'tests': ['tcheck2']}, 23:08:55 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:08:55 INFO - '--tppagecycles', 23:08:55 INFO - '7'], 23:08:55 INFO - 'tests': ['tsvgm']}}, 23:08:55 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 23:08:55 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 23:08:55 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:08:55 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 23:08:55 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 23:08:55 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 23:08:55 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:08:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:08:55 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:08:55 INFO - 'talos_options': ['--e10s'], 23:08:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:08:55 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:08:55 INFO - 'tests': ['damp', 'tps']}, 23:08:55 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:08:55 INFO - 'talos_options': ['--e10s'], 23:08:55 INFO - 'tests': ['damp', 'tps']}, 23:08:55 INFO - 'g3': {'tests': ['dromaeo_dom']}, 23:08:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:08:55 INFO - 'other': {'tests': ['a11yr', 23:08:55 INFO - 'ts_paint', 23:08:55 INFO - 'tpaint', 23:08:55 INFO - 'sessionrestore', 23:08:55 INFO - 'sessionrestore_no_auto_restore']}, 23:08:55 INFO - 'other-e10s': {'talos_options': ['--e10s'], 23:08:55 INFO - 'tests': ['a11yr', 23:08:55 INFO - 'ts_paint', 23:08:55 INFO - 'tpaint', 23:08:55 INFO - 'sessionrestore', 23:08:55 INFO - 'sessionrestore_no_auto_restore']}, 23:08:55 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 23:08:55 INFO - 'tests': ['a11yr', 23:08:55 INFO - 'ts_paint', 23:08:55 INFO - 'tpaint', 23:08:55 INFO - 'sessionrestore', 23:08:55 INFO - 'sessionrestore_no_auto_restore']}, 23:08:55 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 23:08:55 INFO - 'tests': ['a11yr', 23:08:55 INFO - 'ts_paint', 23:08:55 INFO - 'tpaint', 23:08:55 INFO - 'sessionrestore', 23:08:55 INFO - 'sessionrestore_no_auto_restore']}, 23:08:55 INFO - 'other_l64': {'tests': ['a11yr', 23:08:55 INFO - 'ts_paint', 23:08:55 INFO - 'tpaint', 23:08:55 INFO - 'sessionrestore', 23:08:55 INFO - 'sessionrestore_no_auto_restore']}, 23:08:55 INFO - 'other_nol64': {'tests': ['a11yr', 23:08:55 INFO - 'ts_paint', 23:08:55 INFO - 'tpaint', 23:08:55 INFO - 'sessionrestore', 23:08:55 INFO - 'sessionrestore_no_auto_restore']}, 23:08:55 INFO - 'svgr': {'tests': ['tsvgx', 23:08:55 INFO - 'tsvgr_opacity', 23:08:55 INFO - 'tart', 23:08:55 INFO - 'tscrollx', 23:08:55 INFO - 'cart']}, 23:08:55 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 23:08:55 INFO - 'tests': ['tsvgx', 23:08:55 INFO - 'tsvgr_opacity', 23:08:55 INFO - 'tart', 23:08:55 INFO - 'tscrollx', 23:08:55 INFO - 'cart']}, 23:08:55 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:08:55 INFO - 'tests': ['tp5o']}, 23:08:55 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:08:55 INFO - 'talos_options': ['--e10s'], 23:08:55 INFO - 'tests': ['tp5o']}, 23:08:55 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:08:55 INFO - 'talos_options': ['--xperf_path', 23:08:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:08:55 INFO - 'tests': ['tp5n']}, 23:08:55 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:08:55 INFO - 'talos_options': ['--e10s', 23:08:55 INFO - '--xperf_path', 23:08:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:08:55 INFO - 'tests': ['tp5n']}}, 23:08:55 INFO - 'talos.zip': {'path': '', 23:08:55 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:08:55 INFO - Running post-action listener: _resource_record_post_action 23:08:55 INFO - ##### 23:08:55 INFO - ##### Running create-virtualenv step. 23:08:55 INFO - ##### 23:08:55 INFO - Running pre-action listener: _resource_record_pre_action 23:08:55 INFO - Running main action method: create_virtualenv 23:08:55 INFO - Creating virtualenv /builds/slave/test/build/venv 23:08:55 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 23:08:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:08:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:08:56 INFO - Using real prefix '/tools/python27' 23:08:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:08:56 INFO - Installing distribute.............................................................................................................................................................................................done. 23:08:59 INFO - Installing pip.................done. 23:08:59 INFO - Return code: 0 23:08:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:08:59 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')]} 23:08:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:08:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:08:59 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')]} 23:08:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:08:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:08:59 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 0x10b8ca490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b8a7228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbcebd7d260>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b7ee9f0>, '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 0x10b54ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b7e18c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JWy3XbC9ts/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.W1eElHHrlW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 23:08:59 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 23:08:59 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 23:08:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JWy3XbC9ts/Render', 23:08:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:08:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:08:59 INFO - 'HOME': '/Users/cltbld', 23:08:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:08:59 INFO - 'LOGNAME': 'cltbld', 23:08:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:08:59 INFO - 'MOZ_NO_REMOTE': '1', 23:08:59 INFO - 'NO_EM_RESTART': '1', 23:08:59 INFO - 'PAGER': '/bin/cat', 23:08:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:08:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:08:59 INFO - 'PWD': '/builds/slave/test', 23:08:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:08:59 INFO - 'SHELL': '/bin/bash', 23:08:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W1eElHHrlW/Listeners', 23:08:59 INFO - 'TMPDIR': '/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/', 23:08:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:08:59 INFO - 'USER': 'cltbld', 23:08:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:08:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:08:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:08:59 INFO - 'XPC_FLAGS': '0x0', 23:08:59 INFO - 'XPC_SERVICE_NAME': '0', 23:08:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:08:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:08:59 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 23:08:59 INFO - Cleaning up... 23:08:59 INFO - Return code: 0 23:08:59 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 23:08:59 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')]} 23:08:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:08:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:08:59 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')]} 23:08:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:08:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:08:59 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 0x10b8ca490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b8a7228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbcebd7d260>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b7ee9f0>, '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 0x10b54ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b7e18c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JWy3XbC9ts/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.W1eElHHrlW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 23:08:59 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 23:08:59 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 23:08:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JWy3XbC9ts/Render', 23:08:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:08:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:08:59 INFO - 'HOME': '/Users/cltbld', 23:08:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:08:59 INFO - 'LOGNAME': 'cltbld', 23:08:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:08:59 INFO - 'MOZ_NO_REMOTE': '1', 23:08:59 INFO - 'NO_EM_RESTART': '1', 23:08:59 INFO - 'PAGER': '/bin/cat', 23:08:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:08:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:08:59 INFO - 'PWD': '/builds/slave/test', 23:08:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:08:59 INFO - 'SHELL': '/bin/bash', 23:08:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W1eElHHrlW/Listeners', 23:08:59 INFO - 'TMPDIR': '/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/', 23:08:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:08:59 INFO - 'USER': 'cltbld', 23:08:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:08:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:08:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:08:59 INFO - 'XPC_FLAGS': '0x0', 23:08:59 INFO - 'XPC_SERVICE_NAME': '0', 23:08:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:09:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:09:00 INFO - Downloading/unpacking psutil>=0.7.1 23:09:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:09:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:09:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:09:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:09:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:09:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:09:02 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 23:09:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 23:09:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:09:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:09:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:09:03 INFO - Installing collected packages: psutil 23:09:03 INFO - Running setup.py install for psutil 23:09:03 INFO - building 'psutil._psutil_osx' extension 23:09:03 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 23:09:03 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 23:09:03 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 23:09:04 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 23:09:04 INFO - building 'psutil._psutil_posix' extension 23:09:04 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 23:09:04 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 23:09:04 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 23:09:04 INFO - ^ 23:09:04 INFO - 1 warning generated. 23:09:04 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 23:09:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:09:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:09:04 INFO - Successfully installed psutil 23:09:04 INFO - Cleaning up... 23:09:04 INFO - Return code: 0 23:09:04 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 23:09:04 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')]} 23:09:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:09:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09:04 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')]} 23:09:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:09:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09:04 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 0x10b8ca490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b8a7228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbcebd7d260>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b7ee9f0>, '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 0x10b54ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b7e18c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JWy3XbC9ts/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.W1eElHHrlW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 23:09:04 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 23:09:04 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 23:09:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JWy3XbC9ts/Render', 23:09:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:09:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:09:04 INFO - 'HOME': '/Users/cltbld', 23:09:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:09:04 INFO - 'LOGNAME': 'cltbld', 23:09:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:09:04 INFO - 'MOZ_NO_REMOTE': '1', 23:09:04 INFO - 'NO_EM_RESTART': '1', 23:09:04 INFO - 'PAGER': '/bin/cat', 23:09:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:09:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:09:04 INFO - 'PWD': '/builds/slave/test', 23:09:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:09:04 INFO - 'SHELL': '/bin/bash', 23:09:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W1eElHHrlW/Listeners', 23:09:04 INFO - 'TMPDIR': '/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/', 23:09:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:09:04 INFO - 'USER': 'cltbld', 23:09:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:09:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:09:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:09:04 INFO - 'XPC_FLAGS': '0x0', 23:09:04 INFO - 'XPC_SERVICE_NAME': '0', 23:09:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:09:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:09:04 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 23:09:04 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 23:09:04 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 23:09:04 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 23:09:04 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 23:09:04 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 23:09:04 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 23:09:06 INFO - Downloading mozsystemmonitor-0.0.tar.gz 23:09:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 23:09:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:09:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 23:09:06 INFO - Installing collected packages: mozsystemmonitor 23:09:06 INFO - Running setup.py install for mozsystemmonitor 23:09:07 INFO - Successfully installed mozsystemmonitor 23:09:07 INFO - Cleaning up... 23:09:07 INFO - Return code: 0 23:09:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:09:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:09:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:09:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:09:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:09:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x10b8ca490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b8a7228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbcebd7d260>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b7ee9f0>, '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 0x10b54ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b7e18c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JWy3XbC9ts/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.W1eElHHrlW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 23:09:07 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 23:09:07 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 23:09:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JWy3XbC9ts/Render', 23:09:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:09:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:09:07 INFO - 'HOME': '/Users/cltbld', 23:09:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:09:07 INFO - 'LOGNAME': 'cltbld', 23:09:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:09:07 INFO - 'MOZ_NO_REMOTE': '1', 23:09:07 INFO - 'NO_EM_RESTART': '1', 23:09:07 INFO - 'PAGER': '/bin/cat', 23:09:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:09:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:09:07 INFO - 'PWD': '/builds/slave/test', 23:09:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:09:07 INFO - 'SHELL': '/bin/bash', 23:09:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W1eElHHrlW/Listeners', 23:09:07 INFO - 'TMPDIR': '/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/', 23:09:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:09:07 INFO - 'USER': 'cltbld', 23:09:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:09:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:09:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:09:07 INFO - 'XPC_FLAGS': '0x0', 23:09:07 INFO - 'XPC_SERVICE_NAME': '0', 23:09:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:09:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:09:07 INFO - Downloading/unpacking blobuploader==1.2.4 23:09:07 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 23:09:07 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 23:09:07 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 23:09:07 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 23:09:07 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 23:09:07 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 23:09:09 INFO - Downloading blobuploader-1.2.4.tar.gz 23:09:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 23:09:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:09:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:09:09 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 23:09:09 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 23:09:09 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 23:09:09 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 23:09:09 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 23:09:09 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 23:09:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 23:09:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:09:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:09:10 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 23:09:10 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 23:09:10 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 23:09:10 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 23:09:10 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 23:09:10 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 23:09:10 INFO - Downloading docopt-0.6.1.tar.gz 23:09:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 23:09:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:09:10 INFO - Installing collected packages: blobuploader, requests, docopt 23:09:10 INFO - Running setup.py install for blobuploader 23:09:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:09:10 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:09:10 INFO - Running setup.py install for requests 23:09:11 INFO - Running setup.py install for docopt 23:09:11 INFO - Successfully installed blobuploader requests docopt 23:09:11 INFO - Cleaning up... 23:09:11 INFO - Return code: 0 23:09:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:09:11 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')]} 23:09:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:09:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09:11 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')]} 23:09:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:09:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09:11 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 0x10b8ca490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b8a7228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbcebd7d260>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b7ee9f0>, '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 0x10b54ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b7e18c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JWy3XbC9ts/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.W1eElHHrlW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 23:09:11 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 23:09:11 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 23:09:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JWy3XbC9ts/Render', 23:09:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:09:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:09:11 INFO - 'HOME': '/Users/cltbld', 23:09:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:09:11 INFO - 'LOGNAME': 'cltbld', 23:09:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:09:11 INFO - 'MOZ_NO_REMOTE': '1', 23:09:11 INFO - 'NO_EM_RESTART': '1', 23:09:11 INFO - 'PAGER': '/bin/cat', 23:09:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:09:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:09:11 INFO - 'PWD': '/builds/slave/test', 23:09:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:09:11 INFO - 'SHELL': '/bin/bash', 23:09:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W1eElHHrlW/Listeners', 23:09:11 INFO - 'TMPDIR': '/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/', 23:09:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:09:11 INFO - 'USER': 'cltbld', 23:09:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:09:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:09:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:09:11 INFO - 'XPC_FLAGS': '0x0', 23:09:11 INFO - 'XPC_SERVICE_NAME': '0', 23:09:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:09:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:09:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:09:11 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-gLlQqm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:09:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:09:11 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-Sp_Xr3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:09:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:09:12 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-7MK5UW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:09:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:09:12 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-Tb3LCT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:09:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:09:12 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-UwZY2I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:09:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:09:12 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-jvREDO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:09:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:09:12 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-NcVyEL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:09:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:09:12 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-fZUKN7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:09:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:09:12 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-OoIa79-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:09:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:09:12 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-C1faN3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:09:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:09:12 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-swWZnB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:09:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:09:13 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-6NOduG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:09:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:09:13 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-joHrg7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:09:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:09:13 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-U4FvS2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:09:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:09:13 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-Cm_nZm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:09:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:09:13 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-YBgH_D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:09:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:09:13 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-dlpNvY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:09:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:09:13 INFO - Running setup.py install for manifestparser 23:09:13 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:09:13 INFO - Running setup.py install for mozcrash 23:09:13 INFO - Running setup.py install for mozdebug 23:09:14 INFO - Running setup.py install for mozdevice 23:09:14 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:09:14 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:09:14 INFO - Running setup.py install for mozfile 23:09:14 INFO - Running setup.py install for mozhttpd 23:09:14 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:09:14 INFO - Running setup.py install for mozinfo 23:09:14 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:09:14 INFO - Running setup.py install for mozInstall 23:09:14 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:09:14 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:09:14 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:09:14 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:09:14 INFO - Running setup.py install for mozleak 23:09:14 INFO - Running setup.py install for mozlog 23:09:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:09:15 INFO - Running setup.py install for moznetwork 23:09:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:09:15 INFO - Running setup.py install for mozprocess 23:09:15 INFO - Running setup.py install for mozprofile 23:09:15 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:09:15 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:09:15 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:09:15 INFO - Running setup.py install for mozrunner 23:09:15 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:09:15 INFO - Running setup.py install for mozscreenshot 23:09:15 INFO - Running setup.py install for moztest 23:09:16 INFO - Running setup.py install for mozversion 23:09:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:09:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:09:16 INFO - Cleaning up... 23:09:16 INFO - Return code: 0 23:09:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:09:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:09:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:09:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:09:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:09:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x10b8ca490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b8a7228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbcebd7d260>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b7ee9f0>, '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 0x10b54ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b7e18c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JWy3XbC9ts/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.W1eElHHrlW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 23:09:16 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 23:09:16 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 23:09:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JWy3XbC9ts/Render', 23:09:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:09:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:09:16 INFO - 'HOME': '/Users/cltbld', 23:09:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:09:16 INFO - 'LOGNAME': 'cltbld', 23:09:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:09:16 INFO - 'MOZ_NO_REMOTE': '1', 23:09:16 INFO - 'NO_EM_RESTART': '1', 23:09:16 INFO - 'PAGER': '/bin/cat', 23:09:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:09:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:09:16 INFO - 'PWD': '/builds/slave/test', 23:09:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:09:16 INFO - 'SHELL': '/bin/bash', 23:09:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W1eElHHrlW/Listeners', 23:09:16 INFO - 'TMPDIR': '/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/', 23:09:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:09:16 INFO - 'USER': 'cltbld', 23:09:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:09:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:09:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:09:16 INFO - 'XPC_FLAGS': '0x0', 23:09:16 INFO - 'XPC_SERVICE_NAME': '0', 23:09:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:09:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:09:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:09:16 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-C3GzXp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:09:16 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)) 23:09:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:09:16 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-v03X2H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:09:16 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)) 23:09:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:09:16 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-Bmiszy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:09:16 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)) 23:09:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:09:16 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-jXPJFs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:09:16 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)) 23:09:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:09:16 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-fF11bA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:09:16 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)) 23:09:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:09:16 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-5iQaBf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:09:17 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)) 23:09:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:09:17 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-kdGkb3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:09:17 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)) 23:09:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:09:17 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-A97Np4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:09:17 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)) 23:09:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:09:17 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-Y3t8b6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:09:17 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)) 23:09:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:09:17 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-uvcA3X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:09:17 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)) 23:09:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:09:17 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-zVQgk0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:09:17 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)) 23:09:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:09:17 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-XOQRjA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:09:17 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)) 23:09:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:09:17 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-PE3R6i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:09:17 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)) 23:09:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:09:17 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-HLEiFA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:09:17 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)) 23:09:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:09:17 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-oGPBSF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:09:18 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)) 23:09:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:09:18 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-_GblVC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:09:18 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)) 23:09:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:09:18 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-t6q_qH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:09:18 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)) 23:09:18 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)) 23:09:18 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)) 23:09:18 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)) 23:09:18 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)) 23:09:18 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)) 23:09:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:09:18 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 23:09:18 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 23:09:18 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 23:09:18 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 23:09:18 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 23:09:18 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 23:09:20 INFO - Downloading blessings-1.5.1.tar.gz 23:09:20 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 23:09:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:09:20 INFO - Installing collected packages: blessings 23:09:20 INFO - Running setup.py install for blessings 23:09:20 INFO - Successfully installed blessings 23:09:20 INFO - Cleaning up... 23:09:20 INFO - Return code: 0 23:09:20 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:09:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:09:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:09:20 INFO - Reading from file tmpfile_stdout 23:09:20 INFO - Current package versions: 23:09:20 INFO - blessings == 1.5.1 23:09:20 INFO - blobuploader == 1.2.4 23:09:20 INFO - docopt == 0.6.1 23:09:20 INFO - manifestparser == 1.1 23:09:20 INFO - mozInstall == 1.12 23:09:20 INFO - mozcrash == 0.16 23:09:20 INFO - mozdebug == 0.1 23:09:20 INFO - mozdevice == 0.47 23:09:20 INFO - mozfile == 1.2 23:09:20 INFO - mozhttpd == 0.7 23:09:20 INFO - mozinfo == 0.9 23:09:20 INFO - mozleak == 0.1 23:09:20 INFO - mozlog == 3.0 23:09:20 INFO - moznetwork == 0.27 23:09:20 INFO - mozprocess == 0.22 23:09:20 INFO - mozprofile == 0.27 23:09:20 INFO - mozrunner == 6.11 23:09:20 INFO - mozscreenshot == 0.1 23:09:20 INFO - mozsystemmonitor == 0.0 23:09:20 INFO - moztest == 0.7 23:09:20 INFO - mozversion == 1.4 23:09:20 INFO - psutil == 3.1.1 23:09:20 INFO - requests == 1.2.3 23:09:20 INFO - wsgiref == 0.1.2 23:09:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:09:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:09:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:09:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:09:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:09:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x10b8ca490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b8a7228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbcebd7d260>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b7ee9f0>, '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 0x10b54ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b7e18c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JWy3XbC9ts/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.W1eElHHrlW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 23:09:20 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 23:09:20 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 23:09:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JWy3XbC9ts/Render', 23:09:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:09:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:09:20 INFO - 'HOME': '/Users/cltbld', 23:09:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:09:20 INFO - 'LOGNAME': 'cltbld', 23:09:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:09:20 INFO - 'MOZ_NO_REMOTE': '1', 23:09:20 INFO - 'NO_EM_RESTART': '1', 23:09:20 INFO - 'PAGER': '/bin/cat', 23:09:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:09:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:09:20 INFO - 'PWD': '/builds/slave/test', 23:09:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:09:20 INFO - 'SHELL': '/bin/bash', 23:09:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W1eElHHrlW/Listeners', 23:09:20 INFO - 'TMPDIR': '/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/', 23:09:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:09:20 INFO - 'USER': 'cltbld', 23:09:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:09:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:09:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:09:20 INFO - 'XPC_FLAGS': '0x0', 23:09:20 INFO - 'XPC_SERVICE_NAME': '0', 23:09:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:09:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:09:21 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)) 23:09:21 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)) 23:09:21 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)) 23:09:21 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)) 23:09:21 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)) 23:09:21 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)) 23:09:21 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)) 23:09:21 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)) 23:09:21 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)) 23:09:21 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)) 23:09:21 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)) 23:09:21 INFO - Cleaning up... 23:09:21 INFO - Return code: 0 23:09:21 INFO - Running post-action listener: _resource_record_post_action 23:09:21 INFO - Running post-action listener: _start_resource_monitoring 23:09:21 INFO - Starting resource monitoring. 23:09:21 INFO - ##### 23:09:21 INFO - ##### Running install step. 23:09:21 INFO - ##### 23:09:21 INFO - Running pre-action listener: _resource_record_pre_action 23:09:21 INFO - Running main action method: install 23:09:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:09:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:09:21 INFO - Reading from file tmpfile_stdout 23:09:21 INFO - Detecting whether we're running mozinstall >=1.0... 23:09:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:09:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:09:21 INFO - Reading from file tmpfile_stdout 23:09:21 INFO - Output received: 23:09:21 INFO - Usage: mozinstall [options] installer 23:09:21 INFO - Options: 23:09:21 INFO - -h, --help show this help message and exit 23:09:21 INFO - -d DEST, --destination=DEST 23:09:21 INFO - Directory to install application into. [default: 23:09:21 INFO - "/builds/slave/test"] 23:09:21 INFO - --app=APP Application being installed. [default: firefox] 23:09:21 INFO - mkdir: /builds/slave/test/build/application 23:09:21 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'] 23:09:21 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 23:09:52 INFO - Reading from file tmpfile_stdout 23:09:52 INFO - Output received: 23:09:52 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 23:09:52 INFO - Running post-action listener: _resource_record_post_action 23:09:52 INFO - ##### 23:09:52 INFO - ##### Running run-tests step. 23:09:52 INFO - ##### 23:09:52 INFO - Running pre-action listener: _resource_record_pre_action 23:09:52 INFO - Running main action method: run_tests 23:09:52 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 23:09:52 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 23:09:52 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 23:09:52 INFO - 2015-11-19 23:09:52.318 screenresolution[1649:7833] starting screenresolution argv=screenresolution get 23:09:52 INFO - 2015-11-19 23:09:52.321 screenresolution[1649:7833] Display 0: 1600x1200x32@60 23:09:52 INFO - 2015-11-19 23:09:52.327 screenresolution[1650:7836] starting screenresolution argv=screenresolution list 23:09:52 INFO - Available Modes on Display 0 23:09:52 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 23:09:52 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 23:09:52 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 23:09:52 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 23:09:52 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 23:09:52 INFO - Intel Iris: 23:09:52 INFO - Chipset Model: Intel Iris 23:09:52 INFO - Type: GPU 23:09:52 INFO - Bus: Built-In 23:09:52 INFO - VRAM (Dynamic, Max): 1536 MB 23:09:52 INFO - Vendor: Intel (0x8086) 23:09:52 INFO - Device ID: 0x0a2e 23:09:52 INFO - Revision ID: 0x0009 23:09:52 INFO - Displays: 23:09:52 INFO - Display: 23:09:52 INFO - Resolution: 1600 x 1200 @ 60 Hz 23:09:52 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 23:09:52 INFO - Display Serial Number: 1600x1200 60 23:09:52 INFO - Main Display: Yes 23:09:52 INFO - Mirror: Off 23:09:52 INFO - Online: Yes 23:09:52 INFO - Rotation: Supported 23:09:52 INFO - Return code: 0 23:09:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:09:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:09:52 INFO - Python 2.7.3 23:09:52 INFO - Return code: 0 23:09:52 INFO - grabbing minidump binary from tooltool 23:09:52 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')]} 23:09:52 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 0x10b7ee9f0>, '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 0x10b54ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b7e18c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:09:52 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 23:09:52 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 23:09:52 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:09:52 INFO - Return code: 0 23:09:52 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 23:09:52 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:09:52 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:09:52 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 23:09:52 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:09:52 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/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/wBB41CzbQO2t37TsTWPMtw/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0006', '--webServer', 'localhost'] in /builds/slave/test/build 23:09:52 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/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/wBB41CzbQO2t37TsTWPMtw/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0006 --webServer localhost 23:09:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JWy3XbC9ts/Render', 23:09:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:09:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:09:52 INFO - 'HOME': '/Users/cltbld', 23:09:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:09:52 INFO - 'LOGNAME': 'cltbld', 23:09:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:09:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 23:09:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:09:52 INFO - 'MOZ_NO_REMOTE': '1', 23:09:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:09:52 INFO - 'NO_EM_RESTART': '1', 23:09:52 INFO - 'PAGER': '/bin/cat', 23:09:52 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:09:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:09:52 INFO - 'PWD': '/builds/slave/test', 23:09:52 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:09:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:09:52 INFO - 'SHELL': '/bin/bash', 23:09:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W1eElHHrlW/Listeners', 23:09:52 INFO - 'TMPDIR': '/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/', 23:09:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:09:52 INFO - 'USER': 'cltbld', 23:09:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:09:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:09:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:09:52 INFO - 'XPC_FLAGS': '0x0', 23:09:52 INFO - 'XPC_SERVICE_NAME': '0', 23:09:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:09:52 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/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/wBB41CzbQO2t37TsTWPMtw/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0006', '--webServer', 'localhost'] with output_timeout 3600 23:09:52 INFO - mozversion INFO | application_buildid: 20151119205634 23:09:52 INFO - mozversion INFO | application_changeset: 3835b568092ae3b71adc931d24928670ad7141a7 23:09:52 INFO - mozversion INFO | application_display_name: Nightly 23:09:52 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:09:52 INFO - mozversion INFO | application_name: Firefox 23:09:52 INFO - mozversion INFO | application_remotingname: firefox 23:09:52 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 23:09:52 INFO - mozversion INFO | application_vendor: Mozilla 23:09:52 INFO - mozversion INFO | application_version: 45.0a1 23:09:52 INFO - mozversion INFO | platform_buildid: 20151119205634 23:09:52 INFO - mozversion INFO | platform_changeset: 3835b568092ae3b71adc931d24928670ad7141a7 23:09:52 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 23:09:52 INFO - mozversion INFO | platform_version: 45.0a1 23:09:52 INFO - 2015-11-19 23:09:52,874 DEBUG : using testdate: 1448003392 23:09:52 INFO - 2015-11-19 23:09:52,874 DEBUG : actual date: 1448003392 23:09:52 INFO - 2015-11-19 23:09:52,888 INFO : starting webserver on 'localhost:49266' 23:09:52 INFO - 2015-11-19 23:09:52,889 INFO : Starting test suite t-yosemite-r7-0006.e 23:09:52 INFO - 2015-11-19 23:09:52,889 INFO : Starting test dromaeo_css 23:09:52 INFO - 2015-11-19 23:09:52,889 DEBUG : operating with platform_type : mac_ 23:09:52 INFO - 2015-11-19 23:09:52,890 INFO : Initialising browser for dromaeo_css test... 23:09:52 INFO - 2015-11-19 23:09:52,902 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/tmpk7swBu/profile http://localhost:49266/getInfo.html 23:09:55 INFO - 2015-11-19 23:09:55,520 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 23:09:55 INFO - 2015-11-19 23:09:55,520 DEBUG : BROWSER_OUTPUT: colorDepth:24 23:09:55 INFO - 2015-11-19 23:09:55,521 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 23:09:55 INFO - 2015-11-19 23:09:55,521 DEBUG : BROWSER_OUTPUT: __metrics 23:09:56 INFO - 2015-11-19 23:09:56,089 INFO : Browser initialized. 23:09:56 INFO - 2015-11-19 23:09:56,089 INFO : Running cycle 1/1 for dromaeo_css test... 23:09:56 INFO - 2015-11-19 23:09:56,090 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/tmpk7swBu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 23:10:07 INFO - 2015-11-19 23:10:07,940 DEBUG : BROWSER_OUTPUT: RSS: Main: 235786240 23:10:07 INFO - 2015-11-19 23:10:07,940 DEBUG : BROWSER_OUTPUT: 23:10:57 INFO - 2015-11-19 23:10:57,650 DEBUG : BROWSER_OUTPUT: 1448003457649 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] 23:13:08 INFO - 2015-11-19 23:13:08,736 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49266/tests/dromaeo/cssquery-ext.html) 23:13:10 INFO - 2015-11-19 23:13:10,196 DEBUG : BROWSER_OUTPUT: RSS: Main: 253177856 23:13:10 INFO - 2015-11-19 23:13:10,196 DEBUG : BROWSER_OUTPUT: 23:16:12 INFO - 2015-11-19 23:16:12,166 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-ext.html (next: http://localhost:49266/tests/dromaeo/cssquery-jquery.html) 23:16:12 INFO - 2015-11-19 23:16:12,755 DEBUG : BROWSER_OUTPUT: RSS: Main: 262434816 23:16:12 INFO - 2015-11-19 23:16:12,755 DEBUG : BROWSER_OUTPUT: 23:19:14 INFO - 2015-11-19 23:19:14,430 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49266/tests/dromaeo/cssquery-mootools.html) 23:19:15 INFO - 2015-11-19 23:19:15,019 DEBUG : BROWSER_OUTPUT: RSS: Main: 264695808 23:19:15 INFO - 2015-11-19 23:19:15,019 DEBUG : BROWSER_OUTPUT: 23:22:16 INFO - 2015-11-19 23:22:16,596 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49266/tests/dromaeo/cssquery-prototype.html) 23:22:17 INFO - 2015-11-19 23:22:17,187 DEBUG : BROWSER_OUTPUT: RSS: Main: 265265152 23:22:17 INFO - 2015-11-19 23:22:17,187 DEBUG : BROWSER_OUTPUT: 23:25:19 INFO - 2015-11-19 23:25:19,733 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49266/tests/dromaeo/cssquery-yui.html) 23:25:20 INFO - 2015-11-19 23:25:20,321 DEBUG : BROWSER_OUTPUT: RSS: Main: 269918208 23:25:20 INFO - 2015-11-19 23:25:20,321 DEBUG : BROWSER_OUTPUT: 23:28:22 INFO - 2015-11-19 23:28:22,519 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-yui.html (next: http://localhost:49266/tests/dromaeo/cssquery-dojo.html) 23:28:22 INFO - 2015-11-19 23:28:22,777 DEBUG : BROWSER_OUTPUT: RSS: Main: 271757312 23:28:22 INFO - 2015-11-19 23:28:22,777 DEBUG : BROWSER_OUTPUT: 23:28:22 INFO - 2015-11-19 23:28:22,777 DEBUG : BROWSER_OUTPUT: __start_tp_report 23:28:22 INFO - 2015-11-19 23:28:22,777 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 23:28:22 INFO - 2015-11-19 23:28:22,778 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 23:28:22 INFO - 2015-11-19 23:28:22,778 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 23:28:22 INFO - 2015-11-19 23:28:22,778 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2896.6089577906982;3558.661927116923;3577.373959557077;3605.0626837022364;3614.8554057837678;5972.134040564116;6001.009833377488;6005;6015.248093988252;6024.126501657257;4962.131626965284;5767.653940763557;5885.823425297237;5920.644761314325;5942.138389933468;4544.341070544769;5354.41101478837;5355.892882142345;5443.700596467193;5512.6692398456225;5462;5528.308961379827;5555.3611334696425;5560.972195139018;5603.579731520132;5254.290670759437;5307.548858347045;5423.674579525241;5483.232347471338;5540.695261760601;5386.67679939201;5389.137737961907;5403.567714582863;5425.511703946664;5434.103372943459;5362.973185134049;5376.462353764631;5390.00284947286;5401.027814993299;5466.890662186774;5502.9174562381595;5532.474414930575;5689.544836413077;5851.151583020438;5957.791477298274;6287.308396076428;6309.652969086698;6322.336154703736;6336.6198028118;6345.206849143857;6323.74705011799;6333.1766870306565;6336.144620476222;6337.524685648595;6340;5950.375210602868;6039.627950215355;6095.420935011167;6121;6135.570510064342;5360.597955153379;6226.533010024266;6384.553081284265;6504.730758668878;6562.967185164139;6268.905966410507;6294.779682711175;6314.905276420857;6320.778772742932;6339.5562310637815;5191.299174611455;6287.685615719196;6337.904931426032;6378.330275321117;6420.390062944013;6176.135341052256;6323.7786677466065;6323.873522529524;6331.556791024584;6340.809775706644;6274.623522588659;6297.086922396227;6342.904856427157;6346;6359.427651511293;3949.4865667463046;4344.261475549164;4737.620990320766;4895.192293271571;5048.368953880765;3852.4028775539837;4558.293464513005;4569.611583015481;4585.770711464414;4598.838051563341;5424.589606702286;5992;6002.339742628307;6047.546434017467;6054.122152287981;6035.124906888476;6215.906761398583;6291.245050593958;6326.367363263636;6434.131392262078;5969.910451343233;6006.189164462829;6006.9299241293;6069.211002569726;6071.726772295257;4571.862844114682;4855.781489832966;5545.445455454503;5551.555875529948;5557.5831812614215;6215.906761398583;6301.842453938688;6336.809895703136;6407.935920640734;6414.230292364946;6303.275123360872;6351;6360.840978975562;6367.745290188341;6378.52161087911;6260.780872669617;6476.870462590816;6506.967465162644;6518.543701940818;6537.280899101;6157.107219453064;6270.216222972129;6272.466840318624;6315.989441689308;6325.810225693236;6328.683565821782;6364.459020983269;6370.6814659267775;6382.489400848014;6402.87194256103;4773.260144677581;6128.938710612837;6235.314115447388;6291.087792270187;6312.684365781784;6166.722497487534;6300.180976473029;6302.873942521215;6329.461995730415;6334.461570766352;6114.327423983447;6193.1329613855;6206.658633775186;6252.09344645033;6258.968705156445;6108.75564977396;6139.171211886338;6195.132681424694;6241.625502469685;6323.905141422974;5753.9136912945505;5756.683382414008;6206.937930620817;6241.719122639583;6251.249850018027 23:28:22 INFO - 2015-11-19 23:28:22,778 DEBUG : BROWSER_OUTPUT: |1;ext.html;560.4871542538575;564.7684449375754;581.20375086132;581.3054944835801;642.5437939063265;40158.59841401589;40365;40441.59558404415;40487.19025619486;40549.79725101378;34596.48105278423;44583.331250031195;44714;44737.10525789482;44858.551414485846;9683.176929960962;9839.409635421862;9846.1630761385;9858.211343092535;9915.851262231072;9689.515524223796;9741.31810773246;9779.951100244525;9806.754831129207;9819.21446284299;9719.902800972006;9787.119159275664;9802.558884850163;9818.607255709763;9840.458774767385;9737.977512361207;9775.902240977606;9786.951065244699;9811.166050885648;9825.754356141153;9589.472579008152;9713.90286097137;9742.610295588169;9756.90243097567;9770.804583908353;42399.36400953988;42676;42715;42897;43087.56912430867;3130.1861516005774;3143.5913331267016;3304.867805287786;3312.9834350828332;3408.9488657670154;29686.257843553867;29800.956966506285;30036.24909377261;30077.548836767248;30605.69394306073;2769.5014897318474;2841.1476557033016;2858.757005654522;2867.2688464441435;2985.1939976206518;499261;500143.99999999633;500750.99999999633;503565;503650;57737.422625774045;58761.706191468766;72310.63844680742;72842.27157728461;73329;71857.6407117961;72123.6393818038;72197;72303;72976.63511682408;16113.194340282938;16158.919205404132;16159;16197.595060123356;16355.672886542203;12245.265284082983;12251.571195008131;12269.018478521697;12294.569690060805;12329.260244385187;21499.67750483744;21517.354479365644;21620.35138945834;21729.56540869174;21756.782432175474;8268.958655206685;8504.23461888433;8504.574771261412;8510;8536.359773017048;961.1637875048752;983.3706427886159;1000.9949950250348;1069.916409681796;1121.876593574706;30321.24196895095;31117.8444107778;31184.220394489865;31293.530597041063;31602.525962110587;1023.923205759571;1034.6844212515105;1042.4579218806177;1113.0705860606322;1207.06452499312;12094;15202.087874727551;15217.6195595111;15374.385024599114;15503.379864805282;738793.7542810587;745186;753481;756220;756650;60375.69812150999;60629.39370606237;60746.69626651927;60807.69596151991;60964;1441.0705095213739;1473.2633683158635;1475.9040662356913;1484.0872863189277;1611.0253296755295;30667.846660766554;30747.692523074482;30881.845590771904;30969.690303096682;31542.580583874238;43333.78333108441;52471.475285246655;52514.737426314154;52912;53097.20354194613;472620;473936;478058;481770;483342;28936.131916042552;29017.854910725313;29023.41953160967;29289.85355073211;29336.266593334483;45060.54939450695;45664;45990.310145347175;46055.53944460512;46646.30030549612;37726.43410348792;38087.61912380841;38488.80755596204;38599.64901228443;38634.6136538631;37382.813085934395;37794.62205378021;37868.2426351477;38170;38305.425418618186;28867.422651547273;30641.846790765903;37667.81166094152;37865.05337366478;38336.233275333776;31192.532112017885;33331;33387.332253355286;33532.49701254434;33810.32379352448;25212.747872521773;25441.10956116601;25520.10679626204;25657.230283091536;25756.356091097874 23:28:22 INFO - 2015-11-19 23:28:22,778 DEBUG : BROWSER_OUTPUT: |2;jquery.html;324.701274827159;348.68198210763325;356.08308605341267;361.5408431292259;362.1543695471075;15747.685046299095;16902.239399227034;17486.650266994653;19656.312029078985;20113.59772804545;19811.70282445761;19892.005399730027;19971;20358.287459938903;20837.374878753624;5842.795502157425;5960.642361458305;5993.85015374617;5995.700214989255;6022.939770602304;3305.636379998198;4028.536718277406;5650.943490565083;5714.485696287334;5881.441263080022;5821.27234095738;5828.358880523139;5838.41615838417;5875.412458754112;5876.500497457721;5010.273510340999;5844.620099693528;6434.131392262031;6435.195600549931;6476.093346931433;5502.339719233678;5632.662040277596;5652.463016013472;5654.434556544313;5662.320521537401;12773.936130319382;13013.804792928113;13015.47938082485;13102.558718540953;19322.613547729106;1990.6317331293758;2085.4160834966083;2160.0711693971584;2195.3962660268394;2325.6627788970504;10062.24533160016;10075.848862267072;10142.188624910063;10190.59237630494;10210.438425886574;1427.757281262188;1473.9976815765276;1513.553501716985;1805.1042244590622;1846.3168627607736;88372.7673103745;92743;103948.48025759899;104568.47715761448;106312;10980.615678451215;11041.613543526099;11107.94446027781;11122.110231181487;11164.162687798447;11358.318500889973;13187.802182967263;13239.933800330937;13256;13292.534761283308;7235.312645298688;8237.83524329522;8253.174682531819;8341.165883411732;8363.540005299645;8400.369972252105;8438.957805210935;8479.448835825651;8523.105073967268;8547;4284.078923031563;4289.292266775947;4356.956430435718;4361.9127617447475;4383.057642606855;1723.6638855423323;1785.571462848933;1786.88385254958;1815.972760408595;1844.7140693192578;888.9422187557788;898.1916275352105;910.4673765847053;916.8349697054595;973.9610415583439;19224.134913928905;19278.518037048907;19956.50108747264;20942.581148376947;20959.056842442125;909.9899111985691;943.429225318686;970.4225985538593;1020.2807021050141;1044.5978298355187;10742.94628526868;10967.4614319768;11304.604338848101;11825.822612660817;11893.88106118945;715902.4204879047;716914.4154279195;725471;732044;737300;102420.48789756003;122899;123708;125718;127881.36059319644;1222.1506053293053;1235.0736947289354;1240.2806372304042;1246;1271.167385362589;19207.50302460671;19586.118624661638;19608.411747647595;19698.113584889;19948.20207191696;51709.7414512925;52898;53671.19493207683;53706.73146634242;54617.45382546283;74018.62990685012;75542;76170;76292;77213;9675.274354423305;9694;10031.69904902854;10232.64185753495;10270.229732769923;11728.003119734918;15200.315985780446;15884.285207165474;19708.014599270267;20236.392908212776;15326.386944522093;15714.21428928572;15737.68524629524;15950.920245398698;16127.596810079842;15090.320935558146;15309.923450382677;15429.997050191701;15554.61113472127;15753.842461575237;15910.522684319489;16096.034237945762;16344.754828677342;16418.26117824677;16450.177491125156;9618.134367906921;9632.518374081408;9706.951465242628;9798.167155791838;9851.852222216816;10163.44101074448;10229.283950123718;13593;15660.68678626444;16189.838101618832 23:28:22 INFO - 2015-11-19 23:28:22,782 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1324.7946568281914;1493.3727834309595;1837.5957289396329;1899.5251187203196;1931.5364312564984;7165.462590305722;7263.237360077195;8287.585620718963;8663.523506207157;8664.176903194202;8105.554194519299;8244;8317.625706843191;8331;8341.124181960882;2366.301940927422;2403.158894386959;2404.158544509425;2406.9037238510437;2414.6619473273754;2118.5762847430497;2376.964345534818;2415.903363865443;2457.8771061446946;2460.790832779216;2371;2400.303911865557;2409.819263555232;2412.107520217522;2430.368104292888;2204.5921504521716;2227.599032174208;2239.2386588559966;2251.952841928503;2254.323702889135;2382;2432.477017441241;2435.43984883476;2436.1108195508514;2451.2156110044793;8377.95811020947;8464;8474.1102184271;8494.320454363637;8551.358648101355;4551.34005569194;5114.156164232897;5184.896302073975;5237;5244.842654720326;3157.921051973696;3498.825058747078;3518.736094792901;3543.291341731638;3593.7304702147444;1036.3160314192671;1052.9368237905674;1069.8555694981155;1083.3716444462193;1084.143526613974;10883.619073332475;10997.395143267036;11029.779404411867;11038.282511636718;11076.224664273504;4693.48371679115;4738.597219236334;4785.282207668877;4798.49615790344;4802.8799280018275;9669.806603867883;9752.707418777449;9758.804823903482;9787.853182202272;9789.118979291898;5222.2427747976335;5224.791008359699;5236.764345604457;5268.736563171826;5296.232046353257;4758.833440829554;4788.569028787356;4818;4820.855374338706;4844.297576851337;3889.572147063821;3906.5312162540677;3909.276783795007;3911.8851127428547;3918.2163567286657;1269.955551555691;1273.2742336868082;1277.399622177575;1278.0733967873218;1284.5760898903338;1339.6583871112805;1356.1727346318737;1377.800218968244;1389.8610138986223;1397.9301034948414;7862.056553213651;7896.960515197387;7907.644156012993;7930.841383172419;7961.323287520509;504.78546617687334;509.34294759760235;510.72931346386474;512.6232219318798;516.7803683434526;5823.5923485355615;6187.226596675416;6211.720472578745;6214.658193799384;6251.156093927352;9513.429194248367;10208.234382421348;10238.488075596191;10293.588256469808;10334.483275836179;9852.50737463124;10023.298369114238;10091.646792362231;10110.292279540508;10124.392536447836;7862.095858976177;7897.328727058264;7915.564643944638;7978.0825205102155;8028.157043510464;7549;7880.408969327209;7883.369330453435;7909;7984.8802267967185;8971.685990990283;9114.13415725505;9128.178463938277;9141.451512909247;9156;9163.40437871563;9406.482643454401;9421.481818500048;9440.150386465251;9457.905420945977;6195.81412557624;7409.8147546311775;7422.96288518554;7466.36535894455;7492.962535187289;8043.83912321762;8078;8108.108108108221;8121.593920303843;8127.024757029194;6306.46395056407;6745.089412929192;7493.40052795786;7643;7651.846963060596;7501.962490187514;7525.134609519975;7574.128975167706;7639.961800190964;7694.961525192338;7478.401727861649;7665.923340766521;7668.539887606761;7669.118051424158;7697.846043078995;5985.940140598538;6799.252082271045;7022.367986881205;7039.929600704132;7074.115735533059;7002.614856182959;7078.787636370711;7119.82200444993;7128.786136415916;7143.8571228576175 23:28:22 INFO - 2015-11-19 23:28:22,782 DEBUG : BROWSER_OUTPUT: |4;prototype.html;269.81922112184833;311.8440779610195;322.1623778176741;331.12747909259093;331.8357413080527;6839.1451068616425;6884.82787930302;7013.789586312419;7102.538335008234;7124.109486314211;6771.796846094613;6993.125859267591;7014.158301003874;7029.964850175755;7044.8591028179535;4559.680822342438;5131.922296317778;5172.896542069157;5189.662671926331;5207.843764687056;4882.145624515695;5150.871228219287;5161.483851614846;5178.508041736029;5203.765830537635;4948.57937075349;4964.304997300381;4965.925511117336;4972.229304457815;4996.825111121111;4054.635082842529;4970.602351811846;4994.400671919357;4995.475475075119;5024.799008039674;4228.260054490452;4238.3430568261965;4239.894002649928;4247.065645557972;4266.679999000087;6345;6611.471082313404;6614.404703576702;6617.073609694647;6643.6346000969925;5890.499307558863;5913.438223368773;5917.497012753921;5924.200232968537;5937.435943585352;7353.48525603208;7354.705811767523;7381.778546643609;7397.8520429591645;7412.073490813648;3909.4753046311675;4172.8122234499215;4705.670603057787;4706.882327941795;4726.243800991825;6392.785370779537;7307.963460182665;7812.140664526954;7890.289873911318;7908.209179082046;4727.503612120747;4761.9285660726755;4770.045990801784;4774.164521208774;4809.711417314972;4862.05189987949;4874.8781280467565;4879.951200488021;4883.389576302962;4887.731174785421;4909.975450122798;5659.264295641623;5922.970385148046;5924.4667979882015;5955.166276721263;7111.715531378687;7494.288042635941;7498.100227972569;7523.3981281497345;7544.283293087148;1669.4157045034142;1676.7987841459103;1682.7307630779017;1689.7127488327014;1694.9661006779795;1063.1919740996743;1072.4262519552003;1072.6245813965206;1077.498962982217;1083.5557421457165;6090.451859332681;6454.870902582016;6897.758578449831;6900.861982760417;6941.895871561931;6446.129772480655;7465.581539507476;7730.96134519335;7764.767056988299;7776.339011184;6729;6840.384365407038;6864.931350686529;6882.5870447773295;6930.480213983971;4076.9592304076577;4119.0526178979;4132.834686612502;4139.254934111828;4151.086760912594;6960.816661167613;7698.884516732253;8084.191580841986;8122.675092996332;8140.226678465537;7849.215078492105;8083.342914702472;8106;8127.187281271826;8146.470479418819;6817;8073.515589064675;8073.6366863491285;8088.352931765445;8135.227153420534;6521.967390163209;7810.218978102144;7831.412644051605;7833.764987050397;7856.960715196387;7681.807954800951;7697.615119243904;7705.22947705225;7708.03649543807;7725.806854828675;8077.192280771876;8086.838263234585;8091.959540202261;8097.39269554774;8128.983877015373;3955.7626542407547;4682.2040253156365;4753.952460475351;4831.154547954165;4843.176659967884;6275.843103922439;6330;7520.586367749607;7774.689012439665;7803.375729941705;7349.4855360124275;7403.51877127985;7435.367993720378;7468.92531074704;7496.175420703609;6567.408933196035;6989.720411183495;7486.43851711113;7523;7563.886541701769;7097.112860892388;7327;7358.742444014648;7371.557706537625;7403;7481.663325150273;7492.400607951242;7499.812504687427;7501.137369202612;7537.2085930976455;6979.336962988508;7210.206877243394;7302.926970730225;7325.890111648223;7336.669849856876 23:28:22 INFO - 2015-11-19 23:28:22,785 DEBUG : BROWSER_OUTPUT: |5;yui.html;592.8725324055332;722.4509372876612;746.4215233194275;809.5466538738306;809.874469457234;13365.7326853463;13524.729505409887;13622.318884055794;13666.863331366683;13694.726105477885;11763.294202347844;14419.927900360484;14562.635934101652;14568.708625827478;14572.854271457309;754.7094368668047;763.9732609358673;949.2406075139895;953.2278854128143;974.5224839828504;956.4309236004566;963.388248462228;969.2391472693937;972.188222833931;977.2963466304285;1002.2282842211492;1013.8124446977296;1018.4754851251612;1022.166933948833;1025.3079171559204;1001.664442411793;1003.172382784206;1007.9546420411099;1011.5599714124379;1017.4454922067491;747.096013823269;750.1298493747281;751.8233215194425;756.183322012231;759.7302957450136;13895.513657022057;13970.441182352693;14034.578962631036;14042.859571404257;14063.226522541256;12583.874161258362;12744;12870.871291287061;13173.473061077546;13174.736505269937;10028.94985525075;10253.384796912209;10310.484475776257;10631.308964917256;10911.07255883251;3545.3441113393847;3560.038789526813;3574.195805943642;3574.857005719768;3582.7850328980344;78477.43045139065;79695.6015219926;80540.38919221582;80689;80844.59577702133;9689.612415503441;9725.513724313756;9928.35465694742;9992.00079991995;10340.327878687862;21728.34814955554;21822.345329640135;21969;22103.778962210494;22251.332460026224;7404.777856664308;7417.925820741723;7636.50362726421;7679.155292917774;7732.884006739903;4045.8179381927293;4101.569335219819;4165.291900376883;4205.621494065487;4352.412424322739;3355.1108956126645;3355.7650964432255;3373.865045398206;3389.7118744906466;3398.167448975017;608.5709574749791;623.9251289845248;628.0265588338149;636.5766765101156;640.6572483721187;569.6069711898776;581.3575998521658;607.6779306967314;609.2354095610069;625.1903784598956;8382.245597896219;8757.168069033432;8816.250618697355;8845.469986987482;8993.685221017364;523.7957196693293;580.4021857486796;590.4213870407025;594.2304715393576;643.0868167202584;3827.6172382762056;3870.619838424592;3892.065904182976;4147.502299724052;4268.2530557152995;89701.55149224213;89888.10111898927;91194.1761164773;92212.77255296167;92233;89372.5531372339;90083.54958225298;90444.5477772607;90539.09460905439;91189.54405228065;77876.44247115027;78498;78575;79019.41961160745;79133.60433197797;7500.737474188377;7981.24178203093;8350.498970061815;8385.329173666214;8492.320614350961;51847;55150.72424637851;55738;55977.6005599847;57287.42712572821;67208.65582688416;67713;67923.66038169975;75088.62455687686;76216;11731.941340293244;11794.46924888365;11882.584109556125;11974.760504789681;12332.81500777507;12050.698732531757;12259.264444133381;12277.508899644272;12279.815802762787;12317.630471085882;11263.302966828953;11783.941080294544;11810.822837657613;11866.288022718665;12379.319137447526;11471.885281147082;12089.335086570323;12213.389330533615;12465.813012804996;12571.30857802793;11457.255278406878;11669.88330116722;11675.007624351685;12093.637190884288;12330.691732706755;8913.643454261757;9518.714438566854;9684.128428441474;9962.203023758228;10674.412907290174;9489.95255023748;9788.119069283799;10135.64525241613;10396.948015259875;10405.23111071135 23:28:22 INFO - 2015-11-19 23:28:22,785 DEBUG : BROWSER_OUTPUT: __end_tp_report 23:28:22 INFO - 2015-11-19 23:28:22,786 DEBUG : BROWSER_OUTPUT: __start_cc_report 23:28:22 INFO - 2015-11-19 23:28:22,786 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,326 23:28:22 INFO - 2015-11-19 23:28:22,786 DEBUG : BROWSER_OUTPUT: __end_cc_report 23:28:22 INFO - 2015-11-19 23:28:22,786 DEBUG : BROWSER_OUTPUT: __startTimestamp1448004502771__endTimestamp 23:28:22 INFO - 2015-11-19 23:28:22,786 DEBUG : BROWSER_OUTPUT: 23:28:22 INFO - 2015-11-19 23:28:22,786 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 23:28:22 INFO - 2015-11-19 23:28:22,786 DEBUG : BROWSER_OUTPUT: Number of tests: 6 23:28:22 INFO - 2015-11-19 23:28:22,786 DEBUG : BROWSER_OUTPUT: 23:28:22 INFO - 2015-11-19 23:28:22,786 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5840.55 Median:6128.94 stddev:697.35 (11.4%) stddev-sans-first:660.14 23:28:22 INFO - 2015-11-19 23:28:22,787 DEBUG : BROWSER_OUTPUT: Values: 2896.6 3558.7 3577.4 3605.1 3614.9 5972.1 6001.0 6005.0 6015.2 6024.1 4962.1 5767.7 5885.8 5920.6 5942.1 4544.3 5354.4 5355.9 5443.7 5512.7 5462.0 5528.3 5555.4 5561.0 5603.6 5254.3 5307.5 5423.7 5483.2 5540.7 5386.7 5389.1 5403.6 5425.5 5434.1 5363.0 5376.5 5390.0 5401.0 5466.9 5502.9 5532.5 5689.5 5851.2 5957.8 6287.3 6309.7 6322.3 6336.6 6345.2 6323.7 6333.2 6336.1 6337.5 6340.0 5950.4 6039.6 6095.4 6121.0 6135.6 5360.6 6226.5 6384.6 6504.7 6563.0 6268.9 6294.8 6314.9 6320.8 6339.6 5191.3 6287.7 6337.9 6378.3 6420.4 6176.1 6323.8 6323.9 6331.6 6340.8 6274.6 6297.1 6342.9 6346.0 6359.4 3949.5 4344.3 4737.6 4895.2 5048.4 3852.4 4558.3 4569.6 4585.8 4598.8 5424.6 5992.0 6002.3 6047.5 6054.1 6035.1 6215.9 6291.2 6326.4 6434.1 5969.9 6006.2 6006.9 6069.2 6071.7 4571.9 4855.8 5545.4 5551.6 5557.6 6215.9 6301.8 6336.8 6407.9 6414.2 6303.3 6351.0 6360.8 6367.7 6378.5 6260.8 6476.9 6507.0 6518.5 6537.3 6157.1 6270.2 6272.5 6316.0 6325.8 6328.7 6364.5 6370.7 6382.5 6402.9 4773.3 6128.9 6235.3 6291.1 6312.7 6166.7 6300.2 6302.9 6329.5 6334.5 6114.3 6193.1 6206.7 6252.1 6259.0 6108.8 6139.2 6195.1 6241.6 6323.9 5753.9 5756.7 6206.9 6241.7 6251.2 23:28:22 INFO - 2015-11-19 23:28:22,787 DEBUG : BROWSER_OUTPUT: 23:28:22 INFO - 2015-11-19 23:28:22,787 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:71533.83 Median:40403.30 stddev:157940.27 (390.9%) stddev-sans-first:158293.44 23:28:22 INFO - 2015-11-19 23:28:22,788 DEBUG : BROWSER_OUTPUT: Values: 560.5 564.8 581.2 581.3 642.5 40158.6 40365.0 40441.6 40487.2 40549.8 34596.5 44583.3 44714.0 44737.1 44858.6 9683.2 9839.4 9846.2 9858.2 9915.9 9689.5 9741.3 9780.0 9806.8 9819.2 9719.9 9787.1 9802.6 9818.6 9840.5 9738.0 9775.9 9787.0 9811.2 9825.8 9589.5 9713.9 9742.6 9756.9 9770.8 42399.4 42676.0 42715.0 42897.0 43087.6 3130.2 3143.6 3304.9 3313.0 3408.9 29686.3 29801.0 30036.2 30077.5 30605.7 2769.5 2841.1 2858.8 2867.3 2985.2 499261.0 500144.0 500751.0 503565.0 503650.0 57737.4 58761.7 72310.6 72842.3 73329.0 71857.6 72123.6 72197.0 72303.0 72976.6 16113.2 16158.9 16159.0 16197.6 16355.7 12245.3 12251.6 12269.0 12294.6 12329.3 21499.7 21517.4 21620.4 21729.6 21756.8 8269.0 8504.2 8504.6 8510.0 8536.4 961.2 983.4 1001.0 1069.9 1121.9 30321.2 31117.8 31184.2 31293.5 31602.5 1023.9 1034.7 1042.5 1113.1 1207.1 12094.0 15202.1 15217.6 15374.4 15503.4 738793.8 745186.0 753481.0 756220.0 756650.0 60375.7 60629.4 60746.7 60807.7 60964.0 1441.1 1473.3 1475.9 1484.1 1611.0 30667.8 30747.7 30881.8 30969.7 31542.6 43333.8 52471.5 52514.7 52912.0 53097.2 472620.0 473936.0 478058.0 481770.0 483342.0 28936.1 29017.9 29023.4 29289.9 29336.3 45060.5 45664.0 45990.3 46055.5 46646.3 37726.4 38087.6 38488.8 38599.6 38634.6 37382.8 37794.6 37868.2 38170.0 38305.4 28867.4 30641.8 37667.8 37865.1 38336.2 31192.5 33331.0 33387.3 33532.5 33810.3 25212.7 25441.1 25520.1 25657.2 25756.4 23:28:22 INFO - 2015-11-19 23:28:22,788 DEBUG : BROWSER_OUTPUT: 23:28:22 INFO - 2015-11-19 23:28:22,788 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:37975.59 Median:19952.35 stddev:119546.92 (599.2%) stddev-sans-first:119848.85 23:28:22 INFO - 2015-11-19 23:28:22,789 DEBUG : BROWSER_OUTPUT: Values: 324.7 348.7 356.1 361.5 362.2 15747.7 16902.2 17486.7 19656.3 20113.6 19811.7 19892.0 19971.0 20358.3 20837.4 5842.8 5960.6 5993.9 5995.7 6022.9 3305.6 4028.5 5650.9 5714.5 5881.4 5821.3 5828.4 5838.4 5875.4 5876.5 5010.3 5844.6 6434.1 6435.2 6476.1 5502.3 5632.7 5652.5 5654.4 5662.3 12773.9 13013.8 13015.5 13102.6 19322.6 1990.6 2085.4 2160.1 2195.4 2325.7 10062.2 10075.8 10142.2 10190.6 10210.4 1427.8 1474.0 1513.6 1805.1 1846.3 88372.8 92743.0 103948.5 104568.5 106312.0 10980.6 11041.6 11107.9 11122.1 11164.2 11358.3 13187.8 13239.9 13256.0 13292.5 7235.3 8237.8 8253.2 8341.2 8363.5 8400.4 8439.0 8479.4 8523.1 8547.0 4284.1 4289.3 4357.0 4361.9 4383.1 1723.7 1785.6 1786.9 1816.0 1844.7 888.9 898.2 910.5 916.8 974.0 19224.1 19278.5 19956.5 20942.6 20959.1 910.0 943.4 970.4 1020.3 1044.6 10742.9 10967.5 11304.6 11825.8 11893.9 715902.4 716914.4 725471.0 732044.0 737300.0 102420.5 122899.0 123708.0 125718.0 127881.4 1222.2 1235.1 1240.3 1246.0 1271.2 19207.5 19586.1 19608.4 19698.1 19948.2 51709.7 52898.0 53671.2 53706.7 54617.5 74018.6 75542.0 76170.0 76292.0 77213.0 9675.3 9694.0 10031.7 10232.6 10270.2 11728.0 15200.3 15884.3 19708.0 20236.4 15326.4 15714.2 15737.7 15950.9 16127.6 15090.3 15309.9 15430.0 15554.6 15753.8 15910.5 16096.0 16344.8 16418.3 16450.2 9618.1 9632.5 9707.0 9798.2 9851.9 10163.4 10229.3 13593.0 15660.7 16189.8 23:28:22 INFO - 2015-11-19 23:28:22,790 DEBUG : BROWSER_OUTPUT: 23:28:22 INFO - 2015-11-19 23:28:22,790 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5848.48 Median:5256.79 stddev:3047.18 (58.0%) stddev-sans-first:3036.75 23:28:22 INFO - 2015-11-19 23:28:22,791 DEBUG : BROWSER_OUTPUT: Values: 1324.8 1493.4 1837.6 1899.5 1931.5 7165.5 7263.2 8287.6 8663.5 8664.2 8105.6 8244.0 8317.6 8331.0 8341.1 2366.3 2403.2 2404.2 2406.9 2414.7 2118.6 2377.0 2415.9 2457.9 2460.8 2371.0 2400.3 2409.8 2412.1 2430.4 2204.6 2227.6 2239.2 2252.0 2254.3 2382.0 2432.5 2435.4 2436.1 2451.2 8378.0 8464.0 8474.1 8494.3 8551.4 4551.3 5114.2 5184.9 5237.0 5244.8 3157.9 3498.8 3518.7 3543.3 3593.7 1036.3 1052.9 1069.9 1083.4 1084.1 10883.6 10997.4 11029.8 11038.3 11076.2 4693.5 4738.6 4785.3 4798.5 4802.9 9669.8 9752.7 9758.8 9787.9 9789.1 5222.2 5224.8 5236.8 5268.7 5296.2 4758.8 4788.6 4818.0 4820.9 4844.3 3889.6 3906.5 3909.3 3911.9 3918.2 1270.0 1273.3 1277.4 1278.1 1284.6 1339.7 1356.2 1377.8 1389.9 1397.9 7862.1 7897.0 7907.6 7930.8 7961.3 504.8 509.3 510.7 512.6 516.8 5823.6 6187.2 6211.7 6214.7 6251.2 9513.4 10208.2 10238.5 10293.6 10334.5 9852.5 10023.3 10091.6 10110.3 10124.4 7862.1 7897.3 7915.6 7978.1 8028.2 7549.0 7880.4 7883.4 7909.0 7984.9 8971.7 9114.1 9128.2 9141.5 9156.0 9163.4 9406.5 9421.5 9440.2 9457.9 6195.8 7409.8 7423.0 7466.4 7493.0 8043.8 8078.0 8108.1 8121.6 8127.0 6306.5 6745.1 7493.4 7643.0 7651.8 7502.0 7525.1 7574.1 7640.0 7695.0 7478.4 7665.9 7668.5 7669.1 7697.8 5985.9 6799.3 7022.4 7039.9 7074.1 7002.6 7078.8 7119.8 7128.8 7143.9 23:28:22 INFO - 2015-11-19 23:28:22,791 DEBUG : BROWSER_OUTPUT: 23:28:22 INFO - 2015-11-19 23:28:22,791 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:6009.52 Median:6828.07 stddev:1967.49 (28.8%) stddev-sans-first:1925.26 23:28:22 INFO - 2015-11-19 23:28:22,793 DEBUG : BROWSER_OUTPUT: Values: 269.8 311.8 322.2 331.1 331.8 6839.1 6884.8 7013.8 7102.5 7124.1 6771.8 6993.1 7014.2 7030.0 7044.9 4559.7 5131.9 5172.9 5189.7 5207.8 4882.1 5150.9 5161.5 5178.5 5203.8 4948.6 4964.3 4965.9 4972.2 4996.8 4054.6 4970.6 4994.4 4995.5 5024.8 4228.3 4238.3 4239.9 4247.1 4266.7 6345.0 6611.5 6614.4 6617.1 6643.6 5890.5 5913.4 5917.5 5924.2 5937.4 7353.5 7354.7 7381.8 7397.9 7412.1 3909.5 4172.8 4705.7 4706.9 4726.2 6392.8 7308.0 7812.1 7890.3 7908.2 4727.5 4761.9 4770.0 4774.2 4809.7 4862.1 4874.9 4880.0 4883.4 4887.7 4910.0 5659.3 5923.0 5924.5 5955.2 7111.7 7494.3 7498.1 7523.4 7544.3 1669.4 1676.8 1682.7 1689.7 1695.0 1063.2 1072.4 1072.6 1077.5 1083.6 6090.5 6454.9 6897.8 6900.9 6941.9 6446.1 7465.6 7731.0 7764.8 7776.3 6729.0 6840.4 6864.9 6882.6 6930.5 4077.0 4119.1 4132.8 4139.3 4151.1 6960.8 7698.9 8084.2 8122.7 8140.2 7849.2 8083.3 8106.0 8127.2 8146.5 6817.0 8073.5 8073.6 8088.4 8135.2 6522.0 7810.2 7831.4 7833.8 7857.0 7681.8 7697.6 7705.2 7708.0 7725.8 8077.2 8086.8 8092.0 8097.4 8129.0 3955.8 4682.2 4754.0 4831.2 4843.2 6275.8 6330.0 7520.6 7774.7 7803.4 7349.5 7403.5 7435.4 7468.9 7496.2 6567.4 6989.7 7486.4 7523.0 7563.9 7097.1 7327.0 7358.7 7371.6 7403.0 7481.7 7492.4 7499.8 7501.1 7537.2 6979.3 7210.2 7302.9 7325.9 7336.7 23:28:22 INFO - 2015-11-19 23:28:22,793 DEBUG : BROWSER_OUTPUT: 23:28:22 INFO - 2015-11-19 23:28:22,793 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:19151.12 Median:26185.40 stddev:27224.79 (104.0%) stddev-sans-first:27265.50 23:28:22 INFO - 2015-11-19 23:28:22,794 DEBUG : BROWSER_OUTPUT: Values: 592.9 722.5 746.4 809.5 809.9 13365.7 13524.7 13622.3 13666.9 13694.7 11763.3 14419.9 14562.6 14568.7 14572.9 754.7 764.0 949.2 953.2 974.5 956.4 963.4 969.2 972.2 977.3 1002.2 1013.8 1018.5 1022.2 1025.3 1001.7 1003.2 1008.0 1011.6 1017.4 747.1 750.1 751.8 756.2 759.7 13895.5 13970.4 14034.6 14042.9 14063.2 12583.9 12744.0 12870.9 13173.5 13174.7 10028.9 10253.4 10310.5 10631.3 10911.1 3545.3 3560.0 3574.2 3574.9 3582.8 78477.4 79695.6 80540.4 80689.0 80844.6 9689.6 9725.5 9928.4 9992.0 10340.3 21728.3 21822.3 21969.0 22103.8 22251.3 7404.8 7417.9 7636.5 7679.2 7732.9 4045.8 4101.6 4165.3 4205.6 4352.4 3355.1 3355.8 3373.9 3389.7 3398.2 608.6 623.9 628.0 636.6 640.7 569.6 581.4 607.7 609.2 625.2 8382.2 8757.2 8816.3 8845.5 8993.7 523.8 580.4 590.4 594.2 643.1 3827.6 3870.6 3892.1 4147.5 4268.3 89701.6 89888.1 91194.2 92212.8 92233.0 89372.6 90083.5 90444.5 90539.1 91189.5 77876.4 78498.0 78575.0 79019.4 79133.6 7500.7 7981.2 8350.5 8385.3 8492.3 51847.0 55150.7 55738.0 55977.6 57287.4 67208.7 67713.0 67923.7 75088.6 76216.0 11731.9 11794.5 11882.6 11974.8 12332.8 12050.7 12259.3 12277.5 12279.8 12317.6 11263.3 11783.9 11810.8 11866.3 12379.3 11471.9 12089.3 12213.4 12465.8 12571.3 11457.3 11669.9 11675.0 12093.6 12330.7 8913.6 9518.7 9684.1 9962.2 10674.4 9490.0 9788.1 10135.6 10396.9 10405.2 23:28:22 INFO - 2015-11-19 23:28:22,794 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 23:28:22 INFO - 2015-11-19 23:28:22,794 DEBUG : BROWSER_OUTPUT: 23:28:23 INFO - 2015-11-19 23:28:23,281 INFO : Browser exited with error code: 0 23:28:23 INFO - 2015-11-19 23:28:23,305 INFO : Completed test dromaeo_css (00:18:30) 23:28:23 INFO - 2015-11-19 23:28:23,305 INFO : Starting test kraken 23:28:23 INFO - 2015-11-19 23:28:23,305 DEBUG : operating with platform_type : mac_ 23:28:23 INFO - 2015-11-19 23:28:23,306 INFO : Initialising browser for kraken test... 23:28:23 INFO - 2015-11-19 23:28:23,318 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/tmp5FqW5r/profile http://localhost:49266/getInfo.html 23:28:26 INFO - 2015-11-19 23:28:26,155 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 23:28:26 INFO - 2015-11-19 23:28:26,155 DEBUG : BROWSER_OUTPUT: colorDepth:24 23:28:26 INFO - 2015-11-19 23:28:26,155 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 23:28:26 INFO - 2015-11-19 23:28:26,156 DEBUG : BROWSER_OUTPUT: __metrics 23:28:26 INFO - 2015-11-19 23:28:26,748 INFO : Browser initialized. 23:28:26 INFO - 2015-11-19 23:28:26,748 INFO : Running cycle 1/1 for kraken test... 23:28:26 INFO - 2015-11-19 23:28:26,749 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/tmp5FqW5r/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 23:28:38 INFO - 2015-11-19 23:28:38,771 DEBUG : BROWSER_OUTPUT: RSS: Main: 236896256 23:28:38 INFO - 2015-11-19 23:28:38,772 DEBUG : BROWSER_OUTPUT: 23:28:41 INFO - 2015-11-19 23:28:41,459 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-beat-detection) 23:28:42 INFO - 2015-11-19 23:28:42,070 DEBUG : BROWSER_OUTPUT: RSS: Main: 248778752 23:28:42 INFO - 2015-11-19 23:28:42,070 DEBUG : BROWSER_OUTPUT: 23:28:44 INFO - 2015-11-19 23:28:44,688 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-dft) 23:28:45 INFO - 2015-11-19 23:28:45,292 DEBUG : BROWSER_OUTPUT: RSS: Main: 258478080 23:28:45 INFO - 2015-11-19 23:28:45,292 DEBUG : BROWSER_OUTPUT: 23:28:48 INFO - 2015-11-19 23:28:48,688 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-fft) 23:28:49 INFO - 2015-11-19 23:28:49,267 DEBUG : BROWSER_OUTPUT: RSS: Main: 260784128 23:28:49 INFO - 2015-11-19 23:28:49,267 DEBUG : BROWSER_OUTPUT: 23:28:51 INFO - 2015-11-19 23:28:51,330 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-oscillator) 23:28:51 INFO - 2015-11-19 23:28:51,928 DEBUG : BROWSER_OUTPUT: RSS: Main: 264134656 23:28:51 INFO - 2015-11-19 23:28:51,929 DEBUG : BROWSER_OUTPUT: 23:28:53 INFO - 2015-11-19 23:28:53,960 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:28:54 INFO - 2015-11-19 23:28:54,539 DEBUG : BROWSER_OUTPUT: RSS: Main: 263950336 23:28:54 INFO - 2015-11-19 23:28:54,539 DEBUG : BROWSER_OUTPUT: 23:28:57 INFO - 2015-11-19 23:28:57,208 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-darkroom) 23:28:57 INFO - 2015-11-19 23:28:57,799 DEBUG : BROWSER_OUTPUT: RSS: Main: 263188480 23:28:57 INFO - 2015-11-19 23:28:57,799 DEBUG : BROWSER_OUTPUT: 23:29:00 INFO - 2015-11-19 23:29:00,926 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-desaturate) 23:29:01 INFO - 2015-11-19 23:29:01,511 DEBUG : BROWSER_OUTPUT: RSS: Main: 263041024 23:29:01 INFO - 2015-11-19 23:29:01,512 DEBUG : BROWSER_OUTPUT: 23:29:04 INFO - 2015-11-19 23:29:04,560 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49266/tests/kraken/driver.html?testName=json-parse-financial) 23:29:05 INFO - 2015-11-19 23:29:05,164 DEBUG : BROWSER_OUTPUT: RSS: Main: 263254016 23:29:05 INFO - 2015-11-19 23:29:05,164 DEBUG : BROWSER_OUTPUT: 23:29:06 INFO - 2015-11-19 23:29:06,808 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49266/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:29:07 INFO - 2015-11-19 23:29:07,396 DEBUG : BROWSER_OUTPUT: RSS: Main: 264040448 23:29:07 INFO - 2015-11-19 23:29:07,396 DEBUG : BROWSER_OUTPUT: 23:29:09 INFO - 2015-11-19 23:29:09,356 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:29:09 INFO - 2015-11-19 23:29:09,985 DEBUG : BROWSER_OUTPUT: RSS: Main: 264630272 23:29:09 INFO - 2015-11-19 23:29:09,986 DEBUG : BROWSER_OUTPUT: 23:29:12 INFO - 2015-11-19 23:29:12,225 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:29:12 INFO - 2015-11-19 23:29:12,832 DEBUG : BROWSER_OUTPUT: RSS: Main: 264589312 23:29:12 INFO - 2015-11-19 23:29:12,832 DEBUG : BROWSER_OUTPUT: 23:29:15 INFO - 2015-11-19 23:29:15,420 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:29:16 INFO - 2015-11-19 23:29:16,025 DEBUG : BROWSER_OUTPUT: RSS: Main: 264065024 23:29:16 INFO - 2015-11-19 23:29:16,026 DEBUG : BROWSER_OUTPUT: 23:29:18 INFO - 2015-11-19 23:29:18,504 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:29:19 INFO - 2015-11-19 23:29:19,110 DEBUG : BROWSER_OUTPUT: RSS: Main: 264028160 23:29:19 INFO - 2015-11-19 23:29:19,111 DEBUG : BROWSER_OUTPUT: 23:29:20 INFO - 2015-11-19 23:29:20,917 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49266/tests/kraken/driver.html?testName=ai-astar) 23:29:21 INFO - 2015-11-19 23:29:21,175 DEBUG : BROWSER_OUTPUT: RSS: Main: 263643136 23:29:21 INFO - 2015-11-19 23:29:21,175 DEBUG : BROWSER_OUTPUT: 23:29:21 INFO - 2015-11-19 23:29:21,175 DEBUG : BROWSER_OUTPUT: __start_tp_report 23:29:21 INFO - 2015-11-19 23:29:21,175 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 23:29:21 INFO - 2015-11-19 23:29:21,175 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 23:29:21 INFO - 2015-11-19 23:29:21,175 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 23:29:21 INFO - 2015-11-19 23:29:21,176 DEBUG : BROWSER_OUTPUT: |0;ai-astar;123;150;169;115;117;125;114;114;114;115 23:29:21 INFO - 2015-11-19 23:29:21,176 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;164;150;145;162;121;137;140;122;153;124 23:29:21 INFO - 2015-11-19 23:29:21,176 DEBUG : BROWSER_OUTPUT: |2;audio-dft;222;263;197;205;210;205;226;262;204;199 23:29:21 INFO - 2015-11-19 23:29:21,176 DEBUG : BROWSER_OUTPUT: |3;audio-fft;64;73;100;146;69;79;85;86;130;57 23:29:21 INFO - 2015-11-19 23:29:21,176 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;81;106;145;79;78;78;107;78;76;110 23:29:21 INFO - 2015-11-19 23:29:21,176 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;88;89;88;88;89;89;89;89;88;89 23:29:21 INFO - 2015-11-19 23:29:21,176 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;98;105;104;142;149;103;150;149;97;96 23:29:21 INFO - 2015-11-19 23:29:21,176 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;147;152;90;90;99;90;101;142;79;153 23:29:21 INFO - 2015-11-19 23:29:21,176 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;60;59;59;59;63;79;74;91;83;77 23:29:21 INFO - 2015-11-19 23:29:21,176 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;75;98;99;99;70;69;84;70;76 23:29:21 INFO - 2015-11-19 23:29:21,176 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;76;89;110;79;98;99;125;112;108;82 23:29:21 INFO - 2015-11-19 23:29:21,176 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;120;125;136;149;130;131;127;114;136;114 23:29:21 INFO - 2015-11-19 23:29:21,176 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;129;144;185;138;142;129;140;140;149;137 23:29:21 INFO - 2015-11-19 23:29:21,176 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;68;90;89;59;74;96;95;97;84;70 23:29:21 INFO - 2015-11-19 23:29:21,177 DEBUG : BROWSER_OUTPUT: __end_tp_report 23:29:21 INFO - 2015-11-19 23:29:21,177 DEBUG : BROWSER_OUTPUT: __start_cc_report 23:29:21 INFO - 2015-11-19 23:29:21,177 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,811 23:29:21 INFO - 2015-11-19 23:29:21,177 DEBUG : BROWSER_OUTPUT: __end_cc_report 23:29:21 INFO - 2015-11-19 23:29:21,177 DEBUG : BROWSER_OUTPUT: __startTimestamp1448004561172__endTimestamp 23:29:21 INFO - 2015-11-19 23:29:21,177 DEBUG : BROWSER_OUTPUT: 23:29:21 INFO - 2015-11-19 23:29:21,178 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 23:29:21 INFO - 2015-11-19 23:29:21,178 DEBUG : BROWSER_OUTPUT: Number of tests: 14 23:29:21 INFO - 2015-11-19 23:29:21,178 DEBUG : BROWSER_OUTPUT: 23:29:21 INFO - 2015-11-19 23:29:21,178 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:125.60 Median:120.00 stddev:18.82 (15.7%) stddev-sans-first:19.94 23:29:21 INFO - 2015-11-19 23:29:21,179 DEBUG : BROWSER_OUTPUT: Values: 123.0 150.0 169.0 115.0 117.0 125.0 114.0 114.0 114.0 115.0 23:29:21 INFO - 2015-11-19 23:29:21,179 DEBUG : BROWSER_OUTPUT: 23:29:21 INFO - 2015-11-19 23:29:21,179 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:141.80 Median:147.50 stddev:15.89 (10.8%) stddev-sans-first:14.68 23:29:21 INFO - 2015-11-19 23:29:21,179 DEBUG : BROWSER_OUTPUT: Values: 164.0 150.0 145.0 162.0 121.0 137.0 140.0 122.0 153.0 124.0 23:29:21 INFO - 2015-11-19 23:29:21,179 DEBUG : BROWSER_OUTPUT: 23:29:21 INFO - 2015-11-19 23:29:21,179 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:219.30 Median:216.00 stddev:24.55 (11.4%) stddev-sans-first:26.02 23:29:21 INFO - 2015-11-19 23:29:21,179 DEBUG : BROWSER_OUTPUT: Values: 222.0 263.0 197.0 205.0 210.0 205.0 226.0 262.0 204.0 199.0 23:29:21 INFO - 2015-11-19 23:29:21,179 DEBUG : BROWSER_OUTPUT: 23:29:21 INFO - 2015-11-19 23:29:21,179 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:88.90 Median:71.00 stddev:28.83 (40.6%) stddev-sans-first:29.14 23:29:21 INFO - 2015-11-19 23:29:21,179 DEBUG : BROWSER_OUTPUT: Values: 64.0 73.0 100.0 146.0 69.0 79.0 85.0 86.0 130.0 57.0 23:29:21 INFO - 2015-11-19 23:29:21,179 DEBUG : BROWSER_OUTPUT: 23:29:21 INFO - 2015-11-19 23:29:21,179 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:93.80 Median:78.00 stddev:22.74 (29.2%) stddev-sans-first:23.65 23:29:21 INFO - 2015-11-19 23:29:21,180 DEBUG : BROWSER_OUTPUT: Values: 81.0 106.0 145.0 79.0 78.0 78.0 107.0 78.0 76.0 110.0 23:29:21 INFO - 2015-11-19 23:29:21,180 DEBUG : BROWSER_OUTPUT: 23:29:21 INFO - 2015-11-19 23:29:21,180 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:88.60 Median:89.00 stddev:0.52 (0.6%) stddev-sans-first:0.50 23:29:21 INFO - 2015-11-19 23:29:21,180 DEBUG : BROWSER_OUTPUT: Values: 88.0 89.0 88.0 88.0 89.0 89.0 89.0 89.0 88.0 89.0 23:29:21 INFO - 2015-11-19 23:29:21,180 DEBUG : BROWSER_OUTPUT: 23:29:21 INFO - 2015-11-19 23:29:21,180 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:119.30 Median:149.50 stddev:24.54 (16.4%) stddev-sans-first:24.79 23:29:21 INFO - 2015-11-19 23:29:21,180 DEBUG : BROWSER_OUTPUT: Values: 98.0 105.0 104.0 142.0 149.0 103.0 150.0 149.0 97.0 96.0 23:29:21 INFO - 2015-11-19 23:29:21,180 DEBUG : BROWSER_OUTPUT: 23:29:21 INFO - 2015-11-19 23:29:21,181 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:114.30 Median:84.50 stddev:30.16 (35.7%) stddev-sans-first:29.57 23:29:21 INFO - 2015-11-19 23:29:21,181 DEBUG : BROWSER_OUTPUT: Values: 147.0 152.0 90.0 90.0 99.0 90.0 101.0 142.0 79.0 153.0 23:29:21 INFO - 2015-11-19 23:29:21,181 DEBUG : BROWSER_OUTPUT: 23:29:21 INFO - 2015-11-19 23:29:21,181 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:70.40 Median:75.50 stddev:11.86 (15.7%) stddev-sans-first:11.97 23:29:21 INFO - 2015-11-19 23:29:21,181 DEBUG : BROWSER_OUTPUT: Values: 60.0 59.0 59.0 59.0 63.0 79.0 74.0 91.0 83.0 77.0 23:29:21 INFO - 2015-11-19 23:29:21,181 DEBUG : BROWSER_OUTPUT: 23:29:21 INFO - 2015-11-19 23:29:21,181 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:80.90 Median:80.00 stddev:13.07 (16.3%) stddev-sans-first:13.13 23:29:21 INFO - 2015-11-19 23:29:21,182 DEBUG : BROWSER_OUTPUT: Values: 69.0 75.0 98.0 99.0 99.0 70.0 69.0 84.0 70.0 76.0 23:29:21 INFO - 2015-11-19 23:29:21,182 DEBUG : BROWSER_OUTPUT: 23:29:21 INFO - 2015-11-19 23:29:21,182 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:97.80 Median:80.50 stddev:16.16 (20.1%) stddev-sans-first:15.10 23:29:21 INFO - 2015-11-19 23:29:21,183 DEBUG : BROWSER_OUTPUT: Values: 76.0 89.0 110.0 79.0 98.0 99.0 125.0 112.0 108.0 82.0 23:29:21 INFO - 2015-11-19 23:29:21,183 DEBUG : BROWSER_OUTPUT: 23:29:21 INFO - 2015-11-19 23:29:21,183 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:128.20 Median:130.50 stddev:10.79 (8.3%) stddev-sans-first:11.03 23:29:21 INFO - 2015-11-19 23:29:21,183 DEBUG : BROWSER_OUTPUT: Values: 120.0 125.0 136.0 149.0 130.0 131.0 127.0 114.0 136.0 114.0 23:29:21 INFO - 2015-11-19 23:29:21,183 DEBUG : BROWSER_OUTPUT: 23:29:21 INFO - 2015-11-19 23:29:21,183 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.30 Median:141.00 stddev:15.89 (11.3%) stddev-sans-first:15.99 23:29:21 INFO - 2015-11-19 23:29:21,183 DEBUG : BROWSER_OUTPUT: Values: 129.0 144.0 185.0 138.0 142.0 129.0 140.0 140.0 149.0 137.0 23:29:21 INFO - 2015-11-19 23:29:21,183 DEBUG : BROWSER_OUTPUT: 23:29:21 INFO - 2015-11-19 23:29:21,183 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:82.20 Median:89.50 stddev:13.50 (15.1%) stddev-sans-first:13.30 23:29:21 INFO - 2015-11-19 23:29:21,183 DEBUG : BROWSER_OUTPUT: Values: 68.0 90.0 89.0 59.0 74.0 96.0 95.0 97.0 84.0 70.0 23:29:21 INFO - 2015-11-19 23:29:21,183 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 23:29:21 INFO - 2015-11-19 23:29:21,183 DEBUG : BROWSER_OUTPUT: 23:29:21 INFO - 2015-11-19 23:29:21,774 INFO : Browser exited with error code: 0 23:29:21 INFO - 2015-11-19 23:29:21,818 INFO : Completed test kraken (00:00:58) 23:29:21 INFO - 2015-11-19 23:29:21,818 INFO : Starting test v8_7 23:29:21 INFO - 2015-11-19 23:29:21,818 DEBUG : operating with platform_type : mac_ 23:29:21 INFO - 2015-11-19 23:29:21,819 INFO : Initialising browser for v8_7 test... 23:29:21 INFO - 2015-11-19 23:29:21,830 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/tmpT2M16L/profile http://localhost:49266/getInfo.html 23:29:24 INFO - 2015-11-19 23:29:24,624 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 23:29:24 INFO - 2015-11-19 23:29:24,625 DEBUG : BROWSER_OUTPUT: colorDepth:24 23:29:24 INFO - 2015-11-19 23:29:24,625 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 23:29:24 INFO - 2015-11-19 23:29:24,625 DEBUG : BROWSER_OUTPUT: __metrics 23:29:25 INFO - 2015-11-19 23:29:25,279 INFO : Browser initialized. 23:29:25 INFO - 2015-11-19 23:29:25,280 INFO : Running cycle 1/1 for v8_7 test... 23:29:25 INFO - 2015-11-19 23:29:25,280 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/tmpT2M16L/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 23:29:37 INFO - 2015-11-19 23:29:37,255 DEBUG : BROWSER_OUTPUT: RSS: Main: 236892160 23:29:37 INFO - 2015-11-19 23:29:37,255 DEBUG : BROWSER_OUTPUT: 23:29:58 INFO - 2015-11-19 23:29:58,651 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/v8_7/run.html (next: http://localhost:49266/tests/v8_7/run.html) 23:29:58 INFO - 2015-11-19 23:29:58,901 DEBUG : BROWSER_OUTPUT: RSS: Main: 247443456 23:29:58 INFO - 2015-11-19 23:29:58,901 DEBUG : BROWSER_OUTPUT: 23:29:58 INFO - 2015-11-19 23:29:58,901 DEBUG : BROWSER_OUTPUT: __start_tp_report 23:29:58 INFO - 2015-11-19 23:29:58,901 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 23:29:58 INFO - 2015-11-19 23:29:58,901 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 23:29:58 INFO - 2015-11-19 23:29:58,901 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 23:29:58 INFO - 2015-11-19 23:29:58,901 DEBUG : BROWSER_OUTPUT: |0;Richards;147.90711433219937 23:29:58 INFO - 2015-11-19 23:29:58,901 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;184.74043968224643 23:29:58 INFO - 2015-11-19 23:29:58,902 DEBUG : BROWSER_OUTPUT: |2;Encrypt;284.57598178713715 23:29:58 INFO - 2015-11-19 23:29:58,902 DEBUG : BROWSER_OUTPUT: |3;Decrypt;4935.9605911330045 23:29:58 INFO - 2015-11-19 23:29:58,902 DEBUG : BROWSER_OUTPUT: |4;RayTrace;959.6928982725528 23:29:58 INFO - 2015-11-19 23:29:58,902 DEBUG : BROWSER_OUTPUT: |5;Earley;759.8784194528876 23:29:58 INFO - 2015-11-19 23:29:58,902 DEBUG : BROWSER_OUTPUT: |6;Boyer;12662.5 23:29:58 INFO - 2015-11-19 23:29:58,902 DEBUG : BROWSER_OUTPUT: |7;RegExp;28138.88888888889 23:29:58 INFO - 2015-11-19 23:29:58,902 DEBUG : BROWSER_OUTPUT: |8;Splay;649.772579597141 23:29:58 INFO - 2015-11-19 23:29:58,902 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4584.474885844749 23:29:58 INFO - 2015-11-19 23:29:58,902 DEBUG : BROWSER_OUTPUT: __end_tp_report 23:29:58 INFO - 2015-11-19 23:29:58,902 DEBUG : BROWSER_OUTPUT: __startTimestamp1448004598898__endTimestamp 23:29:58 INFO - 2015-11-19 23:29:58,902 DEBUG : BROWSER_OUTPUT: 23:29:58 INFO - 2015-11-19 23:29:58,902 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 23:29:58 INFO - 2015-11-19 23:29:58,903 DEBUG : BROWSER_OUTPUT: Number of tests: 10 23:29:58 INFO - 2015-11-19 23:29:58,903 DEBUG : BROWSER_OUTPUT: 23:29:58 INFO - 2015-11-19 23:29:58,903 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:147.91 Median:147.91 stddev:0.00 (0.0%) 23:29:58 INFO - 2015-11-19 23:29:58,903 DEBUG : BROWSER_OUTPUT: Values: 147.9 23:29:58 INFO - 2015-11-19 23:29:58,903 DEBUG : BROWSER_OUTPUT: 23:29:58 INFO - 2015-11-19 23:29:58,903 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:184.74 Median:184.74 stddev:0.00 (0.0%) 23:29:58 INFO - 2015-11-19 23:29:58,903 DEBUG : BROWSER_OUTPUT: Values: 184.7 23:29:58 INFO - 2015-11-19 23:29:58,903 DEBUG : BROWSER_OUTPUT: 23:29:58 INFO - 2015-11-19 23:29:58,903 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:284.58 Median:284.58 stddev:0.00 (0.0%) 23:29:58 INFO - 2015-11-19 23:29:58,903 DEBUG : BROWSER_OUTPUT: Values: 284.6 23:29:58 INFO - 2015-11-19 23:29:58,903 DEBUG : BROWSER_OUTPUT: 23:29:58 INFO - 2015-11-19 23:29:58,903 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:4935.96 Median:4935.96 stddev:0.00 (0.0%) 23:29:58 INFO - 2015-11-19 23:29:58,903 DEBUG : BROWSER_OUTPUT: Values: 4936.0 23:29:58 INFO - 2015-11-19 23:29:58,904 DEBUG : BROWSER_OUTPUT: 23:29:58 INFO - 2015-11-19 23:29:58,904 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:959.69 Median:959.69 stddev:0.00 (0.0%) 23:29:58 INFO - 2015-11-19 23:29:58,904 DEBUG : BROWSER_OUTPUT: Values: 959.7 23:29:58 INFO - 2015-11-19 23:29:58,904 DEBUG : BROWSER_OUTPUT: 23:29:58 INFO - 2015-11-19 23:29:58,904 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:759.88 Median:759.88 stddev:0.00 (0.0%) 23:29:58 INFO - 2015-11-19 23:29:58,904 DEBUG : BROWSER_OUTPUT: Values: 759.9 23:29:58 INFO - 2015-11-19 23:29:58,904 DEBUG : BROWSER_OUTPUT: 23:29:58 INFO - 2015-11-19 23:29:58,904 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12662.50 Median:12662.50 stddev:0.00 (0.0%) 23:29:58 INFO - 2015-11-19 23:29:58,904 DEBUG : BROWSER_OUTPUT: Values: 12662.5 23:29:58 INFO - 2015-11-19 23:29:58,904 DEBUG : BROWSER_OUTPUT: 23:29:58 INFO - 2015-11-19 23:29:58,904 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:28138.89 Median:28138.89 stddev:0.00 (0.0%) 23:29:58 INFO - 2015-11-19 23:29:58,904 DEBUG : BROWSER_OUTPUT: Values: 28138.9 23:29:58 INFO - 2015-11-19 23:29:58,905 DEBUG : BROWSER_OUTPUT: 23:29:58 INFO - 2015-11-19 23:29:58,905 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:649.77 Median:649.77 stddev:0.00 (0.0%) 23:29:58 INFO - 2015-11-19 23:29:58,905 DEBUG : BROWSER_OUTPUT: Values: 649.8 23:29:58 INFO - 2015-11-19 23:29:58,905 DEBUG : BROWSER_OUTPUT: 23:29:58 INFO - 2015-11-19 23:29:58,905 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4584.47 Median:4584.47 stddev:0.00 (0.0%) 23:29:58 INFO - 2015-11-19 23:29:58,905 DEBUG : BROWSER_OUTPUT: Values: 4584.5 23:29:58 INFO - 2015-11-19 23:29:58,905 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 23:29:58 INFO - 2015-11-19 23:29:58,905 DEBUG : BROWSER_OUTPUT: 23:29:59 INFO - 2015-11-19 23:29:59,530 INFO : Browser exited with error code: 0 23:29:59 INFO - 2015-11-19 23:29:59,548 INFO : Completed test v8_7 (00:00:37) 23:30:00 INFO - 2015-11-19 23:30:00,034 INFO : Completed test suite (00:20:07) 23:30:00 INFO - 2015-11-19 23:30:00,035 DEBUG : Working with test: dromaeo_css 23:30:00 INFO - 2015-11-19 23:30:00,035 DEBUG : Generating results file: dromaeo_css 23:30:00 INFO - 2015-11-19 23:30:00,035 DEBUG : Working with test: kraken 23:30:00 INFO - 2015-11-19 23:30:00,036 DEBUG : Generating results file: kraken 23:30:00 INFO - 2015-11-19 23:30:00,036 INFO : javascript benchmark 23:30:00 INFO - 2015-11-19 23:30:00,036 DEBUG : Working with test: v8_7 23:30:00 INFO - 2015-11-19 23:30:00,036 DEBUG : Generating results file: v8_7 23:30:00 INFO - 2015-11-19 23:30:00,036 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:30:00 INFO - 2015-11-19 23:30:00,434 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,1,61]] 23:30:00 INFO - 2015-11-19 23:30:00,434 DEBUG : process_Request line: dromaeo_css 7689.05 graph.html#tests=[[72,1,61]] 23:30:00 INFO - 2015-11-19 23:30:00,434 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:30:00 INFO - 2015-11-19 23:30:00,460 DEBUG : process_Request line: kraken 1594.40 graph.html#tests=[[232,1,61]] 23:30:00 INFO - 2015-11-19 23:30:00,460 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:30:00 INFO - 2015-11-19 23:30:00,492 DEBUG : process_Request line: v8_7 21493.02 graph.html#tests=[[230,1,61]] 23:30:00 INFO - 2015-11-19 23:30:00,493 INFO : javascript benchmark 23:30:00 INFO - 2015-11-19 23:30:00,495 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2896.6089577906982, 3558.661927116923, 3577.373959557077, 3605.0626837022364, 3614.8554057837678, 5972.134040564116, 6001.009833377488, 6005.0, 6015.248093988252, 6024.126501657257, 4962.131626965284, 5767.653940763557, 5885.823425297237, 5920.644761314325, 5942.138389933468, 4544.341070544769, 5354.41101478837, 5355.892882142345, 5443.700596467193, 5512.6692398456225, 5462.0, 5528.308961379827, 5555.3611334696425, 5560.972195139018, 5603.579731520132, 5254.290670759437, 5307.548858347045, 5423.674579525241, 5483.232347471338, 5540.695261760601, 5386.67679939201, 5389.137737961907, 5403.567714582863, 5425.511703946664, 5434.103372943459, 5362.973185134049, 5376.462353764631, 5390.00284947286, 5401.027814993299, 5466.890662186774, 5502.9174562381595, 5532.474414930575, 5689.544836413077, 5851.151583020438, 5957.791477298274, 6287.308396076428, 6309.652969086698, 6322.336154703736, 6336.6198028118, 6345.206849143857, 6323.74705011799, 6333.1766870306565, 6336.144620476222, 6337.524685648595, 6340.0, 5950.375210602868, 6039.627950215355, 6095.420935011167, 6121.0, 6135.570510064342, 5360.597955153379, 6226.533010024266, 6384.553081284265, 6504.730758668878, 6562.967185164139, 6268.905966410507, 6294.779682711175, 6314.905276420857, 6320.778772742932, 6339.5562310637815, 5191.299174611455, 6287.685615719196, 6337.904931426032, 6378.330275321117, 6420.390062944013, 6176.135341052256, 6323.7786677466065, 6323.873522529524, 6331.556791024584, 6340.809775706644, 6274.623522588659, 6297.086922396227, 6342.904856427157, 6346.0, 6359.427651511293, 3949.4865667463046, 4344.261475549164, 4737.620990320766, 4895.192293271571, 5048.368953880765, 3852.4028775539837, 4558.293464513005, 4569.611583015481, 4585.770711464414, 4598.838051563341, 5424.589606702286, 5992.0, 6002.339742628307, 6047.546434017467, 6054.122152287981, 6035.124906888476, 6215.906761398583, 6291.245050593958, 6326.367363263636, 6434.131392262078, 5969.910451343233, 6006.189164462829, 6006.9299241293, 6069.211002569726, 6071.726772295257, 4571.862844114682, 4855.781489832966, 5545.445455454503, 5551.555875529948, 5557.5831812614215, 6215.906761398583, 6301.842453938688, 6336.809895703136, 6407.935920640734, 6414.230292364946, 6303.275123360872, 6351.0, 6360.840978975562, 6367.745290188341, 6378.52161087911, 6260.780872669617, 6476.870462590816, 6506.967465162644, 6518.543701940818, 6537.280899101, 6157.107219453064, 6270.216222972129, 6272.466840318624, 6315.989441689308, 6325.810225693236, 6328.683565821782, 6364.459020983269, 6370.6814659267775, 6382.489400848014, 6402.87194256103, 4773.260144677581, 6128.938710612837, 6235.314115447388, 6291.087792270187, 6312.684365781784, 6166.722497487534, 6300.180976473029, 6302.873942521215, 6329.461995730415, 6334.461570766352, 6114.327423983447, 6193.1329613855, 6206.658633775186, 6252.09344645033, 6258.968705156445, 6108.75564977396, 6139.171211886338, 6195.132681424694, 6241.625502469685, 6323.905141422974, 5753.9136912945505, 5756.683382414008, 6206.937930620817, 6241.719122639583, 6251.249850018027], "unit": "ms", "name": "dojo.html", "value": 5796.493549341864}, {"lowerIsBetter": false, "replicates": [560.4871542538575, 564.7684449375754, 581.20375086132, 581.3054944835801, 642.5437939063265, 40158.59841401589, 40365.0, 40441.59558404415, 40487.19025619486, 40549.79725101378, 34596.48105278423, 44583.331250031195, 44714.0, 44737.10525789482, 44858.551414485846, 9683.176929960962, 9839.409635421862, 9846.1630761385, 9858.211343092535, 9915.851262231072, 9689.515524223796, 9741.31810773246, 9779.951100244525, 9806.754831129207, 9819.21446284299, 9719.902800972006, 9787.119159275664, 9802.558884850163, 9818.607255709763, 9840.458774767385, 9737.977512361207, 9775.902240977606, 9786.951065244699, 9811.166050885648, 9825.754356141153, 9589.472579008152, 9713.90286097137, 9742.610295588169, 9756.90243097567, 9770.804583908353, 42399.36400953988, 42676.0, 42715.0, 42897.0, 43087.56912430867, 3130.1861516005774, 3143.5913331267016, 3304.867805287786, 3312.9834350828332, 3408.9488657670154, 29686.257843553867, 29800.956966506285, 30036.24909377261, 30077.548836767248, 30605.69394306073, 2769.5014897318474, 2841.1476557033016, 2858.757005654522, 2867.2688464441435, 2985.1939976206518, 499261.0, 500143.99999999633, 500750.99999999633, 503565.0, 503650.0, 57737.422625774045, 58761.706191468766, 72310.63844680742, 72842.27157728461, 73329.0, 71857.6407117961, 72123.6393818038, 72197.0, 72303.0, 72976.63511682408, 16113.194340282938, 16158.919205404132, 16159.0, 16197.595060123356, 16355.672886542203, 12245.265284082983, 12251.571195008131, 12269.018478521697, 12294.569690060805, 12329.260244385187, 21499.67750483744, 21517.354479365644, 21620.35138945834, 21729.56540869174, 21756.782432175474, 8268.958655206685, 8504.23461888433, 8504.574771261412, 8510.0, 8536.359773017048, 961.1637875048752, 983.3706427886159, 1000.9949950250348, 1069.916409681796, 1121.876593574706, 30321.24196895095, 31117.8444107778, 31184.220394489865, 31293.530597041063, 31602.525962110587, 1023.923205759571, 1034.6844212515105, 1042.4579218806177, 1113.0705860606322, 1207.06452499312, 12094.0, 15202.087874727551, 15217.6195595111, 15374.385024599114, 15503.379864805282, 738793.7542810587, 745186.0, 753481.0, 756220.0, 756650.0, 60375.69812150999, 60629.39370606237, 60746.69626651927, 60807.69596151991, 60964.0, 1441.0705095213739, 1473.2633683158635, 1475.9040662356913, 1484.0872863189277, 1611.0253296755295, 30667.846660766554, 30747.692523074482, 30881.845590771904, 30969.690303096682, 31542.580583874238, 43333.78333108441, 52471.475285246655, 52514.737426314154, 52912.0, 53097.20354194613, 472620.0, 473936.0, 478058.0, 481770.0, 483342.0, 28936.131916042552, 29017.854910725313, 29023.41953160967, 29289.85355073211, 29336.266593334483, 45060.54939450695, 45664.0, 45990.310145347175, 46055.53944460512, 46646.30030549612, 37726.43410348792, 38087.61912380841, 38488.80755596204, 38599.64901228443, 38634.6136538631, 37382.813085934395, 37794.62205378021, 37868.2426351477, 38170.0, 38305.425418618186, 28867.422651547273, 30641.846790765903, 37667.81166094152, 37865.05337366478, 38336.233275333776, 31192.532112017885, 33331.0, 33387.332253355286, 33532.49701254434, 33810.32379352448, 25212.747872521773, 25441.10956116601, 25520.10679626204, 25657.230283091536, 25756.356091097874], "unit": "ms", "name": "ext.html", "value": 20409.465288980264}, {"lowerIsBetter": false, "replicates": [324.701274827159, 348.68198210763325, 356.08308605341267, 361.5408431292259, 362.1543695471075, 15747.685046299095, 16902.239399227034, 17486.650266994653, 19656.312029078985, 20113.59772804545, 19811.70282445761, 19892.005399730027, 19971.0, 20358.287459938903, 20837.374878753624, 5842.795502157425, 5960.642361458305, 5993.85015374617, 5995.700214989255, 6022.939770602304, 3305.636379998198, 4028.536718277406, 5650.943490565083, 5714.485696287334, 5881.441263080022, 5821.27234095738, 5828.358880523139, 5838.41615838417, 5875.412458754112, 5876.500497457721, 5010.273510340999, 5844.620099693528, 6434.131392262031, 6435.195600549931, 6476.093346931433, 5502.339719233678, 5632.662040277596, 5652.463016013472, 5654.434556544313, 5662.320521537401, 12773.936130319382, 13013.804792928113, 13015.47938082485, 13102.558718540953, 19322.613547729106, 1990.6317331293758, 2085.4160834966083, 2160.0711693971584, 2195.3962660268394, 2325.6627788970504, 10062.24533160016, 10075.848862267072, 10142.188624910063, 10190.59237630494, 10210.438425886574, 1427.757281262188, 1473.9976815765276, 1513.553501716985, 1805.1042244590622, 1846.3168627607736, 88372.7673103745, 92743.0, 103948.48025759899, 104568.47715761448, 106312.0, 10980.615678451215, 11041.613543526099, 11107.94446027781, 11122.110231181487, 11164.162687798447, 11358.318500889973, 13187.802182967263, 13239.933800330937, 13256.0, 13292.534761283308, 7235.312645298688, 8237.83524329522, 8253.174682531819, 8341.165883411732, 8363.540005299645, 8400.369972252105, 8438.957805210935, 8479.448835825651, 8523.105073967268, 8547.0, 4284.078923031563, 4289.292266775947, 4356.956430435718, 4361.9127617447475, 4383.057642606855, 1723.6638855423323, 1785.571462848933, 1786.88385254958, 1815.972760408595, 1844.7140693192578, 888.9422187557788, 898.1916275352105, 910.4673765847053, 916.8349697054595, 973.9610415583439, 19224.134913928905, 19278.518037048907, 19956.50108747264, 20942.581148376947, 20959.056842442125, 909.9899111985691, 943.429225318686, 970.4225985538593, 1020.2807021050141, 1044.5978298355187, 10742.94628526868, 10967.4614319768, 11304.604338848101, 11825.822612660817, 11893.88106118945, 715902.4204879047, 716914.4154279195, 725471.0, 732044.0, 737300.0, 102420.48789756003, 122899.0, 123708.0, 125718.0, 127881.36059319644, 1222.1506053293053, 1235.0736947289354, 1240.2806372304042, 1246.0, 1271.167385362589, 19207.50302460671, 19586.118624661638, 19608.411747647595, 19698.113584889, 19948.20207191696, 51709.7414512925, 52898.0, 53671.19493207683, 53706.73146634242, 54617.45382546283, 74018.62990685012, 75542.0, 76170.0, 76292.0, 77213.0, 9675.274354423305, 9694.0, 10031.69904902854, 10232.64185753495, 10270.229732769923, 11728.003119734918, 15200.315985780446, 15884.285207165474, 19708.014599270267, 20236.392908212776, 15326.386944522093, 15714.21428928572, 15737.68524629524, 15950.920245398698, 16127.596810079842, 15090.320935558146, 15309.923450382677, 15429.997050191701, 15554.61113472127, 15753.842461575237, 15910.522684319489, 16096.034237945762, 16344.754828677342, 16418.26117824677, 16450.177491125156, 9618.134367906921, 9632.518374081408, 9706.951465242628, 9798.167155791838, 9851.852222216816, 10163.44101074448, 10229.283950123718, 13593.0, 15660.68678626444, 16189.838101618832], "unit": "ms", "name": "jquery.html", "value": 9757.974485007873}, {"lowerIsBetter": false, "replicates": [1324.7946568281914, 1493.3727834309595, 1837.5957289396329, 1899.5251187203196, 1931.5364312564984, 7165.462590305722, 7263.237360077195, 8287.585620718963, 8663.523506207157, 8664.176903194202, 8105.554194519299, 8244.0, 8317.625706843191, 8331.0, 8341.124181960882, 2366.301940927422, 2403.158894386959, 2404.158544509425, 2406.9037238510437, 2414.6619473273754, 2118.5762847430497, 2376.964345534818, 2415.903363865443, 2457.8771061446946, 2460.790832779216, 2371.0, 2400.303911865557, 2409.819263555232, 2412.107520217522, 2430.368104292888, 2204.5921504521716, 2227.599032174208, 2239.2386588559966, 2251.952841928503, 2254.323702889135, 2382.0, 2432.477017441241, 2435.43984883476, 2436.1108195508514, 2451.2156110044793, 8377.95811020947, 8464.0, 8474.1102184271, 8494.320454363637, 8551.358648101355, 4551.34005569194, 5114.156164232897, 5184.896302073975, 5237.0, 5244.842654720326, 3157.921051973696, 3498.825058747078, 3518.736094792901, 3543.291341731638, 3593.7304702147444, 1036.3160314192671, 1052.9368237905674, 1069.8555694981155, 1083.3716444462193, 1084.143526613974, 10883.619073332475, 10997.395143267036, 11029.779404411867, 11038.282511636718, 11076.224664273504, 4693.48371679115, 4738.597219236334, 4785.282207668877, 4798.49615790344, 4802.8799280018275, 9669.806603867883, 9752.707418777449, 9758.804823903482, 9787.853182202272, 9789.118979291898, 5222.2427747976335, 5224.791008359699, 5236.764345604457, 5268.736563171826, 5296.232046353257, 4758.833440829554, 4788.569028787356, 4818.0, 4820.855374338706, 4844.297576851337, 3889.572147063821, 3906.5312162540677, 3909.276783795007, 3911.8851127428547, 3918.2163567286657, 1269.955551555691, 1273.2742336868082, 1277.399622177575, 1278.0733967873218, 1284.5760898903338, 1339.6583871112805, 1356.1727346318737, 1377.800218968244, 1389.8610138986223, 1397.9301034948414, 7862.056553213651, 7896.960515197387, 7907.644156012993, 7930.841383172419, 7961.323287520509, 504.78546617687334, 509.34294759760235, 510.72931346386474, 512.6232219318798, 516.7803683434526, 5823.5923485355615, 6187.226596675416, 6211.720472578745, 6214.658193799384, 6251.156093927352, 9513.429194248367, 10208.234382421348, 10238.488075596191, 10293.588256469808, 10334.483275836179, 9852.50737463124, 10023.298369114238, 10091.646792362231, 10110.292279540508, 10124.392536447836, 7862.095858976177, 7897.328727058264, 7915.564643944638, 7978.0825205102155, 8028.157043510464, 7549.0, 7880.408969327209, 7883.369330453435, 7909.0, 7984.8802267967185, 8971.685990990283, 9114.13415725505, 9128.178463938277, 9141.451512909247, 9156.0, 9163.40437871563, 9406.482643454401, 9421.481818500048, 9440.150386465251, 9457.905420945977, 6195.81412557624, 7409.8147546311775, 7422.96288518554, 7466.36535894455, 7492.962535187289, 8043.83912321762, 8078.0, 8108.108108108221, 8121.593920303843, 8127.024757029194, 6306.46395056407, 6745.089412929192, 7493.40052795786, 7643.0, 7651.846963060596, 7501.962490187514, 7525.134609519975, 7574.128975167706, 7639.961800190964, 7694.961525192338, 7478.401727861649, 7665.923340766521, 7668.539887606761, 7669.118051424158, 7697.846043078995, 5985.940140598538, 6799.252082271045, 7022.367986881205, 7039.929600704132, 7074.115735533059, 7002.614856182959, 7078.787636370711, 7119.82200444993, 7128.786136415916, 7143.8571228576175], "unit": "ms", "name": "mootools.html", "value": 4719.489071029001}, {"lowerIsBetter": false, "replicates": [269.81922112184833, 311.8440779610195, 322.1623778176741, 331.12747909259093, 331.8357413080527, 6839.1451068616425, 6884.82787930302, 7013.789586312419, 7102.538335008234, 7124.109486314211, 6771.796846094613, 6993.125859267591, 7014.158301003874, 7029.964850175755, 7044.8591028179535, 4559.680822342438, 5131.922296317778, 5172.896542069157, 5189.662671926331, 5207.843764687056, 4882.145624515695, 5150.871228219287, 5161.483851614846, 5178.508041736029, 5203.765830537635, 4948.57937075349, 4964.304997300381, 4965.925511117336, 4972.229304457815, 4996.825111121111, 4054.635082842529, 4970.602351811846, 4994.400671919357, 4995.475475075119, 5024.799008039674, 4228.260054490452, 4238.3430568261965, 4239.894002649928, 4247.065645557972, 4266.679999000087, 6345.0, 6611.471082313404, 6614.404703576702, 6617.073609694647, 6643.6346000969925, 5890.499307558863, 5913.438223368773, 5917.497012753921, 5924.200232968537, 5937.435943585352, 7353.48525603208, 7354.705811767523, 7381.778546643609, 7397.8520429591645, 7412.073490813648, 3909.4753046311675, 4172.8122234499215, 4705.670603057787, 4706.882327941795, 4726.243800991825, 6392.785370779537, 7307.963460182665, 7812.140664526954, 7890.289873911318, 7908.209179082046, 4727.503612120747, 4761.9285660726755, 4770.045990801784, 4774.164521208774, 4809.711417314972, 4862.05189987949, 4874.8781280467565, 4879.951200488021, 4883.389576302962, 4887.731174785421, 4909.975450122798, 5659.264295641623, 5922.970385148046, 5924.4667979882015, 5955.166276721263, 7111.715531378687, 7494.288042635941, 7498.100227972569, 7523.3981281497345, 7544.283293087148, 1669.4157045034142, 1676.7987841459103, 1682.7307630779017, 1689.7127488327014, 1694.9661006779795, 1063.1919740996743, 1072.4262519552003, 1072.6245813965206, 1077.498962982217, 1083.5557421457165, 6090.451859332681, 6454.870902582016, 6897.758578449831, 6900.861982760417, 6941.895871561931, 6446.129772480655, 7465.581539507476, 7730.96134519335, 7764.767056988299, 7776.339011184, 6729.0, 6840.384365407038, 6864.931350686529, 6882.5870447773295, 6930.480213983971, 4076.9592304076577, 4119.0526178979, 4132.834686612502, 4139.254934111828, 4151.086760912594, 6960.816661167613, 7698.884516732253, 8084.191580841986, 8122.675092996332, 8140.226678465537, 7849.215078492105, 8083.342914702472, 8106.0, 8127.187281271826, 8146.470479418819, 6817.0, 8073.515589064675, 8073.6366863491285, 8088.352931765445, 8135.227153420534, 6521.967390163209, 7810.218978102144, 7831.412644051605, 7833.764987050397, 7856.960715196387, 7681.807954800951, 7697.615119243904, 7705.22947705225, 7708.03649543807, 7725.806854828675, 8077.192280771876, 8086.838263234585, 8091.959540202261, 8097.39269554774, 8128.983877015373, 3955.7626542407547, 4682.2040253156365, 4753.952460475351, 4831.154547954165, 4843.176659967884, 6275.843103922439, 6330.0, 7520.586367749607, 7774.689012439665, 7803.375729941705, 7349.4855360124275, 7403.51877127985, 7435.367993720378, 7468.92531074704, 7496.175420703609, 6567.408933196035, 6989.720411183495, 7486.43851711113, 7523.0, 7563.886541701769, 7097.112860892388, 7327.0, 7358.742444014648, 7371.557706537625, 7403.0, 7481.663325150273, 7492.400607951242, 7499.812504687427, 7501.137369202612, 7537.2085930976455, 6979.336962988508, 7210.206877243394, 7302.926970730225, 7325.890111648223, 7336.669849856876], "unit": "ms", "name": "prototype.html", "value": 5339.282167358108}, {"lowerIsBetter": false, "replicates": [592.8725324055332, 722.4509372876612, 746.4215233194275, 809.5466538738306, 809.874469457234, 13365.7326853463, 13524.729505409887, 13622.318884055794, 13666.863331366683, 13694.726105477885, 11763.294202347844, 14419.927900360484, 14562.635934101652, 14568.708625827478, 14572.854271457309, 754.7094368668047, 763.9732609358673, 949.2406075139895, 953.2278854128143, 974.5224839828504, 956.4309236004566, 963.388248462228, 969.2391472693937, 972.188222833931, 977.2963466304285, 1002.2282842211492, 1013.8124446977296, 1018.4754851251612, 1022.166933948833, 1025.3079171559204, 1001.664442411793, 1003.172382784206, 1007.9546420411099, 1011.5599714124379, 1017.4454922067491, 747.096013823269, 750.1298493747281, 751.8233215194425, 756.183322012231, 759.7302957450136, 13895.513657022057, 13970.441182352693, 14034.578962631036, 14042.859571404257, 14063.226522541256, 12583.874161258362, 12744.0, 12870.871291287061, 13173.473061077546, 13174.736505269937, 10028.94985525075, 10253.384796912209, 10310.484475776257, 10631.308964917256, 10911.07255883251, 3545.3441113393847, 3560.038789526813, 3574.195805943642, 3574.857005719768, 3582.7850328980344, 78477.43045139065, 79695.6015219926, 80540.38919221582, 80689.0, 80844.59577702133, 9689.612415503441, 9725.513724313756, 9928.35465694742, 9992.00079991995, 10340.327878687862, 21728.34814955554, 21822.345329640135, 21969.0, 22103.778962210494, 22251.332460026224, 7404.777856664308, 7417.925820741723, 7636.50362726421, 7679.155292917774, 7732.884006739903, 4045.8179381927293, 4101.569335219819, 4165.291900376883, 4205.621494065487, 4352.412424322739, 3355.1108956126645, 3355.7650964432255, 3373.865045398206, 3389.7118744906466, 3398.167448975017, 608.5709574749791, 623.9251289845248, 628.0265588338149, 636.5766765101156, 640.6572483721187, 569.6069711898776, 581.3575998521658, 607.6779306967314, 609.2354095610069, 625.1903784598956, 8382.245597896219, 8757.168069033432, 8816.250618697355, 8845.469986987482, 8993.685221017364, 523.7957196693293, 580.4021857486796, 590.4213870407025, 594.2304715393576, 643.0868167202584, 3827.6172382762056, 3870.619838424592, 3892.065904182976, 4147.502299724052, 4268.2530557152995, 89701.55149224213, 89888.10111898927, 91194.1761164773, 92212.77255296167, 92233.0, 89372.5531372339, 90083.54958225298, 90444.5477772607, 90539.09460905439, 91189.54405228065, 77876.44247115027, 78498.0, 78575.0, 79019.41961160745, 79133.60433197797, 7500.737474188377, 7981.24178203093, 8350.498970061815, 8385.329173666214, 8492.320614350961, 51847.0, 55150.72424637851, 55738.0, 55977.6005599847, 57287.42712572821, 67208.65582688416, 67713.0, 67923.66038169975, 75088.62455687686, 76216.0, 11731.941340293244, 11794.46924888365, 11882.584109556125, 11974.760504789681, 12332.81500777507, 12050.698732531757, 12259.264444133381, 12277.508899644272, 12279.815802762787, 12317.630471085882, 11263.302966828953, 11783.941080294544, 11810.822837657613, 11866.288022718665, 12379.319137447526, 11471.885281147082, 12089.335086570323, 12213.389330533615, 12465.813012804996, 12571.30857802793, 11457.255278406878, 11669.88330116722, 11675.007624351685, 12093.637190884288, 12330.691732706755, 8913.643454261757, 9518.714438566854, 9684.128428441474, 9962.203023758228, 10674.412907290174, 9489.95255023748, 9788.119069283799, 10135.64525241613, 10396.948015259875, 10405.23111071135], "unit": "ms", "name": "yui.html", "value": 7103.378185789393}], "name": "dromaeo_css", "value": 7689.048978355984}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [123.0, 150.0, 169.0, 115.0, 117.0, 125.0, 114.0, 114.0, 114.0, 115.0], "unit": "ms", "name": "ai-astar", "value": 125.6}, {"lowerIsBetter": true, "replicates": [164.0, 150.0, 145.0, 162.0, 121.0, 137.0, 140.0, 122.0, 153.0, 124.0], "unit": "ms", "name": "audio-beat-detection", "value": 141.8}, {"lowerIsBetter": true, "replicates": [222.0, 263.0, 197.0, 205.0, 210.0, 205.0, 226.0, 262.0, 204.0, 199.0], "unit": "ms", "name": "audio-dft", "value": 219.3}, {"lowerIsBetter": true, "replicates": [64.0, 73.0, 100.0, 146.0, 69.0, 79.0, 85.0, 86.0, 130.0, 57.0], "unit": "ms", "name": "audio-fft", "value": 88.9}, {"lowerIsBetter": true, "replicates": [81.0, 106.0, 145.0, 79.0, 78.0, 78.0, 107.0, 78.0, 76.0, 110.0], "unit": "ms", "name": "audio-oscillator", "value": 93.8}, {"lowerIsBetter": true, "replicates": [88.0, 89.0, 88.0, 88.0, 89.0, 89.0, 89.0, 89.0, 88.0, 89.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 88.6}, {"lowerIsBetter": true, "replicates": [98.0, 105.0, 104.0, 142.0, 149.0, 103.0, 150.0, 149.0, 97.0, 96.0], "unit": "ms", "name": "imaging-darkroom", "value": 119.3}, {"lowerIsBetter": true, "replicates": [147.0, 152.0, 90.0, 90.0, 99.0, 90.0, 101.0, 142.0, 79.0, 153.0], "unit": "ms", "name": "imaging-desaturate", "value": 114.3}, {"lowerIsBetter": true, "replicates": [60.0, 59.0, 59.0, 59.0, 63.0, 79.0, 74.0, 91.0, 83.0, 77.0], "unit": "ms", "name": "json-parse-financial", "value": 70.4}, {"lowerIsBetter": true, "replicates": [69.0, 75.0, 98.0, 99.0, 99.0, 70.0, 69.0, 84.0, 70.0, 76.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 80.9}, {"lowerIsBetter": true, "replicates": [76.0, 89.0, 110.0, 79.0, 98.0, 99.0, 125.0, 112.0, 108.0, 82.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 97.8}, {"lowerIsBetter": true, "replicates": [120.0, 125.0, 136.0, 149.0, 130.0, 131.0, 127.0, 114.0, 136.0, 114.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 128.2}, {"lowerIsBetter": true, "replicates": [129.0, 144.0, 185.0, 138.0, 142.0, 129.0, 140.0, 140.0, 149.0, 137.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 143.3}, {"lowerIsBetter": true, "replicates": [68.0, 90.0, 89.0, 59.0, 74.0, 96.0, 95.0, 97.0, 84.0, 70.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 82.2}], "name": "kraken", "value": 1594.4}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [147.90711433219937], "unit": "score", "name": "Richards", "value": 238.67682200000002}, {"lowerIsBetter": false, "replicates": [184.74043968224643], "unit": "score", "name": "DeltaBlue", "value": 357.8967339999999}, {"lowerIsBetter": false, "replicates": [284.57598178713715], "unit": "score", "name": "Encrypt", "value": 935.3600340000003}, {"lowerIsBetter": false, "replicates": [4935.9605911330045], "unit": "score", "name": "Decrypt", "value": 53.92688922155686}, {"lowerIsBetter": false, "replicates": [959.6928982725528], "unit": "score", "name": "RayTrace", "value": 771.0685379999996}, {"lowerIsBetter": false, "replicates": [759.8784194528876], "unit": "score", "name": "Earley", "value": 877.0653080000002}, {"lowerIsBetter": false, "replicates": [12662.5], "unit": "score", "name": "Boyer", "value": 52.632813425468896}, {"lowerIsBetter": false, "replicates": [28138.88888888889], "unit": "score", "name": "RegExp", "value": 32.37459032576504}, {"lowerIsBetter": false, "replicates": [649.772579597141], "unit": "score", "name": "Splay", "value": 125.41464899999998}, {"lowerIsBetter": false, "replicates": [4584.474885844749], "unit": "score", "name": "NavierStokes", "value": 323.70119521912324}], "name": "v8_7", "value": 21493.020164030266}]} 23:30:00 INFO - RETURN: dromaeo_css: 7689.05 23:30:00 INFO - RETURN: kraken: 1594.40 23:30:00 INFO - RETURN: v8_7: 21493.02 23:30:00 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,61]]", "result": "21493.02"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,61]]", "result": "1594.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,61]]", "result": "7689.05"}}} 23:30:00 INFO - Return code: 0 23:30:00 INFO - # TBPL SUCCESS # 23:30:00 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 23:30:00 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 23:30:00 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 23:30:00 INFO - 2015-11-19 23:30:00.588 screenresolution[1683:11017] starting screenresolution argv=screenresolution get 23:30:00 INFO - 2015-11-19 23:30:00.591 screenresolution[1683:11017] Display 0: 1600x1200x32@60 23:30:00 INFO - 2015-11-19 23:30:00.597 screenresolution[1684:11020] starting screenresolution argv=screenresolution list 23:30:00 INFO - Available Modes on Display 0 23:30:00 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 23:30:00 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 23:30:00 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 23:30:00 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 23:30:00 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 23:30:00 INFO - Intel Iris: 23:30:00 INFO - Chipset Model: Intel Iris 23:30:00 INFO - Type: GPU 23:30:00 INFO - Bus: Built-In 23:30:00 INFO - VRAM (Dynamic, Max): 1536 MB 23:30:00 INFO - Vendor: Intel (0x8086) 23:30:00 INFO - Device ID: 0x0a2e 23:30:00 INFO - Revision ID: 0x0009 23:30:00 INFO - Displays: 23:30:00 INFO - Display: 23:30:00 INFO - Resolution: 1600 x 1200 @ 60 Hz 23:30:00 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 23:30:00 INFO - Display Serial Number: 1600x1200 60 23:30:00 INFO - Main Display: Yes 23:30:00 INFO - Mirror: Off 23:30:00 INFO - Online: Yes 23:30:00 INFO - Rotation: Supported 23:30:00 INFO - Return code: 0 23:30:00 INFO - Running post-action listener: _resource_record_post_action 23:30:00 INFO - Running post-run listener: _resource_record_post_run 23:30:01 INFO - Total resource usage - Wall time: 1239s; CPU: 54.0%; Read bytes: 33578496; Write bytes: 693195776; Read time: 352; Write time: 2576 23:30:01 INFO - install - Wall time: 31s; CPU: 55.0%; Read bytes: 917504; Write bytes: 348608512; Read time: 13; Write time: 699 23:30:01 INFO - run-tests - Wall time: 1209s; CPU: 54.0%; Read bytes: 31084032; Write bytes: 343116800; Read time: 323; Write time: 1871 23:30:01 INFO - Running post-run listener: _upload_blobber_files 23:30:01 INFO - Blob upload gear active. 23:30:01 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 23:30:01 INFO - Copying logs to upload dir... 23:30:01 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1287.126715 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 27 secs) (at 2015-11-19 23:30:01.951829) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-19 23:30:01.955751) ========= 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.JWy3XbC9ts/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.W1eElHHrlW/Listeners TMPDIR=/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False build_url:https://queue.taskcluster.net/v1/task/wBB41CzbQO2t37TsTWPMtw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.009553 build_url: 'https://queue.taskcluster.net/v1/task/wBB41CzbQO2t37TsTWPMtw/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-19 23:30:01.982823) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 23:30:01.983159) ========= 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.JWy3XbC9ts/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.W1eElHHrlW/Listeners TMPDIR=/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005053 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 23:30:02.032841) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-19 23:30:02.033217) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-19 23:30:02.033769) ========= ========= Total master_lag: 0.46 =========