builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0192 starttime: 1491483611.38 results: success (0) buildid: 20170406043437 builduid: f1c50359d9254eb48ff6fc01dc639575 revision: db49c7b778064599f028d5b3a96cda1deb257e5d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-06 06:00:11.376107) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-06 06:00:11.376584) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-06 06:00:11.376863) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-06 06:00:11.405752) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-06 06:00:11.406122) ========= 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.lQuYoBmes1/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.ZK086vJWTq/Listeners TMPDIR=/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/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-04-06 06:00:11-- 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% 18.1M=0.001s 2017-04-06 06:00:11 (18.1 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.531460 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-06 06:00:11.961497) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-06 06:00:11.961814) ========= 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.lQuYoBmes1/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.ZK086vJWTq/Listeners TMPDIR=/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/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.036727 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-06 06:00:12.020891) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-06 06:00:12.021263) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev db49c7b778064599f028d5b3a96cda1deb257e5d --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 db49c7b778064599f028d5b3a96cda1deb257e5d --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.lQuYoBmes1/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.ZK086vJWTq/Listeners TMPDIR=/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/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-04-06 06:00:12,122 truncating revision to first 12 chars 2017-04-06 06:00:12,122 Setting DEBUG logging. 2017-04-06 06:00:12,122 attempt 1/10 2017-04-06 06:00:12,122 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/db49c7b77806?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-06 06:00:13,754 unpacking tar archive at: mozilla-beta-db49c7b77806/testing/mozharness/ program finished with exit code 0 elapsedTime=1.903730 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-06 06:00:13.948386) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-06 06:00:13.948712) ========= script_repo_revision: db49c7b778064599f028d5b3a96cda1deb257e5d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-06 06:00:13.949116) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-06 06:00:13.949398) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-06 06:00:13.969512) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2017-04-06 06:00:13.969887) ========= /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.lQuYoBmes1/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.ZK086vJWTq/Listeners TMPDIR=/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/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 06:00:14 INFO - MultiFileLogger online at 20170406 06:00:14 in /builds/slave/test 06:00:14 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 06:00:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:00:14 INFO - {'append_to_log': False, 06:00:14 INFO - 'base_work_dir': '/builds/slave/test', 06:00:14 INFO - 'blob_upload_branch': 'Mozilla-Beta', 06:00:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:00:14 INFO - 'branch': 'Mozilla-Beta', 06:00:14 INFO - 'buildbot_json_path': 'buildprops.json', 06:00:14 INFO - 'config_files': ('talos/mac_config.py',), 06:00:14 INFO - 'default_actions': ('clobber', 06:00:14 INFO - 'read-buildbot-config', 06:00:14 INFO - 'download-and-extract', 06:00:14 INFO - 'populate-webroot', 06:00:14 INFO - 'create-virtualenv', 06:00:14 INFO - 'install', 06:00:14 INFO - 'run-tests'), 06:00:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:00:14 INFO - 'download_minidump_stackwalk': True, 06:00:14 INFO - 'download_symbols': 'ondemand', 06:00:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:00:14 INFO - 'tooltool.py': '/tools/tooltool.py', 06:00:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:00:14 INFO - '/tools/misc-python/virtualenv.py')}, 06:00:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:00:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:00:14 INFO - 'installer_path': 'installer.exe', 06:00:14 INFO - 'log_level': 'info', 06:00:14 INFO - 'log_name': 'talos', 06:00:14 INFO - 'log_to_console': True, 06:00:14 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 06:00:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 06:00:14 INFO - 'opt_config_files': (), 06:00:14 INFO - 'pip_index': False, 06:00:14 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:00:14 INFO - 'cmd': ('bash', 06:00:14 INFO - '-c', 06:00:14 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:00:14 INFO - 'enabled': True, 06:00:14 INFO - 'halt_on_failure': False, 06:00:14 INFO - 'name': 'check_screen_resolution'},), 06:00:14 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:00:14 INFO - 'cmd': ('bash', 06:00:14 INFO - '-c', 06:00:14 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:00:14 INFO - 'enabled': True, 06:00:14 INFO - 'halt_on_failure': False, 06:00:14 INFO - 'name': 'check_screen_resolution'},), 06:00:14 INFO - 'run_cmd_checks_enabled': True, 06:00:14 INFO - 'sps_profile': False, 06:00:14 INFO - 'sps_profile_interval': 0, 06:00:14 INFO - 'suite': 'dromaeojs', 06:00:14 INFO - 'system_bits': '32', 06:00:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:00:14 INFO - 'title': 't-yosemite-r7-0192', 06:00:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:00:14 INFO - 'use_talos_json': True, 06:00:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:00:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:00:14 INFO - 'work_dir': 'build'} 06:00:14 INFO - [mozharness: 2017-04-06 13:00:14.182575Z] Running clobber step. 06:00:14 INFO - Running pre-action listener: _resource_record_pre_action 06:00:14 INFO - Running main action method: clobber 06:00:14 INFO - rmtree: /builds/slave/test/build 06:00:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:00:16 INFO - Running post-action listener: _resource_record_post_action 06:00:16 INFO - [mozharness: 2017-04-06 13:00:16.884308Z] Finished clobber step (success) 06:00:16 INFO - [mozharness: 2017-04-06 13:00:16.884497Z] Running read-buildbot-config step. 06:00:16 INFO - Running pre-action listener: _resource_record_pre_action 06:00:16 INFO - Running main action method: read_buildbot_config 06:00:16 INFO - Using buildbot properties: 06:00:16 INFO - { 06:00:16 INFO - "project": "", 06:00:16 INFO - "product": "firefox", 06:00:16 INFO - "script_repo_revision": "production", 06:00:16 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 06:00:16 INFO - "repository": "", 06:00:16 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 06:00:16 INFO - "buildid": "20170406043437", 06:00:16 INFO - "pgo_build": "False", 06:00:16 INFO - "basedir": "/builds/slave/test", 06:00:16 INFO - "buildnumber": 69, 06:00:16 INFO - "slavename": "t-yosemite-r7-0192", 06:00:16 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 06:00:16 INFO - "platform": "yosemite_r7", 06:00:16 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 06:00:16 INFO - "branch": "mozilla-beta", 06:00:16 INFO - "repo_path": "releases/mozilla-beta", 06:00:16 INFO - "revision": "db49c7b778064599f028d5b3a96cda1deb257e5d", 06:00:16 INFO - "stage_platform": "macosx64", 06:00:16 INFO - "builduid": "f1c50359d9254eb48ff6fc01dc639575", 06:00:16 INFO - "slavebuilddir": "test" 06:00:16 INFO - } 06:00:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/MiOfAeh8QC-quz3VKL-ZxA/artifacts/public/build/firefox-53.0.en-US.mac.dmg. 06:00:16 INFO - Running post-action listener: _resource_record_post_action 06:00:16 INFO - [mozharness: 2017-04-06 13:00:16.887834Z] Finished read-buildbot-config step (success) 06:00:16 INFO - [mozharness: 2017-04-06 13:00:16.887947Z] Running download-and-extract step. 06:00:16 INFO - Running pre-action listener: _resource_record_pre_action 06:00:16 INFO - Running main action method: download_and_extract 06:00:16 INFO - mkdir: /builds/slave/test/build/tests 06:00:16 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')]} 06:00:16 INFO - trying https://queue.taskcluster.net/v1/task/MiOfAeh8QC-quz3VKL-ZxA/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json 06:00:16 INFO - Downloading https://queue.taskcluster.net/v1/task/MiOfAeh8QC-quz3VKL-ZxA/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 06:00:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MiOfAeh8QC-quz3VKL-ZxA/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 06:00:18 INFO - Downloaded 1165 bytes. 06:00:18 INFO - Reading from file /builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json 06:00:18 INFO - Using the following test package requirements: 06:00:18 INFO - {u'common': [u'firefox-53.0.en-US.mac.common.tests.zip'], 06:00:18 INFO - u'cppunittest': [u'firefox-53.0.en-US.mac.common.tests.zip', 06:00:18 INFO - u'firefox-53.0.en-US.mac.cppunittest.tests.zip'], 06:00:18 INFO - u'gtest': [u'firefox-53.0.en-US.mac.common.tests.zip', 06:00:18 INFO - u'firefox-53.0.en-US.mac.gtest.tests.zip'], 06:00:18 INFO - u'jittest': [u'firefox-53.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 06:00:18 INFO - u'mochitest': [u'firefox-53.0.en-US.mac.common.tests.zip', 06:00:18 INFO - u'firefox-53.0.en-US.mac.mochitest.tests.zip'], 06:00:18 INFO - u'mozbase': [u'firefox-53.0.en-US.mac.common.tests.zip'], 06:00:18 INFO - u'reftest': [u'firefox-53.0.en-US.mac.common.tests.zip', 06:00:18 INFO - u'firefox-53.0.en-US.mac.reftest.tests.zip'], 06:00:18 INFO - u'talos': [u'firefox-53.0.en-US.mac.common.tests.zip', 06:00:18 INFO - u'firefox-53.0.en-US.mac.talos.tests.zip'], 06:00:18 INFO - u'web-platform': [u'firefox-53.0.en-US.mac.common.tests.zip', 06:00:18 INFO - u'firefox-53.0.en-US.mac.web-platform.tests.zip'], 06:00:18 INFO - u'xpcshell': [u'firefox-53.0.en-US.mac.common.tests.zip', 06:00:18 INFO - u'firefox-53.0.en-US.mac.xpcshell.tests.zip']} 06:00:18 INFO - Downloading packages: [u'firefox-53.0.en-US.mac.common.tests.zip'] for test suite category: common 06:00:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MiOfAeh8QC-quz3VKL-ZxA/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip 06:00:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MiOfAeh8QC-quz3VKL-ZxA/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip'}, attempt #1 06:00:18 INFO - Fetch https://queue.taskcluster.net/v1/task/MiOfAeh8QC-quz3VKL-ZxA/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip into memory 06:00:19 INFO - Expected file size: 16116355 06:00:19 INFO - Obtained file size: 16116355 06:00:26 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 06:00:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MiOfAeh8QC-quz3VKL-ZxA/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip 06:00:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MiOfAeh8QC-quz3VKL-ZxA/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip'}, attempt #1 06:00:26 INFO - Fetch https://queue.taskcluster.net/v1/task/MiOfAeh8QC-quz3VKL-ZxA/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip into memory 06:00:27 INFO - Expected file size: 16116355 06:00:27 INFO - Obtained file size: 16116355 06:00:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MiOfAeh8QC-quz3VKL-ZxA/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip 06:00:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MiOfAeh8QC-quz3VKL-ZxA/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip'}, attempt #1 06:00:33 INFO - Fetch https://queue.taskcluster.net/v1/task/MiOfAeh8QC-quz3VKL-ZxA/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip into memory 06:00:34 INFO - Expected file size: 14403663 06:00:34 INFO - Obtained file size: 14403663 06:00:34 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')]} 06:00:34 INFO - trying https://queue.taskcluster.net/v1/task/MiOfAeh8QC-quz3VKL-ZxA/artifacts/public/build/firefox-53.0.en-US.mac.dmg 06:00:34 INFO - Downloading https://queue.taskcluster.net/v1/task/MiOfAeh8QC-quz3VKL-ZxA/artifacts/public/build/firefox-53.0.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0.en-US.mac.dmg 06:00:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MiOfAeh8QC-quz3VKL-ZxA/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 06:00:36 INFO - Downloaded 58742143 bytes. 06:00:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MiOfAeh8QC-quz3VKL-ZxA/artifacts/public/build/firefox-53.0.en-US.mac.dmg 06:00:36 INFO - mkdir: /builds/slave/test/properties 06:00:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:00:36 INFO - Writing to file /builds/slave/test/properties/build_url 06:00:36 INFO - Contents: 06:00:36 INFO - build_url:https://queue.taskcluster.net/v1/task/MiOfAeh8QC-quz3VKL-ZxA/artifacts/public/build/firefox-53.0.en-US.mac.dmg 06:00:37 INFO - Running post-action listener: _resource_record_post_action 06:00:37 INFO - Running post-action listener: set_extra_try_arguments 06:00:37 INFO - [mozharness: 2017-04-06 13:00:37.248656Z] Finished download-and-extract step (success) 06:00:37 INFO - [mozharness: 2017-04-06 13:00:37.248778Z] Running populate-webroot step. 06:00:37 INFO - Running pre-action listener: _resource_record_pre_action 06:00:37 INFO - Running main action method: populate_webroot 06:00:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:00:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:00:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:00:37 INFO - '--tppagecycles', 06:00:37 INFO - '7'], 06:00:37 INFO - 'tests': ['tsvgm']}}, 06:00:37 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:00:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:00:37 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:00:37 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:00:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:00:37 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:00:37 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 06:00:37 INFO - 'talos_options': ['--disable-e10s'], 06:00:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:00:37 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 06:00:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:00:37 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 06:00:37 INFO - 'talos_options': ['--disable-e10s'], 06:00:37 INFO - 'tests': ['damp', 'tps']}, 06:00:37 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 06:00:37 INFO - 'tests': ['damp', 'tps']}, 06:00:37 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:00:37 INFO - 'tests': ['dromaeo_dom']}, 06:00:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:00:37 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:00:37 INFO - 'tests': ['basic_compositor_video']}, 06:00:37 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:00:37 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:00:37 INFO - 'tests': ['a11yr', 06:00:37 INFO - 'ts_paint', 06:00:37 INFO - 'tpaint', 06:00:37 INFO - 'sessionrestore', 06:00:37 INFO - 'sessionrestore_no_auto_restore', 06:00:37 INFO - 'tabpaint']}, 06:00:37 INFO - 'other-e10s': {'tests': ['a11yr', 06:00:37 INFO - 'ts_paint', 06:00:37 INFO - 'tpaint', 06:00:37 INFO - 'sessionrestore', 06:00:37 INFO - 'sessionrestore_no_auto_restore', 06:00:37 INFO - 'tabpaint']}, 06:00:37 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:00:37 INFO - 'ts_paint', 06:00:37 INFO - 'tpaint', 06:00:37 INFO - 'sessionrestore', 06:00:37 INFO - 'sessionrestore_no_auto_restore', 06:00:37 INFO - 'tabpaint']}, 06:00:37 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:00:37 INFO - 'ts_paint', 06:00:37 INFO - 'tpaint', 06:00:37 INFO - 'sessionrestore', 06:00:37 INFO - 'sessionrestore_no_auto_restore', 06:00:37 INFO - 'tabpaint']}, 06:00:37 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:00:37 INFO - 'tests': ['a11yr', 06:00:37 INFO - 'ts_paint', 06:00:37 INFO - 'tpaint', 06:00:37 INFO - 'sessionrestore', 06:00:37 INFO - 'sessionrestore_no_auto_restore', 06:00:37 INFO - 'tabpaint']}, 06:00:37 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:00:37 INFO - 'tests': ['a11yr', 06:00:37 INFO - 'ts_paint', 06:00:37 INFO - 'tpaint', 06:00:37 INFO - 'sessionrestore', 06:00:37 INFO - 'sessionrestore_no_auto_restore', 06:00:37 INFO - 'tabpaint']}, 06:00:37 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:00:37 INFO - 'tests': ['tsvgx', 06:00:37 INFO - 'tsvgr_opacity', 06:00:37 INFO - 'tart', 06:00:37 INFO - 'tscrollx', 06:00:37 INFO - 'cart', 06:00:37 INFO - 'tsvg_static']}, 06:00:37 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:00:37 INFO - 'tsvgr_opacity', 06:00:37 INFO - 'tart', 06:00:37 INFO - 'tscrollx', 06:00:37 INFO - 'cart', 06:00:37 INFO - 'tsvg_static']}, 06:00:37 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 06:00:37 INFO - 'talos_options': ['--disable-e10s'], 06:00:37 INFO - 'tests': ['tp5o']}, 06:00:37 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 06:00:37 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 06:00:37 INFO - 'talos_options': ['--disable-e10s', 06:00:37 INFO - '--xperf_path', 06:00:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:00:37 INFO - 'tests': ['tp5n']}, 06:00:37 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 06:00:37 INFO - 'talos_options': ['--xperf_path', 06:00:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:00:37 INFO - 'tests': ['tp5n']}}, 06:00:37 INFO - 'talos.zip': {'path': '', 06:00:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:00:37 INFO - Running post-action listener: _resource_record_post_action 06:00:37 INFO - [mozharness: 2017-04-06 13:00:37.267620Z] Finished populate-webroot step (success) 06:00:37 INFO - [mozharness: 2017-04-06 13:00:37.267738Z] Running create-virtualenv step. 06:00:37 INFO - Running pre-action listener: _resource_record_pre_action 06:00:37 INFO - Running main action method: create_virtualenv 06:00:37 INFO - Creating virtualenv /builds/slave/test/build/venv 06:00:37 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 06:00:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:00:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:00:37 INFO - Using real prefix '/tools/python27' 06:00:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:00:38 INFO - Installing distribute.............................................................................................................................................................................................done. 06:00:40 INFO - Installing pip.................done. 06:00:40 INFO - Return code: 0 06:00:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 06:00:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 06:00:41 INFO - Reading from file tmpfile_stdout 06:00:41 INFO - Output received: 06:00:41 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) 06:00:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:00:41 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')]} 06:00:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:00:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00:41 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')]} 06:00:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:00:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00:41 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 0x10f181b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f184768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff2cac6f420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef5fd30>, '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 0x10ee86db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ef54be8>, '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.lQuYoBmes1/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.ZK086vJWTq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/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 06:00:41 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 06:00:41 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 06:00:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lQuYoBmes1/Render', 06:00:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:00:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:00:41 INFO - 'HOME': '/Users/cltbld', 06:00:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:00:41 INFO - 'LOGNAME': 'cltbld', 06:00:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:00:41 INFO - 'MOZ_NO_REMOTE': '1', 06:00:41 INFO - 'NO_EM_RESTART': '1', 06:00:41 INFO - 'PAGER': '/bin/cat', 06:00:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:00:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:00:41 INFO - 'PWD': '/builds/slave/test', 06:00:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:00:41 INFO - 'SHELL': '/bin/bash', 06:00:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZK086vJWTq/Listeners', 06:00:41 INFO - 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/', 06:00:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:00:41 INFO - 'USER': 'cltbld', 06:00:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:00:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:00:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:00:41 INFO - 'XPC_FLAGS': '0x0', 06:00:41 INFO - 'XPC_SERVICE_NAME': '0', 06:00:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:00:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:00:41 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 06:00:41 INFO - Cleaning up... 06:00:41 INFO - Return code: 0 06:00:41 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:00:41 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')]} 06:00:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:00:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00:41 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')]} 06:00:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:00:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00:41 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 0x10f181b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f184768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff2cac6f420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef5fd30>, '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 0x10ee86db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ef54be8>, '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.lQuYoBmes1/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.ZK086vJWTq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/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 06:00:41 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 06:00:41 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 06:00:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lQuYoBmes1/Render', 06:00:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:00:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:00:41 INFO - 'HOME': '/Users/cltbld', 06:00:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:00:41 INFO - 'LOGNAME': 'cltbld', 06:00:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:00:41 INFO - 'MOZ_NO_REMOTE': '1', 06:00:41 INFO - 'NO_EM_RESTART': '1', 06:00:41 INFO - 'PAGER': '/bin/cat', 06:00:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:00:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:00:41 INFO - 'PWD': '/builds/slave/test', 06:00:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:00:41 INFO - 'SHELL': '/bin/bash', 06:00:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZK086vJWTq/Listeners', 06:00:41 INFO - 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/', 06:00:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:00:41 INFO - 'USER': 'cltbld', 06:00:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:00:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:00:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:00:41 INFO - 'XPC_FLAGS': '0x0', 06:00:41 INFO - 'XPC_SERVICE_NAME': '0', 06:00:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:00:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:00:41 INFO - Downloading/unpacking psutil>=3.1.1 06:00:41 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 06:00:41 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 06:00:41 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 06:00:41 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 06:00:41 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 06:00:41 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 06:00:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:00:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:00:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:00:45 INFO - Installing collected packages: psutil 06:00:45 INFO - Running setup.py install for psutil 06:00:45 INFO - building 'psutil._psutil_osx' extension 06:00:45 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 06:00:45 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 06:00:46 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 06:00:46 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 06:00:46 INFO - building 'psutil._psutil_posix' extension 06:00:46 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 06:00:46 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 06:00:46 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 06:00:46 INFO - ^ 06:00:46 INFO - 1 warning generated. 06:00:46 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 06:00:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:00:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:00:46 INFO - Successfully installed psutil 06:00:46 INFO - Cleaning up... 06:00:46 INFO - Return code: 0 06:00:46 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:00: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')]} 06:00:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:00:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00: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')]} 06:00:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:00:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f181b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f184768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff2cac6f420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef5fd30>, '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 0x10ee86db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ef54be8>, '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.lQuYoBmes1/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.ZK086vJWTq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/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 06:00: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 06:00: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 mozsystemmonitor==0.3 06:00:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lQuYoBmes1/Render', 06:00:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:00:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:00:46 INFO - 'HOME': '/Users/cltbld', 06:00:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:00:46 INFO - 'LOGNAME': 'cltbld', 06:00:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:00:46 INFO - 'MOZ_NO_REMOTE': '1', 06:00:46 INFO - 'NO_EM_RESTART': '1', 06:00:46 INFO - 'PAGER': '/bin/cat', 06:00:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:00:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:00:46 INFO - 'PWD': '/builds/slave/test', 06:00:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:00:46 INFO - 'SHELL': '/bin/bash', 06:00:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZK086vJWTq/Listeners', 06:00:46 INFO - 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/', 06:00:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:00:46 INFO - 'USER': 'cltbld', 06:00:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:00:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:00:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:00:46 INFO - 'XPC_FLAGS': '0x0', 06:00:46 INFO - 'XPC_SERVICE_NAME': '0', 06:00:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:00:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:00:46 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:00: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 06:00: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 06:00: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 06:00: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 06:00: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 06:00: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 06:00:49 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:00:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:00:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:00:49 INFO - Installing collected packages: mozsystemmonitor 06:00:49 INFO - Running setup.py install for mozsystemmonitor 06:00:49 INFO - Successfully installed mozsystemmonitor 06:00:49 INFO - Cleaning up... 06:00:49 INFO - Return code: 0 06:00:49 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:00:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:00:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:00:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:00:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:00:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10f181b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f184768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff2cac6f420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef5fd30>, '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 0x10ee86db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ef54be8>, '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.lQuYoBmes1/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.ZK086vJWTq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/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 06:00:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 06:00:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 06:00:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lQuYoBmes1/Render', 06:00:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:00:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:00:49 INFO - 'HOME': '/Users/cltbld', 06:00:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:00:49 INFO - 'LOGNAME': 'cltbld', 06:00:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:00:49 INFO - 'MOZ_NO_REMOTE': '1', 06:00:49 INFO - 'NO_EM_RESTART': '1', 06:00:49 INFO - 'PAGER': '/bin/cat', 06:00:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:00:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:00:49 INFO - 'PWD': '/builds/slave/test', 06:00:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:00:49 INFO - 'SHELL': '/bin/bash', 06:00:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZK086vJWTq/Listeners', 06:00:49 INFO - 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/', 06:00:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:00:49 INFO - 'USER': 'cltbld', 06:00:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:00:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:00:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:00:49 INFO - 'XPC_FLAGS': '0x0', 06:00:49 INFO - 'XPC_SERVICE_NAME': '0', 06:00:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:00:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:00:50 INFO - Downloading/unpacking jsonschema==2.5.1 06:00: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 06:00: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 06:00: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 06:00: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 06:00: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 06:00: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 06:00:52 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:00:52 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:00:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:00:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:00:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:00:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:00:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:00:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:00:53 INFO - Downloading functools32-3.2.3-2.tar.gz 06:00:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:00:53 INFO - warning: no files found matching '*.txt' 06:00:53 INFO - no previously-included directories found matching 'build' 06:00:53 INFO - no previously-included directories found matching 'dist' 06:00:53 INFO - no previously-included directories found matching '.git*' 06:00:53 INFO - Installing collected packages: jsonschema, functools32 06:00:53 INFO - Running setup.py install for functools32 06:00:53 INFO - warning: no files found matching '*.txt' 06:00:53 INFO - no previously-included directories found matching 'build' 06:00:53 INFO - no previously-included directories found matching 'dist' 06:00:53 INFO - no previously-included directories found matching '.git*' 06:00:53 INFO - Successfully installed jsonschema functools32 06:00:53 INFO - Cleaning up... 06:00:53 INFO - Return code: 0 06:00:53 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:00:53 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')]} 06:00:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:00:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00:53 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')]} 06:00:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:00:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00:53 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 0x10f181b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f184768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff2cac6f420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef5fd30>, '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 0x10ee86db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ef54be8>, '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.lQuYoBmes1/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.ZK086vJWTq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/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 06:00:53 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 06:00:53 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 06:00:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lQuYoBmes1/Render', 06:00:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:00:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:00:53 INFO - 'HOME': '/Users/cltbld', 06:00:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:00:53 INFO - 'LOGNAME': 'cltbld', 06:00:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:00:53 INFO - 'MOZ_NO_REMOTE': '1', 06:00:53 INFO - 'NO_EM_RESTART': '1', 06:00:53 INFO - 'PAGER': '/bin/cat', 06:00:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:00:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:00:53 INFO - 'PWD': '/builds/slave/test', 06:00:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:00:53 INFO - 'SHELL': '/bin/bash', 06:00:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZK086vJWTq/Listeners', 06:00:53 INFO - 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/', 06:00:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:00:53 INFO - 'USER': 'cltbld', 06:00:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:00:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:00:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:00:53 INFO - 'XPC_FLAGS': '0x0', 06:00:53 INFO - 'XPC_SERVICE_NAME': '0', 06:00:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:00:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:00:53 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:00:53 INFO - Cleaning up... 06:00:53 INFO - Return code: 0 06:00:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:00:53 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')]} 06:00:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:00:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00:53 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')]} 06:00:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:00:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00:53 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 0x10f181b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f184768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff2cac6f420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef5fd30>, '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 0x10ee86db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ef54be8>, '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.lQuYoBmes1/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.ZK086vJWTq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/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 06:00:53 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 06:00:53 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 06:00:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lQuYoBmes1/Render', 06:00:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:00:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:00:53 INFO - 'HOME': '/Users/cltbld', 06:00:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:00:53 INFO - 'LOGNAME': 'cltbld', 06:00:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:00:53 INFO - 'MOZ_NO_REMOTE': '1', 06:00:53 INFO - 'NO_EM_RESTART': '1', 06:00:53 INFO - 'PAGER': '/bin/cat', 06:00:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:00:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:00:53 INFO - 'PWD': '/builds/slave/test', 06:00:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:00:53 INFO - 'SHELL': '/bin/bash', 06:00:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZK086vJWTq/Listeners', 06:00:53 INFO - 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/', 06:00:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:00:53 INFO - 'USER': 'cltbld', 06:00:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:00:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:00:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:00:53 INFO - 'XPC_FLAGS': '0x0', 06:00:53 INFO - 'XPC_SERVICE_NAME': '0', 06:00:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:00:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:00:53 INFO - Downloading/unpacking blobuploader==1.2.4 06:00: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 06:00: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 06:00: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 06:00: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 06:00: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 06:00: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 06:00:56 INFO - Downloading blobuploader-1.2.4.tar.gz 06:00:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:00:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:00:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:00:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:00:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:00:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:00:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:00:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:00:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:00:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:00:57 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 06:00:57 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 06:00:57 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 06:00:57 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 06:00:57 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 06:00:57 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 06:00:57 INFO - Downloading docopt-0.6.1.tar.gz 06:00:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:00:57 INFO - Installing collected packages: blobuploader, requests, docopt 06:00:57 INFO - Running setup.py install for blobuploader 06:00:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:00:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:00:58 INFO - Running setup.py install for requests 06:00:58 INFO - Running setup.py install for docopt 06:00:58 INFO - Successfully installed blobuploader requests docopt 06:00:58 INFO - Cleaning up... 06:00:58 INFO - Return code: 0 06:00:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:00:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:00:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:00:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:00:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:00:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00:58 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 0x10f181b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f184768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff2cac6f420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef5fd30>, '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 0x10ee86db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ef54be8>, '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.lQuYoBmes1/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.ZK086vJWTq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/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 06:00:58 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 06:00:58 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 06:00:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lQuYoBmes1/Render', 06:00:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:00:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:00:58 INFO - 'HOME': '/Users/cltbld', 06:00:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:00:58 INFO - 'LOGNAME': 'cltbld', 06:00:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:00:58 INFO - 'MOZ_NO_REMOTE': '1', 06:00:58 INFO - 'NO_EM_RESTART': '1', 06:00:58 INFO - 'PAGER': '/bin/cat', 06:00:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:00:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:00:58 INFO - 'PWD': '/builds/slave/test', 06:00:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:00:58 INFO - 'SHELL': '/bin/bash', 06:00:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZK086vJWTq/Listeners', 06:00:58 INFO - 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/', 06:00:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:00:58 INFO - 'USER': 'cltbld', 06:00:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:00:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:00:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:00:58 INFO - 'XPC_FLAGS': '0x0', 06:00:58 INFO - 'XPC_SERVICE_NAME': '0', 06:00:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:00:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:00:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:00:59 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-gX8HBv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:00:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:00:59 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-jC8dpl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:00:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:00:59 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-FI8w2U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:00:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:00:59 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-2maHmG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:00:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:00:59 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-1UKmSL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:00:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:00:59 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-x5tdNe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:00:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:00:59 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-wN2uRx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:00:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:00:59 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-zQLmNN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:00:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:00:59 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-0Dy19S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:01:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:01:00 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-9gLvfJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:01:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:01:00 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-ybjtig-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:01:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:01:00 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-D8gVyH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:01:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:01:00 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-4L_gD1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:01:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:01:00 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-ntBeJ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:01:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:01:00 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-pSmuLz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:01:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:01:00 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-kEUJTG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:01:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:01:00 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-HF2tki-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:01:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:01:00 INFO - Running setup.py install for manifestparser 06:01:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:01:01 INFO - Running setup.py install for mozcrash 06:01:01 INFO - Running setup.py install for mozdebug 06:01:01 INFO - Running setup.py install for mozdevice 06:01:01 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:01:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:01:01 INFO - Running setup.py install for mozfile 06:01:01 INFO - Running setup.py install for mozhttpd 06:01:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:01:01 INFO - Running setup.py install for mozinfo 06:01:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:01:01 INFO - Running setup.py install for mozInstall 06:01:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:01:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:01:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:01:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:01:02 INFO - Running setup.py install for mozleak 06:01:02 INFO - Running setup.py install for mozlog 06:01:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:01:02 INFO - Running setup.py install for moznetwork 06:01:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:01:02 INFO - Running setup.py install for mozprocess 06:01:02 INFO - Running setup.py install for mozprofile 06:01:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:01:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:01:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:01:02 INFO - Running setup.py install for mozrunner 06:01:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:01:03 INFO - Running setup.py install for mozscreenshot 06:01:03 INFO - Running setup.py install for moztest 06:01:03 INFO - Running setup.py install for mozversion 06:01:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:01:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:01:03 INFO - Cleaning up... 06:01:03 INFO - Return code: 0 06:01:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:01:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:01:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:01:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:01:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:01:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01:03 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 0x10f181b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f184768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff2cac6f420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef5fd30>, '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 0x10ee86db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ef54be8>, '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.lQuYoBmes1/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.ZK086vJWTq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/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 06:01:03 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 06:01:03 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 06:01:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lQuYoBmes1/Render', 06:01:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:01:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:01:03 INFO - 'HOME': '/Users/cltbld', 06:01:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:01:03 INFO - 'LOGNAME': 'cltbld', 06:01:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:01:03 INFO - 'MOZ_NO_REMOTE': '1', 06:01:03 INFO - 'NO_EM_RESTART': '1', 06:01:03 INFO - 'PAGER': '/bin/cat', 06:01:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:01:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:01:03 INFO - 'PWD': '/builds/slave/test', 06:01:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:01:03 INFO - 'SHELL': '/bin/bash', 06:01:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZK086vJWTq/Listeners', 06:01:03 INFO - 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/', 06:01:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:01:03 INFO - 'USER': 'cltbld', 06:01:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:01:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:01:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:01:03 INFO - 'XPC_FLAGS': '0x0', 06:01:03 INFO - 'XPC_SERVICE_NAME': '0', 06:01:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:01:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:01:03 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-elwoOF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:01:03 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)) 06:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:01:03 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-bO8622-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:01:03 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)) 06:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:01:03 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-xj9wK1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:01:04 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)) 06:01:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:01:04 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-CABuk7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:01:04 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)) 06:01:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:01:04 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-IwtY0Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:01:04 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)) 06:01:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:01:04 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-xuHxSx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:01:04 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)) 06:01:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:01:04 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-01WdTN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:01:04 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)) 06:01:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:01:04 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-y58lZN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:01:04 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)) 06:01:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:01:04 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-EXupAs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:01:04 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)) 06:01:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:01:04 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-cR2oAi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:01:04 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)) 06:01:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:01:04 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-U5NEdX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:01:04 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)) 06:01:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:01:04 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-WYFjRG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:01:05 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)) 06:01:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:01:05 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-OrPhJS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:01:05 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)) 06:01:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:01:05 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-G6rpQa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:01:05 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)) 06:01:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:01:05 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-3OKlrV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:01:05 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)) 06:01:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:01:05 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-NxD_TW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:01:05 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)) 06:01:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:01:05 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-18ZiMO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:01:05 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)) 06:01:05 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)) 06:01:05 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)) 06:01:05 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)) 06:01:05 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)) 06:01:05 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)) 06:01:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:01:05 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 06:01:05 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 06:01:05 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 06:01:05 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 06:01:05 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 06:01:05 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 06:01:08 INFO - Downloading blessings-1.6.tar.gz 06:01:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:01:08 INFO - Installing collected packages: blessings 06:01:08 INFO - Running setup.py install for blessings 06:01:08 INFO - Successfully installed blessings 06:01:08 INFO - Cleaning up... 06:01:08 INFO - Return code: 0 06:01:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:01:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:01:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:01:09 INFO - Reading from file tmpfile_stdout 06:01:09 INFO - Current package versions: 06:01:09 INFO - blessings == 1.6 06:01:09 INFO - blobuploader == 1.2.4 06:01:09 INFO - docopt == 0.6.1 06:01:09 INFO - functools32 == 3.2.3-2 06:01:09 INFO - jsonschema == 2.5.1 06:01:09 INFO - manifestparser == 1.1 06:01:09 INFO - mozInstall == 1.12 06:01:09 INFO - mozcrash == 1.0 06:01:09 INFO - mozdebug == 0.1 06:01:09 INFO - mozdevice == 0.49 06:01:09 INFO - mozfile == 1.2 06:01:09 INFO - mozhttpd == 0.7 06:01:09 INFO - mozinfo == 0.9 06:01:09 INFO - mozleak == 0.1 06:01:09 INFO - mozlog == 3.4 06:01:09 INFO - moznetwork == 0.27 06:01:09 INFO - mozprocess == 0.24 06:01:09 INFO - mozprofile == 0.28 06:01:09 INFO - mozrunner == 6.13 06:01:09 INFO - mozscreenshot == 0.1 06:01:09 INFO - mozsystemmonitor == 0.3 06:01:09 INFO - moztest == 0.8 06:01:09 INFO - mozversion == 1.4 06:01:09 INFO - psutil == 3.1.1 06:01:09 INFO - requests == 1.2.3 06:01:09 INFO - wsgiref == 0.1.2 06:01:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:01:09 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')]} 06:01:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:01:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01:09 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')]} 06:01:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:01:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01:09 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 0x10f181b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f184768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff2cac6f420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef5fd30>, '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 0x10ee86db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ef54be8>, '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.lQuYoBmes1/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.ZK086vJWTq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/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 06:01:09 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 06:01:09 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 06:01:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lQuYoBmes1/Render', 06:01:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:01:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:01:09 INFO - 'HOME': '/Users/cltbld', 06:01:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:01:09 INFO - 'LOGNAME': 'cltbld', 06:01:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:01:09 INFO - 'MOZ_NO_REMOTE': '1', 06:01:09 INFO - 'NO_EM_RESTART': '1', 06:01:09 INFO - 'PAGER': '/bin/cat', 06:01:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:01:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:01:09 INFO - 'PWD': '/builds/slave/test', 06:01:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:01:09 INFO - 'SHELL': '/bin/bash', 06:01:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZK086vJWTq/Listeners', 06:01:09 INFO - 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/', 06:01:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:01:09 INFO - 'USER': 'cltbld', 06:01:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:01:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:01:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:01:09 INFO - 'XPC_FLAGS': '0x0', 06:01:09 INFO - 'XPC_SERVICE_NAME': '0', 06:01:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:01:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:01:09 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)) 06:01:09 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)) 06:01:09 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)) 06:01:09 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)) 06:01:09 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)) 06:01:09 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)) 06:01:09 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)) 06:01:09 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)) 06:01:09 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)) 06:01:09 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)) 06:01:09 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)) 06:01:09 INFO - Cleaning up... 06:01:09 INFO - Return code: 0 06:01:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:01:09 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')]} 06:01:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:01:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01:09 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')]} 06:01:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:01:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01:09 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 0x10f181b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f184768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff2cac6f420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef5fd30>, '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 0x10ee86db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ef54be8>, '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.lQuYoBmes1/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.ZK086vJWTq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/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 06:01:09 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 06:01:09 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 06:01:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lQuYoBmes1/Render', 06:01:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:01:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:01:09 INFO - 'HOME': '/Users/cltbld', 06:01:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:01:09 INFO - 'LOGNAME': 'cltbld', 06:01:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:01:09 INFO - 'MOZ_NO_REMOTE': '1', 06:01:09 INFO - 'NO_EM_RESTART': '1', 06:01:09 INFO - 'PAGER': '/bin/cat', 06:01:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:01:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:01:09 INFO - 'PWD': '/builds/slave/test', 06:01:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:01:09 INFO - 'SHELL': '/bin/bash', 06:01:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZK086vJWTq/Listeners', 06:01:09 INFO - 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/', 06:01:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:01:09 INFO - 'USER': 'cltbld', 06:01:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:01:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:01:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:01:09 INFO - 'XPC_FLAGS': '0x0', 06:01:09 INFO - 'XPC_SERVICE_NAME': '0', 06:01:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:01:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:01:10 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:01:10 INFO - Cleaning up... 06:01:10 INFO - Return code: 0 06:01:10 INFO - Running post-action listener: _resource_record_post_action 06:01:10 INFO - Running post-action listener: _start_resource_monitoring 06:01:10 INFO - Starting resource monitoring. 06:01:10 INFO - [mozharness: 2017-04-06 13:01:10.138859Z] Finished create-virtualenv step (success) 06:01:10 INFO - [mozharness: 2017-04-06 13:01:10.139799Z] Running install step. 06:01:10 INFO - Running pre-action listener: _resource_record_pre_action 06:01:10 INFO - Running main action method: install 06:01:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:01:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:01:10 INFO - Reading from file tmpfile_stdout 06:01:10 INFO - Detecting whether we're running mozinstall >=1.0... 06:01:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:01:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:01:10 INFO - Reading from file tmpfile_stdout 06:01:10 INFO - Output received: 06:01:10 INFO - Usage: mozinstall [options] installer 06:01:10 INFO - Options: 06:01:10 INFO - -h, --help show this help message and exit 06:01:10 INFO - -d DEST, --destination=DEST 06:01:10 INFO - Directory to install application into. [default: 06:01:10 INFO - "/builds/slave/test"] 06:01:10 INFO - --app=APP Application being installed. [default: firefox] 06:01:10 INFO - mkdir: /builds/slave/test/build/application 06:01:10 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'] 06:01:10 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 06:01:25 INFO - Reading from file tmpfile_stdout 06:01:25 INFO - Output received: 06:01:25 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 06:01:25 INFO - Running post-action listener: _resource_record_post_action 06:01:25 INFO - [mozharness: 2017-04-06 13:01:25.148785Z] Finished install step (success) 06:01:25 INFO - [mozharness: 2017-04-06 13:01:25.148909Z] Running run-tests step. 06:01:25 INFO - Running pre-action listener: _resource_record_pre_action 06:01:25 INFO - Running main action method: run_tests 06:01:25 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:01:25 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:01:25 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:01:25 INFO - 2017-04-06 06:01:25.163 screenresolution[1625:7182] starting screenresolution argv=screenresolution get 06:01:25 INFO - 2017-04-06 06:01:25.166 screenresolution[1625:7182] Display 0: 1600x1200x32@60 06:01:25 INFO - 2017-04-06 06:01:25.171 screenresolution[1626:7184] starting screenresolution argv=screenresolution list 06:01:25 INFO - Available Modes on Display 0 06:01:25 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:01:25 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:01:25 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:01:25 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:01:25 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:01:25 INFO - Intel Iris: 06:01:25 INFO - Chipset Model: Intel Iris 06:01:25 INFO - Type: GPU 06:01:25 INFO - Bus: Built-In 06:01:25 INFO - VRAM (Dynamic, Max): 1536 MB 06:01:25 INFO - Vendor: Intel (0x8086) 06:01:25 INFO - Device ID: 0x0a2e 06:01:25 INFO - Revision ID: 0x0009 06:01:25 INFO - Displays: 06:01:25 INFO - Display: 06:01:25 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:01:25 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:01:25 INFO - Display Serial Number: 1600x1200 60 06:01:25 INFO - Main Display: Yes 06:01:25 INFO - Mirror: Off 06:01:25 INFO - Online: Yes 06:01:25 INFO - Rotation: Supported 06:01:25 INFO - Return code: 0 06:01:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:01:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:01:25 INFO - Python 2.7.3 06:01:25 INFO - Return code: 0 06:01:25 INFO - grabbing minidump binary from tooltool 06:01:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:01:25 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 0x10ef5fd30>, '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 0x10ee86db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ef54be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:01:25 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 06:01:25 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 06:01:25 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 06:01:25 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:01:25 INFO - Return code: 0 06:01:25 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 06:01:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:01:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:01:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 06:01:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:01:25 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/MiOfAeh8QC-quz3VKL-ZxA/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0192', '--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 06:01:25 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/MiOfAeh8QC-quz3VKL-ZxA/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0192 --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 06:01:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lQuYoBmes1/Render', 06:01:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:01:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:01:25 INFO - 'HOME': '/Users/cltbld', 06:01:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:01:25 INFO - 'LOGNAME': 'cltbld', 06:01:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:01:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 06:01:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:01:25 INFO - 'MOZ_NO_REMOTE': '1', 06:01:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:01:25 INFO - 'NO_EM_RESTART': '1', 06:01:25 INFO - 'PAGER': '/bin/cat', 06:01:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:01:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:01:25 INFO - 'PWD': '/builds/slave/test', 06:01:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:01:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:01:25 INFO - 'SHELL': '/bin/bash', 06:01:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZK086vJWTq/Listeners', 06:01:25 INFO - 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/', 06:01:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:01:25 INFO - 'USER': 'cltbld', 06:01:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:01:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:01:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:01:25 INFO - 'XPC_FLAGS': '0x0', 06:01:25 INFO - 'XPC_SERVICE_NAME': '0', 06:01:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:01:25 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/MiOfAeh8QC-quz3VKL-ZxA/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0192', '--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 06:01:25 INFO - mozversion application_buildid: 20170406043437 06:01:25 INFO - mozversion application_changeset: db49c7b778064599f028d5b3a96cda1deb257e5d 06:01:25 INFO - mozversion application_display_name: Firefox 06:01:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:01:25 INFO - mozversion application_name: Firefox 06:01:25 INFO - mozversion application_remotingname: firefox 06:01:25 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 06:01:25 INFO - mozversion application_vendor: Mozilla 06:01:25 INFO - mozversion application_version: 53.0 06:01:25 INFO - mozversion platform_buildid: 20170406043437 06:01:25 INFO - mozversion platform_changeset: db49c7b778064599f028d5b3a96cda1deb257e5d 06:01:25 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 06:01:25 INFO - mozversion platform_version: 53.0 06:01:25 INFO - using testdate: 1491483685 06:01:25 INFO - actual date: 1491483685 06:01:25 INFO - starting webserver on 'localhost:49242' 06:01:25 INFO - SUITE-START | Running 2 tests 06:01:25 INFO - TEST-START | dromaeo_css 06:01:25 INFO - operating with platform_type : mac_ 06:01:25 INFO - Initialising browser for dromaeo_css test... 06:01:25 INFO - TEST-INFO | started process 1636 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/tmpnDn_Tm/profile http://localhost:49242/getInfo.html) 06:01:28 INFO - PROCESS | 1636 | __metrics Screen width/height:1600/1200 06:01:28 INFO - PROCESS | 1636 | colorDepth:24 06:01:28 INFO - PROCESS | 1636 | Browser inner width/height: 1024/689 06:01:28 INFO - PROCESS | 1636 | __metrics 06:01:28 INFO - PROCESS | 1636 | 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" 06:01:28 INFO - PROCESS | 1636 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:01:28 INFO - TEST-INFO | 1636: exit 0 06:01:28 INFO - Browser initialized. 06:01:28 INFO - Running cycle 1/1 for dromaeo_css test... 06:01:28 INFO - TEST-INFO | started process 1639 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/tmpnDn_Tm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:01:40 INFO - PROCESS | 1639 | RSS: Main: 163659776 06:01:40 INFO - PROCESS | 1639 | 06:04:43 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49242/tests/dromaeo/cssquery-ext.html) 06:04:44 INFO - PROCESS | 1639 | RSS: Main: 318251008 06:04:44 INFO - PROCESS | 1639 | 06:07:47 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-ext.html (next: http://localhost:49242/tests/dromaeo/cssquery-jquery.html) 06:07:48 INFO - PROCESS | 1639 | RSS: Main: 304312320 06:07:48 INFO - PROCESS | 1639 | 06:10:50 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49242/tests/dromaeo/cssquery-mootools.html) 06:10:51 INFO - PROCESS | 1639 | RSS: Main: 286580736 06:10:51 INFO - PROCESS | 1639 | 06:13:53 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49242/tests/dromaeo/cssquery-prototype.html) 06:13:54 INFO - PROCESS | 1639 | RSS: Main: 274612224 06:13:54 INFO - PROCESS | 1639 | 06:16:57 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49242/tests/dromaeo/cssquery-yui.html) 06:16:58 INFO - PROCESS | 1639 | RSS: Main: 276217856 06:16:58 INFO - PROCESS | 1639 | 06:20:01 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-yui.html (next: http://localhost:49242/tests/dromaeo/cssquery-dojo.html) 06:20:01 INFO - PROCESS | 1639 | RSS: Main: 348078080 06:20:01 INFO - PROCESS | 1639 | 06:20:01 INFO - PROCESS | 1639 | __start_tp_report 06:20:01 INFO - PROCESS | 1639 | _x_x_mozilla_page_load 06:20:01 INFO - PROCESS | 1639 | _x_x_mozilla_page_load_details 06:20:01 INFO - PROCESS | 1639 | |i|pagename|runs| 06:20:01 INFO - PROCESS | 1639 | |0;dojo.html;3452.27502224533;3457.8098204598746;3463.1861512544565;3470.548828652275;3519.366514027474;5694.202811606373;5695.430456954303;5704.8003319883765;5737.225474560943;5771.50942169915;5653.010723123458;5695.629784064044;5696.060150075243;5698.487136157745;5717.285339332583;4899.975500122495;5126.666766660155;5140.408852981917;5157.53582177603;5186.481351864821;5141.048905952411;5151.381834179903;5160.483951604829;5185.092608793465;5220.060389129955;5220.530152286294;5269.420363759983;5287.444818294081;5294.1529355303155;5311.362636483627;4343.457067866517;5284.920726189111;5288.550473209782;5291.94161167768;5324.068288049576;5103.030424219386;5141.820036298749;5210;5238.240455134022;5247.39654939683;5650.491455769001;5727.742251598646;5733.19735237063;5738.885222295531;5740.08158694611;6190.0405437157315;6210.223722034746;6220.813375598739;6255.374462553754;6323.399277068671;6225.595336303171;6257.468115210213;6287.96856015717;6289;6296.055591661242;5928.288605367384;5937.139114828369;5938.881222375571;5945.554083443759;5990.850228744316;6168.722407491674;6191.81424557264;6245.5628106032145;6253.593516421418;6262.530310226751;6194.101855230966;6228.564000520011;6239.06414037898;6246.500279977591;6255.46828519581;6256.405641464054;6286.088517165077;6289.182406287154;6306.779262725874;6311.652859092794;6143.27988163315;6201.162843016135;6207.937920620826;6280.403361680633;6282.654454004982;6267.2165979252595;6307.810765677037;6311.842203944938;6314.400131987454;6314.400131987454;4336.739795612273;4970.502949705073;5009.198528235464;5035.395752509649;5048.747562621854;4414.690971632019;4424.048829501608;4480.305552639281;4482.282834746425;4503.572160644733;5887.735051922674;5918.171455996164;5949.762009519657;5985.880282394415;6046.727897244635;6204.255489341218;6243.687815609202;6246.656433896179;6246.812595622047;6248.687565621701;5917.349091599921;6017.18767966319;6038.460192650934;6039.758409663652;6057.121717350959;4748.0978614063215;5312.362516498045;5394.217838413408;5472.616916815864;5503.669779813224;6139.185504090456;6459.160309159779;6464.09502669636;6470.09418681385;6477.611343319416;6236.594621349598;6241.095041219089;6243.188385510036;6256.249250090018;6260.467860231931;4775.785089670903;5436.53789427903;6331.5251356147555;6371.840703982438;6458.483321334376;6202.72087756043;6262.624242545462;6294.874102517832;6304.873902522016;6307.148534947723;6179.5056395489155;6198.318184999736;6208.348123447154;6268.561200715906;6295.496360291258;4411.889702757457;6105.511559075175;6134.8159555213415;6140.723667435065;6157;6111.135969295072;6112.442689633966;6146.815595532141;6199.628022318675;6211.565190436626;6093.025115981422;6097.4817140543555;6100.54245931548;6104.542159338156;6128.63228206309;6031.155638210566;6179.532410743088;6193.102000209854;6225.879341718534;6230.470410015199;5924.052151655715;5950.851228719317;5994.07091900756;6027.909581356195;6089.512838972783 06:20:01 INFO - PROCESS | 1639 | |1;ext.html;485.5144855144855;511.5702809639902;521.0672895517025;528.9259503669487;535.6625326044591;32266.838665806667;41612.583874161246;43127.706168814904;43143.568564314344;45004.774976125154;38473.26870290837;41732.79133604335;44182.89542761433;44251;44264;9560.665376711817;9789.902100979007;9804.705858824247;9808.11726944575;9812.116909478145;8945;9175.03662115475;11801.409929503534;11984.940075299612;12017.819732704016;11974.161808673396;12031.157818952677;12035.699107522338;12037.578684746035;12047.397630118503;11879.287242765418;11941.701457463547;11959.760804783855;11962.82055769164;11977.98187154093;11767.764644707058;11841.703957401047;11855.46650400734;11855.58505452305;11878.227915185485;41298;41497.377539336936;41532.79233603843;41578.1684366314;41595.792021040004;4022.1754540319166;4042.4946881639794;4062.2078694654556;4081.4898137732785;4093.283675356801;30141.698583014328;30379.544306835414;31073.844630776926;31329;31585.739955722755;3201.631812341564;3233.9029829105166;3402.2515046689687;3422.743294252941;3427.971608517435;483243;484194;484713;485230;486347;63908.68045659835;64070;64118;64254.67872660607;64309;66882.33117668859;66939;67004.6649766748;67072;67163.32836671668;17639.206235719423;17848.821511784718;17884.374046908295;17918.731219031724;17925.282988680567;12502.874971250352;13748.862511374959;13836.169829810244;13840.861591384159;13887.652808679864;15096.849031509764;15224.695506089816;19470.117679813327;22522.32433027012;22524;8110.107888132301;8811.427257228388;8987.325950553735;9128.90871091294;9153.976311336744;894.9418287811271;910.6676063237003;914.3279689428265;934.8317302885546;948.6395169835419;29968.700312996592;30809;30899.918502852743;31370.52944205839;31453;791.8178818871577;1034.5965073621294;1073.940933248679;1142.874283828778;1232.6733415644683;15312.081275123528;15843.683126337408;15859.286332115082;15863.603409914844;16112.872098953196;645814;651411;651721;651779;652150;63764.362356375845;64556.708865822424;64604.03093953594;64616.67691661606;64617.67691161608;1347.595721283611;1390.0408717984558;1455.8107446032159;1461.283970854295;1511.2670354878096;31361.686383135875;32091;32209.35581288408;32262.838685806422;32891.50662740013;46056.309155362025;50926.981460371324;53441.198382023525;53441.46558534365;53555;469853;471359;473049;473152;805104.9744751473;36811.815940920125;44206.77896610496;44942.3258651127;45097.098058039315;45714;49281.75359123181;49667.50997469937;49842.501574983784;50241.24638130504;50431;32723.67276327206;32860.83569582232;32863.014109576754;32944.84693035732;33073;27402.862985684944;32452.188695281864;33115.83442082774;33781.324373512885;33833.81581644631;38645.22709545737;39299;39350.40974385444;39526.60473395229;39551.60448395479;32859;33128.66871331256;33320;33652.1586960328;33794.15514612154;21338.466538336666;25796.484070318864;25936.481270374865;26190.54692373997;26211.34471638148 06:20:01 INFO - PROCESS | 1639 | |2;jquery.html;368.793475653634;399.13387948152507;400.31745873286053;402.3160626934212;414.7801665117488;20521.692174617376;21771.891140544274;21870.797106159174;21918.561628767435;22458.43853903653;22119.89400529975;22598.88700556495;22731.659025114594;22872.19947301845;23025.194118205865;5122.564582010534;6097.939020609781;6107.847303817396;6158.84602884927;6175.413335733098;5922.644641321513;6015.75936962521;6066.090086487018;6129.417705317987;6143.385661433866;6104.908426373586;6106.419890110433;6107.328193898667;6110.694465276741;6111.663858487781;6091.147239386467;7513.384622306203;7823.804404889895;7894.80262993424;7904.130545639975;7559;7718.382529397635;7739.187385324516;7942.245486678757;7976.641051152654;31096.844515777502;31221.37557248842;31238;31268.061958141294;31336;2936.0898121582377;2996.6853480384466;3061.3418115105137;3352.7820691655206;3497.4404095344876;17846;17861.285548578173;17934.551636209068;18033.368832090815;18054.819451805575;1920.1359388275193;1986.433866348084;2059.5468996820678;2111.5143516991025;2129.073852874005;171401;173753.26246737497;174745;175964;177894;22526.53577517456;22566.323010309716;23220.7677923222;25030.121536023227;25039.70302140003;43863;44738.55261447344;45068.549314507094;45131;45351.31973020407;7488;8636.136386361313;8786.341024423195;9100.726978190665;9195.264378849675;7225.5664660120565;8903.688370907117;8939.642414303486;9090.36367454272;9131.954340228256;4991.529193049464;5003.774830132653;5011.273365362002;5019.573336266385;5129.384473863086;2047.8156965873143;2084.520560271146;2097.968530472044;2099.769025407204;2100.327895073592;1037.8183817832;1066.168388656849;1068.9251752377259;1073.457903758597;1115.219346457483;21852.781472185074;21893.781062189173;21914.45213869666;21931.561368772855;21967.890160549414;1075.714935542082;1095.7260684828793;1099.3568762273999;1108.501174471475;1112.896625378036;10852;11550.942245288888;11573.305601663928;11582.826257606142;11605.6518304451;332757;731684;737983.3100834461;748100;754435;147252;163939;165383.5192472114;166124.33875661332;168705;1047.0576481166859;1050.8266136087614;1092.4919912240687;1102.525913857049;1105.7788442311569;20124.39626811198;20223.98880055962;20589;20683.069261883553;20756.06597703077;51907.70230744262;57335;63235;63617.36382636114;64061;95666;95761;98097.50951245199;98340;99411.50294248482;7848.529088254723;7978.920210797818;8043;8195.918040819515;8224.547649879074;12242.954970322462;12997;13169.53906613264;13323.333833308103;13445.46218151263;11303.321800691985;11314;11351.602693905674;11664.88335116638;11789;8977.730668079968;10619.522121504706;10805.405702686428;10916.07213386871;11022.559097636005;11240.494177762184;11998.460069297078;12006.699832503908;12024.519019239133;12332;7602.46782725204;7761.456698031084;7950.602469876368;7958.243966823143;8174.305184059422;9790;10786.73033174177;11907.04743620491;11946.820797687868;11949.22330048544 06:20:01 INFO - PROCESS | 1639 | |3;mootools.html;1315.45408655408;1393.8606139386063;1472.9042612230205;1497.6181073826174;1503.6015455904187;7706.96146519268;8011.198880111986;8323.667053317875;8517.403781735282;8528.744137675863;8404.201600847924;8475.703350382737;8479.872801907977;8485.27875130613;8491.5329656869;2129.40376694525;2357.422431504284;2387.4747555537842;2396.9573235642465;2399.4361325088676;2220.7779222077825;2360.185735921113;2433.9513209735796;2437.9268621941283;2451.5464639041747;2379.9885048854253;2396.9161079362225;2399.7720216579396;2416.118116887341;2417.16607770319;2193.8701568692136;2375.465520257937;2398.640203969401;2400.483895962359;2401.051584624081;2162.9891850540803;2335.1126571902737;2337.9298621041225;2338.0764597983703;2340.3447034830274;8467.110953349871;8579.828403431959;8593.26957208638;8618.525981071038;8645.740627781177;5186.766595503212;5347.893042139174;5349.331333583302;5355.732213389315;5359.464053594648;3418.1112910643164;3457.757956943015;3639.909002274938;3645.5989841117457;3655.7075433965483;1255.5040758900275;1280.7758642237663;1282.1281528560576;1288.8388951381078;1312.849022362431;10768.353898766178;10885.891141088647;10979.451027448675;11008.669739907815;11015.008649221609;4657.5750443132765;4746;4771.260454629538;4839.588634965997;4853.9029219416125;9659.565319560637;9670.226381889432;9673.984231655575;9676.90323096774;9683.080107389787;5281.894362112736;5374.5700343972385;5382.757775900016;5384.246205531229;5431.185322201702;4806.927896081562;4835.202191638411;4897.902041959141;4903.803847846046;4910.263460480885;3384.8999075300626;3939.428782826474;3949.881503554898;3962.920741585152;3983.3029219886403;1289.6324547503916;1296.9740605187844;1298.4222021200476;1304.1569378754218;1311.888489478386;794.559019744036;911.8267529169569;941.9952900235455;967.4292167621137;969.4522594733953;5589.580781441408;5662.462066103713;5858.707064646751;5863.120531920161;5916.526677865761;963.5808423335872;997.4065431068502;1000.859020716384;1019.0879163148941;1041.239894876729;3044.9086527404215;3769.7172712046704;3907.5701672815967;3976.204759048202;3994.420808982681;9308.767280818034;10041.995800420045;10172.491375431198;10185.796284074277;10220.335678180894;10069.144122749502;10174.949125254327;10184.388936663823;10195.28632995698;10209;7800.45396822217;8082.595870206466;8082.7171049013;8097.716579919675;8113;5184.403793563789;5592.217089607377;5627.21219029328;5649.209110724584;5744.569157313302;9224.538773061186;9298.302627303116;9399.154076133182;9420.57607407682;9422.858657120285;7828;8736.039035706195;9007.459552426875;9385.624575017197;9455.14903658674;6501;6831.077804496329;7058.894116588152;7269.927300726925;7345.853082938418;7991.84016319682;8087.959560202161;8165.305948994402;8223.876641850497;8240.670373185005;7052.188998265266;7095.751648692271;7097.9290207097265;7159.212486626571;7207.639618019183;6033.577649564489;6959.478039147186;6994.370506654425;7011;7112.822179445555;6436.388543088399;6536.346365363425;6541.182352205974;6544.312847151171;6553.082568440327;4898.755062246944;4920.507949205194;4927.187014142626;5001.924971125509;5185.040767458032;5122.974385128051;5123.231515272739;5150.433452320317;5171.870703232449;5223.399309079505 06:20:01 INFO - PROCESS | 1639 | |4;prototype.html;322.80309011502993;366.34972923061565;368.09815950920233;377.38674653687747;378.6629899389542;4581.358609794632;5291.629585928987;5292.338457692788;5338.759755810988;5357.7589008494615;4268.582017611772;5081.542661160494;5212.244224587442;5212.582993360532;5279.815206467774;3464.5842498900106;3502.758234729775;3630.219502806896;3635.9636403636023;4185.455890734201;3672.7061835053264;4142.461480007595;4168.228877657643;4178.185253875496;4203.894902627429;4162.771047592381;4165.56261592533;4176.081262122329;4182.581741825824;4182.64447521961;3852.248811481762;4046.352583586612;4187.664986801049;4198.937015944779;4205.831766729327;3256.462683657194;3558.626344233844;3698.5007024051947;3731.738778285521;3762.529683789526;4370.612775099292;4799.904001919977;5159.7678104485385;5191.195364718475;5257.738142845727;3966.960330396717;4863.2461968394955;4886.877828054292;4894.2903279024695;4958.231474121517;5405.621606487547;5651.4913657770585;5654.745536450829;5666.86662667464;5669.829905102853;3356.5636467259346;4129.359949207877;4138.8344466221315;4150.730202536825;4157.563455837154;5653.349864765522;5803.44867237616;5949.524038076944;5958.255218097738;5958.433948774859;3626.9378296308305;3823.369144091194;4215.178040282116;4276.230278549829;4277.978610106992;3845.769253844778;4336.915771057235;4340.891477713019;4365.9126817463475;4371.75955322454;3860.9344000959354;4761.880952976203;4849.854504364875;4951.752412379366;4979.352684151109;4442.001099505235;5027.673201241908;5712.200656793097;5768.3654797972185;5782.913256301159;1172.6775136837439;1215.9299816161897;1260.7352455984162;1276.6680663027494;1432.7391895132216;836.8075342671219;922.1654402765374;964.9517524123906;1009.3893194617151;1009.9798004040025;4279.576338928844;4539.614132798749;4839.879003024953;4933.087378834927;5050.712068422528;5367.409584945653;5605.887882242332;5661.66030038199;5681.375048744635;5703.315602127688;4189.790510474464;4360.909772556861;5032.421271553745;5081.0854046272025;5182.611304152204;2527.696676398844;2695.6899956505254;2745.574435962429;2798.594203840432;2817.4505971335802;4941.777620007108;5166.767495462638;5713.857153571111;5768.567357448208;5772.971135144381;5066.949330506722;5459;5534.4742249486235;5682.873490908041;6010.579259451796;5229.790808367698;5712.11462223356;6197.442230199214;6202.255729312331;6208.192934918432;4836.517983762932;5651.915221271602;5854.180414741854;5886.911696324644;5889.3780325100615;4789.832355867528;5657.397597105378;5768.221290125779;5775.94224057754;5814.796482123105;5818.970905145447;5988.730507127103;6021.789237376671;6031.703183815501;6131.356207598138;3905.6094390560716;3936.547297060875;3953.2686453006286;3979.6020397959974;3980.422838688432;4848.515148485123;5239.397469291081;5793.623414478046;5888.028475301528;5888.793892213752;5184.507471790174;5319.813806516908;5379.35447746273;5397.379301380392;5660.745266462936;5653.010723123519;5655.575831812548;5655.915161272502;5662.886742265214;5665.470323012681;4228.450301460791;4742.644301677319;5249.022708961152;5559.6664200148125;5569.832905012856;5461.754221059982;5671.517920976598;5679.3184817820475;5691.4877661010705;5696.177223288508;4889.46215916256;5500.9174862377895;5564.796914884596;5568.498835104698;5571.777128914798 06:20:01 INFO - PROCESS | 1639 | |5;yui.html;754.6754895394981;754.9018627578414;787.5070047458703;788.0267869181563;801.9182755296271;14989.62525936852;15385.307661155246;15980.920095399506;16121.113338766363;16180.948238364497;14344;14500.057496262736;14657.706845863077;14722.116672999628;14800.925995370035;881.0528681667201;894.8165626046645;896.9775755606097;898.5731777405713;900.0684291758032;705.5942832871119;730.422965856975;849.800296930221;879.5690111845214;881.088073843572;940.2806852757645;944.6079876851098;945.5697657565826;946.7159852044393;948.5352177433043;939.0984654731466;940.1679513630486;941.0824446165003;941.3645789092369;942.3356533643764;703.8170075780283;704.3977399323607;705.5272967112047;706.0856191232366;706.9717211311541;14366;14786.852131478656;15558.61103472411;15663.373465061384;15705.528834134995;14139.575812725634;14480;14938;15019.849801501954;15329.846701532953;11670.241434306743;11702.707432314175;11710.355930423822;11929.343886086263;11950;3690.612485688991;3856.0745421099014;3919.2871491934648;3923.234969181011;4053.6959728020515;102175.48912255392;109501.45249273782;109772;109837.45081274543;110138;10891.455427228608;11056.723581910517;11221.775564488828;11370.65888023344;11415;20667.4833129173;20761.273355432488;20959.26642567503;20965.37103886886;20989.79010209909;7396.852062958818;7807.258310460497;7821.491603045783;7928.6828526859435;7936.444448888637;4292.055747735493;4382.5298195840705;4495.213337665896;4634.397528321297;4660.1145782301255;3662.157703728104;3756.73702840804;3759.49246851677;3763.6989040876665;3767.56672982605;619.789271647642;621.2389822467532;634.7841733810527;645.9128017717642;648.1573953859963;691.4986634689809;711.5161690050712;726.3680597879878;737.2222305467676;770.7263921307967;10397;10691.251612387057;10701.732456688645;10746.73133171677;11041.723956900982;572.6993328502487;619.1950464396267;626.8622450252776;650.7949995751324;653.8692261547709;4064.5935406459707;4826.7827947742435;5183.429822719498;5185.662931909414;5192.688438693691;90163.54918225367;108680.45659771809;109877.58358473096;110131;114435;93396.06603934009;95005;96362.55456168164;97727.51136244273;99754.50122749485;60626;84882.57558712167;86091.56954215189;86128.56935715406;87617;9725.9027409725;9977.650782222587;10022.649207277711;10028.849567256642;10045.648402305884;40882.59117408788;50223;51104.48895510997;51198;52346.476535234164;69383.3061669397;71057;71681.6415917917;71809.6409517949;73662;11509.827352589886;11601.18791684574;12136.939315303367;12432.627021189379;12825.615231543068;14965.700685986001;14974.277958034965;15102.773458398353;15386.461473848361;15636.765448518508;13783.51757688476;13784.793228101787;13894.861051389356;14113.858861411254;14151.150930943764;12356.38218089074;14250.358733857209;14439.85560144385;14771.261436927896;14880.181590012653;13129.934350328187;13244.271565064015;13978.091424057404;14287.928560357132;14766.926165369105;9845.60617575289;10098.677304220217;10353.84469232947;10413.219008574539;10872.945635271773;9714.447778125892;10612.890706630407;11335.149863760085;11572.6528204154;11572.826407603725 06:20:01 INFO - PROCESS | 1639 | __end_tp_report 06:20:01 INFO - PROCESS | 1639 | __start_cc_report 06:20:01 INFO - PROCESS | 1639 | _x_x_mozilla_cycle_collect,1607 06:20:01 INFO - PROCESS | 1639 | __end_cc_report 06:20:01 INFO - PROCESS | 1639 | __startTimestamp1491484801459__endTimestamp 06:20:01 INFO - PROCESS | 1639 | 06:20:01 INFO - PROCESS | 1639 | ------- Summary: start ------- 06:20:01 INFO - PROCESS | 1639 | Number of tests: 6 06:20:01 INFO - PROCESS | 1639 | 06:20:01 INFO - PROCESS | 1639 | [#0] dojo.html Cycles:165 Average:5765.68 Median:6057.12 stddev:669.67 (11.1%) stddev-sans-first:646.66 06:20:01 INFO - PROCESS | 1639 | Values: 3452.3 3457.8 3463.2 3470.5 3519.4 5694.2 5695.4 5704.8 5737.2 5771.5 5653.0 5695.6 5696.1 5698.5 5717.3 4900.0 5126.7 5140.4 5157.5 5186.5 5141.0 5151.4 5160.5 5185.1 5220.1 5220.5 5269.4 5287.4 5294.2 5311.4 4343.5 5284.9 5288.6 5291.9 5324.1 5103.0 5141.8 5210.0 5238.2 5247.4 5650.5 5727.7 5733.2 5738.9 5740.1 6190.0 6210.2 6220.8 6255.4 6323.4 6225.6 6257.5 6288.0 6289.0 6296.1 5928.3 5937.1 5938.9 5945.6 5990.9 6168.7 6191.8 6245.6 6253.6 6262.5 6194.1 6228.6 6239.1 6246.5 6255.5 6256.4 6286.1 6289.2 6306.8 6311.7 6143.3 6201.2 6207.9 6280.4 6282.7 6267.2 6307.8 6311.8 6314.4 6314.4 4336.7 4970.5 5009.2 5035.4 5048.7 4414.7 4424.0 4480.3 4482.3 4503.6 5887.7 5918.2 5949.8 5985.9 6046.7 6204.3 6243.7 6246.7 6246.8 6248.7 5917.3 6017.2 6038.5 6039.8 6057.1 4748.1 5312.4 5394.2 5472.6 5503.7 6139.2 6459.2 6464.1 6470.1 6477.6 6236.6 6241.1 6243.2 6256.2 6260.5 4775.8 5436.5 6331.5 6371.8 6458.5 6202.7 6262.6 6294.9 6304.9 6307.1 6179.5 6198.3 6208.3 6268.6 6295.5 4411.9 6105.5 6134.8 6140.7 6157.0 6111.1 6112.4 6146.8 6199.6 6211.6 6093.0 6097.5 6100.5 6104.5 6128.6 6031.2 6179.5 6193.1 6225.9 6230.5 5924.1 5950.9 5994.1 6027.9 6089.5 06:20:01 INFO - PROCESS | 1639 | 06:20:01 INFO - PROCESS | 1639 | [#1] ext.html Cycles:180 Average:70517.32 Median:38972.11 stddev:151550.45 (388.9%) stddev-sans-first:151884.37 06:20:01 INFO - PROCESS | 1639 | Values: 485.5 511.6 521.1 528.9 535.7 32266.8 41612.6 43127.7 43143.6 45004.8 38473.3 41732.8 44182.9 44251.0 44264.0 9560.7 9789.9 9804.7 9808.1 9812.1 8945.0 9175.0 11801.4 11984.9 12017.8 11974.2 12031.2 12035.7 12037.6 12047.4 11879.3 11941.7 11959.8 11962.8 11978.0 11767.8 11841.7 11855.5 11855.6 11878.2 41298.0 41497.4 41532.8 41578.2 41595.8 4022.2 4042.5 4062.2 4081.5 4093.3 30141.7 30379.5 31073.8 31329.0 31585.7 3201.6 3233.9 3402.3 3422.7 3428.0 483243.0 484194.0 484713.0 485230.0 486347.0 63908.7 64070.0 64118.0 64254.7 64309.0 66882.3 66939.0 67004.7 67072.0 67163.3 17639.2 17848.8 17884.4 17918.7 17925.3 12502.9 13748.9 13836.2 13840.9 13887.7 15096.8 15224.7 19470.1 22522.3 22524.0 8110.1 8811.4 8987.3 9128.9 9154.0 894.9 910.7 914.3 934.8 948.6 29968.7 30809.0 30899.9 31370.5 31453.0 791.8 1034.6 1073.9 1142.9 1232.7 15312.1 15843.7 15859.3 15863.6 16112.9 645814.0 651411.0 651721.0 651779.0 652150.0 63764.4 64556.7 64604.0 64616.7 64617.7 1347.6 1390.0 1455.8 1461.3 1511.3 31361.7 32091.0 32209.4 32262.8 32891.5 46056.3 50927.0 53441.2 53441.5 53555.0 469853.0 471359.0 473049.0 473152.0 805105.0 36811.8 44206.8 44942.3 45097.1 45714.0 49281.8 49667.5 49842.5 50241.2 50431.0 32723.7 32860.8 32863.0 32944.8 33073.0 27402.9 32452.2 33115.8 33781.3 33833.8 38645.2 39299.0 39350.4 39526.6 39551.6 32859.0 33128.7 33320.0 33652.2 33794.2 21338.5 25796.5 25936.5 26190.5 26211.3 06:20:01 INFO - PROCESS | 1639 | 06:20:01 INFO - PROCESS | 1639 | [#2] jquery.html Cycles:180 Average:42003.60 Median:24125.44 stddev:115499.10 (478.7%) stddev-sans-first:115780.80 06:20:01 INFO - PROCESS | 1639 | Values: 368.8 399.1 400.3 402.3 414.8 20521.7 21771.9 21870.8 21918.6 22458.4 22119.9 22598.9 22731.7 22872.2 23025.2 5122.6 6097.9 6107.8 6158.8 6175.4 5922.6 6015.8 6066.1 6129.4 6143.4 6104.9 6106.4 6107.3 6110.7 6111.7 6091.1 7513.4 7823.8 7894.8 7904.1 7559.0 7718.4 7739.2 7942.2 7976.6 31096.8 31221.4 31238.0 31268.1 31336.0 2936.1 2996.7 3061.3 3352.8 3497.4 17846.0 17861.3 17934.6 18033.4 18054.8 1920.1 1986.4 2059.5 2111.5 2129.1 171401.0 173753.3 174745.0 175964.0 177894.0 22526.5 22566.3 23220.8 25030.1 25039.7 43863.0 44738.6 45068.5 45131.0 45351.3 7488.0 8636.1 8786.3 9100.7 9195.3 7225.6 8903.7 8939.6 9090.4 9132.0 4991.5 5003.8 5011.3 5019.6 5129.4 2047.8 2084.5 2098.0 2099.8 2100.3 1037.8 1066.2 1068.9 1073.5 1115.2 21852.8 21893.8 21914.5 21931.6 21967.9 1075.7 1095.7 1099.4 1108.5 1112.9 10852.0 11550.9 11573.3 11582.8 11605.7 332757.0 731684.0 737983.3 748100.0 754435.0 147252.0 163939.0 165383.5 166124.3 168705.0 1047.1 1050.8 1092.5 1102.5 1105.8 20124.4 20224.0 20589.0 20683.1 20756.1 51907.7 57335.0 63235.0 63617.4 64061.0 95666.0 95761.0 98097.5 98340.0 99411.5 7848.5 7978.9 8043.0 8195.9 8224.5 12243.0 12997.0 13169.5 13323.3 13445.5 11303.3 11314.0 11351.6 11664.9 11789.0 8977.7 10619.5 10805.4 10916.1 11022.6 11240.5 11998.5 12006.7 12024.5 12332.0 7602.5 7761.5 7950.6 7958.2 8174.3 9790.0 10786.7 11907.0 11946.8 11949.2 06:20:01 INFO - PROCESS | 1639 | 06:20:01 INFO - PROCESS | 1639 | [#3] mootools.html Cycles:180 Average:5516.22 Median:5184.72 stddev:2974.15 (57.4%) stddev-sans-first:2965.73 06:20:01 INFO - PROCESS | 1639 | Values: 1315.5 1393.9 1472.9 1497.6 1503.6 7707.0 8011.2 8323.7 8517.4 8528.7 8404.2 8475.7 8479.9 8485.3 8491.5 2129.4 2357.4 2387.5 2397.0 2399.4 2220.8 2360.2 2434.0 2437.9 2451.5 2380.0 2396.9 2399.8 2416.1 2417.2 2193.9 2375.5 2398.6 2400.5 2401.1 2163.0 2335.1 2337.9 2338.1 2340.3 8467.1 8579.8 8593.3 8618.5 8645.7 5186.8 5347.9 5349.3 5355.7 5359.5 3418.1 3457.8 3639.9 3645.6 3655.7 1255.5 1280.8 1282.1 1288.8 1312.8 10768.4 10885.9 10979.5 11008.7 11015.0 4657.6 4746.0 4771.3 4839.6 4853.9 9659.6 9670.2 9674.0 9676.9 9683.1 5281.9 5374.6 5382.8 5384.2 5431.2 4806.9 4835.2 4897.9 4903.8 4910.3 3384.9 3939.4 3949.9 3962.9 3983.3 1289.6 1297.0 1298.4 1304.2 1311.9 794.6 911.8 942.0 967.4 969.5 5589.6 5662.5 5858.7 5863.1 5916.5 963.6 997.4 1000.9 1019.1 1041.2 3044.9 3769.7 3907.6 3976.2 3994.4 9308.8 10042.0 10172.5 10185.8 10220.3 10069.1 10174.9 10184.4 10195.3 10209.0 7800.5 8082.6 8082.7 8097.7 8113.0 5184.4 5592.2 5627.2 5649.2 5744.6 9224.5 9298.3 9399.2 9420.6 9422.9 7828.0 8736.0 9007.5 9385.6 9455.1 6501.0 6831.1 7058.9 7269.9 7345.9 7991.8 8088.0 8165.3 8223.9 8240.7 7052.2 7095.8 7097.9 7159.2 7207.6 6033.6 6959.5 6994.4 7011.0 7112.8 6436.4 6536.3 6541.2 6544.3 6553.1 4898.8 4920.5 4927.2 5001.9 5185.0 5123.0 5123.2 5150.4 5171.9 5223.4 06:20:01 INFO - PROCESS | 1639 | 06:20:01 INFO - PROCESS | 1639 | [#4] prototype.html Cycles:180 Average:4567.94 Median:5030.05 stddev:1391.08 (27.7%) stddev-sans-first:1358.00 06:20:01 INFO - PROCESS | 1639 | Values: 322.8 366.3 368.1 377.4 378.7 4581.4 5291.6 5292.3 5338.8 5357.8 4268.6 5081.5 5212.2 5212.6 5279.8 3464.6 3502.8 3630.2 3636.0 4185.5 3672.7 4142.5 4168.2 4178.2 4203.9 4162.8 4165.6 4176.1 4182.6 4182.6 3852.2 4046.4 4187.7 4198.9 4205.8 3256.5 3558.6 3698.5 3731.7 3762.5 4370.6 4799.9 5159.8 5191.2 5257.7 3967.0 4863.2 4886.9 4894.3 4958.2 5405.6 5651.5 5654.7 5666.9 5669.8 3356.6 4129.4 4138.8 4150.7 4157.6 5653.3 5803.4 5949.5 5958.3 5958.4 3626.9 3823.4 4215.2 4276.2 4278.0 3845.8 4336.9 4340.9 4365.9 4371.8 3860.9 4761.9 4849.9 4951.8 4979.4 4442.0 5027.7 5712.2 5768.4 5782.9 1172.7 1215.9 1260.7 1276.7 1432.7 836.8 922.2 965.0 1009.4 1010.0 4279.6 4539.6 4839.9 4933.1 5050.7 5367.4 5605.9 5661.7 5681.4 5703.3 4189.8 4360.9 5032.4 5081.1 5182.6 2527.7 2695.7 2745.6 2798.6 2817.5 4941.8 5166.8 5713.9 5768.6 5773.0 5066.9 5459.0 5534.5 5682.9 6010.6 5229.8 5712.1 6197.4 6202.3 6208.2 4836.5 5651.9 5854.2 5886.9 5889.4 4789.8 5657.4 5768.2 5775.9 5814.8 5819.0 5988.7 6021.8 6031.7 6131.4 3905.6 3936.5 3953.3 3979.6 3980.4 4848.5 5239.4 5793.6 5888.0 5888.8 5184.5 5319.8 5379.4 5397.4 5660.7 5653.0 5655.6 5655.9 5662.9 5665.5 4228.5 4742.6 5249.0 5559.7 5569.8 5461.8 5671.5 5679.3 5691.5 5696.2 4889.5 5500.9 5564.8 5568.5 5571.8 06:20:01 INFO - PROCESS | 1639 | 06:20:01 INFO - PROCESS | 1639 | [#5] yui.html Cycles:180 Average:21122.30 Median:3811.82 stddev:30733.56 (806.3%) stddev-sans-first:30781.72 06:20:01 INFO - PROCESS | 1639 | Values: 754.7 754.9 787.5 788.0 801.9 14989.6 15385.3 15980.9 16121.1 16180.9 14344.0 14500.1 14657.7 14722.1 14800.9 881.1 894.8 897.0 898.6 900.1 705.6 730.4 849.8 879.6 881.1 940.3 944.6 945.6 946.7 948.5 939.1 940.2 941.1 941.4 942.3 703.8 704.4 705.5 706.1 707.0 14366.0 14786.9 15558.6 15663.4 15705.5 14139.6 14480.0 14938.0 15019.8 15329.8 11670.2 11702.7 11710.4 11929.3 11950.0 3690.6 3856.1 3919.3 3923.2 4053.7 102175.5 109501.5 109772.0 109837.5 110138.0 10891.5 11056.7 11221.8 11370.7 11415.0 20667.5 20761.3 20959.3 20965.4 20989.8 7396.9 7807.3 7821.5 7928.7 7936.4 4292.1 4382.5 4495.2 4634.4 4660.1 3662.2 3756.7 3759.5 3763.7 3767.6 619.8 621.2 634.8 645.9 648.2 691.5 711.5 726.4 737.2 770.7 10397.0 10691.3 10701.7 10746.7 11041.7 572.7 619.2 626.9 650.8 653.9 4064.6 4826.8 5183.4 5185.7 5192.7 90163.5 108680.5 109877.6 110131.0 114435.0 93396.1 95005.0 96362.6 97727.5 99754.5 60626.0 84882.6 86091.6 86128.6 87617.0 9725.9 9977.7 10022.6 10028.8 10045.6 40882.6 50223.0 51104.5 51198.0 52346.5 69383.3 71057.0 71681.6 71809.6 73662.0 11509.8 11601.2 12136.9 12432.6 12825.6 14965.7 14974.3 15102.8 15386.5 15636.8 13783.5 13784.8 13894.9 14113.9 14151.2 12356.4 14250.4 14439.9 14771.3 14880.2 13129.9 13244.3 13978.1 14287.9 14766.9 9845.6 10098.7 10353.8 10413.2 10872.9 9714.4 10612.9 11335.1 11572.7 11572.8 06:20:01 INFO - PROCESS | 1639 | -------- Summary: end -------- 06:20:01 INFO - PROCESS | 1639 | 06:20:02 INFO - TEST-INFO | 1639: exit 0 06:20:02 INFO - TEST-OK | dromaeo_css | took 1116340ms 06:20:02 INFO - TEST-START | kraken 06:20:02 INFO - operating with platform_type : mac_ 06:20:02 INFO - Initialising browser for kraken test... 06:20:02 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/tmpw6ikr5/profile http://localhost:49242/getInfo.html) 06:20:04 INFO - PROCESS | 1649 | __metrics Screen width/height:1600/1200 06:20:04 INFO - PROCESS | 1649 | colorDepth:24 06:20:04 INFO - PROCESS | 1649 | Browser inner width/height: 1024/689 06:20:04 INFO - PROCESS | 1649 | __metrics 06:20:04 INFO - PROCESS | 1649 | 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" 06:20:04 INFO - PROCESS | 1649 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:20:05 INFO - TEST-INFO | 1649: exit 0 06:20:05 INFO - Browser initialized. 06:20:05 INFO - Running cycle 1/1 for kraken test... 06:20:05 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/tmpw6ikr5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:20:17 INFO - PROCESS | 1651 | RSS: Main: 163807232 06:20:17 INFO - PROCESS | 1651 | 06:20:19 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-beat-detection) 06:20:20 INFO - PROCESS | 1651 | RSS: Main: 214654976 06:20:20 INFO - PROCESS | 1651 | 06:20:23 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-dft) 06:20:23 INFO - PROCESS | 1651 | RSS: Main: 228614144 06:20:23 INFO - PROCESS | 1651 | 06:20:27 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-fft) 06:20:27 INFO - PROCESS | 1651 | RSS: Main: 325042176 06:20:27 INFO - PROCESS | 1651 | 06:20:29 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-oscillator) 06:20:30 INFO - PROCESS | 1651 | RSS: Main: 229457920 06:20:30 INFO - PROCESS | 1651 | 06:20:32 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:20:32 INFO - PROCESS | 1651 | RSS: Main: 231153664 06:20:32 INFO - PROCESS | 1651 | 06:20:35 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-darkroom) 06:20:36 INFO - PROCESS | 1651 | RSS: Main: 271544320 06:20:36 INFO - PROCESS | 1651 | 06:20:39 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-desaturate) 06:20:40 INFO - PROCESS | 1651 | RSS: Main: 270368768 06:20:40 INFO - PROCESS | 1651 | 06:20:43 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49242/tests/kraken/driver.html?testName=json-parse-financial) 06:20:43 INFO - PROCESS | 1651 | RSS: Main: 267374592 06:20:43 INFO - PROCESS | 1651 | 06:20:45 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49242/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:20:45 INFO - PROCESS | 1651 | RSS: Main: 244584448 06:20:45 INFO - PROCESS | 1651 | 06:20:47 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:20:48 INFO - PROCESS | 1651 | RSS: Main: 246026240 06:20:48 INFO - PROCESS | 1651 | 06:20:50 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:20:51 INFO - PROCESS | 1651 | RSS: Main: 252649472 06:20:51 INFO - PROCESS | 1651 | 06:20:53 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:20:54 INFO - PROCESS | 1651 | RSS: Main: 267698176 06:20:54 INFO - PROCESS | 1651 | 06:20:57 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:20:58 INFO - PROCESS | 1651 | RSS: Main: 261136384 06:20:58 INFO - PROCESS | 1651 | 06:20:59 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49242/tests/kraken/driver.html?testName=ai-astar) 06:21:00 INFO - PROCESS | 1651 | RSS: Main: 305573888 06:21:00 INFO - PROCESS | 1651 | 06:21:00 INFO - PROCESS | 1651 | __start_tp_report 06:21:00 INFO - PROCESS | 1651 | _x_x_mozilla_page_load 06:21:00 INFO - PROCESS | 1651 | _x_x_mozilla_page_load_details 06:21:00 INFO - PROCESS | 1651 | |i|pagename|runs| 06:21:00 INFO - PROCESS | 1651 | |0;ai-astar;106;115;122;166;163;114;113;113;114;114 06:21:00 INFO - PROCESS | 1651 | |1;audio-beat-detection;144;144;136;165;108;107;106;105;127;105 06:21:00 INFO - PROCESS | 1651 | |2;audio-dft;184;182;185;184;183;184;185;181;185;184 06:21:00 INFO - PROCESS | 1651 | |3;audio-fft;81;60;75;79;77;82;81;81;76;57 06:21:00 INFO - PROCESS | 1651 | |4;audio-oscillator;87;70;85;69;69;69;80;67;68;81 06:21:00 INFO - PROCESS | 1651 | |5;imaging-gaussian-blur;88;86;88;87;88;85;90;86;90;130 06:21:00 INFO - PROCESS | 1651 | |6;imaging-darkroom;95;96;96;96;95;108;163;160;95;100 06:21:00 INFO - PROCESS | 1651 | |7;imaging-desaturate;84;103;131;130;85;87;87;86;86;87 06:21:00 INFO - PROCESS | 1651 | |8;json-parse-financial;54;51;52;51;54;55;55;55;54;54 06:21:00 INFO - PROCESS | 1651 | |9;json-stringify-tinderbox;65;68;72;84;74;72;67;68;69;68 06:21:00 INFO - PROCESS | 1651 | |10;stanford-crypto-aes;83;83;83;84;87;100;98;99;88;81 06:21:00 INFO - PROCESS | 1651 | |11;stanford-crypto-ccm;134;143;148;144;130;133;135;137;176;136 06:21:00 INFO - PROCESS | 1651 | |12;stanford-crypto-pbkdf2;162;163;162;160;203;224;163;162;161;160 06:21:00 INFO - PROCESS | 1651 | |13;stanford-crypto-sha256-iterative;65;64;66;64;64;64;63;64;63;63 06:21:00 INFO - PROCESS | 1651 | __end_tp_report 06:21:00 INFO - PROCESS | 1651 | __start_cc_report 06:21:00 INFO - PROCESS | 1651 | _x_x_mozilla_cycle_collect,2018 06:21:00 INFO - PROCESS | 1651 | __end_cc_report 06:21:00 INFO - PROCESS | 1651 | __startTimestamp1491484860218__endTimestamp 06:21:00 INFO - PROCESS | 1651 | 06:21:00 INFO - PROCESS | 1651 | ------- Summary: start ------- 06:21:00 INFO - PROCESS | 1651 | Number of tests: 14 06:21:00 INFO - PROCESS | 1651 | 06:21:00 INFO - PROCESS | 1651 | [#0] ai-astar Cycles:10 Average:124.00 Median:114.50 stddev:21.69 (18.9%) stddev-sans-first:22.01 06:21:00 INFO - PROCESS | 1651 | Values: 106.0 115.0 122.0 166.0 163.0 114.0 113.0 113.0 114.0 114.0 06:21:00 INFO - PROCESS | 1651 | 06:21:00 INFO - PROCESS | 1651 | [#1] audio-beat-detection Cycles:10 Average:124.70 Median:131.50 stddev:21.65 (16.5%) stddev-sans-first:21.81 06:21:00 INFO - PROCESS | 1651 | Values: 144.0 144.0 136.0 165.0 108.0 107.0 106.0 105.0 127.0 105.0 06:21:00 INFO - PROCESS | 1651 | 06:21:00 INFO - PROCESS | 1651 | [#2] audio-dft Cycles:10 Average:183.70 Median:184.00 stddev:1.34 (0.7%) stddev-sans-first:1.41 06:21:00 INFO - PROCESS | 1651 | Values: 184.0 182.0 185.0 184.0 183.0 184.0 185.0 181.0 185.0 184.0 06:21:00 INFO - PROCESS | 1651 | 06:21:00 INFO - PROCESS | 1651 | [#3] audio-fft Cycles:10 Average:74.90 Median:80.00 stddev:8.99 (11.2%) stddev-sans-first:9.26 06:21:00 INFO - PROCESS | 1651 | Values: 81.0 60.0 75.0 79.0 77.0 82.0 81.0 81.0 76.0 57.0 06:21:00 INFO - PROCESS | 1651 | 06:21:00 INFO - PROCESS | 1651 | [#4] audio-oscillator Cycles:10 Average:74.50 Median:75.00 stddev:7.81 (10.4%) stddev-sans-first:6.85 06:21:00 INFO - PROCESS | 1651 | Values: 87.0 70.0 85.0 69.0 69.0 69.0 80.0 67.0 68.0 81.0 06:21:00 INFO - PROCESS | 1651 | 06:21:00 INFO - PROCESS | 1651 | [#5] imaging-gaussian-blur Cycles:10 Average:91.80 Median:88.00 stddev:13.52 (15.4%) stddev-sans-first:14.27 06:21:00 INFO - PROCESS | 1651 | Values: 88.0 86.0 88.0 87.0 88.0 85.0 90.0 86.0 90.0 130.0 06:21:00 INFO - PROCESS | 1651 | 06:21:00 INFO - PROCESS | 1651 | [#6] imaging-darkroom Cycles:10 Average:110.40 Median:95.00 stddev:27.23 (28.7%) stddev-sans-first:28.31 06:21:00 INFO - PROCESS | 1651 | Values: 95.0 96.0 96.0 96.0 95.0 108.0 163.0 160.0 95.0 100.0 06:21:00 INFO - PROCESS | 1651 | 06:21:00 INFO - PROCESS | 1651 | [#7] imaging-desaturate Cycles:10 Average:96.60 Median:86.00 stddev:18.66 (21.7%) stddev-sans-first:19.23 06:21:00 INFO - PROCESS | 1651 | Values: 84.0 103.0 131.0 130.0 85.0 87.0 87.0 86.0 86.0 87.0 06:21:00 INFO - PROCESS | 1651 | 06:21:00 INFO - PROCESS | 1651 | [#8] json-parse-financial Cycles:10 Average:53.50 Median:54.00 stddev:1.58 (2.9%) stddev-sans-first:1.67 06:21:00 INFO - PROCESS | 1651 | Values: 54.0 51.0 52.0 51.0 54.0 55.0 55.0 55.0 54.0 54.0 06:21:00 INFO - PROCESS | 1651 | 06:21:00 INFO - PROCESS | 1651 | [#9] json-stringify-tinderbox Cycles:10 Average:70.70 Median:70.50 stddev:5.40 (7.7%) stddev-sans-first:5.32 06:21:00 INFO - PROCESS | 1651 | Values: 65.0 68.0 72.0 84.0 74.0 72.0 67.0 68.0 69.0 68.0 06:21:00 INFO - PROCESS | 1651 | 06:21:00 INFO - PROCESS | 1651 | [#10] stanford-crypto-aes Cycles:10 Average:88.60 Median:85.50 stddev:7.47 (8.7%) stddev-sans-first:7.64 06:21:00 INFO - PROCESS | 1651 | Values: 83.0 83.0 83.0 84.0 87.0 100.0 98.0 99.0 88.0 81.0 06:21:00 INFO - PROCESS | 1651 | 06:21:00 INFO - PROCESS | 1651 | [#11] stanford-crypto-ccm Cycles:10 Average:141.60 Median:140.00 stddev:13.31 (9.5%) stddev-sans-first:13.83 06:21:00 INFO - PROCESS | 1651 | Values: 134.0 143.0 148.0 144.0 130.0 133.0 135.0 137.0 176.0 136.0 06:21:00 INFO - PROCESS | 1651 | 06:21:00 INFO - PROCESS | 1651 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.00 Median:162.50 stddev:22.45 (13.8%) stddev-sans-first:23.52 06:21:00 INFO - PROCESS | 1651 | Values: 162.0 163.0 162.0 160.0 203.0 224.0 163.0 162.0 161.0 160.0 06:21:00 INFO - PROCESS | 1651 | 06:21:00 INFO - PROCESS | 1651 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.00 Median:64.00 stddev:0.94 (1.5%) stddev-sans-first:0.93 06:21:00 INFO - PROCESS | 1651 | Values: 65.0 64.0 66.0 64.0 64.0 64.0 63.0 64.0 63.0 63.0 06:21:00 INFO - PROCESS | 1651 | -------- Summary: end -------- 06:21:00 INFO - PROCESS | 1651 | 06:21:01 INFO - TEST-INFO | 1651: exit 0 06:21:01 INFO - TEST-OK | kraken | took 58967ms 06:21:01 INFO - SUITE-END | took 1175s 06:21:01 INFO - Completed test suite (00:19:35) 06:21:01 INFO - javascript benchmark 06:21:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3452.27502224533, 3457.8098204598746, 3463.1861512544565, 3470.548828652275, 3519.366514027474, 5694.202811606373, 5695.430456954303, 5704.8003319883765, 5737.225474560943, 5771.50942169915, 5653.010723123458, 5695.629784064044, 5696.060150075243, 5698.487136157745, 5717.285339332583, 4899.975500122495, 5126.666766660155, 5140.408852981917, 5157.53582177603, 5186.481351864821, 5141.048905952411, 5151.381834179903, 5160.483951604829, 5185.092608793465, 5220.060389129955, 5220.530152286294, 5269.420363759983, 5287.444818294081, 5294.1529355303155, 5311.362636483627, 4343.457067866517, 5284.920726189111, 5288.550473209782, 5291.94161167768, 5324.068288049576, 5103.030424219386, 5141.820036298749, 5210.0, 5238.240455134022, 5247.39654939683, 5650.491455769001, 5727.742251598646, 5733.19735237063, 5738.885222295531, 5740.08158694611, 6190.0405437157315, 6210.223722034746, 6220.813375598739, 6255.374462553754, 6323.399277068671, 6225.595336303171, 6257.468115210213, 6287.96856015717, 6289.0, 6296.055591661242, 5928.288605367384, 5937.139114828369, 5938.881222375571, 5945.554083443759, 5990.850228744316, 6168.722407491674, 6191.81424557264, 6245.5628106032145, 6253.593516421418, 6262.530310226751, 6194.101855230966, 6228.564000520011, 6239.06414037898, 6246.500279977591, 6255.46828519581, 6256.405641464054, 6286.088517165077, 6289.182406287154, 6306.779262725874, 6311.652859092794, 6143.27988163315, 6201.162843016135, 6207.937920620826, 6280.403361680633, 6282.654454004982, 6267.2165979252595, 6307.810765677037, 6311.842203944938, 6314.400131987454, 6314.400131987454, 4336.739795612273, 4970.502949705073, 5009.198528235464, 5035.395752509649, 5048.747562621854, 4414.690971632019, 4424.048829501608, 4480.305552639281, 4482.282834746425, 4503.572160644733, 5887.735051922674, 5918.171455996164, 5949.762009519657, 5985.880282394415, 6046.727897244635, 6204.255489341218, 6243.687815609202, 6246.656433896179, 6246.812595622047, 6248.687565621701, 5917.349091599921, 6017.18767966319, 6038.460192650934, 6039.758409663652, 6057.121717350959, 4748.0978614063215, 5312.362516498045, 5394.217838413408, 5472.616916815864, 5503.669779813224, 6139.185504090456, 6459.160309159779, 6464.09502669636, 6470.09418681385, 6477.611343319416, 6236.594621349598, 6241.095041219089, 6243.188385510036, 6256.249250090018, 6260.467860231931, 4775.785089670903, 5436.53789427903, 6331.5251356147555, 6371.840703982438, 6458.483321334376, 6202.72087756043, 6262.624242545462, 6294.874102517832, 6304.873902522016, 6307.148534947723, 6179.5056395489155, 6198.318184999736, 6208.348123447154, 6268.561200715906, 6295.496360291258, 4411.889702757457, 6105.511559075175, 6134.8159555213415, 6140.723667435065, 6157.0, 6111.135969295072, 6112.442689633966, 6146.815595532141, 6199.628022318675, 6211.565190436626, 6093.025115981422, 6097.4817140543555, 6100.54245931548, 6104.542159338156, 6128.63228206309, 6031.155638210566, 6179.532410743088, 6193.102000209854, 6225.879341718534, 6230.470410015199, 5924.052151655715, 5950.851228719317, 5994.07091900756, 6027.909581356195, 6089.512838972783], "value": 5724.310202763852, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [485.5144855144855, 511.5702809639902, 521.0672895517025, 528.9259503669487, 535.6625326044591, 32266.838665806667, 41612.583874161246, 43127.706168814904, 43143.568564314344, 45004.774976125154, 38473.26870290837, 41732.79133604335, 44182.89542761433, 44251.0, 44264.0, 9560.665376711817, 9789.902100979007, 9804.705858824247, 9808.11726944575, 9812.116909478145, 8945.0, 9175.03662115475, 11801.409929503534, 11984.940075299612, 12017.819732704016, 11974.161808673396, 12031.157818952677, 12035.699107522338, 12037.578684746035, 12047.397630118503, 11879.287242765418, 11941.701457463547, 11959.760804783855, 11962.82055769164, 11977.98187154093, 11767.764644707058, 11841.703957401047, 11855.46650400734, 11855.58505452305, 11878.227915185485, 41298.0, 41497.377539336936, 41532.79233603843, 41578.1684366314, 41595.792021040004, 4022.1754540319166, 4042.4946881639794, 4062.2078694654556, 4081.4898137732785, 4093.283675356801, 30141.698583014328, 30379.544306835414, 31073.844630776926, 31329.0, 31585.739955722755, 3201.631812341564, 3233.9029829105166, 3402.2515046689687, 3422.743294252941, 3427.971608517435, 483243.0, 484194.0, 484713.0, 485230.0, 486347.0, 63908.68045659835, 64070.0, 64118.0, 64254.67872660607, 64309.0, 66882.33117668859, 66939.0, 67004.6649766748, 67072.0, 67163.32836671668, 17639.206235719423, 17848.821511784718, 17884.374046908295, 17918.731219031724, 17925.282988680567, 12502.874971250352, 13748.862511374959, 13836.169829810244, 13840.861591384159, 13887.652808679864, 15096.849031509764, 15224.695506089816, 19470.117679813327, 22522.32433027012, 22524.0, 8110.107888132301, 8811.427257228388, 8987.325950553735, 9128.90871091294, 9153.976311336744, 894.9418287811271, 910.6676063237003, 914.3279689428265, 934.8317302885546, 948.6395169835419, 29968.700312996592, 30809.0, 30899.918502852743, 31370.52944205839, 31453.0, 791.8178818871577, 1034.5965073621294, 1073.940933248679, 1142.874283828778, 1232.6733415644683, 15312.081275123528, 15843.683126337408, 15859.286332115082, 15863.603409914844, 16112.872098953196, 645814.0, 651411.0, 651721.0, 651779.0, 652150.0, 63764.362356375845, 64556.708865822424, 64604.03093953594, 64616.67691661606, 64617.67691161608, 1347.595721283611, 1390.0408717984558, 1455.8107446032159, 1461.283970854295, 1511.2670354878096, 31361.686383135875, 32091.0, 32209.35581288408, 32262.838685806422, 32891.50662740013, 46056.309155362025, 50926.981460371324, 53441.198382023525, 53441.46558534365, 53555.0, 469853.0, 471359.0, 473049.0, 473152.0, 805104.9744751473, 36811.815940920125, 44206.77896610496, 44942.3258651127, 45097.098058039315, 45714.0, 49281.75359123181, 49667.50997469937, 49842.501574983784, 50241.24638130504, 50431.0, 32723.67276327206, 32860.83569582232, 32863.014109576754, 32944.84693035732, 33073.0, 27402.862985684944, 32452.188695281864, 33115.83442082774, 33781.324373512885, 33833.81581644631, 38645.22709545737, 39299.0, 39350.40974385444, 39526.60473395229, 39551.60448395479, 32859.0, 33128.66871331256, 33320.0, 33652.1586960328, 33794.15514612154, 21338.466538336666, 25796.484070318864, 25936.481270374865, 26190.54692373997, 26211.34471638148], "value": 21077.92491378246, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [368.793475653634, 399.13387948152507, 400.31745873286053, 402.3160626934212, 414.7801665117488, 20521.692174617376, 21771.891140544274, 21870.797106159174, 21918.561628767435, 22458.43853903653, 22119.89400529975, 22598.88700556495, 22731.659025114594, 22872.19947301845, 23025.194118205865, 5122.564582010534, 6097.939020609781, 6107.847303817396, 6158.84602884927, 6175.413335733098, 5922.644641321513, 6015.75936962521, 6066.090086487018, 6129.417705317987, 6143.385661433866, 6104.908426373586, 6106.419890110433, 6107.328193898667, 6110.694465276741, 6111.663858487781, 6091.147239386467, 7513.384622306203, 7823.804404889895, 7894.80262993424, 7904.130545639975, 7559.0, 7718.382529397635, 7739.187385324516, 7942.245486678757, 7976.641051152654, 31096.844515777502, 31221.37557248842, 31238.0, 31268.061958141294, 31336.0, 2936.0898121582377, 2996.6853480384466, 3061.3418115105137, 3352.7820691655206, 3497.4404095344876, 17846.0, 17861.285548578173, 17934.551636209068, 18033.368832090815, 18054.819451805575, 1920.1359388275193, 1986.433866348084, 2059.5468996820678, 2111.5143516991025, 2129.073852874005, 171401.0, 173753.26246737497, 174745.0, 175964.0, 177894.0, 22526.53577517456, 22566.323010309716, 23220.7677923222, 25030.121536023227, 25039.70302140003, 43863.0, 44738.55261447344, 45068.549314507094, 45131.0, 45351.31973020407, 7488.0, 8636.136386361313, 8786.341024423195, 9100.726978190665, 9195.264378849675, 7225.5664660120565, 8903.688370907117, 8939.642414303486, 9090.36367454272, 9131.954340228256, 4991.529193049464, 5003.774830132653, 5011.273365362002, 5019.573336266385, 5129.384473863086, 2047.8156965873143, 2084.520560271146, 2097.968530472044, 2099.769025407204, 2100.327895073592, 1037.8183817832, 1066.168388656849, 1068.9251752377259, 1073.457903758597, 1115.219346457483, 21852.781472185074, 21893.781062189173, 21914.45213869666, 21931.561368772855, 21967.890160549414, 1075.714935542082, 1095.7260684828793, 1099.3568762273999, 1108.501174471475, 1112.896625378036, 10852.0, 11550.942245288888, 11573.305601663928, 11582.826257606142, 11605.6518304451, 332757.0, 731684.0, 737983.3100834461, 748100.0, 754435.0, 147252.0, 163939.0, 165383.5192472114, 166124.33875661332, 168705.0, 1047.0576481166859, 1050.8266136087614, 1092.4919912240687, 1102.525913857049, 1105.7788442311569, 20124.39626811198, 20223.98880055962, 20589.0, 20683.069261883553, 20756.06597703077, 51907.70230744262, 57335.0, 63235.0, 63617.36382636114, 64061.0, 95666.0, 95761.0, 98097.50951245199, 98340.0, 99411.50294248482, 7848.529088254723, 7978.920210797818, 8043.0, 8195.918040819515, 8224.547649879074, 12242.954970322462, 12997.0, 13169.53906613264, 13323.333833308103, 13445.46218151263, 11303.321800691985, 11314.0, 11351.602693905674, 11664.88335116638, 11789.0, 8977.730668079968, 10619.522121504706, 10805.405702686428, 10916.07213386871, 11022.559097636005, 11240.494177762184, 11998.460069297078, 12006.699832503908, 12024.519019239133, 12332.0, 7602.46782725204, 7761.456698031084, 7950.602469876368, 7958.243966823143, 8174.305184059422, 9790.0, 10786.73033174177, 11907.04743620491, 11946.820797687868, 11949.22330048544], "value": 11263.088726320047, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1315.45408655408, 1393.8606139386063, 1472.9042612230205, 1497.6181073826174, 1503.6015455904187, 7706.96146519268, 8011.198880111986, 8323.667053317875, 8517.403781735282, 8528.744137675863, 8404.201600847924, 8475.703350382737, 8479.872801907977, 8485.27875130613, 8491.5329656869, 2129.40376694525, 2357.422431504284, 2387.4747555537842, 2396.9573235642465, 2399.4361325088676, 2220.7779222077825, 2360.185735921113, 2433.9513209735796, 2437.9268621941283, 2451.5464639041747, 2379.9885048854253, 2396.9161079362225, 2399.7720216579396, 2416.118116887341, 2417.16607770319, 2193.8701568692136, 2375.465520257937, 2398.640203969401, 2400.483895962359, 2401.051584624081, 2162.9891850540803, 2335.1126571902737, 2337.9298621041225, 2338.0764597983703, 2340.3447034830274, 8467.110953349871, 8579.828403431959, 8593.26957208638, 8618.525981071038, 8645.740627781177, 5186.766595503212, 5347.893042139174, 5349.331333583302, 5355.732213389315, 5359.464053594648, 3418.1112910643164, 3457.757956943015, 3639.909002274938, 3645.5989841117457, 3655.7075433965483, 1255.5040758900275, 1280.7758642237663, 1282.1281528560576, 1288.8388951381078, 1312.849022362431, 10768.353898766178, 10885.891141088647, 10979.451027448675, 11008.669739907815, 11015.008649221609, 4657.5750443132765, 4746.0, 4771.260454629538, 4839.588634965997, 4853.9029219416125, 9659.565319560637, 9670.226381889432, 9673.984231655575, 9676.90323096774, 9683.080107389787, 5281.894362112736, 5374.5700343972385, 5382.757775900016, 5384.246205531229, 5431.185322201702, 4806.927896081562, 4835.202191638411, 4897.902041959141, 4903.803847846046, 4910.263460480885, 3384.8999075300626, 3939.428782826474, 3949.881503554898, 3962.920741585152, 3983.3029219886403, 1289.6324547503916, 1296.9740605187844, 1298.4222021200476, 1304.1569378754218, 1311.888489478386, 794.559019744036, 911.8267529169569, 941.9952900235455, 967.4292167621137, 969.4522594733953, 5589.580781441408, 5662.462066103713, 5858.707064646751, 5863.120531920161, 5916.526677865761, 963.5808423335872, 997.4065431068502, 1000.859020716384, 1019.0879163148941, 1041.239894876729, 3044.9086527404215, 3769.7172712046704, 3907.5701672815967, 3976.204759048202, 3994.420808982681, 9308.767280818034, 10041.995800420045, 10172.491375431198, 10185.796284074277, 10220.335678180894, 10069.144122749502, 10174.949125254327, 10184.388936663823, 10195.28632995698, 10209.0, 7800.45396822217, 8082.595870206466, 8082.7171049013, 8097.716579919675, 8113.0, 5184.403793563789, 5592.217089607377, 5627.21219029328, 5649.209110724584, 5744.569157313302, 9224.538773061186, 9298.302627303116, 9399.154076133182, 9420.57607407682, 9422.858657120285, 7828.0, 8736.039035706195, 9007.459552426875, 9385.624575017197, 9455.14903658674, 6501.0, 6831.077804496329, 7058.894116588152, 7269.927300726925, 7345.853082938418, 7991.84016319682, 8087.959560202161, 8165.305948994402, 8223.876641850497, 8240.670373185005, 7052.188998265266, 7095.751648692271, 7097.9290207097265, 7159.212486626571, 7207.639618019183, 6033.577649564489, 6959.478039147186, 6994.370506654425, 7011.0, 7112.822179445555, 6436.388543088399, 6536.346365363425, 6541.182352205974, 6544.312847151171, 6553.082568440327, 4898.755062246944, 4920.507949205194, 4927.187014142626, 5001.924971125509, 5185.040767458032, 5122.974385128051, 5123.231515272739, 5150.433452320317, 5171.870703232449, 5223.399309079505], "value": 4507.584727136751, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [322.80309011502993, 366.34972923061565, 368.09815950920233, 377.38674653687747, 378.6629899389542, 4581.358609794632, 5291.629585928987, 5292.338457692788, 5338.759755810988, 5357.7589008494615, 4268.582017611772, 5081.542661160494, 5212.244224587442, 5212.582993360532, 5279.815206467774, 3464.5842498900106, 3502.758234729775, 3630.219502806896, 3635.9636403636023, 4185.455890734201, 3672.7061835053264, 4142.461480007595, 4168.228877657643, 4178.185253875496, 4203.894902627429, 4162.771047592381, 4165.56261592533, 4176.081262122329, 4182.581741825824, 4182.64447521961, 3852.248811481762, 4046.352583586612, 4187.664986801049, 4198.937015944779, 4205.831766729327, 3256.462683657194, 3558.626344233844, 3698.5007024051947, 3731.738778285521, 3762.529683789526, 4370.612775099292, 4799.904001919977, 5159.7678104485385, 5191.195364718475, 5257.738142845727, 3966.960330396717, 4863.2461968394955, 4886.877828054292, 4894.2903279024695, 4958.231474121517, 5405.621606487547, 5651.4913657770585, 5654.745536450829, 5666.86662667464, 5669.829905102853, 3356.5636467259346, 4129.359949207877, 4138.8344466221315, 4150.730202536825, 4157.563455837154, 5653.349864765522, 5803.44867237616, 5949.524038076944, 5958.255218097738, 5958.433948774859, 3626.9378296308305, 3823.369144091194, 4215.178040282116, 4276.230278549829, 4277.978610106992, 3845.769253844778, 4336.915771057235, 4340.891477713019, 4365.9126817463475, 4371.75955322454, 3860.9344000959354, 4761.880952976203, 4849.854504364875, 4951.752412379366, 4979.352684151109, 4442.001099505235, 5027.673201241908, 5712.200656793097, 5768.3654797972185, 5782.913256301159, 1172.6775136837439, 1215.9299816161897, 1260.7352455984162, 1276.6680663027494, 1432.7391895132216, 836.8075342671219, 922.1654402765374, 964.9517524123906, 1009.3893194617151, 1009.9798004040025, 4279.576338928844, 4539.614132798749, 4839.879003024953, 4933.087378834927, 5050.712068422528, 5367.409584945653, 5605.887882242332, 5661.66030038199, 5681.375048744635, 5703.315602127688, 4189.790510474464, 4360.909772556861, 5032.421271553745, 5081.0854046272025, 5182.611304152204, 2527.696676398844, 2695.6899956505254, 2745.574435962429, 2798.594203840432, 2817.4505971335802, 4941.777620007108, 5166.767495462638, 5713.857153571111, 5768.567357448208, 5772.971135144381, 5066.949330506722, 5459.0, 5534.4742249486235, 5682.873490908041, 6010.579259451796, 5229.790808367698, 5712.11462223356, 6197.442230199214, 6202.255729312331, 6208.192934918432, 4836.517983762932, 5651.915221271602, 5854.180414741854, 5886.911696324644, 5889.3780325100615, 4789.832355867528, 5657.397597105378, 5768.221290125779, 5775.94224057754, 5814.796482123105, 5818.970905145447, 5988.730507127103, 6021.789237376671, 6031.703183815501, 6131.356207598138, 3905.6094390560716, 3936.547297060875, 3953.2686453006286, 3979.6020397959974, 3980.422838688432, 4848.515148485123, 5239.397469291081, 5793.623414478046, 5888.028475301528, 5888.793892213752, 5184.507471790174, 5319.813806516908, 5379.35447746273, 5397.379301380392, 5660.745266462936, 5653.010723123519, 5655.575831812548, 5655.915161272502, 5662.886742265214, 5665.470323012681, 4228.450301460791, 4742.644301677319, 5249.022708961152, 5559.6664200148125, 5569.832905012856, 5461.754221059982, 5671.517920976598, 5679.3184817820475, 5691.4877661010705, 5696.177223288508, 4889.46215916256, 5500.9174862377895, 5564.796914884596, 5568.498835104698, 5571.777128914798], "value": 4141.830267832557, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [754.6754895394981, 754.9018627578414, 787.5070047458703, 788.0267869181563, 801.9182755296271, 14989.62525936852, 15385.307661155246, 15980.920095399506, 16121.113338766363, 16180.948238364497, 14344.0, 14500.057496262736, 14657.706845863077, 14722.116672999628, 14800.925995370035, 881.0528681667201, 894.8165626046645, 896.9775755606097, 898.5731777405713, 900.0684291758032, 705.5942832871119, 730.422965856975, 849.800296930221, 879.5690111845214, 881.088073843572, 940.2806852757645, 944.6079876851098, 945.5697657565826, 946.7159852044393, 948.5352177433043, 939.0984654731466, 940.1679513630486, 941.0824446165003, 941.3645789092369, 942.3356533643764, 703.8170075780283, 704.3977399323607, 705.5272967112047, 706.0856191232366, 706.9717211311541, 14366.0, 14786.852131478656, 15558.61103472411, 15663.373465061384, 15705.528834134995, 14139.575812725634, 14480.0, 14938.0, 15019.849801501954, 15329.846701532953, 11670.241434306743, 11702.707432314175, 11710.355930423822, 11929.343886086263, 11950.0, 3690.612485688991, 3856.0745421099014, 3919.2871491934648, 3923.234969181011, 4053.6959728020515, 102175.48912255392, 109501.45249273782, 109772.0, 109837.45081274543, 110138.0, 10891.455427228608, 11056.723581910517, 11221.775564488828, 11370.65888023344, 11415.0, 20667.4833129173, 20761.273355432488, 20959.26642567503, 20965.37103886886, 20989.79010209909, 7396.852062958818, 7807.258310460497, 7821.491603045783, 7928.6828526859435, 7936.444448888637, 4292.055747735493, 4382.5298195840705, 4495.213337665896, 4634.397528321297, 4660.1145782301255, 3662.157703728104, 3756.73702840804, 3759.49246851677, 3763.6989040876665, 3767.56672982605, 619.789271647642, 621.2389822467532, 634.7841733810527, 645.9128017717642, 648.1573953859963, 691.4986634689809, 711.5161690050712, 726.3680597879878, 737.2222305467676, 770.7263921307967, 10397.0, 10691.251612387057, 10701.732456688645, 10746.73133171677, 11041.723956900982, 572.6993328502487, 619.1950464396267, 626.8622450252776, 650.7949995751324, 653.8692261547709, 4064.5935406459707, 4826.7827947742435, 5183.429822719498, 5185.662931909414, 5192.688438693691, 90163.54918225367, 108680.45659771809, 109877.58358473096, 110131.0, 114435.0, 93396.06603934009, 95005.0, 96362.55456168164, 97727.51136244273, 99754.50122749485, 60626.0, 84882.57558712167, 86091.56954215189, 86128.56935715406, 87617.0, 9725.9027409725, 9977.650782222587, 10022.649207277711, 10028.849567256642, 10045.648402305884, 40882.59117408788, 50223.0, 51104.48895510997, 51198.0, 52346.476535234164, 69383.3061669397, 71057.0, 71681.6415917917, 71809.6409517949, 73662.0, 11509.827352589886, 11601.18791684574, 12136.939315303367, 12432.627021189379, 12825.615231543068, 14965.700685986001, 14974.277958034965, 15102.773458398353, 15386.461473848361, 15636.765448518508, 13783.51757688476, 13784.793228101787, 13894.861051389356, 14113.858861411254, 14151.150930943764, 12356.38218089074, 14250.358733857209, 14439.85560144385, 14771.261436927896, 14880.181590012653, 13129.934350328187, 13244.271565064015, 13978.091424057404, 14287.928560357132, 14766.926165369105, 9845.60617575289, 10098.677304220217, 10353.84469232947, 10413.219008574539, 10872.945635271773, 9714.447778125892, 10612.890706630407, 11335.149863760085, 11572.6528204154, 11572.826407603725], "value": 7666.713298577539, "unit": "score"}], "name": "dromaeo_css", "value": 7612.034489355464, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 115.0, 122.0, 166.0, 163.0, 114.0, 113.0, 113.0, 114.0, 114.0], "value": 124.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 144.0, 136.0, 165.0, 108.0, 107.0, 106.0, 105.0, 127.0, 105.0], "value": 124.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 182.0, 185.0, 184.0, 183.0, 184.0, 185.0, 181.0, 185.0, 184.0], "value": 183.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 60.0, 75.0, 79.0, 77.0, 82.0, 81.0, 81.0, 76.0, 57.0], "value": 74.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 70.0, 85.0, 69.0, 69.0, 69.0, 80.0, 67.0, 68.0, 81.0], "value": 74.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 86.0, 88.0, 87.0, 88.0, 85.0, 90.0, 86.0, 90.0, 130.0], "value": 91.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 96.0, 95.0, 108.0, 163.0, 160.0, 95.0, 100.0], "value": 110.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 103.0, 131.0, 130.0, 85.0, 87.0, 87.0, 86.0, 86.0, 87.0], "value": 96.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 51.0, 52.0, 51.0, 54.0, 55.0, 55.0, 55.0, 54.0, 54.0], "value": 53.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 68.0, 72.0, 84.0, 74.0, 72.0, 67.0, 68.0, 69.0, 68.0], "value": 70.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 83.0, 84.0, 87.0, 100.0, 98.0, 99.0, 88.0, 81.0], "value": 88.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 143.0, 148.0, 144.0, 130.0, 133.0, 135.0, 137.0, 176.0, 136.0], "value": 141.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 162.0, 160.0, 203.0, 224.0, 163.0, 162.0, 161.0, 160.0], "value": 172.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 66.0, 64.0, 64.0, 64.0, 63.0, 64.0, 63.0, 63.0], "value": 64.0, "unit": "score"}], "name": "kraken", "value": 1470.9999999999998, "alertThreshold": 2.0}]} 06:21:01 INFO - Return code: 0 06:21:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:21:01 INFO - # TBPL SUCCESS # 06:21:01 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:21:01 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:21:01 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:21:01 INFO - 2017-04-06 06:21:01.572 screenresolution[1655:9583] starting screenresolution argv=screenresolution get 06:21:01 INFO - 2017-04-06 06:21:01.575 screenresolution[1655:9583] Display 0: 1600x1200x32@60 06:21:01 INFO - 2017-04-06 06:21:01.581 screenresolution[1656:9586] starting screenresolution argv=screenresolution list 06:21:01 INFO - Available Modes on Display 0 06:21:01 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:21:01 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:21:01 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:21:01 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:21:01 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:21:01 INFO - Intel Iris: 06:21:01 INFO - Chipset Model: Intel Iris 06:21:01 INFO - Type: GPU 06:21:01 INFO - Bus: Built-In 06:21:01 INFO - VRAM (Dynamic, Max): 1536 MB 06:21:01 INFO - Vendor: Intel (0x8086) 06:21:01 INFO - Device ID: 0x0a2e 06:21:01 INFO - Revision ID: 0x0009 06:21:01 INFO - Displays: 06:21:01 INFO - Display: 06:21:01 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:21:01 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:21:01 INFO - Display Serial Number: 1600x1200 60 06:21:01 INFO - Main Display: Yes 06:21:01 INFO - Mirror: Off 06:21:01 INFO - Online: Yes 06:21:01 INFO - Rotation: Supported 06:21:01 INFO - Return code: 0 06:21:01 INFO - Running post-action listener: _resource_record_post_action 06:21:01 INFO - [mozharness: 2017-04-06 13:21:01.814865Z] Finished run-tests step (success) 06:21:01 INFO - Running post-run listener: _resource_record_post_run 06:21:01 INFO - Total resource usage - Wall time: 1191s; CPU: 54.0%; Read bytes: 38900736; Write bytes: 422318080; Read time: 379; Write time: 1770 06:21:01 INFO - TinderboxPrint: CPU usage
53.5% 06:21:01 INFO - TinderboxPrint: I/O read bytes / time
38,900,736 / 379 06:21:01 INFO - TinderboxPrint: I/O write bytes / time
422,318,080 / 1,770 06:21:01 INFO - TinderboxPrint: CPU idle
2,215.8 (46.5%) 06:21:01 INFO - TinderboxPrint: CPU system
949.9 (19.9%) 06:21:01 INFO - TinderboxPrint: CPU user
1,600.0 (33.6%) 06:21:01 INFO - TinderboxPrint: Swap in / out
160,747,520 / 0 06:21:01 INFO - install - Wall time: 15s; CPU: 54.0%; Read bytes: 253952; Write bytes: 122638336; Read time: 5; Write time: 239 06:21:01 INFO - run-tests - Wall time: 1177s; CPU: 53.0%; Read bytes: 34505728; Write bytes: 298287104; Read time: 348; Write time: 1526 06:21:02 INFO - Running post-run listener: _upload_blobber_files 06:21:02 INFO - Blob upload gear active. 06:21:02 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:21:02 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 06:21:02 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'] 06:21:02 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 06:21:02 INFO - (blobuploader) - INFO - Open directory for files ... 06:21:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:21:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:21:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:21:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:21:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:21:03 INFO - (blobuploader) - INFO - Done attempting. 06:21:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:21:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:21:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:21:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:21:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:21:04 INFO - (blobuploader) - INFO - Done attempting. 06:21:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 06:21:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:21:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:21:05 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 06:21:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:21:05 INFO - (blobuploader) - INFO - Done attempting. 06:21:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:21:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:21:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:21:07 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:21:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:21:07 INFO - (blobuploader) - INFO - Done attempting. 06:21:07 INFO - (blobuploader) - INFO - Iteration through files over. 06:21:07 INFO - Return code: 0 06:21:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:21:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:21:07 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/495919047f0b5d171b8ea58e28b2a9c5c38b3efd8de02d3ec4c8ee8e9fca833c67bc2a57cf0904ab028beca8b92a54169471554e4722f3690b14721b6b2e3dec", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/66cbffc7a005eace0d35ca421a94a305dc470bf8133a16fca436808bad3718c45ed3fd438bf8958e9f32a482f1ebaa4780225dfc75b7cfd50f500866044d3b2f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7bc90bf73972b81433ebd892e7d30b36c4da09ed6794b72c6773cb156f3ccc2736ad880c06ec0eaf7fca96802793846ab8f8110d6ea3221697bf90870e95d05f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5e216e15e60540ffae5190c9a7fc6361f81743e54a985891c5ce9040b7d99cb6676ba3b45e7e1b73eeff3079b9d5dd50a24a8edb308fccbc298191d446a0f86f"} 06:21:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:21:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:21:07 INFO - Contents: 06:21:07 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/495919047f0b5d171b8ea58e28b2a9c5c38b3efd8de02d3ec4c8ee8e9fca833c67bc2a57cf0904ab028beca8b92a54169471554e4722f3690b14721b6b2e3dec", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/66cbffc7a005eace0d35ca421a94a305dc470bf8133a16fca436808bad3718c45ed3fd438bf8958e9f32a482f1ebaa4780225dfc75b7cfd50f500866044d3b2f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7bc90bf73972b81433ebd892e7d30b36c4da09ed6794b72c6773cb156f3ccc2736ad880c06ec0eaf7fca96802793846ab8f8110d6ea3221697bf90870e95d05f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5e216e15e60540ffae5190c9a7fc6361f81743e54a985891c5ce9040b7d99cb6676ba3b45e7e1b73eeff3079b9d5dd50a24a8edb308fccbc298191d446a0f86f"} 06:21:07 INFO - Running post-run listener: copy_logs_to_upload_dir 06:21:07 INFO - Copying logs to upload dir... 06:21:07 INFO - mkdir: /builds/slave/test/build/upload/logs 06:21:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1253.857658 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2017-04-06 06:21:07.864122) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-06 06:21:07.867354) ========= 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.lQuYoBmes1/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.ZK086vJWTq/Listeners TMPDIR=/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/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/495919047f0b5d171b8ea58e28b2a9c5c38b3efd8de02d3ec4c8ee8e9fca833c67bc2a57cf0904ab028beca8b92a54169471554e4722f3690b14721b6b2e3dec", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/66cbffc7a005eace0d35ca421a94a305dc470bf8133a16fca436808bad3718c45ed3fd438bf8958e9f32a482f1ebaa4780225dfc75b7cfd50f500866044d3b2f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7bc90bf73972b81433ebd892e7d30b36c4da09ed6794b72c6773cb156f3ccc2736ad880c06ec0eaf7fca96802793846ab8f8110d6ea3221697bf90870e95d05f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5e216e15e60540ffae5190c9a7fc6361f81743e54a985891c5ce9040b7d99cb6676ba3b45e7e1b73eeff3079b9d5dd50a24a8edb308fccbc298191d446a0f86f"} build_url:https://queue.taskcluster.net/v1/task/MiOfAeh8QC-quz3VKL-ZxA/artifacts/public/build/firefox-53.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.009869 build_url: 'https://queue.taskcluster.net/v1/task/MiOfAeh8QC-quz3VKL-ZxA/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/495919047f0b5d171b8ea58e28b2a9c5c38b3efd8de02d3ec4c8ee8e9fca833c67bc2a57cf0904ab028beca8b92a54169471554e4722f3690b14721b6b2e3dec", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/66cbffc7a005eace0d35ca421a94a305dc470bf8133a16fca436808bad3718c45ed3fd438bf8958e9f32a482f1ebaa4780225dfc75b7cfd50f500866044d3b2f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7bc90bf73972b81433ebd892e7d30b36c4da09ed6794b72c6773cb156f3ccc2736ad880c06ec0eaf7fca96802793846ab8f8110d6ea3221697bf90870e95d05f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5e216e15e60540ffae5190c9a7fc6361f81743e54a985891c5ce9040b7d99cb6676ba3b45e7e1b73eeff3079b9d5dd50a24a8edb308fccbc298191d446a0f86f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-06 06:21:07.898792) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-06 06:21:07.899130) ========= 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.lQuYoBmes1/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.ZK086vJWTq/Listeners TMPDIR=/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/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.004681 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-06 06:21:07.948621) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-06 06:21:07.948949) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-06 06:21:07.949284) ========= ========= Total master_lag: 0.17 =========