builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0140 starttime: 1474797643.1 results: success (0) buildid: 20160925004010 builduid: eedd3bf1102b479e82080aaa7d0b1a54 revision: 1fee8de1111fdcc6fb5d95d4afef92c913fc87f2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-25 03:00:43.098745) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-25 03:00:43.099543) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-25 03:00:43.099976) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-25 03:00:43.560565) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-25 03:00:43.560910) ========= 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.LniWFnULpJ/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.VHfub8XtRl/Listeners TMPDIR=/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/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 --2016-09-25 03:00:43-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 8.25M=0.001s 2016-09-25 03:00:43 (8.25 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.173704 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-25 03:00:43.759769) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-25 03:00:43.760043) ========= 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.LniWFnULpJ/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.VHfub8XtRl/Listeners TMPDIR=/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/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.020491 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-25 03:00:43.810744) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-25 03:00:43.811595) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 1fee8de1111fdcc6fb5d95d4afef92c913fc87f2 --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 1fee8de1111fdcc6fb5d95d4afef92c913fc87f2 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.LniWFnULpJ/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.VHfub8XtRl/Listeners TMPDIR=/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/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 2016-09-25 03:00:43,890 truncating revision to first 12 chars 2016-09-25 03:00:43,890 Setting DEBUG logging. 2016-09-25 03:00:43,890 attempt 1/10 2016-09-25 03:00:43,890 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/1fee8de1111f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-25 03:00:45,456 unpacking tar archive at: mozilla-aurora-1fee8de1111f/testing/mozharness/ program finished with exit code 0 elapsedTime=1.841912 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-25 03:00:45.681815) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-25 03:00:45.682551) ========= script_repo_revision: 1fee8de1111fdcc6fb5d95d4afef92c913fc87f2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-25 03:00:45.683539) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-25 03:00:45.684557) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-25 03:00:45.705090) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-09-25 03:00:45.705762) ========= /tools/buildbot/bin/python 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', '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.LniWFnULpJ/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.VHfub8XtRl/Listeners TMPDIR=/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/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 03:00:45 INFO - MultiFileLogger online at 20160925 03:00:45 in /builds/slave/test 03:00:45 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 03:00:45 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:00:45 INFO - {'append_to_log': False, 03:00:45 INFO - 'base_work_dir': '/builds/slave/test', 03:00:45 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:00:45 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:00:45 INFO - 'branch': 'Mozilla-Aurora', 03:00:45 INFO - 'buildbot_json_path': 'buildprops.json', 03:00:45 INFO - 'config_files': ('talos/mac_config.py',), 03:00:45 INFO - 'default_actions': ('clobber', 03:00:45 INFO - 'read-buildbot-config', 03:00:45 INFO - 'download-and-extract', 03:00:45 INFO - 'populate-webroot', 03:00:45 INFO - 'create-virtualenv', 03:00:45 INFO - 'install', 03:00:45 INFO - 'run-tests'), 03:00:45 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:00:45 INFO - 'download_minidump_stackwalk': True, 03:00:45 INFO - 'download_symbols': 'ondemand', 03:00:45 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:00:45 INFO - 'tooltool.py': '/tools/tooltool.py', 03:00:45 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:00:45 INFO - '/tools/misc-python/virtualenv.py')}, 03:00:45 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:00:45 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:00:45 INFO - 'installer_path': 'installer.exe', 03:00:45 INFO - 'log_level': 'info', 03:00:45 INFO - 'log_name': 'talos', 03:00:45 INFO - 'log_to_console': True, 03:00:45 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 03:00:45 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 03:00:45 INFO - 'opt_config_files': (), 03:00:45 INFO - 'pip_index': False, 03:00:45 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:00:45 INFO - 'cmd': ('bash', 03:00:45 INFO - '-c', 03:00:45 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:00:45 INFO - 'enabled': True, 03:00:45 INFO - 'halt_on_failure': False, 03:00:45 INFO - 'name': 'check_screen_resolution'},), 03:00:45 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:00:45 INFO - 'cmd': ('bash', 03:00:45 INFO - '-c', 03:00:45 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:00:45 INFO - 'enabled': True, 03:00:45 INFO - 'halt_on_failure': False, 03:00:45 INFO - 'name': 'check_screen_resolution'},), 03:00:45 INFO - 'run_cmd_checks_enabled': True, 03:00:45 INFO - 'sps_profile': False, 03:00:45 INFO - 'sps_profile_interval': 0, 03:00:45 INFO - 'suite': 'dromaeojs', 03:00:45 INFO - 'system_bits': '32', 03:00:45 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:00:45 INFO - 'title': 't-yosemite-r7-0140', 03:00:45 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:00:45 INFO - 'use_talos_json': True, 03:00:45 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:00:45 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:00:45 INFO - 'work_dir': 'build'} 03:00:45 INFO - [mozharness: 2016-09-25 10:00:45.915239Z] Running clobber step. 03:00:45 INFO - Running pre-action listener: _resource_record_pre_action 03:00:45 INFO - Running main action method: clobber 03:00:45 INFO - rmtree: /builds/slave/test/build 03:00:45 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:00:46 INFO - Running post-action listener: _resource_record_post_action 03:00:46 INFO - [mozharness: 2016-09-25 10:00:46.868494Z] Finished clobber step (success) 03:00:46 INFO - [mozharness: 2016-09-25 10:00:46.868681Z] Running read-buildbot-config step. 03:00:46 INFO - Running pre-action listener: _resource_record_pre_action 03:00:46 INFO - Running main action method: read_buildbot_config 03:00:46 INFO - Using buildbot properties: 03:00:46 INFO - { 03:00:46 INFO - "project": "", 03:00:46 INFO - "product": "firefox", 03:00:46 INFO - "script_repo_revision": "production", 03:00:46 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 03:00:46 INFO - "repository": "", 03:00:46 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 03:00:46 INFO - "buildid": "20160925004010", 03:00:46 INFO - "stage_platform": "macosx64", 03:00:46 INFO - "basedir": "/builds/slave/test", 03:00:46 INFO - "nightly_build": "True", 03:00:46 INFO - "buildnumber": 24, 03:00:46 INFO - "slavename": "t-yosemite-r7-0140", 03:00:46 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 03:00:46 INFO - "platform": "yosemite_r7", 03:00:46 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 03:00:46 INFO - "branch": "mozilla-aurora", 03:00:46 INFO - "repo_path": "releases/mozilla-aurora", 03:00:46 INFO - "revision": "1fee8de1111fdcc6fb5d95d4afef92c913fc87f2", 03:00:46 INFO - "pgo_build": "False", 03:00:46 INFO - "builduid": "eedd3bf1102b479e82080aaa7d0b1a54", 03:00:46 INFO - "slavebuilddir": "test" 03:00:46 INFO - } 03:00:46 INFO - Found installer url https://queue.taskcluster.net/v1/task/L6HWAN9KSrOpvyenBdtk7Q/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 03:00:46 INFO - Running post-action listener: _resource_record_post_action 03:00:46 INFO - [mozharness: 2016-09-25 10:00:46.873300Z] Finished read-buildbot-config step (success) 03:00:46 INFO - [mozharness: 2016-09-25 10:00:46.873479Z] Running download-and-extract step. 03:00:46 INFO - Running pre-action listener: _resource_record_pre_action 03:00:46 INFO - Running main action method: download_and_extract 03:00:46 INFO - mkdir: /builds/slave/test/build/tests 03:00:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:00:46 INFO - trying https://queue.taskcluster.net/v1/task/L6HWAN9KSrOpvyenBdtk7Q/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 03:00:46 INFO - Downloading https://queue.taskcluster.net/v1/task/L6HWAN9KSrOpvyenBdtk7Q/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 03:00:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/L6HWAN9KSrOpvyenBdtk7Q/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json'}, attempt #1 03:00:48 INFO - Downloaded 1199 bytes. 03:00:48 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 03:00:48 INFO - Using the following test package requirements: 03:00:48 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 03:00:48 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:00:48 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 03:00:48 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:00:48 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 03:00:48 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:00:48 INFO - u'jsshell-mac.zip'], 03:00:48 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:00:48 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 03:00:48 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 03:00:48 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:00:48 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 03:00:48 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:00:48 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 03:00:48 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:00:48 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 03:00:48 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:00:48 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 03:00:48 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 03:00:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/L6HWAN9KSrOpvyenBdtk7Q/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 03:00:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/L6HWAN9KSrOpvyenBdtk7Q/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 03:00:48 INFO - Fetch https://queue.taskcluster.net/v1/task/L6HWAN9KSrOpvyenBdtk7Q/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 03:00:48 INFO - Expected file size: 16430922 03:00:55 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip', u'firefox-51.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 03:00:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/L6HWAN9KSrOpvyenBdtk7Q/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 03:00:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/L6HWAN9KSrOpvyenBdtk7Q/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 03:00:55 INFO - Fetch https://queue.taskcluster.net/v1/task/L6HWAN9KSrOpvyenBdtk7Q/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 03:00:56 INFO - Expected file size: 16430922 03:01:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/L6HWAN9KSrOpvyenBdtk7Q/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 03:01:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/L6HWAN9KSrOpvyenBdtk7Q/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 03:01:03 INFO - Fetch https://queue.taskcluster.net/v1/task/L6HWAN9KSrOpvyenBdtk7Q/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 03:01:03 INFO - Expected file size: 14414059 03:01:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:01:04 INFO - trying https://queue.taskcluster.net/v1/task/L6HWAN9KSrOpvyenBdtk7Q/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 03:01:04 INFO - Downloading https://queue.taskcluster.net/v1/task/L6HWAN9KSrOpvyenBdtk7Q/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 03:01:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/L6HWAN9KSrOpvyenBdtk7Q/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg'}, attempt #1 03:01:07 INFO - Downloaded 115380170 bytes. 03:01:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/L6HWAN9KSrOpvyenBdtk7Q/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 03:01:07 INFO - mkdir: /builds/slave/test/properties 03:01:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:01:07 INFO - Writing to file /builds/slave/test/properties/build_url 03:01:07 INFO - Contents: 03:01:07 INFO - build_url:https://queue.taskcluster.net/v1/task/L6HWAN9KSrOpvyenBdtk7Q/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 03:01:07 INFO - Running post-action listener: _resource_record_post_action 03:01:07 INFO - Running post-action listener: set_extra_try_arguments 03:01:07 INFO - [mozharness: 2016-09-25 10:01:07.982557Z] Finished download-and-extract step (success) 03:01:07 INFO - [mozharness: 2016-09-25 10:01:07.982675Z] Running populate-webroot step. 03:01:07 INFO - Running pre-action listener: _resource_record_pre_action 03:01:07 INFO - Running main action method: populate_webroot 03:01:07 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:01:07 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:01:07 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:01:07 INFO - '--tppagecycles', 03:01:07 INFO - '7'], 03:01:07 INFO - 'tests': ['tsvgm']}}, 03:01:07 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:01:07 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:01:07 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:01:07 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:01:07 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:01:07 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:01:07 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:01:07 INFO - 'talos_options': ['--disable-e10s'], 03:01:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:01:07 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:01:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:01:07 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:01:07 INFO - 'talos_options': ['--disable-e10s'], 03:01:07 INFO - 'tests': ['damp', 'tps']}, 03:01:07 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:01:07 INFO - 'tests': ['damp', 'tps']}, 03:01:07 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:01:07 INFO - 'tests': ['dromaeo_dom']}, 03:01:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:01:07 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:01:07 INFO - 'tests': ['basic_compositor_video']}, 03:01:07 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:01:07 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:01:07 INFO - 'tests': ['a11yr', 03:01:07 INFO - 'ts_paint', 03:01:07 INFO - 'tpaint', 03:01:07 INFO - 'sessionrestore', 03:01:07 INFO - 'sessionrestore_no_auto_restore', 03:01:07 INFO - 'tabpaint']}, 03:01:07 INFO - 'other-e10s': {'tests': ['a11yr', 03:01:07 INFO - 'ts_paint', 03:01:07 INFO - 'tpaint', 03:01:07 INFO - 'sessionrestore', 03:01:07 INFO - 'sessionrestore_no_auto_restore', 03:01:07 INFO - 'tabpaint']}, 03:01:07 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:01:07 INFO - 'ts_paint', 03:01:07 INFO - 'tpaint', 03:01:07 INFO - 'sessionrestore', 03:01:07 INFO - 'sessionrestore_no_auto_restore', 03:01:07 INFO - 'tabpaint']}, 03:01:07 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:01:07 INFO - 'ts_paint', 03:01:07 INFO - 'tpaint', 03:01:07 INFO - 'sessionrestore', 03:01:07 INFO - 'sessionrestore_no_auto_restore', 03:01:07 INFO - 'tabpaint']}, 03:01:07 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:01:07 INFO - 'tests': ['a11yr', 03:01:07 INFO - 'ts_paint', 03:01:07 INFO - 'tpaint', 03:01:07 INFO - 'sessionrestore', 03:01:07 INFO - 'sessionrestore_no_auto_restore', 03:01:07 INFO - 'tabpaint']}, 03:01:07 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:01:07 INFO - 'tests': ['a11yr', 03:01:07 INFO - 'ts_paint', 03:01:07 INFO - 'tpaint', 03:01:07 INFO - 'sessionrestore', 03:01:07 INFO - 'sessionrestore_no_auto_restore', 03:01:07 INFO - 'tabpaint']}, 03:01:07 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:01:07 INFO - 'tests': ['tsvgx', 03:01:07 INFO - 'tsvgr_opacity', 03:01:07 INFO - 'tart', 03:01:07 INFO - 'tscrollx', 03:01:07 INFO - 'cart']}, 03:01:07 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:01:07 INFO - 'tsvgr_opacity', 03:01:07 INFO - 'tart', 03:01:07 INFO - 'tscrollx', 03:01:07 INFO - 'cart']}, 03:01:07 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:01:08 INFO - 'talos_options': ['--disable-e10s'], 03:01:08 INFO - 'tests': ['tp5o']}, 03:01:08 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:01:08 INFO - 'tests': ['tp5o']}, 03:01:08 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:01:08 INFO - 'talos_options': ['--disable-e10s', 03:01:08 INFO - '--xperf_path', 03:01:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:01:08 INFO - 'tests': ['tp5n']}, 03:01:08 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:01:08 INFO - 'talos_options': ['--xperf_path', 03:01:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:01:08 INFO - 'tests': ['tp5n']}}, 03:01:08 INFO - 'talos.zip': {'path': '', 03:01:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:01:08 INFO - Running post-action listener: _resource_record_post_action 03:01:08 INFO - [mozharness: 2016-09-25 10:01:08.001840Z] Finished populate-webroot step (success) 03:01:08 INFO - [mozharness: 2016-09-25 10:01:08.001971Z] Running create-virtualenv step. 03:01:08 INFO - Running pre-action listener: _resource_record_pre_action 03:01:08 INFO - Running main action method: create_virtualenv 03:01:08 INFO - Creating virtualenv /builds/slave/test/build/venv 03:01:08 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 03:01:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:01:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:01:08 INFO - Using real prefix '/tools/python27' 03:01:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:01:08 INFO - Installing distribute.............................................................................................................................................................................................done. 03:01:11 INFO - Installing pip.................done. 03:01:11 INFO - Return code: 0 03:01:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:01:11 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')]} 03:01:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:01:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:01:11 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')]} 03:01:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:01:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:01:11 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 0x100ce2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c58570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6ead8f3f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100af6d30>, '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 0x10095cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100aeeb20>, '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.LniWFnULpJ/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.VHfub8XtRl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/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 03:01:11 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 03:01:11 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 03:01:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LniWFnULpJ/Render', 03:01:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:01:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:01:11 INFO - 'HOME': '/Users/cltbld', 03:01:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:01:11 INFO - 'LOGNAME': 'cltbld', 03:01:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:01:11 INFO - 'MOZ_NO_REMOTE': '1', 03:01:11 INFO - 'NO_EM_RESTART': '1', 03:01:11 INFO - 'PAGER': '/bin/cat', 03:01:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:01:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:01:11 INFO - 'PWD': '/builds/slave/test', 03:01:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:01:11 INFO - 'SHELL': '/bin/bash', 03:01:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VHfub8XtRl/Listeners', 03:01:11 INFO - 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/', 03:01:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:01:11 INFO - 'USER': 'cltbld', 03:01:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:01:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:01:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:01:11 INFO - 'XPC_FLAGS': '0x0', 03:01:11 INFO - 'XPC_SERVICE_NAME': '0', 03:01:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:01:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:01:11 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 03:01:11 INFO - Cleaning up... 03:01:11 INFO - Return code: 0 03:01:11 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:01:11 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')]} 03:01:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:01:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:01:11 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')]} 03:01:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:01:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:01:11 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 0x100ce2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c58570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6ead8f3f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100af6d30>, '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 0x10095cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100aeeb20>, '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.LniWFnULpJ/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.VHfub8XtRl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/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 03:01:11 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 03:01:11 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 03:01:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LniWFnULpJ/Render', 03:01:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:01:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:01:11 INFO - 'HOME': '/Users/cltbld', 03:01:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:01:11 INFO - 'LOGNAME': 'cltbld', 03:01:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:01:11 INFO - 'MOZ_NO_REMOTE': '1', 03:01:11 INFO - 'NO_EM_RESTART': '1', 03:01:11 INFO - 'PAGER': '/bin/cat', 03:01:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:01:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:01:11 INFO - 'PWD': '/builds/slave/test', 03:01:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:01:11 INFO - 'SHELL': '/bin/bash', 03:01:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VHfub8XtRl/Listeners', 03:01:11 INFO - 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/', 03:01:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:01:11 INFO - 'USER': 'cltbld', 03:01:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:01:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:01:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:01:11 INFO - 'XPC_FLAGS': '0x0', 03:01:11 INFO - 'XPC_SERVICE_NAME': '0', 03:01:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:01:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:01:12 INFO - Downloading/unpacking psutil>=3.1.1 03:01:12 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 03:01:12 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 03:01:12 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 03:01:12 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 03:01:12 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 03:01:12 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 03:01:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:01:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:01:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:01:15 INFO - Installing collected packages: psutil 03:01:15 INFO - Running setup.py install for psutil 03:01:16 INFO - building 'psutil._psutil_osx' extension 03:01:16 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 03:01:16 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 03:01:16 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 03:01:16 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 03:01:16 INFO - building 'psutil._psutil_posix' extension 03:01:16 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 03:01:16 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 03:01:16 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 03:01:16 INFO - ^ 03:01:16 INFO - 1 warning generated. 03:01:16 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 03:01:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:01:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:01:16 INFO - Successfully installed psutil 03:01:16 INFO - Cleaning up... 03:01:16 INFO - Return code: 0 03:01:16 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:01:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:01:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:01:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:01:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:01:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:01:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:01:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100ce2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c58570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6ead8f3f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100af6d30>, '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 0x10095cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100aeeb20>, '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.LniWFnULpJ/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.VHfub8XtRl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/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 03:01:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:01:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:01:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LniWFnULpJ/Render', 03:01:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:01:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:01:16 INFO - 'HOME': '/Users/cltbld', 03:01:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:01:16 INFO - 'LOGNAME': 'cltbld', 03:01:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:01:16 INFO - 'MOZ_NO_REMOTE': '1', 03:01:16 INFO - 'NO_EM_RESTART': '1', 03:01:16 INFO - 'PAGER': '/bin/cat', 03:01:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:01:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:01:16 INFO - 'PWD': '/builds/slave/test', 03:01:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:01:16 INFO - 'SHELL': '/bin/bash', 03:01:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VHfub8XtRl/Listeners', 03:01:16 INFO - 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/', 03:01:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:01:16 INFO - 'USER': 'cltbld', 03:01:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:01:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:01:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:01:16 INFO - 'XPC_FLAGS': '0x0', 03:01:16 INFO - 'XPC_SERVICE_NAME': '0', 03:01:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:01:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:01:17 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:01:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:01:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:01:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:01:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:01:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:01:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:01:19 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:01:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:01:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:01:19 INFO - Installing collected packages: mozsystemmonitor 03:01:19 INFO - Running setup.py install for mozsystemmonitor 03:01:19 INFO - Successfully installed mozsystemmonitor 03:01:19 INFO - Cleaning up... 03:01:19 INFO - Return code: 0 03:01:19 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:01:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:01:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:01:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:01:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:01:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:01:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:01:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100ce2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c58570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6ead8f3f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100af6d30>, '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 0x10095cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100aeeb20>, '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.LniWFnULpJ/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.VHfub8XtRl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/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 03:01:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:01:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:01:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LniWFnULpJ/Render', 03:01:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:01:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:01:19 INFO - 'HOME': '/Users/cltbld', 03:01:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:01:19 INFO - 'LOGNAME': 'cltbld', 03:01:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:01:19 INFO - 'MOZ_NO_REMOTE': '1', 03:01:19 INFO - 'NO_EM_RESTART': '1', 03:01:19 INFO - 'PAGER': '/bin/cat', 03:01:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:01:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:01:19 INFO - 'PWD': '/builds/slave/test', 03:01:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:01:19 INFO - 'SHELL': '/bin/bash', 03:01:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VHfub8XtRl/Listeners', 03:01:19 INFO - 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/', 03:01:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:01:19 INFO - 'USER': 'cltbld', 03:01:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:01:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:01:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:01:19 INFO - 'XPC_FLAGS': '0x0', 03:01:19 INFO - 'XPC_SERVICE_NAME': '0', 03:01:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:01:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:01:20 INFO - Downloading/unpacking jsonschema==2.5.1 03:01:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:01:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:01:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:01:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:01:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:01:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:01:22 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:01:22 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:01:22 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 03:01:22 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 03:01:22 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 03:01:22 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 03:01:22 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 03:01:22 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 03:01:22 INFO - Downloading functools32-3.2.3-2.tar.gz 03:01:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:01:23 INFO - warning: no files found matching '*.txt' 03:01:23 INFO - no previously-included directories found matching 'build' 03:01:23 INFO - no previously-included directories found matching 'dist' 03:01:23 INFO - no previously-included directories found matching '.git*' 03:01:23 INFO - Installing collected packages: jsonschema, functools32 03:01:23 INFO - Running setup.py install for functools32 03:01:23 INFO - warning: no files found matching '*.txt' 03:01:23 INFO - no previously-included directories found matching 'build' 03:01:23 INFO - no previously-included directories found matching 'dist' 03:01:23 INFO - no previously-included directories found matching '.git*' 03:01:23 INFO - Successfully installed jsonschema functools32 03:01:23 INFO - Cleaning up... 03:01:23 INFO - Return code: 0 03:01:23 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:01:23 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')]} 03:01:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:01:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:01:23 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')]} 03:01:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:01:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:01:23 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 0x100ce2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c58570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6ead8f3f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100af6d30>, '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 0x10095cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100aeeb20>, '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.LniWFnULpJ/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.VHfub8XtRl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/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 03:01:23 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 03:01:23 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 03:01:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LniWFnULpJ/Render', 03:01:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:01:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:01:23 INFO - 'HOME': '/Users/cltbld', 03:01:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:01:23 INFO - 'LOGNAME': 'cltbld', 03:01:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:01:23 INFO - 'MOZ_NO_REMOTE': '1', 03:01:23 INFO - 'NO_EM_RESTART': '1', 03:01:23 INFO - 'PAGER': '/bin/cat', 03:01:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:01:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:01:23 INFO - 'PWD': '/builds/slave/test', 03:01:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:01:23 INFO - 'SHELL': '/bin/bash', 03:01:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VHfub8XtRl/Listeners', 03:01:23 INFO - 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/', 03:01:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:01:23 INFO - 'USER': 'cltbld', 03:01:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:01:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:01:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:01:23 INFO - 'XPC_FLAGS': '0x0', 03:01:23 INFO - 'XPC_SERVICE_NAME': '0', 03:01:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:01:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:01:23 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:01:23 INFO - Cleaning up... 03:01:23 INFO - Return code: 0 03:01:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:01:23 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')]} 03:01:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:01:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:01:23 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')]} 03:01:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:01:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:01:23 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 0x100ce2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c58570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6ead8f3f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100af6d30>, '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 0x10095cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100aeeb20>, '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.LniWFnULpJ/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.VHfub8XtRl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/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 03:01:23 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 03:01:23 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 03:01:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LniWFnULpJ/Render', 03:01:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:01:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:01:23 INFO - 'HOME': '/Users/cltbld', 03:01:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:01:23 INFO - 'LOGNAME': 'cltbld', 03:01:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:01:23 INFO - 'MOZ_NO_REMOTE': '1', 03:01:23 INFO - 'NO_EM_RESTART': '1', 03:01:23 INFO - 'PAGER': '/bin/cat', 03:01:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:01:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:01:23 INFO - 'PWD': '/builds/slave/test', 03:01:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:01:23 INFO - 'SHELL': '/bin/bash', 03:01:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VHfub8XtRl/Listeners', 03:01:23 INFO - 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/', 03:01:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:01:23 INFO - 'USER': 'cltbld', 03:01:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:01:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:01:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:01:23 INFO - 'XPC_FLAGS': '0x0', 03:01:23 INFO - 'XPC_SERVICE_NAME': '0', 03:01:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:01:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:01:23 INFO - Downloading/unpacking blobuploader==1.2.4 03:01:23 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 03:01:23 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 03:01:23 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 03:01:23 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 03:01:23 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 03:01:23 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 03:01:26 INFO - Downloading blobuploader-1.2.4.tar.gz 03:01:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:01:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:01:26 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 03:01:26 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 03:01:26 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 03:01:26 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 03:01:26 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 03:01:26 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 03:01:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:01:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:01:27 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 03:01:27 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 03:01:27 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 03:01:27 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 03:01:27 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 03:01:27 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 03:01:27 INFO - Downloading docopt-0.6.1.tar.gz 03:01:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:01:27 INFO - Installing collected packages: blobuploader, requests, docopt 03:01:27 INFO - Running setup.py install for blobuploader 03:01:27 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:01:27 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:01:27 INFO - Running setup.py install for requests 03:01:28 INFO - Running setup.py install for docopt 03:01:28 INFO - Successfully installed blobuploader requests docopt 03:01:28 INFO - Cleaning up... 03:01:28 INFO - Return code: 0 03:01:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:01:28 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')]} 03:01:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:01:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:01:28 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')]} 03:01:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:01:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:01:28 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 0x100ce2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c58570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6ead8f3f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100af6d30>, '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 0x10095cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100aeeb20>, '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.LniWFnULpJ/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.VHfub8XtRl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/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 03:01:28 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 03:01:28 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 03:01:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LniWFnULpJ/Render', 03:01:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:01:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:01:28 INFO - 'HOME': '/Users/cltbld', 03:01:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:01:28 INFO - 'LOGNAME': 'cltbld', 03:01:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:01:28 INFO - 'MOZ_NO_REMOTE': '1', 03:01:28 INFO - 'NO_EM_RESTART': '1', 03:01:28 INFO - 'PAGER': '/bin/cat', 03:01:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:01:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:01:28 INFO - 'PWD': '/builds/slave/test', 03:01:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:01:28 INFO - 'SHELL': '/bin/bash', 03:01:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VHfub8XtRl/Listeners', 03:01:28 INFO - 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/', 03:01:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:01:28 INFO - 'USER': 'cltbld', 03:01:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:01:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:01:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:01:28 INFO - 'XPC_FLAGS': '0x0', 03:01:28 INFO - 'XPC_SERVICE_NAME': '0', 03:01:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:01:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:01:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:01:28 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-Xvv9Zb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:01:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:01:28 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-GN7YEx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:01:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:01:28 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-IXDUNZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:01:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:01:29 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-HyfeXm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:01:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:01:29 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-odFD9t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:01:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:01:29 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-9xTEax-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:01:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:01:29 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-Opvb_K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:01:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:01:29 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-2vVOlt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:01:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:01:29 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-t19jm5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:01:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:01:29 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-stQF93-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:01:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:01:29 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-i6T63F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:01:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:01:29 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-K9s6mu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:01:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:01:29 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-eVZt29-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:01:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:01:30 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-5gORxH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:01:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:01:30 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-EKPEkY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:01:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:01:30 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-QTAg0Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:01:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:01:30 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-QLlGC_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:01:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:01:30 INFO - Running setup.py install for manifestparser 03:01:30 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:01:30 INFO - Running setup.py install for mozcrash 03:01:30 INFO - Running setup.py install for mozdebug 03:01:30 INFO - Running setup.py install for mozdevice 03:01:31 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:01:31 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:01:31 INFO - Running setup.py install for mozfile 03:01:31 INFO - Running setup.py install for mozhttpd 03:01:31 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:01:31 INFO - Running setup.py install for mozinfo 03:01:31 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:01:31 INFO - Running setup.py install for mozInstall 03:01:31 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:01:31 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:01:31 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:01:31 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:01:31 INFO - Running setup.py install for mozleak 03:01:31 INFO - Running setup.py install for mozlog 03:01:32 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:01:32 INFO - Running setup.py install for moznetwork 03:01:32 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:01:32 INFO - Running setup.py install for mozprocess 03:01:32 INFO - Running setup.py install for mozprofile 03:01:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:01:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:01:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:01:32 INFO - Running setup.py install for mozrunner 03:01:32 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:01:32 INFO - Running setup.py install for mozscreenshot 03:01:32 INFO - Running setup.py install for moztest 03:01:32 INFO - Running setup.py install for mozversion 03:01:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:01:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:01:33 INFO - Cleaning up... 03:01:33 INFO - Return code: 0 03:01:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:01:33 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')]} 03:01:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:01:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:01:33 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')]} 03:01:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:01:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:01:33 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 0x100ce2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c58570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6ead8f3f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100af6d30>, '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 0x10095cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100aeeb20>, '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.LniWFnULpJ/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.VHfub8XtRl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/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 03:01:33 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 03:01:33 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 03:01:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LniWFnULpJ/Render', 03:01:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:01:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:01:33 INFO - 'HOME': '/Users/cltbld', 03:01:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:01:33 INFO - 'LOGNAME': 'cltbld', 03:01:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:01:33 INFO - 'MOZ_NO_REMOTE': '1', 03:01:33 INFO - 'NO_EM_RESTART': '1', 03:01:33 INFO - 'PAGER': '/bin/cat', 03:01:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:01:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:01:33 INFO - 'PWD': '/builds/slave/test', 03:01:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:01:33 INFO - 'SHELL': '/bin/bash', 03:01:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VHfub8XtRl/Listeners', 03:01:33 INFO - 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/', 03:01:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:01:33 INFO - 'USER': 'cltbld', 03:01:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:01:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:01:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:01:33 INFO - 'XPC_FLAGS': '0x0', 03:01:33 INFO - 'XPC_SERVICE_NAME': '0', 03:01:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:01:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:01:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:01:33 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-92t5lF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:01:33 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)) 03:01:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:01:33 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-p2_ohV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:01:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 03:01:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:01:33 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-rBTEQd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:01:33 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)) 03:01:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:01:33 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-Kx82FO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:01:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 03:01:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:01:33 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-5u08IC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:01:33 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)) 03:01:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:01:33 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-K4M7_A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:01:34 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)) 03:01:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:01:34 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-SuTAYk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:01:34 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)) 03:01:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:01:34 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-lCdcsM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:01:34 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)) 03:01:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:01:34 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-uDIInl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:01:34 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)) 03:01:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:01:34 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-7PnFMt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:01:34 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)) 03:01:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:01:34 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-MTfalR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:01:34 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)) 03:01:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:01:34 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-DNI589-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:01:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 03:01:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:01:34 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-lEj1CU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:01:34 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)) 03:01:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:01:34 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-CdYxvg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:01:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 03:01:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:01:34 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-UAqFva-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:01:34 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)) 03:01:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:01:34 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-rnvG4q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:01:35 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 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)) 03:01:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:01:35 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-AcaZOj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:01:35 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)) 03:01:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:01:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:01:35 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)) 03:01:35 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:01:35 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:01:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:01:35 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 03:01:35 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 03:01:35 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 03:01:35 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 03:01:35 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 03:01:35 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 03:01:37 INFO - Downloading blessings-1.6.tar.gz 03:01:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:01:37 INFO - Installing collected packages: blessings 03:01:37 INFO - Running setup.py install for blessings 03:01:37 INFO - Successfully installed blessings 03:01:37 INFO - Cleaning up... 03:01:38 INFO - Return code: 0 03:01:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:01:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:01:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:01:38 INFO - Reading from file tmpfile_stdout 03:01:38 INFO - Current package versions: 03:01:38 INFO - blessings == 1.6 03:01:38 INFO - blobuploader == 1.2.4 03:01:38 INFO - docopt == 0.6.1 03:01:38 INFO - functools32 == 3.2.3-2 03:01:38 INFO - jsonschema == 2.5.1 03:01:38 INFO - manifestparser == 1.1 03:01:38 INFO - mozInstall == 1.12 03:01:38 INFO - mozcrash == 0.17 03:01:38 INFO - mozdebug == 0.1 03:01:38 INFO - mozdevice == 0.48 03:01:38 INFO - mozfile == 1.2 03:01:38 INFO - mozhttpd == 0.7 03:01:38 INFO - mozinfo == 0.9 03:01:38 INFO - mozleak == 0.1 03:01:38 INFO - mozlog == 3.4 03:01:38 INFO - moznetwork == 0.27 03:01:38 INFO - mozprocess == 0.23 03:01:38 INFO - mozprofile == 0.28 03:01:38 INFO - mozrunner == 6.12 03:01:38 INFO - mozscreenshot == 0.1 03:01:38 INFO - mozsystemmonitor == 0.3 03:01:38 INFO - moztest == 0.7 03:01:38 INFO - mozversion == 1.4 03:01:38 INFO - psutil == 3.1.1 03:01:38 INFO - requests == 1.2.3 03:01:38 INFO - wsgiref == 0.1.2 03:01:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:01:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:01:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:01:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:01:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:01:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:01:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:01:38 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 0x100ce2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c58570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6ead8f3f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100af6d30>, '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 0x10095cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100aeeb20>, '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.LniWFnULpJ/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.VHfub8XtRl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/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 03:01:38 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 03:01:38 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 03:01:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LniWFnULpJ/Render', 03:01:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:01:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:01:38 INFO - 'HOME': '/Users/cltbld', 03:01:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:01:38 INFO - 'LOGNAME': 'cltbld', 03:01:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:01:38 INFO - 'MOZ_NO_REMOTE': '1', 03:01:38 INFO - 'NO_EM_RESTART': '1', 03:01:38 INFO - 'PAGER': '/bin/cat', 03:01:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:01:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:01:38 INFO - 'PWD': '/builds/slave/test', 03:01:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:01:38 INFO - 'SHELL': '/bin/bash', 03:01:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VHfub8XtRl/Listeners', 03:01:38 INFO - 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/', 03:01:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:01:38 INFO - 'USER': 'cltbld', 03:01:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:01:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:01:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:01:38 INFO - 'XPC_FLAGS': '0x0', 03:01:38 INFO - 'XPC_SERVICE_NAME': '0', 03:01:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:01:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:01:38 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)) 03:01:38 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)) 03:01:38 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)) 03:01:38 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)) 03:01:38 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)) 03:01:38 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)) 03:01:38 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)) 03:01:38 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)) 03:01:38 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)) 03:01:38 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)) 03:01:38 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)) 03:01:38 INFO - Cleaning up... 03:01:38 INFO - Return code: 0 03:01:38 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:01:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:01:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:01:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:01:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:01:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:01:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:01:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100ce2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c58570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6ead8f3f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100af6d30>, '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 0x10095cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100aeeb20>, '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.LniWFnULpJ/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.VHfub8XtRl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/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 03:01:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:01:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:01:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LniWFnULpJ/Render', 03:01:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:01:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:01:38 INFO - 'HOME': '/Users/cltbld', 03:01:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:01:38 INFO - 'LOGNAME': 'cltbld', 03:01:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:01:38 INFO - 'MOZ_NO_REMOTE': '1', 03:01:38 INFO - 'NO_EM_RESTART': '1', 03:01:38 INFO - 'PAGER': '/bin/cat', 03:01:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:01:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:01:38 INFO - 'PWD': '/builds/slave/test', 03:01:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:01:38 INFO - 'SHELL': '/bin/bash', 03:01:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VHfub8XtRl/Listeners', 03:01:38 INFO - 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/', 03:01:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:01:38 INFO - 'USER': 'cltbld', 03:01:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:01:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:01:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:01:38 INFO - 'XPC_FLAGS': '0x0', 03:01:38 INFO - 'XPC_SERVICE_NAME': '0', 03:01:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:01:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:01:38 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:01:38 INFO - Cleaning up... 03:01:38 INFO - Return code: 0 03:01:38 INFO - Running post-action listener: _resource_record_post_action 03:01:38 INFO - Running post-action listener: _start_resource_monitoring 03:01:38 INFO - Starting resource monitoring. 03:01:38 INFO - [mozharness: 2016-09-25 10:01:38.882083Z] Finished create-virtualenv step (success) 03:01:38 INFO - [mozharness: 2016-09-25 10:01:38.883166Z] Running install step. 03:01:38 INFO - Running pre-action listener: _resource_record_pre_action 03:01:38 INFO - Running main action method: install 03:01:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:01:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:01:39 INFO - Reading from file tmpfile_stdout 03:01:39 INFO - Detecting whether we're running mozinstall >=1.0... 03:01:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:01:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:01:39 INFO - Reading from file tmpfile_stdout 03:01:39 INFO - Output received: 03:01:39 INFO - Usage: mozinstall [options] installer 03:01:39 INFO - Options: 03:01:39 INFO - -h, --help show this help message and exit 03:01:39 INFO - -d DEST, --destination=DEST 03:01:39 INFO - Directory to install application into. [default: 03:01:39 INFO - "/builds/slave/test"] 03:01:39 INFO - --app=APP Application being installed. [default: firefox] 03:01:39 INFO - mkdir: /builds/slave/test/build/application 03:01:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 03:01:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 03:02:11 INFO - Reading from file tmpfile_stdout 03:02:11 INFO - Output received: 03:02:11 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 03:02:11 INFO - Running post-action listener: _resource_record_post_action 03:02:11 INFO - [mozharness: 2016-09-25 10:02:11.106429Z] Finished install step (success) 03:02:11 INFO - [mozharness: 2016-09-25 10:02:11.106559Z] Running run-tests step. 03:02:11 INFO - Running pre-action listener: _resource_record_pre_action 03:02:11 INFO - Running main action method: run_tests 03:02:11 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:02:11 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:02:11 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:02:11 INFO - 2016-09-25 03:02:11.119 screenresolution[1947:15686] starting screenresolution argv=screenresolution get 03:02:11 INFO - 2016-09-25 03:02:11.122 screenresolution[1947:15686] Display 0: 1600x1200x32@60 03:02:11 INFO - 2016-09-25 03:02:11.127 screenresolution[1948:15688] starting screenresolution argv=screenresolution list 03:02:11 INFO - Available Modes on Display 0 03:02:11 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:02:11 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:02:11 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:02:11 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:02:11 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:02:11 INFO - Intel Iris: 03:02:11 INFO - Chipset Model: Intel Iris 03:02:11 INFO - Type: GPU 03:02:11 INFO - Bus: Built-In 03:02:11 INFO - VRAM (Dynamic, Max): 1536 MB 03:02:11 INFO - Vendor: Intel (0x8086) 03:02:11 INFO - Device ID: 0x0a2e 03:02:11 INFO - Revision ID: 0x0009 03:02:11 INFO - Displays: 03:02:11 INFO - Display: 03:02:11 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:02:11 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:02:11 INFO - Display Serial Number: 1600x1200 60 03:02:11 INFO - Main Display: Yes 03:02:11 INFO - Mirror: Off 03:02:11 INFO - Online: Yes 03:02:11 INFO - Rotation: Supported 03:02:11 INFO - Return code: 0 03:02:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:02:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:02:11 INFO - Python 2.7.3 03:02:11 INFO - Return code: 0 03:02:11 INFO - grabbing minidump binary from tooltool 03:02:11 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')]} 03:02:11 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 0x100af6d30>, '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 0x10095cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100aeeb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:02:11 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 03:02:11 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 03:02:11 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 03:02:11 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:02:11 INFO - Return code: 0 03:02:11 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 03:02:11 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:02:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:02:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 03:02:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:02:11 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/L6HWAN9KSrOpvyenBdtk7Q/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0140', '--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 03:02:11 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/L6HWAN9KSrOpvyenBdtk7Q/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0140 --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 03:02:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LniWFnULpJ/Render', 03:02:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:02:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:02:11 INFO - 'HOME': '/Users/cltbld', 03:02:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:02:11 INFO - 'LOGNAME': 'cltbld', 03:02:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:02:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 03:02:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:02:11 INFO - 'MOZ_NO_REMOTE': '1', 03:02:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:02:11 INFO - 'NO_EM_RESTART': '1', 03:02:11 INFO - 'PAGER': '/bin/cat', 03:02:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:02:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:02:11 INFO - 'PWD': '/builds/slave/test', 03:02:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:02:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:02:11 INFO - 'SHELL': '/bin/bash', 03:02:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VHfub8XtRl/Listeners', 03:02:11 INFO - 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/', 03:02:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:02:11 INFO - 'USER': 'cltbld', 03:02:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:02:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:02:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:02:11 INFO - 'XPC_FLAGS': '0x0', 03:02:11 INFO - 'XPC_SERVICE_NAME': '0', 03:02:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:02:11 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/L6HWAN9KSrOpvyenBdtk7Q/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0140', '--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 03:02:11 INFO - mozversion application_buildid: 20160925004010 03:02:11 INFO - mozversion application_changeset: 1fee8de1111fdcc6fb5d95d4afef92c913fc87f2 03:02:11 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:02:11 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:02:11 INFO - mozversion application_name: Firefox 03:02:11 INFO - mozversion application_remotingname: firefox-dev 03:02:11 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:02:11 INFO - mozversion application_vendor: Mozilla 03:02:11 INFO - mozversion application_version: 51.0a2 03:02:11 INFO - mozversion platform_buildid: 20160925004010 03:02:11 INFO - mozversion platform_changeset: 1fee8de1111fdcc6fb5d95d4afef92c913fc87f2 03:02:11 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:02:11 INFO - mozversion platform_version: 51.0a2 03:02:11 INFO - using testdate: 1474797731 03:02:11 INFO - actual date: 1474797731 03:02:11 INFO - starting webserver on 'localhost:52092' 03:02:11 INFO - SUITE-START | Running 2 tests 03:02:11 INFO - TEST-START | dromaeo_css 03:02:11 INFO - operating with platform_type : mac_ 03:02:11 INFO - Initialising browser for dromaeo_css test... 03:02:11 INFO - TEST-INFO | started process 1958 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/tmpbwDT_N/profile http://localhost:52092/getInfo.html) 03:02:14 INFO - PROCESS | 1958 | __metrics Screen width/height:1600/1200 03:02:14 INFO - PROCESS | 1958 | colorDepth:24 03:02:14 INFO - PROCESS | 1958 | Browser inner width/height: 1024/689 03:02:14 INFO - PROCESS | 1958 | __metrics 03:02:14 INFO - PROCESS | 1958 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:02:14 INFO - PROCESS | 1958 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:02:15 INFO - TEST-INFO | 1958: exit 0 03:02:15 INFO - Browser initialized. 03:02:15 INFO - Running cycle 1/1 for dromaeo_css test... 03:02:15 INFO - TEST-INFO | started process 1961 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/tmpbwDT_N/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:02:27 INFO - PROCESS | 1961 | RSS: Main: 219877376 03:02:27 INFO - PROCESS | 1961 | 03:03:19 INFO - PROCESS | 1961 | 1474797799239 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 03:05:30 INFO - PROCESS | 1961 | Cycle 1(1): loaded http://localhost:52092/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52092/tests/dromaeo/cssquery-ext.html) 03:05:31 INFO - PROCESS | 1961 | RSS: Main: 357060608 03:05:31 INFO - PROCESS | 1961 | 03:08:34 INFO - PROCESS | 1961 | Cycle 1(1): loaded http://localhost:52092/tests/dromaeo/cssquery-ext.html (next: http://localhost:52092/tests/dromaeo/cssquery-jquery.html) 03:08:35 INFO - PROCESS | 1961 | RSS: Main: 351850496 03:08:35 INFO - PROCESS | 1961 | 03:11:37 INFO - PROCESS | 1961 | Cycle 1(1): loaded http://localhost:52092/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52092/tests/dromaeo/cssquery-mootools.html) 03:11:38 INFO - PROCESS | 1961 | RSS: Main: 350744576 03:11:38 INFO - PROCESS | 1961 | 03:14:40 INFO - PROCESS | 1961 | Cycle 1(1): loaded http://localhost:52092/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52092/tests/dromaeo/cssquery-prototype.html) 03:14:40 INFO - PROCESS | 1961 | RSS: Main: 333000704 03:14:40 INFO - PROCESS | 1961 | 03:17:44 INFO - PROCESS | 1961 | Cycle 1(1): loaded http://localhost:52092/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52092/tests/dromaeo/cssquery-yui.html) 03:17:44 INFO - PROCESS | 1961 | RSS: Main: 312889344 03:17:44 INFO - PROCESS | 1961 | 03:20:47 INFO - PROCESS | 1961 | Cycle 1(1): loaded http://localhost:52092/tests/dromaeo/cssquery-yui.html (next: http://localhost:52092/tests/dromaeo/cssquery-dojo.html) 03:20:48 INFO - PROCESS | 1961 | RSS: Main: 400957440 03:20:48 INFO - PROCESS | 1961 | 03:20:48 INFO - PROCESS | 1961 | __start_tp_report 03:20:48 INFO - PROCESS | 1961 | _x_x_mozilla_page_load 03:20:48 INFO - PROCESS | 1961 | _x_x_mozilla_page_load_details 03:20:48 INFO - PROCESS | 1961 | |i|pagename|runs| 03:20:48 INFO - PROCESS | 1961 | |0;dojo.html;2759.3377589378547;3295.8187299698507;3323.0363194673546;3356.2784001439686;3380.8816691415805;5591.217229587861;5637.661740295585;5650.6892120933435;5672.064109421945;5690.231818704468;5565.332160140789;5600.747966341514;5668.57485688573;5681.431856814316;5741.110127930177;5140.460251673567;5163.406208286057;5172.948270517284;5191;5208.2968799212;5087.49125087492;5104.464031276718;5112.079825631385;5269.156934890419;5347.54545863602;5174.172132458807;5187.688738675692;5191.870203244911;5193.63644544882;5227.18978558324;5212.556932660747;5227.869303267411;5265.578753699733;5288.867778305573;5328.987492376436;5033.043721692867;5106.64253502255;5198.064348417283;5206.245094461282;5222.738863056832;4653.767311634405;5532.834014979557;5576.358718747356;5589.580781441408;5632.605717599769;6123.785667501616;6128.479079278267;6158.692065396713;6202.96898515509;6217.751289948396;6173.536984726164;6239.906401403982;6248.625082495019;6258.030005349178;6273.05904114382;5602.691851948141;5643.181738647873;5665.9716701417055;5681.17622944679;5721.284839395075;6253.53098517613;6269.486139586842;6278.183836101369;6295.685215739195;6321.462675672619;6068.90759663256;6075.058365953284;6079.118527813443;6081.6351018939;6094.238220222473;6079.148919151322;6109.572329936951;6119.84700382494;6135.754569817246;6164.506839452833;6120.938790612036;6159.630422174684;6169.938300616936;6178.505719542426;6184.81445556625;6104.145419641165;6167.321594624587;6178.907316390258;6195.070739389128;6197.96901015492;4804.471508134103;4839.128956787742;4844.32179494871;4894.583960363409;4928.359313289249;4335.176316499855;4395.428594282723;4403.8238470461465;4410.294352903584;4465.642748580106;5738.598298119092;5764.221830052973;5778.479936805707;5781.219535362672;5789.971050144806;6045;6225.066240064027;6236.18929539157;6238.656873871981;6243.594166379171;5642.069058605366;5655.886882262332;5707.714614269353;5716.056850619684;5741.397153298927;5316.787328506894;5351.197320401893;5368.355797304349;5369.892602147936;5371.811986580451;6336.556441049174;6341.524385671001;6341.587796793194;6345.397187267202;6348.238211414659;6074.66589337573;6115.755369785159;6142.723577439116;6195.473384762346;6279.183706118175;6335.619862808247;6336.144620476177;6343.492520598434;6358.618482890856;6359.8092057238355;6035.818925432244;6070.878582428415;6093.177421048102;6120.60216085953;6151.83115208109;5015.448300686994;6189.690515474118;6263.56155069159;6263.592866463848;6266.874662506633;6018.428249316308;6031.215941927521;6036.124761909587;6046.546509011754;6053.152558641882;4926.679765815211;5802.361740208658;5836.037053886062;5914.792982245601;5947.762089516371;5847.766089356548;5852.092925596539;5852.092925596539;5866.2960444746905;5890.646561206341;4948.975255123845;6037.728302226323;6038.6678732670125;6043.09353596964;6060.6969651516365;5119.334486516729;5716.79991200306;5762.510186634183;5784.363719990713;5823.854403639943 03:20:48 INFO - PROCESS | 1961 | |1;ext.html;460.98583117142294;475.8905451746098;480.5434836904941;495.60104116186454;507.4114027727834;28142;40390.39414408786;41307.58692413075;41342.37986430202;43579.78210108945;43332.783336083274;43668.344974825406;43706;43828.78085609576;43849;8608.56957152143;9727.075927786867;9920.355176913514;9929.056739609725;9932.553035113437;8638.611262493203;8851.690190843321;8857.778555536132;8871.157240062184;11813.23213991092;11878.524859005673;12162.513499460056;12178.391080445987;12179.086568507353;12215.328156951364;12115.878841211563;12198.536175658977;12200.389980500939;12221.511139554406;12228.510859565607;8586.87119693205;8786.86819697705;8794.736157915273;8936.240419564345;12029.39853007355;37679.058023549354;39478.60521394807;39849.80075099635;39855;42241.57758422407;3448.7241020718284;3569.3218288525095;3697.0798930916926;3950.822213000422;3951.644352008333;30438.086857394315;30864.69135308663;31295.53056704151;32232.355352893046;33201.837935672134;3179.60254968129;3237.093613788143;3290.851911663981;3335.382954153489;3392.8303584820906;497763;498130;498150;498850;504126;53286.733566332696;54407.72796136073;54621.72689136529;63772.36227637664;64350.67824660847;66192.33807661958;66310.33689663041;66561;66655;66693.666531668;16822.07478588665;17038;17044.06257655841;17049.31802727877;17060.402885898933;12903.612891613267;13010.674733131558;13015.674608134683;13017.023723220607;13023.47906083746;13435.19388836673;16411.671766564603;16672;18902.243910243713;19354.612907741765;6542.672866356663;6617.04052912325;7760.262775036363;7852.450328477066;7871.527708337404;857.4298091769028;982.2240430060173;988.5650313861878;1059.2003037706481;1113.1095123900848;29768.851155744083;29841.850790746343;30346.54480182755;30519.389612207633;30770.53844192339;1026.5431882812077;1032.1897310611134;1039.7972395382828;1067.40758878823;1175.6766889105565;14605.196714180822;15243.74709646484;15261.542153735405;15362.308696108701;15558.688826223412;675127;677818;680659;681501;682219;48652;49338.51984440473;55771.60570985758;56248.43751562514;56289.43710562924;1338.805873148388;1363.4478036395078;1382.2052319915888;1384.9030567860152;1385.9653508662363;24010.87994560016;29605;30391.696083038885;30437.847810760806;30667.693323066484;41470.79264603658;50421.24368134554;50447.74776126096;50464.99070018653;50481;511138;511949;513034;513277;513661;21850.562988740454;25833.483330333664;26162.607560886223;26517.204483865517;26531.469370612867;45682.54317456916;45956.31065533953;46494.070118598116;46792.53207468018;46845;36180.81909590435;37728.62271377251;38298.617013829506;38323.80838095903;38484.230315394096;37093;38209;38263.61736382712;39263.80368098256;39328;36338;37494.43758343682;40037.39943900786;40439;40446.1910761789;32453;34266;34794.478082828275;34985.82507087448;35104.12239694028;25587.744122558535;25657.871710641328;25661.743382565935;25790.355241119123;26169.607455887795 03:20:48 INFO - PROCESS | 1961 | |2;jquery.html;345.56976564177603;353.8920629208094;374.3150035435154;380.2452132516954;395.9623835735606;13980.510682126127;14315;16338.019718816864;21054.578908421823;21458.356249312506;20382.592348153026;20427.795722042774;21005.894970525165;21026.89486552565;21231.93840307986;4918.409790825088;5939.406059394069;6252.624842509464;6254.405831446005;6265.9686701566425;6112.113743507211;6161.661108639023;6217.316095229544;6226.43962043416;6232.968835155818;6048.939510604903;6092.08644525665;6127.632342059468;6171.197744293258;6176.84557886052;5900.734466948976;6077.6353418795015;6080.787172448943;6084.756609735606;6086.543509236781;5172.456892026321;5273.446288139767;5429.212764149216;5487.670739755627;5533.889322213573;12660.81008784869;12757.107002509829;12781.936090319488;12922.87077129226;12929.54746583865;2228.9219877304217;2244.6745221942892;2252.0203711385434;2345.9882700586386;2356.7289761677457;9497.572609232531;9646.276529260334;9654.131128198496;10146.289759716823;10310.690679279634;1834.8532117430573;1836.9908150459296;1857.219967613592;1899.1833511590012;1940.4566721318054;117139.82860171374;124917;132977;133147;137167.31416342856;10473.790524189473;11171.94414027941;11536.538538458535;11770.646880593597;12135.332556709465;14502.782458263135;14527.85472145286;14528;14529.78205326921;14544.200068996306;7448.590327532038;8318.085010648823;8559.315254779603;8602.268807151462;8752.299816014704;8423.157684231528;8651;8679.913200868037;8842.248408885316;8842.425242359226;3566.91082722934;3756.4928734620476;4529.818807247739;4555.498895121534;4633.745144017044;1604.502604192704;1628.4707470072274;1873.5597134673342;1900.9619807604047;1947.4936516505811;884.186548375496;911.284641556375;927.8654595083675;947.2942657720042;974.3179774158118;19165.904170479058;20072.085631392827;21524.4618884526;21540;21656.61777204506;929.6699671616614;937.2970272295778;946.9195118415012;948.6395169835556;950.814591154732;10896.40069796153;11137.498812553455;11238.719032024264;11369.919857613513;11946.283223006647;623349;629665;631663;633572;635481;67784.6610766943;132252;134700.3264983669;141449;146501;905.4522014181457;970.7476056225432;997.0926456924165;999.3504222255592;999.3703966501204;18624.161912714233;18816.52958676044;19184.328548500736;19207.615847683246;19240.903795480932;44744;57178.71410643087;57180.714096430915;58183;58185.41814581969;77503.61248193723;79590;79657;79997;86965;7077.893831592633;7163.713451461883;7258.564486130849;7475.551466911785;7654.502457340255;7185.856282874418;8950.23922966529;9774.80450390974;11383.886161138282;12979.091463597835;10752.677419677422;10889.836652450062;11229;11307.604233851776;11339.886601133883;10864.837027444753;10908.2364234506;10974.506147223234;11307.265027773497;11419.657410277705;9878.85181722289;11141.721456963316;11350;11696.181267311547;11781.705457363634;5284.471552844839;7334.889976650248;7353.485256032241;7420.666070026754;7455.776326710207;8451.915480845359;9081.364304498622;11079.833802492807;11267.985881270724;11467.31196128235 03:20:48 INFO - PROCESS | 1961 | |3;mootools.html;1359.4698067753573;1516.825565060018;1524.1997951075687;1726.5338358643166;1889.7826749923754;8005.679772809088;8309.709160179395;8570.27152692021;9147.95426022869;9174.587143578538;9017.053209413016;9088.182063614273;9091.863622045674;9096;9118.452892826435;2392.5095355452177;2427.5387676341525;2429.9514009719796;2430.5503481855826;2431.805455563551;2105.5788842231536;2381.8213633977434;2394.8983467604835;2407.6027455469825;2429.5626787178303;2392.473655795731;2414.9275521734376;2418.2503423938547;2428.101602407112;2430;2190.882649848573;2231.7991380775807;2369.3721163891582;2391.5456063347997;2407.434252950555;2362.4802543440414;2384.463495713468;2394.964075538868;2396.1733202045266;2397.113068164773;8930.86603700945;9094.408863423856;9094.772630684285;9191.35660503765;9201.401908875969;4449.9110017799785;5529.25828364064;5540.639858409231;5547.140193270049;5547.44525547446;3626.38351480249;3675.3568125577917;3704.907377315562;3734.3838266685966;3747.756395834262;824.9670013199525;1096.4024606589428;1107.6067995861433;1123.2081382625229;1132.9263597866113;12056.276623402624;12153.756924861542;12173.147879648428;12190.51237950481;12192.81710774339;4043.9797801010805;4072.450219220427;4594.494605593382;4780.163471392492;4795.568398844121;9390.577424015935;9396.95301523488;9403.43579385239;9412.90587094134;9417.717468475958;5340.973295133577;5350.545203657655;5350.678959262456;5352.41123476425;5366.570674346043;4513.684042117086;4563.110193512233;4632.953670463252;4970.105381031449;4993.875153121201;3305.5537502437346;3860.208657225262;3863.130795570974;3944.7830369329963;3964.7621142731527;1172.6657902497918;1173.988260117405;1178.293024185499;1189.3339729751367;1197.9341136237417;637.3148864970176;787.9709747400467;892.4779004282437;929.0523665860784;960.9711708648751;5891.175235467038;5954.345022047572;6002.609830361012;6027.849303767441;6117.724702388403;463.98144074237325;480.1381520171301;481.4703825791601;482.27658512231653;640.9616421397366;3856.7107466940092;4058.553559108496;4076.2255171517318;4080.163566468867;4178.874633760992;10540.894591054144;11310.773784524263;11418.200725949104;11420.714482138013;11434.199606027665;11168.944155279172;11195.009357454772;11385.487653055632;11387.316760994367;11412.828807567894;8354.997400312002;8542.273906718;8559.486430814171;8560.61477233526;8589.48463092229;5772.451617096369;5844.970775146097;5980.37206093354;5981.1327357532045;6039.184710064261;9434.198093161884;9868.358556693793;10105.292629515863;10391.168706503613;10591.364518128938;10632.89367106319;10692.358458492516;10703.785924281627;10720.839187412039;10722.142228621848;6889.138857642794;6964.79105626832;6969.58182509051;6970.965145174242;6974.895376569254;8370.079291277832;8376.916230837614;8453.196946290092;8463.830723385374;8548.358873084419;7600.657970391235;7630.7710768677025;7684.6157692116285;7724.266194711493;7820.530768153929;5955.5235581154275;6630.204375474974;7366.594837284001;7542.396608271215;7552.131504877009;6305.2433707953505;6791.45668346541;7083.6812343443635;7156.3917067047805;7226.891596625949;5054.974725126351;5076.441591425014;5120.052790233819;5128.666636668605;5218.8956220876125;4468.731876087445;5063.8480845574695;5068.949310506995;5092.898142037065;5125.359330083739 03:20:48 INFO - PROCESS | 1961 | |4;prototype.html;299.8620634508126;303.54165210532096;311.6571771051843;319.37083944629086;321.12973840891186;4645.535446455353;4938.814684475722;4977.129002424579;5205.973970130153;5256.579473642109;3901.9464744518964;4875.098106850235;5171.456997015315;5188.740562971855;5193.246979188016;3472.9305413891707;3943.3493473576827;4004.7373234122774;4066.146109317047;4114.156597897439;3583.677469027787;3770.151715863922;4051.4530538377235;4069.5553078657094;4080.3879418087226;2978.7170218829283;3991.181807729423;3994.2011597680435;4039.151778126597;4046.9190616187657;3274.8035117893;3331.4836200388977;3401.911388355727;3711.8329675164546;4038.0106873815807;2922.7077292270815;3468.809215493147;3496.720262379029;3506.789592624425;3550.2012047289413;4336.349547567858;4808.735519546423;4963.925541116886;5038.445770965191;5047.570956468705;3830.655241028293;4248.576726796527;4518.706284091556;4632.930506042412;4638.5593368629925;4506.3101336998625;4520.796564154621;4571.657125715585;5446.210299506589;5487.451254874521;2944.6024786653743;3400.591928968515;3710.833012514416;3842.9807850960847;3943.940840887389;4802.975985120052;5750.597458177971;5756.8848623027725;5757.88484230313;5782.132680097977;3885.6891448684037;3899.5710471848074;3917.941230881539;3932.9606703932595;3937.9761262071493;3835.6739677127757;3977.3835055566433;3989.162275922089;3998.1803730235233;3999.8200080996426;3794.2790869734663;4515.5484451554585;4528.682992190515;4543.704659197141;4633.235516139799;4748.240281554935;5051.520105589963;5479.04116779562;5494.862628434321;5518.668879867221;1267.2523211305374;1311.6786387335164;1317.4466723975954;1333.6999175185506;1358.770312866857;919.7010971434177;948.800751842107;952.3904601223909;958.2046901072093;960.1742501448748;4417.491988421372;4968.434942992945;4990.276409920614;5104.2088476286235;5200.297959775382;5483.464629903633;5639.182318563785;5695.920988839044;5697.4587414195585;5726.79956201531;4381.518033016366;4818.590419814355;4837.467878533358;5063;5141.53726164647;2294.770522947725;2901.998810410405;2930.948336164693;2931.7947743657737;2941.8234905905288;4707.811687532529;4939.604831613462;5793.826185214451;5821.359650438449;5854.2096816930025;5181.663191892515;5362.846987897621;5699.145128230799;5701.8289451315695;5713.5714821388565;5487.917681234705;5764.250647415977;5821.912671309934;5856.24312706195;5863.824085277449;5185.844424667266;5408.594355423437;5521.481592562078;5558.6381336572795;5562.694051827027;4565.238030991202;5465.480779325958;5495.945040549544;5508.504234618904;5534.391216966211;5542.3626282977975;5545.1682247663175;5715.542756579547;5797.449242321973;5879.529637628894;3319.771684476759;3459.9481007785407;3801.809909504569;3879.2241551689212;3920.098377373163;5146.790504231578;5235.869103272448;5513.255710479034;5556.638818476786;5600.439956004367;4777.570018698334;5271.367435907716;5432.414606359784;5467.992604067667;5481.369642491005;5057.241413787814;5082.932584157368;5342.519173274424;5352.100004498503;5393.568514518907;4350.869473915787;4877.463479017234;5103.132467480463;5160.664556803796;5272.65366911736;5453.454654534515;5486.753096110764;5495.46127084417;5530.787684926062;5559.471145435038;5072.728090381757;5346.919796203138;5355.571554275571;5358.410574836843;5426.348838139448 03:20:48 INFO - PROCESS | 1961 | |5;yui.html;651.4202359899689;681.9659017049146;712.4976891291636;738.412961695452;827.1273806134529;15017.62455938602;15463.5360939172;16120.516384508453;16405.343786248537;16417.34330626775;14388.928055359735;14692.853071469282;14705.33825977831;14711.48509802157;14730.63173420665;666.4335314982275;687.5771400588627;848.3043903998739;871.542440218887;890.6749036601626;694.8054544727485;848.3891598049426;869.2524428991094;875.5053394831931;884.5665623844302;905.3526728389201;926.8702381666573;928.7445952363087;930.7486978515797;931.6133804471136;696.3036963036963;918.1002617434917;918.6187732091174;921.7234829551174;924.2144177449181;533.3173537871492;645.6061802300593;664.0736173038632;670.9228438729559;673.8281738156787;14433.422663093465;14433.783493247609;14439.711205775931;14461.78307325391;14492.782608260884;13649.11280766747;13947.511837085653;14067.929660351632;14214.715705685932;14252.144871307755;12070.577529786504;12463.314517701523;12502.562410315595;12751.153426934723;12824.422900969479;4282.314829627245;4423.933640995388;4574.290984897346;4614.584687378152;4827.25177597473;124003.75996240013;124626;125211;125253.37373313075;126313;10350.275480716278;11024.724381890517;11236.831447528293;11338.773224535464;11377.203595748384;22223.77776222217;22241.22155724542;22246.777532224794;22250.221242256444;22287.219947301768;7521.435892308099;7739.419543534257;7806.492577982526;8132.471389359673;8194.795130121795;4365.301551751704;4455.9647005283105;4475.888102797391;4487.259602165672;4494.617957473586;3469.080693616194;3610.4403817408343;3612.1150318172217;3614.512040874501;3615.7288203384323;646.3084499585492;650;655.5345704549823;656.4354654996699;693.0782059860475;535.5929493584904;614.1800696070795;620.4395944200339;626.9842854575617;640.9391107844747;8141.918580814235;9124.863127053099;9186.540672966325;9266.721998340061;9317.72046838596;511.5671567948412;557.7462254674114;588.1824264272665;590.5423296944816;610.5725991805665;4129.772862492592;4418.337249412614;4510.323451482304;4512.390827238347;4540.341650460665;123986;126175;128628.07057893951;141910;172444;124460.37769811093;124649;126333;126873;128155;70200.6489967547;92418.53790731003;105290;111055.44472277748;116559.41720291345;7471.850562988819;9808.264380171373;9988.650397236062;9993.650222242186;10061.647842325483;50677;63295;64613.35386646073;64691.67654161699;67390.66304668445;92115;98632;99809;99987.00013000068;102088.48955755471;12283;12997.220166790023;13041.413136408695;13109.541166059142;13142.40859161321;14284.57146285613;14343.56969290923;14365.425382984982;14636.780448293071;14898.1806000671;13328.33358332099;13948.442062317394;13953.651158721113;14009.369578368794;14270.714585708436;13394.057861609817;13939.930300348433;13962.720745584827;14525.055871368328;14574.417023319373;13655.931720341334;13712.725745485233;14137.293135343398;14236.430542778588;14242.501512447014;11311.264767790068;11462.432938116997;11599.188056835941;11796.94101529487;11821.172517923662;11444.198906076495;11536;11747.647570572897;11802.645920622395;11807.940960295144 03:20:48 INFO - PROCESS | 1961 | __end_tp_report 03:20:48 INFO - PROCESS | 1961 | __start_cc_report 03:20:48 INFO - PROCESS | 1961 | _x_x_mozilla_cycle_collect,1165 03:20:48 INFO - PROCESS | 1961 | __end_cc_report 03:20:48 INFO - PROCESS | 1961 | __startTimestamp1474798848177__endTimestamp 03:20:48 INFO - PROCESS | 1961 | 03:20:48 INFO - PROCESS | 1961 | ------- Summary: start ------- 03:20:48 INFO - PROCESS | 1961 | Number of tests: 6 03:20:48 INFO - PROCESS | 1961 | 03:20:48 INFO - PROCESS | 1961 | [#0] dojo.html Cycles:165 Average:5668.31 Median:5802.36 stddev:657.77 (11.3%) stddev-sans-first:618.94 03:20:48 INFO - PROCESS | 1961 | Values: 2759.3 3295.8 3323.0 3356.3 3380.9 5591.2 5637.7 5650.7 5672.1 5690.2 5565.3 5600.7 5668.6 5681.4 5741.1 5140.5 5163.4 5172.9 5191.0 5208.3 5087.5 5104.5 5112.1 5269.2 5347.5 5174.2 5187.7 5191.9 5193.6 5227.2 5212.6 5227.9 5265.6 5288.9 5329.0 5033.0 5106.6 5198.1 5206.2 5222.7 4653.8 5532.8 5576.4 5589.6 5632.6 6123.8 6128.5 6158.7 6203.0 6217.8 6173.5 6239.9 6248.6 6258.0 6273.1 5602.7 5643.2 5666.0 5681.2 5721.3 6253.5 6269.5 6278.2 6295.7 6321.5 6068.9 6075.1 6079.1 6081.6 6094.2 6079.1 6109.6 6119.8 6135.8 6164.5 6120.9 6159.6 6169.9 6178.5 6184.8 6104.1 6167.3 6178.9 6195.1 6198.0 4804.5 4839.1 4844.3 4894.6 4928.4 4335.2 4395.4 4403.8 4410.3 4465.6 5738.6 5764.2 5778.5 5781.2 5790.0 6045.0 6225.1 6236.2 6238.7 6243.6 5642.1 5655.9 5707.7 5716.1 5741.4 5316.8 5351.2 5368.4 5369.9 5371.8 6336.6 6341.5 6341.6 6345.4 6348.2 6074.7 6115.8 6142.7 6195.5 6279.2 6335.6 6336.1 6343.5 6358.6 6359.8 6035.8 6070.9 6093.2 6120.6 6151.8 5015.4 6189.7 6263.6 6263.6 6266.9 6018.4 6031.2 6036.1 6046.5 6053.2 4926.7 5802.4 5836.0 5914.8 5947.8 5847.8 5852.1 5852.1 5866.3 5890.6 4949.0 6037.7 6038.7 6043.1 6060.7 5119.3 5716.8 5762.5 5784.4 5823.9 03:20:48 INFO - PROCESS | 1961 | 03:20:48 INFO - PROCESS | 1961 | [#1] ext.html Cycles:180 Average:69763.99 Median:38281.12 stddev:152282.73 (397.8%) stddev-sans-first:152621.03 03:20:48 INFO - PROCESS | 1961 | Values: 461.0 475.9 480.5 495.6 507.4 28142.0 40390.4 41307.6 41342.4 43579.8 43332.8 43668.3 43706.0 43828.8 43849.0 8608.6 9727.1 9920.4 9929.1 9932.6 8638.6 8851.7 8857.8 8871.2 11813.2 11878.5 12162.5 12178.4 12179.1 12215.3 12115.9 12198.5 12200.4 12221.5 12228.5 8586.9 8786.9 8794.7 8936.2 12029.4 37679.1 39478.6 39849.8 39855.0 42241.6 3448.7 3569.3 3697.1 3950.8 3951.6 30438.1 30864.7 31295.5 32232.4 33201.8 3179.6 3237.1 3290.9 3335.4 3392.8 497763.0 498130.0 498150.0 498850.0 504126.0 53286.7 54407.7 54621.7 63772.4 64350.7 66192.3 66310.3 66561.0 66655.0 66693.7 16822.1 17038.0 17044.1 17049.3 17060.4 12903.6 13010.7 13015.7 13017.0 13023.5 13435.2 16411.7 16672.0 18902.2 19354.6 6542.7 6617.0 7760.3 7852.5 7871.5 857.4 982.2 988.6 1059.2 1113.1 29768.9 29841.9 30346.5 30519.4 30770.5 1026.5 1032.2 1039.8 1067.4 1175.7 14605.2 15243.7 15261.5 15362.3 15558.7 675127.0 677818.0 680659.0 681501.0 682219.0 48652.0 49338.5 55771.6 56248.4 56289.4 1338.8 1363.4 1382.2 1384.9 1386.0 24010.9 29605.0 30391.7 30437.8 30667.7 41470.8 50421.2 50447.7 50465.0 50481.0 511138.0 511949.0 513034.0 513277.0 513661.0 21850.6 25833.5 26162.6 26517.2 26531.5 45682.5 45956.3 46494.1 46792.5 46845.0 36180.8 37728.6 38298.6 38323.8 38484.2 37093.0 38209.0 38263.6 39263.8 39328.0 36338.0 37494.4 40037.4 40439.0 40446.2 32453.0 34266.0 34794.5 34985.8 35104.1 25587.7 25657.9 25661.7 25790.4 26169.6 03:20:48 INFO - PROCESS | 1961 | 03:20:48 INFO - PROCESS | 1961 | [#2] jquery.html Cycles:180 Average:35728.24 Median:388.10 stddev:105420.33 (27162.9%) stddev-sans-first:105682.59 03:20:48 INFO - PROCESS | 1961 | Values: 345.6 353.9 374.3 380.2 396.0 13980.5 14315.0 16338.0 21054.6 21458.4 20382.6 20427.8 21005.9 21026.9 21231.9 4918.4 5939.4 6252.6 6254.4 6266.0 6112.1 6161.7 6217.3 6226.4 6233.0 6048.9 6092.1 6127.6 6171.2 6176.8 5900.7 6077.6 6080.8 6084.8 6086.5 5172.5 5273.4 5429.2 5487.7 5533.9 12660.8 12757.1 12781.9 12922.9 12929.5 2228.9 2244.7 2252.0 2346.0 2356.7 9497.6 9646.3 9654.1 10146.3 10310.7 1834.9 1837.0 1857.2 1899.2 1940.5 117139.8 124917.0 132977.0 133147.0 137167.3 10473.8 11171.9 11536.5 11770.6 12135.3 14502.8 14527.9 14528.0 14529.8 14544.2 7448.6 8318.1 8559.3 8602.3 8752.3 8423.2 8651.0 8679.9 8842.2 8842.4 3566.9 3756.5 4529.8 4555.5 4633.7 1604.5 1628.5 1873.6 1901.0 1947.5 884.2 911.3 927.9 947.3 974.3 19165.9 20072.1 21524.5 21540.0 21656.6 929.7 937.3 946.9 948.6 950.8 10896.4 11137.5 11238.7 11369.9 11946.3 623349.0 629665.0 631663.0 633572.0 635481.0 67784.7 132252.0 134700.3 141449.0 146501.0 905.5 970.7 997.1 999.4 999.4 18624.2 18816.5 19184.3 19207.6 19240.9 44744.0 57178.7 57180.7 58183.0 58185.4 77503.6 79590.0 79657.0 79997.0 86965.0 7077.9 7163.7 7258.6 7475.6 7654.5 7185.9 8950.2 9774.8 11383.9 12979.1 10752.7 10889.8 11229.0 11307.6 11339.9 10864.8 10908.2 10974.5 11307.3 11419.7 9878.9 11141.7 11350.0 11696.2 11781.7 5284.5 7334.9 7353.5 7420.7 7455.8 8451.9 9081.4 11079.8 11268.0 11467.3 03:20:48 INFO - PROCESS | 1961 | 03:20:48 INFO - PROCESS | 1961 | [#3] mootools.html Cycles:180 Average:5769.86 Median:2726.19 stddev:3331.93 (122.2%) stddev-sans-first:3324.79 03:20:48 INFO - PROCESS | 1961 | Values: 1359.5 1516.8 1524.2 1726.5 1889.8 8005.7 8309.7 8570.3 9148.0 9174.6 9017.1 9088.2 9091.9 9096.0 9118.5 2392.5 2427.5 2430.0 2430.6 2431.8 2105.6 2381.8 2394.9 2407.6 2429.6 2392.5 2414.9 2418.3 2428.1 2430.0 2190.9 2231.8 2369.4 2391.5 2407.4 2362.5 2384.5 2395.0 2396.2 2397.1 8930.9 9094.4 9094.8 9191.4 9201.4 4449.9 5529.3 5540.6 5547.1 5547.4 3626.4 3675.4 3704.9 3734.4 3747.8 825.0 1096.4 1107.6 1123.2 1132.9 12056.3 12153.8 12173.1 12190.5 12192.8 4044.0 4072.5 4594.5 4780.2 4795.6 9390.6 9397.0 9403.4 9412.9 9417.7 5341.0 5350.5 5350.7 5352.4 5366.6 4513.7 4563.1 4633.0 4970.1 4993.9 3305.6 3860.2 3863.1 3944.8 3964.8 1172.7 1174.0 1178.3 1189.3 1197.9 637.3 788.0 892.5 929.1 961.0 5891.2 5954.3 6002.6 6027.8 6117.7 464.0 480.1 481.5 482.3 641.0 3856.7 4058.6 4076.2 4080.2 4178.9 10540.9 11310.8 11418.2 11420.7 11434.2 11168.9 11195.0 11385.5 11387.3 11412.8 8355.0 8542.3 8559.5 8560.6 8589.5 5772.5 5845.0 5980.4 5981.1 6039.2 9434.2 9868.4 10105.3 10391.2 10591.4 10632.9 10692.4 10703.8 10720.8 10722.1 6889.1 6964.8 6969.6 6971.0 6974.9 8370.1 8376.9 8453.2 8463.8 8548.4 7600.7 7630.8 7684.6 7724.3 7820.5 5955.5 6630.2 7366.6 7542.4 7552.1 6305.2 6791.5 7083.7 7156.4 7226.9 5055.0 5076.4 5120.1 5128.7 5218.9 4468.7 5063.8 5068.9 5092.9 5125.4 03:20:48 INFO - PROCESS | 1961 | 03:20:48 INFO - PROCESS | 1961 | [#4] prototype.html Cycles:180 Average:4406.05 Median:4951.77 stddev:1350.68 (27.3%) stddev-sans-first:1318.84 03:20:48 INFO - PROCESS | 1961 | Values: 299.9 303.5 311.7 319.4 321.1 4645.5 4938.8 4977.1 5206.0 5256.6 3901.9 4875.1 5171.5 5188.7 5193.2 3472.9 3943.3 4004.7 4066.1 4114.2 3583.7 3770.2 4051.5 4069.6 4080.4 2978.7 3991.2 3994.2 4039.2 4046.9 3274.8 3331.5 3401.9 3711.8 4038.0 2922.7 3468.8 3496.7 3506.8 3550.2 4336.3 4808.7 4963.9 5038.4 5047.6 3830.7 4248.6 4518.7 4632.9 4638.6 4506.3 4520.8 4571.7 5446.2 5487.5 2944.6 3400.6 3710.8 3843.0 3943.9 4803.0 5750.6 5756.9 5757.9 5782.1 3885.7 3899.6 3917.9 3933.0 3938.0 3835.7 3977.4 3989.2 3998.2 3999.8 3794.3 4515.5 4528.7 4543.7 4633.2 4748.2 5051.5 5479.0 5494.9 5518.7 1267.3 1311.7 1317.4 1333.7 1358.8 919.7 948.8 952.4 958.2 960.2 4417.5 4968.4 4990.3 5104.2 5200.3 5483.5 5639.2 5695.9 5697.5 5726.8 4381.5 4818.6 4837.5 5063.0 5141.5 2294.8 2902.0 2930.9 2931.8 2941.8 4707.8 4939.6 5793.8 5821.4 5854.2 5181.7 5362.8 5699.1 5701.8 5713.6 5487.9 5764.3 5821.9 5856.2 5863.8 5185.8 5408.6 5521.5 5558.6 5562.7 4565.2 5465.5 5495.9 5508.5 5534.4 5542.4 5545.2 5715.5 5797.4 5879.5 3319.8 3459.9 3801.8 3879.2 3920.1 5146.8 5235.9 5513.3 5556.6 5600.4 4777.6 5271.4 5432.4 5468.0 5481.4 5057.2 5082.9 5342.5 5352.1 5393.6 4350.9 4877.5 5103.1 5160.7 5272.7 5453.5 5486.8 5495.5 5530.8 5559.5 5072.7 5346.9 5355.6 5358.4 5426.3 03:20:48 INFO - PROCESS | 1961 | 03:20:48 INFO - PROCESS | 1961 | [#5] yui.html Cycles:180 Average:24918.50 Median:3539.76 stddev:39423.57 (1113.7%) stddev-sans-first:39492.05 03:20:48 INFO - PROCESS | 1961 | Values: 651.4 682.0 712.5 738.4 827.1 15017.6 15463.5 16120.5 16405.3 16417.3 14388.9 14692.9 14705.3 14711.5 14730.6 666.4 687.6 848.3 871.5 890.7 694.8 848.4 869.3 875.5 884.6 905.4 926.9 928.7 930.7 931.6 696.3 918.1 918.6 921.7 924.2 533.3 645.6 664.1 670.9 673.8 14433.4 14433.8 14439.7 14461.8 14492.8 13649.1 13947.5 14067.9 14214.7 14252.1 12070.6 12463.3 12502.6 12751.2 12824.4 4282.3 4423.9 4574.3 4614.6 4827.3 124003.8 124626.0 125211.0 125253.4 126313.0 10350.3 11024.7 11236.8 11338.8 11377.2 22223.8 22241.2 22246.8 22250.2 22287.2 7521.4 7739.4 7806.5 8132.5 8194.8 4365.3 4456.0 4475.9 4487.3 4494.6 3469.1 3610.4 3612.1 3614.5 3615.7 646.3 650.0 655.5 656.4 693.1 535.6 614.2 620.4 627.0 640.9 8141.9 9124.9 9186.5 9266.7 9317.7 511.6 557.7 588.2 590.5 610.6 4129.8 4418.3 4510.3 4512.4 4540.3 123986.0 126175.0 128628.1 141910.0 172444.0 124460.4 124649.0 126333.0 126873.0 128155.0 70200.6 92418.5 105290.0 111055.4 116559.4 7471.9 9808.3 9988.7 9993.7 10061.6 50677.0 63295.0 64613.4 64691.7 67390.7 92115.0 98632.0 99809.0 99987.0 102088.5 12283.0 12997.2 13041.4 13109.5 13142.4 14284.6 14343.6 14365.4 14636.8 14898.2 13328.3 13948.4 13953.7 14009.4 14270.7 13394.1 13939.9 13962.7 14525.1 14574.4 13655.9 13712.7 14137.3 14236.4 14242.5 11311.3 11462.4 11599.2 11796.9 11821.2 11444.2 11536.0 11747.6 11802.6 11807.9 03:20:48 INFO - PROCESS | 1961 | -------- Summary: end -------- 03:20:48 INFO - PROCESS | 1961 | 03:20:48 INFO - TEST-INFO | 1961: exit 0 03:20:48 INFO - TEST-OK | dromaeo_css | took 1117114ms 03:20:48 INFO - TEST-START | kraken 03:20:48 INFO - operating with platform_type : mac_ 03:20:48 INFO - Initialising browser for kraken test... 03:20:48 INFO - TEST-INFO | started process 1968 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/tmpJQ6LU9/profile http://localhost:52092/getInfo.html) 03:20:51 INFO - PROCESS | 1968 | __metrics Screen width/height:1600/1200 03:20:51 INFO - PROCESS | 1968 | colorDepth:24 03:20:51 INFO - PROCESS | 1968 | Browser inner width/height: 1024/689 03:20:51 INFO - PROCESS | 1968 | __metrics 03:20:51 INFO - PROCESS | 1968 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:20:51 INFO - PROCESS | 1968 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:20:52 INFO - TEST-INFO | 1968: exit 0 03:20:52 INFO - Browser initialized. 03:20:52 INFO - Running cycle 1/1 for kraken test... 03:20:52 INFO - TEST-INFO | started process 1969 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/tmpJQ6LU9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:21:04 INFO - PROCESS | 1969 | RSS: Main: 219881472 03:21:04 INFO - PROCESS | 1969 | 03:21:06 INFO - PROCESS | 1969 | Cycle 1(1): loaded http://localhost:52092/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52092/tests/kraken/driver.html?testName=audio-beat-detection) 03:21:07 INFO - PROCESS | 1969 | RSS: Main: 269578240 03:21:07 INFO - PROCESS | 1969 | 03:21:10 INFO - PROCESS | 1969 | Cycle 1(1): loaded http://localhost:52092/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52092/tests/kraken/driver.html?testName=audio-dft) 03:21:10 INFO - PROCESS | 1969 | RSS: Main: 281714688 03:21:10 INFO - PROCESS | 1969 | 03:21:14 INFO - PROCESS | 1969 | Cycle 1(1): loaded http://localhost:52092/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52092/tests/kraken/driver.html?testName=audio-fft) 03:21:14 INFO - PROCESS | 1969 | RSS: Main: 378724352 03:21:14 INFO - PROCESS | 1969 | 03:21:16 INFO - PROCESS | 1969 | Cycle 1(1): loaded http://localhost:52092/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52092/tests/kraken/driver.html?testName=audio-oscillator) 03:21:17 INFO - PROCESS | 1969 | RSS: Main: 280506368 03:21:17 INFO - PROCESS | 1969 | 03:21:19 INFO - PROCESS | 1969 | Cycle 1(1): loaded http://localhost:52092/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52092/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:21:20 INFO - PROCESS | 1969 | RSS: Main: 280645632 03:21:20 INFO - PROCESS | 1969 | 03:21:22 INFO - PROCESS | 1969 | Cycle 1(1): loaded http://localhost:52092/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52092/tests/kraken/driver.html?testName=imaging-darkroom) 03:21:23 INFO - PROCESS | 1969 | RSS: Main: 319397888 03:21:23 INFO - PROCESS | 1969 | 03:21:26 INFO - PROCESS | 1969 | Cycle 1(1): loaded http://localhost:52092/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52092/tests/kraken/driver.html?testName=imaging-desaturate) 03:21:26 INFO - PROCESS | 1969 | RSS: Main: 320360448 03:21:26 INFO - PROCESS | 1969 | 03:21:29 INFO - PROCESS | 1969 | Cycle 1(1): loaded http://localhost:52092/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52092/tests/kraken/driver.html?testName=json-parse-financial) 03:21:30 INFO - PROCESS | 1969 | RSS: Main: 318246912 03:21:30 INFO - PROCESS | 1969 | 03:21:31 INFO - PROCESS | 1969 | Cycle 1(1): loaded http://localhost:52092/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52092/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:21:32 INFO - PROCESS | 1969 | RSS: Main: 295419904 03:21:32 INFO - PROCESS | 1969 | 03:21:34 INFO - PROCESS | 1969 | Cycle 1(1): loaded http://localhost:52092/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52092/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:21:35 INFO - PROCESS | 1969 | RSS: Main: 298467328 03:21:35 INFO - PROCESS | 1969 | 03:21:37 INFO - PROCESS | 1969 | Cycle 1(1): loaded http://localhost:52092/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52092/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:21:37 INFO - PROCESS | 1969 | RSS: Main: 297525248 03:21:37 INFO - PROCESS | 1969 | 03:21:40 INFO - PROCESS | 1969 | Cycle 1(1): loaded http://localhost:52092/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52092/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:21:41 INFO - PROCESS | 1969 | RSS: Main: 312766464 03:21:41 INFO - PROCESS | 1969 | 03:21:44 INFO - PROCESS | 1969 | Cycle 1(1): loaded http://localhost:52092/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52092/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:21:44 INFO - PROCESS | 1969 | RSS: Main: 308981760 03:21:44 INFO - PROCESS | 1969 | 03:21:46 INFO - PROCESS | 1969 | Cycle 1(1): loaded http://localhost:52092/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52092/tests/kraken/driver.html?testName=ai-astar) 03:21:46 INFO - PROCESS | 1969 | RSS: Main: 352395264 03:21:46 INFO - PROCESS | 1969 | 03:21:46 INFO - PROCESS | 1969 | __start_tp_report 03:21:46 INFO - PROCESS | 1969 | _x_x_mozilla_page_load 03:21:46 INFO - PROCESS | 1969 | _x_x_mozilla_page_load_details 03:21:46 INFO - PROCESS | 1969 | |i|pagename|runs| 03:21:46 INFO - PROCESS | 1969 | |0;ai-astar;113;112;111;117;165;118;112;112;112;111 03:21:46 INFO - PROCESS | 1969 | |1;audio-beat-detection;143;106;93;162;139;141;124;107;140;107 03:21:46 INFO - PROCESS | 1969 | |2;audio-dft;184;185;183;186;185;183;184;188;254;235 03:21:46 INFO - PROCESS | 1969 | |3;audio-fft;83;59;58;90;61;61;73;82;109;58 03:21:46 INFO - PROCESS | 1969 | |4;audio-oscillator;87;72;95;69;67;68;92;67;68;93 03:21:46 INFO - PROCESS | 1969 | |5;imaging-gaussian-blur;91;84;87;85;86;84;88;84;86;84 03:21:46 INFO - PROCESS | 1969 | |6;imaging-darkroom;96;95;96;108;96;96;97;96;96;95 03:21:46 INFO - PROCESS | 1969 | |7;imaging-desaturate;84;85;88;84;84;84;90;131;85;85 03:21:46 INFO - PROCESS | 1969 | |8;json-parse-financial;52;50;52;51;56;56;56;55;59;55 03:21:46 INFO - PROCESS | 1969 | |9;json-stringify-tinderbox;73;68;67;82;75;73;70;69;70;71 03:21:46 INFO - PROCESS | 1969 | |10;stanford-crypto-aes;83;81;82;82;88;85;84;82;86;84 03:21:46 INFO - PROCESS | 1969 | |11;stanford-crypto-ccm;148;132;127;149;152;152;160;156;187;137 03:21:46 INFO - PROCESS | 1969 | |12;stanford-crypto-pbkdf2;162;162;162;163;164;165;166;163;165;164 03:21:46 INFO - PROCESS | 1969 | |13;stanford-crypto-sha256-iterative;67;68;67;67;66;65;66;68;64;64 03:21:46 INFO - PROCESS | 1969 | __end_tp_report 03:21:46 INFO - PROCESS | 1969 | __start_cc_report 03:21:46 INFO - PROCESS | 1969 | _x_x_mozilla_cycle_collect,1936 03:21:46 INFO - PROCESS | 1969 | __end_cc_report 03:21:46 INFO - PROCESS | 1969 | __startTimestamp1474798906876__endTimestamp 03:21:46 INFO - PROCESS | 1969 | 03:21:46 INFO - PROCESS | 1969 | ------- Summary: start ------- 03:21:46 INFO - PROCESS | 1969 | Number of tests: 14 03:21:46 INFO - PROCESS | 1969 | 03:21:46 INFO - PROCESS | 1969 | [#0] ai-astar Cycles:10 Average:118.30 Median:112.50 stddev:16.59 (14.7%) stddev-sans-first:17.48 03:21:46 INFO - PROCESS | 1969 | Values: 113.0 112.0 111.0 117.0 165.0 118.0 112.0 112.0 112.0 111.0 03:21:46 INFO - PROCESS | 1969 | 03:21:46 INFO - PROCESS | 1969 | [#1] audio-beat-detection Cycles:10 Average:126.20 Median:140.50 stddev:22.08 (15.7%) stddev-sans-first:22.57 03:21:46 INFO - PROCESS | 1969 | Values: 143.0 106.0 93.0 162.0 139.0 141.0 124.0 107.0 140.0 107.0 03:21:46 INFO - PROCESS | 1969 | 03:21:46 INFO - PROCESS | 1969 | [#2] audio-dft Cycles:10 Average:196.70 Median:185.50 stddev:25.63 (13.8%) stddev-sans-first:26.77 03:21:46 INFO - PROCESS | 1969 | Values: 184.0 185.0 183.0 186.0 185.0 183.0 184.0 188.0 254.0 235.0 03:21:46 INFO - PROCESS | 1969 | 03:21:46 INFO - PROCESS | 1969 | [#3] audio-fft Cycles:10 Average:73.40 Median:67.00 stddev:17.32 (25.8%) stddev-sans-first:18.01 03:21:46 INFO - PROCESS | 1969 | Values: 83.0 59.0 58.0 90.0 61.0 61.0 73.0 82.0 109.0 58.0 03:21:46 INFO - PROCESS | 1969 | 03:21:46 INFO - PROCESS | 1969 | [#4] audio-oscillator Cycles:10 Average:77.80 Median:79.50 stddev:12.25 (15.4%) stddev-sans-first:12.53 03:21:46 INFO - PROCESS | 1969 | Values: 87.0 72.0 95.0 69.0 67.0 68.0 92.0 67.0 68.0 93.0 03:21:46 INFO - PROCESS | 1969 | 03:21:46 INFO - PROCESS | 1969 | [#5] imaging-gaussian-blur Cycles:10 Average:85.90 Median:86.00 stddev:2.28 (2.7%) stddev-sans-first:1.50 03:21:46 INFO - PROCESS | 1969 | Values: 91.0 84.0 87.0 85.0 86.0 84.0 88.0 84.0 86.0 84.0 03:21:46 INFO - PROCESS | 1969 | 03:21:46 INFO - PROCESS | 1969 | [#6] imaging-darkroom Cycles:10 Average:97.10 Median:96.00 stddev:3.87 (4.0%) stddev-sans-first:4.09 03:21:46 INFO - PROCESS | 1969 | Values: 96.0 95.0 96.0 108.0 96.0 96.0 97.0 96.0 96.0 95.0 03:21:46 INFO - PROCESS | 1969 | 03:21:46 INFO - PROCESS | 1969 | [#7] imaging-desaturate Cycles:10 Average:90.00 Median:85.00 stddev:14.54 (17.1%) stddev-sans-first:15.26 03:21:46 INFO - PROCESS | 1969 | Values: 84.0 85.0 88.0 84.0 84.0 84.0 90.0 131.0 85.0 85.0 03:21:46 INFO - PROCESS | 1969 | 03:21:46 INFO - PROCESS | 1969 | [#8] json-parse-financial Cycles:10 Average:54.20 Median:55.50 stddev:2.82 (5.1%) stddev-sans-first:2.88 03:21:46 INFO - PROCESS | 1969 | Values: 52.0 50.0 52.0 51.0 56.0 56.0 56.0 55.0 59.0 55.0 03:21:46 INFO - PROCESS | 1969 | 03:21:46 INFO - PROCESS | 1969 | [#9] json-stringify-tinderbox Cycles:10 Average:71.80 Median:72.00 stddev:4.34 (6.0%) stddev-sans-first:4.58 03:21:46 INFO - PROCESS | 1969 | Values: 73.0 68.0 67.0 82.0 75.0 73.0 70.0 69.0 70.0 71.0 03:21:46 INFO - PROCESS | 1969 | 03:21:46 INFO - PROCESS | 1969 | [#10] stanford-crypto-aes Cycles:10 Average:83.70 Median:84.00 stddev:2.16 (2.6%) stddev-sans-first:2.28 03:21:46 INFO - PROCESS | 1969 | Values: 83.0 81.0 82.0 82.0 88.0 85.0 84.0 82.0 86.0 84.0 03:21:46 INFO - PROCESS | 1969 | 03:21:46 INFO - PROCESS | 1969 | [#11] stanford-crypto-ccm Cycles:10 Average:150.00 Median:152.00 stddev:16.80 (11.1%) stddev-sans-first:17.80 03:21:46 INFO - PROCESS | 1969 | Values: 148.0 132.0 127.0 149.0 152.0 152.0 160.0 156.0 187.0 137.0 03:21:46 INFO - PROCESS | 1969 | 03:21:46 INFO - PROCESS | 1969 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.60 Median:164.00 stddev:1.43 (0.9%) stddev-sans-first:1.39 03:21:46 INFO - PROCESS | 1969 | Values: 162.0 162.0 162.0 163.0 164.0 165.0 166.0 163.0 165.0 164.0 03:21:46 INFO - PROCESS | 1969 | 03:21:46 INFO - PROCESS | 1969 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.20 Median:67.00 stddev:1.48 (2.2%) stddev-sans-first:1.54 03:21:46 INFO - PROCESS | 1969 | Values: 67.0 68.0 67.0 67.0 66.0 65.0 66.0 68.0 64.0 64.0 03:21:46 INFO - PROCESS | 1969 | -------- Summary: end -------- 03:21:46 INFO - PROCESS | 1969 | 03:21:47 INFO - TEST-INFO | 1969: exit 0 03:21:47 INFO - TEST-OK | kraken | took 59022ms 03:21:47 INFO - SUITE-END | took 1176s 03:21:48 INFO - Completed test suite (00:19:36) 03:21:48 INFO - javascript benchmark 03:21:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2759.3377589378547, 3295.8187299698507, 3323.0363194673546, 3356.2784001439686, 3380.8816691415805, 5591.217229587861, 5637.661740295585, 5650.6892120933435, 5672.064109421945, 5690.231818704468, 5565.332160140789, 5600.747966341514, 5668.57485688573, 5681.431856814316, 5741.110127930177, 5140.460251673567, 5163.406208286057, 5172.948270517284, 5191.0, 5208.2968799212, 5087.49125087492, 5104.464031276718, 5112.079825631385, 5269.156934890419, 5347.54545863602, 5174.172132458807, 5187.688738675692, 5191.870203244911, 5193.63644544882, 5227.18978558324, 5212.556932660747, 5227.869303267411, 5265.578753699733, 5288.867778305573, 5328.987492376436, 5033.043721692867, 5106.64253502255, 5198.064348417283, 5206.245094461282, 5222.738863056832, 4653.767311634405, 5532.834014979557, 5576.358718747356, 5589.580781441408, 5632.605717599769, 6123.785667501616, 6128.479079278267, 6158.692065396713, 6202.96898515509, 6217.751289948396, 6173.536984726164, 6239.906401403982, 6248.625082495019, 6258.030005349178, 6273.05904114382, 5602.691851948141, 5643.181738647873, 5665.9716701417055, 5681.17622944679, 5721.284839395075, 6253.53098517613, 6269.486139586842, 6278.183836101369, 6295.685215739195, 6321.462675672619, 6068.90759663256, 6075.058365953284, 6079.118527813443, 6081.6351018939, 6094.238220222473, 6079.148919151322, 6109.572329936951, 6119.84700382494, 6135.754569817246, 6164.506839452833, 6120.938790612036, 6159.630422174684, 6169.938300616936, 6178.505719542426, 6184.81445556625, 6104.145419641165, 6167.321594624587, 6178.907316390258, 6195.070739389128, 6197.96901015492, 4804.471508134103, 4839.128956787742, 4844.32179494871, 4894.583960363409, 4928.359313289249, 4335.176316499855, 4395.428594282723, 4403.8238470461465, 4410.294352903584, 4465.642748580106, 5738.598298119092, 5764.221830052973, 5778.479936805707, 5781.219535362672, 5789.971050144806, 6045.0, 6225.066240064027, 6236.18929539157, 6238.656873871981, 6243.594166379171, 5642.069058605366, 5655.886882262332, 5707.714614269353, 5716.056850619684, 5741.397153298927, 5316.787328506894, 5351.197320401893, 5368.355797304349, 5369.892602147936, 5371.811986580451, 6336.556441049174, 6341.524385671001, 6341.587796793194, 6345.397187267202, 6348.238211414659, 6074.66589337573, 6115.755369785159, 6142.723577439116, 6195.473384762346, 6279.183706118175, 6335.619862808247, 6336.144620476177, 6343.492520598434, 6358.618482890856, 6359.8092057238355, 6035.818925432244, 6070.878582428415, 6093.177421048102, 6120.60216085953, 6151.83115208109, 5015.448300686994, 6189.690515474118, 6263.56155069159, 6263.592866463848, 6266.874662506633, 6018.428249316308, 6031.215941927521, 6036.124761909587, 6046.546509011754, 6053.152558641882, 4926.679765815211, 5802.361740208658, 5836.037053886062, 5914.792982245601, 5947.762089516371, 5847.766089356548, 5852.092925596539, 5852.092925596539, 5866.2960444746905, 5890.646561206341, 4948.975255123845, 6037.728302226323, 6038.6678732670125, 6043.09353596964, 6060.6969651516365, 5119.334486516729, 5716.79991200306, 5762.510186634183, 5784.363719990713, 5823.854403639943], "value": 5625.491252542889, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [460.98583117142294, 475.8905451746098, 480.5434836904941, 495.60104116186454, 507.4114027727834, 28142.0, 40390.39414408786, 41307.58692413075, 41342.37986430202, 43579.78210108945, 43332.783336083274, 43668.344974825406, 43706.0, 43828.78085609576, 43849.0, 8608.56957152143, 9727.075927786867, 9920.355176913514, 9929.056739609725, 9932.553035113437, 8638.611262493203, 8851.690190843321, 8857.778555536132, 8871.157240062184, 11813.23213991092, 11878.524859005673, 12162.513499460056, 12178.391080445987, 12179.086568507353, 12215.328156951364, 12115.878841211563, 12198.536175658977, 12200.389980500939, 12221.511139554406, 12228.510859565607, 8586.87119693205, 8786.86819697705, 8794.736157915273, 8936.240419564345, 12029.39853007355, 37679.058023549354, 39478.60521394807, 39849.80075099635, 39855.0, 42241.57758422407, 3448.7241020718284, 3569.3218288525095, 3697.0798930916926, 3950.822213000422, 3951.644352008333, 30438.086857394315, 30864.69135308663, 31295.53056704151, 32232.355352893046, 33201.837935672134, 3179.60254968129, 3237.093613788143, 3290.851911663981, 3335.382954153489, 3392.8303584820906, 497763.0, 498130.0, 498150.0, 498850.0, 504126.0, 53286.733566332696, 54407.72796136073, 54621.72689136529, 63772.36227637664, 64350.67824660847, 66192.33807661958, 66310.33689663041, 66561.0, 66655.0, 66693.666531668, 16822.07478588665, 17038.0, 17044.06257655841, 17049.31802727877, 17060.402885898933, 12903.612891613267, 13010.674733131558, 13015.674608134683, 13017.023723220607, 13023.47906083746, 13435.19388836673, 16411.671766564603, 16672.0, 18902.243910243713, 19354.612907741765, 6542.672866356663, 6617.04052912325, 7760.262775036363, 7852.450328477066, 7871.527708337404, 857.4298091769028, 982.2240430060173, 988.5650313861878, 1059.2003037706481, 1113.1095123900848, 29768.851155744083, 29841.850790746343, 30346.54480182755, 30519.389612207633, 30770.53844192339, 1026.5431882812077, 1032.1897310611134, 1039.7972395382828, 1067.40758878823, 1175.6766889105565, 14605.196714180822, 15243.74709646484, 15261.542153735405, 15362.308696108701, 15558.688826223412, 675127.0, 677818.0, 680659.0, 681501.0, 682219.0, 48652.0, 49338.51984440473, 55771.60570985758, 56248.43751562514, 56289.43710562924, 1338.805873148388, 1363.4478036395078, 1382.2052319915888, 1384.9030567860152, 1385.9653508662363, 24010.87994560016, 29605.0, 30391.696083038885, 30437.847810760806, 30667.693323066484, 41470.79264603658, 50421.24368134554, 50447.74776126096, 50464.99070018653, 50481.0, 511138.0, 511949.0, 513034.0, 513277.0, 513661.0, 21850.562988740454, 25833.483330333664, 26162.607560886223, 26517.204483865517, 26531.469370612867, 45682.54317456916, 45956.31065533953, 46494.070118598116, 46792.53207468018, 46845.0, 36180.81909590435, 37728.62271377251, 38298.617013829506, 38323.80838095903, 38484.230315394096, 37093.0, 38209.0, 38263.61736382712, 39263.80368098256, 39328.0, 36338.0, 37494.43758343682, 40037.39943900786, 40439.0, 40446.1910761789, 32453.0, 34266.0, 34794.478082828275, 34985.82507087448, 35104.12239694028, 25587.744122558535, 25657.871710641328, 25661.743382565935, 25790.355241119123, 26169.607455887795], "value": 20141.070619391805, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [345.56976564177603, 353.8920629208094, 374.3150035435154, 380.2452132516954, 395.9623835735606, 13980.510682126127, 14315.0, 16338.019718816864, 21054.578908421823, 21458.356249312506, 20382.592348153026, 20427.795722042774, 21005.894970525165, 21026.89486552565, 21231.93840307986, 4918.409790825088, 5939.406059394069, 6252.624842509464, 6254.405831446005, 6265.9686701566425, 6112.113743507211, 6161.661108639023, 6217.316095229544, 6226.43962043416, 6232.968835155818, 6048.939510604903, 6092.08644525665, 6127.632342059468, 6171.197744293258, 6176.84557886052, 5900.734466948976, 6077.6353418795015, 6080.787172448943, 6084.756609735606, 6086.543509236781, 5172.456892026321, 5273.446288139767, 5429.212764149216, 5487.670739755627, 5533.889322213573, 12660.81008784869, 12757.107002509829, 12781.936090319488, 12922.87077129226, 12929.54746583865, 2228.9219877304217, 2244.6745221942892, 2252.0203711385434, 2345.9882700586386, 2356.7289761677457, 9497.572609232531, 9646.276529260334, 9654.131128198496, 10146.289759716823, 10310.690679279634, 1834.8532117430573, 1836.9908150459296, 1857.219967613592, 1899.1833511590012, 1940.4566721318054, 117139.82860171374, 124917.0, 132977.0, 133147.0, 137167.31416342856, 10473.790524189473, 11171.94414027941, 11536.538538458535, 11770.646880593597, 12135.332556709465, 14502.782458263135, 14527.85472145286, 14528.0, 14529.78205326921, 14544.200068996306, 7448.590327532038, 8318.085010648823, 8559.315254779603, 8602.268807151462, 8752.299816014704, 8423.157684231528, 8651.0, 8679.913200868037, 8842.248408885316, 8842.425242359226, 3566.91082722934, 3756.4928734620476, 4529.818807247739, 4555.498895121534, 4633.745144017044, 1604.502604192704, 1628.4707470072274, 1873.5597134673342, 1900.9619807604047, 1947.4936516505811, 884.186548375496, 911.284641556375, 927.8654595083675, 947.2942657720042, 974.3179774158118, 19165.904170479058, 20072.085631392827, 21524.4618884526, 21540.0, 21656.61777204506, 929.6699671616614, 937.2970272295778, 946.9195118415012, 948.6395169835556, 950.814591154732, 10896.40069796153, 11137.498812553455, 11238.719032024264, 11369.919857613513, 11946.283223006647, 623349.0, 629665.0, 631663.0, 633572.0, 635481.0, 67784.6610766943, 132252.0, 134700.3264983669, 141449.0, 146501.0, 905.4522014181457, 970.7476056225432, 997.0926456924165, 999.3504222255592, 999.3703966501204, 18624.161912714233, 18816.52958676044, 19184.328548500736, 19207.615847683246, 19240.903795480932, 44744.0, 57178.71410643087, 57180.714096430915, 58183.0, 58185.41814581969, 77503.61248193723, 79590.0, 79657.0, 79997.0, 86965.0, 7077.893831592633, 7163.713451461883, 7258.564486130849, 7475.551466911785, 7654.502457340255, 7185.856282874418, 8950.23922966529, 9774.80450390974, 11383.886161138282, 12979.091463597835, 10752.677419677422, 10889.836652450062, 11229.0, 11307.604233851776, 11339.886601133883, 10864.837027444753, 10908.2364234506, 10974.506147223234, 11307.265027773497, 11419.657410277705, 9878.85181722289, 11141.721456963316, 11350.0, 11696.181267311547, 11781.705457363634, 5284.471552844839, 7334.889976650248, 7353.485256032241, 7420.666070026754, 7455.776326710207, 8451.915480845359, 9081.364304498622, 11079.833802492807, 11267.985881270724, 11467.31196128235], "value": 9249.657672319303, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1359.4698067753573, 1516.825565060018, 1524.1997951075687, 1726.5338358643166, 1889.7826749923754, 8005.679772809088, 8309.709160179395, 8570.27152692021, 9147.95426022869, 9174.587143578538, 9017.053209413016, 9088.182063614273, 9091.863622045674, 9096.0, 9118.452892826435, 2392.5095355452177, 2427.5387676341525, 2429.9514009719796, 2430.5503481855826, 2431.805455563551, 2105.5788842231536, 2381.8213633977434, 2394.8983467604835, 2407.6027455469825, 2429.5626787178303, 2392.473655795731, 2414.9275521734376, 2418.2503423938547, 2428.101602407112, 2430.0, 2190.882649848573, 2231.7991380775807, 2369.3721163891582, 2391.5456063347997, 2407.434252950555, 2362.4802543440414, 2384.463495713468, 2394.964075538868, 2396.1733202045266, 2397.113068164773, 8930.86603700945, 9094.408863423856, 9094.772630684285, 9191.35660503765, 9201.401908875969, 4449.9110017799785, 5529.25828364064, 5540.639858409231, 5547.140193270049, 5547.44525547446, 3626.38351480249, 3675.3568125577917, 3704.907377315562, 3734.3838266685966, 3747.756395834262, 824.9670013199525, 1096.4024606589428, 1107.6067995861433, 1123.2081382625229, 1132.9263597866113, 12056.276623402624, 12153.756924861542, 12173.147879648428, 12190.51237950481, 12192.81710774339, 4043.9797801010805, 4072.450219220427, 4594.494605593382, 4780.163471392492, 4795.568398844121, 9390.577424015935, 9396.95301523488, 9403.43579385239, 9412.90587094134, 9417.717468475958, 5340.973295133577, 5350.545203657655, 5350.678959262456, 5352.41123476425, 5366.570674346043, 4513.684042117086, 4563.110193512233, 4632.953670463252, 4970.105381031449, 4993.875153121201, 3305.5537502437346, 3860.208657225262, 3863.130795570974, 3944.7830369329963, 3964.7621142731527, 1172.6657902497918, 1173.988260117405, 1178.293024185499, 1189.3339729751367, 1197.9341136237417, 637.3148864970176, 787.9709747400467, 892.4779004282437, 929.0523665860784, 960.9711708648751, 5891.175235467038, 5954.345022047572, 6002.609830361012, 6027.849303767441, 6117.724702388403, 463.98144074237325, 480.1381520171301, 481.4703825791601, 482.27658512231653, 640.9616421397366, 3856.7107466940092, 4058.553559108496, 4076.2255171517318, 4080.163566468867, 4178.874633760992, 10540.894591054144, 11310.773784524263, 11418.200725949104, 11420.714482138013, 11434.199606027665, 11168.944155279172, 11195.009357454772, 11385.487653055632, 11387.316760994367, 11412.828807567894, 8354.997400312002, 8542.273906718, 8559.486430814171, 8560.61477233526, 8589.48463092229, 5772.451617096369, 5844.970775146097, 5980.37206093354, 5981.1327357532045, 6039.184710064261, 9434.198093161884, 9868.358556693793, 10105.292629515863, 10391.168706503613, 10591.364518128938, 10632.89367106319, 10692.358458492516, 10703.785924281627, 10720.839187412039, 10722.142228621848, 6889.138857642794, 6964.79105626832, 6969.58182509051, 6970.965145174242, 6974.895376569254, 8370.079291277832, 8376.916230837614, 8453.196946290092, 8463.830723385374, 8548.358873084419, 7600.657970391235, 7630.7710768677025, 7684.6157692116285, 7724.266194711493, 7820.530768153929, 5955.5235581154275, 6630.204375474974, 7366.594837284001, 7542.396608271215, 7552.131504877009, 6305.2433707953505, 6791.45668346541, 7083.6812343443635, 7156.3917067047805, 7226.891596625949, 5054.974725126351, 5076.441591425014, 5120.052790233819, 5128.666636668605, 5218.8956220876125, 4468.731876087445, 5063.8480845574695, 5068.949310506995, 5092.898142037065, 5125.359330083739], "value": 4531.2108673769735, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [299.8620634508126, 303.54165210532096, 311.6571771051843, 319.37083944629086, 321.12973840891186, 4645.535446455353, 4938.814684475722, 4977.129002424579, 5205.973970130153, 5256.579473642109, 3901.9464744518964, 4875.098106850235, 5171.456997015315, 5188.740562971855, 5193.246979188016, 3472.9305413891707, 3943.3493473576827, 4004.7373234122774, 4066.146109317047, 4114.156597897439, 3583.677469027787, 3770.151715863922, 4051.4530538377235, 4069.5553078657094, 4080.3879418087226, 2978.7170218829283, 3991.181807729423, 3994.2011597680435, 4039.151778126597, 4046.9190616187657, 3274.8035117893, 3331.4836200388977, 3401.911388355727, 3711.8329675164546, 4038.0106873815807, 2922.7077292270815, 3468.809215493147, 3496.720262379029, 3506.789592624425, 3550.2012047289413, 4336.349547567858, 4808.735519546423, 4963.925541116886, 5038.445770965191, 5047.570956468705, 3830.655241028293, 4248.576726796527, 4518.706284091556, 4632.930506042412, 4638.5593368629925, 4506.3101336998625, 4520.796564154621, 4571.657125715585, 5446.210299506589, 5487.451254874521, 2944.6024786653743, 3400.591928968515, 3710.833012514416, 3842.9807850960847, 3943.940840887389, 4802.975985120052, 5750.597458177971, 5756.8848623027725, 5757.88484230313, 5782.132680097977, 3885.6891448684037, 3899.5710471848074, 3917.941230881539, 3932.9606703932595, 3937.9761262071493, 3835.6739677127757, 3977.3835055566433, 3989.162275922089, 3998.1803730235233, 3999.8200080996426, 3794.2790869734663, 4515.5484451554585, 4528.682992190515, 4543.704659197141, 4633.235516139799, 4748.240281554935, 5051.520105589963, 5479.04116779562, 5494.862628434321, 5518.668879867221, 1267.2523211305374, 1311.6786387335164, 1317.4466723975954, 1333.6999175185506, 1358.770312866857, 919.7010971434177, 948.800751842107, 952.3904601223909, 958.2046901072093, 960.1742501448748, 4417.491988421372, 4968.434942992945, 4990.276409920614, 5104.2088476286235, 5200.297959775382, 5483.464629903633, 5639.182318563785, 5695.920988839044, 5697.4587414195585, 5726.79956201531, 4381.518033016366, 4818.590419814355, 4837.467878533358, 5063.0, 5141.53726164647, 2294.770522947725, 2901.998810410405, 2930.948336164693, 2931.7947743657737, 2941.8234905905288, 4707.811687532529, 4939.604831613462, 5793.826185214451, 5821.359650438449, 5854.2096816930025, 5181.663191892515, 5362.846987897621, 5699.145128230799, 5701.8289451315695, 5713.5714821388565, 5487.917681234705, 5764.250647415977, 5821.912671309934, 5856.24312706195, 5863.824085277449, 5185.844424667266, 5408.594355423437, 5521.481592562078, 5558.6381336572795, 5562.694051827027, 4565.238030991202, 5465.480779325958, 5495.945040549544, 5508.504234618904, 5534.391216966211, 5542.3626282977975, 5545.1682247663175, 5715.542756579547, 5797.449242321973, 5879.529637628894, 3319.771684476759, 3459.9481007785407, 3801.809909504569, 3879.2241551689212, 3920.098377373163, 5146.790504231578, 5235.869103272448, 5513.255710479034, 5556.638818476786, 5600.439956004367, 4777.570018698334, 5271.367435907716, 5432.414606359784, 5467.992604067667, 5481.369642491005, 5057.241413787814, 5082.932584157368, 5342.519173274424, 5352.100004498503, 5393.568514518907, 4350.869473915787, 4877.463479017234, 5103.132467480463, 5160.664556803796, 5272.65366911736, 5453.454654534515, 5486.753096110764, 5495.46127084417, 5530.787684926062, 5559.471145435038, 5072.728090381757, 5346.919796203138, 5355.571554275571, 5358.410574836843, 5426.348838139448], "value": 3988.599043129296, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [651.4202359899689, 681.9659017049146, 712.4976891291636, 738.412961695452, 827.1273806134529, 15017.62455938602, 15463.5360939172, 16120.516384508453, 16405.343786248537, 16417.34330626775, 14388.928055359735, 14692.853071469282, 14705.33825977831, 14711.48509802157, 14730.63173420665, 666.4335314982275, 687.5771400588627, 848.3043903998739, 871.542440218887, 890.6749036601626, 694.8054544727485, 848.3891598049426, 869.2524428991094, 875.5053394831931, 884.5665623844302, 905.3526728389201, 926.8702381666573, 928.7445952363087, 930.7486978515797, 931.6133804471136, 696.3036963036963, 918.1002617434917, 918.6187732091174, 921.7234829551174, 924.2144177449181, 533.3173537871492, 645.6061802300593, 664.0736173038632, 670.9228438729559, 673.8281738156787, 14433.422663093465, 14433.783493247609, 14439.711205775931, 14461.78307325391, 14492.782608260884, 13649.11280766747, 13947.511837085653, 14067.929660351632, 14214.715705685932, 14252.144871307755, 12070.577529786504, 12463.314517701523, 12502.562410315595, 12751.153426934723, 12824.422900969479, 4282.314829627245, 4423.933640995388, 4574.290984897346, 4614.584687378152, 4827.25177597473, 124003.75996240013, 124626.0, 125211.0, 125253.37373313075, 126313.0, 10350.275480716278, 11024.724381890517, 11236.831447528293, 11338.773224535464, 11377.203595748384, 22223.77776222217, 22241.22155724542, 22246.777532224794, 22250.221242256444, 22287.219947301768, 7521.435892308099, 7739.419543534257, 7806.492577982526, 8132.471389359673, 8194.795130121795, 4365.301551751704, 4455.9647005283105, 4475.888102797391, 4487.259602165672, 4494.617957473586, 3469.080693616194, 3610.4403817408343, 3612.1150318172217, 3614.512040874501, 3615.7288203384323, 646.3084499585492, 650.0, 655.5345704549823, 656.4354654996699, 693.0782059860475, 535.5929493584904, 614.1800696070795, 620.4395944200339, 626.9842854575617, 640.9391107844747, 8141.918580814235, 9124.863127053099, 9186.540672966325, 9266.721998340061, 9317.72046838596, 511.5671567948412, 557.7462254674114, 588.1824264272665, 590.5423296944816, 610.5725991805665, 4129.772862492592, 4418.337249412614, 4510.323451482304, 4512.390827238347, 4540.341650460665, 123986.0, 126175.0, 128628.07057893951, 141910.0, 172444.0, 124460.37769811093, 124649.0, 126333.0, 126873.0, 128155.0, 70200.6489967547, 92418.53790731003, 105290.0, 111055.44472277748, 116559.41720291345, 7471.850562988819, 9808.264380171373, 9988.650397236062, 9993.650222242186, 10061.647842325483, 50677.0, 63295.0, 64613.35386646073, 64691.67654161699, 67390.66304668445, 92115.0, 98632.0, 99809.0, 99987.00013000068, 102088.48955755471, 12283.0, 12997.220166790023, 13041.413136408695, 13109.541166059142, 13142.40859161321, 14284.57146285613, 14343.56969290923, 14365.425382984982, 14636.780448293071, 14898.1806000671, 13328.33358332099, 13948.442062317394, 13953.651158721113, 14009.369578368794, 14270.714585708436, 13394.057861609817, 13939.930300348433, 13962.720745584827, 14525.055871368328, 14574.417023319373, 13655.931720341334, 13712.725745485233, 14137.293135343398, 14236.430542778588, 14242.501512447014, 11311.264767790068, 11462.432938116997, 11599.188056835941, 11796.94101529487, 11821.172517923662, 11444.198906076495, 11536.0, 11747.647570572897, 11802.645920622395, 11807.940960295144], "value": 7851.306615087329, "unit": "score"}], "name": "dromaeo_css", "value": 7278.895804846035, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 112.0, 111.0, 117.0, 165.0, 118.0, 112.0, 112.0, 112.0, 111.0], "value": 118.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 106.0, 93.0, 162.0, 139.0, 141.0, 124.0, 107.0, 140.0, 107.0], "value": 126.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 185.0, 183.0, 186.0, 185.0, 183.0, 184.0, 188.0, 254.0, 235.0], "value": 196.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 59.0, 58.0, 90.0, 61.0, 61.0, 73.0, 82.0, 109.0, 58.0], "value": 73.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 72.0, 95.0, 69.0, 67.0, 68.0, 92.0, 67.0, 68.0, 93.0], "value": 77.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 84.0, 87.0, 85.0, 86.0, 84.0, 88.0, 84.0, 86.0, 84.0], "value": 85.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 96.0, 108.0, 96.0, 96.0, 97.0, 96.0, 96.0, 95.0], "value": 97.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 88.0, 84.0, 84.0, 84.0, 90.0, 131.0, 85.0, 85.0], "value": 90.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 50.0, 52.0, 51.0, 56.0, 56.0, 56.0, 55.0, 59.0, 55.0], "value": 54.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 68.0, 67.0, 82.0, 75.0, 73.0, 70.0, 69.0, 70.0, 71.0], "value": 71.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 81.0, 82.0, 82.0, 88.0, 85.0, 84.0, 82.0, 86.0, 84.0], "value": 83.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 132.0, 127.0, 149.0, 152.0, 152.0, 160.0, 156.0, 187.0, 137.0], "value": 150.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 162.0, 163.0, 164.0, 165.0, 166.0, 163.0, 165.0, 164.0], "value": 163.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 67.0, 67.0, 66.0, 65.0, 66.0, 68.0, 64.0, 64.0], "value": 66.2, "unit": "score"}], "name": "kraken", "value": 1454.8999999999999, "alertThreshold": 2.0}]} 03:21:48 INFO - Return code: 0 03:21:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:21:48 INFO - # TBPL SUCCESS # 03:21:48 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:21:48 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:21:48 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:21:48 INFO - 2016-09-25 03:21:48.212 screenresolution[1973:17907] starting screenresolution argv=screenresolution get 03:21:48 INFO - 2016-09-25 03:21:48.216 screenresolution[1973:17907] Display 0: 1600x1200x32@60 03:21:48 INFO - 2016-09-25 03:21:48.222 screenresolution[1974:17909] starting screenresolution argv=screenresolution list 03:21:48 INFO - Available Modes on Display 0 03:21:48 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:21:48 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:21:48 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:21:48 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:21:48 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:21:48 INFO - Intel Iris: 03:21:48 INFO - Chipset Model: Intel Iris 03:21:48 INFO - Type: GPU 03:21:48 INFO - Bus: Built-In 03:21:48 INFO - VRAM (Dynamic, Max): 1536 MB 03:21:48 INFO - Vendor: Intel (0x8086) 03:21:48 INFO - Device ID: 0x0a2e 03:21:48 INFO - Revision ID: 0x0009 03:21:48 INFO - Displays: 03:21:48 INFO - Display: 03:21:48 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:21:48 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:21:48 INFO - Display Serial Number: 1600x1200 60 03:21:48 INFO - Main Display: Yes 03:21:48 INFO - Mirror: Off 03:21:48 INFO - Online: Yes 03:21:48 INFO - Rotation: Supported 03:21:48 INFO - Return code: 0 03:21:48 INFO - Running post-action listener: _resource_record_post_action 03:21:48 INFO - [mozharness: 2016-09-25 10:21:48.460122Z] Finished run-tests step (success) 03:21:48 INFO - Running post-run listener: _resource_record_post_run 03:21:48 INFO - Total resource usage - Wall time: 1209s; CPU: 53.0%; Read bytes: 2351104; Write bytes: 664559616; Read time: 23; Write time: 1862 03:21:48 INFO - TinderboxPrint: CPU usage
53.3% 03:21:48 INFO - TinderboxPrint: I/O read bytes / time
2,351,104 / 23 03:21:48 INFO - TinderboxPrint: I/O write bytes / time
664,559,616 / 1,862 03:21:48 INFO - TinderboxPrint: CPU idle
2,258.1 (46.7%) 03:21:48 INFO - TinderboxPrint: CPU system
967.4 (20.0%) 03:21:48 INFO - TinderboxPrint: CPU user
1,612.3 (33.3%) 03:21:48 INFO - TinderboxPrint: Swap in / out
364,195,840 / 0 03:21:48 INFO - install - Wall time: 32s; CPU: 54.0%; Read bytes: 361890304; Write bytes: 357131776; Read time: 27652; Write time: 649 03:21:48 INFO - run-tests - Wall time: 1177s; CPU: 53.0%; Read bytes: 1466368; Write bytes: 297171456; Read time: 18; Write time: 1176 03:21:48 INFO - Running post-run listener: _upload_blobber_files 03:21:48 INFO - Blob upload gear active. 03:21:48 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:21:48 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 03:21:48 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'] 03:21:48 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 03:21:49 INFO - (blobuploader) - INFO - Open directory for files ... 03:21:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:21:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:21:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:21:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:21:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:21:50 INFO - (blobuploader) - INFO - Done attempting. 03:21:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:21:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:21:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:21:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:21:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:21:51 INFO - (blobuploader) - INFO - Done attempting. 03:21:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:21:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:21:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:21:53 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:21:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:21:53 INFO - (blobuploader) - INFO - Done attempting. 03:21:53 INFO - (blobuploader) - INFO - Iteration through files over. 03:21:53 INFO - Return code: 0 03:21:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:21:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:21:53 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/87d3118e50f37fde84bf6e49618fe6ba887d88918786891426f2674faf4e41971da9f3722a1ce7c020a3b482f178119b25cdc66a0040bb8684fe37718b32ae34", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/390b4b406a2ba6ad31a4e2c07918717c8b6dc83e040d2fda913bb7f79a5d68d7da580544197d9ec434d0995e15c19fd7d82989e3af1701b587566142536c06d0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5b6b9271c5a913a191c1ab21e78063700d4a7f49c5ce90ad79eee884b80bd91c431c3cd46faccaf1b19d01b67aef71fdba5b06ff9af77ce4b6bb363375b6b1a8"} 03:21:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:21:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:21:53 INFO - Contents: 03:21:53 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/87d3118e50f37fde84bf6e49618fe6ba887d88918786891426f2674faf4e41971da9f3722a1ce7c020a3b482f178119b25cdc66a0040bb8684fe37718b32ae34", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/390b4b406a2ba6ad31a4e2c07918717c8b6dc83e040d2fda913bb7f79a5d68d7da580544197d9ec434d0995e15c19fd7d82989e3af1701b587566142536c06d0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5b6b9271c5a913a191c1ab21e78063700d4a7f49c5ce90ad79eee884b80bd91c431c3cd46faccaf1b19d01b67aef71fdba5b06ff9af77ce4b6bb363375b6b1a8"} 03:21:53 INFO - Running post-run listener: copy_logs_to_upload_dir 03:21:53 INFO - Copying logs to upload dir... 03:21:53 INFO - mkdir: /builds/slave/test/build/upload/logs 03:21:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1268.257464 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-09-25 03:21:54.010167) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-25 03:21:54.013874) ========= 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.LniWFnULpJ/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.VHfub8XtRl/Listeners TMPDIR=/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/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/87d3118e50f37fde84bf6e49618fe6ba887d88918786891426f2674faf4e41971da9f3722a1ce7c020a3b482f178119b25cdc66a0040bb8684fe37718b32ae34", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/390b4b406a2ba6ad31a4e2c07918717c8b6dc83e040d2fda913bb7f79a5d68d7da580544197d9ec434d0995e15c19fd7d82989e3af1701b587566142536c06d0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5b6b9271c5a913a191c1ab21e78063700d4a7f49c5ce90ad79eee884b80bd91c431c3cd46faccaf1b19d01b67aef71fdba5b06ff9af77ce4b6bb363375b6b1a8"} build_url:https://queue.taskcluster.net/v1/task/L6HWAN9KSrOpvyenBdtk7Q/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011453 build_url: 'https://queue.taskcluster.net/v1/task/L6HWAN9KSrOpvyenBdtk7Q/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/87d3118e50f37fde84bf6e49618fe6ba887d88918786891426f2674faf4e41971da9f3722a1ce7c020a3b482f178119b25cdc66a0040bb8684fe37718b32ae34", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/390b4b406a2ba6ad31a4e2c07918717c8b6dc83e040d2fda913bb7f79a5d68d7da580544197d9ec434d0995e15c19fd7d82989e3af1701b587566142536c06d0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5b6b9271c5a913a191c1ab21e78063700d4a7f49c5ce90ad79eee884b80bd91c431c3cd46faccaf1b19d01b67aef71fdba5b06ff9af77ce4b6bb363375b6b1a8"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-25 03:21:54.051641) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-25 03:21:54.052316) ========= 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.LniWFnULpJ/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.VHfub8XtRl/Listeners TMPDIR=/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/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.005260 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-25 03:21:54.106672) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-25 03:21:54.107172) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-25 03:21:54.107669) ========= ========= Total master_lag: 0.21 =========