builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0326 starttime: 1477407218.16 results: success (0) buildid: 20161025053821 builduid: 15945fb1427e4c3b947a1af998ff7105 revision: 1280f78d221d4c1e146443ee18f99b37f5e520fd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-25 07:53:38.156056) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-25 07:53:38.157038) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-25 07:53:38.157734) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-25 07:53:38.184808) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-25 07:53:38.185625) ========= 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.llhtPj19x7/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.AydXTVScSN/Listeners TMPDIR=/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/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-10-25 07:53:38-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 18.7M=0.001s 2016-10-25 07:53:38 (18.7 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.175376 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-25 07:53:38.386798) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-25 07:53:38.387171) ========= 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.llhtPj19x7/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.AydXTVScSN/Listeners TMPDIR=/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/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.025537 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-25 07:53:38.436480) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2016-10-25 07:53:38.436986) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 1280f78d221d4c1e146443ee18f99b37f5e520fd --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 1280f78d221d4c1e146443ee18f99b37f5e520fd --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.llhtPj19x7/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.AydXTVScSN/Listeners TMPDIR=/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/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-10-25 07:53:38,514 truncating revision to first 12 chars 2016-10-25 07:53:38,514 Setting DEBUG logging. 2016-10-25 07:53:38,514 attempt 1/10 2016-10-25 07:53:38,514 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/1280f78d221d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-25 07:53:39,917 unpacking tar archive at: mozilla-aurora-1280f78d221d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.678476 ========= master_lag: 3.31 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2016-10-25 07:53:43.426840) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-25 07:53:43.427189) ========= script_repo_revision: 1280f78d221d4c1e146443ee18f99b37f5e520fd ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-25 07:53:43.427779) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-25 07:53:43.428152) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-25 07:53:44.267680) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-10-25 07:53:44.268409) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.llhtPj19x7/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.AydXTVScSN/Listeners TMPDIR=/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/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 07:53:44 INFO - MultiFileLogger online at 20161025 07:53:44 in /builds/slave/test 07:53:44 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 07:53:44 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:53:44 INFO - {'append_to_log': False, 07:53:44 INFO - 'base_work_dir': '/builds/slave/test', 07:53:44 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 07:53:44 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:53:44 INFO - 'branch': 'Mozilla-Aurora', 07:53:44 INFO - 'buildbot_json_path': 'buildprops.json', 07:53:44 INFO - 'config_files': ('talos/mac_config.py',), 07:53:44 INFO - 'default_actions': ('clobber', 07:53:44 INFO - 'read-buildbot-config', 07:53:44 INFO - 'download-and-extract', 07:53:44 INFO - 'populate-webroot', 07:53:44 INFO - 'create-virtualenv', 07:53:44 INFO - 'install', 07:53:44 INFO - 'run-tests'), 07:53:44 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:53:44 INFO - 'download_minidump_stackwalk': True, 07:53:44 INFO - 'download_symbols': 'ondemand', 07:53:44 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:53:44 INFO - 'tooltool.py': '/tools/tooltool.py', 07:53:44 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:53:44 INFO - '/tools/misc-python/virtualenv.py')}, 07:53:44 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:53:44 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:53:44 INFO - 'installer_path': 'installer.exe', 07:53:44 INFO - 'log_level': 'info', 07:53:44 INFO - 'log_name': 'talos', 07:53:44 INFO - 'log_to_console': True, 07:53:44 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 07:53:44 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 07:53:44 INFO - 'opt_config_files': (), 07:53:44 INFO - 'pip_index': False, 07:53:44 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:53:44 INFO - 'cmd': ('bash', 07:53:44 INFO - '-c', 07:53:44 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:53:44 INFO - 'enabled': True, 07:53:44 INFO - 'halt_on_failure': False, 07:53:44 INFO - 'name': 'check_screen_resolution'},), 07:53:44 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:53:44 INFO - 'cmd': ('bash', 07:53:44 INFO - '-c', 07:53:44 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:53:44 INFO - 'enabled': True, 07:53:44 INFO - 'halt_on_failure': False, 07:53:44 INFO - 'name': 'check_screen_resolution'},), 07:53:44 INFO - 'run_cmd_checks_enabled': True, 07:53:44 INFO - 'sps_profile': False, 07:53:44 INFO - 'sps_profile_interval': 0, 07:53:44 INFO - 'suite': 'dromaeojs', 07:53:44 INFO - 'system_bits': '32', 07:53:44 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:53:44 INFO - 'title': 't-yosemite-r7-0326', 07:53:44 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:53:44 INFO - 'use_talos_json': True, 07:53:44 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:53:44 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:53:44 INFO - 'work_dir': 'build'} 07:53:44 INFO - [mozharness: 2016-10-25 14:53:44.463830Z] Running clobber step. 07:53:44 INFO - Running pre-action listener: _resource_record_pre_action 07:53:44 INFO - Running main action method: clobber 07:53:44 INFO - rmtree: /builds/slave/test/build 07:53:44 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:53:47 INFO - Running post-action listener: _resource_record_post_action 07:53:47 INFO - [mozharness: 2016-10-25 14:53:47.127379Z] Finished clobber step (success) 07:53:47 INFO - [mozharness: 2016-10-25 14:53:47.127550Z] Running read-buildbot-config step. 07:53:47 INFO - Running pre-action listener: _resource_record_pre_action 07:53:47 INFO - Running main action method: read_buildbot_config 07:53:47 INFO - Using buildbot properties: 07:53:47 INFO - { 07:53:47 INFO - "project": "", 07:53:47 INFO - "product": "firefox", 07:53:47 INFO - "script_repo_revision": "production", 07:53:47 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 07:53:47 INFO - "repository": "", 07:53:47 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 07:53:47 INFO - "buildid": "20161025053821", 07:53:47 INFO - "pgo_build": "False", 07:53:47 INFO - "basedir": "/builds/slave/test", 07:53:47 INFO - "buildnumber": 65, 07:53:47 INFO - "slavename": "t-yosemite-r7-0326", 07:53:47 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 07:53:47 INFO - "platform": "yosemite_r7", 07:53:47 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 07:53:47 INFO - "branch": "mozilla-aurora", 07:53:47 INFO - "repo_path": "releases/mozilla-aurora", 07:53:47 INFO - "revision": "1280f78d221d4c1e146443ee18f99b37f5e520fd", 07:53:47 INFO - "stage_platform": "macosx64", 07:53:47 INFO - "builduid": "15945fb1427e4c3b947a1af998ff7105", 07:53:47 INFO - "slavebuilddir": "test" 07:53:47 INFO - } 07:53:47 INFO - Found installer url https://queue.taskcluster.net/v1/task/MCuVeSfqRiOGvtH7rQEjCQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 07:53:47 INFO - Running post-action listener: _resource_record_post_action 07:53:47 INFO - [mozharness: 2016-10-25 14:53:47.133184Z] Finished read-buildbot-config step (success) 07:53:47 INFO - [mozharness: 2016-10-25 14:53:47.133370Z] Running download-and-extract step. 07:53:47 INFO - Running pre-action listener: _resource_record_pre_action 07:53:47 INFO - Running main action method: download_and_extract 07:53:47 INFO - mkdir: /builds/slave/test/build/tests 07:53:47 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')]} 07:53:47 INFO - trying https://queue.taskcluster.net/v1/task/MCuVeSfqRiOGvtH7rQEjCQ/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 07:53:47 INFO - Downloading https://queue.taskcluster.net/v1/task/MCuVeSfqRiOGvtH7rQEjCQ/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 07:53:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MCuVeSfqRiOGvtH7rQEjCQ/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 07:53:48 INFO - Downloaded 1199 bytes. 07:53:48 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 07:53:48 INFO - Using the following test package requirements: 07:53:48 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 07:53:48 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 07:53:48 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 07:53:48 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 07:53:48 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 07:53:48 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 07:53:48 INFO - u'jsshell-mac.zip'], 07:53:48 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 07:53:48 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 07:53:48 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 07:53:48 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 07:53:48 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 07:53:48 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 07:53:48 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 07:53:48 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 07:53:48 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 07:53:48 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 07:53:48 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 07:53:48 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 07:53:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MCuVeSfqRiOGvtH7rQEjCQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 07:53:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MCuVeSfqRiOGvtH7rQEjCQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 07:53:48 INFO - Fetch https://queue.taskcluster.net/v1/task/MCuVeSfqRiOGvtH7rQEjCQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 07:53:49 INFO - Expected file size: 16438618 07:53:56 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 07:53:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MCuVeSfqRiOGvtH7rQEjCQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 07:53:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MCuVeSfqRiOGvtH7rQEjCQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 07:53:56 INFO - Fetch https://queue.taskcluster.net/v1/task/MCuVeSfqRiOGvtH7rQEjCQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 07:53:56 INFO - Expected file size: 16438618 07:54:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MCuVeSfqRiOGvtH7rQEjCQ/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 07:54:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MCuVeSfqRiOGvtH7rQEjCQ/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 07:54:03 INFO - Fetch https://queue.taskcluster.net/v1/task/MCuVeSfqRiOGvtH7rQEjCQ/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 07:54:03 INFO - Expected file size: 14414081 07:54: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')]} 07:54:04 INFO - trying https://queue.taskcluster.net/v1/task/MCuVeSfqRiOGvtH7rQEjCQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 07:54:04 INFO - Downloading https://queue.taskcluster.net/v1/task/MCuVeSfqRiOGvtH7rQEjCQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 07:54:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MCuVeSfqRiOGvtH7rQEjCQ/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 07:54:07 INFO - Downloaded 115430731 bytes. 07:54:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MCuVeSfqRiOGvtH7rQEjCQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 07:54:07 INFO - mkdir: /builds/slave/test/properties 07:54:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:54:07 INFO - Writing to file /builds/slave/test/properties/build_url 07:54:07 INFO - Contents: 07:54:07 INFO - build_url:https://queue.taskcluster.net/v1/task/MCuVeSfqRiOGvtH7rQEjCQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 07:54:08 INFO - Running post-action listener: _resource_record_post_action 07:54:08 INFO - Running post-action listener: set_extra_try_arguments 07:54:08 INFO - [mozharness: 2016-10-25 14:54:08.299398Z] Finished download-and-extract step (success) 07:54:08 INFO - [mozharness: 2016-10-25 14:54:08.299546Z] Running populate-webroot step. 07:54:08 INFO - Running pre-action listener: _resource_record_pre_action 07:54:08 INFO - Running main action method: populate_webroot 07:54:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:54:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:54:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:54:08 INFO - '--tppagecycles', 07:54:08 INFO - '7'], 07:54:08 INFO - 'tests': ['tsvgm']}}, 07:54:08 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:54:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:54:08 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:54:08 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:54:08 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:54:08 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:54:08 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:54:08 INFO - 'talos_options': ['--disable-e10s'], 07:54:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:54:08 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:54:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:54:08 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:54:08 INFO - 'talos_options': ['--disable-e10s'], 07:54:08 INFO - 'tests': ['damp', 'tps']}, 07:54:08 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:54:08 INFO - 'tests': ['damp', 'tps']}, 07:54:08 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:54:08 INFO - 'tests': ['dromaeo_dom']}, 07:54:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:54:08 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:54:08 INFO - 'tests': ['basic_compositor_video']}, 07:54:08 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:54:08 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:54:08 INFO - 'tests': ['a11yr', 07:54:08 INFO - 'ts_paint', 07:54:08 INFO - 'tpaint', 07:54:08 INFO - 'sessionrestore', 07:54:08 INFO - 'sessionrestore_no_auto_restore', 07:54:08 INFO - 'tabpaint']}, 07:54:08 INFO - 'other-e10s': {'tests': ['a11yr', 07:54:08 INFO - 'ts_paint', 07:54:08 INFO - 'tpaint', 07:54:08 INFO - 'sessionrestore', 07:54:08 INFO - 'sessionrestore_no_auto_restore', 07:54:08 INFO - 'tabpaint']}, 07:54:08 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:54:08 INFO - 'ts_paint', 07:54:08 INFO - 'tpaint', 07:54:08 INFO - 'sessionrestore', 07:54:08 INFO - 'sessionrestore_no_auto_restore', 07:54:08 INFO - 'tabpaint']}, 07:54:08 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:54:08 INFO - 'ts_paint', 07:54:08 INFO - 'tpaint', 07:54:08 INFO - 'sessionrestore', 07:54:08 INFO - 'sessionrestore_no_auto_restore', 07:54:08 INFO - 'tabpaint']}, 07:54:08 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:54:08 INFO - 'tests': ['a11yr', 07:54:08 INFO - 'ts_paint', 07:54:08 INFO - 'tpaint', 07:54:08 INFO - 'sessionrestore', 07:54:08 INFO - 'sessionrestore_no_auto_restore', 07:54:08 INFO - 'tabpaint']}, 07:54:08 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:54:08 INFO - 'tests': ['a11yr', 07:54:08 INFO - 'ts_paint', 07:54:08 INFO - 'tpaint', 07:54:08 INFO - 'sessionrestore', 07:54:08 INFO - 'sessionrestore_no_auto_restore', 07:54:08 INFO - 'tabpaint']}, 07:54:08 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:54:08 INFO - 'tests': ['tsvgx', 07:54:08 INFO - 'tsvgr_opacity', 07:54:08 INFO - 'tart', 07:54:08 INFO - 'tscrollx', 07:54:08 INFO - 'cart']}, 07:54:08 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:54:08 INFO - 'tsvgr_opacity', 07:54:08 INFO - 'tart', 07:54:08 INFO - 'tscrollx', 07:54:08 INFO - 'cart']}, 07:54:08 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:54:08 INFO - 'talos_options': ['--disable-e10s'], 07:54:08 INFO - 'tests': ['tp5o']}, 07:54:08 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:54:08 INFO - 'tests': ['tp5o']}, 07:54:08 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:54:08 INFO - 'talos_options': ['--disable-e10s', 07:54:08 INFO - '--xperf_path', 07:54:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:54:08 INFO - 'tests': ['tp5n']}, 07:54:08 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:54:08 INFO - 'talos_options': ['--xperf_path', 07:54:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:54:08 INFO - 'tests': ['tp5n']}}, 07:54:08 INFO - 'talos.zip': {'path': '', 07:54:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:54:08 INFO - Running post-action listener: _resource_record_post_action 07:54:08 INFO - [mozharness: 2016-10-25 14:54:08.318362Z] Finished populate-webroot step (success) 07:54:08 INFO - [mozharness: 2016-10-25 14:54:08.318472Z] Running create-virtualenv step. 07:54:08 INFO - Running pre-action listener: _resource_record_pre_action 07:54:08 INFO - Running main action method: create_virtualenv 07:54:08 INFO - Creating virtualenv /builds/slave/test/build/venv 07:54: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 07:54:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:54:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:54:08 INFO - Using real prefix '/tools/python27' 07:54:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:54:09 INFO - Installing distribute.............................................................................................................................................................................................done. 07:54:12 INFO - Installing pip.................done. 07:54:12 INFO - Return code: 0 07:54:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:54:12 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')]} 07:54:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:54:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54:12 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')]} 07:54:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:54:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54:12 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 0x10eecf490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ee45570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc18a57be80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ece3d30>, '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 0x10eb49db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ecdbb20>, '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.llhtPj19x7/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.AydXTVScSN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/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 07:54:12 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 07:54:12 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 07:54:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.llhtPj19x7/Render', 07:54:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:54:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:54:12 INFO - 'HOME': '/Users/cltbld', 07:54:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:54:12 INFO - 'LOGNAME': 'cltbld', 07:54:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:54:12 INFO - 'MOZ_NO_REMOTE': '1', 07:54:12 INFO - 'NO_EM_RESTART': '1', 07:54:12 INFO - 'PAGER': '/bin/cat', 07:54:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:54:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:54:12 INFO - 'PWD': '/builds/slave/test', 07:54:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:54:12 INFO - 'SHELL': '/bin/bash', 07:54:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AydXTVScSN/Listeners', 07:54:12 INFO - 'TMPDIR': '/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/', 07:54:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:54:12 INFO - 'USER': 'cltbld', 07:54:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:54:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:54:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:54:12 INFO - 'XPC_FLAGS': '0x0', 07:54:12 INFO - 'XPC_SERVICE_NAME': '0', 07:54:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:54:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:54:12 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 07:54:12 INFO - Cleaning up... 07:54:12 INFO - Return code: 0 07:54:12 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:54:12 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')]} 07:54:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:54:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54:12 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')]} 07:54:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:54:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54:12 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 0x10eecf490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ee45570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc18a57be80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ece3d30>, '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 0x10eb49db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ecdbb20>, '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.llhtPj19x7/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.AydXTVScSN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/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 07:54:12 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 07:54:12 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 07:54:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.llhtPj19x7/Render', 07:54:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:54:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:54:12 INFO - 'HOME': '/Users/cltbld', 07:54:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:54:12 INFO - 'LOGNAME': 'cltbld', 07:54:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:54:12 INFO - 'MOZ_NO_REMOTE': '1', 07:54:12 INFO - 'NO_EM_RESTART': '1', 07:54:12 INFO - 'PAGER': '/bin/cat', 07:54:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:54:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:54:12 INFO - 'PWD': '/builds/slave/test', 07:54:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:54:12 INFO - 'SHELL': '/bin/bash', 07:54:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AydXTVScSN/Listeners', 07:54:12 INFO - 'TMPDIR': '/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/', 07:54:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:54:12 INFO - 'USER': 'cltbld', 07:54:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:54:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:54:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:54:12 INFO - 'XPC_FLAGS': '0x0', 07:54:12 INFO - 'XPC_SERVICE_NAME': '0', 07:54:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:54:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:54:12 INFO - Downloading/unpacking psutil>=3.1.1 07:54: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 07:54: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 07:54: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 07:54: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 07:54: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 07:54: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 07:54:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:54:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:54:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:54:15 INFO - Installing collected packages: psutil 07:54:15 INFO - Running setup.py install for psutil 07:54:15 INFO - building 'psutil._psutil_osx' extension 07:54:15 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 07:54: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 07:54: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 07:54: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 07:54:16 INFO - building 'psutil._psutil_posix' extension 07:54: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 07:54:16 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 07:54:16 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 07:54:16 INFO - ^ 07:54:16 INFO - 1 warning generated. 07:54: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 07:54:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:54:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:54:16 INFO - Successfully installed psutil 07:54:16 INFO - Cleaning up... 07:54:16 INFO - Return code: 0 07:54:16 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:54: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')]} 07:54:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:54:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54: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')]} 07:54:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:54:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54: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 0x10eecf490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ee45570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc18a57be80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ece3d30>, '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 0x10eb49db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ecdbb20>, '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.llhtPj19x7/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.AydXTVScSN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/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 07:54: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 07:54: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 07:54:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.llhtPj19x7/Render', 07:54:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:54:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:54:16 INFO - 'HOME': '/Users/cltbld', 07:54:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:54:16 INFO - 'LOGNAME': 'cltbld', 07:54:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:54:16 INFO - 'MOZ_NO_REMOTE': '1', 07:54:16 INFO - 'NO_EM_RESTART': '1', 07:54:16 INFO - 'PAGER': '/bin/cat', 07:54:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:54:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:54:16 INFO - 'PWD': '/builds/slave/test', 07:54:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:54:16 INFO - 'SHELL': '/bin/bash', 07:54:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AydXTVScSN/Listeners', 07:54:16 INFO - 'TMPDIR': '/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/', 07:54:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:54:16 INFO - 'USER': 'cltbld', 07:54:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:54:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:54:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:54:16 INFO - 'XPC_FLAGS': '0x0', 07:54:16 INFO - 'XPC_SERVICE_NAME': '0', 07:54:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:54:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:54:17 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:54: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 07:54: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 07:54: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 07:54: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 07:54: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 07:54: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 07:54:19 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:54:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:54:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:54:19 INFO - Installing collected packages: mozsystemmonitor 07:54:19 INFO - Running setup.py install for mozsystemmonitor 07:54:19 INFO - Successfully installed mozsystemmonitor 07:54:19 INFO - Cleaning up... 07:54:19 INFO - Return code: 0 07:54:19 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:54: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')]} 07:54:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:54:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54: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')]} 07:54:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:54:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54: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 0x10eecf490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ee45570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc18a57be80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ece3d30>, '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 0x10eb49db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ecdbb20>, '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.llhtPj19x7/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.AydXTVScSN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/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 07:54: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 07:54: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 07:54:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.llhtPj19x7/Render', 07:54:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:54:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:54:19 INFO - 'HOME': '/Users/cltbld', 07:54:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:54:19 INFO - 'LOGNAME': 'cltbld', 07:54:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:54:19 INFO - 'MOZ_NO_REMOTE': '1', 07:54:19 INFO - 'NO_EM_RESTART': '1', 07:54:19 INFO - 'PAGER': '/bin/cat', 07:54:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:54:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:54:19 INFO - 'PWD': '/builds/slave/test', 07:54:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:54:19 INFO - 'SHELL': '/bin/bash', 07:54:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AydXTVScSN/Listeners', 07:54:19 INFO - 'TMPDIR': '/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/', 07:54:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:54:19 INFO - 'USER': 'cltbld', 07:54:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:54:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:54:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:54:19 INFO - 'XPC_FLAGS': '0x0', 07:54:19 INFO - 'XPC_SERVICE_NAME': '0', 07:54:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:54:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:54:20 INFO - Downloading/unpacking jsonschema==2.5.1 07:54: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 07:54: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 07:54: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 07:54: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 07:54: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 07:54: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 07:54:22 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:54:22 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:54: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 07:54: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 07:54: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 07:54: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 07:54: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 07:54: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 07:54:22 INFO - Downloading functools32-3.2.3-2.tar.gz 07:54:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:54:23 INFO - warning: no files found matching '*.txt' 07:54:23 INFO - no previously-included directories found matching 'build' 07:54:23 INFO - no previously-included directories found matching 'dist' 07:54:23 INFO - no previously-included directories found matching '.git*' 07:54:23 INFO - Installing collected packages: jsonschema, functools32 07:54:23 INFO - Running setup.py install for functools32 07:54:23 INFO - warning: no files found matching '*.txt' 07:54:23 INFO - no previously-included directories found matching 'build' 07:54:23 INFO - no previously-included directories found matching 'dist' 07:54:23 INFO - no previously-included directories found matching '.git*' 07:54:23 INFO - Successfully installed jsonschema functools32 07:54:23 INFO - Cleaning up... 07:54:23 INFO - Return code: 0 07:54:23 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:54: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')]} 07:54:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:54:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54: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')]} 07:54:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:54:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54: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 0x10eecf490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ee45570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc18a57be80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ece3d30>, '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 0x10eb49db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ecdbb20>, '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.llhtPj19x7/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.AydXTVScSN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/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 07:54: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 07:54: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 07:54:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.llhtPj19x7/Render', 07:54:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:54:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:54:23 INFO - 'HOME': '/Users/cltbld', 07:54:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:54:23 INFO - 'LOGNAME': 'cltbld', 07:54:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:54:23 INFO - 'MOZ_NO_REMOTE': '1', 07:54:23 INFO - 'NO_EM_RESTART': '1', 07:54:23 INFO - 'PAGER': '/bin/cat', 07:54:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:54:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:54:23 INFO - 'PWD': '/builds/slave/test', 07:54:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:54:23 INFO - 'SHELL': '/bin/bash', 07:54:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AydXTVScSN/Listeners', 07:54:23 INFO - 'TMPDIR': '/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/', 07:54:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:54:23 INFO - 'USER': 'cltbld', 07:54:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:54:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:54:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:54:23 INFO - 'XPC_FLAGS': '0x0', 07:54:23 INFO - 'XPC_SERVICE_NAME': '0', 07:54:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:54:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:54:23 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:54:23 INFO - Cleaning up... 07:54:23 INFO - Return code: 0 07:54:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:54: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')]} 07:54:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:54:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54: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')]} 07:54:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:54:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54: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 0x10eecf490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ee45570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc18a57be80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ece3d30>, '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 0x10eb49db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ecdbb20>, '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.llhtPj19x7/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.AydXTVScSN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/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 07:54: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 07:54: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 07:54:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.llhtPj19x7/Render', 07:54:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:54:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:54:23 INFO - 'HOME': '/Users/cltbld', 07:54:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:54:23 INFO - 'LOGNAME': 'cltbld', 07:54:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:54:23 INFO - 'MOZ_NO_REMOTE': '1', 07:54:23 INFO - 'NO_EM_RESTART': '1', 07:54:23 INFO - 'PAGER': '/bin/cat', 07:54:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:54:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:54:23 INFO - 'PWD': '/builds/slave/test', 07:54:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:54:23 INFO - 'SHELL': '/bin/bash', 07:54:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AydXTVScSN/Listeners', 07:54:23 INFO - 'TMPDIR': '/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/', 07:54:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:54:23 INFO - 'USER': 'cltbld', 07:54:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:54:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:54:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:54:23 INFO - 'XPC_FLAGS': '0x0', 07:54:23 INFO - 'XPC_SERVICE_NAME': '0', 07:54:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:54:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:54:23 INFO - Downloading/unpacking blobuploader==1.2.4 07:54: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 07:54: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 07:54: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 07:54: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 07:54: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 07:54: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 07:54:26 INFO - Downloading blobuploader-1.2.4.tar.gz 07:54:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:54:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:54: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 07:54: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 07:54: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 07:54: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 07:54: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 07:54: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 07:54:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:54:27 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:54: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 07:54: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 07:54: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 07:54: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 07:54: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 07:54: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 07:54:27 INFO - Downloading docopt-0.6.1.tar.gz 07:54:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:54:27 INFO - Installing collected packages: blobuploader, requests, docopt 07:54:27 INFO - Running setup.py install for blobuploader 07:54:27 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:54:27 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:54:27 INFO - Running setup.py install for requests 07:54:28 INFO - Running setup.py install for docopt 07:54:28 INFO - Successfully installed blobuploader requests docopt 07:54:28 INFO - Cleaning up... 07:54:28 INFO - Return code: 0 07:54:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:54: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')]} 07:54:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:54:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54: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')]} 07:54:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:54:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54: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 0x10eecf490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ee45570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc18a57be80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ece3d30>, '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 0x10eb49db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ecdbb20>, '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.llhtPj19x7/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.AydXTVScSN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/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 07:54: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 07:54: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 07:54:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.llhtPj19x7/Render', 07:54:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:54:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:54:28 INFO - 'HOME': '/Users/cltbld', 07:54:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:54:28 INFO - 'LOGNAME': 'cltbld', 07:54:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:54:28 INFO - 'MOZ_NO_REMOTE': '1', 07:54:28 INFO - 'NO_EM_RESTART': '1', 07:54:28 INFO - 'PAGER': '/bin/cat', 07:54:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:54:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:54:28 INFO - 'PWD': '/builds/slave/test', 07:54:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:54:28 INFO - 'SHELL': '/bin/bash', 07:54:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AydXTVScSN/Listeners', 07:54:28 INFO - 'TMPDIR': '/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/', 07:54:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:54:28 INFO - 'USER': 'cltbld', 07:54:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:54:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:54:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:54:28 INFO - 'XPC_FLAGS': '0x0', 07:54:28 INFO - 'XPC_SERVICE_NAME': '0', 07:54:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:54:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:54:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:54:28 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-FfVRk2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:54:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:54:28 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-jrMPZH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:54:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:54:29 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-Um8BuQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:54:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:54:29 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-9nM6YV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:54:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:54:29 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-8kCKBA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:54:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:54:29 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-eVBHrt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:54:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:54:29 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-1KjIdt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:54:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:54:29 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-GggXuK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:54:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:54:29 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-AF7kGJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:54:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:54:29 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-iR9O3s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:54:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:54:29 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-FQVBXF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:54:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:54:29 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-TSsTnK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:54:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:54:30 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-6WyTWX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:54:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:54:30 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-fSiHIJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:54:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:54:30 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-wmDRoc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:54:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:54:30 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-U6leUX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:54:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:54:30 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-_Eknf2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:54:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:54:30 INFO - Running setup.py install for manifestparser 07:54:30 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:54:30 INFO - Running setup.py install for mozcrash 07:54:30 INFO - Running setup.py install for mozdebug 07:54:31 INFO - Running setup.py install for mozdevice 07:54:31 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:54:31 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:54:31 INFO - Running setup.py install for mozfile 07:54:31 INFO - Running setup.py install for mozhttpd 07:54:31 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:54:31 INFO - Running setup.py install for mozinfo 07:54:31 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:54:31 INFO - Running setup.py install for mozInstall 07:54:31 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:54:31 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:54:31 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:54:31 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:54:31 INFO - Running setup.py install for mozleak 07:54:31 INFO - Running setup.py install for mozlog 07:54:32 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:54:32 INFO - Running setup.py install for moznetwork 07:54:32 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:54:32 INFO - Running setup.py install for mozprocess 07:54:32 INFO - Running setup.py install for mozprofile 07:54:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:54:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:54:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:54:32 INFO - Running setup.py install for mozrunner 07:54:32 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:54:32 INFO - Running setup.py install for mozscreenshot 07:54:32 INFO - Running setup.py install for moztest 07:54:33 INFO - Running setup.py install for mozversion 07:54:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:54:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:54:33 INFO - Cleaning up... 07:54:33 INFO - Return code: 0 07:54:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:54: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')]} 07:54:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:54:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54: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')]} 07:54:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:54:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54: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 0x10eecf490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ee45570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc18a57be80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ece3d30>, '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 0x10eb49db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ecdbb20>, '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.llhtPj19x7/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.AydXTVScSN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/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 07:54: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 07:54: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 07:54:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.llhtPj19x7/Render', 07:54:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:54:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:54:33 INFO - 'HOME': '/Users/cltbld', 07:54:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:54:33 INFO - 'LOGNAME': 'cltbld', 07:54:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:54:33 INFO - 'MOZ_NO_REMOTE': '1', 07:54:33 INFO - 'NO_EM_RESTART': '1', 07:54:33 INFO - 'PAGER': '/bin/cat', 07:54:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:54:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:54:33 INFO - 'PWD': '/builds/slave/test', 07:54:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:54:33 INFO - 'SHELL': '/bin/bash', 07:54:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AydXTVScSN/Listeners', 07:54:33 INFO - 'TMPDIR': '/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/', 07:54:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:54:33 INFO - 'USER': 'cltbld', 07:54:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:54:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:54:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:54:33 INFO - 'XPC_FLAGS': '0x0', 07:54:33 INFO - 'XPC_SERVICE_NAME': '0', 07:54:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:54:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:54:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:54:33 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-b1upek-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:54: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)) 07:54:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:54:33 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-5EPKLg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:54: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)) 07:54:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:54:33 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-V5Ig_1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:54: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)) 07:54:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:54:33 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-Ie0SRN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:54: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)) 07:54:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:54:33 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-anL2AW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:54: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)) 07:54:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:54:33 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-fZ10D6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:54: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)) 07:54:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:54:34 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-N3Ihq8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:54: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)) 07:54:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:54:34 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-DKHdEc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:54: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)) 07:54:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:54:34 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-_APLCE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:54: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)) 07:54:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:54:34 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-pzX_h0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:54: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)) 07:54:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:54:34 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-zpmxWV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:54: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)) 07:54:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:54:34 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-JTnfsd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:54: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)) 07:54:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:54:34 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-ZwG_9P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:54: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)) 07:54:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:54:34 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-LviT2y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:54: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)) 07:54:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:54:34 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-nSNmEs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:54:35 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)) 07:54:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:54:35 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-x7OKqJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:54: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)) 07:54:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:54:35 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-bTzg0G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:54: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)) 07:54: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)) 07:54: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)) 07:54: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)) 07:54: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)) 07:54: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)) 07:54:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:54: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 07:54: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 07:54: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 07:54: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 07:54: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 07:54: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 07:54:38 INFO - Downloading blessings-1.6.tar.gz 07:54:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:54:38 INFO - Installing collected packages: blessings 07:54:38 INFO - Running setup.py install for blessings 07:54:38 INFO - Successfully installed blessings 07:54:38 INFO - Cleaning up... 07:54:38 INFO - Return code: 0 07:54:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:54:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:54:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:54:38 INFO - Reading from file tmpfile_stdout 07:54:38 INFO - Current package versions: 07:54:38 INFO - blessings == 1.6 07:54:38 INFO - blobuploader == 1.2.4 07:54:38 INFO - docopt == 0.6.1 07:54:38 INFO - functools32 == 3.2.3-2 07:54:38 INFO - jsonschema == 2.5.1 07:54:38 INFO - manifestparser == 1.1 07:54:38 INFO - mozInstall == 1.12 07:54:38 INFO - mozcrash == 0.17 07:54:38 INFO - mozdebug == 0.1 07:54:38 INFO - mozdevice == 0.48 07:54:38 INFO - mozfile == 1.2 07:54:38 INFO - mozhttpd == 0.7 07:54:38 INFO - mozinfo == 0.9 07:54:38 INFO - mozleak == 0.1 07:54:38 INFO - mozlog == 3.4 07:54:38 INFO - moznetwork == 0.27 07:54:38 INFO - mozprocess == 0.23 07:54:38 INFO - mozprofile == 0.28 07:54:38 INFO - mozrunner == 6.12 07:54:38 INFO - mozscreenshot == 0.1 07:54:38 INFO - mozsystemmonitor == 0.3 07:54:38 INFO - moztest == 0.7 07:54:38 INFO - mozversion == 1.4 07:54:38 INFO - psutil == 3.1.1 07:54:38 INFO - requests == 1.2.3 07:54:38 INFO - wsgiref == 0.1.2 07:54:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:54: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')]} 07:54:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:54:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54:39 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')]} 07:54:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:54:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54:39 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 0x10eecf490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ee45570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc18a57be80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ece3d30>, '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 0x10eb49db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ecdbb20>, '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.llhtPj19x7/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.AydXTVScSN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/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 07:54:39 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 07:54:39 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 07:54:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.llhtPj19x7/Render', 07:54:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:54:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:54:39 INFO - 'HOME': '/Users/cltbld', 07:54:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:54:39 INFO - 'LOGNAME': 'cltbld', 07:54:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:54:39 INFO - 'MOZ_NO_REMOTE': '1', 07:54:39 INFO - 'NO_EM_RESTART': '1', 07:54:39 INFO - 'PAGER': '/bin/cat', 07:54:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:54:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:54:39 INFO - 'PWD': '/builds/slave/test', 07:54:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:54:39 INFO - 'SHELL': '/bin/bash', 07:54:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AydXTVScSN/Listeners', 07:54:39 INFO - 'TMPDIR': '/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/', 07:54:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:54:39 INFO - 'USER': 'cltbld', 07:54:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:54:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:54:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:54:39 INFO - 'XPC_FLAGS': '0x0', 07:54:39 INFO - 'XPC_SERVICE_NAME': '0', 07:54:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:54:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:54:39 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)) 07:54:39 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)) 07:54:39 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)) 07:54:39 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)) 07:54:39 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)) 07:54:39 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)) 07:54:39 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)) 07:54:39 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)) 07:54:39 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)) 07:54:39 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)) 07:54:39 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)) 07:54:39 INFO - Cleaning up... 07:54:39 INFO - Return code: 0 07:54:39 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:54:39 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')]} 07:54:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:54:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54:39 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')]} 07:54:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:54:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54:39 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 0x10eecf490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ee45570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc18a57be80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ece3d30>, '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 0x10eb49db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ecdbb20>, '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.llhtPj19x7/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.AydXTVScSN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/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 07:54:39 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 07:54:39 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 07:54:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.llhtPj19x7/Render', 07:54:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:54:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:54:39 INFO - 'HOME': '/Users/cltbld', 07:54:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:54:39 INFO - 'LOGNAME': 'cltbld', 07:54:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:54:39 INFO - 'MOZ_NO_REMOTE': '1', 07:54:39 INFO - 'NO_EM_RESTART': '1', 07:54:39 INFO - 'PAGER': '/bin/cat', 07:54:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:54:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:54:39 INFO - 'PWD': '/builds/slave/test', 07:54:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:54:39 INFO - 'SHELL': '/bin/bash', 07:54:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AydXTVScSN/Listeners', 07:54:39 INFO - 'TMPDIR': '/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/', 07:54:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:54:39 INFO - 'USER': 'cltbld', 07:54:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:54:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:54:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:54:39 INFO - 'XPC_FLAGS': '0x0', 07:54:39 INFO - 'XPC_SERVICE_NAME': '0', 07:54:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:54:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:54:39 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:54:39 INFO - Cleaning up... 07:54:39 INFO - Return code: 0 07:54:39 INFO - Running post-action listener: _resource_record_post_action 07:54:39 INFO - Running post-action listener: _start_resource_monitoring 07:54:39 INFO - Starting resource monitoring. 07:54:39 INFO - [mozharness: 2016-10-25 14:54:39.698791Z] Finished create-virtualenv step (success) 07:54:39 INFO - [mozharness: 2016-10-25 14:54:39.699720Z] Running install step. 07:54:39 INFO - Running pre-action listener: _resource_record_pre_action 07:54:39 INFO - Running main action method: install 07:54:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:54:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:54:39 INFO - Reading from file tmpfile_stdout 07:54:39 INFO - Detecting whether we're running mozinstall >=1.0... 07:54:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:54:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:54:40 INFO - Reading from file tmpfile_stdout 07:54:40 INFO - Output received: 07:54:40 INFO - Usage: mozinstall [options] installer 07:54:40 INFO - Options: 07:54:40 INFO - -h, --help show this help message and exit 07:54:40 INFO - -d DEST, --destination=DEST 07:54:40 INFO - Directory to install application into. [default: 07:54:40 INFO - "/builds/slave/test"] 07:54:40 INFO - --app=APP Application being installed. [default: firefox] 07:54:40 INFO - mkdir: /builds/slave/test/build/application 07:54:40 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'] 07:54:40 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 07:55:13 INFO - Reading from file tmpfile_stdout 07:55:13 INFO - Output received: 07:55:13 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 07:55:13 INFO - Running post-action listener: _resource_record_post_action 07:55:13 INFO - [mozharness: 2016-10-25 14:55:13.515134Z] Finished install step (success) 07:55:13 INFO - [mozharness: 2016-10-25 14:55:13.515306Z] Running run-tests step. 07:55:13 INFO - Running pre-action listener: _resource_record_pre_action 07:55:13 INFO - Running main action method: run_tests 07:55:13 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:55:13 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:55:13 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:55:13 INFO - 2016-10-25 07:55:13.529 screenresolution[1638:7505] starting screenresolution argv=screenresolution get 07:55:13 INFO - 2016-10-25 07:55:13.532 screenresolution[1638:7505] Display 0: 1600x1200x32@60 07:55:13 INFO - 2016-10-25 07:55:13.538 screenresolution[1639:7507] starting screenresolution argv=screenresolution list 07:55:13 INFO - Available Modes on Display 0 07:55:13 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:55:13 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:55:13 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:55:13 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:55:13 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:55:13 INFO - Intel Iris: 07:55:13 INFO - Chipset Model: Intel Iris 07:55:13 INFO - Type: GPU 07:55:13 INFO - Bus: Built-In 07:55:13 INFO - VRAM (Dynamic, Max): 1536 MB 07:55:13 INFO - Vendor: Intel (0x8086) 07:55:13 INFO - Device ID: 0x0a2e 07:55:13 INFO - Revision ID: 0x0009 07:55:13 INFO - Displays: 07:55:13 INFO - Display: 07:55:13 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:55:13 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:55:13 INFO - Display Serial Number: 1600x1200 60 07:55:13 INFO - Main Display: Yes 07:55:13 INFO - Mirror: Off 07:55:13 INFO - Online: Yes 07:55:13 INFO - Rotation: Supported 07:55:13 INFO - Return code: 0 07:55:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:55:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:55:13 INFO - Python 2.7.3 07:55:13 INFO - Return code: 0 07:55:13 INFO - grabbing minidump binary from tooltool 07:55:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:55:13 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 0x10ece3d30>, '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 0x10eb49db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ecdbb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:55:13 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 07:55:13 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 07:55:13 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 07:55:13 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:55:13 INFO - Return code: 0 07:55:13 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:55:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:55:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:55:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:55:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:55:13 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/MCuVeSfqRiOGvtH7rQEjCQ/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0326', '--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 07:55:13 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/MCuVeSfqRiOGvtH7rQEjCQ/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0326 --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 07:55:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.llhtPj19x7/Render', 07:55:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:55:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:55:13 INFO - 'HOME': '/Users/cltbld', 07:55:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:55:13 INFO - 'LOGNAME': 'cltbld', 07:55:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:55:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:55:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:55:13 INFO - 'MOZ_NO_REMOTE': '1', 07:55:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:55:13 INFO - 'NO_EM_RESTART': '1', 07:55:13 INFO - 'PAGER': '/bin/cat', 07:55:13 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:55:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:55:13 INFO - 'PWD': '/builds/slave/test', 07:55:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:55:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:55:13 INFO - 'SHELL': '/bin/bash', 07:55:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AydXTVScSN/Listeners', 07:55:13 INFO - 'TMPDIR': '/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/', 07:55:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:55:13 INFO - 'USER': 'cltbld', 07:55:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:55:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:55:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:55:13 INFO - 'XPC_FLAGS': '0x0', 07:55:13 INFO - 'XPC_SERVICE_NAME': '0', 07:55:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:55:13 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/MCuVeSfqRiOGvtH7rQEjCQ/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0326', '--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 07:55:14 INFO - mozversion application_buildid: 20161025053821 07:55:14 INFO - mozversion application_changeset: 1280f78d221d4c1e146443ee18f99b37f5e520fd 07:55:14 INFO - mozversion application_display_name: FirefoxDeveloperEdition 07:55:14 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:55:14 INFO - mozversion application_name: Firefox 07:55:14 INFO - mozversion application_remotingname: firefox-dev 07:55:14 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:55:14 INFO - mozversion application_vendor: Mozilla 07:55:14 INFO - mozversion application_version: 51.0a2 07:55:14 INFO - mozversion platform_buildid: 20161025053821 07:55:14 INFO - mozversion platform_changeset: 1280f78d221d4c1e146443ee18f99b37f5e520fd 07:55:14 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:55:14 INFO - mozversion platform_version: 51.0a2 07:55:14 INFO - using testdate: 1477407314 07:55:14 INFO - actual date: 1477407314 07:55:14 INFO - starting webserver on 'localhost:49276' 07:55:14 INFO - SUITE-START | Running 2 tests 07:55:14 INFO - TEST-START | dromaeo_css 07:55:14 INFO - operating with platform_type : mac_ 07:55:14 INFO - Initialising browser for dromaeo_css test... 07:55:14 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/tmpSVejMK/profile http://localhost:49276/getInfo.html) 07:55:16 INFO - PROCESS | 1649 | __metrics Screen width/height:1600/1200 07:55:16 INFO - PROCESS | 1649 | colorDepth:24 07:55:16 INFO - PROCESS | 1649 | Browser inner width/height: 1024/689 07:55:16 INFO - PROCESS | 1649 | __metrics 07:55:16 INFO - PROCESS | 1649 | 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" 07:55:16 INFO - PROCESS | 1649 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:55:17 INFO - TEST-INFO | 1649: exit 0 07:55:17 INFO - Browser initialized. 07:55:17 INFO - Running cycle 1/1 for dromaeo_css test... 07:55:17 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/tmpSVejMK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:55:29 INFO - PROCESS | 1651 | RSS: Main: 219852800 07:55:29 INFO - PROCESS | 1651 | 07:56:20 INFO - PROCESS | 1651 | 1477407380738 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] 07:58:31 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49276/tests/dromaeo/cssquery-ext.html) 07:58:33 INFO - PROCESS | 1651 | RSS: Main: 441507840 07:58:33 INFO - PROCESS | 1651 | 08:01:36 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-ext.html (next: http://localhost:49276/tests/dromaeo/cssquery-jquery.html) 08:01:37 INFO - PROCESS | 1651 | RSS: Main: 352608256 08:01:37 INFO - PROCESS | 1651 | 08:04:39 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49276/tests/dromaeo/cssquery-mootools.html) 08:04:40 INFO - PROCESS | 1651 | RSS: Main: 332288000 08:04:40 INFO - PROCESS | 1651 | 08:07:42 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49276/tests/dromaeo/cssquery-prototype.html) 08:07:43 INFO - PROCESS | 1651 | RSS: Main: 337616896 08:07:43 INFO - PROCESS | 1651 | 08:10:46 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49276/tests/dromaeo/cssquery-yui.html) 08:10:47 INFO - PROCESS | 1651 | RSS: Main: 320667648 08:10:47 INFO - PROCESS | 1651 | 08:13:50 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-yui.html (next: http://localhost:49276/tests/dromaeo/cssquery-dojo.html) 08:13:50 INFO - PROCESS | 1651 | RSS: Main: 507494400 08:13:50 INFO - PROCESS | 1651 | 08:13:50 INFO - PROCESS | 1651 | __start_tp_report 08:13:50 INFO - PROCESS | 1651 | _x_x_mozilla_page_load 08:13:50 INFO - PROCESS | 1651 | _x_x_mozilla_page_load_details 08:13:50 INFO - PROCESS | 1651 | |i|pagename|runs| 08:13:50 INFO - PROCESS | 1651 | |0;dojo.html;3324.3517514084756;3329.5338652588644;3343.5486209361743;3351.4135026370377;3382.1206486313567;4714.71711697298;5581.888362232763;5582.8325150245455;5637.943620563793;5679.204911312419;4770.332153498504;5584.329880414346;5595.020871347519;5658.981383350995;5668.68822214778;5138.049460849736;5146.202338637517;5170.948290517084;5277.287566178555;5283.920741188886;5136.537711605954;5137.12668846297;5138.511841375063;5147.1764517677175;5226.3989641191365;5226.320578324831;5253.474652534755;5260.105782017066;5264.394594621629;5279.102552566073;5231.555317797973;5257.973710131463;5263.368395792491;5267.420583735786;5288.2596436498925;5067;5139.015553595365;5197.454267301917;5202.661826981234;5223.4776522347465;5510.283663123768;5526.806561770359;5589.916151257735;5592.96530141921;5606.859828504279;5995.880082398371;6043.848903777397;6046.576739628228;6079.179310793031;6129.325774164839;6085.878282434371;6150.231221097363;6153.476954458876;6158.384161583851;6184.443400094013;5567.638103523299;5626.578006649435;5662.122371032497;5677.51741102011;5689.743961521742;6305.747770089237;6328.810135695937;6333.904991425133;6346.492280617539;6349.174607301114;6007.849803754941;6088.360722124202;6102.542309326818;6114.602550834182;6129.754809807647;6033.698315084228;6116.3883611638485;6128.63228206309;6254.906176407358;6267.905981410283;6014.097885317237;6046.637201767908;6102.267727872683;6102.298235702862;6104.8506609112055;6039.872949919138;6130.642739936519;6162.630242185483;6172.382761723881;6188.44304012641;4889.193283108248;4895.632827537877;4897.534734200245;4901.583365413909;4955.306257124005;4335.263005289108;4344.326629372389;4388.385626012361;4409.5149533551285;4450.688451808407;5614.2701448811395;5641.26663533738;5671.688057156896;5686.3744988051285;5714.799892022722;6202.749569600004;6227.377262273736;6233.532485063548;6240.126382306481;6241.001439769615;5662.518685911661;5723;5738.5982981191755;5755.65466072037;5776.220210271644;5249.632525723163;5289.629725919226;5293.867653308698;5299.867503312448;5349.277847490539;6255.311915689271;6314.084457753508;6316.463100636497;6318.241810982711;6318.304986451579;6185.134081228722;6224.751009959551;6240.469560087444;6257.9687101564205;6275.435210831047;6207.565470417027;6252.5935814171935;6269.529785266032;6279.623222606659;6325.778597749057;6067.059605761114;6118.4668989547035;6126.181801870855;6144.556029333014;6145.723442445012;6227.06594010902;6238.563300568917;6238.875222495615;6238.968805155945;6240.438360547572;4985.351904252424;5797.8550536236935;6043;6076;6082.60463069899;5863.413658634273;5928.762849486145;5972.25346831646;5973.402659733992;5976.342602313655;5806.970965145148;5811.041178205549;5811.622244554091;5820.738066787089;5836.328822185334;5498.5876059294915;5570.774429625476;5935.2877654681715;5983.431574000463;5986.4013598639785;5796.21751063601;5806.158107074535;5823.94176058234;5832.970835145967;5856.150858125633 08:13:50 INFO - PROCESS | 1651 | |1;ext.html;476.952304769523;506.7339646685492;509.19547115557447;518.9299444574982;526.5366477499799;27315.18054458367;37435.81282093593;40685.79657101714;40999.18001639965;43202.56797432033;42070.57929420705;42115.94710132248;42486.15027699444;42570.36144457828;42638.147237055244;8701.56492175392;9771.609135634584;9933.552990115462;9937.751556211117;9946.90053099467;8760.561971901412;8966.372353935227;8983.46099234048;8985.820283594325;11951.282923024602;11903.642890713292;12201.572944946929;12204.023678105774;12215.022798176169;12225.266484010988;12147.514099436055;12200.267983920949;12230.510779568807;12235.816462752977;12236.449359778831;8713.215810577078;8936.151065648754;11729;12008.759824803543;12101.636950891487;40429.393559096636;40603.593964060274;40679;40705.18589628221;40865;3323.5347051412823;3335.2495688470144;3342.064222017839;3354.882579109744;3400.132966093655;28997.71002289971;30896.918607848842;31382.52926206109;31704;31858;3182.80903145812;3192.904212873594;3216.45320295548;3232.69289417505;3282.770206085575;511825;513517.43241283554;513815.4309228467;515726;517980;58090.709546451995;58361;58372.70813645905;58579.41420585825;58635;61956;61985.76028479405;62003;62011.68994155;62089;14696.41214351414;16749.413770517975;16775.91612041932;16790.66418671644;16790.908590941548;13059.151155174883;13113.868861311455;13134.868651313365;13155.144915580457;13213.207207567577;13647;13916.582502524738;13961.65095872591;14283.214423206824;15616.76574851378;4765.229533950073;6168.19813424252;6323.146375239284;6490.870182596416;6804.149481314836;878.2885862451307;974.8635191073255;1006.0894890124449;1014.3457469931852;1030.9175265978704;28807.38522954092;29835.701642983728;30219.244518887204;30440.391192176034;30502.54246186309;966.521222529531;989.2135752076972;1044.4099084017657;1071.1751950997843;1123.702218911989;14996;15374.461893833886;15712.842871571367;15715.978461400202;15779.921100394424;664309;667855;668422;669074;672767;49203.50796492061;50048.49951500438;56160;56349.43650563524;57019.71490142523;1339.9933000334936;1347.2455424962052;1374.1960952842699;1374.5257886029303;1382.3433868912387;29911.55132672968;30797.538036929913;30912.845435773575;31188.064358069296;31501.684983149877;48679.756601216766;49091.509084910125;49109.50890491192;49243.50756492533;49341.2598811011;685169;699537;699682;887736;888621;25559.74440255648;25860.094896678525;25866.741332587186;25898;26004.86997565;43692.34461483144;44544;45003;45680.62958111262;45990;37447;37805.24389512139;38025.80987095047;38147.28337224776;39389.21221575495;34679.30641387209;35286.647133528335;37175.81412093031;37180.25639487141;38447.80776096102;36318;36908.81545592362;37182.070448239014;37437.251254975294;37478.81260593679;31991.360172795947;33075.783498521385;33320.333593327516;33766.98699039033;33993.660063400035;25294.494110118063;25411.87294063592;25414.491710165323;25471.490570188864;25815.096471623405 08:13:50 INFO - PROCESS | 1651 | |2;jquery.html;350.73694728953285;356.8733099749589;375.6543979538824;381.8110035532411;405.5944055944056;15123.848761512396;15469.922650386747;16569.66860662786;21029;21154.788452115474;19878.304259350927;20320.898395508;20820;21066.36800895972;21086.683699744517;4444.377787109807;5676.091825307941;5913.438223368773;5924.88150236995;5925.644461332334;4163.208990291835;4404.317330813729;5730.19777231188;5780.248567686216;5858.326292476378;4231.238377092122;6359.268684101318;6626.8674626507445;6648.368405001517;6722.462203023746;6306.243250809886;6414.518911081665;6622.1722284714415;6622.602643841385;6705.061291419205;5750.856228594319;5751.511121554673;5752.769889204426;5760.74076666551;5761.827145185651;23364.299071027726;24237.394065148514;24396.26811195667;25431.61852572213;25650.102246421473;2158.7085743424595;2209.2598979341938;2221.7889300516426;2296.2307626944994;2351.917682881091;9688.70933871985;10348.741281468023;10703.464826758709;11252;16156.353745850152;1855.1466325490292;1858.637565674694;1903.2862676496313;1941.825235728777;1998.570307383905;110482;120868.39565802203;126671;126693.36653316766;127887.44225115445;11181.273217240854;11464.31214127155;11471.54113835454;11548.711282218012;11997.100217483723;14404.495842645667;14435.133891966516;14448.855511444961;14453.49412770548;14454.783178252335;8460.8730869037;8651.740447786577;8691.739247822576;8759.2992560595;8810;8715.346349023848;8719.645695662262;8731.60707768152;8908.73273801787;8917.464952102895;4368.170047690992;4452.9109417812115;4455.309427038814;4534.79593418297;4548.249538826057;1461.494660499687;1584.6513766971248;1889.1876493108095;1897.1557656842572;1956.4815323939167;781.4842204145236;910.3991365698607;910.7085732565648;970.0171971188623;1013.0477351289765;20407.4898127548;21110.683339749918;21315.78684213169;21553.892230538746;21594.244201453188;839.9752302191317;957.8323793336139;973.0707174648194;992.7617371830709;1000.0799264676515;9486.478243696525;10259.127974122133;11112.722181945353;11434.428278586203;11453.427328633536;525543;574831;588821;596773;597878;130069;132137;132944.5630056086;135575.32212338876;136413;964.6671898195111;975.4342481360794;983.5721461164417;1001.3591301567003;1006.7785087280787;14804;18692.813071869106;19534.511637208616;20007.899960500104;20118;45105.774471127435;51779;51957.48042519527;52189.95620087653;55391.72304138453;74046.25953740394;77306;78634.6068269655;79633;80498.19501805141;5488.368837583729;6819.795406137824;7895.368370530229;7925.365970722443;8308.086110527958;10885.891141088488;12428.62714118578;12458.937705311415;12642.2414655121;12916.418761155583;10486.632967846088;10958.342499450058;10990.285631434252;11040.613578524713;11205.327680339205;10556.313839600401;10754;10823.242373033812;10977.83533246986;11208;11055.668329950115;11182.944085279521;11256.774864502828;11321;11381.829272560753;7937.285644292041;8136.75589732309;8169.142240064708;8401.915980840113;8430.283425908867;10081.596736130472;10688.679339619825;10874.401907894826;10930.890691092987;11017.228793984665 08:13:50 INFO - PROCESS | 1651 | |3;mootools.html;1335.185536822538;1512.4026009726163;1635.1088656682107;1724.9827501724978;1833.9541511462212;8395.076541580429;8911.598978045988;8912.554372281384;8916.331275154356;8956.283497320215;7751.651175697093;8009.5594742289295;8020.318272946806;8076.5154090754595;8125.796855078626;2153.924612638554;2220.6565028157975;2224.5439684864564;2347.1315613223132;2420.8426452280546;2361.2089949866813;2377.084822343393;2402.615581506959;2404.5551572959057;2411.397150712322;2399.700037495313;2401.3756423329887;2401.7958473529684;2403.6995375578053;2415.770501802335;1988.8508361872846;2383.3088404362716;2384.892679829412;2388.0209114263243;2390.8565486070893;2344.824138189643;2357.10430036585;2380.27401642499;2381.273711517986;2382.809375249976;8675.783105422415;8756;8798.29613630908;8809.383343165917;8863.157999989991;5179.585633149339;5328.333958255218;5329.2006199070065;5334.706591137486;5339.119045357511;3000.849957502116;3563.964360356389;3588.4617307403837;3631.9455208171635;3638.417853143511;1027.2963020331097;1056.3609016544956;1067.4395942130366;1071.839224116381;1087.8857719939372;11482.253653512495;11517.827232591519;11522.76954460906;11525.250858694242;11525.538978440853;4587.288970209623;4606.608438282717;4730.408698912636;4783.832565860178;4789.760511974388;8516.190961858614;9903.702888913343;9910.20718342531;9921.305508614329;9946.751331216778;5328.120860058047;5347.438518955453;5350.4649535046965;5355.500459871242;5359.785608575691;4836;4848.151573474628;4867.367242258484;4921.237208232729;4929.309896614477;3916.060145565101;3952.150287688103;3972.503437070366;4016.0562267867026;4058.797060146981;1276.5213045108085;1282.7178020835402;1296.5915736542959;1301.4013553765185;1308.8233088533116;814.8044469327318;883.4919921045424;889.621910687955;915.1671978499534;933.1741408853214;5586.357568879631;5787.074068149076;5912.615679980788;5959.135925290895;5968.46283834457;923.3398120343986;924.0805398628407;953.0517135450272;954.1555723185031;987.7086259553449;3872.8450861965207;3933.056066544066;3988.5669741457687;4038.0510580013674;4051.4530538376944;9988.400695958266;10609.522571484302;10732.570697172181;10749.40878251688;10763.408012559228;9046.457212567268;10334.276600638033;10699.411532365795;10729.463526823627;10769.299995500267;7965.402594805297;8221.17788221185;8230.794230144294;8240.752777416566;8241.423100383035;4435.600795928382;5609.326880774333;5629.971850140887;5703.144528320619;5723.627964182315;9777.657781977596;9819.018098190123;9925;9969.900300996896;10098.697039088838;8632.266257368194;9847.753806154904;10031.147352475122;10300.124489418484;10308.226882983656;6532.869342613026;6714.294999025227;6728.798136055926;6789.490788190807;6796.864062718817;7721.691132354643;8291.668333266602;8335.958320208603;8447.113053129578;8452.873206901779;7281.308275713799;7404.333609974912;7415.184329723618;7537.057867766529;7589.696412143673;6997.790066298019;7199.388052015637;7294.161171465349;7310.305520975498;7315.890261646186;6245.7189426476825;6959.304069593;6964.686589103604;6982.441404687715;7003.404710599656;4388.429504164438;4873.098476781806;4925.088858561177;5002.199648056294;5028.170351891897;4789.473157952552;4916.139675556835;4931.260310953242;5106.795728170831;5112.412072611697 08:13:50 INFO - PROCESS | 1651 | |4;prototype.html;294.4317467288133;300.7729164480817;309.1760458378421;313.2560169597207;315.60706919884746;4577.816887324511;4915.844776477529;5162.038425398343;5222.425533191351;5355.714628489164;4518.412606361168;4532.002959348946;4595.8621241362725;5065.263978180395;5190.636655434112;3590.084528445243;3872.244912242114;4036.6073704571877;4049.137396797477;4076.859648684435;3511.2801875615437;4085.754854708712;4107.79461026949;4110.753354798707;4117.382392641113;3753.1930634913488;3767.416050512175;3978.6021397860272;4058.594140585947;4118.526369467505;4054.7567145971334;4059.97970010151;4074.490688663917;4084.5915408459214;4096.774677392742;3472.6700963408434;3482.37317282889;3495.5106285120105;3504.229069604683;3517.2262102337445;4482.932756008629;4947.876303092451;5142.997115562467;5246.868828279324;5289.153735402318;4610.608098311647;4631.652626053025;4638.466576343696;4648.976755116203;4686.859394218179;5005.849824505234;5599.32808063031;5689.971550142222;5699.572532060112;5717.828465146053;3007.548867669845;3835.5780864104927;3850.7689538627774;3860;3862.092408284051;5503.944960550423;5507.476789704971;5740.9712951435395;5829.07640478641;5922.394146575493;3740.831662575191;3776.4524143999515;3809.371453710107;3848.9037774055873;3869.96130038696;3685.3734865073;3892.4939757831303;3902.687784977195;3904.3255370071024;3917.7061720371084;4119.361498967664;4433.977830110894;4474.530174331713;4553.476350219701;4610.585047345755;4468.50846406895;4617;5570.053090974463;5658.708223169623;5683.573731970118;1263.829383033297;1310.8558058613544;1329.9933500332436;1332.8600496947681;1333.4866076560595;762.649181376573;807.6930766308765;815.9469634473741;820.4461988158089;823.4441751817499;3708.590735520485;3880.186864523198;4078.9184216316103;4376.14665140301;4468.821247150077;4246.8725938221905;4736.763161841963;4767;4836.758162091952;4837.64545927141;4009.558948515661;4089.8548406446243;4335.674824388184;4425.601695847389;4470.642348612103;2301.367124040902;2667.3862313300174;3034.4689679306475;3055.3125546751803;3092.9381412372077;5529.778808847682;5590.6582420219665;6012.368701286389;6071.241094863142;6075.848103797441;5182.833862380934;5851.297844258716;6050.727717252734;6063.878722425527;6063.9090413643835;5551.833444996576;6016.375578593843;6017.247844019497;6024.7288872001745;6035.547333949971;5221.399539053057;5287.709175995357;5820.912686309794;5834;5864.824055278348;4277.828886844616;5041.495850414929;5801.419858014334;5857.707114644336;5902.498287645598;5819.254223732948;6078.270607526948;6100.816975490742;6117.296510901303;6119.296280927572;3169.429502689538;3901.088466651377;3908.3941988990614;3921.3725803871243;3934.665553427876;4717.43390793107;5049.343585333883;5852.3269823969085;5882.882342353215;5912.911306330495;5353.491418315254;5643.012472817322;5664.26364572603;5674.801381951612;5714.485696287354;5583.52036710264;5620.18507316445;5639.238702775073;5664.85837854057;5675.943240567542;4693.9765301173275;5296.735163241746;5315.1230047043355;5526.834194974157;5562.860928476821;5520.889582208413;5601.271834661468;5609.971950140223;5641.548676105984;5649.54803615718;5494.09347457665;5515.751791169327;5521.282233309644;5562.833115006556;5586.608937374344 08:13:50 INFO - PROCESS | 1651 | |5;yui.html;714.5534041224234;738.1792239705127;739.4564994728873;789.6446599030436;812.3663542436898;14599.635009124777;15964.84035159648;15976.281067351969;15980.920095399506;15993.040417574939;14506.854931450682;15241.390344386238;15727.112746470411;15958.441454549093;16297.429589964353;826.9131741167196;860.5095095795368;861.1990848510883;862.8662557303596;864.9827003459927;655.2857385449859;673.461231015186;831.6423937706813;848.6605357856876;856.8243510080418;893.1604291965532;894.4186278918689;895.1853813030144;895.8118795053047;895.852184389575;891.9910800892005;892.2371372476504;892.6340200517822;893.1515060692336;893.1916615463016;508.0854461968442;523.2204016016109;636.2524034259726;652.5856081388305;657.6317262333109;15438.073715577102;15461.845381546153;15465.613359665986;15477.458288959833;15491.5352539424;11083.224174307801;13578.981576381811;13669.658258543517;13758.793618095737;14271.500497482539;11364.772704545945;11470.885291147066;11632.476538555786;12017.519299228108;12030.33833139177;3252.658470860573;3891.7664940103687;3898.688104951597;3995.2409042281874;4002.4996875390575;124330;125027.74972250251;125543.372283138;126749.36625316906;126790.3660481701;10597.947010265054;10927.726806829893;10980.286281391684;11019.173561982723;11240.100791936626;20070.39788806338;20616.866072366163;22145.55708885813;22231.110755569596;22307.665385019238;7993.240642138988;8027.117017128111;8062;8092.635831387602;8212.712555060543;4462.3752674625575;4474.910501790011;4506.864794056183;4690.437147542317;4764.951710623657;3183.1882869868036;3621.149029977953;3716.4053751399647;3722.181120153562;3734.738568300247;647.5758378262245;654.8035589323184;665.1187176990506;669.2805234372971;672.5292295393244;566.784621843705;594.1711312718733;657.651444734282;670.2827974067701;695.4262733245093;8841.717950897084;8877;9047.90952090484;9352.345335826427;9668.806623867484;547.7069767674275;670.3007875036758;673.6598018000878;679.8912174052128;689.2934741889603;3709.221063576625;4034.5360283567766;4669.626429885669;4684.1334353144775;4716.316134160527;94045;95070.52464737771;129882;130641;151989;123081.38459307647;137628.31185844206;139003.30498347443;140562;143828.28085859714;117253;119968;121276.39361803311;122383;124718;8618.741437756877;9022.593983270637;9036.367454278137;9168.88877812928;9247.676331328372;66485.3351466479;66995.3300466989;67070;68007.97988030282;69951.95072073821;95389.52305238429;100473.96682232173;102328;103349;107808.46095769471;11690.76618467609;11714.355710435668;11742.354170520362;11900.523979040741;12019.579314723942;12238;12506.062045346453;13002.869971300166;13088.476460941456;13721.108127971649;11937;12040.397980101136;12248.14263001617;12662.303573303558;12776.169548979287;12818.423170957143;13078.738425231633;13392.866071339162;14004.43982240699;14134.293285335898;12524.812127818272;12642.683932901751;13897.72204555883;13940.512082077079;13953.581392558239;10727.249092563758;11172.497237624164;11655.417229138679;11692.883071169179;11974.880251197725;9700.708978730649;10536.898055063368;11585.594504192313;11739.706507337385;11845.526178952745 08:13:50 INFO - PROCESS | 1651 | __end_tp_report 08:13:50 INFO - PROCESS | 1651 | __start_cc_report 08:13:50 INFO - PROCESS | 1651 | _x_x_mozilla_cycle_collect,2210 08:13:50 INFO - PROCESS | 1651 | __end_cc_report 08:13:50 INFO - PROCESS | 1651 | __startTimestamp1477408430266__endTimestamp 08:13:50 INFO - PROCESS | 1651 | 08:13:50 INFO - PROCESS | 1651 | ------- Summary: start ------- 08:13:50 INFO - PROCESS | 1651 | Number of tests: 6 08:13:50 INFO - PROCESS | 1651 | 08:13:50 INFO - PROCESS | 1651 | [#0] dojo.html Cycles:165 Average:5668.25 Median:5811.04 stddev:633.35 (10.9%) stddev-sans-first:608.01 08:13:50 INFO - PROCESS | 1651 | Values: 3324.4 3329.5 3343.5 3351.4 3382.1 4714.7 5581.9 5582.8 5637.9 5679.2 4770.3 5584.3 5595.0 5659.0 5668.7 5138.0 5146.2 5170.9 5277.3 5283.9 5136.5 5137.1 5138.5 5147.2 5226.4 5226.3 5253.5 5260.1 5264.4 5279.1 5231.6 5258.0 5263.4 5267.4 5288.3 5067.0 5139.0 5197.5 5202.7 5223.5 5510.3 5526.8 5589.9 5593.0 5606.9 5995.9 6043.8 6046.6 6079.2 6129.3 6085.9 6150.2 6153.5 6158.4 6184.4 5567.6 5626.6 5662.1 5677.5 5689.7 6305.7 6328.8 6333.9 6346.5 6349.2 6007.8 6088.4 6102.5 6114.6 6129.8 6033.7 6116.4 6128.6 6254.9 6267.9 6014.1 6046.6 6102.3 6102.3 6104.9 6039.9 6130.6 6162.6 6172.4 6188.4 4889.2 4895.6 4897.5 4901.6 4955.3 4335.3 4344.3 4388.4 4409.5 4450.7 5614.3 5641.3 5671.7 5686.4 5714.8 6202.7 6227.4 6233.5 6240.1 6241.0 5662.5 5723.0 5738.6 5755.7 5776.2 5249.6 5289.6 5293.9 5299.9 5349.3 6255.3 6314.1 6316.5 6318.2 6318.3 6185.1 6224.8 6240.5 6258.0 6275.4 6207.6 6252.6 6269.5 6279.6 6325.8 6067.1 6118.5 6126.2 6144.6 6145.7 6227.1 6238.6 6238.9 6239.0 6240.4 4985.4 5797.9 6043.0 6076.0 6082.6 5863.4 5928.8 5972.3 5973.4 5976.3 5807.0 5811.0 5811.6 5820.7 5836.3 5498.6 5570.8 5935.3 5983.4 5986.4 5796.2 5806.2 5823.9 5833.0 5856.2 08:13:50 INFO - PROCESS | 1651 | 08:13:50 INFO - PROCESS | 1651 | [#1] ext.html Cycles:180 Average:76740.40 Median:37178.04 stddev:178082.68 (479.0%) stddev-sans-first:178490.20 08:13:50 INFO - PROCESS | 1651 | Values: 477.0 506.7 509.2 518.9 526.5 27315.2 37435.8 40685.8 40999.2 43202.6 42070.6 42115.9 42486.2 42570.4 42638.1 8701.6 9771.6 9933.6 9937.8 9946.9 8760.6 8966.4 8983.5 8985.8 11951.3 11903.6 12201.6 12204.0 12215.0 12225.3 12147.5 12200.3 12230.5 12235.8 12236.4 8713.2 8936.2 11729.0 12008.8 12101.6 40429.4 40603.6 40679.0 40705.2 40865.0 3323.5 3335.2 3342.1 3354.9 3400.1 28997.7 30896.9 31382.5 31704.0 31858.0 3182.8 3192.9 3216.5 3232.7 3282.8 511825.0 513517.4 513815.4 515726.0 517980.0 58090.7 58361.0 58372.7 58579.4 58635.0 61956.0 61985.8 62003.0 62011.7 62089.0 14696.4 16749.4 16775.9 16790.7 16790.9 13059.2 13113.9 13134.9 13155.1 13213.2 13647.0 13916.6 13961.7 14283.2 15616.8 4765.2 6168.2 6323.1 6490.9 6804.1 878.3 974.9 1006.1 1014.3 1030.9 28807.4 29835.7 30219.2 30440.4 30502.5 966.5 989.2 1044.4 1071.2 1123.7 14996.0 15374.5 15712.8 15716.0 15779.9 664309.0 667855.0 668422.0 669074.0 672767.0 49203.5 50048.5 56160.0 56349.4 57019.7 1340.0 1347.2 1374.2 1374.5 1382.3 29911.6 30797.5 30912.8 31188.1 31501.7 48679.8 49091.5 49109.5 49243.5 49341.3 685169.0 699537.0 699682.0 887736.0 888621.0 25559.7 25860.1 25866.7 25898.0 26004.9 43692.3 44544.0 45003.0 45680.6 45990.0 37447.0 37805.2 38025.8 38147.3 39389.2 34679.3 35286.6 37175.8 37180.3 38447.8 36318.0 36908.8 37182.1 37437.3 37478.8 31991.4 33075.8 33320.3 33767.0 33993.7 25294.5 25411.9 25414.5 25471.5 25815.1 08:13:50 INFO - PROCESS | 1651 | 08:13:50 INFO - PROCESS | 1651 | [#2] jquery.html Cycles:180 Average:34586.55 Median:12830.26 stddev:96848.15 (754.8%) stddev-sans-first:97085.72 08:13:50 INFO - PROCESS | 1651 | Values: 350.7 356.9 375.7 381.8 405.6 15123.8 15469.9 16569.7 21029.0 21154.8 19878.3 20320.9 20820.0 21066.4 21086.7 4444.4 5676.1 5913.4 5924.9 5925.6 4163.2 4404.3 5730.2 5780.2 5858.3 4231.2 6359.3 6626.9 6648.4 6722.5 6306.2 6414.5 6622.2 6622.6 6705.1 5750.9 5751.5 5752.8 5760.7 5761.8 23364.3 24237.4 24396.3 25431.6 25650.1 2158.7 2209.3 2221.8 2296.2 2351.9 9688.7 10348.7 10703.5 11252.0 16156.4 1855.1 1858.6 1903.3 1941.8 1998.6 110482.0 120868.4 126671.0 126693.4 127887.4 11181.3 11464.3 11471.5 11548.7 11997.1 14404.5 14435.1 14448.9 14453.5 14454.8 8460.9 8651.7 8691.7 8759.3 8810.0 8715.3 8719.6 8731.6 8908.7 8917.5 4368.2 4452.9 4455.3 4534.8 4548.2 1461.5 1584.7 1889.2 1897.2 1956.5 781.5 910.4 910.7 970.0 1013.0 20407.5 21110.7 21315.8 21553.9 21594.2 840.0 957.8 973.1 992.8 1000.1 9486.5 10259.1 11112.7 11434.4 11453.4 525543.0 574831.0 588821.0 596773.0 597878.0 130069.0 132137.0 132944.6 135575.3 136413.0 964.7 975.4 983.6 1001.4 1006.8 14804.0 18692.8 19534.5 20007.9 20118.0 45105.8 51779.0 51957.5 52190.0 55391.7 74046.3 77306.0 78634.6 79633.0 80498.2 5488.4 6819.8 7895.4 7925.4 8308.1 10885.9 12428.6 12458.9 12642.2 12916.4 10486.6 10958.3 10990.3 11040.6 11205.3 10556.3 10754.0 10823.2 10977.8 11208.0 11055.7 11182.9 11256.8 11321.0 11381.8 7937.3 8136.8 8169.1 8401.9 8430.3 10081.6 10688.7 10874.4 10930.9 11017.2 08:13:50 INFO - PROCESS | 1651 | 08:13:50 INFO - PROCESS | 1651 | [#3] mootools.html Cycles:180 Average:5619.91 Median:5067.48 stddev:3124.12 (61.7%) stddev-sans-first:3116.28 08:13:50 INFO - PROCESS | 1651 | Values: 1335.2 1512.4 1635.1 1725.0 1834.0 8395.1 8911.6 8912.6 8916.3 8956.3 7751.7 8009.6 8020.3 8076.5 8125.8 2153.9 2220.7 2224.5 2347.1 2420.8 2361.2 2377.1 2402.6 2404.6 2411.4 2399.7 2401.4 2401.8 2403.7 2415.8 1988.9 2383.3 2384.9 2388.0 2390.9 2344.8 2357.1 2380.3 2381.3 2382.8 8675.8 8756.0 8798.3 8809.4 8863.2 5179.6 5328.3 5329.2 5334.7 5339.1 3000.8 3564.0 3588.5 3631.9 3638.4 1027.3 1056.4 1067.4 1071.8 1087.9 11482.3 11517.8 11522.8 11525.3 11525.5 4587.3 4606.6 4730.4 4783.8 4789.8 8516.2 9903.7 9910.2 9921.3 9946.8 5328.1 5347.4 5350.5 5355.5 5359.8 4836.0 4848.2 4867.4 4921.2 4929.3 3916.1 3952.2 3972.5 4016.1 4058.8 1276.5 1282.7 1296.6 1301.4 1308.8 814.8 883.5 889.6 915.2 933.2 5586.4 5787.1 5912.6 5959.1 5968.5 923.3 924.1 953.1 954.2 987.7 3872.8 3933.1 3988.6 4038.1 4051.5 9988.4 10609.5 10732.6 10749.4 10763.4 9046.5 10334.3 10699.4 10729.5 10769.3 7965.4 8221.2 8230.8 8240.8 8241.4 4435.6 5609.3 5630.0 5703.1 5723.6 9777.7 9819.0 9925.0 9969.9 10098.7 8632.3 9847.8 10031.1 10300.1 10308.2 6532.9 6714.3 6728.8 6789.5 6796.9 7721.7 8291.7 8336.0 8447.1 8452.9 7281.3 7404.3 7415.2 7537.1 7589.7 6997.8 7199.4 7294.2 7310.3 7315.9 6245.7 6959.3 6964.7 6982.4 7003.4 4388.4 4873.1 4925.1 5002.2 5028.2 4789.5 4916.1 4931.3 5106.8 5112.4 08:13:50 INFO - PROCESS | 1651 | 08:13:50 INFO - PROCESS | 1651 | [#4] prototype.html Cycles:180 Average:4472.95 Median:4727.10 stddev:1408.94 (29.8%) stddev-sans-first:1377.55 08:13:50 INFO - PROCESS | 1651 | Values: 294.4 300.8 309.2 313.3 315.6 4577.8 4915.8 5162.0 5222.4 5355.7 4518.4 4532.0 4595.9 5065.3 5190.6 3590.1 3872.2 4036.6 4049.1 4076.9 3511.3 4085.8 4107.8 4110.8 4117.4 3753.2 3767.4 3978.6 4058.6 4118.5 4054.8 4060.0 4074.5 4084.6 4096.8 3472.7 3482.4 3495.5 3504.2 3517.2 4482.9 4947.9 5143.0 5246.9 5289.2 4610.6 4631.7 4638.5 4649.0 4686.9 5005.8 5599.3 5690.0 5699.6 5717.8 3007.5 3835.6 3850.8 3860.0 3862.1 5503.9 5507.5 5741.0 5829.1 5922.4 3740.8 3776.5 3809.4 3848.9 3870.0 3685.4 3892.5 3902.7 3904.3 3917.7 4119.4 4434.0 4474.5 4553.5 4610.6 4468.5 4617.0 5570.1 5658.7 5683.6 1263.8 1310.9 1330.0 1332.9 1333.5 762.6 807.7 815.9 820.4 823.4 3708.6 3880.2 4078.9 4376.1 4468.8 4246.9 4736.8 4767.0 4836.8 4837.6 4009.6 4089.9 4335.7 4425.6 4470.6 2301.4 2667.4 3034.5 3055.3 3092.9 5529.8 5590.7 6012.4 6071.2 6075.8 5182.8 5851.3 6050.7 6063.9 6063.9 5551.8 6016.4 6017.2 6024.7 6035.5 5221.4 5287.7 5820.9 5834.0 5864.8 4277.8 5041.5 5801.4 5857.7 5902.5 5819.3 6078.3 6100.8 6117.3 6119.3 3169.4 3901.1 3908.4 3921.4 3934.7 4717.4 5049.3 5852.3 5882.9 5912.9 5353.5 5643.0 5664.3 5674.8 5714.5 5583.5 5620.2 5639.2 5664.9 5675.9 4694.0 5296.7 5315.1 5526.8 5562.9 5520.9 5601.3 5610.0 5641.5 5649.5 5494.1 5515.8 5521.3 5562.8 5586.6 08:13:50 INFO - PROCESS | 1651 | 08:13:50 INFO - PROCESS | 1651 | [#5] yui.html Cycles:180 Average:25373.00 Median:12745.43 stddev:40608.46 (318.6%) stddev-sans-first:40680.17 08:13:50 INFO - PROCESS | 1651 | Values: 714.6 738.2 739.5 789.6 812.4 14599.6 15964.8 15976.3 15980.9 15993.0 14506.9 15241.4 15727.1 15958.4 16297.4 826.9 860.5 861.2 862.9 865.0 655.3 673.5 831.6 848.7 856.8 893.2 894.4 895.2 895.8 895.9 892.0 892.2 892.6 893.2 893.2 508.1 523.2 636.3 652.6 657.6 15438.1 15461.8 15465.6 15477.5 15491.5 11083.2 13579.0 13669.7 13758.8 14271.5 11364.8 11470.9 11632.5 12017.5 12030.3 3252.7 3891.8 3898.7 3995.2 4002.5 124330.0 125027.7 125543.4 126749.4 126790.4 10597.9 10927.7 10980.3 11019.2 11240.1 20070.4 20616.9 22145.6 22231.1 22307.7 7993.2 8027.1 8062.0 8092.6 8212.7 4462.4 4474.9 4506.9 4690.4 4765.0 3183.2 3621.1 3716.4 3722.2 3734.7 647.6 654.8 665.1 669.3 672.5 566.8 594.2 657.7 670.3 695.4 8841.7 8877.0 9047.9 9352.3 9668.8 547.7 670.3 673.7 679.9 689.3 3709.2 4034.5 4669.6 4684.1 4716.3 94045.0 95070.5 129882.0 130641.0 151989.0 123081.4 137628.3 139003.3 140562.0 143828.3 117253.0 119968.0 121276.4 122383.0 124718.0 8618.7 9022.6 9036.4 9168.9 9247.7 66485.3 66995.3 67070.0 68008.0 69952.0 95389.5 100474.0 102328.0 103349.0 107808.5 11690.8 11714.4 11742.4 11900.5 12019.6 12238.0 12506.1 13002.9 13088.5 13721.1 11937.0 12040.4 12248.1 12662.3 12776.2 12818.4 13078.7 13392.9 14004.4 14134.3 12524.8 12642.7 13897.7 13940.5 13953.6 10727.2 11172.5 11655.4 11692.9 11974.9 9700.7 10536.9 11585.6 11739.7 11845.5 08:13:50 INFO - PROCESS | 1651 | -------- Summary: end -------- 08:13:50 INFO - PROCESS | 1651 | 08:13:50 INFO - TEST-INFO | 1651: exit 0 08:13:50 INFO - TEST-OK | dromaeo_css | took 1116766ms 08:13:50 INFO - TEST-START | kraken 08:13:50 INFO - operating with platform_type : mac_ 08:13:50 INFO - Initialising browser for kraken test... 08:13:50 INFO - TEST-INFO | started process 1658 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/tmpKqZz2P/profile http://localhost:49276/getInfo.html) 08:13:53 INFO - PROCESS | 1658 | __metrics Screen width/height:1600/1200 08:13:53 INFO - PROCESS | 1658 | colorDepth:24 08:13:53 INFO - PROCESS | 1658 | Browser inner width/height: 1024/689 08:13:53 INFO - PROCESS | 1658 | __metrics 08:13:53 INFO - PROCESS | 1658 | 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" 08:13:53 INFO - PROCESS | 1658 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:13:53 INFO - TEST-INFO | 1658: exit 0 08:13:53 INFO - Browser initialized. 08:13:53 INFO - Running cycle 1/1 for kraken test... 08:13:53 INFO - TEST-INFO | started process 1659 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/tmpKqZz2P/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:14:05 INFO - PROCESS | 1659 | RSS: Main: 219496448 08:14:05 INFO - PROCESS | 1659 | 08:14:08 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-beat-detection) 08:14:09 INFO - PROCESS | 1659 | RSS: Main: 269406208 08:14:09 INFO - PROCESS | 1659 | 08:14:11 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-dft) 08:14:12 INFO - PROCESS | 1659 | RSS: Main: 281419776 08:14:12 INFO - PROCESS | 1659 | 08:14:15 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-fft) 08:14:16 INFO - PROCESS | 1659 | RSS: Main: 379170816 08:14:16 INFO - PROCESS | 1659 | 08:14:18 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-oscillator) 08:14:18 INFO - PROCESS | 1659 | RSS: Main: 279322624 08:14:18 INFO - PROCESS | 1659 | 08:14:20 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:14:21 INFO - PROCESS | 1659 | RSS: Main: 281083904 08:14:21 INFO - PROCESS | 1659 | 08:14:24 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-darkroom) 08:14:24 INFO - PROCESS | 1659 | RSS: Main: 318128128 08:14:24 INFO - PROCESS | 1659 | 08:14:27 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-desaturate) 08:14:28 INFO - PROCESS | 1659 | RSS: Main: 319041536 08:14:28 INFO - PROCESS | 1659 | 08:14:31 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49276/tests/kraken/driver.html?testName=json-parse-financial) 08:14:31 INFO - PROCESS | 1659 | RSS: Main: 318291968 08:14:31 INFO - PROCESS | 1659 | 08:14:33 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49276/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:14:33 INFO - PROCESS | 1659 | RSS: Main: 290000896 08:14:33 INFO - PROCESS | 1659 | 08:14:35 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:14:36 INFO - PROCESS | 1659 | RSS: Main: 294510592 08:14:36 INFO - PROCESS | 1659 | 08:14:38 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:14:39 INFO - PROCESS | 1659 | RSS: Main: 303431680 08:14:39 INFO - PROCESS | 1659 | 08:14:41 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:14:42 INFO - PROCESS | 1659 | RSS: Main: 316542976 08:14:42 INFO - PROCESS | 1659 | 08:14:45 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:14:46 INFO - PROCESS | 1659 | RSS: Main: 310263808 08:14:46 INFO - PROCESS | 1659 | 08:14:47 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49276/tests/kraken/driver.html?testName=ai-astar) 08:14:48 INFO - PROCESS | 1659 | RSS: Main: 354050048 08:14:48 INFO - PROCESS | 1659 | 08:14:48 INFO - PROCESS | 1659 | __start_tp_report 08:14:48 INFO - PROCESS | 1659 | _x_x_mozilla_page_load 08:14:48 INFO - PROCESS | 1659 | _x_x_mozilla_page_load_details 08:14:48 INFO - PROCESS | 1659 | |i|pagename|runs| 08:14:48 INFO - PROCESS | 1659 | |0;ai-astar;115;114;114;111;113;112;112;111;112;112 08:14:48 INFO - PROCESS | 1659 | |1;audio-beat-detection;144;108;110;142;111;108;109;107;139;108 08:14:48 INFO - PROCESS | 1659 | |2;audio-dft;182;186;183;182;183;184;184;184;185;185 08:14:48 INFO - PROCESS | 1659 | |3;audio-fft;87;79;81;112;84;81;58;59;83;59 08:14:48 INFO - PROCESS | 1659 | |4;audio-oscillator;85;71;93;68;67;68;94;67;68;91 08:14:48 INFO - PROCESS | 1659 | |5;imaging-gaussian-blur;90;86;90;86;89;87;90;88;90;86 08:14:48 INFO - PROCESS | 1659 | |6;imaging-darkroom;98;110;169;127;99;98;102;98;98;99 08:14:48 INFO - PROCESS | 1659 | |7;imaging-desaturate;85;86;85;87;86;83;84;85;84;84 08:14:48 INFO - PROCESS | 1659 | |8;json-parse-financial;57;52;53;53;57;58;57;57;57;57 08:14:48 INFO - PROCESS | 1659 | |9;json-stringify-tinderbox;72;68;76;71;73;68;70;69;69;70 08:14:48 INFO - PROCESS | 1659 | |10;stanford-crypto-aes;83;82;85;82;82;82;85;84;84;90 08:14:48 INFO - PROCESS | 1659 | |11;stanford-crypto-ccm;139;140;135;138;137;136;140;143;170;151 08:14:48 INFO - PROCESS | 1659 | |12;stanford-crypto-pbkdf2;163;163;163;164;162;167;163;161;162;162 08:14:48 INFO - PROCESS | 1659 | |13;stanford-crypto-sha256-iterative;65;67;69;63;85;67;66;66;67;67 08:14:48 INFO - PROCESS | 1659 | __end_tp_report 08:14:48 INFO - PROCESS | 1659 | __start_cc_report 08:14:48 INFO - PROCESS | 1659 | _x_x_mozilla_cycle_collect,1985 08:14:48 INFO - PROCESS | 1659 | __end_cc_report 08:14:48 INFO - PROCESS | 1659 | __startTimestamp1477408488061__endTimestamp 08:14:48 INFO - PROCESS | 1659 | 08:14:48 INFO - PROCESS | 1659 | ------- Summary: start ------- 08:14:48 INFO - PROCESS | 1659 | Number of tests: 14 08:14:48 INFO - PROCESS | 1659 | 08:14:48 INFO - PROCESS | 1659 | [#0] ai-astar Cycles:10 Average:112.60 Median:112.50 stddev:1.35 (1.2%) stddev-sans-first:1.12 08:14:48 INFO - PROCESS | 1659 | Values: 115.0 114.0 114.0 111.0 113.0 112.0 112.0 111.0 112.0 112.0 08:14:48 INFO - PROCESS | 1659 | 08:14:48 INFO - PROCESS | 1659 | [#1] audio-beat-detection Cycles:10 Average:118.60 Median:110.50 stddev:16.00 (14.5%) stddev-sans-first:14.09 08:14:48 INFO - PROCESS | 1659 | Values: 144.0 108.0 110.0 142.0 111.0 108.0 109.0 107.0 139.0 108.0 08:14:48 INFO - PROCESS | 1659 | 08:14:48 INFO - PROCESS | 1659 | [#2] audio-dft Cycles:10 Average:183.80 Median:184.00 stddev:1.32 (0.7%) stddev-sans-first:1.22 08:14:48 INFO - PROCESS | 1659 | Values: 182.0 186.0 183.0 182.0 183.0 184.0 184.0 184.0 185.0 185.0 08:14:48 INFO - PROCESS | 1659 | 08:14:48 INFO - PROCESS | 1659 | [#3] audio-fft Cycles:10 Average:78.30 Median:81.00 stddev:16.46 (20.3%) stddev-sans-first:17.15 08:14:48 INFO - PROCESS | 1659 | Values: 87.0 79.0 81.0 112.0 84.0 81.0 58.0 59.0 83.0 59.0 08:14:48 INFO - PROCESS | 1659 | 08:14:48 INFO - PROCESS | 1659 | [#4] audio-oscillator Cycles:10 Average:77.20 Median:78.00 stddev:11.94 (15.3%) stddev-sans-first:12.33 08:14:48 INFO - PROCESS | 1659 | Values: 85.0 71.0 93.0 68.0 67.0 68.0 94.0 67.0 68.0 91.0 08:14:48 INFO - PROCESS | 1659 | 08:14:48 INFO - PROCESS | 1659 | [#5] imaging-gaussian-blur Cycles:10 Average:88.20 Median:89.50 stddev:1.81 (2.0%) stddev-sans-first:1.80 08:14:48 INFO - PROCESS | 1659 | Values: 90.0 86.0 90.0 86.0 89.0 87.0 90.0 88.0 90.0 86.0 08:14:48 INFO - PROCESS | 1659 | 08:14:48 INFO - PROCESS | 1659 | [#6] imaging-darkroom Cycles:10 Average:109.80 Median:98.00 stddev:22.73 (23.2%) stddev-sans-first:23.71 08:14:48 INFO - PROCESS | 1659 | Values: 98.0 110.0 169.0 127.0 99.0 98.0 102.0 98.0 98.0 99.0 08:14:48 INFO - PROCESS | 1659 | 08:14:48 INFO - PROCESS | 1659 | [#7] imaging-desaturate Cycles:10 Average:84.90 Median:85.00 stddev:1.20 (1.4%) stddev-sans-first:1.27 08:14:48 INFO - PROCESS | 1659 | Values: 85.0 86.0 85.0 87.0 86.0 83.0 84.0 85.0 84.0 84.0 08:14:48 INFO - PROCESS | 1659 | 08:14:48 INFO - PROCESS | 1659 | [#8] json-parse-financial Cycles:10 Average:55.80 Median:57.00 stddev:2.20 (3.9%) stddev-sans-first:2.29 08:14:48 INFO - PROCESS | 1659 | Values: 57.0 52.0 53.0 53.0 57.0 58.0 57.0 57.0 57.0 57.0 08:14:48 INFO - PROCESS | 1659 | 08:14:48 INFO - PROCESS | 1659 | [#9] json-stringify-tinderbox Cycles:10 Average:70.60 Median:70.50 stddev:2.50 (3.6%) stddev-sans-first:2.60 08:14:48 INFO - PROCESS | 1659 | Values: 72.0 68.0 76.0 71.0 73.0 68.0 70.0 69.0 69.0 70.0 08:14:48 INFO - PROCESS | 1659 | 08:14:48 INFO - PROCESS | 1659 | [#10] stanford-crypto-aes Cycles:10 Average:83.90 Median:84.00 stddev:2.47 (2.9%) stddev-sans-first:2.60 08:14:48 INFO - PROCESS | 1659 | Values: 83.0 82.0 85.0 82.0 82.0 82.0 85.0 84.0 84.0 90.0 08:14:48 INFO - PROCESS | 1659 | 08:14:48 INFO - PROCESS | 1659 | [#11] stanford-crypto-ccm Cycles:10 Average:142.90 Median:140.00 stddev:10.55 (7.5%) stddev-sans-first:11.09 08:14:48 INFO - PROCESS | 1659 | Values: 139.0 140.0 135.0 138.0 137.0 136.0 140.0 143.0 170.0 151.0 08:14:48 INFO - PROCESS | 1659 | 08:14:48 INFO - PROCESS | 1659 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.00 Median:163.00 stddev:1.63 (1.0%) stddev-sans-first:1.73 08:14:48 INFO - PROCESS | 1659 | Values: 163.0 163.0 163.0 164.0 162.0 167.0 163.0 161.0 162.0 162.0 08:14:48 INFO - PROCESS | 1659 | 08:14:48 INFO - PROCESS | 1659 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.20 Median:67.00 stddev:6.11 (9.1%) stddev-sans-first:6.37 08:14:48 INFO - PROCESS | 1659 | Values: 65.0 67.0 69.0 63.0 85.0 67.0 66.0 66.0 67.0 67.0 08:14:48 INFO - PROCESS | 1659 | -------- Summary: end -------- 08:14:48 INFO - PROCESS | 1659 | 08:14:48 INFO - TEST-INFO | 1659: exit 0 08:14:48 INFO - TEST-OK | kraken | took 58051ms 08:14:48 INFO - SUITE-END | took 1174s 08:14:49 INFO - Completed test suite (00:19:35) 08:14:49 INFO - javascript benchmark 08:14:49 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3324.3517514084756, 3329.5338652588644, 3343.5486209361743, 3351.4135026370377, 3382.1206486313567, 4714.71711697298, 5581.888362232763, 5582.8325150245455, 5637.943620563793, 5679.204911312419, 4770.332153498504, 5584.329880414346, 5595.020871347519, 5658.981383350995, 5668.68822214778, 5138.049460849736, 5146.202338637517, 5170.948290517084, 5277.287566178555, 5283.920741188886, 5136.537711605954, 5137.12668846297, 5138.511841375063, 5147.1764517677175, 5226.3989641191365, 5226.320578324831, 5253.474652534755, 5260.105782017066, 5264.394594621629, 5279.102552566073, 5231.555317797973, 5257.973710131463, 5263.368395792491, 5267.420583735786, 5288.2596436498925, 5067.0, 5139.015553595365, 5197.454267301917, 5202.661826981234, 5223.4776522347465, 5510.283663123768, 5526.806561770359, 5589.916151257735, 5592.96530141921, 5606.859828504279, 5995.880082398371, 6043.848903777397, 6046.576739628228, 6079.179310793031, 6129.325774164839, 6085.878282434371, 6150.231221097363, 6153.476954458876, 6158.384161583851, 6184.443400094013, 5567.638103523299, 5626.578006649435, 5662.122371032497, 5677.51741102011, 5689.743961521742, 6305.747770089237, 6328.810135695937, 6333.904991425133, 6346.492280617539, 6349.174607301114, 6007.849803754941, 6088.360722124202, 6102.542309326818, 6114.602550834182, 6129.754809807647, 6033.698315084228, 6116.3883611638485, 6128.63228206309, 6254.906176407358, 6267.905981410283, 6014.097885317237, 6046.637201767908, 6102.267727872683, 6102.298235702862, 6104.8506609112055, 6039.872949919138, 6130.642739936519, 6162.630242185483, 6172.382761723881, 6188.44304012641, 4889.193283108248, 4895.632827537877, 4897.534734200245, 4901.583365413909, 4955.306257124005, 4335.263005289108, 4344.326629372389, 4388.385626012361, 4409.5149533551285, 4450.688451808407, 5614.2701448811395, 5641.26663533738, 5671.688057156896, 5686.3744988051285, 5714.799892022722, 6202.749569600004, 6227.377262273736, 6233.532485063548, 6240.126382306481, 6241.001439769615, 5662.518685911661, 5723.0, 5738.5982981191755, 5755.65466072037, 5776.220210271644, 5249.632525723163, 5289.629725919226, 5293.867653308698, 5299.867503312448, 5349.277847490539, 6255.311915689271, 6314.084457753508, 6316.463100636497, 6318.241810982711, 6318.304986451579, 6185.134081228722, 6224.751009959551, 6240.469560087444, 6257.9687101564205, 6275.435210831047, 6207.565470417027, 6252.5935814171935, 6269.529785266032, 6279.623222606659, 6325.778597749057, 6067.059605761114, 6118.4668989547035, 6126.181801870855, 6144.556029333014, 6145.723442445012, 6227.06594010902, 6238.563300568917, 6238.875222495615, 6238.968805155945, 6240.438360547572, 4985.351904252424, 5797.8550536236935, 6043.0, 6076.0, 6082.60463069899, 5863.413658634273, 5928.762849486145, 5972.25346831646, 5973.402659733992, 5976.342602313655, 5806.970965145148, 5811.041178205549, 5811.622244554091, 5820.738066787089, 5836.328822185334, 5498.5876059294915, 5570.774429625476, 5935.2877654681715, 5983.431574000463, 5986.4013598639785, 5796.21751063601, 5806.158107074535, 5823.94176058234, 5832.970835145967, 5856.150858125633], "value": 5628.285552030783, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [476.952304769523, 506.7339646685492, 509.19547115557447, 518.9299444574982, 526.5366477499799, 27315.18054458367, 37435.81282093593, 40685.79657101714, 40999.18001639965, 43202.56797432033, 42070.57929420705, 42115.94710132248, 42486.15027699444, 42570.36144457828, 42638.147237055244, 8701.56492175392, 9771.609135634584, 9933.552990115462, 9937.751556211117, 9946.90053099467, 8760.561971901412, 8966.372353935227, 8983.46099234048, 8985.820283594325, 11951.282923024602, 11903.642890713292, 12201.572944946929, 12204.023678105774, 12215.022798176169, 12225.266484010988, 12147.514099436055, 12200.267983920949, 12230.510779568807, 12235.816462752977, 12236.449359778831, 8713.215810577078, 8936.151065648754, 11729.0, 12008.759824803543, 12101.636950891487, 40429.393559096636, 40603.593964060274, 40679.0, 40705.18589628221, 40865.0, 3323.5347051412823, 3335.2495688470144, 3342.064222017839, 3354.882579109744, 3400.132966093655, 28997.71002289971, 30896.918607848842, 31382.52926206109, 31704.0, 31858.0, 3182.80903145812, 3192.904212873594, 3216.45320295548, 3232.69289417505, 3282.770206085575, 511825.0, 513517.43241283554, 513815.4309228467, 515726.0, 517980.0, 58090.709546451995, 58361.0, 58372.70813645905, 58579.41420585825, 58635.0, 61956.0, 61985.76028479405, 62003.0, 62011.68994155, 62089.0, 14696.41214351414, 16749.413770517975, 16775.91612041932, 16790.66418671644, 16790.908590941548, 13059.151155174883, 13113.868861311455, 13134.868651313365, 13155.144915580457, 13213.207207567577, 13647.0, 13916.582502524738, 13961.65095872591, 14283.214423206824, 15616.76574851378, 4765.229533950073, 6168.19813424252, 6323.146375239284, 6490.870182596416, 6804.149481314836, 878.2885862451307, 974.8635191073255, 1006.0894890124449, 1014.3457469931852, 1030.9175265978704, 28807.38522954092, 29835.701642983728, 30219.244518887204, 30440.391192176034, 30502.54246186309, 966.521222529531, 989.2135752076972, 1044.4099084017657, 1071.1751950997843, 1123.702218911989, 14996.0, 15374.461893833886, 15712.842871571367, 15715.978461400202, 15779.921100394424, 664309.0, 667855.0, 668422.0, 669074.0, 672767.0, 49203.50796492061, 50048.49951500438, 56160.0, 56349.43650563524, 57019.71490142523, 1339.9933000334936, 1347.2455424962052, 1374.1960952842699, 1374.5257886029303, 1382.3433868912387, 29911.55132672968, 30797.538036929913, 30912.845435773575, 31188.064358069296, 31501.684983149877, 48679.756601216766, 49091.509084910125, 49109.50890491192, 49243.50756492533, 49341.2598811011, 685169.0, 699537.0, 699682.0, 887736.0, 888621.0, 25559.74440255648, 25860.094896678525, 25866.741332587186, 25898.0, 26004.86997565, 43692.34461483144, 44544.0, 45003.0, 45680.62958111262, 45990.0, 37447.0, 37805.24389512139, 38025.80987095047, 38147.28337224776, 39389.21221575495, 34679.30641387209, 35286.647133528335, 37175.81412093031, 37180.25639487141, 38447.80776096102, 36318.0, 36908.81545592362, 37182.070448239014, 37437.251254975294, 37478.81260593679, 31991.360172795947, 33075.783498521385, 33320.333593327516, 33766.98699039033, 33993.660063400035, 25294.494110118063, 25411.87294063592, 25414.491710165323, 25471.490570188864, 25815.096471623405], "value": 20075.15366358656, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [350.73694728953285, 356.8733099749589, 375.6543979538824, 381.8110035532411, 405.5944055944056, 15123.848761512396, 15469.922650386747, 16569.66860662786, 21029.0, 21154.788452115474, 19878.304259350927, 20320.898395508, 20820.0, 21066.36800895972, 21086.683699744517, 4444.377787109807, 5676.091825307941, 5913.438223368773, 5924.88150236995, 5925.644461332334, 4163.208990291835, 4404.317330813729, 5730.19777231188, 5780.248567686216, 5858.326292476378, 4231.238377092122, 6359.268684101318, 6626.8674626507445, 6648.368405001517, 6722.462203023746, 6306.243250809886, 6414.518911081665, 6622.1722284714415, 6622.602643841385, 6705.061291419205, 5750.856228594319, 5751.511121554673, 5752.769889204426, 5760.74076666551, 5761.827145185651, 23364.299071027726, 24237.394065148514, 24396.26811195667, 25431.61852572213, 25650.102246421473, 2158.7085743424595, 2209.2598979341938, 2221.7889300516426, 2296.2307626944994, 2351.917682881091, 9688.70933871985, 10348.741281468023, 10703.464826758709, 11252.0, 16156.353745850152, 1855.1466325490292, 1858.637565674694, 1903.2862676496313, 1941.825235728777, 1998.570307383905, 110482.0, 120868.39565802203, 126671.0, 126693.36653316766, 127887.44225115445, 11181.273217240854, 11464.31214127155, 11471.54113835454, 11548.711282218012, 11997.100217483723, 14404.495842645667, 14435.133891966516, 14448.855511444961, 14453.49412770548, 14454.783178252335, 8460.8730869037, 8651.740447786577, 8691.739247822576, 8759.2992560595, 8810.0, 8715.346349023848, 8719.645695662262, 8731.60707768152, 8908.73273801787, 8917.464952102895, 4368.170047690992, 4452.9109417812115, 4455.309427038814, 4534.79593418297, 4548.249538826057, 1461.494660499687, 1584.6513766971248, 1889.1876493108095, 1897.1557656842572, 1956.4815323939167, 781.4842204145236, 910.3991365698607, 910.7085732565648, 970.0171971188623, 1013.0477351289765, 20407.4898127548, 21110.683339749918, 21315.78684213169, 21553.892230538746, 21594.244201453188, 839.9752302191317, 957.8323793336139, 973.0707174648194, 992.7617371830709, 1000.0799264676515, 9486.478243696525, 10259.127974122133, 11112.722181945353, 11434.428278586203, 11453.427328633536, 525543.0, 574831.0, 588821.0, 596773.0, 597878.0, 130069.0, 132137.0, 132944.5630056086, 135575.32212338876, 136413.0, 964.6671898195111, 975.4342481360794, 983.5721461164417, 1001.3591301567003, 1006.7785087280787, 14804.0, 18692.813071869106, 19534.511637208616, 20007.899960500104, 20118.0, 45105.774471127435, 51779.0, 51957.48042519527, 52189.95620087653, 55391.72304138453, 74046.25953740394, 77306.0, 78634.6068269655, 79633.0, 80498.19501805141, 5488.368837583729, 6819.795406137824, 7895.368370530229, 7925.365970722443, 8308.086110527958, 10885.891141088488, 12428.62714118578, 12458.937705311415, 12642.2414655121, 12916.418761155583, 10486.632967846088, 10958.342499450058, 10990.285631434252, 11040.613578524713, 11205.327680339205, 10556.313839600401, 10754.0, 10823.242373033812, 10977.83533246986, 11208.0, 11055.668329950115, 11182.944085279521, 11256.774864502828, 11321.0, 11381.829272560753, 7937.285644292041, 8136.75589732309, 8169.142240064708, 8401.915980840113, 8430.283425908867, 10081.596736130472, 10688.679339619825, 10874.401907894826, 10930.890691092987, 11017.228793984665], "value": 9511.368034104624, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1335.185536822538, 1512.4026009726163, 1635.1088656682107, 1724.9827501724978, 1833.9541511462212, 8395.076541580429, 8911.598978045988, 8912.554372281384, 8916.331275154356, 8956.283497320215, 7751.651175697093, 8009.5594742289295, 8020.318272946806, 8076.5154090754595, 8125.796855078626, 2153.924612638554, 2220.6565028157975, 2224.5439684864564, 2347.1315613223132, 2420.8426452280546, 2361.2089949866813, 2377.084822343393, 2402.615581506959, 2404.5551572959057, 2411.397150712322, 2399.700037495313, 2401.3756423329887, 2401.7958473529684, 2403.6995375578053, 2415.770501802335, 1988.8508361872846, 2383.3088404362716, 2384.892679829412, 2388.0209114263243, 2390.8565486070893, 2344.824138189643, 2357.10430036585, 2380.27401642499, 2381.273711517986, 2382.809375249976, 8675.783105422415, 8756.0, 8798.29613630908, 8809.383343165917, 8863.157999989991, 5179.585633149339, 5328.333958255218, 5329.2006199070065, 5334.706591137486, 5339.119045357511, 3000.849957502116, 3563.964360356389, 3588.4617307403837, 3631.9455208171635, 3638.417853143511, 1027.2963020331097, 1056.3609016544956, 1067.4395942130366, 1071.839224116381, 1087.8857719939372, 11482.253653512495, 11517.827232591519, 11522.76954460906, 11525.250858694242, 11525.538978440853, 4587.288970209623, 4606.608438282717, 4730.408698912636, 4783.832565860178, 4789.760511974388, 8516.190961858614, 9903.702888913343, 9910.20718342531, 9921.305508614329, 9946.751331216778, 5328.120860058047, 5347.438518955453, 5350.4649535046965, 5355.500459871242, 5359.785608575691, 4836.0, 4848.151573474628, 4867.367242258484, 4921.237208232729, 4929.309896614477, 3916.060145565101, 3952.150287688103, 3972.503437070366, 4016.0562267867026, 4058.797060146981, 1276.5213045108085, 1282.7178020835402, 1296.5915736542959, 1301.4013553765185, 1308.8233088533116, 814.8044469327318, 883.4919921045424, 889.621910687955, 915.1671978499534, 933.1741408853214, 5586.357568879631, 5787.074068149076, 5912.615679980788, 5959.135925290895, 5968.46283834457, 923.3398120343986, 924.0805398628407, 953.0517135450272, 954.1555723185031, 987.7086259553449, 3872.8450861965207, 3933.056066544066, 3988.5669741457687, 4038.0510580013674, 4051.4530538376944, 9988.400695958266, 10609.522571484302, 10732.570697172181, 10749.40878251688, 10763.408012559228, 9046.457212567268, 10334.276600638033, 10699.411532365795, 10729.463526823627, 10769.299995500267, 7965.402594805297, 8221.17788221185, 8230.794230144294, 8240.752777416566, 8241.423100383035, 4435.600795928382, 5609.326880774333, 5629.971850140887, 5703.144528320619, 5723.627964182315, 9777.657781977596, 9819.018098190123, 9925.0, 9969.900300996896, 10098.697039088838, 8632.266257368194, 9847.753806154904, 10031.147352475122, 10300.124489418484, 10308.226882983656, 6532.869342613026, 6714.294999025227, 6728.798136055926, 6789.490788190807, 6796.864062718817, 7721.691132354643, 8291.668333266602, 8335.958320208603, 8447.113053129578, 8452.873206901779, 7281.308275713799, 7404.333609974912, 7415.184329723618, 7537.057867766529, 7589.696412143673, 6997.790066298019, 7199.388052015637, 7294.161171465349, 7310.305520975498, 7315.890261646186, 6245.7189426476825, 6959.304069593, 6964.686589103604, 6982.441404687715, 7003.404710599656, 4388.429504164438, 4873.098476781806, 4925.088858561177, 5002.199648056294, 5028.170351891897, 4789.473157952552, 4916.139675556835, 4931.260310953242, 5106.795728170831, 5112.412072611697], "value": 4537.822045692594, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [294.4317467288133, 300.7729164480817, 309.1760458378421, 313.2560169597207, 315.60706919884746, 4577.816887324511, 4915.844776477529, 5162.038425398343, 5222.425533191351, 5355.714628489164, 4518.412606361168, 4532.002959348946, 4595.8621241362725, 5065.263978180395, 5190.636655434112, 3590.084528445243, 3872.244912242114, 4036.6073704571877, 4049.137396797477, 4076.859648684435, 3511.2801875615437, 4085.754854708712, 4107.79461026949, 4110.753354798707, 4117.382392641113, 3753.1930634913488, 3767.416050512175, 3978.6021397860272, 4058.594140585947, 4118.526369467505, 4054.7567145971334, 4059.97970010151, 4074.490688663917, 4084.5915408459214, 4096.774677392742, 3472.6700963408434, 3482.37317282889, 3495.5106285120105, 3504.229069604683, 3517.2262102337445, 4482.932756008629, 4947.876303092451, 5142.997115562467, 5246.868828279324, 5289.153735402318, 4610.608098311647, 4631.652626053025, 4638.466576343696, 4648.976755116203, 4686.859394218179, 5005.849824505234, 5599.32808063031, 5689.971550142222, 5699.572532060112, 5717.828465146053, 3007.548867669845, 3835.5780864104927, 3850.7689538627774, 3860.0, 3862.092408284051, 5503.944960550423, 5507.476789704971, 5740.9712951435395, 5829.07640478641, 5922.394146575493, 3740.831662575191, 3776.4524143999515, 3809.371453710107, 3848.9037774055873, 3869.96130038696, 3685.3734865073, 3892.4939757831303, 3902.687784977195, 3904.3255370071024, 3917.7061720371084, 4119.361498967664, 4433.977830110894, 4474.530174331713, 4553.476350219701, 4610.585047345755, 4468.50846406895, 4617.0, 5570.053090974463, 5658.708223169623, 5683.573731970118, 1263.829383033297, 1310.8558058613544, 1329.9933500332436, 1332.8600496947681, 1333.4866076560595, 762.649181376573, 807.6930766308765, 815.9469634473741, 820.4461988158089, 823.4441751817499, 3708.590735520485, 3880.186864523198, 4078.9184216316103, 4376.14665140301, 4468.821247150077, 4246.8725938221905, 4736.763161841963, 4767.0, 4836.758162091952, 4837.64545927141, 4009.558948515661, 4089.8548406446243, 4335.674824388184, 4425.601695847389, 4470.642348612103, 2301.367124040902, 2667.3862313300174, 3034.4689679306475, 3055.3125546751803, 3092.9381412372077, 5529.778808847682, 5590.6582420219665, 6012.368701286389, 6071.241094863142, 6075.848103797441, 5182.833862380934, 5851.297844258716, 6050.727717252734, 6063.878722425527, 6063.9090413643835, 5551.833444996576, 6016.375578593843, 6017.247844019497, 6024.7288872001745, 6035.547333949971, 5221.399539053057, 5287.709175995357, 5820.912686309794, 5834.0, 5864.824055278348, 4277.828886844616, 5041.495850414929, 5801.419858014334, 5857.707114644336, 5902.498287645598, 5819.254223732948, 6078.270607526948, 6100.816975490742, 6117.296510901303, 6119.296280927572, 3169.429502689538, 3901.088466651377, 3908.3941988990614, 3921.3725803871243, 3934.665553427876, 4717.43390793107, 5049.343585333883, 5852.3269823969085, 5882.882342353215, 5912.911306330495, 5353.491418315254, 5643.012472817322, 5664.26364572603, 5674.801381951612, 5714.485696287354, 5583.52036710264, 5620.18507316445, 5639.238702775073, 5664.85837854057, 5675.943240567542, 4693.9765301173275, 5296.735163241746, 5315.1230047043355, 5526.834194974157, 5562.860928476821, 5520.889582208413, 5601.271834661468, 5609.971950140223, 5641.548676105984, 5649.54803615718, 5494.09347457665, 5515.751791169327, 5521.282233309644, 5562.833115006556, 5586.608937374344], "value": 4023.4310929725993, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [714.5534041224234, 738.1792239705127, 739.4564994728873, 789.6446599030436, 812.3663542436898, 14599.635009124777, 15964.84035159648, 15976.281067351969, 15980.920095399506, 15993.040417574939, 14506.854931450682, 15241.390344386238, 15727.112746470411, 15958.441454549093, 16297.429589964353, 826.9131741167196, 860.5095095795368, 861.1990848510883, 862.8662557303596, 864.9827003459927, 655.2857385449859, 673.461231015186, 831.6423937706813, 848.6605357856876, 856.8243510080418, 893.1604291965532, 894.4186278918689, 895.1853813030144, 895.8118795053047, 895.852184389575, 891.9910800892005, 892.2371372476504, 892.6340200517822, 893.1515060692336, 893.1916615463016, 508.0854461968442, 523.2204016016109, 636.2524034259726, 652.5856081388305, 657.6317262333109, 15438.073715577102, 15461.845381546153, 15465.613359665986, 15477.458288959833, 15491.5352539424, 11083.224174307801, 13578.981576381811, 13669.658258543517, 13758.793618095737, 14271.500497482539, 11364.772704545945, 11470.885291147066, 11632.476538555786, 12017.519299228108, 12030.33833139177, 3252.658470860573, 3891.7664940103687, 3898.688104951597, 3995.2409042281874, 4002.4996875390575, 124330.0, 125027.74972250251, 125543.372283138, 126749.36625316906, 126790.3660481701, 10597.947010265054, 10927.726806829893, 10980.286281391684, 11019.173561982723, 11240.100791936626, 20070.39788806338, 20616.866072366163, 22145.55708885813, 22231.110755569596, 22307.665385019238, 7993.240642138988, 8027.117017128111, 8062.0, 8092.635831387602, 8212.712555060543, 4462.3752674625575, 4474.910501790011, 4506.864794056183, 4690.437147542317, 4764.951710623657, 3183.1882869868036, 3621.149029977953, 3716.4053751399647, 3722.181120153562, 3734.738568300247, 647.5758378262245, 654.8035589323184, 665.1187176990506, 669.2805234372971, 672.5292295393244, 566.784621843705, 594.1711312718733, 657.651444734282, 670.2827974067701, 695.4262733245093, 8841.717950897084, 8877.0, 9047.90952090484, 9352.345335826427, 9668.806623867484, 547.7069767674275, 670.3007875036758, 673.6598018000878, 679.8912174052128, 689.2934741889603, 3709.221063576625, 4034.5360283567766, 4669.626429885669, 4684.1334353144775, 4716.316134160527, 94045.0, 95070.52464737771, 129882.0, 130641.0, 151989.0, 123081.38459307647, 137628.31185844206, 139003.30498347443, 140562.0, 143828.28085859714, 117253.0, 119968.0, 121276.39361803311, 122383.0, 124718.0, 8618.741437756877, 9022.593983270637, 9036.367454278137, 9168.88877812928, 9247.676331328372, 66485.3351466479, 66995.3300466989, 67070.0, 68007.97988030282, 69951.95072073821, 95389.52305238429, 100473.96682232173, 102328.0, 103349.0, 107808.46095769471, 11690.76618467609, 11714.355710435668, 11742.354170520362, 11900.523979040741, 12019.579314723942, 12238.0, 12506.062045346453, 13002.869971300166, 13088.476460941456, 13721.108127971649, 11937.0, 12040.397980101136, 12248.14263001617, 12662.303573303558, 12776.169548979287, 12818.423170957143, 13078.738425231633, 13392.866071339162, 14004.43982240699, 14134.293285335898, 12524.812127818272, 12642.683932901751, 13897.72204555883, 13940.512082077079, 13953.581392558239, 10727.249092563758, 11172.497237624164, 11655.417229138679, 11692.883071169179, 11974.880251197725, 9700.708978730649, 10536.898055063368, 11585.594504192313, 11739.706507337385, 11845.526178952745], "value": 7789.5829214472815, "unit": "score"}], "name": "dromaeo_css", "value": 7312.186914615575, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 114.0, 114.0, 111.0, 113.0, 112.0, 112.0, 111.0, 112.0, 112.0], "value": 112.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 108.0, 110.0, 142.0, 111.0, 108.0, 109.0, 107.0, 139.0, 108.0], "value": 118.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 186.0, 183.0, 182.0, 183.0, 184.0, 184.0, 184.0, 185.0, 185.0], "value": 183.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 79.0, 81.0, 112.0, 84.0, 81.0, 58.0, 59.0, 83.0, 59.0], "value": 78.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 71.0, 93.0, 68.0, 67.0, 68.0, 94.0, 67.0, 68.0, 91.0], "value": 77.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 86.0, 90.0, 86.0, 89.0, 87.0, 90.0, 88.0, 90.0, 86.0], "value": 88.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 110.0, 169.0, 127.0, 99.0, 98.0, 102.0, 98.0, 98.0, 99.0], "value": 109.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 85.0, 87.0, 86.0, 83.0, 84.0, 85.0, 84.0, 84.0], "value": 84.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 52.0, 53.0, 53.0, 57.0, 58.0, 57.0, 57.0, 57.0, 57.0], "value": 55.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 68.0, 76.0, 71.0, 73.0, 68.0, 70.0, 69.0, 69.0, 70.0], "value": 70.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 85.0, 82.0, 82.0, 82.0, 85.0, 84.0, 84.0, 90.0], "value": 83.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 140.0, 135.0, 138.0, 137.0, 136.0, 140.0, 143.0, 170.0, 151.0], "value": 142.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 163.0, 164.0, 162.0, 167.0, 163.0, 161.0, 162.0, 162.0], "value": 163.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 67.0, 69.0, 63.0, 85.0, 67.0, 66.0, 66.0, 67.0, 67.0], "value": 68.2, "unit": "score"}], "name": "kraken", "value": 1437.8000000000002, "alertThreshold": 2.0}]} 08:14:49 INFO - Return code: 0 08:14:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:14:49 INFO - # TBPL SUCCESS # 08:14:49 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:14:49 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:14:49 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:14:49 INFO - 2016-10-25 08:14:49.406 screenresolution[1663:9833] starting screenresolution argv=screenresolution get 08:14:49 INFO - 2016-10-25 08:14:49.409 screenresolution[1663:9833] Display 0: 1600x1200x32@60 08:14:49 INFO - 2016-10-25 08:14:49.415 screenresolution[1664:9836] starting screenresolution argv=screenresolution list 08:14:49 INFO - Available Modes on Display 0 08:14:49 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:14:49 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:14:49 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:14:49 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:14:49 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:14:49 INFO - Intel Iris: 08:14:49 INFO - Chipset Model: Intel Iris 08:14:49 INFO - Type: GPU 08:14:49 INFO - Bus: Built-In 08:14:49 INFO - VRAM (Dynamic, Max): 1536 MB 08:14:49 INFO - Vendor: Intel (0x8086) 08:14:49 INFO - Device ID: 0x0a2e 08:14:49 INFO - Revision ID: 0x0009 08:14:49 INFO - Displays: 08:14:49 INFO - Display: 08:14:49 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:14:49 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:14:49 INFO - Display Serial Number: 1600x1200 60 08:14:49 INFO - Main Display: Yes 08:14:49 INFO - Mirror: Off 08:14:49 INFO - Online: Yes 08:14:49 INFO - Rotation: Supported 08:14:49 INFO - Return code: 0 08:14:49 INFO - Running post-action listener: _resource_record_post_action 08:14:49 INFO - [mozharness: 2016-10-25 15:14:49.657181Z] Finished run-tests step (success) 08:14:49 INFO - Running post-run listener: _resource_record_post_run 08:14:49 INFO - Total resource usage - Wall time: 1209s; CPU: 53.0%; Read bytes: 37590016; Write bytes: 662982656; Read time: 238; Write time: 1874 08:14:49 INFO - TinderboxPrint: CPU usage
53.5% 08:14:49 INFO - TinderboxPrint: I/O read bytes / time
37,590,016 / 238 08:14:49 INFO - TinderboxPrint: I/O write bytes / time
662,982,656 / 1,874 08:14:49 INFO - TinderboxPrint: CPU idle
2,251.3 (46.5%) 08:14:49 INFO - TinderboxPrint: CPU system
969.5 (20.0%) 08:14:49 INFO - TinderboxPrint: CPU user
1,616.9 (33.4%) 08:14:49 INFO - TinderboxPrint: Swap in / out
401,129,472 / 0 08:14:49 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 361369088; Write bytes: 355543040; Read time: 28631; Write time: 725 08:14:49 INFO - run-tests - Wall time: 1176s; CPU: 53.0%; Read bytes: 31349760; Write bytes: 297244672; Read time: 186; Write time: 1113 08:14:50 INFO - Running post-run listener: _upload_blobber_files 08:14:50 INFO - Blob upload gear active. 08:14:50 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:14:50 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 08:14:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:14:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:14:50 INFO - (blobuploader) - INFO - Open directory for files ... 08:14:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:14:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:14:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:14:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:14:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:14:51 INFO - (blobuploader) - INFO - Done attempting. 08:14:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:14:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:14:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:14:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:14:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:14:52 INFO - (blobuploader) - INFO - Done attempting. 08:14:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:14:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:14:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:14:54 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:14:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:14:54 INFO - (blobuploader) - INFO - Done attempting. 08:14:54 INFO - (blobuploader) - INFO - Iteration through files over. 08:14:54 INFO - Return code: 0 08:14:54 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:14:54 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:14:54 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/46eb30d23465dfafb698805892ff8f55d9b9a865700a644d54dc5fe9921f81ec09dc8459b640a5632d653ef7162562af513c44b2b06014de9ce7168d03a4ecf0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0d319fc5e7d93612403a62ccb0ca835b2146ec4c8473190825373d339106aa77148109437a6ca9ee0a6877f6170f261ade8eb6d86b7b08367e5970f704c819e6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/49a4d0ee8775d19b6a757fd3f37555976b0673375b03e2c136fd9e1ee69d8c267efe398c307e8d5f6d9e78013c527ef8d0e4362548f787dc016a1bcf36fc7931"} 08:14:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:14:54 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:14:54 INFO - Contents: 08:14:54 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/46eb30d23465dfafb698805892ff8f55d9b9a865700a644d54dc5fe9921f81ec09dc8459b640a5632d653ef7162562af513c44b2b06014de9ce7168d03a4ecf0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0d319fc5e7d93612403a62ccb0ca835b2146ec4c8473190825373d339106aa77148109437a6ca9ee0a6877f6170f261ade8eb6d86b7b08367e5970f704c819e6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/49a4d0ee8775d19b6a757fd3f37555976b0673375b03e2c136fd9e1ee69d8c267efe398c307e8d5f6d9e78013c527ef8d0e4362548f787dc016a1bcf36fc7931"} 08:14:54 INFO - Running post-run listener: copy_logs_to_upload_dir 08:14:54 INFO - Copying logs to upload dir... 08:14:54 INFO - mkdir: /builds/slave/test/build/upload/logs 08:14:54 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1270.110835 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-10-25 08:14:54.421998) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-25 08:14:54.425737) ========= 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.llhtPj19x7/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.AydXTVScSN/Listeners TMPDIR=/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/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/46eb30d23465dfafb698805892ff8f55d9b9a865700a644d54dc5fe9921f81ec09dc8459b640a5632d653ef7162562af513c44b2b06014de9ce7168d03a4ecf0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0d319fc5e7d93612403a62ccb0ca835b2146ec4c8473190825373d339106aa77148109437a6ca9ee0a6877f6170f261ade8eb6d86b7b08367e5970f704c819e6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/49a4d0ee8775d19b6a757fd3f37555976b0673375b03e2c136fd9e1ee69d8c267efe398c307e8d5f6d9e78013c527ef8d0e4362548f787dc016a1bcf36fc7931"} build_url:https://queue.taskcluster.net/v1/task/MCuVeSfqRiOGvtH7rQEjCQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011178 build_url: 'https://queue.taskcluster.net/v1/task/MCuVeSfqRiOGvtH7rQEjCQ/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/46eb30d23465dfafb698805892ff8f55d9b9a865700a644d54dc5fe9921f81ec09dc8459b640a5632d653ef7162562af513c44b2b06014de9ce7168d03a4ecf0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0d319fc5e7d93612403a62ccb0ca835b2146ec4c8473190825373d339106aa77148109437a6ca9ee0a6877f6170f261ade8eb6d86b7b08367e5970f704c819e6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/49a4d0ee8775d19b6a757fd3f37555976b0673375b03e2c136fd9e1ee69d8c267efe398c307e8d5f6d9e78013c527ef8d0e4362548f787dc016a1bcf36fc7931"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-25 08:14:54.458585) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-25 08:14:54.458980) ========= 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.llhtPj19x7/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.AydXTVScSN/Listeners TMPDIR=/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/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.005301 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-25 08:14:54.508385) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-25 08:14:54.508735) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-25 08:14:54.509119) ========= ========= Total master_lag: 3.47 =========