builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0306 starttime: 1467295689.74 results: success (0) buildid: 20160630045027 builduid: 74c13bdfe2bd474cbd4487a2022e886b revision: 82e1f1b9c0559f38a8460e2f2f3044de4c7712d6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-30 07:08:09.744763) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-30 07:08:09.745418) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-30 07:08:09.745709) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-30 07:08:09.818313) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 07:08:09.818810) ========= 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.nvltiZ7TTM/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.eaZcgFWKDl/Listeners TMPDIR=/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/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-06-30 07:08:09-- 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% 165M=0s 2016-06-30 07:08:09 (165 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.101864 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 07:08:09.946421) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 07:08:09.946786) ========= 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.nvltiZ7TTM/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.eaZcgFWKDl/Listeners TMPDIR=/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/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.026981 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 07:08:09.999208) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 07:08:09.999740) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 82e1f1b9c0559f38a8460e2f2f3044de4c7712d6 --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 82e1f1b9c0559f38a8460e2f2f3044de4c7712d6 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.nvltiZ7TTM/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.eaZcgFWKDl/Listeners TMPDIR=/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/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-06-30 07:08:10,087 truncating revision to first 12 chars 2016-06-30 07:08:10,087 Setting DEBUG logging. 2016-06-30 07:08:10,087 attempt 1/10 2016-06-30 07:08:10,087 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/82e1f1b9c055?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-30 07:08:10,784 unpacking tar archive at: mozilla-central-82e1f1b9c055/testing/mozharness/ program finished with exit code 0 elapsedTime=0.970579 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 07:08:10.996468) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-30 07:08:10.996791) ========= script_repo_revision: 82e1f1b9c0559f38a8460e2f2f3044de4c7712d6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-30 07:08:10.997183) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-30 07:08:10.997447) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-30 07:08:11.022755) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-06-30 07:08:11.023270) ========= /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.nvltiZ7TTM/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.eaZcgFWKDl/Listeners TMPDIR=/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/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 07:08:11 INFO - MultiFileLogger online at 20160630 07:08:11 in /builds/slave/test 07:08:11 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 07:08:11 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:08:11 INFO - {'append_to_log': False, 07:08:11 INFO - 'base_work_dir': '/builds/slave/test', 07:08:11 INFO - 'blob_upload_branch': 'Firefox', 07:08:11 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:08:11 INFO - 'branch': 'Firefox', 07:08:11 INFO - 'buildbot_json_path': 'buildprops.json', 07:08:11 INFO - 'config_files': ('talos/mac_config.py',), 07:08:11 INFO - 'default_actions': ('clobber', 07:08:11 INFO - 'read-buildbot-config', 07:08:11 INFO - 'download-and-extract', 07:08:11 INFO - 'populate-webroot', 07:08:11 INFO - 'create-virtualenv', 07:08:11 INFO - 'install', 07:08:11 INFO - 'run-tests'), 07:08:11 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:08:11 INFO - 'download_minidump_stackwalk': True, 07:08:11 INFO - 'download_symbols': 'ondemand', 07:08:11 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:08:11 INFO - 'tooltool.py': '/tools/tooltool.py', 07:08:11 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:08:11 INFO - '/tools/misc-python/virtualenv.py')}, 07:08:11 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:08:11 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:08:11 INFO - 'installer_path': 'installer.exe', 07:08:11 INFO - 'log_level': 'info', 07:08:11 INFO - 'log_name': 'talos', 07:08:11 INFO - 'log_to_console': True, 07:08:11 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 07:08:11 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 07:08:11 INFO - 'opt_config_files': (), 07:08:11 INFO - 'pip_index': False, 07:08:11 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:08:11 INFO - 'cmd': ('bash', 07:08:11 INFO - '-c', 07:08:11 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:08:11 INFO - 'enabled': True, 07:08:11 INFO - 'halt_on_failure': False, 07:08:11 INFO - 'name': 'check_screen_resolution'},), 07:08:11 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:08:11 INFO - 'cmd': ('bash', 07:08:11 INFO - '-c', 07:08:11 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:08:11 INFO - 'enabled': True, 07:08:11 INFO - 'halt_on_failure': False, 07:08:11 INFO - 'name': 'check_screen_resolution'},), 07:08:11 INFO - 'run_cmd_checks_enabled': True, 07:08:11 INFO - 'sps_profile': False, 07:08:11 INFO - 'sps_profile_interval': 0, 07:08:11 INFO - 'suite': 'dromaeojs-e10s', 07:08:11 INFO - 'system_bits': '32', 07:08:11 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:08:11 INFO - 'title': 't-yosemite-r7-0306', 07:08:11 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:08:11 INFO - 'use_talos_json': True, 07:08:11 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:08:11 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:08:11 INFO - 'work_dir': 'build'} 07:08:11 INFO - ##### 07:08:11 INFO - ##### Running clobber step. 07:08:11 INFO - ##### 07:08:11 INFO - Running pre-action listener: _resource_record_pre_action 07:08:11 INFO - Running main action method: clobber 07:08:11 INFO - rmtree: /builds/slave/test/build 07:08:11 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:08:13 INFO - Running post-action listener: _resource_record_post_action 07:08:13 INFO - ##### 07:08:13 INFO - ##### Finished clobber step (success) 07:08:13 INFO - ##### 07:08:13 INFO - ##### 07:08:13 INFO - ##### Running read-buildbot-config step. 07:08:13 INFO - ##### 07:08:13 INFO - Running pre-action listener: _resource_record_pre_action 07:08:13 INFO - Running main action method: read_buildbot_config 07:08:13 INFO - Using buildbot properties: 07:08:13 INFO - { 07:08:13 INFO - "project": "", 07:08:13 INFO - "product": "firefox", 07:08:13 INFO - "script_repo_revision": "production", 07:08:13 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 07:08:13 INFO - "repository": "", 07:08:13 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 07:08:13 INFO - "buildid": "20160630045027", 07:08:13 INFO - "pgo_build": "False", 07:08:13 INFO - "basedir": "/builds/slave/test", 07:08:13 INFO - "buildnumber": 4, 07:08:13 INFO - "slavename": "t-yosemite-r7-0306", 07:08:13 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 07:08:13 INFO - "platform": "yosemite_r7", 07:08:13 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 07:08:13 INFO - "branch": "mozilla-central", 07:08:13 INFO - "repo_path": "mozilla-central", 07:08:13 INFO - "revision": "82e1f1b9c0559f38a8460e2f2f3044de4c7712d6", 07:08:13 INFO - "stage_platform": "macosx64", 07:08:13 INFO - "builduid": "74c13bdfe2bd474cbd4487a2022e886b", 07:08:13 INFO - "slavebuilddir": "test" 07:08:13 INFO - } 07:08:13 INFO - Found installer url https://queue.taskcluster.net/v1/task/bH5HlthoSSKCdkw0i52lWQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg. 07:08:13 INFO - Running post-action listener: _resource_record_post_action 07:08:13 INFO - ##### 07:08:13 INFO - ##### Finished read-buildbot-config step (success) 07:08:13 INFO - ##### 07:08:13 INFO - ##### 07:08:13 INFO - ##### Running download-and-extract step. 07:08:13 INFO - ##### 07:08:13 INFO - Running pre-action listener: _resource_record_pre_action 07:08:13 INFO - Running main action method: download_and_extract 07:08:13 INFO - mkdir: /builds/slave/test/build/tests 07:08: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')]} 07:08:13 INFO - https://queue.taskcluster.net/v1/task/bH5HlthoSSKCdkw0i52lWQ/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 07:08:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bH5HlthoSSKCdkw0i52lWQ/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 07:08:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bH5HlthoSSKCdkw0i52lWQ/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 07:08:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bH5HlthoSSKCdkw0i52lWQ/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 07:08:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bH5HlthoSSKCdkw0i52lWQ/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 07:08:15 INFO - Downloaded 1199 bytes. 07:08:15 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 07:08:15 INFO - Using the following test package requirements: 07:08:15 INFO - {u'common': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 07:08:15 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 07:08:15 INFO - u'firefox-50.0a1.en-US.mac.cppunittest.tests.zip'], 07:08:15 INFO - u'gtest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 07:08:15 INFO - u'firefox-50.0a1.en-US.mac.gtest.tests.zip'], 07:08:15 INFO - u'jittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 07:08:15 INFO - u'jsshell-mac.zip'], 07:08:15 INFO - u'mochitest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 07:08:15 INFO - u'firefox-50.0a1.en-US.mac.mochitest.tests.zip'], 07:08:15 INFO - u'mozbase': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 07:08:15 INFO - u'reftest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 07:08:15 INFO - u'firefox-50.0a1.en-US.mac.reftest.tests.zip'], 07:08:15 INFO - u'talos': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 07:08:15 INFO - u'firefox-50.0a1.en-US.mac.talos.tests.zip'], 07:08:15 INFO - u'web-platform': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 07:08:15 INFO - u'firefox-50.0a1.en-US.mac.web-platform.tests.zip'], 07:08:15 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 07:08:15 INFO - u'firefox-50.0a1.en-US.mac.xpcshell.tests.zip']} 07:08:15 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip'] for test suite category: common 07:08:15 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')]} 07:08:15 INFO - https://queue.taskcluster.net/v1/task/bH5HlthoSSKCdkw0i52lWQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 07:08:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bH5HlthoSSKCdkw0i52lWQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 07:08:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bH5HlthoSSKCdkw0i52lWQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 07:08:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bH5HlthoSSKCdkw0i52lWQ/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 07:08:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bH5HlthoSSKCdkw0i52lWQ/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 07:08:17 INFO - Downloaded 18788530 bytes. 07:08:17 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'] 07:08:17 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 07:08:20 INFO - Return code: 0 07:08:20 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 07:08:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:08:20 INFO - https://queue.taskcluster.net/v1/task/bH5HlthoSSKCdkw0i52lWQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 07:08:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bH5HlthoSSKCdkw0i52lWQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 07:08:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bH5HlthoSSKCdkw0i52lWQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 07:08:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bH5HlthoSSKCdkw0i52lWQ/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 07:08:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bH5HlthoSSKCdkw0i52lWQ/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 07:08:21 INFO - Downloaded 18788530 bytes. 07:08:21 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'] 07:08:21 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 07:08:25 INFO - Return code: 0 07:08:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:08:25 INFO - https://queue.taskcluster.net/v1/task/bH5HlthoSSKCdkw0i52lWQ/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 07:08:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bH5HlthoSSKCdkw0i52lWQ/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 07:08:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bH5HlthoSSKCdkw0i52lWQ/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 07:08:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bH5HlthoSSKCdkw0i52lWQ/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 07:08:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bH5HlthoSSKCdkw0i52lWQ/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 07:08:26 INFO - Downloaded 14405242 bytes. 07:08:26 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'] 07:08:26 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 07:08:27 INFO - Return code: 0 07:08:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:08:27 INFO - https://queue.taskcluster.net/v1/task/bH5HlthoSSKCdkw0i52lWQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 07:08:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bH5HlthoSSKCdkw0i52lWQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 07:08:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bH5HlthoSSKCdkw0i52lWQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 07:08:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bH5HlthoSSKCdkw0i52lWQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg 07:08:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bH5HlthoSSKCdkw0i52lWQ/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 07:08:31 INFO - Downloaded 112427514 bytes. 07:08:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bH5HlthoSSKCdkw0i52lWQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 07:08:31 INFO - mkdir: /builds/slave/test/properties 07:08:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:08:31 INFO - Writing to file /builds/slave/test/properties/build_url 07:08:31 INFO - Contents: 07:08:31 INFO - build_url:https://queue.taskcluster.net/v1/task/bH5HlthoSSKCdkw0i52lWQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 07:08:32 INFO - Running post-action listener: _resource_record_post_action 07:08:32 INFO - Running post-action listener: set_extra_try_arguments 07:08:32 INFO - ##### 07:08:32 INFO - ##### Finished download-and-extract step (success) 07:08:32 INFO - ##### 07:08:32 INFO - ##### 07:08:32 INFO - ##### Running populate-webroot step. 07:08:32 INFO - ##### 07:08:32 INFO - Running pre-action listener: _resource_record_pre_action 07:08:32 INFO - Running main action method: populate_webroot 07:08:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:08:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:08:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:08:32 INFO - '--tppagecycles', 07:08:32 INFO - '7'], 07:08:32 INFO - 'tests': ['tsvgm']}}, 07:08:32 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:08:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:08:32 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:08:32 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:08:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:08:32 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:08:32 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:08:32 INFO - 'talos_options': ['--disable-e10s'], 07:08:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:08:32 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:08:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:08:32 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:08:32 INFO - 'talos_options': ['--disable-e10s'], 07:08:32 INFO - 'tests': ['damp', 'tps']}, 07:08:32 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:08:32 INFO - 'tests': ['damp', 'tps']}, 07:08:32 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:08:32 INFO - 'tests': ['dromaeo_dom']}, 07:08:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:08:32 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:08:32 INFO - 'tests': ['basic_compositor_video']}, 07:08:32 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:08:32 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:08:32 INFO - 'tests': ['a11yr', 07:08:32 INFO - 'ts_paint', 07:08:32 INFO - 'tpaint', 07:08:32 INFO - 'sessionrestore', 07:08:32 INFO - 'sessionrestore_no_auto_restore', 07:08:32 INFO - 'tabpaint']}, 07:08:32 INFO - 'other-e10s': {'tests': ['a11yr', 07:08:32 INFO - 'ts_paint', 07:08:32 INFO - 'tpaint', 07:08:32 INFO - 'sessionrestore', 07:08:32 INFO - 'sessionrestore_no_auto_restore', 07:08:32 INFO - 'tabpaint']}, 07:08:32 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:08:32 INFO - 'ts_paint', 07:08:32 INFO - 'tpaint', 07:08:32 INFO - 'sessionrestore', 07:08:32 INFO - 'sessionrestore_no_auto_restore', 07:08:32 INFO - 'tabpaint']}, 07:08:32 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:08:32 INFO - 'ts_paint', 07:08:32 INFO - 'tpaint', 07:08:32 INFO - 'sessionrestore', 07:08:32 INFO - 'sessionrestore_no_auto_restore', 07:08:32 INFO - 'tabpaint']}, 07:08:32 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:08:32 INFO - 'tests': ['a11yr', 07:08:32 INFO - 'ts_paint', 07:08:32 INFO - 'tpaint', 07:08:32 INFO - 'sessionrestore', 07:08:32 INFO - 'sessionrestore_no_auto_restore', 07:08:32 INFO - 'tabpaint']}, 07:08:32 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:08:32 INFO - 'tests': ['a11yr', 07:08:32 INFO - 'ts_paint', 07:08:32 INFO - 'tpaint', 07:08:32 INFO - 'sessionrestore', 07:08:32 INFO - 'sessionrestore_no_auto_restore', 07:08:32 INFO - 'tabpaint']}, 07:08:32 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:08:32 INFO - 'tests': ['tsvgx', 07:08:32 INFO - 'tsvgr_opacity', 07:08:32 INFO - 'tart', 07:08:32 INFO - 'tscrollx', 07:08:32 INFO - 'cart']}, 07:08:32 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:08:32 INFO - 'tsvgr_opacity', 07:08:32 INFO - 'tart', 07:08:32 INFO - 'tscrollx', 07:08:32 INFO - 'cart']}, 07:08:32 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:08:32 INFO - 'talos_options': ['--disable-e10s'], 07:08:32 INFO - 'tests': ['tp5o']}, 07:08:32 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:08:32 INFO - 'tests': ['tp5o']}, 07:08:32 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:08:32 INFO - 'talos_options': ['--disable-e10s', 07:08:32 INFO - '--xperf_path', 07:08:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:08:32 INFO - 'tests': ['tp5n']}, 07:08:32 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:08:32 INFO - 'talos_options': ['--xperf_path', 07:08:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:08:32 INFO - 'tests': ['tp5n']}}, 07:08:32 INFO - 'talos.zip': {'path': '', 07:08:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:08:32 INFO - Running post-action listener: _resource_record_post_action 07:08:32 INFO - ##### 07:08:32 INFO - ##### Finished populate-webroot step (success) 07:08:32 INFO - ##### 07:08:32 INFO - ##### 07:08:32 INFO - ##### Running create-virtualenv step. 07:08:32 INFO - ##### 07:08:32 INFO - Running pre-action listener: _resource_record_pre_action 07:08:32 INFO - Running main action method: create_virtualenv 07:08:32 INFO - Creating virtualenv /builds/slave/test/build/venv 07:08:32 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 07:08:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:08:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:08:32 INFO - Using real prefix '/tools/python27' 07:08:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:08:33 INFO - Installing distribute.............................................................................................................................................................................................done. 07:08:36 INFO - Installing pip.................done. 07:08:36 INFO - Return code: 0 07:08:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:08:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:08:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:08:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:08:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:08:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:08:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:08:36 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 0x10d4f7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d58c618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa27a4937a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d45bd30>, '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 0x10d1c0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d453b20>, '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.nvltiZ7TTM/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.eaZcgFWKDl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/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 07:08:36 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 07:08:36 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 07:08:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nvltiZ7TTM/Render', 07:08:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:08:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:08:36 INFO - 'HOME': '/Users/cltbld', 07:08:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:08:36 INFO - 'LOGNAME': 'cltbld', 07:08:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:08:36 INFO - 'MOZ_NO_REMOTE': '1', 07:08:36 INFO - 'NO_EM_RESTART': '1', 07:08:36 INFO - 'PAGER': '/bin/cat', 07:08:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:08:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:08:36 INFO - 'PWD': '/builds/slave/test', 07:08:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:08:36 INFO - 'SHELL': '/bin/bash', 07:08:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eaZcgFWKDl/Listeners', 07:08:36 INFO - 'TMPDIR': '/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/', 07:08:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:08:36 INFO - 'USER': 'cltbld', 07:08:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:08:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:08:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:08:36 INFO - 'XPC_FLAGS': '0x0', 07:08:36 INFO - 'XPC_SERVICE_NAME': '0', 07:08:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:08:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:08:36 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 07:08:36 INFO - Cleaning up... 07:08:36 INFO - Return code: 0 07:08:36 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:08:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:08:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:08:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:08:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:08:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:08:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:08:36 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 0x10d4f7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d58c618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa27a4937a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d45bd30>, '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 0x10d1c0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d453b20>, '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.nvltiZ7TTM/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.eaZcgFWKDl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/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 07:08:36 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 07:08:36 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 07:08:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nvltiZ7TTM/Render', 07:08:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:08:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:08:36 INFO - 'HOME': '/Users/cltbld', 07:08:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:08:36 INFO - 'LOGNAME': 'cltbld', 07:08:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:08:36 INFO - 'MOZ_NO_REMOTE': '1', 07:08:36 INFO - 'NO_EM_RESTART': '1', 07:08:36 INFO - 'PAGER': '/bin/cat', 07:08:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:08:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:08:36 INFO - 'PWD': '/builds/slave/test', 07:08:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:08:36 INFO - 'SHELL': '/bin/bash', 07:08:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eaZcgFWKDl/Listeners', 07:08:36 INFO - 'TMPDIR': '/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/', 07:08:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:08:36 INFO - 'USER': 'cltbld', 07:08:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:08:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:08:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:08:36 INFO - 'XPC_FLAGS': '0x0', 07:08:36 INFO - 'XPC_SERVICE_NAME': '0', 07:08:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:08:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:08:36 INFO - Downloading/unpacking psutil>=3.1.1 07:08:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:08:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:08:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:08:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:08:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:08:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:08:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:08:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:08:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:08:39 INFO - Installing collected packages: psutil 07:08:39 INFO - Running setup.py install for psutil 07:08:39 INFO - building 'psutil._psutil_osx' extension 07:08:39 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 07:08:39 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 07:08:39 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 07:08:40 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 07:08:40 INFO - building 'psutil._psutil_posix' extension 07:08:40 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 07:08:40 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 07:08:40 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 07:08:40 INFO - ^ 07:08:40 INFO - 1 warning generated. 07:08:40 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 07:08:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:08:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:08:40 INFO - Successfully installed psutil 07:08:40 INFO - Cleaning up... 07:08:40 INFO - Return code: 0 07:08:40 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:08:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:08:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:08:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:08:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:08:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:08:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:08:40 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 0x10d4f7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d58c618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa27a4937a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d45bd30>, '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 0x10d1c0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d453b20>, '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.nvltiZ7TTM/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.eaZcgFWKDl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/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 07:08:40 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 07:08:40 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 07:08:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nvltiZ7TTM/Render', 07:08:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:08:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:08:40 INFO - 'HOME': '/Users/cltbld', 07:08:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:08:40 INFO - 'LOGNAME': 'cltbld', 07:08:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:08:40 INFO - 'MOZ_NO_REMOTE': '1', 07:08:40 INFO - 'NO_EM_RESTART': '1', 07:08:40 INFO - 'PAGER': '/bin/cat', 07:08:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:08:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:08:40 INFO - 'PWD': '/builds/slave/test', 07:08:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:08:40 INFO - 'SHELL': '/bin/bash', 07:08:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eaZcgFWKDl/Listeners', 07:08:40 INFO - 'TMPDIR': '/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/', 07:08:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:08:40 INFO - 'USER': 'cltbld', 07:08:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:08:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:08:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:08:40 INFO - 'XPC_FLAGS': '0x0', 07:08:40 INFO - 'XPC_SERVICE_NAME': '0', 07:08:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:08:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:08:40 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:08:40 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 07:08:40 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 07:08:40 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 07:08:40 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 07:08:40 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 07:08:40 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 07:08:43 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:08:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:08:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:08:43 INFO - Installing collected packages: mozsystemmonitor 07:08:43 INFO - Running setup.py install for mozsystemmonitor 07:08:43 INFO - Successfully installed mozsystemmonitor 07:08:43 INFO - Cleaning up... 07:08:43 INFO - Return code: 0 07:08:43 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:08:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:08:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:08:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:08:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:08:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:08:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:08:43 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 0x10d4f7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d58c618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa27a4937a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d45bd30>, '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 0x10d1c0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d453b20>, '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.nvltiZ7TTM/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.eaZcgFWKDl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/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 07:08:43 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 07:08:43 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 07:08:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nvltiZ7TTM/Render', 07:08:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:08:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:08:43 INFO - 'HOME': '/Users/cltbld', 07:08:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:08:43 INFO - 'LOGNAME': 'cltbld', 07:08:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:08:43 INFO - 'MOZ_NO_REMOTE': '1', 07:08:43 INFO - 'NO_EM_RESTART': '1', 07:08:43 INFO - 'PAGER': '/bin/cat', 07:08:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:08:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:08:43 INFO - 'PWD': '/builds/slave/test', 07:08:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:08:43 INFO - 'SHELL': '/bin/bash', 07:08:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eaZcgFWKDl/Listeners', 07:08:43 INFO - 'TMPDIR': '/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/', 07:08:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:08:43 INFO - 'USER': 'cltbld', 07:08:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:08:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:08:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:08:43 INFO - 'XPC_FLAGS': '0x0', 07:08:43 INFO - 'XPC_SERVICE_NAME': '0', 07:08:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:08:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:08:43 INFO - Downloading/unpacking jsonschema==2.5.1 07:08:43 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 07:08:43 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 07:08:43 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 07:08:43 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 07:08:43 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 07:08:43 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 07:08:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:08:46 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:08:46 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 07:08:46 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 07:08:46 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 07:08:46 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 07:08:46 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 07:08:46 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 07:08:46 INFO - Downloading functools32-3.2.3-2.tar.gz 07:08:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:08:46 INFO - warning: no files found matching '*.txt' 07:08:46 INFO - no previously-included directories found matching 'build' 07:08:46 INFO - no previously-included directories found matching 'dist' 07:08:46 INFO - no previously-included directories found matching '.git*' 07:08:46 INFO - Installing collected packages: jsonschema, functools32 07:08:46 INFO - Running setup.py install for functools32 07:08:46 INFO - warning: no files found matching '*.txt' 07:08:46 INFO - no previously-included directories found matching 'build' 07:08:46 INFO - no previously-included directories found matching 'dist' 07:08:46 INFO - no previously-included directories found matching '.git*' 07:08:46 INFO - Successfully installed jsonschema functools32 07:08:46 INFO - Cleaning up... 07:08:46 INFO - Return code: 0 07:08:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:08:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:08:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:08:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:08:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:08:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:08:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:08:46 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 0x10d4f7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d58c618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa27a4937a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d45bd30>, '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 0x10d1c0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d453b20>, '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.nvltiZ7TTM/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.eaZcgFWKDl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/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 07:08:46 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 07:08:46 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 07:08:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nvltiZ7TTM/Render', 07:08:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:08:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:08:46 INFO - 'HOME': '/Users/cltbld', 07:08:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:08:46 INFO - 'LOGNAME': 'cltbld', 07:08:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:08:46 INFO - 'MOZ_NO_REMOTE': '1', 07:08:46 INFO - 'NO_EM_RESTART': '1', 07:08:46 INFO - 'PAGER': '/bin/cat', 07:08:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:08:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:08:46 INFO - 'PWD': '/builds/slave/test', 07:08:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:08:46 INFO - 'SHELL': '/bin/bash', 07:08:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eaZcgFWKDl/Listeners', 07:08:46 INFO - 'TMPDIR': '/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/', 07:08:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:08:46 INFO - 'USER': 'cltbld', 07:08:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:08:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:08:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:08:46 INFO - 'XPC_FLAGS': '0x0', 07:08:46 INFO - 'XPC_SERVICE_NAME': '0', 07:08:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:08:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:08:47 INFO - Downloading/unpacking blobuploader==1.2.4 07:08:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:08:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:08:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:08:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:08:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:08:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:08:49 INFO - Downloading blobuploader-1.2.4.tar.gz 07:08:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:08:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:08:49 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 07:08:49 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 07:08:49 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 07:08:49 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 07:08:49 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 07:08:49 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 07:08:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:08:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:08:50 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 07:08:50 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 07:08:50 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 07:08:50 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 07:08:50 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 07:08:50 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 07:08:50 INFO - Downloading docopt-0.6.1.tar.gz 07:08:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:08:50 INFO - Installing collected packages: blobuploader, requests, docopt 07:08:50 INFO - Running setup.py install for blobuploader 07:08:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:08:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:08:51 INFO - Running setup.py install for requests 07:08:51 INFO - Running setup.py install for docopt 07:08:51 INFO - Successfully installed blobuploader requests docopt 07:08:51 INFO - Cleaning up... 07:08:51 INFO - Return code: 0 07:08:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:08:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:08:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:08:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:08:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:08:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:08:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:08:51 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 0x10d4f7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d58c618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa27a4937a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d45bd30>, '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 0x10d1c0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d453b20>, '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.nvltiZ7TTM/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.eaZcgFWKDl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/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 07:08:51 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 07:08:51 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 07:08:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nvltiZ7TTM/Render', 07:08:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:08:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:08:51 INFO - 'HOME': '/Users/cltbld', 07:08:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:08:51 INFO - 'LOGNAME': 'cltbld', 07:08:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:08:51 INFO - 'MOZ_NO_REMOTE': '1', 07:08:51 INFO - 'NO_EM_RESTART': '1', 07:08:51 INFO - 'PAGER': '/bin/cat', 07:08:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:08:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:08:51 INFO - 'PWD': '/builds/slave/test', 07:08:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:08:51 INFO - 'SHELL': '/bin/bash', 07:08:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eaZcgFWKDl/Listeners', 07:08:51 INFO - 'TMPDIR': '/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/', 07:08:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:08:51 INFO - 'USER': 'cltbld', 07:08:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:08:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:08:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:08:51 INFO - 'XPC_FLAGS': '0x0', 07:08:51 INFO - 'XPC_SERVICE_NAME': '0', 07:08:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:08:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:08:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:08:52 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-xtE9TR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:08:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:08:52 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-_mTGW_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:08:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:08:52 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-yjO_qJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:08:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:08:52 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-ZpX9B2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:08:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:08:52 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-QHe2q_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:08:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:08:52 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-M20nDB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:08:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:08:52 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-_T4Vmu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:08:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:08:52 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-C6VdjD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:08:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:08:52 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-wjTPUA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:08:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:08:53 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-UU054E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:08:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:08:53 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-6KWlys-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:08:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:08:53 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-j_hwIY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:08:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:08:53 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-XcJ50R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:08:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:08:53 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-kD4J1K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:08:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:08:53 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-WjY1pT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:08:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:08:53 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-65I7pw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:08:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:08:53 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-6Hcn5z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:08:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:08:53 INFO - Running setup.py install for manifestparser 07:08:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:08:54 INFO - Running setup.py install for mozcrash 07:08:54 INFO - Running setup.py install for mozdebug 07:08:54 INFO - Running setup.py install for mozdevice 07:08:54 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:08:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:08:54 INFO - Running setup.py install for mozfile 07:08:54 INFO - Running setup.py install for mozhttpd 07:08:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:08:54 INFO - Running setup.py install for mozinfo 07:08:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:08:54 INFO - Running setup.py install for mozInstall 07:08:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:08:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:08:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:08:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:08:55 INFO - Running setup.py install for mozleak 07:08:55 INFO - Running setup.py install for mozlog 07:08:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:08:55 INFO - Running setup.py install for moznetwork 07:08:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:08:55 INFO - Running setup.py install for mozprocess 07:08:55 INFO - Running setup.py install for mozprofile 07:08:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:08:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:08:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:08:55 INFO - Running setup.py install for mozrunner 07:08:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:08:56 INFO - Running setup.py install for mozscreenshot 07:08:56 INFO - Running setup.py install for moztest 07:08:56 INFO - Running setup.py install for mozversion 07:08:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:08:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:08:56 INFO - Cleaning up... 07:08:56 INFO - Return code: 0 07:08:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:08:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:08:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:08:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:08:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:08:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:08:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:08:56 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 0x10d4f7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d58c618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa27a4937a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d45bd30>, '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 0x10d1c0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d453b20>, '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.nvltiZ7TTM/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.eaZcgFWKDl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/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 07:08:56 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 07:08:56 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 07:08:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nvltiZ7TTM/Render', 07:08:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:08:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:08:56 INFO - 'HOME': '/Users/cltbld', 07:08:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:08:56 INFO - 'LOGNAME': 'cltbld', 07:08:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:08:56 INFO - 'MOZ_NO_REMOTE': '1', 07:08:56 INFO - 'NO_EM_RESTART': '1', 07:08:56 INFO - 'PAGER': '/bin/cat', 07:08:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:08:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:08:56 INFO - 'PWD': '/builds/slave/test', 07:08:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:08:56 INFO - 'SHELL': '/bin/bash', 07:08:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eaZcgFWKDl/Listeners', 07:08:56 INFO - 'TMPDIR': '/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/', 07:08:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:08:56 INFO - 'USER': 'cltbld', 07:08:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:08:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:08:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:08:56 INFO - 'XPC_FLAGS': '0x0', 07:08:56 INFO - 'XPC_SERVICE_NAME': '0', 07:08:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:08:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:08:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:08:56 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-7DEtqG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:08:56 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)) 07:08:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:08:56 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-K4_TF1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:08:56 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)) 07:08:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:08:56 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-iCkYMm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:08:57 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)) 07:08:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:08:57 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-Aml0Lh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:08:57 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)) 07:08:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:08:57 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-THaYc4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:08:57 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)) 07:08:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:08:57 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-VUeJg9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:08:57 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)) 07:08:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:08:57 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-Ha0g4t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:08:57 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)) 07:08:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:08:57 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-YagkSf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:08:57 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)) 07:08:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:08:57 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-xTnh6m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:08:57 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)) 07:08:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:08:57 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-htR6IK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:08:57 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)) 07:08:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:08:57 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-aSW4RV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:08:57 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)) 07:08:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:08:57 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-MzJIIc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:08:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 07:08:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:08:58 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-rQvTxI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:08:58 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)) 07:08:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:08:58 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-sKErsg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:08:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 07:08:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:08:58 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-9Yo8JQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:08:58 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)) 07:08:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:08:58 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-KMDW35-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:08:58 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)) 07:08:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:08:58 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-oHveqU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:08:58 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)) 07:08:58 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)) 07:08:58 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)) 07:08:58 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)) 07:08:58 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)) 07:08:58 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)) 07:08:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:08:58 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 07:08:58 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 07:08:58 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 07:08:58 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 07:08:58 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 07:08:58 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 07:09:00 INFO - Downloading blessings-1.6.tar.gz 07:09:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:09:01 INFO - Installing collected packages: blessings 07:09:01 INFO - Running setup.py install for blessings 07:09:01 INFO - Successfully installed blessings 07:09:01 INFO - Cleaning up... 07:09:01 INFO - Return code: 0 07:09:01 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:09:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:09:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:09:01 INFO - Reading from file tmpfile_stdout 07:09:01 INFO - Current package versions: 07:09:01 INFO - blessings == 1.6 07:09:01 INFO - blobuploader == 1.2.4 07:09:01 INFO - docopt == 0.6.1 07:09:01 INFO - functools32 == 3.2.3-2 07:09:01 INFO - jsonschema == 2.5.1 07:09:01 INFO - manifestparser == 1.1 07:09:01 INFO - mozInstall == 1.12 07:09:01 INFO - mozcrash == 0.17 07:09:01 INFO - mozdebug == 0.1 07:09:01 INFO - mozdevice == 0.48 07:09:01 INFO - mozfile == 1.2 07:09:01 INFO - mozhttpd == 0.7 07:09:01 INFO - mozinfo == 0.9 07:09:01 INFO - mozleak == 0.1 07:09:01 INFO - mozlog == 3.2 07:09:01 INFO - moznetwork == 0.27 07:09:01 INFO - mozprocess == 0.22 07:09:01 INFO - mozprofile == 0.28 07:09:01 INFO - mozrunner == 6.11 07:09:01 INFO - mozscreenshot == 0.1 07:09:01 INFO - mozsystemmonitor == 0.3 07:09:01 INFO - moztest == 0.7 07:09:01 INFO - mozversion == 1.4 07:09:01 INFO - psutil == 3.1.1 07:09:01 INFO - requests == 1.2.3 07:09:01 INFO - wsgiref == 0.1.2 07:09:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:09:01 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')]} 07:09:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:09:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:01 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')]} 07:09:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:09:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:01 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 0x10d4f7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d58c618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa27a4937a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d45bd30>, '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 0x10d1c0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d453b20>, '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.nvltiZ7TTM/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.eaZcgFWKDl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/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 07:09:01 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 07:09:01 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 07:09:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nvltiZ7TTM/Render', 07:09:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:09:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:09:01 INFO - 'HOME': '/Users/cltbld', 07:09:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:09:01 INFO - 'LOGNAME': 'cltbld', 07:09:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:09:01 INFO - 'MOZ_NO_REMOTE': '1', 07:09:01 INFO - 'NO_EM_RESTART': '1', 07:09:01 INFO - 'PAGER': '/bin/cat', 07:09:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:09:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:09:01 INFO - 'PWD': '/builds/slave/test', 07:09:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:09:01 INFO - 'SHELL': '/bin/bash', 07:09:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eaZcgFWKDl/Listeners', 07:09:01 INFO - 'TMPDIR': '/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/', 07:09:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:09:01 INFO - 'USER': 'cltbld', 07:09:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:09:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:09:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:09:01 INFO - 'XPC_FLAGS': '0x0', 07:09:01 INFO - 'XPC_SERVICE_NAME': '0', 07:09:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:09:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:09:01 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)) 07:09:01 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)) 07:09:01 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)) 07:09:01 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)) 07:09:01 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)) 07:09:01 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)) 07:09:01 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)) 07:09:01 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)) 07:09:01 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)) 07:09:01 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)) 07:09:01 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)) 07:09:01 INFO - Cleaning up... 07:09:01 INFO - Return code: 0 07:09:01 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:09:01 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')]} 07:09:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:09:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:01 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')]} 07:09:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:09:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:01 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 0x10d4f7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d58c618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa27a4937a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d45bd30>, '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 0x10d1c0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d453b20>, '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.nvltiZ7TTM/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.eaZcgFWKDl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/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 07:09:01 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 07:09:01 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 07:09:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nvltiZ7TTM/Render', 07:09:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:09:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:09:01 INFO - 'HOME': '/Users/cltbld', 07:09:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:09:01 INFO - 'LOGNAME': 'cltbld', 07:09:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:09:01 INFO - 'MOZ_NO_REMOTE': '1', 07:09:01 INFO - 'NO_EM_RESTART': '1', 07:09:01 INFO - 'PAGER': '/bin/cat', 07:09:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:09:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:09:01 INFO - 'PWD': '/builds/slave/test', 07:09:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:09:01 INFO - 'SHELL': '/bin/bash', 07:09:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eaZcgFWKDl/Listeners', 07:09:01 INFO - 'TMPDIR': '/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/', 07:09:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:09:01 INFO - 'USER': 'cltbld', 07:09:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:09:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:09:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:09:01 INFO - 'XPC_FLAGS': '0x0', 07:09:01 INFO - 'XPC_SERVICE_NAME': '0', 07:09:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:09:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:09:02 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:09:02 INFO - Cleaning up... 07:09:02 INFO - Return code: 0 07:09:02 INFO - Running post-action listener: _resource_record_post_action 07:09:02 INFO - Running post-action listener: _start_resource_monitoring 07:09:02 INFO - Starting resource monitoring. 07:09:02 INFO - ##### 07:09:02 INFO - ##### Finished create-virtualenv step (success) 07:09:02 INFO - ##### 07:09:02 INFO - ##### 07:09:02 INFO - ##### Running install step. 07:09:02 INFO - ##### 07:09:02 INFO - Running pre-action listener: _resource_record_pre_action 07:09:02 INFO - Running main action method: install 07:09:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:09:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:09:02 INFO - Reading from file tmpfile_stdout 07:09:02 INFO - Detecting whether we're running mozinstall >=1.0... 07:09:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:09:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:09:02 INFO - Reading from file tmpfile_stdout 07:09:02 INFO - Output received: 07:09:02 INFO - Usage: mozinstall [options] installer 07:09:02 INFO - Options: 07:09:02 INFO - -h, --help show this help message and exit 07:09:02 INFO - -d DEST, --destination=DEST 07:09:02 INFO - Directory to install application into. [default: 07:09:02 INFO - "/builds/slave/test"] 07:09:02 INFO - --app=APP Application being installed. [default: firefox] 07:09:02 INFO - mkdir: /builds/slave/test/build/application 07:09:02 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'] 07:09:02 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 07:09:36 INFO - Reading from file tmpfile_stdout 07:09:36 INFO - Output received: 07:09:36 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 07:09:36 INFO - Running post-action listener: _resource_record_post_action 07:09:36 INFO - ##### 07:09:36 INFO - ##### Finished install step (success) 07:09:36 INFO - ##### 07:09:36 INFO - ##### 07:09:36 INFO - ##### Running run-tests step. 07:09:36 INFO - ##### 07:09:36 INFO - Running pre-action listener: _resource_record_pre_action 07:09:36 INFO - Running main action method: run_tests 07:09:36 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:09:36 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:09:36 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:09:36 INFO - 2016-06-30 07:09:36.938 screenresolution[1641:7558] starting screenresolution argv=screenresolution get 07:09:36 INFO - 2016-06-30 07:09:36.940 screenresolution[1641:7558] Display 0: 1600x1200x32@60 07:09:36 INFO - 2016-06-30 07:09:36.946 screenresolution[1642:7560] starting screenresolution argv=screenresolution list 07:09:36 INFO - Available Modes on Display 0 07:09:36 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:09:36 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:09:36 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:09:36 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:09:37 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:09:37 INFO - Intel Iris: 07:09:37 INFO - Chipset Model: Intel Iris 07:09:37 INFO - Type: GPU 07:09:37 INFO - Bus: Built-In 07:09:37 INFO - VRAM (Dynamic, Max): 1536 MB 07:09:37 INFO - Vendor: Intel (0x8086) 07:09:37 INFO - Device ID: 0x0a2e 07:09:37 INFO - Revision ID: 0x0009 07:09:37 INFO - Displays: 07:09:37 INFO - Display: 07:09:37 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:09:37 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:09:37 INFO - Display Serial Number: 1600x1200 60 07:09:37 INFO - Main Display: Yes 07:09:37 INFO - Mirror: Off 07:09:37 INFO - Online: Yes 07:09:37 INFO - Rotation: Supported 07:09:37 INFO - Return code: 0 07:09:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:09:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:09:37 INFO - Python 2.7.3 07:09:37 INFO - Return code: 0 07:09:37 INFO - grabbing minidump binary from tooltool 07:09:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:09:37 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 0x10d45bd30>, '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 0x10d1c0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d453b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:09:37 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 07:09:37 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 07:09:37 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 07:09:37 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:09:37 INFO - Return code: 0 07:09:37 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:09:37 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:09:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:09:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:09:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:09:37 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/bH5HlthoSSKCdkw0i52lWQ/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0306', '--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 07:09:37 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/bH5HlthoSSKCdkw0i52lWQ/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0306 --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 07:09:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nvltiZ7TTM/Render', 07:09:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:09:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:09:37 INFO - 'HOME': '/Users/cltbld', 07:09:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:09:37 INFO - 'LOGNAME': 'cltbld', 07:09:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:09:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:09:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:09:37 INFO - 'MOZ_NO_REMOTE': '1', 07:09:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:09:37 INFO - 'NO_EM_RESTART': '1', 07:09:37 INFO - 'PAGER': '/bin/cat', 07:09:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:09:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:09:37 INFO - 'PWD': '/builds/slave/test', 07:09:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:09:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:09:37 INFO - 'SHELL': '/bin/bash', 07:09:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eaZcgFWKDl/Listeners', 07:09:37 INFO - 'TMPDIR': '/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/', 07:09:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:09:37 INFO - 'USER': 'cltbld', 07:09:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:09:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:09:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:09:37 INFO - 'XPC_FLAGS': '0x0', 07:09:37 INFO - 'XPC_SERVICE_NAME': '0', 07:09:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:09:37 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/bH5HlthoSSKCdkw0i52lWQ/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0306', '--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 07:09:37 INFO - mozversion application_buildid: 20160630045027 07:09:37 INFO - mozversion application_changeset: 82e1f1b9c0559f38a8460e2f2f3044de4c7712d6 07:09:37 INFO - mozversion application_display_name: Nightly 07:09:37 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:09:37 INFO - mozversion application_name: Firefox 07:09:37 INFO - mozversion application_remotingname: firefox 07:09:37 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:09:37 INFO - mozversion application_vendor: Mozilla 07:09:37 INFO - mozversion application_version: 50.0a1 07:09:37 INFO - mozversion platform_buildid: 20160630045027 07:09:37 INFO - mozversion platform_changeset: 82e1f1b9c0559f38a8460e2f2f3044de4c7712d6 07:09:37 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:09:37 INFO - mozversion platform_version: 50.0a1 07:09:37 INFO - using testdate: 1467295777 07:09:37 INFO - actual date: 1467295777 07:09:37 INFO - starting webserver on 'localhost:49274' 07:09:37 INFO - SUITE-START | Running 2 tests 07:09:37 INFO - TEST-START | dromaeo_css 07:09:37 INFO - operating with platform_type : mac_ 07:09:37 INFO - Initialising browser for dromaeo_css test... 07:09:37 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/tmp5r2_zy/profile http://localhost:49274/getInfo.html) 07:09:40 INFO - PROCESS | 1652 | __metrics Screen width/height:1600/1200 07:09:40 INFO - PROCESS | 1652 | colorDepth:24 07:09:40 INFO - PROCESS | 1652 | Browser inner width/height: 1024/689 07:09:40 INFO - PROCESS | 1652 | __metrics 07:09:40 ERROR - PROCESS | 1652 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 07:09:41 INFO - TEST-INFO | 1652: exit 0 07:09:41 INFO - Browser initialized. 07:09:41 INFO - Running cycle 1/1 for dromaeo_css test... 07:09:41 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/tmp5r2_zy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:09:53 INFO - PROCESS | 1655 | RSS: Main: 255811584 07:09:53 INFO - PROCESS | 1655 | 07:10:42 INFO - PROCESS | 1655 | 1467295842950 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] 07:12:54 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49274/tests/dromaeo/cssquery-ext.html) 07:12:55 INFO - PROCESS | 1655 | RSS: Main: 268120064 07:12:55 INFO - PROCESS | 1655 | 07:15:57 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-ext.html (next: http://localhost:49274/tests/dromaeo/cssquery-jquery.html) 07:15:58 INFO - PROCESS | 1655 | RSS: Main: 276738048 07:15:58 INFO - PROCESS | 1655 | 07:19:00 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49274/tests/dromaeo/cssquery-mootools.html) 07:19:00 INFO - PROCESS | 1655 | RSS: Main: 281534464 07:19:00 INFO - PROCESS | 1655 | 07:22:02 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49274/tests/dromaeo/cssquery-prototype.html) 07:22:03 INFO - PROCESS | 1655 | RSS: Main: 280797184 07:22:03 INFO - PROCESS | 1655 | 07:25:05 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49274/tests/dromaeo/cssquery-yui.html) 07:25:06 INFO - PROCESS | 1655 | RSS: Main: 283975680 07:25:06 INFO - PROCESS | 1655 | 07:28:09 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-yui.html (next: http://localhost:49274/tests/dromaeo/cssquery-dojo.html) 07:28:09 INFO - PROCESS | 1655 | RSS: Main: 284303360 07:28:09 INFO - PROCESS | 1655 | 07:28:09 INFO - PROCESS | 1655 | __start_tp_report 07:28:09 INFO - PROCESS | 1655 | _x_x_mozilla_page_load 07:28:09 INFO - PROCESS | 1655 | _x_x_mozilla_page_load_details 07:28:09 INFO - PROCESS | 1655 | |i|pagename|runs| 07:28:09 INFO - PROCESS | 1655 | |0;dojo.html;2848.2452150180193;3403.591569011719;3423.1955490459745;3447.8448469818854;3481.98259008705;5133.255677926699;5881.764729410824;5934.050551911695;5941.6435013899145;5945.227120474343;5798.072308430641;5906.5274778017765;5945.16767652529;5947.88104237915;6053.092036194562;5252.23842542832;5312.73436328184;5321.946780532184;5432.565394768409;5452.40023597404;5462.6995515246645;5496.697681627509;5501.0648189807625;5532.3914369419335;5536.806211782588;5216.556592689607;5290.788368465257;5343.625946183769;5366.651167674088;5375.086235340002;4854.902901941977;5092.497713174585;5329.200619907045;5362.195670649395;5369.8723268113745;5240.3187585614005;5304.708241046741;5348.465153484659;5362.088444964365;5364.8122315718765;4868.853934381974;5834.766609335621;5916.674582897939;6012.78955236569;6055.091736239555;6188.721507532126;6205.441510264098;6239.812805615793;6260.15487909131;6299.37006299371;6145.801568694106;6171.907421388682;6302.401271879165;6306.590071645374;6317.336679648617;5947.5539334550085;5975.282966044103;5985.34161242263;6000.669963151981;6047;6322.430981211713;6349.714262858182;6354.142190804182;6364.586301890362;6386.936130638727;6132.600268413531;6162.969185154136;6234.251889773256;6236.03341482071;6270.905936410957;6251.343608921089;6288.779892703734;6297;6306.306306306303;6324.557280990287;6108.500214525948;6121.849304493819;6146.754129834846;6169.907451388232;6224.066390041439;6131.540134489931;6137.039921714258;6137.101203255209;6237.126802247689;6242.344553821874;3934.724569280123;4358.3680366347335;4998.975210081924;5078.822241221614;5150.944056468415;4088.8773336799945;4319.870403887889;4507.414036175342;4514;4540.432445944257;5722.284714410699;5897.938371093159;6078;6078.270607527125;6085.2393450818645;6317.905231421532;6374.235091789015;6381.680915954184;6382.489400847921;6386.2975072741965;6072.666003369769;6081.665508397081;6099.451049405575;6106;6108.5418593605655;5460.699661518575;5543.750531226105;5560.916586251209;5591.7483713233005;5615.831525054255;6469.703459473436;6493;6526.477881769447;6550.639714815731;6559.180102487189;6119.4798442132915;6293.842653933505;6296.244450665949;6303.558750887394;6307.779227727007;6135.661410523283;6349.9682501587195;6436.388543088399;6442.130312407765;6520.543561950618;6228.03465462854;6242.625442473284;6245.656488893154;6249.50003999688;6254.28075771274;6148.415900489446;6165.876682466415;6170.845728856814;6272.968635156795;6319.968400158154;6119.8470038247615;6124.6325220486915;6135.600157732601;6194.101855231056;6241.812745617639;6142.938570614416;6201;6210.285817131088;6220.502359811295;6220.937790622217;5996.370381110095;6089.056196289582;6111.5110791137495;6171.876562468815;6216.906746398718;6142.648617304186;6175.6912154393;6190.690465476799;6219.751209951552;6220.471259942775;5405.4594540547205;6023.488003519575;6196.690165491617;6201.627902325875;6204.875902482016 07:28:09 INFO - PROCESS | 1655 | |1;ext.html;475.9238521836507;525.8737902903305;532.4223217808677;559.6138664321617;572.5019233267055;29389.853050734742;37824.621753782456;39538.60461395385;39616.009599759986;39630;40831.57089501868;41104.58895411045;41192.17615647685;41253.79373103131;41276.58723412765;9405.623775048989;9557.474338911357;9575.281853860954;9662.275329350292;9669.854952175723;9635.951820240889;9693.17608003317;9694.612215511406;9697.933227345022;9733.367331123489;9624.759381015496;9657.565409556551;9711.417314961089;9714.854277185848;9737.659181928633;9548.713538593818;9641.951790241039;9702.805943881154;9711.951440242754;9712.660056898045;9519.286053545942;9609.855852162224;9615.23078153746;9638.036196380375;9654.179394751454;32117.357652847048;39503.60496395028;39565.20869582621;39853.80073099645;39893;3032.287412458071;3180.1254654970066;3195.0414875537476;3196.824174670392;3783.564890037653;30268.243293917607;30780;31135.532967005285;31155.844220778978;31797.841010794797;3179.650238473766;3187.0757480330676;3188.920276993094;3271.263965607719;3287.161773747703;344079;397963;427051;434723;436234;33254.66745332516;34306.48540271898;34418;34965.12587185341;35007.299854003286;35511.28977420437;35661.64338356635;35716;35784.28431431357;35877.1030724234;12720.300383478812;14833.851661483248;15012.949093563564;15015.849841501664;15019.474318398803;12680.492780288869;12703.618891433272;12730.10889237763;12755.936220319025;12767.233965962072;7763.805904852424;7765.456418050795;7824.256695614022;7871.842563148705;7941.801454963556;3207.631122420905;3226.7738259461253;3252.8210948398064;3255.137388592025;3280.5407242986003;790.9841803163904;899.2401420799414;904.8463209407926;947.966821161256;1023.3859684189426;24459.755402446102;27995.30011749682;30421.847890760404;30568.388632227674;31232.37535249282;940.501534186882;1011.838105903052;1120.1151090638305;1122.5734220995969;1163.3892206591438;12105.636830895088;14879.33043013067;15117.410998092799;15695.979761315479;15833.208339583205;580501;672204;690469;691818;692026;60367.39632603706;60717.69641151854;60854.0871886922;60951.69524152351;61019.69490152521;1264.89248413884;1345.3004437692346;1350.4395675794435;1395.9371828267751;1401.467442371892;26615.93536258528;29800.701992979793;30052.84973575118;30159.275468390908;30393;49405.28270945133;52019.47980520298;52888;52979;53118.203226950856;537434;540199;541814;543295.2835235798;543311;26436.735632644195;27245.318867028484;27615.75729092236;27625.585616215372;27721.30696732517;41534;42207.577924220364;42275.57724422716;42731.1541961225;42731.58147348267;40132.799336004304;40259.1948161041;40612.59387406088;41111.38332925068;41362.96592585089;30988.380232395677;39646.207075858896;39860.601393985686;39866.91165516306;41014.589854101076;38793.224135517696;38828.6117138825;38876.80561597287;39193.41209881911;39225;34508.82745586256;35511;35665.64334356623;35796.105097371736;35909.64090359167;22232;25735.613965790904;25830.837612307867;25871;26402 07:28:09 INFO - PROCESS | 1655 | |2;jquery.html;332.8964482739716;363.469334771234;387.41113507468657;387.59496326338973;411.116100384174;16213;16630.750538741915;20202.090905909234;21456.678149827727;21640.89179554102;18783.62432751344;19740.210391584318;20676.379708608765;21583.352499425044;21593.244236451726;5432.456754324556;5568.248286481334;5597.832065038056;5611.298587676541;6086.7565297388055;6129.295131059918;6140.925338065843;6146.17026701394;6174.845628859292;6181.443670069692;5379.300690910196;5556.638818476807;5840.240768700063;6037.607555508878;6121.479674227696;5434.755436005389;5441.564674826004;5507;5532.6680399175975;5548.889022219553;5167.612429067797;5257.13257312543;5365;5374.355077390738;5397.8380648580605;13786.448542058306;13794.93102534481;13839.792403113961;23898.566086034894;26491.07281245147;2014.687723402875;2162.4593851537115;2211.4139752965475;2226.699395581592;2321.953560928772;9960.501974901226;10208.285420020602;10436.425996570186;12640.367981600883;15393.923030384889;1812.900290484023;1838.4392760208132;1881.294514557041;1890.7163925411162;1891.4798430431604;119033;124901.12648310282;126735;127508;127787;10022.949885250528;11407.144464165222;11615.709607259887;12010.759784804255;12031.518739250507;12401.875981240071;14861.628459288604;14863.108213507008;14935.775963360558;14976.951613387177;7732.922670773332;7916.1792787658005;8260.586970651444;8454.239118479367;8465.83068338642;7018.508704390643;7527.2849079337375;8312.33501319893;8321.583920803936;8411.957940210259;4523.208438523311;4624.606908412823;4647.674662773574;4669.509701481364;4725.527447255316;1796.6137280484759;1958.4418440744319;1981.1382048808814;1997.690357994513;2004.8997550122435;859.8495263328892;905.9355257572327;961.7689357622255;1024.6618615856748;1027.6968294353185;18016;19420.320288790106;19704.605907881763;21166.833166833167;21410.464738381666;967.8644989701447;976.9120779129912;984.2814745236018;990.4255531791543;1008.2708155513184;10833.891661083446;11011.61459348919;11028.944855275673;11073.667789966314;11087.22389432748;595925;600945;602224;607551.9622401859;612545;102962.97037029534;126072.1089183663;128206.35896820643;129537.35231323783;129786;987.5259875259916;987.8765154355706;993.5380048277585;1005.5424781724444;1007.4912169354429;16296.755548666542;17593.296268149643;17923.37268195607;18780.248790048245;19492.610147797248;38666.80666596649;45076;54019.72990135024;58086.4191358081;58154.4184558149;71941;73698.63150684212;75235.26251915075;84090.57954710188;88275.55862220905;5406;5753.424657534213;8234.258916697527;8346.666133354598;8514.318854491501;11083.667489975314;11344.546218151512;11478.426078696199;13183.340832958122;13614.251216183206;11391.658250252505;11459.255148415326;11543.595974140864;11550.537978481103;11677.532898683958;11242.269252498561;11415.543378264776;11442;11580.6525804226;11694.88305116972;11791.056715462571;11807.822882656596;11809.291442513477;11830.349330786888;12054.51781928713;8363.790905227175;8392.244697977212;8399.076101628938;8430.789230269293;8433.114522975;11027.779444410906;11472.88527114718;11555.537778489102;11625.12811539121;11685.00677442427 07:28:09 INFO - PROCESS | 1655 | |3;mootools.html;1326.4893016188767;1555.3312075807403;1695.2795062098605;1842.8525717942557;1855.5268406556327;7946.324562412202;8547.957260213705;8627.396082274243;9114.863277050841;9139.223166030879;7483.775486735407;8647.87028194576;8762.123787621234;8779.517126558037;8785.60464779085;2362.7400985891536;2386.72552656445;2387.6060450025725;2392.5334559760854;2402.087206861399;2324.31432727345;2355.7997570206467;2362.8227882908764;2368.2421625079983;2402.2192787344184;2353.2822489140804;2376.251480783548;2376.489054853206;2381.5475059738596;2401.1235898896866;2310.780475854791;2364.4679947011955;2373.0982226753895;2376.2158487699103;2383.8914904569374;2342.554914566227;2358.693369861924;2370.0401337458356;2374.050379848057;2377.0491803278655;8883.466991980502;8915.108489151098;8920.241779448756;8954.37319387643;8990.460572365679;5260.947390526084;5298.735063246861;5304.840854774363;5305.495977882095;5418.620696551243;3566.144125409909;3620.6922411595046;3643.325984692814;3693.409054551286;3695.7412981091334;1088.820344643133;1089.809283375414;1090.1878100814943;1093.7101668057971;1114.0697517572837;11555.94222028893;11709.590164344207;11719.296842189497;11740.647780566596;11751.294922304689;3758.9850740299967;4066.5933406659688;4610.216263235258;4751.596114330251;4823.686460380064;8763.298936085097;9823.754406139904;9921.40471571708;9936.205103591696;9941.155001824925;5347.2781174541715;5363.597730170253;5398.946010539844;5401.945980540223;5408.972955135199;3825.540935087807;4841.201201801663;4909.116359055333;4996.7501624918605;5000.199968005102;3351.5978082629754;3954.406838974177;4038.5759495252573;4096.774677392712;4100.815463304159;1306.8366454193226;1314.3559655768604;1316.4010375279224;1317.3808310094241;1326.9336533173496;842.8609279468819;914.5061666700041;917.9357444978921;940.05994005994;946.8674385586023;5906.970465147647;6006.279246490449;6104.145419641254;6136.6011209271255;6206.224221972254;944.4569372610639;1033.6278939581896;1073.88187299397;1080;1082.3884505254664;4023.376376661622;4068.145689405258;4074.348104303297;4127.772972486482;4131.586841315844;9018.233450156678;10665.253432259668;10789.19081068923;10837.83743243852;10902.236843420884;10698.572057117784;10740.892591074145;10803;10804.621838235624;10813.62152324665;7945.245201705829;8289.626966786509;8347.833043339098;8368.079511253758;8427.915720842713;4878.365812444359;5543.61194716366;6033.456988871023;6233;6308.243010838729;9836.852447213154;10096;10209.591616335263;10324.22568307395;10357.689269321932;10039;10159.44123073238;10244.385336879812;10249.487525623837;10301.793964120825;7348.008018917378;7454.925450745423;7535.585542795199;7709.845803083795;7711.305982461606;8404.411691181558;8501.404901656824;8580.0561938188;8584.184502472255;8638.352123590881;7455.888161677688;7619.542827430372;7626.847463050819;7726.7681969541;7746.341560967381;7423.183449820407;7450.292222238879;7497.175310715926;7563.394928405604;7614.695412183451;7011.894821577578;7020.5787652741;7067.363937245673;7079.2566780487305;7084.822879428056;4955.108080545537;5081.187010078517;5146.845594632167;5147.430033839715;5205.609579281493;5101.69389836611;5102.2091575804325;5111.207762796773;5253.553447956813;5264.368275806928 07:28:09 INFO - PROCESS | 1655 | |4;prototype.html;276.9958898991157;300.19098529463093;312.79199332443926;315.38027775421307;318.95215717642367;5367.731613419333;5763.567732420075;5798.768049278035;5829.300483941927;5852.536865783554;5280.937056507226;5772.595918285721;5780.971095144529;5783.739731712072;5826.941730582693;4138.793060346986;4205.453291072156;4313.309870420733;4322.675799315064;4350.434443522354;3607.4588811678327;3725.701943844486;4229.365595160735;4344.63070638996;4380.335472520438;3807.990882416162;4332.263515202423;4341.891452713676;4352.521222665504;4364.476262848447;4061.6547593454593;4339.8481053163305;4349.934750978738;4355.998120432302;4402.119576084764;3124.406362791085;3174.3968645957193;3309.7683162178655;3745.887623371276;3765.303418867491;5087.821926232564;5107.565856902168;5223.6865788052455;5618.325800903917;5731.914021289684;4722.386089808338;4977.303177555145;5003.274525193863;5043.571296439807;5101.438841727407;4874.951250487486;5940.108983652443;6146.969265153645;6155.72299246535;6168.629882207082;4216.430781844473;4217.936730949038;4218.1985422769885;4233.407322974786;4243.151369726067;5246.662101164179;5839.854003649943;6081.510030042624;6378.043293505965;6416.743330266784;3627.3108109459645;3827.851644506637;4102.958970410317;4279.914401711948;4298.161858437575;4359.694821362475;4375.365571992043;4376.693631445768;4380.956190438055;4385.25921299188;4606.907861842745;4714.599259062949;5011.298418221452;5056.721880296545;5115.948840511622;5103.489651034867;5730.36965933747;6040;6077.453029227302;6151.477124444383;1168.1472525056586;1343.6640839790052;1483.5030264861177;1499.6325900154532;1507.4196434372845;916.1800188830958;927.958241879117;937.7139972308512;980.7008862297068;996.3822430093244;5533.363663178786;5616.382197958222;5647.983362994701;5664.461876121762;5705.657660540381;5720.914186287209;6251.343608920998;6259.655718935503;6263.279722831841;6263.530235232376;4837.95162048382;5436.972815135899;5590.524805391506;5646.548276137899;5712.828615141552;2567.164477398632;2890.7542858856814;3199.616046074486;3270.9345813083605;3288.638249792521;6231.532635052389;6323.747050117944;6456.257530383972;6464.806055818333;6465.838354041187;5776.884462310731;5829.59192856496;5903.940960590425;6358;6389.945658966311;6086.695665216722;6127.387261273837;6394.744210231632;6398.5521013528605;6413.647249401328;4714.104320179155;5653.378128405954;6158.784442544489;6173.753049877954;6198.659073750987;6020.87958240824;6073.388442969389;6081.817545473643;6109.266887973472;6118;5635.281239222077;6102.938970610237;6126.507890502371;6154.522914500398;6427.517936154713;3828.688184720141;3962.9603703963744;4191.7694526801315;4222.218889505451;4262.829486820492;4814.831480898151;4867.63492738039;5937.693707384368;6145.4161854623735;6148.292946311231;4785.736784476748;5361.973190134025;5435.130379139318;5599.524040456444;5954.821355359346;5213.40045894727;5881.3236477803885;5943.257092863392;5957.6339368256795;5975.34271230173;5523.309586301712;5620.3536593290655;5769.336526299361;5849.94150058511;5863.736131874161;5144.762028517607;6044.848878778066;6059.666718330358;6081.331053584191;6085;5381.784728610812;5487.039768040657;5955.136505206634;5962.52299816005;5975.970120149372 07:28:09 INFO - PROCESS | 1655 | |5;yui.html;723.5188599581278;769.372961036755;782.2177822177825;819.5123901278737;861.9008813986392;15162.620934476643;15809.446669366574;15893.44372946947;15970.84029159708;15986;14210.857891421083;14337;14350.354234059467;14359.35382907769;14363.138211707304;825.3603457320579;835.1481488881337;867.1328671328671;877.2236570634971;877.5480627476854;686.7459040155125;861.0743450790426;862.5687156421789;866.0776273268948;870.3298460185684;900.5947323704327;911.9452832830051;912.5710915869564;912.9817403651956;913.127962795532;888.9244414224798;893.2228960804109;898.6495266845935;904.6064961741663;908.4685459006489;658.108263303222;665.4510029225908;669.8660267946382;675.3347952267013;676.8477092654163;13045.86954130456;14903.105813651217;15270.923645381701;15274.923625381802;15372.692546149014;14081.225532595703;14119.435222591084;14244.643883902881;14297.285135743172;14461.927690361481;11658.708532286675;11736.23714458566;11831.349275789828;11854.644360669194;12300.138990270685;3744.756590821588;3866.555346135174;3874.1670540833857;3891.1439483313907;4004.539477960043;115813.42093289479;116364;119444;119534.40232798868;119559;10892.564297428173;10933.890661093288;10991.670249892515;11002.559897604166;11239.438028098562;22001.779982200293;22156.2245321413;22179.891005449663;22195;22201.888990554944;7943.523388596703;7990.600469976478;8187.058488273925;8230.506169629842;8235.38234632405;4584.129015487047;4588.564086411786;4588.715159755274;4589.207972201094;4657.790399432034;3542.964570354315;3660.5790334111916;3670.0641336459566;3675.8713445029293;3683.981580092136;666.590047121017;671.9260881303053;699.3426179391356;729.6789412658413;747.129594022968;598.964062156272;666.54027679382;673.3165836675778;683.8666460040344;685.6178994890073;8425.410221284574;9406.529673516434;9582.808343833085;9670.468124253233;9829.508524573743;540.645876950598;563.248063834777;627.9560430769802;641.8395401149712;668.2882729892649;4451.221036318631;4665.370175026328;4679.64902632304;4690.929636055462;4721.598664113589;78000;106466.403003955;133926;164889;164905.17547412188;143813.28093359465;145494.27252863668;147771.52228477577;148266.25866870597;152029;127714;128148.87404503902;129090;132301.99999999808;133107.66892331146;7922.445428819928;8586.957065214634;8773.122687731176;9113.3165012623;9122.680706175252;69184;70406;70554.64722676354;72140;72375.63812181116;63907.680461597396;81548;86642.56678716566;101221;103163.45254821033;12765.297908615115;13373.331333433483;13425;13675.111117777313;13743.106698064594;12821.743565128832;14977.326020328894;15083.396664133312;15311.540653780405;15447.459338923083;13814.654633633838;14038.438462461387;14523.273836307932;14547.345369458188;14554.781678274623;13513.729725405634;13875.583732488041;13925;14407.711845763235;14567.781483277971;13669.931650341685;13726.176429414267;14052.648683782987;14235.572932812032;14368.712625747217;10936.084026206217;11366.295055741704;11477;11571.6528504145;11639.941800290944;10886.564537418415;11166.553337866395;11688.298702077902;11737.295762254293;11762.764744704888 07:28:09 INFO - PROCESS | 1655 | __end_tp_report 07:28:09 INFO - PROCESS | 1655 | __start_cc_report 07:28:09 INFO - PROCESS | 1655 | _x_x_mozilla_cycle_collect,445 07:28:09 INFO - PROCESS | 1655 | __end_cc_report 07:28:09 INFO - PROCESS | 1655 | __startTimestamp1467296889490__endTimestamp 07:28:09 INFO - PROCESS | 1655 | 07:28:09 INFO - PROCESS | 1655 | ------- Summary: start ------- 07:28:09 INFO - PROCESS | 1655 | Number of tests: 6 07:28:09 INFO - PROCESS | 1655 | 07:28:09 INFO - PROCESS | 1655 | [#0] dojo.html Cycles:165 Average:5833.67 Median:6119.85 stddev:680.50 (11.1%) stddev-sans-first:641.02 07:28:09 INFO - PROCESS | 1655 | Values: 2848.2 3403.6 3423.2 3447.8 3482.0 5133.3 5881.8 5934.1 5941.6 5945.2 5798.1 5906.5 5945.2 5947.9 6053.1 5252.2 5312.7 5321.9 5432.6 5452.4 5462.7 5496.7 5501.1 5532.4 5536.8 5216.6 5290.8 5343.6 5366.7 5375.1 4854.9 5092.5 5329.2 5362.2 5369.9 5240.3 5304.7 5348.5 5362.1 5364.8 4868.9 5834.8 5916.7 6012.8 6055.1 6188.7 6205.4 6239.8 6260.2 6299.4 6145.8 6171.9 6302.4 6306.6 6317.3 5947.6 5975.3 5985.3 6000.7 6047.0 6322.4 6349.7 6354.1 6364.6 6386.9 6132.6 6163.0 6234.3 6236.0 6270.9 6251.3 6288.8 6297.0 6306.3 6324.6 6108.5 6121.8 6146.8 6169.9 6224.1 6131.5 6137.0 6137.1 6237.1 6242.3 3934.7 4358.4 4999.0 5078.8 5150.9 4088.9 4319.9 4507.4 4514.0 4540.4 5722.3 5897.9 6078.0 6078.3 6085.2 6317.9 6374.2 6381.7 6382.5 6386.3 6072.7 6081.7 6099.5 6106.0 6108.5 5460.7 5543.8 5560.9 5591.7 5615.8 6469.7 6493.0 6526.5 6550.6 6559.2 6119.5 6293.8 6296.2 6303.6 6307.8 6135.7 6350.0 6436.4 6442.1 6520.5 6228.0 6242.6 6245.7 6249.5 6254.3 6148.4 6165.9 6170.8 6273.0 6320.0 6119.8 6124.6 6135.6 6194.1 6241.8 6142.9 6201.0 6210.3 6220.5 6220.9 5996.4 6089.1 6111.5 6171.9 6216.9 6142.6 6175.7 6190.7 6219.8 6220.5 5405.5 6023.5 6196.7 6201.6 6204.9 07:28:09 INFO - PROCESS | 1655 | 07:28:09 INFO - PROCESS | 1655 | [#1] ext.html Cycles:180 Average:65649.84 Median:39521.10 stddev:147265.90 (372.6%) stddev-sans-first:147597.72 07:28:09 INFO - PROCESS | 1655 | Values: 475.9 525.9 532.4 559.6 572.5 29389.9 37824.6 39538.6 39616.0 39630.0 40831.6 41104.6 41192.2 41253.8 41276.6 9405.6 9557.5 9575.3 9662.3 9669.9 9636.0 9693.2 9694.6 9697.9 9733.4 9624.8 9657.6 9711.4 9714.9 9737.7 9548.7 9642.0 9702.8 9712.0 9712.7 9519.3 9609.9 9615.2 9638.0 9654.2 32117.4 39503.6 39565.2 39853.8 39893.0 3032.3 3180.1 3195.0 3196.8 3783.6 30268.2 30780.0 31135.5 31155.8 31797.8 3179.7 3187.1 3188.9 3271.3 3287.2 344079.0 397963.0 427051.0 434723.0 436234.0 33254.7 34306.5 34418.0 34965.1 35007.3 35511.3 35661.6 35716.0 35784.3 35877.1 12720.3 14833.9 15012.9 15015.8 15019.5 12680.5 12703.6 12730.1 12755.9 12767.2 7763.8 7765.5 7824.3 7871.8 7941.8 3207.6 3226.8 3252.8 3255.1 3280.5 791.0 899.2 904.8 948.0 1023.4 24459.8 27995.3 30421.8 30568.4 31232.4 940.5 1011.8 1120.1 1122.6 1163.4 12105.6 14879.3 15117.4 15696.0 15833.2 580501.0 672204.0 690469.0 691818.0 692026.0 60367.4 60717.7 60854.1 60951.7 61019.7 1264.9 1345.3 1350.4 1395.9 1401.5 26615.9 29800.7 30052.8 30159.3 30393.0 49405.3 52019.5 52888.0 52979.0 53118.2 537434.0 540199.0 541814.0 543295.3 543311.0 26436.7 27245.3 27615.8 27625.6 27721.3 41534.0 42207.6 42275.6 42731.2 42731.6 40132.8 40259.2 40612.6 41111.4 41363.0 30988.4 39646.2 39860.6 39866.9 41014.6 38793.2 38828.6 38876.8 39193.4 39225.0 34508.8 35511.0 35665.6 35796.1 35909.6 22232.0 25735.6 25830.8 25871.0 26402.0 07:28:09 INFO - PROCESS | 1655 | 07:28:09 INFO - PROCESS | 1655 | [#2] jquery.html Cycles:180 Average:34970.80 Median:21588.30 stddev:100851.02 (467.2%) stddev-sans-first:101100.40 07:28:09 INFO - PROCESS | 1655 | Values: 332.9 363.5 387.4 387.6 411.1 16213.0 16630.8 20202.1 21456.7 21640.9 18783.6 19740.2 20676.4 21583.4 21593.2 5432.5 5568.2 5597.8 5611.3 6086.8 6129.3 6140.9 6146.2 6174.8 6181.4 5379.3 5556.6 5840.2 6037.6 6121.5 5434.8 5441.6 5507.0 5532.7 5548.9 5167.6 5257.1 5365.0 5374.4 5397.8 13786.4 13794.9 13839.8 23898.6 26491.1 2014.7 2162.5 2211.4 2226.7 2322.0 9960.5 10208.3 10436.4 12640.4 15393.9 1812.9 1838.4 1881.3 1890.7 1891.5 119033.0 124901.1 126735.0 127508.0 127787.0 10022.9 11407.1 11615.7 12010.8 12031.5 12401.9 14861.6 14863.1 14935.8 14977.0 7732.9 7916.2 8260.6 8454.2 8465.8 7018.5 7527.3 8312.3 8321.6 8412.0 4523.2 4624.6 4647.7 4669.5 4725.5 1796.6 1958.4 1981.1 1997.7 2004.9 859.8 905.9 961.8 1024.7 1027.7 18016.0 19420.3 19704.6 21166.8 21410.5 967.9 976.9 984.3 990.4 1008.3 10833.9 11011.6 11028.9 11073.7 11087.2 595925.0 600945.0 602224.0 607552.0 612545.0 102963.0 126072.1 128206.4 129537.4 129786.0 987.5 987.9 993.5 1005.5 1007.5 16296.8 17593.3 17923.4 18780.2 19492.6 38666.8 45076.0 54019.7 58086.4 58154.4 71941.0 73698.6 75235.3 84090.6 88275.6 5406.0 5753.4 8234.3 8346.7 8514.3 11083.7 11344.5 11478.4 13183.3 13614.3 11391.7 11459.3 11543.6 11550.5 11677.5 11242.3 11415.5 11442.0 11580.7 11694.9 11791.1 11807.8 11809.3 11830.3 12054.5 8363.8 8392.2 8399.1 8430.8 8433.1 11027.8 11472.9 11555.5 11625.1 11685.0 07:28:09 INFO - PROCESS | 1655 | 07:28:09 INFO - PROCESS | 1655 | [#3] mootools.html Cycles:180 Average:5752.61 Median:4932.11 stddev:3200.90 (64.9%) stddev-sans-first:3192.59 07:28:09 INFO - PROCESS | 1655 | Values: 1326.5 1555.3 1695.3 1842.9 1855.5 7946.3 8548.0 8627.4 9114.9 9139.2 7483.8 8647.9 8762.1 8779.5 8785.6 2362.7 2386.7 2387.6 2392.5 2402.1 2324.3 2355.8 2362.8 2368.2 2402.2 2353.3 2376.3 2376.5 2381.5 2401.1 2310.8 2364.5 2373.1 2376.2 2383.9 2342.6 2358.7 2370.0 2374.1 2377.0 8883.5 8915.1 8920.2 8954.4 8990.5 5260.9 5298.7 5304.8 5305.5 5418.6 3566.1 3620.7 3643.3 3693.4 3695.7 1088.8 1089.8 1090.2 1093.7 1114.1 11555.9 11709.6 11719.3 11740.6 11751.3 3759.0 4066.6 4610.2 4751.6 4823.7 8763.3 9823.8 9921.4 9936.2 9941.2 5347.3 5363.6 5398.9 5401.9 5409.0 3825.5 4841.2 4909.1 4996.8 5000.2 3351.6 3954.4 4038.6 4096.8 4100.8 1306.8 1314.4 1316.4 1317.4 1326.9 842.9 914.5 917.9 940.1 946.9 5907.0 6006.3 6104.1 6136.6 6206.2 944.5 1033.6 1073.9 1080.0 1082.4 4023.4 4068.1 4074.3 4127.8 4131.6 9018.2 10665.3 10789.2 10837.8 10902.2 10698.6 10740.9 10803.0 10804.6 10813.6 7945.2 8289.6 8347.8 8368.1 8427.9 4878.4 5543.6 6033.5 6233.0 6308.2 9836.9 10096.0 10209.6 10324.2 10357.7 10039.0 10159.4 10244.4 10249.5 10301.8 7348.0 7454.9 7535.6 7709.8 7711.3 8404.4 8501.4 8580.1 8584.2 8638.4 7455.9 7619.5 7626.8 7726.8 7746.3 7423.2 7450.3 7497.2 7563.4 7614.7 7011.9 7020.6 7067.4 7079.3 7084.8 4955.1 5081.2 5146.8 5147.4 5205.6 5101.7 5102.2 5111.2 5253.6 5264.4 07:28:09 INFO - PROCESS | 1655 | 07:28:09 INFO - PROCESS | 1655 | [#4] prototype.html Cycles:180 Average:4863.56 Median:5528.34 stddev:1505.11 (27.2%) stddev-sans-first:1469.44 07:28:09 INFO - PROCESS | 1655 | Values: 277.0 300.2 312.8 315.4 319.0 5367.7 5763.6 5798.8 5829.3 5852.5 5280.9 5772.6 5781.0 5783.7 5826.9 4138.8 4205.5 4313.3 4322.7 4350.4 3607.5 3725.7 4229.4 4344.6 4380.3 3808.0 4332.3 4341.9 4352.5 4364.5 4061.7 4339.8 4349.9 4356.0 4402.1 3124.4 3174.4 3309.8 3745.9 3765.3 5087.8 5107.6 5223.7 5618.3 5731.9 4722.4 4977.3 5003.3 5043.6 5101.4 4875.0 5940.1 6147.0 6155.7 6168.6 4216.4 4217.9 4218.2 4233.4 4243.2 5246.7 5839.9 6081.5 6378.0 6416.7 3627.3 3827.9 4103.0 4279.9 4298.2 4359.7 4375.4 4376.7 4381.0 4385.3 4606.9 4714.6 5011.3 5056.7 5115.9 5103.5 5730.4 6040.0 6077.5 6151.5 1168.1 1343.7 1483.5 1499.6 1507.4 916.2 928.0 937.7 980.7 996.4 5533.4 5616.4 5648.0 5664.5 5705.7 5720.9 6251.3 6259.7 6263.3 6263.5 4838.0 5437.0 5590.5 5646.5 5712.8 2567.2 2890.8 3199.6 3270.9 3288.6 6231.5 6323.7 6456.3 6464.8 6465.8 5776.9 5829.6 5903.9 6358.0 6389.9 6086.7 6127.4 6394.7 6398.6 6413.6 4714.1 5653.4 6158.8 6173.8 6198.7 6020.9 6073.4 6081.8 6109.3 6118.0 5635.3 6102.9 6126.5 6154.5 6427.5 3828.7 3963.0 4191.8 4222.2 4262.8 4814.8 4867.6 5937.7 6145.4 6148.3 4785.7 5362.0 5435.1 5599.5 5954.8 5213.4 5881.3 5943.3 5957.6 5975.3 5523.3 5620.4 5769.3 5849.9 5863.7 5144.8 6044.8 6059.7 6081.3 6085.0 5381.8 5487.0 5955.1 5962.5 5976.0 07:28:09 INFO - PROCESS | 1655 | 07:28:09 INFO - PROCESS | 1655 | [#5] yui.html Cycles:180 Average:25859.13 Median:12872.43 stddev:41805.11 (324.8%) stddev-sans-first:41879.78 07:28:09 INFO - PROCESS | 1655 | Values: 723.5 769.4 782.2 819.5 861.9 15162.6 15809.4 15893.4 15970.8 15986.0 14210.9 14337.0 14350.4 14359.4 14363.1 825.4 835.1 867.1 877.2 877.5 686.7 861.1 862.6 866.1 870.3 900.6 911.9 912.6 913.0 913.1 888.9 893.2 898.6 904.6 908.5 658.1 665.5 669.9 675.3 676.8 13045.9 14903.1 15270.9 15274.9 15372.7 14081.2 14119.4 14244.6 14297.3 14461.9 11658.7 11736.2 11831.3 11854.6 12300.1 3744.8 3866.6 3874.2 3891.1 4004.5 115813.4 116364.0 119444.0 119534.4 119559.0 10892.6 10933.9 10991.7 11002.6 11239.4 22001.8 22156.2 22179.9 22195.0 22201.9 7943.5 7990.6 8187.1 8230.5 8235.4 4584.1 4588.6 4588.7 4589.2 4657.8 3543.0 3660.6 3670.1 3675.9 3684.0 666.6 671.9 699.3 729.7 747.1 599.0 666.5 673.3 683.9 685.6 8425.4 9406.5 9582.8 9670.5 9829.5 540.6 563.2 628.0 641.8 668.3 4451.2 4665.4 4679.6 4690.9 4721.6 78000.0 106466.4 133926.0 164889.0 164905.2 143813.3 145494.3 147771.5 148266.3 152029.0 127714.0 128148.9 129090.0 132302.0 133107.7 7922.4 8587.0 8773.1 9113.3 9122.7 69184.0 70406.0 70554.6 72140.0 72375.6 63907.7 81548.0 86642.6 101221.0 103163.5 12765.3 13373.3 13425.0 13675.1 13743.1 12821.7 14977.3 15083.4 15311.5 15447.5 13814.7 14038.4 14523.3 14547.3 14554.8 13513.7 13875.6 13925.0 14407.7 14567.8 13669.9 13726.2 14052.6 14235.6 14368.7 10936.1 11366.3 11477.0 11571.7 11639.9 10886.6 11166.6 11688.3 11737.3 11762.8 07:28:09 INFO - PROCESS | 1655 | -------- Summary: end -------- 07:28:09 INFO - PROCESS | 1655 | 07:28:10 INFO - TEST-INFO | 1655: exit 0 07:28:10 INFO - TEST-OK | dromaeo_css | took 1112583ms 07:28:10 INFO - TEST-START | kraken 07:28:10 INFO - operating with platform_type : mac_ 07:28:10 INFO - Initialising browser for kraken test... 07:28:10 INFO - TEST-INFO | started process 1666 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/tmpIrdE01/profile http://localhost:49274/getInfo.html) 07:28:12 INFO - PROCESS | 1666 | __metrics Screen width/height:1600/1200 07:28:12 INFO - PROCESS | 1666 | colorDepth:24 07:28:12 INFO - PROCESS | 1666 | Browser inner width/height: 1024/689 07:28:12 INFO - PROCESS | 1666 | __metrics 07:28:13 ERROR - PROCESS | 1666 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 07:28:13 INFO - TEST-INFO | 1666: exit 0 07:28:13 INFO - Browser initialized. 07:28:13 INFO - Running cycle 1/1 for kraken test... 07:28:13 INFO - TEST-INFO | started process 1668 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/tmpIrdE01/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:28:25 INFO - PROCESS | 1668 | RSS: Main: 255881216 07:28:25 INFO - PROCESS | 1668 | 07:28:28 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection) 07:28:29 INFO - PROCESS | 1668 | RSS: Main: 268828672 07:28:29 INFO - PROCESS | 1668 | 07:28:31 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-dft) 07:28:32 INFO - PROCESS | 1668 | RSS: Main: 272941056 07:28:32 INFO - PROCESS | 1668 | 07:28:35 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-fft) 07:28:36 INFO - PROCESS | 1668 | RSS: Main: 273252352 07:28:36 INFO - PROCESS | 1668 | 07:28:38 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator) 07:28:39 INFO - PROCESS | 1668 | RSS: Main: 274120704 07:28:39 INFO - PROCESS | 1668 | 07:28:41 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:28:41 INFO - PROCESS | 1668 | RSS: Main: 274817024 07:28:41 INFO - PROCESS | 1668 | 07:28:44 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom) 07:28:45 INFO - PROCESS | 1668 | RSS: Main: 275075072 07:28:45 INFO - PROCESS | 1668 | 07:28:48 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate) 07:28:48 INFO - PROCESS | 1668 | RSS: Main: 274964480 07:28:48 INFO - PROCESS | 1668 | 07:28:51 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial) 07:28:52 INFO - PROCESS | 1668 | RSS: Main: 275070976 07:28:52 INFO - PROCESS | 1668 | 07:28:53 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:28:54 INFO - PROCESS | 1668 | RSS: Main: 274923520 07:28:54 INFO - PROCESS | 1668 | 07:28:56 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:28:56 INFO - PROCESS | 1668 | RSS: Main: 275103744 07:28:56 INFO - PROCESS | 1668 | 07:28:59 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:28:59 INFO - PROCESS | 1668 | RSS: Main: 275406848 07:28:59 INFO - PROCESS | 1668 | 07:29:02 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:29:03 INFO - PROCESS | 1668 | RSS: Main: 276271104 07:29:03 INFO - PROCESS | 1668 | 07:29:06 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:29:06 INFO - PROCESS | 1668 | RSS: Main: 275464192 07:29:06 INFO - PROCESS | 1668 | 07:29:08 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49274/tests/kraken/driver.html?testName=ai-astar) 07:29:08 INFO - PROCESS | 1668 | RSS: Main: 276684800 07:29:08 INFO - PROCESS | 1668 | 07:29:08 INFO - PROCESS | 1668 | __start_tp_report 07:29:08 INFO - PROCESS | 1668 | _x_x_mozilla_page_load 07:29:08 INFO - PROCESS | 1668 | _x_x_mozilla_page_load_details 07:29:08 INFO - PROCESS | 1668 | |i|pagename|runs| 07:29:08 INFO - PROCESS | 1668 | |0;ai-astar;102;116;106;118;116;117;114;115;164;168 07:29:08 INFO - PROCESS | 1668 | |1;audio-beat-detection;170;138;166;148;107;133;125;107;155;109 07:29:08 INFO - PROCESS | 1668 | |2;audio-dft;193;202;196;208;236;211;193;273;269;195 07:29:08 INFO - PROCESS | 1668 | |3;audio-fft;68;81;75;142;60;60;71;68;131;59 07:29:08 INFO - PROCESS | 1668 | |4;audio-oscillator;70;71;119;71;74;77;117;71;73;116 07:29:08 INFO - PROCESS | 1668 | |5;imaging-gaussian-blur;127;87;89;87;91;90;91;87;88;86 07:29:08 INFO - PROCESS | 1668 | |6;imaging-darkroom;103;128;95;96;95;97;96;96;96;103 07:29:08 INFO - PROCESS | 1668 | |7;imaging-desaturate;125;107;91;90;103;129;90;86;92;92 07:29:08 INFO - PROCESS | 1668 | |8;json-parse-financial;55;57;55;57;57;55;57;58;56;58 07:29:08 INFO - PROCESS | 1668 | |9;json-stringify-tinderbox;67;67;70;75;80;82;74;67;70;86 07:29:08 INFO - PROCESS | 1668 | |10;stanford-crypto-aes;89;83;87;85;97;106;103;82;91;88 07:29:08 INFO - PROCESS | 1668 | |11;stanford-crypto-ccm;144;148;138;140;149;147;123;139;177;151 07:29:08 INFO - PROCESS | 1668 | |12;stanford-crypto-pbkdf2;168;168;167;162;162;162;160;167;166;165 07:29:08 INFO - PROCESS | 1668 | |13;stanford-crypto-sha256-iterative;63;87;82;85;85;81;75;65;67;67 07:29:08 INFO - PROCESS | 1668 | __end_tp_report 07:29:08 INFO - PROCESS | 1668 | __start_cc_report 07:29:08 INFO - PROCESS | 1668 | _x_x_mozilla_cycle_collect,1121 07:29:08 INFO - PROCESS | 1668 | __end_cc_report 07:29:08 INFO - PROCESS | 1668 | __startTimestamp1467296948890__endTimestamp 07:29:08 INFO - PROCESS | 1668 | 07:29:08 INFO - PROCESS | 1668 | ------- Summary: start ------- 07:29:08 INFO - PROCESS | 1668 | Number of tests: 14 07:29:08 INFO - PROCESS | 1668 | 07:29:08 INFO - PROCESS | 1668 | [#0] ai-astar Cycles:10 Average:123.60 Median:116.50 stddev:22.94 (19.7%) stddev-sans-first:22.96 07:29:08 INFO - PROCESS | 1668 | Values: 102.0 116.0 106.0 118.0 116.0 117.0 114.0 115.0 164.0 168.0 07:29:08 INFO - PROCESS | 1668 | 07:29:08 INFO - PROCESS | 1668 | [#1] audio-beat-detection Cycles:10 Average:135.80 Median:143.00 stddev:23.82 (16.7%) stddev-sans-first:21.81 07:29:08 INFO - PROCESS | 1668 | Values: 170.0 138.0 166.0 148.0 107.0 133.0 125.0 107.0 155.0 109.0 07:29:08 INFO - PROCESS | 1668 | 07:29:08 INFO - PROCESS | 1668 | [#2] audio-dft Cycles:10 Average:217.60 Median:209.50 stddev:30.94 (14.8%) stddev-sans-first:31.51 07:29:08 INFO - PROCESS | 1668 | Values: 193.0 202.0 196.0 208.0 236.0 211.0 193.0 273.0 269.0 195.0 07:29:08 INFO - PROCESS | 1668 | 07:29:08 INFO - PROCESS | 1668 | [#3] audio-fft Cycles:10 Average:81.50 Median:68.00 stddev:29.92 (44.0%) stddev-sans-first:31.34 07:29:08 INFO - PROCESS | 1668 | Values: 68.0 81.0 75.0 142.0 60.0 60.0 71.0 68.0 131.0 59.0 07:29:08 INFO - PROCESS | 1668 | 07:29:08 INFO - PROCESS | 1668 | [#4] audio-oscillator Cycles:10 Average:85.90 Median:71.00 stddev:21.79 (30.7%) stddev-sans-first:22.34 07:29:08 INFO - PROCESS | 1668 | Values: 70.0 71.0 119.0 71.0 74.0 77.0 117.0 71.0 73.0 116.0 07:29:08 INFO - PROCESS | 1668 | 07:29:08 INFO - PROCESS | 1668 | [#5] imaging-gaussian-blur Cycles:10 Average:92.30 Median:88.50 stddev:12.32 (13.9%) stddev-sans-first:1.88 07:29:08 INFO - PROCESS | 1668 | Values: 127.0 87.0 89.0 87.0 91.0 90.0 91.0 87.0 88.0 86.0 07:29:08 INFO - PROCESS | 1668 | 07:29:08 INFO - PROCESS | 1668 | [#6] imaging-darkroom Cycles:10 Average:100.50 Median:96.00 stddev:10.12 (10.5%) stddev-sans-first:10.70 07:29:08 INFO - PROCESS | 1668 | Values: 103.0 128.0 95.0 96.0 95.0 97.0 96.0 96.0 96.0 103.0 07:29:08 INFO - PROCESS | 1668 | 07:29:08 INFO - PROCESS | 1668 | [#7] imaging-desaturate Cycles:10 Average:100.50 Median:90.00 stddev:15.37 (17.1%) stddev-sans-first:13.51 07:29:08 INFO - PROCESS | 1668 | Values: 125.0 107.0 91.0 90.0 103.0 129.0 90.0 86.0 92.0 92.0 07:29:08 INFO - PROCESS | 1668 | 07:29:08 INFO - PROCESS | 1668 | [#8] json-parse-financial Cycles:10 Average:56.50 Median:57.00 stddev:1.18 (2.1%) stddev-sans-first:1.12 07:29:08 INFO - PROCESS | 1668 | Values: 55.0 57.0 55.0 57.0 57.0 55.0 57.0 58.0 56.0 58.0 07:29:08 INFO - PROCESS | 1668 | 07:29:08 INFO - PROCESS | 1668 | [#9] json-stringify-tinderbox Cycles:10 Average:73.80 Median:74.50 stddev:6.86 (9.2%) stddev-sans-first:6.82 07:29:08 INFO - PROCESS | 1668 | Values: 67.0 67.0 70.0 75.0 80.0 82.0 74.0 67.0 70.0 86.0 07:29:08 INFO - PROCESS | 1668 | 07:29:08 INFO - PROCESS | 1668 | [#10] stanford-crypto-aes Cycles:10 Average:91.10 Median:87.50 stddev:8.27 (9.4%) stddev-sans-first:8.73 07:29:08 INFO - PROCESS | 1668 | Values: 89.0 83.0 87.0 85.0 97.0 106.0 103.0 82.0 91.0 88.0 07:29:08 INFO - PROCESS | 1668 | 07:29:08 INFO - PROCESS | 1668 | [#11] stanford-crypto-ccm Cycles:10 Average:145.60 Median:147.50 stddev:13.66 (9.3%) stddev-sans-first:14.48 07:29:08 INFO - PROCESS | 1668 | Values: 144.0 148.0 138.0 140.0 149.0 147.0 123.0 139.0 177.0 151.0 07:29:08 INFO - PROCESS | 1668 | 07:29:08 INFO - PROCESS | 1668 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.70 Median:166.50 stddev:2.95 (1.8%) stddev-sans-first:2.87 07:29:08 INFO - PROCESS | 1668 | Values: 168.0 168.0 167.0 162.0 162.0 162.0 160.0 167.0 166.0 165.0 07:29:08 INFO - PROCESS | 1668 | 07:29:08 INFO - PROCESS | 1668 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.70 Median:81.50 stddev:9.41 (11.5%) stddev-sans-first:8.78 07:29:08 INFO - PROCESS | 1668 | Values: 63.0 87.0 82.0 85.0 85.0 81.0 75.0 65.0 67.0 67.0 07:29:08 INFO - PROCESS | 1668 | -------- Summary: end -------- 07:29:08 INFO - PROCESS | 1668 | 07:29:09 INFO - TEST-INFO | 1668: exit 0 07:29:09 INFO - TEST-OK | kraken | took 59589ms 07:29:09 INFO - SUITE-END | took 1172s 07:29:10 INFO - Completed test suite (00:19:32) 07:29:10 INFO - javascript benchmark 07:29:10 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7384.284577042683, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2848.2452150180193, 3403.591569011719, 3423.1955490459745, 3447.8448469818854, 3481.98259008705, 5133.255677926699, 5881.764729410824, 5934.050551911695, 5941.6435013899145, 5945.227120474343, 5798.072308430641, 5906.5274778017765, 5945.16767652529, 5947.88104237915, 6053.092036194562, 5252.23842542832, 5312.73436328184, 5321.946780532184, 5432.565394768409, 5452.40023597404, 5462.6995515246645, 5496.697681627509, 5501.0648189807625, 5532.3914369419335, 5536.806211782588, 5216.556592689607, 5290.788368465257, 5343.625946183769, 5366.651167674088, 5375.086235340002, 4854.902901941977, 5092.497713174585, 5329.200619907045, 5362.195670649395, 5369.8723268113745, 5240.3187585614005, 5304.708241046741, 5348.465153484659, 5362.088444964365, 5364.8122315718765, 4868.853934381974, 5834.766609335621, 5916.674582897939, 6012.78955236569, 6055.091736239555, 6188.721507532126, 6205.441510264098, 6239.812805615793, 6260.15487909131, 6299.37006299371, 6145.801568694106, 6171.907421388682, 6302.401271879165, 6306.590071645374, 6317.336679648617, 5947.5539334550085, 5975.282966044103, 5985.34161242263, 6000.669963151981, 6047.0, 6322.430981211713, 6349.714262858182, 6354.142190804182, 6364.586301890362, 6386.936130638727, 6132.600268413531, 6162.969185154136, 6234.251889773256, 6236.03341482071, 6270.905936410957, 6251.343608921089, 6288.779892703734, 6297.0, 6306.306306306303, 6324.557280990287, 6108.500214525948, 6121.849304493819, 6146.754129834846, 6169.907451388232, 6224.066390041439, 6131.540134489931, 6137.039921714258, 6137.101203255209, 6237.126802247689, 6242.344553821874, 3934.724569280123, 4358.3680366347335, 4998.975210081924, 5078.822241221614, 5150.944056468415, 4088.8773336799945, 4319.870403887889, 4507.414036175342, 4514.0, 4540.432445944257, 5722.284714410699, 5897.938371093159, 6078.0, 6078.270607527125, 6085.2393450818645, 6317.905231421532, 6374.235091789015, 6381.680915954184, 6382.489400847921, 6386.2975072741965, 6072.666003369769, 6081.665508397081, 6099.451049405575, 6106.0, 6108.5418593605655, 5460.699661518575, 5543.750531226105, 5560.916586251209, 5591.7483713233005, 5615.831525054255, 6469.703459473436, 6493.0, 6526.477881769447, 6550.639714815731, 6559.180102487189, 6119.4798442132915, 6293.842653933505, 6296.244450665949, 6303.558750887394, 6307.779227727007, 6135.661410523283, 6349.9682501587195, 6436.388543088399, 6442.130312407765, 6520.543561950618, 6228.03465462854, 6242.625442473284, 6245.656488893154, 6249.50003999688, 6254.28075771274, 6148.415900489446, 6165.876682466415, 6170.845728856814, 6272.968635156795, 6319.968400158154, 6119.8470038247615, 6124.6325220486915, 6135.600157732601, 6194.101855231056, 6241.812745617639, 6142.938570614416, 6201.0, 6210.285817131088, 6220.502359811295, 6220.937790622217, 5996.370381110095, 6089.056196289582, 6111.5110791137495, 6171.876562468815, 6216.906746398718, 6142.648617304186, 6175.6912154393, 6190.690465476799, 6219.751209951552, 6220.471259942775, 5405.4594540547205, 6023.488003519575, 6196.690165491617, 6201.627902325875, 6204.875902482016], "value": 5788.153129822763, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [475.9238521836507, 525.8737902903305, 532.4223217808677, 559.6138664321617, 572.5019233267055, 29389.853050734742, 37824.621753782456, 39538.60461395385, 39616.009599759986, 39630.0, 40831.57089501868, 41104.58895411045, 41192.17615647685, 41253.79373103131, 41276.58723412765, 9405.623775048989, 9557.474338911357, 9575.281853860954, 9662.275329350292, 9669.854952175723, 9635.951820240889, 9693.17608003317, 9694.612215511406, 9697.933227345022, 9733.367331123489, 9624.759381015496, 9657.565409556551, 9711.417314961089, 9714.854277185848, 9737.659181928633, 9548.713538593818, 9641.951790241039, 9702.805943881154, 9711.951440242754, 9712.660056898045, 9519.286053545942, 9609.855852162224, 9615.23078153746, 9638.036196380375, 9654.179394751454, 32117.357652847048, 39503.60496395028, 39565.20869582621, 39853.80073099645, 39893.0, 3032.287412458071, 3180.1254654970066, 3195.0414875537476, 3196.824174670392, 3783.564890037653, 30268.243293917607, 30780.0, 31135.532967005285, 31155.844220778978, 31797.841010794797, 3179.650238473766, 3187.0757480330676, 3188.920276993094, 3271.263965607719, 3287.161773747703, 344079.0, 397963.0, 427051.0, 434723.0, 436234.0, 33254.66745332516, 34306.48540271898, 34418.0, 34965.12587185341, 35007.299854003286, 35511.28977420437, 35661.64338356635, 35716.0, 35784.28431431357, 35877.1030724234, 12720.300383478812, 14833.851661483248, 15012.949093563564, 15015.849841501664, 15019.474318398803, 12680.492780288869, 12703.618891433272, 12730.10889237763, 12755.936220319025, 12767.233965962072, 7763.805904852424, 7765.456418050795, 7824.256695614022, 7871.842563148705, 7941.801454963556, 3207.631122420905, 3226.7738259461253, 3252.8210948398064, 3255.137388592025, 3280.5407242986003, 790.9841803163904, 899.2401420799414, 904.8463209407926, 947.966821161256, 1023.3859684189426, 24459.755402446102, 27995.30011749682, 30421.847890760404, 30568.388632227674, 31232.37535249282, 940.501534186882, 1011.838105903052, 1120.1151090638305, 1122.5734220995969, 1163.3892206591438, 12105.636830895088, 14879.33043013067, 15117.410998092799, 15695.979761315479, 15833.208339583205, 580501.0, 672204.0, 690469.0, 691818.0, 692026.0, 60367.39632603706, 60717.69641151854, 60854.0871886922, 60951.69524152351, 61019.69490152521, 1264.89248413884, 1345.3004437692346, 1350.4395675794435, 1395.9371828267751, 1401.467442371892, 26615.93536258528, 29800.701992979793, 30052.84973575118, 30159.275468390908, 30393.0, 49405.28270945133, 52019.47980520298, 52888.0, 52979.0, 53118.203226950856, 537434.0, 540199.0, 541814.0, 543295.2835235798, 543311.0, 26436.735632644195, 27245.318867028484, 27615.75729092236, 27625.585616215372, 27721.30696732517, 41534.0, 42207.577924220364, 42275.57724422716, 42731.1541961225, 42731.58147348267, 40132.799336004304, 40259.1948161041, 40612.59387406088, 41111.38332925068, 41362.96592585089, 30988.380232395677, 39646.207075858896, 39860.601393985686, 39866.91165516306, 41014.589854101076, 38793.224135517696, 38828.6117138825, 38876.80561597287, 39193.41209881911, 39225.0, 34508.82745586256, 35511.0, 35665.64334356623, 35796.105097371736, 35909.64090359167, 22232.0, 25735.613965790904, 25830.837612307867, 25871.0, 26402.0], "value": 18218.825820160175, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [332.8964482739716, 363.469334771234, 387.41113507468657, 387.59496326338973, 411.116100384174, 16213.0, 16630.750538741915, 20202.090905909234, 21456.678149827727, 21640.89179554102, 18783.62432751344, 19740.210391584318, 20676.379708608765, 21583.352499425044, 21593.244236451726, 5432.456754324556, 5568.248286481334, 5597.832065038056, 5611.298587676541, 6086.7565297388055, 6129.295131059918, 6140.925338065843, 6146.17026701394, 6174.845628859292, 6181.443670069692, 5379.300690910196, 5556.638818476807, 5840.240768700063, 6037.607555508878, 6121.479674227696, 5434.755436005389, 5441.564674826004, 5507.0, 5532.6680399175975, 5548.889022219553, 5167.612429067797, 5257.13257312543, 5365.0, 5374.355077390738, 5397.8380648580605, 13786.448542058306, 13794.93102534481, 13839.792403113961, 23898.566086034894, 26491.07281245147, 2014.687723402875, 2162.4593851537115, 2211.4139752965475, 2226.699395581592, 2321.953560928772, 9960.501974901226, 10208.285420020602, 10436.425996570186, 12640.367981600883, 15393.923030384889, 1812.900290484023, 1838.4392760208132, 1881.294514557041, 1890.7163925411162, 1891.4798430431604, 119033.0, 124901.12648310282, 126735.0, 127508.0, 127787.0, 10022.949885250528, 11407.144464165222, 11615.709607259887, 12010.759784804255, 12031.518739250507, 12401.875981240071, 14861.628459288604, 14863.108213507008, 14935.775963360558, 14976.951613387177, 7732.922670773332, 7916.1792787658005, 8260.586970651444, 8454.239118479367, 8465.83068338642, 7018.508704390643, 7527.2849079337375, 8312.33501319893, 8321.583920803936, 8411.957940210259, 4523.208438523311, 4624.606908412823, 4647.674662773574, 4669.509701481364, 4725.527447255316, 1796.6137280484759, 1958.4418440744319, 1981.1382048808814, 1997.690357994513, 2004.8997550122435, 859.8495263328892, 905.9355257572327, 961.7689357622255, 1024.6618615856748, 1027.6968294353185, 18016.0, 19420.320288790106, 19704.605907881763, 21166.833166833167, 21410.464738381666, 967.8644989701447, 976.9120779129912, 984.2814745236018, 990.4255531791543, 1008.2708155513184, 10833.891661083446, 11011.61459348919, 11028.944855275673, 11073.667789966314, 11087.22389432748, 595925.0, 600945.0, 602224.0, 607551.9622401859, 612545.0, 102962.97037029534, 126072.1089183663, 128206.35896820643, 129537.35231323783, 129786.0, 987.5259875259916, 987.8765154355706, 993.5380048277585, 1005.5424781724444, 1007.4912169354429, 16296.755548666542, 17593.296268149643, 17923.37268195607, 18780.248790048245, 19492.610147797248, 38666.80666596649, 45076.0, 54019.72990135024, 58086.4191358081, 58154.4184558149, 71941.0, 73698.63150684212, 75235.26251915075, 84090.57954710188, 88275.55862220905, 5406.0, 5753.424657534213, 8234.258916697527, 8346.666133354598, 8514.318854491501, 11083.667489975314, 11344.546218151512, 11478.426078696199, 13183.340832958122, 13614.251216183206, 11391.658250252505, 11459.255148415326, 11543.595974140864, 11550.537978481103, 11677.532898683958, 11242.269252498561, 11415.543378264776, 11442.0, 11580.6525804226, 11694.88305116972, 11791.056715462571, 11807.822882656596, 11809.291442513477, 11830.349330786888, 12054.51781928713, 8363.790905227175, 8392.244697977212, 8399.076101628938, 8430.789230269293, 8433.114522975, 11027.779444410906, 11472.88527114718, 11555.537778489102, 11625.12811539121, 11685.00677442427], "value": 9461.216109951018, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1326.4893016188767, 1555.3312075807403, 1695.2795062098605, 1842.8525717942557, 1855.5268406556327, 7946.324562412202, 8547.957260213705, 8627.396082274243, 9114.863277050841, 9139.223166030879, 7483.775486735407, 8647.87028194576, 8762.123787621234, 8779.517126558037, 8785.60464779085, 2362.7400985891536, 2386.72552656445, 2387.6060450025725, 2392.5334559760854, 2402.087206861399, 2324.31432727345, 2355.7997570206467, 2362.8227882908764, 2368.2421625079983, 2402.2192787344184, 2353.2822489140804, 2376.251480783548, 2376.489054853206, 2381.5475059738596, 2401.1235898896866, 2310.780475854791, 2364.4679947011955, 2373.0982226753895, 2376.2158487699103, 2383.8914904569374, 2342.554914566227, 2358.693369861924, 2370.0401337458356, 2374.050379848057, 2377.0491803278655, 8883.466991980502, 8915.108489151098, 8920.241779448756, 8954.37319387643, 8990.460572365679, 5260.947390526084, 5298.735063246861, 5304.840854774363, 5305.495977882095, 5418.620696551243, 3566.144125409909, 3620.6922411595046, 3643.325984692814, 3693.409054551286, 3695.7412981091334, 1088.820344643133, 1089.809283375414, 1090.1878100814943, 1093.7101668057971, 1114.0697517572837, 11555.94222028893, 11709.590164344207, 11719.296842189497, 11740.647780566596, 11751.294922304689, 3758.9850740299967, 4066.5933406659688, 4610.216263235258, 4751.596114330251, 4823.686460380064, 8763.298936085097, 9823.754406139904, 9921.40471571708, 9936.205103591696, 9941.155001824925, 5347.2781174541715, 5363.597730170253, 5398.946010539844, 5401.945980540223, 5408.972955135199, 3825.540935087807, 4841.201201801663, 4909.116359055333, 4996.7501624918605, 5000.199968005102, 3351.5978082629754, 3954.406838974177, 4038.5759495252573, 4096.774677392712, 4100.815463304159, 1306.8366454193226, 1314.3559655768604, 1316.4010375279224, 1317.3808310094241, 1326.9336533173496, 842.8609279468819, 914.5061666700041, 917.9357444978921, 940.05994005994, 946.8674385586023, 5906.970465147647, 6006.279246490449, 6104.145419641254, 6136.6011209271255, 6206.224221972254, 944.4569372610639, 1033.6278939581896, 1073.88187299397, 1080.0, 1082.3884505254664, 4023.376376661622, 4068.145689405258, 4074.348104303297, 4127.772972486482, 4131.586841315844, 9018.233450156678, 10665.253432259668, 10789.19081068923, 10837.83743243852, 10902.236843420884, 10698.572057117784, 10740.892591074145, 10803.0, 10804.621838235624, 10813.62152324665, 7945.245201705829, 8289.626966786509, 8347.833043339098, 8368.079511253758, 8427.915720842713, 4878.365812444359, 5543.61194716366, 6033.456988871023, 6233.0, 6308.243010838729, 9836.852447213154, 10096.0, 10209.591616335263, 10324.22568307395, 10357.689269321932, 10039.0, 10159.44123073238, 10244.385336879812, 10249.487525623837, 10301.793964120825, 7348.008018917378, 7454.925450745423, 7535.585542795199, 7709.845803083795, 7711.305982461606, 8404.411691181558, 8501.404901656824, 8580.0561938188, 8584.184502472255, 8638.352123590881, 7455.888161677688, 7619.542827430372, 7626.847463050819, 7726.7681969541, 7746.341560967381, 7423.183449820407, 7450.292222238879, 7497.175310715926, 7563.394928405604, 7614.695412183451, 7011.894821577578, 7020.5787652741, 7067.363937245673, 7079.2566780487305, 7084.822879428056, 4955.108080545537, 5081.187010078517, 5146.845594632167, 5147.430033839715, 5205.609579281493, 5101.69389836611, 5102.2091575804325, 5111.207762796773, 5253.553447956813, 5264.368275806928], "value": 4644.982366687723, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [276.9958898991157, 300.19098529463093, 312.79199332443926, 315.38027775421307, 318.95215717642367, 5367.731613419333, 5763.567732420075, 5798.768049278035, 5829.300483941927, 5852.536865783554, 5280.937056507226, 5772.595918285721, 5780.971095144529, 5783.739731712072, 5826.941730582693, 4138.793060346986, 4205.453291072156, 4313.309870420733, 4322.675799315064, 4350.434443522354, 3607.4588811678327, 3725.701943844486, 4229.365595160735, 4344.63070638996, 4380.335472520438, 3807.990882416162, 4332.263515202423, 4341.891452713676, 4352.521222665504, 4364.476262848447, 4061.6547593454593, 4339.8481053163305, 4349.934750978738, 4355.998120432302, 4402.119576084764, 3124.406362791085, 3174.3968645957193, 3309.7683162178655, 3745.887623371276, 3765.303418867491, 5087.821926232564, 5107.565856902168, 5223.6865788052455, 5618.325800903917, 5731.914021289684, 4722.386089808338, 4977.303177555145, 5003.274525193863, 5043.571296439807, 5101.438841727407, 4874.951250487486, 5940.108983652443, 6146.969265153645, 6155.72299246535, 6168.629882207082, 4216.430781844473, 4217.936730949038, 4218.1985422769885, 4233.407322974786, 4243.151369726067, 5246.662101164179, 5839.854003649943, 6081.510030042624, 6378.043293505965, 6416.743330266784, 3627.3108109459645, 3827.851644506637, 4102.958970410317, 4279.914401711948, 4298.161858437575, 4359.694821362475, 4375.365571992043, 4376.693631445768, 4380.956190438055, 4385.25921299188, 4606.907861842745, 4714.599259062949, 5011.298418221452, 5056.721880296545, 5115.948840511622, 5103.489651034867, 5730.36965933747, 6040.0, 6077.453029227302, 6151.477124444383, 1168.1472525056586, 1343.6640839790052, 1483.5030264861177, 1499.6325900154532, 1507.4196434372845, 916.1800188830958, 927.958241879117, 937.7139972308512, 980.7008862297068, 996.3822430093244, 5533.363663178786, 5616.382197958222, 5647.983362994701, 5664.461876121762, 5705.657660540381, 5720.914186287209, 6251.343608920998, 6259.655718935503, 6263.279722831841, 6263.530235232376, 4837.95162048382, 5436.972815135899, 5590.524805391506, 5646.548276137899, 5712.828615141552, 2567.164477398632, 2890.7542858856814, 3199.616046074486, 3270.9345813083605, 3288.638249792521, 6231.532635052389, 6323.747050117944, 6456.257530383972, 6464.806055818333, 6465.838354041187, 5776.884462310731, 5829.59192856496, 5903.940960590425, 6358.0, 6389.945658966311, 6086.695665216722, 6127.387261273837, 6394.744210231632, 6398.5521013528605, 6413.647249401328, 4714.104320179155, 5653.378128405954, 6158.784442544489, 6173.753049877954, 6198.659073750987, 6020.87958240824, 6073.388442969389, 6081.817545473643, 6109.266887973472, 6118.0, 5635.281239222077, 6102.938970610237, 6126.507890502371, 6154.522914500398, 6427.517936154713, 3828.688184720141, 3962.9603703963744, 4191.7694526801315, 4222.218889505451, 4262.829486820492, 4814.831480898151, 4867.63492738039, 5937.693707384368, 6145.4161854623735, 6148.292946311231, 4785.736784476748, 5361.973190134025, 5435.130379139318, 5599.524040456444, 5954.821355359346, 5213.40045894727, 5881.3236477803885, 5943.257092863392, 5957.6339368256795, 5975.34271230173, 5523.309586301712, 5620.3536593290655, 5769.336526299361, 5849.94150058511, 5863.736131874161, 5144.762028517607, 6044.848878778066, 6059.666718330358, 6081.331053584191, 6085.0, 5381.784728610812, 5487.039768040657, 5955.136505206634, 5962.52299816005, 5975.970120149372], "value": 4374.447917501099, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [723.5188599581278, 769.372961036755, 782.2177822177825, 819.5123901278737, 861.9008813986392, 15162.620934476643, 15809.446669366574, 15893.44372946947, 15970.84029159708, 15986.0, 14210.857891421083, 14337.0, 14350.354234059467, 14359.35382907769, 14363.138211707304, 825.3603457320579, 835.1481488881337, 867.1328671328671, 877.2236570634971, 877.5480627476854, 686.7459040155125, 861.0743450790426, 862.5687156421789, 866.0776273268948, 870.3298460185684, 900.5947323704327, 911.9452832830051, 912.5710915869564, 912.9817403651956, 913.127962795532, 888.9244414224798, 893.2228960804109, 898.6495266845935, 904.6064961741663, 908.4685459006489, 658.108263303222, 665.4510029225908, 669.8660267946382, 675.3347952267013, 676.8477092654163, 13045.86954130456, 14903.105813651217, 15270.923645381701, 15274.923625381802, 15372.692546149014, 14081.225532595703, 14119.435222591084, 14244.643883902881, 14297.285135743172, 14461.927690361481, 11658.708532286675, 11736.23714458566, 11831.349275789828, 11854.644360669194, 12300.138990270685, 3744.756590821588, 3866.555346135174, 3874.1670540833857, 3891.1439483313907, 4004.539477960043, 115813.42093289479, 116364.0, 119444.0, 119534.40232798868, 119559.0, 10892.564297428173, 10933.890661093288, 10991.670249892515, 11002.559897604166, 11239.438028098562, 22001.779982200293, 22156.2245321413, 22179.891005449663, 22195.0, 22201.888990554944, 7943.523388596703, 7990.600469976478, 8187.058488273925, 8230.506169629842, 8235.38234632405, 4584.129015487047, 4588.564086411786, 4588.715159755274, 4589.207972201094, 4657.790399432034, 3542.964570354315, 3660.5790334111916, 3670.0641336459566, 3675.8713445029293, 3683.981580092136, 666.590047121017, 671.9260881303053, 699.3426179391356, 729.6789412658413, 747.129594022968, 598.964062156272, 666.54027679382, 673.3165836675778, 683.8666460040344, 685.6178994890073, 8425.410221284574, 9406.529673516434, 9582.808343833085, 9670.468124253233, 9829.508524573743, 540.645876950598, 563.248063834777, 627.9560430769802, 641.8395401149712, 668.2882729892649, 4451.221036318631, 4665.370175026328, 4679.64902632304, 4690.929636055462, 4721.598664113589, 78000.0, 106466.403003955, 133926.0, 164889.0, 164905.17547412188, 143813.28093359465, 145494.27252863668, 147771.52228477577, 148266.25866870597, 152029.0, 127714.0, 128148.87404503902, 129090.0, 132301.99999999808, 133107.66892331146, 7922.445428819928, 8586.957065214634, 8773.122687731176, 9113.3165012623, 9122.680706175252, 69184.0, 70406.0, 70554.64722676354, 72140.0, 72375.63812181116, 63907.680461597396, 81548.0, 86642.56678716566, 101221.0, 103163.45254821033, 12765.297908615115, 13373.331333433483, 13425.0, 13675.111117777313, 13743.106698064594, 12821.743565128832, 14977.326020328894, 15083.396664133312, 15311.540653780405, 15447.459338923083, 13814.654633633838, 14038.438462461387, 14523.273836307932, 14547.345369458188, 14554.781678274623, 13513.729725405634, 13875.583732488041, 13925.0, 14407.711845763235, 14567.781483277971, 13669.931650341685, 13726.176429414267, 14052.648683782987, 14235.572932812032, 14368.712625747217, 10936.084026206217, 11366.295055741704, 11477.0, 11571.6528504145, 11639.941800290944, 10886.564537418415, 11166.553337866395, 11688.298702077902, 11737.295762254293, 11762.764744704888], "value": 7996.444061117166, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1545.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 116.0, 106.0, 118.0, 116.0, 117.0, 114.0, 115.0, 164.0, 168.0], "value": 123.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 138.0, 166.0, 148.0, 107.0, 133.0, 125.0, 107.0, 155.0, 109.0], "value": 135.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [193.0, 202.0, 196.0, 208.0, 236.0, 211.0, 193.0, 273.0, 269.0, 195.0], "value": 217.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 81.0, 75.0, 142.0, 60.0, 60.0, 71.0, 68.0, 131.0, 59.0], "value": 81.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 71.0, 119.0, 71.0, 74.0, 77.0, 117.0, 71.0, 73.0, 116.0], "value": 85.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 87.0, 89.0, 87.0, 91.0, 90.0, 91.0, 87.0, 88.0, 86.0], "value": 92.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 128.0, 95.0, 96.0, 95.0, 97.0, 96.0, 96.0, 96.0, 103.0], "value": 100.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 107.0, 91.0, 90.0, 103.0, 129.0, 90.0, 86.0, 92.0, 92.0], "value": 100.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 57.0, 55.0, 57.0, 57.0, 55.0, 57.0, 58.0, 56.0, 58.0], "value": 56.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 70.0, 75.0, 80.0, 82.0, 74.0, 67.0, 70.0, 86.0], "value": 73.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 83.0, 87.0, 85.0, 97.0, 106.0, 103.0, 82.0, 91.0, 88.0], "value": 91.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 148.0, 138.0, 140.0, 149.0, 147.0, 123.0, 139.0, 177.0, 151.0], "value": 145.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 168.0, 167.0, 162.0, 162.0, 162.0, 160.0, 167.0, 166.0, 165.0], "value": 164.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 87.0, 82.0, 85.0, 85.0, 81.0, 75.0, 65.0, 67.0, 67.0], "value": 75.7, "unit": "score"}]}]} 07:29:10 INFO - Return code: 0 07:29:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:29:10 ERROR - # TBPL SUCCESS # 07:29:10 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:29:10 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:29:10 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:29:10 INFO - 2016-06-30 07:29:10.206 screenresolution[1673:10643] starting screenresolution argv=screenresolution get 07:29:10 INFO - 2016-06-30 07:29:10.209 screenresolution[1673:10643] Display 0: 1600x1200x32@60 07:29:10 INFO - 2016-06-30 07:29:10.214 screenresolution[1674:10646] starting screenresolution argv=screenresolution list 07:29:10 INFO - Available Modes on Display 0 07:29:10 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:29:10 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:29:10 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:29:10 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:29:10 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:29:10 INFO - Intel Iris: 07:29:10 INFO - Chipset Model: Intel Iris 07:29:10 INFO - Type: GPU 07:29:10 INFO - Bus: Built-In 07:29:10 INFO - VRAM (Dynamic, Max): 1536 MB 07:29:10 INFO - Vendor: Intel (0x8086) 07:29:10 INFO - Device ID: 0x0a2e 07:29:10 INFO - Revision ID: 0x0009 07:29:10 INFO - Displays: 07:29:10 INFO - Display: 07:29:10 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:29:10 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:29:10 INFO - Display Serial Number: 1600x1200 60 07:29:10 INFO - Main Display: Yes 07:29:10 INFO - Mirror: Off 07:29:10 INFO - Online: Yes 07:29:10 INFO - Rotation: Supported 07:29:10 INFO - Return code: 0 07:29:10 INFO - Running post-action listener: _resource_record_post_action 07:29:10 INFO - ##### 07:29:10 INFO - ##### Finished run-tests step (success) 07:29:10 INFO - ##### 07:29:10 INFO - Running post-run listener: _resource_record_post_run 07:29:10 INFO - Total resource usage - Wall time: 1207s; CPU: 54.0%; Read bytes: 36820480; Write bytes: 708953088; Read time: 236; Write time: 2035 07:29:10 INFO - TinderboxPrint: CPU usage
54.4% 07:29:10 INFO - TinderboxPrint: I/O read bytes / time
36,820,480 / 236 07:29:10 INFO - TinderboxPrint: I/O write bytes / time
708,953,088 / 2,035 07:29:10 INFO - TinderboxPrint: CPU idle
2,203.8 (45.6%) 07:29:10 INFO - TinderboxPrint: CPU system
976.9 (20.2%) 07:29:10 INFO - TinderboxPrint: CPU user
1,648.9 (34.1%) 07:29:10 INFO - TinderboxPrint: Swap in / out
443,465,728 / 0 07:29:10 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 392096256; Write bytes: 385164800; Read time: 29343; Write time: 839 07:29:10 INFO - run-tests - Wall time: 1174s; CPU: 54.0%; Read bytes: 35866112; Write bytes: 299535872; Read time: 224; Write time: 1138 07:29:10 INFO - Running post-run listener: _upload_blobber_files 07:29:10 INFO - Blob upload gear active. 07:29:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:29:10 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 07:29:10 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'] 07:29:10 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 07:29:11 INFO - (blobuploader) - INFO - Open directory for files ... 07:29:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:29:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:29:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:29:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:29:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:29:11 INFO - (blobuploader) - INFO - Done attempting. 07:29:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:29:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:29:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:29:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:29:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:29:12 INFO - (blobuploader) - INFO - Done attempting. 07:29:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:29:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:29:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:29:15 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:29:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:29:15 INFO - (blobuploader) - INFO - Done attempting. 07:29:15 INFO - (blobuploader) - INFO - Iteration through files over. 07:29:15 INFO - Return code: 0 07:29:15 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:29:15 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:29:15 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/557f02e428ca7846b1e32473c3a383e10f343a22ee56c3a8f0c1780e7563443504c58b4ea789988a46fc12618f0d4134c6f42286bd53647c3dc0ee555e2f11f3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5a14c30ca02b3953f297f2dcf7cd5224b13bc867a165f37128d44e730a8d1e4d44189f5e819fecfce2472780c0010c20692501f1c7d6a02a3296a68ce29a8daf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/176f29a228dc151730ec965540eadb05139cb1276bdbbd3f99fdb1fac1d9b9b4138e3d9c16516e3d68d1138af09415afcf7d3570c349be1d71086f461c351df4"} 07:29:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:29:15 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:29:15 INFO - Contents: 07:29:15 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/557f02e428ca7846b1e32473c3a383e10f343a22ee56c3a8f0c1780e7563443504c58b4ea789988a46fc12618f0d4134c6f42286bd53647c3dc0ee555e2f11f3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5a14c30ca02b3953f297f2dcf7cd5224b13bc867a165f37128d44e730a8d1e4d44189f5e819fecfce2472780c0010c20692501f1c7d6a02a3296a68ce29a8daf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/176f29a228dc151730ec965540eadb05139cb1276bdbbd3f99fdb1fac1d9b9b4138e3d9c16516e3d68d1138af09415afcf7d3570c349be1d71086f461c351df4"} 07:29:15 INFO - Running post-run listener: copy_logs_to_upload_dir 07:29:15 INFO - Copying logs to upload dir... 07:29:15 INFO - mkdir: /builds/slave/test/build/upload/logs 07:29:15 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1264.216169 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-06-30 07:29:15.279613) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-30 07:29:15.283393) ========= 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.nvltiZ7TTM/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.eaZcgFWKDl/Listeners TMPDIR=/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/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/557f02e428ca7846b1e32473c3a383e10f343a22ee56c3a8f0c1780e7563443504c58b4ea789988a46fc12618f0d4134c6f42286bd53647c3dc0ee555e2f11f3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5a14c30ca02b3953f297f2dcf7cd5224b13bc867a165f37128d44e730a8d1e4d44189f5e819fecfce2472780c0010c20692501f1c7d6a02a3296a68ce29a8daf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/176f29a228dc151730ec965540eadb05139cb1276bdbbd3f99fdb1fac1d9b9b4138e3d9c16516e3d68d1138af09415afcf7d3570c349be1d71086f461c351df4"} build_url:https://queue.taskcluster.net/v1/task/bH5HlthoSSKCdkw0i52lWQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010821 build_url: 'https://queue.taskcluster.net/v1/task/bH5HlthoSSKCdkw0i52lWQ/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/557f02e428ca7846b1e32473c3a383e10f343a22ee56c3a8f0c1780e7563443504c58b4ea789988a46fc12618f0d4134c6f42286bd53647c3dc0ee555e2f11f3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5a14c30ca02b3953f297f2dcf7cd5224b13bc867a165f37128d44e730a8d1e4d44189f5e819fecfce2472780c0010c20692501f1c7d6a02a3296a68ce29a8daf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/176f29a228dc151730ec965540eadb05139cb1276bdbbd3f99fdb1fac1d9b9b4138e3d9c16516e3d68d1138af09415afcf7d3570c349be1d71086f461c351df4"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-30 07:29:15.316743) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 07:29:15.317312) ========= 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.nvltiZ7TTM/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.eaZcgFWKDl/Listeners TMPDIR=/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/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.004373 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 07:29:15.365866) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-30 07:29:15.366183) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-30 07:29:15.366519) ========= ========= Total master_lag: 0.18 =========