builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0045 starttime: 1468023880.73 results: success (0) buildid: 20160708150326 builduid: cb80233497f8473f92fce3d3b17d3618 revision: bbb29a9b88dd680dbb59577cbe4dc6e58d117100 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-08 17:24:40.728610) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-08 17:24:40.729104) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-08 17:24:40.729410) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-08 17:24:40.752304) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 17:24:40.752643) ========= 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.2hS2oTMDrP/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.LkVDU4qEDd/Listeners TMPDIR=/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/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 --2016-07-08 17:24:40-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 6.08M=0.002s 2016-07-08 17:24:40 (6.08 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.134984 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 17:24:40.909611) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 17:24:40.909948) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.2hS2oTMDrP/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.LkVDU4qEDd/Listeners TMPDIR=/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/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.020903 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 17:24:40.958853) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-08 17:24:40.959214) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev bbb29a9b88dd680dbb59577cbe4dc6e58d117100 --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 bbb29a9b88dd680dbb59577cbe4dc6e58d117100 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.2hS2oTMDrP/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.LkVDU4qEDd/Listeners TMPDIR=/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/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 2016-07-08 17:24:41,032 truncating revision to first 12 chars 2016-07-08 17:24:41,032 Setting DEBUG logging. 2016-07-08 17:24:41,032 attempt 1/10 2016-07-08 17:24:41,032 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/bbb29a9b88dd?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-08 17:24:42,021 unpacking tar archive at: mozilla-central-bbb29a9b88dd/testing/mozharness/ program finished with exit code 0 elapsedTime=1.263530 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-08 17:24:42.242746) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-08 17:24:42.243131) ========= script_repo_revision: bbb29a9b88dd680dbb59577cbe4dc6e58d117100 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-08 17:24:42.243576) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-08 17:24:42.243935) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-08 17:24:42.262594) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2016-07-08 17:24:42.263050) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --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', '--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.2hS2oTMDrP/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.LkVDU4qEDd/Listeners TMPDIR=/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/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 17:24:42 INFO - MultiFileLogger online at 20160708 17:24:42 in /builds/slave/test 17:24:42 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 17:24:42 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:24:42 INFO - {'append_to_log': False, 17:24:42 INFO - 'base_work_dir': '/builds/slave/test', 17:24:42 INFO - 'blob_upload_branch': 'Firefox', 17:24:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:24:42 INFO - 'branch': 'Firefox', 17:24:42 INFO - 'buildbot_json_path': 'buildprops.json', 17:24:42 INFO - 'config_files': ('talos/mac_config.py',), 17:24:42 INFO - 'default_actions': ('clobber', 17:24:42 INFO - 'read-buildbot-config', 17:24:42 INFO - 'download-and-extract', 17:24:42 INFO - 'populate-webroot', 17:24:42 INFO - 'create-virtualenv', 17:24:42 INFO - 'install', 17:24:42 INFO - 'run-tests'), 17:24:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:24:42 INFO - 'download_minidump_stackwalk': True, 17:24:42 INFO - 'download_symbols': 'ondemand', 17:24:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:24:42 INFO - 'tooltool.py': '/tools/tooltool.py', 17:24:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:24:42 INFO - '/tools/misc-python/virtualenv.py')}, 17:24:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:24:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:24:42 INFO - 'installer_path': 'installer.exe', 17:24:42 INFO - 'log_level': 'info', 17:24:42 INFO - 'log_name': 'talos', 17:24:42 INFO - 'log_to_console': True, 17:24:42 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 17:24:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 17:24:42 INFO - 'opt_config_files': (), 17:24:42 INFO - 'pip_index': False, 17:24:42 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:24:42 INFO - 'cmd': ('bash', 17:24:42 INFO - '-c', 17:24:42 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:24:42 INFO - 'enabled': True, 17:24:42 INFO - 'halt_on_failure': False, 17:24:42 INFO - 'name': 'check_screen_resolution'},), 17:24:42 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:24:42 INFO - 'cmd': ('bash', 17:24:42 INFO - '-c', 17:24:42 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:24:42 INFO - 'enabled': True, 17:24:42 INFO - 'halt_on_failure': False, 17:24:42 INFO - 'name': 'check_screen_resolution'},), 17:24:42 INFO - 'run_cmd_checks_enabled': True, 17:24:42 INFO - 'sps_profile': False, 17:24:42 INFO - 'sps_profile_interval': 0, 17:24:42 INFO - 'suite': 'dromaeojs-e10s', 17:24:42 INFO - 'system_bits': '32', 17:24:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:24:42 INFO - 'title': 't-yosemite-r7-0045', 17:24:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:24:42 INFO - 'use_talos_json': True, 17:24:42 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:24:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:24:42 INFO - 'work_dir': 'build'} 17:24:42 INFO - ##### 17:24:42 INFO - ##### Running clobber step. 17:24:42 INFO - ##### 17:24:42 INFO - Running pre-action listener: _resource_record_pre_action 17:24:42 INFO - Running main action method: clobber 17:24:42 INFO - rmtree: /builds/slave/test/build 17:24:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:24:43 INFO - Running post-action listener: _resource_record_post_action 17:24:43 INFO - ##### 17:24:43 INFO - ##### Finished clobber step (success) 17:24:43 INFO - ##### 17:24:43 INFO - ##### 17:24:43 INFO - ##### Running read-buildbot-config step. 17:24:43 INFO - ##### 17:24:43 INFO - Running pre-action listener: _resource_record_pre_action 17:24:43 INFO - Running main action method: read_buildbot_config 17:24:43 INFO - Using buildbot properties: 17:24:43 INFO - { 17:24:43 INFO - "project": "", 17:24:43 INFO - "product": "firefox", 17:24:43 INFO - "script_repo_revision": "production", 17:24:43 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 17:24:43 INFO - "repository": "", 17:24:43 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 17:24:43 INFO - "buildid": "20160708150326", 17:24:43 INFO - "pgo_build": "False", 17:24:43 INFO - "basedir": "/builds/slave/test", 17:24:43 INFO - "buildnumber": 49, 17:24:43 INFO - "slavename": "t-yosemite-r7-0045", 17:24:43 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 17:24:43 INFO - "platform": "yosemite_r7", 17:24:43 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 17:24:43 INFO - "branch": "mozilla-central", 17:24:43 INFO - "repo_path": "mozilla-central", 17:24:43 INFO - "revision": "bbb29a9b88dd680dbb59577cbe4dc6e58d117100", 17:24:43 INFO - "stage_platform": "macosx64", 17:24:43 INFO - "builduid": "cb80233497f8473f92fce3d3b17d3618", 17:24:43 INFO - "slavebuilddir": "test" 17:24:43 INFO - } 17:24:43 INFO - Found installer url https://queue.taskcluster.net/v1/task/A0txUtkLRq67XdDXxuZfGw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg. 17:24:43 INFO - Running post-action listener: _resource_record_post_action 17:24:43 INFO - ##### 17:24:43 INFO - ##### Finished read-buildbot-config step (success) 17:24:43 INFO - ##### 17:24:43 INFO - ##### 17:24:43 INFO - ##### Running download-and-extract step. 17:24:43 INFO - ##### 17:24:43 INFO - Running pre-action listener: _resource_record_pre_action 17:24:43 INFO - Running main action method: download_and_extract 17:24:43 INFO - mkdir: /builds/slave/test/build/tests 17:24:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:24:43 INFO - https://queue.taskcluster.net/v1/task/A0txUtkLRq67XdDXxuZfGw/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 17:24:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A0txUtkLRq67XdDXxuZfGw/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 17:24:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A0txUtkLRq67XdDXxuZfGw/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 17:24:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A0txUtkLRq67XdDXxuZfGw/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 17:24:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A0txUtkLRq67XdDXxuZfGw/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json'}, attempt #1 17:24:44 INFO - Downloaded 1199 bytes. 17:24:44 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 17:24:44 INFO - Using the following test package requirements: 17:24:44 INFO - {u'common': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 17:24:44 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 17:24:44 INFO - u'firefox-50.0a1.en-US.mac.cppunittest.tests.zip'], 17:24:44 INFO - u'gtest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 17:24:44 INFO - u'firefox-50.0a1.en-US.mac.gtest.tests.zip'], 17:24:44 INFO - u'jittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 17:24:44 INFO - u'jsshell-mac.zip'], 17:24:44 INFO - u'mochitest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 17:24:44 INFO - u'firefox-50.0a1.en-US.mac.mochitest.tests.zip'], 17:24:44 INFO - u'mozbase': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 17:24:44 INFO - u'reftest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 17:24:44 INFO - u'firefox-50.0a1.en-US.mac.reftest.tests.zip'], 17:24:44 INFO - u'talos': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 17:24:44 INFO - u'firefox-50.0a1.en-US.mac.talos.tests.zip'], 17:24:44 INFO - u'web-platform': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 17:24:44 INFO - u'firefox-50.0a1.en-US.mac.web-platform.tests.zip'], 17:24:44 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 17:24:44 INFO - u'firefox-50.0a1.en-US.mac.xpcshell.tests.zip']} 17:24:44 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip'] for test suite category: common 17:24:44 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')]} 17:24:44 INFO - https://queue.taskcluster.net/v1/task/A0txUtkLRq67XdDXxuZfGw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 17:24:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A0txUtkLRq67XdDXxuZfGw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 17:24:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A0txUtkLRq67XdDXxuZfGw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 17:24:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A0txUtkLRq67XdDXxuZfGw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip 17:24:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A0txUtkLRq67XdDXxuZfGw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip'}, attempt #1 17:24:45 INFO - Downloaded 18807051 bytes. 17:24:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:24:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 17:24:49 INFO - Return code: 0 17:24:49 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip', u'firefox-50.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 17:24:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:24:49 INFO - https://queue.taskcluster.net/v1/task/A0txUtkLRq67XdDXxuZfGw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 17:24:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A0txUtkLRq67XdDXxuZfGw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 17:24:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A0txUtkLRq67XdDXxuZfGw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 17:24:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A0txUtkLRq67XdDXxuZfGw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip 17:24:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A0txUtkLRq67XdDXxuZfGw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip'}, attempt #1 17:24:50 INFO - Downloaded 18807051 bytes. 17:24:50 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:24:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 17:24:53 INFO - Return code: 0 17:24:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:24:53 INFO - https://queue.taskcluster.net/v1/task/A0txUtkLRq67XdDXxuZfGw/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 17:24:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A0txUtkLRq67XdDXxuZfGw/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 17:24:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A0txUtkLRq67XdDXxuZfGw/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 17:24:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A0txUtkLRq67XdDXxuZfGw/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip 17:24:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A0txUtkLRq67XdDXxuZfGw/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip'}, attempt #1 17:24:54 INFO - Downloaded 14403333 bytes. 17:24:54 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:24:54 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 17:24:55 INFO - Return code: 0 17:24:55 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')]} 17:24:55 INFO - https://queue.taskcluster.net/v1/task/A0txUtkLRq67XdDXxuZfGw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 17:24:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A0txUtkLRq67XdDXxuZfGw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 17:24:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A0txUtkLRq67XdDXxuZfGw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 17:24:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A0txUtkLRq67XdDXxuZfGw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg 17:24:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A0txUtkLRq67XdDXxuZfGw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg'}, attempt #1 17:24:57 INFO - Downloaded 112490487 bytes. 17:24:57 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/A0txUtkLRq67XdDXxuZfGw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 17:24:57 INFO - mkdir: /builds/slave/test/properties 17:24:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:24:57 INFO - Writing to file /builds/slave/test/properties/build_url 17:24:57 INFO - Contents: 17:24:57 INFO - build_url:https://queue.taskcluster.net/v1/task/A0txUtkLRq67XdDXxuZfGw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 17:24:59 INFO - Running post-action listener: _resource_record_post_action 17:24:59 INFO - Running post-action listener: set_extra_try_arguments 17:24:59 INFO - ##### 17:24:59 INFO - ##### Finished download-and-extract step (success) 17:24:59 INFO - ##### 17:24:59 INFO - ##### 17:24:59 INFO - ##### Running populate-webroot step. 17:24:59 INFO - ##### 17:24:59 INFO - Running pre-action listener: _resource_record_pre_action 17:24:59 INFO - Running main action method: populate_webroot 17:24:59 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:24:59 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:24:59 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:24:59 INFO - '--tppagecycles', 17:24:59 INFO - '7'], 17:24:59 INFO - 'tests': ['tsvgm']}}, 17:24:59 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:24:59 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:24:59 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:24:59 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:24:59 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:24:59 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:24:59 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:24:59 INFO - 'talos_options': ['--disable-e10s'], 17:24:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:24:59 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:24:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:24:59 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:24:59 INFO - 'talos_options': ['--disable-e10s'], 17:24:59 INFO - 'tests': ['damp', 'tps']}, 17:24:59 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:24:59 INFO - 'tests': ['damp', 'tps']}, 17:24:59 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:24:59 INFO - 'tests': ['dromaeo_dom']}, 17:24:59 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:24:59 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:24:59 INFO - 'tests': ['basic_compositor_video']}, 17:24:59 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:24:59 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:24:59 INFO - 'tests': ['a11yr', 17:24:59 INFO - 'ts_paint', 17:24:59 INFO - 'tpaint', 17:24:59 INFO - 'sessionrestore', 17:24:59 INFO - 'sessionrestore_no_auto_restore', 17:24:59 INFO - 'tabpaint']}, 17:24:59 INFO - 'other-e10s': {'tests': ['a11yr', 17:24:59 INFO - 'ts_paint', 17:24:59 INFO - 'tpaint', 17:24:59 INFO - 'sessionrestore', 17:24:59 INFO - 'sessionrestore_no_auto_restore', 17:24:59 INFO - 'tabpaint']}, 17:24:59 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:24:59 INFO - 'ts_paint', 17:24:59 INFO - 'tpaint', 17:24:59 INFO - 'sessionrestore', 17:24:59 INFO - 'sessionrestore_no_auto_restore', 17:24:59 INFO - 'tabpaint']}, 17:24:59 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:24:59 INFO - 'ts_paint', 17:24:59 INFO - 'tpaint', 17:24:59 INFO - 'sessionrestore', 17:24:59 INFO - 'sessionrestore_no_auto_restore', 17:24:59 INFO - 'tabpaint']}, 17:24:59 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:24:59 INFO - 'tests': ['a11yr', 17:24:59 INFO - 'ts_paint', 17:24:59 INFO - 'tpaint', 17:24:59 INFO - 'sessionrestore', 17:24:59 INFO - 'sessionrestore_no_auto_restore', 17:24:59 INFO - 'tabpaint']}, 17:24:59 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:24:59 INFO - 'tests': ['a11yr', 17:24:59 INFO - 'ts_paint', 17:24:59 INFO - 'tpaint', 17:24:59 INFO - 'sessionrestore', 17:24:59 INFO - 'sessionrestore_no_auto_restore', 17:24:59 INFO - 'tabpaint']}, 17:24:59 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:24:59 INFO - 'tests': ['tsvgx', 17:24:59 INFO - 'tsvgr_opacity', 17:24:59 INFO - 'tart', 17:24:59 INFO - 'tscrollx', 17:24:59 INFO - 'cart']}, 17:24:59 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:24:59 INFO - 'tsvgr_opacity', 17:24:59 INFO - 'tart', 17:24:59 INFO - 'tscrollx', 17:24:59 INFO - 'cart']}, 17:24:59 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:24:59 INFO - 'talos_options': ['--disable-e10s'], 17:24:59 INFO - 'tests': ['tp5o']}, 17:24:59 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:24:59 INFO - 'tests': ['tp5o']}, 17:24:59 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:24:59 INFO - 'talos_options': ['--disable-e10s', 17:24:59 INFO - '--xperf_path', 17:24:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:24:59 INFO - 'tests': ['tp5n']}, 17:24:59 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:24:59 INFO - 'talos_options': ['--xperf_path', 17:24:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:24:59 INFO - 'tests': ['tp5n']}}, 17:24:59 INFO - 'talos.zip': {'path': '', 17:24:59 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:24:59 INFO - Running post-action listener: _resource_record_post_action 17:24:59 INFO - ##### 17:24:59 INFO - ##### Finished populate-webroot step (success) 17:24:59 INFO - ##### 17:24:59 INFO - ##### 17:24:59 INFO - ##### Running create-virtualenv step. 17:24:59 INFO - ##### 17:24:59 INFO - Running pre-action listener: _resource_record_pre_action 17:24:59 INFO - Running main action method: create_virtualenv 17:24:59 INFO - Creating virtualenv /builds/slave/test/build/venv 17:24:59 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 17:24:59 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:24:59 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:24:59 INFO - Using real prefix '/tools/python27' 17:24:59 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:24:59 INFO - Installing distribute.............................................................................................................................................................................................done. 17:25:02 INFO - Installing pip.................done. 17:25:02 INFO - Return code: 0 17:25:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:25:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:25:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:25:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:25:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:25:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:25:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:25:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x107b6da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c02618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8ca561430>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ad1d30>, '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 0x107836db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107ac9b20>, '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.2hS2oTMDrP/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.LkVDU4qEDd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/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 17:25:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 17:25:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 17:25:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2hS2oTMDrP/Render', 17:25:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:25:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:25:02 INFO - 'HOME': '/Users/cltbld', 17:25:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:25:02 INFO - 'LOGNAME': 'cltbld', 17:25:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:25:02 INFO - 'MOZ_NO_REMOTE': '1', 17:25:02 INFO - 'NO_EM_RESTART': '1', 17:25:02 INFO - 'PAGER': '/bin/cat', 17:25:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:25:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:25:02 INFO - 'PWD': '/builds/slave/test', 17:25:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:25:02 INFO - 'SHELL': '/bin/bash', 17:25:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LkVDU4qEDd/Listeners', 17:25:02 INFO - 'TMPDIR': '/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/', 17:25:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:25:02 INFO - 'USER': 'cltbld', 17:25:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:25:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:25:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:25:02 INFO - 'XPC_FLAGS': '0x0', 17:25:02 INFO - 'XPC_SERVICE_NAME': '0', 17:25:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:25:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:25:03 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 17:25:03 INFO - Cleaning up... 17:25:03 INFO - Return code: 0 17:25:03 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:25:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:25:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:25:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:25:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:25:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:25:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:25:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107b6da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c02618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8ca561430>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ad1d30>, '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 0x107836db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107ac9b20>, '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.2hS2oTMDrP/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.LkVDU4qEDd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/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 17:25:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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>=3.1.1'] in /builds/slave/test/build 17:25:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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>=3.1.1 17:25:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2hS2oTMDrP/Render', 17:25:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:25:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:25:03 INFO - 'HOME': '/Users/cltbld', 17:25:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:25:03 INFO - 'LOGNAME': 'cltbld', 17:25:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:25:03 INFO - 'MOZ_NO_REMOTE': '1', 17:25:03 INFO - 'NO_EM_RESTART': '1', 17:25:03 INFO - 'PAGER': '/bin/cat', 17:25:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:25:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:25:03 INFO - 'PWD': '/builds/slave/test', 17:25:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:25:03 INFO - 'SHELL': '/bin/bash', 17:25:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LkVDU4qEDd/Listeners', 17:25:03 INFO - 'TMPDIR': '/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/', 17:25:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:25:03 INFO - 'USER': 'cltbld', 17:25:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:25:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:25:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:25:03 INFO - 'XPC_FLAGS': '0x0', 17:25:03 INFO - 'XPC_SERVICE_NAME': '0', 17:25:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:25:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:25:03 INFO - Downloading/unpacking psutil>=3.1.1 17:25:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:25:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:25:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:25:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:25:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:25:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:25:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:25:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:25:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:25:06 INFO - Installing collected packages: psutil 17:25:06 INFO - Running setup.py install for psutil 17:25:06 INFO - building 'psutil._psutil_osx' extension 17:25:06 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 17:25:06 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 17:25:06 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 17:25:06 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 17:25:06 INFO - building 'psutil._psutil_posix' extension 17:25:06 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 17:25:06 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 17:25:06 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 17:25:06 INFO - ^ 17:25:06 INFO - 1 warning generated. 17:25:06 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 17:25:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:25:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:25:07 INFO - Successfully installed psutil 17:25:07 INFO - Cleaning up... 17:25:07 INFO - Return code: 0 17:25:07 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:25: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')]} 17:25:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:25:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:25: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')]} 17:25:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:25:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:25:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107b6da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c02618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8ca561430>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ad1d30>, '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 0x107836db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107ac9b20>, '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.2hS2oTMDrP/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.LkVDU4qEDd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/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 17:25:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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.3'] in /builds/slave/test/build 17:25:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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.3 17:25:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2hS2oTMDrP/Render', 17:25:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:25:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:25:07 INFO - 'HOME': '/Users/cltbld', 17:25:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:25:07 INFO - 'LOGNAME': 'cltbld', 17:25:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:25:07 INFO - 'MOZ_NO_REMOTE': '1', 17:25:07 INFO - 'NO_EM_RESTART': '1', 17:25:07 INFO - 'PAGER': '/bin/cat', 17:25:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:25:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:25:07 INFO - 'PWD': '/builds/slave/test', 17:25:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:25:07 INFO - 'SHELL': '/bin/bash', 17:25:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LkVDU4qEDd/Listeners', 17:25:07 INFO - 'TMPDIR': '/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/', 17:25:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:25:07 INFO - 'USER': 'cltbld', 17:25:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:25:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:25:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:25:07 INFO - 'XPC_FLAGS': '0x0', 17:25:07 INFO - 'XPC_SERVICE_NAME': '0', 17:25:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:25:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:25:07 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:25: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 17:25: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 17:25: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 17:25: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 17:25: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 17:25: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 17:25:09 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:25:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:25:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:25:09 INFO - Installing collected packages: mozsystemmonitor 17:25:09 INFO - Running setup.py install for mozsystemmonitor 17:25:09 INFO - Successfully installed mozsystemmonitor 17:25:09 INFO - Cleaning up... 17:25:10 INFO - Return code: 0 17:25:10 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:25:10 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')]} 17:25:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:25:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:25:10 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')]} 17:25:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:25:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:25:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107b6da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c02618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8ca561430>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ad1d30>, '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 0x107836db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107ac9b20>, '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.2hS2oTMDrP/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.LkVDU4qEDd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/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 17:25:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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', 'jsonschema==2.5.1'] in /builds/slave/test/build 17:25:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 jsonschema==2.5.1 17:25:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2hS2oTMDrP/Render', 17:25:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:25:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:25:10 INFO - 'HOME': '/Users/cltbld', 17:25:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:25:10 INFO - 'LOGNAME': 'cltbld', 17:25:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:25:10 INFO - 'MOZ_NO_REMOTE': '1', 17:25:10 INFO - 'NO_EM_RESTART': '1', 17:25:10 INFO - 'PAGER': '/bin/cat', 17:25:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:25:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:25:10 INFO - 'PWD': '/builds/slave/test', 17:25:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:25:10 INFO - 'SHELL': '/bin/bash', 17:25:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LkVDU4qEDd/Listeners', 17:25:10 INFO - 'TMPDIR': '/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/', 17:25:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:25:10 INFO - 'USER': 'cltbld', 17:25:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:25:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:25:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:25:10 INFO - 'XPC_FLAGS': '0x0', 17:25:10 INFO - 'XPC_SERVICE_NAME': '0', 17:25:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:25:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:25:10 INFO - Downloading/unpacking jsonschema==2.5.1 17:25: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 17:25: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 17:25: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 17:25: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 17:25: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 17:25: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 17:25:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:25:12 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:25:12 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 17:25:12 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 17:25:12 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 17:25:12 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 17:25:12 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 17:25:12 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 17:25:13 INFO - Downloading functools32-3.2.3-2.tar.gz 17:25:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:25:13 INFO - warning: no files found matching '*.txt' 17:25:13 INFO - no previously-included directories found matching 'build' 17:25:13 INFO - no previously-included directories found matching 'dist' 17:25:13 INFO - no previously-included directories found matching '.git*' 17:25:13 INFO - Installing collected packages: jsonschema, functools32 17:25:13 INFO - Running setup.py install for functools32 17:25:13 INFO - warning: no files found matching '*.txt' 17:25:13 INFO - no previously-included directories found matching 'build' 17:25:13 INFO - no previously-included directories found matching 'dist' 17:25:13 INFO - no previously-included directories found matching '.git*' 17:25:13 INFO - Successfully installed jsonschema functools32 17:25:13 INFO - Cleaning up... 17:25:13 INFO - Return code: 0 17:25:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:25:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:25:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:25:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:25:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:25:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:25:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:25:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x107b6da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c02618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8ca561430>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ad1d30>, '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 0x107836db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107ac9b20>, '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.2hS2oTMDrP/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.LkVDU4qEDd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/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 17:25:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 17:25:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 17:25:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2hS2oTMDrP/Render', 17:25:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:25:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:25:13 INFO - 'HOME': '/Users/cltbld', 17:25:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:25:13 INFO - 'LOGNAME': 'cltbld', 17:25:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:25:13 INFO - 'MOZ_NO_REMOTE': '1', 17:25:13 INFO - 'NO_EM_RESTART': '1', 17:25:13 INFO - 'PAGER': '/bin/cat', 17:25:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:25:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:25:13 INFO - 'PWD': '/builds/slave/test', 17:25:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:25:13 INFO - 'SHELL': '/bin/bash', 17:25:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LkVDU4qEDd/Listeners', 17:25:13 INFO - 'TMPDIR': '/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/', 17:25:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:25:13 INFO - 'USER': 'cltbld', 17:25:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:25:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:25:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:25:13 INFO - 'XPC_FLAGS': '0x0', 17:25:13 INFO - 'XPC_SERVICE_NAME': '0', 17:25:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:25:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:25:13 INFO - Downloading/unpacking blobuploader==1.2.4 17:25:13 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 17:25:13 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 17:25:13 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 17:25:13 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 17:25:13 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 17:25:13 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 17:25:16 INFO - Downloading blobuploader-1.2.4.tar.gz 17:25:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:25:16 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:25:16 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 17:25:16 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 17:25:16 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 17:25:16 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 17:25:16 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 17:25:16 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 17:25:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:25:17 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:25:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:25:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:25:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:25:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:25:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:25:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:25:17 INFO - Downloading docopt-0.6.1.tar.gz 17:25:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:25:17 INFO - Installing collected packages: blobuploader, requests, docopt 17:25:17 INFO - Running setup.py install for blobuploader 17:25:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:25:17 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:25:17 INFO - Running setup.py install for requests 17:25:18 INFO - Running setup.py install for docopt 17:25:18 INFO - Successfully installed blobuploader requests docopt 17:25:18 INFO - Cleaning up... 17:25:18 INFO - Return code: 0 17:25:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:25:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:25:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:25:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:25:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:25:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:25:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:25:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--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 0x107b6da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c02618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8ca561430>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ad1d30>, '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 0x107836db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107ac9b20>, '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.2hS2oTMDrP/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.LkVDU4qEDd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/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 17:25:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--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 17:25:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --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 17:25:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2hS2oTMDrP/Render', 17:25:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:25:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:25:18 INFO - 'HOME': '/Users/cltbld', 17:25:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:25:18 INFO - 'LOGNAME': 'cltbld', 17:25:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:25:18 INFO - 'MOZ_NO_REMOTE': '1', 17:25:18 INFO - 'NO_EM_RESTART': '1', 17:25:18 INFO - 'PAGER': '/bin/cat', 17:25:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:25:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:25:18 INFO - 'PWD': '/builds/slave/test', 17:25:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:25:18 INFO - 'SHELL': '/bin/bash', 17:25:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LkVDU4qEDd/Listeners', 17:25:18 INFO - 'TMPDIR': '/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/', 17:25:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:25:18 INFO - 'USER': 'cltbld', 17:25:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:25:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:25:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:25:18 INFO - 'XPC_FLAGS': '0x0', 17:25:18 INFO - 'XPC_SERVICE_NAME': '0', 17:25:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:25:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:25:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:25:18 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-yfVve1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:25:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:25:18 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-MTbRai-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:25:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:25:19 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-YGpDFn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:25:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:25:19 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-NSjEvN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:25:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:25:19 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-qVU6GN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:25:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:25:19 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-0shuFb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:25:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:25:19 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-gMxws6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:25:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:25:19 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-EVxvLf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:25:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:25:19 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-ug7LJj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:25:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:25:19 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-LXrEPn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:25:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:25:19 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-0Et5si-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:25:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:25:20 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-IHQsfg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:25:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:25:20 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-FDPDxb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:25:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:25:20 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-ikwY_e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:25:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:25:20 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-dz4qk0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:25:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:25:20 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-gnKpRr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:25:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:25:20 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-e4qD5w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:25:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:25:20 INFO - Running setup.py install for manifestparser 17:25:20 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:25:20 INFO - Running setup.py install for mozcrash 17:25:20 INFO - Running setup.py install for mozdebug 17:25:21 INFO - Running setup.py install for mozdevice 17:25:21 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:25:21 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:25:21 INFO - Running setup.py install for mozfile 17:25:21 INFO - Running setup.py install for mozhttpd 17:25:21 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:25:21 INFO - Running setup.py install for mozinfo 17:25:21 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:25:21 INFO - Running setup.py install for mozInstall 17:25:21 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:25:21 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:25:21 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:25:21 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:25:21 INFO - Running setup.py install for mozleak 17:25:21 INFO - Running setup.py install for mozlog 17:25:22 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:25:22 INFO - Running setup.py install for moznetwork 17:25:22 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:25:22 INFO - Running setup.py install for mozprocess 17:25:22 INFO - Running setup.py install for mozprofile 17:25:22 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:25:22 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:25:22 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:25:22 INFO - Running setup.py install for mozrunner 17:25:22 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:25:22 INFO - Running setup.py install for mozscreenshot 17:25:22 INFO - Running setup.py install for moztest 17:25:23 INFO - Running setup.py install for mozversion 17:25:23 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:25:23 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:25:23 INFO - Cleaning up... 17:25:23 INFO - Return code: 0 17:25:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:25:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:25:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:25:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:25:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:25:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:25:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:25:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x107b6da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c02618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8ca561430>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ad1d30>, '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 0x107836db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107ac9b20>, '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.2hS2oTMDrP/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.LkVDU4qEDd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/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 17:25:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 17:25:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 17:25:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2hS2oTMDrP/Render', 17:25:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:25:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:25:23 INFO - 'HOME': '/Users/cltbld', 17:25:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:25:23 INFO - 'LOGNAME': 'cltbld', 17:25:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:25:23 INFO - 'MOZ_NO_REMOTE': '1', 17:25:23 INFO - 'NO_EM_RESTART': '1', 17:25:23 INFO - 'PAGER': '/bin/cat', 17:25:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:25:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:25:23 INFO - 'PWD': '/builds/slave/test', 17:25:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:25:23 INFO - 'SHELL': '/bin/bash', 17:25:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LkVDU4qEDd/Listeners', 17:25:23 INFO - 'TMPDIR': '/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/', 17:25:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:25:23 INFO - 'USER': 'cltbld', 17:25:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:25:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:25:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:25:23 INFO - 'XPC_FLAGS': '0x0', 17:25:23 INFO - 'XPC_SERVICE_NAME': '0', 17:25:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:25:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:25:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:25:23 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-fzNwCb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:25:23 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)) 17:25:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:25:23 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-kuPLwE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:25:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 17:25:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:25:23 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-itJOjy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:25:23 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)) 17:25:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:25:23 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-XiaQ1z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:25:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 17:25:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:25:23 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-uh7ABk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:25:24 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)) 17:25:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:25:24 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-DcUgLo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:25:24 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)) 17:25:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:25:24 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-ASVD_t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:25:24 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)) 17:25:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:25:24 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-sVTSJe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:25:24 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)) 17:25:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:25:24 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-WTsekn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:25:24 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)) 17:25:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:25:24 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-g9FSJf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:25:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 17:25:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:25:24 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-GgKWnm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:25:24 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)) 17:25:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:25:24 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-3tP_vZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:25:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 17:25:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:25:24 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-NgULMl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:25:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 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)) 17:25:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:25:24 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-nvEHcg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:25:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 17:25:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:25:25 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-FsM3JC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:25:25 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)) 17:25:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:25:25 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-Whr1yY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:25:25 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)) 17:25:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:25:25 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-OCGR6u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:25:25 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)) 17:25:25 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.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:25:25 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.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:25:25 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)) 17:25:25 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:25:25 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:25:25 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:25:25 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 17:25:25 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 17:25:25 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 17:25:25 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 17:25:25 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 17:25:25 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 17:25:27 INFO - Downloading blessings-1.6.tar.gz 17:25:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:25:27 INFO - Installing collected packages: blessings 17:25:27 INFO - Running setup.py install for blessings 17:25:28 INFO - Successfully installed blessings 17:25:28 INFO - Cleaning up... 17:25:28 INFO - Return code: 0 17:25:28 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:25:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:25:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:25:28 INFO - Reading from file tmpfile_stdout 17:25:28 INFO - Current package versions: 17:25:28 INFO - blessings == 1.6 17:25:28 INFO - blobuploader == 1.2.4 17:25:28 INFO - docopt == 0.6.1 17:25:28 INFO - functools32 == 3.2.3-2 17:25:28 INFO - jsonschema == 2.5.1 17:25:28 INFO - manifestparser == 1.1 17:25:28 INFO - mozInstall == 1.12 17:25:28 INFO - mozcrash == 0.17 17:25:28 INFO - mozdebug == 0.1 17:25:28 INFO - mozdevice == 0.48 17:25:28 INFO - mozfile == 1.2 17:25:28 INFO - mozhttpd == 0.7 17:25:28 INFO - mozinfo == 0.9 17:25:28 INFO - mozleak == 0.1 17:25:28 INFO - mozlog == 3.2 17:25:28 INFO - moznetwork == 0.27 17:25:28 INFO - mozprocess == 0.23 17:25:28 INFO - mozprofile == 0.28 17:25:28 INFO - mozrunner == 6.12 17:25:28 INFO - mozscreenshot == 0.1 17:25:28 INFO - mozsystemmonitor == 0.3 17:25:28 INFO - moztest == 0.7 17:25:28 INFO - mozversion == 1.4 17:25:28 INFO - psutil == 3.1.1 17:25:28 INFO - requests == 1.2.3 17:25:28 INFO - wsgiref == 0.1.2 17:25:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:25:28 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')]} 17:25:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:25:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:25:28 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')]} 17:25:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:25:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:25:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x107b6da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c02618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8ca561430>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ad1d30>, '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 0x107836db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107ac9b20>, '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.2hS2oTMDrP/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.LkVDU4qEDd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/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 17:25:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 17:25:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 17:25:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2hS2oTMDrP/Render', 17:25:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:25:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:25:28 INFO - 'HOME': '/Users/cltbld', 17:25:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:25:28 INFO - 'LOGNAME': 'cltbld', 17:25:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:25:28 INFO - 'MOZ_NO_REMOTE': '1', 17:25:28 INFO - 'NO_EM_RESTART': '1', 17:25:28 INFO - 'PAGER': '/bin/cat', 17:25:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:25:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:25:28 INFO - 'PWD': '/builds/slave/test', 17:25:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:25:28 INFO - 'SHELL': '/bin/bash', 17:25:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LkVDU4qEDd/Listeners', 17:25:28 INFO - 'TMPDIR': '/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/', 17:25:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:25:28 INFO - 'USER': 'cltbld', 17:25:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:25:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:25:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:25:28 INFO - 'XPC_FLAGS': '0x0', 17:25:28 INFO - 'XPC_SERVICE_NAME': '0', 17:25:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:25:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:25:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:25:28 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 2)) 17:25:28 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 3)) 17:25:28 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 4)) 17:25:28 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 5)) 17:25:28 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 6)) 17:25:28 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 7)) 17:25:28 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 8)) 17:25:28 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 9)) 17:25:28 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.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:25:28 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 4)) 17:25:28 INFO - Cleaning up... 17:25:28 INFO - Return code: 0 17:25:28 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:25:28 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')]} 17:25:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:25:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:25:28 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')]} 17:25:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:25:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:25:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107b6da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c02618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8ca561430>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ad1d30>, '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 0x107836db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107ac9b20>, '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.2hS2oTMDrP/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.LkVDU4qEDd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/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 17:25:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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', 'jsonschema'] in /builds/slave/test/build 17:25:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 jsonschema 17:25:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2hS2oTMDrP/Render', 17:25:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:25:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:25:28 INFO - 'HOME': '/Users/cltbld', 17:25:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:25:28 INFO - 'LOGNAME': 'cltbld', 17:25:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:25:28 INFO - 'MOZ_NO_REMOTE': '1', 17:25:28 INFO - 'NO_EM_RESTART': '1', 17:25:28 INFO - 'PAGER': '/bin/cat', 17:25:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:25:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:25:28 INFO - 'PWD': '/builds/slave/test', 17:25:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:25:28 INFO - 'SHELL': '/bin/bash', 17:25:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LkVDU4qEDd/Listeners', 17:25:28 INFO - 'TMPDIR': '/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/', 17:25:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:25:28 INFO - 'USER': 'cltbld', 17:25:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:25:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:25:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:25:28 INFO - 'XPC_FLAGS': '0x0', 17:25:28 INFO - 'XPC_SERVICE_NAME': '0', 17:25:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:25:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:25:28 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:25:28 INFO - Cleaning up... 17:25:28 INFO - Return code: 0 17:25:28 INFO - Running post-action listener: _resource_record_post_action 17:25:28 INFO - Running post-action listener: _start_resource_monitoring 17:25:28 INFO - Starting resource monitoring. 17:25:28 INFO - ##### 17:25:28 INFO - ##### Finished create-virtualenv step (success) 17:25:28 INFO - ##### 17:25:28 INFO - ##### 17:25:28 INFO - ##### Running install step. 17:25:28 INFO - ##### 17:25:28 INFO - Running pre-action listener: _resource_record_pre_action 17:25:28 INFO - Running main action method: install 17:25:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:25:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:25:29 INFO - Reading from file tmpfile_stdout 17:25:29 INFO - Detecting whether we're running mozinstall >=1.0... 17:25:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:25:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:25:29 INFO - Reading from file tmpfile_stdout 17:25:29 INFO - Output received: 17:25:29 INFO - Usage: mozinstall [options] installer 17:25:29 INFO - Options: 17:25:29 INFO - -h, --help show this help message and exit 17:25:29 INFO - -d DEST, --destination=DEST 17:25:29 INFO - Directory to install application into. [default: 17:25:29 INFO - "/builds/slave/test"] 17:25:29 INFO - --app=APP Application being installed. [default: firefox] 17:25:29 INFO - mkdir: /builds/slave/test/build/application 17:25:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 17:25:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 17:26:03 INFO - Reading from file tmpfile_stdout 17:26:03 INFO - Output received: 17:26:03 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 17:26:03 INFO - Running post-action listener: _resource_record_post_action 17:26:03 INFO - ##### 17:26:03 INFO - ##### Finished install step (success) 17:26:03 INFO - ##### 17:26:03 INFO - ##### 17:26:03 INFO - ##### Running run-tests step. 17:26:03 INFO - ##### 17:26:03 INFO - Running pre-action listener: _resource_record_pre_action 17:26:03 INFO - Running main action method: run_tests 17:26:03 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:26:03 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:26:03 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:26:03 INFO - 2016-07-08 17:26:03.530 screenresolution[1927:12877] starting screenresolution argv=screenresolution get 17:26:03 INFO - 2016-07-08 17:26:03.533 screenresolution[1927:12877] Display 0: 1600x1200x32@60 17:26:03 INFO - 2016-07-08 17:26:03.538 screenresolution[1928:12879] starting screenresolution argv=screenresolution list 17:26:03 INFO - Available Modes on Display 0 17:26:03 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:26:03 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:26:03 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:26:03 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:26:03 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:26:03 INFO - Intel Iris: 17:26:03 INFO - Chipset Model: Intel Iris 17:26:03 INFO - Type: GPU 17:26:03 INFO - Bus: Built-In 17:26:03 INFO - VRAM (Dynamic, Max): 1536 MB 17:26:03 INFO - Vendor: Intel (0x8086) 17:26:03 INFO - Device ID: 0x0a2e 17:26:03 INFO - Revision ID: 0x0009 17:26:03 INFO - Displays: 17:26:03 INFO - Display: 17:26:03 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:26:03 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:26:03 INFO - Display Serial Number: 1600x1200 60 17:26:03 INFO - Main Display: Yes 17:26:03 INFO - Mirror: Off 17:26:03 INFO - Online: Yes 17:26:03 INFO - Rotation: Supported 17:26:03 INFO - Return code: 0 17:26:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:26:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:26:03 INFO - Python 2.7.3 17:26:03 INFO - Return code: 0 17:26:03 INFO - grabbing minidump binary from tooltool 17:26:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:26:03 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: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ad1d30>, '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 0x107836db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107ac9b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:26:03 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 17:26:03 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 17:26:03 INFO - Calling ['/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'] with output_timeout 600 17:26:03 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:26:03 INFO - Return code: 0 17:26:03 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 17:26:03 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:26:03 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:26:03 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 17:26:03 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:26:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/A0txUtkLRq67XdDXxuZfGw/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0045', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 17:26:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/A0txUtkLRq67XdDXxuZfGw/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0045 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 17:26:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2hS2oTMDrP/Render', 17:26:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:26:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:26:03 INFO - 'HOME': '/Users/cltbld', 17:26:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:26:03 INFO - 'LOGNAME': 'cltbld', 17:26:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:26:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 17:26:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:26:03 INFO - 'MOZ_NO_REMOTE': '1', 17:26:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:26:03 INFO - 'NO_EM_RESTART': '1', 17:26:03 INFO - 'PAGER': '/bin/cat', 17:26:03 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:26:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:26:03 INFO - 'PWD': '/builds/slave/test', 17:26:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:26:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:26:03 INFO - 'SHELL': '/bin/bash', 17:26:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LkVDU4qEDd/Listeners', 17:26:03 INFO - 'TMPDIR': '/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/', 17:26:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:26:03 INFO - 'USER': 'cltbld', 17:26:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:26:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:26:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:26:03 INFO - 'XPC_FLAGS': '0x0', 17:26:03 INFO - 'XPC_SERVICE_NAME': '0', 17:26:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:26:03 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/A0txUtkLRq67XdDXxuZfGw/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0045', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 17:26:04 INFO - mozversion application_buildid: 20160708150326 17:26:04 INFO - mozversion application_changeset: bbb29a9b88dd680dbb59577cbe4dc6e58d117100 17:26:04 INFO - mozversion application_display_name: Nightly 17:26:04 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:26:04 INFO - mozversion application_name: Firefox 17:26:04 INFO - mozversion application_remotingname: firefox 17:26:04 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 17:26:04 INFO - mozversion application_vendor: Mozilla 17:26:04 INFO - mozversion application_version: 50.0a1 17:26:04 INFO - mozversion platform_buildid: 20160708150326 17:26:04 INFO - mozversion platform_changeset: bbb29a9b88dd680dbb59577cbe4dc6e58d117100 17:26:04 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 17:26:04 INFO - mozversion platform_version: 50.0a1 17:26:04 INFO - using testdate: 1468023964 17:26:04 INFO - actual date: 1468023964 17:26:04 INFO - starting webserver on 'localhost:52272' 17:26:04 INFO - SUITE-START | Running 2 tests 17:26:04 INFO - TEST-START | dromaeo_css 17:26:04 INFO - operating with platform_type : mac_ 17:26:04 INFO - Initialising browser for dromaeo_css test... 17:26:04 INFO - TEST-INFO | started process 1938 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/tmp7iWoF8/profile http://localhost:52272/getInfo.html) 17:26:07 INFO - PROCESS | 1938 | __metrics Screen width/height:1600/1200 17:26:07 INFO - PROCESS | 1938 | colorDepth:24 17:26:07 INFO - PROCESS | 1938 | Browser inner width/height: 1024/689 17:26:07 INFO - PROCESS | 1938 | __metrics 17:26:07 ERROR - PROCESS | 1938 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2957: TypeError: this.tabs is undefined 17:26:07 INFO - TEST-INFO | 1938: exit 0 17:26:07 INFO - Browser initialized. 17:26:07 INFO - Running cycle 1/1 for dromaeo_css test... 17:26:07 INFO - TEST-INFO | started process 1941 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/tmp7iWoF8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:26:19 INFO - PROCESS | 1941 | RSS: Main: 254771200 17:26:19 INFO - PROCESS | 1941 | 17:27:09 INFO - PROCESS | 1941 | 1468024029557 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] 17:29:20 INFO - PROCESS | 1941 | Cycle 1(1): loaded http://localhost:52272/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52272/tests/dromaeo/cssquery-ext.html) 17:29:22 INFO - PROCESS | 1941 | RSS: Main: 269041664 17:29:22 INFO - PROCESS | 1941 | 17:32:24 INFO - PROCESS | 1941 | Cycle 1(1): loaded http://localhost:52272/tests/dromaeo/cssquery-ext.html (next: http://localhost:52272/tests/dromaeo/cssquery-jquery.html) 17:32:25 INFO - PROCESS | 1941 | RSS: Main: 277721088 17:32:25 INFO - PROCESS | 1941 | 17:35:26 INFO - PROCESS | 1941 | Cycle 1(1): loaded http://localhost:52272/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52272/tests/dromaeo/cssquery-mootools.html) 17:35:27 INFO - PROCESS | 1941 | RSS: Main: 282083328 17:35:27 INFO - PROCESS | 1941 | 17:38:29 INFO - PROCESS | 1941 | Cycle 1(1): loaded http://localhost:52272/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52272/tests/dromaeo/cssquery-prototype.html) 17:38:30 INFO - PROCESS | 1941 | RSS: Main: 281473024 17:38:30 INFO - PROCESS | 1941 | 17:41:32 INFO - PROCESS | 1941 | Cycle 1(1): loaded http://localhost:52272/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52272/tests/dromaeo/cssquery-yui.html) 17:41:33 INFO - PROCESS | 1941 | RSS: Main: 284602368 17:41:33 INFO - PROCESS | 1941 | 17:44:36 INFO - PROCESS | 1941 | Cycle 1(1): loaded http://localhost:52272/tests/dromaeo/cssquery-yui.html (next: http://localhost:52272/tests/dromaeo/cssquery-dojo.html) 17:44:36 INFO - PROCESS | 1941 | RSS: Main: 285245440 17:44:36 INFO - PROCESS | 1941 | 17:44:36 INFO - PROCESS | 1941 | __start_tp_report 17:44:36 INFO - PROCESS | 1941 | _x_x_mozilla_page_load 17:44:36 INFO - PROCESS | 1941 | _x_x_mozilla_page_load_details 17:44:36 INFO - PROCESS | 1941 | |i|pagename|runs| 17:44:36 INFO - PROCESS | 1941 | |0;dojo.html;3453.930921381574;3457.7406694497904;3469.3234819210247;3476.2873610909764;3491.1970246843225;5879.088741245103;5920.200772895658;5953.374895635955;6004.099385092239;6017.879642407149;5740.5981581289325;5794.333651630064;5930.792422265222;5944.405559444053;6053.031514957607;5289.788408463666;5329.600279978998;5440.129579267318;5452;5504.091824848915;285.01078595864277;4416.829540171857;5096.5922726182;5364.284300138583;5431;5397.298351214356;5399.676019438807;5413.648112872651;5428.131498960148;5486.972565137189;5302.628815982883;5430.945690543083;5445.210444485528;5469.890602187934;5483.451654834525;5307.548858347045;5351.438098999627;5353.170258609883;5360.731963401853;5413.512783849433;4123.525794533637;4696.671233013691;5283.996040752245;5819.447152520504;5956;6256.96871515644;6260.15487909131;6268.09112678659;6301.369863013662;6329.588576742497;6289.716962736642;6360.141380913564;6385.553011289212;6448.871022579522;6450.9677451612915;6117.969410152965;6130.540209484307;6146.723397447081;6147.170132032208;6151.046587778901;4995.425526064549;6309.810705678745;6476.449501792306;6519.152510173647;6547.934520654828;6274.6548939808745;6286.245650521875;6294;6296.401841825019;6302.086197501429;6355.983042713144;6386.265579458422;6410.8717825643225;6417.550771446047;6435.871282574322;6038.215032045894;6144.617461071223;6232.065190221503;6280.623162610258;6335.429811317003;5245.239440281138;5439.292891924025;6070.3929607038945;6245.375462453719;6305.684715764193;5038;5096.617753668415;5106.336176297058;5113.923291150636;5121.8719532012;4510.436195475566;4515.480719717209;4538.546145385435;4553.157665831832;4599.379083823708;5676.403977582377;5984.700764961734;6015.3383127855905;6036.2756469223095;6047.848803779941;6276.027215781562;6364.904526432108;6371.458426033839;6376.202974628171;6390.0734393512685;5891.823245302648;5927.762889484372;5951.047832346891;5986.2517185351835;6024.4879185268865;5573.247611572467;5582.469665381782;5586.91619625706;5589.692566908859;5623.971880140655;6285.308616052322;6447.032945058185;6447.838804029937;6450.161479007699;6473.902891456632;6263.78076767311;6266.592671476339;6315.242170939517;6372.55392122547;6383.106365108795;6457.61254324742;6478.805635830932;6502.967485162544;6512.5766825156215;6522.21733391996;6201.658908760061;6256.530760192913;6298.275698294755;6364.204474440695;6369.33122022181;6316.210473690789;6381.106645069601;6385.584936979081;6406.519511036598;6425.58233714807;6271.560990730787;6293.181886354928;6333.778317758856;6346.143270658402;6355.3644635536075;6143.112737013596;6177.660228687286;6280.591761535486;6339.270983836917;6363.5545511813725;5926.496247818984;6021.187139736079;6102.943731970988;6192.721327540362;6203.8138855834395;6258.655773932295;6291.716872740829;6297.149884765498;6330.715117819617;6340.71466784005;6028.638281703112;6108.419700128481;6111.77406523465;6176.258848938156;6221.440070393686 17:44:36 INFO - PROCESS | 1941 | |1;ext.html;477.41516642113413;515.7266648676201;542.6282996147639;544.8556132624855;557.6765476023907;38896.611033889654;41489.58510414895;41605.58394416055;41616.58383416165;41682.166356672846;42727.93180170497;43195.568044319545;43288.13423731532;43359.56640433602;43400.13199736011;9664.371815831984;9814.411135331868;9856.852147217798;9858.408495490257;9859.704208873709;9726.270529710264;9779.706608801747;9788.36375635585;9796.971318011612;9811.852822207673;9801.754956126118;9806.411615303068;9814.312998090136;9832.115109640132;9838.508074596277;9763.755906102333;9810.509474526316;9825.459599722013;9850.556724947359;9882.407055576616;9641.90358096417;9666.468344241064;9711.125998660083;9741.512924353825;9778.364406313567;40006.799966000275;40185.79907100475;40482;40495.987600309934;40680;3121.7346525545354;3338.0939821749384;3392.3045775616188;3405.4721518164724;3534.469829525566;23358.53282934332;24249.666268355235;25215.73921303946;30219.395612087636;30488.39023219523;2669.3726974161054;3164.556962025318;3165.5884734984534;3246.4967929970894;3273.083536609753;454177;462070;468661;470921;472043;33717.494237586456;33763;33976.49035264473;34039;34073.97778066662;34658.78694245689;35063;35143.94568162959;35859;35897;16822.24299906507;16873.07198104116;17033.318667253418;17071.658566828595;17109.82890171082;12923.095383323265;13056.673583160307;13066.608001759962;13068;13077.476900924046;19473.221071156993;19687.114079866442;19723.901380493007;19740.90129549343;19762.407127786188;8336.62485188168;8337.583120843934;8418.957905210556;8426.199511046441;8529.872051919227;889.7197382824389;930.8976012638605;987.5950860147306;1055.944055944056;1068.9893101069044;24614.384640384134;30841;30865.228369290948;31486.527702084488;31638.683613163576;942.6229508196639;1023.2530252915413;1123.8370436286693;1139.4758411130806;1236.4992178167856;15012.849871501145;16001.519954401387;16097.79266555013;16360.918195409186;16645.91677041607;685957;706239;706494;708066;711769;60423;60955.39044609497;61081.69459152676;61108;61146;1380.8895288376905;1390.318743815523;1394.8326200855963;1452.106954223145;1455.5778824141091;24693.753062469863;26105.608415873397;30451.934182303514;30928.0721578353;30933.381332373676;49995;50135.49864501308;51374.22938655998;51516;51813;595551;598249;598648;598744;601058;26413.735862641126;26907.443792839647;27573.172804815888;27589.44821103607;27633.171004869888;49524.75237623789;49951.75024124856;49991.75004124956;50055.249171261734;51148;33600.99197024093;41036.38445423261;41597.79201103975;42389.78805105955;42408.78795606126;41003.1799364017;41452.58547414487;41501.58498414977;42178.578214217465;42284;39323.803380984056;39459.60540394559;39568.80215598903;40118.799406002785;40312.19375612413;34024.65975340215;34560;35297.823510882285;36131.458028130124;36201.818990904874;23144.3056708299;25351.985920563708;26415.603765943142;26714.866425667748;27065.531299381542 17:44:36 INFO - PROCESS | 1941 | |2;jquery.html;382.51802728562006;384.69224620303766;386.5573917864046;398.43820213498935;406.69091490467235;17733.379331723394;18950.526236844085;20647.483812904647;21758.238461653826;22323.553528929413;10284.485775711204;12004.879951200486;12289.938550307235;12438.25370477772;20214.89892550539;5396.64921780084;5641.548676105902;5642.943570564304;5650.74571644277;5654.208410822488;3982.701297402692;5909.290885093795;6206.689665516728;6237;6243.313235544087;6140.293866205398;6143.662098584576;6228.065790131472;6233.50131989442;6237.781677641284;6036.215292012011;6206.906896396557;6224;6231.40801623845;6250.218722659668;5828.892510423006;6047.334793172748;6050.396644889108;6065.02959526478;6068.726907289182;13661.863381366158;13680.52118175869;13750.243736594482;21176.788232117637;25540.23379298624;2255.492514184312;2346.7183937927557;2464.963025554618;2653.257088015359;2740.780737541012;10214.387136771817;10297.17622590191;10307.381557106597;10308.381497110197;10462.372257664565;1803.6212395396983;1847.3349594146096;1866.6360059788346;1875.3342563389936;1875.5967466994525;101818.98181018169;107469;110933.44533277363;112711;113146.99999999917;11610.825837612443;11757.118216133824;11764.58823941175;11765.470553825098;11772.50181735472;12065;14508;14635.92682036583;14652.340644671016;14678.339474723449;7136.822424300036;8668.349873759367;8809.603567839462;8860.734177974671;8880.51157186348;8764.78088047804;8792.47245165292;8821.867671984797;8890.377673562918;8908.06465321145;4036.6770658347264;4142.565030671796;4497.730136191839;4662.906741865144;4696.60078893291;1667.5820060911726;1702.0213377308098;1838.7637757546547;1910.3982245592595;1970.2119152339178;873.4715497124275;875.3916028360355;886.5212785095976;988.906053924876;998.9300748947504;21452;21786.455338616346;21793.891030544746;22019.66970495444;22137.557248854933;989;990.9504524773732;998.6554638649654;1011.5903059261011;1039.6880935719405;11176.050035747052;11424.42877856104;12286.75426491465;12491.750164996649;12556.431173768393;505053.47473263135;602670;621471;625651;635245;105200;110368;143309.28345358206;144181.27909360596;144473.27763361117;920.8388532006738;1047.779966207105;1057.9153667706564;1085.484394912426;1087.331291255872;13763.518276860263;19703;20428.97855107209;20485.38543843687;20791.272305469236;43080;45557.54442455533;58324.70837645785;59432.70283648554;63324.36675633369;82374.58812705897;82420.58789706013;83787.5810620943;87354.32196907434;89370.10629893618;8409.2431681149;8570.571471426529;8628.870566941376;8685.91314086851;8761;10148.492575371054;13838;13938.024338296222;13968.790468142783;13977.720445591234;10186.777586689645;10726.356418614909;11879.287242765462;12022.27866328023;12061.396930153633;11830.645080647595;11850.940745296219;11912.52349905994;11924.463399146885;11943.104267179822;11820.468078936297;11858.110641701734;12025.158238923192;12115.273083615011;12221.388930553614;8383.455075420079;8445.239928406472;8523.74428767138;8560.785980350292;8602.526861022703;11463.254888432226;11665.416729163677;11943.701407464883;11988.640340789441;11994.980426663831 17:44:36 INFO - PROCESS | 1941 | |3;mootools.html;1471.4702707025472;1558.6415124521363;1812.8549716022712;1914.7989461106592;1920.6350793349272;8238.423310368276;8861.822763544742;8864.46813191209;9323.114304141096;9355.625774969001;9003.774905627346;9010.324225683067;9051.547422628859;9212.078792120785;9218.631254749802;2340.3914982104648;2364.4443555764383;2369.6563998220336;2371.336025912747;2379.0602711928777;2308.2498188088853;2352.294311706481;2355.1286024170995;2377.583922813509;2400.111958575321;2355.9764402356013;2367.4673198530277;2374.7625237476286;2385.6063749481314;2389.474315650554;2293.472501324705;2347.9882600586975;2349.5535848188874;2365.2667673021333;2368.4078980254935;2336.2640768157976;2343.5195784864063;2358.7287461941924;2359.988200059006;2360.067773229565;9089.500077495735;9136.360454768168;9270.351075424724;9346.953265233631;9353.298502612332;5341.519263266325;5465.316835395575;5468.945310546884;5481.397046324901;5506.311711036121;3553.8223088845452;3664.871729489482;3696.815159242054;3711.2763011212824;3712.1276500022473;1091.1870656360982;1092.2463500184847;1099.5107177306102;1101.8181999970075;1106.181425744951;11638.37062811207;11797.351145686984;11816.231944923638;11885.643430697093;11900.702482438008;4450.06548624786;4451.643868490513;4548.704334218265;4596.253423698973;4614.515475875052;9021.052789457144;9350;9351.158395744416;9352;9375.437473751597;5237.633365664443;5258.868528286747;5271.103912334912;5291.444398338119;5318.335208098988;3883.6310550497656;4010.7593544387432;4026.174634199982;4859.70841749489;4955.132851750929;3325.3040949116125;3772.9434058489146;3828;3891.5524714658177;3909.100906791397;983.5180761426992;1180.7166280092888;1186.371223251678;1188.364225139546;1188.9405529723479;734.8162959260185;863.408565132886;876.0319846569449;921.7234829551242;955.5652178258875;6159.5072394208355;6218.471429928416;6317.399847014526;6331.588446750947;6339.080833279241;952.9380590261611;1004;1014.518103900656;1025.4718819807806;1034.6740776655329;4118.691098167649;4229.344451610005;4241.851535196253;4274.059706864485;4319.6112349888035;10831.83752243717;11316.490757915913;11418.771624567627;11426.25729327591;11459.541618335174;9719.31964762474;11248.381339026268;11308.378039207922;11361.943190283995;11407.25852819564;8066;8105.27052565272;8447.155284471504;8488.405811593253;8617.793508908759;5951.55363347742;6055.2430946131735;6213.285472170758;6356.237251529846;6446.67766611677;10197.745056373353;10327.018933201334;10399.32404393712;10425.165986721197;10465.895341046493;10524.526396312338;10646.680599581716;10671.199660025373;10704.678859634223;10736.516856741622;7776.92223077762;7803.765887023398;7819.178986206366;7838.764837054898;7919;8520.531370774666;8525.87211191845;8603.354748393771;8616.569171541523;8625.309975202093;7565.554662580135;7664.923350766421;7701.537907725555;7815.218478152139;7853.1361550228285;7580.54516728998;7700.730474433368;7710.575918324546;7821.178776228414;7828.2954534092205;7259.6007219603425;7278.053852999288;7285.307895749896;7325.120985481776;7339.59632220233;5151.25306830515;5259.605529585373;5270.446603106772;5311.389190243017;5330.466953304638;5225.399079105951;5282.630215884851;5325.653832500875;5440.347158341025;5467.753951072132 17:44:36 INFO - PROCESS | 1941 | |4;prototype.html;301.2003131685375;307.72766101999724;310.469097842689;320.63287535771525;322.8918312365359;4649.535046495357;5535.778568857241;5671.546276297897;5767.90409822134;5798.739056742441;5158.535731784139;5650.576206784487;5674.460926212014;5678.261825962619;5684.886302273952;4339.956600434002;4342.3052311630145;4346.15250026245;4346.521882592912;4367.497737760151;3420.4698271767916;4120.25835349637;4346.826126954918;4383.013821890065;4447.88880277994;4273.358996150587;4292.785360731951;4299.355096735483;4328.242557552416;4335.544767799383;3771.076086358832;3813.294540510001;4136.400221967813;4321.222180007598;4367.6069153776;3726.1122629961724;3734.9439758403373;3739.700823934079;3740.831662575191;3754.2303827715527;4441.622462090726;4525.86422407325;4896.706197628154;5494.313210848644;5590.217369568264;4840.661153719241;4853.417589889236;4903.166461701484;4925.827596034157;4935;5464.333378319611;5670.152020022903;5789.710514474259;5949.345571987078;6016.1878146450545;3551.3252482028333;3677.9080522986874;3912.197999410114;4025.174839157995;4045.1505183911413;5536.4186760389985;5625.6905870177125;6267.467265282411;6310.495160387158;6325.240971083454;3574.12433953683;3731.7014638829373;3933.6263055009726;4000.7999600020466;4115.629593336614;4071.002604361891;4111.568285330057;4115.604626183411;4134.937975930364;4135.255653982312;4803.78382972767;4860.222364421676;4902.313676085351;4914.852554423373;4932.753362331869;4955.240889484253;5373.247745315659;5736.6844823534275;5871.324797648325;6073.08903664445;1338.6118025772416;1365.9823431543366;1442.5672298310465;1460.2990564529086;1468.5153899213446;783.4046124945082;790.9361908233417;882.4440602420434;903.4759839293325;911.4531281231341;4083.571225021389;4645.396098507173;4700.929486057712;4723.433188017391;4728.574428301469;4627.375304333872;4701.48283688794;4756.6908150970075;5153.1497302945345;5267.313670028237;3866.8646597368956;4164.66682665386;4215.894602634898;4242.639375653042;4255;2839.758620517238;3029.591005214268;3336.2660214752714;3336.716379107803;3343.983280083584;6414.1340918976275;6526.28210896801;6529.869402611921;6541.313162118005;6546.214454265519;6108.938910610926;6406.6476343800605;6408.263049749338;6432.87715054031;6447.002858227835;5602.691851948182;5847.06446968483;6430.495380017902;6480;6518.57629254097;5079.644424890223;5927.251460818982;6251.374862513712;6272.717727702173;6301.149344838572;5760.638138363251;5922.940770592411;6167.814965551041;6179.84550386244;6208.751649934133;5273.871848083938;5532.395605274425;6525.282218956006;6567.737290508518;6644.783844681901;3593.6765691087926;3596.9820150899077;3917.823697933543;4073.0021144819707;4113.8971525712095;5308.548773354308;5338.839834804962;5857.238558987305;6103.755849765959;6113.5414843886;5503.367112781922;5600.991821472011;5763.827085187451;6039.849003774941;6152.415520525543;6021.458068773832;6064.757409703562;6067.878642427038;6145.784897528565;6152;5134.075866343945;5699.34457537372;5866.2960444745195;5942.346341902301;5988.910166347421;5668.348139963792;6023;6029.487493563096;6093.811706717148;6123.326434092335;5708.57185711065;5886.881492516408;5898.793542226002;5905.604277540346;5920.319163296276 17:44:36 INFO - PROCESS | 1941 | |5;yui.html;695.3880585085125;696.3489137656288;794.2176955698636;810.2383759266286;837.0666706622114;15190.848091519081;15809.683806323896;15963.521094367188;15974;16053.03681779094;14461.421543138262;14510.201938893357;14539.200343981076;14554.636134096652;14615.488457903975;707.476467414115;890.8351954888367;899.9370044096916;924.96300147994;935.6210734652443;910.658503061352;912.0423555266976;917.6925729880498;919.8114386550775;922.4465320807495;941.4022095969075;974.4494360686225;977.8728765260541;981.6171693039685;981.9312648114635;956.4978386347154;958.2525630008604;969.2585172343163;969.5733877094056;971.6113554578154;713.0089176045301;722.461765984345;727.3054233207274;729.6096588325273;730.0946825935802;14791.038582492103;14921.850781492154;15164.165970871598;15202.391904323813;15238.314275857501;14818.110913345234;14986.775198372034;15003.549893503212;15050.623734406618;15109.773353399707;11980.28118312904;12204.206726562745;12311.322877241837;12441.253524788452;12500.24998500093;3794.90512737181;3801.459506623286;3994.6205110514456;4011.538673052607;4015.738976966517;75475;111656;113050.43474782574;113804.4309778454;113970;11309;11378.43107844621;11446.37044962535;11561.653150405502;11700.180987330976;23320.416989575395;23389.298321050395;23726.762732372456;24027.038918443068;24052.27843164708;8225.71210007659;8379.70671026511;8451.11263317355;8500.787480313042;8605.354598405145;3447.6552344765823;4556.248219043887;4619.376384188092;4641.164590373698;4670.836520721827;3609.873654422083;3733.6079711629886;3736.23407201523;3736.3087828751222;3745.6254374562873;603.9969800150972;669.5146019136088;685.1059367525328;689.9103116594811;694.3056943056943;605.479287812481;637.8373514753708;667.5360624366019;701.7964790210782;702.8570295616277;9336.953315233517;9339.859902101474;9342.2526197904;9470.195033422098;9604.95197524022;626.9843253918598;633.7750098714982;665.9667016649148;681.8806708826035;692.536000879412;4284.94376635573;4395.7362558246605;4453.599176074104;4614.515475875052;4625.213713668684;150768.2461587685;151490.24254878654;151620;151740;154174;122941.38529307296;124758.37620811838;129914.05128923073;131316;134321.32839335935;105536.47231763946;106443.93556064495;106480.46759766151;106825;108461;8253.587320634064;8860;8880.600372983103;9020.861490277417;9035.683751068682;62186.68906655619;62814.37185628085;63021;63395.46418143407;64347.71304573789;93151;95395.52302238444;97617.02382976079;97658.51170744385;97938;11853.170278080452;11931.522739090338;12105;12270.570530031406;12524.311162886128;13195.67010824737;13236.87486563653;13278.203307801563;13321;13747.793783093462;11997.040236781211;12026.458809353426;12203.938980305042;12445.377731113227;12532.812007819708;10834.566617335218;11430.685471170922;12186.329751863732;12379.257244565355;12660.936695316464;11849.881501184878;11990.820137697767;12013.75972480528;12025.2567153354;12036.398180091135;10146.898531014594;10170.57611934315;10285.177185825265;10366.688999330032;10859.2398532102;9343.672971445967;9615.23078153732;9777.168940640126;10287.022732840369;10376.118094706831 17:44:36 INFO - PROCESS | 1941 | __end_tp_report 17:44:36 INFO - PROCESS | 1941 | __start_cc_report 17:44:36 INFO - PROCESS | 1941 | _x_x_mozilla_cycle_collect,441 17:44:36 INFO - PROCESS | 1941 | __end_cc_report 17:44:36 INFO - PROCESS | 1941 | __startTimestamp1468025076304__endTimestamp 17:44:36 INFO - PROCESS | 1941 | 17:44:36 INFO - PROCESS | 1941 | ------- Summary: start ------- 17:44:36 INFO - PROCESS | 1941 | Number of tests: 6 17:44:36 INFO - PROCESS | 1941 | 17:44:36 INFO - PROCESS | 1941 | [#0] dojo.html Cycles:165 Average:5832.62 Median:6130.54 stddev:798.93 (13.0%) stddev-sans-first:779.28 17:44:36 INFO - PROCESS | 1941 | Values: 3453.9 3457.7 3469.3 3476.3 3491.2 5879.1 5920.2 5953.4 6004.1 6017.9 5740.6 5794.3 5930.8 5944.4 6053.0 5289.8 5329.6 5440.1 5452.0 5504.1 285.0 4416.8 5096.6 5364.3 5431.0 5397.3 5399.7 5413.6 5428.1 5487.0 5302.6 5430.9 5445.2 5469.9 5483.5 5307.5 5351.4 5353.2 5360.7 5413.5 4123.5 4696.7 5284.0 5819.4 5956.0 6257.0 6260.2 6268.1 6301.4 6329.6 6289.7 6360.1 6385.6 6448.9 6451.0 6118.0 6130.5 6146.7 6147.2 6151.0 4995.4 6309.8 6476.4 6519.2 6547.9 6274.7 6286.2 6294.0 6296.4 6302.1 6356.0 6386.3 6410.9 6417.6 6435.9 6038.2 6144.6 6232.1 6280.6 6335.4 5245.2 5439.3 6070.4 6245.4 6305.7 5038.0 5096.6 5106.3 5113.9 5121.9 4510.4 4515.5 4538.5 4553.2 4599.4 5676.4 5984.7 6015.3 6036.3 6047.8 6276.0 6364.9 6371.5 6376.2 6390.1 5891.8 5927.8 5951.0 5986.3 6024.5 5573.2 5582.5 5586.9 5589.7 5624.0 6285.3 6447.0 6447.8 6450.2 6473.9 6263.8 6266.6 6315.2 6372.6 6383.1 6457.6 6478.8 6503.0 6512.6 6522.2 6201.7 6256.5 6298.3 6364.2 6369.3 6316.2 6381.1 6385.6 6406.5 6425.6 6271.6 6293.2 6333.8 6346.1 6355.4 6143.1 6177.7 6280.6 6339.3 6363.6 5926.5 6021.2 6102.9 6192.7 6203.8 6258.7 6291.7 6297.1 6330.7 6340.7 6028.6 6108.4 6111.8 6176.3 6221.4 17:44:36 INFO - PROCESS | 1941 | 17:44:36 INFO - PROCESS | 1941 | [#1] ext.html Cycles:180 Average:70896.25 Median:40488.99 stddev:160081.66 (395.4%) stddev-sans-first:160443.42 17:44:36 INFO - PROCESS | 1941 | Values: 477.4 515.7 542.6 544.9 557.7 38896.6 41489.6 41605.6 41616.6 41682.2 42727.9 43195.6 43288.1 43359.6 43400.1 9664.4 9814.4 9856.9 9858.4 9859.7 9726.3 9779.7 9788.4 9797.0 9811.9 9801.8 9806.4 9814.3 9832.1 9838.5 9763.8 9810.5 9825.5 9850.6 9882.4 9641.9 9666.5 9711.1 9741.5 9778.4 40006.8 40185.8 40482.0 40496.0 40680.0 3121.7 3338.1 3392.3 3405.5 3534.5 23358.5 24249.7 25215.7 30219.4 30488.4 2669.4 3164.6 3165.6 3246.5 3273.1 454177.0 462070.0 468661.0 470921.0 472043.0 33717.5 33763.0 33976.5 34039.0 34074.0 34658.8 35063.0 35143.9 35859.0 35897.0 16822.2 16873.1 17033.3 17071.7 17109.8 12923.1 13056.7 13066.6 13068.0 13077.5 19473.2 19687.1 19723.9 19740.9 19762.4 8336.6 8337.6 8419.0 8426.2 8529.9 889.7 930.9 987.6 1055.9 1069.0 24614.4 30841.0 30865.2 31486.5 31638.7 942.6 1023.3 1123.8 1139.5 1236.5 15012.8 16001.5 16097.8 16360.9 16645.9 685957.0 706239.0 706494.0 708066.0 711769.0 60423.0 60955.4 61081.7 61108.0 61146.0 1380.9 1390.3 1394.8 1452.1 1455.6 24693.8 26105.6 30451.9 30928.1 30933.4 49995.0 50135.5 51374.2 51516.0 51813.0 595551.0 598249.0 598648.0 598744.0 601058.0 26413.7 26907.4 27573.2 27589.4 27633.2 49524.8 49951.8 49991.8 50055.2 51148.0 33601.0 41036.4 41597.8 42389.8 42408.8 41003.2 41452.6 41501.6 42178.6 42284.0 39323.8 39459.6 39568.8 40118.8 40312.2 34024.7 34560.0 35297.8 36131.5 36201.8 23144.3 25352.0 26415.6 26714.9 27065.5 17:44:36 INFO - PROCESS | 1941 | 17:44:36 INFO - PROCESS | 1941 | [#2] jquery.html Cycles:180 Average:34843.97 Median:21790.17 stddev:100147.90 (459.6%) stddev-sans-first:100395.41 17:44:36 INFO - PROCESS | 1941 | Values: 382.5 384.7 386.6 398.4 406.7 17733.4 18950.5 20647.5 21758.2 22323.6 10284.5 12004.9 12289.9 12438.3 20214.9 5396.6 5641.5 5642.9 5650.7 5654.2 3982.7 5909.3 6206.7 6237.0 6243.3 6140.3 6143.7 6228.1 6233.5 6237.8 6036.2 6206.9 6224.0 6231.4 6250.2 5828.9 6047.3 6050.4 6065.0 6068.7 13661.9 13680.5 13750.2 21176.8 25540.2 2255.5 2346.7 2465.0 2653.3 2740.8 10214.4 10297.2 10307.4 10308.4 10462.4 1803.6 1847.3 1866.6 1875.3 1875.6 101819.0 107469.0 110933.4 112711.0 113147.0 11610.8 11757.1 11764.6 11765.5 11772.5 12065.0 14508.0 14635.9 14652.3 14678.3 7136.8 8668.3 8809.6 8860.7 8880.5 8764.8 8792.5 8821.9 8890.4 8908.1 4036.7 4142.6 4497.7 4662.9 4696.6 1667.6 1702.0 1838.8 1910.4 1970.2 873.5 875.4 886.5 988.9 998.9 21452.0 21786.5 21793.9 22019.7 22137.6 989.0 991.0 998.7 1011.6 1039.7 11176.1 11424.4 12286.8 12491.8 12556.4 505053.5 602670.0 621471.0 625651.0 635245.0 105200.0 110368.0 143309.3 144181.3 144473.3 920.8 1047.8 1057.9 1085.5 1087.3 13763.5 19703.0 20429.0 20485.4 20791.3 43080.0 45557.5 58324.7 59432.7 63324.4 82374.6 82420.6 83787.6 87354.3 89370.1 8409.2 8570.6 8628.9 8685.9 8761.0 10148.5 13838.0 13938.0 13968.8 13977.7 10186.8 10726.4 11879.3 12022.3 12061.4 11830.6 11850.9 11912.5 11924.5 11943.1 11820.5 11858.1 12025.2 12115.3 12221.4 8383.5 8445.2 8523.7 8560.8 8602.5 11463.3 11665.4 11943.7 11988.6 11995.0 17:44:36 INFO - PROCESS | 1941 | 17:44:36 INFO - PROCESS | 1941 | [#3] mootools.html Cycles:180 Average:5866.22 Median:4907.42 stddev:3319.17 (67.6%) stddev-sans-first:3312.05 17:44:36 INFO - PROCESS | 1941 | Values: 1471.5 1558.6 1812.9 1914.8 1920.6 8238.4 8861.8 8864.5 9323.1 9355.6 9003.8 9010.3 9051.5 9212.1 9218.6 2340.4 2364.4 2369.7 2371.3 2379.1 2308.2 2352.3 2355.1 2377.6 2400.1 2356.0 2367.5 2374.8 2385.6 2389.5 2293.5 2348.0 2349.6 2365.3 2368.4 2336.3 2343.5 2358.7 2360.0 2360.1 9089.5 9136.4 9270.4 9347.0 9353.3 5341.5 5465.3 5468.9 5481.4 5506.3 3553.8 3664.9 3696.8 3711.3 3712.1 1091.2 1092.2 1099.5 1101.8 1106.2 11638.4 11797.4 11816.2 11885.6 11900.7 4450.1 4451.6 4548.7 4596.3 4614.5 9021.1 9350.0 9351.2 9352.0 9375.4 5237.6 5258.9 5271.1 5291.4 5318.3 3883.6 4010.8 4026.2 4859.7 4955.1 3325.3 3772.9 3828.0 3891.6 3909.1 983.5 1180.7 1186.4 1188.4 1188.9 734.8 863.4 876.0 921.7 955.6 6159.5 6218.5 6317.4 6331.6 6339.1 952.9 1004.0 1014.5 1025.5 1034.7 4118.7 4229.3 4241.9 4274.1 4319.6 10831.8 11316.5 11418.8 11426.3 11459.5 9719.3 11248.4 11308.4 11361.9 11407.3 8066.0 8105.3 8447.2 8488.4 8617.8 5951.6 6055.2 6213.3 6356.2 6446.7 10197.7 10327.0 10399.3 10425.2 10465.9 10524.5 10646.7 10671.2 10704.7 10736.5 7776.9 7803.8 7819.2 7838.8 7919.0 8520.5 8525.9 8603.4 8616.6 8625.3 7565.6 7664.9 7701.5 7815.2 7853.1 7580.5 7700.7 7710.6 7821.2 7828.3 7259.6 7278.1 7285.3 7325.1 7339.6 5151.3 5259.6 5270.4 5311.4 5330.5 5225.4 5282.6 5325.7 5440.3 5467.8 17:44:36 INFO - PROCESS | 1941 | 17:44:36 INFO - PROCESS | 1941 | [#4] prototype.html Cycles:180 Average:4758.29 Median:5155.84 stddev:1507.00 (29.2%) stddev-sans-first:1473.63 17:44:36 INFO - PROCESS | 1941 | Values: 301.2 307.7 310.5 320.6 322.9 4649.5 5535.8 5671.5 5767.9 5798.7 5158.5 5650.6 5674.5 5678.3 5684.9 4340.0 4342.3 4346.2 4346.5 4367.5 3420.5 4120.3 4346.8 4383.0 4447.9 4273.4 4292.8 4299.4 4328.2 4335.5 3771.1 3813.3 4136.4 4321.2 4367.6 3726.1 3734.9 3739.7 3740.8 3754.2 4441.6 4525.9 4896.7 5494.3 5590.2 4840.7 4853.4 4903.2 4925.8 4935.0 5464.3 5670.2 5789.7 5949.3 6016.2 3551.3 3677.9 3912.2 4025.2 4045.2 5536.4 5625.7 6267.5 6310.5 6325.2 3574.1 3731.7 3933.6 4000.8 4115.6 4071.0 4111.6 4115.6 4134.9 4135.3 4803.8 4860.2 4902.3 4914.9 4932.8 4955.2 5373.2 5736.7 5871.3 6073.1 1338.6 1366.0 1442.6 1460.3 1468.5 783.4 790.9 882.4 903.5 911.5 4083.6 4645.4 4700.9 4723.4 4728.6 4627.4 4701.5 4756.7 5153.1 5267.3 3866.9 4164.7 4215.9 4242.6 4255.0 2839.8 3029.6 3336.3 3336.7 3344.0 6414.1 6526.3 6529.9 6541.3 6546.2 6108.9 6406.6 6408.3 6432.9 6447.0 5602.7 5847.1 6430.5 6480.0 6518.6 5079.6 5927.3 6251.4 6272.7 6301.1 5760.6 5922.9 6167.8 6179.8 6208.8 5273.9 5532.4 6525.3 6567.7 6644.8 3593.7 3597.0 3917.8 4073.0 4113.9 5308.5 5338.8 5857.2 6103.8 6113.5 5503.4 5601.0 5763.8 6039.8 6152.4 6021.5 6064.8 6067.9 6145.8 6152.0 5134.1 5699.3 5866.3 5942.3 5988.9 5668.3 6023.0 6029.5 6093.8 6123.3 5708.6 5886.9 5898.8 5905.6 5920.3 17:44:36 INFO - PROCESS | 1941 | 17:44:36 INFO - PROCESS | 1941 | [#5] yui.html Cycles:180 Average:24792.89 Median:3740.97 stddev:39768.18 (1063.0%) stddev-sans-first:39838.58 17:44:36 INFO - PROCESS | 1941 | Values: 695.4 696.3 794.2 810.2 837.1 15190.8 15809.7 15963.5 15974.0 16053.0 14461.4 14510.2 14539.2 14554.6 14615.5 707.5 890.8 899.9 925.0 935.6 910.7 912.0 917.7 919.8 922.4 941.4 974.4 977.9 981.6 981.9 956.5 958.3 969.3 969.6 971.6 713.0 722.5 727.3 729.6 730.1 14791.0 14921.9 15164.2 15202.4 15238.3 14818.1 14986.8 15003.5 15050.6 15109.8 11980.3 12204.2 12311.3 12441.3 12500.2 3794.9 3801.5 3994.6 4011.5 4015.7 75475.0 111656.0 113050.4 113804.4 113970.0 11309.0 11378.4 11446.4 11561.7 11700.2 23320.4 23389.3 23726.8 24027.0 24052.3 8225.7 8379.7 8451.1 8500.8 8605.4 3447.7 4556.2 4619.4 4641.2 4670.8 3609.9 3733.6 3736.2 3736.3 3745.6 604.0 669.5 685.1 689.9 694.3 605.5 637.8 667.5 701.8 702.9 9337.0 9339.9 9342.3 9470.2 9605.0 627.0 633.8 666.0 681.9 692.5 4284.9 4395.7 4453.6 4614.5 4625.2 150768.2 151490.2 151620.0 151740.0 154174.0 122941.4 124758.4 129914.1 131316.0 134321.3 105536.5 106443.9 106480.5 106825.0 108461.0 8253.6 8860.0 8880.6 9020.9 9035.7 62186.7 62814.4 63021.0 63395.5 64347.7 93151.0 95395.5 97617.0 97658.5 97938.0 11853.2 11931.5 12105.0 12270.6 12524.3 13195.7 13236.9 13278.2 13321.0 13747.8 11997.0 12026.5 12203.9 12445.4 12532.8 10834.6 11430.7 12186.3 12379.3 12660.9 11849.9 11990.8 12013.8 12025.3 12036.4 10146.9 10170.6 10285.2 10366.7 10859.2 9343.7 9615.2 9777.2 10287.0 10376.1 17:44:36 INFO - PROCESS | 1941 | -------- Summary: end -------- 17:44:36 INFO - PROCESS | 1941 | 17:44:36 INFO - TEST-INFO | 1941: exit 0 17:44:36 INFO - TEST-OK | dromaeo_css | took 1112780ms 17:44:36 INFO - TEST-START | kraken 17:44:36 INFO - operating with platform_type : mac_ 17:44:36 INFO - Initialising browser for kraken test... 17:44:36 INFO - TEST-INFO | started process 1949 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/tmpqTbRtA/profile http://localhost:52272/getInfo.html) 17:44:39 INFO - PROCESS | 1949 | __metrics Screen width/height:1600/1200 17:44:39 INFO - PROCESS | 1949 | colorDepth:24 17:44:39 INFO - PROCESS | 1949 | Browser inner width/height: 1024/689 17:44:39 INFO - PROCESS | 1949 | __metrics 17:44:39 ERROR - PROCESS | 1949 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2957: TypeError: this.tabs is undefined 17:44:40 INFO - TEST-INFO | 1949: exit 0 17:44:40 INFO - Browser initialized. 17:44:40 INFO - Running cycle 1/1 for kraken test... 17:44:40 INFO - TEST-INFO | started process 1951 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/tmpqTbRtA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:44:52 INFO - PROCESS | 1951 | RSS: Main: 254746624 17:44:52 INFO - PROCESS | 1951 | 17:44:55 INFO - PROCESS | 1951 | Cycle 1(1): loaded http://localhost:52272/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52272/tests/kraken/driver.html?testName=audio-beat-detection) 17:44:56 INFO - PROCESS | 1951 | RSS: Main: 267345920 17:44:56 INFO - PROCESS | 1951 | 17:44:58 INFO - PROCESS | 1951 | Cycle 1(1): loaded http://localhost:52272/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52272/tests/kraken/driver.html?testName=audio-dft) 17:44:59 INFO - PROCESS | 1951 | RSS: Main: 271368192 17:44:59 INFO - PROCESS | 1951 | 17:45:02 INFO - PROCESS | 1951 | Cycle 1(1): loaded http://localhost:52272/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52272/tests/kraken/driver.html?testName=audio-fft) 17:45:03 INFO - PROCESS | 1951 | RSS: Main: 271835136 17:45:03 INFO - PROCESS | 1951 | 17:45:05 INFO - PROCESS | 1951 | Cycle 1(1): loaded http://localhost:52272/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52272/tests/kraken/driver.html?testName=audio-oscillator) 17:45:06 INFO - PROCESS | 1951 | RSS: Main: 272683008 17:45:06 INFO - PROCESS | 1951 | 17:45:08 INFO - PROCESS | 1951 | Cycle 1(1): loaded http://localhost:52272/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52272/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:45:08 INFO - PROCESS | 1951 | RSS: Main: 273420288 17:45:08 INFO - PROCESS | 1951 | 17:45:11 INFO - PROCESS | 1951 | Cycle 1(1): loaded http://localhost:52272/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52272/tests/kraken/driver.html?testName=imaging-darkroom) 17:45:12 INFO - PROCESS | 1951 | RSS: Main: 274092032 17:45:12 INFO - PROCESS | 1951 | 17:45:15 INFO - PROCESS | 1951 | Cycle 1(1): loaded http://localhost:52272/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52272/tests/kraken/driver.html?testName=imaging-desaturate) 17:45:16 INFO - PROCESS | 1951 | RSS: Main: 274210816 17:45:16 INFO - PROCESS | 1951 | 17:45:18 INFO - PROCESS | 1951 | Cycle 1(1): loaded http://localhost:52272/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52272/tests/kraken/driver.html?testName=json-parse-financial) 17:45:19 INFO - PROCESS | 1951 | RSS: Main: 274538496 17:45:19 INFO - PROCESS | 1951 | 17:45:21 INFO - PROCESS | 1951 | Cycle 1(1): loaded http://localhost:52272/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52272/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:45:21 INFO - PROCESS | 1951 | RSS: Main: 273932288 17:45:21 INFO - PROCESS | 1951 | 17:45:23 INFO - PROCESS | 1951 | Cycle 1(1): loaded http://localhost:52272/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52272/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:45:24 INFO - PROCESS | 1951 | RSS: Main: 274223104 17:45:24 INFO - PROCESS | 1951 | 17:45:26 INFO - PROCESS | 1951 | Cycle 1(1): loaded http://localhost:52272/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52272/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:45:27 INFO - PROCESS | 1951 | RSS: Main: 274149376 17:45:27 INFO - PROCESS | 1951 | 17:45:30 INFO - PROCESS | 1951 | Cycle 1(1): loaded http://localhost:52272/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:45:30 INFO - PROCESS | 1951 | RSS: Main: 274186240 17:45:30 INFO - PROCESS | 1951 | 17:45:33 INFO - PROCESS | 1951 | Cycle 1(1): loaded http://localhost:52272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:45:34 INFO - PROCESS | 1951 | RSS: Main: 274128896 17:45:34 INFO - PROCESS | 1951 | 17:45:35 INFO - PROCESS | 1951 | Cycle 1(1): loaded http://localhost:52272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52272/tests/kraken/driver.html?testName=ai-astar) 17:45:36 INFO - PROCESS | 1951 | RSS: Main: 275124224 17:45:36 INFO - PROCESS | 1951 | 17:45:36 INFO - PROCESS | 1951 | __start_tp_report 17:45:36 INFO - PROCESS | 1951 | _x_x_mozilla_page_load 17:45:36 INFO - PROCESS | 1951 | _x_x_mozilla_page_load_details 17:45:36 INFO - PROCESS | 1951 | |i|pagename|runs| 17:45:36 INFO - PROCESS | 1951 | |0;ai-astar;103;117;109;115;117;118;113;115;126;115 17:45:36 INFO - PROCESS | 1951 | |1;audio-beat-detection;149;111;135;155;94;135;168;139;164;133 17:45:36 INFO - PROCESS | 1951 | |2;audio-dft;200;201;200;237;268;169;244;284;246;196 17:45:36 INFO - PROCESS | 1951 | |3;audio-fft;69;87;75;144;58;57;57;64;133;67 17:45:36 INFO - PROCESS | 1951 | |4;audio-oscillator;68;70;115;72;74;79;110;69;73;113 17:45:36 INFO - PROCESS | 1951 | |5;imaging-gaussian-blur;88;86;87;86;89;85;89;86;131;128 17:45:36 INFO - PROCESS | 1951 | |6;imaging-darkroom;95;95;95;121;148;96;95;145;149;95 17:45:36 INFO - PROCESS | 1951 | |7;imaging-desaturate;91;91;90;97;97;93;94;93;124;85 17:45:36 INFO - PROCESS | 1951 | |8;json-parse-financial;56;56;56;57;56;57;56;55;56;58 17:45:36 INFO - PROCESS | 1951 | |9;json-stringify-tinderbox;66;69;74;69;76;75;74;71;67;72 17:45:36 INFO - PROCESS | 1951 | |10;stanford-crypto-aes;84;105;105;107;84;83;89;83;86;85 17:45:36 INFO - PROCESS | 1951 | |11;stanford-crypto-ccm;150;141;124;171;146;158;126;156;198;154 17:45:36 INFO - PROCESS | 1951 | |12;stanford-crypto-pbkdf2;167;172;165;175;222;170;169;167;168;160 17:45:36 INFO - PROCESS | 1951 | |13;stanford-crypto-sha256-iterative;57;82;86;87;77;66;67;69;65;68 17:45:36 INFO - PROCESS | 1951 | __end_tp_report 17:45:36 INFO - PROCESS | 1951 | __start_cc_report 17:45:36 INFO - PROCESS | 1951 | _x_x_mozilla_cycle_collect,1108 17:45:36 INFO - PROCESS | 1951 | __end_cc_report 17:45:36 INFO - PROCESS | 1951 | __startTimestamp1468025136158__endTimestamp 17:45:36 INFO - PROCESS | 1951 | 17:45:36 INFO - PROCESS | 1951 | ------- Summary: start ------- 17:45:36 INFO - PROCESS | 1951 | Number of tests: 14 17:45:36 INFO - PROCESS | 1951 | 17:45:36 INFO - PROCESS | 1951 | [#0] ai-astar Cycles:10 Average:114.80 Median:116.00 stddev:5.98 (5.2%) stddev-sans-first:4.57 17:45:36 INFO - PROCESS | 1951 | Values: 103.0 117.0 109.0 115.0 117.0 118.0 113.0 115.0 126.0 115.0 17:45:36 INFO - PROCESS | 1951 | 17:45:36 INFO - PROCESS | 1951 | [#1] audio-beat-detection Cycles:10 Average:138.30 Median:152.00 stddev:22.84 (15.0%) stddev-sans-first:23.89 17:45:36 INFO - PROCESS | 1951 | Values: 149.0 111.0 135.0 155.0 94.0 135.0 168.0 139.0 164.0 133.0 17:45:36 INFO - PROCESS | 1951 | 17:45:36 INFO - PROCESS | 1951 | [#2] audio-dft Cycles:10 Average:224.50 Median:240.50 stddev:36.63 (15.2%) stddev-sans-first:37.76 17:45:36 INFO - PROCESS | 1951 | Values: 200.0 201.0 200.0 237.0 268.0 169.0 244.0 284.0 246.0 196.0 17:45:36 INFO - PROCESS | 1951 | 17:45:36 INFO - PROCESS | 1951 | [#3] audio-fft Cycles:10 Average:81.10 Median:65.50 stddev:31.72 (48.4%) stddev-sans-first:33.34 17:45:36 INFO - PROCESS | 1951 | Values: 69.0 87.0 75.0 144.0 58.0 57.0 57.0 64.0 133.0 67.0 17:45:36 INFO - PROCESS | 1951 | 17:45:36 INFO - PROCESS | 1951 | [#4] audio-oscillator Cycles:10 Average:84.30 Median:71.00 stddev:19.84 (27.9%) stddev-sans-first:20.15 17:45:36 INFO - PROCESS | 1951 | Values: 68.0 70.0 115.0 72.0 74.0 79.0 110.0 69.0 73.0 113.0 17:45:36 INFO - PROCESS | 1951 | 17:45:36 INFO - PROCESS | 1951 | [#5] imaging-gaussian-blur Cycles:10 Average:95.50 Median:86.50 stddev:17.98 (20.8%) stddev-sans-first:18.87 17:45:36 INFO - PROCESS | 1951 | Values: 88.0 86.0 87.0 86.0 89.0 85.0 89.0 86.0 131.0 128.0 17:45:36 INFO - PROCESS | 1951 | 17:45:36 INFO - PROCESS | 1951 | [#6] imaging-darkroom Cycles:10 Average:113.40 Median:95.00 stddev:24.76 (26.1%) stddev-sans-first:25.35 17:45:36 INFO - PROCESS | 1951 | Values: 95.0 95.0 95.0 121.0 148.0 96.0 95.0 145.0 149.0 95.0 17:45:36 INFO - PROCESS | 1951 | 17:45:36 INFO - PROCESS | 1951 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:93.00 stddev:10.61 (11.4%) stddev-sans-first:11.12 17:45:36 INFO - PROCESS | 1951 | Values: 91.0 91.0 90.0 97.0 97.0 93.0 94.0 93.0 124.0 85.0 17:45:36 INFO - PROCESS | 1951 | 17:45:36 INFO - PROCESS | 1951 | [#8] json-parse-financial Cycles:10 Average:56.30 Median:56.00 stddev:0.82 (1.5%) stddev-sans-first:0.87 17:45:36 INFO - PROCESS | 1951 | Values: 56.0 56.0 56.0 57.0 56.0 57.0 56.0 55.0 56.0 58.0 17:45:36 INFO - PROCESS | 1951 | 17:45:36 INFO - PROCESS | 1951 | [#9] json-stringify-tinderbox Cycles:10 Average:71.30 Median:73.00 stddev:3.47 (4.7%) stddev-sans-first:3.10 17:45:36 INFO - PROCESS | 1951 | Values: 66.0 69.0 74.0 69.0 76.0 75.0 74.0 71.0 67.0 72.0 17:45:36 INFO - PROCESS | 1951 | 17:45:36 INFO - PROCESS | 1951 | [#10] stanford-crypto-aes Cycles:10 Average:91.10 Median:84.00 stddev:10.21 (12.2%) stddev-sans-first:10.51 17:45:36 INFO - PROCESS | 1951 | Values: 84.0 105.0 105.0 107.0 84.0 83.0 89.0 83.0 86.0 85.0 17:45:36 INFO - PROCESS | 1951 | 17:45:36 INFO - PROCESS | 1951 | [#11] stanford-crypto-ccm Cycles:10 Average:152.40 Median:155.00 stddev:21.48 (13.9%) stddev-sans-first:22.77 17:45:36 INFO - PROCESS | 1951 | Values: 150.0 141.0 124.0 171.0 146.0 158.0 126.0 156.0 198.0 154.0 17:45:36 INFO - PROCESS | 1951 | 17:45:36 INFO - PROCESS | 1951 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.50 Median:169.50 stddev:17.51 (10.3%) stddev-sans-first:18.41 17:45:36 INFO - PROCESS | 1951 | Values: 167.0 172.0 165.0 175.0 222.0 170.0 169.0 167.0 168.0 160.0 17:45:36 INFO - PROCESS | 1951 | 17:45:36 INFO - PROCESS | 1951 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.40 Median:73.00 stddev:10.02 (13.7%) stddev-sans-first:8.95 17:45:36 INFO - PROCESS | 1951 | Values: 57.0 82.0 86.0 87.0 77.0 66.0 67.0 69.0 65.0 68.0 17:45:36 INFO - PROCESS | 1951 | -------- Summary: end -------- 17:45:36 INFO - PROCESS | 1951 | 17:45:36 INFO - TEST-INFO | 1951: exit 0 17:45:36 INFO - TEST-OK | kraken | took 60063ms 17:45:36 INFO - SUITE-END | took 1172s 17:45:37 INFO - Completed test suite (00:19:33) 17:45:37 INFO - javascript benchmark 17:45:37 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7460.111063330188, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3453.930921381574, 3457.7406694497904, 3469.3234819210247, 3476.2873610909764, 3491.1970246843225, 5879.088741245103, 5920.200772895658, 5953.374895635955, 6004.099385092239, 6017.879642407149, 5740.5981581289325, 5794.333651630064, 5930.792422265222, 5944.405559444053, 6053.031514957607, 5289.788408463666, 5329.600279978998, 5440.129579267318, 5452.0, 5504.091824848915, 285.01078595864277, 4416.829540171857, 5096.5922726182, 5364.284300138583, 5431.0, 5397.298351214356, 5399.676019438807, 5413.648112872651, 5428.131498960148, 5486.972565137189, 5302.628815982883, 5430.945690543083, 5445.210444485528, 5469.890602187934, 5483.451654834525, 5307.548858347045, 5351.438098999627, 5353.170258609883, 5360.731963401853, 5413.512783849433, 4123.525794533637, 4696.671233013691, 5283.996040752245, 5819.447152520504, 5956.0, 6256.96871515644, 6260.15487909131, 6268.09112678659, 6301.369863013662, 6329.588576742497, 6289.716962736642, 6360.141380913564, 6385.553011289212, 6448.871022579522, 6450.9677451612915, 6117.969410152965, 6130.540209484307, 6146.723397447081, 6147.170132032208, 6151.046587778901, 4995.425526064549, 6309.810705678745, 6476.449501792306, 6519.152510173647, 6547.934520654828, 6274.6548939808745, 6286.245650521875, 6294.0, 6296.401841825019, 6302.086197501429, 6355.983042713144, 6386.265579458422, 6410.8717825643225, 6417.550771446047, 6435.871282574322, 6038.215032045894, 6144.617461071223, 6232.065190221503, 6280.623162610258, 6335.429811317003, 5245.239440281138, 5439.292891924025, 6070.3929607038945, 6245.375462453719, 6305.684715764193, 5038.0, 5096.617753668415, 5106.336176297058, 5113.923291150636, 5121.8719532012, 4510.436195475566, 4515.480719717209, 4538.546145385435, 4553.157665831832, 4599.379083823708, 5676.403977582377, 5984.700764961734, 6015.3383127855905, 6036.2756469223095, 6047.848803779941, 6276.027215781562, 6364.904526432108, 6371.458426033839, 6376.202974628171, 6390.0734393512685, 5891.823245302648, 5927.762889484372, 5951.047832346891, 5986.2517185351835, 6024.4879185268865, 5573.247611572467, 5582.469665381782, 5586.91619625706, 5589.692566908859, 5623.971880140655, 6285.308616052322, 6447.032945058185, 6447.838804029937, 6450.161479007699, 6473.902891456632, 6263.78076767311, 6266.592671476339, 6315.242170939517, 6372.55392122547, 6383.106365108795, 6457.61254324742, 6478.805635830932, 6502.967485162544, 6512.5766825156215, 6522.21733391996, 6201.658908760061, 6256.530760192913, 6298.275698294755, 6364.204474440695, 6369.33122022181, 6316.210473690789, 6381.106645069601, 6385.584936979081, 6406.519511036598, 6425.58233714807, 6271.560990730787, 6293.181886354928, 6333.778317758856, 6346.143270658402, 6355.3644635536075, 6143.112737013596, 6177.660228687286, 6280.591761535486, 6339.270983836917, 6363.5545511813725, 5926.496247818984, 6021.187139736079, 6102.943731970988, 6192.721327540362, 6203.8138855834395, 6258.655773932295, 6291.716872740829, 6297.149884765498, 6330.715117819617, 6340.71466784005, 6028.638281703112, 6108.419700128481, 6111.77406523465, 6176.258848938156, 6221.440070393686], "value": 5783.104398171466, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [477.41516642113413, 515.7266648676201, 542.6282996147639, 544.8556132624855, 557.6765476023907, 38896.611033889654, 41489.58510414895, 41605.58394416055, 41616.58383416165, 41682.166356672846, 42727.93180170497, 43195.568044319545, 43288.13423731532, 43359.56640433602, 43400.13199736011, 9664.371815831984, 9814.411135331868, 9856.852147217798, 9858.408495490257, 9859.704208873709, 9726.270529710264, 9779.706608801747, 9788.36375635585, 9796.971318011612, 9811.852822207673, 9801.754956126118, 9806.411615303068, 9814.312998090136, 9832.115109640132, 9838.508074596277, 9763.755906102333, 9810.509474526316, 9825.459599722013, 9850.556724947359, 9882.407055576616, 9641.90358096417, 9666.468344241064, 9711.125998660083, 9741.512924353825, 9778.364406313567, 40006.799966000275, 40185.79907100475, 40482.0, 40495.987600309934, 40680.0, 3121.7346525545354, 3338.0939821749384, 3392.3045775616188, 3405.4721518164724, 3534.469829525566, 23358.53282934332, 24249.666268355235, 25215.73921303946, 30219.395612087636, 30488.39023219523, 2669.3726974161054, 3164.556962025318, 3165.5884734984534, 3246.4967929970894, 3273.083536609753, 454177.0, 462070.0, 468661.0, 470921.0, 472043.0, 33717.494237586456, 33763.0, 33976.49035264473, 34039.0, 34073.97778066662, 34658.78694245689, 35063.0, 35143.94568162959, 35859.0, 35897.0, 16822.24299906507, 16873.07198104116, 17033.318667253418, 17071.658566828595, 17109.82890171082, 12923.095383323265, 13056.673583160307, 13066.608001759962, 13068.0, 13077.476900924046, 19473.221071156993, 19687.114079866442, 19723.901380493007, 19740.90129549343, 19762.407127786188, 8336.62485188168, 8337.583120843934, 8418.957905210556, 8426.199511046441, 8529.872051919227, 889.7197382824389, 930.8976012638605, 987.5950860147306, 1055.944055944056, 1068.9893101069044, 24614.384640384134, 30841.0, 30865.228369290948, 31486.527702084488, 31638.683613163576, 942.6229508196639, 1023.2530252915413, 1123.8370436286693, 1139.4758411130806, 1236.4992178167856, 15012.849871501145, 16001.519954401387, 16097.79266555013, 16360.918195409186, 16645.91677041607, 685957.0, 706239.0, 706494.0, 708066.0, 711769.0, 60423.0, 60955.39044609497, 61081.69459152676, 61108.0, 61146.0, 1380.8895288376905, 1390.318743815523, 1394.8326200855963, 1452.106954223145, 1455.5778824141091, 24693.753062469863, 26105.608415873397, 30451.934182303514, 30928.0721578353, 30933.381332373676, 49995.0, 50135.49864501308, 51374.22938655998, 51516.0, 51813.0, 595551.0, 598249.0, 598648.0, 598744.0, 601058.0, 26413.735862641126, 26907.443792839647, 27573.172804815888, 27589.44821103607, 27633.171004869888, 49524.75237623789, 49951.75024124856, 49991.75004124956, 50055.249171261734, 51148.0, 33600.99197024093, 41036.38445423261, 41597.79201103975, 42389.78805105955, 42408.78795606126, 41003.1799364017, 41452.58547414487, 41501.58498414977, 42178.578214217465, 42284.0, 39323.803380984056, 39459.60540394559, 39568.80215598903, 40118.799406002785, 40312.19375612413, 34024.65975340215, 34560.0, 35297.823510882285, 36131.458028130124, 36201.818990904874, 23144.3056708299, 25351.985920563708, 26415.603765943142, 26714.866425667748, 27065.531299381542], "value": 19751.38128090589, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [382.51802728562006, 384.69224620303766, 386.5573917864046, 398.43820213498935, 406.69091490467235, 17733.379331723394, 18950.526236844085, 20647.483812904647, 21758.238461653826, 22323.553528929413, 10284.485775711204, 12004.879951200486, 12289.938550307235, 12438.25370477772, 20214.89892550539, 5396.64921780084, 5641.548676105902, 5642.943570564304, 5650.74571644277, 5654.208410822488, 3982.701297402692, 5909.290885093795, 6206.689665516728, 6237.0, 6243.313235544087, 6140.293866205398, 6143.662098584576, 6228.065790131472, 6233.50131989442, 6237.781677641284, 6036.215292012011, 6206.906896396557, 6224.0, 6231.40801623845, 6250.218722659668, 5828.892510423006, 6047.334793172748, 6050.396644889108, 6065.02959526478, 6068.726907289182, 13661.863381366158, 13680.52118175869, 13750.243736594482, 21176.788232117637, 25540.23379298624, 2255.492514184312, 2346.7183937927557, 2464.963025554618, 2653.257088015359, 2740.780737541012, 10214.387136771817, 10297.17622590191, 10307.381557106597, 10308.381497110197, 10462.372257664565, 1803.6212395396983, 1847.3349594146096, 1866.6360059788346, 1875.3342563389936, 1875.5967466994525, 101818.98181018169, 107469.0, 110933.44533277363, 112711.0, 113146.99999999917, 11610.825837612443, 11757.118216133824, 11764.58823941175, 11765.470553825098, 11772.50181735472, 12065.0, 14508.0, 14635.92682036583, 14652.340644671016, 14678.339474723449, 7136.822424300036, 8668.349873759367, 8809.603567839462, 8860.734177974671, 8880.51157186348, 8764.78088047804, 8792.47245165292, 8821.867671984797, 8890.377673562918, 8908.06465321145, 4036.6770658347264, 4142.565030671796, 4497.730136191839, 4662.906741865144, 4696.60078893291, 1667.5820060911726, 1702.0213377308098, 1838.7637757546547, 1910.3982245592595, 1970.2119152339178, 873.4715497124275, 875.3916028360355, 886.5212785095976, 988.906053924876, 998.9300748947504, 21452.0, 21786.455338616346, 21793.891030544746, 22019.66970495444, 22137.557248854933, 989.0, 990.9504524773732, 998.6554638649654, 1011.5903059261011, 1039.6880935719405, 11176.050035747052, 11424.42877856104, 12286.75426491465, 12491.750164996649, 12556.431173768393, 505053.47473263135, 602670.0, 621471.0, 625651.0, 635245.0, 105200.0, 110368.0, 143309.28345358206, 144181.27909360596, 144473.27763361117, 920.8388532006738, 1047.779966207105, 1057.9153667706564, 1085.484394912426, 1087.331291255872, 13763.518276860263, 19703.0, 20428.97855107209, 20485.38543843687, 20791.272305469236, 43080.0, 45557.54442455533, 58324.70837645785, 59432.70283648554, 63324.36675633369, 82374.58812705897, 82420.58789706013, 83787.5810620943, 87354.32196907434, 89370.10629893618, 8409.2431681149, 8570.571471426529, 8628.870566941376, 8685.91314086851, 8761.0, 10148.492575371054, 13838.0, 13938.024338296222, 13968.790468142783, 13977.720445591234, 10186.777586689645, 10726.356418614909, 11879.287242765462, 12022.27866328023, 12061.396930153633, 11830.645080647595, 11850.940745296219, 11912.52349905994, 11924.463399146885, 11943.104267179822, 11820.468078936297, 11858.110641701734, 12025.158238923192, 12115.273083615011, 12221.388930553614, 8383.455075420079, 8445.239928406472, 8523.74428767138, 8560.785980350292, 8602.526861022703, 11463.254888432226, 11665.416729163677, 11943.701407464883, 11988.640340789441, 11994.980426663831], "value": 9597.807065006386, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1471.4702707025472, 1558.6415124521363, 1812.8549716022712, 1914.7989461106592, 1920.6350793349272, 8238.423310368276, 8861.822763544742, 8864.46813191209, 9323.114304141096, 9355.625774969001, 9003.774905627346, 9010.324225683067, 9051.547422628859, 9212.078792120785, 9218.631254749802, 2340.3914982104648, 2364.4443555764383, 2369.6563998220336, 2371.336025912747, 2379.0602711928777, 2308.2498188088853, 2352.294311706481, 2355.1286024170995, 2377.583922813509, 2400.111958575321, 2355.9764402356013, 2367.4673198530277, 2374.7625237476286, 2385.6063749481314, 2389.474315650554, 2293.472501324705, 2347.9882600586975, 2349.5535848188874, 2365.2667673021333, 2368.4078980254935, 2336.2640768157976, 2343.5195784864063, 2358.7287461941924, 2359.988200059006, 2360.067773229565, 9089.500077495735, 9136.360454768168, 9270.351075424724, 9346.953265233631, 9353.298502612332, 5341.519263266325, 5465.316835395575, 5468.945310546884, 5481.397046324901, 5506.311711036121, 3553.8223088845452, 3664.871729489482, 3696.815159242054, 3711.2763011212824, 3712.1276500022473, 1091.1870656360982, 1092.2463500184847, 1099.5107177306102, 1101.8181999970075, 1106.181425744951, 11638.37062811207, 11797.351145686984, 11816.231944923638, 11885.643430697093, 11900.702482438008, 4450.06548624786, 4451.643868490513, 4548.704334218265, 4596.253423698973, 4614.515475875052, 9021.052789457144, 9350.0, 9351.158395744416, 9352.0, 9375.437473751597, 5237.633365664443, 5258.868528286747, 5271.103912334912, 5291.444398338119, 5318.335208098988, 3883.6310550497656, 4010.7593544387432, 4026.174634199982, 4859.70841749489, 4955.132851750929, 3325.3040949116125, 3772.9434058489146, 3828.0, 3891.5524714658177, 3909.100906791397, 983.5180761426992, 1180.7166280092888, 1186.371223251678, 1188.364225139546, 1188.9405529723479, 734.8162959260185, 863.408565132886, 876.0319846569449, 921.7234829551242, 955.5652178258875, 6159.5072394208355, 6218.471429928416, 6317.399847014526, 6331.588446750947, 6339.080833279241, 952.9380590261611, 1004.0, 1014.518103900656, 1025.4718819807806, 1034.6740776655329, 4118.691098167649, 4229.344451610005, 4241.851535196253, 4274.059706864485, 4319.6112349888035, 10831.83752243717, 11316.490757915913, 11418.771624567627, 11426.25729327591, 11459.541618335174, 9719.31964762474, 11248.381339026268, 11308.378039207922, 11361.943190283995, 11407.25852819564, 8066.0, 8105.27052565272, 8447.155284471504, 8488.405811593253, 8617.793508908759, 5951.55363347742, 6055.2430946131735, 6213.285472170758, 6356.237251529846, 6446.67766611677, 10197.745056373353, 10327.018933201334, 10399.32404393712, 10425.165986721197, 10465.895341046493, 10524.526396312338, 10646.680599581716, 10671.199660025373, 10704.678859634223, 10736.516856741622, 7776.92223077762, 7803.765887023398, 7819.178986206366, 7838.764837054898, 7919.0, 8520.531370774666, 8525.87211191845, 8603.354748393771, 8616.569171541523, 8625.309975202093, 7565.554662580135, 7664.923350766421, 7701.537907725555, 7815.218478152139, 7853.1361550228285, 7580.54516728998, 7700.730474433368, 7710.575918324546, 7821.178776228414, 7828.2954534092205, 7259.6007219603425, 7278.053852999288, 7285.307895749896, 7325.120985481776, 7339.59632220233, 5151.25306830515, 5259.605529585373, 5270.446603106772, 5311.389190243017, 5330.466953304638, 5225.399079105951, 5282.630215884851, 5325.653832500875, 5440.347158341025, 5467.753951072132], "value": 4684.922962568882, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [301.2003131685375, 307.72766101999724, 310.469097842689, 320.63287535771525, 322.8918312365359, 4649.535046495357, 5535.778568857241, 5671.546276297897, 5767.90409822134, 5798.739056742441, 5158.535731784139, 5650.576206784487, 5674.460926212014, 5678.261825962619, 5684.886302273952, 4339.956600434002, 4342.3052311630145, 4346.15250026245, 4346.521882592912, 4367.497737760151, 3420.4698271767916, 4120.25835349637, 4346.826126954918, 4383.013821890065, 4447.88880277994, 4273.358996150587, 4292.785360731951, 4299.355096735483, 4328.242557552416, 4335.544767799383, 3771.076086358832, 3813.294540510001, 4136.400221967813, 4321.222180007598, 4367.6069153776, 3726.1122629961724, 3734.9439758403373, 3739.700823934079, 3740.831662575191, 3754.2303827715527, 4441.622462090726, 4525.86422407325, 4896.706197628154, 5494.313210848644, 5590.217369568264, 4840.661153719241, 4853.417589889236, 4903.166461701484, 4925.827596034157, 4935.0, 5464.333378319611, 5670.152020022903, 5789.710514474259, 5949.345571987078, 6016.1878146450545, 3551.3252482028333, 3677.9080522986874, 3912.197999410114, 4025.174839157995, 4045.1505183911413, 5536.4186760389985, 5625.6905870177125, 6267.467265282411, 6310.495160387158, 6325.240971083454, 3574.12433953683, 3731.7014638829373, 3933.6263055009726, 4000.7999600020466, 4115.629593336614, 4071.002604361891, 4111.568285330057, 4115.604626183411, 4134.937975930364, 4135.255653982312, 4803.78382972767, 4860.222364421676, 4902.313676085351, 4914.852554423373, 4932.753362331869, 4955.240889484253, 5373.247745315659, 5736.6844823534275, 5871.324797648325, 6073.08903664445, 1338.6118025772416, 1365.9823431543366, 1442.5672298310465, 1460.2990564529086, 1468.5153899213446, 783.4046124945082, 790.9361908233417, 882.4440602420434, 903.4759839293325, 911.4531281231341, 4083.571225021389, 4645.396098507173, 4700.929486057712, 4723.433188017391, 4728.574428301469, 4627.375304333872, 4701.48283688794, 4756.6908150970075, 5153.1497302945345, 5267.313670028237, 3866.8646597368956, 4164.66682665386, 4215.894602634898, 4242.639375653042, 4255.0, 2839.758620517238, 3029.591005214268, 3336.2660214752714, 3336.716379107803, 3343.983280083584, 6414.1340918976275, 6526.28210896801, 6529.869402611921, 6541.313162118005, 6546.214454265519, 6108.938910610926, 6406.6476343800605, 6408.263049749338, 6432.87715054031, 6447.002858227835, 5602.691851948182, 5847.06446968483, 6430.495380017902, 6480.0, 6518.57629254097, 5079.644424890223, 5927.251460818982, 6251.374862513712, 6272.717727702173, 6301.149344838572, 5760.638138363251, 5922.940770592411, 6167.814965551041, 6179.84550386244, 6208.751649934133, 5273.871848083938, 5532.395605274425, 6525.282218956006, 6567.737290508518, 6644.783844681901, 3593.6765691087926, 3596.9820150899077, 3917.823697933543, 4073.0021144819707, 4113.8971525712095, 5308.548773354308, 5338.839834804962, 5857.238558987305, 6103.755849765959, 6113.5414843886, 5503.367112781922, 5600.991821472011, 5763.827085187451, 6039.849003774941, 6152.415520525543, 6021.458068773832, 6064.757409703562, 6067.878642427038, 6145.784897528565, 6152.0, 5134.075866343945, 5699.34457537372, 5866.2960444745195, 5942.346341902301, 5988.910166347421, 5668.348139963792, 6023.0, 6029.487493563096, 6093.811706717148, 6123.326434092335, 5708.57185711065, 5886.881492516408, 5898.793542226002, 5905.604277540346, 5920.319163296276], "value": 4273.805458309059, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [695.3880585085125, 696.3489137656288, 794.2176955698636, 810.2383759266286, 837.0666706622114, 15190.848091519081, 15809.683806323896, 15963.521094367188, 15974.0, 16053.03681779094, 14461.421543138262, 14510.201938893357, 14539.200343981076, 14554.636134096652, 14615.488457903975, 707.476467414115, 890.8351954888367, 899.9370044096916, 924.96300147994, 935.6210734652443, 910.658503061352, 912.0423555266976, 917.6925729880498, 919.8114386550775, 922.4465320807495, 941.4022095969075, 974.4494360686225, 977.8728765260541, 981.6171693039685, 981.9312648114635, 956.4978386347154, 958.2525630008604, 969.2585172343163, 969.5733877094056, 971.6113554578154, 713.0089176045301, 722.461765984345, 727.3054233207274, 729.6096588325273, 730.0946825935802, 14791.038582492103, 14921.850781492154, 15164.165970871598, 15202.391904323813, 15238.314275857501, 14818.110913345234, 14986.775198372034, 15003.549893503212, 15050.623734406618, 15109.773353399707, 11980.28118312904, 12204.206726562745, 12311.322877241837, 12441.253524788452, 12500.24998500093, 3794.90512737181, 3801.459506623286, 3994.6205110514456, 4011.538673052607, 4015.738976966517, 75475.0, 111656.0, 113050.43474782574, 113804.4309778454, 113970.0, 11309.0, 11378.43107844621, 11446.37044962535, 11561.653150405502, 11700.180987330976, 23320.416989575395, 23389.298321050395, 23726.762732372456, 24027.038918443068, 24052.27843164708, 8225.71210007659, 8379.70671026511, 8451.11263317355, 8500.787480313042, 8605.354598405145, 3447.6552344765823, 4556.248219043887, 4619.376384188092, 4641.164590373698, 4670.836520721827, 3609.873654422083, 3733.6079711629886, 3736.23407201523, 3736.3087828751222, 3745.6254374562873, 603.9969800150972, 669.5146019136088, 685.1059367525328, 689.9103116594811, 694.3056943056943, 605.479287812481, 637.8373514753708, 667.5360624366019, 701.7964790210782, 702.8570295616277, 9336.953315233517, 9339.859902101474, 9342.2526197904, 9470.195033422098, 9604.95197524022, 626.9843253918598, 633.7750098714982, 665.9667016649148, 681.8806708826035, 692.536000879412, 4284.94376635573, 4395.7362558246605, 4453.599176074104, 4614.515475875052, 4625.213713668684, 150768.2461587685, 151490.24254878654, 151620.0, 151740.0, 154174.0, 122941.38529307296, 124758.37620811838, 129914.05128923073, 131316.0, 134321.32839335935, 105536.47231763946, 106443.93556064495, 106480.46759766151, 106825.0, 108461.0, 8253.587320634064, 8860.0, 8880.600372983103, 9020.861490277417, 9035.683751068682, 62186.68906655619, 62814.37185628085, 63021.0, 63395.46418143407, 64347.71304573789, 93151.0, 95395.52302238444, 97617.02382976079, 97658.51170744385, 97938.0, 11853.170278080452, 11931.522739090338, 12105.0, 12270.570530031406, 12524.311162886128, 13195.67010824737, 13236.87486563653, 13278.203307801563, 13321.0, 13747.793783093462, 11997.040236781211, 12026.458809353426, 12203.938980305042, 12445.377731113227, 12532.812007819708, 10834.566617335218, 11430.685471170922, 12186.329751863732, 12379.257244565355, 12660.936695316464, 11849.881501184878, 11990.820137697767, 12013.75972480528, 12025.2567153354, 12036.398180091135, 10146.898531014594, 10170.57611934315, 10285.177185825265, 10366.688999330032, 10859.2398532102, 9343.672971445967, 9615.23078153732, 9777.168940640126, 10287.022732840369, 10376.118094706831], "value": 7852.019634834356, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1564.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 117.0, 109.0, 115.0, 117.0, 118.0, 113.0, 115.0, 126.0, 115.0], "value": 114.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 111.0, 135.0, 155.0, 94.0, 135.0, 168.0, 139.0, 164.0, 133.0], "value": 138.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [200.0, 201.0, 200.0, 237.0, 268.0, 169.0, 244.0, 284.0, 246.0, 196.0], "value": 224.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 87.0, 75.0, 144.0, 58.0, 57.0, 57.0, 64.0, 133.0, 67.0], "value": 81.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 70.0, 115.0, 72.0, 74.0, 79.0, 110.0, 69.0, 73.0, 113.0], "value": 84.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 86.0, 87.0, 86.0, 89.0, 85.0, 89.0, 86.0, 131.0, 128.0], "value": 95.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 121.0, 148.0, 96.0, 95.0, 145.0, 149.0, 95.0], "value": 113.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 91.0, 90.0, 97.0, 97.0, 93.0, 94.0, 93.0, 124.0, 85.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 56.0, 57.0, 56.0, 57.0, 56.0, 55.0, 56.0, 58.0], "value": 56.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 69.0, 74.0, 69.0, 76.0, 75.0, 74.0, 71.0, 67.0, 72.0], "value": 71.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 105.0, 105.0, 107.0, 84.0, 83.0, 89.0, 83.0, 86.0, 85.0], "value": 91.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 141.0, 124.0, 171.0, 146.0, 158.0, 126.0, 156.0, 198.0, 154.0], "value": 152.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 172.0, 165.0, 175.0, 222.0, 170.0, 169.0, 167.0, 168.0, 160.0], "value": 173.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 82.0, 86.0, 87.0, 77.0, 66.0, 67.0, 69.0, 65.0, 68.0], "value": 72.4, "unit": "score"}]}]} 17:45:37 INFO - Return code: 0 17:45:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:45:37 ERROR - # TBPL SUCCESS # 17:45:37 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:45:37 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:45:37 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:45:37 INFO - 2016-07-08 17:45:37.478 screenresolution[1956:15530] starting screenresolution argv=screenresolution get 17:45:37 INFO - 2016-07-08 17:45:37.480 screenresolution[1956:15530] Display 0: 1600x1200x32@60 17:45:37 INFO - 2016-07-08 17:45:37.486 screenresolution[1957:15533] starting screenresolution argv=screenresolution list 17:45:37 INFO - Available Modes on Display 0 17:45:37 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:45:37 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:45:37 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:45:37 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:45:37 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:45:37 INFO - Intel Iris: 17:45:37 INFO - Chipset Model: Intel Iris 17:45:37 INFO - Type: GPU 17:45:37 INFO - Bus: Built-In 17:45:37 INFO - VRAM (Dynamic, Max): 1536 MB 17:45:37 INFO - Vendor: Intel (0x8086) 17:45:37 INFO - Device ID: 0x0a2e 17:45:37 INFO - Revision ID: 0x0009 17:45:37 INFO - Displays: 17:45:37 INFO - Display: 17:45:37 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:45:37 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:45:37 INFO - Display Serial Number: 1600x1200 60 17:45:37 INFO - Main Display: Yes 17:45:37 INFO - Mirror: Off 17:45:37 INFO - Online: Yes 17:45:37 INFO - Rotation: Supported 17:45:37 INFO - Return code: 0 17:45:37 INFO - Running post-action listener: _resource_record_post_action 17:45:37 INFO - ##### 17:45:37 INFO - ##### Finished run-tests step (success) 17:45:37 INFO - ##### 17:45:37 INFO - Running post-run listener: _resource_record_post_run 17:45:37 INFO - Total resource usage - Wall time: 1208s; CPU: 54.0%; Read bytes: 540672; Write bytes: 707350528; Read time: 10; Write time: 2233 17:45:37 INFO - TinderboxPrint: CPU usage
54.3% 17:45:37 INFO - TinderboxPrint: I/O read bytes / time
540,672 / 10 17:45:37 INFO - TinderboxPrint: I/O write bytes / time
707,350,528 / 2,233 17:45:37 INFO - TinderboxPrint: CPU idle
2,209.7 (45.7%) 17:45:37 INFO - TinderboxPrint: CPU system
976.1 (20.2%) 17:45:37 INFO - TinderboxPrint: CPU user
1,647.8 (34.1%) 17:45:37 INFO - TinderboxPrint: Swap in / out
407,494,656 / 0 17:45:37 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 398471680; Write bytes: 392898560; Read time: 29508; Write time: 773 17:45:37 INFO - run-tests - Wall time: 1174s; CPU: 54.0%; Read bytes: 540672; Write bytes: 296863744; Read time: 10; Write time: 1423 17:45:38 INFO - Running post-run listener: _upload_blobber_files 17:45:38 INFO - Blob upload gear active. 17:45:38 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:45:38 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 17:45:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:45:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:45:38 INFO - (blobuploader) - INFO - Open directory for files ... 17:45:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:45:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:45:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:45:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:45:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:45:39 INFO - (blobuploader) - INFO - Done attempting. 17:45:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:45:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:45:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:45:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:45:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:45:40 INFO - (blobuploader) - INFO - Done attempting. 17:45:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:45:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:45:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:45:42 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:45:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:45:42 INFO - (blobuploader) - INFO - Done attempting. 17:45:42 INFO - (blobuploader) - INFO - Iteration through files over. 17:45:42 INFO - Return code: 0 17:45:42 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:45:42 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:45:42 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9473f8724e044dc8616df8396f20d135a2f365bda92de678157898d3dd8c481dbf32235e6fa5d51739086842a73ab20e140c96635377e34f4e65550bed719342", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eda2efb27912adf25f07377ccede5b7e940245f3bae9e75a6e6e98670de358de0ad2792ee13fd4cd7f320141d9beaeca5ec15a04bfa513db6c70c6bc3f926dd6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ef52e95ceb31a788a17a9ba2809990e6768b4fd34f9a7a792ffde8040d1cd7e4719c0eb898240a45def07c8d37d3adf4741430c96a3a587acb7e1e8d270dd248"} 17:45:42 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:45:42 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:45:42 INFO - Contents: 17:45:42 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9473f8724e044dc8616df8396f20d135a2f365bda92de678157898d3dd8c481dbf32235e6fa5d51739086842a73ab20e140c96635377e34f4e65550bed719342", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eda2efb27912adf25f07377ccede5b7e940245f3bae9e75a6e6e98670de358de0ad2792ee13fd4cd7f320141d9beaeca5ec15a04bfa513db6c70c6bc3f926dd6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ef52e95ceb31a788a17a9ba2809990e6768b4fd34f9a7a792ffde8040d1cd7e4719c0eb898240a45def07c8d37d3adf4741430c96a3a587acb7e1e8d270dd248"} 17:45:42 INFO - Running post-run listener: copy_logs_to_upload_dir 17:45:42 INFO - Copying logs to upload dir... 17:45:42 INFO - mkdir: /builds/slave/test/build/upload/logs 17:45:42 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1260.157775 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2016-07-08 17:45:42.457318) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-08 17:45:42.461093) ========= 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.2hS2oTMDrP/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.LkVDU4qEDd/Listeners TMPDIR=/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/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 blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9473f8724e044dc8616df8396f20d135a2f365bda92de678157898d3dd8c481dbf32235e6fa5d51739086842a73ab20e140c96635377e34f4e65550bed719342", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eda2efb27912adf25f07377ccede5b7e940245f3bae9e75a6e6e98670de358de0ad2792ee13fd4cd7f320141d9beaeca5ec15a04bfa513db6c70c6bc3f926dd6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ef52e95ceb31a788a17a9ba2809990e6768b4fd34f9a7a792ffde8040d1cd7e4719c0eb898240a45def07c8d37d3adf4741430c96a3a587acb7e1e8d270dd248"} build_url:https://queue.taskcluster.net/v1/task/A0txUtkLRq67XdDXxuZfGw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011312 build_url: 'https://queue.taskcluster.net/v1/task/A0txUtkLRq67XdDXxuZfGw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9473f8724e044dc8616df8396f20d135a2f365bda92de678157898d3dd8c481dbf32235e6fa5d51739086842a73ab20e140c96635377e34f4e65550bed719342", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eda2efb27912adf25f07377ccede5b7e940245f3bae9e75a6e6e98670de358de0ad2792ee13fd4cd7f320141d9beaeca5ec15a04bfa513db6c70c6bc3f926dd6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ef52e95ceb31a788a17a9ba2809990e6768b4fd34f9a7a792ffde8040d1cd7e4719c0eb898240a45def07c8d37d3adf4741430c96a3a587acb7e1e8d270dd248"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-08 17:45:42.494213) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 17:45:42.494540) ========= 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.2hS2oTMDrP/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.LkVDU4qEDd/Listeners TMPDIR=/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/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.005251 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 17:45:42.544178) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-08 17:45:42.544533) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-08 17:45:42.545054) ========= ========= Total master_lag: 0.17 =========