builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0234 starttime: 1491432156.47 results: success (0) buildid: 20170405144620 builduid: e86936d5148540c7abd45c182d46646d revision: db91f4e6e0a88c46f6dc02ffe31a933f5fe538bb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-05 15:42:36.471459) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-05 15:42:36.471894) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-05 15:42:36.472195) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-05 15:42:36.498392) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-05 15:42:36.498681) ========= 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.PEphafPAaw/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.ZWvoYmv5Bg/Listeners TMPDIR=/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/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-05 15:42:36-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 29.5M=0s 2017-04-05 15:42:36 (29.5 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.112164 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-05 15:42:36.634707) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-05 15:42:36.635019) ========= 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.PEphafPAaw/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.ZWvoYmv5Bg/Listeners TMPDIR=/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/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.026019 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-05 15:42:36.683848) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-05 15:42:36.684221) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev db91f4e6e0a88c46f6dc02ffe31a933f5fe538bb --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 db91f4e6e0a88c46f6dc02ffe31a933f5fe538bb --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.PEphafPAaw/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.ZWvoYmv5Bg/Listeners TMPDIR=/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/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-05 15:42:36,793 truncating revision to first 12 chars 2017-04-05 15:42:36,793 Setting DEBUG logging. 2017-04-05 15:42:36,794 attempt 1/10 2017-04-05 15:42:36,794 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/db91f4e6e0a8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-05 15:42:37,796 unpacking tar archive at: mozilla-beta-db91f4e6e0a8/testing/mozharness/ program finished with exit code 0 elapsedTime=1.285430 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-05 15:42:37.993073) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-05 15:42:37.993457) ========= script_repo_revision: db91f4e6e0a88c46f6dc02ffe31a933f5fe538bb ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-05 15:42:37.993852) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-05 15:42:37.994197) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-05 15:42:38.013628) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2017-04-05 15:42:38.013900) ========= /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.PEphafPAaw/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.ZWvoYmv5Bg/Listeners TMPDIR=/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/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 15:42:38 INFO - MultiFileLogger online at 20170405 15:42:38 in /builds/slave/test 15:42:38 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 15:42:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:42:38 INFO - {'append_to_log': False, 15:42:38 INFO - 'base_work_dir': '/builds/slave/test', 15:42:38 INFO - 'blob_upload_branch': 'Mozilla-Beta', 15:42:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:42:38 INFO - 'branch': 'Mozilla-Beta', 15:42:38 INFO - 'buildbot_json_path': 'buildprops.json', 15:42:38 INFO - 'config_files': ('talos/mac_config.py',), 15:42:38 INFO - 'default_actions': ('clobber', 15:42:38 INFO - 'read-buildbot-config', 15:42:38 INFO - 'download-and-extract', 15:42:38 INFO - 'populate-webroot', 15:42:38 INFO - 'create-virtualenv', 15:42:38 INFO - 'install', 15:42:38 INFO - 'run-tests'), 15:42:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:42:38 INFO - 'download_minidump_stackwalk': True, 15:42:38 INFO - 'download_symbols': 'ondemand', 15:42:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:42:38 INFO - 'tooltool.py': '/tools/tooltool.py', 15:42:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:42:38 INFO - '/tools/misc-python/virtualenv.py')}, 15:42:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:42:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:42:38 INFO - 'installer_path': 'installer.exe', 15:42:38 INFO - 'log_level': 'info', 15:42:38 INFO - 'log_name': 'talos', 15:42:38 INFO - 'log_to_console': True, 15:42:38 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 15:42:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 15:42:38 INFO - 'opt_config_files': (), 15:42:38 INFO - 'pip_index': False, 15:42:38 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:42:38 INFO - 'cmd': ('bash', 15:42:38 INFO - '-c', 15:42:38 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:42:38 INFO - 'enabled': True, 15:42:38 INFO - 'halt_on_failure': False, 15:42:38 INFO - 'name': 'check_screen_resolution'},), 15:42:38 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:42:38 INFO - 'cmd': ('bash', 15:42:38 INFO - '-c', 15:42:38 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:42:38 INFO - 'enabled': True, 15:42:38 INFO - 'halt_on_failure': False, 15:42:38 INFO - 'name': 'check_screen_resolution'},), 15:42:38 INFO - 'run_cmd_checks_enabled': True, 15:42:38 INFO - 'sps_profile': False, 15:42:38 INFO - 'sps_profile_interval': 0, 15:42:38 INFO - 'suite': 'dromaeojs', 15:42:38 INFO - 'system_bits': '32', 15:42:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:42:38 INFO - 'title': 't-yosemite-r7-0234', 15:42:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:42:38 INFO - 'use_talos_json': True, 15:42:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:42:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:42:38 INFO - 'work_dir': 'build'} 15:42:38 INFO - [mozharness: 2017-04-05 22:42:38.232346Z] Running clobber step. 15:42:38 INFO - Running pre-action listener: _resource_record_pre_action 15:42:38 INFO - Running main action method: clobber 15:42:38 INFO - rmtree: /builds/slave/test/build 15:42:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:42:40 INFO - Running post-action listener: _resource_record_post_action 15:42:40 INFO - [mozharness: 2017-04-05 22:42:40.590851Z] Finished clobber step (success) 15:42:40 INFO - [mozharness: 2017-04-05 22:42:40.591052Z] Running read-buildbot-config step. 15:42:40 INFO - Running pre-action listener: _resource_record_pre_action 15:42:40 INFO - Running main action method: read_buildbot_config 15:42:40 INFO - Using buildbot properties: 15:42:40 INFO - { 15:42:40 INFO - "project": "", 15:42:40 INFO - "product": "firefox", 15:42:40 INFO - "script_repo_revision": "production", 15:42:40 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 15:42:40 INFO - "repository": "", 15:42:40 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 15:42:40 INFO - "buildid": "20170405144620", 15:42:40 INFO - "pgo_build": "False", 15:42:40 INFO - "basedir": "/builds/slave/test", 15:42:40 INFO - "buildnumber": 12, 15:42:40 INFO - "slavename": "t-yosemite-r7-0234", 15:42:40 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 15:42:40 INFO - "platform": "yosemite_r7", 15:42:40 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 15:42:40 INFO - "branch": "mozilla-beta", 15:42:40 INFO - "repo_path": "releases/mozilla-beta", 15:42:40 INFO - "revision": "db91f4e6e0a88c46f6dc02ffe31a933f5fe538bb", 15:42:40 INFO - "stage_platform": "macosx64", 15:42:40 INFO - "builduid": "e86936d5148540c7abd45c182d46646d", 15:42:40 INFO - "slavebuilddir": "test" 15:42:40 INFO - } 15:42:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/A_8Vm6DISB26Wae52EqG6A/artifacts/public/build/firefox-53.0.en-US.mac.dmg. 15:42:40 INFO - Running post-action listener: _resource_record_post_action 15:42:40 INFO - [mozharness: 2017-04-05 22:42:40.596421Z] Finished read-buildbot-config step (success) 15:42:40 INFO - [mozharness: 2017-04-05 22:42:40.596572Z] Running download-and-extract step. 15:42:40 INFO - Running pre-action listener: _resource_record_pre_action 15:42:40 INFO - Running main action method: download_and_extract 15:42:40 INFO - mkdir: /builds/slave/test/build/tests 15:42:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:42:40 INFO - trying https://queue.taskcluster.net/v1/task/A_8Vm6DISB26Wae52EqG6A/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json 15:42:40 INFO - Downloading https://queue.taskcluster.net/v1/task/A_8Vm6DISB26Wae52EqG6A/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 15:42:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/A_8Vm6DISB26Wae52EqG6A/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 15:42:41 INFO - Downloaded 1165 bytes. 15:42:41 INFO - Reading from file /builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json 15:42:41 INFO - Using the following test package requirements: 15:42:41 INFO - {u'common': [u'firefox-53.0.en-US.mac.common.tests.zip'], 15:42:41 INFO - u'cppunittest': [u'firefox-53.0.en-US.mac.common.tests.zip', 15:42:41 INFO - u'firefox-53.0.en-US.mac.cppunittest.tests.zip'], 15:42:41 INFO - u'gtest': [u'firefox-53.0.en-US.mac.common.tests.zip', 15:42:41 INFO - u'firefox-53.0.en-US.mac.gtest.tests.zip'], 15:42:41 INFO - u'jittest': [u'firefox-53.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 15:42:41 INFO - u'mochitest': [u'firefox-53.0.en-US.mac.common.tests.zip', 15:42:41 INFO - u'firefox-53.0.en-US.mac.mochitest.tests.zip'], 15:42:41 INFO - u'mozbase': [u'firefox-53.0.en-US.mac.common.tests.zip'], 15:42:41 INFO - u'reftest': [u'firefox-53.0.en-US.mac.common.tests.zip', 15:42:41 INFO - u'firefox-53.0.en-US.mac.reftest.tests.zip'], 15:42:41 INFO - u'talos': [u'firefox-53.0.en-US.mac.common.tests.zip', 15:42:41 INFO - u'firefox-53.0.en-US.mac.talos.tests.zip'], 15:42:41 INFO - u'web-platform': [u'firefox-53.0.en-US.mac.common.tests.zip', 15:42:41 INFO - u'firefox-53.0.en-US.mac.web-platform.tests.zip'], 15:42:41 INFO - u'xpcshell': [u'firefox-53.0.en-US.mac.common.tests.zip', 15:42:41 INFO - u'firefox-53.0.en-US.mac.xpcshell.tests.zip']} 15:42:41 INFO - Downloading packages: [u'firefox-53.0.en-US.mac.common.tests.zip'] for test suite category: common 15:42:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/A_8Vm6DISB26Wae52EqG6A/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip 15:42:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/A_8Vm6DISB26Wae52EqG6A/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip'}, attempt #1 15:42:41 INFO - Fetch https://queue.taskcluster.net/v1/task/A_8Vm6DISB26Wae52EqG6A/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip into memory 15:42:42 INFO - Expected file size: 16116371 15:42:42 INFO - Obtained file size: 16116371 15:42:49 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 15:42:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/A_8Vm6DISB26Wae52EqG6A/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip 15:42:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/A_8Vm6DISB26Wae52EqG6A/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip'}, attempt #1 15:42:49 INFO - Fetch https://queue.taskcluster.net/v1/task/A_8Vm6DISB26Wae52EqG6A/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip into memory 15:42:50 INFO - Expected file size: 16116371 15:42:50 INFO - Obtained file size: 16116371 15:42:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/A_8Vm6DISB26Wae52EqG6A/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip 15:42:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/A_8Vm6DISB26Wae52EqG6A/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip'}, attempt #1 15:42:56 INFO - Fetch https://queue.taskcluster.net/v1/task/A_8Vm6DISB26Wae52EqG6A/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip into memory 15:42:57 INFO - Expected file size: 14403663 15:42:57 INFO - Obtained file size: 14403663 15:42: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')]} 15:42:58 INFO - trying https://queue.taskcluster.net/v1/task/A_8Vm6DISB26Wae52EqG6A/artifacts/public/build/firefox-53.0.en-US.mac.dmg 15:42:58 INFO - Downloading https://queue.taskcluster.net/v1/task/A_8Vm6DISB26Wae52EqG6A/artifacts/public/build/firefox-53.0.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0.en-US.mac.dmg 15:42:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/A_8Vm6DISB26Wae52EqG6A/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 15:42:59 INFO - Downloaded 58737630 bytes. 15:42:59 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/A_8Vm6DISB26Wae52EqG6A/artifacts/public/build/firefox-53.0.en-US.mac.dmg 15:42:59 INFO - mkdir: /builds/slave/test/properties 15:42:59 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:42:59 INFO - Writing to file /builds/slave/test/properties/build_url 15:42:59 INFO - Contents: 15:42:59 INFO - build_url:https://queue.taskcluster.net/v1/task/A_8Vm6DISB26Wae52EqG6A/artifacts/public/build/firefox-53.0.en-US.mac.dmg 15:43:00 INFO - Running post-action listener: _resource_record_post_action 15:43:00 INFO - Running post-action listener: set_extra_try_arguments 15:43:00 INFO - [mozharness: 2017-04-05 22:43:00.535660Z] Finished download-and-extract step (success) 15:43:00 INFO - [mozharness: 2017-04-05 22:43:00.535804Z] Running populate-webroot step. 15:43:00 INFO - Running pre-action listener: _resource_record_pre_action 15:43:00 INFO - Running main action method: populate_webroot 15:43:00 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:43:00 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:43:00 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:43:00 INFO - '--tppagecycles', 15:43:00 INFO - '7'], 15:43:00 INFO - 'tests': ['tsvgm']}}, 15:43:00 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:43:00 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:43:00 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:43:00 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:43:00 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:43:00 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:43:00 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 15:43:00 INFO - 'talos_options': ['--disable-e10s'], 15:43:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:43:00 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 15:43:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:43:00 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 15:43:00 INFO - 'talos_options': ['--disable-e10s'], 15:43:00 INFO - 'tests': ['damp', 'tps']}, 15:43:00 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 15:43:00 INFO - 'tests': ['damp', 'tps']}, 15:43:00 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:43:00 INFO - 'tests': ['dromaeo_dom']}, 15:43:00 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:43:00 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:43:00 INFO - 'tests': ['basic_compositor_video']}, 15:43:00 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:43:00 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:43:00 INFO - 'tests': ['a11yr', 15:43:00 INFO - 'ts_paint', 15:43:00 INFO - 'tpaint', 15:43:00 INFO - 'sessionrestore', 15:43:00 INFO - 'sessionrestore_no_auto_restore', 15:43:00 INFO - 'tabpaint']}, 15:43:00 INFO - 'other-e10s': {'tests': ['a11yr', 15:43:00 INFO - 'ts_paint', 15:43:00 INFO - 'tpaint', 15:43:00 INFO - 'sessionrestore', 15:43:00 INFO - 'sessionrestore_no_auto_restore', 15:43:00 INFO - 'tabpaint']}, 15:43:00 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:43:00 INFO - 'ts_paint', 15:43:00 INFO - 'tpaint', 15:43:00 INFO - 'sessionrestore', 15:43:00 INFO - 'sessionrestore_no_auto_restore', 15:43:00 INFO - 'tabpaint']}, 15:43:00 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:43:00 INFO - 'ts_paint', 15:43:00 INFO - 'tpaint', 15:43:00 INFO - 'sessionrestore', 15:43:00 INFO - 'sessionrestore_no_auto_restore', 15:43:00 INFO - 'tabpaint']}, 15:43:00 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:43:00 INFO - 'tests': ['a11yr', 15:43:00 INFO - 'ts_paint', 15:43:00 INFO - 'tpaint', 15:43:00 INFO - 'sessionrestore', 15:43:00 INFO - 'sessionrestore_no_auto_restore', 15:43:00 INFO - 'tabpaint']}, 15:43:00 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:43:00 INFO - 'tests': ['a11yr', 15:43:00 INFO - 'ts_paint', 15:43:00 INFO - 'tpaint', 15:43:00 INFO - 'sessionrestore', 15:43:00 INFO - 'sessionrestore_no_auto_restore', 15:43:00 INFO - 'tabpaint']}, 15:43:00 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:43:00 INFO - 'tests': ['tsvgx', 15:43:00 INFO - 'tsvgr_opacity', 15:43:00 INFO - 'tart', 15:43:00 INFO - 'tscrollx', 15:43:00 INFO - 'cart', 15:43:00 INFO - 'tsvg_static']}, 15:43:00 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:43:00 INFO - 'tsvgr_opacity', 15:43:00 INFO - 'tart', 15:43:00 INFO - 'tscrollx', 15:43:00 INFO - 'cart', 15:43:00 INFO - 'tsvg_static']}, 15:43:00 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 15:43:00 INFO - 'talos_options': ['--disable-e10s'], 15:43:00 INFO - 'tests': ['tp5o']}, 15:43:00 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 15:43:00 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 15:43:00 INFO - 'talos_options': ['--disable-e10s', 15:43:00 INFO - '--xperf_path', 15:43:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:43:00 INFO - 'tests': ['tp5n']}, 15:43:00 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 15:43:00 INFO - 'talos_options': ['--xperf_path', 15:43:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:43:00 INFO - 'tests': ['tp5n']}}, 15:43:00 INFO - 'talos.zip': {'path': '', 15:43:00 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:43:00 INFO - Running post-action listener: _resource_record_post_action 15:43:00 INFO - [mozharness: 2017-04-05 22:43:00.555884Z] Finished populate-webroot step (success) 15:43:00 INFO - [mozharness: 2017-04-05 22:43:00.555998Z] Running create-virtualenv step. 15:43:00 INFO - Running pre-action listener: _resource_record_pre_action 15:43:00 INFO - Running main action method: create_virtualenv 15:43:00 INFO - Creating virtualenv /builds/slave/test/build/venv 15:43:00 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 15:43:00 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:43:00 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:43:00 INFO - Using real prefix '/tools/python27' 15:43:00 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:43:01 INFO - Installing distribute.............................................................................................................................................................................................done. 15:43:04 INFO - Installing pip.................done. 15:43:04 INFO - Return code: 0 15:43:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:43:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:43:04 INFO - Reading from file tmpfile_stdout 15:43:04 INFO - Output received: 15:43:04 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) 15:43:04 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:43:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:43:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:43:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:43:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:43:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:43:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:43:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107b7db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107b80768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb499d63ee0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10795bd30>, '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 0x107882db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107950be8>, '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.PEphafPAaw/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.ZWvoYmv5Bg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/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 15:43:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:43:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:43:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PEphafPAaw/Render', 15:43:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:43:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:43:04 INFO - 'HOME': '/Users/cltbld', 15:43:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:43:04 INFO - 'LOGNAME': 'cltbld', 15:43:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:43:04 INFO - 'MOZ_NO_REMOTE': '1', 15:43:04 INFO - 'NO_EM_RESTART': '1', 15:43:04 INFO - 'PAGER': '/bin/cat', 15:43:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:43:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:43:04 INFO - 'PWD': '/builds/slave/test', 15:43:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:43:04 INFO - 'SHELL': '/bin/bash', 15:43:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZWvoYmv5Bg/Listeners', 15:43:04 INFO - 'TMPDIR': '/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/', 15:43:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:43:04 INFO - 'USER': 'cltbld', 15:43:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:43:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:43:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:43:04 INFO - 'XPC_FLAGS': '0x0', 15:43:04 INFO - 'XPC_SERVICE_NAME': '0', 15:43:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:43:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:43:04 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 15:43:04 INFO - Cleaning up... 15:43:04 INFO - Return code: 0 15:43:04 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:43:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:43:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:43:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:43:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:43:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:43:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:43:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x107b7db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107b80768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb499d63ee0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10795bd30>, '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 0x107882db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107950be8>, '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.PEphafPAaw/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.ZWvoYmv5Bg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/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 15:43:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 15:43:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 15:43:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PEphafPAaw/Render', 15:43:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:43:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:43:04 INFO - 'HOME': '/Users/cltbld', 15:43:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:43:04 INFO - 'LOGNAME': 'cltbld', 15:43:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:43:04 INFO - 'MOZ_NO_REMOTE': '1', 15:43:04 INFO - 'NO_EM_RESTART': '1', 15:43:04 INFO - 'PAGER': '/bin/cat', 15:43:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:43:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:43:04 INFO - 'PWD': '/builds/slave/test', 15:43:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:43:04 INFO - 'SHELL': '/bin/bash', 15:43:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZWvoYmv5Bg/Listeners', 15:43:04 INFO - 'TMPDIR': '/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/', 15:43:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:43:04 INFO - 'USER': 'cltbld', 15:43:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:43:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:43:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:43:04 INFO - 'XPC_FLAGS': '0x0', 15:43:04 INFO - 'XPC_SERVICE_NAME': '0', 15:43:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:43:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:43:05 INFO - Downloading/unpacking psutil>=3.1.1 15:43: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 15:43: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 15:43: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 15:43: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 15:43: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 15:43: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 15:43:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:43:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:43:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:43:08 INFO - Installing collected packages: psutil 15:43:08 INFO - Running setup.py install for psutil 15:43:08 INFO - building 'psutil._psutil_osx' extension 15:43:08 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 15:43:09 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 15:43:09 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 15:43:09 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 15:43:09 INFO - building 'psutil._psutil_posix' extension 15:43:09 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 15:43:09 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 15:43:09 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 15:43:09 INFO - ^ 15:43:09 INFO - 1 warning generated. 15:43:09 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 15:43:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:43:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:43:09 INFO - Successfully installed psutil 15:43:09 INFO - Cleaning up... 15:43:09 INFO - Return code: 0 15:43:09 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:43: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')]} 15:43:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:43:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:43: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')]} 15:43:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:43:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:43: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107b7db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107b80768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb499d63ee0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10795bd30>, '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 0x107882db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107950be8>, '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.PEphafPAaw/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.ZWvoYmv5Bg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/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 15:43: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 15:43: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 mozsystemmonitor==0.3 15:43:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PEphafPAaw/Render', 15:43:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:43:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:43:09 INFO - 'HOME': '/Users/cltbld', 15:43:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:43:09 INFO - 'LOGNAME': 'cltbld', 15:43:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:43:09 INFO - 'MOZ_NO_REMOTE': '1', 15:43:09 INFO - 'NO_EM_RESTART': '1', 15:43:09 INFO - 'PAGER': '/bin/cat', 15:43:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:43:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:43:09 INFO - 'PWD': '/builds/slave/test', 15:43:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:43:09 INFO - 'SHELL': '/bin/bash', 15:43:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZWvoYmv5Bg/Listeners', 15:43:09 INFO - 'TMPDIR': '/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/', 15:43:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:43:09 INFO - 'USER': 'cltbld', 15:43:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:43:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:43:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:43:09 INFO - 'XPC_FLAGS': '0x0', 15:43:09 INFO - 'XPC_SERVICE_NAME': '0', 15:43:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:43:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:43:10 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:43:10 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 15:43:10 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 15:43:10 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 15:43:10 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 15:43:10 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 15:43:10 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 15:43:12 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:43:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:43:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:43:12 INFO - Installing collected packages: mozsystemmonitor 15:43:12 INFO - Running setup.py install for mozsystemmonitor 15:43:12 INFO - Successfully installed mozsystemmonitor 15:43:12 INFO - Cleaning up... 15:43:13 INFO - Return code: 0 15:43:13 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:43:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:43:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:43:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:43:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:43:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:43:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:43:13 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 0x107b7db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107b80768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb499d63ee0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10795bd30>, '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 0x107882db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107950be8>, '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.PEphafPAaw/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.ZWvoYmv5Bg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/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 15:43:13 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 15:43:13 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 15:43:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PEphafPAaw/Render', 15:43:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:43:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:43:13 INFO - 'HOME': '/Users/cltbld', 15:43:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:43:13 INFO - 'LOGNAME': 'cltbld', 15:43:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:43:13 INFO - 'MOZ_NO_REMOTE': '1', 15:43:13 INFO - 'NO_EM_RESTART': '1', 15:43:13 INFO - 'PAGER': '/bin/cat', 15:43:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:43:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:43:13 INFO - 'PWD': '/builds/slave/test', 15:43:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:43:13 INFO - 'SHELL': '/bin/bash', 15:43:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZWvoYmv5Bg/Listeners', 15:43:13 INFO - 'TMPDIR': '/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/', 15:43:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:43:13 INFO - 'USER': 'cltbld', 15:43:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:43:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:43:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:43:13 INFO - 'XPC_FLAGS': '0x0', 15:43:13 INFO - 'XPC_SERVICE_NAME': '0', 15:43:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:43:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:43:13 INFO - Downloading/unpacking jsonschema==2.5.1 15:43:13 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 15:43:13 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 15:43:13 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 15:43:13 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 15:43:13 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 15:43:13 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 15:43:15 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:43:15 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:43:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:43:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:43:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:43:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:43:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:43:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:43:16 INFO - Downloading functools32-3.2.3-2.tar.gz 15:43:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:43:16 INFO - warning: no files found matching '*.txt' 15:43:16 INFO - no previously-included directories found matching 'build' 15:43:16 INFO - no previously-included directories found matching 'dist' 15:43:16 INFO - no previously-included directories found matching '.git*' 15:43:16 INFO - Installing collected packages: jsonschema, functools32 15:43:16 INFO - Running setup.py install for functools32 15:43:16 INFO - warning: no files found matching '*.txt' 15:43:16 INFO - no previously-included directories found matching 'build' 15:43:16 INFO - no previously-included directories found matching 'dist' 15:43:16 INFO - no previously-included directories found matching '.git*' 15:43:16 INFO - Successfully installed jsonschema functools32 15:43:16 INFO - Cleaning up... 15:43:16 INFO - Return code: 0 15:43:16 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:43: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')]} 15:43:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:43:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:43: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')]} 15:43:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:43:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:43:16 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 0x107b7db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107b80768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb499d63ee0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10795bd30>, '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 0x107882db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107950be8>, '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.PEphafPAaw/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.ZWvoYmv5Bg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/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 15:43:16 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 15:43:16 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 15:43:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PEphafPAaw/Render', 15:43:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:43:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:43:16 INFO - 'HOME': '/Users/cltbld', 15:43:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:43:16 INFO - 'LOGNAME': 'cltbld', 15:43:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:43:16 INFO - 'MOZ_NO_REMOTE': '1', 15:43:16 INFO - 'NO_EM_RESTART': '1', 15:43:16 INFO - 'PAGER': '/bin/cat', 15:43:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:43:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:43:16 INFO - 'PWD': '/builds/slave/test', 15:43:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:43:16 INFO - 'SHELL': '/bin/bash', 15:43:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZWvoYmv5Bg/Listeners', 15:43:16 INFO - 'TMPDIR': '/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/', 15:43:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:43:16 INFO - 'USER': 'cltbld', 15:43:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:43:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:43:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:43:16 INFO - 'XPC_FLAGS': '0x0', 15:43:16 INFO - 'XPC_SERVICE_NAME': '0', 15:43:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:43:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:43:16 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:43:16 INFO - Cleaning up... 15:43:16 INFO - Return code: 0 15:43:16 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:43: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')]} 15:43:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:43:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:43: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')]} 15:43:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:43:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:43:16 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 0x107b7db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107b80768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb499d63ee0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10795bd30>, '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 0x107882db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107950be8>, '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.PEphafPAaw/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.ZWvoYmv5Bg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/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 15:43:16 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 15:43:16 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 15:43:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PEphafPAaw/Render', 15:43:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:43:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:43:16 INFO - 'HOME': '/Users/cltbld', 15:43:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:43:16 INFO - 'LOGNAME': 'cltbld', 15:43:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:43:16 INFO - 'MOZ_NO_REMOTE': '1', 15:43:16 INFO - 'NO_EM_RESTART': '1', 15:43:16 INFO - 'PAGER': '/bin/cat', 15:43:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:43:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:43:16 INFO - 'PWD': '/builds/slave/test', 15:43:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:43:16 INFO - 'SHELL': '/bin/bash', 15:43:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZWvoYmv5Bg/Listeners', 15:43:16 INFO - 'TMPDIR': '/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/', 15:43:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:43:16 INFO - 'USER': 'cltbld', 15:43:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:43:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:43:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:43:16 INFO - 'XPC_FLAGS': '0x0', 15:43:16 INFO - 'XPC_SERVICE_NAME': '0', 15:43:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:43:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:43:17 INFO - Downloading/unpacking blobuploader==1.2.4 15:43:17 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 15:43:17 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 15:43:17 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 15:43:17 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 15:43:17 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 15:43:17 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 15:43:19 INFO - Downloading blobuploader-1.2.4.tar.gz 15:43:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:43:19 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:43:19 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 15:43:19 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 15:43:19 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 15:43:19 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 15:43:19 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 15:43:19 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 15:43:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:43:20 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:43:20 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 15:43:20 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 15:43:20 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 15:43:20 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 15:43:20 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 15:43:20 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 15:43:21 INFO - Downloading docopt-0.6.1.tar.gz 15:43:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:43:21 INFO - Installing collected packages: blobuploader, requests, docopt 15:43:21 INFO - Running setup.py install for blobuploader 15:43:21 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:43:21 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:43:21 INFO - Running setup.py install for requests 15:43:21 INFO - Running setup.py install for docopt 15:43:21 INFO - Successfully installed blobuploader requests docopt 15:43:21 INFO - Cleaning up... 15:43:22 INFO - Return code: 0 15:43:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:43:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:43:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:43:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:43:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:43:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:43:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:43:22 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 0x107b7db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107b80768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb499d63ee0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10795bd30>, '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 0x107882db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107950be8>, '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.PEphafPAaw/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.ZWvoYmv5Bg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/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 15:43:22 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 15:43:22 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 15:43:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PEphafPAaw/Render', 15:43:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:43:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:43:22 INFO - 'HOME': '/Users/cltbld', 15:43:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:43:22 INFO - 'LOGNAME': 'cltbld', 15:43:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:43:22 INFO - 'MOZ_NO_REMOTE': '1', 15:43:22 INFO - 'NO_EM_RESTART': '1', 15:43:22 INFO - 'PAGER': '/bin/cat', 15:43:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:43:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:43:22 INFO - 'PWD': '/builds/slave/test', 15:43:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:43:22 INFO - 'SHELL': '/bin/bash', 15:43:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZWvoYmv5Bg/Listeners', 15:43:22 INFO - 'TMPDIR': '/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/', 15:43:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:43:22 INFO - 'USER': 'cltbld', 15:43:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:43:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:43:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:43:22 INFO - 'XPC_FLAGS': '0x0', 15:43:22 INFO - 'XPC_SERVICE_NAME': '0', 15:43:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:43:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:43:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:43:22 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-W87vlG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:43:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:43:22 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-zsandr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:43:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:43:22 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-88BIVC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:43:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:43:22 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-gTpdZ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:43:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:43:22 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-sJ872t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:43:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:43:22 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-v70sjI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:43:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:43:22 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-F7H19q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:43:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:43:23 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-QxdHNV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:43:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:43:23 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-MhCRpn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:43:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:43:23 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-WwgsZp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:43:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:43:23 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-YXVYzt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:43:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:43:23 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-byhx_f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:43:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:43:23 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-u40azG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:43:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:43:23 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-Ftv4G6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:43:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:43:23 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-_sLIG2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:43:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:43:23 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-i16VME-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:43:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:43:23 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-drLoVH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:43:24 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:43:24 INFO - Running setup.py install for manifestparser 15:43:24 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:43:24 INFO - Running setup.py install for mozcrash 15:43:24 INFO - Running setup.py install for mozdebug 15:43:24 INFO - Running setup.py install for mozdevice 15:43:24 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:43:24 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:43:24 INFO - Running setup.py install for mozfile 15:43:24 INFO - Running setup.py install for mozhttpd 15:43:24 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:43:24 INFO - Running setup.py install for mozinfo 15:43:25 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:43:25 INFO - Running setup.py install for mozInstall 15:43:25 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:43:25 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:43:25 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:43:25 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:43:25 INFO - Running setup.py install for mozleak 15:43:25 INFO - Running setup.py install for mozlog 15:43:25 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:43:25 INFO - Running setup.py install for moznetwork 15:43:25 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:43:25 INFO - Running setup.py install for mozprocess 15:43:25 INFO - Running setup.py install for mozprofile 15:43:26 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:43:26 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:43:26 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:43:26 INFO - Running setup.py install for mozrunner 15:43:26 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:43:26 INFO - Running setup.py install for mozscreenshot 15:43:26 INFO - Running setup.py install for moztest 15:43:26 INFO - Running setup.py install for mozversion 15:43:26 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:43:26 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:43:26 INFO - Cleaning up... 15:43:26 INFO - Return code: 0 15:43:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:43:26 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')]} 15:43:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:43:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:43:26 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')]} 15:43:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:43:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:43:26 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 0x107b7db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107b80768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb499d63ee0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10795bd30>, '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 0x107882db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107950be8>, '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.PEphafPAaw/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.ZWvoYmv5Bg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/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 15:43:26 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 15:43:26 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 15:43:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PEphafPAaw/Render', 15:43:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:43:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:43:26 INFO - 'HOME': '/Users/cltbld', 15:43:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:43:26 INFO - 'LOGNAME': 'cltbld', 15:43:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:43:26 INFO - 'MOZ_NO_REMOTE': '1', 15:43:26 INFO - 'NO_EM_RESTART': '1', 15:43:26 INFO - 'PAGER': '/bin/cat', 15:43:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:43:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:43:26 INFO - 'PWD': '/builds/slave/test', 15:43:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:43:26 INFO - 'SHELL': '/bin/bash', 15:43:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZWvoYmv5Bg/Listeners', 15:43:26 INFO - 'TMPDIR': '/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/', 15:43:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:43:26 INFO - 'USER': 'cltbld', 15:43:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:43:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:43:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:43:26 INFO - 'XPC_FLAGS': '0x0', 15:43:26 INFO - 'XPC_SERVICE_NAME': '0', 15:43:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:43:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:43:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:43:26 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-4b32UI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:43:27 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)) 15:43:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:43:27 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-1TWjwv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:43:27 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)) 15:43:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:43:27 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-I_nD1F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:43:27 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)) 15:43:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:43:27 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-ztVfkb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:43:27 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)) 15:43:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:43:27 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-beNA6x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:43:27 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)) 15:43:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:43:27 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-O1zza6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:43:27 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)) 15:43:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:43:27 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-2z_ERo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:43:27 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)) 15:43:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:43:27 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-Sx0YlD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:43:27 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)) 15:43:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:43:27 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-Gpdhcz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:43:27 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)) 15:43:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:43:27 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-7LGDQN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:43:28 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)) 15:43:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:43:28 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-iKyo_E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:43:28 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)) 15:43:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:43:28 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-oqrBlu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:43:28 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)) 15:43:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:43:28 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-e4wKMP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:43:28 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)) 15:43:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:43:28 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-CRbUp7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:43:28 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)) 15:43:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:43:28 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-mdP8_M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:43:28 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)) 15:43:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:43:28 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-7mWa5B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:43:28 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)) 15:43:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:43:28 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-U_EfkM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:43:28 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)) 15:43:28 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)) 15:43:28 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)) 15:43:28 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)) 15:43:28 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)) 15:43:28 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)) 15:43:28 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:43:28 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 15:43:28 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 15:43:28 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 15:43:28 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 15:43:28 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 15:43:28 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 15:43:31 INFO - Downloading blessings-1.6.tar.gz 15:43:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:43:31 INFO - Installing collected packages: blessings 15:43:31 INFO - Running setup.py install for blessings 15:43:32 INFO - Successfully installed blessings 15:43:32 INFO - Cleaning up... 15:43:32 INFO - Return code: 0 15:43:32 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:43:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:43:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:43:32 INFO - Reading from file tmpfile_stdout 15:43:32 INFO - Current package versions: 15:43:32 INFO - blessings == 1.6 15:43:32 INFO - blobuploader == 1.2.4 15:43:32 INFO - docopt == 0.6.1 15:43:32 INFO - functools32 == 3.2.3-2 15:43:32 INFO - jsonschema == 2.5.1 15:43:32 INFO - manifestparser == 1.1 15:43:32 INFO - mozInstall == 1.12 15:43:32 INFO - mozcrash == 1.0 15:43:32 INFO - mozdebug == 0.1 15:43:32 INFO - mozdevice == 0.49 15:43:32 INFO - mozfile == 1.2 15:43:32 INFO - mozhttpd == 0.7 15:43:32 INFO - mozinfo == 0.9 15:43:32 INFO - mozleak == 0.1 15:43:32 INFO - mozlog == 3.4 15:43:32 INFO - moznetwork == 0.27 15:43:32 INFO - mozprocess == 0.24 15:43:32 INFO - mozprofile == 0.28 15:43:32 INFO - mozrunner == 6.13 15:43:32 INFO - mozscreenshot == 0.1 15:43:32 INFO - mozsystemmonitor == 0.3 15:43:32 INFO - moztest == 0.8 15:43:32 INFO - mozversion == 1.4 15:43:32 INFO - psutil == 3.1.1 15:43:32 INFO - requests == 1.2.3 15:43:32 INFO - wsgiref == 0.1.2 15:43:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:43:32 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')]} 15:43:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:43:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:43:32 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')]} 15:43:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:43:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:43:32 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 0x107b7db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107b80768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb499d63ee0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10795bd30>, '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 0x107882db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107950be8>, '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.PEphafPAaw/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.ZWvoYmv5Bg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/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 15:43:32 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 15:43:32 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 15:43:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PEphafPAaw/Render', 15:43:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:43:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:43:32 INFO - 'HOME': '/Users/cltbld', 15:43:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:43:32 INFO - 'LOGNAME': 'cltbld', 15:43:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:43:32 INFO - 'MOZ_NO_REMOTE': '1', 15:43:32 INFO - 'NO_EM_RESTART': '1', 15:43:32 INFO - 'PAGER': '/bin/cat', 15:43:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:43:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:43:32 INFO - 'PWD': '/builds/slave/test', 15:43:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:43:32 INFO - 'SHELL': '/bin/bash', 15:43:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZWvoYmv5Bg/Listeners', 15:43:32 INFO - 'TMPDIR': '/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/', 15:43:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:43:32 INFO - 'USER': 'cltbld', 15:43:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:43:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:43:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:43:32 INFO - 'XPC_FLAGS': '0x0', 15:43:32 INFO - 'XPC_SERVICE_NAME': '0', 15:43:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:43:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:43:32 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)) 15:43:32 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)) 15:43:32 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)) 15:43:32 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)) 15:43:32 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)) 15:43:32 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)) 15:43:32 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)) 15:43:32 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)) 15:43:32 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)) 15:43:32 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)) 15:43:32 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)) 15:43:32 INFO - Cleaning up... 15:43:32 INFO - Return code: 0 15:43:32 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:43:32 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')]} 15:43:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:43:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:43:32 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')]} 15:43:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:43:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:43:32 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 0x107b7db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107b80768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb499d63ee0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10795bd30>, '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 0x107882db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107950be8>, '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.PEphafPAaw/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.ZWvoYmv5Bg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/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 15:43:32 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 15:43:32 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 15:43:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PEphafPAaw/Render', 15:43:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:43:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:43:32 INFO - 'HOME': '/Users/cltbld', 15:43:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:43:32 INFO - 'LOGNAME': 'cltbld', 15:43:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:43:32 INFO - 'MOZ_NO_REMOTE': '1', 15:43:32 INFO - 'NO_EM_RESTART': '1', 15:43:32 INFO - 'PAGER': '/bin/cat', 15:43:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:43:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:43:32 INFO - 'PWD': '/builds/slave/test', 15:43:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:43:32 INFO - 'SHELL': '/bin/bash', 15:43:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZWvoYmv5Bg/Listeners', 15:43:32 INFO - 'TMPDIR': '/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/', 15:43:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:43:32 INFO - 'USER': 'cltbld', 15:43:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:43:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:43:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:43:32 INFO - 'XPC_FLAGS': '0x0', 15:43:32 INFO - 'XPC_SERVICE_NAME': '0', 15:43:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:43:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:43:32 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:43:32 INFO - Cleaning up... 15:43:32 INFO - Return code: 0 15:43:32 INFO - Running post-action listener: _resource_record_post_action 15:43:32 INFO - Running post-action listener: _start_resource_monitoring 15:43:32 INFO - Starting resource monitoring. 15:43:32 INFO - [mozharness: 2017-04-05 22:43:32.959233Z] Finished create-virtualenv step (success) 15:43:32 INFO - [mozharness: 2017-04-05 22:43:32.960065Z] Running install step. 15:43:32 INFO - Running pre-action listener: _resource_record_pre_action 15:43:32 INFO - Running main action method: install 15:43:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:43:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:43:33 INFO - Reading from file tmpfile_stdout 15:43:33 INFO - Detecting whether we're running mozinstall >=1.0... 15:43:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:43:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:43:33 INFO - Reading from file tmpfile_stdout 15:43:33 INFO - Output received: 15:43:33 INFO - Usage: mozinstall [options] installer 15:43:33 INFO - Options: 15:43:33 INFO - -h, --help show this help message and exit 15:43:33 INFO - -d DEST, --destination=DEST 15:43:33 INFO - Directory to install application into. [default: 15:43:33 INFO - "/builds/slave/test"] 15:43:33 INFO - --app=APP Application being installed. [default: firefox] 15:43:33 INFO - mkdir: /builds/slave/test/build/application 15:43:33 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'] 15:43:33 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 15:43:48 INFO - Reading from file tmpfile_stdout 15:43:48 INFO - Output received: 15:43:48 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 15:43:48 INFO - Running post-action listener: _resource_record_post_action 15:43:48 INFO - [mozharness: 2017-04-05 22:43:48.051208Z] Finished install step (success) 15:43:48 INFO - [mozharness: 2017-04-05 22:43:48.051379Z] Running run-tests step. 15:43:48 INFO - Running pre-action listener: _resource_record_pre_action 15:43:48 INFO - Running main action method: run_tests 15:43:48 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:43:48 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:43:48 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:43:48 INFO - 2017-04-05 15:43:48.066 screenresolution[1625:7308] starting screenresolution argv=screenresolution get 15:43:48 INFO - 2017-04-05 15:43:48.068 screenresolution[1625:7308] Display 0: 1600x1200x32@60 15:43:48 INFO - 2017-04-05 15:43:48.074 screenresolution[1626:7310] starting screenresolution argv=screenresolution list 15:43:48 INFO - Available Modes on Display 0 15:43:48 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:43:48 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:43:48 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:43:48 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:43:48 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:43:48 INFO - Intel Iris: 15:43:48 INFO - Chipset Model: Intel Iris 15:43:48 INFO - Type: GPU 15:43:48 INFO - Bus: Built-In 15:43:48 INFO - VRAM (Dynamic, Max): 1536 MB 15:43:48 INFO - Vendor: Intel (0x8086) 15:43:48 INFO - Device ID: 0x0a2e 15:43:48 INFO - Revision ID: 0x0009 15:43:48 INFO - Displays: 15:43:48 INFO - Display: 15:43:48 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:43:48 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:43:48 INFO - Display Serial Number: 1600x1200 60 15:43:48 INFO - Main Display: Yes 15:43:48 INFO - Mirror: Off 15:43:48 INFO - Online: Yes 15:43:48 INFO - Rotation: Supported 15:43:48 INFO - Return code: 0 15:43:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:43:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:43:48 INFO - Python 2.7.3 15:43:48 INFO - Return code: 0 15:43:48 INFO - grabbing minidump binary from tooltool 15:43:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:43:48 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 0x10795bd30>, '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 0x107882db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107950be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:43:48 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 15:43:48 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 15:43:48 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 15:43:48 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:43:48 INFO - Return code: 0 15:43:48 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 15:43:48 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:43:48 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:43:48 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 15:43:48 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:43:48 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/A_8Vm6DISB26Wae52EqG6A/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0234', '--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 15:43:48 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/A_8Vm6DISB26Wae52EqG6A/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0234 --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 15:43:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PEphafPAaw/Render', 15:43:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:43:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:43:48 INFO - 'HOME': '/Users/cltbld', 15:43:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:43:48 INFO - 'LOGNAME': 'cltbld', 15:43:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:43:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 15:43:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:43:48 INFO - 'MOZ_NO_REMOTE': '1', 15:43:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:43:48 INFO - 'NO_EM_RESTART': '1', 15:43:48 INFO - 'PAGER': '/bin/cat', 15:43:48 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:43:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:43:48 INFO - 'PWD': '/builds/slave/test', 15:43:48 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:43:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:43:48 INFO - 'SHELL': '/bin/bash', 15:43:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZWvoYmv5Bg/Listeners', 15:43:48 INFO - 'TMPDIR': '/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/', 15:43:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:43:48 INFO - 'USER': 'cltbld', 15:43:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:43:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:43:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:43:48 INFO - 'XPC_FLAGS': '0x0', 15:43:48 INFO - 'XPC_SERVICE_NAME': '0', 15:43:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:43:48 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/A_8Vm6DISB26Wae52EqG6A/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0234', '--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 15:43:48 INFO - mozversion application_buildid: 20170405144620 15:43:48 INFO - mozversion application_changeset: db91f4e6e0a88c46f6dc02ffe31a933f5fe538bb 15:43:48 INFO - mozversion application_display_name: Firefox 15:43:48 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:43:48 INFO - mozversion application_name: Firefox 15:43:48 INFO - mozversion application_remotingname: firefox 15:43:48 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 15:43:48 INFO - mozversion application_vendor: Mozilla 15:43:48 INFO - mozversion application_version: 53.0 15:43:48 INFO - mozversion platform_buildid: 20170405144620 15:43:48 INFO - mozversion platform_changeset: db91f4e6e0a88c46f6dc02ffe31a933f5fe538bb 15:43:48 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 15:43:48 INFO - mozversion platform_version: 53.0 15:43:48 INFO - using testdate: 1491432228 15:43:48 INFO - actual date: 1491432228 15:43:48 INFO - starting webserver on 'localhost:49236' 15:43:48 INFO - SUITE-START | Running 2 tests 15:43:48 INFO - TEST-START | dromaeo_css 15:43:48 INFO - operating with platform_type : mac_ 15:43:48 INFO - Initialising browser for dromaeo_css test... 15:43:48 INFO - TEST-INFO | started process 1636 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/tmpPTwu0B/profile http://localhost:49236/getInfo.html) 15:43:51 INFO - PROCESS | 1636 | __metrics Screen width/height:1600/1200 15:43:51 INFO - PROCESS | 1636 | colorDepth:24 15:43:51 INFO - PROCESS | 1636 | Browser inner width/height: 1024/689 15:43:51 INFO - PROCESS | 1636 | __metrics 15:43:51 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" 15:43:51 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] 15:43:51 INFO - TEST-INFO | 1636: exit 0 15:43:51 INFO - Browser initialized. 15:43:51 INFO - Running cycle 1/1 for dromaeo_css test... 15:43:51 INFO - TEST-INFO | started process 1639 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/tmpPTwu0B/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:44:03 INFO - PROCESS | 1639 | RSS: Main: 163971072 15:44:03 INFO - PROCESS | 1639 | 15:47:06 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49236/tests/dromaeo/cssquery-ext.html) 15:47:08 INFO - PROCESS | 1639 | RSS: Main: 329891840 15:47:08 INFO - PROCESS | 1639 | 15:50:10 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-ext.html (next: http://localhost:49236/tests/dromaeo/cssquery-jquery.html) 15:50:11 INFO - PROCESS | 1639 | RSS: Main: 310931456 15:50:11 INFO - PROCESS | 1639 | 15:53:13 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49236/tests/dromaeo/cssquery-mootools.html) 15:53:14 INFO - PROCESS | 1639 | RSS: Main: 294563840 15:53:14 INFO - PROCESS | 1639 | 15:56:16 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49236/tests/dromaeo/cssquery-prototype.html) 15:56:17 INFO - PROCESS | 1639 | RSS: Main: 287834112 15:56:17 INFO - PROCESS | 1639 | 15:59:20 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49236/tests/dromaeo/cssquery-yui.html) 15:59:21 INFO - PROCESS | 1639 | RSS: Main: 263761920 15:59:21 INFO - PROCESS | 1639 | 16:02:24 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-yui.html (next: http://localhost:49236/tests/dromaeo/cssquery-dojo.html) 16:02:24 INFO - PROCESS | 1639 | RSS: Main: 318599168 16:02:24 INFO - PROCESS | 1639 | 16:02:24 INFO - PROCESS | 1639 | __start_tp_report 16:02:24 INFO - PROCESS | 1639 | _x_x_mozilla_page_load 16:02:24 INFO - PROCESS | 1639 | _x_x_mozilla_page_load_details 16:02:24 INFO - PROCESS | 1639 | |i|pagename|runs| 16:02:24 INFO - PROCESS | 1639 | |0;dojo.html;3425.725941924646;3467.4452087665964;3472.288180922911;3476.7044801191896;3543.964560354396;5684.886302273952;5705.686187259705;5766.740496677654;5767.740451679674;5777.931082749689;5744.942550574493;5818.679972601505;5832.387599302076;5837.941620583803;5844.298684157897;4809.855704328876;5227.973860130713;5250.973745131269;5257.106291930381;5315.521603055724;5147.7683504242395;5183.6371453998045;5184.066867963765;5320.9467905320835;5329.600279978998;5248.816291429801;5251.658642188265;5301.966116607263;5329.520343169114;5332.653377530468;4386.495553011413;5316.415194328621;5317.867053323678;5327;5336.119540275849;5177.249298851645;5217.634765566412;5251.159814429711;5264.368275806889;5303.071962406563;5522.3649280332875;5618.4662457066515;5627.803026894039;5693.943060569382;5696.544276457915;6213.875722485525;6244.687765611747;6258.843528911768;6259.311475737665;6271.655058971754;6260.655663938482;6273.498120150377;6293.653849038301;6306;6310.968445157745;5773.595848290622;5785.103308987113;5802.6808525531505;5837.270341207349;5883.294004719375;6265.185525881606;6328.71520781566;6329.082283068929;6340.365963403623;6350.618962862243;5141.717205553656;6286.277078136073;6299.96850015747;6301.842453938597;6310.968445157745;6201.56589038772;6232;6237.656928868865;6282.905756413657;6288;5128.205128205134;6204.255489341218;6220.346863579259;6318.115463835067;6318.557700960889;6271.372862713783;6272.686365681698;6279.905801412982;6285.340039295808;6292.559520833589;4986.152354099811;5065.138926382524;5114.232865070269;5120.308758317654;5142.742862856842;4460.241758900995;4482.103579284156;4529.38853254813;4530.139273538017;4540.296254080623;5930.644161350333;5933.110033495011;5958.821235362946;5985.042393217064;5989.341172471025;6189.8452538686;6229.844253893598;6233.158523599256;6253.280872699698;6269;5110.9488905110475;5501.779928802803;5791.594588378773;5889.38161493037;5923.318818335861;5543.501084902378;5579.302587176603;5581.860453488614;5602.719864006784;5614.522765564891;6434.64609446485;6463;6475.611463312311;6489.513286503626;6494.155759751202;6134.5590473767;6201.317855036033;6237.563370564017;6243.594166379171;6259.374062593704;6312.936870631235;6319.399657032574;6356.269029061532;6503.122078519528;6506.772262970773;5569.888602227852;6264.718087685974;6273.090401891792;6294.464970477561;6304.148939893055;5265.78936842522;6183.103449999635;6218.204625324791;6222.968885155546;6227.844303892439;6119.632822030692;6122.571420000557;6126.059675755388;6126.365000174519;6210.534209934182;6131.938680613137;6185.381461853958;6192.59748116371;6194.5973511721595;6200.976838821544;6017.518598512196;6067.24159480065;6083.330833608211;6091.786787462417;6109.358517355614;4801.18379875415;5968.522518198447;6137.560853825989;6161.045038019114;6185.597936134137;6144.846378840565;6145.324014358328;6149.2620885494025;6152.261728592597;6154 16:02:24 INFO - PROCESS | 1639 | |1;ext.html;517.8964207158568;537.8225185688723;542.7204989430444;551.81635392084;572.736541191052;32550.837245813767;42475.36286955694;44402.33396499051;44488.11023779523;47125.293120603215;46349.7682511587;46687.53312466874;46750.53249467504;46764;46927.76536117323;9575.569099390526;9790.706278811647;9793.755156121082;9795.608175672964;9800.460974646392;8871.423357481775;9131.589078491485;11810.291382517076;12033.51865925362;12037.21758085726;11730.17888747788;11855.7628847423;11878.465469053914;11929.94035029828;11961.40192990347;11908.225965312271;11992.22050566719;11998.58004969822;12001.279923204636;12006.039516838631;11739.23694959825;11789.882101178964;11801.232919860182;11824.11319151067;11827;42968.35547466791;43253.91865203364;43331.56668433307;43472.565274347166;43581;4022.255882661717;4029.97985010076;4059.147579008412;4064.1668457966343;4120.773357465338;29953.767661302038;31861.84069079663;31918.521222181687;32286.708531658707;32610.347793044006;2724.945501089967;3330.8748779077996;3343.632200457948;3454.481827725836;3567.946480802764;369744.30255697365;373625;374126;375362;376072;68534;68604.31395686079;70904.2909570908;71092;71405.64297178481;74828;74842;74912.62543687246;74968;75007;18069.186886590134;18306.08469576516;18356.449306520826;18405.171767270505;18424.35514756977;12571.748565028649;13754.93122534381;13896.791548126786;13927.234002129777;13966.162030278216;14486.782698259534;17605.29578816833;17629.911850440923;17700.822991769917;19430.2227910882;7521.699132034657;8774.298056155492;8885.844840170736;8901.554922253861;9200;923.7644400677918;923.9769005774775;929.9674511392069;940.948247846375;980.7989362180735;31786.523202151988;32277.35445291128;32364.83817580897;33099;33154.50268245978;1063.8457423673678;1069.9029901393355;1077.488193108283;1094.934303941766;1108.578740078765;14710.55868323952;14886.627834304012;14969.850301497063;15039.398424062914;15149.939504234819;651986;657848.7107564432;657903.7104814445;659846;661934;53649.731751340994;54601;57240;58017.419825801204;58287.417125829044;1459.8248210214842;1489.5754709907624;1493.9850601493845;1510.1618601676175;1518.3926429428318;29683.851580742823;30860.22849428782;30959.0712278632;31666.683333167293;32110.839445802623;50516;54124.729376352865;55368;57506.424935751784;58201;625463;632477;633182;633258;634455;42150.36774448324;42567.787161064;42581.46061824484;42920.570794291656;43297;45432;46162.538374615826;46597.53402466067;46781.532184677715;47164;31166.532502012942;31528.684713152576;31603.73585056572;32618;32861.56368890169;31152.532712008884;31233.8438307807;31408.05775826729;31827;32169.35661286808;37021.62978370182;37796.43305350477;37831;37997.81001094977;38026;30044.69955300419;30977.225569360948;31188.844055779577;32237.838810805795;32238;23196.536069278856;23835.64246536338;24560.263192104267;24693.506129876943;24928.75071249264 16:02:24 INFO - PROCESS | 1639 | |2;jquery.html;402.4968789013733;403.59237170457845;407.76553481748005;414.4591308342614;429.66700806874667;20548.589028219427;21701.891490542526;21983.560328793435;22553;22800.88599557004;22081.889590552026;22865.31404057881;23147.537049259005;23440.648390274117;23494.64758028631;5807.767689292423;5893.823185304448;6178.629282243057;6188.195534580498;6189.721462534197;5623.634463759863;6061.45446909778;6108.755649774003;6126.142340072393;6134.539909506782;5819.650820950736;5975.193348897908;6069.453749162574;6084.1786358841655;6087.3303936566945;6060.787872424466;6099.268087829444;6108.389161083878;6119.357467465941;6121.816345509642;5338.252644629755;5360.892782144335;5361.758720857531;5542.612017158801;5615.691136987464;13825.930870345584;14064.296785160803;14070.788938165935;19004;26029.73970260292;2615.2938706549317;2654.5752679571174;2686.3149896776395;2688.0591792872533;2722.414680843628;10246.89753102467;10467.214958878114;10636.840447393295;10755.677329680044;16088.195590220443;1811.5652243461607;1837.7610910581539;1846.5199048247418;1859.7954225035235;1864.6270745850884;109158.45420772924;125512;129919;132940;135078;11562.132840037031;12035.39823008846;12041.578544750892;12055.87944120565;12140.939295303644;16144.596385090466;16175.514734557983;16176.919115404347;16177.59556011109;16196.271167797242;8927.151920567536;9073.77315567103;9075.2286055686;9094.454332740057;9185.35702500832;8920.063393343735;8926.152015558511;8939.195472407515;9100.544972751335;9105.726828195166;4365.646649538653;4757.429108506932;4909.803607855717;4911.607071434277;4928.162212423897;1757.650359259169;1779.946601601954;1949.9610007799765;1967.5868067705655;2002.4192984034466;1043.5564884923876;1058.5762149908362;1078.412265315405;1096.71485413793;1127;20561.588768224552;21774.782252177592;21818.345449636538;21964.341069767932;22005.66991495129;1079.6167360587035;1087.282393620207;1106.623747925709;1112.3214838948236;1124.241137232365;11170.497327620276;11488.368139752394;11506.482208300478;11633.53465861356;12532.310722910144;770713;771769;774074;783004;790741;120968;140615;160347;163763;165725.17137414234;1056.7939251845817;1061.5647584490323;1095.5398732532356;1096.0628662493452;1100.9394483303336;17501.824981750528;19039.80960190436;20873.582528349045;21129.577408452053;21243.575128497036;48846.99999999858;61762.69118654378;61960.69019654873;63340.68329658506;63680.68159659172;79271;85152.1484785169;91024.08975910157;93765;94305.5284723572;7597.468177227541;8018.398620103399;8339.749807505785;8385.035720892176;8652.653893844175;12841.422136004088;12862.67843303925;13211.735765284448;13270.27013514266;13350.065495415227;10136.341137826017;10647.680569582924;11162.274452160584;11211.775764484502;11639.88360116388;10117.949410252902;10308.948455257676;10460.63387781424;10776.515056822305;11010.724731881766;10702.036816686536;10870.293430926964;11501.654950351503;11566.363849988331;11638.243514171552;7136.928630713626;8305.12796156419;8386.203310685476;8582.871256931276;8591.742247732578;9604.95197524008;11013.2841365311;11279.718007049889;11654.009409199974;11658.18392712536 16:02:24 INFO - PROCESS | 1639 | |3;mootools.html;1325.251233053325;1448.2829964679631;1462.6050966239109;1489.240487351451;1493.036991140714;8082.070561885385;8463.026751923531;8479.703210387637;8501.659933602648;8529.360297977653;7502.249775022508;7780.6109694515335;7787.844243115134;7847.921520784805;8332.541710205936;2165.058199683139;2206.8455208135438;2321.129576408847;2405.0620258099357;2406.097713357491;2418.9637155442683;2427.927162185137;2432.5499782540196;2434.2818868433765;2435.2694191742494;2237.5636750833596;2270.7842754938256;2271.954560908781;2273.9994402462944;2277.1005452846116;1815.4372144635074;2193.3419974007816;2194.36363454598;2208.381653137124;2216.6231740604135;2365.3377054424786;2381.0832829360647;2393.3059412770276;2417.758224177586;2419.3104965085045;8397.916020839775;8410.747677569683;8481.236688698047;8498.022727386306;8508.064112947572;5169.4313625501545;5324.627276090675;5327.866803329909;5330.786768529254;5338.412774594792;3507.4914137450182;3537.3455910656353;3649.051246675857;3649.81750912456;3656.1042544576485;1254.8180513825534;1257.7547378261243;1259.2633309513944;1301.6485548901744;1308.6335825968745;10833;10885.020348168702;10897.346159230392;10903.236773425784;10908.618198363098;4605.240135377625;4725.787339569659;4808.735519546459;4810.7113573185725;4843.830465933675;8669.739907802776;8810.471371717718;8814.823703525894;8852.981907080768;8855.158759917798;4526.932096018562;5237.476252374732;5248.081585722483;5252.921206181911;5275.129603615361;4777.904441911142;4862.3922009748785;4944.035912996931;4944.085344211332;4945.7774400152075;3339.749518786101;3597.6222496637474;3710.05393624624;3770.7360484765804;4074.2869997750868;1117.5697356517637;1228.9877101229051;1298.6818229533824;1300.3043371796043;1309.8362704661918;799.1010113622175;804.0994086623019;816.4774544291658;819.4878201124297;827.8427098851199;5503.422140675251;5595.412481689364;5675.489205971482;5692.800751973661;5701.71491425427;1006.3408467453829;1012.7694850756367;1040;1042.5308611125024;1095.7589330347312;3709.4806727058235;3784.5836957934607;3817.599152089046;3828.942565861514;3851.9422208666892;9720;10011.949940250397;10054.74863128413;10084.2436817239;10084.394936303699;9763.414195148314;9767;9842.311038227255;10036.197104231644;10049;7845.607719613997;7980.600969951479;7990.200979901963;8001.279884810395;8016.679332826739;4847.684900481458;5482.945170548243;5502.642328248651;5572.331320241597;5768.2501274834;8748;9126.17864392208;9159.542022898962;9320.161185493338;9320.72037838866;9162;9210.217131543894;9319.114684105;9338.066193380608;9389.201917837061;7189.317014883578;7231.2768723127265;7310.707571697072;7330.486865919334;7343.52267102658;7250.3112204340505;7485.7754267372065;7776.533407995538;7837.216278372117;7854.842903141791;6982.162140543167;7061.752838650623;7085.574865508086;7103.82240443993;7123.928760712327;5757.884842303214;5998.550108741774;6880.931190688029;6909.827254318682;6973.895391569232;6343.682815859281;6467.60946396527;6467.611943283418;6470.967645161744;6471.417572418505;4854.077725232195;4883.852294710669;4997.2504124380175;5013.147764880052;5140.537351638221;4918.852434426973;4946.925796112989;5041.949580504148;5096.439391666988;5105.4384017757275 16:02:24 INFO - PROCESS | 1639 | |4;prototype.html;313.60642393795786;370.6978812268001;376.6666500147369;388.28943034247345;391.1472988884235;5244.4493328200515;5246.973765131173;5251.842444726654;5259.815906443275;5298.523132918037;3836.4245363195537;4801.759912004403;4971.577415919651;5006.274090256919;5085.720285384303;3291.8313998530416;3506.0358401439553;3758.3798673218885;4045.8381664733447;4089.284375234337;3600.6579374959338;4087.386891966199;4109.876703698894;4143.316352801784;4161.292580261363;3713.702903767692;3958.2083583283315;3979.8010099495054;4091.6112969267874;4101.9179616407655;3620.475031120499;3938;3949.4668219790246;3973.4834671315803;3980.4029395590605;3176.571162893026;3442.208292092808;3449.223924616966;3452;3463.0995941055253;4953.603711703091;5029.798808047673;5035.748212589356;5097.43928167905;5145.974270128625;4261.21167583998;4458.308962110878;4504.346869703907;4530.478994915594;4559.335842417527;4885.802978270311;5483.505005222614;5493.368262649807;5499.040690702687;5509.614326997112;3823.1648808571763;3825.5218097737784;3831.8275677594575;3853.2486165197797;3887.552931412867;4857.684250523669;5444.455554444524;5730.4269573042775;5730.656160630334;5780.971095144498;3272.4600440927456;3315.353506066294;3874.6706529945272;3879.80600969956;3882.078371206271;3223.323102148528;3388.423967925459;3941.3890846918775;3975.3241948868763;3985.2826491231276;4395.648348132142;4498.482674492475;4544.909101817945;4580.748058856795;4612.7924243409125;5078.873028174326;5482.655580096218;5492.642978206483;5516.475934786189;5584.246126772915;1221.132995573153;1247.5695884919687;1265.5191027409526;1277.6393141304482;1283.3903895649678;832.0888626953476;832.7543374704477;845.2857335551449;862.7713655881197;873.4148120759106;4266.338717498793;4611.486739726857;4874.635102171398;4886.291487734258;4900.754962251873;4644.790984405709;4712.340272361872;4808.903821923612;5258.921116183184;5301.3373328333955;4379.934300985487;4457.977710111429;4558.307770705739;4629.3518907353;4688.906221875543;2472.4807790364225;2778.7360200780895;2783.359827239746;2801.4817258807184;2809.6909339972585;5144.562712169508;5498.645826046109;5520.365158006881;5542.418046105182;5543.944560554423;4609.262517997171;4812;4935.731114491031;5305.549028332635;5392.514673679388;4743.31221972812;5426.864328391822;5470.234167216672;5482.984358602753;5502.697351645698;4309.784510774512;5037.319961805256;5270.657407268669;5302.170751090867;5306.25712400272;4502.977485112685;5184.948150518598;5222.537689446809;5230.4694331325445;5247.396549396715;4740.4785473597185;5481.464455426308;5487.75305111279;5492.423295553909;5567.610267281413;3045.5838035313686;3129.6386072058726;3132.5120567730146;3612.494250804837;3639.435042931565;4603.58567728906;5174.870628234325;5209.374875015023;5219.859857458424;5280.947190528045;4206.978965105155;4300.570177849505;4633.6061434777075;4986.902881366093;5096.974515127401;4526.411566496335;4784.378030855966;5105.259737337991;5105.489451054865;5114.8977020460125;4393.29707246839;4571.400009996474;4686.109639168547;4729.479757226633;5029.303461955386;5312;5325.174597937326;5359.624826262124;5467.469108649584;5494.2857428534035;4671.299305104261;5284.233786101071;5412.83761487156;5435.891282174255;5467.617266791286 16:02:24 INFO - PROCESS | 1639 | |5;yui.html;747.3348719639519;756.7237958145275;795.9204079592041;858.6136238692588;871.1636828644502;15268.694626107472;15829.97105188162;15860;15868.52394428169;15920.920395398021;14598.708025839476;14602.19687917164;14720;14720.6319842004;14722.926385368084;717.8959050937638;740.5852722475404;741.6180666956521;876.6449587916904;892.8258989497034;901.729481155654;901.8692289618001;913.4017218721748;913.8811954445946;915.5239275576696;968.1045033344163;971.9600027970075;972.1153750087421;972.5574863437155;972.9075737804898;966.2028826218398;968.6222373274429;969.6606187834202;970.1317320997703;970.8592254123113;639.9568703014104;687.3538873458932;719.6186021408662;720.459655258556;721.2715157690718;12833.230006199658;15487.690246195125;15741.606459838482;15887.52337429879;16175.595610109724;14949.626259343495;15243.009204401678;15357.692846143014;15371.769423458658;15397.846021539754;11377.943110284396;11643.534258629645;11878.346690931996;12118.39408029595;12147.331896745676;4566.1780879441685;4585.908281834345;4657.301404789275;4658.883527911796;4696.694714843524;108015;109307;109430;114670.27994580088;117835;11293;11389;11434.371109588887;11670.708232294091;11737.471813768401;23048.65427018596;23148.768512314997;23313.30060098166;23450.413739656644;23579.528409431714;7876.921230787733;7980.720674776355;7993.840123197503;8083.514989100673;8210.220029097227;4422.933655995163;4559.840405585788;4588.059447813191;4604.861854144381;4629.328747331618;3686.5576130863933;3790.56408513019;3791.1469919268498;3797.145642230476;3799.430085487144;669.1267895396456;682.8975653651893;687.2200052939949;688.1123350877313;714.6319645382632;702.2345643248883;726.8182954261434;739.7780665800238;754.8980887580216;776.953382797034;9808.73316644083;10364.429956352473;10438.843417348746;10498.265121441425;10572.420033209599;702.5819637315789;741.3402072155785;743.4424181863602;747.1706405889458;753.15270320889;4245.80893859777;4583.977080114578;4617.191991401492;4652.348671186037;4666.673332866734;102195;105903.4704826471;109777.35333969997;111717;112742;93971.53014234886;95535;96294.0370596285;96938;98342;70367.94448083283;73106.63446682839;79336;81725.36549268982;83748.16251837526;10911.83632245501;10971;11370.715732106433;11398.544058237578;11419.429028548706;46634.53365466302;47970.76014619905;48197.5180248207;48795.75602121967;49389.50610493849;60130.098048530184;60410;61001.38998610135;61264.69367653133;62712;13057.151285166814;13125.212487250796;13399.33003349809;13417.932910335387;13702.655745842641;14365.353559089657;14409.855901441271;14434.639134021734;14858.03422777516;14982.101073935599;13453.730925381633;13984.720305594035;14040.578782636538;14143.575692729235;14210.78683819723;11291.604793832177;13239.801402979156;13764.334748620975;14321.64195895111;14344.928275358556;13707.588772336845;13741.132990243694;13773.793393098911;14183.432662693376;14680;9829.262805289489;9929.900700992897;9969.850452243367;10474.842877356998;10544.525496352837;11170.162237832032;11271.267367621078;11294.548218071184;11394.487248074023;11428.14288928317 16:02:24 INFO - PROCESS | 1639 | __end_tp_report 16:02:24 INFO - PROCESS | 1639 | __start_cc_report 16:02:24 INFO - PROCESS | 1639 | _x_x_mozilla_cycle_collect,1705 16:02:24 INFO - PROCESS | 1639 | __end_cc_report 16:02:24 INFO - PROCESS | 1639 | __startTimestamp1491433344623__endTimestamp 16:02:24 INFO - PROCESS | 1639 | 16:02:24 INFO - PROCESS | 1639 | ------- Summary: start ------- 16:02:24 INFO - PROCESS | 1639 | Number of tests: 6 16:02:24 INFO - PROCESS | 1639 | 16:02:24 INFO - PROCESS | 1639 | [#0] dojo.html Cycles:165 Average:5779.37 Median:6067.24 stddev:646.85 (10.7%) stddev-sans-first:621.93 16:02:24 INFO - PROCESS | 1639 | Values: 3425.7 3467.4 3472.3 3476.7 3544.0 5684.9 5705.7 5766.7 5767.7 5777.9 5744.9 5818.7 5832.4 5837.9 5844.3 4809.9 5228.0 5251.0 5257.1 5315.5 5147.8 5183.6 5184.1 5320.9 5329.6 5248.8 5251.7 5302.0 5329.5 5332.7 4386.5 5316.4 5317.9 5327.0 5336.1 5177.2 5217.6 5251.2 5264.4 5303.1 5522.4 5618.5 5627.8 5693.9 5696.5 6213.9 6244.7 6258.8 6259.3 6271.7 6260.7 6273.5 6293.7 6306.0 6311.0 5773.6 5785.1 5802.7 5837.3 5883.3 6265.2 6328.7 6329.1 6340.4 6350.6 5141.7 6286.3 6300.0 6301.8 6311.0 6201.6 6232.0 6237.7 6282.9 6288.0 5128.2 6204.3 6220.3 6318.1 6318.6 6271.4 6272.7 6279.9 6285.3 6292.6 4986.2 5065.1 5114.2 5120.3 5142.7 4460.2 4482.1 4529.4 4530.1 4540.3 5930.6 5933.1 5958.8 5985.0 5989.3 6189.8 6229.8 6233.2 6253.3 6269.0 5110.9 5501.8 5791.6 5889.4 5923.3 5543.5 5579.3 5581.9 5602.7 5614.5 6434.6 6463.0 6475.6 6489.5 6494.2 6134.6 6201.3 6237.6 6243.6 6259.4 6312.9 6319.4 6356.3 6503.1 6506.8 5569.9 6264.7 6273.1 6294.5 6304.1 5265.8 6183.1 6218.2 6223.0 6227.8 6119.6 6122.6 6126.1 6126.4 6210.5 6131.9 6185.4 6192.6 6194.6 6201.0 6017.5 6067.2 6083.3 6091.8 6109.4 4801.2 5968.5 6137.6 6161.0 6185.6 6144.8 6145.3 6149.3 6152.3 6154.0 16:02:24 INFO - PROCESS | 1639 | 16:02:24 INFO - PROCESS | 1639 | [#1] ext.html Cycles:180 Average:70388.31 Median:205323.31 stddev:152244.32 (74.1%) stddev-sans-first:152581.02 16:02:24 INFO - PROCESS | 1639 | Values: 517.9 537.8 542.7 551.8 572.7 32550.8 42475.4 44402.3 44488.1 47125.3 46349.8 46687.5 46750.5 46764.0 46927.8 9575.6 9790.7 9793.8 9795.6 9800.5 8871.4 9131.6 11810.3 12033.5 12037.2 11730.2 11855.8 11878.5 11929.9 11961.4 11908.2 11992.2 11998.6 12001.3 12006.0 11739.2 11789.9 11801.2 11824.1 11827.0 42968.4 43253.9 43331.6 43472.6 43581.0 4022.3 4030.0 4059.1 4064.2 4120.8 29953.8 31861.8 31918.5 32286.7 32610.3 2724.9 3330.9 3343.6 3454.5 3567.9 369744.3 373625.0 374126.0 375362.0 376072.0 68534.0 68604.3 70904.3 71092.0 71405.6 74828.0 74842.0 74912.6 74968.0 75007.0 18069.2 18306.1 18356.4 18405.2 18424.4 12571.7 13754.9 13896.8 13927.2 13966.2 14486.8 17605.3 17629.9 17700.8 19430.2 7521.7 8774.3 8885.8 8901.6 9200.0 923.8 924.0 930.0 940.9 980.8 31786.5 32277.4 32364.8 33099.0 33154.5 1063.8 1069.9 1077.5 1094.9 1108.6 14710.6 14886.6 14969.9 15039.4 15149.9 651986.0 657848.7 657903.7 659846.0 661934.0 53649.7 54601.0 57240.0 58017.4 58287.4 1459.8 1489.6 1494.0 1510.2 1518.4 29683.9 30860.2 30959.1 31666.7 32110.8 50516.0 54124.7 55368.0 57506.4 58201.0 625463.0 632477.0 633182.0 633258.0 634455.0 42150.4 42567.8 42581.5 42920.6 43297.0 45432.0 46162.5 46597.5 46781.5 47164.0 31166.5 31528.7 31603.7 32618.0 32861.6 31152.5 31233.8 31408.1 31827.0 32169.4 37021.6 37796.4 37831.0 37997.8 38026.0 30044.7 30977.2 31188.8 32237.8 32238.0 23196.5 23835.6 24560.3 24693.5 24928.8 16:02:24 INFO - PROCESS | 1639 | 16:02:24 INFO - PROCESS | 1639 | [#2] jquery.html Cycles:180 Average:41518.97 Median:21738.34 stddev:129235.81 (594.5%) stddev-sans-first:129561.48 16:02:24 INFO - PROCESS | 1639 | Values: 402.5 403.6 407.8 414.5 429.7 20548.6 21701.9 21983.6 22553.0 22800.9 22081.9 22865.3 23147.5 23440.6 23494.6 5807.8 5893.8 6178.6 6188.2 6189.7 5623.6 6061.5 6108.8 6126.1 6134.5 5819.7 5975.2 6069.5 6084.2 6087.3 6060.8 6099.3 6108.4 6119.4 6121.8 5338.3 5360.9 5361.8 5542.6 5615.7 13825.9 14064.3 14070.8 19004.0 26029.7 2615.3 2654.6 2686.3 2688.1 2722.4 10246.9 10467.2 10636.8 10755.7 16088.2 1811.6 1837.8 1846.5 1859.8 1864.6 109158.5 125512.0 129919.0 132940.0 135078.0 11562.1 12035.4 12041.6 12055.9 12140.9 16144.6 16175.5 16176.9 16177.6 16196.3 8927.2 9073.8 9075.2 9094.5 9185.4 8920.1 8926.2 8939.2 9100.5 9105.7 4365.6 4757.4 4909.8 4911.6 4928.2 1757.7 1779.9 1950.0 1967.6 2002.4 1043.6 1058.6 1078.4 1096.7 1127.0 20561.6 21774.8 21818.3 21964.3 22005.7 1079.6 1087.3 1106.6 1112.3 1124.2 11170.5 11488.4 11506.5 11633.5 12532.3 770713.0 771769.0 774074.0 783004.0 790741.0 120968.0 140615.0 160347.0 163763.0 165725.2 1056.8 1061.6 1095.5 1096.1 1100.9 17501.8 19039.8 20873.6 21129.6 21243.6 48847.0 61762.7 61960.7 63340.7 63680.7 79271.0 85152.1 91024.1 93765.0 94305.5 7597.5 8018.4 8339.7 8385.0 8652.7 12841.4 12862.7 13211.7 13270.3 13350.1 10136.3 10647.7 11162.3 11211.8 11639.9 10117.9 10308.9 10460.6 10776.5 11010.7 10702.0 10870.3 11501.7 11566.4 11638.2 7136.9 8305.1 8386.2 8582.9 8591.7 9605.0 11013.3 11279.7 11654.0 11658.2 16:02:24 INFO - PROCESS | 1639 | 16:02:24 INFO - PROCESS | 1639 | [#3] mootools.html Cycles:180 Average:5421.78 Median:5100.94 stddev:2919.87 (57.2%) stddev-sans-first:2911.83 16:02:24 INFO - PROCESS | 1639 | Values: 1325.3 1448.3 1462.6 1489.2 1493.0 8082.1 8463.0 8479.7 8501.7 8529.4 7502.2 7780.6 7787.8 7847.9 8332.5 2165.1 2206.8 2321.1 2405.1 2406.1 2419.0 2427.9 2432.5 2434.3 2435.3 2237.6 2270.8 2272.0 2274.0 2277.1 1815.4 2193.3 2194.4 2208.4 2216.6 2365.3 2381.1 2393.3 2417.8 2419.3 8397.9 8410.7 8481.2 8498.0 8508.1 5169.4 5324.6 5327.9 5330.8 5338.4 3507.5 3537.3 3649.1 3649.8 3656.1 1254.8 1257.8 1259.3 1301.6 1308.6 10833.0 10885.0 10897.3 10903.2 10908.6 4605.2 4725.8 4808.7 4810.7 4843.8 8669.7 8810.5 8814.8 8853.0 8855.2 4526.9 5237.5 5248.1 5252.9 5275.1 4777.9 4862.4 4944.0 4944.1 4945.8 3339.7 3597.6 3710.1 3770.7 4074.3 1117.6 1229.0 1298.7 1300.3 1309.8 799.1 804.1 816.5 819.5 827.8 5503.4 5595.4 5675.5 5692.8 5701.7 1006.3 1012.8 1040.0 1042.5 1095.8 3709.5 3784.6 3817.6 3828.9 3851.9 9720.0 10011.9 10054.7 10084.2 10084.4 9763.4 9767.0 9842.3 10036.2 10049.0 7845.6 7980.6 7990.2 8001.3 8016.7 4847.7 5482.9 5502.6 5572.3 5768.3 8748.0 9126.2 9159.5 9320.2 9320.7 9162.0 9210.2 9319.1 9338.1 9389.2 7189.3 7231.3 7310.7 7330.5 7343.5 7250.3 7485.8 7776.5 7837.2 7854.8 6982.2 7061.8 7085.6 7103.8 7123.9 5757.9 5998.6 6880.9 6909.8 6973.9 6343.7 6467.6 6467.6 6471.0 6471.4 4854.1 4883.9 4997.3 5013.1 5140.5 4918.9 4946.9 5041.9 5096.4 5105.4 16:02:24 INFO - PROCESS | 1639 | 16:02:24 INFO - PROCESS | 1639 | [#4] prototype.html Cycles:180 Average:4292.77 Median:4700.62 stddev:1287.51 (27.4%) stddev-sans-first:1256.00 16:02:24 INFO - PROCESS | 1639 | Values: 313.6 370.7 376.7 388.3 391.1 5244.4 5247.0 5251.8 5259.8 5298.5 3836.4 4801.8 4971.6 5006.3 5085.7 3291.8 3506.0 3758.4 4045.8 4089.3 3600.7 4087.4 4109.9 4143.3 4161.3 3713.7 3958.2 3979.8 4091.6 4101.9 3620.5 3938.0 3949.5 3973.5 3980.4 3176.6 3442.2 3449.2 3452.0 3463.1 4953.6 5029.8 5035.7 5097.4 5146.0 4261.2 4458.3 4504.3 4530.5 4559.3 4885.8 5483.5 5493.4 5499.0 5509.6 3823.2 3825.5 3831.8 3853.2 3887.6 4857.7 5444.5 5730.4 5730.7 5781.0 3272.5 3315.4 3874.7 3879.8 3882.1 3223.3 3388.4 3941.4 3975.3 3985.3 4395.6 4498.5 4544.9 4580.7 4612.8 5078.9 5482.7 5492.6 5516.5 5584.2 1221.1 1247.6 1265.5 1277.6 1283.4 832.1 832.8 845.3 862.8 873.4 4266.3 4611.5 4874.6 4886.3 4900.8 4644.8 4712.3 4808.9 5258.9 5301.3 4379.9 4458.0 4558.3 4629.4 4688.9 2472.5 2778.7 2783.4 2801.5 2809.7 5144.6 5498.6 5520.4 5542.4 5543.9 4609.3 4812.0 4935.7 5305.5 5392.5 4743.3 5426.9 5470.2 5483.0 5502.7 4309.8 5037.3 5270.7 5302.2 5306.3 4503.0 5184.9 5222.5 5230.5 5247.4 4740.5 5481.5 5487.8 5492.4 5567.6 3045.6 3129.6 3132.5 3612.5 3639.4 4603.6 5174.9 5209.4 5219.9 5280.9 4207.0 4300.6 4633.6 4986.9 5097.0 4526.4 4784.4 5105.3 5105.5 5114.9 4393.3 4571.4 4686.1 4729.5 5029.3 5312.0 5325.2 5359.6 5467.5 5494.3 4671.3 5284.2 5412.8 5435.9 5467.6 16:02:24 INFO - PROCESS | 1639 | 16:02:24 INFO - PROCESS | 1639 | [#5] yui.html Cycles:180 Average:21007.01 Median:4022.62 stddev:30413.52 (756.1%) stddev-sans-first:30460.79 16:02:24 INFO - PROCESS | 1639 | Values: 747.3 756.7 795.9 858.6 871.2 15268.7 15830.0 15860.0 15868.5 15920.9 14598.7 14602.2 14720.0 14720.6 14722.9 717.9 740.6 741.6 876.6 892.8 901.7 901.9 913.4 913.9 915.5 968.1 972.0 972.1 972.6 972.9 966.2 968.6 969.7 970.1 970.9 640.0 687.4 719.6 720.5 721.3 12833.2 15487.7 15741.6 15887.5 16175.6 14949.6 15243.0 15357.7 15371.8 15397.8 11377.9 11643.5 11878.3 12118.4 12147.3 4566.2 4585.9 4657.3 4658.9 4696.7 108015.0 109307.0 109430.0 114670.3 117835.0 11293.0 11389.0 11434.4 11670.7 11737.5 23048.7 23148.8 23313.3 23450.4 23579.5 7876.9 7980.7 7993.8 8083.5 8210.2 4422.9 4559.8 4588.1 4604.9 4629.3 3686.6 3790.6 3791.1 3797.1 3799.4 669.1 682.9 687.2 688.1 714.6 702.2 726.8 739.8 754.9 777.0 9808.7 10364.4 10438.8 10498.3 10572.4 702.6 741.3 743.4 747.2 753.2 4245.8 4584.0 4617.2 4652.3 4666.7 102195.0 105903.5 109777.4 111717.0 112742.0 93971.5 95535.0 96294.0 96938.0 98342.0 70367.9 73106.6 79336.0 81725.4 83748.2 10911.8 10971.0 11370.7 11398.5 11419.4 46634.5 47970.8 48197.5 48795.8 49389.5 60130.1 60410.0 61001.4 61264.7 62712.0 13057.2 13125.2 13399.3 13417.9 13702.7 14365.4 14409.9 14434.6 14858.0 14982.1 13453.7 13984.7 14040.6 14143.6 14210.8 11291.6 13239.8 13764.3 14321.6 14344.9 13707.6 13741.1 13773.8 14183.4 14680.0 9829.3 9929.9 9969.9 10474.8 10544.5 11170.2 11271.3 11294.5 11394.5 11428.1 16:02:24 INFO - PROCESS | 1639 | -------- Summary: end -------- 16:02:24 INFO - PROCESS | 1639 | 16:02:25 INFO - TEST-INFO | 1639: exit 0 16:02:25 INFO - TEST-OK | dromaeo_css | took 1116576ms 16:02:25 INFO - TEST-START | kraken 16:02:25 INFO - operating with platform_type : mac_ 16:02:25 INFO - Initialising browser for kraken test... 16:02:25 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/tmpFsPZkF/profile http://localhost:49236/getInfo.html) 16:02:27 INFO - PROCESS | 1648 | __metrics Screen width/height:1600/1200 16:02:27 INFO - PROCESS | 1648 | colorDepth:24 16:02:27 INFO - PROCESS | 1648 | Browser inner width/height: 1024/689 16:02:27 INFO - PROCESS | 1648 | __metrics 16:02:27 INFO - PROCESS | 1648 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 16:02:27 INFO - PROCESS | 1648 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:02:28 INFO - TEST-INFO | 1648: exit 0 16:02:28 INFO - Browser initialized. 16:02:28 INFO - Running cycle 1/1 for kraken test... 16:02:28 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/tmpFsPZkF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:02:40 INFO - PROCESS | 1650 | RSS: Main: 164093952 16:02:40 INFO - PROCESS | 1650 | 16:02:42 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-beat-detection) 16:02:43 INFO - PROCESS | 1650 | RSS: Main: 214351872 16:02:43 INFO - PROCESS | 1650 | 16:02:46 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-dft) 16:02:46 INFO - PROCESS | 1650 | RSS: Main: 228782080 16:02:46 INFO - PROCESS | 1650 | 16:02:49 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-fft) 16:02:50 INFO - PROCESS | 1650 | RSS: Main: 324874240 16:02:50 INFO - PROCESS | 1650 | 16:02:52 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-oscillator) 16:02:53 INFO - PROCESS | 1650 | RSS: Main: 228364288 16:02:53 INFO - PROCESS | 1650 | 16:02:55 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:02:55 INFO - PROCESS | 1650 | RSS: Main: 231096320 16:02:55 INFO - PROCESS | 1650 | 16:02:58 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-darkroom) 16:02:59 INFO - PROCESS | 1650 | RSS: Main: 271224832 16:02:59 INFO - PROCESS | 1650 | 16:03:02 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-desaturate) 16:03:02 INFO - PROCESS | 1650 | RSS: Main: 269946880 16:03:02 INFO - PROCESS | 1650 | 16:03:05 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49236/tests/kraken/driver.html?testName=json-parse-financial) 16:03:06 INFO - PROCESS | 1650 | RSS: Main: 265670656 16:03:06 INFO - PROCESS | 1650 | 16:03:07 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49236/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:03:08 INFO - PROCESS | 1650 | RSS: Main: 245481472 16:03:08 INFO - PROCESS | 1650 | 16:03:10 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:03:10 INFO - PROCESS | 1650 | RSS: Main: 246341632 16:03:10 INFO - PROCESS | 1650 | 16:03:13 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:03:13 INFO - PROCESS | 1650 | RSS: Main: 257179648 16:03:13 INFO - PROCESS | 1650 | 16:03:16 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:03:17 INFO - PROCESS | 1650 | RSS: Main: 270024704 16:03:17 INFO - PROCESS | 1650 | 16:03:20 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:03:20 INFO - PROCESS | 1650 | RSS: Main: 263467008 16:03:20 INFO - PROCESS | 1650 | 16:03:22 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49236/tests/kraken/driver.html?testName=ai-astar) 16:03:22 INFO - PROCESS | 1650 | RSS: Main: 307671040 16:03:22 INFO - PROCESS | 1650 | 16:03:22 INFO - PROCESS | 1650 | __start_tp_report 16:03:22 INFO - PROCESS | 1650 | _x_x_mozilla_page_load 16:03:22 INFO - PROCESS | 1650 | _x_x_mozilla_page_load_details 16:03:22 INFO - PROCESS | 1650 | |i|pagename|runs| 16:03:22 INFO - PROCESS | 1650 | |0;ai-astar;103;114;113;114;114;115;114;114;111;115 16:03:22 INFO - PROCESS | 1650 | |1;audio-beat-detection;139;107;105;141;109;103;107;106;126;107 16:03:22 INFO - PROCESS | 1650 | |2;audio-dft;203;262;200;186;182;183;184;182;183;181 16:03:22 INFO - PROCESS | 1650 | |3;audio-fft;79;58;58;93;61;58;57;57;72;57 16:03:22 INFO - PROCESS | 1650 | |4;audio-oscillator;87;70;85;73;93;98;83;67;68;82 16:03:22 INFO - PROCESS | 1650 | |5;imaging-gaussian-blur;90;87;89;89;135;87;90;87;89;85 16:03:22 INFO - PROCESS | 1650 | |6;imaging-darkroom;94;94;94;94;94;93;93;94;93;93 16:03:22 INFO - PROCESS | 1650 | |7;imaging-desaturate;87;90;72;130;131;133;84;84;87;84 16:03:22 INFO - PROCESS | 1650 | |8;json-parse-financial;56;51;52;52;55;55;55;57;56;55 16:03:22 INFO - PROCESS | 1650 | |9;json-stringify-tinderbox;64;72;71;74;70;67;69;68;67;69 16:03:22 INFO - PROCESS | 1650 | |10;stanford-crypto-aes;84;82;78;83;83;79;85;81;82;87 16:03:22 INFO - PROCESS | 1650 | |11;stanford-crypto-ccm;132;134;131;131;131;131;133;134;171;151 16:03:22 INFO - PROCESS | 1650 | |12;stanford-crypto-pbkdf2;161;190;192;161;160;161;168;216;196;162 16:03:22 INFO - PROCESS | 1650 | |13;stanford-crypto-sha256-iterative;64;65;64;64;66;64;63;63;63;64 16:03:22 INFO - PROCESS | 1650 | __end_tp_report 16:03:22 INFO - PROCESS | 1650 | __start_cc_report 16:03:22 INFO - PROCESS | 1650 | _x_x_mozilla_cycle_collect,1972 16:03:22 INFO - PROCESS | 1650 | __end_cc_report 16:03:22 INFO - PROCESS | 1650 | __startTimestamp1491433402687__endTimestamp 16:03:22 INFO - PROCESS | 1650 | 16:03:22 INFO - PROCESS | 1650 | ------- Summary: start ------- 16:03:22 INFO - PROCESS | 1650 | Number of tests: 14 16:03:22 INFO - PROCESS | 1650 | 16:03:22 INFO - PROCESS | 1650 | [#0] ai-astar Cycles:10 Average:112.70 Median:114.00 stddev:3.59 (3.2%) stddev-sans-first:1.20 16:03:22 INFO - PROCESS | 1650 | Values: 103.0 114.0 113.0 114.0 114.0 115.0 114.0 114.0 111.0 115.0 16:03:22 INFO - PROCESS | 1650 | 16:03:22 INFO - PROCESS | 1650 | [#1] audio-beat-detection Cycles:10 Average:115.00 Median:108.00 stddev:14.63 (13.5%) stddev-sans-first:12.68 16:03:22 INFO - PROCESS | 1650 | Values: 139.0 107.0 105.0 141.0 109.0 103.0 107.0 106.0 126.0 107.0 16:03:22 INFO - PROCESS | 1650 | 16:03:22 INFO - PROCESS | 1650 | [#2] audio-dft Cycles:10 Average:194.60 Median:185.00 stddev:24.95 (13.5%) stddev-sans-first:26.27 16:03:22 INFO - PROCESS | 1650 | Values: 203.0 262.0 200.0 186.0 182.0 183.0 184.0 182.0 183.0 181.0 16:03:22 INFO - PROCESS | 1650 | 16:03:22 INFO - PROCESS | 1650 | [#3] audio-fft Cycles:10 Average:65.00 Median:59.50 stddev:12.40 (20.8%) stddev-sans-first:12.07 16:03:22 INFO - PROCESS | 1650 | Values: 79.0 58.0 58.0 93.0 61.0 58.0 57.0 57.0 72.0 57.0 16:03:22 INFO - PROCESS | 1650 | 16:03:22 INFO - PROCESS | 1650 | [#4] audio-oscillator Cycles:10 Average:80.60 Median:84.00 stddev:10.74 (12.8%) stddev-sans-first:11.14 16:03:22 INFO - PROCESS | 1650 | Values: 87.0 70.0 85.0 73.0 93.0 98.0 83.0 67.0 68.0 82.0 16:03:22 INFO - PROCESS | 1650 | 16:03:22 INFO - PROCESS | 1650 | [#5] imaging-gaussian-blur Cycles:10 Average:92.80 Median:89.00 stddev:14.91 (16.8%) stddev-sans-first:15.78 16:03:22 INFO - PROCESS | 1650 | Values: 90.0 87.0 89.0 89.0 135.0 87.0 90.0 87.0 89.0 85.0 16:03:22 INFO - PROCESS | 1650 | 16:03:22 INFO - PROCESS | 1650 | [#6] imaging-darkroom Cycles:10 Average:93.60 Median:94.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 16:03:22 INFO - PROCESS | 1650 | Values: 94.0 94.0 94.0 94.0 94.0 93.0 93.0 94.0 93.0 93.0 16:03:22 INFO - PROCESS | 1650 | 16:03:22 INFO - PROCESS | 1650 | [#7] imaging-desaturate Cycles:10 Average:98.20 Median:84.00 stddev:23.35 (27.8%) stddev-sans-first:24.41 16:03:22 INFO - PROCESS | 1650 | Values: 87.0 90.0 72.0 130.0 131.0 133.0 84.0 84.0 87.0 84.0 16:03:22 INFO - PROCESS | 1650 | 16:03:22 INFO - PROCESS | 1650 | [#8] json-parse-financial Cycles:10 Average:54.40 Median:55.00 stddev:2.01 (3.7%) stddev-sans-first:2.05 16:03:22 INFO - PROCESS | 1650 | Values: 56.0 51.0 52.0 52.0 55.0 55.0 55.0 57.0 56.0 55.0 16:03:22 INFO - PROCESS | 1650 | 16:03:22 INFO - PROCESS | 1650 | [#9] json-stringify-tinderbox Cycles:10 Average:69.10 Median:69.50 stddev:2.85 (4.1%) stddev-sans-first:2.35 16:03:22 INFO - PROCESS | 1650 | Values: 64.0 72.0 71.0 74.0 70.0 67.0 69.0 68.0 67.0 69.0 16:03:22 INFO - PROCESS | 1650 | 16:03:22 INFO - PROCESS | 1650 | [#10] stanford-crypto-aes Cycles:10 Average:82.40 Median:83.00 stddev:2.67 (3.2%) stddev-sans-first:2.77 16:03:22 INFO - PROCESS | 1650 | Values: 84.0 82.0 78.0 83.0 83.0 79.0 85.0 81.0 82.0 87.0 16:03:22 INFO - PROCESS | 1650 | 16:03:22 INFO - PROCESS | 1650 | [#11] stanford-crypto-ccm Cycles:10 Average:137.90 Median:133.50 stddev:13.11 (9.8%) stddev-sans-first:13.73 16:03:22 INFO - PROCESS | 1650 | Values: 132.0 134.0 131.0 131.0 131.0 131.0 133.0 134.0 171.0 151.0 16:03:22 INFO - PROCESS | 1650 | 16:03:22 INFO - PROCESS | 1650 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.70 Median:179.00 stddev:20.11 (11.2%) stddev-sans-first:20.51 16:03:22 INFO - PROCESS | 1650 | Values: 161.0 190.0 192.0 161.0 160.0 161.0 168.0 216.0 196.0 162.0 16:03:22 INFO - PROCESS | 1650 | 16:03:22 INFO - PROCESS | 1650 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.00 Median:64.00 stddev:0.94 (1.5%) stddev-sans-first:1.00 16:03:22 INFO - PROCESS | 1650 | Values: 64.0 65.0 64.0 64.0 66.0 64.0 63.0 63.0 63.0 64.0 16:03:22 INFO - PROCESS | 1650 | -------- Summary: end -------- 16:03:22 INFO - PROCESS | 1650 | 16:03:23 INFO - TEST-INFO | 1650: exit 0 16:03:23 INFO - TEST-OK | kraken | took 58307ms 16:03:23 INFO - SUITE-END | took 1174s 16:03:23 INFO - Completed test suite (00:19:35) 16:03:23 INFO - javascript benchmark 16:03:23 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3425.725941924646, 3467.4452087665964, 3472.288180922911, 3476.7044801191896, 3543.964560354396, 5684.886302273952, 5705.686187259705, 5766.740496677654, 5767.740451679674, 5777.931082749689, 5744.942550574493, 5818.679972601505, 5832.387599302076, 5837.941620583803, 5844.298684157897, 4809.855704328876, 5227.973860130713, 5250.973745131269, 5257.106291930381, 5315.521603055724, 5147.7683504242395, 5183.6371453998045, 5184.066867963765, 5320.9467905320835, 5329.600279978998, 5248.816291429801, 5251.658642188265, 5301.966116607263, 5329.520343169114, 5332.653377530468, 4386.495553011413, 5316.415194328621, 5317.867053323678, 5327.0, 5336.119540275849, 5177.249298851645, 5217.634765566412, 5251.159814429711, 5264.368275806889, 5303.071962406563, 5522.3649280332875, 5618.4662457066515, 5627.803026894039, 5693.943060569382, 5696.544276457915, 6213.875722485525, 6244.687765611747, 6258.843528911768, 6259.311475737665, 6271.655058971754, 6260.655663938482, 6273.498120150377, 6293.653849038301, 6306.0, 6310.968445157745, 5773.595848290622, 5785.103308987113, 5802.6808525531505, 5837.270341207349, 5883.294004719375, 6265.185525881606, 6328.71520781566, 6329.082283068929, 6340.365963403623, 6350.618962862243, 5141.717205553656, 6286.277078136073, 6299.96850015747, 6301.842453938597, 6310.968445157745, 6201.56589038772, 6232.0, 6237.656928868865, 6282.905756413657, 6288.0, 5128.205128205134, 6204.255489341218, 6220.346863579259, 6318.115463835067, 6318.557700960889, 6271.372862713783, 6272.686365681698, 6279.905801412982, 6285.340039295808, 6292.559520833589, 4986.152354099811, 5065.138926382524, 5114.232865070269, 5120.308758317654, 5142.742862856842, 4460.241758900995, 4482.103579284156, 4529.38853254813, 4530.139273538017, 4540.296254080623, 5930.644161350333, 5933.110033495011, 5958.821235362946, 5985.042393217064, 5989.341172471025, 6189.8452538686, 6229.844253893598, 6233.158523599256, 6253.280872699698, 6269.0, 5110.9488905110475, 5501.779928802803, 5791.594588378773, 5889.38161493037, 5923.318818335861, 5543.501084902378, 5579.302587176603, 5581.860453488614, 5602.719864006784, 5614.522765564891, 6434.64609446485, 6463.0, 6475.611463312311, 6489.513286503626, 6494.155759751202, 6134.5590473767, 6201.317855036033, 6237.563370564017, 6243.594166379171, 6259.374062593704, 6312.936870631235, 6319.399657032574, 6356.269029061532, 6503.122078519528, 6506.772262970773, 5569.888602227852, 6264.718087685974, 6273.090401891792, 6294.464970477561, 6304.148939893055, 5265.78936842522, 6183.103449999635, 6218.204625324791, 6222.968885155546, 6227.844303892439, 6119.632822030692, 6122.571420000557, 6126.059675755388, 6126.365000174519, 6210.534209934182, 6131.938680613137, 6185.381461853958, 6192.59748116371, 6194.5973511721595, 6200.976838821544, 6017.518598512196, 6067.24159480065, 6083.330833608211, 6091.786787462417, 6109.358517355614, 4801.18379875415, 5968.522518198447, 6137.560853825989, 6161.045038019114, 6185.597936134137, 6144.846378840565, 6145.324014358328, 6149.2620885494025, 6152.261728592597, 6154.0], "value": 5740.767734219339, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [517.8964207158568, 537.8225185688723, 542.7204989430444, 551.81635392084, 572.736541191052, 32550.837245813767, 42475.36286955694, 44402.33396499051, 44488.11023779523, 47125.293120603215, 46349.7682511587, 46687.53312466874, 46750.53249467504, 46764.0, 46927.76536117323, 9575.569099390526, 9790.706278811647, 9793.755156121082, 9795.608175672964, 9800.460974646392, 8871.423357481775, 9131.589078491485, 11810.291382517076, 12033.51865925362, 12037.21758085726, 11730.17888747788, 11855.7628847423, 11878.465469053914, 11929.94035029828, 11961.40192990347, 11908.225965312271, 11992.22050566719, 11998.58004969822, 12001.279923204636, 12006.039516838631, 11739.23694959825, 11789.882101178964, 11801.232919860182, 11824.11319151067, 11827.0, 42968.35547466791, 43253.91865203364, 43331.56668433307, 43472.565274347166, 43581.0, 4022.255882661717, 4029.97985010076, 4059.147579008412, 4064.1668457966343, 4120.773357465338, 29953.767661302038, 31861.84069079663, 31918.521222181687, 32286.708531658707, 32610.347793044006, 2724.945501089967, 3330.8748779077996, 3343.632200457948, 3454.481827725836, 3567.946480802764, 369744.30255697365, 373625.0, 374126.0, 375362.0, 376072.0, 68534.0, 68604.31395686079, 70904.2909570908, 71092.0, 71405.64297178481, 74828.0, 74842.0, 74912.62543687246, 74968.0, 75007.0, 18069.186886590134, 18306.08469576516, 18356.449306520826, 18405.171767270505, 18424.35514756977, 12571.748565028649, 13754.93122534381, 13896.791548126786, 13927.234002129777, 13966.162030278216, 14486.782698259534, 17605.29578816833, 17629.911850440923, 17700.822991769917, 19430.2227910882, 7521.699132034657, 8774.298056155492, 8885.844840170736, 8901.554922253861, 9200.0, 923.7644400677918, 923.9769005774775, 929.9674511392069, 940.948247846375, 980.7989362180735, 31786.523202151988, 32277.35445291128, 32364.83817580897, 33099.0, 33154.50268245978, 1063.8457423673678, 1069.9029901393355, 1077.488193108283, 1094.934303941766, 1108.578740078765, 14710.55868323952, 14886.627834304012, 14969.850301497063, 15039.398424062914, 15149.939504234819, 651986.0, 657848.7107564432, 657903.7104814445, 659846.0, 661934.0, 53649.731751340994, 54601.0, 57240.0, 58017.419825801204, 58287.417125829044, 1459.8248210214842, 1489.5754709907624, 1493.9850601493845, 1510.1618601676175, 1518.3926429428318, 29683.851580742823, 30860.22849428782, 30959.0712278632, 31666.683333167293, 32110.839445802623, 50516.0, 54124.729376352865, 55368.0, 57506.424935751784, 58201.0, 625463.0, 632477.0, 633182.0, 633258.0, 634455.0, 42150.36774448324, 42567.787161064, 42581.46061824484, 42920.570794291656, 43297.0, 45432.0, 46162.538374615826, 46597.53402466067, 46781.532184677715, 47164.0, 31166.532502012942, 31528.684713152576, 31603.73585056572, 32618.0, 32861.56368890169, 31152.532712008884, 31233.8438307807, 31408.05775826729, 31827.0, 32169.35661286808, 37021.62978370182, 37796.43305350477, 37831.0, 37997.81001094977, 38026.0, 30044.69955300419, 30977.225569360948, 31188.844055779577, 32237.838810805795, 32238.0, 23196.536069278856, 23835.64246536338, 24560.263192104267, 24693.506129876943, 24928.75071249264], "value": 21053.932196829857, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [402.4968789013733, 403.59237170457845, 407.76553481748005, 414.4591308342614, 429.66700806874667, 20548.589028219427, 21701.891490542526, 21983.560328793435, 22553.0, 22800.88599557004, 22081.889590552026, 22865.31404057881, 23147.537049259005, 23440.648390274117, 23494.64758028631, 5807.767689292423, 5893.823185304448, 6178.629282243057, 6188.195534580498, 6189.721462534197, 5623.634463759863, 6061.45446909778, 6108.755649774003, 6126.142340072393, 6134.539909506782, 5819.650820950736, 5975.193348897908, 6069.453749162574, 6084.1786358841655, 6087.3303936566945, 6060.787872424466, 6099.268087829444, 6108.389161083878, 6119.357467465941, 6121.816345509642, 5338.252644629755, 5360.892782144335, 5361.758720857531, 5542.612017158801, 5615.691136987464, 13825.930870345584, 14064.296785160803, 14070.788938165935, 19004.0, 26029.73970260292, 2615.2938706549317, 2654.5752679571174, 2686.3149896776395, 2688.0591792872533, 2722.414680843628, 10246.89753102467, 10467.214958878114, 10636.840447393295, 10755.677329680044, 16088.195590220443, 1811.5652243461607, 1837.7610910581539, 1846.5199048247418, 1859.7954225035235, 1864.6270745850884, 109158.45420772924, 125512.0, 129919.0, 132940.0, 135078.0, 11562.132840037031, 12035.39823008846, 12041.578544750892, 12055.87944120565, 12140.939295303644, 16144.596385090466, 16175.514734557983, 16176.919115404347, 16177.59556011109, 16196.271167797242, 8927.151920567536, 9073.77315567103, 9075.2286055686, 9094.454332740057, 9185.35702500832, 8920.063393343735, 8926.152015558511, 8939.195472407515, 9100.544972751335, 9105.726828195166, 4365.646649538653, 4757.429108506932, 4909.803607855717, 4911.607071434277, 4928.162212423897, 1757.650359259169, 1779.946601601954, 1949.9610007799765, 1967.5868067705655, 2002.4192984034466, 1043.5564884923876, 1058.5762149908362, 1078.412265315405, 1096.71485413793, 1127.0, 20561.588768224552, 21774.782252177592, 21818.345449636538, 21964.341069767932, 22005.66991495129, 1079.6167360587035, 1087.282393620207, 1106.623747925709, 1112.3214838948236, 1124.241137232365, 11170.497327620276, 11488.368139752394, 11506.482208300478, 11633.53465861356, 12532.310722910144, 770713.0, 771769.0, 774074.0, 783004.0, 790741.0, 120968.0, 140615.0, 160347.0, 163763.0, 165725.17137414234, 1056.7939251845817, 1061.5647584490323, 1095.5398732532356, 1096.0628662493452, 1100.9394483303336, 17501.824981750528, 19039.80960190436, 20873.582528349045, 21129.577408452053, 21243.575128497036, 48846.99999999858, 61762.69118654378, 61960.69019654873, 63340.68329658506, 63680.68159659172, 79271.0, 85152.1484785169, 91024.08975910157, 93765.0, 94305.5284723572, 7597.468177227541, 8018.398620103399, 8339.749807505785, 8385.035720892176, 8652.653893844175, 12841.422136004088, 12862.67843303925, 13211.735765284448, 13270.27013514266, 13350.065495415227, 10136.341137826017, 10647.680569582924, 11162.274452160584, 11211.775764484502, 11639.88360116388, 10117.949410252902, 10308.948455257676, 10460.63387781424, 10776.515056822305, 11010.724731881766, 10702.036816686536, 10870.293430926964, 11501.654950351503, 11566.363849988331, 11638.243514171552, 7136.928630713626, 8305.12796156419, 8386.203310685476, 8582.871256931276, 8591.742247732578, 9604.95197524008, 11013.2841365311, 11279.718007049889, 11654.009409199974, 11658.18392712536], "value": 10092.421824546765, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1325.251233053325, 1448.2829964679631, 1462.6050966239109, 1489.240487351451, 1493.036991140714, 8082.070561885385, 8463.026751923531, 8479.703210387637, 8501.659933602648, 8529.360297977653, 7502.249775022508, 7780.6109694515335, 7787.844243115134, 7847.921520784805, 8332.541710205936, 2165.058199683139, 2206.8455208135438, 2321.129576408847, 2405.0620258099357, 2406.097713357491, 2418.9637155442683, 2427.927162185137, 2432.5499782540196, 2434.2818868433765, 2435.2694191742494, 2237.5636750833596, 2270.7842754938256, 2271.954560908781, 2273.9994402462944, 2277.1005452846116, 1815.4372144635074, 2193.3419974007816, 2194.36363454598, 2208.381653137124, 2216.6231740604135, 2365.3377054424786, 2381.0832829360647, 2393.3059412770276, 2417.758224177586, 2419.3104965085045, 8397.916020839775, 8410.747677569683, 8481.236688698047, 8498.022727386306, 8508.064112947572, 5169.4313625501545, 5324.627276090675, 5327.866803329909, 5330.786768529254, 5338.412774594792, 3507.4914137450182, 3537.3455910656353, 3649.051246675857, 3649.81750912456, 3656.1042544576485, 1254.8180513825534, 1257.7547378261243, 1259.2633309513944, 1301.6485548901744, 1308.6335825968745, 10833.0, 10885.020348168702, 10897.346159230392, 10903.236773425784, 10908.618198363098, 4605.240135377625, 4725.787339569659, 4808.735519546459, 4810.7113573185725, 4843.830465933675, 8669.739907802776, 8810.471371717718, 8814.823703525894, 8852.981907080768, 8855.158759917798, 4526.932096018562, 5237.476252374732, 5248.081585722483, 5252.921206181911, 5275.129603615361, 4777.904441911142, 4862.3922009748785, 4944.035912996931, 4944.085344211332, 4945.7774400152075, 3339.749518786101, 3597.6222496637474, 3710.05393624624, 3770.7360484765804, 4074.2869997750868, 1117.5697356517637, 1228.9877101229051, 1298.6818229533824, 1300.3043371796043, 1309.8362704661918, 799.1010113622175, 804.0994086623019, 816.4774544291658, 819.4878201124297, 827.8427098851199, 5503.422140675251, 5595.412481689364, 5675.489205971482, 5692.800751973661, 5701.71491425427, 1006.3408467453829, 1012.7694850756367, 1040.0, 1042.5308611125024, 1095.7589330347312, 3709.4806727058235, 3784.5836957934607, 3817.599152089046, 3828.942565861514, 3851.9422208666892, 9720.0, 10011.949940250397, 10054.74863128413, 10084.2436817239, 10084.394936303699, 9763.414195148314, 9767.0, 9842.311038227255, 10036.197104231644, 10049.0, 7845.607719613997, 7980.600969951479, 7990.200979901963, 8001.279884810395, 8016.679332826739, 4847.684900481458, 5482.945170548243, 5502.642328248651, 5572.331320241597, 5768.2501274834, 8748.0, 9126.17864392208, 9159.542022898962, 9320.161185493338, 9320.72037838866, 9162.0, 9210.217131543894, 9319.114684105, 9338.066193380608, 9389.201917837061, 7189.317014883578, 7231.2768723127265, 7310.707571697072, 7330.486865919334, 7343.52267102658, 7250.3112204340505, 7485.7754267372065, 7776.533407995538, 7837.216278372117, 7854.842903141791, 6982.162140543167, 7061.752838650623, 7085.574865508086, 7103.82240443993, 7123.928760712327, 5757.884842303214, 5998.550108741774, 6880.931190688029, 6909.827254318682, 6973.895391569232, 6343.682815859281, 6467.60946396527, 6467.611943283418, 6470.967645161744, 6471.417572418505, 4854.077725232195, 4883.852294710669, 4997.2504124380175, 5013.147764880052, 5140.537351638221, 4918.852434426973, 4946.925796112989, 5041.949580504148, 5096.439391666988, 5105.4384017757275], "value": 4426.554252902659, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [313.60642393795786, 370.6978812268001, 376.6666500147369, 388.28943034247345, 391.1472988884235, 5244.4493328200515, 5246.973765131173, 5251.842444726654, 5259.815906443275, 5298.523132918037, 3836.4245363195537, 4801.759912004403, 4971.577415919651, 5006.274090256919, 5085.720285384303, 3291.8313998530416, 3506.0358401439553, 3758.3798673218885, 4045.8381664733447, 4089.284375234337, 3600.6579374959338, 4087.386891966199, 4109.876703698894, 4143.316352801784, 4161.292580261363, 3713.702903767692, 3958.2083583283315, 3979.8010099495054, 4091.6112969267874, 4101.9179616407655, 3620.475031120499, 3938.0, 3949.4668219790246, 3973.4834671315803, 3980.4029395590605, 3176.571162893026, 3442.208292092808, 3449.223924616966, 3452.0, 3463.0995941055253, 4953.603711703091, 5029.798808047673, 5035.748212589356, 5097.43928167905, 5145.974270128625, 4261.21167583998, 4458.308962110878, 4504.346869703907, 4530.478994915594, 4559.335842417527, 4885.802978270311, 5483.505005222614, 5493.368262649807, 5499.040690702687, 5509.614326997112, 3823.1648808571763, 3825.5218097737784, 3831.8275677594575, 3853.2486165197797, 3887.552931412867, 4857.684250523669, 5444.455554444524, 5730.4269573042775, 5730.656160630334, 5780.971095144498, 3272.4600440927456, 3315.353506066294, 3874.6706529945272, 3879.80600969956, 3882.078371206271, 3223.323102148528, 3388.423967925459, 3941.3890846918775, 3975.3241948868763, 3985.2826491231276, 4395.648348132142, 4498.482674492475, 4544.909101817945, 4580.748058856795, 4612.7924243409125, 5078.873028174326, 5482.655580096218, 5492.642978206483, 5516.475934786189, 5584.246126772915, 1221.132995573153, 1247.5695884919687, 1265.5191027409526, 1277.6393141304482, 1283.3903895649678, 832.0888626953476, 832.7543374704477, 845.2857335551449, 862.7713655881197, 873.4148120759106, 4266.338717498793, 4611.486739726857, 4874.635102171398, 4886.291487734258, 4900.754962251873, 4644.790984405709, 4712.340272361872, 4808.903821923612, 5258.921116183184, 5301.3373328333955, 4379.934300985487, 4457.977710111429, 4558.307770705739, 4629.3518907353, 4688.906221875543, 2472.4807790364225, 2778.7360200780895, 2783.359827239746, 2801.4817258807184, 2809.6909339972585, 5144.562712169508, 5498.645826046109, 5520.365158006881, 5542.418046105182, 5543.944560554423, 4609.262517997171, 4812.0, 4935.731114491031, 5305.549028332635, 5392.514673679388, 4743.31221972812, 5426.864328391822, 5470.234167216672, 5482.984358602753, 5502.697351645698, 4309.784510774512, 5037.319961805256, 5270.657407268669, 5302.170751090867, 5306.25712400272, 4502.977485112685, 5184.948150518598, 5222.537689446809, 5230.4694331325445, 5247.396549396715, 4740.4785473597185, 5481.464455426308, 5487.75305111279, 5492.423295553909, 5567.610267281413, 3045.5838035313686, 3129.6386072058726, 3132.5120567730146, 3612.494250804837, 3639.435042931565, 4603.58567728906, 5174.870628234325, 5209.374875015023, 5219.859857458424, 5280.947190528045, 4206.978965105155, 4300.570177849505, 4633.6061434777075, 4986.902881366093, 5096.974515127401, 4526.411566496335, 4784.378030855966, 5105.259737337991, 5105.489451054865, 5114.8977020460125, 4393.29707246839, 4571.400009996474, 4686.109639168547, 4729.479757226633, 5029.303461955386, 5312.0, 5325.174597937326, 5359.624826262124, 5467.469108649584, 5494.2857428534035, 4671.299305104261, 5284.233786101071, 5412.83761487156, 5435.891282174255, 5467.617266791286], "value": 3902.941285444649, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [747.3348719639519, 756.7237958145275, 795.9204079592041, 858.6136238692588, 871.1636828644502, 15268.694626107472, 15829.97105188162, 15860.0, 15868.52394428169, 15920.920395398021, 14598.708025839476, 14602.19687917164, 14720.0, 14720.6319842004, 14722.926385368084, 717.8959050937638, 740.5852722475404, 741.6180666956521, 876.6449587916904, 892.8258989497034, 901.729481155654, 901.8692289618001, 913.4017218721748, 913.8811954445946, 915.5239275576696, 968.1045033344163, 971.9600027970075, 972.1153750087421, 972.5574863437155, 972.9075737804898, 966.2028826218398, 968.6222373274429, 969.6606187834202, 970.1317320997703, 970.8592254123113, 639.9568703014104, 687.3538873458932, 719.6186021408662, 720.459655258556, 721.2715157690718, 12833.230006199658, 15487.690246195125, 15741.606459838482, 15887.52337429879, 16175.595610109724, 14949.626259343495, 15243.009204401678, 15357.692846143014, 15371.769423458658, 15397.846021539754, 11377.943110284396, 11643.534258629645, 11878.346690931996, 12118.39408029595, 12147.331896745676, 4566.1780879441685, 4585.908281834345, 4657.301404789275, 4658.883527911796, 4696.694714843524, 108015.0, 109307.0, 109430.0, 114670.27994580088, 117835.0, 11293.0, 11389.0, 11434.371109588887, 11670.708232294091, 11737.471813768401, 23048.65427018596, 23148.768512314997, 23313.30060098166, 23450.413739656644, 23579.528409431714, 7876.921230787733, 7980.720674776355, 7993.840123197503, 8083.514989100673, 8210.220029097227, 4422.933655995163, 4559.840405585788, 4588.059447813191, 4604.861854144381, 4629.328747331618, 3686.5576130863933, 3790.56408513019, 3791.1469919268498, 3797.145642230476, 3799.430085487144, 669.1267895396456, 682.8975653651893, 687.2200052939949, 688.1123350877313, 714.6319645382632, 702.2345643248883, 726.8182954261434, 739.7780665800238, 754.8980887580216, 776.953382797034, 9808.73316644083, 10364.429956352473, 10438.843417348746, 10498.265121441425, 10572.420033209599, 702.5819637315789, 741.3402072155785, 743.4424181863602, 747.1706405889458, 753.15270320889, 4245.80893859777, 4583.977080114578, 4617.191991401492, 4652.348671186037, 4666.673332866734, 102195.0, 105903.4704826471, 109777.35333969997, 111717.0, 112742.0, 93971.53014234886, 95535.0, 96294.0370596285, 96938.0, 98342.0, 70367.94448083283, 73106.63446682839, 79336.0, 81725.36549268982, 83748.16251837526, 10911.83632245501, 10971.0, 11370.715732106433, 11398.544058237578, 11419.429028548706, 46634.53365466302, 47970.76014619905, 48197.5180248207, 48795.75602121967, 49389.50610493849, 60130.098048530184, 60410.0, 61001.38998610135, 61264.69367653133, 62712.0, 13057.151285166814, 13125.212487250796, 13399.33003349809, 13417.932910335387, 13702.655745842641, 14365.353559089657, 14409.855901441271, 14434.639134021734, 14858.03422777516, 14982.101073935599, 13453.730925381633, 13984.720305594035, 14040.578782636538, 14143.575692729235, 14210.78683819723, 11291.604793832177, 13239.801402979156, 13764.334748620975, 14321.64195895111, 14344.928275358556, 13707.588772336845, 13741.132990243694, 13773.793393098911, 14183.432662693376, 14680.0, 9829.262805289489, 9929.900700992897, 9969.850452243367, 10474.842877356998, 10544.525496352837, 11170.162237832032, 11271.267367621078, 11294.548218071184, 11394.487248074023, 11428.14288928317], "value": 7800.41323667799, "unit": "score"}], "name": "dromaeo_css", "value": 7401.522290946997, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 114.0, 113.0, 114.0, 114.0, 115.0, 114.0, 114.0, 111.0, 115.0], "value": 112.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 107.0, 105.0, 141.0, 109.0, 103.0, 107.0, 106.0, 126.0, 107.0], "value": 115.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [203.0, 262.0, 200.0, 186.0, 182.0, 183.0, 184.0, 182.0, 183.0, 181.0], "value": 194.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 58.0, 58.0, 93.0, 61.0, 58.0, 57.0, 57.0, 72.0, 57.0], "value": 65.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 70.0, 85.0, 73.0, 93.0, 98.0, 83.0, 67.0, 68.0, 82.0], "value": 80.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 87.0, 89.0, 89.0, 135.0, 87.0, 90.0, 87.0, 89.0, 85.0], "value": 92.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 94.0, 93.0, 93.0, 94.0, 93.0, 93.0], "value": 93.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 90.0, 72.0, 130.0, 131.0, 133.0, 84.0, 84.0, 87.0, 84.0], "value": 98.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 51.0, 52.0, 52.0, 55.0, 55.0, 55.0, 57.0, 56.0, 55.0], "value": 54.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 72.0, 71.0, 74.0, 70.0, 67.0, 69.0, 68.0, 67.0, 69.0], "value": 69.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 82.0, 78.0, 83.0, 83.0, 79.0, 85.0, 81.0, 82.0, 87.0], "value": 82.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 134.0, 131.0, 131.0, 131.0, 131.0, 133.0, 134.0, 171.0, 151.0], "value": 137.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 190.0, 192.0, 161.0, 160.0, 161.0, 168.0, 216.0, 196.0, 162.0], "value": 176.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 64.0, 64.0, 66.0, 64.0, 63.0, 63.0, 63.0, 64.0], "value": 64.0, "unit": "score"}], "name": "kraken", "value": 1437.0000000000002, "alertThreshold": 2.0}]} 16:03:23 INFO - Return code: 0 16:03:23 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:03:23 INFO - # TBPL SUCCESS # 16:03:23 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:03:23 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:03:23 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:03:23 INFO - 2017-04-05 16:03:23.993 screenresolution[1654:9710] starting screenresolution argv=screenresolution get 16:03:23 INFO - 2017-04-05 16:03:23.996 screenresolution[1654:9710] Display 0: 1600x1200x32@60 16:03:24 INFO - 2017-04-05 16:03:24.002 screenresolution[1655:9714] starting screenresolution argv=screenresolution list 16:03:24 INFO - Available Modes on Display 0 16:03:24 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:03:24 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:03:24 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:03:24 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:03:24 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:03:24 INFO - Intel Iris: 16:03:24 INFO - Chipset Model: Intel Iris 16:03:24 INFO - Type: GPU 16:03:24 INFO - Bus: Built-In 16:03:24 INFO - VRAM (Dynamic, Max): 1536 MB 16:03:24 INFO - Vendor: Intel (0x8086) 16:03:24 INFO - Device ID: 0x0a2e 16:03:24 INFO - Revision ID: 0x0009 16:03:24 INFO - Displays: 16:03:24 INFO - Display: 16:03:24 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:03:24 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:03:24 INFO - Display Serial Number: 1600x1200 60 16:03:24 INFO - Main Display: Yes 16:03:24 INFO - Mirror: Off 16:03:24 INFO - Online: Yes 16:03:24 INFO - Rotation: Supported 16:03:24 INFO - Return code: 0 16:03:24 INFO - Running post-action listener: _resource_record_post_action 16:03:24 INFO - [mozharness: 2017-04-05 23:03:24.239533Z] Finished run-tests step (success) 16:03:24 INFO - Running post-run listener: _resource_record_post_run 16:03:24 INFO - Total resource usage - Wall time: 1190s; CPU: 54.0%; Read bytes: 38269952; Write bytes: 421016064; Read time: 243; Write time: 1385 16:03:24 INFO - TinderboxPrint: CPU usage
53.7% 16:03:24 INFO - TinderboxPrint: I/O read bytes / time
38,269,952 / 243 16:03:24 INFO - TinderboxPrint: I/O write bytes / time
421,016,064 / 1,385 16:03:24 INFO - TinderboxPrint: CPU idle
2,204.9 (46.3%) 16:03:24 INFO - TinderboxPrint: CPU system
946.0 (19.9%) 16:03:24 INFO - TinderboxPrint: CPU user
1,610.8 (33.8%) 16:03:24 INFO - TinderboxPrint: Swap in / out
159,870,976 / 0 16:03:24 INFO - install - Wall time: 15s; CPU: 54.0%; Read bytes: 122925568; Write bytes: 122634240; Read time: 11163; Write time: 281 16:03:24 INFO - run-tests - Wall time: 1176s; CPU: 54.0%; Read bytes: 34472960; Write bytes: 296960512; Read time: 218; Write time: 1099 16:03:24 INFO - Running post-run listener: _upload_blobber_files 16:03:24 INFO - Blob upload gear active. 16:03:24 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:03:24 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 16:03:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:03:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:03:25 INFO - (blobuploader) - INFO - Open directory for files ... 16:03:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:03:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:03:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:03:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:03:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:03:26 INFO - (blobuploader) - INFO - Done attempting. 16:03:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:03:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:03:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:03:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:03:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:03:27 INFO - (blobuploader) - INFO - Done attempting. 16:03:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 16:03:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:03:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:03:28 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 16:03:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:03:28 INFO - (blobuploader) - INFO - Done attempting. 16:03:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:03:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:03:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:03:33 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:03:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:03:33 INFO - (blobuploader) - INFO - Done attempting. 16:03:33 INFO - (blobuploader) - INFO - Iteration through files over. 16:03:33 INFO - Return code: 0 16:03:33 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:03:33 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:03:33 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/145cc7617ead63ea924f7b8f0cc640cebd4bca109034975980571f85b672ca304ad72d371fdf6049408cc2c5d4faab79d69a4c1401548bef4e11be0a1d8e7292", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/72bdc0775309251600bd08381cc8a72b145f19f9c54b7f01ac9ddbe5cf152b350506ffab34d4765dbec2138cbf7e754b7859bd7e7b77017376462696c5e5ea09", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/436a93438bbd1092c348472c544dc336e3b0a9be934cf6cd181c066399037e2f9c1c08b3597a13b4b10b7fe61f5d4d612802dacbb72b9b1aba37385e1559a52b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/eb29ced59f859195ea99b99d4184be4c824844ed2e0e090180e415da28b017fabbae62f7c60cf1cb6c97f125152a76805e957f072689f192c0c5d608a7dc96a8"} 16:03:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:03:33 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:03:33 INFO - Contents: 16:03:33 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/145cc7617ead63ea924f7b8f0cc640cebd4bca109034975980571f85b672ca304ad72d371fdf6049408cc2c5d4faab79d69a4c1401548bef4e11be0a1d8e7292", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/72bdc0775309251600bd08381cc8a72b145f19f9c54b7f01ac9ddbe5cf152b350506ffab34d4765dbec2138cbf7e754b7859bd7e7b77017376462696c5e5ea09", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/436a93438bbd1092c348472c544dc336e3b0a9be934cf6cd181c066399037e2f9c1c08b3597a13b4b10b7fe61f5d4d612802dacbb72b9b1aba37385e1559a52b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/eb29ced59f859195ea99b99d4184be4c824844ed2e0e090180e415da28b017fabbae62f7c60cf1cb6c97f125152a76805e957f072689f192c0c5d608a7dc96a8"} 16:03:33 INFO - Running post-run listener: copy_logs_to_upload_dir 16:03:33 INFO - Copying logs to upload dir... 16:03:33 INFO - mkdir: /builds/slave/test/build/upload/logs 16:03:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1255.256793 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2017-04-05 16:03:33.310548) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-05 16:03:33.314878) ========= 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.PEphafPAaw/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.ZWvoYmv5Bg/Listeners TMPDIR=/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/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/145cc7617ead63ea924f7b8f0cc640cebd4bca109034975980571f85b672ca304ad72d371fdf6049408cc2c5d4faab79d69a4c1401548bef4e11be0a1d8e7292", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/72bdc0775309251600bd08381cc8a72b145f19f9c54b7f01ac9ddbe5cf152b350506ffab34d4765dbec2138cbf7e754b7859bd7e7b77017376462696c5e5ea09", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/436a93438bbd1092c348472c544dc336e3b0a9be934cf6cd181c066399037e2f9c1c08b3597a13b4b10b7fe61f5d4d612802dacbb72b9b1aba37385e1559a52b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/eb29ced59f859195ea99b99d4184be4c824844ed2e0e090180e415da28b017fabbae62f7c60cf1cb6c97f125152a76805e957f072689f192c0c5d608a7dc96a8"} build_url:https://queue.taskcluster.net/v1/task/A_8Vm6DISB26Wae52EqG6A/artifacts/public/build/firefox-53.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010960 build_url: 'https://queue.taskcluster.net/v1/task/A_8Vm6DISB26Wae52EqG6A/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/145cc7617ead63ea924f7b8f0cc640cebd4bca109034975980571f85b672ca304ad72d371fdf6049408cc2c5d4faab79d69a4c1401548bef4e11be0a1d8e7292", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/72bdc0775309251600bd08381cc8a72b145f19f9c54b7f01ac9ddbe5cf152b350506ffab34d4765dbec2138cbf7e754b7859bd7e7b77017376462696c5e5ea09", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/436a93438bbd1092c348472c544dc336e3b0a9be934cf6cd181c066399037e2f9c1c08b3597a13b4b10b7fe61f5d4d612802dacbb72b9b1aba37385e1559a52b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/eb29ced59f859195ea99b99d4184be4c824844ed2e0e090180e415da28b017fabbae62f7c60cf1cb6c97f125152a76805e957f072689f192c0c5d608a7dc96a8"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-05 16:03:33.352968) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-05 16:03:33.353328) ========= 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.PEphafPAaw/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.ZWvoYmv5Bg/Listeners TMPDIR=/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/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.005227 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-05 16:03:33.405262) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-05 16:03:33.405573) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-05 16:03:33.405902) ========= ========= Total master_lag: 0.18 =========