builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0030 starttime: 1488993180.17 results: success (0) buildid: 20170308073826 builduid: 4026df89322444f9aa89106577b31b3d revision: 70790a08686d78e9f3bb83094c2c04bf1dad20f3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-08 09:13:00.169580) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-08 09:13:00.170028) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-08 09:13:00.170299) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-08 09:13:00.196889) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-08 09:13:00.197236) ========= 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.0jRwKrdhlp/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.rqADtuOjmc/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 --2017-03-08 09:13:00-- 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: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 14.8M=0.001s 2017-03-08 09:13:00 (14.8 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.137405 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-08 09:13:00.358878) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-08 09:13:00.359184) ========= 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.0jRwKrdhlp/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.rqADtuOjmc/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.027862 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-08 09:13:00.410074) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-08 09:13:00.410637) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 70790a08686d78e9f3bb83094c2c04bf1dad20f3 --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 70790a08686d78e9f3bb83094c2c04bf1dad20f3 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.0jRwKrdhlp/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.rqADtuOjmc/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 2017-03-08 09:13:00,548 truncating revision to first 12 chars 2017-03-08 09:13:00,549 Setting DEBUG logging. 2017-03-08 09:13:00,549 attempt 1/10 2017-03-08 09:13:00,549 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/70790a08686d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-08 09:13:01,247 unpacking tar archive at: mozilla-central-70790a08686d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.979195 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-08 09:13:01.412037) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-08 09:13:01.412380) ========= script_repo_revision: 70790a08686d78e9f3bb83094c2c04bf1dad20f3 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-08 09:13:01.412751) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-08 09:13:01.413027) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-08 09:13:01.432857) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 29 secs) (at 2017-03-08 09:13:01.433233) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --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', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--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.0jRwKrdhlp/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.rqADtuOjmc/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 09:13:01 INFO - MultiFileLogger online at 20170308 09:13:01 in /builds/slave/test 09:13:01 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 09:13:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:13:01 INFO - {'append_to_log': False, 09:13:01 INFO - 'base_work_dir': '/builds/slave/test', 09:13:01 INFO - 'blob_upload_branch': 'Firefox', 09:13:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:13:01 INFO - 'branch': 'Firefox', 09:13:01 INFO - 'buildbot_json_path': 'buildprops.json', 09:13:01 INFO - 'config_files': ('talos/mac_config.py',), 09:13:01 INFO - 'default_actions': ('clobber', 09:13:01 INFO - 'read-buildbot-config', 09:13:01 INFO - 'download-and-extract', 09:13:01 INFO - 'populate-webroot', 09:13:01 INFO - 'create-virtualenv', 09:13:01 INFO - 'install', 09:13:01 INFO - 'run-tests'), 09:13:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:13:01 INFO - 'download_minidump_stackwalk': True, 09:13:01 INFO - 'download_symbols': 'ondemand', 09:13:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:13:01 INFO - 'tooltool.py': '/tools/tooltool.py', 09:13:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:13:01 INFO - '/tools/misc-python/virtualenv.py')}, 09:13:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:13:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:13:01 INFO - 'gecko_profile': False, 09:13:01 INFO - 'gecko_profile_interval': 0, 09:13:01 INFO - 'installer_path': 'installer.exe', 09:13:01 INFO - 'log_level': 'info', 09:13:01 INFO - 'log_name': 'talos', 09:13:01 INFO - 'log_to_console': True, 09:13:01 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:13:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:13:01 INFO - 'opt_config_files': (), 09:13:01 INFO - 'pip_index': False, 09:13:01 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:13:01 INFO - 'cmd': ('bash', 09:13:01 INFO - '-c', 09:13:01 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:13:01 INFO - 'enabled': True, 09:13:01 INFO - 'halt_on_failure': False, 09:13:01 INFO - 'name': 'check_screen_resolution'},), 09:13:01 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:13:01 INFO - 'cmd': ('bash', 09:13:01 INFO - '-c', 09:13:01 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:13:01 INFO - 'enabled': True, 09:13:01 INFO - 'halt_on_failure': False, 09:13:01 INFO - 'name': 'check_screen_resolution'},), 09:13:01 INFO - 'run_cmd_checks_enabled': True, 09:13:01 INFO - 'suite': 'dromaeojs', 09:13:01 INFO - 'system_bits': '32', 09:13:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:13:01 INFO - 'title': 't-yosemite-r7-0030', 09:13:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:13:01 INFO - 'use_talos_json': True, 09:13:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:13:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:13:01 INFO - 'work_dir': 'build'} 09:13:01 INFO - [mozharness: 2017-03-08 17:13:01.684274Z] Running clobber step. 09:13:01 INFO - Running pre-action listener: _resource_record_pre_action 09:13:01 INFO - Running main action method: clobber 09:13:01 INFO - rmtree: /builds/slave/test/build 09:13:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:13:06 INFO - Running post-action listener: _resource_record_post_action 09:13:06 INFO - [mozharness: 2017-03-08 17:13:06.138252Z] Finished clobber step (success) 09:13:06 INFO - [mozharness: 2017-03-08 17:13:06.138436Z] Running read-buildbot-config step. 09:13:06 INFO - Running pre-action listener: _resource_record_pre_action 09:13:06 INFO - Running main action method: read_buildbot_config 09:13:06 INFO - Using buildbot properties: 09:13:06 INFO - { 09:13:06 INFO - "project": "", 09:13:06 INFO - "product": "firefox", 09:13:06 INFO - "script_repo_revision": "production", 09:13:06 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 09:13:06 INFO - "repository": "", 09:13:06 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 09:13:06 INFO - "buildid": "20170308073826", 09:13:06 INFO - "pgo_build": "False", 09:13:06 INFO - "basedir": "/builds/slave/test", 09:13:06 INFO - "buildnumber": 14, 09:13:06 INFO - "slavename": "t-yosemite-r7-0030", 09:13:06 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 09:13:06 INFO - "platform": "yosemite_r7", 09:13:06 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 09:13:06 INFO - "branch": "mozilla-central", 09:13:06 INFO - "repo_path": "mozilla-central", 09:13:06 INFO - "revision": "70790a08686d78e9f3bb83094c2c04bf1dad20f3", 09:13:06 INFO - "stage_platform": "macosx64", 09:13:06 INFO - "builduid": "4026df89322444f9aa89106577b31b3d", 09:13:06 INFO - "slavebuilddir": "test" 09:13:06 INFO - } 09:13:06 INFO - Found installer url https://queue.taskcluster.net/v1/task/W814j9yQSNy3dAL9zQLoiA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 09:13:06 INFO - Running post-action listener: _resource_record_post_action 09:13:06 INFO - [mozharness: 2017-03-08 17:13:06.141871Z] Finished read-buildbot-config step (success) 09:13:06 INFO - [mozharness: 2017-03-08 17:13:06.142012Z] Running download-and-extract step. 09:13:06 INFO - Running pre-action listener: _resource_record_pre_action 09:13:06 INFO - Running main action method: download_and_extract 09:13:06 INFO - mkdir: /builds/slave/test/build/tests 09:13:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:13:06 INFO - trying https://queue.taskcluster.net/v1/task/W814j9yQSNy3dAL9zQLoiA/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 09:13:06 INFO - Downloading https://queue.taskcluster.net/v1/task/W814j9yQSNy3dAL9zQLoiA/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 09:13:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/W814j9yQSNy3dAL9zQLoiA/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 09:13:07 INFO - Downloaded 1199 bytes. 09:13:07 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 09:13:07 INFO - Using the following test package requirements: 09:13:07 INFO - {u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 09:13:07 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:13:07 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 09:13:07 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:13:07 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 09:13:07 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:13:07 INFO - u'jsshell-mac.zip'], 09:13:07 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:13:07 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 09:13:07 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 09:13:07 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:13:07 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 09:13:07 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:13:07 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 09:13:07 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:13:07 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 09:13:07 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:13:07 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 09:13:07 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 09:13:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/W814j9yQSNy3dAL9zQLoiA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 09:13:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/W814j9yQSNy3dAL9zQLoiA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 09:13:07 INFO - Fetch https://queue.taskcluster.net/v1/task/W814j9yQSNy3dAL9zQLoiA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 09:13:08 INFO - Expected file size: 51786402 09:13:08 INFO - Obtained file size: 51786402 09:13:24 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 09:13:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/W814j9yQSNy3dAL9zQLoiA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 09:13:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/W814j9yQSNy3dAL9zQLoiA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 09:13:24 INFO - Fetch https://queue.taskcluster.net/v1/task/W814j9yQSNy3dAL9zQLoiA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 09:13:26 INFO - Expected file size: 51786402 09:13:26 INFO - Obtained file size: 51786402 09:13:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/W814j9yQSNy3dAL9zQLoiA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 09:13:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/W814j9yQSNy3dAL9zQLoiA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 09:13:41 INFO - Fetch https://queue.taskcluster.net/v1/task/W814j9yQSNy3dAL9zQLoiA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 09:13:42 INFO - Expected file size: 14404424 09:13:42 INFO - Obtained file size: 14404424 09:13:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:13:43 INFO - trying https://queue.taskcluster.net/v1/task/W814j9yQSNy3dAL9zQLoiA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 09:13:43 INFO - Downloading https://queue.taskcluster.net/v1/task/W814j9yQSNy3dAL9zQLoiA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 09:13:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/W814j9yQSNy3dAL9zQLoiA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 09:13:45 INFO - Downloaded 74926928 bytes. 09:13:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/W814j9yQSNy3dAL9zQLoiA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 09:13:45 INFO - mkdir: /builds/slave/test/properties 09:13:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:13:45 INFO - Writing to file /builds/slave/test/properties/build_url 09:13:45 INFO - Contents: 09:13:45 INFO - build_url:https://queue.taskcluster.net/v1/task/W814j9yQSNy3dAL9zQLoiA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 09:13:46 INFO - Running post-action listener: _resource_record_post_action 09:13:46 INFO - Running post-action listener: set_extra_try_arguments 09:13:46 INFO - [mozharness: 2017-03-08 17:13:46.370683Z] Finished download-and-extract step (success) 09:13:46 INFO - [mozharness: 2017-03-08 17:13:46.370827Z] Running populate-webroot step. 09:13:46 INFO - Running pre-action listener: _resource_record_pre_action 09:13:46 INFO - Running main action method: populate_webroot 09:13:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:13:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:13:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:13:46 INFO - '--tppagecycles', 09:13:46 INFO - '7'], 09:13:46 INFO - 'tests': ['tsvgm']}}, 09:13:46 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:13:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:13:46 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:13:46 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:13:46 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:13:46 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:13:46 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 09:13:46 INFO - 'talos_options': ['--disable-e10s'], 09:13:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:13:46 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:13:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:13:46 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 09:13:46 INFO - 'talos_options': ['--disable-e10s'], 09:13:46 INFO - 'tests': ['damp', 'tps']}, 09:13:46 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:13:46 INFO - 'tests': ['damp', 'tps']}, 09:13:46 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:13:46 INFO - 'tests': ['dromaeo_dom']}, 09:13:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:13:46 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:13:46 INFO - 'tests': ['basic_compositor_video']}, 09:13:46 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:13:46 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:13:46 INFO - 'tests': ['a11yr', 09:13:46 INFO - 'ts_paint', 09:13:46 INFO - 'tpaint', 09:13:46 INFO - 'sessionrestore', 09:13:46 INFO - 'sessionrestore_no_auto_restore', 09:13:46 INFO - 'tabpaint']}, 09:13:46 INFO - 'other-e10s': {'tests': ['a11yr', 09:13:46 INFO - 'ts_paint', 09:13:46 INFO - 'tpaint', 09:13:46 INFO - 'sessionrestore', 09:13:46 INFO - 'sessionrestore_no_auto_restore', 09:13:46 INFO - 'tabpaint']}, 09:13:46 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:13:46 INFO - 'ts_paint', 09:13:46 INFO - 'tpaint', 09:13:46 INFO - 'sessionrestore', 09:13:46 INFO - 'sessionrestore_no_auto_restore', 09:13:46 INFO - 'tabpaint']}, 09:13:46 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:13:46 INFO - 'ts_paint', 09:13:46 INFO - 'tpaint', 09:13:46 INFO - 'sessionrestore', 09:13:46 INFO - 'sessionrestore_no_auto_restore', 09:13:46 INFO - 'tabpaint']}, 09:13:46 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:13:46 INFO - 'tests': ['a11yr', 09:13:46 INFO - 'ts_paint', 09:13:46 INFO - 'tpaint', 09:13:46 INFO - 'sessionrestore', 09:13:46 INFO - 'sessionrestore_no_auto_restore', 09:13:46 INFO - 'tabpaint']}, 09:13:46 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:13:46 INFO - 'tests': ['a11yr', 09:13:46 INFO - 'ts_paint', 09:13:46 INFO - 'tpaint', 09:13:46 INFO - 'sessionrestore', 09:13:46 INFO - 'sessionrestore_no_auto_restore', 09:13:46 INFO - 'tabpaint']}, 09:13:46 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:13:46 INFO - 'tests': ['tsvgx', 09:13:46 INFO - 'tsvgr_opacity', 09:13:46 INFO - 'tart', 09:13:46 INFO - 'tscrollx', 09:13:46 INFO - 'cart', 09:13:46 INFO - 'tsvg_static']}, 09:13:46 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:13:46 INFO - 'tsvgr_opacity', 09:13:46 INFO - 'tart', 09:13:46 INFO - 'tscrollx', 09:13:46 INFO - 'cart', 09:13:46 INFO - 'tsvg_static']}, 09:13:46 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 09:13:46 INFO - 'talos_options': ['--disable-e10s'], 09:13:46 INFO - 'tests': ['tp5o']}, 09:13:46 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:13:46 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 09:13:46 INFO - 'talos_options': ['--disable-e10s', 09:13:46 INFO - '--xperf_path', 09:13:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:13:46 INFO - 'tests': ['tp5n']}, 09:13:46 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:13:46 INFO - 'talos_options': ['--xperf_path', 09:13:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:13:46 INFO - 'tests': ['tp5n']}}, 09:13:46 INFO - 'talos.zip': {'path': '', 09:13:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:13:46 INFO - Running post-action listener: _resource_record_post_action 09:13:46 INFO - [mozharness: 2017-03-08 17:13:46.389176Z] Finished populate-webroot step (success) 09:13:46 INFO - [mozharness: 2017-03-08 17:13:46.389292Z] Running create-virtualenv step. 09:13:46 INFO - Running pre-action listener: _resource_record_pre_action 09:13:46 INFO - Running main action method: create_virtualenv 09:13:46 INFO - Creating virtualenv /builds/slave/test/build/venv 09:13:46 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 09:13:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:13:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:13:46 INFO - Using real prefix '/tools/python27' 09:13:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:13:47 INFO - Installing distribute.............................................................................................................................................................................................done. 09:13:50 INFO - Installing pip.................done. 09:13:50 INFO - Return code: 0 09:13:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:13:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:13:50 INFO - Reading from file tmpfile_stdout 09:13:50 INFO - Output received: 09:13:50 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 09:13:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:13:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:13:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:13:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:13:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:13:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:13:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:13:50 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 0x10fb80b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fb83768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdad04653b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f95ed30>, '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 0x10f885db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f953be8>, '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.0jRwKrdhlp/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.rqADtuOjmc/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 09:13:50 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 09:13:50 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 09:13:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0jRwKrdhlp/Render', 09:13:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:13:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:13:50 INFO - 'HOME': '/Users/cltbld', 09:13:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:13:50 INFO - 'LOGNAME': 'cltbld', 09:13:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:13:50 INFO - 'MOZ_NO_REMOTE': '1', 09:13:50 INFO - 'NO_EM_RESTART': '1', 09:13:50 INFO - 'PAGER': '/bin/cat', 09:13:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:13:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:13:50 INFO - 'PWD': '/builds/slave/test', 09:13:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:13:50 INFO - 'SHELL': '/bin/bash', 09:13:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rqADtuOjmc/Listeners', 09:13:50 INFO - 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', 09:13:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:13:50 INFO - 'USER': 'cltbld', 09:13:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:13:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:13:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:13:50 INFO - 'XPC_FLAGS': '0x0', 09:13:50 INFO - 'XPC_SERVICE_NAME': '0', 09:13:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:13:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:13:50 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 09:13:50 INFO - Cleaning up... 09:13:50 INFO - Return code: 0 09:13:50 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:13:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:13:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:13:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:13:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:13:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:13:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:13:50 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 0x10fb80b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fb83768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdad04653b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f95ed30>, '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 0x10f885db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f953be8>, '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.0jRwKrdhlp/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.rqADtuOjmc/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 09:13:50 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 09:13:50 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 09:13:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0jRwKrdhlp/Render', 09:13:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:13:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:13:50 INFO - 'HOME': '/Users/cltbld', 09:13:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:13:50 INFO - 'LOGNAME': 'cltbld', 09:13:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:13:50 INFO - 'MOZ_NO_REMOTE': '1', 09:13:50 INFO - 'NO_EM_RESTART': '1', 09:13:50 INFO - 'PAGER': '/bin/cat', 09:13:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:13:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:13:50 INFO - 'PWD': '/builds/slave/test', 09:13:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:13:50 INFO - 'SHELL': '/bin/bash', 09:13:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rqADtuOjmc/Listeners', 09:13:50 INFO - 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', 09:13:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:13:50 INFO - 'USER': 'cltbld', 09:13:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:13:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:13:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:13:50 INFO - 'XPC_FLAGS': '0x0', 09:13:50 INFO - 'XPC_SERVICE_NAME': '0', 09:13:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:13:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:13:50 INFO - Downloading/unpacking psutil>=3.1.1 09:13:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:13:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:13:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:13:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:13:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:13:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:13:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:13:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:13:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:13:54 INFO - Installing collected packages: psutil 09:13:54 INFO - Running setup.py install for psutil 09:13:54 INFO - building 'psutil._psutil_osx' extension 09:13:54 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 09:13:55 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 09:13:55 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 09:13:55 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 09:13:55 INFO - building 'psutil._psutil_posix' extension 09:13:55 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 09:13:55 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:13:55 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:13:55 INFO - ^ 09:13:55 INFO - 1 warning generated. 09:13:55 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 09:13:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:13:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:13:55 INFO - Successfully installed psutil 09:13:55 INFO - Cleaning up... 09:13:55 INFO - Return code: 0 09:13:55 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:13:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:13:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:13:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:13:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:13:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:13:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:13:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10fb80b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fb83768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdad04653b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f95ed30>, '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 0x10f885db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f953be8>, '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.0jRwKrdhlp/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.rqADtuOjmc/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 09:13:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:13:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:13:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0jRwKrdhlp/Render', 09:13:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:13:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:13:55 INFO - 'HOME': '/Users/cltbld', 09:13:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:13:55 INFO - 'LOGNAME': 'cltbld', 09:13:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:13:55 INFO - 'MOZ_NO_REMOTE': '1', 09:13:55 INFO - 'NO_EM_RESTART': '1', 09:13:55 INFO - 'PAGER': '/bin/cat', 09:13:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:13:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:13:55 INFO - 'PWD': '/builds/slave/test', 09:13:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:13:55 INFO - 'SHELL': '/bin/bash', 09:13:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rqADtuOjmc/Listeners', 09:13:55 INFO - 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', 09:13:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:13:55 INFO - 'USER': 'cltbld', 09:13:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:13:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:13:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:13:55 INFO - 'XPC_FLAGS': '0x0', 09:13:55 INFO - 'XPC_SERVICE_NAME': '0', 09:13:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:13:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:13:55 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:13:55 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 09:13:55 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 09:13:55 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 09:13:55 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 09:13:55 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 09:13:55 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 09:13:58 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:13:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:13:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:13:58 INFO - Installing collected packages: mozsystemmonitor 09:13:58 INFO - Running setup.py install for mozsystemmonitor 09:13:58 INFO - Successfully installed mozsystemmonitor 09:13:58 INFO - Cleaning up... 09:13:58 INFO - Return code: 0 09:13:58 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:13: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')]} 09:13:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:13:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:13:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:13:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:13:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:13:59 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 0x10fb80b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fb83768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdad04653b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f95ed30>, '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 0x10f885db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f953be8>, '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.0jRwKrdhlp/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.rqADtuOjmc/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 09:13:59 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 09:13:59 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 09:13:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0jRwKrdhlp/Render', 09:13:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:13:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:13:59 INFO - 'HOME': '/Users/cltbld', 09:13:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:13:59 INFO - 'LOGNAME': 'cltbld', 09:13:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:13:59 INFO - 'MOZ_NO_REMOTE': '1', 09:13:59 INFO - 'NO_EM_RESTART': '1', 09:13:59 INFO - 'PAGER': '/bin/cat', 09:13:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:13:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:13:59 INFO - 'PWD': '/builds/slave/test', 09:13:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:13:59 INFO - 'SHELL': '/bin/bash', 09:13:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rqADtuOjmc/Listeners', 09:13:59 INFO - 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', 09:13:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:13:59 INFO - 'USER': 'cltbld', 09:13:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:13:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:13:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:13:59 INFO - 'XPC_FLAGS': '0x0', 09:13:59 INFO - 'XPC_SERVICE_NAME': '0', 09:13:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:13:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:13:59 INFO - Downloading/unpacking jsonschema==2.5.1 09:13:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:13:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:13:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:13:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:13:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:13:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:14:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:14:02 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:14:02 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 09:14:02 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 09:14:02 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 09:14:02 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 09:14:02 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 09:14:02 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 09:14:03 INFO - Downloading functools32-3.2.3-2.tar.gz 09:14:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:14:03 INFO - warning: no files found matching '*.txt' 09:14:03 INFO - no previously-included directories found matching 'build' 09:14:03 INFO - no previously-included directories found matching 'dist' 09:14:03 INFO - no previously-included directories found matching '.git*' 09:14:03 INFO - Installing collected packages: jsonschema, functools32 09:14:03 INFO - Running setup.py install for functools32 09:14:03 INFO - warning: no files found matching '*.txt' 09:14:03 INFO - no previously-included directories found matching 'build' 09:14:03 INFO - no previously-included directories found matching 'dist' 09:14:03 INFO - no previously-included directories found matching '.git*' 09:14:03 INFO - Successfully installed jsonschema functools32 09:14:03 INFO - Cleaning up... 09:14:03 INFO - Return code: 0 09:14:03 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:14:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:14:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:14:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:14:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:14:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10fb80b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fb83768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdad04653b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f95ed30>, '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 0x10f885db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f953be8>, '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.0jRwKrdhlp/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.rqADtuOjmc/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 09:14:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:14:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 09:14:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0jRwKrdhlp/Render', 09:14:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:14:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:14:03 INFO - 'HOME': '/Users/cltbld', 09:14:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:14:03 INFO - 'LOGNAME': 'cltbld', 09:14:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:14:03 INFO - 'MOZ_NO_REMOTE': '1', 09:14:03 INFO - 'NO_EM_RESTART': '1', 09:14:03 INFO - 'PAGER': '/bin/cat', 09:14:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:14:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:14:03 INFO - 'PWD': '/builds/slave/test', 09:14:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:14:03 INFO - 'SHELL': '/bin/bash', 09:14:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rqADtuOjmc/Listeners', 09:14:03 INFO - 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', 09:14:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:14:03 INFO - 'USER': 'cltbld', 09:14:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:14:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:14:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:14:03 INFO - 'XPC_FLAGS': '0x0', 09:14:03 INFO - 'XPC_SERVICE_NAME': '0', 09:14:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:14:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:14:03 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:14:03 INFO - Cleaning up... 09:14:03 INFO - Return code: 0 09:14:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:14:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:14:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:14:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:14:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:14:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10fb80b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fb83768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdad04653b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f95ed30>, '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 0x10f885db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f953be8>, '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.0jRwKrdhlp/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.rqADtuOjmc/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 09:14:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:14:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:14:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0jRwKrdhlp/Render', 09:14:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:14:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:14:03 INFO - 'HOME': '/Users/cltbld', 09:14:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:14:03 INFO - 'LOGNAME': 'cltbld', 09:14:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:14:03 INFO - 'MOZ_NO_REMOTE': '1', 09:14:03 INFO - 'NO_EM_RESTART': '1', 09:14:03 INFO - 'PAGER': '/bin/cat', 09:14:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:14:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:14:03 INFO - 'PWD': '/builds/slave/test', 09:14:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:14:03 INFO - 'SHELL': '/bin/bash', 09:14:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rqADtuOjmc/Listeners', 09:14:03 INFO - 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', 09:14:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:14:03 INFO - 'USER': 'cltbld', 09:14:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:14:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:14:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:14:03 INFO - 'XPC_FLAGS': '0x0', 09:14:03 INFO - 'XPC_SERVICE_NAME': '0', 09:14:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:14:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:14:04 INFO - Downloading/unpacking blobuploader==1.2.4 09:14:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:14:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:14:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:14:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:14:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:14:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:14:06 INFO - Downloading blobuploader-1.2.4.tar.gz 09:14:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:14:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:14:06 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 09:14:06 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 09:14:06 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 09:14:06 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 09:14:06 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 09:14:06 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 09:14:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:14:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:14:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:14:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:14:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:14:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:14:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:14:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:14:07 INFO - Downloading docopt-0.6.1.tar.gz 09:14:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:14:08 INFO - Installing collected packages: blobuploader, requests, docopt 09:14:08 INFO - Running setup.py install for blobuploader 09:14:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:14:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:14:08 INFO - Running setup.py install for requests 09:14:08 INFO - Running setup.py install for docopt 09:14:08 INFO - Successfully installed blobuploader requests docopt 09:14:08 INFO - Cleaning up... 09:14:08 INFO - Return code: 0 09:14:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:14:08 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')]} 09:14:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:14:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14:08 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')]} 09:14:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:14:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14:08 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 0x10fb80b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fb83768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdad04653b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f95ed30>, '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 0x10f885db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f953be8>, '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.0jRwKrdhlp/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.rqADtuOjmc/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 09:14:08 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 09:14:08 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 09:14:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0jRwKrdhlp/Render', 09:14:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:14:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:14:08 INFO - 'HOME': '/Users/cltbld', 09:14:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:14:08 INFO - 'LOGNAME': 'cltbld', 09:14:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:14:08 INFO - 'MOZ_NO_REMOTE': '1', 09:14:08 INFO - 'NO_EM_RESTART': '1', 09:14:08 INFO - 'PAGER': '/bin/cat', 09:14:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:14:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:14:08 INFO - 'PWD': '/builds/slave/test', 09:14:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:14:08 INFO - 'SHELL': '/bin/bash', 09:14:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rqADtuOjmc/Listeners', 09:14:08 INFO - 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', 09:14:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:14:08 INFO - 'USER': 'cltbld', 09:14:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:14:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:14:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:14:08 INFO - 'XPC_FLAGS': '0x0', 09:14:08 INFO - 'XPC_SERVICE_NAME': '0', 09:14:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:14:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:14:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:14:09 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-p8Vr_R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:14:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:14:09 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-8l8bnk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:14:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:14:09 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-JK0ery-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:14:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:14:09 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-mj7vp1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:14:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:14:09 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-tepMuQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:14:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:14:09 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-kvVp9k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:14:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:14:09 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-b9Vxzw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:14:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:14:09 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-9TILRi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:14:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:14:10 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-nELwnt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:14:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:14:10 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-wdkbqB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:14:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:14:10 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-fi1gRG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:14:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:14:10 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-M4UX8a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:14:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:14:10 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-Gs_fWC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:14:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:14:10 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-q5eP4e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:14:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:14:10 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-GNQqwi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:14:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:14:10 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-i9HBgO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:14:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:14:10 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-p79mT6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:14:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:14:10 INFO - Running setup.py install for manifestparser 09:14:11 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:14:11 INFO - Running setup.py install for mozcrash 09:14:11 INFO - Running setup.py install for mozdebug 09:14:11 INFO - Running setup.py install for mozdevice 09:14:11 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:14:11 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:14:11 INFO - Running setup.py install for mozfile 09:14:11 INFO - Running setup.py install for mozhttpd 09:14:11 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:14:11 INFO - Running setup.py install for mozinfo 09:14:11 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:14:12 INFO - Running setup.py install for mozInstall 09:14:12 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:14:12 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:14:12 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:14:12 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:14:12 INFO - Running setup.py install for mozleak 09:14:12 INFO - Running setup.py install for mozlog 09:14:12 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:14:12 INFO - Running setup.py install for moznetwork 09:14:12 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:14:12 INFO - Running setup.py install for mozprocess 09:14:12 INFO - Running setup.py install for mozprofile 09:14:12 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:14:12 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:14:12 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:14:12 INFO - Running setup.py install for mozrunner 09:14:13 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:14:13 INFO - Running setup.py install for mozscreenshot 09:14:13 INFO - Running setup.py install for moztest 09:14:13 INFO - Running setup.py install for mozversion 09:14:13 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:14:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:14:13 INFO - Cleaning up... 09:14:13 INFO - Return code: 0 09:14:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:14: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')]} 09:14:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:14:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14: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')]} 09:14:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:14:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14:13 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 0x10fb80b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fb83768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdad04653b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f95ed30>, '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 0x10f885db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f953be8>, '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.0jRwKrdhlp/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.rqADtuOjmc/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 09:14:13 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 09:14:13 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 09:14:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0jRwKrdhlp/Render', 09:14:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:14:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:14:13 INFO - 'HOME': '/Users/cltbld', 09:14:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:14:13 INFO - 'LOGNAME': 'cltbld', 09:14:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:14:13 INFO - 'MOZ_NO_REMOTE': '1', 09:14:13 INFO - 'NO_EM_RESTART': '1', 09:14:13 INFO - 'PAGER': '/bin/cat', 09:14:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:14:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:14:13 INFO - 'PWD': '/builds/slave/test', 09:14:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:14:13 INFO - 'SHELL': '/bin/bash', 09:14:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rqADtuOjmc/Listeners', 09:14:13 INFO - 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', 09:14:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:14:13 INFO - 'USER': 'cltbld', 09:14:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:14:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:14:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:14:13 INFO - 'XPC_FLAGS': '0x0', 09:14:13 INFO - 'XPC_SERVICE_NAME': '0', 09:14:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:14:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:14:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:14:13 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-WcrcEA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:14:13 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)) 09:14:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:14:13 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-5ojq2e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:14:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 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)) 09:14:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:14:14 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-_VOKTf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:14:14 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)) 09:14:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:14:14 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-mt9mx5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:14:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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)) 09:14:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:14:14 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-fuVWi9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:14:14 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)) 09:14:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:14:14 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-8Xrc2V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:14:14 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)) 09:14:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:14:14 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-IGlBNq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:14:14 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)) 09:14:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:14:14 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-G1URlw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:14:14 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)) 09:14:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:14:14 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-K8XOBA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:14:14 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)) 09:14:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:14:14 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-jDdcmR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:14:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 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)) 09:14:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:14:14 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-VSAWrx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:14:14 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)) 09:14:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:14:15 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-v0umwQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:14:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 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)) 09:14:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:14:15 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-eKrqAJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:14:15 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)) 09:14:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:14:15 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-rQWfSF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:14:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 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)) 09:14:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:14:15 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-elfMkn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:14:15 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)) 09:14:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:14:15 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-0rDw4G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:14:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 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)) 09:14:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:14:15 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-v54PFc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:14:15 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)) 09:14:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:14:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:14:15 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)) 09:14:15 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:14:15 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:14:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:14:15 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 09:14:15 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 09:14:15 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 09:14:15 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 09:14:15 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 09:14:15 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 09:14:18 INFO - Downloading blessings-1.6.tar.gz 09:14:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:14:18 INFO - Installing collected packages: blessings 09:14:18 INFO - Running setup.py install for blessings 09:14:18 INFO - Successfully installed blessings 09:14:18 INFO - Cleaning up... 09:14:18 INFO - Return code: 0 09:14:18 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:14:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:14:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:14:18 INFO - Reading from file tmpfile_stdout 09:14:18 INFO - Current package versions: 09:14:18 INFO - blessings == 1.6 09:14:18 INFO - blobuploader == 1.2.4 09:14:18 INFO - docopt == 0.6.1 09:14:18 INFO - functools32 == 3.2.3-2 09:14:18 INFO - jsonschema == 2.5.1 09:14:18 INFO - manifestparser == 1.1 09:14:18 INFO - mozInstall == 1.12 09:14:18 INFO - mozcrash == 1.0 09:14:18 INFO - mozdebug == 0.1 09:14:18 INFO - mozdevice == 0.49 09:14:18 INFO - mozfile == 1.2 09:14:18 INFO - mozhttpd == 0.7 09:14:18 INFO - mozinfo == 0.9 09:14:18 INFO - mozleak == 0.1 09:14:18 INFO - mozlog == 3.4 09:14:18 INFO - moznetwork == 0.27 09:14:18 INFO - mozprocess == 0.25 09:14:18 INFO - mozprofile == 0.28 09:14:18 INFO - mozrunner == 6.13 09:14:18 INFO - mozscreenshot == 0.1 09:14:18 INFO - mozsystemmonitor == 0.3 09:14:18 INFO - moztest == 0.8 09:14:18 INFO - mozversion == 1.4 09:14:18 INFO - psutil == 3.1.1 09:14:18 INFO - requests == 1.2.3 09:14:18 INFO - wsgiref == 0.1.2 09:14:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:14:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:14:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:14:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:14:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:14:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14:18 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 0x10fb80b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fb83768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdad04653b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f95ed30>, '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 0x10f885db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f953be8>, '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.0jRwKrdhlp/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.rqADtuOjmc/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 09:14:18 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 09:14:18 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 09:14:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0jRwKrdhlp/Render', 09:14:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:14:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:14:18 INFO - 'HOME': '/Users/cltbld', 09:14:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:14:18 INFO - 'LOGNAME': 'cltbld', 09:14:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:14:18 INFO - 'MOZ_NO_REMOTE': '1', 09:14:18 INFO - 'NO_EM_RESTART': '1', 09:14:18 INFO - 'PAGER': '/bin/cat', 09:14:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:14:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:14:18 INFO - 'PWD': '/builds/slave/test', 09:14:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:14:18 INFO - 'SHELL': '/bin/bash', 09:14:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rqADtuOjmc/Listeners', 09:14:18 INFO - 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', 09:14:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:14:18 INFO - 'USER': 'cltbld', 09:14:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:14:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:14:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:14:18 INFO - 'XPC_FLAGS': '0x0', 09:14:18 INFO - 'XPC_SERVICE_NAME': '0', 09:14:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:14:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:14:19 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)) 09:14:19 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)) 09:14:19 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)) 09:14:19 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)) 09:14:19 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)) 09:14:19 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)) 09:14:19 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)) 09:14:19 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)) 09:14:19 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)) 09:14:19 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)) 09:14:19 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)) 09:14:19 INFO - Cleaning up... 09:14:19 INFO - Return code: 0 09:14:19 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:14:19 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')]} 09:14:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:14:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14:19 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')]} 09:14:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:14:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14:19 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 0x10fb80b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fb83768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdad04653b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f95ed30>, '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 0x10f885db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f953be8>, '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.0jRwKrdhlp/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.rqADtuOjmc/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 09:14:19 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 09:14:19 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 09:14:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0jRwKrdhlp/Render', 09:14:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:14:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:14:19 INFO - 'HOME': '/Users/cltbld', 09:14:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:14:19 INFO - 'LOGNAME': 'cltbld', 09:14:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:14:19 INFO - 'MOZ_NO_REMOTE': '1', 09:14:19 INFO - 'NO_EM_RESTART': '1', 09:14:19 INFO - 'PAGER': '/bin/cat', 09:14:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:14:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:14:19 INFO - 'PWD': '/builds/slave/test', 09:14:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:14:19 INFO - 'SHELL': '/bin/bash', 09:14:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rqADtuOjmc/Listeners', 09:14:19 INFO - 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', 09:14:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:14:19 INFO - 'USER': 'cltbld', 09:14:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:14:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:14:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:14:19 INFO - 'XPC_FLAGS': '0x0', 09:14:19 INFO - 'XPC_SERVICE_NAME': '0', 09:14:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:14:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:14:19 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:14:19 INFO - Cleaning up... 09:14:19 INFO - Return code: 0 09:14:19 INFO - Running post-action listener: _resource_record_post_action 09:14:19 INFO - Running post-action listener: _start_resource_monitoring 09:14:19 INFO - Starting resource monitoring. 09:14:19 INFO - [mozharness: 2017-03-08 17:14:19.411439Z] Finished create-virtualenv step (success) 09:14:19 INFO - [mozharness: 2017-03-08 17:14:19.412376Z] Running install step. 09:14:19 INFO - Running pre-action listener: _resource_record_pre_action 09:14:19 INFO - Running main action method: install 09:14:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:14:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:14:19 INFO - Reading from file tmpfile_stdout 09:14:19 INFO - Detecting whether we're running mozinstall >=1.0... 09:14:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:14:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:14:19 INFO - Reading from file tmpfile_stdout 09:14:19 INFO - Output received: 09:14:19 INFO - Usage: mozinstall [options] installer 09:14:19 INFO - Options: 09:14:19 INFO - -h, --help show this help message and exit 09:14:19 INFO - -d DEST, --destination=DEST 09:14:19 INFO - Directory to install application into. [default: 09:14:19 INFO - "/builds/slave/test"] 09:14:19 INFO - --app=APP Application being installed. [default: firefox] 09:14:19 INFO - mkdir: /builds/slave/test/build/application 09:14:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 09:14:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 09:14:40 INFO - Reading from file tmpfile_stdout 09:14:40 INFO - Output received: 09:14:40 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 09:14:40 INFO - Running post-action listener: _resource_record_post_action 09:14:40 INFO - [mozharness: 2017-03-08 17:14:40.194209Z] Finished install step (success) 09:14:40 INFO - [mozharness: 2017-03-08 17:14:40.194391Z] Running run-tests step. 09:14:40 INFO - Running pre-action listener: _resource_record_pre_action 09:14:40 INFO - Running main action method: run_tests 09:14:40 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:14:40 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:14:40 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:14:40 INFO - 2017-03-08 09:14:40.209 screenresolution[1623:7676] starting screenresolution argv=screenresolution get 09:14:40 INFO - 2017-03-08 09:14:40.212 screenresolution[1623:7676] Display 0: 1600x1200x32@60 09:14:40 INFO - 2017-03-08 09:14:40.217 screenresolution[1624:7678] starting screenresolution argv=screenresolution list 09:14:40 INFO - Available Modes on Display 0 09:14:40 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:14:40 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:14:40 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:14:40 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:14:40 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:14:40 INFO - Intel Iris: 09:14:40 INFO - Chipset Model: Intel Iris 09:14:40 INFO - Type: GPU 09:14:40 INFO - Bus: Built-In 09:14:40 INFO - VRAM (Dynamic, Max): 1536 MB 09:14:40 INFO - Vendor: Intel (0x8086) 09:14:40 INFO - Device ID: 0x0a2e 09:14:40 INFO - Revision ID: 0x0009 09:14:40 INFO - Displays: 09:14:40 INFO - Display: 09:14:40 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:14:40 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:14:40 INFO - Display Serial Number: 1600x1200 60 09:14:40 INFO - Main Display: Yes 09:14:40 INFO - Mirror: Off 09:14:40 INFO - Online: Yes 09:14:40 INFO - Rotation: Supported 09:14:40 INFO - Return code: 0 09:14:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:14:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:14:40 INFO - Python 2.7.3 09:14:40 INFO - Return code: 0 09:14:40 INFO - grabbing minidump binary from tooltool 09:14: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')]} 09:14: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 0x10f95ed30>, '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 0x10f885db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f953be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:14: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 09:14: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 09:14: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 09:14:40 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:14:40 INFO - Return code: 0 09:14:40 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:14:40 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:14:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:14:40 INFO - ENV: RUST_BACKTRACE is now 1 09:14:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:14:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:14: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', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/W814j9yQSNy3dAL9zQLoiA/artifacts/public/build/firefox-55.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_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 09:14: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 --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/W814j9yQSNy3dAL9zQLoiA/artifacts/public/build/firefox-55.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_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 09:14:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0jRwKrdhlp/Render', 09:14:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:14:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:14:40 INFO - 'HOME': '/Users/cltbld', 09:14:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:14:40 INFO - 'LOGNAME': 'cltbld', 09:14:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:14:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:14:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:14:40 INFO - 'MOZ_NO_REMOTE': '1', 09:14:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:14:40 INFO - 'NO_EM_RESTART': '1', 09:14:40 INFO - 'PAGER': '/bin/cat', 09:14:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:14:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:14:40 INFO - 'PWD': '/builds/slave/test', 09:14:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:14:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:14:40 INFO - 'RUST_BACKTRACE': '1', 09:14:40 INFO - 'SHELL': '/bin/bash', 09:14:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rqADtuOjmc/Listeners', 09:14:40 INFO - 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', 09:14:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:14:40 INFO - 'USER': 'cltbld', 09:14:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:14:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:14:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:14:40 INFO - 'XPC_FLAGS': '0x0', 09:14:40 INFO - 'XPC_SERVICE_NAME': '0', 09:14:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:14:40 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/W814j9yQSNy3dAL9zQLoiA/artifacts/public/build/firefox-55.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_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 09:14:40 INFO - mozversion application_buildid: 20170308073826 09:14:40 INFO - mozversion application_changeset: 70790a08686d78e9f3bb83094c2c04bf1dad20f3 09:14:40 INFO - mozversion application_display_name: Nightly 09:14:40 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:14:40 INFO - mozversion application_name: Firefox 09:14:40 INFO - mozversion application_remotingname: firefox 09:14:40 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:14:40 INFO - mozversion application_vendor: Mozilla 09:14:40 INFO - mozversion application_version: 55.0a1 09:14:40 INFO - mozversion platform_buildid: 20170308073826 09:14:40 INFO - mozversion platform_changeset: 70790a08686d78e9f3bb83094c2c04bf1dad20f3 09:14:40 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:14:40 INFO - mozversion platform_version: 55.0a1 09:14:40 INFO - using testdate: 1488993280 09:14:40 INFO - actual date: 1488993280 09:14:40 INFO - starting webserver on 'localhost:49240' 09:14:40 INFO - SUITE-START | Running 2 tests 09:14:40 INFO - TEST-START | dromaeo_css 09:14:40 INFO - operating with platform_type : mac_ 09:14:40 INFO - Initialising browser for dromaeo_css test... 09:14:40 INFO - TEST-INFO | started process 1634 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/tmp20xw3b/profile http://localhost:49240/getInfo.html) 09:14:43 INFO - PROCESS | 1634 | __metrics Screen width/height:1600/1200 09:14:43 INFO - PROCESS | 1634 | colorDepth:24 09:14:43 INFO - PROCESS | 1634 | Browser inner width/height: 1024/689 09:14:43 INFO - PROCESS | 1634 | __metrics 09:14:43 INFO - PROCESS | 1634 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:14:43 INFO - PROCESS | 1634 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:14:44 INFO - TEST-INFO | 1634: exit 0 09:14:44 INFO - Browser initialized. 09:14:44 INFO - Running cycle 1/1 for dromaeo_css test... 09:14:44 INFO - TEST-INFO | started process 1636 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/tmp20xw3b/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:14:57 INFO - PROCESS | 1636 | RSS: Main: 232296448 09:14:57 INFO - PROCESS | 1636 | 09:18:02 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49240/tests/dromaeo/cssquery-ext.html) 09:18:04 INFO - PROCESS | 1636 | RSS: Main: 406138880 09:18:04 INFO - PROCESS | 1636 | 09:19:46 INFO - PROCESS | 1636 | ************************* 09:19:46 INFO - PROCESS | 1636 | A coding exception was thrown and uncaught in a Task. 09:19:46 INFO - PROCESS | 1636 | 09:19:46 ERROR - PROCESS | 1636 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:19:46 INFO - PROCESS | 1636 | Full stack: 09:19:46 INFO - PROCESS | 1636 | ************************* 09:21:06 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-ext.html (next: http://localhost:49240/tests/dromaeo/cssquery-jquery.html) 09:21:07 INFO - PROCESS | 1636 | RSS: Main: 366174208 09:21:07 INFO - PROCESS | 1636 | 09:24:10 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49240/tests/dromaeo/cssquery-mootools.html) 09:24:10 INFO - PROCESS | 1636 | RSS: Main: 341700608 09:24:10 INFO - PROCESS | 1636 | 09:27:13 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49240/tests/dromaeo/cssquery-prototype.html) 09:27:13 INFO - PROCESS | 1636 | RSS: Main: 360718336 09:27:13 INFO - PROCESS | 1636 | 09:30:17 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49240/tests/dromaeo/cssquery-yui.html) 09:30:18 INFO - PROCESS | 1636 | RSS: Main: 337444864 09:30:18 INFO - PROCESS | 1636 | 09:33:21 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-yui.html (next: http://localhost:49240/tests/dromaeo/cssquery-dojo.html) 09:33:22 INFO - PROCESS | 1636 | RSS: Main: 454369280 09:33:22 INFO - PROCESS | 1636 | 09:33:22 INFO - PROCESS | 1636 | __start_tp_report 09:33:22 INFO - PROCESS | 1636 | _x_x_mozilla_page_load 09:33:22 INFO - PROCESS | 1636 | _x_x_mozilla_page_load_details 09:33:22 INFO - PROCESS | 1636 | |i|pagename|runs| 09:33:22 INFO - PROCESS | 1636 | |0;dojo.html;3373.325334933014;3407.7784943978654;3408.2842603053364;3410.266792639583;3425.6745609167137;5619.550435965123;5720.056190728525;5804.332501762298;5891.558133140015;5903.6162649427815;5743.195952566633;5828.009238429467;5875.441833025867;5893.322267939199;5911.408859114097;5226.843194704165;5302.337207849019;5310.283111779899;5335.973320133394;5344.518993290603;5338.412774594792;5390.380106287768;5396.568274538027;5413;5443.374011988632;5189.948100519022;5210.53105220532;5266.894662106774;5269.235960785703;5359.839204823842;5279.973600131974;5281.63028587999;5282.471752824726;5285;5286.3127793387;5188.273641690166;5230.503102205284;5235.712035838027;5257.737113144328;5260.184671375943;5726.942730572682;5730.942690573124;5733.312002559678;5734.483896449298;5735;6251.562390632657;6252.062190671436;6257.906131408033;6258;6259.311475737665;6178.660173690445;6288.371162883721;6318.684065796738;6329.746810127589;6343.175387199681;5830.62100963436;5840.97079514604;5928.02187639039;5943.465088142088;5986.910196347058;6472.482201423874;6505.642189679518;6507.772227971998;6513.2509761377105;6517.706703198368;6120.965252118766;6172.074188871705;6219.036049412348;6351.841203969938;6356.77751278703;6306.49548036156;6342.619442833445;6345.746170153235;6355.491560675135;6358.1734374531015;6370.904436433457;6374.904376434357;6386.265579458329;6392.552521323462;6397.4562162216735;6182.350853160443;6233.875322493615;6353.174087368612;6394.936050639527;6415.582987105917;4981.352424184833;5054.620903432257;5058.46886076964;5064.240363945364;5067.5439210470495;4459.353393757951;4525.366448697185;4541.863744087683;4573.131105090089;4587.839425620087;5808.244928159397;5814.738336774855;5822.301323841081;5824.728620598281;5838.182654428383;6291.874162516724;6354.904676429857;6378.968105159537;6380.521460890359;6384.3934826191435;4601.930971035437;5804.564657650693;5880.617759845596;5907.970460147758;5950.464458198696;4631.374764406762;5581.6930068846605;5595.63628364155;5604.131359639263;5606.299212598426;6533.444657204001;6536.640484773288;6538.934610653832;6542.54202205841;6546.214454265519;6269.0909818075215;6322.114903913363;6358.491320694426;6374.4263016326895;6385.329540398191;6347.17486726741;6363.395477429637;6365.936340636719;6371;6451.548391612542;5313.681179129265;6345.936540634534;6361.109444677656;6380.425761681471;6393.1369265148605;4837.443693975238;6300.9684951574945;6368.777092801915;6375.394337537927;6398.744050237939;5940.821775346746;6312.621242725451;6321.841953951188;6321.905171422524;6327.778527751507;6137.018077107641;6139.246828488627;6149.2313460817395;6162.568620196544;6227.065940108839;6110.406879924546;6134.7121296814075;6135.177818203676;6137.249026071286;6140.473573783631;6268.717907694256;6273.843153921189;6276.8430789228805;6283.71723272463;6290.056491526308;5861.706914654165;5887.499562537232;5974.37269086757;5985.820425387245;6050.485708714808 09:33:22 INFO - PROCESS | 1636 | |1;ext.html;722.7217521254319;774.1136398823347;794.2295972906279;863.9956800215998;871.363904349825;28621.284467888287;38986.41520377197;39501.209975800506;41582.99999999993;41745.7912710436;40069.198616027665;40240.19519609613;40279.99300017501;40284.59715402845;40334;7331.633418329062;8192.262696357328;9103.816503854507;9421.858672119924;9432.151106400423;7401.925980740204;7492.700291988314;7501.962490187541;7507.9624601877185;7516.285952834472;11095.611653592126;11321.830172547418;11448.22552504359;11450.656480305563;11454.770904581903;11151.330920144777;11220.270682405699;11224.66326010221;11235.21353505255;11243.99999999996;7283.126024877049;10906.890931090667;10982;10989.945050274777;10997.065249453806;27574;27770.02804901839;27826.860865695744;37855.810720946494;38550.03624909372;3823.751456155369;3833.17586718854;3872.1674839909556;3875.4961854958956;3887.844486220548;27311.634418279005;27335.863320683467;27986.3003424914;28331.291717707016;28842.278943026384;3084.8766049358;3091.9690803091908;3117.173948903542;3192.680731926812;3211.4058899103507;239226;292174;293854;294170;294195;49235.015299694525;49453.75273123683;49460;49520;49629.50370496321;52091.47908520942;52101;52123.739381302854;52125.95748085017;52193;11478.827817582744;13840.723185536233;13907.443702252;13931.721365572632;13945.721085578434;12014.279143251433;12031.398430078636;12036.458359373673;12036.916677499066;12043.698907527381;9978.151857092083;10036.698899033041;10173.33873298248;11586.073114150848;11644;4499.437570303712;4636.5131661175765;4876.902461950741;5472.5621950243885;5555.111182210827;923.6213152607532;1085.4247248958065;1137.3062431916524;1141.4863311509853;1189.583645724007;19768.604627907647;23431.7656823433;25636.871815640803;25739.742602573733;25828.612570811452;1223.590097317391;1224.2287358963795;1224.6020043485903;1282.4805953588811;1293.1852932652369;12943.741125177443;12977.545785897637;13104.148230364995;13341.132826366254;13479.05646604748;358831;359372;360288;360732;361519;52431.73784131055;52453.95092098137;52567.474325256255;52640.47359526356;52818;1366.8223130993106;1436.2603259321459;1442.473497173524;1443.480347075073;1445.6241377241784;24002.22196872403;24526.754732453162;24526.77366131722;24614.876925615972;24633.507329853663;42223.94440139021;42250.73247802571;42311.576884231996;42343.3648495279;42499.787501062296;344234.27882860426;344341;345606;347185;348551;30816.53775193329;31638.683613163576;31736.523952140273;31770;31818.6818131825;40697.79651101726;41036;41191.588084118775;41344;41717.79141104275;29222;30828.845855770578;32688.673113268564;34156.03628194743;35355.82322088373;33361.666383335854;33766.66233337635;34617.42268968888;34771.65228347684;34931.82534087313;33539.329213415105;33673.66326336705;34224.14439639029;34271.828640856635;34888;29595.556066658588;29873.253168670955;29956.550651739806;30001;30203.244918877204;22783.430414239778;23077.076916923135;23323.766762332158;23416.326346991027;23620.17329393463 09:33:22 INFO - PROCESS | 1636 | |2;jquery.html;385.88423472958107;396.7857357027204;410.45409605225046;419.42748148776917;439.47263284059136;12969.416376263067;14871.479498217564;17877.28490860364;20969.47576310593;21365;21695;22081.33755987323;22124.446888827788;22402;22735.317940461813;5760.942390576082;5950.375210602868;6265.154204182434;6562.770303039395;6761.695723692445;4075.1238483725992;6701.229358623772;6715.9590263509235;6776.220734615508;6778.423833974093;4419.845305414295;4474.0828130233385;7665.808354791119;7752.108507521651;7752.844943101135;6559.737610495575;7190.352868241831;7390.408767298603;7619.80950476237;7676.002119724456;7114.750983715545;7386.889196662054;7408.925910740877;7409.629518524052;7419.36935360495;26666.06668766584;26861.462770744474;26885.731142688517;27230.31924201891;27261.591076133875;2844.687084420712;2877.2087675889297;2879.9280017999718;2882.553204253323;2897.246715853872;15796.447124350707;16275;16282.348706051744;16507.009579425274;16744.497665070066;1626.7604582788258;1673.3557580331537;1984.7915968823354;1996.3012945469115;2066.2974588639786;114486;117649;117892.41053794762;118164;118906;16703.41538046187;20752.896235518725;21204.36386908395;21330;21341;35395.64604353975;35839.4624080639;35910.38403271859;35940;35961.8201908994;10136.493175341351;10211.489425528694;10414.427206503715;10415.94792026035;10545.630902918361;6750;8344.290735287446;8362.58187090643;8520.914790852135;8547.35894807892;10377.9481102594;10437.425941573287;10507.651736124966;10644.574217031386;10669.35983840972;3609.9278014439565;3743.9251214975548;3897.415387691812;3985.282649123186;4004.839806407711;1042.3849928542197;1086.5165001574223;1090.8309212072143;1099.2030777686273;1136.539701420926;21594.789016142015;22966.196183133845;23000.424989375064;23025.769742302364;23076.88461557715;998.7553049502918;1108.9667309980714;1109.9500522476508;1130.9377984210948;1134.1380550781466;10381.806092299332;11150.888491114985;11905;12122.636320910387;12165.20926139798;477511;511050;566286;577250;651436.9712605816;110053;119431.40284298523;127666;130194.34902825615;137368.31315843356;1100.7688385439149;1196.4675719304826;1281.372127657441;1300.752856957175;1301.0372324480006;13825.308734563432;17016.744748829024;19686.40940771779;19690.50773730668;19981.400557983285;57927.84144317175;60212.69893650504;61642;61657.07514387198;61664;80647;81645;82133;82247;83660;11312.434378281218;11381.487833047699;11492.337776358767;11770;11831.704207394883;12900.8064879025;13089.149205301625;13311.134776239513;13491.257980810757;13573.457061717816;11390.658280251606;11615.303081815118;11732.41337933117;11806.763864722829;11833.230839995373;8574.914250857411;11042.613508527164;11091.223614347242;11394.886051139383;11401.315921044765;11424.314541127558;11458.197926145423;11531.94234028858;11550;11793.410329483662;11483.770324593293;11673;11692.064634829363;11713.590024349107;11744.354060526754;11112.833307500556;11292.548298067984;11340.773184536429;11468.19722619442;11483 09:33:22 INFO - PROCESS | 1636 | |3;mootools.html;1390.3187438155303;1576.5112815027348;1577.171984708028;1596.1620149421544;1606.983930160698;10414.739631509206;11058.778824423507;11080.556777728882;11087.27932684376;11091.057260132879;10275.28073034886;10780.676579702602;10843.891561084387;11001.889981100187;11004.834927476095;2192.243675931801;2227.7883601057874;2228.2646726580188;2229.7101376820992;2230.4423894026495;2010.3968809357207;2230.3754948614333;2257.89839457224;2295.9655605165935;2299.678045073691;2322.6632138339933;2338.0764597983784;2344.589696803061;2353.6587194856734;2356.9764302357016;2207.2716003718733;2221.255879280443;2230.6430971044715;2236.9217077402295;2237.474193564511;2237.407087121914;2303.976960230393;2306.6736626439697;2311.9768802312096;2312.3409828198883;10733.355998640107;10806.29759065666;10832.916708329183;10834.458277086114;10841.186910981707;5578.9163162552595;5773;5780.1907732917425;5781.768729250825;5781.797637082724;3214.758893083028;3308.6856748608843;3519.4544845548726;3528.276703275848;3532.452469867175;1215.094754407963;1220.2190598017276;1756.6223261998605;1801.306496998665;1884.481767513931;14540.49108281205;15054.041295003311;15110.848891511054;15130.016548924285;15135.470258541009;4285.10012897295;4831.492693267156;4898.8775280618265;4903.87740306488;4926.975365123151;12186.939065304794;12648.241105533514;12681.30252836103;12681.49274029047;12719.809202861965;5340.626156169109;5832.766689332464;5881.911771323434;5884.911726324109;5905.970470147622;5192.714400707921;5195.064888320063;5196.298499702568;5196.818111366159;5197.168453047494;3782.4176455383304;3923.803809809498;3979.1245925896837;4009;4018.216447792711;1022.9208185364363;1065.3820783945293;1086.1473743111778;1116.1684545013854;1134.5915470430639;799.5522507395877;807.9515229086156;820.5979070255531;828.4201059258543;829.8921140251729;5825.24271844666;5838.919799837044;6156.753729850756;6522.282548919615;6572.244191917991;740.7074205688831;998.8951160128228;1007.7833265847878;1060.9257351985286;1065.4086981725218;3930.941035884464;3999.6000399960353;4048.4332193492933;4160.854370097032;4162.812673429703;12729.681757956125;13266.867331326755;13266.938644908385;13296.002799790054;13314.06801523884;13192.47230110804;13204.669883252804;13209;13216.94264458841;13218.801717974238;9555.996620354901;9707.320487565803;9779.364341317792;9968.700938971842;10007.549660265451;6242.719077641608;6404.807855764335;6417.2299324081405;6473.77341793035;6604.207495100619;10345.74135646615;11423.743388227454;11676.06591472697;11818.81351949892;12143.635690929286;11715.648530544097;11871.940640296743;12125.333106678865;12146.817797732865;12314.50741970347;8987.41581797181;9039.457632541806;9080.739227063323;9165.404248723811;9188.264938804747;9928;9956.601735930482;10070.19438444908;10085.29402941787;10093.646722364681;8571.65713371483;8786.824263514822;8830.823383532164;8909.198172164537;8939.418937769024;8429.578521074045;8669.263112635497;8695.434796738191;8859.689910853089;8860.025397206431;7575;7747.457677962489;7750.031246094239;7754.418418618513;7758.456908016385;5611.971940140274;5705.087186050212;5796.362400136066;5860.853478663067;5905.852353691021;5046.394432667957;5207.6875387476875;5822.272215973004;5865.266841644794;6105.694715264308 09:33:22 INFO - PROCESS | 1636 | |4;prototype.html;332.56766203934876;360.12489650150127;365.8298891015678;380.3875760026357;384.89030626271517;4009.398590211466;4647.86056418308;4827.78274977626;4878.48775878533;4884.242942343938;4348.456442944632;4733.154069912737;4895.9020819583675;4906.877328066791;4940.333055037569;3495.7727747696317;3892.9805350973274;4351.912961740763;4386.714863533876;4425.557444255581;4256.87229383119;4404.69167158299;4413.205622987861;4434.556544345572;4443.244648409762;3465.5668041494814;3935.704822138351;3962.0491082140225;3975.1652153047894;4401.735895846244;3818.4654148419245;4134.214499245164;4134.751914885116;4171.581662234855;4370.497392799821;3771.133938206955;4010.5187377514594;4018.819153138116;4093.9181216375505;4110.547839737626;4191.832326706928;4841.636877234187;4958.528939750718;4979.278004689336;5012.8496145115705;4229.471316085489;4255.55316691746;4734.621230301567;4825.131476334259;5028.823991160292;4802.5197480252045;5307.469253074701;5473.589480788957;5488.780448782044;5515.310586176728;3876.2635099331037;4028.8589899353383;4214.163383713548;4330.350447432878;4356.847510337123;5319.276506445503;5334.653247538898;5685.488306052475;5810.5932584719085;5890;4172.186423647359;4400.163968845909;4412.492068805307;4446.377507149002;4448.688591798543;4457.398251236106;4536.455625324916;4571.885702857388;4577.48942848859;4582.702124361906;4166.626027758026;4203.495580530356;4751;4844.8304309349005;4857.906970931583;4453.599176074104;4939.975300123477;5332.706701131475;5412.161115027177;5440.863978400572;1256.447163248168;1357.0568454923732;1376.779715245556;1455.5415044261024;1526.9618259543379;1004.477671610773;1011.4322799660497;1139.6353166986485;1169.216624861345;1170.2919733561073;4817.0606731686985;4864.246041863516;5056.367954005749;5101.51535604117;5126.410462796752;5146.459621739664;5371.650842695212;5385.380681221632;5534.647774695738;5672.659640421588;4784.354112194878;4865.683730557503;5020.59835213182;5032.345795046621;5063.265826455217;2599.6880374355196;2678.611601317798;2921.561765735114;2930.6776254611977;2933.090741870027;4232.724872883253;4920.803167873245;5330.307060082242;5502.614816962854;5567.603761705356;4822.12964905441;4824.684151607248;5496.6701997880255;5565.9443405566235;5584.253384623119;4831.806727730851;5027.522385373383;5538.9169162462595;5725.942740572541;5763.8673690734695;5275.551578115903;5308.336457942757;5553.777848886161;5624.216013073555;5627.634203776742;4751.857444276678;4772.403449568804;5021.623378246573;5235.502627250406;5461.972690136524;5322.498425739896;5556.249906262603;5857.824265272048;5871;5886.823395298148;3809.790461524532;4387.319965405367;4389.948985455206;4401.701498058144;4438.977805110953;5011;5371.274877891435;5524.944750552604;5678.0915053591225;5740.39725828782;4972.383975208144;5011.8950040982145;5038.521340472649;5515.200295956984;5527.613067085265;4351.692713537671;5103.932907172601;5383.062097644766;5391.987933454248;5439.5648348132845;4728.574428301469;4859.032092002744;5182.378114626269;5188.316295430287;5193.610479213999;4812.614990800797;5419.756110975094;5436.429174936733;5445.53712934405;5471.644343117685;4406.493253275914;5052.46949070357;5251.8708477675955;5257.896841263525;5293.682379057269 09:33:22 INFO - PROCESS | 1636 | |5;yui.html;726.6439444672112;745.5116898431529;771.9691212351506;773.9883901741475;847.1486156412805;15013.249337533121;15173.468928587501;15740.449084282052;15999.520014399557;16013.519594412186;14645.92677036616;14773.261336933137;14785.260736963135;14793.408263669467;14797.55607331779;739.7004213293625;918.6463211663507;939.9906000939972;945.1446440970898;946.0303189231059;939.4879790514152;940.407543247753;942.0532364973227;942.354487176283;942.4157022645969;932.137772560379;968.801395713877;982.287841315048;983.1593987140999;992.7567745902264;957.674390707163;958.4393130018947;958.755517343073;960.663767681313;961.1541843178029;715.6099925540593;716.201435399531;719.3130560314939;719.5682590445743;719.6401799100449;15289;15517.767233491506;15582.532524024298;15591.766123508156;15875.047497150208;13773.655658608515;13987.300634968211;14088.15471071739;14133.222672752994;14176.787348189786;11563.364014979257;11615.593454229145;11793.410329483491;11829.526818927232;12067.275963442222;3124.6875312468796;3548.538689970313;3565.5721313442555;3622.1850083731215;3704.833282502267;72803;94638.31903518588;95045.5743163853;95714.04285957121;97018.51490742501;10510.316829406063;10569.947150264354;10760.623378181726;10772.78454430907;10891.455427228608;21877.562448750938;22064.33806985793;22073.668894966268;22079.44801379946;22084.447888802588;7387.7783666490095;7510.286522780327;7518.210587888302;7597.544147351176;7738.961305193438;4146.751194928314;4193.329067349209;4244.808983595745;4397.40635014269;4414.3157810539415;3315.950260746091;3411.8570278956827;3416.0947348952545;3416.641252668434;3421.2473255883665;610.9358517355703;648.144449326884;648.5298158834808;655.1712084213474;656.6093174561129;588.9587728859025;653.4608947618234;672.3243140643622;712.7113519024804;718.795143384133;9264.536773161315;9618.797650293713;9683.198471231117;9942.80114397708;10138.847917281246;585.7215431969641;629.4869681209799;648.6951132967498;682.436989483678;699.7620808924888;4288.593628516676;4770.76146192689;4932.482089380635;4991.575716064102;4994.925076123861;76529.85205221926;80626.5968670153;80717.78923316154;92470.61294080594;95408;70732.2926770736;70962.9355559667;75815.48369032699;76298.6185069071;76879.61560192275;58651.70674146602;67291.32708672949;68031.31968680349;71116.64441677759;71413;10547.367157970546;10580.259381843198;10632.468376580986;10860.185486088418;11035.72410689707;35185.64814351926;44108.558914411726;46438.535614644774;46661.766691166325;47029.05941881212;58207.4179258202;59409.702951484964;59520.51198720067;59679.403205967385;59965.700171498866;10866.61966831157;10929.581387484202;10984.615538456115;11045.889541104487;11111.833322500008;11814.173007889365;11897.94051029774;11967.281963082243;12004.819927701266;12148.817767733668;13095.607131786062;13503.39234734459;13736.93131534336;13757.587272381845;14141;11749.47127379253;13292.42741694119;13457.596272111852;13483.258420786951;13886.93056534711;13319.667008324483;13458.46166153382;13541.390637421142;13644.795328069888;13776.793348099987;9843.375842986114;10633.361998280128;10682.145428365557;10914.454277285946;11436.771264574496;9860.408375497493;10376.429296388469;11195.160362972647;11227.214095013598;11308.943455282671 09:33:22 INFO - PROCESS | 1636 | __end_tp_report 09:33:22 INFO - PROCESS | 1636 | __start_cc_report 09:33:22 INFO - PROCESS | 1636 | _x_x_mozilla_cycle_collect,1792 09:33:22 INFO - PROCESS | 1636 | __end_cc_report 09:33:22 INFO - PROCESS | 1636 | __startTimestamp1488994402159__endTimestamp 09:33:22 INFO - PROCESS | 1636 | 09:33:22 INFO - PROCESS | 1636 | ------- Summary: start ------- 09:33:22 INFO - PROCESS | 1636 | Number of tests: 6 09:33:22 INFO - PROCESS | 1636 | 09:33:22 INFO - PROCESS | 1636 | [#0] dojo.html Cycles:165 Average:5834.48 Median:6050.49 stddev:672.23 (11.1%) stddev-sans-first:645.97 09:33:22 INFO - PROCESS | 1636 | Values: 3373.3 3407.8 3408.3 3410.3 3425.7 5619.6 5720.1 5804.3 5891.6 5903.6 5743.2 5828.0 5875.4 5893.3 5911.4 5226.8 5302.3 5310.3 5336.0 5344.5 5338.4 5390.4 5396.6 5413.0 5443.4 5189.9 5210.5 5266.9 5269.2 5359.8 5280.0 5281.6 5282.5 5285.0 5286.3 5188.3 5230.5 5235.7 5257.7 5260.2 5726.9 5730.9 5733.3 5734.5 5735.0 6251.6 6252.1 6257.9 6258.0 6259.3 6178.7 6288.4 6318.7 6329.7 6343.2 5830.6 5841.0 5928.0 5943.5 5986.9 6472.5 6505.6 6507.8 6513.3 6517.7 6121.0 6172.1 6219.0 6351.8 6356.8 6306.5 6342.6 6345.7 6355.5 6358.2 6370.9 6374.9 6386.3 6392.6 6397.5 6182.4 6233.9 6353.2 6394.9 6415.6 4981.4 5054.6 5058.5 5064.2 5067.5 4459.4 4525.4 4541.9 4573.1 4587.8 5808.2 5814.7 5822.3 5824.7 5838.2 6291.9 6354.9 6379.0 6380.5 6384.4 4601.9 5804.6 5880.6 5908.0 5950.5 4631.4 5581.7 5595.6 5604.1 5606.3 6533.4 6536.6 6538.9 6542.5 6546.2 6269.1 6322.1 6358.5 6374.4 6385.3 6347.2 6363.4 6365.9 6371.0 6451.5 5313.7 6345.9 6361.1 6380.4 6393.1 4837.4 6301.0 6368.8 6375.4 6398.7 5940.8 6312.6 6321.8 6321.9 6327.8 6137.0 6139.2 6149.2 6162.6 6227.1 6110.4 6134.7 6135.2 6137.2 6140.5 6268.7 6273.8 6276.8 6283.7 6290.1 5861.7 5887.5 5974.4 5985.8 6050.5 09:33:22 INFO - PROCESS | 1636 | 09:33:22 INFO - PROCESS | 1636 | [#1] ext.html Cycles:180 Average:47604.25 Median:17505.68 stddev:87286.07 (498.6%) stddev-sans-first:87459.96 09:33:22 INFO - PROCESS | 1636 | Values: 722.7 774.1 794.2 864.0 871.4 28621.3 38986.4 39501.2 41583.0 41745.8 40069.2 40240.2 40280.0 40284.6 40334.0 7331.6 8192.3 9103.8 9421.9 9432.2 7401.9 7492.7 7502.0 7508.0 7516.3 11095.6 11321.8 11448.2 11450.7 11454.8 11151.3 11220.3 11224.7 11235.2 11244.0 7283.1 10906.9 10982.0 10989.9 10997.1 27574.0 27770.0 27826.9 37855.8 38550.0 3823.8 3833.2 3872.2 3875.5 3887.8 27311.6 27335.9 27986.3 28331.3 28842.3 3084.9 3092.0 3117.2 3192.7 3211.4 239226.0 292174.0 293854.0 294170.0 294195.0 49235.0 49453.8 49460.0 49520.0 49629.5 52091.5 52101.0 52123.7 52126.0 52193.0 11478.8 13840.7 13907.4 13931.7 13945.7 12014.3 12031.4 12036.5 12036.9 12043.7 9978.2 10036.7 10173.3 11586.1 11644.0 4499.4 4636.5 4876.9 5472.6 5555.1 923.6 1085.4 1137.3 1141.5 1189.6 19768.6 23431.8 25636.9 25739.7 25828.6 1223.6 1224.2 1224.6 1282.5 1293.2 12943.7 12977.5 13104.1 13341.1 13479.1 358831.0 359372.0 360288.0 360732.0 361519.0 52431.7 52454.0 52567.5 52640.5 52818.0 1366.8 1436.3 1442.5 1443.5 1445.6 24002.2 24526.8 24526.8 24614.9 24633.5 42223.9 42250.7 42311.6 42343.4 42499.8 344234.3 344341.0 345606.0 347185.0 348551.0 30816.5 31638.7 31736.5 31770.0 31818.7 40697.8 41036.0 41191.6 41344.0 41717.8 29222.0 30828.8 32688.7 34156.0 35355.8 33361.7 33766.7 34617.4 34771.7 34931.8 33539.3 33673.7 34224.1 34271.8 34888.0 29595.6 29873.3 29956.6 30001.0 30203.2 22783.4 23077.1 23323.8 23416.3 23620.2 09:33:22 INFO - PROCESS | 1636 | 09:33:22 INFO - PROCESS | 1636 | [#2] jquery.html Cycles:180 Average:35832.03 Median:11023.85 stddev:93528.42 (848.4%) stddev-sans-first:93752.93 09:33:22 INFO - PROCESS | 1636 | Values: 385.9 396.8 410.5 419.4 439.5 12969.4 14871.5 17877.3 20969.5 21365.0 21695.0 22081.3 22124.4 22402.0 22735.3 5760.9 5950.4 6265.2 6562.8 6761.7 4075.1 6701.2 6716.0 6776.2 6778.4 4419.8 4474.1 7665.8 7752.1 7752.8 6559.7 7190.4 7390.4 7619.8 7676.0 7114.8 7386.9 7408.9 7409.6 7419.4 26666.1 26861.5 26885.7 27230.3 27261.6 2844.7 2877.2 2879.9 2882.6 2897.2 15796.4 16275.0 16282.3 16507.0 16744.5 1626.8 1673.4 1984.8 1996.3 2066.3 114486.0 117649.0 117892.4 118164.0 118906.0 16703.4 20752.9 21204.4 21330.0 21341.0 35395.6 35839.5 35910.4 35940.0 35961.8 10136.5 10211.5 10414.4 10415.9 10545.6 6750.0 8344.3 8362.6 8520.9 8547.4 10377.9 10437.4 10507.7 10644.6 10669.4 3609.9 3743.9 3897.4 3985.3 4004.8 1042.4 1086.5 1090.8 1099.2 1136.5 21594.8 22966.2 23000.4 23025.8 23076.9 998.8 1109.0 1110.0 1130.9 1134.1 10381.8 11150.9 11905.0 12122.6 12165.2 477511.0 511050.0 566286.0 577250.0 651437.0 110053.0 119431.4 127666.0 130194.3 137368.3 1100.8 1196.5 1281.4 1300.8 1301.0 13825.3 17016.7 19686.4 19690.5 19981.4 57927.8 60212.7 61642.0 61657.1 61664.0 80647.0 81645.0 82133.0 82247.0 83660.0 11312.4 11381.5 11492.3 11770.0 11831.7 12900.8 13089.1 13311.1 13491.3 13573.5 11390.7 11615.3 11732.4 11806.8 11833.2 8574.9 11042.6 11091.2 11394.9 11401.3 11424.3 11458.2 11531.9 11550.0 11793.4 11483.8 11673.0 11692.1 11713.6 11744.4 11112.8 11292.5 11340.8 11468.2 11483.0 09:33:22 INFO - PROCESS | 1636 | 09:33:22 INFO - PROCESS | 1636 | [#3] mootools.html Cycles:180 Average:6621.28 Median:2355.32 stddev:4139.22 (175.7%) stddev-sans-first:4132.16 09:33:22 INFO - PROCESS | 1636 | Values: 1390.3 1576.5 1577.2 1596.2 1607.0 10414.7 11058.8 11080.6 11087.3 11091.1 10275.3 10780.7 10843.9 11001.9 11004.8 2192.2 2227.8 2228.3 2229.7 2230.4 2010.4 2230.4 2257.9 2296.0 2299.7 2322.7 2338.1 2344.6 2353.7 2357.0 2207.3 2221.3 2230.6 2236.9 2237.5 2237.4 2304.0 2306.7 2312.0 2312.3 10733.4 10806.3 10832.9 10834.5 10841.2 5578.9 5773.0 5780.2 5781.8 5781.8 3214.8 3308.7 3519.5 3528.3 3532.5 1215.1 1220.2 1756.6 1801.3 1884.5 14540.5 15054.0 15110.8 15130.0 15135.5 4285.1 4831.5 4898.9 4903.9 4927.0 12186.9 12648.2 12681.3 12681.5 12719.8 5340.6 5832.8 5881.9 5884.9 5906.0 5192.7 5195.1 5196.3 5196.8 5197.2 3782.4 3923.8 3979.1 4009.0 4018.2 1022.9 1065.4 1086.1 1116.2 1134.6 799.6 808.0 820.6 828.4 829.9 5825.2 5838.9 6156.8 6522.3 6572.2 740.7 998.9 1007.8 1060.9 1065.4 3930.9 3999.6 4048.4 4160.9 4162.8 12729.7 13266.9 13266.9 13296.0 13314.1 13192.5 13204.7 13209.0 13216.9 13218.8 9556.0 9707.3 9779.4 9968.7 10007.5 6242.7 6404.8 6417.2 6473.8 6604.2 10345.7 11423.7 11676.1 11818.8 12143.6 11715.6 11871.9 12125.3 12146.8 12314.5 8987.4 9039.5 9080.7 9165.4 9188.3 9928.0 9956.6 10070.2 10085.3 10093.6 8571.7 8786.8 8830.8 8909.2 8939.4 8429.6 8669.3 8695.4 8859.7 8860.0 7575.0 7747.5 7750.0 7754.4 7758.5 5612.0 5705.1 5796.4 5860.9 5905.9 5046.4 5207.7 5822.3 5865.3 6105.7 09:33:22 INFO - PROCESS | 1636 | 09:33:22 INFO - PROCESS | 1636 | [#4] prototype.html Cycles:180 Average:4488.91 Median:4829.79 stddev:1248.89 (25.9%) stddev-sans-first:1212.80 09:33:22 INFO - PROCESS | 1636 | Values: 332.6 360.1 365.8 380.4 384.9 4009.4 4647.9 4827.8 4878.5 4884.2 4348.5 4733.2 4895.9 4906.9 4940.3 3495.8 3893.0 4351.9 4386.7 4425.6 4256.9 4404.7 4413.2 4434.6 4443.2 3465.6 3935.7 3962.0 3975.2 4401.7 3818.5 4134.2 4134.8 4171.6 4370.5 3771.1 4010.5 4018.8 4093.9 4110.5 4191.8 4841.6 4958.5 4979.3 5012.8 4229.5 4255.6 4734.6 4825.1 5028.8 4802.5 5307.5 5473.6 5488.8 5515.3 3876.3 4028.9 4214.2 4330.4 4356.8 5319.3 5334.7 5685.5 5810.6 5890.0 4172.2 4400.2 4412.5 4446.4 4448.7 4457.4 4536.5 4571.9 4577.5 4582.7 4166.6 4203.5 4751.0 4844.8 4857.9 4453.6 4940.0 5332.7 5412.2 5440.9 1256.4 1357.1 1376.8 1455.5 1527.0 1004.5 1011.4 1139.6 1169.2 1170.3 4817.1 4864.2 5056.4 5101.5 5126.4 5146.5 5371.7 5385.4 5534.6 5672.7 4784.4 4865.7 5020.6 5032.3 5063.3 2599.7 2678.6 2921.6 2930.7 2933.1 4232.7 4920.8 5330.3 5502.6 5567.6 4822.1 4824.7 5496.7 5565.9 5584.3 4831.8 5027.5 5538.9 5725.9 5763.9 5275.6 5308.3 5553.8 5624.2 5627.6 4751.9 4772.4 5021.6 5235.5 5462.0 5322.5 5556.2 5857.8 5871.0 5886.8 3809.8 4387.3 4389.9 4401.7 4439.0 5011.0 5371.3 5524.9 5678.1 5740.4 4972.4 5011.9 5038.5 5515.2 5527.6 4351.7 5103.9 5383.1 5392.0 5439.6 4728.6 4859.0 5182.4 5188.3 5193.6 4812.6 5419.8 5436.4 5445.5 5471.6 4406.5 5052.5 5251.9 5257.9 5293.7 09:33:22 INFO - PROCESS | 1636 | 09:33:22 INFO - PROCESS | 1636 | [#5] yui.html Cycles:180 Average:18371.50 Median:24261.44 stddev:24828.24 (102.3%) stddev-sans-first:24862.54 09:33:22 INFO - PROCESS | 1636 | Values: 726.6 745.5 772.0 774.0 847.1 15013.2 15173.5 15740.4 15999.5 16013.5 14645.9 14773.3 14785.3 14793.4 14797.6 739.7 918.6 940.0 945.1 946.0 939.5 940.4 942.1 942.4 942.4 932.1 968.8 982.3 983.2 992.8 957.7 958.4 958.8 960.7 961.2 715.6 716.2 719.3 719.6 719.6 15289.0 15517.8 15582.5 15591.8 15875.0 13773.7 13987.3 14088.2 14133.2 14176.8 11563.4 11615.6 11793.4 11829.5 12067.3 3124.7 3548.5 3565.6 3622.2 3704.8 72803.0 94638.3 95045.6 95714.0 97018.5 10510.3 10569.9 10760.6 10772.8 10891.5 21877.6 22064.3 22073.7 22079.4 22084.4 7387.8 7510.3 7518.2 7597.5 7739.0 4146.8 4193.3 4244.8 4397.4 4414.3 3316.0 3411.9 3416.1 3416.6 3421.2 610.9 648.1 648.5 655.2 656.6 589.0 653.5 672.3 712.7 718.8 9264.5 9618.8 9683.2 9942.8 10138.8 585.7 629.5 648.7 682.4 699.8 4288.6 4770.8 4932.5 4991.6 4994.9 76529.9 80626.6 80717.8 92470.6 95408.0 70732.3 70962.9 75815.5 76298.6 76879.6 58651.7 67291.3 68031.3 71116.6 71413.0 10547.4 10580.3 10632.5 10860.2 11035.7 35185.6 44108.6 46438.5 46661.8 47029.1 58207.4 59409.7 59520.5 59679.4 59965.7 10866.6 10929.6 10984.6 11045.9 11111.8 11814.2 11897.9 11967.3 12004.8 12148.8 13095.6 13503.4 13736.9 13757.6 14141.0 11749.5 13292.4 13457.6 13483.3 13886.9 13319.7 13458.5 13541.4 13644.8 13776.8 9843.4 10633.4 10682.1 10914.5 11436.8 9860.4 10376.4 11195.2 11227.2 11308.9 09:33:22 INFO - PROCESS | 1636 | -------- Summary: end -------- 09:33:22 INFO - PROCESS | 1636 | 09:33:22 INFO - TEST-INFO | 1636: exit 0 09:33:22 INFO - TEST-OK | dromaeo_css | took 1122076ms 09:33:22 INFO - TEST-START | kraken 09:33:22 INFO - operating with platform_type : mac_ 09:33:22 INFO - Initialising browser for kraken test... 09:33:22 INFO - TEST-INFO | started process 1646 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/tmpZu734P/profile http://localhost:49240/getInfo.html) 09:33:25 INFO - PROCESS | 1646 | __metrics Screen width/height:1600/1200 09:33:25 INFO - PROCESS | 1646 | colorDepth:24 09:33:25 INFO - PROCESS | 1646 | Browser inner width/height: 1024/689 09:33:25 INFO - PROCESS | 1646 | __metrics 09:33:25 INFO - PROCESS | 1646 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:33:25 INFO - PROCESS | 1646 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:33:26 INFO - TEST-INFO | 1646: exit 0 09:33:26 INFO - Browser initialized. 09:33:26 INFO - Running cycle 1/1 for kraken test... 09:33:26 INFO - TEST-INFO | started process 1647 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/tmpZu734P/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:33:38 INFO - PROCESS | 1647 | RSS: Main: 232689664 09:33:38 INFO - PROCESS | 1647 | 09:33:41 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-beat-detection) 09:33:42 INFO - PROCESS | 1647 | RSS: Main: 284278784 09:33:42 INFO - PROCESS | 1647 | 09:33:44 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-dft) 09:33:45 INFO - PROCESS | 1647 | RSS: Main: 286461952 09:33:45 INFO - PROCESS | 1647 | 09:33:48 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-fft) 09:33:49 INFO - PROCESS | 1647 | RSS: Main: 378408960 09:33:49 INFO - PROCESS | 1647 | 09:33:51 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-oscillator) 09:33:52 INFO - PROCESS | 1647 | RSS: Main: 280535040 09:33:52 INFO - PROCESS | 1647 | 09:33:54 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:33:55 INFO - PROCESS | 1647 | RSS: Main: 283410432 09:33:55 INFO - PROCESS | 1647 | 09:33:58 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-darkroom) 09:33:58 INFO - PROCESS | 1647 | RSS: Main: 324915200 09:33:58 INFO - PROCESS | 1647 | 09:34:02 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-desaturate) 09:34:02 INFO - PROCESS | 1647 | RSS: Main: 328388608 09:34:02 INFO - PROCESS | 1647 | 09:34:05 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49240/tests/kraken/driver.html?testName=json-parse-financial) 09:34:06 INFO - PROCESS | 1647 | RSS: Main: 327225344 09:34:06 INFO - PROCESS | 1647 | 09:34:08 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49240/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:34:08 INFO - PROCESS | 1647 | RSS: Main: 302575616 09:34:08 INFO - PROCESS | 1647 | 09:34:10 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:34:11 INFO - PROCESS | 1647 | RSS: Main: 307650560 09:34:11 INFO - PROCESS | 1647 | 09:34:13 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:34:14 INFO - PROCESS | 1647 | RSS: Main: 311885824 09:34:14 INFO - PROCESS | 1647 | 09:34:17 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:34:17 INFO - PROCESS | 1647 | RSS: Main: 325152768 09:34:17 INFO - PROCESS | 1647 | 09:34:20 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:34:21 INFO - PROCESS | 1647 | RSS: Main: 318959616 09:34:21 INFO - PROCESS | 1647 | 09:34:23 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49240/tests/kraken/driver.html?testName=ai-astar) 09:34:23 INFO - PROCESS | 1647 | RSS: Main: 363831296 09:34:23 INFO - PROCESS | 1647 | 09:34:23 INFO - PROCESS | 1647 | __start_tp_report 09:34:23 INFO - PROCESS | 1647 | _x_x_mozilla_page_load 09:34:23 INFO - PROCESS | 1647 | _x_x_mozilla_page_load_details 09:34:23 INFO - PROCESS | 1647 | |i|pagename|runs| 09:34:23 INFO - PROCESS | 1647 | |0;ai-astar;115;115;115;115;112;113;114;113;115;114 09:34:23 INFO - PROCESS | 1647 | |1;audio-beat-detection;132;112;108;148;111;109;108;108;130;111 09:34:23 INFO - PROCESS | 1647 | |2;audio-dft;185;184;184;187;188;185;185;183;184;197 09:34:23 INFO - PROCESS | 1647 | |3;audio-fft;81;62;62;89;65;59;59;60;79;61 09:34:23 INFO - PROCESS | 1647 | |4;audio-oscillator;93;70;89;70;70;70;88;94;101;117 09:34:23 INFO - PROCESS | 1647 | |5;imaging-gaussian-blur;89;88;90;87;89;89;88;89;90;92 09:34:23 INFO - PROCESS | 1647 | |6;imaging-darkroom;96;111;150;96;96;130;149;96;96;95 09:34:23 INFO - PROCESS | 1647 | |7;imaging-desaturate;83;87;83;83;86;85;83;85;83;83 09:34:23 INFO - PROCESS | 1647 | |8;json-parse-financial;61;60;60;60;60;63;63;62;61;62 09:34:23 INFO - PROCESS | 1647 | |9;json-stringify-tinderbox;54;63;56;57;64;58;57;57;58;57 09:34:23 INFO - PROCESS | 1647 | |10;stanford-crypto-aes;88;87;89;86;85;87;85;88;90;91 09:34:23 INFO - PROCESS | 1647 | |11;stanford-crypto-ccm;142;142;141;134;162;144;151;134;195;156 09:34:23 INFO - PROCESS | 1647 | |12;stanford-crypto-pbkdf2;172;172;169;180;205;223;174;170;170;171 09:34:23 INFO - PROCESS | 1647 | |13;stanford-crypto-sha256-iterative;66;66;67;66;65;67;67;65;65;64 09:34:23 INFO - PROCESS | 1647 | __end_tp_report 09:34:23 INFO - PROCESS | 1647 | __start_cc_report 09:34:23 INFO - PROCESS | 1647 | _x_x_mozilla_cycle_collect,2180 09:34:23 INFO - PROCESS | 1647 | __end_cc_report 09:34:23 INFO - PROCESS | 1647 | __startTimestamp1488994463608__endTimestamp 09:34:23 INFO - PROCESS | 1647 | 09:34:23 INFO - PROCESS | 1647 | ------- Summary: start ------- 09:34:23 INFO - PROCESS | 1647 | Number of tests: 14 09:34:23 INFO - PROCESS | 1647 | 09:34:23 INFO - PROCESS | 1647 | [#0] ai-astar Cycles:10 Average:114.10 Median:115.00 stddev:1.10 (1.0%) stddev-sans-first:1.12 09:34:23 INFO - PROCESS | 1647 | Values: 115.0 115.0 115.0 115.0 112.0 113.0 114.0 113.0 115.0 114.0 09:34:23 INFO - PROCESS | 1647 | 09:34:23 INFO - PROCESS | 1647 | [#1] audio-beat-detection Cycles:10 Average:117.70 Median:111.50 stddev:13.96 (12.5%) stddev-sans-first:13.82 09:34:23 INFO - PROCESS | 1647 | Values: 132.0 112.0 108.0 148.0 111.0 109.0 108.0 108.0 130.0 111.0 09:34:23 INFO - PROCESS | 1647 | 09:34:23 INFO - PROCESS | 1647 | [#2] audio-dft Cycles:10 Average:186.20 Median:185.00 stddev:4.08 (2.2%) stddev-sans-first:4.30 09:34:23 INFO - PROCESS | 1647 | Values: 185.0 184.0 184.0 187.0 188.0 185.0 185.0 183.0 184.0 197.0 09:34:23 INFO - PROCESS | 1647 | 09:34:23 INFO - PROCESS | 1647 | [#3] audio-fft Cycles:10 Average:67.70 Median:63.50 stddev:10.99 (17.3%) stddev-sans-first:10.54 09:34:23 INFO - PROCESS | 1647 | Values: 81.0 62.0 62.0 89.0 65.0 59.0 59.0 60.0 79.0 61.0 09:34:23 INFO - PROCESS | 1647 | 09:34:23 INFO - PROCESS | 1647 | [#4] audio-oscillator Cycles:10 Average:86.20 Median:79.00 stddev:16.11 (20.4%) stddev-sans-first:16.90 09:34:23 INFO - PROCESS | 1647 | Values: 93.0 70.0 89.0 70.0 70.0 70.0 88.0 94.0 101.0 117.0 09:34:23 INFO - PROCESS | 1647 | 09:34:23 INFO - PROCESS | 1647 | [#5] imaging-gaussian-blur Cycles:10 Average:89.10 Median:89.00 stddev:1.37 (1.5%) stddev-sans-first:1.45 09:34:23 INFO - PROCESS | 1647 | Values: 89.0 88.0 90.0 87.0 89.0 89.0 88.0 89.0 90.0 92.0 09:34:23 INFO - PROCESS | 1647 | 09:34:23 INFO - PROCESS | 1647 | [#6] imaging-darkroom Cycles:10 Average:111.50 Median:96.00 stddev:22.86 (23.8%) stddev-sans-first:23.55 09:34:23 INFO - PROCESS | 1647 | Values: 96.0 111.0 150.0 96.0 96.0 130.0 149.0 96.0 96.0 95.0 09:34:23 INFO - PROCESS | 1647 | 09:34:23 INFO - PROCESS | 1647 | [#7] imaging-desaturate Cycles:10 Average:84.10 Median:84.00 stddev:1.52 (1.8%) stddev-sans-first:1.56 09:34:23 INFO - PROCESS | 1647 | Values: 83.0 87.0 83.0 83.0 86.0 85.0 83.0 85.0 83.0 83.0 09:34:23 INFO - PROCESS | 1647 | 09:34:23 INFO - PROCESS | 1647 | [#8] json-parse-financial Cycles:10 Average:61.20 Median:61.50 stddev:1.23 (2.0%) stddev-sans-first:1.30 09:34:23 INFO - PROCESS | 1647 | Values: 61.0 60.0 60.0 60.0 60.0 63.0 63.0 62.0 61.0 62.0 09:34:23 INFO - PROCESS | 1647 | 09:34:23 INFO - PROCESS | 1647 | [#9] json-stringify-tinderbox Cycles:10 Average:58.10 Median:57.50 stddev:3.07 (5.3%) stddev-sans-first:2.88 09:34:23 INFO - PROCESS | 1647 | Values: 54.0 63.0 56.0 57.0 64.0 58.0 57.0 57.0 58.0 57.0 09:34:23 INFO - PROCESS | 1647 | 09:34:23 INFO - PROCESS | 1647 | [#10] stanford-crypto-aes Cycles:10 Average:87.60 Median:88.00 stddev:2.01 (2.3%) stddev-sans-first:2.13 09:34:23 INFO - PROCESS | 1647 | Values: 88.0 87.0 89.0 86.0 85.0 87.0 85.0 88.0 90.0 91.0 09:34:23 INFO - PROCESS | 1647 | 09:34:23 INFO - PROCESS | 1647 | [#11] stanford-crypto-ccm Cycles:10 Average:150.10 Median:147.50 stddev:18.14 (12.3%) stddev-sans-first:19.01 09:34:23 INFO - PROCESS | 1647 | Values: 142.0 142.0 141.0 134.0 162.0 144.0 151.0 134.0 195.0 156.0 09:34:23 INFO - PROCESS | 1647 | 09:34:23 INFO - PROCESS | 1647 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:180.60 Median:173.00 stddev:18.37 (10.6%) stddev-sans-first:19.22 09:34:23 INFO - PROCESS | 1647 | Values: 172.0 172.0 169.0 180.0 205.0 223.0 174.0 170.0 170.0 171.0 09:34:23 INFO - PROCESS | 1647 | 09:34:23 INFO - PROCESS | 1647 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.80 Median:66.00 stddev:1.03 (1.6%) stddev-sans-first:1.09 09:34:23 INFO - PROCESS | 1647 | Values: 66.0 66.0 67.0 66.0 65.0 67.0 67.0 65.0 65.0 64.0 09:34:23 INFO - PROCESS | 1647 | -------- Summary: end -------- 09:34:23 INFO - PROCESS | 1647 | 09:34:24 INFO - TEST-INFO | 1647: exit 0 09:34:24 INFO - TEST-OK | kraken | took 61693ms 09:34:24 INFO - SUITE-END | took 1183s 09:34:24 INFO - Completed test suite (00:19:43) 09:34:24 INFO - javascript benchmark 09:34:24 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7504.339287791054, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3373.325334933014, 3407.7784943978654, 3408.2842603053364, 3410.266792639583, 3425.6745609167137, 5619.550435965123, 5720.056190728525, 5804.332501762298, 5891.558133140015, 5903.6162649427815, 5743.195952566633, 5828.009238429467, 5875.441833025867, 5893.322267939199, 5911.408859114097, 5226.843194704165, 5302.337207849019, 5310.283111779899, 5335.973320133394, 5344.518993290603, 5338.412774594792, 5390.380106287768, 5396.568274538027, 5413.0, 5443.374011988632, 5189.948100519022, 5210.53105220532, 5266.894662106774, 5269.235960785703, 5359.839204823842, 5279.973600131974, 5281.63028587999, 5282.471752824726, 5285.0, 5286.3127793387, 5188.273641690166, 5230.503102205284, 5235.712035838027, 5257.737113144328, 5260.184671375943, 5726.942730572682, 5730.942690573124, 5733.312002559678, 5734.483896449298, 5735.0, 6251.562390632657, 6252.062190671436, 6257.906131408033, 6258.0, 6259.311475737665, 6178.660173690445, 6288.371162883721, 6318.684065796738, 6329.746810127589, 6343.175387199681, 5830.62100963436, 5840.97079514604, 5928.02187639039, 5943.465088142088, 5986.910196347058, 6472.482201423874, 6505.642189679518, 6507.772227971998, 6513.2509761377105, 6517.706703198368, 6120.965252118766, 6172.074188871705, 6219.036049412348, 6351.841203969938, 6356.77751278703, 6306.49548036156, 6342.619442833445, 6345.746170153235, 6355.491560675135, 6358.1734374531015, 6370.904436433457, 6374.904376434357, 6386.265579458329, 6392.552521323462, 6397.4562162216735, 6182.350853160443, 6233.875322493615, 6353.174087368612, 6394.936050639527, 6415.582987105917, 4981.352424184833, 5054.620903432257, 5058.46886076964, 5064.240363945364, 5067.5439210470495, 4459.353393757951, 4525.366448697185, 4541.863744087683, 4573.131105090089, 4587.839425620087, 5808.244928159397, 5814.738336774855, 5822.301323841081, 5824.728620598281, 5838.182654428383, 6291.874162516724, 6354.904676429857, 6378.968105159537, 6380.521460890359, 6384.3934826191435, 4601.930971035437, 5804.564657650693, 5880.617759845596, 5907.970460147758, 5950.464458198696, 4631.374764406762, 5581.6930068846605, 5595.63628364155, 5604.131359639263, 5606.299212598426, 6533.444657204001, 6536.640484773288, 6538.934610653832, 6542.54202205841, 6546.214454265519, 6269.0909818075215, 6322.114903913363, 6358.491320694426, 6374.4263016326895, 6385.329540398191, 6347.17486726741, 6363.395477429637, 6365.936340636719, 6371.0, 6451.548391612542, 5313.681179129265, 6345.936540634534, 6361.109444677656, 6380.425761681471, 6393.1369265148605, 4837.443693975238, 6300.9684951574945, 6368.777092801915, 6375.394337537927, 6398.744050237939, 5940.821775346746, 6312.621242725451, 6321.841953951188, 6321.905171422524, 6327.778527751507, 6137.018077107641, 6139.246828488627, 6149.2313460817395, 6162.568620196544, 6227.065940108839, 6110.406879924546, 6134.7121296814075, 6135.177818203676, 6137.249026071286, 6140.473573783631, 6268.717907694256, 6273.843153921189, 6276.8430789228805, 6283.71723272463, 6290.056491526308, 5861.706914654165, 5887.499562537232, 5974.37269086757, 5985.820425387245, 6050.485708714808], "value": 5791.939250664076, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [722.7217521254319, 774.1136398823347, 794.2295972906279, 863.9956800215998, 871.363904349825, 28621.284467888287, 38986.41520377197, 39501.209975800506, 41582.99999999993, 41745.7912710436, 40069.198616027665, 40240.19519609613, 40279.99300017501, 40284.59715402845, 40334.0, 7331.633418329062, 8192.262696357328, 9103.816503854507, 9421.858672119924, 9432.151106400423, 7401.925980740204, 7492.700291988314, 7501.962490187541, 7507.9624601877185, 7516.285952834472, 11095.611653592126, 11321.830172547418, 11448.22552504359, 11450.656480305563, 11454.770904581903, 11151.330920144777, 11220.270682405699, 11224.66326010221, 11235.21353505255, 11243.99999999996, 7283.126024877049, 10906.890931090667, 10982.0, 10989.945050274777, 10997.065249453806, 27574.0, 27770.02804901839, 27826.860865695744, 37855.810720946494, 38550.03624909372, 3823.751456155369, 3833.17586718854, 3872.1674839909556, 3875.4961854958956, 3887.844486220548, 27311.634418279005, 27335.863320683467, 27986.3003424914, 28331.291717707016, 28842.278943026384, 3084.8766049358, 3091.9690803091908, 3117.173948903542, 3192.680731926812, 3211.4058899103507, 239226.0, 292174.0, 293854.0, 294170.0, 294195.0, 49235.015299694525, 49453.75273123683, 49460.0, 49520.0, 49629.50370496321, 52091.47908520942, 52101.0, 52123.739381302854, 52125.95748085017, 52193.0, 11478.827817582744, 13840.723185536233, 13907.443702252, 13931.721365572632, 13945.721085578434, 12014.279143251433, 12031.398430078636, 12036.458359373673, 12036.916677499066, 12043.698907527381, 9978.151857092083, 10036.698899033041, 10173.33873298248, 11586.073114150848, 11644.0, 4499.437570303712, 4636.5131661175765, 4876.902461950741, 5472.5621950243885, 5555.111182210827, 923.6213152607532, 1085.4247248958065, 1137.3062431916524, 1141.4863311509853, 1189.583645724007, 19768.604627907647, 23431.7656823433, 25636.871815640803, 25739.742602573733, 25828.612570811452, 1223.590097317391, 1224.2287358963795, 1224.6020043485903, 1282.4805953588811, 1293.1852932652369, 12943.741125177443, 12977.545785897637, 13104.148230364995, 13341.132826366254, 13479.05646604748, 358831.0, 359372.0, 360288.0, 360732.0, 361519.0, 52431.73784131055, 52453.95092098137, 52567.474325256255, 52640.47359526356, 52818.0, 1366.8223130993106, 1436.2603259321459, 1442.473497173524, 1443.480347075073, 1445.6241377241784, 24002.22196872403, 24526.754732453162, 24526.77366131722, 24614.876925615972, 24633.507329853663, 42223.94440139021, 42250.73247802571, 42311.576884231996, 42343.3648495279, 42499.787501062296, 344234.27882860426, 344341.0, 345606.0, 347185.0, 348551.0, 30816.53775193329, 31638.683613163576, 31736.523952140273, 31770.0, 31818.6818131825, 40697.79651101726, 41036.0, 41191.588084118775, 41344.0, 41717.79141104275, 29222.0, 30828.845855770578, 32688.673113268564, 34156.03628194743, 35355.82322088373, 33361.666383335854, 33766.66233337635, 34617.42268968888, 34771.65228347684, 34931.82534087313, 33539.329213415105, 33673.66326336705, 34224.14439639029, 34271.828640856635, 34888.0, 29595.556066658588, 29873.253168670955, 29956.550651739806, 30001.0, 30203.244918877204, 22783.430414239778, 23077.076916923135, 23323.766762332158, 23416.326346991027, 23620.17329393463], "value": 17798.3551220359, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [385.88423472958107, 396.7857357027204, 410.45409605225046, 419.42748148776917, 439.47263284059136, 12969.416376263067, 14871.479498217564, 17877.28490860364, 20969.47576310593, 21365.0, 21695.0, 22081.33755987323, 22124.446888827788, 22402.0, 22735.317940461813, 5760.942390576082, 5950.375210602868, 6265.154204182434, 6562.770303039395, 6761.695723692445, 4075.1238483725992, 6701.229358623772, 6715.9590263509235, 6776.220734615508, 6778.423833974093, 4419.845305414295, 4474.0828130233385, 7665.808354791119, 7752.108507521651, 7752.844943101135, 6559.737610495575, 7190.352868241831, 7390.408767298603, 7619.80950476237, 7676.002119724456, 7114.750983715545, 7386.889196662054, 7408.925910740877, 7409.629518524052, 7419.36935360495, 26666.06668766584, 26861.462770744474, 26885.731142688517, 27230.31924201891, 27261.591076133875, 2844.687084420712, 2877.2087675889297, 2879.9280017999718, 2882.553204253323, 2897.246715853872, 15796.447124350707, 16275.0, 16282.348706051744, 16507.009579425274, 16744.497665070066, 1626.7604582788258, 1673.3557580331537, 1984.7915968823354, 1996.3012945469115, 2066.2974588639786, 114486.0, 117649.0, 117892.41053794762, 118164.0, 118906.0, 16703.41538046187, 20752.896235518725, 21204.36386908395, 21330.0, 21341.0, 35395.64604353975, 35839.4624080639, 35910.38403271859, 35940.0, 35961.8201908994, 10136.493175341351, 10211.489425528694, 10414.427206503715, 10415.94792026035, 10545.630902918361, 6750.0, 8344.290735287446, 8362.58187090643, 8520.914790852135, 8547.35894807892, 10377.9481102594, 10437.425941573287, 10507.651736124966, 10644.574217031386, 10669.35983840972, 3609.9278014439565, 3743.9251214975548, 3897.415387691812, 3985.282649123186, 4004.839806407711, 1042.3849928542197, 1086.5165001574223, 1090.8309212072143, 1099.2030777686273, 1136.539701420926, 21594.789016142015, 22966.196183133845, 23000.424989375064, 23025.769742302364, 23076.88461557715, 998.7553049502918, 1108.9667309980714, 1109.9500522476508, 1130.9377984210948, 1134.1380550781466, 10381.806092299332, 11150.888491114985, 11905.0, 12122.636320910387, 12165.20926139798, 477511.0, 511050.0, 566286.0, 577250.0, 651436.9712605816, 110053.0, 119431.40284298523, 127666.0, 130194.34902825615, 137368.31315843356, 1100.7688385439149, 1196.4675719304826, 1281.372127657441, 1300.752856957175, 1301.0372324480006, 13825.308734563432, 17016.744748829024, 19686.40940771779, 19690.50773730668, 19981.400557983285, 57927.84144317175, 60212.69893650504, 61642.0, 61657.07514387198, 61664.0, 80647.0, 81645.0, 82133.0, 82247.0, 83660.0, 11312.434378281218, 11381.487833047699, 11492.337776358767, 11770.0, 11831.704207394883, 12900.8064879025, 13089.149205301625, 13311.134776239513, 13491.257980810757, 13573.457061717816, 11390.658280251606, 11615.303081815118, 11732.41337933117, 11806.763864722829, 11833.230839995373, 8574.914250857411, 11042.613508527164, 11091.223614347242, 11394.886051139383, 11401.315921044765, 11424.314541127558, 11458.197926145423, 11531.94234028858, 11550.0, 11793.410329483662, 11483.770324593293, 11673.0, 11692.064634829363, 11713.590024349107, 11744.354060526754, 11112.833307500556, 11292.548298067984, 11340.773184536429, 11468.19722619442, 11483.0], "value": 11379.1888283831, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1390.3187438155303, 1576.5112815027348, 1577.171984708028, 1596.1620149421544, 1606.983930160698, 10414.739631509206, 11058.778824423507, 11080.556777728882, 11087.27932684376, 11091.057260132879, 10275.28073034886, 10780.676579702602, 10843.891561084387, 11001.889981100187, 11004.834927476095, 2192.243675931801, 2227.7883601057874, 2228.2646726580188, 2229.7101376820992, 2230.4423894026495, 2010.3968809357207, 2230.3754948614333, 2257.89839457224, 2295.9655605165935, 2299.678045073691, 2322.6632138339933, 2338.0764597983784, 2344.589696803061, 2353.6587194856734, 2356.9764302357016, 2207.2716003718733, 2221.255879280443, 2230.6430971044715, 2236.9217077402295, 2237.474193564511, 2237.407087121914, 2303.976960230393, 2306.6736626439697, 2311.9768802312096, 2312.3409828198883, 10733.355998640107, 10806.29759065666, 10832.916708329183, 10834.458277086114, 10841.186910981707, 5578.9163162552595, 5773.0, 5780.1907732917425, 5781.768729250825, 5781.797637082724, 3214.758893083028, 3308.6856748608843, 3519.4544845548726, 3528.276703275848, 3532.452469867175, 1215.094754407963, 1220.2190598017276, 1756.6223261998605, 1801.306496998665, 1884.481767513931, 14540.49108281205, 15054.041295003311, 15110.848891511054, 15130.016548924285, 15135.470258541009, 4285.10012897295, 4831.492693267156, 4898.8775280618265, 4903.87740306488, 4926.975365123151, 12186.939065304794, 12648.241105533514, 12681.30252836103, 12681.49274029047, 12719.809202861965, 5340.626156169109, 5832.766689332464, 5881.911771323434, 5884.911726324109, 5905.970470147622, 5192.714400707921, 5195.064888320063, 5196.298499702568, 5196.818111366159, 5197.168453047494, 3782.4176455383304, 3923.803809809498, 3979.1245925896837, 4009.0, 4018.216447792711, 1022.9208185364363, 1065.3820783945293, 1086.1473743111778, 1116.1684545013854, 1134.5915470430639, 799.5522507395877, 807.9515229086156, 820.5979070255531, 828.4201059258543, 829.8921140251729, 5825.24271844666, 5838.919799837044, 6156.753729850756, 6522.282548919615, 6572.244191917991, 740.7074205688831, 998.8951160128228, 1007.7833265847878, 1060.9257351985286, 1065.4086981725218, 3930.941035884464, 3999.6000399960353, 4048.4332193492933, 4160.854370097032, 4162.812673429703, 12729.681757956125, 13266.867331326755, 13266.938644908385, 13296.002799790054, 13314.06801523884, 13192.47230110804, 13204.669883252804, 13209.0, 13216.94264458841, 13218.801717974238, 9555.996620354901, 9707.320487565803, 9779.364341317792, 9968.700938971842, 10007.549660265451, 6242.719077641608, 6404.807855764335, 6417.2299324081405, 6473.77341793035, 6604.207495100619, 10345.74135646615, 11423.743388227454, 11676.06591472697, 11818.81351949892, 12143.635690929286, 11715.648530544097, 11871.940640296743, 12125.333106678865, 12146.817797732865, 12314.50741970347, 8987.41581797181, 9039.457632541806, 9080.739227063323, 9165.404248723811, 9188.264938804747, 9928.0, 9956.601735930482, 10070.19438444908, 10085.29402941787, 10093.646722364681, 8571.65713371483, 8786.824263514822, 8830.823383532164, 8909.198172164537, 8939.418937769024, 8429.578521074045, 8669.263112635497, 8695.434796738191, 8859.689910853089, 8860.025397206431, 7575.0, 7747.457677962489, 7750.031246094239, 7754.418418618513, 7758.456908016385, 5611.971940140274, 5705.087186050212, 5796.362400136066, 5860.853478663067, 5905.852353691021, 5046.394432667957, 5207.6875387476875, 5822.272215973004, 5865.266841644794, 6105.694715264308], "value": 5058.49417295975, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [332.56766203934876, 360.12489650150127, 365.8298891015678, 380.3875760026357, 384.89030626271517, 4009.398590211466, 4647.86056418308, 4827.78274977626, 4878.48775878533, 4884.242942343938, 4348.456442944632, 4733.154069912737, 4895.9020819583675, 4906.877328066791, 4940.333055037569, 3495.7727747696317, 3892.9805350973274, 4351.912961740763, 4386.714863533876, 4425.557444255581, 4256.87229383119, 4404.69167158299, 4413.205622987861, 4434.556544345572, 4443.244648409762, 3465.5668041494814, 3935.704822138351, 3962.0491082140225, 3975.1652153047894, 4401.735895846244, 3818.4654148419245, 4134.214499245164, 4134.751914885116, 4171.581662234855, 4370.497392799821, 3771.133938206955, 4010.5187377514594, 4018.819153138116, 4093.9181216375505, 4110.547839737626, 4191.832326706928, 4841.636877234187, 4958.528939750718, 4979.278004689336, 5012.8496145115705, 4229.471316085489, 4255.55316691746, 4734.621230301567, 4825.131476334259, 5028.823991160292, 4802.5197480252045, 5307.469253074701, 5473.589480788957, 5488.780448782044, 5515.310586176728, 3876.2635099331037, 4028.8589899353383, 4214.163383713548, 4330.350447432878, 4356.847510337123, 5319.276506445503, 5334.653247538898, 5685.488306052475, 5810.5932584719085, 5890.0, 4172.186423647359, 4400.163968845909, 4412.492068805307, 4446.377507149002, 4448.688591798543, 4457.398251236106, 4536.455625324916, 4571.885702857388, 4577.48942848859, 4582.702124361906, 4166.626027758026, 4203.495580530356, 4751.0, 4844.8304309349005, 4857.906970931583, 4453.599176074104, 4939.975300123477, 5332.706701131475, 5412.161115027177, 5440.863978400572, 1256.447163248168, 1357.0568454923732, 1376.779715245556, 1455.5415044261024, 1526.9618259543379, 1004.477671610773, 1011.4322799660497, 1139.6353166986485, 1169.216624861345, 1170.2919733561073, 4817.0606731686985, 4864.246041863516, 5056.367954005749, 5101.51535604117, 5126.410462796752, 5146.459621739664, 5371.650842695212, 5385.380681221632, 5534.647774695738, 5672.659640421588, 4784.354112194878, 4865.683730557503, 5020.59835213182, 5032.345795046621, 5063.265826455217, 2599.6880374355196, 2678.611601317798, 2921.561765735114, 2930.6776254611977, 2933.090741870027, 4232.724872883253, 4920.803167873245, 5330.307060082242, 5502.614816962854, 5567.603761705356, 4822.12964905441, 4824.684151607248, 5496.6701997880255, 5565.9443405566235, 5584.253384623119, 4831.806727730851, 5027.522385373383, 5538.9169162462595, 5725.942740572541, 5763.8673690734695, 5275.551578115903, 5308.336457942757, 5553.777848886161, 5624.216013073555, 5627.634203776742, 4751.857444276678, 4772.403449568804, 5021.623378246573, 5235.502627250406, 5461.972690136524, 5322.498425739896, 5556.249906262603, 5857.824265272048, 5871.0, 5886.823395298148, 3809.790461524532, 4387.319965405367, 4389.948985455206, 4401.701498058144, 4438.977805110953, 5011.0, 5371.274877891435, 5524.944750552604, 5678.0915053591225, 5740.39725828782, 4972.383975208144, 5011.8950040982145, 5038.521340472649, 5515.200295956984, 5527.613067085265, 4351.692713537671, 5103.932907172601, 5383.062097644766, 5391.987933454248, 5439.5648348132845, 4728.574428301469, 4859.032092002744, 5182.378114626269, 5188.316295430287, 5193.610479213999, 4812.614990800797, 5419.756110975094, 5436.429174936733, 5445.53712934405, 5471.644343117685, 4406.493253275914, 5052.46949070357, 5251.8708477675955, 5257.896841263525, 5293.682379057269], "value": 4118.974727496095, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [726.6439444672112, 745.5116898431529, 771.9691212351506, 773.9883901741475, 847.1486156412805, 15013.249337533121, 15173.468928587501, 15740.449084282052, 15999.520014399557, 16013.519594412186, 14645.92677036616, 14773.261336933137, 14785.260736963135, 14793.408263669467, 14797.55607331779, 739.7004213293625, 918.6463211663507, 939.9906000939972, 945.1446440970898, 946.0303189231059, 939.4879790514152, 940.407543247753, 942.0532364973227, 942.354487176283, 942.4157022645969, 932.137772560379, 968.801395713877, 982.287841315048, 983.1593987140999, 992.7567745902264, 957.674390707163, 958.4393130018947, 958.755517343073, 960.663767681313, 961.1541843178029, 715.6099925540593, 716.201435399531, 719.3130560314939, 719.5682590445743, 719.6401799100449, 15289.0, 15517.767233491506, 15582.532524024298, 15591.766123508156, 15875.047497150208, 13773.655658608515, 13987.300634968211, 14088.15471071739, 14133.222672752994, 14176.787348189786, 11563.364014979257, 11615.593454229145, 11793.410329483491, 11829.526818927232, 12067.275963442222, 3124.6875312468796, 3548.538689970313, 3565.5721313442555, 3622.1850083731215, 3704.833282502267, 72803.0, 94638.31903518588, 95045.5743163853, 95714.04285957121, 97018.51490742501, 10510.316829406063, 10569.947150264354, 10760.623378181726, 10772.78454430907, 10891.455427228608, 21877.562448750938, 22064.33806985793, 22073.668894966268, 22079.44801379946, 22084.447888802588, 7387.7783666490095, 7510.286522780327, 7518.210587888302, 7597.544147351176, 7738.961305193438, 4146.751194928314, 4193.329067349209, 4244.808983595745, 4397.40635014269, 4414.3157810539415, 3315.950260746091, 3411.8570278956827, 3416.0947348952545, 3416.641252668434, 3421.2473255883665, 610.9358517355703, 648.144449326884, 648.5298158834808, 655.1712084213474, 656.6093174561129, 588.9587728859025, 653.4608947618234, 672.3243140643622, 712.7113519024804, 718.795143384133, 9264.536773161315, 9618.797650293713, 9683.198471231117, 9942.80114397708, 10138.847917281246, 585.7215431969641, 629.4869681209799, 648.6951132967498, 682.436989483678, 699.7620808924888, 4288.593628516676, 4770.76146192689, 4932.482089380635, 4991.575716064102, 4994.925076123861, 76529.85205221926, 80626.5968670153, 80717.78923316154, 92470.61294080594, 95408.0, 70732.2926770736, 70962.9355559667, 75815.48369032699, 76298.6185069071, 76879.61560192275, 58651.70674146602, 67291.32708672949, 68031.31968680349, 71116.64441677759, 71413.0, 10547.367157970546, 10580.259381843198, 10632.468376580986, 10860.185486088418, 11035.72410689707, 35185.64814351926, 44108.558914411726, 46438.535614644774, 46661.766691166325, 47029.05941881212, 58207.4179258202, 59409.702951484964, 59520.51198720067, 59679.403205967385, 59965.700171498866, 10866.61966831157, 10929.581387484202, 10984.615538456115, 11045.889541104487, 11111.833322500008, 11814.173007889365, 11897.94051029774, 11967.281963082243, 12004.819927701266, 12148.817767733668, 13095.607131786062, 13503.39234734459, 13736.93131534336, 13757.587272381845, 14141.0, 11749.47127379253, 13292.42741694119, 13457.596272111852, 13483.258420786951, 13886.93056534711, 13319.667008324483, 13458.46166153382, 13541.390637421142, 13644.795328069888, 13776.793348099987, 9843.375842986114, 10633.361998280128, 10682.145428365557, 10914.454277285946, 11436.771264574496, 9860.408375497493, 10376.429296388469, 11195.160362972647, 11227.214095013598, 11308.943455282671], "value": 7306.479682017001, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1459.9999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 115.0, 115.0, 115.0, 112.0, 113.0, 114.0, 113.0, 115.0, 114.0], "value": 114.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 112.0, 108.0, 148.0, 111.0, 109.0, 108.0, 108.0, 130.0, 111.0], "value": 117.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 184.0, 184.0, 187.0, 188.0, 185.0, 185.0, 183.0, 184.0, 197.0], "value": 186.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 62.0, 62.0, 89.0, 65.0, 59.0, 59.0, 60.0, 79.0, 61.0], "value": 67.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 70.0, 89.0, 70.0, 70.0, 70.0, 88.0, 94.0, 101.0, 117.0], "value": 86.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 88.0, 90.0, 87.0, 89.0, 89.0, 88.0, 89.0, 90.0, 92.0], "value": 89.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 111.0, 150.0, 96.0, 96.0, 130.0, 149.0, 96.0, 96.0, 95.0], "value": 111.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 87.0, 83.0, 83.0, 86.0, 85.0, 83.0, 85.0, 83.0, 83.0], "value": 84.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 60.0, 60.0, 60.0, 60.0, 63.0, 63.0, 62.0, 61.0, 62.0], "value": 61.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 63.0, 56.0, 57.0, 64.0, 58.0, 57.0, 57.0, 58.0, 57.0], "value": 58.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 87.0, 89.0, 86.0, 85.0, 87.0, 85.0, 88.0, 90.0, 91.0], "value": 87.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 142.0, 141.0, 134.0, 162.0, 144.0, 151.0, 134.0, 195.0, 156.0], "value": 150.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 172.0, 169.0, 180.0, 205.0, 223.0, 174.0, 170.0, 170.0, 171.0], "value": 180.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 67.0, 66.0, 65.0, 67.0, 67.0, 65.0, 65.0, 64.0], "value": 65.8, "unit": "score"}]}]} 09:34:24 INFO - Return code: 0 09:34:24 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:34:24 ERROR - # TBPL SUCCESS # 09:34:24 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:34:24 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:34:24 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:34:24 INFO - 2017-03-08 09:34:24.942 screenresolution[1651:10373] starting screenresolution argv=screenresolution get 09:34:24 INFO - 2017-03-08 09:34:24.945 screenresolution[1651:10373] Display 0: 1600x1200x32@60 09:34:24 INFO - 2017-03-08 09:34:24.950 screenresolution[1652:10376] starting screenresolution argv=screenresolution list 09:34:24 INFO - Available Modes on Display 0 09:34:24 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:34:24 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:34:24 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:34:24 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:34:25 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:34:25 INFO - Intel Iris: 09:34:25 INFO - Chipset Model: Intel Iris 09:34:25 INFO - Type: GPU 09:34:25 INFO - Bus: Built-In 09:34:25 INFO - VRAM (Dynamic, Max): 1536 MB 09:34:25 INFO - Vendor: Intel (0x8086) 09:34:25 INFO - Device ID: 0x0a2e 09:34:25 INFO - Revision ID: 0x0009 09:34:25 INFO - Displays: 09:34:25 INFO - Display: 09:34:25 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:34:25 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:34:25 INFO - Display Serial Number: 1600x1200 60 09:34:25 INFO - Main Display: Yes 09:34:25 INFO - Mirror: Off 09:34:25 INFO - Online: Yes 09:34:25 INFO - Rotation: Supported 09:34:25 INFO - Return code: 0 09:34:25 INFO - Running post-action listener: _resource_record_post_action 09:34:25 INFO - [mozharness: 2017-03-08 17:34:25.187569Z] Finished run-tests step (success) 09:34:25 INFO - Running post-run listener: _resource_record_post_run 09:34:25 INFO - Total resource usage - Wall time: 1206s; CPU: 54.0%; Read bytes: 40653824; Write bytes: 512153600; Read time: 400; Write time: 1615 09:34:25 INFO - TinderboxPrint: CPU usage
53.8% 09:34:25 INFO - TinderboxPrint: I/O read bytes / time
40,653,824 / 400 09:34:25 INFO - TinderboxPrint: I/O write bytes / time
512,153,600 / 1,615 09:34:25 INFO - TinderboxPrint: CPU idle
2,226.4 (46.2%) 09:34:25 INFO - TinderboxPrint: CPU system
962.2 (20.0%) 09:34:25 INFO - TinderboxPrint: CPU user
1,633.2 (33.9%) 09:34:25 INFO - TinderboxPrint: Swap in / out
248,942,592 / 0 09:34:25 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 202680832; Write bytes: 202585600; Read time: 15410; Write time: 479 09:34:25 INFO - run-tests - Wall time: 1185s; CPU: 54.0%; Read bytes: 39638016; Write bytes: 299663872; Read time: 384; Write time: 1100 09:34:25 INFO - Running post-run listener: _upload_blobber_files 09:34:25 INFO - Blob upload gear active. 09:34:25 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:34:25 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 09:34:25 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'] 09:34:25 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 09:34:26 INFO - (blobuploader) - INFO - Open directory for files ... 09:34:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:34:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:34:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:34:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:34:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:34:26 INFO - (blobuploader) - INFO - Done attempting. 09:34:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:34:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:34:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:34:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:34:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:34:27 INFO - (blobuploader) - INFO - Done attempting. 09:34:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:34:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:34:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:34:28 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:34:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:34:28 INFO - (blobuploader) - INFO - Done attempting. 09:34:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:34:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:34:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:34:30 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:34:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:34:30 INFO - (blobuploader) - INFO - Done attempting. 09:34:30 INFO - (blobuploader) - INFO - Iteration through files over. 09:34:30 INFO - Return code: 0 09:34:30 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:34:30 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:34:30 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9454335ffc122b4dc76a659f2e86904031948807404d720c9b0208f6bb26b482b58488fb6113e0948a40af349b90441bd36a7e59d6d927c1de2f58479d13ff59", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/adcb7e90a2f5aa7ac3a4ce5eee692317da29468077d953cfd0fa3c38b8a34dec9257fdc47da128a70e6981d9a00b811fed8d6ad736425039560523ce438cee6a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6983e2a153835517293a58062386abf9d6c498a9a9b235a4ea9940c5c333a707ac9fb719e9e8f6348f11889308b4e5c3e1e78a8c7965b891b61f07fb40879c47", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ad6293ba207051c798acad2eb24be76b2807eeafd8cb63d224d2cb8c6e69399fc129217fc3e574ce42819eff823d43efd2a774d47ae91699b3f5c59f93414574"} 09:34:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:34:30 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:34:30 INFO - Contents: 09:34:30 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9454335ffc122b4dc76a659f2e86904031948807404d720c9b0208f6bb26b482b58488fb6113e0948a40af349b90441bd36a7e59d6d927c1de2f58479d13ff59", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/adcb7e90a2f5aa7ac3a4ce5eee692317da29468077d953cfd0fa3c38b8a34dec9257fdc47da128a70e6981d9a00b811fed8d6ad736425039560523ce438cee6a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6983e2a153835517293a58062386abf9d6c498a9a9b235a4ea9940c5c333a707ac9fb719e9e8f6348f11889308b4e5c3e1e78a8c7965b891b61f07fb40879c47", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ad6293ba207051c798acad2eb24be76b2807eeafd8cb63d224d2cb8c6e69399fc129217fc3e574ce42819eff823d43efd2a774d47ae91699b3f5c59f93414574"} 09:34:30 INFO - Running post-run listener: copy_logs_to_upload_dir 09:34:30 INFO - Copying logs to upload dir... 09:34:31 INFO - mkdir: /builds/slave/test/build/upload/logs 09:34:31 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1289.551115 ========= master_lag: -0.11 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 29 secs) (at 2017-03-08 09:34:30.874125) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-08 09:34:30.879466) ========= 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.0jRwKrdhlp/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.rqADtuOjmc/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_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9454335ffc122b4dc76a659f2e86904031948807404d720c9b0208f6bb26b482b58488fb6113e0948a40af349b90441bd36a7e59d6d927c1de2f58479d13ff59", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/adcb7e90a2f5aa7ac3a4ce5eee692317da29468077d953cfd0fa3c38b8a34dec9257fdc47da128a70e6981d9a00b811fed8d6ad736425039560523ce438cee6a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6983e2a153835517293a58062386abf9d6c498a9a9b235a4ea9940c5c333a707ac9fb719e9e8f6348f11889308b4e5c3e1e78a8c7965b891b61f07fb40879c47", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ad6293ba207051c798acad2eb24be76b2807eeafd8cb63d224d2cb8c6e69399fc129217fc3e574ce42819eff823d43efd2a774d47ae91699b3f5c59f93414574"} build_url:https://queue.taskcluster.net/v1/task/W814j9yQSNy3dAL9zQLoiA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011103 build_url: 'https://queue.taskcluster.net/v1/task/W814j9yQSNy3dAL9zQLoiA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9454335ffc122b4dc76a659f2e86904031948807404d720c9b0208f6bb26b482b58488fb6113e0948a40af349b90441bd36a7e59d6d927c1de2f58479d13ff59", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/adcb7e90a2f5aa7ac3a4ce5eee692317da29468077d953cfd0fa3c38b8a34dec9257fdc47da128a70e6981d9a00b811fed8d6ad736425039560523ce438cee6a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6983e2a153835517293a58062386abf9d6c498a9a9b235a4ea9940c5c333a707ac9fb719e9e8f6348f11889308b4e5c3e1e78a8c7965b891b61f07fb40879c47", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ad6293ba207051c798acad2eb24be76b2807eeafd8cb63d224d2cb8c6e69399fc129217fc3e574ce42819eff823d43efd2a774d47ae91699b3f5c59f93414574"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-08 09:34:30.917707) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-08 09:34:30.918055) ========= 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.0jRwKrdhlp/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.rqADtuOjmc/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.005014 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-08 09:34:30.966739) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-08 09:34:30.967125) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-08 09:34:30.967450) ========= ========= Total master_lag: 0.03 =========