builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0371 starttime: 1471899546.11 results: success (0) buildid: 20160822113014 builduid: 2253cea16ceb4551973b1bfa5c1211a7 revision: 3345f0e8ed3bd33d8af6e2b9bf1fd8bf397a45bc ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-22 13:59:06.105784) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-22 13:59:06.106140) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 7 secs) (at 2016-08-22 13:59:06.106459) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 7 secs) (at 2016-08-22 13:59:13.212102) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-22 13:59:13.212430) ========= 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.Z7x2WIGpaS/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.FKPM5tEkTP/Listeners TMPDIR=/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/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-08-22 13:59:13-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 156M=0s 2016-08-22 13:59:13 (156 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.090148 ========= master_lag: 1.40 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-22 13:59:14.707137) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 1 secs) (at 2016-08-22 13:59:14.707459) ========= 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.Z7x2WIGpaS/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.FKPM5tEkTP/Listeners TMPDIR=/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/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.019785 ========= master_lag: 1.19 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 1 secs) (at 2016-08-22 13:59:15.919777) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-22 13:59:15.920163) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 3345f0e8ed3bd33d8af6e2b9bf1fd8bf397a45bc --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 3345f0e8ed3bd33d8af6e2b9bf1fd8bf397a45bc --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Z7x2WIGpaS/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.FKPM5tEkTP/Listeners TMPDIR=/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/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-08-22 13:59:15,998 truncating revision to first 12 chars 2016-08-22 13:59:15,998 Setting DEBUG logging. 2016-08-22 13:59:15,998 attempt 1/10 2016-08-22 13:59:15,998 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/3345f0e8ed3b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-22 13:59:17,107 unpacking tar archive at: mozilla-central-3345f0e8ed3b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.382813 ========= master_lag: 0.27 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-22 13:59:17.569166) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-22 13:59:17.569521) ========= script_repo_revision: 3345f0e8ed3bd33d8af6e2b9bf1fd8bf397a45bc ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-22 13:59:17.569913) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-22 13:59:17.570196) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-22 13:59:18.318300) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-08-22 13:59:18.318669) ========= /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.Z7x2WIGpaS/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.FKPM5tEkTP/Listeners TMPDIR=/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/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 13:59:18 INFO - MultiFileLogger online at 20160822 13:59:18 in /builds/slave/test 13:59:18 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 13:59:18 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:59:18 INFO - {'append_to_log': False, 13:59:18 INFO - 'base_work_dir': '/builds/slave/test', 13:59:18 INFO - 'blob_upload_branch': 'Firefox', 13:59:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:59:18 INFO - 'branch': 'Firefox', 13:59:18 INFO - 'buildbot_json_path': 'buildprops.json', 13:59:18 INFO - 'config_files': ('talos/mac_config.py',), 13:59:18 INFO - 'default_actions': ('clobber', 13:59:18 INFO - 'read-buildbot-config', 13:59:18 INFO - 'download-and-extract', 13:59:18 INFO - 'populate-webroot', 13:59:18 INFO - 'create-virtualenv', 13:59:18 INFO - 'install', 13:59:18 INFO - 'run-tests'), 13:59:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:59:18 INFO - 'download_minidump_stackwalk': True, 13:59:18 INFO - 'download_symbols': 'ondemand', 13:59:18 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:59:18 INFO - 'tooltool.py': '/tools/tooltool.py', 13:59:18 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:59:18 INFO - '/tools/misc-python/virtualenv.py')}, 13:59:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:59:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:59:18 INFO - 'installer_path': 'installer.exe', 13:59:18 INFO - 'log_level': 'info', 13:59:18 INFO - 'log_name': 'talos', 13:59:18 INFO - 'log_to_console': True, 13:59:18 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 13:59:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 13:59:18 INFO - 'opt_config_files': (), 13:59:18 INFO - 'pip_index': False, 13:59:18 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:59:18 INFO - 'cmd': ('bash', 13:59:18 INFO - '-c', 13:59:18 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:59:18 INFO - 'enabled': True, 13:59:18 INFO - 'halt_on_failure': False, 13:59:18 INFO - 'name': 'check_screen_resolution'},), 13:59:18 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:59:18 INFO - 'cmd': ('bash', 13:59:18 INFO - '-c', 13:59:18 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:59:18 INFO - 'enabled': True, 13:59:18 INFO - 'halt_on_failure': False, 13:59:18 INFO - 'name': 'check_screen_resolution'},), 13:59:18 INFO - 'run_cmd_checks_enabled': True, 13:59:18 INFO - 'sps_profile': False, 13:59:18 INFO - 'sps_profile_interval': 0, 13:59:18 INFO - 'suite': 'dromaeojs-e10s', 13:59:18 INFO - 'system_bits': '32', 13:59:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:59:18 INFO - 'title': 't-yosemite-r7-0371', 13:59:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:59:18 INFO - 'use_talos_json': True, 13:59:18 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:59:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:59:18 INFO - 'work_dir': 'build'} 13:59:18 INFO - [mozharness: 2016-08-22 20:59:18.504291Z] Running clobber step. 13:59:18 INFO - Running pre-action listener: _resource_record_pre_action 13:59:18 INFO - Running main action method: clobber 13:59:18 INFO - rmtree: /builds/slave/test/build 13:59:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:59:20 INFO - Running post-action listener: _resource_record_post_action 13:59:20 INFO - [mozharness: 2016-08-22 20:59:20.020251Z] Finished clobber step (success) 13:59:20 INFO - [mozharness: 2016-08-22 20:59:20.020394Z] Running read-buildbot-config step. 13:59:20 INFO - Running pre-action listener: _resource_record_pre_action 13:59:20 INFO - Running main action method: read_buildbot_config 13:59:20 INFO - Using buildbot properties: 13:59:20 INFO - { 13:59:20 INFO - "project": "", 13:59:20 INFO - "product": "firefox", 13:59:20 INFO - "script_repo_revision": "production", 13:59:20 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 13:59:20 INFO - "repository": "", 13:59:20 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 13:59:20 INFO - "buildid": "20160822113014", 13:59:20 INFO - "pgo_build": "False", 13:59:20 INFO - "basedir": "/builds/slave/test", 13:59:20 INFO - "buildnumber": 7, 13:59:20 INFO - "slavename": "t-yosemite-r7-0371", 13:59:20 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 13:59:20 INFO - "platform": "yosemite_r7", 13:59:20 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 13:59:20 INFO - "branch": "mozilla-central", 13:59:20 INFO - "repo_path": "mozilla-central", 13:59:20 INFO - "revision": "3345f0e8ed3bd33d8af6e2b9bf1fd8bf397a45bc", 13:59:20 INFO - "stage_platform": "macosx64", 13:59:20 INFO - "builduid": "2253cea16ceb4551973b1bfa5c1211a7", 13:59:20 INFO - "slavebuilddir": "test" 13:59:20 INFO - } 13:59:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/D7KAnUDmTUKS1fGkWXefLg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 13:59:20 INFO - Running post-action listener: _resource_record_post_action 13:59:20 INFO - [mozharness: 2016-08-22 20:59:20.024048Z] Finished read-buildbot-config step (success) 13:59:20 INFO - [mozharness: 2016-08-22 20:59:20.024195Z] Running download-and-extract step. 13:59:20 INFO - Running pre-action listener: _resource_record_pre_action 13:59:20 INFO - Running main action method: download_and_extract 13:59:20 INFO - mkdir: /builds/slave/test/build/tests 13:59: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:59:20 INFO - trying https://queue.taskcluster.net/v1/task/D7KAnUDmTUKS1fGkWXefLg/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 13:59:20 INFO - Downloading https://queue.taskcluster.net/v1/task/D7KAnUDmTUKS1fGkWXefLg/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 13:59:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/D7KAnUDmTUKS1fGkWXefLg/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json'}, attempt #1 13:59:20 INFO - Downloaded 1199 bytes. 13:59:20 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 13:59:20 INFO - Using the following test package requirements: 13:59:20 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 13:59:20 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 13:59:20 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 13:59:20 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 13:59:20 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 13:59:20 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 13:59:20 INFO - u'jsshell-mac.zip'], 13:59:20 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 13:59:20 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 13:59:20 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 13:59:20 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 13:59:20 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 13:59:20 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 13:59:20 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 13:59:20 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 13:59:20 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 13:59:20 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 13:59:20 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 13:59:20 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 13:59: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:59:20 INFO - trying https://queue.taskcluster.net/v1/task/D7KAnUDmTUKS1fGkWXefLg/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 13:59:20 INFO - Downloading https://queue.taskcluster.net/v1/task/D7KAnUDmTUKS1fGkWXefLg/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip 13:59:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/D7KAnUDmTUKS1fGkWXefLg/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip'}, attempt #1 13:59:21 INFO - Downloaded 16352467 bytes. 13:59:21 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 13:59:29 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip', u'firefox-51.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 13:59:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:59:29 INFO - trying https://queue.taskcluster.net/v1/task/D7KAnUDmTUKS1fGkWXefLg/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 13:59:29 INFO - Downloading https://queue.taskcluster.net/v1/task/D7KAnUDmTUKS1fGkWXefLg/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip 13:59:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/D7KAnUDmTUKS1fGkWXefLg/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip'}, attempt #1 13:59:29 INFO - Downloaded 16352467 bytes. 13:59:29 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 13:59: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:59:36 INFO - trying https://queue.taskcluster.net/v1/task/D7KAnUDmTUKS1fGkWXefLg/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 13:59:36 INFO - Downloading https://queue.taskcluster.net/v1/task/D7KAnUDmTUKS1fGkWXefLg/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip 13:59:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/D7KAnUDmTUKS1fGkWXefLg/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip'}, attempt #1 13:59:37 INFO - Downloaded 14413981 bytes. 13:59:37 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/tests 13:59: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:59:37 INFO - trying https://queue.taskcluster.net/v1/task/D7KAnUDmTUKS1fGkWXefLg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 13:59:37 INFO - Downloading https://queue.taskcluster.net/v1/task/D7KAnUDmTUKS1fGkWXefLg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 13:59:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/D7KAnUDmTUKS1fGkWXefLg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg'}, attempt #1 13:59:40 INFO - Downloaded 111489018 bytes. 13:59:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/D7KAnUDmTUKS1fGkWXefLg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 13:59:40 INFO - mkdir: /builds/slave/test/properties 13:59:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:59:40 INFO - Writing to file /builds/slave/test/properties/build_url 13:59:40 INFO - Contents: 13:59:40 INFO - build_url:https://queue.taskcluster.net/v1/task/D7KAnUDmTUKS1fGkWXefLg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 13:59:41 INFO - Running post-action listener: _resource_record_post_action 13:59:41 INFO - Running post-action listener: set_extra_try_arguments 13:59:41 INFO - [mozharness: 2016-08-22 20:59:41.140330Z] Finished download-and-extract step (success) 13:59:41 INFO - [mozharness: 2016-08-22 20:59:41.140472Z] Running populate-webroot step. 13:59:41 INFO - Running pre-action listener: _resource_record_pre_action 13:59:41 INFO - Running main action method: populate_webroot 13:59:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:59:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:59:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:59:41 INFO - '--tppagecycles', 13:59:41 INFO - '7'], 13:59:41 INFO - 'tests': ['tsvgm']}}, 13:59:41 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:59:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:59:41 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:59:41 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:59:41 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:59:41 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:59:41 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:59:41 INFO - 'talos_options': ['--disable-e10s'], 13:59:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:59:41 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:59:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:59:41 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:59:41 INFO - 'talos_options': ['--disable-e10s'], 13:59:41 INFO - 'tests': ['damp', 'tps']}, 13:59:41 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:59:41 INFO - 'tests': ['damp', 'tps']}, 13:59:41 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:59:41 INFO - 'tests': ['dromaeo_dom']}, 13:59:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:59:41 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:59:41 INFO - 'tests': ['basic_compositor_video']}, 13:59:41 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:59:41 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:59:41 INFO - 'tests': ['a11yr', 13:59:41 INFO - 'ts_paint', 13:59:41 INFO - 'tpaint', 13:59:41 INFO - 'sessionrestore', 13:59:41 INFO - 'sessionrestore_no_auto_restore', 13:59:41 INFO - 'tabpaint']}, 13:59:41 INFO - 'other-e10s': {'tests': ['a11yr', 13:59:41 INFO - 'ts_paint', 13:59:41 INFO - 'tpaint', 13:59:41 INFO - 'sessionrestore', 13:59:41 INFO - 'sessionrestore_no_auto_restore', 13:59:41 INFO - 'tabpaint']}, 13:59:41 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:59:41 INFO - 'ts_paint', 13:59:41 INFO - 'tpaint', 13:59:41 INFO - 'sessionrestore', 13:59:41 INFO - 'sessionrestore_no_auto_restore', 13:59:41 INFO - 'tabpaint']}, 13:59:41 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:59:41 INFO - 'ts_paint', 13:59:41 INFO - 'tpaint', 13:59:41 INFO - 'sessionrestore', 13:59:41 INFO - 'sessionrestore_no_auto_restore', 13:59:41 INFO - 'tabpaint']}, 13:59:41 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:59:41 INFO - 'tests': ['a11yr', 13:59:41 INFO - 'ts_paint', 13:59:41 INFO - 'tpaint', 13:59:41 INFO - 'sessionrestore', 13:59:41 INFO - 'sessionrestore_no_auto_restore', 13:59:41 INFO - 'tabpaint']}, 13:59:41 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:59:41 INFO - 'tests': ['a11yr', 13:59:41 INFO - 'ts_paint', 13:59:41 INFO - 'tpaint', 13:59:41 INFO - 'sessionrestore', 13:59:41 INFO - 'sessionrestore_no_auto_restore', 13:59:41 INFO - 'tabpaint']}, 13:59:41 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:59:41 INFO - 'tests': ['tsvgx', 13:59:41 INFO - 'tsvgr_opacity', 13:59:41 INFO - 'tart', 13:59:41 INFO - 'tscrollx', 13:59:41 INFO - 'cart']}, 13:59:41 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:59:41 INFO - 'tsvgr_opacity', 13:59:41 INFO - 'tart', 13:59:41 INFO - 'tscrollx', 13:59:41 INFO - 'cart']}, 13:59:41 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:59:41 INFO - 'talos_options': ['--disable-e10s'], 13:59:41 INFO - 'tests': ['tp5o']}, 13:59:41 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:59:41 INFO - 'tests': ['tp5o']}, 13:59:41 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:59:41 INFO - 'talos_options': ['--disable-e10s', 13:59:41 INFO - '--xperf_path', 13:59:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:59:41 INFO - 'tests': ['tp5n']}, 13:59:41 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:59:41 INFO - 'talos_options': ['--xperf_path', 13:59:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:59:41 INFO - 'tests': ['tp5n']}}, 13:59:41 INFO - 'talos.zip': {'path': '', 13:59:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:59:41 INFO - Running post-action listener: _resource_record_post_action 13:59:41 INFO - [mozharness: 2016-08-22 20:59:41.159306Z] Finished populate-webroot step (success) 13:59:41 INFO - [mozharness: 2016-08-22 20:59:41.159448Z] Running create-virtualenv step. 13:59:41 INFO - Running pre-action listener: _resource_record_pre_action 13:59:41 INFO - Running main action method: create_virtualenv 13:59:41 INFO - Creating virtualenv /builds/slave/test/build/venv 13:59:41 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 13:59:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:59:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:59:41 INFO - Using real prefix '/tools/python27' 13:59:41 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:59:41 INFO - Installing distribute.............................................................................................................................................................................................done. 13:59:44 INFO - Installing pip.................done. 13:59:44 INFO - Return code: 0 13:59:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:59:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:59:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:59:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:59:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:59:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:59:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:59:44 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 0x102347a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1023dc618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbeb1c9bd20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1022abd30>, '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 0x102010db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1022a3b20>, '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.Z7x2WIGpaS/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.FKPM5tEkTP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/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 13:59:44 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 13:59:44 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 13:59:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Z7x2WIGpaS/Render', 13:59:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:59:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:59:44 INFO - 'HOME': '/Users/cltbld', 13:59:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:59:44 INFO - 'LOGNAME': 'cltbld', 13:59:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:59:44 INFO - 'MOZ_NO_REMOTE': '1', 13:59:44 INFO - 'NO_EM_RESTART': '1', 13:59:44 INFO - 'PAGER': '/bin/cat', 13:59:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:59:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:59:44 INFO - 'PWD': '/builds/slave/test', 13:59:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:59:44 INFO - 'SHELL': '/bin/bash', 13:59:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FKPM5tEkTP/Listeners', 13:59:44 INFO - 'TMPDIR': '/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/', 13:59:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:59:44 INFO - 'USER': 'cltbld', 13:59:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:59:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:59:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:59:44 INFO - 'XPC_FLAGS': '0x0', 13:59:44 INFO - 'XPC_SERVICE_NAME': '0', 13:59:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:59:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:59:45 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 13:59:45 INFO - Cleaning up... 13:59:45 INFO - Return code: 0 13:59:45 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:59:45 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:59:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:59:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:59:45 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:59:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:59:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:59:45 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 0x102347a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1023dc618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbeb1c9bd20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1022abd30>, '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 0x102010db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1022a3b20>, '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.Z7x2WIGpaS/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.FKPM5tEkTP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/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 13:59:45 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 13:59:45 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 13:59:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Z7x2WIGpaS/Render', 13:59:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:59:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:59:45 INFO - 'HOME': '/Users/cltbld', 13:59:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:59:45 INFO - 'LOGNAME': 'cltbld', 13:59:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:59:45 INFO - 'MOZ_NO_REMOTE': '1', 13:59:45 INFO - 'NO_EM_RESTART': '1', 13:59:45 INFO - 'PAGER': '/bin/cat', 13:59:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:59:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:59:45 INFO - 'PWD': '/builds/slave/test', 13:59:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:59:45 INFO - 'SHELL': '/bin/bash', 13:59:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FKPM5tEkTP/Listeners', 13:59:45 INFO - 'TMPDIR': '/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/', 13:59:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:59:45 INFO - 'USER': 'cltbld', 13:59:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:59:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:59:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:59:45 INFO - 'XPC_FLAGS': '0x0', 13:59:45 INFO - 'XPC_SERVICE_NAME': '0', 13:59:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:59:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:59:45 INFO - Downloading/unpacking psutil>=3.1.1 13:59:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:59:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:59:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:59:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:59:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:59:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:59:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:59:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:59:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:59:48 INFO - Installing collected packages: psutil 13:59:48 INFO - Running setup.py install for psutil 13:59:48 INFO - building 'psutil._psutil_osx' extension 13:59:48 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 13:59:48 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 13:59:48 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 13:59:48 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 13:59:48 INFO - building 'psutil._psutil_posix' extension 13:59:48 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 13:59:48 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 13:59:48 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 13:59:48 INFO - ^ 13:59:48 INFO - 1 warning generated. 13:59:48 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 13:59:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:59:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:59:49 INFO - Successfully installed psutil 13:59:49 INFO - Cleaning up... 13:59:49 INFO - Return code: 0 13:59:49 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:59:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:59:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:59:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:59:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:59:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:59:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:59:49 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 0x102347a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1023dc618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbeb1c9bd20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1022abd30>, '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 0x102010db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1022a3b20>, '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.Z7x2WIGpaS/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.FKPM5tEkTP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/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 13:59:49 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 13:59:49 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 13:59:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Z7x2WIGpaS/Render', 13:59:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:59:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:59:49 INFO - 'HOME': '/Users/cltbld', 13:59:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:59:49 INFO - 'LOGNAME': 'cltbld', 13:59:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:59:49 INFO - 'MOZ_NO_REMOTE': '1', 13:59:49 INFO - 'NO_EM_RESTART': '1', 13:59:49 INFO - 'PAGER': '/bin/cat', 13:59:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:59:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:59:49 INFO - 'PWD': '/builds/slave/test', 13:59:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:59:49 INFO - 'SHELL': '/bin/bash', 13:59:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FKPM5tEkTP/Listeners', 13:59:49 INFO - 'TMPDIR': '/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/', 13:59:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:59:49 INFO - 'USER': 'cltbld', 13:59:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:59:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:59:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:59:49 INFO - 'XPC_FLAGS': '0x0', 13:59:49 INFO - 'XPC_SERVICE_NAME': '0', 13:59:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:59:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:59:49 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:59: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 13:59: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 13:59: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 13:59: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 13:59: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 13:59: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 13:59:51 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:59:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:59:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:59:51 INFO - Installing collected packages: mozsystemmonitor 13:59:51 INFO - Running setup.py install for mozsystemmonitor 13:59:52 INFO - Successfully installed mozsystemmonitor 13:59:52 INFO - Cleaning up... 13:59:52 INFO - Return code: 0 13:59:52 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:59:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:59:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:59:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:59:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:59:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:59:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:59:52 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 0x102347a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1023dc618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbeb1c9bd20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1022abd30>, '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 0x102010db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1022a3b20>, '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.Z7x2WIGpaS/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.FKPM5tEkTP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/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 13:59:52 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 13:59:52 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 13:59:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Z7x2WIGpaS/Render', 13:59:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:59:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:59:52 INFO - 'HOME': '/Users/cltbld', 13:59:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:59:52 INFO - 'LOGNAME': 'cltbld', 13:59:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:59:52 INFO - 'MOZ_NO_REMOTE': '1', 13:59:52 INFO - 'NO_EM_RESTART': '1', 13:59:52 INFO - 'PAGER': '/bin/cat', 13:59:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:59:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:59:52 INFO - 'PWD': '/builds/slave/test', 13:59:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:59:52 INFO - 'SHELL': '/bin/bash', 13:59:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FKPM5tEkTP/Listeners', 13:59:52 INFO - 'TMPDIR': '/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/', 13:59:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:59:52 INFO - 'USER': 'cltbld', 13:59:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:59:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:59:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:59:52 INFO - 'XPC_FLAGS': '0x0', 13:59:52 INFO - 'XPC_SERVICE_NAME': '0', 13:59:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:59:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:59:52 INFO - Downloading/unpacking jsonschema==2.5.1 13:59:52 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 13:59:52 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 13:59:52 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 13:59:52 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 13:59:52 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 13:59:52 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 13:59:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:59:54 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:59:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:59:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:59:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:59:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:59:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:59:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:59:55 INFO - Downloading functools32-3.2.3-2.tar.gz 13:59:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:59:55 INFO - warning: no files found matching '*.txt' 13:59:55 INFO - no previously-included directories found matching 'build' 13:59:55 INFO - no previously-included directories found matching 'dist' 13:59:55 INFO - no previously-included directories found matching '.git*' 13:59:55 INFO - Installing collected packages: jsonschema, functools32 13:59:55 INFO - Running setup.py install for functools32 13:59:55 INFO - warning: no files found matching '*.txt' 13:59:55 INFO - no previously-included directories found matching 'build' 13:59:55 INFO - no previously-included directories found matching 'dist' 13:59:55 INFO - no previously-included directories found matching '.git*' 13:59:55 INFO - Successfully installed jsonschema functools32 13:59:55 INFO - Cleaning up... 13:59:55 INFO - Return code: 0 13:59:55 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:59:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:59:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:59:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:59:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:59:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:59:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:59:55 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', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102347a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1023dc618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbeb1c9bd20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1022abd30>, '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 0x102010db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1022a3b20>, '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.Z7x2WIGpaS/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.FKPM5tEkTP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/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 13:59:55 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', 'functools32==3.2.3-2'] in /builds/slave/test/build 13:59:55 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 functools32==3.2.3-2 13:59:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Z7x2WIGpaS/Render', 13:59:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:59:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:59:55 INFO - 'HOME': '/Users/cltbld', 13:59:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:59:55 INFO - 'LOGNAME': 'cltbld', 13:59:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:59:55 INFO - 'MOZ_NO_REMOTE': '1', 13:59:55 INFO - 'NO_EM_RESTART': '1', 13:59:55 INFO - 'PAGER': '/bin/cat', 13:59:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:59:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:59:55 INFO - 'PWD': '/builds/slave/test', 13:59:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:59:55 INFO - 'SHELL': '/bin/bash', 13:59:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FKPM5tEkTP/Listeners', 13:59:55 INFO - 'TMPDIR': '/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/', 13:59:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:59:55 INFO - 'USER': 'cltbld', 13:59:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:59:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:59:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:59:55 INFO - 'XPC_FLAGS': '0x0', 13:59:55 INFO - 'XPC_SERVICE_NAME': '0', 13:59:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:59:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:59:55 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:59:55 INFO - Cleaning up... 13:59:55 INFO - Return code: 0 13:59:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:59:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:59:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:59:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:59:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:59:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:59:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:59:55 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 0x102347a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1023dc618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbeb1c9bd20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1022abd30>, '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 0x102010db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1022a3b20>, '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.Z7x2WIGpaS/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.FKPM5tEkTP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/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 13:59:55 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 13:59:55 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 13:59:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Z7x2WIGpaS/Render', 13:59:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:59:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:59:55 INFO - 'HOME': '/Users/cltbld', 13:59:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:59:55 INFO - 'LOGNAME': 'cltbld', 13:59:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:59:55 INFO - 'MOZ_NO_REMOTE': '1', 13:59:55 INFO - 'NO_EM_RESTART': '1', 13:59:55 INFO - 'PAGER': '/bin/cat', 13:59:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:59:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:59:55 INFO - 'PWD': '/builds/slave/test', 13:59:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:59:55 INFO - 'SHELL': '/bin/bash', 13:59:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FKPM5tEkTP/Listeners', 13:59:55 INFO - 'TMPDIR': '/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/', 13:59:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:59:55 INFO - 'USER': 'cltbld', 13:59:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:59:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:59:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:59:55 INFO - 'XPC_FLAGS': '0x0', 13:59:55 INFO - 'XPC_SERVICE_NAME': '0', 13:59:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:59:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:59:56 INFO - Downloading/unpacking blobuploader==1.2.4 13:59:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:59:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:59:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:59:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:59:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:59:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:59:59 INFO - Downloading blobuploader-1.2.4.tar.gz 13:59:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:59:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:59:59 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 13:59:59 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 13:59:59 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 13:59:59 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 13:59:59 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 13:59:59 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 14:00:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:00:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:00:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:00:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:00:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:00:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:00:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:00:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:00:00 INFO - Downloading docopt-0.6.1.tar.gz 14:00:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:00:00 INFO - Installing collected packages: blobuploader, requests, docopt 14:00:00 INFO - Running setup.py install for blobuploader 14:00:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:00:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:00:01 INFO - Running setup.py install for requests 14:00:01 INFO - Running setup.py install for docopt 14:00:01 INFO - Successfully installed blobuploader requests docopt 14:00:01 INFO - Cleaning up... 14:00:01 INFO - Return code: 0 14:00:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:00: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:00:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:00:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:00:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:00:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:00:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:00:02 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 0x102347a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1023dc618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbeb1c9bd20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1022abd30>, '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 0x102010db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1022a3b20>, '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.Z7x2WIGpaS/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.FKPM5tEkTP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/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 14:00:02 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 14:00:02 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 14:00:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Z7x2WIGpaS/Render', 14:00:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:00:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:00:02 INFO - 'HOME': '/Users/cltbld', 14:00:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:00:02 INFO - 'LOGNAME': 'cltbld', 14:00:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:00:02 INFO - 'MOZ_NO_REMOTE': '1', 14:00:02 INFO - 'NO_EM_RESTART': '1', 14:00:02 INFO - 'PAGER': '/bin/cat', 14:00:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:00:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:00:02 INFO - 'PWD': '/builds/slave/test', 14:00:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:00:02 INFO - 'SHELL': '/bin/bash', 14:00:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FKPM5tEkTP/Listeners', 14:00:02 INFO - 'TMPDIR': '/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/', 14:00:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:00:02 INFO - 'USER': 'cltbld', 14:00:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:00:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:00:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:00:02 INFO - 'XPC_FLAGS': '0x0', 14:00:02 INFO - 'XPC_SERVICE_NAME': '0', 14:00:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:00:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:00:02 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-T3SZrW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:00:02 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-sx0KQV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:00:02 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-DCDVF8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:00:02 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-mQZQr1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:00:02 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-lvzgvA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:00:03 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-bP6hB3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:00:03 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-L9X6_M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:00:03 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-bdnrNn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:00:03 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-aPARwD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:00:03 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-wztfSJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:00:03 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-8S10Mo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:00:03 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-_SAHgq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:00:03 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-BqfQj7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:00:03 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-kxqo7w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:00:03 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-UjfRq9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:00:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:00:04 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-W_RiTF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:00:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:00:04 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-eJWCFv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:00:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:00:04 INFO - Running setup.py install for manifestparser 14:00:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:00:04 INFO - Running setup.py install for mozcrash 14:00:04 INFO - Running setup.py install for mozdebug 14:00:04 INFO - Running setup.py install for mozdevice 14:00:04 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:00:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:00:04 INFO - Running setup.py install for mozfile 14:00:05 INFO - Running setup.py install for mozhttpd 14:00:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:00:05 INFO - Running setup.py install for mozinfo 14:00:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:00:05 INFO - Running setup.py install for mozInstall 14:00:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:00:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:00:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:00:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:00:05 INFO - Running setup.py install for mozleak 14:00:05 INFO - Running setup.py install for mozlog 14:00:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:00:05 INFO - Running setup.py install for moznetwork 14:00:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:00:05 INFO - Running setup.py install for mozprocess 14:00:06 INFO - Running setup.py install for mozprofile 14:00:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:00:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:00:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:00:06 INFO - Running setup.py install for mozrunner 14:00:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:00:06 INFO - Running setup.py install for mozscreenshot 14:00:06 INFO - Running setup.py install for moztest 14:00:06 INFO - Running setup.py install for mozversion 14:00:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:00:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:00:06 INFO - Cleaning up... 14:00:06 INFO - Return code: 0 14:00:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:00:06 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:00:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:00:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:00:06 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:00:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:00:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:00:06 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 0x102347a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1023dc618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbeb1c9bd20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1022abd30>, '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 0x102010db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1022a3b20>, '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.Z7x2WIGpaS/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.FKPM5tEkTP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/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 14:00:06 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 14:00:06 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 14:00:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Z7x2WIGpaS/Render', 14:00:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:00:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:00:06 INFO - 'HOME': '/Users/cltbld', 14:00:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:00:06 INFO - 'LOGNAME': 'cltbld', 14:00:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:00:06 INFO - 'MOZ_NO_REMOTE': '1', 14:00:06 INFO - 'NO_EM_RESTART': '1', 14:00:06 INFO - 'PAGER': '/bin/cat', 14:00:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:00:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:00:06 INFO - 'PWD': '/builds/slave/test', 14:00:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:00:06 INFO - 'SHELL': '/bin/bash', 14:00:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FKPM5tEkTP/Listeners', 14:00:06 INFO - 'TMPDIR': '/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/', 14:00:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:00:06 INFO - 'USER': 'cltbld', 14:00:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:00:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:00:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:00:06 INFO - 'XPC_FLAGS': '0x0', 14:00:06 INFO - 'XPC_SERVICE_NAME': '0', 14:00:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:00:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:00:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:00:07 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-9i6lv0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:00:07 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)) 14:00:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:00:07 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-INzywn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:00:07 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)) 14:00:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:00:07 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-XCKa2a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:00:07 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)) 14:00:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:00:07 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-EtflvH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:00:07 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)) 14:00:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:00:07 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-TTXbE1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:00:07 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)) 14:00:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:00:07 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-gjyPec-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:00:07 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)) 14:00:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:00:07 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-DOpGNj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:00:07 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)) 14:00:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:00:07 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-UEO1YX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:00:07 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)) 14:00:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:00:07 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-rtetQx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:00:08 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)) 14:00:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:00:08 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-QmJWEm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:00:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 14:00:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:00:08 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-mpaabU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:00:08 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)) 14:00:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:00:08 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-Eh8QMP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:00:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 14:00:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:00:08 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-mg9HT6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:00:08 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)) 14:00:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:00:08 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-cMfzIw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:00:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 14:00:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:00:08 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-ylfkax-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:00:08 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)) 14:00:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:00:08 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-OT5dfc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:00:08 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)) 14:00:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:00:08 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-Vmf67c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:00:08 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)) 14:00:08 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)) 14:00:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:00:08 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)) 14:00:08 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)) 14:00:08 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)) 14:00:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:00:08 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 14:00:08 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 14:00:08 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 14:00:08 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 14:00:08 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 14:00:08 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 14:00:11 INFO - Downloading blessings-1.6.tar.gz 14:00:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:00:11 INFO - Installing collected packages: blessings 14:00:11 INFO - Running setup.py install for blessings 14:00:11 INFO - Successfully installed blessings 14:00:11 INFO - Cleaning up... 14:00:12 INFO - Return code: 0 14:00:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:00:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:00:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:00:12 INFO - Reading from file tmpfile_stdout 14:00:12 INFO - Current package versions: 14:00:12 INFO - blessings == 1.6 14:00:12 INFO - blobuploader == 1.2.4 14:00:12 INFO - docopt == 0.6.1 14:00:12 INFO - functools32 == 3.2.3-2 14:00:12 INFO - jsonschema == 2.5.1 14:00:12 INFO - manifestparser == 1.1 14:00:12 INFO - mozInstall == 1.12 14:00:12 INFO - mozcrash == 0.17 14:00:12 INFO - mozdebug == 0.1 14:00:12 INFO - mozdevice == 0.48 14:00:12 INFO - mozfile == 1.2 14:00:12 INFO - mozhttpd == 0.7 14:00:12 INFO - mozinfo == 0.9 14:00:12 INFO - mozleak == 0.1 14:00:12 INFO - mozlog == 3.3 14:00:12 INFO - moznetwork == 0.27 14:00:12 INFO - mozprocess == 0.23 14:00:12 INFO - mozprofile == 0.28 14:00:12 INFO - mozrunner == 6.12 14:00:12 INFO - mozscreenshot == 0.1 14:00:12 INFO - mozsystemmonitor == 0.3 14:00:12 INFO - moztest == 0.7 14:00:12 INFO - mozversion == 1.4 14:00:12 INFO - psutil == 3.1.1 14:00:12 INFO - requests == 1.2.3 14:00:12 INFO - wsgiref == 0.1.2 14:00:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:00:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:00:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:00:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:00:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:00:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:00:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:00:12 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 0x102347a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1023dc618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbeb1c9bd20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1022abd30>, '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 0x102010db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1022a3b20>, '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.Z7x2WIGpaS/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.FKPM5tEkTP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/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 14:00:12 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 14:00:12 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 14:00:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Z7x2WIGpaS/Render', 14:00:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:00:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:00:12 INFO - 'HOME': '/Users/cltbld', 14:00:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:00:12 INFO - 'LOGNAME': 'cltbld', 14:00:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:00:12 INFO - 'MOZ_NO_REMOTE': '1', 14:00:12 INFO - 'NO_EM_RESTART': '1', 14:00:12 INFO - 'PAGER': '/bin/cat', 14:00:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:00:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:00:12 INFO - 'PWD': '/builds/slave/test', 14:00:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:00:12 INFO - 'SHELL': '/bin/bash', 14:00:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FKPM5tEkTP/Listeners', 14:00:12 INFO - 'TMPDIR': '/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/', 14:00:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:00:12 INFO - 'USER': 'cltbld', 14:00:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:00:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:00:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:00:12 INFO - 'XPC_FLAGS': '0x0', 14:00:12 INFO - 'XPC_SERVICE_NAME': '0', 14:00:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:00:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:00:12 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)) 14:00:12 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)) 14:00:12 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)) 14:00:12 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)) 14:00:12 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)) 14:00:12 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)) 14:00:12 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)) 14:00:12 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)) 14:00:12 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)) 14:00:12 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)) 14:00:12 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)) 14:00:12 INFO - Cleaning up... 14:00:12 INFO - Return code: 0 14:00:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:00:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:00:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:00:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:00:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:00:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:00:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:00:12 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 0x102347a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1023dc618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbeb1c9bd20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1022abd30>, '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 0x102010db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1022a3b20>, '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.Z7x2WIGpaS/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.FKPM5tEkTP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/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 14:00:12 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 14:00:12 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 14:00:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Z7x2WIGpaS/Render', 14:00:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:00:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:00:12 INFO - 'HOME': '/Users/cltbld', 14:00:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:00:12 INFO - 'LOGNAME': 'cltbld', 14:00:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:00:12 INFO - 'MOZ_NO_REMOTE': '1', 14:00:12 INFO - 'NO_EM_RESTART': '1', 14:00:12 INFO - 'PAGER': '/bin/cat', 14:00:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:00:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:00:12 INFO - 'PWD': '/builds/slave/test', 14:00:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:00:12 INFO - 'SHELL': '/bin/bash', 14:00:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FKPM5tEkTP/Listeners', 14:00:12 INFO - 'TMPDIR': '/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/', 14:00:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:00:12 INFO - 'USER': 'cltbld', 14:00:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:00:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:00:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:00:12 INFO - 'XPC_FLAGS': '0x0', 14:00:12 INFO - 'XPC_SERVICE_NAME': '0', 14:00:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:00:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:00:12 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:00:12 INFO - Cleaning up... 14:00:12 INFO - Return code: 0 14:00:12 INFO - Running post-action listener: _resource_record_post_action 14:00:12 INFO - Running post-action listener: _start_resource_monitoring 14:00:12 INFO - Starting resource monitoring. 14:00:12 INFO - [mozharness: 2016-08-22 21:00:12.870544Z] Finished create-virtualenv step (success) 14:00:12 INFO - [mozharness: 2016-08-22 21:00:12.871548Z] Running install step. 14:00:12 INFO - Running pre-action listener: _resource_record_pre_action 14:00:12 INFO - Running main action method: install 14:00:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:00:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:00:13 INFO - Reading from file tmpfile_stdout 14:00:13 INFO - Detecting whether we're running mozinstall >=1.0... 14:00:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:00:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:00:13 INFO - Reading from file tmpfile_stdout 14:00:13 INFO - Output received: 14:00:13 INFO - Usage: mozinstall [options] installer 14:00:13 INFO - Options: 14:00:13 INFO - -h, --help show this help message and exit 14:00:13 INFO - -d DEST, --destination=DEST 14:00:13 INFO - Directory to install application into. [default: 14:00:13 INFO - "/builds/slave/test"] 14:00:13 INFO - --app=APP Application being installed. [default: firefox] 14:00:13 INFO - mkdir: /builds/slave/test/build/application 14:00:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 14:00:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 14:00:47 INFO - Reading from file tmpfile_stdout 14:00:47 INFO - Output received: 14:00:47 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 14:00:47 INFO - Running post-action listener: _resource_record_post_action 14:00:47 INFO - [mozharness: 2016-08-22 21:00:47.153992Z] Finished install step (success) 14:00:47 INFO - [mozharness: 2016-08-22 21:00:47.154143Z] Running run-tests step. 14:00:47 INFO - Running pre-action listener: _resource_record_pre_action 14:00:47 INFO - Running main action method: run_tests 14:00:47 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:00:47 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:00:47 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:00:47 INFO - 2016-08-22 14:00:47.168 screenresolution[1917:18180] starting screenresolution argv=screenresolution get 14:00:47 INFO - 2016-08-22 14:00:47.171 screenresolution[1917:18180] Display 0: 1600x1200x32@60 14:00:47 INFO - 2016-08-22 14:00:47.177 screenresolution[1918:18182] starting screenresolution argv=screenresolution list 14:00:47 INFO - Available Modes on Display 0 14:00:47 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:00:47 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:00:47 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:00:47 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:00:47 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:00:47 INFO - Intel Iris: 14:00:47 INFO - Chipset Model: Intel Iris 14:00:47 INFO - Type: GPU 14:00:47 INFO - Bus: Built-In 14:00:47 INFO - VRAM (Dynamic, Max): 1536 MB 14:00:47 INFO - Vendor: Intel (0x8086) 14:00:47 INFO - Device ID: 0x0a2e 14:00:47 INFO - Revision ID: 0x0009 14:00:47 INFO - Displays: 14:00:47 INFO - Display: 14:00:47 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:00:47 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:00:47 INFO - Display Serial Number: 1600x1200 60 14:00:47 INFO - Main Display: Yes 14:00:47 INFO - Mirror: Off 14:00:47 INFO - Online: Yes 14:00:47 INFO - Rotation: Supported 14:00:47 INFO - Return code: 0 14:00:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:00:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:00:47 INFO - Python 2.7.3 14:00:47 INFO - Return code: 0 14:00:47 INFO - grabbing minidump binary from tooltool 14:00:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:00:47 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 0x1022abd30>, '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 0x102010db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1022a3b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:00:47 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 14:00:47 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 14:00:47 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 14:00:47 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:00:47 INFO - Return code: 0 14:00:47 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 14:00:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:00:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:00:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 14:00:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:00:47 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/D7KAnUDmTUKS1fGkWXefLg/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0371', '--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 14:00:47 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/D7KAnUDmTUKS1fGkWXefLg/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0371 --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 14:00:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Z7x2WIGpaS/Render', 14:00:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:00:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:00:47 INFO - 'HOME': '/Users/cltbld', 14:00:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:00:47 INFO - 'LOGNAME': 'cltbld', 14:00:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:00:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 14:00:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:00:47 INFO - 'MOZ_NO_REMOTE': '1', 14:00:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:00:47 INFO - 'NO_EM_RESTART': '1', 14:00:47 INFO - 'PAGER': '/bin/cat', 14:00:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:00:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:00:47 INFO - 'PWD': '/builds/slave/test', 14:00:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:00:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:00:47 INFO - 'SHELL': '/bin/bash', 14:00:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FKPM5tEkTP/Listeners', 14:00:47 INFO - 'TMPDIR': '/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/', 14:00:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:00:47 INFO - 'USER': 'cltbld', 14:00:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:00:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:00:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:00:47 INFO - 'XPC_FLAGS': '0x0', 14:00:47 INFO - 'XPC_SERVICE_NAME': '0', 14:00:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:00:47 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/D7KAnUDmTUKS1fGkWXefLg/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0371', '--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 14:00:47 INFO - mozversion application_buildid: 20160822113014 14:00:47 INFO - mozversion application_changeset: 3345f0e8ed3bd33d8af6e2b9bf1fd8bf397a45bc 14:00:47 INFO - mozversion application_display_name: Nightly 14:00:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:00:47 INFO - mozversion application_name: Firefox 14:00:47 INFO - mozversion application_remotingname: firefox 14:00:47 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 14:00:47 INFO - mozversion application_vendor: Mozilla 14:00:47 INFO - mozversion application_version: 51.0a1 14:00:47 INFO - mozversion platform_buildid: 20160822113014 14:00:47 INFO - mozversion platform_changeset: 3345f0e8ed3bd33d8af6e2b9bf1fd8bf397a45bc 14:00:47 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 14:00:47 INFO - mozversion platform_version: 51.0a1 14:00:47 INFO - using testdate: 1471899647 14:00:47 INFO - actual date: 1471899647 14:00:47 INFO - starting webserver on 'localhost:54437' 14:00:47 INFO - SUITE-START | Running 2 tests 14:00:47 INFO - TEST-START | dromaeo_css 14:00:47 INFO - operating with platform_type : mac_ 14:00:47 INFO - Initialising browser for dromaeo_css test... 14:00:47 INFO - TEST-INFO | started process 1928 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/tmpW4yMY3/profile http://localhost:54437/getInfo.html) 14:00:50 INFO - PROCESS | 1928 | __metrics Screen width/height:1600/1200 14:00:50 INFO - PROCESS | 1928 | colorDepth:24 14:00:50 INFO - PROCESS | 1928 | Browser inner width/height: 1024/689 14:00:50 INFO - PROCESS | 1928 | __metrics 14:00:50 ERROR - PROCESS | 1928 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2993: TypeError: this.tabs is undefined 14:00:51 INFO - TEST-INFO | 1928: exit 0 14:00:51 INFO - Browser initialized. 14:00:51 INFO - Running cycle 1/1 for dromaeo_css test... 14:00:51 INFO - TEST-INFO | started process 1931 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/tmpW4yMY3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:01:03 INFO - PROCESS | 1931 | RSS: Main: 239751168 14:01:03 INFO - PROCESS | 1931 | 14:01:52 INFO - PROCESS | 1931 | 1471899712949 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] 14:04:05 INFO - PROCESS | 1931 | Cycle 1(1): loaded http://localhost:54437/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54437/tests/dromaeo/cssquery-ext.html) 14:04:06 INFO - PROCESS | 1931 | RSS: Main: 255246336 14:04:06 INFO - PROCESS | 1931 | 14:07:09 INFO - PROCESS | 1931 | Cycle 1(1): loaded http://localhost:54437/tests/dromaeo/cssquery-ext.html (next: http://localhost:54437/tests/dromaeo/cssquery-jquery.html) 14:07:09 INFO - PROCESS | 1931 | RSS: Main: 268279808 14:07:09 INFO - PROCESS | 1931 | 14:10:11 INFO - PROCESS | 1931 | Cycle 1(1): loaded http://localhost:54437/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54437/tests/dromaeo/cssquery-mootools.html) 14:10:12 INFO - PROCESS | 1931 | RSS: Main: 272777216 14:10:12 INFO - PROCESS | 1931 | 14:13:14 INFO - PROCESS | 1931 | Cycle 1(1): loaded http://localhost:54437/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54437/tests/dromaeo/cssquery-prototype.html) 14:13:14 INFO - PROCESS | 1931 | RSS: Main: 272392192 14:13:14 INFO - PROCESS | 1931 | 14:16:17 INFO - PROCESS | 1931 | Cycle 1(1): loaded http://localhost:54437/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54437/tests/dromaeo/cssquery-yui.html) 14:16:18 INFO - PROCESS | 1931 | RSS: Main: 277573632 14:16:18 INFO - PROCESS | 1931 | 14:19:21 INFO - PROCESS | 1931 | Cycle 1(1): loaded http://localhost:54437/tests/dromaeo/cssquery-yui.html (next: http://localhost:54437/tests/dromaeo/cssquery-dojo.html) 14:19:21 INFO - PROCESS | 1931 | RSS: Main: 280596480 14:19:21 INFO - PROCESS | 1931 | 14:19:21 INFO - PROCESS | 1931 | __start_tp_report 14:19:21 INFO - PROCESS | 1931 | _x_x_mozilla_page_load 14:19:21 INFO - PROCESS | 1931 | _x_x_mozilla_page_load_details 14:19:21 INFO - PROCESS | 1931 | |i|pagename|runs| 14:19:21 INFO - PROCESS | 1931 | |0;dojo.html;3418.6240562808825;3427.2117412994994;3435.74231932605;3445.8966231013064;3473.7742046766966;5161.612879034069;5504.174373843925;5658.462446067627;5787.536997040237;5794.101914203295;4962.932969411576;5625.80309689161;5656.490915817576;5694.259746232984;5778.162166485857;5223.216517522383;5317.175837745136;5325.627206095575;5353.678779273237;5388.676679399229;5415.025295446818;5445.64837469417;5451.863703407407;5459.099248623972;5469.507744303012;5207.557357624606;5218.739063046871;5254.579633629301;5260.263563101169;5325.60057995648;5337.946620533784;5353.223782551547;5354.41101478837;5369.731513424353;5375.973120134413;5258.605604579672;5272.499112584298;5292.02097611943;5340.198970154469;5361.463853614647;4652.464966528859;5594.608377413582;5659.122835960433;5748.425157484218;5787.816700814577;6248.094026366197;6269.592476489013;6317.463015643676;6320.589161704521;6337.429631333202;6256.499480041586;6281.968590157066;6285.402886725754;6286.49708023357;6294.244690637107;5702.8289151325525;5767.480926716616;5794.797182098607;5847.415258474203;5921.289445266552;6333.398327158912;6349.333320001426;6351.269603995507;6353.745850166034;6357.523185761086;5360.3299587551555;6184.567080304336;6208.906866397007;6237.5321850860455;6238.688065596702;5098.872528186751;6147.538934579924;6159.5688301818445;6180.845478863064;6262.718177681924;6292.339304373067;6305.527085468608;6307.5269354798575;6317.4630156437215;6324.936750632527;6084.726187321581;6281.560290779693;6291.622502649856;6297.370262973757;6305.274893387227;4487.6634252431195;4866.95133048665;4925.75371231437;4944.752762361867;4945.159322915113;4447.132809102259;4453.3320001999955;4472.306792447176;4483.596476317147;4493.393391892118;5825.213596164548;5932.970335148297;5941.168236446901;5958.791442299499;5974.551908606872;6146.508279337731;6177.722002509898;6201.782937597252;6208.689565521706;6275.843103922439;5959.761609535657;5968.552358573124;5975.52195824333;5975.581709280395;5979.372165922602;5486.506214440719;5487.176923461433;5492.533134683516;5497.230387745719;5518.33779946409;6185.443310102022;6258.874822503433;6284.74861005573;6329.620222786648;6367.140436041075;6254.749810007731;6272.153259309935;6285.748570057147;6290.559660823698;6313.90529142054;6387.712552935036;6453.1610890583925;6463.709133088928;6477.935220647733;6485.383888530582;6043.2748070231855;6180.721867515883;6191.597546159485;6194.225721784777;6283;5315.176147697113;6275.341089185752;6283;6292.056191571301;6366.6180029198395;5018.84943451697;5220.791168353223;6266.404691554295;6267.62394256346;6286.779962701284;6026.758929642765;6104.26748790148;6116.510679145568;6160.568760186744;6200.906986395298;5891.351951285269;6089.025755879038;6103.328633850362;6103.816885493442;6108.389161083856;6193.38066193377;6199.752009919553;6232.470240029467;6250.281217660027;6272.310045895039;5878.3239927408895;5967.492763115184;5978.461938425563;6020.608660437058;6084.361142080018 14:19:21 INFO - PROCESS | 1931 | |1;ext.html;473.4106037982711;486.82474309248664;498.8328909815212;508.1387048952028;521.7052365413541;32543.837280813594;39419.80290098549;39447.40828887565;39533.80233098831;39591.604083959224;34195;34218.14454638635;34486;34555.82722086386;34746.47880281792;9555.856662150074;9721.076497732704;9733;9743.317967742261;9763.316567840255;8747.343949203836;9498.717673114144;9577.138057574817;9685.467299298536;9701.708948731513;9652.469114198717;9686.98286679899;9712.757181070494;9713.174380177694;9728.65949691761;9602.423854568748;9618.90381096187;9636.90363096367;9654.951725241399;9668.75828104296;9532.809343813155;9598.616055357777;9603.887144828126;9615.173117107726;9639.325247232697;34489.96530104076;38633;39082;39354.803225983975;39495.60504394948;3608.6030536640947;3634.4548317752283;3669.192777588926;3825.4261860720835;4028.5971402859773;30439.086827395215;31207.84396078005;31592.52611210834;31652.841735791404;31717.524237136462;3253.072874230833;3304.5538852254876;3340.9977006898075;3450.016745227598;3456.3778519866414;483186;483885.1920548327;485958;486019.56990215176;490544.5472772649;56125;56244.15633765497;56618.150727739114;56773.14840277399;56774.71612641993;55098.17352739712;55435.445645543026;55546.72226638841;55906.44093559094;59203.11195332073;16018.679626407407;16025.599360016093;16201.675966480605;16209.67580648404;16223.91888040576;12649.936750316374;12684.04869634781;12687.048471364684;12693.619191424272;12715.237085774883;13265.535706250235;15636.92181539085;15687.058776473448;15700.900936934533;15911.68176636484;6349.873002539924;6812.523123381316;6909.481788865855;7092.4326053915565;7185;722.4004076616396;773.6170595555124;784.2197013971021;797.330242596222;816.7917181118895;26572.867135664197;30186.9434569789;30210.54684179739;30461.93383231576;31124.910628127906;970.631160159135;1018.2363227579316;1029.3206483720708;1032.143321043532;1194.5460724924646;15029;15454.227288635524;15613;15713.842861571238;15848.286827092808;617962;653616;685565;697270;697883;57527.42472575221;57530;58048.419515805144;58314.12528811987;58453.41546584565;1347.5889853594551;1349.3590544491485;1365.4606430460112;1372.1218420211073;1382.025671901307;21919;24938.251852444457;28924.698388572986;29168.3957382346;29781.702182977893;47173.76413117912;47423.762881186754;47442.28836567523;47494;47549.81125471891;600102;606201;608598;610308;610605.6288029897;37352;38286;38582.80708596439;38619.613803862725;38994;44637.55362446334;45956.54043459523;46405.53594464012;46868.53131468778;46995.530044700485;38088.809555952044;38185.6181438182;38789;39444.80277598594;40143.598564013984;32947;35465;38854;38865.61134388733;39954.00114997148;32297.677023230408;37599.43600846044;37806.43290350592;37868.810655946545;38719.8384048479;28015.719842802126;31928.201794955312;34380;34536.309273814884;34861;24774.876125619256;25375.36561585975;25842;26251.08121215748;26698.46603067889 14:19:21 INFO - PROCESS | 1931 | |2;jquery.html;334.92155260062606;346.85952189363314;366.1395720057866;379.67917110042015;385.7376983651118;18334.72497912531;19393.612127757453;20652.07065682046;20787;20852;16948.3220671173;20277.188912443486;20349.796502034977;21076;21229.787702122972;5824.796132135376;5833.300003999515;5998.910016349758;6019.337872833985;6034.758609655609;5821.18503409523;5941.19793827832;5943.078822782454;5954.451842520954;5973.522118230531;4925.876853078666;5741.684207368593;5813.82558523245;5816.912746308809;5837.737301821407;5697.6866272355;5840;5852.941470585282;5864.76540938362;5871.588988770766;4205.957940420587;5047.242913562958;5113.61647876407;5131.897362052738;5198;26389.208323750125;26490.33774155642;26491.807868645956;26603.334916627045;26749.930002799865;2034.9287774927955;2469.6295555666616;2705.959410608823;2748.8900443982216;3031.8180909145303;10379.584816607327;11592.884071159266;12898.226106433644;15575.532734017997;15643.843561564467;1807.6023274879506;1837.6049149432802;1880.6050729346716;1882.6611209982334;1882.9152688129068;106166.46916765366;124720;128981.7101828979;130907;132027.6797232025;9197.402168859002;11674.474648640831;11710.594728632619;11734.471948762326;11945.940270298766;14658.633534161518;14693.26533673312;14700.55898323052;14701.852981470049;14732.631684207981;8489.4481858679;8630.525321107274;8699.086595907338;8782.165694259034;8832.823343533222;8535.573221339033;8547.27348175412;8643.87034194475;8771.956140219258;8788.60451279694;4462.665300102505;4543.159515489645;4557.5442455754155;4558.225101732647;4623.988564974247;1828.1189224769896;1840.9657328651647;1890.2722451856134;1916.0898573177628;1931.65230258552;837.2757564706607;892.5017909734993;919.6459363145237;953.9284553658504;990.8315586350337;20293.28973485921;20877.478063048242;21566.921653917554;21615.783842161378;21705.891470542545;906.7687739626354;916.7524768312652;927.2952556057445;948.9335746497679;951.3673407184145;9597.568109434953;11481.483333250024;11501.53993840237;11504.712382190512;11511.76976460483;488400;553294.2335288378;609159;630290;631020;84387;125569;126350;127182;128372;873.1922971251566;926.2636204217798;967.2020583019038;1005.2862467648051;1005.9245556583286;17226.655466890843;17468.650626987135;19004.95472749012;19017.524561886064;19111.426657200307;56169;57631.42368576428;58286.708566456895;58384;59053.818923622144;79120.60439697765;80867.19132808832;81683;83368.58315708382;85678.57160714405;5732.541396688338;6441;7328.083989501312;7678.5008974418715;8321.209485098905;10892.346459212473;13119.147255428366;13221.140625859289;13665.86334136646;13677.726445470837;11545.191836571359;11751.823722644338;11846.348450834943;11929.343886086348;12033.759324813629;11425.428728563373;11481.138914581607;11637.709057273636;11871.05031597453;12038.638840834788;11437.428128593703;11647.417629118341;11836;11986.820197696867;12046.819297710717;7363.521371110861;7416.480846340704;7449.5902725350625;7466.141393739789;7689.846203076019;11318.547258109584;11798.053321201905;11878.940605296919;11888.881111188777;11918.40407979615 14:19:21 INFO - PROCESS | 1931 | |3;mootools.html;1467.171048357678;1501.609581508808;1734;1829.1037391678083;1854.221227084625;6927.51507394482;7850.097238817538;8535.573221338924;8901.554922253885;8912.287017038638;8609;8728.258098061673;8794;8816.77958051049;8818.98581663109;2363.420961864346;2406.109739396426;2407.843490173142;2412.2160297903165;2418.3107814272935;2376.4771750214927;2380.6071998120374;2420.4070002849326;2430.4895971845845;2430.5017471418405;2385.2367242482414;2391.940201494968;2392.688950436441;2408.3738228060656;2409.180878501309;2380.214529205358;2384.868832214236;2397.9160729374476;2405.1942599229365;2405.615101583738;2368.1593034472858;2381.2141993142222;2386.749391313922;2388.749181335952;2389.0563227525204;8820.33847461443;8855.114488551159;8900.465972041633;8910.643574257021;8916.55417229136;5166.966606678679;5334.199870019489;5334.22653715213;5335.33308336458;5338.119210330291;3117.189530722006;3615.7288203384587;3627.1113577173496;3672.6327367263325;3685.4287585424304;1097.6268068856627;1100.2793170473353;1110.900018998286;1114.4706264524368;1118.8321751737305;11260.43697815106;11381.374024428653;11441.256318339281;11453.312801231952;11481.425928703531;4020.8994775130855;4451.710638808467;4634.95365046352;4820.68665536739;4837.129316723023;9662.178714809179;9789.951050244703;9803.852942205873;9808.362456440309;9823.607055717834;5249.632525723163;5274.12976858814;5283.550898173621;5289.523942845162;5296.285001524745;4298.677599180074;4666.253399456071;4801.567858892717;4849.078675051799;4859.586935110485;3888.747231429948;3907.199024200032;3991.381335892941;3997.6601988831276;4054.71616986814;1296.8897643700202;1312.068431413688;1315.15829868884;1321.711331451846;1322.9801552976712;886.8004698942815;924.2559739409705;924.9491277979641;927.5779520318239;930.5347326336831;5666.660000399989;5975.693944345418;6045.425684559959;6111.877762444727;6124.540659450559;444.4200318584279;456.6346922462017;458.43612356800656;458.86004768545916;463.99072018560116;3243.7891537050486;3951.1702542466405;3992.680585553149;4027.2952233359047;4119.835206591702;9950.601975920883;10656.893431065746;10669.78660426787;10676.679699609023;10687.41219232934;10344.431056291825;10548.261621686563;10623.734406639742;10638.787224255626;10682.359058456517;7967.322777563972;8104.027516698034;8161.428699991063;8215;8238.382121340803;5355.892882142413;5829.59192856496;5866.530677545701;5887.61730487517;5895.555588880752;9655.855162172433;9720.368176068532;9824.361416507903;9907.950460247941;9983.351082179635;10044.447555384231;10089.445080520642;10195.7451063724;10215.7446063849;10244.897551024394;6867.416269616939;7306.926930730625;7449.14334851499;7467.514611550232;7539.623018848926;8408.579571021302;8454.112318206746;8511.021232558087;8521.957390213009;8561.871571926302;7354.742584009534;7442.292982166686;7479.588622625808;7546.886796698163;7570.772876813704;7226.0244866944395;7278.67245973943;7316.8536629266055;7394.519356241827;7476.401887849068;6934.826629334307;6943.930560694328;7009.544379615309;7020.648967551704;7023.859522809617;4983.202687569971;5039.118154322906;5105.744712764421;5151.124308867426;5165.276861239355;5060.569851562511;5196.2725218470205;5211.973940130275;5218.869528261824;5330.120530112643 14:19:21 INFO - PROCESS | 1931 | |4;prototype.html;268.6883215470055;302.1765688498841;308.34784430928585;314.82841851191097;319.89923174200123;4441.067375851075;5058.797648094076;5443.727813609324;5670;5750.913736293959;5343.893122137555;5618.690971996549;5625.46558076982;5634.549236061115;5680.460356266159;3914.7063970202207;4139.799458157131;4244.858804484675;4260.8721738347895;4289;4175.728577642459;4275;4323.567643235683;4324.351347297899;4336.3278691802825;3588.2464682416726;4028.7985600719994;4231;4271.231178387889;4272.444582204309;3566.7146628269675;4246.278132717445;4256.170046840867;4305.892352691177;4314.374415709704;3082.4143412751505;3440.1571614954496;3596.5863925648364;3603.927921441583;3616.18635806944;4991.278009086859;5517.668939863581;5518.586106042023;5529.889402211933;5548.4174161713245;4788.736619485927;4822.421309442854;4827.648258487594;4834.444038935532;4858.46556878743;4921.163402221595;5651.813119244964;5867.149263356832;5870.794522191745;5927.229460170193;3967.9008024799323;3983.8605648802154;3986.720929534934;3989;4001;6265.806967561362;6276.96861515694;6278.403551662539;6298.559100862942;6345.001324582788;2904.9854750726536;3714.331420344364;3946.782926939046;3971.582983786661;4036.091879327128;3623.963760362363;3695.427208782643;4062.512498500199;4079.63283304504;4091.161311931047;4261.424707664488;4342.261815491374;4570.902983283988;4678.274867395559;4823.758812059383;5693.601447898607;5955.183668980916;6020.518358531307;6075.696215189223;6092.390760923872;1306.314185052836;1347.508159521787;1374.1617613255905;1376.3462355381114;1381.2196109198471;763.7632333976485;912.8493798523302;918.2470374293149;933.2347475070512;933.6312156698202;4898.632602554822;5481.232627432163;5527.5577953764405;5549.1676248562235;5593.468620481048;5126;5622;6082.452579267799;6088.238970128734;6108.877822443526;5256.211568264791;5321.760520776575;5524.861878453071;5530.198121272393;5530.806421775299;2708.7832973362083;2720.9660329074827;2725.065203705352;2741.369485018417;2748.7113853045144;4957;5185.870353241199;5286.779552587922;5294.364676238799;5398.78404863801;5262;5727.427257274323;5983.19226904371;6242.843928901723;6357.078223657544;5102.897942041212;5612.494875461147;6288.930881750022;6352.523560732963;6530.836729081716;5036.992601479646;5578.916316255179;5836.416358364129;6260.68696565179;6270.310265870659;5042.193249080129;5414.918776218438;5436.130219164915;6174.289956654862;6198.2871969722255;5447.676917080498;5742.454466825645;5914.438128377969;6162.969185154046;6473.96416573346;3873.5739068702983;3980.820863061111;3990.4213888986515;4009.5389030261895;4034.2939985501835;5855;6129.233845769279;6184.443400094013;6193.84515387119;6266.905996409966;5231.90130072689;5678.602497825113;5798.449147330997;5893.705314734332;5960.940390596039;5525.392206857323;5939.792107276225;5978.521718262442;6017.338092809875;6026.758929642765;4786.2581299898575;5196.9346284012445;5527.695976721319;5602.814902188232;5840.853978650568;5089.312942752681;5753.338366087954;5953.255843019622;6013.639181649115;6018.8194354169445;5176.7152806594495;5451.863703407446;5882.911756323744;5883.264436991012;5893.762309914794 14:19:21 INFO - PROCESS | 1931 | |5;yui.html;722.5283550371887;735.4116706634692;768.5926458976744;769.7767647382259;866.0040952904161;15771.447999320011;16212.594685132877;16683.24925378358;16754.664906701873;16845.747313790303;14881.627959301022;15164.317605707742;15184.240787960585;15216.619584510392;15270.389184432637;679.052721453572;845.3955421873359;869.8999615044256;873.6680061576592;876.6931573949099;732.4506620034974;859.9656013759442;875.2210532625968;878.5914549734372;878.7539488943074;919.8390281700675;921.5162039929024;924.1867156901917;924.7549399409162;930.6789157740602;912.8448163812102;914.7758799094231;916.4913473022469;916.8716379706847;916.9312301577409;670.980110232444;679.0425500044962;683.6445048574762;687.1033301541486;687.2886562407933;15386.461473848474;15426.845731542653;15469.613259668598;15470.922645386701;15503.379864805394;14953.775693364609;14994.325255363536;15013.174275414847;15076.472323468626;15311.234438278152;12109.333986630732;12257;12491.875081249162;12559;12692.80960785589;3832.176082142325;3863.130795571002;3962.722609417313;4040.939385909214;4106.67146628272;125584.37207813903;125836.99628223135;126529;126570;126775.36612316972;8627.956860215785;10650.307729997525;11625.24435911663;11646;11781.823272650745;20500.07749651269;21171;21311.573768524853;21367.46581335479;21414.892925535274;7909.525428474195;8015.278624923785;8035.357171426272;8061.798455038671;8106.027276726831;4510.255807791743;4514.6614003949835;4523.570260825217;4584.4957054723955;4610.2854057621125;3848.499695039627;4052.63526282636;4095.1604920991126;4099.3031184698675;4106.178764247103;564.221374503183;603.4538742438101;620.8913440147955;717.3794667612582;718.3606590134784;545.9344878614592;663.847315117516;665.218368417108;676.7936526922269;680.3604611665118;9716.61133554664;9731.951340243395;9803.166730827817;9862.802743945082;9933.354331968543;553.7342075803637;575.5395683453304;660.5442244851038;678.2539206872401;689.3898899474002;4754.429468463737;5080.780940366628;5270.710110943858;5289.603279754034;5400.027994960867;108836;113338.86661133284;139311;152958.23520882547;159893;113941.43029284966;129427;144062;145964;149240.25379873032;97963;99854;100398;110435.44782276358;114686.27970580448;9882.357646752938;9920.52861862663;10250.487475626338;10370.792584148425;10423.63517276922;48641;49648.751756240985;64617.67691161514;65734;66781.65746740151;81758;85674.14325856662;98609;100695;104802;13100.986773042445;13438;13743.106698064594;13787.241701706502;14517;15347.00244484105;15387.461438849587;15441.996270242398;16217;16313.755293670367;14208.218547979961;14398.784018239945;14427.855721442651;14462.132272063709;14725.263736813331;14158.221297828719;14218.786718199442;14437.205953672648;14987;14996.775048374066;14003.649908752363;14027.228502432465;14292.928535357256;14473.059251148641;14751.262436877898;11214.607488737855;11616.5353385867;11621.709457263636;12013.339266340436;12276.693082673004;9855.35940163887;10988.395638239974;11074.143066333341;11748.823767643664;12133.332666703416 14:19:21 INFO - PROCESS | 1931 | __end_tp_report 14:19:21 INFO - PROCESS | 1931 | __start_cc_report 14:19:21 INFO - PROCESS | 1931 | _x_x_mozilla_cycle_collect,417 14:19:21 INFO - PROCESS | 1931 | __end_cc_report 14:19:21 INFO - PROCESS | 1931 | __startTimestamp1471900761620__endTimestamp 14:19:21 INFO - PROCESS | 1931 | 14:19:21 INFO - PROCESS | 1931 | ------- Summary: start ------- 14:19:21 INFO - PROCESS | 1931 | Number of tests: 6 14:19:21 INFO - PROCESS | 1931 | 14:19:21 INFO - PROCESS | 1931 | [#0] dojo.html Cycles:165 Average:5771.80 Median:5978.46 stddev:651.00 (10.9%) stddev-sans-first:626.27 14:19:21 INFO - PROCESS | 1931 | Values: 3418.6 3427.2 3435.7 3445.9 3473.8 5161.6 5504.2 5658.5 5787.5 5794.1 4962.9 5625.8 5656.5 5694.3 5778.2 5223.2 5317.2 5325.6 5353.7 5388.7 5415.0 5445.6 5451.9 5459.1 5469.5 5207.6 5218.7 5254.6 5260.3 5325.6 5337.9 5353.2 5354.4 5369.7 5376.0 5258.6 5272.5 5292.0 5340.2 5361.5 4652.5 5594.6 5659.1 5748.4 5787.8 6248.1 6269.6 6317.5 6320.6 6337.4 6256.5 6282.0 6285.4 6286.5 6294.2 5702.8 5767.5 5794.8 5847.4 5921.3 6333.4 6349.3 6351.3 6353.7 6357.5 5360.3 6184.6 6208.9 6237.5 6238.7 5098.9 6147.5 6159.6 6180.8 6262.7 6292.3 6305.5 6307.5 6317.5 6324.9 6084.7 6281.6 6291.6 6297.4 6305.3 4487.7 4867.0 4925.8 4944.8 4945.2 4447.1 4453.3 4472.3 4483.6 4493.4 5825.2 5933.0 5941.2 5958.8 5974.6 6146.5 6177.7 6201.8 6208.7 6275.8 5959.8 5968.6 5975.5 5975.6 5979.4 5486.5 5487.2 5492.5 5497.2 5518.3 6185.4 6258.9 6284.7 6329.6 6367.1 6254.7 6272.2 6285.7 6290.6 6313.9 6387.7 6453.2 6463.7 6477.9 6485.4 6043.3 6180.7 6191.6 6194.2 6283.0 5315.2 6275.3 6283.0 6292.1 6366.6 5018.8 5220.8 6266.4 6267.6 6286.8 6026.8 6104.3 6116.5 6160.6 6200.9 5891.4 6089.0 6103.3 6103.8 6108.4 6193.4 6199.8 6232.5 6250.3 6272.3 5878.3 5967.5 5978.5 6020.6 6084.4 14:19:21 INFO - PROCESS | 1931 | 14:19:21 INFO - PROCESS | 1931 | [#1] ext.html Cycles:180 Average:71162.21 Median:39432.30 stddev:158790.65 (402.7%) stddev-sans-first:159147.40 14:19:21 INFO - PROCESS | 1931 | Values: 473.4 486.8 498.8 508.1 521.7 32543.8 39419.8 39447.4 39533.8 39591.6 34195.0 34218.1 34486.0 34555.8 34746.5 9555.9 9721.1 9733.0 9743.3 9763.3 8747.3 9498.7 9577.1 9685.5 9701.7 9652.5 9687.0 9712.8 9713.2 9728.7 9602.4 9618.9 9636.9 9655.0 9668.8 9532.8 9598.6 9603.9 9615.2 9639.3 34490.0 38633.0 39082.0 39354.8 39495.6 3608.6 3634.5 3669.2 3825.4 4028.6 30439.1 31207.8 31592.5 31652.8 31717.5 3253.1 3304.6 3341.0 3450.0 3456.4 483186.0 483885.2 485958.0 486019.6 490544.5 56125.0 56244.2 56618.2 56773.1 56774.7 55098.2 55435.4 55546.7 55906.4 59203.1 16018.7 16025.6 16201.7 16209.7 16223.9 12649.9 12684.0 12687.0 12693.6 12715.2 13265.5 15636.9 15687.1 15700.9 15911.7 6349.9 6812.5 6909.5 7092.4 7185.0 722.4 773.6 784.2 797.3 816.8 26572.9 30186.9 30210.5 30461.9 31124.9 970.6 1018.2 1029.3 1032.1 1194.5 15029.0 15454.2 15613.0 15713.8 15848.3 617962.0 653616.0 685565.0 697270.0 697883.0 57527.4 57530.0 58048.4 58314.1 58453.4 1347.6 1349.4 1365.5 1372.1 1382.0 21919.0 24938.3 28924.7 29168.4 29781.7 47173.8 47423.8 47442.3 47494.0 47549.8 600102.0 606201.0 608598.0 610308.0 610605.6 37352.0 38286.0 38582.8 38619.6 38994.0 44637.6 45956.5 46405.5 46868.5 46995.5 38088.8 38185.6 38789.0 39444.8 40143.6 32947.0 35465.0 38854.0 38865.6 39954.0 32297.7 37599.4 37806.4 37868.8 38719.8 28015.7 31928.2 34380.0 34536.3 34861.0 24774.9 25375.4 25842.0 26251.1 26698.5 14:19:21 INFO - PROCESS | 1931 | 14:19:21 INFO - PROCESS | 1931 | [#2] jquery.html Cycles:180 Average:34889.43 Median:14727.94 stddev:97818.60 (664.2%) stddev-sans-first:98058.59 14:19:21 INFO - PROCESS | 1931 | Values: 334.9 346.9 366.1 379.7 385.7 18334.7 19393.6 20652.1 20787.0 20852.0 16948.3 20277.2 20349.8 21076.0 21229.8 5824.8 5833.3 5998.9 6019.3 6034.8 5821.2 5941.2 5943.1 5954.5 5973.5 4925.9 5741.7 5813.8 5816.9 5837.7 5697.7 5840.0 5852.9 5864.8 5871.6 4206.0 5047.2 5113.6 5131.9 5198.0 26389.2 26490.3 26491.8 26603.3 26749.9 2034.9 2469.6 2706.0 2748.9 3031.8 10379.6 11592.9 12898.2 15575.5 15643.8 1807.6 1837.6 1880.6 1882.7 1882.9 106166.5 124720.0 128981.7 130907.0 132027.7 9197.4 11674.5 11710.6 11734.5 11945.9 14658.6 14693.3 14700.6 14701.9 14732.6 8489.4 8630.5 8699.1 8782.2 8832.8 8535.6 8547.3 8643.9 8772.0 8788.6 4462.7 4543.2 4557.5 4558.2 4624.0 1828.1 1841.0 1890.3 1916.1 1931.7 837.3 892.5 919.6 953.9 990.8 20293.3 20877.5 21566.9 21615.8 21705.9 906.8 916.8 927.3 948.9 951.4 9597.6 11481.5 11501.5 11504.7 11511.8 488400.0 553294.2 609159.0 630290.0 631020.0 84387.0 125569.0 126350.0 127182.0 128372.0 873.2 926.3 967.2 1005.3 1005.9 17226.7 17468.7 19005.0 19017.5 19111.4 56169.0 57631.4 58286.7 58384.0 59053.8 79120.6 80867.2 81683.0 83368.6 85678.6 5732.5 6441.0 7328.1 7678.5 8321.2 10892.3 13119.1 13221.1 13665.9 13677.7 11545.2 11751.8 11846.3 11929.3 12033.8 11425.4 11481.1 11637.7 11871.1 12038.6 11437.4 11647.4 11836.0 11986.8 12046.8 7363.5 7416.5 7449.6 7466.1 7689.8 11318.5 11798.1 11878.9 11888.9 11918.4 14:19:21 INFO - PROCESS | 1931 | 14:19:21 INFO - PROCESS | 1931 | [#3] mootools.html Cycles:180 Average:5682.83 Median:5049.84 stddev:3169.63 (62.8%) stddev-sans-first:3162.69 14:19:21 INFO - PROCESS | 1931 | Values: 1467.2 1501.6 1734.0 1829.1 1854.2 6927.5 7850.1 8535.6 8901.6 8912.3 8609.0 8728.3 8794.0 8816.8 8819.0 2363.4 2406.1 2407.8 2412.2 2418.3 2376.5 2380.6 2420.4 2430.5 2430.5 2385.2 2391.9 2392.7 2408.4 2409.2 2380.2 2384.9 2397.9 2405.2 2405.6 2368.2 2381.2 2386.7 2388.7 2389.1 8820.3 8855.1 8900.5 8910.6 8916.6 5167.0 5334.2 5334.2 5335.3 5338.1 3117.2 3615.7 3627.1 3672.6 3685.4 1097.6 1100.3 1110.9 1114.5 1118.8 11260.4 11381.4 11441.3 11453.3 11481.4 4020.9 4451.7 4635.0 4820.7 4837.1 9662.2 9790.0 9803.9 9808.4 9823.6 5249.6 5274.1 5283.6 5289.5 5296.3 4298.7 4666.3 4801.6 4849.1 4859.6 3888.7 3907.2 3991.4 3997.7 4054.7 1296.9 1312.1 1315.2 1321.7 1323.0 886.8 924.3 924.9 927.6 930.5 5666.7 5975.7 6045.4 6111.9 6124.5 444.4 456.6 458.4 458.9 464.0 3243.8 3951.2 3992.7 4027.3 4119.8 9950.6 10656.9 10669.8 10676.7 10687.4 10344.4 10548.3 10623.7 10638.8 10682.4 7967.3 8104.0 8161.4 8215.0 8238.4 5355.9 5829.6 5866.5 5887.6 5895.6 9655.9 9720.4 9824.4 9908.0 9983.4 10044.4 10089.4 10195.7 10215.7 10244.9 6867.4 7306.9 7449.1 7467.5 7539.6 8408.6 8454.1 8511.0 8522.0 8561.9 7354.7 7442.3 7479.6 7546.9 7570.8 7226.0 7278.7 7316.9 7394.5 7476.4 6934.8 6943.9 7009.5 7020.6 7023.9 4983.2 5039.1 5105.7 5151.1 5165.3 5060.6 5196.3 5212.0 5218.9 5330.1 14:19:21 INFO - PROCESS | 1931 | 14:19:21 INFO - PROCESS | 1931 | [#4] prototype.html Cycles:180 Average:4729.69 Median:5332.83 stddev:1493.49 (28.0%) stddev-sans-first:1459.66 14:19:21 INFO - PROCESS | 1931 | Values: 268.7 302.2 308.3 314.8 319.9 4441.1 5058.8 5443.7 5670.0 5750.9 5343.9 5618.7 5625.5 5634.5 5680.5 3914.7 4139.8 4244.9 4260.9 4289.0 4175.7 4275.0 4323.6 4324.4 4336.3 3588.2 4028.8 4231.0 4271.2 4272.4 3566.7 4246.3 4256.2 4305.9 4314.4 3082.4 3440.2 3596.6 3603.9 3616.2 4991.3 5517.7 5518.6 5529.9 5548.4 4788.7 4822.4 4827.6 4834.4 4858.5 4921.2 5651.8 5867.1 5870.8 5927.2 3967.9 3983.9 3986.7 3989.0 4001.0 6265.8 6277.0 6278.4 6298.6 6345.0 2905.0 3714.3 3946.8 3971.6 4036.1 3624.0 3695.4 4062.5 4079.6 4091.2 4261.4 4342.3 4570.9 4678.3 4823.8 5693.6 5955.2 6020.5 6075.7 6092.4 1306.3 1347.5 1374.2 1376.3 1381.2 763.8 912.8 918.2 933.2 933.6 4898.6 5481.2 5527.6 5549.2 5593.5 5126.0 5622.0 6082.5 6088.2 6108.9 5256.2 5321.8 5524.9 5530.2 5530.8 2708.8 2721.0 2725.1 2741.4 2748.7 4957.0 5185.9 5286.8 5294.4 5398.8 5262.0 5727.4 5983.2 6242.8 6357.1 5102.9 5612.5 6288.9 6352.5 6530.8 5037.0 5578.9 5836.4 6260.7 6270.3 5042.2 5414.9 5436.1 6174.3 6198.3 5447.7 5742.5 5914.4 6163.0 6474.0 3873.6 3980.8 3990.4 4009.5 4034.3 5855.0 6129.2 6184.4 6193.8 6266.9 5231.9 5678.6 5798.4 5893.7 5960.9 5525.4 5939.8 5978.5 6017.3 6026.8 4786.3 5196.9 5527.7 5602.8 5840.9 5089.3 5753.3 5953.3 6013.6 6018.8 5176.7 5451.9 5882.9 5883.3 5893.8 14:19:21 INFO - PROCESS | 1931 | 14:19:21 INFO - PROCESS | 1931 | [#5] yui.html Cycles:180 Average:25293.28 Median:12623.53 stddev:39982.02 (316.7%) stddev-sans-first:40051.61 14:19:21 INFO - PROCESS | 1931 | Values: 722.5 735.4 768.6 769.8 866.0 15771.4 16212.6 16683.2 16754.7 16845.7 14881.6 15164.3 15184.2 15216.6 15270.4 679.1 845.4 869.9 873.7 876.7 732.5 860.0 875.2 878.6 878.8 919.8 921.5 924.2 924.8 930.7 912.8 914.8 916.5 916.9 916.9 671.0 679.0 683.6 687.1 687.3 15386.5 15426.8 15469.6 15470.9 15503.4 14953.8 14994.3 15013.2 15076.5 15311.2 12109.3 12257.0 12491.9 12559.0 12692.8 3832.2 3863.1 3962.7 4040.9 4106.7 125584.4 125837.0 126529.0 126570.0 126775.4 8628.0 10650.3 11625.2 11646.0 11781.8 20500.1 21171.0 21311.6 21367.5 21414.9 7909.5 8015.3 8035.4 8061.8 8106.0 4510.3 4514.7 4523.6 4584.5 4610.3 3848.5 4052.6 4095.2 4099.3 4106.2 564.2 603.5 620.9 717.4 718.4 545.9 663.8 665.2 676.8 680.4 9716.6 9732.0 9803.2 9862.8 9933.4 553.7 575.5 660.5 678.3 689.4 4754.4 5080.8 5270.7 5289.6 5400.0 108836.0 113338.9 139311.0 152958.2 159893.0 113941.4 129427.0 144062.0 145964.0 149240.3 97963.0 99854.0 100398.0 110435.4 114686.3 9882.4 9920.5 10250.5 10370.8 10423.6 48641.0 49648.8 64617.7 65734.0 66781.7 81758.0 85674.1 98609.0 100695.0 104802.0 13101.0 13438.0 13743.1 13787.2 14517.0 15347.0 15387.5 15442.0 16217.0 16313.8 14208.2 14398.8 14427.9 14462.1 14725.3 14158.2 14218.8 14437.2 14987.0 14996.8 14003.6 14027.2 14292.9 14473.1 14751.3 11214.6 11616.5 11621.7 12013.3 12276.7 9855.4 10988.4 11074.1 11748.8 12133.3 14:19:21 INFO - PROCESS | 1931 | -------- Summary: end -------- 14:19:21 INFO - PROCESS | 1931 | 14:19:22 INFO - TEST-INFO | 1931: exit 0 14:19:22 INFO - TEST-OK | dromaeo_css | took 1114570ms 14:19:22 INFO - TEST-START | kraken 14:19:22 INFO - operating with platform_type : mac_ 14:19:22 INFO - Initialising browser for kraken test... 14:19:22 INFO - TEST-INFO | started process 1936 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/tmpFOMoYX/profile http://localhost:54437/getInfo.html) 14:19:25 INFO - PROCESS | 1936 | __metrics Screen width/height:1600/1200 14:19:25 INFO - PROCESS | 1936 | colorDepth:24 14:19:25 INFO - PROCESS | 1936 | Browser inner width/height: 1024/689 14:19:25 INFO - PROCESS | 1936 | __metrics 14:19:25 ERROR - PROCESS | 1936 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2993: TypeError: this.tabs is undefined 14:19:25 INFO - TEST-INFO | 1936: exit 0 14:19:25 INFO - Browser initialized. 14:19:25 INFO - Running cycle 1/1 for kraken test... 14:19:25 INFO - TEST-INFO | started process 1938 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/tmpFOMoYX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:19:38 INFO - PROCESS | 1938 | RSS: Main: 239947776 14:19:38 INFO - PROCESS | 1938 | 14:19:40 INFO - PROCESS | 1938 | Cycle 1(1): loaded http://localhost:54437/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54437/tests/kraken/driver.html?testName=audio-beat-detection) 14:19:41 INFO - PROCESS | 1938 | RSS: Main: 252649472 14:19:41 INFO - PROCESS | 1938 | 14:19:44 INFO - PROCESS | 1938 | Cycle 1(1): loaded http://localhost:54437/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54437/tests/kraken/driver.html?testName=audio-dft) 14:19:45 INFO - PROCESS | 1938 | RSS: Main: 261910528 14:19:45 INFO - PROCESS | 1938 | 14:19:48 INFO - PROCESS | 1938 | Cycle 1(1): loaded http://localhost:54437/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54437/tests/kraken/driver.html?testName=audio-fft) 14:19:49 INFO - PROCESS | 1938 | RSS: Main: 264343552 14:19:49 INFO - PROCESS | 1938 | 14:19:51 INFO - PROCESS | 1938 | Cycle 1(1): loaded http://localhost:54437/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54437/tests/kraken/driver.html?testName=audio-oscillator) 14:19:52 INFO - PROCESS | 1938 | RSS: Main: 266739712 14:19:52 INFO - PROCESS | 1938 | 14:19:54 INFO - PROCESS | 1938 | Cycle 1(1): loaded http://localhost:54437/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54437/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:19:54 INFO - PROCESS | 1938 | RSS: Main: 267280384 14:19:54 INFO - PROCESS | 1938 | 14:19:57 INFO - PROCESS | 1938 | Cycle 1(1): loaded http://localhost:54437/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54437/tests/kraken/driver.html?testName=imaging-darkroom) 14:19:58 INFO - PROCESS | 1938 | RSS: Main: 268156928 14:19:58 INFO - PROCESS | 1938 | 14:20:01 INFO - PROCESS | 1938 | Cycle 1(1): loaded http://localhost:54437/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54437/tests/kraken/driver.html?testName=imaging-desaturate) 14:20:02 INFO - PROCESS | 1938 | RSS: Main: 268423168 14:20:02 INFO - PROCESS | 1938 | 14:20:05 INFO - PROCESS | 1938 | Cycle 1(1): loaded http://localhost:54437/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54437/tests/kraken/driver.html?testName=json-parse-financial) 14:20:05 INFO - PROCESS | 1938 | RSS: Main: 268898304 14:20:05 INFO - PROCESS | 1938 | 14:20:07 INFO - PROCESS | 1938 | Cycle 1(1): loaded http://localhost:54437/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54437/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:20:07 INFO - PROCESS | 1938 | RSS: Main: 268304384 14:20:07 INFO - PROCESS | 1938 | 14:20:09 INFO - PROCESS | 1938 | Cycle 1(1): loaded http://localhost:54437/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54437/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:20:10 INFO - PROCESS | 1938 | RSS: Main: 267771904 14:20:10 INFO - PROCESS | 1938 | 14:20:12 INFO - PROCESS | 1938 | Cycle 1(1): loaded http://localhost:54437/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54437/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:20:13 INFO - PROCESS | 1938 | RSS: Main: 268132352 14:20:13 INFO - PROCESS | 1938 | 14:20:16 INFO - PROCESS | 1938 | Cycle 1(1): loaded http://localhost:54437/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54437/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:20:17 INFO - PROCESS | 1938 | RSS: Main: 268210176 14:20:17 INFO - PROCESS | 1938 | 14:20:20 INFO - PROCESS | 1938 | Cycle 1(1): loaded http://localhost:54437/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54437/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:20:20 INFO - PROCESS | 1938 | RSS: Main: 268197888 14:20:20 INFO - PROCESS | 1938 | 14:20:22 INFO - PROCESS | 1938 | Cycle 1(1): loaded http://localhost:54437/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54437/tests/kraken/driver.html?testName=ai-astar) 14:20:22 INFO - PROCESS | 1938 | RSS: Main: 270241792 14:20:22 INFO - PROCESS | 1938 | 14:20:22 INFO - PROCESS | 1938 | __start_tp_report 14:20:22 INFO - PROCESS | 1938 | _x_x_mozilla_page_load 14:20:22 INFO - PROCESS | 1938 | _x_x_mozilla_page_load_details 14:20:22 INFO - PROCESS | 1938 | |i|pagename|runs| 14:20:22 INFO - PROCESS | 1938 | |0;ai-astar;106;122;117;120;117;116;122;116;116;118 14:20:22 INFO - PROCESS | 1938 | |1;audio-beat-detection;151;99;168;199;113;133;131;114;179;143 14:20:22 INFO - PROCESS | 1938 | |2;audio-dft;203;204;255;178;246;279;248;203;190;256 14:20:22 INFO - PROCESS | 1938 | |3;audio-fft;64;83;77;148;88;81;82;52;156;53 14:20:22 INFO - PROCESS | 1938 | |4;audio-oscillator;68;71;128;97;103;107;118;70;72;118 14:20:22 INFO - PROCESS | 1938 | |5;imaging-gaussian-blur;113;108;88;87;88;85;88;103;135;105 14:20:22 INFO - PROCESS | 1938 | |6;imaging-darkroom;95;95;104;94;96;98;93;144;151;95 14:20:22 INFO - PROCESS | 1938 | |7;imaging-desaturate;92;95;98;143;141;90;93;88;92;109 14:20:22 INFO - PROCESS | 1938 | |8;json-parse-financial;55;58;57;56;59;58;57;57;57;58 14:20:22 INFO - PROCESS | 1938 | |9;json-stringify-tinderbox;73;71;101;102;92;80;75;69;68;71 14:20:22 INFO - PROCESS | 1938 | |10;stanford-crypto-aes;88;89;86;86;87;110;113;108;87;89 14:20:22 INFO - PROCESS | 1938 | |11;stanford-crypto-ccm;142;144;157;130;144;124;150;157;212;155 14:20:22 INFO - PROCESS | 1938 | |12;stanford-crypto-pbkdf2;156;233;239;174;166;166;168;169;171;185 14:20:22 INFO - PROCESS | 1938 | |13;stanford-crypto-sha256-iterative;71;66;68;67;70;68;75;89;89;86 14:20:22 INFO - PROCESS | 1938 | __end_tp_report 14:20:22 INFO - PROCESS | 1938 | __start_cc_report 14:20:22 INFO - PROCESS | 1938 | _x_x_mozilla_cycle_collect,1082 14:20:22 INFO - PROCESS | 1938 | __end_cc_report 14:20:22 INFO - PROCESS | 1938 | __startTimestamp1471900822800__endTimestamp 14:20:22 INFO - PROCESS | 1938 | 14:20:22 INFO - PROCESS | 1938 | ------- Summary: start ------- 14:20:22 INFO - PROCESS | 1938 | Number of tests: 14 14:20:22 INFO - PROCESS | 1938 | 14:20:22 INFO - PROCESS | 1938 | [#0] ai-astar Cycles:10 Average:117.00 Median:117.50 stddev:4.52 (3.8%) stddev-sans-first:2.49 14:20:22 INFO - PROCESS | 1938 | Values: 106.0 122.0 117.0 120.0 117.0 116.0 122.0 116.0 116.0 118.0 14:20:22 INFO - PROCESS | 1938 | 14:20:22 INFO - PROCESS | 1938 | [#1] audio-beat-detection Cycles:10 Average:143.00 Median:159.50 stddev:31.70 (19.9%) stddev-sans-first:33.49 14:20:22 INFO - PROCESS | 1938 | Values: 151.0 99.0 168.0 199.0 113.0 133.0 131.0 114.0 179.0 143.0 14:20:22 INFO - PROCESS | 1938 | 14:20:22 INFO - PROCESS | 1938 | [#2] audio-dft Cycles:10 Average:226.20 Median:247.00 stddev:34.28 (13.9%) stddev-sans-first:35.32 14:20:22 INFO - PROCESS | 1938 | Values: 203.0 204.0 255.0 178.0 246.0 279.0 248.0 203.0 190.0 256.0 14:20:22 INFO - PROCESS | 1938 | 14:20:22 INFO - PROCESS | 1938 | [#3] audio-fft Cycles:10 Average:88.40 Median:79.00 stddev:35.82 (45.3%) stddev-sans-first:36.89 14:20:22 INFO - PROCESS | 1938 | Values: 64.0 83.0 77.0 148.0 88.0 81.0 82.0 52.0 156.0 53.0 14:20:22 INFO - PROCESS | 1938 | 14:20:22 INFO - PROCESS | 1938 | [#4] audio-oscillator Cycles:10 Average:95.20 Median:69.00 stddev:23.14 (33.5%) stddev-sans-first:22.35 14:20:22 INFO - PROCESS | 1938 | Values: 68.0 71.0 128.0 97.0 103.0 107.0 118.0 70.0 72.0 118.0 14:20:22 INFO - PROCESS | 1938 | 14:20:22 INFO - PROCESS | 1938 | [#5] imaging-gaussian-blur Cycles:10 Average:100.00 Median:86.00 stddev:16.05 (18.7%) stddev-sans-first:16.32 14:20:22 INFO - PROCESS | 1938 | Values: 113.0 108.0 88.0 87.0 88.0 85.0 88.0 103.0 135.0 105.0 14:20:22 INFO - PROCESS | 1938 | 14:20:22 INFO - PROCESS | 1938 | [#6] imaging-darkroom Cycles:10 Average:106.50 Median:95.00 stddev:21.88 (23.0%) stddev-sans-first:22.81 14:20:22 INFO - PROCESS | 1938 | Values: 95.0 95.0 104.0 94.0 96.0 98.0 93.0 144.0 151.0 95.0 14:20:22 INFO - PROCESS | 1938 | 14:20:22 INFO - PROCESS | 1938 | [#7] imaging-desaturate Cycles:10 Average:104.10 Median:92.00 stddev:20.80 (22.6%) stddev-sans-first:21.59 14:20:22 INFO - PROCESS | 1938 | Values: 92.0 95.0 98.0 143.0 141.0 90.0 93.0 88.0 92.0 109.0 14:20:22 INFO - PROCESS | 1938 | 14:20:22 INFO - PROCESS | 1938 | [#8] json-parse-financial Cycles:10 Average:57.20 Median:57.50 stddev:1.14 (2.0%) stddev-sans-first:0.88 14:20:22 INFO - PROCESS | 1938 | Values: 55.0 58.0 57.0 56.0 59.0 58.0 57.0 57.0 57.0 58.0 14:20:22 INFO - PROCESS | 1938 | 14:20:22 INFO - PROCESS | 1938 | [#9] json-stringify-tinderbox Cycles:10 Average:80.20 Median:72.00 stddev:13.21 (18.3%) stddev-sans-first:13.75 14:20:22 INFO - PROCESS | 1938 | Values: 73.0 71.0 101.0 102.0 92.0 80.0 75.0 69.0 68.0 71.0 14:20:22 INFO - PROCESS | 1938 | 14:20:22 INFO - PROCESS | 1938 | [#10] stanford-crypto-aes Cycles:10 Average:94.30 Median:87.00 stddev:11.18 (12.8%) stddev-sans-first:11.62 14:20:22 INFO - PROCESS | 1938 | Values: 88.0 89.0 86.0 86.0 87.0 110.0 113.0 108.0 87.0 89.0 14:20:22 INFO - PROCESS | 1938 | 14:20:22 INFO - PROCESS | 1938 | [#11] stanford-crypto-ccm Cycles:10 Average:151.50 Median:152.50 stddev:23.94 (15.7%) stddev-sans-first:25.14 14:20:22 INFO - PROCESS | 1938 | Values: 142.0 144.0 157.0 130.0 144.0 124.0 150.0 157.0 212.0 155.0 14:20:22 INFO - PROCESS | 1938 | 14:20:22 INFO - PROCESS | 1938 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:182.70 Median:172.50 stddev:29.04 (16.8%) stddev-sans-first:29.15 14:20:22 INFO - PROCESS | 1938 | Values: 156.0 233.0 239.0 174.0 166.0 166.0 168.0 169.0 171.0 185.0 14:20:22 INFO - PROCESS | 1938 | 14:20:22 INFO - PROCESS | 1938 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.90 Median:73.00 stddev:9.41 (12.9%) stddev-sans-first:9.87 14:20:22 INFO - PROCESS | 1938 | Values: 71.0 66.0 68.0 67.0 70.0 68.0 75.0 89.0 89.0 86.0 14:20:22 INFO - PROCESS | 1938 | -------- Summary: end -------- 14:20:22 INFO - PROCESS | 1938 | 14:20:23 INFO - TEST-INFO | 1938: exit 0 14:20:23 INFO - TEST-OK | kraken | took 61376ms 14:20:23 INFO - SUITE-END | took 1175s 14:20:23 INFO - Completed test suite (00:19:36) 14:20:23 INFO - javascript benchmark 14:20:24 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7429.679766814969, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3418.6240562808825, 3427.2117412994994, 3435.74231932605, 3445.8966231013064, 3473.7742046766966, 5161.612879034069, 5504.174373843925, 5658.462446067627, 5787.536997040237, 5794.101914203295, 4962.932969411576, 5625.80309689161, 5656.490915817576, 5694.259746232984, 5778.162166485857, 5223.216517522383, 5317.175837745136, 5325.627206095575, 5353.678779273237, 5388.676679399229, 5415.025295446818, 5445.64837469417, 5451.863703407407, 5459.099248623972, 5469.507744303012, 5207.557357624606, 5218.739063046871, 5254.579633629301, 5260.263563101169, 5325.60057995648, 5337.946620533784, 5353.223782551547, 5354.41101478837, 5369.731513424353, 5375.973120134413, 5258.605604579672, 5272.499112584298, 5292.02097611943, 5340.198970154469, 5361.463853614647, 4652.464966528859, 5594.608377413582, 5659.122835960433, 5748.425157484218, 5787.816700814577, 6248.094026366197, 6269.592476489013, 6317.463015643676, 6320.589161704521, 6337.429631333202, 6256.499480041586, 6281.968590157066, 6285.402886725754, 6286.49708023357, 6294.244690637107, 5702.8289151325525, 5767.480926716616, 5794.797182098607, 5847.415258474203, 5921.289445266552, 6333.398327158912, 6349.333320001426, 6351.269603995507, 6353.745850166034, 6357.523185761086, 5360.3299587551555, 6184.567080304336, 6208.906866397007, 6237.5321850860455, 6238.688065596702, 5098.872528186751, 6147.538934579924, 6159.5688301818445, 6180.845478863064, 6262.718177681924, 6292.339304373067, 6305.527085468608, 6307.5269354798575, 6317.4630156437215, 6324.936750632527, 6084.726187321581, 6281.560290779693, 6291.622502649856, 6297.370262973757, 6305.274893387227, 4487.6634252431195, 4866.95133048665, 4925.75371231437, 4944.752762361867, 4945.159322915113, 4447.132809102259, 4453.3320001999955, 4472.306792447176, 4483.596476317147, 4493.393391892118, 5825.213596164548, 5932.970335148297, 5941.168236446901, 5958.791442299499, 5974.551908606872, 6146.508279337731, 6177.722002509898, 6201.782937597252, 6208.689565521706, 6275.843103922439, 5959.761609535657, 5968.552358573124, 5975.52195824333, 5975.581709280395, 5979.372165922602, 5486.506214440719, 5487.176923461433, 5492.533134683516, 5497.230387745719, 5518.33779946409, 6185.443310102022, 6258.874822503433, 6284.74861005573, 6329.620222786648, 6367.140436041075, 6254.749810007731, 6272.153259309935, 6285.748570057147, 6290.559660823698, 6313.90529142054, 6387.712552935036, 6453.1610890583925, 6463.709133088928, 6477.935220647733, 6485.383888530582, 6043.2748070231855, 6180.721867515883, 6191.597546159485, 6194.225721784777, 6283.0, 5315.176147697113, 6275.341089185752, 6283.0, 6292.056191571301, 6366.6180029198395, 5018.84943451697, 5220.791168353223, 6266.404691554295, 6267.62394256346, 6286.779962701284, 6026.758929642765, 6104.26748790148, 6116.510679145568, 6160.568760186744, 6200.906986395298, 5891.351951285269, 6089.025755879038, 6103.328633850362, 6103.816885493442, 6108.389161083856, 6193.38066193377, 6199.752009919553, 6232.470240029467, 6250.281217660027, 6272.310045895039, 5878.3239927408895, 5967.492763115184, 5978.461938425563, 6020.608660437058, 6084.361142080018], "value": 5732.251098384998, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [473.4106037982711, 486.82474309248664, 498.8328909815212, 508.1387048952028, 521.7052365413541, 32543.837280813594, 39419.80290098549, 39447.40828887565, 39533.80233098831, 39591.604083959224, 34195.0, 34218.14454638635, 34486.0, 34555.82722086386, 34746.47880281792, 9555.856662150074, 9721.076497732704, 9733.0, 9743.317967742261, 9763.316567840255, 8747.343949203836, 9498.717673114144, 9577.138057574817, 9685.467299298536, 9701.708948731513, 9652.469114198717, 9686.98286679899, 9712.757181070494, 9713.174380177694, 9728.65949691761, 9602.423854568748, 9618.90381096187, 9636.90363096367, 9654.951725241399, 9668.75828104296, 9532.809343813155, 9598.616055357777, 9603.887144828126, 9615.173117107726, 9639.325247232697, 34489.96530104076, 38633.0, 39082.0, 39354.803225983975, 39495.60504394948, 3608.6030536640947, 3634.4548317752283, 3669.192777588926, 3825.4261860720835, 4028.5971402859773, 30439.086827395215, 31207.84396078005, 31592.52611210834, 31652.841735791404, 31717.524237136462, 3253.072874230833, 3304.5538852254876, 3340.9977006898075, 3450.016745227598, 3456.3778519866414, 483186.0, 483885.1920548327, 485958.0, 486019.56990215176, 490544.5472772649, 56125.0, 56244.15633765497, 56618.150727739114, 56773.14840277399, 56774.71612641993, 55098.17352739712, 55435.445645543026, 55546.72226638841, 55906.44093559094, 59203.11195332073, 16018.679626407407, 16025.599360016093, 16201.675966480605, 16209.67580648404, 16223.91888040576, 12649.936750316374, 12684.04869634781, 12687.048471364684, 12693.619191424272, 12715.237085774883, 13265.535706250235, 15636.92181539085, 15687.058776473448, 15700.900936934533, 15911.68176636484, 6349.873002539924, 6812.523123381316, 6909.481788865855, 7092.4326053915565, 7185.0, 722.4004076616396, 773.6170595555124, 784.2197013971021, 797.330242596222, 816.7917181118895, 26572.867135664197, 30186.9434569789, 30210.54684179739, 30461.93383231576, 31124.910628127906, 970.631160159135, 1018.2363227579316, 1029.3206483720708, 1032.143321043532, 1194.5460724924646, 15029.0, 15454.227288635524, 15613.0, 15713.842861571238, 15848.286827092808, 617962.0, 653616.0, 685565.0, 697270.0, 697883.0, 57527.42472575221, 57530.0, 58048.419515805144, 58314.12528811987, 58453.41546584565, 1347.5889853594551, 1349.3590544491485, 1365.4606430460112, 1372.1218420211073, 1382.025671901307, 21919.0, 24938.251852444457, 28924.698388572986, 29168.3957382346, 29781.702182977893, 47173.76413117912, 47423.762881186754, 47442.28836567523, 47494.0, 47549.81125471891, 600102.0, 606201.0, 608598.0, 610308.0, 610605.6288029897, 37352.0, 38286.0, 38582.80708596439, 38619.613803862725, 38994.0, 44637.55362446334, 45956.54043459523, 46405.53594464012, 46868.53131468778, 46995.530044700485, 38088.809555952044, 38185.6181438182, 38789.0, 39444.80277598594, 40143.598564013984, 32947.0, 35465.0, 38854.0, 38865.61134388733, 39954.00114997148, 32297.677023230408, 37599.43600846044, 37806.43290350592, 37868.810655946545, 38719.8384048479, 28015.719842802126, 31928.201794955312, 34380.0, 34536.309273814884, 34861.0, 24774.876125619256, 25375.36561585975, 25842.0, 26251.08121215748, 26698.46603067889], "value": 19602.97019691833, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [334.92155260062606, 346.85952189363314, 366.1395720057866, 379.67917110042015, 385.7376983651118, 18334.72497912531, 19393.612127757453, 20652.07065682046, 20787.0, 20852.0, 16948.3220671173, 20277.188912443486, 20349.796502034977, 21076.0, 21229.787702122972, 5824.796132135376, 5833.300003999515, 5998.910016349758, 6019.337872833985, 6034.758609655609, 5821.18503409523, 5941.19793827832, 5943.078822782454, 5954.451842520954, 5973.522118230531, 4925.876853078666, 5741.684207368593, 5813.82558523245, 5816.912746308809, 5837.737301821407, 5697.6866272355, 5840.0, 5852.941470585282, 5864.76540938362, 5871.588988770766, 4205.957940420587, 5047.242913562958, 5113.61647876407, 5131.897362052738, 5198.0, 26389.208323750125, 26490.33774155642, 26491.807868645956, 26603.334916627045, 26749.930002799865, 2034.9287774927955, 2469.6295555666616, 2705.959410608823, 2748.8900443982216, 3031.8180909145303, 10379.584816607327, 11592.884071159266, 12898.226106433644, 15575.532734017997, 15643.843561564467, 1807.6023274879506, 1837.6049149432802, 1880.6050729346716, 1882.6611209982334, 1882.9152688129068, 106166.46916765366, 124720.0, 128981.7101828979, 130907.0, 132027.6797232025, 9197.402168859002, 11674.474648640831, 11710.594728632619, 11734.471948762326, 11945.940270298766, 14658.633534161518, 14693.26533673312, 14700.55898323052, 14701.852981470049, 14732.631684207981, 8489.4481858679, 8630.525321107274, 8699.086595907338, 8782.165694259034, 8832.823343533222, 8535.573221339033, 8547.27348175412, 8643.87034194475, 8771.956140219258, 8788.60451279694, 4462.665300102505, 4543.159515489645, 4557.5442455754155, 4558.225101732647, 4623.988564974247, 1828.1189224769896, 1840.9657328651647, 1890.2722451856134, 1916.0898573177628, 1931.65230258552, 837.2757564706607, 892.5017909734993, 919.6459363145237, 953.9284553658504, 990.8315586350337, 20293.28973485921, 20877.478063048242, 21566.921653917554, 21615.783842161378, 21705.891470542545, 906.7687739626354, 916.7524768312652, 927.2952556057445, 948.9335746497679, 951.3673407184145, 9597.568109434953, 11481.483333250024, 11501.53993840237, 11504.712382190512, 11511.76976460483, 488400.0, 553294.2335288378, 609159.0, 630290.0, 631020.0, 84387.0, 125569.0, 126350.0, 127182.0, 128372.0, 873.1922971251566, 926.2636204217798, 967.2020583019038, 1005.2862467648051, 1005.9245556583286, 17226.655466890843, 17468.650626987135, 19004.95472749012, 19017.524561886064, 19111.426657200307, 56169.0, 57631.42368576428, 58286.708566456895, 58384.0, 59053.818923622144, 79120.60439697765, 80867.19132808832, 81683.0, 83368.58315708382, 85678.57160714405, 5732.541396688338, 6441.0, 7328.083989501312, 7678.5008974418715, 8321.209485098905, 10892.346459212473, 13119.147255428366, 13221.140625859289, 13665.86334136646, 13677.726445470837, 11545.191836571359, 11751.823722644338, 11846.348450834943, 11929.343886086348, 12033.759324813629, 11425.428728563373, 11481.138914581607, 11637.709057273636, 11871.05031597453, 12038.638840834788, 11437.428128593703, 11647.417629118341, 11836.0, 11986.820197696867, 12046.819297710717, 7363.521371110861, 7416.480846340704, 7449.5902725350625, 7466.141393739789, 7689.846203076019, 11318.547258109584, 11798.053321201905, 11878.940605296919, 11888.881111188777, 11918.40407979615], "value": 9657.141340503635, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1467.171048357678, 1501.609581508808, 1734.0, 1829.1037391678083, 1854.221227084625, 6927.51507394482, 7850.097238817538, 8535.573221338924, 8901.554922253885, 8912.287017038638, 8609.0, 8728.258098061673, 8794.0, 8816.77958051049, 8818.98581663109, 2363.420961864346, 2406.109739396426, 2407.843490173142, 2412.2160297903165, 2418.3107814272935, 2376.4771750214927, 2380.6071998120374, 2420.4070002849326, 2430.4895971845845, 2430.5017471418405, 2385.2367242482414, 2391.940201494968, 2392.688950436441, 2408.3738228060656, 2409.180878501309, 2380.214529205358, 2384.868832214236, 2397.9160729374476, 2405.1942599229365, 2405.615101583738, 2368.1593034472858, 2381.2141993142222, 2386.749391313922, 2388.749181335952, 2389.0563227525204, 8820.33847461443, 8855.114488551159, 8900.465972041633, 8910.643574257021, 8916.55417229136, 5166.966606678679, 5334.199870019489, 5334.22653715213, 5335.33308336458, 5338.119210330291, 3117.189530722006, 3615.7288203384587, 3627.1113577173496, 3672.6327367263325, 3685.4287585424304, 1097.6268068856627, 1100.2793170473353, 1110.900018998286, 1114.4706264524368, 1118.8321751737305, 11260.43697815106, 11381.374024428653, 11441.256318339281, 11453.312801231952, 11481.425928703531, 4020.8994775130855, 4451.710638808467, 4634.95365046352, 4820.68665536739, 4837.129316723023, 9662.178714809179, 9789.951050244703, 9803.852942205873, 9808.362456440309, 9823.607055717834, 5249.632525723163, 5274.12976858814, 5283.550898173621, 5289.523942845162, 5296.285001524745, 4298.677599180074, 4666.253399456071, 4801.567858892717, 4849.078675051799, 4859.586935110485, 3888.747231429948, 3907.199024200032, 3991.381335892941, 3997.6601988831276, 4054.71616986814, 1296.8897643700202, 1312.068431413688, 1315.15829868884, 1321.711331451846, 1322.9801552976712, 886.8004698942815, 924.2559739409705, 924.9491277979641, 927.5779520318239, 930.5347326336831, 5666.660000399989, 5975.693944345418, 6045.425684559959, 6111.877762444727, 6124.540659450559, 444.4200318584279, 456.6346922462017, 458.43612356800656, 458.86004768545916, 463.99072018560116, 3243.7891537050486, 3951.1702542466405, 3992.680585553149, 4027.2952233359047, 4119.835206591702, 9950.601975920883, 10656.893431065746, 10669.78660426787, 10676.679699609023, 10687.41219232934, 10344.431056291825, 10548.261621686563, 10623.734406639742, 10638.787224255626, 10682.359058456517, 7967.322777563972, 8104.027516698034, 8161.428699991063, 8215.0, 8238.382121340803, 5355.892882142413, 5829.59192856496, 5866.530677545701, 5887.61730487517, 5895.555588880752, 9655.855162172433, 9720.368176068532, 9824.361416507903, 9907.950460247941, 9983.351082179635, 10044.447555384231, 10089.445080520642, 10195.7451063724, 10215.7446063849, 10244.897551024394, 6867.416269616939, 7306.926930730625, 7449.14334851499, 7467.514611550232, 7539.623018848926, 8408.579571021302, 8454.112318206746, 8511.021232558087, 8521.957390213009, 8561.871571926302, 7354.742584009534, 7442.292982166686, 7479.588622625808, 7546.886796698163, 7570.772876813704, 7226.0244866944395, 7278.67245973943, 7316.8536629266055, 7394.519356241827, 7476.401887849068, 6934.826629334307, 6943.930560694328, 7009.544379615309, 7020.648967551704, 7023.859522809617, 4983.202687569971, 5039.118154322906, 5105.744712764421, 5151.124308867426, 5165.276861239355, 5060.569851562511, 5196.2725218470205, 5211.973940130275, 5218.869528261824, 5330.120530112643], "value": 4515.592593583445, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [268.6883215470055, 302.1765688498841, 308.34784430928585, 314.82841851191097, 319.89923174200123, 4441.067375851075, 5058.797648094076, 5443.727813609324, 5670.0, 5750.913736293959, 5343.893122137555, 5618.690971996549, 5625.46558076982, 5634.549236061115, 5680.460356266159, 3914.7063970202207, 4139.799458157131, 4244.858804484675, 4260.8721738347895, 4289.0, 4175.728577642459, 4275.0, 4323.567643235683, 4324.351347297899, 4336.3278691802825, 3588.2464682416726, 4028.7985600719994, 4231.0, 4271.231178387889, 4272.444582204309, 3566.7146628269675, 4246.278132717445, 4256.170046840867, 4305.892352691177, 4314.374415709704, 3082.4143412751505, 3440.1571614954496, 3596.5863925648364, 3603.927921441583, 3616.18635806944, 4991.278009086859, 5517.668939863581, 5518.586106042023, 5529.889402211933, 5548.4174161713245, 4788.736619485927, 4822.421309442854, 4827.648258487594, 4834.444038935532, 4858.46556878743, 4921.163402221595, 5651.813119244964, 5867.149263356832, 5870.794522191745, 5927.229460170193, 3967.9008024799323, 3983.8605648802154, 3986.720929534934, 3989.0, 4001.0, 6265.806967561362, 6276.96861515694, 6278.403551662539, 6298.559100862942, 6345.001324582788, 2904.9854750726536, 3714.331420344364, 3946.782926939046, 3971.582983786661, 4036.091879327128, 3623.963760362363, 3695.427208782643, 4062.512498500199, 4079.63283304504, 4091.161311931047, 4261.424707664488, 4342.261815491374, 4570.902983283988, 4678.274867395559, 4823.758812059383, 5693.601447898607, 5955.183668980916, 6020.518358531307, 6075.696215189223, 6092.390760923872, 1306.314185052836, 1347.508159521787, 1374.1617613255905, 1376.3462355381114, 1381.2196109198471, 763.7632333976485, 912.8493798523302, 918.2470374293149, 933.2347475070512, 933.6312156698202, 4898.632602554822, 5481.232627432163, 5527.5577953764405, 5549.1676248562235, 5593.468620481048, 5126.0, 5622.0, 6082.452579267799, 6088.238970128734, 6108.877822443526, 5256.211568264791, 5321.760520776575, 5524.861878453071, 5530.198121272393, 5530.806421775299, 2708.7832973362083, 2720.9660329074827, 2725.065203705352, 2741.369485018417, 2748.7113853045144, 4957.0, 5185.870353241199, 5286.779552587922, 5294.364676238799, 5398.78404863801, 5262.0, 5727.427257274323, 5983.19226904371, 6242.843928901723, 6357.078223657544, 5102.897942041212, 5612.494875461147, 6288.930881750022, 6352.523560732963, 6530.836729081716, 5036.992601479646, 5578.916316255179, 5836.416358364129, 6260.68696565179, 6270.310265870659, 5042.193249080129, 5414.918776218438, 5436.130219164915, 6174.289956654862, 6198.2871969722255, 5447.676917080498, 5742.454466825645, 5914.438128377969, 6162.969185154046, 6473.96416573346, 3873.5739068702983, 3980.820863061111, 3990.4213888986515, 4009.5389030261895, 4034.2939985501835, 5855.0, 6129.233845769279, 6184.443400094013, 6193.84515387119, 6266.905996409966, 5231.90130072689, 5678.602497825113, 5798.449147330997, 5893.705314734332, 5960.940390596039, 5525.392206857323, 5939.792107276225, 5978.521718262442, 6017.338092809875, 6026.758929642765, 4786.2581299898575, 5196.9346284012445, 5527.695976721319, 5602.814902188232, 5840.853978650568, 5089.312942752681, 5753.338366087954, 5953.255843019622, 6013.639181649115, 6018.8194354169445, 5176.7152806594495, 5451.863703407446, 5882.911756323744, 5883.264436991012, 5893.762309914794], "value": 4244.42816299351, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [722.5283550371887, 735.4116706634692, 768.5926458976744, 769.7767647382259, 866.0040952904161, 15771.447999320011, 16212.594685132877, 16683.24925378358, 16754.664906701873, 16845.747313790303, 14881.627959301022, 15164.317605707742, 15184.240787960585, 15216.619584510392, 15270.389184432637, 679.052721453572, 845.3955421873359, 869.8999615044256, 873.6680061576592, 876.6931573949099, 732.4506620034974, 859.9656013759442, 875.2210532625968, 878.5914549734372, 878.7539488943074, 919.8390281700675, 921.5162039929024, 924.1867156901917, 924.7549399409162, 930.6789157740602, 912.8448163812102, 914.7758799094231, 916.4913473022469, 916.8716379706847, 916.9312301577409, 670.980110232444, 679.0425500044962, 683.6445048574762, 687.1033301541486, 687.2886562407933, 15386.461473848474, 15426.845731542653, 15469.613259668598, 15470.922645386701, 15503.379864805394, 14953.775693364609, 14994.325255363536, 15013.174275414847, 15076.472323468626, 15311.234438278152, 12109.333986630732, 12257.0, 12491.875081249162, 12559.0, 12692.80960785589, 3832.176082142325, 3863.130795571002, 3962.722609417313, 4040.939385909214, 4106.67146628272, 125584.37207813903, 125836.99628223135, 126529.0, 126570.0, 126775.36612316972, 8627.956860215785, 10650.307729997525, 11625.24435911663, 11646.0, 11781.823272650745, 20500.07749651269, 21171.0, 21311.573768524853, 21367.46581335479, 21414.892925535274, 7909.525428474195, 8015.278624923785, 8035.357171426272, 8061.798455038671, 8106.027276726831, 4510.255807791743, 4514.6614003949835, 4523.570260825217, 4584.4957054723955, 4610.2854057621125, 3848.499695039627, 4052.63526282636, 4095.1604920991126, 4099.3031184698675, 4106.178764247103, 564.221374503183, 603.4538742438101, 620.8913440147955, 717.3794667612582, 718.3606590134784, 545.9344878614592, 663.847315117516, 665.218368417108, 676.7936526922269, 680.3604611665118, 9716.61133554664, 9731.951340243395, 9803.166730827817, 9862.802743945082, 9933.354331968543, 553.7342075803637, 575.5395683453304, 660.5442244851038, 678.2539206872401, 689.3898899474002, 4754.429468463737, 5080.780940366628, 5270.710110943858, 5289.603279754034, 5400.027994960867, 108836.0, 113338.86661133284, 139311.0, 152958.23520882547, 159893.0, 113941.43029284966, 129427.0, 144062.0, 145964.0, 149240.25379873032, 97963.0, 99854.0, 100398.0, 110435.44782276358, 114686.27970580448, 9882.357646752938, 9920.52861862663, 10250.487475626338, 10370.792584148425, 10423.63517276922, 48641.0, 49648.751756240985, 64617.67691161514, 65734.0, 66781.65746740151, 81758.0, 85674.14325856662, 98609.0, 100695.0, 104802.0, 13100.986773042445, 13438.0, 13743.106698064594, 13787.241701706502, 14517.0, 15347.00244484105, 15387.461438849587, 15441.996270242398, 16217.0, 16313.755293670367, 14208.218547979961, 14398.784018239945, 14427.855721442651, 14462.132272063709, 14725.263736813331, 14158.221297828719, 14218.786718199442, 14437.205953672648, 14987.0, 14996.775048374066, 14003.649908752363, 14027.228502432465, 14292.928535357256, 14473.059251148641, 14751.262436877898, 11214.607488737855, 11616.5353385867, 11621.709457263636, 12013.339266340436, 12276.693082673004, 9855.35940163887, 10988.395638239974, 11074.143066333341, 11748.823767643664, 12133.332666703416], "value": 8086.239487397126, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1621.2000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 122.0, 117.0, 120.0, 117.0, 116.0, 122.0, 116.0, 116.0, 118.0], "value": 117.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 99.0, 168.0, 199.0, 113.0, 133.0, 131.0, 114.0, 179.0, 143.0], "value": 143.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [203.0, 204.0, 255.0, 178.0, 246.0, 279.0, 248.0, 203.0, 190.0, 256.0], "value": 226.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 83.0, 77.0, 148.0, 88.0, 81.0, 82.0, 52.0, 156.0, 53.0], "value": 88.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 71.0, 128.0, 97.0, 103.0, 107.0, 118.0, 70.0, 72.0, 118.0], "value": 95.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 108.0, 88.0, 87.0, 88.0, 85.0, 88.0, 103.0, 135.0, 105.0], "value": 100.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 104.0, 94.0, 96.0, 98.0, 93.0, 144.0, 151.0, 95.0], "value": 106.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 95.0, 98.0, 143.0, 141.0, 90.0, 93.0, 88.0, 92.0, 109.0], "value": 104.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 58.0, 57.0, 56.0, 59.0, 58.0, 57.0, 57.0, 57.0, 58.0], "value": 57.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 71.0, 101.0, 102.0, 92.0, 80.0, 75.0, 69.0, 68.0, 71.0], "value": 80.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 89.0, 86.0, 86.0, 87.0, 110.0, 113.0, 108.0, 87.0, 89.0], "value": 94.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 144.0, 157.0, 130.0, 144.0, 124.0, 150.0, 157.0, 212.0, 155.0], "value": 151.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 233.0, 239.0, 174.0, 166.0, 166.0, 168.0, 169.0, 171.0, 185.0], "value": 182.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 66.0, 68.0, 67.0, 70.0, 68.0, 75.0, 89.0, 89.0, 86.0], "value": 74.9, "unit": "score"}]}]} 14:20:24 INFO - Return code: 0 14:20:24 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:20:24 ERROR - # TBPL SUCCESS # 14:20:24 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:20:24 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:20:24 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:20:24 INFO - 2016-08-22 14:20:24.095 screenresolution[1943:20812] starting screenresolution argv=screenresolution get 14:20:24 INFO - 2016-08-22 14:20:24.098 screenresolution[1943:20812] Display 0: 1600x1200x32@60 14:20:24 INFO - 2016-08-22 14:20:24.104 screenresolution[1944:20815] starting screenresolution argv=screenresolution list 14:20:24 INFO - Available Modes on Display 0 14:20:24 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:20:24 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:20:24 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:20:24 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:20:24 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:20:24 INFO - Intel Iris: 14:20:24 INFO - Chipset Model: Intel Iris 14:20:24 INFO - Type: GPU 14:20:24 INFO - Bus: Built-In 14:20:24 INFO - VRAM (Dynamic, Max): 1536 MB 14:20:24 INFO - Vendor: Intel (0x8086) 14:20:24 INFO - Device ID: 0x0a2e 14:20:24 INFO - Revision ID: 0x0009 14:20:24 INFO - Displays: 14:20:24 INFO - Display: 14:20:24 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:20:24 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:20:24 INFO - Display Serial Number: 1600x1200 60 14:20:24 INFO - Main Display: Yes 14:20:24 INFO - Mirror: Off 14:20:24 INFO - Online: Yes 14:20:24 INFO - Rotation: Supported 14:20:24 INFO - Return code: 0 14:20:24 INFO - Running post-action listener: _resource_record_post_action 14:20:24 INFO - [mozharness: 2016-08-22 21:20:24.342314Z] Finished run-tests step (success) 14:20:24 INFO - Running post-run listener: _resource_record_post_run 14:20:24 INFO - Total resource usage - Wall time: 1211s; CPU: 55.0%; Read bytes: 905216; Write bytes: 707026944; Read time: 8; Write time: 2041 14:20:24 INFO - TinderboxPrint: CPU usage
54.5% 14:20:24 INFO - TinderboxPrint: I/O read bytes / time
905,216 / 8 14:20:24 INFO - TinderboxPrint: I/O write bytes / time
707,026,944 / 2,041 14:20:24 INFO - TinderboxPrint: CPU idle
2,202.9 (45.5%) 14:20:24 INFO - TinderboxPrint: CPU system
980.0 (20.2%) 14:20:24 INFO - TinderboxPrint: CPU user
1,662.8 (34.3%) 14:20:24 INFO - TinderboxPrint: Swap in / out
406,724,608 / 0 14:20:24 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 403823104; Write bytes: 398300672; Read time: 29862; Write time: 847 14:20:24 INFO - run-tests - Wall time: 1177s; CPU: 55.0%; Read bytes: 782336; Write bytes: 296778240; Read time: 6; Write time: 1154 14:20:24 INFO - Running post-run listener: _upload_blobber_files 14:20:24 INFO - Blob upload gear active. 14:20:24 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:20:24 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 14:20:24 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'] 14:20:24 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 14:20:25 INFO - (blobuploader) - INFO - Open directory for files ... 14:20:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:20:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:20:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:20:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:20:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:20:25 INFO - (blobuploader) - INFO - Done attempting. 14:20:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:20:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:20:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:20:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:20:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:20:27 INFO - (blobuploader) - INFO - Done attempting. 14:20:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:20:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:20:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:20:29 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:20:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:20:29 INFO - (blobuploader) - INFO - Done attempting. 14:20:29 INFO - (blobuploader) - INFO - Iteration through files over. 14:20:29 INFO - Return code: 0 14:20:29 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:20:29 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:20:29 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b5d3b5dc7494451029b83dfd62d9a33f8ca99628715c88022b1472d76292aae9c130bb5166ad78064cb2037b213b21ea212fe72134fcb6297b121436f4f960bf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/537658c99f864466b3790cbb905a70fae528f6db4596c87d25d1863440cca3b05629e73fa401a76a42fabba0f3ec39f61e09af2e732f9ea966c24116ccf41237", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5879cd29a78e5596419c79c2a19adc98116f3be7a3a399d74b12dd0424bb177a6320d7c3bb7060260a29f277266a84650d54a175519a9967b87713b1727a44db"} 14:20:29 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:20:29 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:20:29 INFO - Contents: 14:20:29 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b5d3b5dc7494451029b83dfd62d9a33f8ca99628715c88022b1472d76292aae9c130bb5166ad78064cb2037b213b21ea212fe72134fcb6297b121436f4f960bf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/537658c99f864466b3790cbb905a70fae528f6db4596c87d25d1863440cca3b05629e73fa401a76a42fabba0f3ec39f61e09af2e732f9ea966c24116ccf41237", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5879cd29a78e5596419c79c2a19adc98116f3be7a3a399d74b12dd0424bb177a6320d7c3bb7060260a29f277266a84650d54a175519a9967b87713b1727a44db"} 14:20:29 INFO - Running post-run listener: copy_logs_to_upload_dir 14:20:29 INFO - Copying logs to upload dir... 14:20:29 INFO - mkdir: /builds/slave/test/build/upload/logs 14:20:29 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1271.395392 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-08-22 14:20:29.754308) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-22 14:20:29.758473) ========= 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.Z7x2WIGpaS/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.FKPM5tEkTP/Listeners TMPDIR=/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/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/b5d3b5dc7494451029b83dfd62d9a33f8ca99628715c88022b1472d76292aae9c130bb5166ad78064cb2037b213b21ea212fe72134fcb6297b121436f4f960bf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/537658c99f864466b3790cbb905a70fae528f6db4596c87d25d1863440cca3b05629e73fa401a76a42fabba0f3ec39f61e09af2e732f9ea966c24116ccf41237", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5879cd29a78e5596419c79c2a19adc98116f3be7a3a399d74b12dd0424bb177a6320d7c3bb7060260a29f277266a84650d54a175519a9967b87713b1727a44db"} build_url:https://queue.taskcluster.net/v1/task/D7KAnUDmTUKS1fGkWXefLg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011322 build_url: 'https://queue.taskcluster.net/v1/task/D7KAnUDmTUKS1fGkWXefLg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b5d3b5dc7494451029b83dfd62d9a33f8ca99628715c88022b1472d76292aae9c130bb5166ad78064cb2037b213b21ea212fe72134fcb6297b121436f4f960bf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/537658c99f864466b3790cbb905a70fae528f6db4596c87d25d1863440cca3b05629e73fa401a76a42fabba0f3ec39f61e09af2e732f9ea966c24116ccf41237", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5879cd29a78e5596419c79c2a19adc98116f3be7a3a399d74b12dd0424bb177a6320d7c3bb7060260a29f277266a84650d54a175519a9967b87713b1727a44db"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-22 14:20:29.792853) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 14:20:29.793183) ========= 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.Z7x2WIGpaS/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.FKPM5tEkTP/Listeners TMPDIR=/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/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.005309 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 14:20:29.841837) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-22 14:20:29.842190) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-22 14:20:29.842527) ========= ========= Total master_lag: 2.97 =========