builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0061 starttime: 1490822468.43 results: success (0) buildid: 20170329132822 builduid: 24af142e3df441249328a7c3f41e0a2b revision: f76dd729117c42ffbb503db17d3f0e9c64533372 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-29 14:21:08.430989) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-29 14:21:08.431471) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-29 14:21:08.431776) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-29 14:21:08.459064) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-29 14:21:08.459489) ========= 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.7fEdgXp8GX/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.kwRU133bhJ/Listeners TMPDIR=/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/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-29 14:21:08-- 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% 54.0M=0s 2017-03-29 14:21:08 (54.0 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.220341 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-29 14:21:08.704132) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-29 14:21:08.704746) ========= 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.7fEdgXp8GX/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.kwRU133bhJ/Listeners TMPDIR=/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/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.028295 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-29 14:21:08.755053) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-03-29 14:21:08.755430) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev f76dd729117c42ffbb503db17d3f0e9c64533372 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev f76dd729117c42ffbb503db17d3f0e9c64533372 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.7fEdgXp8GX/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.kwRU133bhJ/Listeners TMPDIR=/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/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-29 14:21:08,860 truncating revision to first 12 chars 2017-03-29 14:21:08,861 Setting DEBUG logging. 2017-03-29 14:21:08,861 attempt 1/10 2017-03-29 14:21:08,861 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/f76dd729117c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-29 14:21:11,023 unpacking tar archive at: mozilla-beta-f76dd729117c/testing/mozharness/ program finished with exit code 0 elapsedTime=2.436456 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-03-29 14:21:11.214187) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-29 14:21:11.214520) ========= script_repo_revision: f76dd729117c42ffbb503db17d3f0e9c64533372 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-29 14:21:11.214931) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-29 14:21:11.215207) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-29 14:21:11.233387) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-03-29 14:21:11.233847) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.7fEdgXp8GX/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.kwRU133bhJ/Listeners TMPDIR=/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/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 14:21:11 INFO - MultiFileLogger online at 20170329 14:21:11 in /builds/slave/test 14:21:11 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 14:21:11 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:21:11 INFO - {'append_to_log': False, 14:21:11 INFO - 'base_work_dir': '/builds/slave/test', 14:21:11 INFO - 'blob_upload_branch': 'Mozilla-Beta', 14:21:11 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:21:11 INFO - 'branch': 'Mozilla-Beta', 14:21:11 INFO - 'buildbot_json_path': 'buildprops.json', 14:21:11 INFO - 'config_files': ('talos/mac_config.py',), 14:21:11 INFO - 'default_actions': ('clobber', 14:21:11 INFO - 'read-buildbot-config', 14:21:11 INFO - 'download-and-extract', 14:21:11 INFO - 'populate-webroot', 14:21:11 INFO - 'create-virtualenv', 14:21:11 INFO - 'install', 14:21:11 INFO - 'run-tests'), 14:21:11 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:21:11 INFO - 'download_minidump_stackwalk': True, 14:21:11 INFO - 'download_symbols': 'ondemand', 14:21:11 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:21:11 INFO - 'tooltool.py': '/tools/tooltool.py', 14:21:11 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:21:11 INFO - '/tools/misc-python/virtualenv.py')}, 14:21:11 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:21:11 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:21:11 INFO - 'installer_path': 'installer.exe', 14:21:11 INFO - 'log_level': 'info', 14:21:11 INFO - 'log_name': 'talos', 14:21:11 INFO - 'log_to_console': True, 14:21:11 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 14:21:11 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 14:21:11 INFO - 'opt_config_files': (), 14:21:11 INFO - 'pip_index': False, 14:21:11 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:21:11 INFO - 'cmd': ('bash', 14:21:11 INFO - '-c', 14:21:11 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:21:11 INFO - 'enabled': True, 14:21:11 INFO - 'halt_on_failure': False, 14:21:11 INFO - 'name': 'check_screen_resolution'},), 14:21:11 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:21:11 INFO - 'cmd': ('bash', 14:21:11 INFO - '-c', 14:21:11 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:21:11 INFO - 'enabled': True, 14:21:11 INFO - 'halt_on_failure': False, 14:21:11 INFO - 'name': 'check_screen_resolution'},), 14:21:11 INFO - 'run_cmd_checks_enabled': True, 14:21:11 INFO - 'sps_profile': False, 14:21:11 INFO - 'sps_profile_interval': 0, 14:21:11 INFO - 'suite': 'dromaeojs', 14:21:11 INFO - 'system_bits': '32', 14:21:11 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:21:11 INFO - 'title': 't-yosemite-r7-0061', 14:21:11 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:21:11 INFO - 'use_talos_json': True, 14:21:11 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:21:11 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:21:11 INFO - 'work_dir': 'build'} 14:21:11 INFO - [mozharness: 2017-03-29 21:21:11.435001Z] Running clobber step. 14:21:11 INFO - Running pre-action listener: _resource_record_pre_action 14:21:11 INFO - Running main action method: clobber 14:21:11 INFO - rmtree: /builds/slave/test/build 14:21:11 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:21:13 INFO - Running post-action listener: _resource_record_post_action 14:21:13 INFO - [mozharness: 2017-03-29 21:21:13.920973Z] Finished clobber step (success) 14:21:13 INFO - [mozharness: 2017-03-29 21:21:13.921197Z] Running read-buildbot-config step. 14:21:13 INFO - Running pre-action listener: _resource_record_pre_action 14:21:13 INFO - Running main action method: read_buildbot_config 14:21:13 INFO - Using buildbot properties: 14:21:13 INFO - { 14:21:13 INFO - "project": "", 14:21:13 INFO - "product": "firefox", 14:21:13 INFO - "script_repo_revision": "production", 14:21:13 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 14:21:13 INFO - "repository": "", 14:21:13 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 14:21:13 INFO - "buildid": "20170329132822", 14:21:13 INFO - "pgo_build": "False", 14:21:13 INFO - "basedir": "/builds/slave/test", 14:21:13 INFO - "buildnumber": 22, 14:21:13 INFO - "slavename": "t-yosemite-r7-0061", 14:21:13 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 14:21:13 INFO - "platform": "yosemite_r7", 14:21:13 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 14:21:13 INFO - "branch": "mozilla-beta", 14:21:13 INFO - "repo_path": "releases/mozilla-beta", 14:21:13 INFO - "revision": "f76dd729117c42ffbb503db17d3f0e9c64533372", 14:21:13 INFO - "stage_platform": "macosx64", 14:21:13 INFO - "builduid": "24af142e3df441249328a7c3f41e0a2b", 14:21:13 INFO - "slavebuilddir": "test" 14:21:13 INFO - } 14:21:13 INFO - Found installer url https://queue.taskcluster.net/v1/task/a8CV2bEdQPa53PweV6-s1Q/artifacts/public/build/firefox-53.0.en-US.mac.dmg. 14:21:13 INFO - Running post-action listener: _resource_record_post_action 14:21:13 INFO - [mozharness: 2017-03-29 21:21:13.926943Z] Finished read-buildbot-config step (success) 14:21:13 INFO - [mozharness: 2017-03-29 21:21:13.927177Z] Running download-and-extract step. 14:21:13 INFO - Running pre-action listener: _resource_record_pre_action 14:21:13 INFO - Running main action method: download_and_extract 14:21:13 INFO - mkdir: /builds/slave/test/build/tests 14:21: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')]} 14:21:13 INFO - trying https://queue.taskcluster.net/v1/task/a8CV2bEdQPa53PweV6-s1Q/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json 14:21:13 INFO - Downloading https://queue.taskcluster.net/v1/task/a8CV2bEdQPa53PweV6-s1Q/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json 14:21:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/a8CV2bEdQPa53PweV6-s1Q/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json'}, attempt #1 14:21:15 INFO - Downloaded 1165 bytes. 14:21:15 INFO - Reading from file /builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json 14:21:15 INFO - Using the following test package requirements: 14:21:15 INFO - {u'common': [u'firefox-53.0.en-US.mac.common.tests.zip'], 14:21:15 INFO - u'cppunittest': [u'firefox-53.0.en-US.mac.common.tests.zip', 14:21:15 INFO - u'firefox-53.0.en-US.mac.cppunittest.tests.zip'], 14:21:15 INFO - u'gtest': [u'firefox-53.0.en-US.mac.common.tests.zip', 14:21:15 INFO - u'firefox-53.0.en-US.mac.gtest.tests.zip'], 14:21:15 INFO - u'jittest': [u'firefox-53.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 14:21:15 INFO - u'mochitest': [u'firefox-53.0.en-US.mac.common.tests.zip', 14:21:15 INFO - u'firefox-53.0.en-US.mac.mochitest.tests.zip'], 14:21:15 INFO - u'mozbase': [u'firefox-53.0.en-US.mac.common.tests.zip'], 14:21:15 INFO - u'reftest': [u'firefox-53.0.en-US.mac.common.tests.zip', 14:21:15 INFO - u'firefox-53.0.en-US.mac.reftest.tests.zip'], 14:21:15 INFO - u'talos': [u'firefox-53.0.en-US.mac.common.tests.zip', 14:21:15 INFO - u'firefox-53.0.en-US.mac.talos.tests.zip'], 14:21:15 INFO - u'web-platform': [u'firefox-53.0.en-US.mac.common.tests.zip', 14:21:15 INFO - u'firefox-53.0.en-US.mac.web-platform.tests.zip'], 14:21:15 INFO - u'xpcshell': [u'firefox-53.0.en-US.mac.common.tests.zip', 14:21:15 INFO - u'firefox-53.0.en-US.mac.xpcshell.tests.zip']} 14:21:15 INFO - Downloading packages: [u'firefox-53.0.en-US.mac.common.tests.zip'] for test suite category: common 14:21:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/a8CV2bEdQPa53PweV6-s1Q/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip 14:21:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/a8CV2bEdQPa53PweV6-s1Q/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip'}, attempt #1 14:21:15 INFO - Fetch https://queue.taskcluster.net/v1/task/a8CV2bEdQPa53PweV6-s1Q/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip into memory 14:21:16 INFO - Expected file size: 16108789 14:21:16 INFO - Obtained file size: 16108789 14:21:22 INFO - Downloading packages: [u'firefox-53.0.en-US.mac.common.tests.zip', u'firefox-53.0.en-US.mac.talos.tests.zip'] for test suite category: talos 14:21:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/a8CV2bEdQPa53PweV6-s1Q/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip 14:21:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/a8CV2bEdQPa53PweV6-s1Q/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip'}, attempt #1 14:21:22 INFO - Fetch https://queue.taskcluster.net/v1/task/a8CV2bEdQPa53PweV6-s1Q/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip into memory 14:21:23 INFO - Expected file size: 16108789 14:21:23 INFO - Obtained file size: 16108789 14:21:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/a8CV2bEdQPa53PweV6-s1Q/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip 14:21:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/a8CV2bEdQPa53PweV6-s1Q/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip'}, attempt #1 14:21:30 INFO - Fetch https://queue.taskcluster.net/v1/task/a8CV2bEdQPa53PweV6-s1Q/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip into memory 14:21:31 INFO - Expected file size: 14403663 14:21:31 INFO - Obtained file size: 14403663 14:21:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:21:31 INFO - trying https://queue.taskcluster.net/v1/task/a8CV2bEdQPa53PweV6-s1Q/artifacts/public/build/firefox-53.0.en-US.mac.dmg 14:21:31 INFO - Downloading https://queue.taskcluster.net/v1/task/a8CV2bEdQPa53PweV6-s1Q/artifacts/public/build/firefox-53.0.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0.en-US.mac.dmg 14:21:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/a8CV2bEdQPa53PweV6-s1Q/artifacts/public/build/firefox-53.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0.en-US.mac.dmg'}, attempt #1 14:21:33 INFO - Downloaded 58690218 bytes. 14:21:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/a8CV2bEdQPa53PweV6-s1Q/artifacts/public/build/firefox-53.0.en-US.mac.dmg 14:21:33 INFO - mkdir: /builds/slave/test/properties 14:21:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:21:33 INFO - Writing to file /builds/slave/test/properties/build_url 14:21:33 INFO - Contents: 14:21:33 INFO - build_url:https://queue.taskcluster.net/v1/task/a8CV2bEdQPa53PweV6-s1Q/artifacts/public/build/firefox-53.0.en-US.mac.dmg 14:21:33 INFO - Running post-action listener: _resource_record_post_action 14:21:33 INFO - Running post-action listener: set_extra_try_arguments 14:21:33 INFO - [mozharness: 2017-03-29 21:21:33.793937Z] Finished download-and-extract step (success) 14:21:33 INFO - [mozharness: 2017-03-29 21:21:33.794058Z] Running populate-webroot step. 14:21:33 INFO - Running pre-action listener: _resource_record_pre_action 14:21:33 INFO - Running main action method: populate_webroot 14:21:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:21:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:21:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:21:33 INFO - '--tppagecycles', 14:21:33 INFO - '7'], 14:21:33 INFO - 'tests': ['tsvgm']}}, 14:21:33 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:21:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:21:33 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:21:33 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:21:33 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:21:33 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:21:33 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 14:21:33 INFO - 'talos_options': ['--disable-e10s'], 14:21:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:21:33 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 14:21:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:21:33 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 14:21:33 INFO - 'talos_options': ['--disable-e10s'], 14:21:33 INFO - 'tests': ['damp', 'tps']}, 14:21:33 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 14:21:33 INFO - 'tests': ['damp', 'tps']}, 14:21:33 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:21:33 INFO - 'tests': ['dromaeo_dom']}, 14:21:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:21:33 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:21:33 INFO - 'tests': ['basic_compositor_video']}, 14:21:33 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:21:33 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:21:33 INFO - 'tests': ['a11yr', 14:21:33 INFO - 'ts_paint', 14:21:33 INFO - 'tpaint', 14:21:33 INFO - 'sessionrestore', 14:21:33 INFO - 'sessionrestore_no_auto_restore', 14:21:33 INFO - 'tabpaint']}, 14:21:33 INFO - 'other-e10s': {'tests': ['a11yr', 14:21:33 INFO - 'ts_paint', 14:21:33 INFO - 'tpaint', 14:21:33 INFO - 'sessionrestore', 14:21:33 INFO - 'sessionrestore_no_auto_restore', 14:21:33 INFO - 'tabpaint']}, 14:21:33 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:21:33 INFO - 'ts_paint', 14:21:33 INFO - 'tpaint', 14:21:33 INFO - 'sessionrestore', 14:21:33 INFO - 'sessionrestore_no_auto_restore', 14:21:33 INFO - 'tabpaint']}, 14:21:33 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:21:33 INFO - 'ts_paint', 14:21:33 INFO - 'tpaint', 14:21:33 INFO - 'sessionrestore', 14:21:33 INFO - 'sessionrestore_no_auto_restore', 14:21:33 INFO - 'tabpaint']}, 14:21:33 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:21:33 INFO - 'tests': ['a11yr', 14:21:33 INFO - 'ts_paint', 14:21:33 INFO - 'tpaint', 14:21:33 INFO - 'sessionrestore', 14:21:33 INFO - 'sessionrestore_no_auto_restore', 14:21:33 INFO - 'tabpaint']}, 14:21:33 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:21:33 INFO - 'tests': ['a11yr', 14:21:33 INFO - 'ts_paint', 14:21:33 INFO - 'tpaint', 14:21:33 INFO - 'sessionrestore', 14:21:33 INFO - 'sessionrestore_no_auto_restore', 14:21:33 INFO - 'tabpaint']}, 14:21:33 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:21:33 INFO - 'tests': ['tsvgx', 14:21:33 INFO - 'tsvgr_opacity', 14:21:33 INFO - 'tart', 14:21:33 INFO - 'tscrollx', 14:21:33 INFO - 'cart', 14:21:33 INFO - 'tsvg_static']}, 14:21:33 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:21:33 INFO - 'tsvgr_opacity', 14:21:33 INFO - 'tart', 14:21:33 INFO - 'tscrollx', 14:21:33 INFO - 'cart', 14:21:33 INFO - 'tsvg_static']}, 14:21:33 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 14:21:33 INFO - 'talos_options': ['--disable-e10s'], 14:21:33 INFO - 'tests': ['tp5o']}, 14:21:33 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 14:21:33 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 14:21:33 INFO - 'talos_options': ['--disable-e10s', 14:21:33 INFO - '--xperf_path', 14:21:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:21:33 INFO - 'tests': ['tp5n']}, 14:21:33 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 14:21:33 INFO - 'talos_options': ['--xperf_path', 14:21:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:21:33 INFO - 'tests': ['tp5n']}}, 14:21:33 INFO - 'talos.zip': {'path': '', 14:21:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:21:33 INFO - Running post-action listener: _resource_record_post_action 14:21:33 INFO - [mozharness: 2017-03-29 21:21:33.812497Z] Finished populate-webroot step (success) 14:21:33 INFO - [mozharness: 2017-03-29 21:21:33.812625Z] Running create-virtualenv step. 14:21:33 INFO - Running pre-action listener: _resource_record_pre_action 14:21:33 INFO - Running main action method: create_virtualenv 14:21:33 INFO - Creating virtualenv /builds/slave/test/build/venv 14:21:33 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 14:21:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:21:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:21:33 INFO - Using real prefix '/tools/python27' 14:21:33 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:21:34 INFO - Installing distribute.............................................................................................................................................................................................done. 14:21:37 INFO - Installing pip.................done. 14:21:37 INFO - Return code: 0 14:21:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 14:21:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 14:21:37 INFO - Reading from file tmpfile_stdout 14:21:37 INFO - Output received: 14:21:37 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) 14:21:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:21:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:21:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:21:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:21:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:21:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:21:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:21:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1008c3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1008c6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee3a597150>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1006a1d30>, '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 0x1005c8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100696be8>, '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.7fEdgXp8GX/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.kwRU133bhJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:21:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 14:21:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:21:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7fEdgXp8GX/Render', 14:21:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:21:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:21:37 INFO - 'HOME': '/Users/cltbld', 14:21:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:21:37 INFO - 'LOGNAME': 'cltbld', 14:21:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:21:37 INFO - 'MOZ_NO_REMOTE': '1', 14:21:37 INFO - 'NO_EM_RESTART': '1', 14:21:37 INFO - 'PAGER': '/bin/cat', 14:21:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:21:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:21:37 INFO - 'PWD': '/builds/slave/test', 14:21:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:21:37 INFO - 'SHELL': '/bin/bash', 14:21:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kwRU133bhJ/Listeners', 14:21:37 INFO - 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/', 14:21:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:21:37 INFO - 'USER': 'cltbld', 14:21:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:21:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:21:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:21:37 INFO - 'XPC_FLAGS': '0x0', 14:21:37 INFO - 'XPC_SERVICE_NAME': '0', 14:21:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:21:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:21:38 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 14:21:38 INFO - Cleaning up... 14:21:38 INFO - Return code: 0 14:21:38 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:21:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:21:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:21:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:21:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:21:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:21:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:21:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1008c3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1008c6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee3a597150>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1006a1d30>, '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 0x1005c8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100696be8>, '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.7fEdgXp8GX/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.kwRU133bhJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:21:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 14:21:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 14:21:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7fEdgXp8GX/Render', 14:21:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:21:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:21:38 INFO - 'HOME': '/Users/cltbld', 14:21:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:21:38 INFO - 'LOGNAME': 'cltbld', 14:21:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:21:38 INFO - 'MOZ_NO_REMOTE': '1', 14:21:38 INFO - 'NO_EM_RESTART': '1', 14:21:38 INFO - 'PAGER': '/bin/cat', 14:21:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:21:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:21:38 INFO - 'PWD': '/builds/slave/test', 14:21:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:21:38 INFO - 'SHELL': '/bin/bash', 14:21:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kwRU133bhJ/Listeners', 14:21:38 INFO - 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/', 14:21:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:21:38 INFO - 'USER': 'cltbld', 14:21:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:21:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:21:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:21:38 INFO - 'XPC_FLAGS': '0x0', 14:21:38 INFO - 'XPC_SERVICE_NAME': '0', 14:21:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:21:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:21:38 INFO - Downloading/unpacking psutil>=3.1.1 14:21:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:21:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:21:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:21:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:21:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:21:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:21:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:21:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:21:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:21:41 INFO - Installing collected packages: psutil 14:21:41 INFO - Running setup.py install for psutil 14:21:41 INFO - building 'psutil._psutil_osx' extension 14:21:41 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 14:21:42 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 14:21:42 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 14:21:42 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 14:21:42 INFO - building 'psutil._psutil_posix' extension 14:21:42 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 14:21:42 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 14:21:42 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 14:21:42 INFO - ^ 14:21:42 INFO - 1 warning generated. 14:21:42 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 14:21:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:21:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:21:42 INFO - Successfully installed psutil 14:21:42 INFO - Cleaning up... 14:21:43 INFO - Return code: 0 14:21:43 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:21: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')]} 14:21:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:21:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:21: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')]} 14:21:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:21:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:21:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1008c3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1008c6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee3a597150>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1006a1d30>, '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 0x1005c8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100696be8>, '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.7fEdgXp8GX/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.kwRU133bhJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:21:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 14:21:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 14:21:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7fEdgXp8GX/Render', 14:21:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:21:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:21:43 INFO - 'HOME': '/Users/cltbld', 14:21:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:21:43 INFO - 'LOGNAME': 'cltbld', 14:21:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:21:43 INFO - 'MOZ_NO_REMOTE': '1', 14:21:43 INFO - 'NO_EM_RESTART': '1', 14:21:43 INFO - 'PAGER': '/bin/cat', 14:21:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:21:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:21:43 INFO - 'PWD': '/builds/slave/test', 14:21:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:21:43 INFO - 'SHELL': '/bin/bash', 14:21:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kwRU133bhJ/Listeners', 14:21:43 INFO - 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/', 14:21:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:21:43 INFO - 'USER': 'cltbld', 14:21:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:21:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:21:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:21:43 INFO - 'XPC_FLAGS': '0x0', 14:21:43 INFO - 'XPC_SERVICE_NAME': '0', 14:21:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:21:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:21:43 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:21:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:21:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:21:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:21:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:21:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:21:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:21:45 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:21:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:21:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:21:46 INFO - Installing collected packages: mozsystemmonitor 14:21:46 INFO - Running setup.py install for mozsystemmonitor 14:21:46 INFO - Successfully installed mozsystemmonitor 14:21:46 INFO - Cleaning up... 14:21:46 INFO - Return code: 0 14:21:46 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:21:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:21:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:21:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:21:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:21:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:21:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:21:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1008c3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1008c6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee3a597150>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1006a1d30>, '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 0x1005c8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100696be8>, '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.7fEdgXp8GX/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.kwRU133bhJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:21:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 14:21:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 14:21:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7fEdgXp8GX/Render', 14:21:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:21:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:21:46 INFO - 'HOME': '/Users/cltbld', 14:21:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:21:46 INFO - 'LOGNAME': 'cltbld', 14:21:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:21:46 INFO - 'MOZ_NO_REMOTE': '1', 14:21:46 INFO - 'NO_EM_RESTART': '1', 14:21:46 INFO - 'PAGER': '/bin/cat', 14:21:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:21:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:21:46 INFO - 'PWD': '/builds/slave/test', 14:21:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:21:46 INFO - 'SHELL': '/bin/bash', 14:21:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kwRU133bhJ/Listeners', 14:21:46 INFO - 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/', 14:21:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:21:46 INFO - 'USER': 'cltbld', 14:21:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:21:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:21:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:21:46 INFO - 'XPC_FLAGS': '0x0', 14:21:46 INFO - 'XPC_SERVICE_NAME': '0', 14:21:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:21:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:21:46 INFO - Downloading/unpacking jsonschema==2.5.1 14:21:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:21:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:21:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:21:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:21:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:21:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:21:49 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:21:49 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:21:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:21:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:21:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:21:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:21:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:21:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:21:49 INFO - Downloading functools32-3.2.3-2.tar.gz 14:21:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:21:49 INFO - warning: no files found matching '*.txt' 14:21:49 INFO - no previously-included directories found matching 'build' 14:21:49 INFO - no previously-included directories found matching 'dist' 14:21:49 INFO - no previously-included directories found matching '.git*' 14:21:49 INFO - Installing collected packages: jsonschema, functools32 14:21:49 INFO - Running setup.py install for functools32 14:21:49 INFO - warning: no files found matching '*.txt' 14:21:49 INFO - no previously-included directories found matching 'build' 14:21:49 INFO - no previously-included directories found matching 'dist' 14:21:49 INFO - no previously-included directories found matching '.git*' 14:21:49 INFO - Successfully installed jsonschema functools32 14:21:49 INFO - Cleaning up... 14:21:50 INFO - Return code: 0 14:21:50 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:21: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')]} 14:21:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:21:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:21: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')]} 14:21:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:21:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:21: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', '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 0x1008c3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1008c6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee3a597150>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1006a1d30>, '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 0x1005c8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100696be8>, '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.7fEdgXp8GX/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.kwRU133bhJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:21: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 14:21: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 functools32==3.2.3-2 14:21:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7fEdgXp8GX/Render', 14:21:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:21:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:21:50 INFO - 'HOME': '/Users/cltbld', 14:21:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:21:50 INFO - 'LOGNAME': 'cltbld', 14:21:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:21:50 INFO - 'MOZ_NO_REMOTE': '1', 14:21:50 INFO - 'NO_EM_RESTART': '1', 14:21:50 INFO - 'PAGER': '/bin/cat', 14:21:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:21:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:21:50 INFO - 'PWD': '/builds/slave/test', 14:21:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:21:50 INFO - 'SHELL': '/bin/bash', 14:21:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kwRU133bhJ/Listeners', 14:21:50 INFO - 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/', 14:21:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:21:50 INFO - 'USER': 'cltbld', 14:21:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:21:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:21:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:21:50 INFO - 'XPC_FLAGS': '0x0', 14:21:50 INFO - 'XPC_SERVICE_NAME': '0', 14:21:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:21:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:21:50 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:21:50 INFO - Cleaning up... 14:21:50 INFO - Return code: 0 14:21:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:21: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')]} 14:21:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:21:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:21: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')]} 14:21:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:21:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:21: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', '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 0x1008c3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1008c6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee3a597150>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1006a1d30>, '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 0x1005c8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100696be8>, '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.7fEdgXp8GX/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.kwRU133bhJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:21: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:21: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 blobuploader==1.2.4 14:21:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7fEdgXp8GX/Render', 14:21:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:21:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:21:50 INFO - 'HOME': '/Users/cltbld', 14:21:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:21:50 INFO - 'LOGNAME': 'cltbld', 14:21:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:21:50 INFO - 'MOZ_NO_REMOTE': '1', 14:21:50 INFO - 'NO_EM_RESTART': '1', 14:21:50 INFO - 'PAGER': '/bin/cat', 14:21:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:21:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:21:50 INFO - 'PWD': '/builds/slave/test', 14:21:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:21:50 INFO - 'SHELL': '/bin/bash', 14:21:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kwRU133bhJ/Listeners', 14:21:50 INFO - 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/', 14:21:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:21:50 INFO - 'USER': 'cltbld', 14:21:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:21:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:21:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:21:50 INFO - 'XPC_FLAGS': '0x0', 14:21:50 INFO - 'XPC_SERVICE_NAME': '0', 14:21:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:21:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:21:50 INFO - Downloading/unpacking blobuploader==1.2.4 14:21: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 14:21: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 14:21: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 14:21: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 14:21: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 14:21: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 14:21:53 INFO - Downloading blobuploader-1.2.4.tar.gz 14:21:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:21:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:21:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:21:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:21:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:21:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:21:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:21:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:21:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:21:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:21:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:21:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:21:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:21:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:21:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:21:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:21:54 INFO - Downloading docopt-0.6.1.tar.gz 14:21:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:21:54 INFO - Installing collected packages: blobuploader, requests, docopt 14:21:54 INFO - Running setup.py install for blobuploader 14:21:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:21:54 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:21:54 INFO - Running setup.py install for requests 14:21:55 INFO - Running setup.py install for docopt 14:21:55 INFO - Successfully installed blobuploader requests docopt 14:21:55 INFO - Cleaning up... 14:21:55 INFO - Return code: 0 14:21:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:21: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')]} 14:21:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:21:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:21: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')]} 14:21:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:21:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:21:55 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 0x1008c3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1008c6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee3a597150>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1006a1d30>, '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 0x1005c8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100696be8>, '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.7fEdgXp8GX/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.kwRU133bhJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:21:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:21:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:21:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7fEdgXp8GX/Render', 14:21:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:21:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:21:55 INFO - 'HOME': '/Users/cltbld', 14:21:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:21:55 INFO - 'LOGNAME': 'cltbld', 14:21:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:21:55 INFO - 'MOZ_NO_REMOTE': '1', 14:21:55 INFO - 'NO_EM_RESTART': '1', 14:21:55 INFO - 'PAGER': '/bin/cat', 14:21:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:21:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:21:55 INFO - 'PWD': '/builds/slave/test', 14:21:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:21:55 INFO - 'SHELL': '/bin/bash', 14:21:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kwRU133bhJ/Listeners', 14:21:55 INFO - 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/', 14:21:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:21:55 INFO - 'USER': 'cltbld', 14:21:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:21:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:21:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:21:55 INFO - 'XPC_FLAGS': '0x0', 14:21:55 INFO - 'XPC_SERVICE_NAME': '0', 14:21:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:21:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:21:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:21:55 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-qexk9D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:21:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:21:55 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-YYAubp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:21:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:21:55 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-dXe2lN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:21:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:21:55 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-Uid1PO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:21:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:21:56 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-pzT9qC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:21:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:21:56 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-zmGP0G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:21:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:21:56 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-6t3kmw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:21:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:21:56 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-aAYTaU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:21:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:21:56 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-tNdVkN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:21:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:21:56 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-PTGTwK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:21:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:21:56 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-hpXQ7C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:21:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:21:56 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-9McgNo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:21:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:21:56 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-Y56lpV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:21:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:21:57 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-wuo2qQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:21:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:21:57 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-w6YRUC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:21:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:21:57 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-_vkgE9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:21:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:21:57 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-qofcTF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:21:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:21:57 INFO - Running setup.py install for manifestparser 14:21:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:21:57 INFO - Running setup.py install for mozcrash 14:21:57 INFO - Running setup.py install for mozdebug 14:21:57 INFO - Running setup.py install for mozdevice 14:21:58 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:21:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:21:58 INFO - Running setup.py install for mozfile 14:21:58 INFO - Running setup.py install for mozhttpd 14:21:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:21:58 INFO - Running setup.py install for mozinfo 14:21:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:21:58 INFO - Running setup.py install for mozInstall 14:21:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:21:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:21:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:21:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:21:58 INFO - Running setup.py install for mozleak 14:21:58 INFO - Running setup.py install for mozlog 14:21:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:21:58 INFO - Running setup.py install for moznetwork 14:21:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:21:59 INFO - Running setup.py install for mozprocess 14:21:59 INFO - Running setup.py install for mozprofile 14:21:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:21:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:21:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:21:59 INFO - Running setup.py install for mozrunner 14:21:59 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:21:59 INFO - Running setup.py install for mozscreenshot 14:21:59 INFO - Running setup.py install for moztest 14:21:59 INFO - Running setup.py install for mozversion 14:21:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:21:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:21:59 INFO - Cleaning up... 14:21:59 INFO - Return code: 0 14:21:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:21: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')]} 14:21:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:21:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:21: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')]} 14:21:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:21:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:21:59 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 0x1008c3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1008c6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee3a597150>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1006a1d30>, '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 0x1005c8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100696be8>, '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.7fEdgXp8GX/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.kwRU133bhJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:21:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:21:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:21:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7fEdgXp8GX/Render', 14:21:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:21:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:21:59 INFO - 'HOME': '/Users/cltbld', 14:21:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:21:59 INFO - 'LOGNAME': 'cltbld', 14:21:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:21:59 INFO - 'MOZ_NO_REMOTE': '1', 14:21:59 INFO - 'NO_EM_RESTART': '1', 14:21:59 INFO - 'PAGER': '/bin/cat', 14:21:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:21:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:21:59 INFO - 'PWD': '/builds/slave/test', 14:21:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:21:59 INFO - 'SHELL': '/bin/bash', 14:21:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kwRU133bhJ/Listeners', 14:21:59 INFO - 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/', 14:21:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:21:59 INFO - 'USER': 'cltbld', 14:21:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:21:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:21:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:21:59 INFO - 'XPC_FLAGS': '0x0', 14:21:59 INFO - 'XPC_SERVICE_NAME': '0', 14:21:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:22:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:22:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:22:00 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-OVPTWL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:22:00 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 14:22:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:22:00 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-mJv7gY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:22:00 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)) 14:22:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:22:00 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-R3Yk27-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:22:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:22:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:22:00 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-ui72qP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:22:00 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)) 14:22:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:22:00 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-zIXWfN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:22:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 14:22:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:22:00 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-Ksw3cd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:22:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 14:22:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:22:00 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-U7cz1h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:22:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 14:22:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:22:00 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-b2xfUn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:22:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 14:22:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:22:01 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-CP2Bf3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:22:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 14:22:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:22:01 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-8ryPGy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:22:01 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)) 14:22:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:22:01 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-NkbVrP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:22:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 14:22:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:22:01 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-x7A8dG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:22:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 14:22:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:22:01 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-eeaDQb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:22:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 14:22:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:22:01 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-vME40k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:22:01 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)) 14:22:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:22:01 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-vpoiRX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:22:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 14:22:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:22:01 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-P9Fvf6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:22:01 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)) 14:22:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:22:01 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-VOwiha-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:22:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 14:22:02 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)) 14:22:02 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)) 14:22:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:22:02 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)) 14:22:02 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)) 14:22:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:22: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 14:22: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 14:22: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 14:22: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 14:22: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 14:22: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 14:22:04 INFO - Downloading blessings-1.6.tar.gz 14:22:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:22:04 INFO - Installing collected packages: blessings 14:22:04 INFO - Running setup.py install for blessings 14:22:04 INFO - Successfully installed blessings 14:22:04 INFO - Cleaning up... 14:22:05 INFO - Return code: 0 14:22:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:22:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:22:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:22:05 INFO - Reading from file tmpfile_stdout 14:22:05 INFO - Current package versions: 14:22:05 INFO - blessings == 1.6 14:22:05 INFO - blobuploader == 1.2.4 14:22:05 INFO - docopt == 0.6.1 14:22:05 INFO - functools32 == 3.2.3-2 14:22:05 INFO - jsonschema == 2.5.1 14:22:05 INFO - manifestparser == 1.1 14:22:05 INFO - mozInstall == 1.12 14:22:05 INFO - mozcrash == 1.0 14:22:05 INFO - mozdebug == 0.1 14:22:05 INFO - mozdevice == 0.49 14:22:05 INFO - mozfile == 1.2 14:22:05 INFO - mozhttpd == 0.7 14:22:05 INFO - mozinfo == 0.9 14:22:05 INFO - mozleak == 0.1 14:22:05 INFO - mozlog == 3.4 14:22:05 INFO - moznetwork == 0.27 14:22:05 INFO - mozprocess == 0.24 14:22:05 INFO - mozprofile == 0.28 14:22:05 INFO - mozrunner == 6.13 14:22:05 INFO - mozscreenshot == 0.1 14:22:05 INFO - mozsystemmonitor == 0.3 14:22:05 INFO - moztest == 0.8 14:22:05 INFO - mozversion == 1.4 14:22:05 INFO - psutil == 3.1.1 14:22:05 INFO - requests == 1.2.3 14:22:05 INFO - wsgiref == 0.1.2 14:22:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:22:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:22:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:22:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:22:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:22:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:22:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:22:06 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 0x1008c3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1008c6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee3a597150>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1006a1d30>, '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 0x1005c8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100696be8>, '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.7fEdgXp8GX/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.kwRU133bhJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:22:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 14:22:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:22:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7fEdgXp8GX/Render', 14:22:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:22:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:22:06 INFO - 'HOME': '/Users/cltbld', 14:22:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:22:06 INFO - 'LOGNAME': 'cltbld', 14:22:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:22:06 INFO - 'MOZ_NO_REMOTE': '1', 14:22:06 INFO - 'NO_EM_RESTART': '1', 14:22:06 INFO - 'PAGER': '/bin/cat', 14:22:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:22:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:22:06 INFO - 'PWD': '/builds/slave/test', 14:22:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:22:06 INFO - 'SHELL': '/bin/bash', 14:22:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kwRU133bhJ/Listeners', 14:22:06 INFO - 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/', 14:22:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:22:06 INFO - 'USER': 'cltbld', 14:22:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:22:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:22:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:22:06 INFO - 'XPC_FLAGS': '0x0', 14:22:06 INFO - 'XPC_SERVICE_NAME': '0', 14:22:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:22:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:22:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:22:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 14:22:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 14:22:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:22:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 14:22:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 14:22:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 14:22:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 14:22:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 14:22:06 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:22:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:22:06 INFO - Cleaning up... 14:22:06 INFO - Return code: 0 14:22:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:22:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:22:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:22:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:22:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:22:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:22:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:22:06 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 0x1008c3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1008c6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee3a597150>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1006a1d30>, '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 0x1005c8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100696be8>, '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.7fEdgXp8GX/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.kwRU133bhJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:22:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:22:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:22:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7fEdgXp8GX/Render', 14:22:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:22:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:22:06 INFO - 'HOME': '/Users/cltbld', 14:22:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:22:06 INFO - 'LOGNAME': 'cltbld', 14:22:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:22:06 INFO - 'MOZ_NO_REMOTE': '1', 14:22:06 INFO - 'NO_EM_RESTART': '1', 14:22:06 INFO - 'PAGER': '/bin/cat', 14:22:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:22:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:22:06 INFO - 'PWD': '/builds/slave/test', 14:22:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:22:06 INFO - 'SHELL': '/bin/bash', 14:22:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kwRU133bhJ/Listeners', 14:22:06 INFO - 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/', 14:22:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:22:06 INFO - 'USER': 'cltbld', 14:22:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:22:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:22:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:22:06 INFO - 'XPC_FLAGS': '0x0', 14:22:06 INFO - 'XPC_SERVICE_NAME': '0', 14:22:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:22:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:22:06 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:22:06 INFO - Cleaning up... 14:22:06 INFO - Return code: 0 14:22:06 INFO - Running post-action listener: _resource_record_post_action 14:22:06 INFO - Running post-action listener: _start_resource_monitoring 14:22:06 INFO - Starting resource monitoring. 14:22:06 INFO - [mozharness: 2017-03-29 21:22:06.992168Z] Finished create-virtualenv step (success) 14:22:06 INFO - [mozharness: 2017-03-29 21:22:06.992895Z] Running install step. 14:22:06 INFO - Running pre-action listener: _resource_record_pre_action 14:22:06 INFO - Running main action method: install 14:22:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:22:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:22:07 INFO - Reading from file tmpfile_stdout 14:22:07 INFO - Detecting whether we're running mozinstall >=1.0... 14:22:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:22:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:22:07 INFO - Reading from file tmpfile_stdout 14:22:07 INFO - Output received: 14:22:07 INFO - Usage: mozinstall [options] installer 14:22:07 INFO - Options: 14:22:07 INFO - -h, --help show this help message and exit 14:22:07 INFO - -d DEST, --destination=DEST 14:22:07 INFO - Directory to install application into. [default: 14:22:07 INFO - "/builds/slave/test"] 14:22:07 INFO - --app=APP Application being installed. [default: firefox] 14:22:07 INFO - mkdir: /builds/slave/test/build/application 14:22:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 14:22:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0.en-US.mac.dmg --destination /builds/slave/test/build/application 14:22:22 INFO - Reading from file tmpfile_stdout 14:22:22 INFO - Output received: 14:22:22 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 14:22:22 INFO - Running post-action listener: _resource_record_post_action 14:22:22 INFO - [mozharness: 2017-03-29 21:22:22.222709Z] Finished install step (success) 14:22:22 INFO - [mozharness: 2017-03-29 21:22:22.222843Z] Running run-tests step. 14:22:22 INFO - Running pre-action listener: _resource_record_pre_action 14:22:22 INFO - Running main action method: run_tests 14:22:22 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:22:22 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:22:22 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:22:22 INFO - 2017-03-29 14:22:22.236 screenresolution[1623:7371] starting screenresolution argv=screenresolution get 14:22:22 INFO - 2017-03-29 14:22:22.239 screenresolution[1623:7371] Display 0: 1600x1200x32@60 14:22:22 INFO - 2017-03-29 14:22:22.245 screenresolution[1624:7373] starting screenresolution argv=screenresolution list 14:22:22 INFO - Available Modes on Display 0 14:22:22 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:22:22 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:22:22 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:22:22 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:22:22 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:22:22 INFO - Intel Iris: 14:22:22 INFO - Chipset Model: Intel Iris 14:22:22 INFO - Type: GPU 14:22:22 INFO - Bus: Built-In 14:22:22 INFO - VRAM (Dynamic, Max): 1536 MB 14:22:22 INFO - Vendor: Intel (0x8086) 14:22:22 INFO - Device ID: 0x0a2e 14:22:22 INFO - Revision ID: 0x0009 14:22:22 INFO - Displays: 14:22:22 INFO - Display: 14:22:22 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:22:22 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:22:22 INFO - Display Serial Number: 1600x1200 60 14:22:22 INFO - Main Display: Yes 14:22:22 INFO - Mirror: Off 14:22:22 INFO - Online: Yes 14:22:22 INFO - Rotation: Supported 14:22:22 INFO - Return code: 0 14:22:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:22:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:22:22 INFO - Python 2.7.3 14:22:22 INFO - Return code: 0 14:22:22 INFO - grabbing minidump binary from tooltool 14:22:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:22:22 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 0x1006a1d30>, '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 0x1005c8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100696be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:22:22 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 14:22:22 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 14:22:22 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 14:22:22 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:22:22 INFO - Return code: 0 14:22:22 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 14:22:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:22:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:22:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 14:22:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:22:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/a8CV2bEdQPa53PweV6-s1Q/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0061', '--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 14:22:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/a8CV2bEdQPa53PweV6-s1Q/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0061 --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 14:22:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7fEdgXp8GX/Render', 14:22:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:22:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:22:22 INFO - 'HOME': '/Users/cltbld', 14:22:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:22:22 INFO - 'LOGNAME': 'cltbld', 14:22:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:22:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 14:22:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:22:22 INFO - 'MOZ_NO_REMOTE': '1', 14:22:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:22:22 INFO - 'NO_EM_RESTART': '1', 14:22:22 INFO - 'PAGER': '/bin/cat', 14:22:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:22:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:22:22 INFO - 'PWD': '/builds/slave/test', 14:22:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:22:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:22:22 INFO - 'SHELL': '/bin/bash', 14:22:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kwRU133bhJ/Listeners', 14:22:22 INFO - 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/', 14:22:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:22:22 INFO - 'USER': 'cltbld', 14:22:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:22:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:22:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:22:22 INFO - 'XPC_FLAGS': '0x0', 14:22:22 INFO - 'XPC_SERVICE_NAME': '0', 14:22:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:22:22 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/a8CV2bEdQPa53PweV6-s1Q/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0061', '--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 14:22:22 INFO - mozversion application_buildid: 20170329132822 14:22:22 INFO - mozversion application_changeset: f76dd729117c42ffbb503db17d3f0e9c64533372 14:22:22 INFO - mozversion application_display_name: Firefox 14:22:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:22:22 INFO - mozversion application_name: Firefox 14:22:22 INFO - mozversion application_remotingname: firefox 14:22:22 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 14:22:22 INFO - mozversion application_vendor: Mozilla 14:22:22 INFO - mozversion application_version: 53.0 14:22:22 INFO - mozversion platform_buildid: 20170329132822 14:22:22 INFO - mozversion platform_changeset: f76dd729117c42ffbb503db17d3f0e9c64533372 14:22:22 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 14:22:22 INFO - mozversion platform_version: 53.0 14:22:22 INFO - using testdate: 1490822542 14:22:22 INFO - actual date: 1490822542 14:22:22 INFO - starting webserver on 'localhost:49237' 14:22:22 INFO - SUITE-START | Running 2 tests 14:22:22 INFO - TEST-START | dromaeo_css 14:22:22 INFO - operating with platform_type : mac_ 14:22:22 INFO - Initialising browser for dromaeo_css test... 14:22:22 INFO - TEST-INFO | started process 1634 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/tmpAJ9sWh/profile http://localhost:49237/getInfo.html) 14:22:25 INFO - PROCESS | 1634 | __metrics Screen width/height:1600/1200 14:22:25 INFO - PROCESS | 1634 | colorDepth:24 14:22:25 INFO - PROCESS | 1634 | Browser inner width/height: 1024/689 14:22:25 INFO - PROCESS | 1634 | __metrics 14:22:25 INFO - PROCESS | 1634 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 14:22:25 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] 14:22:26 INFO - TEST-INFO | 1634: exit 0 14:22:26 INFO - Browser initialized. 14:22:26 INFO - Running cycle 1/1 for dromaeo_css test... 14:22:26 INFO - TEST-INFO | started process 1637 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/tmpAJ9sWh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:22:38 INFO - PROCESS | 1637 | RSS: Main: 167194624 14:22:38 INFO - PROCESS | 1637 | 14:25:40 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49237/tests/dromaeo/cssquery-ext.html) 14:25:42 INFO - PROCESS | 1637 | RSS: Main: 339910656 14:25:42 INFO - PROCESS | 1637 | 14:28:45 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-ext.html (next: http://localhost:49237/tests/dromaeo/cssquery-jquery.html) 14:28:45 INFO - PROCESS | 1637 | RSS: Main: 307699712 14:28:45 INFO - PROCESS | 1637 | 14:31:48 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49237/tests/dromaeo/cssquery-mootools.html) 14:31:48 INFO - PROCESS | 1637 | RSS: Main: 277868544 14:31:48 INFO - PROCESS | 1637 | 14:34:50 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49237/tests/dromaeo/cssquery-prototype.html) 14:34:51 INFO - PROCESS | 1637 | RSS: Main: 288239616 14:34:51 INFO - PROCESS | 1637 | 14:37:54 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49237/tests/dromaeo/cssquery-yui.html) 14:37:55 INFO - PROCESS | 1637 | RSS: Main: 271859712 14:37:55 INFO - PROCESS | 1637 | 14:40:58 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-yui.html (next: http://localhost:49237/tests/dromaeo/cssquery-dojo.html) 14:40:58 INFO - PROCESS | 1637 | RSS: Main: 430432256 14:40:58 INFO - PROCESS | 1637 | 14:40:58 INFO - PROCESS | 1637 | __start_tp_report 14:40:58 INFO - PROCESS | 1637 | _x_x_mozilla_page_load 14:40:58 INFO - PROCESS | 1637 | _x_x_mozilla_page_load_details 14:40:58 INFO - PROCESS | 1637 | |i|pagename|runs| 14:40:58 INFO - PROCESS | 1637 | |0;dojo.html;2867.1685211288727;3375.5105509701093;3378.138574663462;3406.773561517853;3428.7599868009247;5761.510271626911;5786.508146807527;5840.445157710016;5844.064949608063;5853.239078919734;5707.571932105088;5753.597248192628;5848.970755146229;5848.976429124897;5851.385604511529;5128.256402821598;5295.496927791873;5303.7082960437165;5316.867078323035;5354.705491197982;3695.722820788438;5198.324217851674;5228.712420816853;5348.224507446418;5377.946220537803;5252.133397989346;5258.8685282867855;5265.3681558212875;5283.656562323436;5289.365276166865;5277.419483856773;5284.762185701653;5294.867628309304;5299.284596579451;5306.893862122774;5154.664946778447;5226.5818734501145;5309.65487243328;5314;5332.626716129873;5972.372900845392;5976.312724036748;6002.6398416094735;6009.549283803733;6024.969875150597;6156.476699480505;6214.036824292242;6355.968220158869;6372.426481616677;6387.776427825051;6263.71813268404;6308.684565771693;6329.493640508748;6335.081413195107;6347.619142851444;5805.970970145165;5881.117832325142;5941.287045554518;5988.401159883977;6006.759729610854;6307.053941908659;6308.369163083655;6315.273743519462;6315.273743519554;6328.810135695937;6275.215598050244;6285.59143655661;6288.213973253343;6306.306306306303;6313.147725057151;6245.843853903598;6279.717412716347;6292.779752708633;6296.590721603081;6350.587211831216;6309.08518264849;6334.556581039283;6358.427741503287;6372.490200783926;6375.075614035939;6350.968245158745;6354.078658594478;6371.96814015927;6375.71309291083;6408.9745640697265;4971.527704868032;5025.623078269071;5025.874353141127;5040.722760248148;5083.567896728746;4471.776411179493;4483.148201841705;4500.189965806121;4533.093381323749;4547.8635640930825;5746.827595172152;5751.424857514299;5760.36635970043;5765;5801.6519008859605;6207.379262073757;6290.150829638032;6317.084022816758;6330.8100756977365;6347.619142851444;5592.832215033555;5606.271184746039;5698;5713.200151978726;5830.7959221427045;5522.088855338824;5526.47498487643;5534.05920993424;5541.113421852484;5543.390227075019;6249.6875156242;6262.029385445263;6264.68676566179;6269.059641053878;6270.059491076375;6034.788782392595;6053.727582258721;6115.113308570321;6274.529410294337;6275.184226050585;6264.123022776724;6279.811605651837;6289.528285378524;6292.433680968735;6293.811185664437;6297.275813281532;6304.71628776697;6313.589616674902;6320.462760665395;6330.145430367026;6257.249130104235;6260.843478913063;6275.058741188675;6299.748010079546;6317.399847014526;6171.1360409543595;6171.321154673072;6191.84520386994;6294.370562943669;6301.243850737941;6008.54935879802;6247.0629405589525;6250.812475625738;6261.24865016201;6263.96868015657;5844.6785426801935;5936.673482958478;6034.547408944259;6133.080037994337;6147.784827531015;6044.90932636002;6134.467201660849;6141.662208578571;6149.84625384369;6228.813135605939;6094.481969032682;6102.780000695884;6129.84675383119;6130.5402094842175;6134.577161634294 14:40:58 INFO - PROCESS | 1637 | |1;ext.html;471.75233002673593;494.97772600232975;546.1289243656369;547.4033303698967;557.6458948567658;32347.353052938957;41483;43432.13135737283;43479.47821826237;45329;37920.81039594805;44015.55984440155;45110.323345149845;45114.32328515075;45365;9105.544722763836;9580.473073980927;9796.510174491246;9804.264680148981;9818.705438836847;9157.2216361609;12057.939710301436;12265.386730663477;12281.815772763372;12408.627741167735;12118.757624847498;12214.511419543252;12215.206011609262;12216.511339546452;12218.32799196044;12141.817872731915;12203.511859525608;12209.93895030528;12217.93891030539;12225;12004.339761313124;12075.154739168262;12080.758384832254;12082.033437324993;12086.153969222158;41839;42085.78957105226;42088.57911420908;42162.78918605418;42253;4018.959810401888;4099.913522916429;4114.670826333886;4115.938260926088;4124.298869192215;30601.540976885364;30887.536686949712;32808.85169019097;33096.67613295465;33302;3272.6072871255365;3302.3230237801195;3401.795892246473;3493;3537.964620353789;435629;436477;436892;440835;441872;65279.673601631686;65544.67227663832;65653.671731642;65696.67151664307;65745;67655.66172169108;68540.3145968544;68614.65692671605;68626;68629.65685171542;17333;17900.194491247927;17915.73126403105;17931;17940.83384579998;12356.814647780291;12651;13551.254680992442;13563.728725425437;13577.389017494237;21892.343229703136;22814.31557053291;22846.086156553883;23327.066917323456;23404.7659523406;7498.925010749932;8854.335924805537;9109.362344635812;9112.81774364509;9143.177114059767;890.6838072484304;911.9270458363314;919.6643225222746;949.2738055387634;959.5681943125621;30723.846380767955;31139.37721245608;31441.899533516218;31797.36405271928;31938.041858744276;982.1259079419323;989.4261328429494;1009.7071849163807;1016.0601443664729;1075.596651255779;15589.610259743597;15978.041317520985;16046.679066418606;16071.517854464384;16462.341506339853;691072;694842;695113.048869515;696855;698491;63270.68364658147;63777;63920.680396597716;64055.6797216011;64061.679691601246;1270.6632742323293;1313.507434711983;1410.5133728863525;1493.5668656089613;1522.9923850380678;26788.866055670376;28847.42305153927;29720.05305727672;32349.838250808596;32420.513692294164;52629.473705262455;53224;53358.46641533535;53516;53523;533806;535611;536009;539188;540485;37250.25499490049;38018;44224.7887605612;44644.88387790331;44837.551624483334;49535.752321238164;49557;50641.73395665138;50746.2388064172;51070.74464627653;26573.60139597869;31092.844535777178;33449;33856.15359616029;34954;33471.665283346854;33484.49773253354;33559.83220083884;33740;34090.82954585211;37200.883973480835;37571.81214093912;37596.436053458674;39579.80210098931;39846.60153398545;30388.936387226342;31261.8436907814;31682.049538513882;31701.524477133324;32457.837710811295;24599.877000615597;25197.496050079262;25432.618510722725;25561.488770224863;25921.945220681788 14:40:58 INFO - PROCESS | 1637 | |2;jquery.html;313.2888343460345;374.2048147686167;393.8188433320672;403.9636432721056;418;17257.137143142856;17483.737743933852;19749.50626234345;22875;23082.88458557707;21980.78019219807;22634.20780272691;23166;23339.066437342528;23362.532749345002;5879.617824841383;6192.504599632019;6202.4417802397775;6202.9379706203035;6205.131281620576;6051.062085376773;6069.696515174246;6127.540434467411;6186.412290832363;6204.193454850863;6155.846103847395;6165.7533698652;6169.537284703642;6176.87646247077;6177.969110154443;4931.3835770528685;6071.332153463138;6125.234345706786;6136.048912418582;6136.509079273647;4998.57512111471;5014.047331007097;5337.946620533823;5370.758315875795;5376.596755243372;13733.931330343285;14118;14127.364268607835;14135.010549261557;19006.809931900643;2373.311739595515;2930.1209637108996;3001.0846691759007;3047.832369219692;3052.786304958654;10157.644482443078;10333.534990925351;10366.429846358447;10377.429241391721;10557.788844223072;1824.5894673698444;1846.6860633692304;1853.7497437845852;1861.3299212283566;1872.0826794870552;133915;137147.31426342804;140325.2983735085;141078;142862;11776.293422394683;11923.224990375598;11924.34416107105;11970.281783093042;12136.271823690608;14321.856781432261;15001.099934003994;16114.113723745306;16116.194190290438;16137.515874523782;8436.28291595209;8756.4308319959;8858.689945851864;9175.541222938826;9267;8758.343124265706;9045.59294831721;9049.683261085962;9055.230305424113;9241.861372079424;3998.820053097618;4173.706151093171;4361.367601697736;4647.16351056813;4834.597966589649;1859.9535011624819;1926.1428664244556;2043.867148635334;2055.4553043443498;2056.794320567931;1008.9041541053588;1037.8495118207818;1054.5289321396608;1058.1270451877078;1069.6988005506919;18600.7909485883;21938.793366365004;22062.88968555147;22188.778112218995;22398.880055997462;929.6002718830968;975.531744762518;982.3663736889808;1034.8447732840134;1092.6721983404946;10918.071963883;11559.653210403701;11562.07503399726;11595.826062609067;11595.942020289845;650212;728667;758844;779276;788963;130769.34615327053;150036.24981875022;153247;157286.21356893142;159018;1060.920430967665;1066.7866426714688;1083.2146693647044;1088.0751361342955;1091.514276147107;18783.906080470057;18998.240070397584;19377.709334359715;19396;19459.805401946367;56082.439175609354;58317.4168258312;58804.529886753175;59016;60044.39733615997;70710.93933591103;86834.56582717046;87159;87814.80462988222;87855.56072219598;8345.707900223462;8456.83086338282;8657.696980605648;8970.41692289999;8999.910000899907;11307.265027773168;13114.60656180316;13254;13540.79688804649;13891.305434728021;11244.718882027688;11788.29270243788;12058.577949771716;12143.75712485763;12256.632301030982;8664.83024791645;10754.89245107539;11038.448077595927;11350.375729334966;11385.715357116138;11638.88361116378;11800.409979501163;12119.272843629411;12248.265104093784;12279.140460167702;8460.873086903579;8606.44058136219;8675.82648347017;8924.464532128093;8927.910720892707;10005;11754.647360579196;11827.645170644895;11874.228175168586;12124.454399552218 14:40:58 INFO - PROCESS | 1637 | |3;mootools.html;1474.6903150338428;1478.0762023735165;1500.2198856594564;1507.2463768115942;1512.4177191781162;8171.0603280622745;8562.357823163256;8564.91435085649;8566.357523185763;8589.312854971602;7568;7776.53340799551;8117.512949223036;8356.749297521068;8383.455075420094;2338.2634470141893;2379.4884099918513;2386.8567885926814;2390.008146619151;2396.928092157238;2366.408397900525;2394.353524548371;2397.1729753235104;2402.5675378431874;2405.1581946318825;2281.977180228193;2284.189112864934;2307.365474494519;2309.2033248529315;2309.399556115405;2317.7566355532595;2335.637976113697;2336.6027775278076;2361.0791791201445;2362.185046159081;2354.776296251853;2355.4464700795297;2400.567897778399;2400.8559486430872;2403.110848985869;7290.651229522556;8444.155584441569;8517.82964340716;8525.232729054353;8530.360222983301;5152.948470515322;5308.309919710451;5321.707306098163;5324.361076670824;5324.440933701983;2881.3084859633536;3163.9209019774457;3255.283837555734;3439.8820383375255;3448.4310088835314;1159.2406973432414;1168.9006434452997;1181.1967861853936;1203.3441774233063;1212.89083982442;10798.2441229114;10879.510422031028;10893.727656808564;10910.454477276104;10936.015758581765;4487.506374298824;4683.320918466803;4752.239641657387;4831.613470922318;4838.588719958772;9562;9565.569549370295;9566.234701223886;9568.56941437637;9598.520073996273;5345.70598617072;5350.117230656976;5359.651622644516;5367.382750983609;5371.4897084776885;4259.7231179973205;4317.330813723878;4893.559579637849;4899.902001959941;4924.926126108111;3898.590647981978;3931.4889064422014;3989.162275922089;4013.177298653769;4018.4976877890263;1293.734784369202;1295.430010795247;1297.1049975516862;1303.687115092371;1309.607117864656;791.6239786101555;802.6388125343618;818.0878320672407;819.6680344460503;827.2554700769356;5464.808731694372;5510.256115424447;5517.393086760453;5586.608937374426;5615.354234263031;562.4993755557557;581.5405829394731;587.574008843585;596.9104634304889;599.5173885022512;3634.473001414833;3680.6319368063514;3775;3791.810409479515;3798.6201379862346;9698.75753106178;10134.23993200513;10161.593536258466;10167.440790756431;10167.949160254298;9743.415395076176;9794.510274486389;10043.69868903934;10060.899391006142;10115.190784737204;7665;7829.64766585505;7903.972483577213;7912.248336408032;7915.406344524184;5433.945660543344;5475.863103422446;5574.749136288796;5635.380108188178;5644.548436125018;9216.447013179231;9229.907700922904;9249.028851970446;9270.907290927003;9276.211522020434;9208.355415120877;9317.16145546904;9350.485723285285;9543.570539325608;9568.904310956801;7201.891971620535;7285.089363829521;7334.156571994075;7356.48504604694;7375.520591161558;7897.131315555399;7938.880916786368;7972.123066462568;7977;7984.361251100015;5955.464008239106;6955.547889387173;6977;7033.542819716702;7068.893966590608;6856.588604683735;6879.174499060145;6893.138357705287;7020.894686579603;7021.754238601625;6302.842428939313;6474;6477.125588045742;6486.578372405778;6490.221173459215;5001.824936127218;5042.168042272984;5061.240813877947;5081;5095.0574143783515;4929.926051109164;5000.799968001239;5049.823256186016;5113.309703190171;5203.037438073969 14:40:58 INFO - PROCESS | 1637 | |4;prototype.html;363.2462640021955;366.1687968311932;378.2774899941112;380.12381460733;383.631713554987;4975.154223781957;5168.302279192308;5194.792208311667;5241.423443421226;5283.920741188876;4312.5903039211225;4410.404595379631;4994.350734404531;5080;5085.720285384303;3183.3951549205576;3990.8204130814183;4039.6970227233;4049.2711311963835;4150.730202536841;3900.5904380040115;3935.2129574085156;4062.329715596923;4110.054687421894;4151.543330233671;3296.6373698893103;3442.6901578857896;3989.4241774499055;4085.5097388313443;4122.051928056549;3398.09950363154;4083.203775263825;4114.19773144237;4116.464859568267;4116.58834116589;3181.5704879841387;3456.6864591455337;3649.3431182387158;3666.2319948439026;3679.7792132472136;4801.391533836169;5019.297298378194;5095.898082038376;5120.564751996085;5139.203423469368;4067.715259931806;4134.214499245134;4634.907301853944;4654.627629789608;4743.83396581118;4756.127395912908;4760.880977975578;5262.842114736564;5464.289642346509;5504.366997795265;3390.9491357629654;3811.5774919260857;4020.557738648746;4036.455078564415;4043.3934909763475;4772.73749943753;5629.60592758507;5659.60382773206;5706.657600543981;5739.225204597367;3458.4120699480645;4086.713930024929;4092.979535102365;4096.528899176573;4118.990847242445;3551.685876225813;3619.583747868976;4148.6352778915725;4150.654879992794;4159.563245859202;3916.4321173429694;4473.9933514958875;4482.843100491467;4514.6614003949835;4575.702579332333;4814.20565606671;5483.369412517612;5501.284832971688;5542.057850165482;5545.251391062236;1176.7940610393148;1206.6907405464992;1249.3191210790142;1250.3810613746073;1261.5933234443712;719.0544434069183;868.8088620503479;871.7733389318822;878.6090189865577;886.2998231397124;4231.788410579458;4707.670463067552;4870.003298647608;4900.950990490121;4983.352164218701;4530.818767249339;4612.5654711677025;5101.974490127525;5230.3985041719925;5374.828850977942;4056.9451942495166;4148.854790082332;4753.480655252722;4807;4862.416510018749;2611.9477610447684;2797.9160625181275;2803.444088530844;2828.9717102829118;2872.7989040766947;4791.880202994953;5006.973570418056;5084.542391184811;5260.710660913686;5378.650387724785;4370.781460927004;5011.298418221452;5415.539679127318;5416.945830541723;5478.260434841325;4774.641901857305;4826.420829500342;5342.999999999923;5451.972740136274;5465.836024919259;4452.666050046195;4543;4618.907621847611;4644.8142074318;4851.490593487633;4527.713504680116;4784.712917224978;4800.039992001543;5178.275041494118;5269.235960785588;4814.037192561432;4973.428055773632;5187;5434.3207099112615;5436.565074793928;3109.9222519437194;3163.8576264068633;3269.7711160218555;3630.623520126308;3647.8081678531285;4525.773711314355;4979.726115063706;5265.578753699771;5338.893222135458;5365.865853353697;4207.957920420879;4569;4769.093872164278;5160.638755287094;5169.974150129226;4529.8641040768825;4754.980587327142;4903.877403064952;5030.572401345927;5131.461196574455;5102.79588816458;5239.947600523946;5284.260203571426;5291.867703307448;5312.601554883322;4738.455077665974;4776.880577985439;5418.674879507243;5450.945490545044;5519.475649813261;4723.409573803275;5286.735663216747;5365.38298095724;5371.462853714754;5420.4037555868035 14:40:58 INFO - PROCESS | 1637 | |5;yui.html;747.9289467500586;773.6441237030969;802.6588699802586;867.1458613265931;879.4239772948716;12566.057545684065;12713.682157946056;14931.178785166812;15099.094054356732;15575.766363504557;14123.505677301297;14385.856141438582;14415.477291473977;14539.418423263083;14563.344649490771;885.7431344909985;892.13908578222;892.2505095719595;892.3931726426027;892.5715656484891;617.1883972576071;709.9609521476317;875.3303722652176;881.1144799476517;907.0747837206046;937.2548823685187;941.4492521874678;941.5433514745343;941.7786820097272;943.8914524829664;932.5710173320281;934.8597710343469;934.8691183234353;934.9252059835197;935.3172184305461;697.7836870570139;698.5145323999823;699.9335063168991;700.4291502425558;700.5061431690646;15449.828108597514;15515.379384824593;15553.066815991077;15579.532614021597;15592.532224033297;14578.927105364512;14706.70586588273;14995.100293982396;15117.924410377987;15142.54572362831;11478.770424591545;11491.367974761384;11720.120990925714;11852.881471185265;11867.762644747057;3676.37527545394;3858.189780146173;3903.6486716195395;3915.393114067324;4047.5750046245307;97423.51288243514;98750;100743.49628251886;101689.4915525425;101929.49035254776;11339.433028348549;11369.2609980351;11885.28688278706;11922.642320730392;12181.573644922386;23553.41116472102;23773.524529509312;23993.52012959731;24002.27993160208;24024.15915442951;8046.195380462024;8082.595870206584;8084.959575202086;8203.630836612367;8338.541380224025;4439;4453.55464453552;4464.665150113689;4549;4558.1795276849825;3469.2367679110557;3532;3553.289342131584;3566.4828599852876;3569.232614987738;668.4284936379325;669.3908543225641;675.9053732477457;688.2188715807595;688.5662032919229;696.7735485967081;697.7732237022988;710.531049507333;720.2725247500063;764.9800299426478;10008;10607.705099226261;10625.9468702656;10652.254342195973;10853.403062831461;679.7247114918367;710.3961632612342;715.377621469325;724.5652608434897;728.8870225115115;5111.233315002705;5160.354955630546;5210.557102646242;5242.633015688865;5260.184671375943;105179.474102629;107720.92279077266;108899.45550272198;109110;109912;98250;99774.5011274939;99885.00114998902;100345;101118.48322275172;84134.15865841263;85781;87162;87180.1281987172;88899.11100889038;9975.60097596088;10160.390376577428;10162.339447935861;10175.389476631426;10214.591416343263;41392.586074140076;43725.469608563544;51348.48651513437;51577.10017548327;52147.43557693275;46276.7686161567;63421.682891585246;68702.65648671724;68983;71682.92475612974;13285.734285314433;13528.526501572398;13640.65898352549;13816.96372772026;14058.578242652737;15006.6998660024;15119.848801511844;15321.540353788958;15417;15652.4521641742;13629.38667759973;13750.243736594583;14246.786298205328;14438.711225775636;14875.47935822241;14045.36795844169;14227.50203742864;14250;14275.928620356832;14426.639334016314;13310.46758129664;14003.649908752363;14173;14173.574792756233;14193.716125677221;9682.951585242028;9897.802043958936;10106.49467526606;10407.531661075422;10477.42374169428;11043.668689939315;11058.612948546763;11457.427128643702;11485.712857178638;11519.42402879836 14:40:58 INFO - PROCESS | 1637 | __end_tp_report 14:40:58 INFO - PROCESS | 1637 | __start_cc_report 14:40:58 INFO - PROCESS | 1637 | _x_x_mozilla_cycle_collect,1793 14:40:58 INFO - PROCESS | 1637 | __end_cc_report 14:40:58 INFO - PROCESS | 1637 | __startTimestamp1490823658790__endTimestamp 14:40:58 INFO - PROCESS | 1637 | 14:40:58 INFO - PROCESS | 1637 | ------- Summary: start ------- 14:40:58 INFO - PROCESS | 1637 | Number of tests: 6 14:40:58 INFO - PROCESS | 1637 | 14:40:58 INFO - PROCESS | 1637 | [#0] dojo.html Cycles:165 Average:5817.43 Median:6094.48 stddev:672.61 (11.0%) stddev-sans-first:633.60 14:40:58 INFO - PROCESS | 1637 | Values: 2867.2 3375.5 3378.1 3406.8 3428.8 5761.5 5786.5 5840.4 5844.1 5853.2 5707.6 5753.6 5849.0 5849.0 5851.4 5128.3 5295.5 5303.7 5316.9 5354.7 3695.7 5198.3 5228.7 5348.2 5377.9 5252.1 5258.9 5265.4 5283.7 5289.4 5277.4 5284.8 5294.9 5299.3 5306.9 5154.7 5226.6 5309.7 5314.0 5332.6 5972.4 5976.3 6002.6 6009.5 6025.0 6156.5 6214.0 6356.0 6372.4 6387.8 6263.7 6308.7 6329.5 6335.1 6347.6 5806.0 5881.1 5941.3 5988.4 6006.8 6307.1 6308.4 6315.3 6315.3 6328.8 6275.2 6285.6 6288.2 6306.3 6313.1 6245.8 6279.7 6292.8 6296.6 6350.6 6309.1 6334.6 6358.4 6372.5 6375.1 6351.0 6354.1 6372.0 6375.7 6409.0 4971.5 5025.6 5025.9 5040.7 5083.6 4471.8 4483.1 4500.2 4533.1 4547.9 5746.8 5751.4 5760.4 5765.0 5801.7 6207.4 6290.2 6317.1 6330.8 6347.6 5592.8 5606.3 5698.0 5713.2 5830.8 5522.1 5526.5 5534.1 5541.1 5543.4 6249.7 6262.0 6264.7 6269.1 6270.1 6034.8 6053.7 6115.1 6274.5 6275.2 6264.1 6279.8 6289.5 6292.4 6293.8 6297.3 6304.7 6313.6 6320.5 6330.1 6257.2 6260.8 6275.1 6299.7 6317.4 6171.1 6171.3 6191.8 6294.4 6301.2 6008.5 6247.1 6250.8 6261.2 6264.0 5844.7 5936.7 6034.5 6133.1 6147.8 6044.9 6134.5 6141.7 6149.8 6228.8 6094.5 6102.8 6129.8 6130.5 6134.6 14:40:58 INFO - PROCESS | 1637 | 14:40:58 INFO - PROCESS | 1637 | [#1] ext.html Cycles:180 Average:70630.35 Median:37584.12 stddev:151361.71 (402.7%) stddev-sans-first:151694.66 14:40:58 INFO - PROCESS | 1637 | Values: 471.8 495.0 546.1 547.4 557.6 32347.4 41483.0 43432.1 43479.5 45329.0 37920.8 44015.6 45110.3 45114.3 45365.0 9105.5 9580.5 9796.5 9804.3 9818.7 9157.2 12057.9 12265.4 12281.8 12408.6 12118.8 12214.5 12215.2 12216.5 12218.3 12141.8 12203.5 12209.9 12217.9 12225.0 12004.3 12075.2 12080.8 12082.0 12086.2 41839.0 42085.8 42088.6 42162.8 42253.0 4019.0 4099.9 4114.7 4115.9 4124.3 30601.5 30887.5 32808.9 33096.7 33302.0 3272.6 3302.3 3401.8 3493.0 3538.0 435629.0 436477.0 436892.0 440835.0 441872.0 65279.7 65544.7 65653.7 65696.7 65745.0 67655.7 68540.3 68614.7 68626.0 68629.7 17333.0 17900.2 17915.7 17931.0 17940.8 12356.8 12651.0 13551.3 13563.7 13577.4 21892.3 22814.3 22846.1 23327.1 23404.8 7498.9 8854.3 9109.4 9112.8 9143.2 890.7 911.9 919.7 949.3 959.6 30723.8 31139.4 31441.9 31797.4 31938.0 982.1 989.4 1009.7 1016.1 1075.6 15589.6 15978.0 16046.7 16071.5 16462.3 691072.0 694842.0 695113.0 696855.0 698491.0 63270.7 63777.0 63920.7 64055.7 64061.7 1270.7 1313.5 1410.5 1493.6 1523.0 26788.9 28847.4 29720.1 32349.8 32420.5 52629.5 53224.0 53358.5 53516.0 53523.0 533806.0 535611.0 536009.0 539188.0 540485.0 37250.3 38018.0 44224.8 44644.9 44837.6 49535.8 49557.0 50641.7 50746.2 51070.7 26573.6 31092.8 33449.0 33856.2 34954.0 33471.7 33484.5 33559.8 33740.0 34090.8 37200.9 37571.8 37596.4 39579.8 39846.6 30388.9 31261.8 31682.0 31701.5 32457.8 24599.9 25197.5 25432.6 25561.5 25921.9 14:40:58 INFO - PROCESS | 1637 | 14:40:58 INFO - PROCESS | 1637 | [#2] jquery.html Cycles:180 Average:40538.62 Median:21959.79 stddev:123841.43 (563.9%) stddev-sans-first:124152.00 14:40:58 INFO - PROCESS | 1637 | Values: 313.3 374.2 393.8 404.0 418.0 17257.1 17483.7 19749.5 22875.0 23082.9 21980.8 22634.2 23166.0 23339.1 23362.5 5879.6 6192.5 6202.4 6202.9 6205.1 6051.1 6069.7 6127.5 6186.4 6204.2 6155.8 6165.8 6169.5 6176.9 6178.0 4931.4 6071.3 6125.2 6136.0 6136.5 4998.6 5014.0 5337.9 5370.8 5376.6 13733.9 14118.0 14127.4 14135.0 19006.8 2373.3 2930.1 3001.1 3047.8 3052.8 10157.6 10333.5 10366.4 10377.4 10557.8 1824.6 1846.7 1853.7 1861.3 1872.1 133915.0 137147.3 140325.3 141078.0 142862.0 11776.3 11923.2 11924.3 11970.3 12136.3 14321.9 15001.1 16114.1 16116.2 16137.5 8436.3 8756.4 8858.7 9175.5 9267.0 8758.3 9045.6 9049.7 9055.2 9241.9 3998.8 4173.7 4361.4 4647.2 4834.6 1860.0 1926.1 2043.9 2055.5 2056.8 1008.9 1037.8 1054.5 1058.1 1069.7 18600.8 21938.8 22062.9 22188.8 22398.9 929.6 975.5 982.4 1034.8 1092.7 10918.1 11559.7 11562.1 11595.8 11595.9 650212.0 728667.0 758844.0 779276.0 788963.0 130769.3 150036.2 153247.0 157286.2 159018.0 1060.9 1066.8 1083.2 1088.1 1091.5 18783.9 18998.2 19377.7 19396.0 19459.8 56082.4 58317.4 58804.5 59016.0 60044.4 70710.9 86834.6 87159.0 87814.8 87855.6 8345.7 8456.8 8657.7 8970.4 8999.9 11307.3 13114.6 13254.0 13540.8 13891.3 11244.7 11788.3 12058.6 12143.8 12256.6 8664.8 10754.9 11038.4 11350.4 11385.7 11638.9 11800.4 12119.3 12248.3 12279.1 8460.9 8606.4 8675.8 8924.5 8927.9 10005.0 11754.6 11827.6 11874.2 12124.5 14:40:58 INFO - PROCESS | 1637 | 14:40:58 INFO - PROCESS | 1637 | [#3] mootools.html Cycles:180 Average:5459.66 Median:5324.40 stddev:2984.25 (56.0%) stddev-sans-first:2977.59 14:40:58 INFO - PROCESS | 1637 | Values: 1474.7 1478.1 1500.2 1507.2 1512.4 8171.1 8562.4 8564.9 8566.4 8589.3 7568.0 7776.5 8117.5 8356.7 8383.5 2338.3 2379.5 2386.9 2390.0 2396.9 2366.4 2394.4 2397.2 2402.6 2405.2 2282.0 2284.2 2307.4 2309.2 2309.4 2317.8 2335.6 2336.6 2361.1 2362.2 2354.8 2355.4 2400.6 2400.9 2403.1 7290.7 8444.2 8517.8 8525.2 8530.4 5152.9 5308.3 5321.7 5324.4 5324.4 2881.3 3163.9 3255.3 3439.9 3448.4 1159.2 1168.9 1181.2 1203.3 1212.9 10798.2 10879.5 10893.7 10910.5 10936.0 4487.5 4683.3 4752.2 4831.6 4838.6 9562.0 9565.6 9566.2 9568.6 9598.5 5345.7 5350.1 5359.7 5367.4 5371.5 4259.7 4317.3 4893.6 4899.9 4924.9 3898.6 3931.5 3989.2 4013.2 4018.5 1293.7 1295.4 1297.1 1303.7 1309.6 791.6 802.6 818.1 819.7 827.3 5464.8 5510.3 5517.4 5586.6 5615.4 562.5 581.5 587.6 596.9 599.5 3634.5 3680.6 3775.0 3791.8 3798.6 9698.8 10134.2 10161.6 10167.4 10167.9 9743.4 9794.5 10043.7 10060.9 10115.2 7665.0 7829.6 7904.0 7912.2 7915.4 5433.9 5475.9 5574.7 5635.4 5644.5 9216.4 9229.9 9249.0 9270.9 9276.2 9208.4 9317.2 9350.5 9543.6 9568.9 7201.9 7285.1 7334.2 7356.5 7375.5 7897.1 7938.9 7972.1 7977.0 7984.4 5955.5 6955.5 6977.0 7033.5 7068.9 6856.6 6879.2 6893.1 7020.9 7021.8 6302.8 6474.0 6477.1 6486.6 6490.2 5001.8 5042.2 5061.2 5081.0 5095.1 4929.9 5000.8 5049.8 5113.3 5203.0 14:40:58 INFO - PROCESS | 1637 | 14:40:58 INFO - PROCESS | 1637 | [#4] prototype.html Cycles:180 Average:4282.08 Median:4754.23 stddev:1259.03 (26.5%) stddev-sans-first:1227.72 14:40:58 INFO - PROCESS | 1637 | Values: 363.2 366.2 378.3 380.1 383.6 4975.2 5168.3 5194.8 5241.4 5283.9 4312.6 4410.4 4994.4 5080.0 5085.7 3183.4 3990.8 4039.7 4049.3 4150.7 3900.6 3935.2 4062.3 4110.1 4151.5 3296.6 3442.7 3989.4 4085.5 4122.1 3398.1 4083.2 4114.2 4116.5 4116.6 3181.6 3456.7 3649.3 3666.2 3679.8 4801.4 5019.3 5095.9 5120.6 5139.2 4067.7 4134.2 4634.9 4654.6 4743.8 4756.1 4760.9 5262.8 5464.3 5504.4 3390.9 3811.6 4020.6 4036.5 4043.4 4772.7 5629.6 5659.6 5706.7 5739.2 3458.4 4086.7 4093.0 4096.5 4119.0 3551.7 3619.6 4148.6 4150.7 4159.6 3916.4 4474.0 4482.8 4514.7 4575.7 4814.2 5483.4 5501.3 5542.1 5545.3 1176.8 1206.7 1249.3 1250.4 1261.6 719.1 868.8 871.8 878.6 886.3 4231.8 4707.7 4870.0 4901.0 4983.4 4530.8 4612.6 5102.0 5230.4 5374.8 4056.9 4148.9 4753.5 4807.0 4862.4 2611.9 2797.9 2803.4 2829.0 2872.8 4791.9 5007.0 5084.5 5260.7 5378.7 4370.8 5011.3 5415.5 5416.9 5478.3 4774.6 4826.4 5343.0 5452.0 5465.8 4452.7 4543.0 4618.9 4644.8 4851.5 4527.7 4784.7 4800.0 5178.3 5269.2 4814.0 4973.4 5187.0 5434.3 5436.6 3109.9 3163.9 3269.8 3630.6 3647.8 4525.8 4979.7 5265.6 5338.9 5365.9 4208.0 4569.0 4769.1 5160.6 5170.0 4529.9 4755.0 4903.9 5030.6 5131.5 5102.8 5239.9 5284.3 5291.9 5312.6 4738.5 4776.9 5418.7 5450.9 5519.5 4723.4 5286.7 5365.4 5371.5 5420.4 14:40:58 INFO - PROCESS | 1637 | 14:40:58 INFO - PROCESS | 1637 | [#5] yui.html Cycles:180 Average:21080.09 Median:3567.86 stddev:30373.77 (851.3%) stddev-sans-first:30420.61 14:40:58 INFO - PROCESS | 1637 | Values: 747.9 773.6 802.7 867.1 879.4 12566.1 12713.7 14931.2 15099.1 15575.8 14123.5 14385.9 14415.5 14539.4 14563.3 885.7 892.1 892.3 892.4 892.6 617.2 710.0 875.3 881.1 907.1 937.3 941.4 941.5 941.8 943.9 932.6 934.9 934.9 934.9 935.3 697.8 698.5 699.9 700.4 700.5 15449.8 15515.4 15553.1 15579.5 15592.5 14578.9 14706.7 14995.1 15117.9 15142.5 11478.8 11491.4 11720.1 11852.9 11867.8 3676.4 3858.2 3903.6 3915.4 4047.6 97423.5 98750.0 100743.5 101689.5 101929.5 11339.4 11369.3 11885.3 11922.6 12181.6 23553.4 23773.5 23993.5 24002.3 24024.2 8046.2 8082.6 8085.0 8203.6 8338.5 4439.0 4453.6 4464.7 4549.0 4558.2 3469.2 3532.0 3553.3 3566.5 3569.2 668.4 669.4 675.9 688.2 688.6 696.8 697.8 710.5 720.3 765.0 10008.0 10607.7 10625.9 10652.3 10853.4 679.7 710.4 715.4 724.6 728.9 5111.2 5160.4 5210.6 5242.6 5260.2 105179.5 107720.9 108899.5 109110.0 109912.0 98250.0 99774.5 99885.0 100345.0 101118.5 84134.2 85781.0 87162.0 87180.1 88899.1 9975.6 10160.4 10162.3 10175.4 10214.6 41392.6 43725.5 51348.5 51577.1 52147.4 46276.8 63421.7 68702.7 68983.0 71682.9 13285.7 13528.5 13640.7 13817.0 14058.6 15006.7 15119.8 15321.5 15417.0 15652.5 13629.4 13750.2 14246.8 14438.7 14875.5 14045.4 14227.5 14250.0 14275.9 14426.6 13310.5 14003.6 14173.0 14173.6 14193.7 9683.0 9897.8 10106.5 10407.5 10477.4 11043.7 11058.6 11457.4 11485.7 11519.4 14:40:58 INFO - PROCESS | 1637 | -------- Summary: end -------- 14:40:58 INFO - PROCESS | 1637 | 14:40:59 INFO - TEST-INFO | 1637: exit 0 14:40:59 INFO - TEST-OK | dromaeo_css | took 1116602ms 14:40:59 INFO - TEST-START | kraken 14:40:59 INFO - operating with platform_type : mac_ 14:40:59 INFO - Initialising browser for kraken test... 14:40:59 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/tmpZKHMVf/profile http://localhost:49237/getInfo.html) 14:41:01 INFO - PROCESS | 1648 | __metrics Screen width/height:1600/1200 14:41:01 INFO - PROCESS | 1648 | colorDepth:24 14:41:01 INFO - PROCESS | 1648 | Browser inner width/height: 1024/689 14:41:01 INFO - PROCESS | 1648 | __metrics 14:41:01 INFO - PROCESS | 1648 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 14:41:01 INFO - PROCESS | 1648 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:41:02 INFO - TEST-INFO | 1648: exit 0 14:41:02 INFO - Browser initialized. 14:41:02 INFO - Running cycle 1/1 for kraken test... 14:41:02 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/tmpZKHMVf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:41:14 INFO - PROCESS | 1650 | RSS: Main: 163643392 14:41:14 INFO - PROCESS | 1650 | 14:41:17 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49237/tests/kraken/driver.html?testName=audio-beat-detection) 14:41:17 INFO - PROCESS | 1650 | RSS: Main: 213716992 14:41:17 INFO - PROCESS | 1650 | 14:41:20 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49237/tests/kraken/driver.html?testName=audio-dft) 14:41:21 INFO - PROCESS | 1650 | RSS: Main: 227696640 14:41:21 INFO - PROCESS | 1650 | 14:41:24 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49237/tests/kraken/driver.html?testName=audio-fft) 14:41:24 INFO - PROCESS | 1650 | RSS: Main: 324259840 14:41:24 INFO - PROCESS | 1650 | 14:41:26 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49237/tests/kraken/driver.html?testName=audio-oscillator) 14:41:27 INFO - PROCESS | 1650 | RSS: Main: 227749888 14:41:27 INFO - PROCESS | 1650 | 14:41:29 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49237/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:41:29 INFO - PROCESS | 1650 | RSS: Main: 229425152 14:41:29 INFO - PROCESS | 1650 | 14:41:32 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49237/tests/kraken/driver.html?testName=imaging-darkroom) 14:41:33 INFO - PROCESS | 1650 | RSS: Main: 269692928 14:41:33 INFO - PROCESS | 1650 | 14:41:36 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49237/tests/kraken/driver.html?testName=imaging-desaturate) 14:41:36 INFO - PROCESS | 1650 | RSS: Main: 268824576 14:41:36 INFO - PROCESS | 1650 | 14:41:39 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49237/tests/kraken/driver.html?testName=json-parse-financial) 14:41:40 INFO - PROCESS | 1650 | RSS: Main: 267870208 14:41:40 INFO - PROCESS | 1650 | 14:41:41 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49237/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:41:42 INFO - PROCESS | 1650 | RSS: Main: 244031488 14:41:42 INFO - PROCESS | 1650 | 14:41:44 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:41:44 INFO - PROCESS | 1650 | RSS: Main: 244428800 14:41:44 INFO - PROCESS | 1650 | 14:41:47 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:41:47 INFO - PROCESS | 1650 | RSS: Main: 251899904 14:41:47 INFO - PROCESS | 1650 | 14:41:50 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:41:51 INFO - PROCESS | 1650 | RSS: Main: 257421312 14:41:51 INFO - PROCESS | 1650 | 14:41:54 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:41:54 INFO - PROCESS | 1650 | RSS: Main: 258789376 14:41:54 INFO - PROCESS | 1650 | 14:41:56 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49237/tests/kraken/driver.html?testName=ai-astar) 14:41:56 INFO - PROCESS | 1650 | RSS: Main: 303206400 14:41:56 INFO - PROCESS | 1650 | 14:41:56 INFO - PROCESS | 1650 | __start_tp_report 14:41:56 INFO - PROCESS | 1650 | _x_x_mozilla_page_load 14:41:56 INFO - PROCESS | 1650 | _x_x_mozilla_page_load_details 14:41:56 INFO - PROCESS | 1650 | |i|pagename|runs| 14:41:56 INFO - PROCESS | 1650 | |0;ai-astar;105;113;114;117;112;113;113;113;113;113 14:41:56 INFO - PROCESS | 1650 | |1;audio-beat-detection;141;110;131;173;139;107;106;106;126;107 14:41:56 INFO - PROCESS | 1650 | |2;audio-dft;183;182;180;183;181;182;182;184;184;180 14:41:56 INFO - PROCESS | 1650 | |3;audio-fft;81;58;57;87;61;58;57;58;73;58 14:41:56 INFO - PROCESS | 1650 | |4;audio-oscillator;85;69;85;68;67;68;80;67;68;81 14:41:56 INFO - PROCESS | 1650 | |5;imaging-gaussian-blur;89;87;88;87;88;86;89;87;89;84 14:41:56 INFO - PROCESS | 1650 | |6;imaging-darkroom;94;94;95;96;100;144;109;97;94;94 14:41:56 INFO - PROCESS | 1650 | |7;imaging-desaturate;87;85;84;87;86;84;85;87;85;86 14:41:56 INFO - PROCESS | 1650 | |8;json-parse-financial;54;53;52;52;56;55;56;57;55;54 14:41:56 INFO - PROCESS | 1650 | |9;json-stringify-tinderbox;63;72;64;74;71;66;68;67;68;69 14:41:56 INFO - PROCESS | 1650 | |10;stanford-crypto-aes;82;90;82;84;83;83;84;86;88;106 14:41:56 INFO - PROCESS | 1650 | |11;stanford-crypto-ccm;130;135;148;144;124;133;132;134;147;139 14:41:56 INFO - PROCESS | 1650 | |12;stanford-crypto-pbkdf2;161;162;163;162;162;162;177;226;220;164 14:41:56 INFO - PROCESS | 1650 | |13;stanford-crypto-sha256-iterative;57;72;65;62;64;79;58;57;55;71 14:41:56 INFO - PROCESS | 1650 | __end_tp_report 14:41:56 INFO - PROCESS | 1650 | __start_cc_report 14:41:56 INFO - PROCESS | 1650 | _x_x_mozilla_cycle_collect,1926 14:41:56 INFO - PROCESS | 1650 | __end_cc_report 14:41:56 INFO - PROCESS | 1650 | __startTimestamp1490823716821__endTimestamp 14:41:56 INFO - PROCESS | 1650 | 14:41:56 INFO - PROCESS | 1650 | ------- Summary: start ------- 14:41:56 INFO - PROCESS | 1650 | Number of tests: 14 14:41:56 INFO - PROCESS | 1650 | 14:41:56 INFO - PROCESS | 1650 | [#0] ai-astar Cycles:10 Average:112.60 Median:113.00 stddev:2.99 (2.6%) stddev-sans-first:1.42 14:41:56 INFO - PROCESS | 1650 | Values: 105.0 113.0 114.0 117.0 112.0 113.0 113.0 113.0 113.0 113.0 14:41:56 INFO - PROCESS | 1650 | 14:41:56 INFO - PROCESS | 1650 | [#1] audio-beat-detection Cycles:10 Average:124.60 Median:128.50 stddev:22.08 (17.2%) stddev-sans-first:22.60 14:41:56 INFO - PROCESS | 1650 | Values: 141.0 110.0 131.0 173.0 139.0 107.0 106.0 106.0 126.0 107.0 14:41:56 INFO - PROCESS | 1650 | 14:41:56 INFO - PROCESS | 1650 | [#2] audio-dft Cycles:10 Average:182.10 Median:182.50 stddev:1.45 (0.8%) stddev-sans-first:1.50 14:41:56 INFO - PROCESS | 1650 | Values: 183.0 182.0 180.0 183.0 181.0 182.0 182.0 184.0 184.0 180.0 14:41:56 INFO - PROCESS | 1650 | 14:41:56 INFO - PROCESS | 1650 | [#3] audio-fft Cycles:10 Average:64.80 Median:59.50 stddev:11.27 (18.9%) stddev-sans-first:10.32 14:41:56 INFO - PROCESS | 1650 | Values: 81.0 58.0 57.0 87.0 61.0 58.0 57.0 58.0 73.0 58.0 14:41:56 INFO - PROCESS | 1650 | 14:41:56 INFO - PROCESS | 1650 | [#4] audio-oscillator Cycles:10 Average:73.80 Median:74.50 stddev:7.87 (10.6%) stddev-sans-first:7.23 14:41:56 INFO - PROCESS | 1650 | Values: 85.0 69.0 85.0 68.0 67.0 68.0 80.0 67.0 68.0 81.0 14:41:56 INFO - PROCESS | 1650 | 14:41:56 INFO - PROCESS | 1650 | [#5] imaging-gaussian-blur Cycles:10 Average:87.40 Median:88.00 stddev:1.58 (1.8%) stddev-sans-first:1.56 14:41:56 INFO - PROCESS | 1650 | Values: 89.0 87.0 88.0 87.0 88.0 86.0 89.0 87.0 89.0 84.0 14:41:56 INFO - PROCESS | 1650 | 14:41:56 INFO - PROCESS | 1650 | [#6] imaging-darkroom Cycles:10 Average:101.70 Median:94.00 stddev:15.57 (16.6%) stddev-sans-first:16.26 14:41:56 INFO - PROCESS | 1650 | Values: 94.0 94.0 95.0 96.0 100.0 144.0 109.0 97.0 94.0 94.0 14:41:56 INFO - PROCESS | 1650 | 14:41:56 INFO - PROCESS | 1650 | [#7] imaging-desaturate Cycles:10 Average:85.60 Median:86.00 stddev:1.17 (1.4%) stddev-sans-first:1.13 14:41:56 INFO - PROCESS | 1650 | Values: 87.0 85.0 84.0 87.0 86.0 84.0 85.0 87.0 85.0 86.0 14:41:56 INFO - PROCESS | 1650 | 14:41:56 INFO - PROCESS | 1650 | [#8] json-parse-financial Cycles:10 Average:54.40 Median:55.00 stddev:1.71 (3.1%) stddev-sans-first:1.81 14:41:56 INFO - PROCESS | 1650 | Values: 54.0 53.0 52.0 52.0 56.0 55.0 56.0 57.0 55.0 54.0 14:41:56 INFO - PROCESS | 1650 | 14:41:56 INFO - PROCESS | 1650 | [#9] json-stringify-tinderbox Cycles:10 Average:68.20 Median:68.50 stddev:3.46 (5.0%) stddev-sans-first:3.11 14:41:56 INFO - PROCESS | 1650 | Values: 63.0 72.0 64.0 74.0 71.0 66.0 68.0 67.0 68.0 69.0 14:41:56 INFO - PROCESS | 1650 | 14:41:56 INFO - PROCESS | 1650 | [#10] stanford-crypto-aes Cycles:10 Average:86.80 Median:84.00 stddev:7.24 (8.6%) stddev-sans-first:7.47 14:41:56 INFO - PROCESS | 1650 | Values: 82.0 90.0 82.0 84.0 83.0 83.0 84.0 86.0 88.0 106.0 14:41:56 INFO - PROCESS | 1650 | 14:41:56 INFO - PROCESS | 1650 | [#11] stanford-crypto-ccm Cycles:10 Average:136.60 Median:137.00 stddev:7.78 (5.7%) stddev-sans-first:7.87 14:41:56 INFO - PROCESS | 1650 | Values: 130.0 135.0 148.0 144.0 124.0 133.0 132.0 134.0 147.0 139.0 14:41:56 INFO - PROCESS | 1650 | 14:41:56 INFO - PROCESS | 1650 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.90 Median:163.50 stddev:25.30 (15.5%) stddev-sans-first:26.25 14:41:56 INFO - PROCESS | 1650 | Values: 161.0 162.0 163.0 162.0 162.0 162.0 177.0 226.0 220.0 164.0 14:41:56 INFO - PROCESS | 1650 | 14:41:56 INFO - PROCESS | 1650 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.00 Median:64.50 stddev:7.87 (12.2%) stddev-sans-first:7.93 14:41:56 INFO - PROCESS | 1650 | Values: 57.0 72.0 65.0 62.0 64.0 79.0 58.0 57.0 55.0 71.0 14:41:56 INFO - PROCESS | 1650 | -------- Summary: end -------- 14:41:56 INFO - PROCESS | 1650 | 14:41:57 INFO - TEST-INFO | 1650: exit 0 14:41:57 INFO - TEST-OK | kraken | took 58339ms 14:41:57 INFO - SUITE-END | took 1174s 14:41:57 INFO - Completed test suite (00:19:35) 14:41:57 INFO - javascript benchmark 14:41:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2867.1685211288727, 3375.5105509701093, 3378.138574663462, 3406.773561517853, 3428.7599868009247, 5761.510271626911, 5786.508146807527, 5840.445157710016, 5844.064949608063, 5853.239078919734, 5707.571932105088, 5753.597248192628, 5848.970755146229, 5848.976429124897, 5851.385604511529, 5128.256402821598, 5295.496927791873, 5303.7082960437165, 5316.867078323035, 5354.705491197982, 3695.722820788438, 5198.324217851674, 5228.712420816853, 5348.224507446418, 5377.946220537803, 5252.133397989346, 5258.8685282867855, 5265.3681558212875, 5283.656562323436, 5289.365276166865, 5277.419483856773, 5284.762185701653, 5294.867628309304, 5299.284596579451, 5306.893862122774, 5154.664946778447, 5226.5818734501145, 5309.65487243328, 5314.0, 5332.626716129873, 5972.372900845392, 5976.312724036748, 6002.6398416094735, 6009.549283803733, 6024.969875150597, 6156.476699480505, 6214.036824292242, 6355.968220158869, 6372.426481616677, 6387.776427825051, 6263.71813268404, 6308.684565771693, 6329.493640508748, 6335.081413195107, 6347.619142851444, 5805.970970145165, 5881.117832325142, 5941.287045554518, 5988.401159883977, 6006.759729610854, 6307.053941908659, 6308.369163083655, 6315.273743519462, 6315.273743519554, 6328.810135695937, 6275.215598050244, 6285.59143655661, 6288.213973253343, 6306.306306306303, 6313.147725057151, 6245.843853903598, 6279.717412716347, 6292.779752708633, 6296.590721603081, 6350.587211831216, 6309.08518264849, 6334.556581039283, 6358.427741503287, 6372.490200783926, 6375.075614035939, 6350.968245158745, 6354.078658594478, 6371.96814015927, 6375.71309291083, 6408.9745640697265, 4971.527704868032, 5025.623078269071, 5025.874353141127, 5040.722760248148, 5083.567896728746, 4471.776411179493, 4483.148201841705, 4500.189965806121, 4533.093381323749, 4547.8635640930825, 5746.827595172152, 5751.424857514299, 5760.36635970043, 5765.0, 5801.6519008859605, 6207.379262073757, 6290.150829638032, 6317.084022816758, 6330.8100756977365, 6347.619142851444, 5592.832215033555, 5606.271184746039, 5698.0, 5713.200151978726, 5830.7959221427045, 5522.088855338824, 5526.47498487643, 5534.05920993424, 5541.113421852484, 5543.390227075019, 6249.6875156242, 6262.029385445263, 6264.68676566179, 6269.059641053878, 6270.059491076375, 6034.788782392595, 6053.727582258721, 6115.113308570321, 6274.529410294337, 6275.184226050585, 6264.123022776724, 6279.811605651837, 6289.528285378524, 6292.433680968735, 6293.811185664437, 6297.275813281532, 6304.71628776697, 6313.589616674902, 6320.462760665395, 6330.145430367026, 6257.249130104235, 6260.843478913063, 6275.058741188675, 6299.748010079546, 6317.399847014526, 6171.1360409543595, 6171.321154673072, 6191.84520386994, 6294.370562943669, 6301.243850737941, 6008.54935879802, 6247.0629405589525, 6250.812475625738, 6261.24865016201, 6263.96868015657, 5844.6785426801935, 5936.673482958478, 6034.547408944259, 6133.080037994337, 6147.784827531015, 6044.90932636002, 6134.467201660849, 6141.662208578571, 6149.84625384369, 6228.813135605939, 6094.481969032682, 6102.780000695884, 6129.84675383119, 6130.5402094842175, 6134.577161634294], "value": 5772.2326083767275, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [471.75233002673593, 494.97772600232975, 546.1289243656369, 547.4033303698967, 557.6458948567658, 32347.353052938957, 41483.0, 43432.13135737283, 43479.47821826237, 45329.0, 37920.81039594805, 44015.55984440155, 45110.323345149845, 45114.32328515075, 45365.0, 9105.544722763836, 9580.473073980927, 9796.510174491246, 9804.264680148981, 9818.705438836847, 9157.2216361609, 12057.939710301436, 12265.386730663477, 12281.815772763372, 12408.627741167735, 12118.757624847498, 12214.511419543252, 12215.206011609262, 12216.511339546452, 12218.32799196044, 12141.817872731915, 12203.511859525608, 12209.93895030528, 12217.93891030539, 12225.0, 12004.339761313124, 12075.154739168262, 12080.758384832254, 12082.033437324993, 12086.153969222158, 41839.0, 42085.78957105226, 42088.57911420908, 42162.78918605418, 42253.0, 4018.959810401888, 4099.913522916429, 4114.670826333886, 4115.938260926088, 4124.298869192215, 30601.540976885364, 30887.536686949712, 32808.85169019097, 33096.67613295465, 33302.0, 3272.6072871255365, 3302.3230237801195, 3401.795892246473, 3493.0, 3537.964620353789, 435629.0, 436477.0, 436892.0, 440835.0, 441872.0, 65279.673601631686, 65544.67227663832, 65653.671731642, 65696.67151664307, 65745.0, 67655.66172169108, 68540.3145968544, 68614.65692671605, 68626.0, 68629.65685171542, 17333.0, 17900.194491247927, 17915.73126403105, 17931.0, 17940.83384579998, 12356.814647780291, 12651.0, 13551.254680992442, 13563.728725425437, 13577.389017494237, 21892.343229703136, 22814.31557053291, 22846.086156553883, 23327.066917323456, 23404.7659523406, 7498.925010749932, 8854.335924805537, 9109.362344635812, 9112.81774364509, 9143.177114059767, 890.6838072484304, 911.9270458363314, 919.6643225222746, 949.2738055387634, 959.5681943125621, 30723.846380767955, 31139.37721245608, 31441.899533516218, 31797.36405271928, 31938.041858744276, 982.1259079419323, 989.4261328429494, 1009.7071849163807, 1016.0601443664729, 1075.596651255779, 15589.610259743597, 15978.041317520985, 16046.679066418606, 16071.517854464384, 16462.341506339853, 691072.0, 694842.0, 695113.048869515, 696855.0, 698491.0, 63270.68364658147, 63777.0, 63920.680396597716, 64055.6797216011, 64061.679691601246, 1270.6632742323293, 1313.507434711983, 1410.5133728863525, 1493.5668656089613, 1522.9923850380678, 26788.866055670376, 28847.42305153927, 29720.05305727672, 32349.838250808596, 32420.513692294164, 52629.473705262455, 53224.0, 53358.46641533535, 53516.0, 53523.0, 533806.0, 535611.0, 536009.0, 539188.0, 540485.0, 37250.25499490049, 38018.0, 44224.7887605612, 44644.88387790331, 44837.551624483334, 49535.752321238164, 49557.0, 50641.73395665138, 50746.2388064172, 51070.74464627653, 26573.60139597869, 31092.844535777178, 33449.0, 33856.15359616029, 34954.0, 33471.665283346854, 33484.49773253354, 33559.83220083884, 33740.0, 34090.82954585211, 37200.883973480835, 37571.81214093912, 37596.436053458674, 39579.80210098931, 39846.60153398545, 30388.936387226342, 31261.8436907814, 31682.049538513882, 31701.524477133324, 32457.837710811295, 24599.877000615597, 25197.496050079262, 25432.618510722725, 25561.488770224863, 25921.945220681788], "value": 21216.234433265654, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [313.2888343460345, 374.2048147686167, 393.8188433320672, 403.9636432721056, 418.0, 17257.137143142856, 17483.737743933852, 19749.50626234345, 22875.0, 23082.88458557707, 21980.78019219807, 22634.20780272691, 23166.0, 23339.066437342528, 23362.532749345002, 5879.617824841383, 6192.504599632019, 6202.4417802397775, 6202.9379706203035, 6205.131281620576, 6051.062085376773, 6069.696515174246, 6127.540434467411, 6186.412290832363, 6204.193454850863, 6155.846103847395, 6165.7533698652, 6169.537284703642, 6176.87646247077, 6177.969110154443, 4931.3835770528685, 6071.332153463138, 6125.234345706786, 6136.048912418582, 6136.509079273647, 4998.57512111471, 5014.047331007097, 5337.946620533823, 5370.758315875795, 5376.596755243372, 13733.931330343285, 14118.0, 14127.364268607835, 14135.010549261557, 19006.809931900643, 2373.311739595515, 2930.1209637108996, 3001.0846691759007, 3047.832369219692, 3052.786304958654, 10157.644482443078, 10333.534990925351, 10366.429846358447, 10377.429241391721, 10557.788844223072, 1824.5894673698444, 1846.6860633692304, 1853.7497437845852, 1861.3299212283566, 1872.0826794870552, 133915.0, 137147.31426342804, 140325.2983735085, 141078.0, 142862.0, 11776.293422394683, 11923.224990375598, 11924.34416107105, 11970.281783093042, 12136.271823690608, 14321.856781432261, 15001.099934003994, 16114.113723745306, 16116.194190290438, 16137.515874523782, 8436.28291595209, 8756.4308319959, 8858.689945851864, 9175.541222938826, 9267.0, 8758.343124265706, 9045.59294831721, 9049.683261085962, 9055.230305424113, 9241.861372079424, 3998.820053097618, 4173.706151093171, 4361.367601697736, 4647.16351056813, 4834.597966589649, 1859.9535011624819, 1926.1428664244556, 2043.867148635334, 2055.4553043443498, 2056.794320567931, 1008.9041541053588, 1037.8495118207818, 1054.5289321396608, 1058.1270451877078, 1069.6988005506919, 18600.7909485883, 21938.793366365004, 22062.88968555147, 22188.778112218995, 22398.880055997462, 929.6002718830968, 975.531744762518, 982.3663736889808, 1034.8447732840134, 1092.6721983404946, 10918.071963883, 11559.653210403701, 11562.07503399726, 11595.826062609067, 11595.942020289845, 650212.0, 728667.0, 758844.0, 779276.0, 788963.0, 130769.34615327053, 150036.24981875022, 153247.0, 157286.21356893142, 159018.0, 1060.920430967665, 1066.7866426714688, 1083.2146693647044, 1088.0751361342955, 1091.514276147107, 18783.906080470057, 18998.240070397584, 19377.709334359715, 19396.0, 19459.805401946367, 56082.439175609354, 58317.4168258312, 58804.529886753175, 59016.0, 60044.39733615997, 70710.93933591103, 86834.56582717046, 87159.0, 87814.80462988222, 87855.56072219598, 8345.707900223462, 8456.83086338282, 8657.696980605648, 8970.41692289999, 8999.910000899907, 11307.265027773168, 13114.60656180316, 13254.0, 13540.79688804649, 13891.305434728021, 11244.718882027688, 11788.29270243788, 12058.577949771716, 12143.75712485763, 12256.632301030982, 8664.83024791645, 10754.89245107539, 11038.448077595927, 11350.375729334966, 11385.715357116138, 11638.88361116378, 11800.409979501163, 12119.272843629411, 12248.265104093784, 12279.140460167702, 8460.873086903579, 8606.44058136219, 8675.82648347017, 8924.464532128093, 8927.910720892707, 10005.0, 11754.647360579196, 11827.645170644895, 11874.228175168586, 12124.454399552218], "value": 9986.252580620752, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1474.6903150338428, 1478.0762023735165, 1500.2198856594564, 1507.2463768115942, 1512.4177191781162, 8171.0603280622745, 8562.357823163256, 8564.91435085649, 8566.357523185763, 8589.312854971602, 7568.0, 7776.53340799551, 8117.512949223036, 8356.749297521068, 8383.455075420094, 2338.2634470141893, 2379.4884099918513, 2386.8567885926814, 2390.008146619151, 2396.928092157238, 2366.408397900525, 2394.353524548371, 2397.1729753235104, 2402.5675378431874, 2405.1581946318825, 2281.977180228193, 2284.189112864934, 2307.365474494519, 2309.2033248529315, 2309.399556115405, 2317.7566355532595, 2335.637976113697, 2336.6027775278076, 2361.0791791201445, 2362.185046159081, 2354.776296251853, 2355.4464700795297, 2400.567897778399, 2400.8559486430872, 2403.110848985869, 7290.651229522556, 8444.155584441569, 8517.82964340716, 8525.232729054353, 8530.360222983301, 5152.948470515322, 5308.309919710451, 5321.707306098163, 5324.361076670824, 5324.440933701983, 2881.3084859633536, 3163.9209019774457, 3255.283837555734, 3439.8820383375255, 3448.4310088835314, 1159.2406973432414, 1168.9006434452997, 1181.1967861853936, 1203.3441774233063, 1212.89083982442, 10798.2441229114, 10879.510422031028, 10893.727656808564, 10910.454477276104, 10936.015758581765, 4487.506374298824, 4683.320918466803, 4752.239641657387, 4831.613470922318, 4838.588719958772, 9562.0, 9565.569549370295, 9566.234701223886, 9568.56941437637, 9598.520073996273, 5345.70598617072, 5350.117230656976, 5359.651622644516, 5367.382750983609, 5371.4897084776885, 4259.7231179973205, 4317.330813723878, 4893.559579637849, 4899.902001959941, 4924.926126108111, 3898.590647981978, 3931.4889064422014, 3989.162275922089, 4013.177298653769, 4018.4976877890263, 1293.734784369202, 1295.430010795247, 1297.1049975516862, 1303.687115092371, 1309.607117864656, 791.6239786101555, 802.6388125343618, 818.0878320672407, 819.6680344460503, 827.2554700769356, 5464.808731694372, 5510.256115424447, 5517.393086760453, 5586.608937374426, 5615.354234263031, 562.4993755557557, 581.5405829394731, 587.574008843585, 596.9104634304889, 599.5173885022512, 3634.473001414833, 3680.6319368063514, 3775.0, 3791.810409479515, 3798.6201379862346, 9698.75753106178, 10134.23993200513, 10161.593536258466, 10167.440790756431, 10167.949160254298, 9743.415395076176, 9794.510274486389, 10043.69868903934, 10060.899391006142, 10115.190784737204, 7665.0, 7829.64766585505, 7903.972483577213, 7912.248336408032, 7915.406344524184, 5433.945660543344, 5475.863103422446, 5574.749136288796, 5635.380108188178, 5644.548436125018, 9216.447013179231, 9229.907700922904, 9249.028851970446, 9270.907290927003, 9276.211522020434, 9208.355415120877, 9317.16145546904, 9350.485723285285, 9543.570539325608, 9568.904310956801, 7201.891971620535, 7285.089363829521, 7334.156571994075, 7356.48504604694, 7375.520591161558, 7897.131315555399, 7938.880916786368, 7972.123066462568, 7977.0, 7984.361251100015, 5955.464008239106, 6955.547889387173, 6977.0, 7033.542819716702, 7068.893966590608, 6856.588604683735, 6879.174499060145, 6893.138357705287, 7020.894686579603, 7021.754238601625, 6302.842428939313, 6474.0, 6477.125588045742, 6486.578372405778, 6490.221173459215, 5001.824936127218, 5042.168042272984, 5061.240813877947, 5081.0, 5095.0574143783515, 4929.926051109164, 5000.799968001239, 5049.823256186016, 5113.309703190171, 5203.037438073969], "value": 4389.4165733119735, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [363.2462640021955, 366.1687968311932, 378.2774899941112, 380.12381460733, 383.631713554987, 4975.154223781957, 5168.302279192308, 5194.792208311667, 5241.423443421226, 5283.920741188876, 4312.5903039211225, 4410.404595379631, 4994.350734404531, 5080.0, 5085.720285384303, 3183.3951549205576, 3990.8204130814183, 4039.6970227233, 4049.2711311963835, 4150.730202536841, 3900.5904380040115, 3935.2129574085156, 4062.329715596923, 4110.054687421894, 4151.543330233671, 3296.6373698893103, 3442.6901578857896, 3989.4241774499055, 4085.5097388313443, 4122.051928056549, 3398.09950363154, 4083.203775263825, 4114.19773144237, 4116.464859568267, 4116.58834116589, 3181.5704879841387, 3456.6864591455337, 3649.3431182387158, 3666.2319948439026, 3679.7792132472136, 4801.391533836169, 5019.297298378194, 5095.898082038376, 5120.564751996085, 5139.203423469368, 4067.715259931806, 4134.214499245134, 4634.907301853944, 4654.627629789608, 4743.83396581118, 4756.127395912908, 4760.880977975578, 5262.842114736564, 5464.289642346509, 5504.366997795265, 3390.9491357629654, 3811.5774919260857, 4020.557738648746, 4036.455078564415, 4043.3934909763475, 4772.73749943753, 5629.60592758507, 5659.60382773206, 5706.657600543981, 5739.225204597367, 3458.4120699480645, 4086.713930024929, 4092.979535102365, 4096.528899176573, 4118.990847242445, 3551.685876225813, 3619.583747868976, 4148.6352778915725, 4150.654879992794, 4159.563245859202, 3916.4321173429694, 4473.9933514958875, 4482.843100491467, 4514.6614003949835, 4575.702579332333, 4814.20565606671, 5483.369412517612, 5501.284832971688, 5542.057850165482, 5545.251391062236, 1176.7940610393148, 1206.6907405464992, 1249.3191210790142, 1250.3810613746073, 1261.5933234443712, 719.0544434069183, 868.8088620503479, 871.7733389318822, 878.6090189865577, 886.2998231397124, 4231.788410579458, 4707.670463067552, 4870.003298647608, 4900.950990490121, 4983.352164218701, 4530.818767249339, 4612.5654711677025, 5101.974490127525, 5230.3985041719925, 5374.828850977942, 4056.9451942495166, 4148.854790082332, 4753.480655252722, 4807.0, 4862.416510018749, 2611.9477610447684, 2797.9160625181275, 2803.444088530844, 2828.9717102829118, 2872.7989040766947, 4791.880202994953, 5006.973570418056, 5084.542391184811, 5260.710660913686, 5378.650387724785, 4370.781460927004, 5011.298418221452, 5415.539679127318, 5416.945830541723, 5478.260434841325, 4774.641901857305, 4826.420829500342, 5342.999999999923, 5451.972740136274, 5465.836024919259, 4452.666050046195, 4543.0, 4618.907621847611, 4644.8142074318, 4851.490593487633, 4527.713504680116, 4784.712917224978, 4800.039992001543, 5178.275041494118, 5269.235960785588, 4814.037192561432, 4973.428055773632, 5187.0, 5434.3207099112615, 5436.565074793928, 3109.9222519437194, 3163.8576264068633, 3269.7711160218555, 3630.623520126308, 3647.8081678531285, 4525.773711314355, 4979.726115063706, 5265.578753699771, 5338.893222135458, 5365.865853353697, 4207.957920420879, 4569.0, 4769.093872164278, 5160.638755287094, 5169.974150129226, 4529.8641040768825, 4754.980587327142, 4903.877403064952, 5030.572401345927, 5131.461196574455, 5102.79588816458, 5239.947600523946, 5284.260203571426, 5291.867703307448, 5312.601554883322, 4738.455077665974, 4776.880577985439, 5418.674879507243, 5450.945490545044, 5519.475649813261, 4723.409573803275, 5286.735663216747, 5365.38298095724, 5371.462853714754, 5420.4037555868035], "value": 3901.744526641833, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [747.9289467500586, 773.6441237030969, 802.6588699802586, 867.1458613265931, 879.4239772948716, 12566.057545684065, 12713.682157946056, 14931.178785166812, 15099.094054356732, 15575.766363504557, 14123.505677301297, 14385.856141438582, 14415.477291473977, 14539.418423263083, 14563.344649490771, 885.7431344909985, 892.13908578222, 892.2505095719595, 892.3931726426027, 892.5715656484891, 617.1883972576071, 709.9609521476317, 875.3303722652176, 881.1144799476517, 907.0747837206046, 937.2548823685187, 941.4492521874678, 941.5433514745343, 941.7786820097272, 943.8914524829664, 932.5710173320281, 934.8597710343469, 934.8691183234353, 934.9252059835197, 935.3172184305461, 697.7836870570139, 698.5145323999823, 699.9335063168991, 700.4291502425558, 700.5061431690646, 15449.828108597514, 15515.379384824593, 15553.066815991077, 15579.532614021597, 15592.532224033297, 14578.927105364512, 14706.70586588273, 14995.100293982396, 15117.924410377987, 15142.54572362831, 11478.770424591545, 11491.367974761384, 11720.120990925714, 11852.881471185265, 11867.762644747057, 3676.37527545394, 3858.189780146173, 3903.6486716195395, 3915.393114067324, 4047.5750046245307, 97423.51288243514, 98750.0, 100743.49628251886, 101689.4915525425, 101929.49035254776, 11339.433028348549, 11369.2609980351, 11885.28688278706, 11922.642320730392, 12181.573644922386, 23553.41116472102, 23773.524529509312, 23993.52012959731, 24002.27993160208, 24024.15915442951, 8046.195380462024, 8082.595870206584, 8084.959575202086, 8203.630836612367, 8338.541380224025, 4439.0, 4453.55464453552, 4464.665150113689, 4549.0, 4558.1795276849825, 3469.2367679110557, 3532.0, 3553.289342131584, 3566.4828599852876, 3569.232614987738, 668.4284936379325, 669.3908543225641, 675.9053732477457, 688.2188715807595, 688.5662032919229, 696.7735485967081, 697.7732237022988, 710.531049507333, 720.2725247500063, 764.9800299426478, 10008.0, 10607.705099226261, 10625.9468702656, 10652.254342195973, 10853.403062831461, 679.7247114918367, 710.3961632612342, 715.377621469325, 724.5652608434897, 728.8870225115115, 5111.233315002705, 5160.354955630546, 5210.557102646242, 5242.633015688865, 5260.184671375943, 105179.474102629, 107720.92279077266, 108899.45550272198, 109110.0, 109912.0, 98250.0, 99774.5011274939, 99885.00114998902, 100345.0, 101118.48322275172, 84134.15865841263, 85781.0, 87162.0, 87180.1281987172, 88899.11100889038, 9975.60097596088, 10160.390376577428, 10162.339447935861, 10175.389476631426, 10214.591416343263, 41392.586074140076, 43725.469608563544, 51348.48651513437, 51577.10017548327, 52147.43557693275, 46276.7686161567, 63421.682891585246, 68702.65648671724, 68983.0, 71682.92475612974, 13285.734285314433, 13528.526501572398, 13640.65898352549, 13816.96372772026, 14058.578242652737, 15006.6998660024, 15119.848801511844, 15321.540353788958, 15417.0, 15652.4521641742, 13629.38667759973, 13750.243736594583, 14246.786298205328, 14438.711225775636, 14875.47935822241, 14045.36795844169, 14227.50203742864, 14250.0, 14275.928620356832, 14426.639334016314, 13310.46758129664, 14003.649908752363, 14173.0, 14173.574792756233, 14193.716125677221, 9682.951585242028, 9897.802043958936, 10106.49467526606, 10407.531661075422, 10477.42374169428, 11043.668689939315, 11058.612948546763, 11457.427128643702, 11485.712857178638, 11519.42402879836], "value": 7752.379132164639, "unit": "score"}], "name": "dromaeo_css", "value": 7386.31791933907, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 113.0, 114.0, 117.0, 112.0, 113.0, 113.0, 113.0, 113.0, 113.0], "value": 112.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 110.0, 131.0, 173.0, 139.0, 107.0, 106.0, 106.0, 126.0, 107.0], "value": 124.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 182.0, 180.0, 183.0, 181.0, 182.0, 182.0, 184.0, 184.0, 180.0], "value": 182.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 58.0, 57.0, 87.0, 61.0, 58.0, 57.0, 58.0, 73.0, 58.0], "value": 64.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 69.0, 85.0, 68.0, 67.0, 68.0, 80.0, 67.0, 68.0, 81.0], "value": 73.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 87.0, 88.0, 87.0, 88.0, 86.0, 89.0, 87.0, 89.0, 84.0], "value": 87.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 96.0, 100.0, 144.0, 109.0, 97.0, 94.0, 94.0], "value": 101.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 84.0, 87.0, 86.0, 84.0, 85.0, 87.0, 85.0, 86.0], "value": 85.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 52.0, 52.0, 56.0, 55.0, 56.0, 57.0, 55.0, 54.0], "value": 54.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 72.0, 64.0, 74.0, 71.0, 66.0, 68.0, 67.0, 68.0, 69.0], "value": 68.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 90.0, 82.0, 84.0, 83.0, 83.0, 84.0, 86.0, 88.0, 106.0], "value": 86.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 135.0, 148.0, 144.0, 124.0, 133.0, 132.0, 134.0, 147.0, 139.0], "value": 136.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 163.0, 162.0, 162.0, 162.0, 177.0, 226.0, 220.0, 164.0], "value": 175.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 72.0, 65.0, 62.0, 64.0, 79.0, 58.0, 57.0, 55.0, 71.0], "value": 64.0, "unit": "score"}], "name": "kraken", "value": 1418.5, "alertThreshold": 2.0}]} 14:41:58 INFO - Return code: 0 14:41:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:41:58 INFO - # TBPL SUCCESS # 14:41:58 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:41:58 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:41:58 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:41:58 INFO - 2017-03-29 14:41:58.095 screenresolution[1654:9939] starting screenresolution argv=screenresolution get 14:41:58 INFO - 2017-03-29 14:41:58.098 screenresolution[1654:9939] Display 0: 1600x1200x32@60 14:41:58 INFO - 2017-03-29 14:41:58.105 screenresolution[1655:9942] starting screenresolution argv=screenresolution list 14:41:58 INFO - Available Modes on Display 0 14:41:58 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:41:58 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:41:58 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:41:58 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:41:58 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:41:58 INFO - Intel Iris: 14:41:58 INFO - Chipset Model: Intel Iris 14:41:58 INFO - Type: GPU 14:41:58 INFO - Bus: Built-In 14:41:58 INFO - VRAM (Dynamic, Max): 1536 MB 14:41:58 INFO - Vendor: Intel (0x8086) 14:41:58 INFO - Device ID: 0x0a2e 14:41:58 INFO - Revision ID: 0x0009 14:41:58 INFO - Displays: 14:41:58 INFO - Display: 14:41:58 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:41:58 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:41:58 INFO - Display Serial Number: 1600x1200 60 14:41:58 INFO - Main Display: Yes 14:41:58 INFO - Mirror: Off 14:41:58 INFO - Online: Yes 14:41:58 INFO - Rotation: Supported 14:41:58 INFO - Return code: 0 14:41:58 INFO - Running post-action listener: _resource_record_post_action 14:41:58 INFO - [mozharness: 2017-03-29 21:41:58.351240Z] Finished run-tests step (success) 14:41:58 INFO - Running post-run listener: _resource_record_post_run 14:41:58 INFO - Total resource usage - Wall time: 1190s; CPU: 54.0%; Read bytes: 38638592; Write bytes: 418589184; Read time: 439; Write time: 1393 14:41:58 INFO - TinderboxPrint: CPU usage
53.6% 14:41:58 INFO - TinderboxPrint: I/O read bytes / time
38,638,592 / 439 14:41:58 INFO - TinderboxPrint: I/O write bytes / time
418,589,184 / 1,393 14:41:58 INFO - TinderboxPrint: CPU idle
2,210.7 (46.4%) 14:41:58 INFO - TinderboxPrint: CPU system
949.4 (19.9%) 14:41:58 INFO - TinderboxPrint: CPU user
1,601.5 (33.6%) 14:41:58 INFO - TinderboxPrint: Swap in / out
160,292,864 / 0 14:41:58 INFO - install - Wall time: 15s; CPU: 54.0%; Read bytes: 119357952; Write bytes: 112726016; Read time: 10910; Write time: 208 14:41:58 INFO - run-tests - Wall time: 1176s; CPU: 54.0%; Read bytes: 36520960; Write bytes: 294750720; Read time: 354; Write time: 1148 14:41:58 INFO - Running post-run listener: _upload_blobber_files 14:41:58 INFO - Blob upload gear active. 14:41:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:41:58 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 14:41:58 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', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:41:58 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 Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:41:59 INFO - (blobuploader) - INFO - Open directory for files ... 14:41:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:41:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:41:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:42:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:42:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:42:00 INFO - (blobuploader) - INFO - Done attempting. 14:42:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:42:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:42:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:42:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:42:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:42:01 INFO - (blobuploader) - INFO - Done attempting. 14:42:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 14:42:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:42:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:42:02 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 14:42:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:42:02 INFO - (blobuploader) - INFO - Done attempting. 14:42:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:42:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:42:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:42:05 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:42:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:42:05 INFO - (blobuploader) - INFO - Done attempting. 14:42:05 INFO - (blobuploader) - INFO - Iteration through files over. 14:42:05 INFO - Return code: 0 14:42:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:42:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:42:05 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b7076f9fb655456a60fe4d2bc97ba1dfe1b21347060275b5f93c75e36880221c4b46f3d53f6a9b588a81d674cb3c12d41af1cc31172dd83c068fbb56fe343ce3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0bb62f6d5f23adbb3410d8a140aace6e6256c65cf6c7916c13eb59295367b5df417148d03e77ab4c329d02db6e8a26d375fe8d0109cb8d437c974ab6a86da052", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/83d62977730ee976198027c2d1295e5b95534ff92ab199b0cf93705f29d0f205ce936e9dae34a282487fff823c06739bb729e6a2581c38fc59c5c7a600b0e878", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2f53f39a064588bdca4db944d7aafee49243320d866ac8804f05b26c8f4ec3bb40a9133753b8346be64072ca59a58ba43107e0db21c003cd5492c54b6fb0f2e1"} 14:42:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:42:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:42:05 INFO - Contents: 14:42:05 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b7076f9fb655456a60fe4d2bc97ba1dfe1b21347060275b5f93c75e36880221c4b46f3d53f6a9b588a81d674cb3c12d41af1cc31172dd83c068fbb56fe343ce3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0bb62f6d5f23adbb3410d8a140aace6e6256c65cf6c7916c13eb59295367b5df417148d03e77ab4c329d02db6e8a26d375fe8d0109cb8d437c974ab6a86da052", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/83d62977730ee976198027c2d1295e5b95534ff92ab199b0cf93705f29d0f205ce936e9dae34a282487fff823c06739bb729e6a2581c38fc59c5c7a600b0e878", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2f53f39a064588bdca4db944d7aafee49243320d866ac8804f05b26c8f4ec3bb40a9133753b8346be64072ca59a58ba43107e0db21c003cd5492c54b6fb0f2e1"} 14:42:05 INFO - Running post-run listener: copy_logs_to_upload_dir 14:42:05 INFO - Copying logs to upload dir... 14:42:05 INFO - mkdir: /builds/slave/test/build/upload/logs 14:42:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1254.361040 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-03-29 14:42:05.636556) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-29 14:42:05.640325) ========= 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.7fEdgXp8GX/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.kwRU133bhJ/Listeners TMPDIR=/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/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/Mozilla-Beta/sha512/b7076f9fb655456a60fe4d2bc97ba1dfe1b21347060275b5f93c75e36880221c4b46f3d53f6a9b588a81d674cb3c12d41af1cc31172dd83c068fbb56fe343ce3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0bb62f6d5f23adbb3410d8a140aace6e6256c65cf6c7916c13eb59295367b5df417148d03e77ab4c329d02db6e8a26d375fe8d0109cb8d437c974ab6a86da052", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/83d62977730ee976198027c2d1295e5b95534ff92ab199b0cf93705f29d0f205ce936e9dae34a282487fff823c06739bb729e6a2581c38fc59c5c7a600b0e878", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2f53f39a064588bdca4db944d7aafee49243320d866ac8804f05b26c8f4ec3bb40a9133753b8346be64072ca59a58ba43107e0db21c003cd5492c54b6fb0f2e1"} build_url:https://queue.taskcluster.net/v1/task/a8CV2bEdQPa53PweV6-s1Q/artifacts/public/build/firefox-53.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011066 build_url: 'https://queue.taskcluster.net/v1/task/a8CV2bEdQPa53PweV6-s1Q/artifacts/public/build/firefox-53.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b7076f9fb655456a60fe4d2bc97ba1dfe1b21347060275b5f93c75e36880221c4b46f3d53f6a9b588a81d674cb3c12d41af1cc31172dd83c068fbb56fe343ce3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0bb62f6d5f23adbb3410d8a140aace6e6256c65cf6c7916c13eb59295367b5df417148d03e77ab4c329d02db6e8a26d375fe8d0109cb8d437c974ab6a86da052", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/83d62977730ee976198027c2d1295e5b95534ff92ab199b0cf93705f29d0f205ce936e9dae34a282487fff823c06739bb729e6a2581c38fc59c5c7a600b0e878", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2f53f39a064588bdca4db944d7aafee49243320d866ac8804f05b26c8f4ec3bb40a9133753b8346be64072ca59a58ba43107e0db21c003cd5492c54b6fb0f2e1"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-29 14:42:05.676549) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-29 14:42:05.676933) ========= 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.7fEdgXp8GX/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.kwRU133bhJ/Listeners TMPDIR=/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/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.005060 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-29 14:42:05.725846) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-29 14:42:05.726196) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-29 14:42:05.726530) ========= ========= Total master_lag: 0.18 =========