builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0030 starttime: 1471519509.5 results: success (0) buildid: 20160817163516 builduid: d5c059133172493a96b3248b810652c9 revision: b25d09b7fab57ddb82f14916a443eb34fda31137 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-18 04:25:09.504330) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-18 04:25:09.504756) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-18 04:25:09.505029) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-18 04:25:09.539046) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 04:25:09.539348) ========= 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.o0Zaix51xt/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.paYme5DJqU/Listeners TMPDIR=/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/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-18 04:25:09-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 7.57M=0.002s 2016-08-18 04:25:09 (7.57 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.080960 ========= master_lag: 0.20 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 04:25:09.817242) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 04:25:09.817533) ========= 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.o0Zaix51xt/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.paYme5DJqU/Listeners TMPDIR=/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/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.020625 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 04:25:09.864636) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 04:25:09.864942) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev b25d09b7fab57ddb82f14916a443eb34fda31137 --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 b25d09b7fab57ddb82f14916a443eb34fda31137 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.o0Zaix51xt/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.paYme5DJqU/Listeners TMPDIR=/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/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-18 04:25:09,936 truncating revision to first 12 chars 2016-08-18 04:25:09,936 Setting DEBUG logging. 2016-08-18 04:25:09,936 attempt 1/10 2016-08-18 04:25:09,936 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/b25d09b7fab5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-18 04:25:10,238 unpacking tar archive at: mozilla-central-b25d09b7fab5/testing/mozharness/ program finished with exit code 0 elapsedTime=0.562901 ========= master_lag: 0.43 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 04:25:10.852873) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-18 04:25:10.853185) ========= script_repo_revision: b25d09b7fab57ddb82f14916a443eb34fda31137 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-18 04:25:10.853592) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-18 04:25:10.853854) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-18 04:25:11.499191) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-08-18 04:25:11.499489) ========= /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.o0Zaix51xt/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.paYme5DJqU/Listeners TMPDIR=/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/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 04:25:11 INFO - MultiFileLogger online at 20160818 04:25:11 in /builds/slave/test 04:25:11 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 04:25:11 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:25:11 INFO - {'append_to_log': False, 04:25:11 INFO - 'base_work_dir': '/builds/slave/test', 04:25:11 INFO - 'blob_upload_branch': 'Firefox', 04:25:11 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:25:11 INFO - 'branch': 'Firefox', 04:25:11 INFO - 'buildbot_json_path': 'buildprops.json', 04:25:11 INFO - 'config_files': ('talos/mac_config.py',), 04:25:11 INFO - 'default_actions': ('clobber', 04:25:11 INFO - 'read-buildbot-config', 04:25:11 INFO - 'download-and-extract', 04:25:11 INFO - 'populate-webroot', 04:25:11 INFO - 'create-virtualenv', 04:25:11 INFO - 'install', 04:25:11 INFO - 'run-tests'), 04:25:11 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:25:11 INFO - 'download_minidump_stackwalk': True, 04:25:11 INFO - 'download_symbols': 'ondemand', 04:25:11 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:25:11 INFO - 'tooltool.py': '/tools/tooltool.py', 04:25:11 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:25:11 INFO - '/tools/misc-python/virtualenv.py')}, 04:25:11 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:25:11 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:25:11 INFO - 'installer_path': 'installer.exe', 04:25:11 INFO - 'log_level': 'info', 04:25:11 INFO - 'log_name': 'talos', 04:25:11 INFO - 'log_to_console': True, 04:25:11 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:25:11 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:25:11 INFO - 'opt_config_files': (), 04:25:11 INFO - 'pip_index': False, 04:25:11 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:25:11 INFO - 'cmd': ('bash', 04:25:11 INFO - '-c', 04:25:11 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:25:11 INFO - 'enabled': True, 04:25:11 INFO - 'halt_on_failure': False, 04:25:11 INFO - 'name': 'check_screen_resolution'},), 04:25:11 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:25:11 INFO - 'cmd': ('bash', 04:25:11 INFO - '-c', 04:25:11 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:25:11 INFO - 'enabled': True, 04:25:11 INFO - 'halt_on_failure': False, 04:25:11 INFO - 'name': 'check_screen_resolution'},), 04:25:11 INFO - 'run_cmd_checks_enabled': True, 04:25:11 INFO - 'sps_profile': False, 04:25:11 INFO - 'sps_profile_interval': 0, 04:25:11 INFO - 'suite': 'dromaeojs-e10s', 04:25:11 INFO - 'system_bits': '32', 04:25:11 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:25:11 INFO - 'title': 't-yosemite-r7-0030', 04:25:11 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:25:11 INFO - 'use_talos_json': True, 04:25:11 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:25:11 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:25:11 INFO - 'work_dir': 'build'} 04:25:11 INFO - [mozharness: 2016-08-18 11:25:11.686054Z] Running clobber step. 04:25:11 INFO - Running pre-action listener: _resource_record_pre_action 04:25:11 INFO - Running main action method: clobber 04:25:11 INFO - rmtree: /builds/slave/test/build 04:25:11 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:25:12 INFO - Running post-action listener: _resource_record_post_action 04:25:12 INFO - [mozharness: 2016-08-18 11:25:12.656024Z] Finished clobber step (success) 04:25:12 INFO - [mozharness: 2016-08-18 11:25:12.656164Z] Running read-buildbot-config step. 04:25:12 INFO - Running pre-action listener: _resource_record_pre_action 04:25:12 INFO - Running main action method: read_buildbot_config 04:25:12 INFO - Using buildbot properties: 04:25:12 INFO - { 04:25:12 INFO - "project": "", 04:25:12 INFO - "product": "firefox", 04:25:12 INFO - "script_repo_revision": "production", 04:25:12 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 04:25:12 INFO - "repository": "", 04:25:12 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 04:25:12 INFO - "buildid": "20160817163516", 04:25:12 INFO - "pgo_build": "False", 04:25:12 INFO - "basedir": "/builds/slave/test", 04:25:12 INFO - "buildnumber": 95, 04:25:12 INFO - "slavename": "t-yosemite-r7-0030", 04:25:12 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 04:25:12 INFO - "platform": "yosemite_r7", 04:25:12 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 04:25:12 INFO - "branch": "mozilla-central", 04:25:12 INFO - "repo_path": "mozilla-central", 04:25:12 INFO - "revision": "b25d09b7fab57ddb82f14916a443eb34fda31137", 04:25:12 INFO - "stage_platform": "macosx64", 04:25:12 INFO - "builduid": "d5c059133172493a96b3248b810652c9", 04:25:12 INFO - "slavebuilddir": "test" 04:25:12 INFO - } 04:25:12 INFO - Found installer url https://queue.taskcluster.net/v1/task/bPSr0os7Tv60bl3E03y8BA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 04:25:12 INFO - Running post-action listener: _resource_record_post_action 04:25:12 INFO - [mozharness: 2016-08-18 11:25:12.659413Z] Finished read-buildbot-config step (success) 04:25:12 INFO - [mozharness: 2016-08-18 11:25:12.659540Z] Running download-and-extract step. 04:25:12 INFO - Running pre-action listener: _resource_record_pre_action 04:25:12 INFO - Running main action method: download_and_extract 04:25:12 INFO - mkdir: /builds/slave/test/build/tests 04:25: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')]} 04:25:12 INFO - trying https://queue.taskcluster.net/v1/task/bPSr0os7Tv60bl3E03y8BA/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 04:25:12 INFO - Downloading https://queue.taskcluster.net/v1/task/bPSr0os7Tv60bl3E03y8BA/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 04:25:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bPSr0os7Tv60bl3E03y8BA/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 04:25:13 INFO - Downloaded 1199 bytes. 04:25:13 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 04:25:13 INFO - Using the following test package requirements: 04:25:13 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 04:25:13 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 04:25:13 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 04:25:13 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 04:25:13 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 04:25:13 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 04:25:13 INFO - u'jsshell-mac.zip'], 04:25:13 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 04:25:13 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 04:25:13 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 04:25:13 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 04:25:13 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 04:25:13 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 04:25:13 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 04:25:13 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 04:25:13 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 04:25:13 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 04:25:13 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 04:25:13 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:25:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:25:13 INFO - trying https://queue.taskcluster.net/v1/task/bPSr0os7Tv60bl3E03y8BA/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 04:25:13 INFO - Downloading https://queue.taskcluster.net/v1/task/bPSr0os7Tv60bl3E03y8BA/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 04:25:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bPSr0os7Tv60bl3E03y8BA/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 04:25:14 INFO - Downloaded 16338716 bytes. 04:25:14 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 04:25:21 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 04:25:21 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')]} 04:25:21 INFO - trying https://queue.taskcluster.net/v1/task/bPSr0os7Tv60bl3E03y8BA/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 04:25:21 INFO - Downloading https://queue.taskcluster.net/v1/task/bPSr0os7Tv60bl3E03y8BA/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 04:25:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bPSr0os7Tv60bl3E03y8BA/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 04:25:22 INFO - Downloaded 16338716 bytes. 04:25:22 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 04:25: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')]} 04:25:29 INFO - trying https://queue.taskcluster.net/v1/task/bPSr0os7Tv60bl3E03y8BA/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 04:25:29 INFO - Downloading https://queue.taskcluster.net/v1/task/bPSr0os7Tv60bl3E03y8BA/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 04:25:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bPSr0os7Tv60bl3E03y8BA/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 04:25:29 INFO - Downloaded 14413719 bytes. 04:25:29 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/tests 04:25:30 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')]} 04:25:30 INFO - trying https://queue.taskcluster.net/v1/task/bPSr0os7Tv60bl3E03y8BA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 04:25:30 INFO - Downloading https://queue.taskcluster.net/v1/task/bPSr0os7Tv60bl3E03y8BA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 04:25:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bPSr0os7Tv60bl3E03y8BA/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 04:25:33 INFO - Downloaded 111292281 bytes. 04:25:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bPSr0os7Tv60bl3E03y8BA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 04:25:33 INFO - mkdir: /builds/slave/test/properties 04:25:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:25:33 INFO - Writing to file /builds/slave/test/properties/build_url 04:25:33 INFO - Contents: 04:25:33 INFO - build_url:https://queue.taskcluster.net/v1/task/bPSr0os7Tv60bl3E03y8BA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 04:25:34 INFO - Running post-action listener: _resource_record_post_action 04:25:34 INFO - Running post-action listener: set_extra_try_arguments 04:25:34 INFO - [mozharness: 2016-08-18 11:25:34.148549Z] Finished download-and-extract step (success) 04:25:34 INFO - [mozharness: 2016-08-18 11:25:34.148664Z] Running populate-webroot step. 04:25:34 INFO - Running pre-action listener: _resource_record_pre_action 04:25:34 INFO - Running main action method: populate_webroot 04:25:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:25:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:25:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:25:34 INFO - '--tppagecycles', 04:25:34 INFO - '7'], 04:25:34 INFO - 'tests': ['tsvgm']}}, 04:25:34 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:25:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:25:34 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:25:34 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:25:34 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:25:34 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:25:34 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:25:34 INFO - 'talos_options': ['--disable-e10s'], 04:25:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:25:34 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:25:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:25:34 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:25:34 INFO - 'talos_options': ['--disable-e10s'], 04:25:34 INFO - 'tests': ['damp', 'tps']}, 04:25:34 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:25:34 INFO - 'tests': ['damp', 'tps']}, 04:25:34 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:25:34 INFO - 'tests': ['dromaeo_dom']}, 04:25:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:25:34 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:25:34 INFO - 'tests': ['basic_compositor_video']}, 04:25:34 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:25:34 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:25:34 INFO - 'tests': ['a11yr', 04:25:34 INFO - 'ts_paint', 04:25:34 INFO - 'tpaint', 04:25:34 INFO - 'sessionrestore', 04:25:34 INFO - 'sessionrestore_no_auto_restore', 04:25:34 INFO - 'tabpaint']}, 04:25:34 INFO - 'other-e10s': {'tests': ['a11yr', 04:25:34 INFO - 'ts_paint', 04:25:34 INFO - 'tpaint', 04:25:34 INFO - 'sessionrestore', 04:25:34 INFO - 'sessionrestore_no_auto_restore', 04:25:34 INFO - 'tabpaint']}, 04:25:34 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:25:34 INFO - 'ts_paint', 04:25:34 INFO - 'tpaint', 04:25:34 INFO - 'sessionrestore', 04:25:34 INFO - 'sessionrestore_no_auto_restore', 04:25:34 INFO - 'tabpaint']}, 04:25:34 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:25:34 INFO - 'ts_paint', 04:25:34 INFO - 'tpaint', 04:25:34 INFO - 'sessionrestore', 04:25:34 INFO - 'sessionrestore_no_auto_restore', 04:25:34 INFO - 'tabpaint']}, 04:25:34 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:25:34 INFO - 'tests': ['a11yr', 04:25:34 INFO - 'ts_paint', 04:25:34 INFO - 'tpaint', 04:25:34 INFO - 'sessionrestore', 04:25:34 INFO - 'sessionrestore_no_auto_restore', 04:25:34 INFO - 'tabpaint']}, 04:25:34 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:25:34 INFO - 'tests': ['a11yr', 04:25:34 INFO - 'ts_paint', 04:25:34 INFO - 'tpaint', 04:25:34 INFO - 'sessionrestore', 04:25:34 INFO - 'sessionrestore_no_auto_restore', 04:25:34 INFO - 'tabpaint']}, 04:25:34 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:25:34 INFO - 'tests': ['tsvgx', 04:25:34 INFO - 'tsvgr_opacity', 04:25:34 INFO - 'tart', 04:25:34 INFO - 'tscrollx', 04:25:34 INFO - 'cart']}, 04:25:34 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:25:34 INFO - 'tsvgr_opacity', 04:25:34 INFO - 'tart', 04:25:34 INFO - 'tscrollx', 04:25:34 INFO - 'cart']}, 04:25:34 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:25:34 INFO - 'talos_options': ['--disable-e10s'], 04:25:34 INFO - 'tests': ['tp5o']}, 04:25:34 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:25:34 INFO - 'tests': ['tp5o']}, 04:25:34 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:25:34 INFO - 'talos_options': ['--disable-e10s', 04:25:34 INFO - '--xperf_path', 04:25:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:25:34 INFO - 'tests': ['tp5n']}, 04:25:34 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:25:34 INFO - 'talos_options': ['--xperf_path', 04:25:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:25:34 INFO - 'tests': ['tp5n']}}, 04:25:34 INFO - 'talos.zip': {'path': '', 04:25:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:25:34 INFO - Running post-action listener: _resource_record_post_action 04:25:34 INFO - [mozharness: 2016-08-18 11:25:34.167541Z] Finished populate-webroot step (success) 04:25:34 INFO - [mozharness: 2016-08-18 11:25:34.167678Z] Running create-virtualenv step. 04:25:34 INFO - Running pre-action listener: _resource_record_pre_action 04:25:34 INFO - Running main action method: create_virtualenv 04:25:34 INFO - Creating virtualenv /builds/slave/test/build/venv 04:25:34 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 04:25:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:25:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:25:34 INFO - Using real prefix '/tools/python27' 04:25:34 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:25:35 INFO - Installing distribute.............................................................................................................................................................................................done. 04:25:37 INFO - Installing pip.................done. 04:25:37 INFO - Return code: 0 04:25:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:25: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')]} 04:25:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:25:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25: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')]} 04:25:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:25:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:37 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 0x1096cda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109762618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffda2474440>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109631d30>, '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 0x109396db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109629b20>, '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.o0Zaix51xt/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.paYme5DJqU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/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 04:25:37 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 04:25:37 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 04:25:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.o0Zaix51xt/Render', 04:25:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:25:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:25:37 INFO - 'HOME': '/Users/cltbld', 04:25:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:25:37 INFO - 'LOGNAME': 'cltbld', 04:25:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:25:37 INFO - 'MOZ_NO_REMOTE': '1', 04:25:37 INFO - 'NO_EM_RESTART': '1', 04:25:37 INFO - 'PAGER': '/bin/cat', 04:25:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:25:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:25:37 INFO - 'PWD': '/builds/slave/test', 04:25:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:25:37 INFO - 'SHELL': '/bin/bash', 04:25:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.paYme5DJqU/Listeners', 04:25:37 INFO - 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', 04:25:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:25:37 INFO - 'USER': 'cltbld', 04:25:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:25:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:25:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:25:37 INFO - 'XPC_FLAGS': '0x0', 04:25:37 INFO - 'XPC_SERVICE_NAME': '0', 04:25:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:25:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:25:38 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 04:25:38 INFO - Cleaning up... 04:25:38 INFO - Return code: 0 04:25:38 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:25:38 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')]} 04:25:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:25:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:38 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')]} 04:25:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:25:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:38 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 0x1096cda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109762618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffda2474440>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109631d30>, '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 0x109396db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109629b20>, '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.o0Zaix51xt/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.paYme5DJqU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/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 04:25:38 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 04:25:38 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 04:25:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.o0Zaix51xt/Render', 04:25:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:25:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:25:38 INFO - 'HOME': '/Users/cltbld', 04:25:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:25:38 INFO - 'LOGNAME': 'cltbld', 04:25:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:25:38 INFO - 'MOZ_NO_REMOTE': '1', 04:25:38 INFO - 'NO_EM_RESTART': '1', 04:25:38 INFO - 'PAGER': '/bin/cat', 04:25:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:25:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:25:38 INFO - 'PWD': '/builds/slave/test', 04:25:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:25:38 INFO - 'SHELL': '/bin/bash', 04:25:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.paYme5DJqU/Listeners', 04:25:38 INFO - 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', 04:25:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:25:38 INFO - 'USER': 'cltbld', 04:25:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:25:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:25:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:25:38 INFO - 'XPC_FLAGS': '0x0', 04:25:38 INFO - 'XPC_SERVICE_NAME': '0', 04:25:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:25:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:25:38 INFO - Downloading/unpacking psutil>=3.1.1 04:25:38 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 04:25:38 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 04:25:38 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 04:25:38 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 04:25:38 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 04:25:38 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 04:25:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:25:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:25:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:25:41 INFO - Installing collected packages: psutil 04:25:41 INFO - Running setup.py install for psutil 04:25:41 INFO - building 'psutil._psutil_osx' extension 04:25:41 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 04:25:41 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 04:25:41 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 04:25:41 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 04:25:41 INFO - building 'psutil._psutil_posix' extension 04:25:41 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 04:25:42 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:25:42 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:25:42 INFO - ^ 04:25:42 INFO - 1 warning generated. 04:25:42 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 04:25:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:25:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:25:42 INFO - Successfully installed psutil 04:25:42 INFO - Cleaning up... 04:25:42 INFO - Return code: 0 04:25:42 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:25:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:25:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:25:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:25:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:25:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:42 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 0x1096cda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109762618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffda2474440>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109631d30>, '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 0x109396db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109629b20>, '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.o0Zaix51xt/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.paYme5DJqU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/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 04:25:42 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 04:25:42 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 04:25:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.o0Zaix51xt/Render', 04:25:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:25:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:25:42 INFO - 'HOME': '/Users/cltbld', 04:25:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:25:42 INFO - 'LOGNAME': 'cltbld', 04:25:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:25:42 INFO - 'MOZ_NO_REMOTE': '1', 04:25:42 INFO - 'NO_EM_RESTART': '1', 04:25:42 INFO - 'PAGER': '/bin/cat', 04:25:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:25:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:25:42 INFO - 'PWD': '/builds/slave/test', 04:25:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:25:42 INFO - 'SHELL': '/bin/bash', 04:25:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.paYme5DJqU/Listeners', 04:25:42 INFO - 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', 04:25:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:25:42 INFO - 'USER': 'cltbld', 04:25:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:25:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:25:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:25:42 INFO - 'XPC_FLAGS': '0x0', 04:25:42 INFO - 'XPC_SERVICE_NAME': '0', 04:25:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:25:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:25:42 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:25:42 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 04:25:42 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 04:25:42 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 04:25:42 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 04:25:42 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 04:25:42 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 04:25:45 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:25:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:25:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:25:45 INFO - Installing collected packages: mozsystemmonitor 04:25:45 INFO - Running setup.py install for mozsystemmonitor 04:25:45 INFO - Successfully installed mozsystemmonitor 04:25:45 INFO - Cleaning up... 04:25:45 INFO - Return code: 0 04:25:45 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:25: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')]} 04:25:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:25:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25: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')]} 04:25:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:25:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25: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', '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 0x1096cda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109762618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffda2474440>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109631d30>, '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 0x109396db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109629b20>, '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.o0Zaix51xt/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.paYme5DJqU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/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 04:25: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:25: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 jsonschema==2.5.1 04:25:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.o0Zaix51xt/Render', 04:25:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:25:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:25:45 INFO - 'HOME': '/Users/cltbld', 04:25:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:25:45 INFO - 'LOGNAME': 'cltbld', 04:25:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:25:45 INFO - 'MOZ_NO_REMOTE': '1', 04:25:45 INFO - 'NO_EM_RESTART': '1', 04:25:45 INFO - 'PAGER': '/bin/cat', 04:25:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:25:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:25:45 INFO - 'PWD': '/builds/slave/test', 04:25:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:25:45 INFO - 'SHELL': '/bin/bash', 04:25:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.paYme5DJqU/Listeners', 04:25:45 INFO - 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', 04:25:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:25:45 INFO - 'USER': 'cltbld', 04:25:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:25:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:25:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:25:45 INFO - 'XPC_FLAGS': '0x0', 04:25:45 INFO - 'XPC_SERVICE_NAME': '0', 04:25:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:25:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:25:45 INFO - Downloading/unpacking jsonschema==2.5.1 04:25: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 04:25: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 04:25: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 04:25: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 04:25: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 04:25: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 04:25:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:25:48 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:25:48 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 04:25:48 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 04:25:48 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 04:25:48 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 04:25:48 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 04:25:48 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 04:25:48 INFO - Downloading functools32-3.2.3-2.tar.gz 04:25:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:25:48 INFO - warning: no files found matching '*.txt' 04:25:48 INFO - no previously-included directories found matching 'build' 04:25:48 INFO - no previously-included directories found matching 'dist' 04:25:48 INFO - no previously-included directories found matching '.git*' 04:25:48 INFO - Installing collected packages: jsonschema, functools32 04:25:48 INFO - Running setup.py install for functools32 04:25:48 INFO - warning: no files found matching '*.txt' 04:25:48 INFO - no previously-included directories found matching 'build' 04:25:48 INFO - no previously-included directories found matching 'dist' 04:25:48 INFO - no previously-included directories found matching '.git*' 04:25:48 INFO - Successfully installed jsonschema functools32 04:25:48 INFO - Cleaning up... 04:25:48 INFO - Return code: 0 04:25:48 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:25:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:25:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:25:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:25:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:25:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:48 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 0x1096cda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109762618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffda2474440>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109631d30>, '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 0x109396db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109629b20>, '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.o0Zaix51xt/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.paYme5DJqU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/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 04:25:48 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 04:25:48 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 04:25:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.o0Zaix51xt/Render', 04:25:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:25:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:25:48 INFO - 'HOME': '/Users/cltbld', 04:25:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:25:48 INFO - 'LOGNAME': 'cltbld', 04:25:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:25:48 INFO - 'MOZ_NO_REMOTE': '1', 04:25:48 INFO - 'NO_EM_RESTART': '1', 04:25:48 INFO - 'PAGER': '/bin/cat', 04:25:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:25:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:25:48 INFO - 'PWD': '/builds/slave/test', 04:25:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:25:48 INFO - 'SHELL': '/bin/bash', 04:25:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.paYme5DJqU/Listeners', 04:25:48 INFO - 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', 04:25:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:25:48 INFO - 'USER': 'cltbld', 04:25:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:25:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:25:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:25:48 INFO - 'XPC_FLAGS': '0x0', 04:25:48 INFO - 'XPC_SERVICE_NAME': '0', 04:25:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:25:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:25:49 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:25:49 INFO - Cleaning up... 04:25:49 INFO - Return code: 0 04:25:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:25: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')]} 04:25:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:25:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25: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')]} 04:25:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:25:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25: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', '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 0x1096cda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109762618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffda2474440>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109631d30>, '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 0x109396db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109629b20>, '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.o0Zaix51xt/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.paYme5DJqU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/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 04:25: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:25: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 blobuploader==1.2.4 04:25:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.o0Zaix51xt/Render', 04:25:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:25:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:25:49 INFO - 'HOME': '/Users/cltbld', 04:25:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:25:49 INFO - 'LOGNAME': 'cltbld', 04:25:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:25:49 INFO - 'MOZ_NO_REMOTE': '1', 04:25:49 INFO - 'NO_EM_RESTART': '1', 04:25:49 INFO - 'PAGER': '/bin/cat', 04:25:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:25:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:25:49 INFO - 'PWD': '/builds/slave/test', 04:25:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:25:49 INFO - 'SHELL': '/bin/bash', 04:25:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.paYme5DJqU/Listeners', 04:25:49 INFO - 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', 04:25:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:25:49 INFO - 'USER': 'cltbld', 04:25:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:25:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:25:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:25:49 INFO - 'XPC_FLAGS': '0x0', 04:25:49 INFO - 'XPC_SERVICE_NAME': '0', 04:25:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:25:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:25:49 INFO - Downloading/unpacking blobuploader==1.2.4 04:25: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 04:25: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 04:25: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 04:25: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 04:25: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 04:25: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 04:25:51 INFO - Downloading blobuploader-1.2.4.tar.gz 04:25:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:25:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:25: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 04:25: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 04:25: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 04:25: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 04:25: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 04:25: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 04:25:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:25:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:25: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 04:25: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 04:25: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 04:25: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 04:25: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 04:25: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 04:25:53 INFO - Downloading docopt-0.6.1.tar.gz 04:25:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:25:53 INFO - Installing collected packages: blobuploader, requests, docopt 04:25:53 INFO - Running setup.py install for blobuploader 04:25:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:25:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:25:53 INFO - Running setup.py install for requests 04:25:53 INFO - Running setup.py install for docopt 04:25:54 INFO - Successfully installed blobuploader requests docopt 04:25:54 INFO - Cleaning up... 04:25:54 INFO - Return code: 0 04:25:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:25:54 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')]} 04:25:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:25:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:54 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')]} 04:25:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:25:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:54 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 0x1096cda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109762618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffda2474440>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109631d30>, '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 0x109396db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109629b20>, '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.o0Zaix51xt/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.paYme5DJqU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/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 04:25:54 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 04:25:54 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 04:25:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.o0Zaix51xt/Render', 04:25:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:25:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:25:54 INFO - 'HOME': '/Users/cltbld', 04:25:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:25:54 INFO - 'LOGNAME': 'cltbld', 04:25:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:25:54 INFO - 'MOZ_NO_REMOTE': '1', 04:25:54 INFO - 'NO_EM_RESTART': '1', 04:25:54 INFO - 'PAGER': '/bin/cat', 04:25:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:25:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:25:54 INFO - 'PWD': '/builds/slave/test', 04:25:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:25:54 INFO - 'SHELL': '/bin/bash', 04:25:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.paYme5DJqU/Listeners', 04:25:54 INFO - 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', 04:25:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:25:54 INFO - 'USER': 'cltbld', 04:25:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:25:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:25:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:25:54 INFO - 'XPC_FLAGS': '0x0', 04:25:54 INFO - 'XPC_SERVICE_NAME': '0', 04:25:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:25:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:25:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:25:54 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-tiJMgI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:25:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:25:54 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-BXLMAt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:25:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:25:54 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-gmU49r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:25:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:25:54 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-IL9mDE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:25:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:25:54 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-8_kUTY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:25:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:25:54 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-orFgJn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:25:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:25:55 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-dxmDoO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:25:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:25:55 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-Kr4RTR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:25:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:25:55 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-vzH9bB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:25:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:25:55 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-kOyUBL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:25:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:25:55 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-vdkqpz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:25:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:25:55 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-UlQlgH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:25:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:25:55 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-A24TWm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:25:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:25:55 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-YsFNpp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:25:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:25:55 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-Jm3nZ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:25:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:25:56 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-EEsMCB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:25:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:25:56 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-1s8xKj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:25:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:25:56 INFO - Running setup.py install for manifestparser 04:25:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:25:56 INFO - Running setup.py install for mozcrash 04:25:56 INFO - Running setup.py install for mozdebug 04:25:56 INFO - Running setup.py install for mozdevice 04:25:56 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:25:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:25:56 INFO - Running setup.py install for mozfile 04:25:56 INFO - Running setup.py install for mozhttpd 04:25:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:25:57 INFO - Running setup.py install for mozinfo 04:25:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:25:57 INFO - Running setup.py install for mozInstall 04:25:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:25:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:25:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:25:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:25:57 INFO - Running setup.py install for mozleak 04:25:57 INFO - Running setup.py install for mozlog 04:25:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:25:57 INFO - Running setup.py install for moznetwork 04:25:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:25:57 INFO - Running setup.py install for mozprocess 04:25:58 INFO - Running setup.py install for mozprofile 04:25:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:25:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:25:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:25:58 INFO - Running setup.py install for mozrunner 04:25:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:25:58 INFO - Running setup.py install for mozscreenshot 04:25:58 INFO - Running setup.py install for moztest 04:25:58 INFO - Running setup.py install for mozversion 04:25:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:25:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:25:58 INFO - Cleaning up... 04:25:58 INFO - Return code: 0 04:25:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:25:58 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')]} 04:25:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:25:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:58 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')]} 04:25:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:25:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:58 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 0x1096cda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109762618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffda2474440>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109631d30>, '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 0x109396db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109629b20>, '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.o0Zaix51xt/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.paYme5DJqU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/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 04:25:58 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 04:25:58 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 04:25:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.o0Zaix51xt/Render', 04:25:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:25:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:25:58 INFO - 'HOME': '/Users/cltbld', 04:25:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:25:58 INFO - 'LOGNAME': 'cltbld', 04:25:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:25:58 INFO - 'MOZ_NO_REMOTE': '1', 04:25:58 INFO - 'NO_EM_RESTART': '1', 04:25:58 INFO - 'PAGER': '/bin/cat', 04:25:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:25:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:25:58 INFO - 'PWD': '/builds/slave/test', 04:25:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:25:58 INFO - 'SHELL': '/bin/bash', 04:25:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.paYme5DJqU/Listeners', 04:25:58 INFO - 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', 04:25:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:25:58 INFO - 'USER': 'cltbld', 04:25:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:25:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:25:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:25:58 INFO - 'XPC_FLAGS': '0x0', 04:25:58 INFO - 'XPC_SERVICE_NAME': '0', 04:25:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:25:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:25:59 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-7ihke4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:25:59 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)) 04:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:25:59 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-UkUz4R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:25:59 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)) 04:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:25:59 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-z_9Om6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:25:59 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)) 04:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:25:59 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-_XnBcn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:25:59 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)) 04:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:25:59 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-AZBkXY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:25:59 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)) 04:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:25:59 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-laChBX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:25:59 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)) 04:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:25:59 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-wUl2GX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:25:59 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)) 04:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:25:59 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-vRcmNI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:25:59 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)) 04:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:25:59 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-9kAld7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:26:00 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)) 04:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:26:00 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-0Tynny-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:26:00 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)) 04:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:26:00 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-l3DxBV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:26:00 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)) 04:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:26:00 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-xiYb1T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:26:00 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)) 04:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:26:00 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-j7cHOJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:26:00 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)) 04:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:26:00 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-h4tMIN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:26:00 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)) 04:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:26:00 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-8sS5xE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:26:00 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)) 04:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:26:00 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-UD2GpI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:26:00 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)) 04:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:26:00 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-SavEmX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:26:00 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)) 04:26:00 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)) 04:26:00 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)) 04:26:00 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)) 04:26:00 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)) 04:26:00 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)) 04:26:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:26: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 04:26: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 04:26: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 04:26: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 04:26: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 04:26: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 04:26:03 INFO - Downloading blessings-1.6.tar.gz 04:26:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:26:03 INFO - Installing collected packages: blessings 04:26:03 INFO - Running setup.py install for blessings 04:26:03 INFO - Successfully installed blessings 04:26:03 INFO - Cleaning up... 04:26:03 INFO - Return code: 0 04:26:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:26:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:26:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:26:04 INFO - Reading from file tmpfile_stdout 04:26:04 INFO - Current package versions: 04:26:04 INFO - blessings == 1.6 04:26:04 INFO - blobuploader == 1.2.4 04:26:04 INFO - docopt == 0.6.1 04:26:04 INFO - functools32 == 3.2.3-2 04:26:04 INFO - jsonschema == 2.5.1 04:26:04 INFO - manifestparser == 1.1 04:26:04 INFO - mozInstall == 1.12 04:26:04 INFO - mozcrash == 0.17 04:26:04 INFO - mozdebug == 0.1 04:26:04 INFO - mozdevice == 0.48 04:26:04 INFO - mozfile == 1.2 04:26:04 INFO - mozhttpd == 0.7 04:26:04 INFO - mozinfo == 0.9 04:26:04 INFO - mozleak == 0.1 04:26:04 INFO - mozlog == 3.3 04:26:04 INFO - moznetwork == 0.27 04:26:04 INFO - mozprocess == 0.23 04:26:04 INFO - mozprofile == 0.28 04:26:04 INFO - mozrunner == 6.12 04:26:04 INFO - mozscreenshot == 0.1 04:26:04 INFO - mozsystemmonitor == 0.3 04:26:04 INFO - moztest == 0.7 04:26:04 INFO - mozversion == 1.4 04:26:04 INFO - psutil == 3.1.1 04:26:04 INFO - requests == 1.2.3 04:26:04 INFO - wsgiref == 0.1.2 04:26:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:26:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:26:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:26:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:26:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:26:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:04 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 0x1096cda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109762618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffda2474440>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109631d30>, '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 0x109396db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109629b20>, '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.o0Zaix51xt/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.paYme5DJqU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/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 04:26:04 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 04:26:04 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 04:26:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.o0Zaix51xt/Render', 04:26:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:26:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:26:04 INFO - 'HOME': '/Users/cltbld', 04:26:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:26:04 INFO - 'LOGNAME': 'cltbld', 04:26:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:26:04 INFO - 'MOZ_NO_REMOTE': '1', 04:26:04 INFO - 'NO_EM_RESTART': '1', 04:26:04 INFO - 'PAGER': '/bin/cat', 04:26:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:26:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:26:04 INFO - 'PWD': '/builds/slave/test', 04:26:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:26:04 INFO - 'SHELL': '/bin/bash', 04:26:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.paYme5DJqU/Listeners', 04:26:04 INFO - 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', 04:26:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:26:04 INFO - 'USER': 'cltbld', 04:26:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:26:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:26:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:26:04 INFO - 'XPC_FLAGS': '0x0', 04:26:04 INFO - 'XPC_SERVICE_NAME': '0', 04:26:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:26:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:26:04 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)) 04:26:04 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)) 04:26:04 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)) 04:26:04 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)) 04:26:04 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)) 04:26:04 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)) 04:26:04 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)) 04:26:04 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)) 04:26:04 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)) 04:26:04 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)) 04:26:04 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)) 04:26:04 INFO - Cleaning up... 04:26:04 INFO - Return code: 0 04:26:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:26:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:26:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:26:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:26:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:26:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:04 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 0x1096cda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109762618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffda2474440>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109631d30>, '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 0x109396db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109629b20>, '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.o0Zaix51xt/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.paYme5DJqU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/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 04:26:04 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 04:26:04 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 04:26:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.o0Zaix51xt/Render', 04:26:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:26:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:26:04 INFO - 'HOME': '/Users/cltbld', 04:26:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:26:04 INFO - 'LOGNAME': 'cltbld', 04:26:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:26:04 INFO - 'MOZ_NO_REMOTE': '1', 04:26:04 INFO - 'NO_EM_RESTART': '1', 04:26:04 INFO - 'PAGER': '/bin/cat', 04:26:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:26:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:26:04 INFO - 'PWD': '/builds/slave/test', 04:26:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:26:04 INFO - 'SHELL': '/bin/bash', 04:26:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.paYme5DJqU/Listeners', 04:26:04 INFO - 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', 04:26:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:26:04 INFO - 'USER': 'cltbld', 04:26:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:26:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:26:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:26:04 INFO - 'XPC_FLAGS': '0x0', 04:26:04 INFO - 'XPC_SERVICE_NAME': '0', 04:26:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:26:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:26:05 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:26:05 INFO - Cleaning up... 04:26:05 INFO - Return code: 0 04:26:05 INFO - Running post-action listener: _resource_record_post_action 04:26:05 INFO - Running post-action listener: _start_resource_monitoring 04:26:05 INFO - Starting resource monitoring. 04:26:05 INFO - [mozharness: 2016-08-18 11:26:05.093838Z] Finished create-virtualenv step (success) 04:26:05 INFO - [mozharness: 2016-08-18 11:26:05.094820Z] Running install step. 04:26:05 INFO - Running pre-action listener: _resource_record_pre_action 04:26:05 INFO - Running main action method: install 04:26:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:26:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:26:05 INFO - Reading from file tmpfile_stdout 04:26:05 INFO - Detecting whether we're running mozinstall >=1.0... 04:26:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:26:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:26:05 INFO - Reading from file tmpfile_stdout 04:26:05 INFO - Output received: 04:26:05 INFO - Usage: mozinstall [options] installer 04:26:05 INFO - Options: 04:26:05 INFO - -h, --help show this help message and exit 04:26:05 INFO - -d DEST, --destination=DEST 04:26:05 INFO - Directory to install application into. [default: 04:26:05 INFO - "/builds/slave/test"] 04:26:05 INFO - --app=APP Application being installed. [default: firefox] 04:26:05 INFO - mkdir: /builds/slave/test/build/application 04:26:05 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'] 04:26:05 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 04:26:39 INFO - Reading from file tmpfile_stdout 04:26:39 INFO - Output received: 04:26:39 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 04:26:39 INFO - Running post-action listener: _resource_record_post_action 04:26:39 INFO - [mozharness: 2016-08-18 11:26:39.997909Z] Finished install step (success) 04:26:39 INFO - [mozharness: 2016-08-18 11:26:39.998048Z] Running run-tests step. 04:26:39 INFO - Running pre-action listener: _resource_record_pre_action 04:26:39 INFO - Running main action method: run_tests 04:26:40 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:26:40 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:26:40 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:26:40 INFO - 2016-08-18 04:26:40.012 screenresolution[1942:13976] starting screenresolution argv=screenresolution get 04:26:40 INFO - 2016-08-18 04:26:40.015 screenresolution[1942:13976] Display 0: 1600x1200x32@60 04:26:40 INFO - 2016-08-18 04:26:40.021 screenresolution[1943:13978] starting screenresolution argv=screenresolution list 04:26:40 INFO - Available Modes on Display 0 04:26:40 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:26:40 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:26:40 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:26:40 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:26:40 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:26:40 INFO - Intel Iris: 04:26:40 INFO - Chipset Model: Intel Iris 04:26:40 INFO - Type: GPU 04:26:40 INFO - Bus: Built-In 04:26:40 INFO - VRAM (Dynamic, Max): 1536 MB 04:26:40 INFO - Vendor: Intel (0x8086) 04:26:40 INFO - Device ID: 0x0a2e 04:26:40 INFO - Revision ID: 0x0009 04:26:40 INFO - Displays: 04:26:40 INFO - Display: 04:26:40 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:26:40 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:26:40 INFO - Display Serial Number: 1600x1200 60 04:26:40 INFO - Main Display: Yes 04:26:40 INFO - Mirror: Off 04:26:40 INFO - Online: Yes 04:26:40 INFO - Rotation: Supported 04:26:40 INFO - Return code: 0 04:26:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:26:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:26:40 INFO - Python 2.7.3 04:26:40 INFO - Return code: 0 04:26:40 INFO - grabbing minidump binary from tooltool 04:26:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:26:40 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 0x109631d30>, '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 0x109396db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109629b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:26:40 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 04:26:40 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 04:26:40 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 04:26:40 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:26:40 INFO - Return code: 0 04:26:40 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:26:40 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:26:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:26:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:26:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:26:40 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/bPSr0os7Tv60bl3E03y8BA/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0030', '--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 04:26:40 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/bPSr0os7Tv60bl3E03y8BA/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0030 --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 04:26:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.o0Zaix51xt/Render', 04:26:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:26:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:26:40 INFO - 'HOME': '/Users/cltbld', 04:26:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:26:40 INFO - 'LOGNAME': 'cltbld', 04:26:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:26:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:26:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:26:40 INFO - 'MOZ_NO_REMOTE': '1', 04:26:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:26:40 INFO - 'NO_EM_RESTART': '1', 04:26:40 INFO - 'PAGER': '/bin/cat', 04:26:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:26:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:26:40 INFO - 'PWD': '/builds/slave/test', 04:26:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:26:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:26:40 INFO - 'SHELL': '/bin/bash', 04:26:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.paYme5DJqU/Listeners', 04:26:40 INFO - 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', 04:26:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:26:40 INFO - 'USER': 'cltbld', 04:26:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:26:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:26:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:26:40 INFO - 'XPC_FLAGS': '0x0', 04:26:40 INFO - 'XPC_SERVICE_NAME': '0', 04:26:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:26:40 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/bPSr0os7Tv60bl3E03y8BA/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0030', '--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 04:26:40 INFO - mozversion application_buildid: 20160817163516 04:26:40 INFO - mozversion application_changeset: b25d09b7fab57ddb82f14916a443eb34fda31137 04:26:40 INFO - mozversion application_display_name: Nightly 04:26:40 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:26:40 INFO - mozversion application_name: Firefox 04:26:40 INFO - mozversion application_remotingname: firefox 04:26:40 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:26:40 INFO - mozversion application_vendor: Mozilla 04:26:40 INFO - mozversion application_version: 51.0a1 04:26:40 INFO - mozversion platform_buildid: 20160817163516 04:26:40 INFO - mozversion platform_changeset: b25d09b7fab57ddb82f14916a443eb34fda31137 04:26:40 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:26:40 INFO - mozversion platform_version: 51.0a1 04:26:40 INFO - using testdate: 1471519600 04:26:40 INFO - actual date: 1471519600 04:26:40 INFO - starting webserver on 'localhost:49512' 04:26:40 INFO - SUITE-START | Running 2 tests 04:26:40 INFO - TEST-START | dromaeo_css 04:26:40 INFO - operating with platform_type : mac_ 04:26:40 INFO - Initialising browser for dromaeo_css test... 04:26:40 INFO - TEST-INFO | started process 1953 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/tmp23zMiX/profile http://localhost:49512/getInfo.html) 04:26:43 INFO - PROCESS | 1953 | __metrics Screen width/height:1600/1200 04:26:43 INFO - PROCESS | 1953 | colorDepth:24 04:26:43 INFO - PROCESS | 1953 | Browser inner width/height: 1024/689 04:26:43 INFO - PROCESS | 1953 | __metrics 04:26:43 ERROR - PROCESS | 1953 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2983: TypeError: this.tabs is undefined 04:26:44 INFO - TEST-INFO | 1953: exit 0 04:26:44 INFO - Browser initialized. 04:26:44 INFO - Running cycle 1/1 for dromaeo_css test... 04:26:44 INFO - TEST-INFO | started process 1956 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/tmp23zMiX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:26:56 INFO - PROCESS | 1956 | RSS: Main: 239255552 04:26:56 INFO - PROCESS | 1956 | 04:27:45 INFO - PROCESS | 1956 | 1471519665941 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] 04:29:58 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:49512/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49512/tests/dromaeo/cssquery-ext.html) 04:29:59 INFO - PROCESS | 1956 | RSS: Main: 254328832 04:29:59 INFO - PROCESS | 1956 | 04:33:02 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:49512/tests/dromaeo/cssquery-ext.html (next: http://localhost:49512/tests/dromaeo/cssquery-jquery.html) 04:33:02 INFO - PROCESS | 1956 | RSS: Main: 266973184 04:33:02 INFO - PROCESS | 1956 | 04:36:04 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:49512/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49512/tests/dromaeo/cssquery-mootools.html) 04:36:05 INFO - PROCESS | 1956 | RSS: Main: 271130624 04:36:05 INFO - PROCESS | 1956 | 04:39:07 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:49512/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49512/tests/dromaeo/cssquery-prototype.html) 04:39:07 INFO - PROCESS | 1956 | RSS: Main: 270516224 04:39:07 INFO - PROCESS | 1956 | 04:42:10 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:49512/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49512/tests/dromaeo/cssquery-yui.html) 04:42:11 INFO - PROCESS | 1956 | RSS: Main: 275787776 04:42:11 INFO - PROCESS | 1956 | 04:45:14 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:49512/tests/dromaeo/cssquery-yui.html (next: http://localhost:49512/tests/dromaeo/cssquery-dojo.html) 04:45:14 INFO - PROCESS | 1956 | RSS: Main: 278274048 04:45:14 INFO - PROCESS | 1956 | 04:45:14 INFO - PROCESS | 1956 | __start_tp_report 04:45:14 INFO - PROCESS | 1956 | _x_x_mozilla_page_load 04:45:14 INFO - PROCESS | 1956 | _x_x_mozilla_page_load_details 04:45:14 INFO - PROCESS | 1956 | |i|pagename|runs| 04:45:14 INFO - PROCESS | 1956 | |0;dojo.html;3376.088456116848;3386.4243078676636;3387.441072223083;3415.3681568909747;3433.9313213735727;5627.915581266274;5665.405132461094;5667.234923285355;5718.685472299022;5738.282714660668;5671.8582035449135;5703.973284808743;5705.172749951254;5730.3123625165035;5805.12923061541;5152.948470515294;5245.501677340666;5279.63042587019;5294.073537131006;5322.281491998569;4106.650934670542;4372.8469503567385;4857.392825896763;5279.3928698199625;5362.410134885179;5131.769070391822;5183.922241166386;5184.092783762826;5190.662606930575;5252.080885845;5163.225516172567;5181.274621552986;5205.791768329263;5221.582273418117;5244.39689435716;4661.347411362412;5171.612129090296;5174.301469301634;5220.8694782630355;5228.529432351069;5479.780808767645;5716.657000579979;5742.511886489653;5789.739461724233;5807.041838096751;6195.504359651262;6238.407351301619;6239.688015599248;6242.812715618538;6255.749770009194;6121.117656725397;6145.600535965148;6220.657863817488;6247.625142491465;6273.56085074045;5771.855703607402;5849.064149736022;5864.179014937912;5891.7054147292465;5908.350081490989;6295.18162638854;6314.936850631527;6338.904916426257;6340.239171299474;6363.395477429637;6060.878782424327;6123.877522449526;6187.659678717624;6191.133241346215;6201.162843016135;6146.709191069836;6204.13142160098;6218.906716399258;6231.844203894939;6254.405831446005;6168;6193.287771906288;6206.193194884636;6214.347493513206;6223.284322302902;4597.379353787196;6113.480354169946;6216.347283535254;6247.344028876993;6268.122462855204;4987.825426110068;4988.351514303117;5031.4465408805;5036.992601479718;5085.542301192911;4400.141972315432;4418.7127836690515;4436.778161091933;4443.089166720814;4456.509783923766;5743.310802703619;5808.215890854765;5882.117682347682;5890.587658863924;5901.3508514063415;6165.8458538536;6179.660118693425;6196.969015154986;6260.937390626035;6261.405166509175;5874.970625146847;5878.3239927408895;5914.940850591439;5933.199018132497;5969.373215812364;5365.919511207335;5533.142362933751;5543.750531226105;5546.362168350692;5556.416576259516;6271.3728627136925;6275.811725648238;6322.936770632235;6419.4864410846085;6431.5819471734185;6250.531210159165;6251.9062214067735;6259.655718935503;6263.404976527223;6271.560990730605;6215.595986260879;6332.651704156316;6379.617222966637;6382.20222472191;6387.968060159669;6127.0673618518995;6138.357744607992;6175.96912015437;6225.750969961151;6228.377162283736;4380.4305440292555;5567.387587365306;6185.907211391743;6244.812655620339;6269.717862696099;5972.731227094704;6177.722002509988;6190.3190649029475;6194.442500175006;6217.626942383471;6095.603785753912;6105.41283628241;6107.097787096225;6118.479929206067;6148.938510615016;5929.377415371324;5977.3126090500145;6041.426064523863;6048.455638992512;6078.817635470943;6054.515638748801;6128.754849806136;6131.785387511416;6155;6155.6614386209185;6040;6062.605930614496;6080.331163572092;6114.084479019511;6139.890808645427 04:45:14 INFO - PROCESS | 1956 | |1;ext.html;510.3365624687905;528.2788993024521;531.9973400133001;534.348095323705;564.0974440894566;37264;40068;40142.79214643197;40211.793646190585;40288;40592.797036014854;40850.7957460213;41083;41220.38169427461;41336.37995430071;9495.857562136556;9701.757456063584;9711.562979665896;9733.124018838304;9734.464604446752;9586.23310135191;9680.56437460316;9685.176759975375;9687.515624218797;9748.512574371252;9698.951505242463;9724.902750972471;9729.951350243275;9745.02549745027;9765.511724413787;9621.759456013586;9673.75815604605;9691;9693.757656058584;9723.416595004323;8512.106228846005;9616.711498655051;9625.422474651543;9635;9668.70993870185;39217.019574510865;39442.408363874565;39702;39789;40055.19889602221;3475.5134281200653;3501.509788629594;3545.3618348697223;3653.835577398997;4022.6982976276895;31203.531947020812;31478;31649.52525712116;31689.732410703546;32605.510917336258;3291.410222103298;3291.8189499577516;3294.6870047345465;3306.553615261957;3373.7638365314438;444749;448804.75597621803;449747.7512612416;452195;453059;46556.06887862224;56088.43911560914;56403.74385024553;56785.14822277669;56933;33895.661043389744;34650.48024279638;58995.52511187255;59165.112523312186;59360.40639593635;16054.956427832154;16640.83359166393;16641.16794160287;16647.16764161787;16658.583535411468;12524.686882828002;12676;12764.361781910868;12766.68083297925;12772.361381930867;18660.440186794418;18737.90631046836;18742.625147496972;18902.716459253123;18928.242870285034;7046.43628509718;8320.417570770109;8346.499210047417;8347.707830225912;8385.119562445978;790.7864876483317;842.616609442702;875.2560323724783;936.7915389147923;968.2786324188525;29650.55524167139;29709.702902971127;29848.104556863327;30446.69553304483;30673.69326306753;1032.2774058159168;1050.5062620568474;1062.1821197677746;1078.9946050269855;1107.2360071550604;14863.851361486462;15550.688986220212;15782.92108539473;15845;15925.840741592436;707671;716466;718336;718652;718805.4059729773;50164;53768.19347709788;57086.714566427734;57424.851502970545;58109;1357.4027427931678;1373.8351397832125;1395.539471974246;1400.530822174583;1403.996142757933;26338.60492092582;29434;30043.849780751832;30411.78352865949;30451.37596466484;49725.25412118893;49829.75085124551;49869.00261994812;49979.75010124926;50135.74117682339;612949;619425;619747;620378;623278;25812.61281080823;26116;26274.86862565675;26330;26432.0748773792;46598;46664.7666761664;47854.5214547864;47881;48206;38213;38319.61680383272;38908;39641;39918.40122398225;37975.43036854504;38328;38543.614563854004;39453.40819887647;39963.20073598454;32250.35499290048;36804.81597591995;37223.81388093042;37693.4345984805;37711.81144094372;27092.864535677196;28146.71853281523;28880;31051.44742762898;33315;24373.878130609235;25684.486310274064;25885.229526038762;25944.962201511727;26353.868230658725 04:45:14 INFO - PROCESS | 1956 | |2;jquery.html;313.82269018004826;359.4697820714446;369.58606360875814;377.0667597695705;396.9678835028925;20213.696794548094;21041.684374734392;21860;21893;22101.005454754533;20237.898810505925;20389.49026274344;21082.262120825773;21170.894145529288;21424.571508569818;5340.558049326699;5950.226470558821;6087.939120608781;6147.569670123094;6164.383561643845;6110.663913484756;6115.69421528924;6179.0422484514975;6183.319834818167;6195.659238741868;5968.820935371924;6011.57918945674;6087.878242435148;6107.236595425572;6155.138280640692;6029.547783916224;6064.181335519693;6133.264008318985;6137.969310153443;6155.538334624899;5290.391604965402;5298.284731561228;5298.629095963284;5301.098813201765;5317.175837745156;25380;26391;26652.73347266522;26673.866630666722;26698.466030679472;2288.164819840746;2413.5776239158254;2424.054618698709;3075.969240307613;3152.952705709416;15463.072215667096;15596.064236145867;16081.437149699821;16330.918345408198;16364.181790910407;1801.6576850398383;1863.6459072776265;1872.26981477224;1944.7860735319105;1971.6845304751314;95795;114106;114450;115838;116168.41915790367;10406.791864162826;10814.621488247874;10826.945865270623;10884.782304353868;11062.668119956414;11369.488373023234;13506.122102063335;13559.86440135586;13567.118137321042;13639.863601363859;8412.728563287877;8634.78413039679;8659.740207793777;8749.737507874774;8774.473531588124;7285.235050319746;7752.806179845549;8745.693900713572;8764.123587641185;8963.641454341754;6508.707108180143;6606.834829129214;6611.86776264472;6624.337566243434;6728.529002969745;1607.9839201608067;1769.0358754478839;1791;1864.794872564017;1875.5967466994662;777.6500574741389;890.2166093837382;951.1487218939011;1035.8860525342207;1073.4525392049954;17601.471955841345;20738.58522829565;21590.136394544043;22263.777362226494;22640.773592263868;988.1995583577325;1000.3797645459862;1007.9798404032025;1023.4319952426326;1072.265498133781;9720.90279097214;11004.504797284142;11270.703869055;12042.277463352228;12133.33266670324;605649;606099;613816;625605;629708;118744.40627796805;121340;127035;131878.34060829825;142047;983.311681822727;1012.1801340913884;1022.3814592171777;1030.299396410448;1031.4327120083924;14342.784858226927;19064.42806715801;19975.300864469675;20225.69661455109;20250.291239806535;56000;56717.504713075985;57131.14303285371;58251.83496330134;58586.4141358598;61676.52396498303;81755;85560;86549;87647.68528471951;6630.8396030693475;7482.558686492063;7553.131389890013;7636.389088872988;7840.411969102454;11277.661670149908;12323.198992065487;12545.686357841127;12561.748765024466;12897.226166430044;10761.246712730033;11034.779304414027;11039.39283339424;11202.887971120184;11374.829377559508;10586.788264234827;10752.40861752611;10907.454627268764;10981.505832237408;11264.267822591506;10940.56237750481;11037.558497660004;11196.440177991231;11291.548338066385;11418;7650.540967541965;7743.419243556643;7843.647035883285;8025.157358477276;8275.255227029596;10425.654227798685;10879.945600271947;10999.780004399707;11098.2786118902;11176.552937882394 04:45:14 INFO - PROCESS | 1956 | |3;mootools.html;1539.207308236258;1558.9844101558986;1799.8110198429165;1872.9250829966802;1915.2721965653059;7958.32354249888;8464.449810762304;8615.35384846136;9038.457692538444;9039.367244292902;8670.609822557984;8835.293176545876;8844.027157012724;8867.068957759422;8877.51173685447;2339.1111377676502;2382.094803974487;2383.535210633927;2388.844725092872;2390.0917651292484;2356.081128359941;2381.499885024147;2390.9718820907;2394.5809483340345;2401.411654144737;2153.8599991000533;2244.674522194281;2366.325597204797;2406.278116565032;2412.975870241293;2335.0426325206586;2358.5047140100514;2367.1123328751632;2368.4907744834945;2379.547885901673;2346.6480027995767;2349.0721165139844;2358.481134150484;2373.0863617507384;2374.15717420315;8928.955355223183;8966.462012279218;8975.192232699088;8982.236509896667;8993.370464067519;5258.368995720538;5373.7581808818695;5416.729163541807;5458.5087342139;5820.505257053155;3448.7241020718284;3618.6381361863864;3631.4734363517405;3693.8522459101605;3697.611750766158;1065.6430095917876;1066.4561073852315;1075.0485820049234;1075.870895492538;1086.3101930274254;11698.941505292503;11721.472533736003;11730.589429370017;11865.169438139334;11918.046556275478;3934.567197608261;4428.778561071934;4484.820607175741;4655.5102367242835;4715.22198837188;7901.841963160705;9180.540972951325;9269.72190834276;9281.72154835356;9317.90682093184;5277.8416647500635;5278.683279003195;5284.39229488606;5293.655912365684;5304.549113325411;4433.423654924839;4783.186858234039;4926.236433352836;4944.826931057396;4969.229769385751;3783.432485127253;3846.9418860909277;3904.7461914975434;3920.8039598020555;3958.683305335624;1191.6127258640804;1204.8915597596083;1205.4093494187784;1208.848893888264;1220.9023278137727;801.9759407217792;814.1736137820118;883.8983516895511;895.5208963204655;957.2581249531669;5620.409856965041;5778.595498315078;6044;6056.121862330026;6202.2867370253;420.87584162672084;430.1590390786006;430.1933873986276;439.34976235172127;443.3438511003668;3933.1740334529495;3938.6652134568308;3960.32674445345;4064.695147863922;4064.837406503707;10542.631007914839;11055.834162487568;11062.557497700001;11074.778504430027;11201.439928003567;10903.182261330432;10972.396518191417;11007.394593297446;11036.172287078502;11066.889331106748;8297.751067467985;8346.040205376337;8351.874721879176;8390.412671112963;8413.200745929249;5225.6603320784025;5283.920741188962;5528.19841123043;5695.601307908572;5852.912206316823;10011.84863740679;10169.84745228837;10179.083882450615;10251.538680759533;10256.17950563968;9820.361676491006;10287.897121028695;10300.96990300964;10356.948215258875;10457.84313235287;6635.900461493178;7002.3697867192195;7431.516951398142;7574.772756817304;7780.144184139854;8523.573821309034;8601.096884827253;8601.870971935301;8611.224989750952;8621.180987806149;7568.886466703114;7634.4655874088285;7648.426368022309;7654.2345765423015;7719.459637825298;7437.739679111205;7492.737754178577;7536.547807131589;7590.506617069873;7671.424643151674;6909.93090069113;7048.929510704827;7049.788506344613;7068.752593659197;7087.043249161504;4398.912021759611;4411.919079825463;4437.467503899553;4797.808087676453;5029.044481548494;4105.85629502966;4313.266744653479;4753.9762301188275;4965.950340496549;5107.821226257063 04:45:14 INFO - PROCESS | 1956 | |4;prototype.html;257.42465589407675;304.61466245199813;307.2656351320345;312.1369413571477;312.85764976935496;4911.484294149108;4915.6067514598835;5312.256284120222;5621.662700237988;5685.346185188704;5470.495613706233;5562.694051827148;5576.581756368279;5590.329160500735;5628.032237272723;3580.462930560424;3762.742354587246;4121.361189015707;4133.545310015896;4249.553796851333;4015.6787457003516;4189.392538081976;4210.515790684065;4220.472440944882;4222.514410842747;4178.331466965286;4190.601892820177;4194.343234422401;4194.370844373338;4202.831886724527;3127;3697.6672099511175;3775.867844625425;3843.3466310727244;4198.244316023115;3228.497914116555;3299.851506682181;3560.4689983307167;3574.7318951078773;3577.2308953575107;4755.904881902343;5155;5268.473152684739;5408.972955135238;5429.592780541436;3777.50788438568;4206.095689426757;4526.736631684158;4531.360846938803;4777.761111944389;5277.815276465305;5809.6804675742815;5854.443827836349;5861.150133230701;5861.4724674779045;3676.3382591133586;3923.4311024901517;3934.940975885364;3937.7637341759587;3938.951745092536;5308.389535203462;5732.971335143297;6141.815745527641;6154.353792851775;6199.380061993809;3123.7188653021335;3963.742356746802;3966.2662407454136;3975.4831871856472;3999.5200575931076;3868.941965870514;4051.399697119621;4058.7564746114735;4091.713580049368;4099.651529619956;3935.3506671399473;4193.748375097504;4783.378160839138;4785.425748910153;4829.348038014893;4985.853253751658;5213.713245771519;5267.868303292448;5363.865903352447;5740.56945729072;1166.8856242288764;1175.4064197580337;1272.9434569307452;1402.3172193368;1406.507722297188;812.2851890336466;817.3747083481142;829.9585020749059;868.522312727997;872.1409411729442;4971.328870602495;5471.835844924659;5577.470140336743;5619.80330688424;5625.268715067015;5121.615878809104;6127.969360153171;6148.907766383508;6173.81478555644;6202.503799696014;5292.841214763564;5570.275864137636;5614.887702245932;5623.578231632644;5643.125315576092;2848.9715102848704;2867.913962581126;2949.2479417748336;3194.3132226570933;3209.4704373778063;5919.881602368015;6292.105631409511;6340.7463701451425;6364.809055728336;6394.4564712;5555.722093987688;6167.929166749924;6239.914469707174;6244.531660125509;6407.679616019273;5202.479752024843;6288.5598008138995;6296.937030629727;6309.716062777278;6371.904421433775;5293.153095504701;5703.429657034263;6069.51443884497;6076.32641637678;6082.300535438481;4940.975295123501;4948.950510494993;5242.97378513105;5322.361316642027;5937.435943585352;5146.588272938081;5926.851828704317;6318.62088274705;6323.525735569942;6367;3889.416587511896;3973.205358928168;4010.673809190604;4045;4054.8175332109536;5905.114232865105;6138.07928810682;6209.161763161916;6255.843603909939;6327.658766256514;4955.959248557699;5507.5593952482905;5834.928600346816;5931.733072011856;6033.637981720935;5531.363893152178;5701.6360347393575;5897.321807992136;5944.821655350346;5993.112169666541;5051.545360917535;5530.97234513841;5646.830595082154;5781.797637082682;5814.883702326015;5146.408163061295;5803.58927215311;5933.635263889243;5987.790427335022;5987.904233518234;5866.266716660418;5874.001419758566;5892.499137573354;5900.970495147497;5941.910871336847 04:45:14 INFO - PROCESS | 1956 | |5;yui.html;608.540551883328;653.4151934019056;719.3346154806802;720.1753991679527;790.9677870379153;15065.246737663114;16034;16239.51281461558;16273.023618582893;16324.673506529862;13939.163650180997;13970.860291397083;14017.649558761035;14025.929870350634;14935.701285974274;785;801.7212545989153;874.7813046738315;874.7944233105247;874.9937571792426;687.4809518813289;831.1605278668558;861.9310455163571;862.6980556805131;865.9911203447975;904.1410659873114;906.2297047509597;911.3301723233418;912.6668765900432;913.9451632902047;900.9054049324792;901.923336516397;903.421810041574;904.077840602585;904.764761162096;672.8183390484542;674.0933444517117;674.5581644023173;674.5918719174927;675.7432175773224;14797.926010369987;14945.327460264314;15023.924880375638;15068.321925513379;15112.924435377863;14619.561413157622;14658.267086645732;14729.337179826933;14796.18620975846;14950.551483455514;11876.465559049777;12073.154879158463;12244.938775306067;12260.570880019246;12409.813852792215;3878.728489005771;3880.3791393376923;4052.716309858311;4113.670906327487;4113.773742444165;110593.9999999992;113646;114422.42788786086;115453;115944.42027789807;10866.348019118877;11289.943550282196;11403.372814495116;11456.140789440826;11500.597479088192;23271.883640581687;23384.064637414653;23425.828708564502;23512.7648723514;23531.647025294635;6800.217974932946;7536.434767392468;8085.948826652498;8131;8218.096009439076;4246.023414614656;4373.540778218241;4548.795304211319;4592.954070459253;4683.976580117078;3512.964870351264;3618.511500947391;3629.8185090745355;3634.1459756957092;3636.3454578176184;555.5250261026764;609.8534754661208;642.04335540045;646.3891622416771;649.1301655781276;638.4860187548975;656.8456412743002;659.3176062775004;678.220046946016;694.4999600287784;9543.61825526985;9567.61729530825;9667;9778.853317200248;9787.755306117404;602.5209958083334;636.4717284653726;658.8385845467891;664.2460806984108;670.7048898484651;4473.8657840264195;4653.534646535387;4718.8584342469785;4749.287606858929;4754.690945088558;99536;120332;136636;144769.8284525733;154684;120828.39585802014;124286.37856810658;136158.23727593693;138503;141164;79742.60128699319;86833;116755;117186.41406792912;118352;8970.775730606787;9119.954400228222;9206.723798286062;9217.170454659114;9218.124278193562;59510;59912.70043649754;63902;65240;67959.98060029004;67515.66242168758;76335.80153091633;78352.16478352119;90417.54791226002;93960.53019735131;13422.127561708458;13461.730765384442;13505;13538.255395953318;13954.112437944468;14923.403063877324;15080.849191507945;15160.31778569989;15179.620509487351;15895.841041589436;13850.238236897067;14192.36134373935;14213;14729.852701472848;14782.48261310892;13857.4457021718;13922.303884805922;14009.08940918837;14239.430422782973;14360.425582976564;13465;13630.795538066739;13794.93102534481;14130.92934535362;14269.195881221396;11155.549778528739;11528.884711152781;11540.24988375753;11619.47712352963;11814.232074915102;8360.996680398392;9660.806783864424;10474.528646210787;11081.50133244022;11653.47559359814 04:45:14 INFO - PROCESS | 1956 | __end_tp_report 04:45:14 INFO - PROCESS | 1956 | __start_cc_report 04:45:14 INFO - PROCESS | 1956 | _x_x_mozilla_cycle_collect,407 04:45:14 INFO - PROCESS | 1956 | __end_cc_report 04:45:14 INFO - PROCESS | 1956 | __startTimestamp1471520714368__endTimestamp 04:45:14 INFO - PROCESS | 1956 | 04:45:14 INFO - PROCESS | 1956 | ------- Summary: start ------- 04:45:14 INFO - PROCESS | 1956 | Number of tests: 6 04:45:14 INFO - PROCESS | 1956 | 04:45:14 INFO - PROCESS | 1956 | [#0] dojo.html Cycles:165 Average:5739.78 Median:6041.43 stddev:670.63 (11.1%) stddev-sans-first:646.54 04:45:14 INFO - PROCESS | 1956 | Values: 3376.1 3386.4 3387.4 3415.4 3433.9 5627.9 5665.4 5667.2 5718.7 5738.3 5671.9 5704.0 5705.2 5730.3 5805.1 5152.9 5245.5 5279.6 5294.1 5322.3 4106.7 4372.8 4857.4 5279.4 5362.4 5131.8 5183.9 5184.1 5190.7 5252.1 5163.2 5181.3 5205.8 5221.6 5244.4 4661.3 5171.6 5174.3 5220.9 5228.5 5479.8 5716.7 5742.5 5789.7 5807.0 6195.5 6238.4 6239.7 6242.8 6255.7 6121.1 6145.6 6220.7 6247.6 6273.6 5771.9 5849.1 5864.2 5891.7 5908.4 6295.2 6314.9 6338.9 6340.2 6363.4 6060.9 6123.9 6187.7 6191.1 6201.2 6146.7 6204.1 6218.9 6231.8 6254.4 6168.0 6193.3 6206.2 6214.3 6223.3 4597.4 6113.5 6216.3 6247.3 6268.1 4987.8 4988.4 5031.4 5037.0 5085.5 4400.1 4418.7 4436.8 4443.1 4456.5 5743.3 5808.2 5882.1 5890.6 5901.4 6165.8 6179.7 6197.0 6260.9 6261.4 5875.0 5878.3 5914.9 5933.2 5969.4 5365.9 5533.1 5543.8 5546.4 5556.4 6271.4 6275.8 6322.9 6419.5 6431.6 6250.5 6251.9 6259.7 6263.4 6271.6 6215.6 6332.7 6379.6 6382.2 6388.0 6127.1 6138.4 6176.0 6225.8 6228.4 4380.4 5567.4 6185.9 6244.8 6269.7 5972.7 6177.7 6190.3 6194.4 6217.6 6095.6 6105.4 6107.1 6118.5 6148.9 5929.4 5977.3 6041.4 6048.5 6078.8 6054.5 6128.8 6131.8 6155.0 6155.7 6040.0 6062.6 6080.3 6114.1 6139.9 04:45:14 INFO - PROCESS | 1956 | 04:45:14 INFO - PROCESS | 1956 | [#1] ext.html Cycles:180 Average:71641.44 Median:40009.20 stddev:162267.87 (405.6%) stddev-sans-first:162635.19 04:45:14 INFO - PROCESS | 1956 | Values: 510.3 528.3 532.0 534.3 564.1 37264.0 40068.0 40142.8 40211.8 40288.0 40592.8 40850.8 41083.0 41220.4 41336.4 9495.9 9701.8 9711.6 9733.1 9734.5 9586.2 9680.6 9685.2 9687.5 9748.5 9699.0 9724.9 9730.0 9745.0 9765.5 9621.8 9673.8 9691.0 9693.8 9723.4 8512.1 9616.7 9625.4 9635.0 9668.7 39217.0 39442.4 39702.0 39789.0 40055.2 3475.5 3501.5 3545.4 3653.8 4022.7 31203.5 31478.0 31649.5 31689.7 32605.5 3291.4 3291.8 3294.7 3306.6 3373.8 444749.0 448804.8 449747.8 452195.0 453059.0 46556.1 56088.4 56403.7 56785.1 56933.0 33895.7 34650.5 58995.5 59165.1 59360.4 16055.0 16640.8 16641.2 16647.2 16658.6 12524.7 12676.0 12764.4 12766.7 12772.4 18660.4 18737.9 18742.6 18902.7 18928.2 7046.4 8320.4 8346.5 8347.7 8385.1 790.8 842.6 875.3 936.8 968.3 29650.6 29709.7 29848.1 30446.7 30673.7 1032.3 1050.5 1062.2 1079.0 1107.2 14863.9 15550.7 15782.9 15845.0 15925.8 707671.0 716466.0 718336.0 718652.0 718805.4 50164.0 53768.2 57086.7 57424.9 58109.0 1357.4 1373.8 1395.5 1400.5 1404.0 26338.6 29434.0 30043.8 30411.8 30451.4 49725.3 49829.8 49869.0 49979.8 50135.7 612949.0 619425.0 619747.0 620378.0 623278.0 25812.6 26116.0 26274.9 26330.0 26432.1 46598.0 46664.8 47854.5 47881.0 48206.0 38213.0 38319.6 38908.0 39641.0 39918.4 37975.4 38328.0 38543.6 39453.4 39963.2 32250.4 36804.8 37223.8 37693.4 37711.8 27092.9 28146.7 28880.0 31051.4 33315.0 24373.9 25684.5 25885.2 25945.0 26353.9 04:45:14 INFO - PROCESS | 1956 | 04:45:14 INFO - PROCESS | 1956 | [#2] jquery.html Cycles:180 Average:35769.17 Median:22182.39 stddev:102584.17 (462.5%) stddev-sans-first:102837.40 04:45:14 INFO - PROCESS | 1956 | Values: 313.8 359.5 369.6 377.1 397.0 20213.7 21041.7 21860.0 21893.0 22101.0 20237.9 20389.5 21082.3 21170.9 21424.6 5340.6 5950.2 6087.9 6147.6 6164.4 6110.7 6115.7 6179.0 6183.3 6195.7 5968.8 6011.6 6087.9 6107.2 6155.1 6029.5 6064.2 6133.3 6138.0 6155.5 5290.4 5298.3 5298.6 5301.1 5317.2 25380.0 26391.0 26652.7 26673.9 26698.5 2288.2 2413.6 2424.1 3076.0 3153.0 15463.1 15596.1 16081.4 16330.9 16364.2 1801.7 1863.6 1872.3 1944.8 1971.7 95795.0 114106.0 114450.0 115838.0 116168.4 10406.8 10814.6 10826.9 10884.8 11062.7 11369.5 13506.1 13559.9 13567.1 13639.9 8412.7 8634.8 8659.7 8749.7 8774.5 7285.2 7752.8 8745.7 8764.1 8963.6 6508.7 6606.8 6611.9 6624.3 6728.5 1608.0 1769.0 1791.0 1864.8 1875.6 777.7 890.2 951.1 1035.9 1073.5 17601.5 20738.6 21590.1 22263.8 22640.8 988.2 1000.4 1008.0 1023.4 1072.3 9720.9 11004.5 11270.7 12042.3 12133.3 605649.0 606099.0 613816.0 625605.0 629708.0 118744.4 121340.0 127035.0 131878.3 142047.0 983.3 1012.2 1022.4 1030.3 1031.4 14342.8 19064.4 19975.3 20225.7 20250.3 56000.0 56717.5 57131.1 58251.8 58586.4 61676.5 81755.0 85560.0 86549.0 87647.7 6630.8 7482.6 7553.1 7636.4 7840.4 11277.7 12323.2 12545.7 12561.7 12897.2 10761.2 11034.8 11039.4 11202.9 11374.8 10586.8 10752.4 10907.5 10981.5 11264.3 10940.6 11037.6 11196.4 11291.5 11418.0 7650.5 7743.4 7843.6 8025.2 8275.3 10425.7 10879.9 10999.8 11098.3 11176.6 04:45:14 INFO - PROCESS | 1956 | 04:45:14 INFO - PROCESS | 1956 | [#3] mootools.html Cycles:180 Average:5705.48 Median:4435.45 stddev:3263.94 (73.6%) stddev-sans-first:3258.09 04:45:14 INFO - PROCESS | 1956 | Values: 1539.2 1559.0 1799.8 1872.9 1915.3 7958.3 8464.4 8615.4 9038.5 9039.4 8670.6 8835.3 8844.0 8867.1 8877.5 2339.1 2382.1 2383.5 2388.8 2390.1 2356.1 2381.5 2391.0 2394.6 2401.4 2153.9 2244.7 2366.3 2406.3 2413.0 2335.0 2358.5 2367.1 2368.5 2379.5 2346.6 2349.1 2358.5 2373.1 2374.2 8929.0 8966.5 8975.2 8982.2 8993.4 5258.4 5373.8 5416.7 5458.5 5820.5 3448.7 3618.6 3631.5 3693.9 3697.6 1065.6 1066.5 1075.0 1075.9 1086.3 11698.9 11721.5 11730.6 11865.2 11918.0 3934.6 4428.8 4484.8 4655.5 4715.2 7901.8 9180.5 9269.7 9281.7 9317.9 5277.8 5278.7 5284.4 5293.7 5304.5 4433.4 4783.2 4926.2 4944.8 4969.2 3783.4 3846.9 3904.7 3920.8 3958.7 1191.6 1204.9 1205.4 1208.8 1220.9 802.0 814.2 883.9 895.5 957.3 5620.4 5778.6 6044.0 6056.1 6202.3 420.9 430.2 430.2 439.3 443.3 3933.2 3938.7 3960.3 4064.7 4064.8 10542.6 11055.8 11062.6 11074.8 11201.4 10903.2 10972.4 11007.4 11036.2 11066.9 8297.8 8346.0 8351.9 8390.4 8413.2 5225.7 5283.9 5528.2 5695.6 5852.9 10011.8 10169.8 10179.1 10251.5 10256.2 9820.4 10287.9 10301.0 10356.9 10457.8 6635.9 7002.4 7431.5 7574.8 7780.1 8523.6 8601.1 8601.9 8611.2 8621.2 7568.9 7634.5 7648.4 7654.2 7719.5 7437.7 7492.7 7536.5 7590.5 7671.4 6909.9 7048.9 7049.8 7068.8 7087.0 4398.9 4411.9 4437.5 4797.8 5029.0 4105.9 4313.3 4754.0 4966.0 5107.8 04:45:14 INFO - PROCESS | 1956 | 04:45:14 INFO - PROCESS | 1956 | [#4] prototype.html Cycles:180 Average:4721.92 Median:5300.77 stddev:1512.26 (28.5%) stddev-sans-first:1478.91 04:45:14 INFO - PROCESS | 1956 | Values: 257.4 304.6 307.3 312.1 312.9 4911.5 4915.6 5312.3 5621.7 5685.3 5470.5 5562.7 5576.6 5590.3 5628.0 3580.5 3762.7 4121.4 4133.5 4249.6 4015.7 4189.4 4210.5 4220.5 4222.5 4178.3 4190.6 4194.3 4194.4 4202.8 3127.0 3697.7 3775.9 3843.3 4198.2 3228.5 3299.9 3560.5 3574.7 3577.2 4755.9 5155.0 5268.5 5409.0 5429.6 3777.5 4206.1 4526.7 4531.4 4777.8 5277.8 5809.7 5854.4 5861.2 5861.5 3676.3 3923.4 3934.9 3937.8 3939.0 5308.4 5733.0 6141.8 6154.4 6199.4 3123.7 3963.7 3966.3 3975.5 3999.5 3868.9 4051.4 4058.8 4091.7 4099.7 3935.4 4193.7 4783.4 4785.4 4829.3 4985.9 5213.7 5267.9 5363.9 5740.6 1166.9 1175.4 1272.9 1402.3 1406.5 812.3 817.4 830.0 868.5 872.1 4971.3 5471.8 5577.5 5619.8 5625.3 5121.6 6128.0 6148.9 6173.8 6202.5 5292.8 5570.3 5614.9 5623.6 5643.1 2849.0 2867.9 2949.2 3194.3 3209.5 5919.9 6292.1 6340.7 6364.8 6394.5 5555.7 6167.9 6239.9 6244.5 6407.7 5202.5 6288.6 6296.9 6309.7 6371.9 5293.2 5703.4 6069.5 6076.3 6082.3 4941.0 4949.0 5243.0 5322.4 5937.4 5146.6 5926.9 6318.6 6323.5 6367.0 3889.4 3973.2 4010.7 4045.0 4054.8 5905.1 6138.1 6209.2 6255.8 6327.7 4956.0 5507.6 5834.9 5931.7 6033.6 5531.4 5701.6 5897.3 5944.8 5993.1 5051.5 5531.0 5646.8 5781.8 5814.9 5146.4 5803.6 5933.6 5987.8 5987.9 5866.3 5874.0 5892.5 5901.0 5941.9 04:45:14 INFO - PROCESS | 1956 | 04:45:14 INFO - PROCESS | 1956 | [#5] yui.html Cycles:180 Average:24322.52 Median:3879.55 stddev:38075.65 (981.4%) stddev-sans-first:38140.83 04:45:14 INFO - PROCESS | 1956 | Values: 608.5 653.4 719.3 720.2 791.0 15065.2 16034.0 16239.5 16273.0 16324.7 13939.2 13970.9 14017.6 14025.9 14935.7 785.0 801.7 874.8 874.8 875.0 687.5 831.2 861.9 862.7 866.0 904.1 906.2 911.3 912.7 913.9 900.9 901.9 903.4 904.1 904.8 672.8 674.1 674.6 674.6 675.7 14797.9 14945.3 15023.9 15068.3 15112.9 14619.6 14658.3 14729.3 14796.2 14950.6 11876.5 12073.2 12244.9 12260.6 12409.8 3878.7 3880.4 4052.7 4113.7 4113.8 110594.0 113646.0 114422.4 115453.0 115944.4 10866.3 11289.9 11403.4 11456.1 11500.6 23271.9 23384.1 23425.8 23512.8 23531.6 6800.2 7536.4 8085.9 8131.0 8218.1 4246.0 4373.5 4548.8 4593.0 4684.0 3513.0 3618.5 3629.8 3634.1 3636.3 555.5 609.9 642.0 646.4 649.1 638.5 656.8 659.3 678.2 694.5 9543.6 9567.6 9667.0 9778.9 9787.8 602.5 636.5 658.8 664.2 670.7 4473.9 4653.5 4718.9 4749.3 4754.7 99536.0 120332.0 136636.0 144769.8 154684.0 120828.4 124286.4 136158.2 138503.0 141164.0 79742.6 86833.0 116755.0 117186.4 118352.0 8970.8 9120.0 9206.7 9217.2 9218.1 59510.0 59912.7 63902.0 65240.0 67960.0 67515.7 76335.8 78352.2 90417.5 93960.5 13422.1 13461.7 13505.0 13538.3 13954.1 14923.4 15080.8 15160.3 15179.6 15895.8 13850.2 14192.4 14213.0 14729.9 14782.5 13857.4 13922.3 14009.1 14239.4 14360.4 13465.0 13630.8 13794.9 14130.9 14269.2 11155.5 11528.9 11540.2 11619.5 11814.2 8361.0 9660.8 10474.5 11081.5 11653.5 04:45:14 INFO - PROCESS | 1956 | -------- Summary: end -------- 04:45:14 INFO - PROCESS | 1956 | 04:45:14 INFO - TEST-INFO | 1956: exit 0 04:45:14 INFO - TEST-OK | dromaeo_css | took 1114346ms 04:45:14 INFO - TEST-START | kraken 04:45:14 INFO - operating with platform_type : mac_ 04:45:14 INFO - Initialising browser for kraken test... 04:45:14 INFO - TEST-INFO | started process 1962 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/tmpVM9I6f/profile http://localhost:49512/getInfo.html) 04:45:17 INFO - PROCESS | 1962 | __metrics Screen width/height:1600/1200 04:45:17 INFO - PROCESS | 1962 | colorDepth:24 04:45:17 INFO - PROCESS | 1962 | Browser inner width/height: 1024/689 04:45:17 INFO - PROCESS | 1962 | __metrics 04:45:17 ERROR - PROCESS | 1962 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2983: TypeError: this.tabs is undefined 04:45:18 INFO - TEST-INFO | 1962: exit 0 04:45:18 INFO - Browser initialized. 04:45:18 INFO - Running cycle 1/1 for kraken test... 04:45:18 INFO - TEST-INFO | started process 1964 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/tmpVM9I6f/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:45:30 INFO - PROCESS | 1964 | RSS: Main: 239136768 04:45:30 INFO - PROCESS | 1964 | 04:45:33 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:49512/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49512/tests/kraken/driver.html?testName=audio-beat-detection) 04:45:34 INFO - PROCESS | 1964 | RSS: Main: 252063744 04:45:34 INFO - PROCESS | 1964 | 04:45:37 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:49512/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49512/tests/kraken/driver.html?testName=audio-dft) 04:45:37 INFO - PROCESS | 1964 | RSS: Main: 260714496 04:45:37 INFO - PROCESS | 1964 | 04:45:41 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:49512/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49512/tests/kraken/driver.html?testName=audio-fft) 04:45:42 INFO - PROCESS | 1964 | RSS: Main: 263790592 04:45:42 INFO - PROCESS | 1964 | 04:45:44 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:49512/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49512/tests/kraken/driver.html?testName=audio-oscillator) 04:45:44 INFO - PROCESS | 1964 | RSS: Main: 266182656 04:45:44 INFO - PROCESS | 1964 | 04:45:46 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:49512/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49512/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:45:47 INFO - PROCESS | 1964 | RSS: Main: 266862592 04:45:47 INFO - PROCESS | 1964 | 04:45:50 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:49512/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49512/tests/kraken/driver.html?testName=imaging-darkroom) 04:45:50 INFO - PROCESS | 1964 | RSS: Main: 266977280 04:45:50 INFO - PROCESS | 1964 | 04:45:53 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:49512/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49512/tests/kraken/driver.html?testName=imaging-desaturate) 04:45:54 INFO - PROCESS | 1964 | RSS: Main: 267005952 04:45:54 INFO - PROCESS | 1964 | 04:45:57 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:49512/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49512/tests/kraken/driver.html?testName=json-parse-financial) 04:45:58 INFO - PROCESS | 1964 | RSS: Main: 267137024 04:45:58 INFO - PROCESS | 1964 | 04:45:59 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:49512/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49512/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:46:00 INFO - PROCESS | 1964 | RSS: Main: 267018240 04:46:00 INFO - PROCESS | 1964 | 04:46:02 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:49512/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49512/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:46:03 INFO - PROCESS | 1964 | RSS: Main: 267042816 04:46:03 INFO - PROCESS | 1964 | 04:46:05 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:49512/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49512/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:46:06 INFO - PROCESS | 1964 | RSS: Main: 267108352 04:46:06 INFO - PROCESS | 1964 | 04:46:08 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:49512/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49512/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:46:09 INFO - PROCESS | 1964 | RSS: Main: 267255808 04:46:09 INFO - PROCESS | 1964 | 04:46:12 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:49512/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49512/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:46:13 INFO - PROCESS | 1964 | RSS: Main: 267292672 04:46:13 INFO - PROCESS | 1964 | 04:46:14 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:49512/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49512/tests/kraken/driver.html?testName=ai-astar) 04:46:15 INFO - PROCESS | 1964 | RSS: Main: 268333056 04:46:15 INFO - PROCESS | 1964 | 04:46:15 INFO - PROCESS | 1964 | __start_tp_report 04:46:15 INFO - PROCESS | 1964 | _x_x_mozilla_page_load 04:46:15 INFO - PROCESS | 1964 | _x_x_mozilla_page_load_details 04:46:15 INFO - PROCESS | 1964 | |i|pagename|runs| 04:46:15 INFO - PROCESS | 1964 | |0;ai-astar;106;118;106;111;116;119;121;119;118;117 04:46:15 INFO - PROCESS | 1964 | |1;audio-beat-detection;147;111;140;166;121;160;155;111;158;105 04:46:15 INFO - PROCESS | 1964 | |2;audio-dft;271;230;273;239;184;253;277;237;191;219 04:46:15 INFO - PROCESS | 1964 | |3;audio-fft;71;83;76;146;59;61;59;62;145;61 04:46:15 INFO - PROCESS | 1964 | |4;audio-oscillator;69;73;136;98;103;124;114;71;74;104 04:46:15 INFO - PROCESS | 1964 | |5;imaging-gaussian-blur;116;130;89;86;88;87;91;88;91;87 04:46:15 INFO - PROCESS | 1964 | |6;imaging-darkroom;150;138;97;116;121;96;97;97;97;117 04:46:15 INFO - PROCESS | 1964 | |7;imaging-desaturate;97;130;94;102;82;152;156;95;97;105 04:46:15 INFO - PROCESS | 1964 | |8;json-parse-financial;57;57;60;58;58;77;85;85;81;61 04:46:15 INFO - PROCESS | 1964 | |9;json-stringify-tinderbox;65;70;66;87;78;74;68;72;70;70 04:46:15 INFO - PROCESS | 1964 | |10;stanford-crypto-aes;91;101;101;85;87;88;86;89;91;88 04:46:15 INFO - PROCESS | 1964 | |11;stanford-crypto-ccm;145;160;140;163;159;137;146;143;155;164 04:46:15 INFO - PROCESS | 1964 | |12;stanford-crypto-pbkdf2;177;176;176;174;176;177;175;176;172;173 04:46:15 INFO - PROCESS | 1964 | |13;stanford-crypto-sha256-iterative;70;69;73;92;88;87;69;68;71;70 04:46:15 INFO - PROCESS | 1964 | __end_tp_report 04:46:15 INFO - PROCESS | 1964 | __start_cc_report 04:46:15 INFO - PROCESS | 1964 | _x_x_mozilla_cycle_collect,1042 04:46:15 INFO - PROCESS | 1964 | __end_cc_report 04:46:15 INFO - PROCESS | 1964 | __startTimestamp1471520775200__endTimestamp 04:46:15 INFO - PROCESS | 1964 | 04:46:15 INFO - PROCESS | 1964 | ------- Summary: start ------- 04:46:15 INFO - PROCESS | 1964 | Number of tests: 14 04:46:15 INFO - PROCESS | 1964 | 04:46:15 INFO - PROCESS | 1964 | [#0] ai-astar Cycles:10 Average:115.10 Median:118.00 stddev:5.47 (4.6%) stddev-sans-first:4.70 04:46:15 INFO - PROCESS | 1964 | Values: 106.0 118.0 106.0 111.0 116.0 119.0 121.0 119.0 118.0 117.0 04:46:15 INFO - PROCESS | 1964 | 04:46:15 INFO - PROCESS | 1964 | [#1] audio-beat-detection Cycles:10 Average:137.40 Median:151.00 stddev:23.27 (15.4%) stddev-sans-first:24.42 04:46:15 INFO - PROCESS | 1964 | Values: 147.0 111.0 140.0 166.0 121.0 160.0 155.0 111.0 158.0 105.0 04:46:15 INFO - PROCESS | 1964 | 04:46:15 INFO - PROCESS | 1964 | [#2] audio-dft Cycles:10 Average:237.40 Median:246.00 stddev:32.67 (13.3%) stddev-sans-first:32.31 04:46:15 INFO - PROCESS | 1964 | Values: 271.0 230.0 273.0 239.0 184.0 253.0 277.0 237.0 191.0 219.0 04:46:15 INFO - PROCESS | 1964 | 04:46:15 INFO - PROCESS | 1964 | [#3] audio-fft Cycles:10 Average:82.30 Median:61.50 stddev:34.26 (55.7%) stddev-sans-first:36.09 04:46:15 INFO - PROCESS | 1964 | Values: 71.0 83.0 76.0 146.0 59.0 61.0 59.0 62.0 145.0 61.0 04:46:15 INFO - PROCESS | 1964 | 04:46:15 INFO - PROCESS | 1964 | [#4] audio-oscillator Cycles:10 Average:96.60 Median:70.00 stddev:24.01 (34.3%) stddev-sans-first:23.30 04:46:15 INFO - PROCESS | 1964 | Values: 69.0 73.0 136.0 98.0 103.0 124.0 114.0 71.0 74.0 104.0 04:46:15 INFO - PROCESS | 1964 | 04:46:15 INFO - PROCESS | 1964 | [#5] imaging-gaussian-blur Cycles:10 Average:95.30 Median:88.00 stddev:15.06 (17.1%) stddev-sans-first:13.98 04:46:15 INFO - PROCESS | 1964 | Values: 116.0 130.0 89.0 86.0 88.0 87.0 91.0 88.0 91.0 87.0 04:46:15 INFO - PROCESS | 1964 | 04:46:15 INFO - PROCESS | 1964 | [#6] imaging-darkroom Cycles:10 Average:112.60 Median:96.50 stddev:19.42 (20.1%) stddev-sans-first:15.17 04:46:15 INFO - PROCESS | 1964 | Values: 150.0 138.0 97.0 116.0 121.0 96.0 97.0 97.0 97.0 117.0 04:46:15 INFO - PROCESS | 1964 | 04:46:15 INFO - PROCESS | 1964 | [#7] imaging-desaturate Cycles:10 Average:111.00 Median:88.00 stddev:25.74 (29.2%) stddev-sans-first:26.80 04:46:15 INFO - PROCESS | 1964 | Values: 97.0 130.0 94.0 102.0 82.0 152.0 156.0 95.0 97.0 105.0 04:46:15 INFO - PROCESS | 1964 | 04:46:15 INFO - PROCESS | 1964 | [#8] json-parse-financial Cycles:10 Average:67.90 Median:69.00 stddev:12.40 (18.0%) stddev-sans-first:12.50 04:46:15 INFO - PROCESS | 1964 | Values: 57.0 57.0 60.0 58.0 58.0 77.0 85.0 85.0 81.0 61.0 04:46:15 INFO - PROCESS | 1964 | 04:46:15 INFO - PROCESS | 1964 | [#9] json-stringify-tinderbox Cycles:10 Average:72.00 Median:71.00 stddev:6.48 (9.1%) stddev-sans-first:6.36 04:46:15 INFO - PROCESS | 1964 | Values: 65.0 70.0 66.0 87.0 78.0 74.0 68.0 72.0 70.0 70.0 04:46:15 INFO - PROCESS | 1964 | 04:46:15 INFO - PROCESS | 1964 | [#10] stanford-crypto-aes Cycles:10 Average:90.70 Median:88.00 stddev:5.76 (6.5%) stddev-sans-first:6.10 04:46:15 INFO - PROCESS | 1964 | Values: 91.0 101.0 101.0 85.0 87.0 88.0 86.0 89.0 91.0 88.0 04:46:15 INFO - PROCESS | 1964 | 04:46:15 INFO - PROCESS | 1964 | [#11] stanford-crypto-ccm Cycles:10 Average:151.20 Median:157.00 stddev:10.09 (6.4%) stddev-sans-first:10.45 04:46:15 INFO - PROCESS | 1964 | Values: 145.0 160.0 140.0 163.0 159.0 137.0 146.0 143.0 155.0 164.0 04:46:15 INFO - PROCESS | 1964 | 04:46:15 INFO - PROCESS | 1964 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.20 Median:176.00 stddev:1.69 (1.0%) stddev-sans-first:1.66 04:46:15 INFO - PROCESS | 1964 | Values: 177.0 176.0 176.0 174.0 176.0 177.0 175.0 176.0 172.0 173.0 04:46:15 INFO - PROCESS | 1964 | 04:46:15 INFO - PROCESS | 1964 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.70 Median:72.00 stddev:9.36 (13.0%) stddev-sans-first:9.70 04:46:15 INFO - PROCESS | 1964 | Values: 70.0 69.0 73.0 92.0 88.0 87.0 69.0 68.0 71.0 70.0 04:46:15 INFO - PROCESS | 1964 | -------- Summary: end -------- 04:46:15 INFO - PROCESS | 1964 | 04:46:15 INFO - TEST-INFO | 1964: exit 0 04:46:16 INFO - TEST-OK | kraken | took 61055ms 04:46:16 INFO - SUITE-END | took 1175s 04:46:16 INFO - Completed test suite (00:19:35) 04:46:16 INFO - javascript benchmark 04:46:16 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7409.903363312159, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3376.088456116848, 3386.4243078676636, 3387.441072223083, 3415.3681568909747, 3433.9313213735727, 5627.915581266274, 5665.405132461094, 5667.234923285355, 5718.685472299022, 5738.282714660668, 5671.8582035449135, 5703.973284808743, 5705.172749951254, 5730.3123625165035, 5805.12923061541, 5152.948470515294, 5245.501677340666, 5279.63042587019, 5294.073537131006, 5322.281491998569, 4106.650934670542, 4372.8469503567385, 4857.392825896763, 5279.3928698199625, 5362.410134885179, 5131.769070391822, 5183.922241166386, 5184.092783762826, 5190.662606930575, 5252.080885845, 5163.225516172567, 5181.274621552986, 5205.791768329263, 5221.582273418117, 5244.39689435716, 4661.347411362412, 5171.612129090296, 5174.301469301634, 5220.8694782630355, 5228.529432351069, 5479.780808767645, 5716.657000579979, 5742.511886489653, 5789.739461724233, 5807.041838096751, 6195.504359651262, 6238.407351301619, 6239.688015599248, 6242.812715618538, 6255.749770009194, 6121.117656725397, 6145.600535965148, 6220.657863817488, 6247.625142491465, 6273.56085074045, 5771.855703607402, 5849.064149736022, 5864.179014937912, 5891.7054147292465, 5908.350081490989, 6295.18162638854, 6314.936850631527, 6338.904916426257, 6340.239171299474, 6363.395477429637, 6060.878782424327, 6123.877522449526, 6187.659678717624, 6191.133241346215, 6201.162843016135, 6146.709191069836, 6204.13142160098, 6218.906716399258, 6231.844203894939, 6254.405831446005, 6168.0, 6193.287771906288, 6206.193194884636, 6214.347493513206, 6223.284322302902, 4597.379353787196, 6113.480354169946, 6216.347283535254, 6247.344028876993, 6268.122462855204, 4987.825426110068, 4988.351514303117, 5031.4465408805, 5036.992601479718, 5085.542301192911, 4400.141972315432, 4418.7127836690515, 4436.778161091933, 4443.089166720814, 4456.509783923766, 5743.310802703619, 5808.215890854765, 5882.117682347682, 5890.587658863924, 5901.3508514063415, 6165.8458538536, 6179.660118693425, 6196.969015154986, 6260.937390626035, 6261.405166509175, 5874.970625146847, 5878.3239927408895, 5914.940850591439, 5933.199018132497, 5969.373215812364, 5365.919511207335, 5533.142362933751, 5543.750531226105, 5546.362168350692, 5556.416576259516, 6271.3728627136925, 6275.811725648238, 6322.936770632235, 6419.4864410846085, 6431.5819471734185, 6250.531210159165, 6251.9062214067735, 6259.655718935503, 6263.404976527223, 6271.560990730605, 6215.595986260879, 6332.651704156316, 6379.617222966637, 6382.20222472191, 6387.968060159669, 6127.0673618518995, 6138.357744607992, 6175.96912015437, 6225.750969961151, 6228.377162283736, 4380.4305440292555, 5567.387587365306, 6185.907211391743, 6244.812655620339, 6269.717862696099, 5972.731227094704, 6177.722002509988, 6190.3190649029475, 6194.442500175006, 6217.626942383471, 6095.603785753912, 6105.41283628241, 6107.097787096225, 6118.479929206067, 6148.938510615016, 5929.377415371324, 5977.3126090500145, 6041.426064523863, 6048.455638992512, 6078.817635470943, 6054.515638748801, 6128.754849806136, 6131.785387511416, 6155.0, 6155.6614386209185, 6040.0, 6062.605930614496, 6080.331163572092, 6114.084479019511, 6139.890808645427], "value": 5697.726085588947, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [510.3365624687905, 528.2788993024521, 531.9973400133001, 534.348095323705, 564.0974440894566, 37264.0, 40068.0, 40142.79214643197, 40211.793646190585, 40288.0, 40592.797036014854, 40850.7957460213, 41083.0, 41220.38169427461, 41336.37995430071, 9495.857562136556, 9701.757456063584, 9711.562979665896, 9733.124018838304, 9734.464604446752, 9586.23310135191, 9680.56437460316, 9685.176759975375, 9687.515624218797, 9748.512574371252, 9698.951505242463, 9724.902750972471, 9729.951350243275, 9745.02549745027, 9765.511724413787, 9621.759456013586, 9673.75815604605, 9691.0, 9693.757656058584, 9723.416595004323, 8512.106228846005, 9616.711498655051, 9625.422474651543, 9635.0, 9668.70993870185, 39217.019574510865, 39442.408363874565, 39702.0, 39789.0, 40055.19889602221, 3475.5134281200653, 3501.509788629594, 3545.3618348697223, 3653.835577398997, 4022.6982976276895, 31203.531947020812, 31478.0, 31649.52525712116, 31689.732410703546, 32605.510917336258, 3291.410222103298, 3291.8189499577516, 3294.6870047345465, 3306.553615261957, 3373.7638365314438, 444749.0, 448804.75597621803, 449747.7512612416, 452195.0, 453059.0, 46556.06887862224, 56088.43911560914, 56403.74385024553, 56785.14822277669, 56933.0, 33895.661043389744, 34650.48024279638, 58995.52511187255, 59165.112523312186, 59360.40639593635, 16054.956427832154, 16640.83359166393, 16641.16794160287, 16647.16764161787, 16658.583535411468, 12524.686882828002, 12676.0, 12764.361781910868, 12766.68083297925, 12772.361381930867, 18660.440186794418, 18737.90631046836, 18742.625147496972, 18902.716459253123, 18928.242870285034, 7046.43628509718, 8320.417570770109, 8346.499210047417, 8347.707830225912, 8385.119562445978, 790.7864876483317, 842.616609442702, 875.2560323724783, 936.7915389147923, 968.2786324188525, 29650.55524167139, 29709.702902971127, 29848.104556863327, 30446.69553304483, 30673.69326306753, 1032.2774058159168, 1050.5062620568474, 1062.1821197677746, 1078.9946050269855, 1107.2360071550604, 14863.851361486462, 15550.688986220212, 15782.92108539473, 15845.0, 15925.840741592436, 707671.0, 716466.0, 718336.0, 718652.0, 718805.4059729773, 50164.0, 53768.19347709788, 57086.714566427734, 57424.851502970545, 58109.0, 1357.4027427931678, 1373.8351397832125, 1395.539471974246, 1400.530822174583, 1403.996142757933, 26338.60492092582, 29434.0, 30043.849780751832, 30411.78352865949, 30451.37596466484, 49725.25412118893, 49829.75085124551, 49869.00261994812, 49979.75010124926, 50135.74117682339, 612949.0, 619425.0, 619747.0, 620378.0, 623278.0, 25812.61281080823, 26116.0, 26274.86862565675, 26330.0, 26432.0748773792, 46598.0, 46664.7666761664, 47854.5214547864, 47881.0, 48206.0, 38213.0, 38319.61680383272, 38908.0, 39641.0, 39918.40122398225, 37975.43036854504, 38328.0, 38543.614563854004, 39453.40819887647, 39963.20073598454, 32250.35499290048, 36804.81597591995, 37223.81388093042, 37693.4345984805, 37711.81144094372, 27092.864535677196, 28146.71853281523, 28880.0, 31051.44742762898, 33315.0, 24373.878130609235, 25684.486310274064, 25885.229526038762, 25944.962201511727, 26353.868230658725], "value": 19805.65512496599, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [313.82269018004826, 359.4697820714446, 369.58606360875814, 377.0667597695705, 396.9678835028925, 20213.696794548094, 21041.684374734392, 21860.0, 21893.0, 22101.005454754533, 20237.898810505925, 20389.49026274344, 21082.262120825773, 21170.894145529288, 21424.571508569818, 5340.558049326699, 5950.226470558821, 6087.939120608781, 6147.569670123094, 6164.383561643845, 6110.663913484756, 6115.69421528924, 6179.0422484514975, 6183.319834818167, 6195.659238741868, 5968.820935371924, 6011.57918945674, 6087.878242435148, 6107.236595425572, 6155.138280640692, 6029.547783916224, 6064.181335519693, 6133.264008318985, 6137.969310153443, 6155.538334624899, 5290.391604965402, 5298.284731561228, 5298.629095963284, 5301.098813201765, 5317.175837745156, 25380.0, 26391.0, 26652.73347266522, 26673.866630666722, 26698.466030679472, 2288.164819840746, 2413.5776239158254, 2424.054618698709, 3075.969240307613, 3152.952705709416, 15463.072215667096, 15596.064236145867, 16081.437149699821, 16330.918345408198, 16364.181790910407, 1801.6576850398383, 1863.6459072776265, 1872.26981477224, 1944.7860735319105, 1971.6845304751314, 95795.0, 114106.0, 114450.0, 115838.0, 116168.41915790367, 10406.791864162826, 10814.621488247874, 10826.945865270623, 10884.782304353868, 11062.668119956414, 11369.488373023234, 13506.122102063335, 13559.86440135586, 13567.118137321042, 13639.863601363859, 8412.728563287877, 8634.78413039679, 8659.740207793777, 8749.737507874774, 8774.473531588124, 7285.235050319746, 7752.806179845549, 8745.693900713572, 8764.123587641185, 8963.641454341754, 6508.707108180143, 6606.834829129214, 6611.86776264472, 6624.337566243434, 6728.529002969745, 1607.9839201608067, 1769.0358754478839, 1791.0, 1864.794872564017, 1875.5967466994662, 777.6500574741389, 890.2166093837382, 951.1487218939011, 1035.8860525342207, 1073.4525392049954, 17601.471955841345, 20738.58522829565, 21590.136394544043, 22263.777362226494, 22640.773592263868, 988.1995583577325, 1000.3797645459862, 1007.9798404032025, 1023.4319952426326, 1072.265498133781, 9720.90279097214, 11004.504797284142, 11270.703869055, 12042.277463352228, 12133.33266670324, 605649.0, 606099.0, 613816.0, 625605.0, 629708.0, 118744.40627796805, 121340.0, 127035.0, 131878.34060829825, 142047.0, 983.311681822727, 1012.1801340913884, 1022.3814592171777, 1030.299396410448, 1031.4327120083924, 14342.784858226927, 19064.42806715801, 19975.300864469675, 20225.69661455109, 20250.291239806535, 56000.0, 56717.504713075985, 57131.14303285371, 58251.83496330134, 58586.4141358598, 61676.52396498303, 81755.0, 85560.0, 86549.0, 87647.68528471951, 6630.8396030693475, 7482.558686492063, 7553.131389890013, 7636.389088872988, 7840.411969102454, 11277.661670149908, 12323.198992065487, 12545.686357841127, 12561.748765024466, 12897.226166430044, 10761.246712730033, 11034.779304414027, 11039.39283339424, 11202.887971120184, 11374.829377559508, 10586.788264234827, 10752.40861752611, 10907.454627268764, 10981.505832237408, 11264.267822591506, 10940.56237750481, 11037.558497660004, 11196.440177991231, 11291.548338066385, 11418.0, 7650.540967541965, 7743.419243556643, 7843.647035883285, 8025.157358477276, 8275.255227029596, 10425.654227798685, 10879.945600271947, 10999.780004399707, 11098.2786118902, 11176.552937882394], "value": 9840.59395362587, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1539.207308236258, 1558.9844101558986, 1799.8110198429165, 1872.9250829966802, 1915.2721965653059, 7958.32354249888, 8464.449810762304, 8615.35384846136, 9038.457692538444, 9039.367244292902, 8670.609822557984, 8835.293176545876, 8844.027157012724, 8867.068957759422, 8877.51173685447, 2339.1111377676502, 2382.094803974487, 2383.535210633927, 2388.844725092872, 2390.0917651292484, 2356.081128359941, 2381.499885024147, 2390.9718820907, 2394.5809483340345, 2401.411654144737, 2153.8599991000533, 2244.674522194281, 2366.325597204797, 2406.278116565032, 2412.975870241293, 2335.0426325206586, 2358.5047140100514, 2367.1123328751632, 2368.4907744834945, 2379.547885901673, 2346.6480027995767, 2349.0721165139844, 2358.481134150484, 2373.0863617507384, 2374.15717420315, 8928.955355223183, 8966.462012279218, 8975.192232699088, 8982.236509896667, 8993.370464067519, 5258.368995720538, 5373.7581808818695, 5416.729163541807, 5458.5087342139, 5820.505257053155, 3448.7241020718284, 3618.6381361863864, 3631.4734363517405, 3693.8522459101605, 3697.611750766158, 1065.6430095917876, 1066.4561073852315, 1075.0485820049234, 1075.870895492538, 1086.3101930274254, 11698.941505292503, 11721.472533736003, 11730.589429370017, 11865.169438139334, 11918.046556275478, 3934.567197608261, 4428.778561071934, 4484.820607175741, 4655.5102367242835, 4715.22198837188, 7901.841963160705, 9180.540972951325, 9269.72190834276, 9281.72154835356, 9317.90682093184, 5277.8416647500635, 5278.683279003195, 5284.39229488606, 5293.655912365684, 5304.549113325411, 4433.423654924839, 4783.186858234039, 4926.236433352836, 4944.826931057396, 4969.229769385751, 3783.432485127253, 3846.9418860909277, 3904.7461914975434, 3920.8039598020555, 3958.683305335624, 1191.6127258640804, 1204.8915597596083, 1205.4093494187784, 1208.848893888264, 1220.9023278137727, 801.9759407217792, 814.1736137820118, 883.8983516895511, 895.5208963204655, 957.2581249531669, 5620.409856965041, 5778.595498315078, 6044.0, 6056.121862330026, 6202.2867370253, 420.87584162672084, 430.1590390786006, 430.1933873986276, 439.34976235172127, 443.3438511003668, 3933.1740334529495, 3938.6652134568308, 3960.32674445345, 4064.695147863922, 4064.837406503707, 10542.631007914839, 11055.834162487568, 11062.557497700001, 11074.778504430027, 11201.439928003567, 10903.182261330432, 10972.396518191417, 11007.394593297446, 11036.172287078502, 11066.889331106748, 8297.751067467985, 8346.040205376337, 8351.874721879176, 8390.412671112963, 8413.200745929249, 5225.6603320784025, 5283.920741188962, 5528.19841123043, 5695.601307908572, 5852.912206316823, 10011.84863740679, 10169.84745228837, 10179.083882450615, 10251.538680759533, 10256.17950563968, 9820.361676491006, 10287.897121028695, 10300.96990300964, 10356.948215258875, 10457.84313235287, 6635.900461493178, 7002.3697867192195, 7431.516951398142, 7574.772756817304, 7780.144184139854, 8523.573821309034, 8601.096884827253, 8601.870971935301, 8611.224989750952, 8621.180987806149, 7568.886466703114, 7634.4655874088285, 7648.426368022309, 7654.2345765423015, 7719.459637825298, 7437.739679111205, 7492.737754178577, 7536.547807131589, 7590.506617069873, 7671.424643151674, 6909.93090069113, 7048.929510704827, 7049.788506344613, 7068.752593659197, 7087.043249161504, 4398.912021759611, 4411.919079825463, 4437.467503899553, 4797.808087676453, 5029.044481548494, 4105.85629502966, 4313.266744653479, 4753.9762301188275, 4965.950340496549, 5107.821226257063], "value": 4486.193552239717, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [257.42465589407675, 304.61466245199813, 307.2656351320345, 312.1369413571477, 312.85764976935496, 4911.484294149108, 4915.6067514598835, 5312.256284120222, 5621.662700237988, 5685.346185188704, 5470.495613706233, 5562.694051827148, 5576.581756368279, 5590.329160500735, 5628.032237272723, 3580.462930560424, 3762.742354587246, 4121.361189015707, 4133.545310015896, 4249.553796851333, 4015.6787457003516, 4189.392538081976, 4210.515790684065, 4220.472440944882, 4222.514410842747, 4178.331466965286, 4190.601892820177, 4194.343234422401, 4194.370844373338, 4202.831886724527, 3127.0, 3697.6672099511175, 3775.867844625425, 3843.3466310727244, 4198.244316023115, 3228.497914116555, 3299.851506682181, 3560.4689983307167, 3574.7318951078773, 3577.2308953575107, 4755.904881902343, 5155.0, 5268.473152684739, 5408.972955135238, 5429.592780541436, 3777.50788438568, 4206.095689426757, 4526.736631684158, 4531.360846938803, 4777.761111944389, 5277.815276465305, 5809.6804675742815, 5854.443827836349, 5861.150133230701, 5861.4724674779045, 3676.3382591133586, 3923.4311024901517, 3934.940975885364, 3937.7637341759587, 3938.951745092536, 5308.389535203462, 5732.971335143297, 6141.815745527641, 6154.353792851775, 6199.380061993809, 3123.7188653021335, 3963.742356746802, 3966.2662407454136, 3975.4831871856472, 3999.5200575931076, 3868.941965870514, 4051.399697119621, 4058.7564746114735, 4091.713580049368, 4099.651529619956, 3935.3506671399473, 4193.748375097504, 4783.378160839138, 4785.425748910153, 4829.348038014893, 4985.853253751658, 5213.713245771519, 5267.868303292448, 5363.865903352447, 5740.56945729072, 1166.8856242288764, 1175.4064197580337, 1272.9434569307452, 1402.3172193368, 1406.507722297188, 812.2851890336466, 817.3747083481142, 829.9585020749059, 868.522312727997, 872.1409411729442, 4971.328870602495, 5471.835844924659, 5577.470140336743, 5619.80330688424, 5625.268715067015, 5121.615878809104, 6127.969360153171, 6148.907766383508, 6173.81478555644, 6202.503799696014, 5292.841214763564, 5570.275864137636, 5614.887702245932, 5623.578231632644, 5643.125315576092, 2848.9715102848704, 2867.913962581126, 2949.2479417748336, 3194.3132226570933, 3209.4704373778063, 5919.881602368015, 6292.105631409511, 6340.7463701451425, 6364.809055728336, 6394.4564712, 5555.722093987688, 6167.929166749924, 6239.914469707174, 6244.531660125509, 6407.679616019273, 5202.479752024843, 6288.5598008138995, 6296.937030629727, 6309.716062777278, 6371.904421433775, 5293.153095504701, 5703.429657034263, 6069.51443884497, 6076.32641637678, 6082.300535438481, 4940.975295123501, 4948.950510494993, 5242.97378513105, 5322.361316642027, 5937.435943585352, 5146.588272938081, 5926.851828704317, 6318.62088274705, 6323.525735569942, 6367.0, 3889.416587511896, 3973.205358928168, 4010.673809190604, 4045.0, 4054.8175332109536, 5905.114232865105, 6138.07928810682, 6209.161763161916, 6255.843603909939, 6327.658766256514, 4955.959248557699, 5507.5593952482905, 5834.928600346816, 5931.733072011856, 6033.637981720935, 5531.363893152178, 5701.6360347393575, 5897.321807992136, 5944.821655350346, 5993.112169666541, 5051.545360917535, 5530.97234513841, 5646.830595082154, 5781.797637082682, 5814.883702326015, 5146.408163061295, 5803.58927215311, 5933.635263889243, 5987.790427335022, 5987.904233518234, 5866.266716660418, 5874.001419758566, 5892.499137573354, 5900.970495147497, 5941.910871336847], "value": 4224.460821551365, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [608.540551883328, 653.4151934019056, 719.3346154806802, 720.1753991679527, 790.9677870379153, 15065.246737663114, 16034.0, 16239.51281461558, 16273.023618582893, 16324.673506529862, 13939.163650180997, 13970.860291397083, 14017.649558761035, 14025.929870350634, 14935.701285974274, 785.0, 801.7212545989153, 874.7813046738315, 874.7944233105247, 874.9937571792426, 687.4809518813289, 831.1605278668558, 861.9310455163571, 862.6980556805131, 865.9911203447975, 904.1410659873114, 906.2297047509597, 911.3301723233418, 912.6668765900432, 913.9451632902047, 900.9054049324792, 901.923336516397, 903.421810041574, 904.077840602585, 904.764761162096, 672.8183390484542, 674.0933444517117, 674.5581644023173, 674.5918719174927, 675.7432175773224, 14797.926010369987, 14945.327460264314, 15023.924880375638, 15068.321925513379, 15112.924435377863, 14619.561413157622, 14658.267086645732, 14729.337179826933, 14796.18620975846, 14950.551483455514, 11876.465559049777, 12073.154879158463, 12244.938775306067, 12260.570880019246, 12409.813852792215, 3878.728489005771, 3880.3791393376923, 4052.716309858311, 4113.670906327487, 4113.773742444165, 110593.9999999992, 113646.0, 114422.42788786086, 115453.0, 115944.42027789807, 10866.348019118877, 11289.943550282196, 11403.372814495116, 11456.140789440826, 11500.597479088192, 23271.883640581687, 23384.064637414653, 23425.828708564502, 23512.7648723514, 23531.647025294635, 6800.217974932946, 7536.434767392468, 8085.948826652498, 8131.0, 8218.096009439076, 4246.023414614656, 4373.540778218241, 4548.795304211319, 4592.954070459253, 4683.976580117078, 3512.964870351264, 3618.511500947391, 3629.8185090745355, 3634.1459756957092, 3636.3454578176184, 555.5250261026764, 609.8534754661208, 642.04335540045, 646.3891622416771, 649.1301655781276, 638.4860187548975, 656.8456412743002, 659.3176062775004, 678.220046946016, 694.4999600287784, 9543.61825526985, 9567.61729530825, 9667.0, 9778.853317200248, 9787.755306117404, 602.5209958083334, 636.4717284653726, 658.8385845467891, 664.2460806984108, 670.7048898484651, 4473.8657840264195, 4653.534646535387, 4718.8584342469785, 4749.287606858929, 4754.690945088558, 99536.0, 120332.0, 136636.0, 144769.8284525733, 154684.0, 120828.39585802014, 124286.37856810658, 136158.23727593693, 138503.0, 141164.0, 79742.60128699319, 86833.0, 116755.0, 117186.41406792912, 118352.0, 8970.775730606787, 9119.954400228222, 9206.723798286062, 9217.170454659114, 9218.124278193562, 59510.0, 59912.70043649754, 63902.0, 65240.0, 67959.98060029004, 67515.66242168758, 76335.80153091633, 78352.16478352119, 90417.54791226002, 93960.53019735131, 13422.127561708458, 13461.730765384442, 13505.0, 13538.255395953318, 13954.112437944468, 14923.403063877324, 15080.849191507945, 15160.31778569989, 15179.620509487351, 15895.841041589436, 13850.238236897067, 14192.36134373935, 14213.0, 14729.852701472848, 14782.48261310892, 13857.4457021718, 13922.303884805922, 14009.08940918837, 14239.430422782973, 14360.425582976564, 13465.0, 13630.795538066739, 13794.93102534481, 14130.92934535362, 14269.195881221396, 11155.549778528739, 11528.884711152781, 11540.24988375753, 11619.47712352963, 11814.232074915102, 8360.996680398392, 9660.806783864424, 10474.528646210787, 11081.50133244022, 11653.47559359814], "value": 7864.451431136616, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1620.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 118.0, 106.0, 111.0, 116.0, 119.0, 121.0, 119.0, 118.0, 117.0], "value": 115.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 111.0, 140.0, 166.0, 121.0, 160.0, 155.0, 111.0, 158.0, 105.0], "value": 137.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [271.0, 230.0, 273.0, 239.0, 184.0, 253.0, 277.0, 237.0, 191.0, 219.0], "value": 237.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 83.0, 76.0, 146.0, 59.0, 61.0, 59.0, 62.0, 145.0, 61.0], "value": 82.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 73.0, 136.0, 98.0, 103.0, 124.0, 114.0, 71.0, 74.0, 104.0], "value": 96.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 130.0, 89.0, 86.0, 88.0, 87.0, 91.0, 88.0, 91.0, 87.0], "value": 95.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 138.0, 97.0, 116.0, 121.0, 96.0, 97.0, 97.0, 97.0, 117.0], "value": 112.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 130.0, 94.0, 102.0, 82.0, 152.0, 156.0, 95.0, 97.0, 105.0], "value": 111.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 60.0, 58.0, 58.0, 77.0, 85.0, 85.0, 81.0, 61.0], "value": 67.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 70.0, 66.0, 87.0, 78.0, 74.0, 68.0, 72.0, 70.0, 70.0], "value": 72.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 101.0, 101.0, 85.0, 87.0, 88.0, 86.0, 89.0, 91.0, 88.0], "value": 90.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 160.0, 140.0, 163.0, 159.0, 137.0, 146.0, 143.0, 155.0, 164.0], "value": 151.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 176.0, 176.0, 174.0, 176.0, 177.0, 175.0, 176.0, 172.0, 173.0], "value": 175.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 69.0, 73.0, 92.0, 88.0, 87.0, 69.0, 68.0, 71.0, 70.0], "value": 75.7, "unit": "score"}]}]} 04:46:16 INFO - Return code: 0 04:46:16 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:46:16 ERROR - # TBPL SUCCESS # 04:46:16 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:46:16 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:46:16 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:46:16 INFO - 2016-08-18 04:46:16.542 screenresolution[1969:16583] starting screenresolution argv=screenresolution get 04:46:16 INFO - 2016-08-18 04:46:16.544 screenresolution[1969:16583] Display 0: 1600x1200x32@60 04:46:16 INFO - 2016-08-18 04:46:16.550 screenresolution[1970:16586] starting screenresolution argv=screenresolution list 04:46:16 INFO - Available Modes on Display 0 04:46:16 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:46:16 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:46:16 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:46:16 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:46:16 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:46:16 INFO - Intel Iris: 04:46:16 INFO - Chipset Model: Intel Iris 04:46:16 INFO - Type: GPU 04:46:16 INFO - Bus: Built-In 04:46:16 INFO - VRAM (Dynamic, Max): 1536 MB 04:46:16 INFO - Vendor: Intel (0x8086) 04:46:16 INFO - Device ID: 0x0a2e 04:46:16 INFO - Revision ID: 0x0009 04:46:16 INFO - Displays: 04:46:16 INFO - Display: 04:46:16 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:46:16 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:46:16 INFO - Display Serial Number: 1600x1200 60 04:46:16 INFO - Main Display: Yes 04:46:16 INFO - Mirror: Off 04:46:16 INFO - Online: Yes 04:46:16 INFO - Rotation: Supported 04:46:16 INFO - Return code: 0 04:46:16 INFO - Running post-action listener: _resource_record_post_action 04:46:16 INFO - [mozharness: 2016-08-18 11:46:16.785408Z] Finished run-tests step (success) 04:46:16 INFO - Running post-run listener: _resource_record_post_run 04:46:16 INFO - Total resource usage - Wall time: 1211s; CPU: 54.0%; Read bytes: 1187840; Write bytes: 704791040; Read time: 16; Write time: 2162 04:46:16 INFO - TinderboxPrint: CPU usage
54.3% 04:46:16 INFO - TinderboxPrint: I/O read bytes / time
1,187,840 / 16 04:46:16 INFO - TinderboxPrint: I/O write bytes / time
704,791,040 / 2,162 04:46:16 INFO - TinderboxPrint: CPU idle
2,214.5 (45.7%) 04:46:16 INFO - TinderboxPrint: CPU system
978.5 (20.2%) 04:46:16 INFO - TinderboxPrint: CPU user
1,652.7 (34.1%) 04:46:16 INFO - TinderboxPrint: Swap in / out
406,892,544 / 0 04:46:16 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 385948160; Write bytes: 380478976; Read time: 29557; Write time: 758 04:46:16 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 1187840; Write bytes: 296745984; Read time: 16; Write time: 1352 04:46:17 INFO - Running post-run listener: _upload_blobber_files 04:46:17 INFO - Blob upload gear active. 04:46:17 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:46:17 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 04:46:17 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'] 04:46:17 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 04:46:17 INFO - (blobuploader) - INFO - Open directory for files ... 04:46:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:46:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:46:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:46:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:46:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:46:18 INFO - (blobuploader) - INFO - Done attempting. 04:46:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:46:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:46:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:46:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:46:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:46:19 INFO - (blobuploader) - INFO - Done attempting. 04:46:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:46:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:46:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:46:22 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:46:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:46:22 INFO - (blobuploader) - INFO - Done attempting. 04:46:22 INFO - (blobuploader) - INFO - Iteration through files over. 04:46:22 INFO - Return code: 0 04:46:22 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:46:22 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:46:22 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0b7c79f634751a81a4c761a2990f99cc22151eea8cf69691ea92322bc9badb6e04f673492106187c04cf68262eb4a60498dad69035b072f34485851aa3df4255", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/925fe4b64b6eb9856e5197fec6fba56b561a49b7ee0f4181eaf5d8c5a3b40abcd6ce3c95d4b013501097dee51d3849d5bcbfc2c58fa771b43a249e55594517c5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8422587b3df062cc3dcc10bc547455703f10bc767907e1068c72f89ab40e79c93da6ecd391476f371346e02448ccc34c1d2f9cf3892fa1cb23243c4d123ffc7e"} 04:46:22 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:46:22 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:46:22 INFO - Contents: 04:46:22 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0b7c79f634751a81a4c761a2990f99cc22151eea8cf69691ea92322bc9badb6e04f673492106187c04cf68262eb4a60498dad69035b072f34485851aa3df4255", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/925fe4b64b6eb9856e5197fec6fba56b561a49b7ee0f4181eaf5d8c5a3b40abcd6ce3c95d4b013501097dee51d3849d5bcbfc2c58fa771b43a249e55594517c5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8422587b3df062cc3dcc10bc547455703f10bc767907e1068c72f89ab40e79c93da6ecd391476f371346e02448ccc34c1d2f9cf3892fa1cb23243c4d123ffc7e"} 04:46:22 INFO - Running post-run listener: copy_logs_to_upload_dir 04:46:22 INFO - Copying logs to upload dir... 04:46:22 INFO - mkdir: /builds/slave/test/build/upload/logs 04:46:22 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1270.864469 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-08-18 04:46:22.403087) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-18 04:46:22.406668) ========= 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.o0Zaix51xt/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.paYme5DJqU/Listeners TMPDIR=/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/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/0b7c79f634751a81a4c761a2990f99cc22151eea8cf69691ea92322bc9badb6e04f673492106187c04cf68262eb4a60498dad69035b072f34485851aa3df4255", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/925fe4b64b6eb9856e5197fec6fba56b561a49b7ee0f4181eaf5d8c5a3b40abcd6ce3c95d4b013501097dee51d3849d5bcbfc2c58fa771b43a249e55594517c5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8422587b3df062cc3dcc10bc547455703f10bc767907e1068c72f89ab40e79c93da6ecd391476f371346e02448ccc34c1d2f9cf3892fa1cb23243c4d123ffc7e"} build_url:https://queue.taskcluster.net/v1/task/bPSr0os7Tv60bl3E03y8BA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011330 build_url: 'https://queue.taskcluster.net/v1/task/bPSr0os7Tv60bl3E03y8BA/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/0b7c79f634751a81a4c761a2990f99cc22151eea8cf69691ea92322bc9badb6e04f673492106187c04cf68262eb4a60498dad69035b072f34485851aa3df4255", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/925fe4b64b6eb9856e5197fec6fba56b561a49b7ee0f4181eaf5d8c5a3b40abcd6ce3c95d4b013501097dee51d3849d5bcbfc2c58fa771b43a249e55594517c5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8422587b3df062cc3dcc10bc547455703f10bc767907e1068c72f89ab40e79c93da6ecd391476f371346e02448ccc34c1d2f9cf3892fa1cb23243c4d123ffc7e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-18 04:46:22.439391) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 04:46:22.439683) ========= 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.o0Zaix51xt/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.paYme5DJqU/Listeners TMPDIR=/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/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.005190 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 04:46:22.488011) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-18 04:46:22.488326) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-18 04:46:22.488642) ========= ========= Total master_lag: 0.75 =========