builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0258 starttime: 1487434682.23 results: success (0) buildid: 20170218070119 builduid: eed4d884ea5e40d4bee4676ce00d7033 revision: b200f1a3b627e520af1f7f6546e7d76b8b09c8af ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-18 08:18:02.229773) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-18 08:18:02.230438) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-18 08:18:02.231946) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-18 08:18:02.261993) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-18 08:18:02.262607) ========= 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.cjrzqC2rki/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.fmduFg0KA9/Listeners TMPDIR=/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/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-02-18 08:18:02-- 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% 18.5M=0.001s 2017-02-18 08:18:02 (18.5 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.494006 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-18 08:18:02.787738) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-18 08:18:02.788139) ========= 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.cjrzqC2rki/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.fmduFg0KA9/Listeners TMPDIR=/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/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.025915 ========= master_lag: 0.13 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-18 08:18:02.947926) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-02-18 08:18:02.948326) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev b200f1a3b627e520af1f7f6546e7d76b8b09c8af --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-aurora --rev b200f1a3b627e520af1f7f6546e7d76b8b09c8af --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.cjrzqC2rki/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.fmduFg0KA9/Listeners TMPDIR=/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/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-02-18 08:18:03,058 truncating revision to first 12 chars 2017-02-18 08:18:03,058 Setting DEBUG logging. 2017-02-18 08:18:03,058 attempt 1/10 2017-02-18 08:18:03,058 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/b200f1a3b627?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-18 08:18:04,798 unpacking tar archive at: mozilla-aurora-b200f1a3b627/testing/mozharness/ program finished with exit code 0 elapsedTime=2.006115 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-02-18 08:18:04.985437) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-18 08:18:04.985732) ========= script_repo_revision: b200f1a3b627e520af1f7f6546e7d76b8b09c8af ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-18 08:18:04.986117) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-18 08:18:04.986427) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-18 08:18:05.011218) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-02-18 08:18:05.011666) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.cjrzqC2rki/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.fmduFg0KA9/Listeners TMPDIR=/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/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 08:18:05 INFO - MultiFileLogger online at 20170218 08:18:05 in /builds/slave/test 08:18:05 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 08:18:05 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:18:05 INFO - {'append_to_log': False, 08:18:05 INFO - 'base_work_dir': '/builds/slave/test', 08:18:05 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 08:18:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:18:05 INFO - 'branch': 'Mozilla-Aurora', 08:18:05 INFO - 'buildbot_json_path': 'buildprops.json', 08:18:05 INFO - 'config_files': ('talos/mac_config.py',), 08:18:05 INFO - 'default_actions': ('clobber', 08:18:05 INFO - 'read-buildbot-config', 08:18:05 INFO - 'download-and-extract', 08:18:05 INFO - 'populate-webroot', 08:18:05 INFO - 'create-virtualenv', 08:18:05 INFO - 'install', 08:18:05 INFO - 'run-tests'), 08:18:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:18:05 INFO - 'download_minidump_stackwalk': True, 08:18:05 INFO - 'download_symbols': 'ondemand', 08:18:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:18:05 INFO - 'tooltool.py': '/tools/tooltool.py', 08:18:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:18:05 INFO - '/tools/misc-python/virtualenv.py')}, 08:18:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:18:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:18:05 INFO - 'installer_path': 'installer.exe', 08:18:05 INFO - 'log_level': 'info', 08:18:05 INFO - 'log_name': 'talos', 08:18:05 INFO - 'log_to_console': True, 08:18:05 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:18:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:18:05 INFO - 'opt_config_files': (), 08:18:05 INFO - 'pip_index': False, 08:18:05 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:18:05 INFO - 'cmd': ('bash', 08:18:05 INFO - '-c', 08:18:05 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:18:05 INFO - 'enabled': True, 08:18:05 INFO - 'halt_on_failure': False, 08:18:05 INFO - 'name': 'check_screen_resolution'},), 08:18:05 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:18:05 INFO - 'cmd': ('bash', 08:18:05 INFO - '-c', 08:18:05 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:18:05 INFO - 'enabled': True, 08:18:05 INFO - 'halt_on_failure': False, 08:18:05 INFO - 'name': 'check_screen_resolution'},), 08:18:05 INFO - 'run_cmd_checks_enabled': True, 08:18:05 INFO - 'sps_profile': False, 08:18:05 INFO - 'sps_profile_interval': 0, 08:18:05 INFO - 'suite': 'dromaeojs', 08:18:05 INFO - 'system_bits': '32', 08:18:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:18:05 INFO - 'title': 't-yosemite-r7-0258', 08:18:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:18:05 INFO - 'use_talos_json': True, 08:18:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:18:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:18:05 INFO - 'work_dir': 'build'} 08:18:05 INFO - [mozharness: 2017-02-18 16:18:05.226588Z] Running clobber step. 08:18:05 INFO - Running pre-action listener: _resource_record_pre_action 08:18:05 INFO - Running main action method: clobber 08:18:05 INFO - rmtree: /builds/slave/test/build 08:18:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:18:07 INFO - Running post-action listener: _resource_record_post_action 08:18:07 INFO - [mozharness: 2017-02-18 16:18:07.560035Z] Finished clobber step (success) 08:18:07 INFO - [mozharness: 2017-02-18 16:18:07.560246Z] Running read-buildbot-config step. 08:18:07 INFO - Running pre-action listener: _resource_record_pre_action 08:18:07 INFO - Running main action method: read_buildbot_config 08:18:07 INFO - Using buildbot properties: 08:18:07 INFO - { 08:18:07 INFO - "project": "", 08:18:07 INFO - "product": "firefox", 08:18:07 INFO - "script_repo_revision": "production", 08:18:07 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 08:18:07 INFO - "repository": "", 08:18:07 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 08:18:07 INFO - "buildid": "20170218070119", 08:18:07 INFO - "pgo_build": "False", 08:18:07 INFO - "basedir": "/builds/slave/test", 08:18:07 INFO - "buildnumber": 53, 08:18:07 INFO - "slavename": "t-yosemite-r7-0258", 08:18:07 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 08:18:07 INFO - "platform": "yosemite_r7", 08:18:07 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 08:18:07 INFO - "branch": "mozilla-aurora", 08:18:07 INFO - "repo_path": "releases/mozilla-aurora", 08:18:07 INFO - "revision": "b200f1a3b627e520af1f7f6546e7d76b8b09c8af", 08:18:07 INFO - "stage_platform": "macosx64", 08:18:07 INFO - "builduid": "eed4d884ea5e40d4bee4676ce00d7033", 08:18:07 INFO - "slavebuilddir": "test" 08:18:07 INFO - } 08:18:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/DvIpX7R7SdyPGnPVQZCNMg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg. 08:18:07 INFO - Running post-action listener: _resource_record_post_action 08:18:07 INFO - [mozharness: 2017-02-18 16:18:07.564333Z] Finished read-buildbot-config step (success) 08:18:07 INFO - [mozharness: 2017-02-18 16:18:07.564507Z] Running download-and-extract step. 08:18:07 INFO - Running pre-action listener: _resource_record_pre_action 08:18:07 INFO - Running main action method: download_and_extract 08:18:07 INFO - mkdir: /builds/slave/test/build/tests 08:18:07 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')]} 08:18:07 INFO - trying https://queue.taskcluster.net/v1/task/DvIpX7R7SdyPGnPVQZCNMg/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json 08:18:07 INFO - Downloading https://queue.taskcluster.net/v1/task/DvIpX7R7SdyPGnPVQZCNMg/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 08:18:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DvIpX7R7SdyPGnPVQZCNMg/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json'}, attempt #1 08:18:08 INFO - Downloaded 1199 bytes. 08:18:08 INFO - Reading from file /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 08:18:08 INFO - Using the following test package requirements: 08:18:08 INFO - {u'common': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 08:18:08 INFO - u'cppunittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:18:08 INFO - u'firefox-53.0a2.en-US.mac.cppunittest.tests.zip'], 08:18:08 INFO - u'gtest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:18:08 INFO - u'firefox-53.0a2.en-US.mac.gtest.tests.zip'], 08:18:08 INFO - u'jittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:18:08 INFO - u'jsshell-mac.zip'], 08:18:08 INFO - u'mochitest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:18:08 INFO - u'firefox-53.0a2.en-US.mac.mochitest.tests.zip'], 08:18:08 INFO - u'mozbase': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 08:18:08 INFO - u'reftest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:18:08 INFO - u'firefox-53.0a2.en-US.mac.reftest.tests.zip'], 08:18:08 INFO - u'talos': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:18:08 INFO - u'firefox-53.0a2.en-US.mac.talos.tests.zip'], 08:18:08 INFO - u'web-platform': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:18:08 INFO - u'firefox-53.0a2.en-US.mac.web-platform.tests.zip'], 08:18:08 INFO - u'xpcshell': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:18:08 INFO - u'firefox-53.0a2.en-US.mac.xpcshell.tests.zip']} 08:18:08 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip'] for test suite category: common 08:18:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DvIpX7R7SdyPGnPVQZCNMg/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 08:18:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DvIpX7R7SdyPGnPVQZCNMg/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 08:18:08 INFO - Fetch https://queue.taskcluster.net/v1/task/DvIpX7R7SdyPGnPVQZCNMg/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 08:18:09 INFO - Expected file size: 16358989 08:18:09 INFO - Obtained file size: 16358989 08:18:16 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip', u'firefox-53.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 08:18:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DvIpX7R7SdyPGnPVQZCNMg/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 08:18:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DvIpX7R7SdyPGnPVQZCNMg/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 08:18:16 INFO - Fetch https://queue.taskcluster.net/v1/task/DvIpX7R7SdyPGnPVQZCNMg/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 08:18:17 INFO - Expected file size: 16358989 08:18:17 INFO - Obtained file size: 16358989 08:18:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DvIpX7R7SdyPGnPVQZCNMg/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip 08:18:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DvIpX7R7SdyPGnPVQZCNMg/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip'}, attempt #1 08:18:23 INFO - Fetch https://queue.taskcluster.net/v1/task/DvIpX7R7SdyPGnPVQZCNMg/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip into memory 08:18:24 INFO - Expected file size: 14403485 08:18:24 INFO - Obtained file size: 14403485 08:18:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:18:25 INFO - trying https://queue.taskcluster.net/v1/task/DvIpX7R7SdyPGnPVQZCNMg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 08:18:25 INFO - Downloading https://queue.taskcluster.net/v1/task/DvIpX7R7SdyPGnPVQZCNMg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg 08:18:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DvIpX7R7SdyPGnPVQZCNMg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg'}, attempt #1 08:18:27 INFO - Downloaded 73963699 bytes. 08:18:27 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DvIpX7R7SdyPGnPVQZCNMg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 08:18:27 INFO - mkdir: /builds/slave/test/properties 08:18:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:18:27 INFO - Writing to file /builds/slave/test/properties/build_url 08:18:27 INFO - Contents: 08:18:27 INFO - build_url:https://queue.taskcluster.net/v1/task/DvIpX7R7SdyPGnPVQZCNMg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 08:18:27 INFO - Running post-action listener: _resource_record_post_action 08:18:27 INFO - Running post-action listener: set_extra_try_arguments 08:18:27 INFO - [mozharness: 2017-02-18 16:18:27.826335Z] Finished download-and-extract step (success) 08:18:27 INFO - [mozharness: 2017-02-18 16:18:27.826459Z] Running populate-webroot step. 08:18:27 INFO - Running pre-action listener: _resource_record_pre_action 08:18:27 INFO - Running main action method: populate_webroot 08:18:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:18:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:18:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:18:27 INFO - '--tppagecycles', 08:18:27 INFO - '7'], 08:18:27 INFO - 'tests': ['tsvgm']}}, 08:18:27 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:18:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:18:27 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:18:27 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:18:27 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:18:27 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:18:27 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:18:27 INFO - 'talos_options': ['--disable-e10s'], 08:18:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:18:27 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:18:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:18:27 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:18:27 INFO - 'talos_options': ['--disable-e10s'], 08:18:27 INFO - 'tests': ['damp', 'tps']}, 08:18:27 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:18:27 INFO - 'tests': ['damp', 'tps']}, 08:18:27 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:18:27 INFO - 'tests': ['dromaeo_dom']}, 08:18:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:18:27 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:18:27 INFO - 'tests': ['basic_compositor_video']}, 08:18:27 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:18:27 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:18:27 INFO - 'tests': ['a11yr', 08:18:27 INFO - 'ts_paint', 08:18:27 INFO - 'tpaint', 08:18:27 INFO - 'sessionrestore', 08:18:27 INFO - 'sessionrestore_no_auto_restore', 08:18:27 INFO - 'tabpaint']}, 08:18:27 INFO - 'other-e10s': {'tests': ['a11yr', 08:18:27 INFO - 'ts_paint', 08:18:27 INFO - 'tpaint', 08:18:27 INFO - 'sessionrestore', 08:18:27 INFO - 'sessionrestore_no_auto_restore', 08:18:27 INFO - 'tabpaint']}, 08:18:27 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:18:27 INFO - 'ts_paint', 08:18:27 INFO - 'tpaint', 08:18:27 INFO - 'sessionrestore', 08:18:27 INFO - 'sessionrestore_no_auto_restore', 08:18:27 INFO - 'tabpaint']}, 08:18:27 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:18:27 INFO - 'ts_paint', 08:18:27 INFO - 'tpaint', 08:18:27 INFO - 'sessionrestore', 08:18:27 INFO - 'sessionrestore_no_auto_restore', 08:18:27 INFO - 'tabpaint']}, 08:18:27 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:18:27 INFO - 'tests': ['a11yr', 08:18:27 INFO - 'ts_paint', 08:18:27 INFO - 'tpaint', 08:18:27 INFO - 'sessionrestore', 08:18:27 INFO - 'sessionrestore_no_auto_restore', 08:18:27 INFO - 'tabpaint']}, 08:18:27 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:18:27 INFO - 'tests': ['a11yr', 08:18:27 INFO - 'ts_paint', 08:18:27 INFO - 'tpaint', 08:18:27 INFO - 'sessionrestore', 08:18:27 INFO - 'sessionrestore_no_auto_restore', 08:18:27 INFO - 'tabpaint']}, 08:18:27 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:18:27 INFO - 'tests': ['tsvgx', 08:18:27 INFO - 'tsvgr_opacity', 08:18:27 INFO - 'tart', 08:18:27 INFO - 'tscrollx', 08:18:27 INFO - 'cart', 08:18:27 INFO - 'tsvg_static']}, 08:18:27 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:18:27 INFO - 'tsvgr_opacity', 08:18:27 INFO - 'tart', 08:18:27 INFO - 'tscrollx', 08:18:27 INFO - 'cart', 08:18:27 INFO - 'tsvg_static']}, 08:18:27 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:18:27 INFO - 'talos_options': ['--disable-e10s'], 08:18:27 INFO - 'tests': ['tp5o']}, 08:18:27 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:18:27 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:18:27 INFO - 'talos_options': ['--disable-e10s', 08:18:27 INFO - '--xperf_path', 08:18:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:18:27 INFO - 'tests': ['tp5n']}, 08:18:27 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:18:27 INFO - 'talos_options': ['--xperf_path', 08:18:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:18:27 INFO - 'tests': ['tp5n']}}, 08:18:27 INFO - 'talos.zip': {'path': '', 08:18:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:18:27 INFO - Running post-action listener: _resource_record_post_action 08:18:27 INFO - [mozharness: 2017-02-18 16:18:27.844744Z] Finished populate-webroot step (success) 08:18:27 INFO - [mozharness: 2017-02-18 16:18:27.844826Z] Running create-virtualenv step. 08:18:27 INFO - Running pre-action listener: _resource_record_pre_action 08:18:27 INFO - Running main action method: create_virtualenv 08:18:27 INFO - Creating virtualenv /builds/slave/test/build/venv 08:18:27 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 08:18:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:18:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:18:27 INFO - Using real prefix '/tools/python27' 08:18:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:18:28 INFO - Installing distribute.............................................................................................................................................................................................done. 08:18:31 INFO - Installing pip.................done. 08:18:31 INFO - Return code: 0 08:18:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:18:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:18:31 INFO - Reading from file tmpfile_stdout 08:18:31 INFO - Output received: 08:18:31 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) 08:18:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:18:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:18:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:18:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:18:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:18:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:18:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:18:31 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 0x10852ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10852d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe0435c2130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108308d30>, '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 0x10822fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1082fdbe8>, '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.cjrzqC2rki/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.fmduFg0KA9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/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 08:18:31 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 08:18:31 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 08:18:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cjrzqC2rki/Render', 08:18:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:18:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:18:31 INFO - 'HOME': '/Users/cltbld', 08:18:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:18:31 INFO - 'LOGNAME': 'cltbld', 08:18:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:18:31 INFO - 'MOZ_NO_REMOTE': '1', 08:18:31 INFO - 'NO_EM_RESTART': '1', 08:18:31 INFO - 'PAGER': '/bin/cat', 08:18:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:18:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:18:31 INFO - 'PWD': '/builds/slave/test', 08:18:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:18:31 INFO - 'SHELL': '/bin/bash', 08:18:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fmduFg0KA9/Listeners', 08:18:31 INFO - 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/', 08:18:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:18:31 INFO - 'USER': 'cltbld', 08:18:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:18:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:18:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:18:31 INFO - 'XPC_FLAGS': '0x0', 08:18:31 INFO - 'XPC_SERVICE_NAME': '0', 08:18:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:18:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:18:32 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 08:18:32 INFO - Cleaning up... 08:18:32 INFO - Return code: 0 08:18:32 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:18: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')]} 08:18:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:18:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:18: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')]} 08:18:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:18:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:18: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', '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 0x10852ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10852d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe0435c2130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108308d30>, '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 0x10822fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1082fdbe8>, '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.cjrzqC2rki/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.fmduFg0KA9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/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 08:18: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', 'psutil>=3.1.1'] in /builds/slave/test/build 08:18: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 psutil>=3.1.1 08:18:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cjrzqC2rki/Render', 08:18:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:18:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:18:32 INFO - 'HOME': '/Users/cltbld', 08:18:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:18:32 INFO - 'LOGNAME': 'cltbld', 08:18:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:18:32 INFO - 'MOZ_NO_REMOTE': '1', 08:18:32 INFO - 'NO_EM_RESTART': '1', 08:18:32 INFO - 'PAGER': '/bin/cat', 08:18:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:18:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:18:32 INFO - 'PWD': '/builds/slave/test', 08:18:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:18:32 INFO - 'SHELL': '/bin/bash', 08:18:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fmduFg0KA9/Listeners', 08:18:32 INFO - 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/', 08:18:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:18:32 INFO - 'USER': 'cltbld', 08:18:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:18:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:18:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:18:32 INFO - 'XPC_FLAGS': '0x0', 08:18:32 INFO - 'XPC_SERVICE_NAME': '0', 08:18:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:18:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:18:32 INFO - Downloading/unpacking psutil>=3.1.1 08:18:32 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 08:18:32 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 08:18:32 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 08:18:32 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 08:18:32 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 08:18:32 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 08:18:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:18:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:18:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:18:36 INFO - Installing collected packages: psutil 08:18:36 INFO - Running setup.py install for psutil 08:18:36 INFO - building 'psutil._psutil_osx' extension 08:18:36 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 08:18:36 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 08:18:36 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 08:18:37 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 08:18:37 INFO - building 'psutil._psutil_posix' extension 08:18:37 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 08:18:37 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:18:37 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:18:37 INFO - ^ 08:18:37 INFO - 1 warning generated. 08:18:37 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 08:18:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:18:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:18:37 INFO - Successfully installed psutil 08:18:37 INFO - Cleaning up... 08:18:37 INFO - Return code: 0 08:18:37 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:18:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:18:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:18:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:18:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:18:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:18:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:18:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10852ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10852d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe0435c2130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108308d30>, '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 0x10822fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1082fdbe8>, '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.cjrzqC2rki/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.fmduFg0KA9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/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 08:18:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:18:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:18:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cjrzqC2rki/Render', 08:18:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:18:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:18:37 INFO - 'HOME': '/Users/cltbld', 08:18:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:18:37 INFO - 'LOGNAME': 'cltbld', 08:18:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:18:37 INFO - 'MOZ_NO_REMOTE': '1', 08:18:37 INFO - 'NO_EM_RESTART': '1', 08:18:37 INFO - 'PAGER': '/bin/cat', 08:18:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:18:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:18:37 INFO - 'PWD': '/builds/slave/test', 08:18:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:18:37 INFO - 'SHELL': '/bin/bash', 08:18:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fmduFg0KA9/Listeners', 08:18:37 INFO - 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/', 08:18:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:18:37 INFO - 'USER': 'cltbld', 08:18:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:18:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:18:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:18:37 INFO - 'XPC_FLAGS': '0x0', 08:18:37 INFO - 'XPC_SERVICE_NAME': '0', 08:18:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:18:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:18:37 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:18:37 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 08:18:37 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 08:18:37 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 08:18:37 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 08:18:37 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 08:18:37 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 08:18:40 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:18:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:18:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:18:40 INFO - Installing collected packages: mozsystemmonitor 08:18:40 INFO - Running setup.py install for mozsystemmonitor 08:18:40 INFO - Successfully installed mozsystemmonitor 08:18:40 INFO - Cleaning up... 08:18:40 INFO - Return code: 0 08:18:40 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:18: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')]} 08:18:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:18:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:18: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')]} 08:18:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:18:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:18:40 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 0x10852ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10852d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe0435c2130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108308d30>, '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 0x10822fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1082fdbe8>, '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.cjrzqC2rki/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.fmduFg0KA9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/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 08:18:40 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 08:18:40 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 08:18:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cjrzqC2rki/Render', 08:18:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:18:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:18:40 INFO - 'HOME': '/Users/cltbld', 08:18:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:18:40 INFO - 'LOGNAME': 'cltbld', 08:18:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:18:40 INFO - 'MOZ_NO_REMOTE': '1', 08:18:40 INFO - 'NO_EM_RESTART': '1', 08:18:40 INFO - 'PAGER': '/bin/cat', 08:18:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:18:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:18:40 INFO - 'PWD': '/builds/slave/test', 08:18:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:18:40 INFO - 'SHELL': '/bin/bash', 08:18:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fmduFg0KA9/Listeners', 08:18:40 INFO - 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/', 08:18:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:18:40 INFO - 'USER': 'cltbld', 08:18:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:18:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:18:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:18:40 INFO - 'XPC_FLAGS': '0x0', 08:18:40 INFO - 'XPC_SERVICE_NAME': '0', 08:18:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:18:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:18:40 INFO - Downloading/unpacking jsonschema==2.5.1 08:18:40 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 08:18:40 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 08:18:40 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 08:18:40 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 08:18:40 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 08:18:40 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 08:18:43 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:18:43 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:18:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:18:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:18:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:18:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:18:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:18:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:18:43 INFO - Downloading functools32-3.2.3-2.tar.gz 08:18:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:18:43 INFO - warning: no files found matching '*.txt' 08:18:43 INFO - no previously-included directories found matching 'build' 08:18:43 INFO - no previously-included directories found matching 'dist' 08:18:43 INFO - no previously-included directories found matching '.git*' 08:18:43 INFO - Installing collected packages: jsonschema, functools32 08:18:43 INFO - Running setup.py install for functools32 08:18:44 INFO - warning: no files found matching '*.txt' 08:18:44 INFO - no previously-included directories found matching 'build' 08:18:44 INFO - no previously-included directories found matching 'dist' 08:18:44 INFO - no previously-included directories found matching '.git*' 08:18:44 INFO - Successfully installed jsonschema functools32 08:18:44 INFO - Cleaning up... 08:18:44 INFO - Return code: 0 08:18:44 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:18:44 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')]} 08:18:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:18:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:18:44 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')]} 08:18:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:18:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:18:44 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 0x10852ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10852d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe0435c2130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108308d30>, '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 0x10822fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1082fdbe8>, '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.cjrzqC2rki/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.fmduFg0KA9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/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 08:18:44 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 08:18:44 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 08:18:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cjrzqC2rki/Render', 08:18:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:18:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:18:44 INFO - 'HOME': '/Users/cltbld', 08:18:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:18:44 INFO - 'LOGNAME': 'cltbld', 08:18:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:18:44 INFO - 'MOZ_NO_REMOTE': '1', 08:18:44 INFO - 'NO_EM_RESTART': '1', 08:18:44 INFO - 'PAGER': '/bin/cat', 08:18:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:18:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:18:44 INFO - 'PWD': '/builds/slave/test', 08:18:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:18:44 INFO - 'SHELL': '/bin/bash', 08:18:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fmduFg0KA9/Listeners', 08:18:44 INFO - 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/', 08:18:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:18:44 INFO - 'USER': 'cltbld', 08:18:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:18:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:18:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:18:44 INFO - 'XPC_FLAGS': '0x0', 08:18:44 INFO - 'XPC_SERVICE_NAME': '0', 08:18:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:18:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:18:44 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:18:44 INFO - Cleaning up... 08:18:44 INFO - Return code: 0 08:18:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:18:44 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')]} 08:18:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:18:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:18:44 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')]} 08:18:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:18:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:18:44 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 0x10852ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10852d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe0435c2130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108308d30>, '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 0x10822fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1082fdbe8>, '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.cjrzqC2rki/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.fmduFg0KA9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/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 08:18:44 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 08:18:44 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 08:18:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cjrzqC2rki/Render', 08:18:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:18:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:18:44 INFO - 'HOME': '/Users/cltbld', 08:18:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:18:44 INFO - 'LOGNAME': 'cltbld', 08:18:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:18:44 INFO - 'MOZ_NO_REMOTE': '1', 08:18:44 INFO - 'NO_EM_RESTART': '1', 08:18:44 INFO - 'PAGER': '/bin/cat', 08:18:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:18:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:18:44 INFO - 'PWD': '/builds/slave/test', 08:18:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:18:44 INFO - 'SHELL': '/bin/bash', 08:18:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fmduFg0KA9/Listeners', 08:18:44 INFO - 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/', 08:18:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:18:44 INFO - 'USER': 'cltbld', 08:18:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:18:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:18:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:18:44 INFO - 'XPC_FLAGS': '0x0', 08:18:44 INFO - 'XPC_SERVICE_NAME': '0', 08:18:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:18:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:18:44 INFO - Downloading/unpacking blobuploader==1.2.4 08:18:44 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 08:18:44 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 08:18:44 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 08:18:44 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 08:18:44 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 08:18:44 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 08:18:47 INFO - Downloading blobuploader-1.2.4.tar.gz 08:18:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:18:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:18:47 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 08:18:47 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 08:18:47 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 08:18:47 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 08:18:47 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 08:18:47 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 08:18:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:18:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:18:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:18:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:18:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:18:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:18:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:18:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:18:48 INFO - Downloading docopt-0.6.1.tar.gz 08:18:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:18:48 INFO - Installing collected packages: blobuploader, requests, docopt 08:18:48 INFO - Running setup.py install for blobuploader 08:18:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:18:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:18:48 INFO - Running setup.py install for requests 08:18:49 INFO - Running setup.py install for docopt 08:18:49 INFO - Successfully installed blobuploader requests docopt 08:18:49 INFO - Cleaning up... 08:18:49 INFO - Return code: 0 08:18:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:18:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:18:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:18:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:18:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:18:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:18:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:18:49 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 0x10852ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10852d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe0435c2130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108308d30>, '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 0x10822fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1082fdbe8>, '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.cjrzqC2rki/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.fmduFg0KA9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/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 08:18:49 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 08:18:49 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 08:18:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cjrzqC2rki/Render', 08:18:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:18:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:18:49 INFO - 'HOME': '/Users/cltbld', 08:18:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:18:49 INFO - 'LOGNAME': 'cltbld', 08:18:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:18:49 INFO - 'MOZ_NO_REMOTE': '1', 08:18:49 INFO - 'NO_EM_RESTART': '1', 08:18:49 INFO - 'PAGER': '/bin/cat', 08:18:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:18:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:18:49 INFO - 'PWD': '/builds/slave/test', 08:18:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:18:49 INFO - 'SHELL': '/bin/bash', 08:18:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fmduFg0KA9/Listeners', 08:18:49 INFO - 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/', 08:18:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:18:49 INFO - 'USER': 'cltbld', 08:18:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:18:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:18:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:18:49 INFO - 'XPC_FLAGS': '0x0', 08:18:49 INFO - 'XPC_SERVICE_NAME': '0', 08:18:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:18:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:18:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:18:49 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-7Jciu9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:18:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:18:50 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-FVmXi3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:18:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:18:50 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-wjjmFI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:18:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:18:50 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-Vmk33S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:18:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:18:50 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-qZrSh3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:18:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:18:50 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-srll3w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:18:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:18:50 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-y8Vx3z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:18:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:18:50 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-WeRGMb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:18:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:18:50 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-fzcpvb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:18:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:18:50 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-tqB0uk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:18:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:18:50 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-bd2SMV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:18:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:18:51 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-mqQkUM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:18:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:18:51 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-Wmr3AD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:18:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:18:51 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-R_d37l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:18:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:18:51 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-Fu2LWI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:18:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:18:51 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-dCQ3jf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:18:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:18:51 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-8oGvSd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:18:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:18:51 INFO - Running setup.py install for manifestparser 08:18:51 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:18:51 INFO - Running setup.py install for mozcrash 08:18:52 INFO - Running setup.py install for mozdebug 08:18:52 INFO - Running setup.py install for mozdevice 08:18:52 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:18:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:18:52 INFO - Running setup.py install for mozfile 08:18:52 INFO - Running setup.py install for mozhttpd 08:18:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:18:52 INFO - Running setup.py install for mozinfo 08:18:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:18:52 INFO - Running setup.py install for mozInstall 08:18:52 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:18:52 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:18:52 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:18:52 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:18:52 INFO - Running setup.py install for mozleak 08:18:53 INFO - Running setup.py install for mozlog 08:18:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:18:53 INFO - Running setup.py install for moznetwork 08:18:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:18:53 INFO - Running setup.py install for mozprocess 08:18:53 INFO - Running setup.py install for mozprofile 08:18:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:18:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:18:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:18:53 INFO - Running setup.py install for mozrunner 08:18:53 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:18:53 INFO - Running setup.py install for mozscreenshot 08:18:54 INFO - Running setup.py install for moztest 08:18:54 INFO - Running setup.py install for mozversion 08:18:54 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:18:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:18:54 INFO - Cleaning up... 08:18:54 INFO - Return code: 0 08:18:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:18:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:18:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:18:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:18:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:18:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:18:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:18:54 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 0x10852ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10852d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe0435c2130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108308d30>, '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 0x10822fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1082fdbe8>, '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.cjrzqC2rki/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.fmduFg0KA9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/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 08:18:54 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 08:18:54 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 08:18:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cjrzqC2rki/Render', 08:18:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:18:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:18:54 INFO - 'HOME': '/Users/cltbld', 08:18:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:18:54 INFO - 'LOGNAME': 'cltbld', 08:18:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:18:54 INFO - 'MOZ_NO_REMOTE': '1', 08:18:54 INFO - 'NO_EM_RESTART': '1', 08:18:54 INFO - 'PAGER': '/bin/cat', 08:18:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:18:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:18:54 INFO - 'PWD': '/builds/slave/test', 08:18:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:18:54 INFO - 'SHELL': '/bin/bash', 08:18:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fmduFg0KA9/Listeners', 08:18:54 INFO - 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/', 08:18:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:18:54 INFO - 'USER': 'cltbld', 08:18:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:18:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:18:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:18:54 INFO - 'XPC_FLAGS': '0x0', 08:18:54 INFO - 'XPC_SERVICE_NAME': '0', 08:18:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:18:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:18:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:18:54 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-VxXIpP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:18:54 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)) 08:18:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:18:54 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-Ekxx82-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:18:54 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)) 08:18:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:18:54 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-zlmtjI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:18:54 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)) 08:18:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:18:54 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-x2p70B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:18:55 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)) 08:18:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:18:55 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-BGt0Oq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:18:55 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)) 08:18:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:18:55 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-o90JST-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:18:55 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)) 08:18:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:18:55 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-puRBTq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:18:55 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)) 08:18:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:18:55 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-Q71P2J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:18:55 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)) 08:18:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:18:55 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-tvwis8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:18:55 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)) 08:18:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:18:55 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-rZHbLm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:18:55 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)) 08:18:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:18:55 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-kVliNF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:18:55 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)) 08:18:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:18:55 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-fO3boK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:18:55 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)) 08:18:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:18:55 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-P_GKIS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:18:56 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)) 08:18:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:18:56 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-7qv0Ei-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:18:56 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)) 08:18:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:18:56 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-YMxj0i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:18:56 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)) 08:18:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:18:56 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-AlRjc7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:18:56 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)) 08:18:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:18:56 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-_MHcPT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:18:56 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)) 08:18:56 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)) 08:18:56 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)) 08:18:56 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)) 08:18:56 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)) 08:18:56 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)) 08:18:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:18:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:18:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:18:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:18:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:18:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:18:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:18:59 INFO - Downloading blessings-1.6.tar.gz 08:18:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:18:59 INFO - Installing collected packages: blessings 08:18:59 INFO - Running setup.py install for blessings 08:18:59 INFO - Successfully installed blessings 08:18:59 INFO - Cleaning up... 08:18:59 INFO - Return code: 0 08:18:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:18:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:18:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:18:59 INFO - Reading from file tmpfile_stdout 08:18:59 INFO - Current package versions: 08:18:59 INFO - blessings == 1.6 08:18:59 INFO - blobuploader == 1.2.4 08:18:59 INFO - docopt == 0.6.1 08:18:59 INFO - functools32 == 3.2.3-2 08:18:59 INFO - jsonschema == 2.5.1 08:18:59 INFO - manifestparser == 1.1 08:18:59 INFO - mozInstall == 1.12 08:18:59 INFO - mozcrash == 1.0 08:18:59 INFO - mozdebug == 0.1 08:18:59 INFO - mozdevice == 0.49 08:18:59 INFO - mozfile == 1.2 08:18:59 INFO - mozhttpd == 0.7 08:18:59 INFO - mozinfo == 0.9 08:18:59 INFO - mozleak == 0.1 08:18:59 INFO - mozlog == 3.4 08:18:59 INFO - moznetwork == 0.27 08:18:59 INFO - mozprocess == 0.24 08:18:59 INFO - mozprofile == 0.28 08:18:59 INFO - mozrunner == 6.13 08:18:59 INFO - mozscreenshot == 0.1 08:18:59 INFO - mozsystemmonitor == 0.3 08:18:59 INFO - moztest == 0.8 08:18:59 INFO - mozversion == 1.4 08:18:59 INFO - psutil == 3.1.1 08:18:59 INFO - requests == 1.2.3 08:18:59 INFO - wsgiref == 0.1.2 08:18:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:18:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:18:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:18:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:18:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:18:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:18:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:18:59 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 0x10852ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10852d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe0435c2130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108308d30>, '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 0x10822fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1082fdbe8>, '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.cjrzqC2rki/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.fmduFg0KA9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/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 08:18:59 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 08:18:59 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 08:18:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cjrzqC2rki/Render', 08:18:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:18:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:18:59 INFO - 'HOME': '/Users/cltbld', 08:18:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:18:59 INFO - 'LOGNAME': 'cltbld', 08:18:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:18:59 INFO - 'MOZ_NO_REMOTE': '1', 08:18:59 INFO - 'NO_EM_RESTART': '1', 08:18:59 INFO - 'PAGER': '/bin/cat', 08:18:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:18:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:18:59 INFO - 'PWD': '/builds/slave/test', 08:18:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:18:59 INFO - 'SHELL': '/bin/bash', 08:18:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fmduFg0KA9/Listeners', 08:18:59 INFO - 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/', 08:18:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:18:59 INFO - 'USER': 'cltbld', 08:18:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:18:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:18:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:18:59 INFO - 'XPC_FLAGS': '0x0', 08:18:59 INFO - 'XPC_SERVICE_NAME': '0', 08:18:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:18:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:18:59 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)) 08:18:59 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)) 08:18:59 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)) 08:18:59 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)) 08:18:59 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)) 08:18:59 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)) 08:18:59 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)) 08:18:59 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)) 08:18:59 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)) 08:18:59 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)) 08:18:59 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)) 08:18:59 INFO - Cleaning up... 08:18:59 INFO - Return code: 0 08:18:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:18:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:18:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:18:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:18:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:18:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:18:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:18:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10852ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10852d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe0435c2130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108308d30>, '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 0x10822fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1082fdbe8>, '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.cjrzqC2rki/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.fmduFg0KA9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/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 08:18:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:18:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:18:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cjrzqC2rki/Render', 08:18:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:18:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:18:59 INFO - 'HOME': '/Users/cltbld', 08:18:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:18:59 INFO - 'LOGNAME': 'cltbld', 08:18:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:18:59 INFO - 'MOZ_NO_REMOTE': '1', 08:18:59 INFO - 'NO_EM_RESTART': '1', 08:18:59 INFO - 'PAGER': '/bin/cat', 08:18:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:18:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:18:59 INFO - 'PWD': '/builds/slave/test', 08:18:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:18:59 INFO - 'SHELL': '/bin/bash', 08:18:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fmduFg0KA9/Listeners', 08:18:59 INFO - 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/', 08:18:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:18:59 INFO - 'USER': 'cltbld', 08:18:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:18:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:18:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:18:59 INFO - 'XPC_FLAGS': '0x0', 08:18:59 INFO - 'XPC_SERVICE_NAME': '0', 08:18:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:19:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:19:00 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:19:00 INFO - Cleaning up... 08:19:00 INFO - Return code: 0 08:19:00 INFO - Running post-action listener: _resource_record_post_action 08:19:00 INFO - Running post-action listener: _start_resource_monitoring 08:19:00 INFO - Starting resource monitoring. 08:19:00 INFO - [mozharness: 2017-02-18 16:19:00.271087Z] Finished create-virtualenv step (success) 08:19:00 INFO - [mozharness: 2017-02-18 16:19:00.272093Z] Running install step. 08:19:00 INFO - Running pre-action listener: _resource_record_pre_action 08:19:00 INFO - Running main action method: install 08:19:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:19:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:19:00 INFO - Reading from file tmpfile_stdout 08:19:00 INFO - Detecting whether we're running mozinstall >=1.0... 08:19:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:19:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:19:00 INFO - Reading from file tmpfile_stdout 08:19:00 INFO - Output received: 08:19:00 INFO - Usage: mozinstall [options] installer 08:19:00 INFO - Options: 08:19:00 INFO - -h, --help show this help message and exit 08:19:00 INFO - -d DEST, --destination=DEST 08:19:00 INFO - Directory to install application into. [default: 08:19:00 INFO - "/builds/slave/test"] 08:19:00 INFO - --app=APP Application being installed. [default: firefox] 08:19:00 INFO - mkdir: /builds/slave/test/build/application 08:19:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 08:19:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 08:19:20 INFO - Reading from file tmpfile_stdout 08:19:20 INFO - Output received: 08:19:20 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 08:19:20 INFO - Running post-action listener: _resource_record_post_action 08:19:20 INFO - [mozharness: 2017-02-18 16:19:20.537767Z] Finished install step (success) 08:19:20 INFO - [mozharness: 2017-02-18 16:19:20.537953Z] Running run-tests step. 08:19:20 INFO - Running pre-action listener: _resource_record_pre_action 08:19:20 INFO - Running main action method: run_tests 08:19:20 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:19:20 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:19:20 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:19:20 INFO - 2017-02-18 08:19:20.552 screenresolution[1663:7815] starting screenresolution argv=screenresolution get 08:19:20 INFO - 2017-02-18 08:19:20.555 screenresolution[1663:7815] Display 0: 1600x1200x32@60 08:19:20 INFO - 2017-02-18 08:19:20.561 screenresolution[1664:7817] starting screenresolution argv=screenresolution list 08:19:20 INFO - Available Modes on Display 0 08:19:20 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:19:20 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:19:20 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:19:20 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:19:20 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:19:20 INFO - Intel Iris: 08:19:20 INFO - Chipset Model: Intel Iris 08:19:20 INFO - Type: GPU 08:19:20 INFO - Bus: Built-In 08:19:20 INFO - VRAM (Dynamic, Max): 1536 MB 08:19:20 INFO - Vendor: Intel (0x8086) 08:19:20 INFO - Device ID: 0x0a2e 08:19:20 INFO - Revision ID: 0x0009 08:19:20 INFO - Displays: 08:19:20 INFO - Display: 08:19:20 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:19:20 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:19:20 INFO - Display Serial Number: 1600x1200 60 08:19:20 INFO - Main Display: Yes 08:19:20 INFO - Mirror: Off 08:19:20 INFO - Online: Yes 08:19:20 INFO - Rotation: Supported 08:19:20 INFO - Return code: 0 08:19:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:19:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:19:20 INFO - Python 2.7.3 08:19:20 INFO - Return code: 0 08:19:20 INFO - grabbing minidump binary from tooltool 08:19:20 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')]} 08:19:20 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 0x108308d30>, '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 0x10822fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1082fdbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:19:20 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 08:19:20 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 08:19:20 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 08:19:20 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:19:20 INFO - Return code: 0 08:19:20 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:19:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:19:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:19:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:19:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:19:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DvIpX7R7SdyPGnPVQZCNMg/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0258', '--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 08:19:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/DvIpX7R7SdyPGnPVQZCNMg/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0258 --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 08:19:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cjrzqC2rki/Render', 08:19:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:19:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:19:20 INFO - 'HOME': '/Users/cltbld', 08:19:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:19:20 INFO - 'LOGNAME': 'cltbld', 08:19:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:19:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:19:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:19:20 INFO - 'MOZ_NO_REMOTE': '1', 08:19:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:19:20 INFO - 'NO_EM_RESTART': '1', 08:19:20 INFO - 'PAGER': '/bin/cat', 08:19:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:19:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:19:20 INFO - 'PWD': '/builds/slave/test', 08:19:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:19:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:19:20 INFO - 'SHELL': '/bin/bash', 08:19:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fmduFg0KA9/Listeners', 08:19:20 INFO - 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/', 08:19:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:19:20 INFO - 'USER': 'cltbld', 08:19:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:19:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:19:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:19:20 INFO - 'XPC_FLAGS': '0x0', 08:19:20 INFO - 'XPC_SERVICE_NAME': '0', 08:19:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:19:20 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DvIpX7R7SdyPGnPVQZCNMg/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0258', '--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 08:19:21 INFO - mozversion application_buildid: 20170218070119 08:19:21 INFO - mozversion application_changeset: b200f1a3b627e520af1f7f6546e7d76b8b09c8af 08:19:21 INFO - mozversion application_display_name: FirefoxDeveloperEdition 08:19:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:19:21 INFO - mozversion application_name: Firefox 08:19:21 INFO - mozversion application_remotingname: firefox-dev 08:19:21 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:19:21 INFO - mozversion application_vendor: Mozilla 08:19:21 INFO - mozversion application_version: 53.0a2 08:19:21 INFO - mozversion platform_buildid: 20170218070119 08:19:21 INFO - mozversion platform_changeset: b200f1a3b627e520af1f7f6546e7d76b8b09c8af 08:19:21 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:19:21 INFO - mozversion platform_version: 53.0a2 08:19:21 INFO - using testdate: 1487434761 08:19:21 INFO - actual date: 1487434761 08:19:21 INFO - starting webserver on 'localhost:49241' 08:19:21 INFO - SUITE-START | Running 2 tests 08:19:21 INFO - TEST-START | dromaeo_css 08:19:21 INFO - operating with platform_type : mac_ 08:19:21 INFO - Initialising browser for dromaeo_css test... 08:19:21 INFO - TEST-INFO | started process 1674 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/tmpAnQecg/profile http://localhost:49241/getInfo.html) 08:19:23 INFO - PROCESS | 1674 | __metrics Screen width/height:1600/1200 08:19:23 INFO - PROCESS | 1674 | colorDepth:24 08:19:23 INFO - PROCESS | 1674 | Browser inner width/height: 1024/689 08:19:23 INFO - PROCESS | 1674 | __metrics 08:19:23 INFO - PROCESS | 1674 | 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" 08:19:23 INFO - PROCESS | 1674 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:19:24 INFO - TEST-INFO | 1674: exit 0 08:19:24 INFO - Browser initialized. 08:19:24 INFO - Running cycle 1/1 for dromaeo_css test... 08:19:24 INFO - TEST-INFO | started process 1677 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/tmpAnQecg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:19:36 INFO - PROCESS | 1677 | RSS: Main: 213639168 08:19:36 INFO - PROCESS | 1677 | 08:22:41 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49241/tests/dromaeo/cssquery-ext.html) 08:22:43 INFO - PROCESS | 1677 | RSS: Main: 348672000 08:22:43 INFO - PROCESS | 1677 | 08:24:25 INFO - PROCESS | 1677 | ************************* 08:24:25 INFO - PROCESS | 1677 | A coding exception was thrown and uncaught in a Task. 08:24:25 INFO - PROCESS | 1677 | 08:24:25 ERROR - PROCESS | 1677 | Full message: TypeError: NetworkError when attempting to fetch resource. 08:24:25 INFO - PROCESS | 1677 | Full stack: 08:24:25 INFO - PROCESS | 1677 | ************************* 08:25:46 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-ext.html (next: http://localhost:49241/tests/dromaeo/cssquery-jquery.html) 08:25:46 INFO - PROCESS | 1677 | RSS: Main: 353771520 08:25:46 INFO - PROCESS | 1677 | 08:28:49 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49241/tests/dromaeo/cssquery-mootools.html) 08:28:49 INFO - PROCESS | 1677 | RSS: Main: 323239936 08:28:49 INFO - PROCESS | 1677 | 08:31:52 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49241/tests/dromaeo/cssquery-prototype.html) 08:31:52 INFO - PROCESS | 1677 | RSS: Main: 320954368 08:31:52 INFO - PROCESS | 1677 | 08:34:56 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49241/tests/dromaeo/cssquery-yui.html) 08:34:57 INFO - PROCESS | 1677 | RSS: Main: 310530048 08:34:57 INFO - PROCESS | 1677 | 08:38:00 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-yui.html (next: http://localhost:49241/tests/dromaeo/cssquery-dojo.html) 08:38:00 INFO - PROCESS | 1677 | RSS: Main: 554016768 08:38:00 INFO - PROCESS | 1677 | 08:38:00 INFO - PROCESS | 1677 | __start_tp_report 08:38:00 INFO - PROCESS | 1677 | _x_x_mozilla_page_load 08:38:00 INFO - PROCESS | 1677 | _x_x_mozilla_page_load_details 08:38:00 INFO - PROCESS | 1677 | |i|pagename|runs| 08:38:00 INFO - PROCESS | 1677 | |0;dojo.html;3268.313654132632;3290.736741060715;3317.9548442240675;3331.2837739885917;3367.932641347173;5685.971570142148;5737.426257374261;5743.483086522207;5767.250257466523;5774.335951365594;5699.857503562403;5748.712564371785;5768.134779783024;5768.798092066779;5786.710664466781;5208.140656791625;5264.736763161845;5266.210068489719;5273.288106105684;5327.200919862013;5170.638055336128;5176.197689358137;5341.519263266306;5342.332208473941;5360.088784906556;5193.480651934814;5196.376434827807;5203.0114278287;5217.295665085203;5289.603279754015;5216.7913283468615;5230.979958908015;5236.319278493809;5260.631755777116;5272.947270527322;5136.203888397305;5211.530962213419;5231.581473482112;5234.685918844882;5265.578753699695;5571.387147413781;5572.804951826666;5619.887602247933;5625.128105143709;5683.318001839764;6251;6256.87486250277;6278.560500764948;6294.433500984887;6296.307406185316;6255.499560035232;6325.715342809584;6332.05019247112;6337.112804207414;6360.363963603602;4735.668503204743;5580.469855363734;5711.171880077449;5814.97092514539;5830.38780928005;6205.906911396332;6253.53098517613;6282.842928926813;6287.371262873676;6305.873882522324;6195.907061394083;6227.844303892439;6230.626162430269;6239.688015599202;6257.09272155544;6136.7852125175405;6267.435930766253;6317.905231421532;6340.778072767431;6349.746010159542;6088.543359248074;6148.262208535004;6169.691515424211;6221.129041934133;6226.315105338409;6315.684215789192;6321.336259692758;6329.778457753957;6345.365463453618;6348.460380867586;5012.47369026247;5025.723585202849;5044.117279476077;5053.36832895888;5060.51925067118;4342.913141737211;4381.992141807402;4387.714798538149;4396.252637051709;4484.618807401407;5717.085266357363;5768.451997060272;5792.131180322901;5808.099744539603;5827.038538641077;5234.42421333653;6119.654885716942;6203.8138855834395;6234.906476402857;6303.684815759286;5672.290963629546;5718.599698021182;5736.282964629421;5767.596268261265;5799.4780469757925;5329.360476742738;5402.864928376822;5480.7533660985355;5499.670019798825;5512.448755124456;6176.7838125665385;6249.812505624838;6254.061890716429;6284.591501552384;6348.428641422294;5369.838904832861;6250.531210159347;6305.180326557702;6307.053941908567;6307.590006649553;6310.943253329642;6345.650989195638;6352.745890164341;6358.523110766619;6368.42684158428;5332.093544097435;6055.061465472859;6135.294441139147;6148.938510614837;6262.06069089622;6055.727492262947;6295.842603934755;6297.96851015742;6304.779332723333;6310.05349197624;6049.334573197033;6155.753769849156;6170.290416602148;6188.783392581238;6189.752409903554;5983;6027.306859711014;6114.419130182626;6172.290186628596;6197.876042479215;5908.3796201399955;6077.817665470043;6078.72645730952;6118.755249789959;6125.418085281891;6179.1411533197215;6182.474489668429;6222.688865556795;6224.439800417984;6225.159603453476;5728.369879313355;5847.152162936435;6060.545459090674;6075.1191077294425;6094.421030002142 08:38:00 INFO - PROCESS | 1677 | |1;ext.html;451.386114883758;469.2937129619921;484.60746795095974;492.6206820748024;499.87003379121415;32021.839890800544;40121.197576048464;42332.153356932846;42486.7875660622;44415.33376999348;43485;43777;43860.78069609647;43861;43871.56128438715;8130.308923741489;8797;9020.368574199809;9029.322800789967;9039;8124.431289809716;10493.685189444328;10706.678799636024;10747.62383316584;10919.617813376533;10765.03114719675;10826.512806923707;10848.511816968215;10872.130229581615;10884.510197041152;10792.136629069695;10850.18623603225;10881.23831331807;10882.129429645609;10896.78206435867;8005.399595030396;8201.753947381589;10431.530581123867;10710.143188544898;10740;41836.1632767346;42256;42268.36597451041;42299.36550951738;42333.78833105846;3813.4858727682276;3937.960620393788;3973.860914867995;3978.5026871641044;3995.20095980805;27501.862490687417;27506;27513.862430687717;27665.308367290778;28097.578536321973;3044.360684256309;3323.4682450807995;3331.1172539277113;3331.3503866745996;3337.3992681317354;441561;489585;493337;494038;494171.9999999964;57811.710941445024;58069.41930580725;58201;58216;58364;59884.70057649684;59936.40063599395;60080.39919600835;60089.798204036546;60116;15745.763813542806;16036.877418580822;16041.037537747772;16078.67842643164;16095.356185752438;11163.218574699693;12407.813882791765;12443.502259909683;12490.313032783284;12520.561780337644;15498.30257638409;15898.60253493672;17800.020998845186;18178.818211817976;18234;6875.243723190445;7590.696372145163;7657.23427657241;7664.195259497673;7752.341051010727;859.3125499600295;878.5870640798814;881.9142727449536;895.5925054100499;913.1051569461964;30692;30709.38581228363;30750.84624576863;30975.845120774702;31499.685003150134;1059.2003037706481;1069.3102948598112;1083.5124194112523;1094.2285688589525;1204.9396531052794;15549.222538873237;15568;16072.839271607134;16157.596060098356;16481.83518164803;643335;649928;650102;651019;651378;55557;56254.43745562492;56304.155437668465;56343.71828140833;56389.43610563924;1406.9718605628034;1418.7871819227198;1449.1232804153547;1456.3519233941006;1457.8031965684497;29048.9832855849;29252.853735731183;29279.560806588343;30004.399912002074;30054.549181761853;49496;50289.24566131584;50318.99362012666;50364.74817626035;50417;575418.1229093996;577172;578670;579273;579713;26182.86908565445;26401.867990659925;26635.467290654466;26645.866770666024;26676.19971400861;43373.78313108414;43472.34791478067;44837.551624484644;45701;45912.62262132141;35136.12159696028;35862;36744.278805404385;37622.43566346452;37704.245915082094;35751.88853281802;36041.63958360383;36168.638313616524;37517.81241093777;37683.43474847825;34304;34916.82541587276;35156.29687406187;35407.82296088503;35831.82084089563;30005.399892001602;32549;32750.50874236936;32817.83591082029;32854.83572582217;24225.273241802774;24302.756972430758;24356.75643243545;24516.6322505159;24555.263342099766 08:38:00 INFO - PROCESS | 1677 | |2;jquery.html;363.8726445743988;381.2584523102565;387.2023631319482;399.73817149766916;419.6831392298816;13591.864081359183;13917.095388799733;15223.847761522395;17942.641147177048;18654;17376.304947802073;18002.459926202202;18256.81743182568;18459.81540184601;18663.066846657646;5520.751566179511;5790.7683692652245;5801.767929282823;5806.10005449154;5807.477327040587;5427.0773968425465;5557.5553955683445;5603.495685388314;5617.4382561743905;5622.212890195376;5168.974155129238;5214.06146893559;5497.5601951843755;5593.8601534961745;5604.1593760935775;5423.484768946963;5576.693281869496;5677.829665110054;5700.572457065695;5782.624129431573;5541.833744987657;5541.972290138524;5631.746571404296;5640;5659.264295641581;12209.962153216988;12572.559960401433;12579.245245285312;12592.244465332109;12598.055145864006;2585.340738111788;2585.831920925134;2601.7008044074983;2650.6554147960833;2651.164883061829;9755.170810481117;10108.848367274497;10132.898671013269;10165.796684066352;10574.471276436147;1756.6311074674334;1789.4363275568155;1800.7945856375673;1836.2563161919445;1865.4310435317223;97810;130397.6960230395;132890;136331;139593;11502.482388292547;11673;11882.287062776088;12035.939820300842;12253.816192757116;15683.215839208222;16269.51191464258;16269.755953660704;16289.918550407172;16312.51062468128;8740.344474164463;8966.730998070068;9034.593443295067;9082.954585227031;9171.312151588658;7704;8079;8412;8675.696350627697;8857.867131993025;4769.373421717196;4855.927161092586;4863.95136048635;4899.265110233494;4914.557689807934;1982.7521559805025;2021.3632705697657;2026.71625972364;2030.2287377729292;2030.8375329973862;965.6620182935916;968.6125549780145;996.1731762636994;1001.3891526169031;1006.2201793609864;21645.783542164692;21850.672239916414;22002.669959950614;22065;22210.222642207445;1016.4866742295242;1036.3315661398356;1043.8642976413018;1048.1509976918721;1061.8035663402295;10926.726831829108;11426.08591312693;11435.771284574263;11476.713082172846;11496.367699776592;726976;727577.362113186;749916;751737;774731;128169;155849;159919;162133;170727.29272707115;1010.7877345757473;1027.6454623155;1069.4064794039227;1074.521837782195;1076.364944682641;19792;19953.600927981068;20305.78165310086;20336.79663203349;20397.694034589196;60032.099518508134;60407;60814;61151;61241;68871;69299.65350173217;88102;88958;88966;8289.295409890226;8336.166383361615;8445.366597505088;8506.106858779738;8569.871451928102;7684.500507466997;11035.72410689707;12636.747265054832;12819.487220511075;13029.739405212033;5670.432956704297;8603.881495405807;8644.567771611268;10279.640212592523;11077.501512432122;11111.44442777874;11353.54585816558;11497.597584084851;11601.216883007104;11602.18784685064;11483.425828708698;11834.82247766267;11871.228370155912;11962.162648614514;11970.58102966392;8151.30713889326;8301.584920753818;8369.455985360932;8674.522901240493;8681.826363472821;8488.830223395375;9990.800183996425;10980.615678451215;11473.196876218584;11487.36819474937 08:38:00 INFO - PROCESS | 1677 | |3;mootools.html;1411;1441.2937660546336;1447.5946734914226;1455.8325792533863;1458.0959804920947;8158.796030099251;8413.78965525862;8563.35774816888;8575.828483430336;8601.741947741577;6695.899561506581;7424.109106907165;7696;7709.845803083935;8247.91752082479;2297.448612333045;2339.532093581282;2343.6484527320868;2344.1443872986324;2352.200251914349;2323.6398358254496;2359.539889721505;2366.597678394677;2367.6093444581625;2373.6320870265135;1895.2703209264464;2021.231931865889;2104.3160972683863;2319.489712263299;2355.1521452277166;2322.593546129429;2337.754535773753;2338.3452633262546;2338.5556744218543;2340.461693810433;2274.9886250568807;2311.0640190722784;2358.516504116652;2362.5393048355577;2364.550735360276;8433.915660843375;8533.445326053848;8553.315734741269;8554.572271386469;8567.400281980264;4979;5138.152204886189;5140.537351638371;5155.381354237478;5161.3806343238675;3034.7723920706035;3304.6364899860996;3457.0320310313155;3467.3932061889323;3508.14050557615;1169.7309618787726;1210.3887536793864;1213.1932265043824;1270.5134992059313;1271.5041133957764;10832.458377081115;10900.96440838119;10978.725531861688;10983.780324393467;11010.284331518505;4510.323451482304;4684;4766.046790641816;4779.952200477951;4782.641301902371;9380.343375963617;9593.760155996017;9596.376235544667;9613.51932403377;9618.711438656852;5302.416734159239;5308.469153084738;5314.12316967696;5331.600129990189;5362.731863406814;4067.6949228807957;4183.640316897021;4283.271843786564;4820.373351464287;4852.223644216909;3843.2121415110396;3883;3985.601439855991;3994.72036957416;4007.6192761687594;1284.6724085358173;1303.3418123847396;1313.441787240419;1321.5704895908868;1329.0497294434526;767.8195624028349;819.6516480495766;897.2328658996595;898.1826537850656;915.912988266127;5204.609654275944;5590.468905453975;5722.227499287543;5775.451332123442;5978.432048955342;825.3149885594942;972.2416515118219;1005.994005994006;1009.5204777730667;1039.3763741755038;3245.6105267368066;3683.4843121962945;3687.5943646199435;3730.9067273318383;3848.8845334640005;9765.755856103513;10122.291439599305;10129.544170512345;10161;10178.491075446198;9895.406275623342;9966.900330996597;9972;10005.099541041196;10112.544935477774;7403.370713489306;7691.423143264277;7699.422543309274;7777.611119444005;7781.221877812287;5473.616846820843;5659.236003139524;5734.111212762028;5746.942530574641;5819.5635327351465;7258.782236532912;8890.24432923183;9056;9192.678256260999;9253.76865578339;9228.307876909394;9328.813423731352;9497.477638729937;9537.475438850652;9552.713418597454;6420.935790642034;6865.5537390069485;7096.858062838817;7243.45674074436;7262.818429539304;7855.921440785519;7915.920840791749;7995.720149794729;7997.680092796456;8022;6994.160700715743;7063.646817659199;7075.929240707527;7124.501284910007;7215.350618444155;7024.402925751164;7027.4378049756915;7034.120734908137;7109.502334836512;7153.070100886852;6157.168782214344;6306.148669929501;6402.295747467868;6449.322821103717;6474.449671777763;4494.348319493721;4550.203714350042;4573.108243892409;4579.633629309581;4684.718916864999;4984.675996060245;4985.626078044089;5044.4198917125;5080.669756465818;5099.0821652101495 08:38:00 INFO - PROCESS | 1677 | |4;prototype.html;354.028192611282;355.4401817138008;363.3985753577829;375.34876988425094;375.72572022423645;4330.501992270886;4994.650374473788;5171.663841850277;5326.067938110835;5350.464953504647;4250.9149817003645;4989.476105008976;5087.847364579059;5115.411727651322;5244.68531888087;3358.5465962095172;3567.732420068492;3896.376579747241;4135;4151.916961660765;3597.622249663787;3985.641292283694;4142.440770495975;4152.875413737577;4181;3455.619881813011;4053.1691003344245;4063.8374465021366;4065.7560546367163;4091.590840915914;3909.198614284065;4045.4336392905016;4056.7565946043333;4062.329715596923;4065.471488706479;3597.80212088335;3615.511905892697;3619;3622.5652921649307;3655.7623754455876;4743.857684269477;5035.471275516092;5040.639027462565;5111.875387414762;5232.953409318114;4406.832189469793;4505.873531617096;4714.858554243378;4744.857654270378;4793;4422.690411671184;4727.479977202505;5139.331886854722;5543.861403464905;5555.916661250085;3875.1862108957152;3905.453236546886;3951.5455722591983;3988.1824226033596;4014.093305679808;4768.47546769855;5183.766730497136;5446.101393270105;5653.4911857932575;5819.88360232793;3521.7710848794745;3941.9605803941595;4037;4071.1043570414463;4078.5921407858978;3461.480777883338;3551.7213803030886;3748.231612519427;3749.5875453700073;4122.670186385082;4653.930191047137;4677.567664814277;4682.74244916526;4728.858134255978;4746.620270378361;5388.892222155535;5615.978247830778;5634.85912852182;5639.548836093103;5668.8866222675315;1181.7990941539958;1244.3840299052026;1306.399056434032;1337.3714354253486;1348.9392977315847;884.8363052835246;924.4915296586851;953.6423841059602;966.6036924860773;971.2958105373689;4597.103564804898;4654.25531914892;4873.926891096637;4925.088858561106;4966.875828104254;4387.451568553931;4944.554990050912;5005.314992160942;5019.278023053722;5386;4485.349624304457;4702.741349225757;4843.2735089736825;4870.196417591058;4883.438404583448;2638.103044964683;2648.576227803542;2655.8672066396603;2833.6032955386263;2849.6891429942043;5039.44566097729;5354.929014197176;5569;5569.777208911679;5584.022796010763;4931.950680493149;5874.324452687995;5880.235569375954;5894.8821023579285;5900;5528.944710552843;5741.684207368635;5928.28860536747;5935.82192534216;5990.4908082813445;4803.615710743202;5623.971880140573;5627.874425114912;5704.974733969547;5745.540356771532;4631.614718419949;5630.73308505583;5699.5725320600295;5699.886002279848;5732.971335143297;4935.284383764262;5648.802291919763;5707.203470299606;5919.460940155676;5964.731587078505;3317.5568627646085;3330.052903180751;3853.6531712146043;3881.262560113569;3901.9464744518255;5096.974515127401;5710.828675139753;5750.166225897305;5764.106563482667;5789.989205613142;4711.316859055486;5373.570114390917;5492.835214943558;5574.108142697149;5664.631798933056;4853.757312134449;4965.602751779921;5436.7281635918835;5552.750126244409;5555.30558680165;5302.8713059295205;5335.466453354634;5416.918746218731;5460.645058071213;5461.4980880258245;5318.840434786963;5526.861828454321;5579.804706835242;5590.183190463197;5594.9720251398485;5287.444818294024;5409.567234621142;5464.699441530754;5465.59008074388;5468.675812779632 08:38:00 INFO - PROCESS | 1677 | |5;yui.html;690.3338278561188;701.3302296307024;759.6505607420586;813.3249402995514;820.2699597358352;12536.435860386282;13342.332883355843;13348.7330253395;13359.19844809311;13415.26216058119;12324;12548.874511254884;12644.810327845089;12675.61973140805;12716.491340346374;672.7914346552584;696.0776970514089;696.8188271049538;828.6561077152975;846.5640195299426;853.7353420439653;855.2687452228348;868.2142660891903;869.0527325215514;870.5168631409565;921.005314260597;921.764949937765;922.8385032619299;924.5839372282467;927.9721608351726;711.8505113926082;732.9706811727525;916.1388295002677;918.0223062438548;918.1323649151522;658.0359772932629;676.0163961436099;682.3415404135034;683.5761827666829;683.9692213850388;12561.309127997956;12584.68538286541;12637.115401921868;12655.746885062246;12670.113092083559;12120.757584848341;12139.514419423213;12262.386880655931;12370;12485.56300529477;12343.13598048137;12366.072544559194;12401.44193511285;12404.13171078025;12565.560205392767;4286.121345124273;4341.956580434186;4390.078083602447;4402.163588918095;4459.974205932654;95198.52400737951;96518.55222171673;97015;101619;104095;9383.436993780395;9460.52697365129;9572.90427095734;9636.614535418645;9717.416954982724;20993.265235716677;21131.366059018255;21291.78708212898;21392.465188370414;21444.678329825067;6695.899561506581;6713.865722685617;6718.563293385914;6742.528023038439;6811.761588344384;3227.1286752577143;3273.541704161419;3290.4899740540254;3292.3250733599552;3357.1774915145456;3386.2211691311136;3421.8289085545625;3436.226848959014;3475.6176820549717;3479.321532301177;613.3069631316673;618.0790621973227;620.9379062093844;632.301307055706;633.5596760251673;577.3043482603453;603.9430995757424;620.7516993202755;643.2506130358174;657.5922927784804;8923.821523569492;9056.13966673165;9255.472846980307;9616.711498655051;9695.321327507148;599.6791716431688;667.2660073918651;668.7826456401592;671.7111641993989;674.2010717300016;4577.633789296849;4653.278741795028;4688.648351373592;4699;4715.7642117893965;104827;105472;107574;109242;111940.44029779799;88039;88985;91536.54231728798;93317;95227;69495.3050469509;70461.2953870465;80927;83248.58375708082;83378.58310708408;10146.594136234467;10747.086497647788;10787.083097936764;10945.807085734545;11026.173037022416;49798.75100624474;50053;52229.10324346002;52919;53878;66111;66314.66842665756;69599.65200173967;70599;70603;12528.749425011267;12589;12831.679208019874;12839.807402889151;12938.478076715366;13996.300184990507;14118.47996250726;14282.928585357007;14569.490067847575;14789.260536972894;12805.615831525069;12977.156484828834;13822.861771382157;14069.085509441853;14097.224652644203;11652.359120248468;12735.74528509406;12901.741965160832;13470.393832277376;13521;12485.812712809497;13091.869081309065;13115.934420327838;13148.474061037834;13724.039317247696;10575.894241057798;11311;11385.259958102697;11490.942545287555;11565.826512602485;7718.575478348745;10159.644412445528;10558.894411056099;10910.72723181895;10970.341779493256 08:38:00 INFO - PROCESS | 1677 | __end_tp_report 08:38:00 INFO - PROCESS | 1677 | __start_cc_report 08:38:00 INFO - PROCESS | 1677 | _x_x_mozilla_cycle_collect,1473 08:38:00 INFO - PROCESS | 1677 | __end_cc_report 08:38:00 INFO - PROCESS | 1677 | __startTimestamp1487435880532__endTimestamp 08:38:00 INFO - PROCESS | 1677 | 08:38:00 INFO - PROCESS | 1677 | ------- Summary: start ------- 08:38:00 INFO - PROCESS | 1677 | Number of tests: 6 08:38:00 INFO - PROCESS | 1677 | 08:38:00 INFO - PROCESS | 1677 | [#0] dojo.html Cycles:165 Average:5755.36 Median:6027.31 stddev:653.84 (10.8%) stddev-sans-first:626.06 08:38:00 INFO - PROCESS | 1677 | Values: 3268.3 3290.7 3318.0 3331.3 3367.9 5686.0 5737.4 5743.5 5767.3 5774.3 5699.9 5748.7 5768.1 5768.8 5786.7 5208.1 5264.7 5266.2 5273.3 5327.2 5170.6 5176.2 5341.5 5342.3 5360.1 5193.5 5196.4 5203.0 5217.3 5289.6 5216.8 5231.0 5236.3 5260.6 5272.9 5136.2 5211.5 5231.6 5234.7 5265.6 5571.4 5572.8 5619.9 5625.1 5683.3 6251.0 6256.9 6278.6 6294.4 6296.3 6255.5 6325.7 6332.1 6337.1 6360.4 4735.7 5580.5 5711.2 5815.0 5830.4 6205.9 6253.5 6282.8 6287.4 6305.9 6195.9 6227.8 6230.6 6239.7 6257.1 6136.8 6267.4 6317.9 6340.8 6349.7 6088.5 6148.3 6169.7 6221.1 6226.3 6315.7 6321.3 6329.8 6345.4 6348.5 5012.5 5025.7 5044.1 5053.4 5060.5 4342.9 4382.0 4387.7 4396.3 4484.6 5717.1 5768.5 5792.1 5808.1 5827.0 5234.4 6119.7 6203.8 6234.9 6303.7 5672.3 5718.6 5736.3 5767.6 5799.5 5329.4 5402.9 5480.8 5499.7 5512.4 6176.8 6249.8 6254.1 6284.6 6348.4 5369.8 6250.5 6305.2 6307.1 6307.6 6310.9 6345.7 6352.7 6358.5 6368.4 5332.1 6055.1 6135.3 6148.9 6262.1 6055.7 6295.8 6298.0 6304.8 6310.1 6049.3 6155.8 6170.3 6188.8 6189.8 5983.0 6027.3 6114.4 6172.3 6197.9 5908.4 6077.8 6078.7 6118.8 6125.4 6179.1 6182.5 6222.7 6224.4 6225.2 5728.4 5847.2 6060.5 6075.1 6094.4 08:38:00 INFO - PROCESS | 1677 | 08:38:00 INFO - PROCESS | 1677 | [#1] ext.html Cycles:180 Average:69859.99 Median:35951.82 stddev:153498.44 (427.0%) stddev-sans-first:153840.58 08:38:00 INFO - PROCESS | 1677 | Values: 451.4 469.3 484.6 492.6 499.9 32021.8 40121.2 42332.2 42486.8 44415.3 43485.0 43777.0 43860.8 43861.0 43871.6 8130.3 8797.0 9020.4 9029.3 9039.0 8124.4 10493.7 10706.7 10747.6 10919.6 10765.0 10826.5 10848.5 10872.1 10884.5 10792.1 10850.2 10881.2 10882.1 10896.8 8005.4 8201.8 10431.5 10710.1 10740.0 41836.2 42256.0 42268.4 42299.4 42333.8 3813.5 3938.0 3973.9 3978.5 3995.2 27501.9 27506.0 27513.9 27665.3 28097.6 3044.4 3323.5 3331.1 3331.4 3337.4 441561.0 489585.0 493337.0 494038.0 494172.0 57811.7 58069.4 58201.0 58216.0 58364.0 59884.7 59936.4 60080.4 60089.8 60116.0 15745.8 16036.9 16041.0 16078.7 16095.4 11163.2 12407.8 12443.5 12490.3 12520.6 15498.3 15898.6 17800.0 18178.8 18234.0 6875.2 7590.7 7657.2 7664.2 7752.3 859.3 878.6 881.9 895.6 913.1 30692.0 30709.4 30750.8 30975.8 31499.7 1059.2 1069.3 1083.5 1094.2 1204.9 15549.2 15568.0 16072.8 16157.6 16481.8 643335.0 649928.0 650102.0 651019.0 651378.0 55557.0 56254.4 56304.2 56343.7 56389.4 1407.0 1418.8 1449.1 1456.4 1457.8 29049.0 29252.9 29279.6 30004.4 30054.5 49496.0 50289.2 50319.0 50364.7 50417.0 575418.1 577172.0 578670.0 579273.0 579713.0 26182.9 26401.9 26635.5 26645.9 26676.2 43373.8 43472.3 44837.6 45701.0 45912.6 35136.1 35862.0 36744.3 37622.4 37704.2 35751.9 36041.6 36168.6 37517.8 37683.4 34304.0 34916.8 35156.3 35407.8 35831.8 30005.4 32549.0 32750.5 32817.8 32854.8 24225.3 24302.8 24356.8 24516.6 24555.3 08:38:00 INFO - PROCESS | 1677 | 08:38:00 INFO - PROCESS | 1677 | [#2] jquery.html Cycles:180 Average:39991.08 Median:21926.67 stddev:124399.30 (567.3%) stddev-sans-first:124712.69 08:38:00 INFO - PROCESS | 1677 | Values: 363.9 381.3 387.2 399.7 419.7 13591.9 13917.1 15223.8 17942.6 18654.0 17376.3 18002.5 18256.8 18459.8 18663.1 5520.8 5790.8 5801.8 5806.1 5807.5 5427.1 5557.6 5603.5 5617.4 5622.2 5169.0 5214.1 5497.6 5593.9 5604.2 5423.5 5576.7 5677.8 5700.6 5782.6 5541.8 5542.0 5631.7 5640.0 5659.3 12210.0 12572.6 12579.2 12592.2 12598.1 2585.3 2585.8 2601.7 2650.7 2651.2 9755.2 10108.8 10132.9 10165.8 10574.5 1756.6 1789.4 1800.8 1836.3 1865.4 97810.0 130397.7 132890.0 136331.0 139593.0 11502.5 11673.0 11882.3 12035.9 12253.8 15683.2 16269.5 16269.8 16289.9 16312.5 8740.3 8966.7 9034.6 9083.0 9171.3 7704.0 8079.0 8412.0 8675.7 8857.9 4769.4 4855.9 4864.0 4899.3 4914.6 1982.8 2021.4 2026.7 2030.2 2030.8 965.7 968.6 996.2 1001.4 1006.2 21645.8 21850.7 22002.7 22065.0 22210.2 1016.5 1036.3 1043.9 1048.2 1061.8 10926.7 11426.1 11435.8 11476.7 11496.4 726976.0 727577.4 749916.0 751737.0 774731.0 128169.0 155849.0 159919.0 162133.0 170727.3 1010.8 1027.6 1069.4 1074.5 1076.4 19792.0 19953.6 20305.8 20336.8 20397.7 60032.1 60407.0 60814.0 61151.0 61241.0 68871.0 69299.7 88102.0 88958.0 88966.0 8289.3 8336.2 8445.4 8506.1 8569.9 7684.5 11035.7 12636.7 12819.5 13029.7 5670.4 8603.9 8644.6 10279.6 11077.5 11111.4 11353.5 11497.6 11601.2 11602.2 11483.4 11834.8 11871.2 11962.2 11970.6 8151.3 8301.6 8369.5 8674.5 8681.8 8488.8 9990.8 10980.6 11473.2 11487.4 08:38:00 INFO - PROCESS | 1677 | 08:38:00 INFO - PROCESS | 1677 | [#3] mootools.html Cycles:180 Average:5421.88 Median:5139.34 stddev:2962.13 (57.6%) stddev-sans-first:2955.10 08:38:00 INFO - PROCESS | 1677 | Values: 1411.0 1441.3 1447.6 1455.8 1458.1 8158.8 8413.8 8563.4 8575.8 8601.7 6695.9 7424.1 7696.0 7709.8 8247.9 2297.4 2339.5 2343.6 2344.1 2352.2 2323.6 2359.5 2366.6 2367.6 2373.6 1895.3 2021.2 2104.3 2319.5 2355.2 2322.6 2337.8 2338.3 2338.6 2340.5 2275.0 2311.1 2358.5 2362.5 2364.6 8433.9 8533.4 8553.3 8554.6 8567.4 4979.0 5138.2 5140.5 5155.4 5161.4 3034.8 3304.6 3457.0 3467.4 3508.1 1169.7 1210.4 1213.2 1270.5 1271.5 10832.5 10901.0 10978.7 10983.8 11010.3 4510.3 4684.0 4766.0 4780.0 4782.6 9380.3 9593.8 9596.4 9613.5 9618.7 5302.4 5308.5 5314.1 5331.6 5362.7 4067.7 4183.6 4283.3 4820.4 4852.2 3843.2 3883.0 3985.6 3994.7 4007.6 1284.7 1303.3 1313.4 1321.6 1329.0 767.8 819.7 897.2 898.2 915.9 5204.6 5590.5 5722.2 5775.5 5978.4 825.3 972.2 1006.0 1009.5 1039.4 3245.6 3683.5 3687.6 3730.9 3848.9 9765.8 10122.3 10129.5 10161.0 10178.5 9895.4 9966.9 9972.0 10005.1 10112.5 7403.4 7691.4 7699.4 7777.6 7781.2 5473.6 5659.2 5734.1 5746.9 5819.6 7258.8 8890.2 9056.0 9192.7 9253.8 9228.3 9328.8 9497.5 9537.5 9552.7 6420.9 6865.6 7096.9 7243.5 7262.8 7855.9 7915.9 7995.7 7997.7 8022.0 6994.2 7063.6 7075.9 7124.5 7215.4 7024.4 7027.4 7034.1 7109.5 7153.1 6157.2 6306.1 6402.3 6449.3 6474.4 4494.3 4550.2 4573.1 4579.6 4684.7 4984.7 4985.6 5044.4 5080.7 5099.1 08:38:00 INFO - PROCESS | 1677 | 08:38:00 INFO - PROCESS | 1677 | [#4] prototype.html Cycles:180 Average:4473.52 Median:4933.62 stddev:1351.48 (27.4%) stddev-sans-first:1319.43 08:38:00 INFO - PROCESS | 1677 | Values: 354.0 355.4 363.4 375.3 375.7 4330.5 4994.7 5171.7 5326.1 5350.5 4250.9 4989.5 5087.8 5115.4 5244.7 3358.5 3567.7 3896.4 4135.0 4151.9 3597.6 3985.6 4142.4 4152.9 4181.0 3455.6 4053.2 4063.8 4065.8 4091.6 3909.2 4045.4 4056.8 4062.3 4065.5 3597.8 3615.5 3619.0 3622.6 3655.8 4743.9 5035.5 5040.6 5111.9 5233.0 4406.8 4505.9 4714.9 4744.9 4793.0 4422.7 4727.5 5139.3 5543.9 5555.9 3875.2 3905.5 3951.5 3988.2 4014.1 4768.5 5183.8 5446.1 5653.5 5819.9 3521.8 3942.0 4037.0 4071.1 4078.6 3461.5 3551.7 3748.2 3749.6 4122.7 4653.9 4677.6 4682.7 4728.9 4746.6 5388.9 5616.0 5634.9 5639.5 5668.9 1181.8 1244.4 1306.4 1337.4 1348.9 884.8 924.5 953.6 966.6 971.3 4597.1 4654.3 4873.9 4925.1 4966.9 4387.5 4944.6 5005.3 5019.3 5386.0 4485.3 4702.7 4843.3 4870.2 4883.4 2638.1 2648.6 2655.9 2833.6 2849.7 5039.4 5354.9 5569.0 5569.8 5584.0 4932.0 5874.3 5880.2 5894.9 5900.0 5528.9 5741.7 5928.3 5935.8 5990.5 4803.6 5624.0 5627.9 5705.0 5745.5 4631.6 5630.7 5699.6 5699.9 5733.0 4935.3 5648.8 5707.2 5919.5 5964.7 3317.6 3330.1 3853.7 3881.3 3901.9 5097.0 5710.8 5750.2 5764.1 5790.0 4711.3 5373.6 5492.8 5574.1 5664.6 4853.8 4965.6 5436.7 5552.8 5555.3 5302.9 5335.5 5416.9 5460.6 5461.5 5318.8 5526.9 5579.8 5590.2 5595.0 5287.4 5409.6 5464.7 5465.6 5468.7 08:38:00 INFO - PROCESS | 1677 | 08:38:00 INFO - PROCESS | 1677 | [#5] yui.html Cycles:180 Average:20198.66 Median:4518.80 stddev:29577.40 (654.5%) stddev-sans-first:29624.10 08:38:00 INFO - PROCESS | 1677 | Values: 690.3 701.3 759.7 813.3 820.3 12536.4 13342.3 13348.7 13359.2 13415.3 12324.0 12548.9 12644.8 12675.6 12716.5 672.8 696.1 696.8 828.7 846.6 853.7 855.3 868.2 869.1 870.5 921.0 921.8 922.8 924.6 928.0 711.9 733.0 916.1 918.0 918.1 658.0 676.0 682.3 683.6 684.0 12561.3 12584.7 12637.1 12655.7 12670.1 12120.8 12139.5 12262.4 12370.0 12485.6 12343.1 12366.1 12401.4 12404.1 12565.6 4286.1 4342.0 4390.1 4402.2 4460.0 95198.5 96518.6 97015.0 101619.0 104095.0 9383.4 9460.5 9572.9 9636.6 9717.4 20993.3 21131.4 21291.8 21392.5 21444.7 6695.9 6713.9 6718.6 6742.5 6811.8 3227.1 3273.5 3290.5 3292.3 3357.2 3386.2 3421.8 3436.2 3475.6 3479.3 613.3 618.1 620.9 632.3 633.6 577.3 603.9 620.8 643.3 657.6 8923.8 9056.1 9255.5 9616.7 9695.3 599.7 667.3 668.8 671.7 674.2 4577.6 4653.3 4688.6 4699.0 4715.8 104827.0 105472.0 107574.0 109242.0 111940.4 88039.0 88985.0 91536.5 93317.0 95227.0 69495.3 70461.3 80927.0 83248.6 83378.6 10146.6 10747.1 10787.1 10945.8 11026.2 49798.8 50053.0 52229.1 52919.0 53878.0 66111.0 66314.7 69599.7 70599.0 70603.0 12528.7 12589.0 12831.7 12839.8 12938.5 13996.3 14118.5 14282.9 14569.5 14789.3 12805.6 12977.2 13822.9 14069.1 14097.2 11652.4 12735.7 12901.7 13470.4 13521.0 12485.8 13091.9 13115.9 13148.5 13724.0 10575.9 11311.0 11385.3 11490.9 11565.8 7718.6 10159.6 10558.9 10910.7 10970.3 08:38:00 INFO - PROCESS | 1677 | -------- Summary: end -------- 08:38:00 INFO - PROCESS | 1677 | 08:38:01 INFO - TEST-INFO | 1677: exit 0 08:38:01 INFO - TEST-OK | dromaeo_css | took 1120046ms 08:38:01 INFO - TEST-START | kraken 08:38:01 INFO - operating with platform_type : mac_ 08:38:01 INFO - Initialising browser for kraken test... 08:38:01 INFO - TEST-INFO | started process 1794 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/tmpIqFqQu/profile http://localhost:49241/getInfo.html) 08:38:03 INFO - PROCESS | 1794 | __metrics Screen width/height:1600/1200 08:38:03 INFO - PROCESS | 1794 | colorDepth:24 08:38:03 INFO - PROCESS | 1794 | Browser inner width/height: 1024/689 08:38:03 INFO - PROCESS | 1794 | __metrics 08:38:03 INFO - PROCESS | 1794 | 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" 08:38:03 INFO - PROCESS | 1794 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:38:04 INFO - TEST-INFO | 1794: exit 0 08:38:04 INFO - Browser initialized. 08:38:04 INFO - Running cycle 1/1 for kraken test... 08:38:04 INFO - TEST-INFO | started process 1796 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/tmpIqFqQu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:38:16 INFO - PROCESS | 1796 | RSS: Main: 213204992 08:38:16 INFO - PROCESS | 1796 | 08:38:19 INFO - PROCESS | 1796 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection) 08:38:20 INFO - PROCESS | 1796 | RSS: Main: 266158080 08:38:20 INFO - PROCESS | 1796 | 08:38:22 INFO - PROCESS | 1796 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-dft) 08:38:23 INFO - PROCESS | 1796 | RSS: Main: 275869696 08:38:23 INFO - PROCESS | 1796 | 08:38:26 INFO - PROCESS | 1796 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-fft) 08:38:27 INFO - PROCESS | 1796 | RSS: Main: 373518336 08:38:27 INFO - PROCESS | 1796 | 08:38:29 INFO - PROCESS | 1796 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator) 08:38:29 INFO - PROCESS | 1796 | RSS: Main: 276811776 08:38:29 INFO - PROCESS | 1796 | 08:38:31 INFO - PROCESS | 1796 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:38:32 INFO - PROCESS | 1796 | RSS: Main: 278777856 08:38:32 INFO - PROCESS | 1796 | 08:38:35 INFO - PROCESS | 1796 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom) 08:38:35 INFO - PROCESS | 1796 | RSS: Main: 318771200 08:38:35 INFO - PROCESS | 1796 | 08:38:38 INFO - PROCESS | 1796 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate) 08:38:39 INFO - PROCESS | 1796 | RSS: Main: 320794624 08:38:39 INFO - PROCESS | 1796 | 08:38:42 INFO - PROCESS | 1796 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial) 08:38:42 INFO - PROCESS | 1796 | RSS: Main: 319561728 08:38:42 INFO - PROCESS | 1796 | 08:38:44 INFO - PROCESS | 1796 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:38:45 INFO - PROCESS | 1796 | RSS: Main: 294010880 08:38:45 INFO - PROCESS | 1796 | 08:38:46 INFO - PROCESS | 1796 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:38:47 INFO - PROCESS | 1796 | RSS: Main: 297508864 08:38:47 INFO - PROCESS | 1796 | 08:38:49 INFO - PROCESS | 1796 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:38:50 INFO - PROCESS | 1796 | RSS: Main: 303656960 08:38:50 INFO - PROCESS | 1796 | 08:38:53 INFO - PROCESS | 1796 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:38:54 INFO - PROCESS | 1796 | RSS: Main: 313192448 08:38:54 INFO - PROCESS | 1796 | 08:38:56 INFO - PROCESS | 1796 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:38:57 INFO - PROCESS | 1796 | RSS: Main: 311906304 08:38:57 INFO - PROCESS | 1796 | 08:38:59 INFO - PROCESS | 1796 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49241/tests/kraken/driver.html?testName=ai-astar) 08:38:59 INFO - PROCESS | 1796 | RSS: Main: 356724736 08:38:59 INFO - PROCESS | 1796 | 08:38:59 INFO - PROCESS | 1796 | __start_tp_report 08:38:59 INFO - PROCESS | 1796 | _x_x_mozilla_page_load 08:38:59 INFO - PROCESS | 1796 | _x_x_mozilla_page_load_details 08:38:59 INFO - PROCESS | 1796 | |i|pagename|runs| 08:38:59 INFO - PROCESS | 1796 | |0;ai-astar;115;115;112;113;114;114;114;115;115;115 08:38:59 INFO - PROCESS | 1796 | |1;audio-beat-detection;138;111;110;142;109;112;110;109;130;108 08:38:59 INFO - PROCESS | 1796 | |2;audio-dft;185;182;187;185;185;182;185;192;262;213 08:38:59 INFO - PROCESS | 1796 | |3;audio-fft;82;61;59;89;60;57;59;57;74;58 08:38:59 INFO - PROCESS | 1796 | |4;audio-oscillator;88;71;85;69;68;69;82;66;69;83 08:38:59 INFO - PROCESS | 1796 | |5;imaging-gaussian-blur;89;87;89;86;89;85;88;87;89;84 08:38:59 INFO - PROCESS | 1796 | |6;imaging-darkroom;99;94;95;95;94;94;95;94;93;97 08:38:59 INFO - PROCESS | 1796 | |7;imaging-desaturate;85;85;84;85;86;85;85;85;88;99 08:38:59 INFO - PROCESS | 1796 | |8;json-parse-financial;54;52;75;84;83;86;57;57;59;59 08:38:59 INFO - PROCESS | 1796 | |9;json-stringify-tinderbox;63;67;79;75;73;68;68;68;68;69 08:38:59 INFO - PROCESS | 1796 | |10;stanford-crypto-aes;86;83;81;77;83;82;85;84;81;82 08:38:59 INFO - PROCESS | 1796 | |11;stanford-crypto-ccm;139;138;137;137;140;133;145;138;239;173 08:38:59 INFO - PROCESS | 1796 | |12;stanford-crypto-pbkdf2;170;170;164;168;167;166;168;164;166;168 08:38:59 INFO - PROCESS | 1796 | |13;stanford-crypto-sha256-iterative;66;65;66;66;67;66;65;67;64;65 08:38:59 INFO - PROCESS | 1796 | __end_tp_report 08:38:59 INFO - PROCESS | 1796 | __start_cc_report 08:38:59 INFO - PROCESS | 1796 | _x_x_mozilla_cycle_collect,2023 08:38:59 INFO - PROCESS | 1796 | __end_cc_report 08:38:59 INFO - PROCESS | 1796 | __startTimestamp1487435939504__endTimestamp 08:38:59 INFO - PROCESS | 1796 | 08:38:59 INFO - PROCESS | 1796 | ------- Summary: start ------- 08:38:59 INFO - PROCESS | 1796 | Number of tests: 14 08:38:59 INFO - PROCESS | 1796 | 08:38:59 INFO - PROCESS | 1796 | [#0] ai-astar Cycles:10 Average:114.20 Median:115.00 stddev:1.03 (0.9%) stddev-sans-first:1.05 08:38:59 INFO - PROCESS | 1796 | Values: 115.0 115.0 112.0 113.0 114.0 114.0 114.0 115.0 115.0 115.0 08:38:59 INFO - PROCESS | 1796 | 08:38:59 INFO - PROCESS | 1796 | [#1] audio-beat-detection Cycles:10 Average:117.90 Median:111.50 stddev:13.31 (11.9%) stddev-sans-first:11.97 08:38:59 INFO - PROCESS | 1796 | Values: 138.0 111.0 110.0 142.0 109.0 112.0 110.0 109.0 130.0 108.0 08:38:59 INFO - PROCESS | 1796 | 08:38:59 INFO - PROCESS | 1796 | [#2] audio-dft Cycles:10 Average:195.80 Median:186.00 stddev:24.98 (13.4%) stddev-sans-first:26.19 08:38:59 INFO - PROCESS | 1796 | Values: 185.0 182.0 187.0 185.0 185.0 182.0 185.0 192.0 262.0 213.0 08:38:59 INFO - PROCESS | 1796 | 08:38:59 INFO - PROCESS | 1796 | [#3] audio-fft Cycles:10 Average:65.60 Median:60.50 stddev:11.70 (19.3%) stddev-sans-first:10.80 08:38:59 INFO - PROCESS | 1796 | Values: 82.0 61.0 59.0 89.0 60.0 57.0 59.0 57.0 74.0 58.0 08:38:59 INFO - PROCESS | 1796 | 08:38:59 INFO - PROCESS | 1796 | [#4] audio-oscillator Cycles:10 Average:75.00 Median:76.50 stddev:8.41 (11.0%) stddev-sans-first:7.49 08:38:59 INFO - PROCESS | 1796 | Values: 88.0 71.0 85.0 69.0 68.0 69.0 82.0 66.0 69.0 83.0 08:38:59 INFO - PROCESS | 1796 | 08:38:59 INFO - PROCESS | 1796 | [#5] imaging-gaussian-blur Cycles:10 Average:87.30 Median:88.50 stddev:1.83 (2.1%) stddev-sans-first:1.83 08:38:59 INFO - PROCESS | 1796 | Values: 89.0 87.0 89.0 86.0 89.0 85.0 88.0 87.0 89.0 84.0 08:38:59 INFO - PROCESS | 1796 | 08:38:59 INFO - PROCESS | 1796 | [#6] imaging-darkroom Cycles:10 Average:95.00 Median:95.00 stddev:1.76 (1.9%) stddev-sans-first:1.13 08:38:59 INFO - PROCESS | 1796 | Values: 99.0 94.0 95.0 95.0 94.0 94.0 95.0 94.0 93.0 97.0 08:38:59 INFO - PROCESS | 1796 | 08:38:59 INFO - PROCESS | 1796 | [#7] imaging-desaturate Cycles:10 Average:86.70 Median:85.00 stddev:4.45 (5.2%) stddev-sans-first:4.68 08:38:59 INFO - PROCESS | 1796 | Values: 85.0 85.0 84.0 85.0 86.0 85.0 85.0 85.0 88.0 99.0 08:38:59 INFO - PROCESS | 1796 | 08:38:59 INFO - PROCESS | 1796 | [#8] json-parse-financial Cycles:10 Average:66.60 Median:67.00 stddev:13.70 (20.5%) stddev-sans-first:13.76 08:38:59 INFO - PROCESS | 1796 | Values: 54.0 52.0 75.0 84.0 83.0 86.0 57.0 57.0 59.0 59.0 08:38:59 INFO - PROCESS | 1796 | 08:38:59 INFO - PROCESS | 1796 | [#9] json-stringify-tinderbox Cycles:10 Average:69.80 Median:68.50 stddev:4.59 (6.7%) stddev-sans-first:4.16 08:38:59 INFO - PROCESS | 1796 | Values: 63.0 67.0 79.0 75.0 73.0 68.0 68.0 68.0 68.0 69.0 08:38:59 INFO - PROCESS | 1796 | 08:38:59 INFO - PROCESS | 1796 | [#10] stanford-crypto-aes Cycles:10 Average:82.40 Median:83.00 stddev:2.50 (3.0%) stddev-sans-first:2.29 08:38:59 INFO - PROCESS | 1796 | Values: 86.0 83.0 81.0 77.0 83.0 82.0 85.0 84.0 81.0 82.0 08:38:59 INFO - PROCESS | 1796 | 08:38:59 INFO - PROCESS | 1796 | [#11] stanford-crypto-ccm Cycles:10 Average:151.90 Median:139.50 stddev:32.62 (23.4%) stddev-sans-first:34.26 08:38:59 INFO - PROCESS | 1796 | Values: 139.0 138.0 137.0 137.0 140.0 133.0 145.0 138.0 239.0 173.0 08:38:59 INFO - PROCESS | 1796 | 08:38:59 INFO - PROCESS | 1796 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.10 Median:168.00 stddev:2.13 (1.3%) stddev-sans-first:1.99 08:38:59 INFO - PROCESS | 1796 | Values: 170.0 170.0 164.0 168.0 167.0 166.0 168.0 164.0 166.0 168.0 08:38:59 INFO - PROCESS | 1796 | 08:38:59 INFO - PROCESS | 1796 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.70 Median:66.00 stddev:0.95 (1.4%) stddev-sans-first:1.00 08:38:59 INFO - PROCESS | 1796 | Values: 66.0 65.0 66.0 66.0 67.0 66.0 65.0 67.0 64.0 65.0 08:38:59 INFO - PROCESS | 1796 | -------- Summary: end -------- 08:38:59 INFO - PROCESS | 1796 | 08:39:00 INFO - TEST-INFO | 1796: exit 0 08:39:00 INFO - TEST-OK | kraken | took 59194ms 08:39:00 INFO - SUITE-END | took 1179s 08:39:00 INFO - Completed test suite (00:19:39) 08:39:00 INFO - javascript benchmark 08:39:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3268.313654132632, 3290.736741060715, 3317.9548442240675, 3331.2837739885917, 3367.932641347173, 5685.971570142148, 5737.426257374261, 5743.483086522207, 5767.250257466523, 5774.335951365594, 5699.857503562403, 5748.712564371785, 5768.134779783024, 5768.798092066779, 5786.710664466781, 5208.140656791625, 5264.736763161845, 5266.210068489719, 5273.288106105684, 5327.200919862013, 5170.638055336128, 5176.197689358137, 5341.519263266306, 5342.332208473941, 5360.088784906556, 5193.480651934814, 5196.376434827807, 5203.0114278287, 5217.295665085203, 5289.603279754015, 5216.7913283468615, 5230.979958908015, 5236.319278493809, 5260.631755777116, 5272.947270527322, 5136.203888397305, 5211.530962213419, 5231.581473482112, 5234.685918844882, 5265.578753699695, 5571.387147413781, 5572.804951826666, 5619.887602247933, 5625.128105143709, 5683.318001839764, 6251.0, 6256.87486250277, 6278.560500764948, 6294.433500984887, 6296.307406185316, 6255.499560035232, 6325.715342809584, 6332.05019247112, 6337.112804207414, 6360.363963603602, 4735.668503204743, 5580.469855363734, 5711.171880077449, 5814.97092514539, 5830.38780928005, 6205.906911396332, 6253.53098517613, 6282.842928926813, 6287.371262873676, 6305.873882522324, 6195.907061394083, 6227.844303892439, 6230.626162430269, 6239.688015599202, 6257.09272155544, 6136.7852125175405, 6267.435930766253, 6317.905231421532, 6340.778072767431, 6349.746010159542, 6088.543359248074, 6148.262208535004, 6169.691515424211, 6221.129041934133, 6226.315105338409, 6315.684215789192, 6321.336259692758, 6329.778457753957, 6345.365463453618, 6348.460380867586, 5012.47369026247, 5025.723585202849, 5044.117279476077, 5053.36832895888, 5060.51925067118, 4342.913141737211, 4381.992141807402, 4387.714798538149, 4396.252637051709, 4484.618807401407, 5717.085266357363, 5768.451997060272, 5792.131180322901, 5808.099744539603, 5827.038538641077, 5234.42421333653, 6119.654885716942, 6203.8138855834395, 6234.906476402857, 6303.684815759286, 5672.290963629546, 5718.599698021182, 5736.282964629421, 5767.596268261265, 5799.4780469757925, 5329.360476742738, 5402.864928376822, 5480.7533660985355, 5499.670019798825, 5512.448755124456, 6176.7838125665385, 6249.812505624838, 6254.061890716429, 6284.591501552384, 6348.428641422294, 5369.838904832861, 6250.531210159347, 6305.180326557702, 6307.053941908567, 6307.590006649553, 6310.943253329642, 6345.650989195638, 6352.745890164341, 6358.523110766619, 6368.42684158428, 5332.093544097435, 6055.061465472859, 6135.294441139147, 6148.938510614837, 6262.06069089622, 6055.727492262947, 6295.842603934755, 6297.96851015742, 6304.779332723333, 6310.05349197624, 6049.334573197033, 6155.753769849156, 6170.290416602148, 6188.783392581238, 6189.752409903554, 5983.0, 6027.306859711014, 6114.419130182626, 6172.290186628596, 6197.876042479215, 5908.3796201399955, 6077.817665470043, 6078.72645730952, 6118.755249789959, 6125.418085281891, 6179.1411533197215, 6182.474489668429, 6222.688865556795, 6224.439800417984, 6225.159603453476, 5728.369879313355, 5847.152162936435, 6060.545459090674, 6075.1191077294425, 6094.421030002142], "value": 5712.9938578942865, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [451.386114883758, 469.2937129619921, 484.60746795095974, 492.6206820748024, 499.87003379121415, 32021.839890800544, 40121.197576048464, 42332.153356932846, 42486.7875660622, 44415.33376999348, 43485.0, 43777.0, 43860.78069609647, 43861.0, 43871.56128438715, 8130.308923741489, 8797.0, 9020.368574199809, 9029.322800789967, 9039.0, 8124.431289809716, 10493.685189444328, 10706.678799636024, 10747.62383316584, 10919.617813376533, 10765.03114719675, 10826.512806923707, 10848.511816968215, 10872.130229581615, 10884.510197041152, 10792.136629069695, 10850.18623603225, 10881.23831331807, 10882.129429645609, 10896.78206435867, 8005.399595030396, 8201.753947381589, 10431.530581123867, 10710.143188544898, 10740.0, 41836.1632767346, 42256.0, 42268.36597451041, 42299.36550951738, 42333.78833105846, 3813.4858727682276, 3937.960620393788, 3973.860914867995, 3978.5026871641044, 3995.20095980805, 27501.862490687417, 27506.0, 27513.862430687717, 27665.308367290778, 28097.578536321973, 3044.360684256309, 3323.4682450807995, 3331.1172539277113, 3331.3503866745996, 3337.3992681317354, 441561.0, 489585.0, 493337.0, 494038.0, 494171.9999999964, 57811.710941445024, 58069.41930580725, 58201.0, 58216.0, 58364.0, 59884.70057649684, 59936.40063599395, 60080.39919600835, 60089.798204036546, 60116.0, 15745.763813542806, 16036.877418580822, 16041.037537747772, 16078.67842643164, 16095.356185752438, 11163.218574699693, 12407.813882791765, 12443.502259909683, 12490.313032783284, 12520.561780337644, 15498.30257638409, 15898.60253493672, 17800.020998845186, 18178.818211817976, 18234.0, 6875.243723190445, 7590.696372145163, 7657.23427657241, 7664.195259497673, 7752.341051010727, 859.3125499600295, 878.5870640798814, 881.9142727449536, 895.5925054100499, 913.1051569461964, 30692.0, 30709.38581228363, 30750.84624576863, 30975.845120774702, 31499.685003150134, 1059.2003037706481, 1069.3102948598112, 1083.5124194112523, 1094.2285688589525, 1204.9396531052794, 15549.222538873237, 15568.0, 16072.839271607134, 16157.596060098356, 16481.83518164803, 643335.0, 649928.0, 650102.0, 651019.0, 651378.0, 55557.0, 56254.43745562492, 56304.155437668465, 56343.71828140833, 56389.43610563924, 1406.9718605628034, 1418.7871819227198, 1449.1232804153547, 1456.3519233941006, 1457.8031965684497, 29048.9832855849, 29252.853735731183, 29279.560806588343, 30004.399912002074, 30054.549181761853, 49496.0, 50289.24566131584, 50318.99362012666, 50364.74817626035, 50417.0, 575418.1229093996, 577172.0, 578670.0, 579273.0, 579713.0, 26182.86908565445, 26401.867990659925, 26635.467290654466, 26645.866770666024, 26676.19971400861, 43373.78313108414, 43472.34791478067, 44837.551624484644, 45701.0, 45912.62262132141, 35136.12159696028, 35862.0, 36744.278805404385, 37622.43566346452, 37704.245915082094, 35751.88853281802, 36041.63958360383, 36168.638313616524, 37517.81241093777, 37683.43474847825, 34304.0, 34916.82541587276, 35156.29687406187, 35407.82296088503, 35831.82084089563, 30005.399892001602, 32549.0, 32750.50874236936, 32817.83591082029, 32854.83572582217, 24225.273241802774, 24302.756972430758, 24356.75643243545, 24516.6322505159, 24555.263342099766], "value": 19846.533632827985, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [363.8726445743988, 381.2584523102565, 387.2023631319482, 399.73817149766916, 419.6831392298816, 13591.864081359183, 13917.095388799733, 15223.847761522395, 17942.641147177048, 18654.0, 17376.304947802073, 18002.459926202202, 18256.81743182568, 18459.81540184601, 18663.066846657646, 5520.751566179511, 5790.7683692652245, 5801.767929282823, 5806.10005449154, 5807.477327040587, 5427.0773968425465, 5557.5553955683445, 5603.495685388314, 5617.4382561743905, 5622.212890195376, 5168.974155129238, 5214.06146893559, 5497.5601951843755, 5593.8601534961745, 5604.1593760935775, 5423.484768946963, 5576.693281869496, 5677.829665110054, 5700.572457065695, 5782.624129431573, 5541.833744987657, 5541.972290138524, 5631.746571404296, 5640.0, 5659.264295641581, 12209.962153216988, 12572.559960401433, 12579.245245285312, 12592.244465332109, 12598.055145864006, 2585.340738111788, 2585.831920925134, 2601.7008044074983, 2650.6554147960833, 2651.164883061829, 9755.170810481117, 10108.848367274497, 10132.898671013269, 10165.796684066352, 10574.471276436147, 1756.6311074674334, 1789.4363275568155, 1800.7945856375673, 1836.2563161919445, 1865.4310435317223, 97810.0, 130397.6960230395, 132890.0, 136331.0, 139593.0, 11502.482388292547, 11673.0, 11882.287062776088, 12035.939820300842, 12253.816192757116, 15683.215839208222, 16269.51191464258, 16269.755953660704, 16289.918550407172, 16312.51062468128, 8740.344474164463, 8966.730998070068, 9034.593443295067, 9082.954585227031, 9171.312151588658, 7704.0, 8079.0, 8412.0, 8675.696350627697, 8857.867131993025, 4769.373421717196, 4855.927161092586, 4863.95136048635, 4899.265110233494, 4914.557689807934, 1982.7521559805025, 2021.3632705697657, 2026.71625972364, 2030.2287377729292, 2030.8375329973862, 965.6620182935916, 968.6125549780145, 996.1731762636994, 1001.3891526169031, 1006.2201793609864, 21645.783542164692, 21850.672239916414, 22002.669959950614, 22065.0, 22210.222642207445, 1016.4866742295242, 1036.3315661398356, 1043.8642976413018, 1048.1509976918721, 1061.8035663402295, 10926.726831829108, 11426.08591312693, 11435.771284574263, 11476.713082172846, 11496.367699776592, 726976.0, 727577.362113186, 749916.0, 751737.0, 774731.0, 128169.0, 155849.0, 159919.0, 162133.0, 170727.29272707115, 1010.7877345757473, 1027.6454623155, 1069.4064794039227, 1074.521837782195, 1076.364944682641, 19792.0, 19953.600927981068, 20305.78165310086, 20336.79663203349, 20397.694034589196, 60032.099518508134, 60407.0, 60814.0, 61151.0, 61241.0, 68871.0, 69299.65350173217, 88102.0, 88958.0, 88966.0, 8289.295409890226, 8336.166383361615, 8445.366597505088, 8506.106858779738, 8569.871451928102, 7684.500507466997, 11035.72410689707, 12636.747265054832, 12819.487220511075, 13029.739405212033, 5670.432956704297, 8603.881495405807, 8644.567771611268, 10279.640212592523, 11077.501512432122, 11111.44442777874, 11353.54585816558, 11497.597584084851, 11601.216883007104, 11602.18784685064, 11483.425828708698, 11834.82247766267, 11871.228370155912, 11962.162648614514, 11970.58102966392, 8151.30713889326, 8301.584920753818, 8369.455985360932, 8674.522901240493, 8681.826363472821, 8488.830223395375, 9990.800183996425, 10980.615678451215, 11473.196876218584, 11487.36819474937], "value": 9577.219974146792, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1411.0, 1441.2937660546336, 1447.5946734914226, 1455.8325792533863, 1458.0959804920947, 8158.796030099251, 8413.78965525862, 8563.35774816888, 8575.828483430336, 8601.741947741577, 6695.899561506581, 7424.109106907165, 7696.0, 7709.845803083935, 8247.91752082479, 2297.448612333045, 2339.532093581282, 2343.6484527320868, 2344.1443872986324, 2352.200251914349, 2323.6398358254496, 2359.539889721505, 2366.597678394677, 2367.6093444581625, 2373.6320870265135, 1895.2703209264464, 2021.231931865889, 2104.3160972683863, 2319.489712263299, 2355.1521452277166, 2322.593546129429, 2337.754535773753, 2338.3452633262546, 2338.5556744218543, 2340.461693810433, 2274.9886250568807, 2311.0640190722784, 2358.516504116652, 2362.5393048355577, 2364.550735360276, 8433.915660843375, 8533.445326053848, 8553.315734741269, 8554.572271386469, 8567.400281980264, 4979.0, 5138.152204886189, 5140.537351638371, 5155.381354237478, 5161.3806343238675, 3034.7723920706035, 3304.6364899860996, 3457.0320310313155, 3467.3932061889323, 3508.14050557615, 1169.7309618787726, 1210.3887536793864, 1213.1932265043824, 1270.5134992059313, 1271.5041133957764, 10832.458377081115, 10900.96440838119, 10978.725531861688, 10983.780324393467, 11010.284331518505, 4510.323451482304, 4684.0, 4766.046790641816, 4779.952200477951, 4782.641301902371, 9380.343375963617, 9593.760155996017, 9596.376235544667, 9613.51932403377, 9618.711438656852, 5302.416734159239, 5308.469153084738, 5314.12316967696, 5331.600129990189, 5362.731863406814, 4067.6949228807957, 4183.640316897021, 4283.271843786564, 4820.373351464287, 4852.223644216909, 3843.2121415110396, 3883.0, 3985.601439855991, 3994.72036957416, 4007.6192761687594, 1284.6724085358173, 1303.3418123847396, 1313.441787240419, 1321.5704895908868, 1329.0497294434526, 767.8195624028349, 819.6516480495766, 897.2328658996595, 898.1826537850656, 915.912988266127, 5204.609654275944, 5590.468905453975, 5722.227499287543, 5775.451332123442, 5978.432048955342, 825.3149885594942, 972.2416515118219, 1005.994005994006, 1009.5204777730667, 1039.3763741755038, 3245.6105267368066, 3683.4843121962945, 3687.5943646199435, 3730.9067273318383, 3848.8845334640005, 9765.755856103513, 10122.291439599305, 10129.544170512345, 10161.0, 10178.491075446198, 9895.406275623342, 9966.900330996597, 9972.0, 10005.099541041196, 10112.544935477774, 7403.370713489306, 7691.423143264277, 7699.422543309274, 7777.611119444005, 7781.221877812287, 5473.616846820843, 5659.236003139524, 5734.111212762028, 5746.942530574641, 5819.5635327351465, 7258.782236532912, 8890.24432923183, 9056.0, 9192.678256260999, 9253.76865578339, 9228.307876909394, 9328.813423731352, 9497.477638729937, 9537.475438850652, 9552.713418597454, 6420.935790642034, 6865.5537390069485, 7096.858062838817, 7243.45674074436, 7262.818429539304, 7855.921440785519, 7915.920840791749, 7995.720149794729, 7997.680092796456, 8022.0, 6994.160700715743, 7063.646817659199, 7075.929240707527, 7124.501284910007, 7215.350618444155, 7024.402925751164, 7027.4378049756915, 7034.120734908137, 7109.502334836512, 7153.070100886852, 6157.168782214344, 6306.148669929501, 6402.295747467868, 6449.322821103717, 6474.449671777763, 4494.348319493721, 4550.203714350042, 4573.108243892409, 4579.633629309581, 4684.718916864999, 4984.675996060245, 4985.626078044089, 5044.4198917125, 5080.669756465818, 5099.0821652101495], "value": 4413.073869747062, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [354.028192611282, 355.4401817138008, 363.3985753577829, 375.34876988425094, 375.72572022423645, 4330.501992270886, 4994.650374473788, 5171.663841850277, 5326.067938110835, 5350.464953504647, 4250.9149817003645, 4989.476105008976, 5087.847364579059, 5115.411727651322, 5244.68531888087, 3358.5465962095172, 3567.732420068492, 3896.376579747241, 4135.0, 4151.916961660765, 3597.622249663787, 3985.641292283694, 4142.440770495975, 4152.875413737577, 4181.0, 3455.619881813011, 4053.1691003344245, 4063.8374465021366, 4065.7560546367163, 4091.590840915914, 3909.198614284065, 4045.4336392905016, 4056.7565946043333, 4062.329715596923, 4065.471488706479, 3597.80212088335, 3615.511905892697, 3619.0, 3622.5652921649307, 3655.7623754455876, 4743.857684269477, 5035.471275516092, 5040.639027462565, 5111.875387414762, 5232.953409318114, 4406.832189469793, 4505.873531617096, 4714.858554243378, 4744.857654270378, 4793.0, 4422.690411671184, 4727.479977202505, 5139.331886854722, 5543.861403464905, 5555.916661250085, 3875.1862108957152, 3905.453236546886, 3951.5455722591983, 3988.1824226033596, 4014.093305679808, 4768.47546769855, 5183.766730497136, 5446.101393270105, 5653.4911857932575, 5819.88360232793, 3521.7710848794745, 3941.9605803941595, 4037.0, 4071.1043570414463, 4078.5921407858978, 3461.480777883338, 3551.7213803030886, 3748.231612519427, 3749.5875453700073, 4122.670186385082, 4653.930191047137, 4677.567664814277, 4682.74244916526, 4728.858134255978, 4746.620270378361, 5388.892222155535, 5615.978247830778, 5634.85912852182, 5639.548836093103, 5668.8866222675315, 1181.7990941539958, 1244.3840299052026, 1306.399056434032, 1337.3714354253486, 1348.9392977315847, 884.8363052835246, 924.4915296586851, 953.6423841059602, 966.6036924860773, 971.2958105373689, 4597.103564804898, 4654.25531914892, 4873.926891096637, 4925.088858561106, 4966.875828104254, 4387.451568553931, 4944.554990050912, 5005.314992160942, 5019.278023053722, 5386.0, 4485.349624304457, 4702.741349225757, 4843.2735089736825, 4870.196417591058, 4883.438404583448, 2638.103044964683, 2648.576227803542, 2655.8672066396603, 2833.6032955386263, 2849.6891429942043, 5039.44566097729, 5354.929014197176, 5569.0, 5569.777208911679, 5584.022796010763, 4931.950680493149, 5874.324452687995, 5880.235569375954, 5894.8821023579285, 5900.0, 5528.944710552843, 5741.684207368635, 5928.28860536747, 5935.82192534216, 5990.4908082813445, 4803.615710743202, 5623.971880140573, 5627.874425114912, 5704.974733969547, 5745.540356771532, 4631.614718419949, 5630.73308505583, 5699.5725320600295, 5699.886002279848, 5732.971335143297, 4935.284383764262, 5648.802291919763, 5707.203470299606, 5919.460940155676, 5964.731587078505, 3317.5568627646085, 3330.052903180751, 3853.6531712146043, 3881.262560113569, 3901.9464744518255, 5096.974515127401, 5710.828675139753, 5750.166225897305, 5764.106563482667, 5789.989205613142, 4711.316859055486, 5373.570114390917, 5492.835214943558, 5574.108142697149, 5664.631798933056, 4853.757312134449, 4965.602751779921, 5436.7281635918835, 5552.750126244409, 5555.30558680165, 5302.8713059295205, 5335.466453354634, 5416.918746218731, 5460.645058071213, 5461.4980880258245, 5318.840434786963, 5526.861828454321, 5579.804706835242, 5590.183190463197, 5594.9720251398485, 5287.444818294024, 5409.567234621142, 5464.699441530754, 5465.59008074388, 5468.675812779632], "value": 4062.8254388337273, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [690.3338278561188, 701.3302296307024, 759.6505607420586, 813.3249402995514, 820.2699597358352, 12536.435860386282, 13342.332883355843, 13348.7330253395, 13359.19844809311, 13415.26216058119, 12324.0, 12548.874511254884, 12644.810327845089, 12675.61973140805, 12716.491340346374, 672.7914346552584, 696.0776970514089, 696.8188271049538, 828.6561077152975, 846.5640195299426, 853.7353420439653, 855.2687452228348, 868.2142660891903, 869.0527325215514, 870.5168631409565, 921.005314260597, 921.764949937765, 922.8385032619299, 924.5839372282467, 927.9721608351726, 711.8505113926082, 732.9706811727525, 916.1388295002677, 918.0223062438548, 918.1323649151522, 658.0359772932629, 676.0163961436099, 682.3415404135034, 683.5761827666829, 683.9692213850388, 12561.309127997956, 12584.68538286541, 12637.115401921868, 12655.746885062246, 12670.113092083559, 12120.757584848341, 12139.514419423213, 12262.386880655931, 12370.0, 12485.56300529477, 12343.13598048137, 12366.072544559194, 12401.44193511285, 12404.13171078025, 12565.560205392767, 4286.121345124273, 4341.956580434186, 4390.078083602447, 4402.163588918095, 4459.974205932654, 95198.52400737951, 96518.55222171673, 97015.0, 101619.0, 104095.0, 9383.436993780395, 9460.52697365129, 9572.90427095734, 9636.614535418645, 9717.416954982724, 20993.265235716677, 21131.366059018255, 21291.78708212898, 21392.465188370414, 21444.678329825067, 6695.899561506581, 6713.865722685617, 6718.563293385914, 6742.528023038439, 6811.761588344384, 3227.1286752577143, 3273.541704161419, 3290.4899740540254, 3292.3250733599552, 3357.1774915145456, 3386.2211691311136, 3421.8289085545625, 3436.226848959014, 3475.6176820549717, 3479.321532301177, 613.3069631316673, 618.0790621973227, 620.9379062093844, 632.301307055706, 633.5596760251673, 577.3043482603453, 603.9430995757424, 620.7516993202755, 643.2506130358174, 657.5922927784804, 8923.821523569492, 9056.13966673165, 9255.472846980307, 9616.711498655051, 9695.321327507148, 599.6791716431688, 667.2660073918651, 668.7826456401592, 671.7111641993989, 674.2010717300016, 4577.633789296849, 4653.278741795028, 4688.648351373592, 4699.0, 4715.7642117893965, 104827.0, 105472.0, 107574.0, 109242.0, 111940.44029779799, 88039.0, 88985.0, 91536.54231728798, 93317.0, 95227.0, 69495.3050469509, 70461.2953870465, 80927.0, 83248.58375708082, 83378.58310708408, 10146.594136234467, 10747.086497647788, 10787.083097936764, 10945.807085734545, 11026.173037022416, 49798.75100624474, 50053.0, 52229.10324346002, 52919.0, 53878.0, 66111.0, 66314.66842665756, 69599.65200173967, 70599.0, 70603.0, 12528.749425011267, 12589.0, 12831.679208019874, 12839.807402889151, 12938.478076715366, 13996.300184990507, 14118.47996250726, 14282.928585357007, 14569.490067847575, 14789.260536972894, 12805.615831525069, 12977.156484828834, 13822.861771382157, 14069.085509441853, 14097.224652644203, 11652.359120248468, 12735.74528509406, 12901.741965160832, 13470.393832277376, 13521.0, 12485.812712809497, 13091.869081309065, 13115.934420327838, 13148.474061037834, 13724.039317247696, 10575.894241057798, 11311.0, 11385.259958102697, 11490.942545287555, 11565.826512602485, 7718.575478348745, 10159.644412445528, 10558.894411056099, 10910.72723181895, 10970.341779493256], "value": 7228.883815772384, "unit": "score"}], "name": "dromaeo_css", "value": 7212.39166551273, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 115.0, 112.0, 113.0, 114.0, 114.0, 114.0, 115.0, 115.0, 115.0], "value": 114.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 111.0, 110.0, 142.0, 109.0, 112.0, 110.0, 109.0, 130.0, 108.0], "value": 117.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 182.0, 187.0, 185.0, 185.0, 182.0, 185.0, 192.0, 262.0, 213.0], "value": 195.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 61.0, 59.0, 89.0, 60.0, 57.0, 59.0, 57.0, 74.0, 58.0], "value": 65.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 71.0, 85.0, 69.0, 68.0, 69.0, 82.0, 66.0, 69.0, 83.0], "value": 75.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 87.0, 89.0, 86.0, 89.0, 85.0, 88.0, 87.0, 89.0, 84.0], "value": 87.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 94.0, 95.0, 95.0, 94.0, 94.0, 95.0, 94.0, 93.0, 97.0], "value": 95.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 84.0, 85.0, 86.0, 85.0, 85.0, 85.0, 88.0, 99.0], "value": 86.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 52.0, 75.0, 84.0, 83.0, 86.0, 57.0, 57.0, 59.0, 59.0], "value": 66.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 67.0, 79.0, 75.0, 73.0, 68.0, 68.0, 68.0, 68.0, 69.0], "value": 69.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 83.0, 81.0, 77.0, 83.0, 82.0, 85.0, 84.0, 81.0, 82.0], "value": 82.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 138.0, 137.0, 137.0, 140.0, 133.0, 145.0, 138.0, 239.0, 173.0], "value": 151.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 170.0, 164.0, 168.0, 167.0, 166.0, 168.0, 164.0, 166.0, 168.0], "value": 167.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 66.0, 66.0, 67.0, 66.0, 65.0, 67.0, 64.0, 65.0], "value": 65.7, "unit": "score"}], "name": "kraken", "value": 1441.0, "alertThreshold": 2.0}]} 08:39:00 INFO - Return code: 0 08:39:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:39:00 ERROR - # TBPL SUCCESS # 08:39:00 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:39:00 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:39:00 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:39:00 INFO - 2017-02-18 08:39:00.829 screenresolution[1805:10172] starting screenresolution argv=screenresolution get 08:39:00 INFO - 2017-02-18 08:39:00.831 screenresolution[1805:10172] Display 0: 1600x1200x32@60 08:39:00 INFO - 2017-02-18 08:39:00.838 screenresolution[1806:10175] starting screenresolution argv=screenresolution list 08:39:00 INFO - Available Modes on Display 0 08:39:00 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:39:00 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:39:00 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:39:00 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:39:01 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:39:01 INFO - Intel Iris: 08:39:01 INFO - Chipset Model: Intel Iris 08:39:01 INFO - Type: GPU 08:39:01 INFO - Bus: Built-In 08:39:01 INFO - VRAM (Dynamic, Max): 1536 MB 08:39:01 INFO - Vendor: Intel (0x8086) 08:39:01 INFO - Device ID: 0x0a2e 08:39:01 INFO - Revision ID: 0x0009 08:39:01 INFO - Displays: 08:39:01 INFO - Display: 08:39:01 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:39:01 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:39:01 INFO - Display Serial Number: 1600x1200 60 08:39:01 INFO - Main Display: Yes 08:39:01 INFO - Mirror: Off 08:39:01 INFO - Online: Yes 08:39:01 INFO - Rotation: Supported 08:39:01 INFO - Return code: 0 08:39:01 INFO - Running post-action listener: _resource_record_post_action 08:39:01 INFO - [mozharness: 2017-02-18 16:39:01.072844Z] Finished run-tests step (success) 08:39:01 INFO - Running post-run listener: _resource_record_post_run 08:39:01 INFO - Total resource usage - Wall time: 1200s; CPU: 54.0%; Read bytes: 32480256; Write bytes: 513101824; Read time: 190; Write time: 1679 08:39:01 INFO - TinderboxPrint: CPU usage
53.7% 08:39:01 INFO - TinderboxPrint: I/O read bytes / time
32,480,256 / 190 08:39:01 INFO - TinderboxPrint: I/O write bytes / time
513,101,824 / 1,679 08:39:01 INFO - TinderboxPrint: CPU idle
2,225.0 (46.3%) 08:39:01 INFO - TinderboxPrint: CPU system
962.4 (20.0%) 08:39:01 INFO - TinderboxPrint: CPU user
1,614.1 (33.6%) 08:39:01 INFO - TinderboxPrint: Swap in / out
236,060,672 / 0 08:39:01 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 205605376; Write bytes: 200345600; Read time: 15714; Write time: 448 08:39:01 INFO - run-tests - Wall time: 1181s; CPU: 54.0%; Read bytes: 28994560; Write bytes: 301660160; Read time: 168; Write time: 1194 08:39:01 INFO - Running post-run listener: _upload_blobber_files 08:39:01 INFO - Blob upload gear active. 08:39:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:39:01 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 08:39:01 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-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:39:01 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-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:39:01 INFO - (blobuploader) - INFO - Open directory for files ... 08:39:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:39:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:39:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:39:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:39:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:39:03 INFO - (blobuploader) - INFO - Done attempting. 08:39:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:39:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:39:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:39:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:39:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:39:04 INFO - (blobuploader) - INFO - Done attempting. 08:39:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 08:39:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:39:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:39:05 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 08:39:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:39:05 INFO - (blobuploader) - INFO - Done attempting. 08:39:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:39:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:39:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:39:07 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:39:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:39:07 INFO - (blobuploader) - INFO - Done attempting. 08:39:07 INFO - (blobuploader) - INFO - Iteration through files over. 08:39:07 INFO - Return code: 0 08:39:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:39:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:39:07 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2bc2b7343a80752c1e15810dfcff591065957a0a320b5667b1901ada7463e8173d975bb4a692e84b81e7d55644981116b4f8113a4390dbccd1a1fe38c7e055ec", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/22fbc24cfeae56c850d642b72142e16ad2569584c3b5e442d0c9962cce00a169f9fe7d26880bc04214d70735870251a631899595aebd4cff4251e76f54400106", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b7557b3560bf7823411fc453e3e61512a162e9e5153ab5b1abf8033ed070bb44091cae13a23a4f5c9fe3bfb1c1ab88909ad5bd442175eb88315bf280e2457459", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e4310854d697b35e60eb59af6460fc0fbcab89d1ca13635c648767633a1bb709b1d69756361022e51a3359b269a625f15b8d8eb1fbeb18f7b43f8c47806e8e0f"} 08:39:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:39:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:39:07 INFO - Contents: 08:39:07 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2bc2b7343a80752c1e15810dfcff591065957a0a320b5667b1901ada7463e8173d975bb4a692e84b81e7d55644981116b4f8113a4390dbccd1a1fe38c7e055ec", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/22fbc24cfeae56c850d642b72142e16ad2569584c3b5e442d0c9962cce00a169f9fe7d26880bc04214d70735870251a631899595aebd4cff4251e76f54400106", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b7557b3560bf7823411fc453e3e61512a162e9e5153ab5b1abf8033ed070bb44091cae13a23a4f5c9fe3bfb1c1ab88909ad5bd442175eb88315bf280e2457459", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e4310854d697b35e60eb59af6460fc0fbcab89d1ca13635c648767633a1bb709b1d69756361022e51a3359b269a625f15b8d8eb1fbeb18f7b43f8c47806e8e0f"} 08:39:07 INFO - Running post-run listener: copy_logs_to_upload_dir 08:39:07 INFO - Copying logs to upload dir... 08:39:07 INFO - mkdir: /builds/slave/test/build/upload/logs 08:39:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.465948 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-02-18 08:39:07.518280) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-18 08:39:07.521769) ========= 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.cjrzqC2rki/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.fmduFg0KA9/Listeners TMPDIR=/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/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-Aurora/sha512/2bc2b7343a80752c1e15810dfcff591065957a0a320b5667b1901ada7463e8173d975bb4a692e84b81e7d55644981116b4f8113a4390dbccd1a1fe38c7e055ec", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/22fbc24cfeae56c850d642b72142e16ad2569584c3b5e442d0c9962cce00a169f9fe7d26880bc04214d70735870251a631899595aebd4cff4251e76f54400106", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b7557b3560bf7823411fc453e3e61512a162e9e5153ab5b1abf8033ed070bb44091cae13a23a4f5c9fe3bfb1c1ab88909ad5bd442175eb88315bf280e2457459", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e4310854d697b35e60eb59af6460fc0fbcab89d1ca13635c648767633a1bb709b1d69756361022e51a3359b269a625f15b8d8eb1fbeb18f7b43f8c47806e8e0f"} build_url:https://queue.taskcluster.net/v1/task/DvIpX7R7SdyPGnPVQZCNMg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011119 build_url: 'https://queue.taskcluster.net/v1/task/DvIpX7R7SdyPGnPVQZCNMg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2bc2b7343a80752c1e15810dfcff591065957a0a320b5667b1901ada7463e8173d975bb4a692e84b81e7d55644981116b4f8113a4390dbccd1a1fe38c7e055ec", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/22fbc24cfeae56c850d642b72142e16ad2569584c3b5e442d0c9962cce00a169f9fe7d26880bc04214d70735870251a631899595aebd4cff4251e76f54400106", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b7557b3560bf7823411fc453e3e61512a162e9e5153ab5b1abf8033ed070bb44091cae13a23a4f5c9fe3bfb1c1ab88909ad5bd442175eb88315bf280e2457459", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e4310854d697b35e60eb59af6460fc0fbcab89d1ca13635c648767633a1bb709b1d69756361022e51a3359b269a625f15b8d8eb1fbeb18f7b43f8c47806e8e0f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-18 08:39:07.556529) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-18 08:39:07.556869) ========= 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.cjrzqC2rki/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.fmduFg0KA9/Listeners TMPDIR=/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/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.005094 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-18 08:39:07.606561) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-18 08:39:07.606888) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-18 08:39:07.607244) ========= ========= Total master_lag: 0.30 =========