builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0173 starttime: 1476709001.1 results: success (0) buildid: 20161017034236 builduid: 95692864c7a24bd8b7c4d6974a563527 revision: 89734b85a2ef68ffd6260ba99f601486d2d3f5e5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-17 05:56:41.097100) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-17 05:56:41.097525) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-17 05:56:41.097803) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-17 05:56:41.125586) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 05:56:41.126115) ========= 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.2kEUODjIDB/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.XUBWGflwlD/Listeners TMPDIR=/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/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-17 05:56:41-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 15.3M=0.001s 2016-10-17 05:56:41 (15.3 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.126207 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 05:56:41.275803) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 05:56:41.276140) ========= 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.2kEUODjIDB/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.XUBWGflwlD/Listeners TMPDIR=/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/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.027778 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 05:56:41.329375) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-10-17 05:56:41.329729) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 89734b85a2ef68ffd6260ba99f601486d2d3f5e5 --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 89734b85a2ef68ffd6260ba99f601486d2d3f5e5 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.2kEUODjIDB/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.XUBWGflwlD/Listeners TMPDIR=/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/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-17 05:56:41,408 truncating revision to first 12 chars 2016-10-17 05:56:41,409 Setting DEBUG logging. 2016-10-17 05:56:41,409 attempt 1/10 2016-10-17 05:56:41,409 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/89734b85a2ef?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-17 05:56:43,299 unpacking tar archive at: mozilla-aurora-89734b85a2ef/testing/mozharness/ program finished with exit code 0 elapsedTime=2.185201 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-10-17 05:56:43.538476) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-17 05:56:43.538801) ========= script_repo_revision: 89734b85a2ef68ffd6260ba99f601486d2d3f5e5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-17 05:56:43.542219) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-17 05:56:43.542493) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-17 05:56:43.560653) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-10-17 05:56:43.561042) ========= /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.2kEUODjIDB/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.XUBWGflwlD/Listeners TMPDIR=/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/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 05:56:43 INFO - MultiFileLogger online at 20161017 05:56:43 in /builds/slave/test 05:56:43 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 05:56:43 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:56:43 INFO - {'append_to_log': False, 05:56:43 INFO - 'base_work_dir': '/builds/slave/test', 05:56:43 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 05:56:43 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:56:43 INFO - 'branch': 'Mozilla-Aurora', 05:56:43 INFO - 'buildbot_json_path': 'buildprops.json', 05:56:43 INFO - 'config_files': ('talos/mac_config.py',), 05:56:43 INFO - 'default_actions': ('clobber', 05:56:43 INFO - 'read-buildbot-config', 05:56:43 INFO - 'download-and-extract', 05:56:43 INFO - 'populate-webroot', 05:56:43 INFO - 'create-virtualenv', 05:56:43 INFO - 'install', 05:56:43 INFO - 'run-tests'), 05:56:43 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:56:43 INFO - 'download_minidump_stackwalk': True, 05:56:43 INFO - 'download_symbols': 'ondemand', 05:56:43 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:56:43 INFO - 'tooltool.py': '/tools/tooltool.py', 05:56:43 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:56:43 INFO - '/tools/misc-python/virtualenv.py')}, 05:56:43 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:56:43 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:56:43 INFO - 'installer_path': 'installer.exe', 05:56:43 INFO - 'log_level': 'info', 05:56:43 INFO - 'log_name': 'talos', 05:56:43 INFO - 'log_to_console': True, 05:56:43 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:56:43 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:56:43 INFO - 'opt_config_files': (), 05:56:43 INFO - 'pip_index': False, 05:56:43 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:56:43 INFO - 'cmd': ('bash', 05:56:43 INFO - '-c', 05:56:43 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:56:43 INFO - 'enabled': True, 05:56:43 INFO - 'halt_on_failure': False, 05:56:43 INFO - 'name': 'check_screen_resolution'},), 05:56:43 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:56:43 INFO - 'cmd': ('bash', 05:56:43 INFO - '-c', 05:56:43 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:56:43 INFO - 'enabled': True, 05:56:43 INFO - 'halt_on_failure': False, 05:56:43 INFO - 'name': 'check_screen_resolution'},), 05:56:43 INFO - 'run_cmd_checks_enabled': True, 05:56:43 INFO - 'sps_profile': False, 05:56:43 INFO - 'sps_profile_interval': 0, 05:56:43 INFO - 'suite': 'dromaeojs', 05:56:43 INFO - 'system_bits': '32', 05:56:43 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:56:43 INFO - 'title': 't-yosemite-r7-0173', 05:56:43 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:56:43 INFO - 'use_talos_json': True, 05:56:43 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:56:43 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:56:43 INFO - 'work_dir': 'build'} 05:56:43 INFO - [mozharness: 2016-10-17 12:56:43.762602Z] Running clobber step. 05:56:43 INFO - Running pre-action listener: _resource_record_pre_action 05:56:43 INFO - Running main action method: clobber 05:56:43 INFO - rmtree: /builds/slave/test/build 05:56:43 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:56:45 INFO - Running post-action listener: _resource_record_post_action 05:56:45 INFO - [mozharness: 2016-10-17 12:56:45.926808Z] Finished clobber step (success) 05:56:45 INFO - [mozharness: 2016-10-17 12:56:45.926934Z] Running read-buildbot-config step. 05:56:45 INFO - Running pre-action listener: _resource_record_pre_action 05:56:45 INFO - Running main action method: read_buildbot_config 05:56:45 INFO - Using buildbot properties: 05:56:45 INFO - { 05:56:45 INFO - "project": "", 05:56:45 INFO - "product": "firefox", 05:56:45 INFO - "script_repo_revision": "production", 05:56:45 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 05:56:45 INFO - "repository": "", 05:56:45 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 05:56:45 INFO - "buildid": "20161017034236", 05:56:45 INFO - "pgo_build": "False", 05:56:45 INFO - "basedir": "/builds/slave/test", 05:56:45 INFO - "buildnumber": 89, 05:56:45 INFO - "slavename": "t-yosemite-r7-0173", 05:56:45 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 05:56:45 INFO - "platform": "yosemite_r7", 05:56:45 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 05:56:45 INFO - "branch": "mozilla-aurora", 05:56:45 INFO - "repo_path": "releases/mozilla-aurora", 05:56:45 INFO - "revision": "89734b85a2ef68ffd6260ba99f601486d2d3f5e5", 05:56:45 INFO - "stage_platform": "macosx64", 05:56:45 INFO - "builduid": "95692864c7a24bd8b7c4d6974a563527", 05:56:45 INFO - "slavebuilddir": "test" 05:56:45 INFO - } 05:56:45 INFO - Found installer url https://queue.taskcluster.net/v1/task/bwx1jE75TEGHl4ovoWlrmA/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 05:56:45 INFO - Running post-action listener: _resource_record_post_action 05:56:45 INFO - [mozharness: 2016-10-17 12:56:45.930002Z] Finished read-buildbot-config step (success) 05:56:45 INFO - [mozharness: 2016-10-17 12:56:45.930111Z] Running download-and-extract step. 05:56:45 INFO - Running pre-action listener: _resource_record_pre_action 05:56:45 INFO - Running main action method: download_and_extract 05:56:45 INFO - mkdir: /builds/slave/test/build/tests 05:56:45 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')]} 05:56:45 INFO - trying https://queue.taskcluster.net/v1/task/bwx1jE75TEGHl4ovoWlrmA/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 05:56:45 INFO - Downloading https://queue.taskcluster.net/v1/task/bwx1jE75TEGHl4ovoWlrmA/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 05:56:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bwx1jE75TEGHl4ovoWlrmA/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 05:56:47 INFO - Downloaded 1199 bytes. 05:56:47 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 05:56:47 INFO - Using the following test package requirements: 05:56:47 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 05:56:47 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 05:56:47 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 05:56:47 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 05:56:47 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 05:56:47 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 05:56:47 INFO - u'jsshell-mac.zip'], 05:56:47 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 05:56:47 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 05:56:47 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 05:56:47 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 05:56:47 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 05:56:47 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 05:56:47 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 05:56:47 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 05:56:47 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 05:56:47 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 05:56:47 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 05:56:47 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 05:56:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bwx1jE75TEGHl4ovoWlrmA/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 05:56:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bwx1jE75TEGHl4ovoWlrmA/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 05:56:47 INFO - Fetch https://queue.taskcluster.net/v1/task/bwx1jE75TEGHl4ovoWlrmA/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 05:56:47 INFO - Expected file size: 16435292 05:56:54 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 05:56:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bwx1jE75TEGHl4ovoWlrmA/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 05:56:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bwx1jE75TEGHl4ovoWlrmA/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 05:56:54 INFO - Fetch https://queue.taskcluster.net/v1/task/bwx1jE75TEGHl4ovoWlrmA/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 05:56:55 INFO - Expected file size: 16435292 05:57:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bwx1jE75TEGHl4ovoWlrmA/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 05:57:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bwx1jE75TEGHl4ovoWlrmA/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 05:57:02 INFO - Fetch https://queue.taskcluster.net/v1/task/bwx1jE75TEGHl4ovoWlrmA/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 05:57:02 INFO - Expected file size: 14414081 05:57:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:57:03 INFO - trying https://queue.taskcluster.net/v1/task/bwx1jE75TEGHl4ovoWlrmA/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 05:57:03 INFO - Downloading https://queue.taskcluster.net/v1/task/bwx1jE75TEGHl4ovoWlrmA/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 05:57:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bwx1jE75TEGHl4ovoWlrmA/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 05:57:06 INFO - Downloaded 115424505 bytes. 05:57:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bwx1jE75TEGHl4ovoWlrmA/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 05:57:06 INFO - mkdir: /builds/slave/test/properties 05:57:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:57:06 INFO - Writing to file /builds/slave/test/properties/build_url 05:57:06 INFO - Contents: 05:57:06 INFO - build_url:https://queue.taskcluster.net/v1/task/bwx1jE75TEGHl4ovoWlrmA/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 05:57:06 INFO - Running post-action listener: _resource_record_post_action 05:57:06 INFO - Running post-action listener: set_extra_try_arguments 05:57:06 INFO - [mozharness: 2016-10-17 12:57:06.910059Z] Finished download-and-extract step (success) 05:57:06 INFO - [mozharness: 2016-10-17 12:57:06.910183Z] Running populate-webroot step. 05:57:06 INFO - Running pre-action listener: _resource_record_pre_action 05:57:06 INFO - Running main action method: populate_webroot 05:57:06 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:57:06 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:57:06 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:57:06 INFO - '--tppagecycles', 05:57:06 INFO - '7'], 05:57:06 INFO - 'tests': ['tsvgm']}}, 05:57:06 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:57:06 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:57:06 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:57:06 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:57:06 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:57:06 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:57:06 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:57:06 INFO - 'talos_options': ['--disable-e10s'], 05:57:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:57:06 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:57:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:57:06 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:57:06 INFO - 'talos_options': ['--disable-e10s'], 05:57:06 INFO - 'tests': ['damp', 'tps']}, 05:57:06 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:57:06 INFO - 'tests': ['damp', 'tps']}, 05:57:06 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:57:06 INFO - 'tests': ['dromaeo_dom']}, 05:57:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:57:06 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:57:06 INFO - 'tests': ['basic_compositor_video']}, 05:57:06 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:57:06 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:57:06 INFO - 'tests': ['a11yr', 05:57:06 INFO - 'ts_paint', 05:57:06 INFO - 'tpaint', 05:57:06 INFO - 'sessionrestore', 05:57:06 INFO - 'sessionrestore_no_auto_restore', 05:57:06 INFO - 'tabpaint']}, 05:57:06 INFO - 'other-e10s': {'tests': ['a11yr', 05:57:06 INFO - 'ts_paint', 05:57:06 INFO - 'tpaint', 05:57:06 INFO - 'sessionrestore', 05:57:06 INFO - 'sessionrestore_no_auto_restore', 05:57:06 INFO - 'tabpaint']}, 05:57:06 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:57:06 INFO - 'ts_paint', 05:57:06 INFO - 'tpaint', 05:57:06 INFO - 'sessionrestore', 05:57:06 INFO - 'sessionrestore_no_auto_restore', 05:57:06 INFO - 'tabpaint']}, 05:57:06 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:57:06 INFO - 'ts_paint', 05:57:06 INFO - 'tpaint', 05:57:06 INFO - 'sessionrestore', 05:57:06 INFO - 'sessionrestore_no_auto_restore', 05:57:06 INFO - 'tabpaint']}, 05:57:06 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:57:06 INFO - 'tests': ['a11yr', 05:57:06 INFO - 'ts_paint', 05:57:06 INFO - 'tpaint', 05:57:06 INFO - 'sessionrestore', 05:57:06 INFO - 'sessionrestore_no_auto_restore', 05:57:06 INFO - 'tabpaint']}, 05:57:06 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:57:06 INFO - 'tests': ['a11yr', 05:57:06 INFO - 'ts_paint', 05:57:06 INFO - 'tpaint', 05:57:06 INFO - 'sessionrestore', 05:57:06 INFO - 'sessionrestore_no_auto_restore', 05:57:06 INFO - 'tabpaint']}, 05:57:06 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:57:06 INFO - 'tests': ['tsvgx', 05:57:06 INFO - 'tsvgr_opacity', 05:57:06 INFO - 'tart', 05:57:06 INFO - 'tscrollx', 05:57:06 INFO - 'cart']}, 05:57:06 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:57:06 INFO - 'tsvgr_opacity', 05:57:06 INFO - 'tart', 05:57:06 INFO - 'tscrollx', 05:57:06 INFO - 'cart']}, 05:57:06 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:57:06 INFO - 'talos_options': ['--disable-e10s'], 05:57:06 INFO - 'tests': ['tp5o']}, 05:57:06 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:57:06 INFO - 'tests': ['tp5o']}, 05:57:06 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:57:06 INFO - 'talos_options': ['--disable-e10s', 05:57:06 INFO - '--xperf_path', 05:57:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:57:06 INFO - 'tests': ['tp5n']}, 05:57:06 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:57:06 INFO - 'talos_options': ['--xperf_path', 05:57:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:57:06 INFO - 'tests': ['tp5n']}}, 05:57:06 INFO - 'talos.zip': {'path': '', 05:57:06 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:57:06 INFO - Running post-action listener: _resource_record_post_action 05:57:06 INFO - [mozharness: 2016-10-17 12:57:06.928591Z] Finished populate-webroot step (success) 05:57:06 INFO - [mozharness: 2016-10-17 12:57:06.928727Z] Running create-virtualenv step. 05:57:06 INFO - Running pre-action listener: _resource_record_pre_action 05:57:06 INFO - Running main action method: create_virtualenv 05:57:06 INFO - Creating virtualenv /builds/slave/test/build/venv 05:57:06 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 05:57:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:57:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:57:07 INFO - Using real prefix '/tools/python27' 05:57:07 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:57:07 INFO - Installing distribute.............................................................................................................................................................................................done. 05:57:10 INFO - Installing pip.................done. 05:57:10 INFO - Return code: 0 05:57:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:57:10 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')]} 05:57:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:57:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57:10 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')]} 05:57:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:57:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57:10 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 0x10894b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1088c1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdac955bdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10875fd30>, '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 0x1085c5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108757b20>, '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.2kEUODjIDB/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.XUBWGflwlD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/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 05:57:10 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 05:57:10 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 05:57:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2kEUODjIDB/Render', 05:57:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:57:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:57:10 INFO - 'HOME': '/Users/cltbld', 05:57:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:57:10 INFO - 'LOGNAME': 'cltbld', 05:57:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:57:10 INFO - 'MOZ_NO_REMOTE': '1', 05:57:10 INFO - 'NO_EM_RESTART': '1', 05:57:10 INFO - 'PAGER': '/bin/cat', 05:57:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:57:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:57:10 INFO - 'PWD': '/builds/slave/test', 05:57:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:57:10 INFO - 'SHELL': '/bin/bash', 05:57:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XUBWGflwlD/Listeners', 05:57:10 INFO - 'TMPDIR': '/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/', 05:57:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:57:10 INFO - 'USER': 'cltbld', 05:57:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:57:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:57:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:57:10 INFO - 'XPC_FLAGS': '0x0', 05:57:10 INFO - 'XPC_SERVICE_NAME': '0', 05:57:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:57:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:57:10 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 05:57:10 INFO - Cleaning up... 05:57:10 INFO - Return code: 0 05:57:10 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:57:10 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')]} 05:57:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:57:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57:10 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')]} 05:57:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:57:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57:10 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 0x10894b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1088c1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdac955bdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10875fd30>, '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 0x1085c5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108757b20>, '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.2kEUODjIDB/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.XUBWGflwlD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/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 05:57:10 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 05:57:10 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 05:57:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2kEUODjIDB/Render', 05:57:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:57:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:57:10 INFO - 'HOME': '/Users/cltbld', 05:57:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:57:10 INFO - 'LOGNAME': 'cltbld', 05:57:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:57:10 INFO - 'MOZ_NO_REMOTE': '1', 05:57:10 INFO - 'NO_EM_RESTART': '1', 05:57:10 INFO - 'PAGER': '/bin/cat', 05:57:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:57:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:57:10 INFO - 'PWD': '/builds/slave/test', 05:57:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:57:10 INFO - 'SHELL': '/bin/bash', 05:57:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XUBWGflwlD/Listeners', 05:57:10 INFO - 'TMPDIR': '/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/', 05:57:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:57:10 INFO - 'USER': 'cltbld', 05:57:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:57:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:57:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:57:10 INFO - 'XPC_FLAGS': '0x0', 05:57:10 INFO - 'XPC_SERVICE_NAME': '0', 05:57:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:57:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:57:11 INFO - Downloading/unpacking psutil>=3.1.1 05:57:11 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 05:57:11 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 05:57:11 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 05:57:11 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 05:57:11 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 05:57:11 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 05:57:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:57:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:57:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:57:13 INFO - Installing collected packages: psutil 05:57:13 INFO - Running setup.py install for psutil 05:57:13 INFO - building 'psutil._psutil_osx' extension 05:57:13 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 05:57:14 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 05:57:14 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 05:57:14 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 05:57:14 INFO - building 'psutil._psutil_posix' extension 05:57:14 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 05:57:14 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:57:14 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:57:14 INFO - ^ 05:57:14 INFO - 1 warning generated. 05:57:14 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 05:57:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:57:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:57:14 INFO - Successfully installed psutil 05:57:14 INFO - Cleaning up... 05:57:15 INFO - Return code: 0 05:57:15 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:57:15 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')]} 05:57:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:57:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57:15 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')]} 05:57:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:57:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57:15 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 0x10894b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1088c1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdac955bdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10875fd30>, '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 0x1085c5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108757b20>, '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.2kEUODjIDB/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.XUBWGflwlD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/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 05:57:15 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 05:57:15 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 05:57:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2kEUODjIDB/Render', 05:57:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:57:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:57:15 INFO - 'HOME': '/Users/cltbld', 05:57:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:57:15 INFO - 'LOGNAME': 'cltbld', 05:57:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:57:15 INFO - 'MOZ_NO_REMOTE': '1', 05:57:15 INFO - 'NO_EM_RESTART': '1', 05:57:15 INFO - 'PAGER': '/bin/cat', 05:57:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:57:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:57:15 INFO - 'PWD': '/builds/slave/test', 05:57:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:57:15 INFO - 'SHELL': '/bin/bash', 05:57:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XUBWGflwlD/Listeners', 05:57:15 INFO - 'TMPDIR': '/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/', 05:57:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:57:15 INFO - 'USER': 'cltbld', 05:57:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:57:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:57:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:57:15 INFO - 'XPC_FLAGS': '0x0', 05:57:15 INFO - 'XPC_SERVICE_NAME': '0', 05:57:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:57:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:57:15 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:57:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:57:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:57:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:57:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:57:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:57:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:57:17 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:57:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:57:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:57:17 INFO - Installing collected packages: mozsystemmonitor 05:57:17 INFO - Running setup.py install for mozsystemmonitor 05:57:18 INFO - Successfully installed mozsystemmonitor 05:57:18 INFO - Cleaning up... 05:57:18 INFO - Return code: 0 05:57:18 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:57:18 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')]} 05:57:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:57:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57:18 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')]} 05:57:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:57:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57:18 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 0x10894b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1088c1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdac955bdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10875fd30>, '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 0x1085c5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108757b20>, '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.2kEUODjIDB/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.XUBWGflwlD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/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 05:57:18 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 05:57:18 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 05:57:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2kEUODjIDB/Render', 05:57:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:57:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:57:18 INFO - 'HOME': '/Users/cltbld', 05:57:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:57:18 INFO - 'LOGNAME': 'cltbld', 05:57:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:57:18 INFO - 'MOZ_NO_REMOTE': '1', 05:57:18 INFO - 'NO_EM_RESTART': '1', 05:57:18 INFO - 'PAGER': '/bin/cat', 05:57:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:57:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:57:18 INFO - 'PWD': '/builds/slave/test', 05:57:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:57:18 INFO - 'SHELL': '/bin/bash', 05:57:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XUBWGflwlD/Listeners', 05:57:18 INFO - 'TMPDIR': '/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/', 05:57:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:57:18 INFO - 'USER': 'cltbld', 05:57:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:57:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:57:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:57:18 INFO - 'XPC_FLAGS': '0x0', 05:57:18 INFO - 'XPC_SERVICE_NAME': '0', 05:57:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:57:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:57:18 INFO - Downloading/unpacking jsonschema==2.5.1 05:57:18 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 05:57:18 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 05:57:18 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 05:57:18 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 05:57:18 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 05:57:18 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 05:57:21 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:57:21 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:57:21 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 05:57:21 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 05:57:21 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 05:57:21 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 05:57:21 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 05:57:21 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 05:57:21 INFO - Downloading functools32-3.2.3-2.tar.gz 05:57:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:57:21 INFO - warning: no files found matching '*.txt' 05:57:21 INFO - no previously-included directories found matching 'build' 05:57:21 INFO - no previously-included directories found matching 'dist' 05:57:21 INFO - no previously-included directories found matching '.git*' 05:57:21 INFO - Installing collected packages: jsonschema, functools32 05:57:21 INFO - Running setup.py install for functools32 05:57:21 INFO - warning: no files found matching '*.txt' 05:57:21 INFO - no previously-included directories found matching 'build' 05:57:21 INFO - no previously-included directories found matching 'dist' 05:57:21 INFO - no previously-included directories found matching '.git*' 05:57:21 INFO - Successfully installed jsonschema functools32 05:57:21 INFO - Cleaning up... 05:57:21 INFO - Return code: 0 05:57:21 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:57:21 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')]} 05:57:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:57:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57:21 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')]} 05:57:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:57:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57:21 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 0x10894b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1088c1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdac955bdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10875fd30>, '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 0x1085c5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108757b20>, '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.2kEUODjIDB/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.XUBWGflwlD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/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 05:57:21 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 05:57:21 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 05:57:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2kEUODjIDB/Render', 05:57:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:57:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:57:21 INFO - 'HOME': '/Users/cltbld', 05:57:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:57:21 INFO - 'LOGNAME': 'cltbld', 05:57:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:57:21 INFO - 'MOZ_NO_REMOTE': '1', 05:57:21 INFO - 'NO_EM_RESTART': '1', 05:57:21 INFO - 'PAGER': '/bin/cat', 05:57:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:57:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:57:21 INFO - 'PWD': '/builds/slave/test', 05:57:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:57:21 INFO - 'SHELL': '/bin/bash', 05:57:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XUBWGflwlD/Listeners', 05:57:21 INFO - 'TMPDIR': '/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/', 05:57:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:57:21 INFO - 'USER': 'cltbld', 05:57:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:57:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:57:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:57:21 INFO - 'XPC_FLAGS': '0x0', 05:57:21 INFO - 'XPC_SERVICE_NAME': '0', 05:57:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:57:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:57:22 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:57:22 INFO - Cleaning up... 05:57:22 INFO - Return code: 0 05:57:22 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:57:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:57:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:57:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:57:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:57:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57:22 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 0x10894b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1088c1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdac955bdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10875fd30>, '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 0x1085c5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108757b20>, '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.2kEUODjIDB/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.XUBWGflwlD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/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 05:57:22 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 05:57:22 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 05:57:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2kEUODjIDB/Render', 05:57:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:57:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:57:22 INFO - 'HOME': '/Users/cltbld', 05:57:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:57:22 INFO - 'LOGNAME': 'cltbld', 05:57:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:57:22 INFO - 'MOZ_NO_REMOTE': '1', 05:57:22 INFO - 'NO_EM_RESTART': '1', 05:57:22 INFO - 'PAGER': '/bin/cat', 05:57:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:57:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:57:22 INFO - 'PWD': '/builds/slave/test', 05:57:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:57:22 INFO - 'SHELL': '/bin/bash', 05:57:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XUBWGflwlD/Listeners', 05:57:22 INFO - 'TMPDIR': '/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/', 05:57:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:57:22 INFO - 'USER': 'cltbld', 05:57:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:57:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:57:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:57:22 INFO - 'XPC_FLAGS': '0x0', 05:57:22 INFO - 'XPC_SERVICE_NAME': '0', 05:57:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:57:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:57:22 INFO - Downloading/unpacking blobuploader==1.2.4 05:57: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 05:57: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 05:57: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 05:57: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 05:57: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 05:57: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 05:57:24 INFO - Downloading blobuploader-1.2.4.tar.gz 05:57:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:57:24 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:57:24 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 05:57:24 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 05:57:24 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 05:57:24 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 05:57:24 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 05:57:24 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 05:57:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:57:25 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:57:25 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 05:57:25 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 05:57:25 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 05:57:25 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 05:57:25 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 05:57:25 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 05:57:26 INFO - Downloading docopt-0.6.1.tar.gz 05:57:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:57:26 INFO - Installing collected packages: blobuploader, requests, docopt 05:57:26 INFO - Running setup.py install for blobuploader 05:57:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:57:26 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:57:26 INFO - Running setup.py install for requests 05:57:26 INFO - Running setup.py install for docopt 05:57:27 INFO - Successfully installed blobuploader requests docopt 05:57:27 INFO - Cleaning up... 05:57:27 INFO - Return code: 0 05:57:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:57:27 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')]} 05:57:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:57:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57:27 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')]} 05:57:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:57:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57:27 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 0x10894b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1088c1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdac955bdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10875fd30>, '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 0x1085c5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108757b20>, '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.2kEUODjIDB/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.XUBWGflwlD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/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 05:57:27 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 05:57:27 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 05:57:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2kEUODjIDB/Render', 05:57:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:57:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:57:27 INFO - 'HOME': '/Users/cltbld', 05:57:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:57:27 INFO - 'LOGNAME': 'cltbld', 05:57:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:57:27 INFO - 'MOZ_NO_REMOTE': '1', 05:57:27 INFO - 'NO_EM_RESTART': '1', 05:57:27 INFO - 'PAGER': '/bin/cat', 05:57:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:57:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:57:27 INFO - 'PWD': '/builds/slave/test', 05:57:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:57:27 INFO - 'SHELL': '/bin/bash', 05:57:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XUBWGflwlD/Listeners', 05:57:27 INFO - 'TMPDIR': '/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/', 05:57:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:57:27 INFO - 'USER': 'cltbld', 05:57:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:57:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:57:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:57:27 INFO - 'XPC_FLAGS': '0x0', 05:57:27 INFO - 'XPC_SERVICE_NAME': '0', 05:57:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:57:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:57:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:57:27 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-TCSUgR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:57:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:57:27 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-tC1T4u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:57:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:57:27 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-luevfR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:57:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:57:27 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-gpnq8x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:57:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:57:27 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-8obQlB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:57:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:57:27 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-5m2cNA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:57:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:57:28 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-XmRTGP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:57:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:57:28 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-KpJ0Pl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:57:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:57:28 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-uWM8Gn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:57:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:57:28 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-GQFMKg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:57:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:57:28 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-88l3Pn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:57:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:57:28 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-7TH2Bq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:57:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:57:28 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-NRQpJR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:57:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:57:28 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-EMgqzm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:57:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:57:28 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-_1TkgB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:57:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:57:28 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-c1lRaQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:57:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:57:29 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-CKCFJ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:57:29 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:57:29 INFO - Running setup.py install for manifestparser 05:57:29 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:57:29 INFO - Running setup.py install for mozcrash 05:57:29 INFO - Running setup.py install for mozdebug 05:57:29 INFO - Running setup.py install for mozdevice 05:57:29 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:57:29 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:57:29 INFO - Running setup.py install for mozfile 05:57:29 INFO - Running setup.py install for mozhttpd 05:57:30 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:57:30 INFO - Running setup.py install for mozinfo 05:57:30 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:57:30 INFO - Running setup.py install for mozInstall 05:57:30 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:57:30 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:57:30 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:57:30 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:57:30 INFO - Running setup.py install for mozleak 05:57:30 INFO - Running setup.py install for mozlog 05:57:30 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:57:30 INFO - Running setup.py install for moznetwork 05:57:30 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:57:30 INFO - Running setup.py install for mozprocess 05:57:30 INFO - Running setup.py install for mozprofile 05:57:31 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:57:31 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:57:31 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:57:31 INFO - Running setup.py install for mozrunner 05:57:31 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:57:31 INFO - Running setup.py install for mozscreenshot 05:57:31 INFO - Running setup.py install for moztest 05:57:31 INFO - Running setup.py install for mozversion 05:57:31 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:57:31 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:57:31 INFO - Cleaning up... 05:57:31 INFO - Return code: 0 05:57:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:57:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:57:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:57:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:57:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:57:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57:32 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 0x10894b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1088c1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdac955bdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10875fd30>, '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 0x1085c5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108757b20>, '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.2kEUODjIDB/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.XUBWGflwlD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/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 05:57:32 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 05:57:32 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 05:57:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2kEUODjIDB/Render', 05:57:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:57:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:57:32 INFO - 'HOME': '/Users/cltbld', 05:57:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:57:32 INFO - 'LOGNAME': 'cltbld', 05:57:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:57:32 INFO - 'MOZ_NO_REMOTE': '1', 05:57:32 INFO - 'NO_EM_RESTART': '1', 05:57:32 INFO - 'PAGER': '/bin/cat', 05:57:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:57:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:57:32 INFO - 'PWD': '/builds/slave/test', 05:57:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:57:32 INFO - 'SHELL': '/bin/bash', 05:57:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XUBWGflwlD/Listeners', 05:57:32 INFO - 'TMPDIR': '/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/', 05:57:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:57:32 INFO - 'USER': 'cltbld', 05:57:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:57:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:57:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:57:32 INFO - 'XPC_FLAGS': '0x0', 05:57:32 INFO - 'XPC_SERVICE_NAME': '0', 05:57:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:57:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:57:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:57:32 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-ISJ1c8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:57:32 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)) 05:57:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:57:32 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-Qs182T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:57:32 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)) 05:57:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:57:32 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-gVE5B3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:57:32 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)) 05:57:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:57:32 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-EapzhG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:57:32 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)) 05:57:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:57:32 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-iOlYVE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:57:32 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)) 05:57:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:57:32 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-LT0GhP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:57:33 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)) 05:57:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:57:33 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-v6FoMh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:57:33 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)) 05:57:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:57:33 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-qHKvyg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:57:33 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)) 05:57:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:57:33 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-Kchid8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:57:33 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)) 05:57:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:57:33 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-Zniozw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:57:33 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)) 05:57:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:57:33 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-IbsTJu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:57:33 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)) 05:57:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:57:33 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-wT03tV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:57:33 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)) 05:57:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:57:33 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-UAhYll-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:57:33 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)) 05:57:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:57:33 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-4dbz6k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:57:33 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)) 05:57:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:57:33 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-0btHK3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:57:33 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)) 05:57:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:57:33 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-MgODxe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:57:34 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)) 05:57:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:57:34 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-xhoKKm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:57:34 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)) 05:57:34 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)) 05:57:34 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)) 05:57:34 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)) 05:57:34 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)) 05:57:34 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)) 05:57:34 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:57:34 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 05:57:34 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 05:57:34 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 05:57:34 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 05:57:34 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 05:57:34 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 05:57:37 INFO - Downloading blessings-1.6.tar.gz 05:57:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:57:37 INFO - Installing collected packages: blessings 05:57:37 INFO - Running setup.py install for blessings 05:57:37 INFO - Successfully installed blessings 05:57:37 INFO - Cleaning up... 05:57:37 INFO - Return code: 0 05:57:37 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:57:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:57:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:57:37 INFO - Reading from file tmpfile_stdout 05:57:37 INFO - Current package versions: 05:57:37 INFO - blessings == 1.6 05:57:37 INFO - blobuploader == 1.2.4 05:57:37 INFO - docopt == 0.6.1 05:57:37 INFO - functools32 == 3.2.3-2 05:57:37 INFO - jsonschema == 2.5.1 05:57:37 INFO - manifestparser == 1.1 05:57:37 INFO - mozInstall == 1.12 05:57:37 INFO - mozcrash == 0.17 05:57:37 INFO - mozdebug == 0.1 05:57:37 INFO - mozdevice == 0.48 05:57:37 INFO - mozfile == 1.2 05:57:37 INFO - mozhttpd == 0.7 05:57:37 INFO - mozinfo == 0.9 05:57:37 INFO - mozleak == 0.1 05:57:37 INFO - mozlog == 3.4 05:57:37 INFO - moznetwork == 0.27 05:57:37 INFO - mozprocess == 0.23 05:57:37 INFO - mozprofile == 0.28 05:57:37 INFO - mozrunner == 6.12 05:57:37 INFO - mozscreenshot == 0.1 05:57:37 INFO - mozsystemmonitor == 0.3 05:57:37 INFO - moztest == 0.7 05:57:37 INFO - mozversion == 1.4 05:57:37 INFO - psutil == 3.1.1 05:57:37 INFO - requests == 1.2.3 05:57:37 INFO - wsgiref == 0.1.2 05:57:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:57:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:57:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:57:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:57:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:57:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57:37 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 0x10894b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1088c1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdac955bdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10875fd30>, '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 0x1085c5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108757b20>, '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.2kEUODjIDB/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.XUBWGflwlD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/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 05:57:37 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 05:57:37 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 05:57:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2kEUODjIDB/Render', 05:57:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:57:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:57:37 INFO - 'HOME': '/Users/cltbld', 05:57:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:57:37 INFO - 'LOGNAME': 'cltbld', 05:57:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:57:37 INFO - 'MOZ_NO_REMOTE': '1', 05:57:37 INFO - 'NO_EM_RESTART': '1', 05:57:37 INFO - 'PAGER': '/bin/cat', 05:57:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:57:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:57:37 INFO - 'PWD': '/builds/slave/test', 05:57:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:57:37 INFO - 'SHELL': '/bin/bash', 05:57:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XUBWGflwlD/Listeners', 05:57:37 INFO - 'TMPDIR': '/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/', 05:57:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:57:37 INFO - 'USER': 'cltbld', 05:57:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:57:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:57:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:57:37 INFO - 'XPC_FLAGS': '0x0', 05:57:37 INFO - 'XPC_SERVICE_NAME': '0', 05:57:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:57:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:57:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:57:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:57:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:57:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:57:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:57:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:57:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:57:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:57:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:57:38 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:57:38 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:57:38 INFO - Cleaning up... 05:57:38 INFO - Return code: 0 05:57:38 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:57: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')]} 05:57:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:57:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57: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')]} 05:57:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:57:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10894b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1088c1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdac955bdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10875fd30>, '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 0x1085c5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108757b20>, '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.2kEUODjIDB/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.XUBWGflwlD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/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 05:57:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:57:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:57:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2kEUODjIDB/Render', 05:57:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:57:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:57:38 INFO - 'HOME': '/Users/cltbld', 05:57:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:57:38 INFO - 'LOGNAME': 'cltbld', 05:57:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:57:38 INFO - 'MOZ_NO_REMOTE': '1', 05:57:38 INFO - 'NO_EM_RESTART': '1', 05:57:38 INFO - 'PAGER': '/bin/cat', 05:57:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:57:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:57:38 INFO - 'PWD': '/builds/slave/test', 05:57:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:57:38 INFO - 'SHELL': '/bin/bash', 05:57:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XUBWGflwlD/Listeners', 05:57:38 INFO - 'TMPDIR': '/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/', 05:57:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:57:38 INFO - 'USER': 'cltbld', 05:57:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:57:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:57:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:57:38 INFO - 'XPC_FLAGS': '0x0', 05:57:38 INFO - 'XPC_SERVICE_NAME': '0', 05:57:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:57:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:57:38 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:57:38 INFO - Cleaning up... 05:57:38 INFO - Return code: 0 05:57:38 INFO - Running post-action listener: _resource_record_post_action 05:57:38 INFO - Running post-action listener: _start_resource_monitoring 05:57:38 INFO - Starting resource monitoring. 05:57:38 INFO - [mozharness: 2016-10-17 12:57:38.362612Z] Finished create-virtualenv step (success) 05:57:38 INFO - [mozharness: 2016-10-17 12:57:38.363596Z] Running install step. 05:57:38 INFO - Running pre-action listener: _resource_record_pre_action 05:57:38 INFO - Running main action method: install 05:57:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:57:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:57:38 INFO - Reading from file tmpfile_stdout 05:57:38 INFO - Detecting whether we're running mozinstall >=1.0... 05:57:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:57:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:57:38 INFO - Reading from file tmpfile_stdout 05:57:38 INFO - Output received: 05:57:38 INFO - Usage: mozinstall [options] installer 05:57:38 INFO - Options: 05:57:38 INFO - -h, --help show this help message and exit 05:57:38 INFO - -d DEST, --destination=DEST 05:57:38 INFO - Directory to install application into. [default: 05:57:38 INFO - "/builds/slave/test"] 05:57:38 INFO - --app=APP Application being installed. [default: firefox] 05:57:38 INFO - mkdir: /builds/slave/test/build/application 05:57:38 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'] 05:57:38 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 05:58:10 INFO - Reading from file tmpfile_stdout 05:58:10 INFO - Output received: 05:58:10 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 05:58:10 INFO - Running post-action listener: _resource_record_post_action 05:58:10 INFO - [mozharness: 2016-10-17 12:58:10.762200Z] Finished install step (success) 05:58:10 INFO - [mozharness: 2016-10-17 12:58:10.762357Z] Running run-tests step. 05:58:10 INFO - Running pre-action listener: _resource_record_pre_action 05:58:10 INFO - Running main action method: run_tests 05:58:10 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:58:10 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:58:10 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:58:10 INFO - 2016-10-17 05:58:10.776 screenresolution[1635:7456] starting screenresolution argv=screenresolution get 05:58:10 INFO - 2016-10-17 05:58:10.779 screenresolution[1635:7456] Display 0: 1600x1200x32@60 05:58:10 INFO - 2016-10-17 05:58:10.784 screenresolution[1636:7458] starting screenresolution argv=screenresolution list 05:58:10 INFO - Available Modes on Display 0 05:58:10 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:58:10 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:58:10 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:58:10 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:58:11 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:58:11 INFO - Intel Iris: 05:58:11 INFO - Chipset Model: Intel Iris 05:58:11 INFO - Type: GPU 05:58:11 INFO - Bus: Built-In 05:58:11 INFO - VRAM (Dynamic, Max): 1536 MB 05:58:11 INFO - Vendor: Intel (0x8086) 05:58:11 INFO - Device ID: 0x0a2e 05:58:11 INFO - Revision ID: 0x0009 05:58:11 INFO - Displays: 05:58:11 INFO - Display: 05:58:11 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:58:11 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:58:11 INFO - Display Serial Number: 1600x1200 60 05:58:11 INFO - Main Display: Yes 05:58:11 INFO - Mirror: Off 05:58:11 INFO - Online: Yes 05:58:11 INFO - Rotation: Supported 05:58:11 INFO - Return code: 0 05:58:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:58:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:58:11 INFO - Python 2.7.3 05:58:11 INFO - Return code: 0 05:58:11 INFO - grabbing minidump binary from tooltool 05:58:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:58:11 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10875fd30>, '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 0x1085c5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108757b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:58:11 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:58:11 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 05:58:11 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 05:58:11 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:58:11 INFO - Return code: 0 05:58:11 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:58:11 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:58:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:58:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:58:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:58:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bwx1jE75TEGHl4ovoWlrmA/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0173', '--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 05:58:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/bwx1jE75TEGHl4ovoWlrmA/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0173 --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 05:58:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2kEUODjIDB/Render', 05:58:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:58:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:58:11 INFO - 'HOME': '/Users/cltbld', 05:58:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:58:11 INFO - 'LOGNAME': 'cltbld', 05:58:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:58:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:58:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:11 INFO - 'MOZ_NO_REMOTE': '1', 05:58:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:58:11 INFO - 'NO_EM_RESTART': '1', 05:58:11 INFO - 'PAGER': '/bin/cat', 05:58:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:58:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:11 INFO - 'PWD': '/builds/slave/test', 05:58:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:58:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:58:11 INFO - 'SHELL': '/bin/bash', 05:58:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XUBWGflwlD/Listeners', 05:58:11 INFO - 'TMPDIR': '/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/', 05:58:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:58:11 INFO - 'USER': 'cltbld', 05:58:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:58:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:58:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:11 INFO - 'XPC_FLAGS': '0x0', 05:58:11 INFO - 'XPC_SERVICE_NAME': '0', 05:58:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:58:11 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bwx1jE75TEGHl4ovoWlrmA/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0173', '--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 05:58:11 INFO - mozversion application_buildid: 20161017034236 05:58:11 INFO - mozversion application_changeset: 89734b85a2ef68ffd6260ba99f601486d2d3f5e5 05:58:11 INFO - mozversion application_display_name: FirefoxDeveloperEdition 05:58:11 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:58:11 INFO - mozversion application_name: Firefox 05:58:11 INFO - mozversion application_remotingname: firefox-dev 05:58:11 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 05:58:11 INFO - mozversion application_vendor: Mozilla 05:58:11 INFO - mozversion application_version: 51.0a2 05:58:11 INFO - mozversion platform_buildid: 20161017034236 05:58:11 INFO - mozversion platform_changeset: 89734b85a2ef68ffd6260ba99f601486d2d3f5e5 05:58:11 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 05:58:11 INFO - mozversion platform_version: 51.0a2 05:58:11 INFO - using testdate: 1476709091 05:58:11 INFO - actual date: 1476709091 05:58:11 INFO - starting webserver on 'localhost:49266' 05:58:11 INFO - SUITE-START | Running 2 tests 05:58:11 INFO - TEST-START | dromaeo_css 05:58:11 INFO - operating with platform_type : mac_ 05:58:11 INFO - Initialising browser for dromaeo_css test... 05:58:11 INFO - TEST-INFO | started process 1646 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/tmp3ynOyR/profile http://localhost:49266/getInfo.html) 05:58:13 INFO - PROCESS | 1646 | __metrics Screen width/height:1600/1200 05:58:13 INFO - PROCESS | 1646 | colorDepth:24 05:58:13 INFO - PROCESS | 1646 | Browser inner width/height: 1024/689 05:58:13 INFO - PROCESS | 1646 | __metrics 05:58:14 INFO - PROCESS | 1646 | 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" 05:58:14 INFO - PROCESS | 1646 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:58:14 INFO - TEST-INFO | 1646: exit 0 05:58:14 INFO - Browser initialized. 05:58:14 INFO - Running cycle 1/1 for dromaeo_css test... 05:58:14 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/tmp3ynOyR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:58:26 INFO - PROCESS | 1651 | RSS: Main: 219869184 05:58:26 INFO - PROCESS | 1651 | 05:59:20 INFO - PROCESS | 1651 | 1476709160181 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] 06:01:29 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49266/tests/dromaeo/cssquery-ext.html) 06:01:31 INFO - PROCESS | 1651 | RSS: Main: 374472704 06:01:31 INFO - PROCESS | 1651 | 06:04:34 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-ext.html (next: http://localhost:49266/tests/dromaeo/cssquery-jquery.html) 06:04:35 INFO - PROCESS | 1651 | RSS: Main: 351277056 06:04:35 INFO - PROCESS | 1651 | 06:07:37 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49266/tests/dromaeo/cssquery-mootools.html) 06:07:37 INFO - PROCESS | 1651 | RSS: Main: 321642496 06:07:37 INFO - PROCESS | 1651 | 06:10:40 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49266/tests/dromaeo/cssquery-prototype.html) 06:10:40 INFO - PROCESS | 1651 | RSS: Main: 326557696 06:10:40 INFO - PROCESS | 1651 | 06:13:44 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49266/tests/dromaeo/cssquery-yui.html) 06:13:44 INFO - PROCESS | 1651 | RSS: Main: 311726080 06:13:44 INFO - PROCESS | 1651 | 06:16:47 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-yui.html (next: http://localhost:49266/tests/dromaeo/cssquery-dojo.html) 06:16:48 INFO - PROCESS | 1651 | RSS: Main: 361074688 06:16:48 INFO - PROCESS | 1651 | 06:16:48 INFO - PROCESS | 1651 | __start_tp_report 06:16:48 INFO - PROCESS | 1651 | _x_x_mozilla_page_load 06:16:48 INFO - PROCESS | 1651 | _x_x_mozilla_page_load_details 06:16:48 INFO - PROCESS | 1651 | |i|pagename|runs| 06:16:48 INFO - PROCESS | 1651 | |0;dojo.html;3342.4484959981596;3343.531905533225;3382.2389962258494;3391.7286617070636;3398.2014226656747;5840.445157710016;5864.501517371029;5871.060630299153;5871.29544454666;5930.881382372356;5801.9129713054335;5902.734376953037;5905.114232865061;5915.999999999989;5922.4373684500015;5184.092783762845;5311.9468805311835;5325.920111198335;5359.785608575652;5375.11310633747;5255.763490642911;5260.579153667716;5394.163904594794;5397.379301380332;5402;5278;5331.466853314676;5354.41101478837;5362.705051222181;5370.409254981949;5325.414204437548;5347.54545863602;5380.596455265871;5383;5434.429384914586;5208.921866172011;5248;5304.124819404794;5330.38700549434;5362.088444964326;5872.432993394097;5909.497692696126;5911.408859114097;5979.372165922602;5979.701014949235;6072.5445591580365;6185.257769067695;6203.844903877439;6226.844328891769;6288.434040936338;6097.298810636789;6129.295131059941;6172.1667574877265;6187.752489900398;6207.937920620781;5654.151877218368;5690.516306113944;5715.371309155989;5716.142578613159;5753.913691294634;6150.446459818638;6179.3820617938745;6207.34822843604;6241.313455519889;6248.9062664060075;6219.284782250009;6251.437370636573;6258.342873998165;6267.71795269214;6269.059641053787;6215.533834962396;6250.74997000124;6276.184096067482;6320.525960552977;6358.682065896686;6110.01202914832;6166.506679465632;6190.969045154836;6233.283172435137;6242.344553821874;6260.467860231931;6282.4974002079725;6313.873722525524;6315.684215789284;6322.304546499881;4937.086638971802;4983.352164218629;4984.102861484895;4984.900301994012;4996.300517927493;4375.890602734957;4417.757023363746;4444.533324000998;4452.243118669834;4480.663950203748;5811.767529298865;5898.056310990221;5911.290645122613;5931.317898441648;5988.071848863433;6320.62076275425;6339.904901426482;6342.143810585604;6348.333424990309;6376.234851817811;5715.657060576379;5721.771129154788;5899.997000509924;5936.347001829795;5942.821715348547;5415.323084614423;5419.349678038582;5474.753636086386;5481.177823326533;5515.448455154533;6328.430441260309;6360.427561519486;6371.840703982438;6374.26695929974;6386.489080873519;6196.442320191204;6336.271328797063;6345.746170153327;6358.872822543616;6359.713812878339;6217.409346112112;6244.094606282155;6307.085472606538;6330.208723909512;6343;6258.217722784652;6263.686815659108;6289.811305660837;6292.993121100602;6307.148534947907;6133.601315914451;6353.777617783356;6357.491400688026;6359.332270111757;6378.075179099097;6041.456268935817;6109.192117492145;6119.571629985859;6158.876822463615;6167.938320616737;6215.906761398493;6218.440340369389;6222.191115155001;6234.064890266315;6238.563300568917;6040.214772079602;6051.364606716232;6055.848603784941;6063.939360606338;6067.514598831995;5968.22413086296;6098.11577321277;6100.969495152496;6116.792316687851;6132.846678833065;4570.6800523963;5854.619449735754;5978.491828194652;5989.101634754822;5999.280086389661 06:16:48 INFO - PROCESS | 1651 | |1;ext.html;499.99750001249987;509.0506205925949;519.1045446604605;521.5462547583602;527.6833899660203;29421.85289073557;38528.42207366888;39838.40242396359;39852.40221396674;41618.58381416185;41773.58226417735;42148.78925605375;42223.733288001335;42229;42410.36384454228;9623.711288661334;9803.36278141922;9804.558794854249;9809.01909809017;9811.969743176971;7750.224977502233;8670.566471676391;9753.853692194623;11989.280643161395;12038.81941770874;11914.285142891411;11988.160828741991;11996;12013.579524716637;12038.638840834745;8664.48013119215;11891.464884080195;11980;11982.400879956054;12003.099767517428;8555.230029297392;8648.264897483721;8671;8677.869831952527;11416.42917854104;37886.81056594727;39941.40087898684;39944;39984.00039998994;40019.99950001273;3329.93340133196;3601.2977469393477;3901.8244179012013;3928.64642182205;3943.585923478051;28697.56953645697;30823.537646935314;31466.528002079987;31700.524492132638;31933.361332773213;3156.494960806283;3267.2485328374605;3278.639349671534;3306.8842590509457;3409;519178.9999999962;525876;528966.3551682218;529364;532445;57657;58109;58134;58137.709311453174;58189.70905145447;61945.522179113235;62117.68941155265;62134.067988980205;62244.37755622386;62315.37684623096;16420.425285114965;17067.146642667816;17074.743878841826;17077.231524581424;17094.658106838044;11984.221025633306;12322.260664360167;13275.66810829737;13311.93344033293;13374.33128343579;14118.71762564743;15583.922080389526;15829.287682054335;16009.519714408587;16242.675146497004;7098.432125429953;7168.856622867514;7173.820654483679;7226.168990566047;7233.204347521769;854.6239654551978;975.1223898491272;976.9804603908024;1041.8176819056634;1050.3540322701483;24433.38916527101;29999;30080.849595751883;30697.846510767304;30794;945.8628498867625;1065.4512925843196;1065.4512925843196;1077.8006068877282;1079.9136069114452;14949.925250373679;15446.459373921858;15488.922555387151;15503.689926201412;15849.286782094834;158212;189928;190497.0475147643;191002;191299.6525260611;58131.709341453025;58152.70923645355;58169.709151454816;58269;58306.7084664574;1233.7532493501155;1237.059834525767;1341.1215653747006;1360.9387577559035;1381.295539274997;26209.253938373433;26639.46721065529;30278.155495120674;30442.934497293376;30464.390712185188;48202.758986206245;48667.026659465904;48713.26930095981;48823.77940551373;48907;520520;520531;520626;522826;523773;25373;26441;26484.735152648227;26546.60180097339;26870.865645671645;46905;47081;47331.526684732715;47743;47779;36352;38391.42412863753;39467;39474.60525394709;40690.389644155955;38325;38581;39834;39896.60103398929;40145.39781903215;37296;37601.62398375981;38106.428403573416;38248.61751382562;38831.61168388393;32461.35077298488;34302.44115776026;34689.82655086708;34718.82640586781;34932.650673493954;21508.449676703578;25548.872255638602;25679.743202567734;25968.350791230372;26044.869775651758 06:16:48 INFO - PROCESS | 1651 | |2;jquery.html;351.05916144732106;371.25933762144507;372.79868870809764;382.5753413710781;395.63206218217044;14926;15190.696186076286;15979.760303595427;19988.30040948567;20323;16339.26473308701;20339.694904576445;20877.895610521966;20985.895070524664;21260;5572.606848287928;5949.643021418707;5985.730642121093;6195.2565692117005;6208.9379106209035;5429.701366424845;5608.411116832735;6116.724747386378;6148.200733904586;6186.876262474748;5827.446392592697;5934.465898069173;6106.358832322609;6143.784967526138;6147.0164773636225;5226.294450249225;5964.582479226434;6021.638701677914;6022.427869352405;6023.849403764919;5221.869453263661;5223.71269580173;5343.225232341289;5556.194351818964;5620.156976453564;12751.298678572768;13076.280804555745;13112.082154249207;13345.266010369425;13372.997025223147;2112.271266413085;2134.9252776152916;2346.835721499496;2575.6136579513036;2593.9351516212055;8488.363372747068;9840.507974601313;10230.028147326066;12881.420336084899;14963.653271205643;1676.1702957036223;1818.927242910282;1840;1849.713294439364;1854.2768320355071;103391;113691;114709.27936081048;121248.39375803065;126668;9780.462074585967;10598.470076496144;11496.310221386744;11548.249363791327;11710.355930423908;14589.708205835825;14709.632259193606;14726.190059546827;14741.852581474048;14769.261536923112;8441;8732.432391894634;8747.387682862265;8789;8880.644774209088;7119.928800711927;8671.219590236782;8671.913280867111;8774.868376974351;8833.160849719266;4453.087117140978;4520.977395113069;4538.069695712371;4610.561996610384;4615.607673347736;1863.2360732099773;1902.2961504243242;1910.5032691500032;1913.2825190553542;1918.7121931710356;841.6044459104211;911.5077857956629;937.1940131486916;938.380668758616;967.1150896929372;20130.496737581678;21057;21141.788582114288;21209.575808483743;21217.984520864928;899.7120921305119;978.6427953796813;980.6861804222581;1014.9035841595037;1061.659041812801;9563.139317461322;10889.183311251687;10896.509657065451;10908.236423450282;10978.011978921935;588767;598950;609918.950405254;613745;619202;124498;126948;127275;130727;131669;989.4261328429494;991.1030517381781;999.8150342186718;1015.3197357770312;1018.4907546226887;15710.685786284439;17951.551211219823;18131.456056318333;18237.45287641373;18604.44186674402;36201.55193792219;49701;50089.74775630638;50500;51838.481615183366;76177;77023.61488192523;78288;78304;79756.60121699587;7340.96329518349;7661.118971318369;7694.922710820601;7892.684292628231;7994.2805147537;11588.6523404298;11985.520579176735;12339.13626046168;12453.937730311653;12479;10219.59121635156;10264.076233139054;10437.843432348673;10685;10843.728906777395;10314.638987635397;10368.948155259175;10453.895461045597;10672.62645807393;10794.676159715222;10378.169746420117;10531.315464494783;10569.682909512727;10663.680089597325;11069.225154239126;7647.426443016685;7841.137474877645;7872.56700881457;7938.404619653434;8018.759437216893;7984.600769961363;9227.630894764134;10589;10692.358458492516;10935.781284374109 06:16:48 INFO - PROCESS | 1651 | |3;mootools.html;1291.5544137272639;1520.92395380231;1531.6706908014776;1750.5973626066004;1903.514603776036;7558.811029724259;8414.873776893352;8640.265577425911;8948;8948.194662480375;8851.114888511162;8939.865902011476;8954.328425368107;8958.507282099481;8966.91033089669;2377.037299893542;2401.9639705404434;2402.3994001499627;2409.0484258717884;2410.939726506843;2363.3028256664325;2386.176769014687;2405.783479486846;2408.5784987627185;2417.2627348658652;2380.452495925938;2390.282915125464;2400.1119585753295;2407.6990376202975;2415.4806716555936;2357.846739961897;2372.5847976604114;2378.1676413255223;2380.4167978845207;2390.725066617344;2327.6392159215347;2348.7181538215355;2361.268006917861;2371.0989823866994;2372.6678265042906;8859.424137431046;8983.640654373818;8986.505742184178;9000.549972501349;9008.234300084501;5143.588512918995;5376;5377.354717433894;5414.756335964891;5417.160340147283;3596.8741094061584;3640.7451478396524;3650.6166852480374;3667.9266414671824;3726.366517691999;1077.784443111373;1078.2075174746633;1078.7464945737745;1103.0568863621568;1110.3726394587034;11623.360715160747;11687.883121168765;11690;11794;11795.41022948849;4440.62254708347;4504.144212599595;4670.883227919261;4676.625869930397;4681.133990211822;9209.493477858781;9211.355205135711;9216.493092879822;9228.5847136879;9232.492212928353;5280.1815718563685;5283.286756287929;5285.339332583427;5291.603129765206;5296.364436267596;4369.650427965755;4408.470983482002;4549.6360291176625;4703.17694403478;4910.410750709938;3755.1926335837925;3790.469334293146;3897.6686981606313;3905.1018265799025;3931.5871833457645;1139.3847322445786;1151.4473052934638;1153.4751687981948;1167.7897978363806;1172.2146162071433;816.6937398475571;902.4089221559889;903.3631289940577;911.0525053943824;920.889493260813;5520.779168833282;5756.510696590753;5845.889281036674;5861.472467477862;6115.143879856823;921.5162039929091;938.9483578403253;945.239082538563;966.5698764050071;996.2627655534997;3808.8666896658483;3932;4012.9598704012587;4041.4341992121126;4115.52671442782;10664.306820056672;11038.779224415466;11080.445977701243;11126.554937802559;11139.498722557504;11072.557097716;11081.944590277159;11093.889061109447;11116;11142.164337674707;7100.644967751592;8429.241368276762;8458.154184581615;8460.027096883814;8476.788080298042;5571.721413929368;5700.771969121189;5723.8855222896145;5948;5948.196993405835;9448.433094014106;9978.401295922267;10009.24930630191;10372.222083343628;10385.221108416748;9788.853167202355;10387.792244154924;10548.578056877639;10577.73067231937;10579.15366770672;6517.120188774455;6708.597484150967;7132.072830531998;7251.8187045324285;7259.854802904018;7226.494145409771;7774.766756997299;7796.181400953045;7854.72508462201;7869;7289.890651640336;7554.962225188839;7655.961720191363;7665.156832748505;7717.729879454192;7420.257974202536;7487.962560187164;7489.28851759082;7491.887621685788;7612.238776122344;7074.823129421806;7083.858322833411;7091.326323999212;7142.035825163536;7156.320149585781;4982.950170498249;5052.267421223975;5085.084684756779;5087.745612719275;5126.23106534008;4987.40151181846;4994.126027945168;5118.38579370478;5181.119209734279;5212.661177023481 06:16:48 INFO - PROCESS | 1651 | |4;prototype.html;294.9056301983366;295.8180718857903;303.62653935659137;305.6988865967022;310.22753344173015;4722.772079259392;5293.947060529394;5360.52585538977;5396.352437707471;5397.2174034764985;4563.954360456394;5207.682581251344;5306.814261500848;5311.973440132794;5368.91946620801;3724.9827639611867;4038.818253178614;4095.365218391154;4101.097758493127;4113.424120623115;3769.5288088988877;3992.740471869319;4133.42132101506;4172.144710334374;4187.623113919746;3862.1503269280715;4016.6184212499766;4081.4694089768436;4087.3664581989838;4114.794260286989;3559.6796288334176;4045.37296719009;4072.7759973201464;4081.9183616327805;4113.280175969194;3000.6249218847643;3563.4832949222478;3571.8571257149683;3597.622249663774;3610.819459027038;4023.959760402417;5150.690958542462;5158.3552055993005;5270;5314.990151871132;4636.721796692175;4674.69614475058;4689.507601701806;4702;4712.986707857827;4896.583790377822;5588.692621905834;5596.468335508121;5607.075047466748;5613.887722245532;3296.307775367176;3528.311979164064;3795.544534655859;3809.5428548574073;3826.3112639724836;5534.727012787082;5920.585559010871;5927.281088484335;5930.733117009745;5976.981624279711;3664.4320130379833;3912.550056743454;3914.535635962194;3921.7254792164276;3932.5674175840636;3335.4329763940186;3914.6085391460624;3945.585713500099;3949.881503554898;3955.782431966212;4581.885452863705;4581.9690569622235;4602.1025899949855;4620.468646105741;4652.953470465252;5003.999200159982;5653.717314134276;5667.801626943037;5746.195532625436;5756.280464941882;1215.7386161975041;1264.6585421936027;1272.2239433945285;1277.5152328720549;1318.808772727949;749.4716225061319;819.7376839411331;819.9221073997961;822.3380178955879;829.2122483640566;3946.796227150689;4326.242907491176;4362.9965108025335;4416.889577760582;4530.524294948983;4323.783810809447;4543.840965566189;4750.311204875274;4771.397594815961;4942.505749425029;3919.92160156801;4918.729469879191;5400.540954018874;5415.48552887475;5460.733795474913;2622.3575224070223;2809;3037.407705497407;3059.816411015346;3060.831654258993;5320.467953204648;5550.750216240279;5728.341240757366;6022.69886505673;6079.9328228402555;4666.673332866667;5949.9107513387335;6037.366076561898;6052.517133302369;6097.298810636745;5908.793192238251;6079.908801367895;6103;6140.539459540463;6198.1012753149635;5136.357955255593;5145.562627176732;5696.686682232517;5763.7982670606325;5856.297244330707;5709.771609135588;5818.6217895836635;5826;5826.70866456684;5848.923632110539;4971.552560269449;5473.507384335429;5846.356900741001;5906.822795316148;6091.4771307173205;3322.0200040987484;3357.4795906634513;3512.7541072125728;3894.5910679378258;3911.237308724885;4947.529984651453;5876.41235876409;5908.852278693067;5942.850289346653;5961.076033214858;5574.303212098488;5666.575006874418;5718.742656580381;5826.504747096545;5827.854303642443;4644.744539050384;5095.414027386898;5687.317521897398;5697.515711164598;5700.828975130753;4343.500497442708;4649.907001860011;4779.211430113992;5271.920921186109;5469.988052210354;5219.659417972576;5571.60998730085;5675.779707362937;5682.37493875665;5690.914636280542;4582.221022426129;4817.542333478314;5077;5176.4305926347315;5560.416156303691 06:16:48 INFO - PROCESS | 1651 | |5;yui.html;750.4596690382922;750.4821673045598;751.3012898004853;758.5031804168271;788.259036505685;14951;15936.282867270971;15961.441349552768;15997.440089596852;16073.035617862906;14405;14592.854071459282;15000.249987500636;15589.142597157152;15607.687846243096;689.741346994877;708.348319546019;844.6663567890664;868.1318681318681;873.9300855931542;706.3713295167305;845.8646616541355;863.5121156546562;878.4948654523643;879.9956000219989;917.7843206846386;922.1239822168933;922.5341202692631;924.7549399409162;925.6019911438079;711.068500264655;911.2846415563816;914.0265617117748;914.0402577293814;918.347972939214;541.7616248850533;649.422014407178;670.597641415147;676.3338111959715;676.9390754832089;15452.690946181126;15473.690526189414;15481.922590387088;15498.30257638409;15511.457099001593;13497.527586534425;13787.172769633855;13798.586042418743;13961.720765584632;13967.720645587133;12549.309787961658;12732.87267127326;12777.23336599807;13274;13588.048836581444;4306.246406878815;4695.577398034194;4704.388429504177;4737.905241895177;4769.070031343889;112727;114008;114673;121608;123152.76354273465;10415.68752937413;10416.583336666448;11034.889651103385;11041.39272340013;11142.610008649659;19614.52891033178;21147.682784758243;21212.78787212139;21224.681629775565;21283.148674053173;6938.965305173442;7628.618569071524;7904.723334683258;7945.12603613602;8042.195780421911;4403.933940990888;4446.822127114944;4458.308962110878;4538.319252112209;4694.319323698045;3649.5802982656805;3704.7036237100965;3797.35444974355;3798.7910664913693;3806.3719486284454;670.5105273150627;672.3679741043403;672.8486090629569;674;681.8295426143465;539.7652021370716;612.3478495402383;623.8471574464195;650.8633187030682;680.1362269917277;8967.148120928501;9674.371165874196;9740.512974351253;9806.411615303105;9818.607255709834;649.3538928765814;662.1987395251703;665.3845193196274;696.3384784454788;696.4776417686735;4609.101225261042;4615.399998000238;4634.37435946143;4663.090697313991;4681.391419115494;113316;114587;141463;170816;174222.12888935473;110937;141998;143548.28225859013;144754;148258.25870870578;103020.48489757504;111596;115233.4238328803;118467;125969.37015315048;8643.438176518506;8854.822903541764;8970.102989700978;9118;9156;66733.66633166804;68295.65852170707;68704;69838;69994;100720;104752;108132;109218.90781092088;109387;11712.941435292769;11869.40652967331;12049.638510844688;12067.637970860887;12096.516139354679;12741.235525868107;12888.033397495414;14138;14680.853191467948;14973.026753261003;13357.465701371837;14308.785368219693;14568.125912445286;14628.195449250394;14918.850811491746;12507.874921251036;13483.460661573426;14116.647083822987;14152.929235353757;14852.925735371255;13901.930490347484;13944.372503237175;13954.441822326993;13978;14003.369848356644;11415.486303116213;11643.708907277385;11644.417779110841;11780.352080635646;12151.088668350087;11658.708532286422;11689.240199387013;11802.704932376759;11854.288742675468;11873.109516786448 06:16:48 INFO - PROCESS | 1651 | __end_tp_report 06:16:48 INFO - PROCESS | 1651 | __start_cc_report 06:16:48 INFO - PROCESS | 1651 | _x_x_mozilla_cycle_collect,1515 06:16:48 INFO - PROCESS | 1651 | __end_cc_report 06:16:48 INFO - PROCESS | 1651 | __startTimestamp1476710208089__endTimestamp 06:16:48 INFO - PROCESS | 1651 | 06:16:48 INFO - PROCESS | 1651 | ------- Summary: start ------- 06:16:48 INFO - PROCESS | 1651 | Number of tests: 6 06:16:48 INFO - PROCESS | 1651 | 06:16:48 INFO - PROCESS | 1651 | [#0] dojo.html Cycles:165 Average:5809.67 Median:6041.46 stddev:640.25 (10.6%) stddev-sans-first:612.26 06:16:48 INFO - PROCESS | 1651 | Values: 3342.4 3343.5 3382.2 3391.7 3398.2 5840.4 5864.5 5871.1 5871.3 5930.9 5801.9 5902.7 5905.1 5916.0 5922.4 5184.1 5311.9 5325.9 5359.8 5375.1 5255.8 5260.6 5394.2 5397.4 5402.0 5278.0 5331.5 5354.4 5362.7 5370.4 5325.4 5347.5 5380.6 5383.0 5434.4 5208.9 5248.0 5304.1 5330.4 5362.1 5872.4 5909.5 5911.4 5979.4 5979.7 6072.5 6185.3 6203.8 6226.8 6288.4 6097.3 6129.3 6172.2 6187.8 6207.9 5654.2 5690.5 5715.4 5716.1 5753.9 6150.4 6179.4 6207.3 6241.3 6248.9 6219.3 6251.4 6258.3 6267.7 6269.1 6215.5 6250.7 6276.2 6320.5 6358.7 6110.0 6166.5 6191.0 6233.3 6242.3 6260.5 6282.5 6313.9 6315.7 6322.3 4937.1 4983.4 4984.1 4984.9 4996.3 4375.9 4417.8 4444.5 4452.2 4480.7 5811.8 5898.1 5911.3 5931.3 5988.1 6320.6 6339.9 6342.1 6348.3 6376.2 5715.7 5721.8 5900.0 5936.3 5942.8 5415.3 5419.3 5474.8 5481.2 5515.4 6328.4 6360.4 6371.8 6374.3 6386.5 6196.4 6336.3 6345.7 6358.9 6359.7 6217.4 6244.1 6307.1 6330.2 6343.0 6258.2 6263.7 6289.8 6293.0 6307.1 6133.6 6353.8 6357.5 6359.3 6378.1 6041.5 6109.2 6119.6 6158.9 6167.9 6215.9 6218.4 6222.2 6234.1 6238.6 6040.2 6051.4 6055.8 6063.9 6067.5 5968.2 6098.1 6101.0 6116.8 6132.8 4570.7 5854.6 5978.5 5989.1 5999.3 06:16:48 INFO - PROCESS | 1651 | 06:16:48 INFO - PROCESS | 1651 | [#1] ext.html Cycles:180 Average:56912.88 Median:38177.52 stddev:118036.37 (309.2%) stddev-sans-first:118291.50 06:16:48 INFO - PROCESS | 1651 | Values: 500.0 509.1 519.1 521.5 527.7 29421.9 38528.4 39838.4 39852.4 41618.6 41773.6 42148.8 42223.7 42229.0 42410.4 9623.7 9803.4 9804.6 9809.0 9812.0 7750.2 8670.6 9753.9 11989.3 12038.8 11914.3 11988.2 11996.0 12013.6 12038.6 8664.5 11891.5 11980.0 11982.4 12003.1 8555.2 8648.3 8671.0 8677.9 11416.4 37886.8 39941.4 39944.0 39984.0 40020.0 3329.9 3601.3 3901.8 3928.6 3943.6 28697.6 30823.5 31466.5 31700.5 31933.4 3156.5 3267.2 3278.6 3306.9 3409.0 519179.0 525876.0 528966.4 529364.0 532445.0 57657.0 58109.0 58134.0 58137.7 58189.7 61945.5 62117.7 62134.1 62244.4 62315.4 16420.4 17067.1 17074.7 17077.2 17094.7 11984.2 12322.3 13275.7 13311.9 13374.3 14118.7 15583.9 15829.3 16009.5 16242.7 7098.4 7168.9 7173.8 7226.2 7233.2 854.6 975.1 977.0 1041.8 1050.4 24433.4 29999.0 30080.8 30697.8 30794.0 945.9 1065.5 1065.5 1077.8 1079.9 14949.9 15446.5 15488.9 15503.7 15849.3 158212.0 189928.0 190497.0 191002.0 191299.7 58131.7 58152.7 58169.7 58269.0 58306.7 1233.8 1237.1 1341.1 1360.9 1381.3 26209.3 26639.5 30278.2 30442.9 30464.4 48202.8 48667.0 48713.3 48823.8 48907.0 520520.0 520531.0 520626.0 522826.0 523773.0 25373.0 26441.0 26484.7 26546.6 26870.9 46905.0 47081.0 47331.5 47743.0 47779.0 36352.0 38391.4 39467.0 39474.6 40690.4 38325.0 38581.0 39834.0 39896.6 40145.4 37296.0 37601.6 38106.4 38248.6 38831.6 32461.4 34302.4 34689.8 34718.8 34932.7 21508.4 25548.9 25679.7 25968.4 26044.9 06:16:48 INFO - PROCESS | 1651 | 06:16:48 INFO - PROCESS | 1651 | [#2] jquery.html Cycles:180 Average:34501.21 Median:2461.22 stddev:101145.40 (4109.6%) stddev-sans-first:101396.63 06:16:48 INFO - PROCESS | 1651 | Values: 351.1 371.3 372.8 382.6 395.6 14926.0 15190.7 15979.8 19988.3 20323.0 16339.3 20339.7 20877.9 20985.9 21260.0 5572.6 5949.6 5985.7 6195.3 6208.9 5429.7 5608.4 6116.7 6148.2 6186.9 5827.4 5934.5 6106.4 6143.8 6147.0 5226.3 5964.6 6021.6 6022.4 6023.8 5221.9 5223.7 5343.2 5556.2 5620.2 12751.3 13076.3 13112.1 13345.3 13373.0 2112.3 2134.9 2346.8 2575.6 2593.9 8488.4 9840.5 10230.0 12881.4 14963.7 1676.2 1818.9 1840.0 1849.7 1854.3 103391.0 113691.0 114709.3 121248.4 126668.0 9780.5 10598.5 11496.3 11548.2 11710.4 14589.7 14709.6 14726.2 14741.9 14769.3 8441.0 8732.4 8747.4 8789.0 8880.6 7119.9 8671.2 8671.9 8774.9 8833.2 4453.1 4521.0 4538.1 4610.6 4615.6 1863.2 1902.3 1910.5 1913.3 1918.7 841.6 911.5 937.2 938.4 967.1 20130.5 21057.0 21141.8 21209.6 21218.0 899.7 978.6 980.7 1014.9 1061.7 9563.1 10889.2 10896.5 10908.2 10978.0 588767.0 598950.0 609919.0 613745.0 619202.0 124498.0 126948.0 127275.0 130727.0 131669.0 989.4 991.1 999.8 1015.3 1018.5 15710.7 17951.6 18131.5 18237.5 18604.4 36201.6 49701.0 50089.7 50500.0 51838.5 76177.0 77023.6 78288.0 78304.0 79756.6 7341.0 7661.1 7694.9 7892.7 7994.3 11588.7 11985.5 12339.1 12453.9 12479.0 10219.6 10264.1 10437.8 10685.0 10843.7 10314.6 10368.9 10453.9 10672.6 10794.7 10378.2 10531.3 10569.7 10663.7 11069.2 7647.4 7841.1 7872.6 7938.4 8018.8 7984.6 9227.6 10589.0 10692.4 10935.8 06:16:48 INFO - PROCESS | 1651 | 06:16:48 INFO - PROCESS | 1651 | [#3] mootools.html Cycles:180 Average:5711.41 Median:5068.68 stddev:3218.13 (63.5%) stddev-sans-first:3210.01 06:16:48 INFO - PROCESS | 1651 | Values: 1291.6 1520.9 1531.7 1750.6 1903.5 7558.8 8414.9 8640.3 8948.0 8948.2 8851.1 8939.9 8954.3 8958.5 8966.9 2377.0 2402.0 2402.4 2409.0 2410.9 2363.3 2386.2 2405.8 2408.6 2417.3 2380.5 2390.3 2400.1 2407.7 2415.5 2357.8 2372.6 2378.2 2380.4 2390.7 2327.6 2348.7 2361.3 2371.1 2372.7 8859.4 8983.6 8986.5 9000.5 9008.2 5143.6 5376.0 5377.4 5414.8 5417.2 3596.9 3640.7 3650.6 3667.9 3726.4 1077.8 1078.2 1078.7 1103.1 1110.4 11623.4 11687.9 11690.0 11794.0 11795.4 4440.6 4504.1 4670.9 4676.6 4681.1 9209.5 9211.4 9216.5 9228.6 9232.5 5280.2 5283.3 5285.3 5291.6 5296.4 4369.7 4408.5 4549.6 4703.2 4910.4 3755.2 3790.5 3897.7 3905.1 3931.6 1139.4 1151.4 1153.5 1167.8 1172.2 816.7 902.4 903.4 911.1 920.9 5520.8 5756.5 5845.9 5861.5 6115.1 921.5 938.9 945.2 966.6 996.3 3808.9 3932.0 4013.0 4041.4 4115.5 10664.3 11038.8 11080.4 11126.6 11139.5 11072.6 11081.9 11093.9 11116.0 11142.2 7100.6 8429.2 8458.2 8460.0 8476.8 5571.7 5700.8 5723.9 5948.0 5948.2 9448.4 9978.4 10009.2 10372.2 10385.2 9788.9 10387.8 10548.6 10577.7 10579.2 6517.1 6708.6 7132.1 7251.8 7259.9 7226.5 7774.8 7796.2 7854.7 7869.0 7289.9 7555.0 7656.0 7665.2 7717.7 7420.3 7488.0 7489.3 7491.9 7612.2 7074.8 7083.9 7091.3 7142.0 7156.3 4983.0 5052.3 5085.1 5087.7 5126.2 4987.4 4994.1 5118.4 5181.1 5212.7 06:16:48 INFO - PROCESS | 1651 | 06:16:48 INFO - PROCESS | 1651 | [#4] prototype.html Cycles:180 Average:4506.41 Median:4907.66 stddev:1416.31 (28.9%) stddev-sans-first:1384.56 06:16:48 INFO - PROCESS | 1651 | Values: 294.9 295.8 303.6 305.7 310.2 4722.8 5293.9 5360.5 5396.4 5397.2 4564.0 5207.7 5306.8 5312.0 5368.9 3725.0 4038.8 4095.4 4101.1 4113.4 3769.5 3992.7 4133.4 4172.1 4187.6 3862.2 4016.6 4081.5 4087.4 4114.8 3559.7 4045.4 4072.8 4081.9 4113.3 3000.6 3563.5 3571.9 3597.6 3610.8 4024.0 5150.7 5158.4 5270.0 5315.0 4636.7 4674.7 4689.5 4702.0 4713.0 4896.6 5588.7 5596.5 5607.1 5613.9 3296.3 3528.3 3795.5 3809.5 3826.3 5534.7 5920.6 5927.3 5930.7 5977.0 3664.4 3912.6 3914.5 3921.7 3932.6 3335.4 3914.6 3945.6 3949.9 3955.8 4581.9 4582.0 4602.1 4620.5 4653.0 5004.0 5653.7 5667.8 5746.2 5756.3 1215.7 1264.7 1272.2 1277.5 1318.8 749.5 819.7 819.9 822.3 829.2 3946.8 4326.2 4363.0 4416.9 4530.5 4323.8 4543.8 4750.3 4771.4 4942.5 3919.9 4918.7 5400.5 5415.5 5460.7 2622.4 2809.0 3037.4 3059.8 3060.8 5320.5 5550.8 5728.3 6022.7 6079.9 4666.7 5949.9 6037.4 6052.5 6097.3 5908.8 6079.9 6103.0 6140.5 6198.1 5136.4 5145.6 5696.7 5763.8 5856.3 5709.8 5818.6 5826.0 5826.7 5848.9 4971.6 5473.5 5846.4 5906.8 6091.5 3322.0 3357.5 3512.8 3894.6 3911.2 4947.5 5876.4 5908.9 5942.9 5961.1 5574.3 5666.6 5718.7 5826.5 5827.9 4644.7 5095.4 5687.3 5697.5 5700.8 4343.5 4649.9 4779.2 5271.9 5470.0 5219.7 5571.6 5675.8 5682.4 5690.9 4582.2 4817.5 5077.0 5176.4 5560.4 06:16:48 INFO - PROCESS | 1651 | 06:16:48 INFO - PROCESS | 1651 | [#5] yui.html Cycles:180 Average:25969.25 Median:20381.11 stddev:41699.58 (204.6%) stddev-sans-first:41773.57 06:16:48 INFO - PROCESS | 1651 | Values: 750.5 750.5 751.3 758.5 788.3 14951.0 15936.3 15961.4 15997.4 16073.0 14405.0 14592.9 15000.2 15589.1 15607.7 689.7 708.3 844.7 868.1 873.9 706.4 845.9 863.5 878.5 880.0 917.8 922.1 922.5 924.8 925.6 711.1 911.3 914.0 914.0 918.3 541.8 649.4 670.6 676.3 676.9 15452.7 15473.7 15481.9 15498.3 15511.5 13497.5 13787.2 13798.6 13961.7 13967.7 12549.3 12732.9 12777.2 13274.0 13588.0 4306.2 4695.6 4704.4 4737.9 4769.1 112727.0 114008.0 114673.0 121608.0 123152.8 10415.7 10416.6 11034.9 11041.4 11142.6 19614.5 21147.7 21212.8 21224.7 21283.1 6939.0 7628.6 7904.7 7945.1 8042.2 4403.9 4446.8 4458.3 4538.3 4694.3 3649.6 3704.7 3797.4 3798.8 3806.4 670.5 672.4 672.8 674.0 681.8 539.8 612.3 623.8 650.9 680.1 8967.1 9674.4 9740.5 9806.4 9818.6 649.4 662.2 665.4 696.3 696.5 4609.1 4615.4 4634.4 4663.1 4681.4 113316.0 114587.0 141463.0 170816.0 174222.1 110937.0 141998.0 143548.3 144754.0 148258.3 103020.5 111596.0 115233.4 118467.0 125969.4 8643.4 8854.8 8970.1 9118.0 9156.0 66733.7 68295.7 68704.0 69838.0 69994.0 100720.0 104752.0 108132.0 109218.9 109387.0 11712.9 11869.4 12049.6 12067.6 12096.5 12741.2 12888.0 14138.0 14680.9 14973.0 13357.5 14308.8 14568.1 14628.2 14918.9 12507.9 13483.5 14116.6 14152.9 14852.9 13901.9 13944.4 13954.4 13978.0 14003.4 11415.5 11643.7 11644.4 11780.4 12151.1 11658.7 11689.2 11802.7 11854.3 11873.1 06:16:48 INFO - PROCESS | 1651 | -------- Summary: end -------- 06:16:48 INFO - PROCESS | 1651 | 06:16:48 INFO - TEST-INFO | 1651: exit 0 06:16:48 INFO - TEST-OK | dromaeo_css | took 1117357ms 06:16:48 INFO - TEST-START | kraken 06:16:48 INFO - operating with platform_type : mac_ 06:16:48 INFO - Initialising browser for kraken test... 06:16:48 INFO - TEST-INFO | started process 1657 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/tmpMHT0IZ/profile http://localhost:49266/getInfo.html) 06:16:51 INFO - PROCESS | 1657 | __metrics Screen width/height:1600/1200 06:16:51 INFO - PROCESS | 1657 | colorDepth:24 06:16:51 INFO - PROCESS | 1657 | Browser inner width/height: 1024/689 06:16:51 INFO - PROCESS | 1657 | __metrics 06:16:51 INFO - PROCESS | 1657 | 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" 06:16:51 INFO - PROCESS | 1657 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:16:51 INFO - TEST-INFO | 1657: exit 0 06:16:51 INFO - Browser initialized. 06:16:51 INFO - Running cycle 1/1 for kraken test... 06:16:51 INFO - TEST-INFO | started process 1658 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/tmpMHT0IZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:17:03 INFO - PROCESS | 1658 | RSS: Main: 219742208 06:17:03 INFO - PROCESS | 1658 | 06:17:06 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-beat-detection) 06:17:07 INFO - PROCESS | 1658 | RSS: Main: 269479936 06:17:07 INFO - PROCESS | 1658 | 06:17:10 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-dft) 06:17:10 INFO - PROCESS | 1658 | RSS: Main: 280571904 06:17:10 INFO - PROCESS | 1658 | 06:17:13 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-fft) 06:17:14 INFO - PROCESS | 1658 | RSS: Main: 377438208 06:17:14 INFO - PROCESS | 1658 | 06:17:16 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-oscillator) 06:17:17 INFO - PROCESS | 1658 | RSS: Main: 279154688 06:17:17 INFO - PROCESS | 1658 | 06:17:19 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:17:19 INFO - PROCESS | 1658 | RSS: Main: 280989696 06:17:19 INFO - PROCESS | 1658 | 06:17:22 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-darkroom) 06:17:23 INFO - PROCESS | 1658 | RSS: Main: 318685184 06:17:23 INFO - PROCESS | 1658 | 06:17:25 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-desaturate) 06:17:26 INFO - PROCESS | 1658 | RSS: Main: 318808064 06:17:26 INFO - PROCESS | 1658 | 06:17:29 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49266/tests/kraken/driver.html?testName=json-parse-financial) 06:17:30 INFO - PROCESS | 1658 | RSS: Main: 316608512 06:17:30 INFO - PROCESS | 1658 | 06:17:31 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49266/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:17:32 INFO - PROCESS | 1658 | RSS: Main: 289939456 06:17:32 INFO - PROCESS | 1658 | 06:17:34 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:17:34 INFO - PROCESS | 1658 | RSS: Main: 295751680 06:17:34 INFO - PROCESS | 1658 | 06:17:36 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:17:37 INFO - PROCESS | 1658 | RSS: Main: 298082304 06:17:37 INFO - PROCESS | 1658 | 06:17:40 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:17:41 INFO - PROCESS | 1658 | RSS: Main: 309161984 06:17:41 INFO - PROCESS | 1658 | 06:17:44 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:17:44 INFO - PROCESS | 1658 | RSS: Main: 309055488 06:17:44 INFO - PROCESS | 1658 | 06:17:46 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49266/tests/kraken/driver.html?testName=ai-astar) 06:17:46 INFO - PROCESS | 1658 | RSS: Main: 353030144 06:17:46 INFO - PROCESS | 1658 | 06:17:46 INFO - PROCESS | 1658 | __start_tp_report 06:17:46 INFO - PROCESS | 1658 | _x_x_mozilla_page_load 06:17:46 INFO - PROCESS | 1658 | _x_x_mozilla_page_load_details 06:17:46 INFO - PROCESS | 1658 | |i|pagename|runs| 06:17:46 INFO - PROCESS | 1658 | |0;ai-astar;115;116;115;114;114;115;113;114;115;114 06:17:46 INFO - PROCESS | 1658 | |1;audio-beat-detection;142;112;109;143;109;109;110;108;140;108 06:17:46 INFO - PROCESS | 1658 | |2;audio-dft;184;184;183;184;185;183;183;185;183;185 06:17:46 INFO - PROCESS | 1658 | |3;audio-fft;81;59;59;88;62;58;60;61;98;82 06:17:46 INFO - PROCESS | 1658 | |4;audio-oscillator;82;70;94;69;67;70;95;92;99;124 06:17:46 INFO - PROCESS | 1658 | |5;imaging-gaussian-blur;91;85;86;84;86;84;87;84;86;84 06:17:46 INFO - PROCESS | 1658 | |6;imaging-darkroom;93;93;93;93;92;91;92;92;92;92 06:17:46 INFO - PROCESS | 1658 | |7;imaging-desaturate;87;104;130;132;83;101;134;133;83;90 06:17:46 INFO - PROCESS | 1658 | |8;json-parse-financial;56;53;54;53;55;58;58;56;57;57 06:17:46 INFO - PROCESS | 1658 | |9;json-stringify-tinderbox;64;72;72;78;75;70;70;71;70;70 06:17:46 INFO - PROCESS | 1658 | |10;stanford-crypto-aes;80;83;83;83;82;84;82;95;98;86 06:17:46 INFO - PROCESS | 1658 | |11;stanford-crypto-ccm;140;139;140;145;133;119;151;151;162;144 06:17:46 INFO - PROCESS | 1658 | |12;stanford-crypto-pbkdf2;166;164;164;165;169;163;163;163;167;165 06:17:46 INFO - PROCESS | 1658 | |13;stanford-crypto-sha256-iterative;62;69;82;81;65;67;67;67;67;67 06:17:46 INFO - PROCESS | 1658 | __end_tp_report 06:17:46 INFO - PROCESS | 1658 | __start_cc_report 06:17:46 INFO - PROCESS | 1658 | _x_x_mozilla_cycle_collect,1980 06:17:46 INFO - PROCESS | 1658 | __end_cc_report 06:17:46 INFO - PROCESS | 1658 | __startTimestamp1476710266728__endTimestamp 06:17:46 INFO - PROCESS | 1658 | 06:17:46 INFO - PROCESS | 1658 | ------- Summary: start ------- 06:17:46 INFO - PROCESS | 1658 | Number of tests: 14 06:17:46 INFO - PROCESS | 1658 | 06:17:46 INFO - PROCESS | 1658 | [#0] ai-astar Cycles:10 Average:114.50 Median:115.00 stddev:0.85 (0.7%) stddev-sans-first:0.88 06:17:46 INFO - PROCESS | 1658 | Values: 115.0 116.0 115.0 114.0 114.0 115.0 113.0 114.0 115.0 114.0 06:17:46 INFO - PROCESS | 1658 | 06:17:46 INFO - PROCESS | 1658 | [#1] audio-beat-detection Cycles:10 Average:119.00 Median:111.00 stddev:15.70 (14.1%) stddev-sans-first:14.28 06:17:46 INFO - PROCESS | 1658 | Values: 142.0 112.0 109.0 143.0 109.0 109.0 110.0 108.0 140.0 108.0 06:17:46 INFO - PROCESS | 1658 | 06:17:46 INFO - PROCESS | 1658 | [#2] audio-dft Cycles:10 Average:183.90 Median:184.00 stddev:0.88 (0.5%) stddev-sans-first:0.93 06:17:46 INFO - PROCESS | 1658 | Values: 184.0 184.0 183.0 184.0 185.0 183.0 183.0 185.0 183.0 185.0 06:17:46 INFO - PROCESS | 1658 | 06:17:46 INFO - PROCESS | 1658 | [#3] audio-fft Cycles:10 Average:70.80 Median:71.50 stddev:14.90 (20.8%) stddev-sans-first:15.34 06:17:46 INFO - PROCESS | 1658 | Values: 81.0 59.0 59.0 88.0 62.0 58.0 60.0 61.0 98.0 82.0 06:17:46 INFO - PROCESS | 1658 | 06:17:46 INFO - PROCESS | 1658 | [#4] audio-oscillator Cycles:10 Average:86.20 Median:87.00 stddev:18.17 (20.9%) stddev-sans-first:19.21 06:17:46 INFO - PROCESS | 1658 | Values: 82.0 70.0 94.0 69.0 67.0 70.0 95.0 92.0 99.0 124.0 06:17:46 INFO - PROCESS | 1658 | 06:17:46 INFO - PROCESS | 1658 | [#5] imaging-gaussian-blur Cycles:10 Average:85.70 Median:86.00 stddev:2.16 (2.5%) stddev-sans-first:1.17 06:17:46 INFO - PROCESS | 1658 | Values: 91.0 85.0 86.0 84.0 86.0 84.0 87.0 84.0 86.0 84.0 06:17:46 INFO - PROCESS | 1658 | 06:17:46 INFO - PROCESS | 1658 | [#6] imaging-darkroom Cycles:10 Average:92.30 Median:92.50 stddev:0.67 (0.7%) stddev-sans-first:0.67 06:17:46 INFO - PROCESS | 1658 | Values: 93.0 93.0 93.0 93.0 92.0 91.0 92.0 92.0 92.0 92.0 06:17:46 INFO - PROCESS | 1658 | 06:17:46 INFO - PROCESS | 1658 | [#7] imaging-desaturate Cycles:10 Average:107.70 Median:108.50 stddev:22.21 (20.5%) stddev-sans-first:22.26 06:17:46 INFO - PROCESS | 1658 | Values: 87.0 104.0 130.0 132.0 83.0 101.0 134.0 133.0 83.0 90.0 06:17:46 INFO - PROCESS | 1658 | 06:17:46 INFO - PROCESS | 1658 | [#8] json-parse-financial Cycles:10 Average:55.70 Median:56.50 stddev:1.89 (3.3%) stddev-sans-first:2.00 06:17:46 INFO - PROCESS | 1658 | Values: 56.0 53.0 54.0 53.0 55.0 58.0 58.0 56.0 57.0 57.0 06:17:46 INFO - PROCESS | 1658 | 06:17:46 INFO - PROCESS | 1658 | [#9] json-stringify-tinderbox Cycles:10 Average:71.20 Median:71.50 stddev:3.65 (5.1%) stddev-sans-first:2.78 06:17:46 INFO - PROCESS | 1658 | Values: 64.0 72.0 72.0 78.0 75.0 70.0 70.0 71.0 70.0 70.0 06:17:46 INFO - PROCESS | 1658 | 06:17:46 INFO - PROCESS | 1658 | [#10] stanford-crypto-aes Cycles:10 Average:85.60 Median:83.50 stddev:5.99 (7.2%) stddev-sans-first:6.00 06:17:46 INFO - PROCESS | 1658 | Values: 80.0 83.0 83.0 83.0 82.0 84.0 82.0 95.0 98.0 86.0 06:17:46 INFO - PROCESS | 1658 | 06:17:46 INFO - PROCESS | 1658 | [#11] stanford-crypto-ccm Cycles:10 Average:142.40 Median:144.50 stddev:11.55 (8.0%) stddev-sans-first:12.22 06:17:46 INFO - PROCESS | 1658 | Values: 140.0 139.0 140.0 145.0 133.0 119.0 151.0 151.0 162.0 144.0 06:17:46 INFO - PROCESS | 1658 | 06:17:46 INFO - PROCESS | 1658 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.90 Median:165.00 stddev:1.97 (1.2%) stddev-sans-first:2.05 06:17:46 INFO - PROCESS | 1658 | Values: 166.0 164.0 164.0 165.0 169.0 163.0 163.0 163.0 167.0 165.0 06:17:46 INFO - PROCESS | 1658 | 06:17:46 INFO - PROCESS | 1658 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.40 Median:67.00 stddev:6.64 (9.9%) stddev-sans-first:6.48 06:17:46 INFO - PROCESS | 1658 | Values: 62.0 69.0 82.0 81.0 65.0 67.0 67.0 67.0 67.0 67.0 06:17:46 INFO - PROCESS | 1658 | -------- Summary: end -------- 06:17:46 INFO - PROCESS | 1658 | 06:17:47 INFO - TEST-INFO | 1658: exit 0 06:17:47 INFO - TEST-OK | kraken | took 58843ms 06:17:47 INFO - SUITE-END | took 1176s 06:17:47 INFO - Completed test suite (00:19:36) 06:17:47 INFO - javascript benchmark 06:17:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3342.4484959981596, 3343.531905533225, 3382.2389962258494, 3391.7286617070636, 3398.2014226656747, 5840.445157710016, 5864.501517371029, 5871.060630299153, 5871.29544454666, 5930.881382372356, 5801.9129713054335, 5902.734376953037, 5905.114232865061, 5915.999999999989, 5922.4373684500015, 5184.092783762845, 5311.9468805311835, 5325.920111198335, 5359.785608575652, 5375.11310633747, 5255.763490642911, 5260.579153667716, 5394.163904594794, 5397.379301380332, 5402.0, 5278.0, 5331.466853314676, 5354.41101478837, 5362.705051222181, 5370.409254981949, 5325.414204437548, 5347.54545863602, 5380.596455265871, 5383.0, 5434.429384914586, 5208.921866172011, 5248.0, 5304.124819404794, 5330.38700549434, 5362.088444964326, 5872.432993394097, 5909.497692696126, 5911.408859114097, 5979.372165922602, 5979.701014949235, 6072.5445591580365, 6185.257769067695, 6203.844903877439, 6226.844328891769, 6288.434040936338, 6097.298810636789, 6129.295131059941, 6172.1667574877265, 6187.752489900398, 6207.937920620781, 5654.151877218368, 5690.516306113944, 5715.371309155989, 5716.142578613159, 5753.913691294634, 6150.446459818638, 6179.3820617938745, 6207.34822843604, 6241.313455519889, 6248.9062664060075, 6219.284782250009, 6251.437370636573, 6258.342873998165, 6267.71795269214, 6269.059641053787, 6215.533834962396, 6250.74997000124, 6276.184096067482, 6320.525960552977, 6358.682065896686, 6110.01202914832, 6166.506679465632, 6190.969045154836, 6233.283172435137, 6242.344553821874, 6260.467860231931, 6282.4974002079725, 6313.873722525524, 6315.684215789284, 6322.304546499881, 4937.086638971802, 4983.352164218629, 4984.102861484895, 4984.900301994012, 4996.300517927493, 4375.890602734957, 4417.757023363746, 4444.533324000998, 4452.243118669834, 4480.663950203748, 5811.767529298865, 5898.056310990221, 5911.290645122613, 5931.317898441648, 5988.071848863433, 6320.62076275425, 6339.904901426482, 6342.143810585604, 6348.333424990309, 6376.234851817811, 5715.657060576379, 5721.771129154788, 5899.997000509924, 5936.347001829795, 5942.821715348547, 5415.323084614423, 5419.349678038582, 5474.753636086386, 5481.177823326533, 5515.448455154533, 6328.430441260309, 6360.427561519486, 6371.840703982438, 6374.26695929974, 6386.489080873519, 6196.442320191204, 6336.271328797063, 6345.746170153327, 6358.872822543616, 6359.713812878339, 6217.409346112112, 6244.094606282155, 6307.085472606538, 6330.208723909512, 6343.0, 6258.217722784652, 6263.686815659108, 6289.811305660837, 6292.993121100602, 6307.148534947907, 6133.601315914451, 6353.777617783356, 6357.491400688026, 6359.332270111757, 6378.075179099097, 6041.456268935817, 6109.192117492145, 6119.571629985859, 6158.876822463615, 6167.938320616737, 6215.906761398493, 6218.440340369389, 6222.191115155001, 6234.064890266315, 6238.563300568917, 6040.214772079602, 6051.364606716232, 6055.848603784941, 6063.939360606338, 6067.514598831995, 5968.22413086296, 6098.11577321277, 6100.969495152496, 6116.792316687851, 6132.846678833065, 4570.6800523963, 5854.619449735754, 5978.491828194652, 5989.101634754822, 5999.280086389661], "value": 5768.426918476224, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [499.99750001249987, 509.0506205925949, 519.1045446604605, 521.5462547583602, 527.6833899660203, 29421.85289073557, 38528.42207366888, 39838.40242396359, 39852.40221396674, 41618.58381416185, 41773.58226417735, 42148.78925605375, 42223.733288001335, 42229.0, 42410.36384454228, 9623.711288661334, 9803.36278141922, 9804.558794854249, 9809.01909809017, 9811.969743176971, 7750.224977502233, 8670.566471676391, 9753.853692194623, 11989.280643161395, 12038.81941770874, 11914.285142891411, 11988.160828741991, 11996.0, 12013.579524716637, 12038.638840834745, 8664.48013119215, 11891.464884080195, 11980.0, 11982.400879956054, 12003.099767517428, 8555.230029297392, 8648.264897483721, 8671.0, 8677.869831952527, 11416.42917854104, 37886.81056594727, 39941.40087898684, 39944.0, 39984.00039998994, 40019.99950001273, 3329.93340133196, 3601.2977469393477, 3901.8244179012013, 3928.64642182205, 3943.585923478051, 28697.56953645697, 30823.537646935314, 31466.528002079987, 31700.524492132638, 31933.361332773213, 3156.494960806283, 3267.2485328374605, 3278.639349671534, 3306.8842590509457, 3409.0, 519178.9999999962, 525876.0, 528966.3551682218, 529364.0, 532445.0, 57657.0, 58109.0, 58134.0, 58137.709311453174, 58189.70905145447, 61945.522179113235, 62117.68941155265, 62134.067988980205, 62244.37755622386, 62315.37684623096, 16420.425285114965, 17067.146642667816, 17074.743878841826, 17077.231524581424, 17094.658106838044, 11984.221025633306, 12322.260664360167, 13275.66810829737, 13311.93344033293, 13374.33128343579, 14118.71762564743, 15583.922080389526, 15829.287682054335, 16009.519714408587, 16242.675146497004, 7098.432125429953, 7168.856622867514, 7173.820654483679, 7226.168990566047, 7233.204347521769, 854.6239654551978, 975.1223898491272, 976.9804603908024, 1041.8176819056634, 1050.3540322701483, 24433.38916527101, 29999.0, 30080.849595751883, 30697.846510767304, 30794.0, 945.8628498867625, 1065.4512925843196, 1065.4512925843196, 1077.8006068877282, 1079.9136069114452, 14949.925250373679, 15446.459373921858, 15488.922555387151, 15503.689926201412, 15849.286782094834, 158212.0, 189928.0, 190497.0475147643, 191002.0, 191299.6525260611, 58131.709341453025, 58152.70923645355, 58169.709151454816, 58269.0, 58306.7084664574, 1233.7532493501155, 1237.059834525767, 1341.1215653747006, 1360.9387577559035, 1381.295539274997, 26209.253938373433, 26639.46721065529, 30278.155495120674, 30442.934497293376, 30464.390712185188, 48202.758986206245, 48667.026659465904, 48713.26930095981, 48823.77940551373, 48907.0, 520520.0, 520531.0, 520626.0, 522826.0, 523773.0, 25373.0, 26441.0, 26484.735152648227, 26546.60180097339, 26870.865645671645, 46905.0, 47081.0, 47331.526684732715, 47743.0, 47779.0, 36352.0, 38391.42412863753, 39467.0, 39474.60525394709, 40690.389644155955, 38325.0, 38581.0, 39834.0, 39896.60103398929, 40145.39781903215, 37296.0, 37601.62398375981, 38106.428403573416, 38248.61751382562, 38831.61168388393, 32461.35077298488, 34302.44115776026, 34689.82655086708, 34718.82640586781, 34932.650673493954, 21508.449676703578, 25548.872255638602, 25679.743202567734, 25968.350791230372, 26044.869775651758], "value": 19344.382858036868, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [351.05916144732106, 371.25933762144507, 372.79868870809764, 382.5753413710781, 395.63206218217044, 14926.0, 15190.696186076286, 15979.760303595427, 19988.30040948567, 20323.0, 16339.26473308701, 20339.694904576445, 20877.895610521966, 20985.895070524664, 21260.0, 5572.606848287928, 5949.643021418707, 5985.730642121093, 6195.2565692117005, 6208.9379106209035, 5429.701366424845, 5608.411116832735, 6116.724747386378, 6148.200733904586, 6186.876262474748, 5827.446392592697, 5934.465898069173, 6106.358832322609, 6143.784967526138, 6147.0164773636225, 5226.294450249225, 5964.582479226434, 6021.638701677914, 6022.427869352405, 6023.849403764919, 5221.869453263661, 5223.71269580173, 5343.225232341289, 5556.194351818964, 5620.156976453564, 12751.298678572768, 13076.280804555745, 13112.082154249207, 13345.266010369425, 13372.997025223147, 2112.271266413085, 2134.9252776152916, 2346.835721499496, 2575.6136579513036, 2593.9351516212055, 8488.363372747068, 9840.507974601313, 10230.028147326066, 12881.420336084899, 14963.653271205643, 1676.1702957036223, 1818.927242910282, 1840.0, 1849.713294439364, 1854.2768320355071, 103391.0, 113691.0, 114709.27936081048, 121248.39375803065, 126668.0, 9780.462074585967, 10598.470076496144, 11496.310221386744, 11548.249363791327, 11710.355930423908, 14589.708205835825, 14709.632259193606, 14726.190059546827, 14741.852581474048, 14769.261536923112, 8441.0, 8732.432391894634, 8747.387682862265, 8789.0, 8880.644774209088, 7119.928800711927, 8671.219590236782, 8671.913280867111, 8774.868376974351, 8833.160849719266, 4453.087117140978, 4520.977395113069, 4538.069695712371, 4610.561996610384, 4615.607673347736, 1863.2360732099773, 1902.2961504243242, 1910.5032691500032, 1913.2825190553542, 1918.7121931710356, 841.6044459104211, 911.5077857956629, 937.1940131486916, 938.380668758616, 967.1150896929372, 20130.496737581678, 21057.0, 21141.788582114288, 21209.575808483743, 21217.984520864928, 899.7120921305119, 978.6427953796813, 980.6861804222581, 1014.9035841595037, 1061.659041812801, 9563.139317461322, 10889.183311251687, 10896.509657065451, 10908.236423450282, 10978.011978921935, 588767.0, 598950.0, 609918.950405254, 613745.0, 619202.0, 124498.0, 126948.0, 127275.0, 130727.0, 131669.0, 989.4261328429494, 991.1030517381781, 999.8150342186718, 1015.3197357770312, 1018.4907546226887, 15710.685786284439, 17951.551211219823, 18131.456056318333, 18237.45287641373, 18604.44186674402, 36201.55193792219, 49701.0, 50089.74775630638, 50500.0, 51838.481615183366, 76177.0, 77023.61488192523, 78288.0, 78304.0, 79756.60121699587, 7340.96329518349, 7661.118971318369, 7694.922710820601, 7892.684292628231, 7994.2805147537, 11588.6523404298, 11985.520579176735, 12339.13626046168, 12453.937730311653, 12479.0, 10219.59121635156, 10264.076233139054, 10437.843432348673, 10685.0, 10843.728906777395, 10314.638987635397, 10368.948155259175, 10453.895461045597, 10672.62645807393, 10794.676159715222, 10378.169746420117, 10531.315464494783, 10569.682909512727, 10663.680089597325, 11069.225154239126, 7647.426443016685, 7841.137474877645, 7872.56700881457, 7938.404619653434, 8018.759437216893, 7984.600769961363, 9227.630894764134, 10589.0, 10692.358458492516, 10935.781284374109], "value": 9241.509132215897, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1291.5544137272639, 1520.92395380231, 1531.6706908014776, 1750.5973626066004, 1903.514603776036, 7558.811029724259, 8414.873776893352, 8640.265577425911, 8948.0, 8948.194662480375, 8851.114888511162, 8939.865902011476, 8954.328425368107, 8958.507282099481, 8966.91033089669, 2377.037299893542, 2401.9639705404434, 2402.3994001499627, 2409.0484258717884, 2410.939726506843, 2363.3028256664325, 2386.176769014687, 2405.783479486846, 2408.5784987627185, 2417.2627348658652, 2380.452495925938, 2390.282915125464, 2400.1119585753295, 2407.6990376202975, 2415.4806716555936, 2357.846739961897, 2372.5847976604114, 2378.1676413255223, 2380.4167978845207, 2390.725066617344, 2327.6392159215347, 2348.7181538215355, 2361.268006917861, 2371.0989823866994, 2372.6678265042906, 8859.424137431046, 8983.640654373818, 8986.505742184178, 9000.549972501349, 9008.234300084501, 5143.588512918995, 5376.0, 5377.354717433894, 5414.756335964891, 5417.160340147283, 3596.8741094061584, 3640.7451478396524, 3650.6166852480374, 3667.9266414671824, 3726.366517691999, 1077.784443111373, 1078.2075174746633, 1078.7464945737745, 1103.0568863621568, 1110.3726394587034, 11623.360715160747, 11687.883121168765, 11690.0, 11794.0, 11795.41022948849, 4440.62254708347, 4504.144212599595, 4670.883227919261, 4676.625869930397, 4681.133990211822, 9209.493477858781, 9211.355205135711, 9216.493092879822, 9228.5847136879, 9232.492212928353, 5280.1815718563685, 5283.286756287929, 5285.339332583427, 5291.603129765206, 5296.364436267596, 4369.650427965755, 4408.470983482002, 4549.6360291176625, 4703.17694403478, 4910.410750709938, 3755.1926335837925, 3790.469334293146, 3897.6686981606313, 3905.1018265799025, 3931.5871833457645, 1139.3847322445786, 1151.4473052934638, 1153.4751687981948, 1167.7897978363806, 1172.2146162071433, 816.6937398475571, 902.4089221559889, 903.3631289940577, 911.0525053943824, 920.889493260813, 5520.779168833282, 5756.510696590753, 5845.889281036674, 5861.472467477862, 6115.143879856823, 921.5162039929091, 938.9483578403253, 945.239082538563, 966.5698764050071, 996.2627655534997, 3808.8666896658483, 3932.0, 4012.9598704012587, 4041.4341992121126, 4115.52671442782, 10664.306820056672, 11038.779224415466, 11080.445977701243, 11126.554937802559, 11139.498722557504, 11072.557097716, 11081.944590277159, 11093.889061109447, 11116.0, 11142.164337674707, 7100.644967751592, 8429.241368276762, 8458.154184581615, 8460.027096883814, 8476.788080298042, 5571.721413929368, 5700.771969121189, 5723.8855222896145, 5948.0, 5948.196993405835, 9448.433094014106, 9978.401295922267, 10009.24930630191, 10372.222083343628, 10385.221108416748, 9788.853167202355, 10387.792244154924, 10548.578056877639, 10577.73067231937, 10579.15366770672, 6517.120188774455, 6708.597484150967, 7132.072830531998, 7251.8187045324285, 7259.854802904018, 7226.494145409771, 7774.766756997299, 7796.181400953045, 7854.72508462201, 7869.0, 7289.890651640336, 7554.962225188839, 7655.961720191363, 7665.156832748505, 7717.729879454192, 7420.257974202536, 7487.962560187164, 7489.28851759082, 7491.887621685788, 7612.238776122344, 7074.823129421806, 7083.858322833411, 7091.326323999212, 7142.035825163536, 7156.320149585781, 4982.950170498249, 5052.267421223975, 5085.084684756779, 5087.745612719275, 5126.23106534008, 4987.40151181846, 4994.126027945168, 5118.38579370478, 5181.119209734279, 5212.661177023481], "value": 4584.841370297984, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [294.9056301983366, 295.8180718857903, 303.62653935659137, 305.6988865967022, 310.22753344173015, 4722.772079259392, 5293.947060529394, 5360.52585538977, 5396.352437707471, 5397.2174034764985, 4563.954360456394, 5207.682581251344, 5306.814261500848, 5311.973440132794, 5368.91946620801, 3724.9827639611867, 4038.818253178614, 4095.365218391154, 4101.097758493127, 4113.424120623115, 3769.5288088988877, 3992.740471869319, 4133.42132101506, 4172.144710334374, 4187.623113919746, 3862.1503269280715, 4016.6184212499766, 4081.4694089768436, 4087.3664581989838, 4114.794260286989, 3559.6796288334176, 4045.37296719009, 4072.7759973201464, 4081.9183616327805, 4113.280175969194, 3000.6249218847643, 3563.4832949222478, 3571.8571257149683, 3597.622249663774, 3610.819459027038, 4023.959760402417, 5150.690958542462, 5158.3552055993005, 5270.0, 5314.990151871132, 4636.721796692175, 4674.69614475058, 4689.507601701806, 4702.0, 4712.986707857827, 4896.583790377822, 5588.692621905834, 5596.468335508121, 5607.075047466748, 5613.887722245532, 3296.307775367176, 3528.311979164064, 3795.544534655859, 3809.5428548574073, 3826.3112639724836, 5534.727012787082, 5920.585559010871, 5927.281088484335, 5930.733117009745, 5976.981624279711, 3664.4320130379833, 3912.550056743454, 3914.535635962194, 3921.7254792164276, 3932.5674175840636, 3335.4329763940186, 3914.6085391460624, 3945.585713500099, 3949.881503554898, 3955.782431966212, 4581.885452863705, 4581.9690569622235, 4602.1025899949855, 4620.468646105741, 4652.953470465252, 5003.999200159982, 5653.717314134276, 5667.801626943037, 5746.195532625436, 5756.280464941882, 1215.7386161975041, 1264.6585421936027, 1272.2239433945285, 1277.5152328720549, 1318.808772727949, 749.4716225061319, 819.7376839411331, 819.9221073997961, 822.3380178955879, 829.2122483640566, 3946.796227150689, 4326.242907491176, 4362.9965108025335, 4416.889577760582, 4530.524294948983, 4323.783810809447, 4543.840965566189, 4750.311204875274, 4771.397594815961, 4942.505749425029, 3919.92160156801, 4918.729469879191, 5400.540954018874, 5415.48552887475, 5460.733795474913, 2622.3575224070223, 2809.0, 3037.407705497407, 3059.816411015346, 3060.831654258993, 5320.467953204648, 5550.750216240279, 5728.341240757366, 6022.69886505673, 6079.9328228402555, 4666.673332866667, 5949.9107513387335, 6037.366076561898, 6052.517133302369, 6097.298810636745, 5908.793192238251, 6079.908801367895, 6103.0, 6140.539459540463, 6198.1012753149635, 5136.357955255593, 5145.562627176732, 5696.686682232517, 5763.7982670606325, 5856.297244330707, 5709.771609135588, 5818.6217895836635, 5826.0, 5826.70866456684, 5848.923632110539, 4971.552560269449, 5473.507384335429, 5846.356900741001, 5906.822795316148, 6091.4771307173205, 3322.0200040987484, 3357.4795906634513, 3512.7541072125728, 3894.5910679378258, 3911.237308724885, 4947.529984651453, 5876.41235876409, 5908.852278693067, 5942.850289346653, 5961.076033214858, 5574.303212098488, 5666.575006874418, 5718.742656580381, 5826.504747096545, 5827.854303642443, 4644.744539050384, 5095.414027386898, 5687.317521897398, 5697.515711164598, 5700.828975130753, 4343.500497442708, 4649.907001860011, 4779.211430113992, 5271.920921186109, 5469.988052210354, 5219.659417972576, 5571.60998730085, 5675.779707362937, 5682.37493875665, 5690.914636280542, 4582.221022426129, 4817.542333478314, 5077.0, 5176.4305926347315, 5560.416156303691], "value": 4049.579218417262, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [750.4596690382922, 750.4821673045598, 751.3012898004853, 758.5031804168271, 788.259036505685, 14951.0, 15936.282867270971, 15961.441349552768, 15997.440089596852, 16073.035617862906, 14405.0, 14592.854071459282, 15000.249987500636, 15589.142597157152, 15607.687846243096, 689.741346994877, 708.348319546019, 844.6663567890664, 868.1318681318681, 873.9300855931542, 706.3713295167305, 845.8646616541355, 863.5121156546562, 878.4948654523643, 879.9956000219989, 917.7843206846386, 922.1239822168933, 922.5341202692631, 924.7549399409162, 925.6019911438079, 711.068500264655, 911.2846415563816, 914.0265617117748, 914.0402577293814, 918.347972939214, 541.7616248850533, 649.422014407178, 670.597641415147, 676.3338111959715, 676.9390754832089, 15452.690946181126, 15473.690526189414, 15481.922590387088, 15498.30257638409, 15511.457099001593, 13497.527586534425, 13787.172769633855, 13798.586042418743, 13961.720765584632, 13967.720645587133, 12549.309787961658, 12732.87267127326, 12777.23336599807, 13274.0, 13588.048836581444, 4306.246406878815, 4695.577398034194, 4704.388429504177, 4737.905241895177, 4769.070031343889, 112727.0, 114008.0, 114673.0, 121608.0, 123152.76354273465, 10415.68752937413, 10416.583336666448, 11034.889651103385, 11041.39272340013, 11142.610008649659, 19614.52891033178, 21147.682784758243, 21212.78787212139, 21224.681629775565, 21283.148674053173, 6938.965305173442, 7628.618569071524, 7904.723334683258, 7945.12603613602, 8042.195780421911, 4403.933940990888, 4446.822127114944, 4458.308962110878, 4538.319252112209, 4694.319323698045, 3649.5802982656805, 3704.7036237100965, 3797.35444974355, 3798.7910664913693, 3806.3719486284454, 670.5105273150627, 672.3679741043403, 672.8486090629569, 674.0, 681.8295426143465, 539.7652021370716, 612.3478495402383, 623.8471574464195, 650.8633187030682, 680.1362269917277, 8967.148120928501, 9674.371165874196, 9740.512974351253, 9806.411615303105, 9818.607255709834, 649.3538928765814, 662.1987395251703, 665.3845193196274, 696.3384784454788, 696.4776417686735, 4609.101225261042, 4615.399998000238, 4634.37435946143, 4663.090697313991, 4681.391419115494, 113316.0, 114587.0, 141463.0, 170816.0, 174222.12888935473, 110937.0, 141998.0, 143548.28225859013, 144754.0, 148258.25870870578, 103020.48489757504, 111596.0, 115233.4238328803, 118467.0, 125969.37015315048, 8643.438176518506, 8854.822903541764, 8970.102989700978, 9118.0, 9156.0, 66733.66633166804, 68295.65852170707, 68704.0, 69838.0, 69994.0, 100720.0, 104752.0, 108132.0, 109218.90781092088, 109387.0, 11712.941435292769, 11869.40652967331, 12049.638510844688, 12067.637970860887, 12096.516139354679, 12741.235525868107, 12888.033397495414, 14138.0, 14680.853191467948, 14973.026753261003, 13357.465701371837, 14308.785368219693, 14568.125912445286, 14628.195449250394, 14918.850811491746, 12507.874921251036, 13483.460661573426, 14116.647083822987, 14152.929235353757, 14852.925735371255, 13901.930490347484, 13944.372503237175, 13954.441822326993, 13978.0, 14003.369848356644, 11415.486303116213, 11643.708907277385, 11644.417779110841, 11780.352080635646, 12151.088668350087, 11658.708532286422, 11689.240199387013, 11802.704932376759, 11854.288742675468, 11873.109516786448], "value": 8003.714367733674, "unit": "score"}], "name": "dromaeo_css", "value": 7315.392265355231, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 116.0, 115.0, 114.0, 114.0, 115.0, 113.0, 114.0, 115.0, 114.0], "value": 114.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 112.0, 109.0, 143.0, 109.0, 109.0, 110.0, 108.0, 140.0, 108.0], "value": 119.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 184.0, 183.0, 184.0, 185.0, 183.0, 183.0, 185.0, 183.0, 185.0], "value": 183.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 59.0, 59.0, 88.0, 62.0, 58.0, 60.0, 61.0, 98.0, 82.0], "value": 70.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 70.0, 94.0, 69.0, 67.0, 70.0, 95.0, 92.0, 99.0, 124.0], "value": 86.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 85.0, 86.0, 84.0, 86.0, 84.0, 87.0, 84.0, 86.0, 84.0], "value": 85.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 93.0, 93.0, 92.0, 91.0, 92.0, 92.0, 92.0, 92.0], "value": 92.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 104.0, 130.0, 132.0, 83.0, 101.0, 134.0, 133.0, 83.0, 90.0], "value": 107.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 53.0, 54.0, 53.0, 55.0, 58.0, 58.0, 56.0, 57.0, 57.0], "value": 55.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 72.0, 72.0, 78.0, 75.0, 70.0, 70.0, 71.0, 70.0, 70.0], "value": 71.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 83.0, 83.0, 83.0, 82.0, 84.0, 82.0, 95.0, 98.0, 86.0], "value": 85.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 139.0, 140.0, 145.0, 133.0, 119.0, 151.0, 151.0, 162.0, 144.0], "value": 142.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 164.0, 164.0, 165.0, 169.0, 163.0, 163.0, 163.0, 167.0, 165.0], "value": 164.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 69.0, 82.0, 81.0, 65.0, 67.0, 67.0, 67.0, 67.0, 67.0], "value": 69.4, "unit": "score"}], "name": "kraken", "value": 1449.3000000000004, "alertThreshold": 2.0}]} 06:17:47 INFO - Return code: 0 06:17:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:17:48 INFO - # TBPL SUCCESS # 06:17:48 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:17:48 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:17:48 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:17:48 INFO - 2016-10-17 06:17:48.042 screenresolution[1662:9803] starting screenresolution argv=screenresolution get 06:17:48 INFO - 2016-10-17 06:17:48.045 screenresolution[1662:9803] Display 0: 1600x1200x32@60 06:17:48 INFO - 2016-10-17 06:17:48.051 screenresolution[1663:9806] starting screenresolution argv=screenresolution list 06:17:48 INFO - Available Modes on Display 0 06:17:48 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:17:48 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:17:48 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:17:48 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:17:48 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:17:48 INFO - Intel Iris: 06:17:48 INFO - Chipset Model: Intel Iris 06:17:48 INFO - Type: GPU 06:17:48 INFO - Bus: Built-In 06:17:48 INFO - VRAM (Dynamic, Max): 1536 MB 06:17:48 INFO - Vendor: Intel (0x8086) 06:17:48 INFO - Device ID: 0x0a2e 06:17:48 INFO - Revision ID: 0x0009 06:17:48 INFO - Displays: 06:17:48 INFO - Display: 06:17:48 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:17:48 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:17:48 INFO - Display Serial Number: 1600x1200 60 06:17:48 INFO - Main Display: Yes 06:17:48 INFO - Mirror: Off 06:17:48 INFO - Online: Yes 06:17:48 INFO - Rotation: Supported 06:17:48 INFO - Return code: 0 06:17:48 INFO - Running post-action listener: _resource_record_post_action 06:17:48 INFO - [mozharness: 2016-10-17 13:17:48.288551Z] Finished run-tests step (success) 06:17:48 INFO - Running post-run listener: _resource_record_post_run 06:17:48 INFO - Total resource usage - Wall time: 1209s; CPU: 53.0%; Read bytes: 38384640; Write bytes: 664411136; Read time: 411; Write time: 2001 06:17:48 INFO - TinderboxPrint: CPU usage
53.4% 06:17:48 INFO - TinderboxPrint: I/O read bytes / time
38,384,640 / 411 06:17:48 INFO - TinderboxPrint: I/O write bytes / time
664,411,136 / 2,001 06:17:48 INFO - TinderboxPrint: CPU idle
2,253.4 (46.6%) 06:17:48 INFO - TinderboxPrint: CPU system
969.0 (20.0%) 06:17:48 INFO - TinderboxPrint: CPU user
1,615.3 (33.4%) 06:17:48 INFO - TinderboxPrint: Swap in / out
401,903,616 / 0 06:17:48 INFO - install - Wall time: 32s; CPU: 54.0%; Read bytes: 360731136; Write bytes: 356554752; Read time: 27630; Write time: 717 06:17:48 INFO - run-tests - Wall time: 1178s; CPU: 53.0%; Read bytes: 36312064; Write bytes: 296551424; Read time: 352; Write time: 1247 06:17:48 INFO - Running post-run listener: _upload_blobber_files 06:17:48 INFO - Blob upload gear active. 06:17:48 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:17:48 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 06:17:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:17:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:17:49 INFO - (blobuploader) - INFO - Open directory for files ... 06:17:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:17:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:17:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:17:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:17:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:17:49 INFO - (blobuploader) - INFO - Done attempting. 06:17:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:17:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:17:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:17:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:17:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:17:50 INFO - (blobuploader) - INFO - Done attempting. 06:17:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:17:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:17:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:17:52 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:17:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:17:52 INFO - (blobuploader) - INFO - Done attempting. 06:17:52 INFO - (blobuploader) - INFO - Iteration through files over. 06:17:53 INFO - Return code: 0 06:17:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:17:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:17:53 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7fb2760d526e5f90da2ec181064530ac1e579193504a2ca321961b277856ad4191f13624cbe7070e68a23a79483faeffb5ea2164c7c1f5c184b02b79eeda8fcc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/70b61805f54bb27fbc5cf31d78ff4f6339f5497384488fcbb25988db3d12697863d3fe7a45de6829f351c96c4b4d7f02ccbfed01051114a8b5977a461f635919", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/67953df4bf615b722b2de7e83c23ed6836d590f42c2f189334e00c18f4cee92b72bfa0b1551e57b214c413116722a7be32903de81d3f58790a4948eee6392a5e"} 06:17:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:17:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:17:53 INFO - Contents: 06:17:53 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7fb2760d526e5f90da2ec181064530ac1e579193504a2ca321961b277856ad4191f13624cbe7070e68a23a79483faeffb5ea2164c7c1f5c184b02b79eeda8fcc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/70b61805f54bb27fbc5cf31d78ff4f6339f5497384488fcbb25988db3d12697863d3fe7a45de6829f351c96c4b4d7f02ccbfed01051114a8b5977a461f635919", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/67953df4bf615b722b2de7e83c23ed6836d590f42c2f189334e00c18f4cee92b72bfa0b1551e57b214c413116722a7be32903de81d3f58790a4948eee6392a5e"} 06:17:53 INFO - Running post-run listener: copy_logs_to_upload_dir 06:17:53 INFO - Copying logs to upload dir... 06:17:53 INFO - mkdir: /builds/slave/test/build/upload/logs 06:17:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1269.470779 ========= master_lag: 1.35 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-10-17 06:17:54.386547) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-17 06:17:54.391402) ========= 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.2kEUODjIDB/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.XUBWGflwlD/Listeners TMPDIR=/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/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/7fb2760d526e5f90da2ec181064530ac1e579193504a2ca321961b277856ad4191f13624cbe7070e68a23a79483faeffb5ea2164c7c1f5c184b02b79eeda8fcc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/70b61805f54bb27fbc5cf31d78ff4f6339f5497384488fcbb25988db3d12697863d3fe7a45de6829f351c96c4b4d7f02ccbfed01051114a8b5977a461f635919", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/67953df4bf615b722b2de7e83c23ed6836d590f42c2f189334e00c18f4cee92b72bfa0b1551e57b214c413116722a7be32903de81d3f58790a4948eee6392a5e"} build_url:https://queue.taskcluster.net/v1/task/bwx1jE75TEGHl4ovoWlrmA/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011019 build_url: 'https://queue.taskcluster.net/v1/task/bwx1jE75TEGHl4ovoWlrmA/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/7fb2760d526e5f90da2ec181064530ac1e579193504a2ca321961b277856ad4191f13624cbe7070e68a23a79483faeffb5ea2164c7c1f5c184b02b79eeda8fcc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/70b61805f54bb27fbc5cf31d78ff4f6339f5497384488fcbb25988db3d12697863d3fe7a45de6829f351c96c4b4d7f02ccbfed01051114a8b5977a461f635919", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/67953df4bf615b722b2de7e83c23ed6836d590f42c2f189334e00c18f4cee92b72bfa0b1551e57b214c413116722a7be32903de81d3f58790a4948eee6392a5e"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-17 06:17:54.432580) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 06:17:54.432955) ========= 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.2kEUODjIDB/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.XUBWGflwlD/Listeners TMPDIR=/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/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.004989 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 06:17:54.485033) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-17 06:17:54.485413) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-17 06:17:54.485834) ========= ========= Total master_lag: 1.50 =========