builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0183 starttime: 1476358046.79 results: success (0) buildid: 20161013014024 builduid: f2a3128fdb0a487db1ec0acfb2acde6a revision: cd067bd545083034fe8c1a9c5f1c39cf4fd257ea ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-13 04:27:26.788847) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-13 04:27:26.789280) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-13 04:27:26.789552) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-13 04:27:26.813502) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 04:27:26.813846) ========= 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.HBi8CMr0dW/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.o6L2gEYnAb/Listeners TMPDIR=/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/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-13 04:27:26-- 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% 157M=0s 2016-10-13 04:27:26 (157 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.095603 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 04:27:26.931838) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 04:27:26.932180) ========= 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.HBi8CMr0dW/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.o6L2gEYnAb/Listeners TMPDIR=/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/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.028155 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 04:27:26.980601) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-13 04:27:26.980958) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev cd067bd545083034fe8c1a9c5f1c39cf4fd257ea --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 cd067bd545083034fe8c1a9c5f1c39cf4fd257ea --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.HBi8CMr0dW/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.o6L2gEYnAb/Listeners TMPDIR=/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/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-13 04:27:27,054 truncating revision to first 12 chars 2016-10-13 04:27:27,054 Setting DEBUG logging. 2016-10-13 04:27:27,054 attempt 1/10 2016-10-13 04:27:27,054 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/cd067bd54508?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-13 04:27:28,204 unpacking tar archive at: mozilla-aurora-cd067bd54508/testing/mozharness/ program finished with exit code 0 elapsedTime=1.413841 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-13 04:27:28.416399) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-13 04:27:28.416714) ========= script_repo_revision: cd067bd545083034fe8c1a9c5f1c39cf4fd257ea ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-13 04:27:28.417100) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-13 04:27:28.417360) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-13 04:27:28.435512) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-10-13 04:27:28.435902) ========= /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.HBi8CMr0dW/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.o6L2gEYnAb/Listeners TMPDIR=/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/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 04:27:28 INFO - MultiFileLogger online at 20161013 04:27:28 in /builds/slave/test 04:27:28 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 04:27:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:27:28 INFO - {'append_to_log': False, 04:27:28 INFO - 'base_work_dir': '/builds/slave/test', 04:27:28 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 04:27:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:27:28 INFO - 'branch': 'Mozilla-Aurora', 04:27:28 INFO - 'buildbot_json_path': 'buildprops.json', 04:27:28 INFO - 'config_files': ('talos/mac_config.py',), 04:27:28 INFO - 'default_actions': ('clobber', 04:27:28 INFO - 'read-buildbot-config', 04:27:28 INFO - 'download-and-extract', 04:27:28 INFO - 'populate-webroot', 04:27:28 INFO - 'create-virtualenv', 04:27:28 INFO - 'install', 04:27:28 INFO - 'run-tests'), 04:27:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:27:28 INFO - 'download_minidump_stackwalk': True, 04:27:28 INFO - 'download_symbols': 'ondemand', 04:27:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:27:28 INFO - 'tooltool.py': '/tools/tooltool.py', 04:27:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:27:28 INFO - '/tools/misc-python/virtualenv.py')}, 04:27:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:27:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:27:28 INFO - 'installer_path': 'installer.exe', 04:27:28 INFO - 'log_level': 'info', 04:27:28 INFO - 'log_name': 'talos', 04:27:28 INFO - 'log_to_console': True, 04:27:28 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:27:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:27:28 INFO - 'opt_config_files': (), 04:27:28 INFO - 'pip_index': False, 04:27:28 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:27:28 INFO - 'cmd': ('bash', 04:27:28 INFO - '-c', 04:27:28 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:27:28 INFO - 'enabled': True, 04:27:28 INFO - 'halt_on_failure': False, 04:27:28 INFO - 'name': 'check_screen_resolution'},), 04:27:28 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:27:28 INFO - 'cmd': ('bash', 04:27:28 INFO - '-c', 04:27:28 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:27:28 INFO - 'enabled': True, 04:27:28 INFO - 'halt_on_failure': False, 04:27:28 INFO - 'name': 'check_screen_resolution'},), 04:27:28 INFO - 'run_cmd_checks_enabled': True, 04:27:28 INFO - 'sps_profile': False, 04:27:28 INFO - 'sps_profile_interval': 0, 04:27:28 INFO - 'suite': 'dromaeojs', 04:27:28 INFO - 'system_bits': '32', 04:27:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:27:28 INFO - 'title': 't-yosemite-r7-0183', 04:27:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:27:28 INFO - 'use_talos_json': True, 04:27:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:27:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:27:28 INFO - 'work_dir': 'build'} 04:27:28 INFO - [mozharness: 2016-10-13 11:27:28.629219Z] Running clobber step. 04:27:28 INFO - Running pre-action listener: _resource_record_pre_action 04:27:28 INFO - Running main action method: clobber 04:27:28 INFO - rmtree: /builds/slave/test/build 04:27:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:27:30 INFO - Running post-action listener: _resource_record_post_action 04:27:30 INFO - [mozharness: 2016-10-13 11:27:30.937219Z] Finished clobber step (success) 04:27:30 INFO - [mozharness: 2016-10-13 11:27:30.937343Z] Running read-buildbot-config step. 04:27:30 INFO - Running pre-action listener: _resource_record_pre_action 04:27:30 INFO - Running main action method: read_buildbot_config 04:27:30 INFO - Using buildbot properties: 04:27:30 INFO - { 04:27:30 INFO - "project": "", 04:27:30 INFO - "product": "firefox", 04:27:30 INFO - "script_repo_revision": "production", 04:27:30 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 04:27:30 INFO - "repository": "", 04:27:30 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 04:27:30 INFO - "buildid": "20161013014024", 04:27:30 INFO - "pgo_build": "False", 04:27:30 INFO - "basedir": "/builds/slave/test", 04:27:30 INFO - "buildnumber": 5, 04:27:30 INFO - "slavename": "t-yosemite-r7-0183", 04:27:30 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 04:27:30 INFO - "platform": "yosemite_r7", 04:27:30 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 04:27:30 INFO - "branch": "mozilla-aurora", 04:27:30 INFO - "repo_path": "releases/mozilla-aurora", 04:27:30 INFO - "revision": "cd067bd545083034fe8c1a9c5f1c39cf4fd257ea", 04:27:30 INFO - "stage_platform": "macosx64", 04:27:30 INFO - "builduid": "f2a3128fdb0a487db1ec0acfb2acde6a", 04:27:30 INFO - "slavebuilddir": "test" 04:27:30 INFO - } 04:27:30 INFO - Found installer url https://queue.taskcluster.net/v1/task/Kyp2yyZGSjiT03QJcMTLOw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 04:27:30 INFO - Running post-action listener: _resource_record_post_action 04:27:30 INFO - [mozharness: 2016-10-13 11:27:30.940617Z] Finished read-buildbot-config step (success) 04:27:30 INFO - [mozharness: 2016-10-13 11:27:30.940731Z] Running download-and-extract step. 04:27:30 INFO - Running pre-action listener: _resource_record_pre_action 04:27:30 INFO - Running main action method: download_and_extract 04:27:30 INFO - mkdir: /builds/slave/test/build/tests 04:27:30 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')]} 04:27:30 INFO - trying https://queue.taskcluster.net/v1/task/Kyp2yyZGSjiT03QJcMTLOw/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 04:27:30 INFO - Downloading https://queue.taskcluster.net/v1/task/Kyp2yyZGSjiT03QJcMTLOw/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 04:27:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Kyp2yyZGSjiT03QJcMTLOw/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 04:27:32 INFO - Downloaded 1199 bytes. 04:27:32 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 04:27:32 INFO - Using the following test package requirements: 04:27:32 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 04:27:32 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 04:27:32 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 04:27:32 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 04:27:32 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 04:27:32 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 04:27:32 INFO - u'jsshell-mac.zip'], 04:27:32 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 04:27:32 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 04:27:32 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 04:27:32 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 04:27:32 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 04:27:32 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 04:27:32 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 04:27:32 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 04:27:32 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 04:27:32 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 04:27:32 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 04:27:32 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 04:27:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Kyp2yyZGSjiT03QJcMTLOw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 04:27:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Kyp2yyZGSjiT03QJcMTLOw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 04:27:32 INFO - Fetch https://queue.taskcluster.net/v1/task/Kyp2yyZGSjiT03QJcMTLOw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 04:27:32 INFO - Expected file size: 16435313 04:27:39 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 04:27:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Kyp2yyZGSjiT03QJcMTLOw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 04:27:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Kyp2yyZGSjiT03QJcMTLOw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 04:27:39 INFO - Fetch https://queue.taskcluster.net/v1/task/Kyp2yyZGSjiT03QJcMTLOw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 04:27:40 INFO - Expected file size: 16435313 04:27:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Kyp2yyZGSjiT03QJcMTLOw/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 04:27:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Kyp2yyZGSjiT03QJcMTLOw/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 04:27:46 INFO - Fetch https://queue.taskcluster.net/v1/task/Kyp2yyZGSjiT03QJcMTLOw/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 04:27:47 INFO - Expected file size: 14414059 04:27:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:27:48 INFO - trying https://queue.taskcluster.net/v1/task/Kyp2yyZGSjiT03QJcMTLOw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 04:27:48 INFO - Downloading https://queue.taskcluster.net/v1/task/Kyp2yyZGSjiT03QJcMTLOw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 04:27:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Kyp2yyZGSjiT03QJcMTLOw/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 04:27:51 INFO - Downloaded 115363558 bytes. 04:27:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Kyp2yyZGSjiT03QJcMTLOw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 04:27:51 INFO - mkdir: /builds/slave/test/properties 04:27:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:27:51 INFO - Writing to file /builds/slave/test/properties/build_url 04:27:51 INFO - Contents: 04:27:51 INFO - build_url:https://queue.taskcluster.net/v1/task/Kyp2yyZGSjiT03QJcMTLOw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 04:27:52 INFO - Running post-action listener: _resource_record_post_action 04:27:52 INFO - Running post-action listener: set_extra_try_arguments 04:27:52 INFO - [mozharness: 2016-10-13 11:27:52.164008Z] Finished download-and-extract step (success) 04:27:52 INFO - [mozharness: 2016-10-13 11:27:52.164133Z] Running populate-webroot step. 04:27:52 INFO - Running pre-action listener: _resource_record_pre_action 04:27:52 INFO - Running main action method: populate_webroot 04:27:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:27:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:27:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:27:52 INFO - '--tppagecycles', 04:27:52 INFO - '7'], 04:27:52 INFO - 'tests': ['tsvgm']}}, 04:27:52 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:27:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:27:52 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:27:52 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:27:52 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:27:52 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:27:52 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:27:52 INFO - 'talos_options': ['--disable-e10s'], 04:27:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:27:52 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:27:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:27:52 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:27:52 INFO - 'talos_options': ['--disable-e10s'], 04:27:52 INFO - 'tests': ['damp', 'tps']}, 04:27:52 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:27:52 INFO - 'tests': ['damp', 'tps']}, 04:27:52 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:27:52 INFO - 'tests': ['dromaeo_dom']}, 04:27:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:27:52 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:27:52 INFO - 'tests': ['basic_compositor_video']}, 04:27:52 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:27:52 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:27:52 INFO - 'tests': ['a11yr', 04:27:52 INFO - 'ts_paint', 04:27:52 INFO - 'tpaint', 04:27:52 INFO - 'sessionrestore', 04:27:52 INFO - 'sessionrestore_no_auto_restore', 04:27:52 INFO - 'tabpaint']}, 04:27:52 INFO - 'other-e10s': {'tests': ['a11yr', 04:27:52 INFO - 'ts_paint', 04:27:52 INFO - 'tpaint', 04:27:52 INFO - 'sessionrestore', 04:27:52 INFO - 'sessionrestore_no_auto_restore', 04:27:52 INFO - 'tabpaint']}, 04:27:52 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:27:52 INFO - 'ts_paint', 04:27:52 INFO - 'tpaint', 04:27:52 INFO - 'sessionrestore', 04:27:52 INFO - 'sessionrestore_no_auto_restore', 04:27:52 INFO - 'tabpaint']}, 04:27:52 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:27:52 INFO - 'ts_paint', 04:27:52 INFO - 'tpaint', 04:27:52 INFO - 'sessionrestore', 04:27:52 INFO - 'sessionrestore_no_auto_restore', 04:27:52 INFO - 'tabpaint']}, 04:27:52 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:27:52 INFO - 'tests': ['a11yr', 04:27:52 INFO - 'ts_paint', 04:27:52 INFO - 'tpaint', 04:27:52 INFO - 'sessionrestore', 04:27:52 INFO - 'sessionrestore_no_auto_restore', 04:27:52 INFO - 'tabpaint']}, 04:27:52 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:27:52 INFO - 'tests': ['a11yr', 04:27:52 INFO - 'ts_paint', 04:27:52 INFO - 'tpaint', 04:27:52 INFO - 'sessionrestore', 04:27:52 INFO - 'sessionrestore_no_auto_restore', 04:27:52 INFO - 'tabpaint']}, 04:27:52 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:27:52 INFO - 'tests': ['tsvgx', 04:27:52 INFO - 'tsvgr_opacity', 04:27:52 INFO - 'tart', 04:27:52 INFO - 'tscrollx', 04:27:52 INFO - 'cart']}, 04:27:52 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:27:52 INFO - 'tsvgr_opacity', 04:27:52 INFO - 'tart', 04:27:52 INFO - 'tscrollx', 04:27:52 INFO - 'cart']}, 04:27:52 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:27:52 INFO - 'talos_options': ['--disable-e10s'], 04:27:52 INFO - 'tests': ['tp5o']}, 04:27:52 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:27:52 INFO - 'tests': ['tp5o']}, 04:27:52 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:27:52 INFO - 'talos_options': ['--disable-e10s', 04:27:52 INFO - '--xperf_path', 04:27:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:27:52 INFO - 'tests': ['tp5n']}, 04:27:52 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:27:52 INFO - 'talos_options': ['--xperf_path', 04:27:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:27:52 INFO - 'tests': ['tp5n']}}, 04:27:52 INFO - 'talos.zip': {'path': '', 04:27:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:27:52 INFO - Running post-action listener: _resource_record_post_action 04:27:52 INFO - [mozharness: 2016-10-13 11:27:52.182527Z] Finished populate-webroot step (success) 04:27:52 INFO - [mozharness: 2016-10-13 11:27:52.182637Z] Running create-virtualenv step. 04:27:52 INFO - Running pre-action listener: _resource_record_pre_action 04:27:52 INFO - Running main action method: create_virtualenv 04:27:52 INFO - Creating virtualenv /builds/slave/test/build/venv 04:27:52 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 04:27:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:27:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:27:52 INFO - Using real prefix '/tools/python27' 04:27:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:27:53 INFO - Installing distribute.............................................................................................................................................................................................done. 04:27:55 INFO - Installing pip.................done. 04:27:55 INFO - Return code: 0 04:27:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:27:55 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')]} 04:27:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:27:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:55 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')]} 04:27:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:27:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:55 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 0x107520490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107496570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc75bc6db80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107334d30>, '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 0x10719adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10732cb20>, '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.HBi8CMr0dW/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.o6L2gEYnAb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/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 04:27:55 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 04:27:55 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 04:27:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HBi8CMr0dW/Render', 04:27:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:27:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:27:55 INFO - 'HOME': '/Users/cltbld', 04:27:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:27:55 INFO - 'LOGNAME': 'cltbld', 04:27:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:27:55 INFO - 'MOZ_NO_REMOTE': '1', 04:27:55 INFO - 'NO_EM_RESTART': '1', 04:27:55 INFO - 'PAGER': '/bin/cat', 04:27:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:27:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:27:55 INFO - 'PWD': '/builds/slave/test', 04:27:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:27:55 INFO - 'SHELL': '/bin/bash', 04:27:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.o6L2gEYnAb/Listeners', 04:27:55 INFO - 'TMPDIR': '/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/', 04:27:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:27:55 INFO - 'USER': 'cltbld', 04:27:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:27:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:27:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:27:55 INFO - 'XPC_FLAGS': '0x0', 04:27:55 INFO - 'XPC_SERVICE_NAME': '0', 04:27:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:27:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:27:56 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 04:27:56 INFO - Cleaning up... 04:27:56 INFO - Return code: 0 04:27:56 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:27:56 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')]} 04:27:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:27:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:56 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')]} 04:27:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:27:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:56 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 0x107520490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107496570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc75bc6db80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107334d30>, '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 0x10719adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10732cb20>, '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.HBi8CMr0dW/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.o6L2gEYnAb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/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 04:27:56 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 04:27:56 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 04:27:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HBi8CMr0dW/Render', 04:27:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:27:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:27:56 INFO - 'HOME': '/Users/cltbld', 04:27:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:27:56 INFO - 'LOGNAME': 'cltbld', 04:27:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:27:56 INFO - 'MOZ_NO_REMOTE': '1', 04:27:56 INFO - 'NO_EM_RESTART': '1', 04:27:56 INFO - 'PAGER': '/bin/cat', 04:27:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:27:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:27:56 INFO - 'PWD': '/builds/slave/test', 04:27:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:27:56 INFO - 'SHELL': '/bin/bash', 04:27:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.o6L2gEYnAb/Listeners', 04:27:56 INFO - 'TMPDIR': '/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/', 04:27:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:27:56 INFO - 'USER': 'cltbld', 04:27:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:27:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:27:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:27:56 INFO - 'XPC_FLAGS': '0x0', 04:27:56 INFO - 'XPC_SERVICE_NAME': '0', 04:27:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:27:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:27:56 INFO - Downloading/unpacking psutil>=3.1.1 04:27:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:27:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:27:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:27:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:27:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:27:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:27:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:27:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:27:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:27:59 INFO - Installing collected packages: psutil 04:27:59 INFO - Running setup.py install for psutil 04:27:59 INFO - building 'psutil._psutil_osx' extension 04:27:59 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 04:27:59 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 04:28:00 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 04:28:00 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 04:28:00 INFO - building 'psutil._psutil_posix' extension 04:28:00 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 04:28:00 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:28:00 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:28:00 INFO - ^ 04:28:00 INFO - 1 warning generated. 04:28:00 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 04:28:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:28:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:28:00 INFO - Successfully installed psutil 04:28:00 INFO - Cleaning up... 04:28:00 INFO - Return code: 0 04:28:00 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:28:00 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')]} 04:28:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:28:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:28:00 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')]} 04:28:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:28:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:28:00 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 0x107520490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107496570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc75bc6db80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107334d30>, '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 0x10719adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10732cb20>, '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.HBi8CMr0dW/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.o6L2gEYnAb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/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 04:28:00 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 04:28:00 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 04:28:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HBi8CMr0dW/Render', 04:28:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:28:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:28:00 INFO - 'HOME': '/Users/cltbld', 04:28:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:28:00 INFO - 'LOGNAME': 'cltbld', 04:28:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:28:00 INFO - 'MOZ_NO_REMOTE': '1', 04:28:00 INFO - 'NO_EM_RESTART': '1', 04:28:00 INFO - 'PAGER': '/bin/cat', 04:28:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:28:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:28:00 INFO - 'PWD': '/builds/slave/test', 04:28:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:28:00 INFO - 'SHELL': '/bin/bash', 04:28:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.o6L2gEYnAb/Listeners', 04:28:00 INFO - 'TMPDIR': '/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/', 04:28:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:28:00 INFO - 'USER': 'cltbld', 04:28:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:28:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:28:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:28:00 INFO - 'XPC_FLAGS': '0x0', 04:28:00 INFO - 'XPC_SERVICE_NAME': '0', 04:28:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:28:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:28:00 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:28:00 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 04:28:00 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 04:28:00 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 04:28:00 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 04:28:00 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 04:28:00 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 04:28:03 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:28:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:28:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:28:03 INFO - Installing collected packages: mozsystemmonitor 04:28:03 INFO - Running setup.py install for mozsystemmonitor 04:28:03 INFO - Successfully installed mozsystemmonitor 04:28:03 INFO - Cleaning up... 04:28:03 INFO - Return code: 0 04:28:03 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:28: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')]} 04:28:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:28:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:28: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')]} 04:28:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:28:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:28:03 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 0x107520490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107496570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc75bc6db80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107334d30>, '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 0x10719adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10732cb20>, '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.HBi8CMr0dW/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.o6L2gEYnAb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/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 04:28:03 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 04:28:03 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 04:28:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HBi8CMr0dW/Render', 04:28:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:28:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:28:03 INFO - 'HOME': '/Users/cltbld', 04:28:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:28:03 INFO - 'LOGNAME': 'cltbld', 04:28:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:28:03 INFO - 'MOZ_NO_REMOTE': '1', 04:28:03 INFO - 'NO_EM_RESTART': '1', 04:28:03 INFO - 'PAGER': '/bin/cat', 04:28:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:28:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:28:03 INFO - 'PWD': '/builds/slave/test', 04:28:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:28:03 INFO - 'SHELL': '/bin/bash', 04:28:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.o6L2gEYnAb/Listeners', 04:28:03 INFO - 'TMPDIR': '/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/', 04:28:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:28:03 INFO - 'USER': 'cltbld', 04:28:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:28:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:28:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:28:03 INFO - 'XPC_FLAGS': '0x0', 04:28:03 INFO - 'XPC_SERVICE_NAME': '0', 04:28:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:28:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:28:03 INFO - Downloading/unpacking jsonschema==2.5.1 04:28:03 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 04:28:03 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 04:28:03 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 04:28:03 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 04:28:03 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 04:28:03 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 04:28:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:28:06 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:28:06 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 04:28:06 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 04:28:06 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 04:28:06 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 04:28:06 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 04:28:06 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 04:28:06 INFO - Downloading functools32-3.2.3-2.tar.gz 04:28:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:28:06 INFO - warning: no files found matching '*.txt' 04:28:06 INFO - no previously-included directories found matching 'build' 04:28:06 INFO - no previously-included directories found matching 'dist' 04:28:06 INFO - no previously-included directories found matching '.git*' 04:28:06 INFO - Installing collected packages: jsonschema, functools32 04:28:06 INFO - Running setup.py install for functools32 04:28:06 INFO - warning: no files found matching '*.txt' 04:28:06 INFO - no previously-included directories found matching 'build' 04:28:06 INFO - no previously-included directories found matching 'dist' 04:28:06 INFO - no previously-included directories found matching '.git*' 04:28:06 INFO - Successfully installed jsonschema functools32 04:28:06 INFO - Cleaning up... 04:28:07 INFO - Return code: 0 04:28:07 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:28:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:28:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:28:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:28:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:28:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:28:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:28:07 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 0x107520490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107496570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc75bc6db80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107334d30>, '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 0x10719adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10732cb20>, '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.HBi8CMr0dW/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.o6L2gEYnAb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/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 04:28:07 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 04:28:07 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 04:28:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HBi8CMr0dW/Render', 04:28:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:28:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:28:07 INFO - 'HOME': '/Users/cltbld', 04:28:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:28:07 INFO - 'LOGNAME': 'cltbld', 04:28:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:28:07 INFO - 'MOZ_NO_REMOTE': '1', 04:28:07 INFO - 'NO_EM_RESTART': '1', 04:28:07 INFO - 'PAGER': '/bin/cat', 04:28:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:28:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:28:07 INFO - 'PWD': '/builds/slave/test', 04:28:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:28:07 INFO - 'SHELL': '/bin/bash', 04:28:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.o6L2gEYnAb/Listeners', 04:28:07 INFO - 'TMPDIR': '/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/', 04:28:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:28:07 INFO - 'USER': 'cltbld', 04:28:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:28:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:28:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:28:07 INFO - 'XPC_FLAGS': '0x0', 04:28:07 INFO - 'XPC_SERVICE_NAME': '0', 04:28:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:28:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:28:07 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:28:07 INFO - Cleaning up... 04:28:07 INFO - Return code: 0 04:28:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:28:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:28:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:28:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:28:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:28:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:28:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:28:07 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 0x107520490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107496570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc75bc6db80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107334d30>, '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 0x10719adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10732cb20>, '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.HBi8CMr0dW/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.o6L2gEYnAb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/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 04:28:07 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 04:28:07 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 04:28:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HBi8CMr0dW/Render', 04:28:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:28:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:28:07 INFO - 'HOME': '/Users/cltbld', 04:28:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:28:07 INFO - 'LOGNAME': 'cltbld', 04:28:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:28:07 INFO - 'MOZ_NO_REMOTE': '1', 04:28:07 INFO - 'NO_EM_RESTART': '1', 04:28:07 INFO - 'PAGER': '/bin/cat', 04:28:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:28:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:28:07 INFO - 'PWD': '/builds/slave/test', 04:28:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:28:07 INFO - 'SHELL': '/bin/bash', 04:28:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.o6L2gEYnAb/Listeners', 04:28:07 INFO - 'TMPDIR': '/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/', 04:28:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:28:07 INFO - 'USER': 'cltbld', 04:28:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:28:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:28:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:28:07 INFO - 'XPC_FLAGS': '0x0', 04:28:07 INFO - 'XPC_SERVICE_NAME': '0', 04:28:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:28:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:28:07 INFO - Downloading/unpacking blobuploader==1.2.4 04:28:07 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 04:28:07 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 04:28:07 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 04:28:07 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 04:28:07 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 04:28:07 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 04:28:09 INFO - Downloading blobuploader-1.2.4.tar.gz 04:28:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:28:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:28:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:28:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:28:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:28:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:28:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:28:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:28:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:28:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:28:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:28:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:28:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:28:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:28:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:28:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:28:11 INFO - Downloading docopt-0.6.1.tar.gz 04:28:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:28:11 INFO - Installing collected packages: blobuploader, requests, docopt 04:28:11 INFO - Running setup.py install for blobuploader 04:28:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:28:11 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:28:11 INFO - Running setup.py install for requests 04:28:11 INFO - Running setup.py install for docopt 04:28:12 INFO - Successfully installed blobuploader requests docopt 04:28:12 INFO - Cleaning up... 04:28:12 INFO - Return code: 0 04:28:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:28:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:28:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:28:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:28:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:28:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:28:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:28:12 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 0x107520490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107496570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc75bc6db80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107334d30>, '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 0x10719adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10732cb20>, '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.HBi8CMr0dW/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.o6L2gEYnAb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/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 04:28:12 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 04:28:12 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 04:28:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HBi8CMr0dW/Render', 04:28:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:28:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:28:12 INFO - 'HOME': '/Users/cltbld', 04:28:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:28:12 INFO - 'LOGNAME': 'cltbld', 04:28:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:28:12 INFO - 'MOZ_NO_REMOTE': '1', 04:28:12 INFO - 'NO_EM_RESTART': '1', 04:28:12 INFO - 'PAGER': '/bin/cat', 04:28:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:28:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:28:12 INFO - 'PWD': '/builds/slave/test', 04:28:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:28:12 INFO - 'SHELL': '/bin/bash', 04:28:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.o6L2gEYnAb/Listeners', 04:28:12 INFO - 'TMPDIR': '/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/', 04:28:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:28:12 INFO - 'USER': 'cltbld', 04:28:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:28:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:28:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:28:12 INFO - 'XPC_FLAGS': '0x0', 04:28:12 INFO - 'XPC_SERVICE_NAME': '0', 04:28:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:28:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:28:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:28:12 INFO - Running setup.py (path:/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/pip-BYXoAl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:28:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:28:12 INFO - Running setup.py (path:/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/pip-yBy5ig-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:28:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:28:12 INFO - Running setup.py (path:/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/pip-_LKEg1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:28:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:28:12 INFO - Running setup.py (path:/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/pip-5mnvZ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:28:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:28:12 INFO - Running setup.py (path:/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/pip-cgr88A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:28:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:28:12 INFO - Running setup.py (path:/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/pip-lwDt9n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:28:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:28:13 INFO - Running setup.py (path:/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/pip-laoIAG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:28:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:28:13 INFO - Running setup.py (path:/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/pip-D6CH1Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:28:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:28:13 INFO - Running setup.py (path:/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/pip-MBKLiY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:28:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:28:13 INFO - Running setup.py (path:/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/pip-ZuvX4c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:28:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:28:13 INFO - Running setup.py (path:/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/pip-UyyHSr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:28:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:28:13 INFO - Running setup.py (path:/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/pip-ESyJ1O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:28:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:28:13 INFO - Running setup.py (path:/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/pip-cXZAIa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:28:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:28:13 INFO - Running setup.py (path:/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/pip-x9n408-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:28:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:28:13 INFO - Running setup.py (path:/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/pip-PCNVFh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:28:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:28:13 INFO - Running setup.py (path:/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/pip-No_7al-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:28:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:28:14 INFO - Running setup.py (path:/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/pip-5L705w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:28:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:28:14 INFO - Running setup.py install for manifestparser 04:28:14 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:28:14 INFO - Running setup.py install for mozcrash 04:28:14 INFO - Running setup.py install for mozdebug 04:28:14 INFO - Running setup.py install for mozdevice 04:28:14 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:28:14 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:28:14 INFO - Running setup.py install for mozfile 04:28:14 INFO - Running setup.py install for mozhttpd 04:28:15 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:28:15 INFO - Running setup.py install for mozinfo 04:28:15 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:28:15 INFO - Running setup.py install for mozInstall 04:28:15 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:28:15 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:28:15 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:28:15 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:28:15 INFO - Running setup.py install for mozleak 04:28:15 INFO - Running setup.py install for mozlog 04:28:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:28:15 INFO - Running setup.py install for moznetwork 04:28:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:28:15 INFO - Running setup.py install for mozprocess 04:28:15 INFO - Running setup.py install for mozprofile 04:28:16 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:28:16 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:28:16 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:28:16 INFO - Running setup.py install for mozrunner 04:28:16 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:28:16 INFO - Running setup.py install for mozscreenshot 04:28:16 INFO - Running setup.py install for moztest 04:28:16 INFO - Running setup.py install for mozversion 04:28:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:28:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:28:16 INFO - Cleaning up... 04:28:16 INFO - Return code: 0 04:28:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:28:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:28:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:28:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:28:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:28:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:28:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:28:16 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 0x107520490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107496570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc75bc6db80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107334d30>, '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 0x10719adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10732cb20>, '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.HBi8CMr0dW/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.o6L2gEYnAb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/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 04:28:16 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 04:28:16 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 04:28:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HBi8CMr0dW/Render', 04:28:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:28:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:28:16 INFO - 'HOME': '/Users/cltbld', 04:28:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:28:16 INFO - 'LOGNAME': 'cltbld', 04:28:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:28:16 INFO - 'MOZ_NO_REMOTE': '1', 04:28:16 INFO - 'NO_EM_RESTART': '1', 04:28:16 INFO - 'PAGER': '/bin/cat', 04:28:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:28:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:28:16 INFO - 'PWD': '/builds/slave/test', 04:28:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:28:16 INFO - 'SHELL': '/bin/bash', 04:28:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.o6L2gEYnAb/Listeners', 04:28:16 INFO - 'TMPDIR': '/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/', 04:28:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:28:16 INFO - 'USER': 'cltbld', 04:28:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:28:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:28:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:28:16 INFO - 'XPC_FLAGS': '0x0', 04:28:16 INFO - 'XPC_SERVICE_NAME': '0', 04:28:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:28:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:28:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:28:17 INFO - Running setup.py (path:/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/pip-EdufD1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:28:17 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)) 04:28:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:28:17 INFO - Running setup.py (path:/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/pip-TfNDxQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:28:17 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)) 04:28:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:28:17 INFO - Running setup.py (path:/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/pip-O5zrmo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:28:17 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)) 04:28:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:28:17 INFO - Running setup.py (path:/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/pip-ieqCXV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:28:17 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)) 04:28:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:28:17 INFO - Running setup.py (path:/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/pip-hG84W3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:28:17 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)) 04:28:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:28:17 INFO - Running setup.py (path:/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/pip-Sr18Tv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:28:17 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)) 04:28:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:28:17 INFO - Running setup.py (path:/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/pip-44ukMP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:28:17 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)) 04:28:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:28:17 INFO - Running setup.py (path:/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/pip-KX8W9j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:28:17 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)) 04:28:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:28:17 INFO - Running setup.py (path:/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/pip-dSEPU1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:28:17 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)) 04:28:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:28:17 INFO - Running setup.py (path:/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/pip-UFuV_X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:28:18 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)) 04:28:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:28:18 INFO - Running setup.py (path:/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/pip-5EfB37-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:28:18 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)) 04:28:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:28:18 INFO - Running setup.py (path:/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/pip-FUaLwx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:28:18 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)) 04:28:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:28:18 INFO - Running setup.py (path:/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/pip-sWCr8m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:28:18 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)) 04:28:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:28:18 INFO - Running setup.py (path:/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/pip-Mdkk0k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:28:18 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)) 04:28:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:28:18 INFO - Running setup.py (path:/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/pip-VVGYjj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:28:18 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)) 04:28:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:28:18 INFO - Running setup.py (path:/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/pip-QCSMvj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:28:18 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)) 04:28:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:28:18 INFO - Running setup.py (path:/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/pip-U2q2yg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:28:18 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)) 04:28:18 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)) 04:28:18 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)) 04:28:18 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)) 04:28:18 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)) 04:28:18 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)) 04:28:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:28: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 04:28: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 04:28: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 04:28: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 04:28: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 04:28: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 04:28:21 INFO - Downloading blessings-1.6.tar.gz 04:28:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:28:21 INFO - Installing collected packages: blessings 04:28:21 INFO - Running setup.py install for blessings 04:28:21 INFO - Successfully installed blessings 04:28:21 INFO - Cleaning up... 04:28:21 INFO - Return code: 0 04:28:21 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:28:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:28:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:28:21 INFO - Reading from file tmpfile_stdout 04:28:21 INFO - Current package versions: 04:28:21 INFO - blessings == 1.6 04:28:21 INFO - blobuploader == 1.2.4 04:28:21 INFO - docopt == 0.6.1 04:28:21 INFO - functools32 == 3.2.3-2 04:28:21 INFO - jsonschema == 2.5.1 04:28:21 INFO - manifestparser == 1.1 04:28:21 INFO - mozInstall == 1.12 04:28:21 INFO - mozcrash == 0.17 04:28:21 INFO - mozdebug == 0.1 04:28:21 INFO - mozdevice == 0.48 04:28:21 INFO - mozfile == 1.2 04:28:21 INFO - mozhttpd == 0.7 04:28:21 INFO - mozinfo == 0.9 04:28:21 INFO - mozleak == 0.1 04:28:21 INFO - mozlog == 3.4 04:28:21 INFO - moznetwork == 0.27 04:28:21 INFO - mozprocess == 0.23 04:28:21 INFO - mozprofile == 0.28 04:28:21 INFO - mozrunner == 6.12 04:28:21 INFO - mozscreenshot == 0.1 04:28:21 INFO - mozsystemmonitor == 0.3 04:28:21 INFO - moztest == 0.7 04:28:21 INFO - mozversion == 1.4 04:28:21 INFO - psutil == 3.1.1 04:28:21 INFO - requests == 1.2.3 04:28:21 INFO - wsgiref == 0.1.2 04:28:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:28: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')]} 04:28:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:28:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:28: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')]} 04:28:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:28:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:28:21 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 0x107520490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107496570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc75bc6db80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107334d30>, '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 0x10719adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10732cb20>, '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.HBi8CMr0dW/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.o6L2gEYnAb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/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 04:28:21 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 04:28:21 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 04:28:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HBi8CMr0dW/Render', 04:28:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:28:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:28:21 INFO - 'HOME': '/Users/cltbld', 04:28:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:28:21 INFO - 'LOGNAME': 'cltbld', 04:28:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:28:21 INFO - 'MOZ_NO_REMOTE': '1', 04:28:21 INFO - 'NO_EM_RESTART': '1', 04:28:21 INFO - 'PAGER': '/bin/cat', 04:28:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:28:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:28:21 INFO - 'PWD': '/builds/slave/test', 04:28:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:28:21 INFO - 'SHELL': '/bin/bash', 04:28:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.o6L2gEYnAb/Listeners', 04:28:21 INFO - 'TMPDIR': '/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/', 04:28:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:28:21 INFO - 'USER': 'cltbld', 04:28:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:28:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:28:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:28:21 INFO - 'XPC_FLAGS': '0x0', 04:28:21 INFO - 'XPC_SERVICE_NAME': '0', 04:28:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:28:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:28:22 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)) 04:28:22 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)) 04:28:22 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)) 04:28:22 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)) 04:28:22 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)) 04:28:22 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)) 04:28:22 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)) 04:28:22 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)) 04:28:22 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)) 04:28:22 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)) 04:28:22 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)) 04:28:22 INFO - Cleaning up... 04:28:22 INFO - Return code: 0 04:28:22 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:28: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')]} 04:28:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:28:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:28: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')]} 04:28:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:28:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:28: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107520490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107496570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc75bc6db80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107334d30>, '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 0x10719adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10732cb20>, '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.HBi8CMr0dW/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.o6L2gEYnAb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/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 04:28: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', 'jsonschema'] in /builds/slave/test/build 04:28: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 jsonschema 04:28:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HBi8CMr0dW/Render', 04:28:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:28:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:28:22 INFO - 'HOME': '/Users/cltbld', 04:28:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:28:22 INFO - 'LOGNAME': 'cltbld', 04:28:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:28:22 INFO - 'MOZ_NO_REMOTE': '1', 04:28:22 INFO - 'NO_EM_RESTART': '1', 04:28:22 INFO - 'PAGER': '/bin/cat', 04:28:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:28:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:28:22 INFO - 'PWD': '/builds/slave/test', 04:28:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:28:22 INFO - 'SHELL': '/bin/bash', 04:28:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.o6L2gEYnAb/Listeners', 04:28:22 INFO - 'TMPDIR': '/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/', 04:28:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:28:22 INFO - 'USER': 'cltbld', 04:28:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:28:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:28:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:28:22 INFO - 'XPC_FLAGS': '0x0', 04:28:22 INFO - 'XPC_SERVICE_NAME': '0', 04:28:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:28:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:28:22 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:28:22 INFO - Cleaning up... 04:28:22 INFO - Return code: 0 04:28:22 INFO - Running post-action listener: _resource_record_post_action 04:28:22 INFO - Running post-action listener: _start_resource_monitoring 04:28:22 INFO - Starting resource monitoring. 04:28:22 INFO - [mozharness: 2016-10-13 11:28:22.520260Z] Finished create-virtualenv step (success) 04:28:22 INFO - [mozharness: 2016-10-13 11:28:22.521302Z] Running install step. 04:28:22 INFO - Running pre-action listener: _resource_record_pre_action 04:28:22 INFO - Running main action method: install 04:28:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:28:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:28:22 INFO - Reading from file tmpfile_stdout 04:28:22 INFO - Detecting whether we're running mozinstall >=1.0... 04:28:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:28:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:28:22 INFO - Reading from file tmpfile_stdout 04:28:22 INFO - Output received: 04:28:22 INFO - Usage: mozinstall [options] installer 04:28:22 INFO - Options: 04:28:22 INFO - -h, --help show this help message and exit 04:28:22 INFO - -d DEST, --destination=DEST 04:28:22 INFO - Directory to install application into. [default: 04:28:22 INFO - "/builds/slave/test"] 04:28:22 INFO - --app=APP Application being installed. [default: firefox] 04:28:22 INFO - mkdir: /builds/slave/test/build/application 04:28:22 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'] 04:28:22 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 04:28:55 INFO - Reading from file tmpfile_stdout 04:28:55 INFO - Output received: 04:28:55 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 04:28:55 INFO - Running post-action listener: _resource_record_post_action 04:28:55 INFO - [mozharness: 2016-10-13 11:28:55.329648Z] Finished install step (success) 04:28:55 INFO - [mozharness: 2016-10-13 11:28:55.329837Z] Running run-tests step. 04:28:55 INFO - Running pre-action listener: _resource_record_pre_action 04:28:55 INFO - Running main action method: run_tests 04:28:55 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:28:55 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:28:55 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:28:55 INFO - 2016-10-13 04:28:55.344 screenresolution[1634:7423] starting screenresolution argv=screenresolution get 04:28:55 INFO - 2016-10-13 04:28:55.346 screenresolution[1634:7423] Display 0: 1600x1200x32@60 04:28:55 INFO - 2016-10-13 04:28:55.352 screenresolution[1635:7425] starting screenresolution argv=screenresolution list 04:28:55 INFO - Available Modes on Display 0 04:28:55 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:28:55 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:28:55 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:28:55 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:28:55 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:28:55 INFO - Intel Iris: 04:28:55 INFO - Chipset Model: Intel Iris 04:28:55 INFO - Type: GPU 04:28:55 INFO - Bus: Built-In 04:28:55 INFO - VRAM (Dynamic, Max): 1536 MB 04:28:55 INFO - Vendor: Intel (0x8086) 04:28:55 INFO - Device ID: 0x0a2e 04:28:55 INFO - Revision ID: 0x0009 04:28:55 INFO - Displays: 04:28:55 INFO - Display: 04:28:55 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:28:55 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:28:55 INFO - Display Serial Number: 1600x1200 60 04:28:55 INFO - Main Display: Yes 04:28:55 INFO - Mirror: Off 04:28:55 INFO - Online: Yes 04:28:55 INFO - Rotation: Supported 04:28:55 INFO - Return code: 0 04:28:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:28:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:28:55 INFO - Python 2.7.3 04:28:55 INFO - Return code: 0 04:28:55 INFO - grabbing minidump binary from tooltool 04:28:55 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')]} 04:28:55 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 0x107334d30>, '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 0x10719adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10732cb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:28:55 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 04:28:55 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 04:28:55 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 04:28:55 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:28:55 INFO - Return code: 0 04:28:55 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:28:55 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:28:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:28:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:28:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:28:55 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/Kyp2yyZGSjiT03QJcMTLOw/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0183', '--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 04:28:55 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/Kyp2yyZGSjiT03QJcMTLOw/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0183 --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 04:28:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HBi8CMr0dW/Render', 04:28:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:28:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:28:55 INFO - 'HOME': '/Users/cltbld', 04:28:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:28:55 INFO - 'LOGNAME': 'cltbld', 04:28:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:28:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:28:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:28:55 INFO - 'MOZ_NO_REMOTE': '1', 04:28:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:28:55 INFO - 'NO_EM_RESTART': '1', 04:28:55 INFO - 'PAGER': '/bin/cat', 04:28:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:28:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:28:55 INFO - 'PWD': '/builds/slave/test', 04:28:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:28:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:28:55 INFO - 'SHELL': '/bin/bash', 04:28:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.o6L2gEYnAb/Listeners', 04:28:55 INFO - 'TMPDIR': '/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/', 04:28:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:28:55 INFO - 'USER': 'cltbld', 04:28:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:28:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:28:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:28:55 INFO - 'XPC_FLAGS': '0x0', 04:28:55 INFO - 'XPC_SERVICE_NAME': '0', 04:28:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:28:55 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/Kyp2yyZGSjiT03QJcMTLOw/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0183', '--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 04:28:55 INFO - mozversion application_buildid: 20161013014024 04:28:55 INFO - mozversion application_changeset: cd067bd545083034fe8c1a9c5f1c39cf4fd257ea 04:28:55 INFO - mozversion application_display_name: FirefoxDeveloperEdition 04:28:55 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:28:55 INFO - mozversion application_name: Firefox 04:28:55 INFO - mozversion application_remotingname: firefox-dev 04:28:55 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 04:28:55 INFO - mozversion application_vendor: Mozilla 04:28:55 INFO - mozversion application_version: 51.0a2 04:28:55 INFO - mozversion platform_buildid: 20161013014024 04:28:55 INFO - mozversion platform_changeset: cd067bd545083034fe8c1a9c5f1c39cf4fd257ea 04:28:55 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 04:28:55 INFO - mozversion platform_version: 51.0a2 04:28:55 INFO - using testdate: 1476358135 04:28:55 INFO - actual date: 1476358135 04:28:55 INFO - starting webserver on 'localhost:49268' 04:28:55 INFO - SUITE-START | Running 2 tests 04:28:55 INFO - TEST-START | dromaeo_css 04:28:55 INFO - operating with platform_type : mac_ 04:28:55 INFO - Initialising browser for dromaeo_css test... 04:28:55 INFO - TEST-INFO | started process 1645 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/tmplN0c2c/profile http://localhost:49268/getInfo.html) 04:28:58 INFO - PROCESS | 1645 | __metrics Screen width/height:1600/1200 04:28:58 INFO - PROCESS | 1645 | colorDepth:24 04:28:58 INFO - PROCESS | 1645 | Browser inner width/height: 1024/689 04:28:58 INFO - PROCESS | 1645 | __metrics 04:28:58 INFO - PROCESS | 1645 | 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" 04:28:58 INFO - PROCESS | 1645 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:28:59 INFO - TEST-INFO | 1645: exit 0 04:28:59 INFO - Browser initialized. 04:28:59 INFO - Running cycle 1/1 for dromaeo_css test... 04:28:59 INFO - TEST-INFO | started process 1647 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/tmplN0c2c/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:29:11 INFO - PROCESS | 1647 | RSS: Main: 219463680 04:29:11 INFO - PROCESS | 1647 | 04:30:03 INFO - PROCESS | 1647 | 1476358203024 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] 04:32:13 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49268/tests/dromaeo/cssquery-ext.html) 04:32:15 INFO - PROCESS | 1647 | RSS: Main: 351870976 04:32:15 INFO - PROCESS | 1647 | 04:35:18 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-ext.html (next: http://localhost:49268/tests/dromaeo/cssquery-jquery.html) 04:35:18 INFO - PROCESS | 1647 | RSS: Main: 351416320 04:35:18 INFO - PROCESS | 1647 | 04:38:21 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49268/tests/dromaeo/cssquery-mootools.html) 04:38:21 INFO - PROCESS | 1647 | RSS: Main: 321413120 04:38:21 INFO - PROCESS | 1647 | 04:41:23 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49268/tests/dromaeo/cssquery-prototype.html) 04:41:24 INFO - PROCESS | 1647 | RSS: Main: 336257024 04:41:24 INFO - PROCESS | 1647 | 04:44:27 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49268/tests/dromaeo/cssquery-yui.html) 04:44:28 INFO - PROCESS | 1647 | RSS: Main: 309760000 04:44:28 INFO - PROCESS | 1647 | 04:47:31 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-yui.html (next: http://localhost:49268/tests/dromaeo/cssquery-dojo.html) 04:47:31 INFO - PROCESS | 1647 | RSS: Main: 358907904 04:47:31 INFO - PROCESS | 1647 | 04:47:31 INFO - PROCESS | 1647 | __start_tp_report 04:47:31 INFO - PROCESS | 1647 | _x_x_mozilla_page_load 04:47:31 INFO - PROCESS | 1647 | _x_x_mozilla_page_load_details 04:47:31 INFO - PROCESS | 1647 | |i|pagename|runs| 04:47:31 INFO - PROCESS | 1647 | |0;dojo.html;3106.4563701352263;3299.208190034392;3314.5028245763147;3331.2837739885917;3366.7811592246503;5624.465675760801;5643.492085712285;5679.659220446766;5727.42725727427;5731.369549349573;5652.547796176306;5730.05454100074;5735.283089613798;5735.426457354273;5741.052726300166;5158.277841102249;5190.299309593213;5192.92210616842;5193.065248255312;5229.372475302969;4375.234333991555;5126.307948426952;5151.665141765792;5273;5319.867003324909;5186.844394668147;5191.688498690071;5259.579233661317;5262.657927234736;5268.367795864501;5172.456892026321;5184.429712731597;5190.636655434121;5208.5312321891215;5264.210368444726;5106.872328191825;5218.269442278084;5227.137522308853;5271;5295.443978382253;5483;5522.475364840374;5528.55771538276;5633.887322253573;5703.116017017369;5306.946930530684;6056.454919057262;6136.509079273692;6189.597676151081;6233.877901977642;6250.624962502219;6309.589876658002;6310.8106756796915;6316.242050953915;6320.905186422161;5600.747966341524;5647.858803529863;5776.595638305363;5787.623804452697;5806.477417032487;6209.9379006210265;6257.843553911098;6257.8748425031245;6280.214973128359;6304.338044505353;5987.221661184019;6057.091436284504;6058.818235452944;6066.545009124334;6067.7269522871575;4648.465426475998;6074.726637301332;6191.876162476815;6217.9689101555105;6222.315545290015;5156.664816786897;5929.673867937218;6048.546359023003;6063.575549711566;6079.118527813443;5294.41761406245;6081.179040829431;6118.908216376758;6143.938560614426;6235.532335074888;4932.235503496964;4933.827316043921;4934.210526315772;4941.234108713155;4946.950530494721;4308.052228509723;4360.847370342086;4392.604665580113;4443.200223959654;4452.354408610733;5684.204211410406;5691.203231547586;5756.856078597984;5759.280089988752;5777.884442311214;5391;6203.720832562545;6360.52296077796;6360.7137678804565;6372.171617689671;5755.740991655385;5805.564582656318;5809.215755872988;5818.4472475115645;5829.708514574254;5208.947910520847;5328.786848526015;5332.733363331818;5376.435474275223;5410.323709536308;6218.347073557211;6250.6874656267;6307.05394190875;6342;6368.9044664330995;6304.243490780952;6306.842328941813;6323.462505687068;6331.113644089924;6339.4928405726505;6159.952808022557;6306.054091886253;6327.430531252209;6347.333529979471;6356.4279214870885;6044.365341639064;6051.273847138195;6132.816015519542;6134.509239260759;6142.222533141996;6165.753369865155;6290.49676025926;6295.622262664255;6298.149749783904;6300.779472718433;6009.969950150221;6035.094735789491;6043.45608895184;6074.119252708421;6098.5426093042315;5798.478136967693;5801.680907550125;5831.241938547962;5988.760449581968;5991.970040149771;4782.258749893772;5708.885822283614;5722.113072473773;5738.971305143447;5742.655440673573;5860.150278209721;5866.2960444746905;5869.559783016376;5875.853103672443;5895.20414744004;5704.657720536781;5709.54323654115;5733;5833.387494313036;5841.912371314349 04:47:31 INFO - PROCESS | 1647 | |1;ext.html;482.08404032338564;514.5729044892738;523.2177894048396;523.5079025715827;552.0284299632646;29917.55123673144;30291;32249.83875080621;32343.191420214476;40070.59929400705;39614.40578391319;40865;42118;42288.36567451483;42318;9747.220222382228;9915.603375864957;9942.304038717293;9945.502724863763;9954.552045157949;8786.64853405863;8959.01450840407;9736.561854716554;9852;11845.111616628787;11904.940475297655;12139.878601214008;12142.39288035599;12161.452734626962;12166.939165304206;12154.93922530386;12231.449584768707;12232.755344893141;12235.143539952207;12267.957223635956;8743.256823170039;8921.955390223073;8926.2412694921;9047.18575328217;12009.579664711693;31899.52150717741;39083.609163908564;39412.40881386781;39418.802905985285;41785.791071044754;3241.286916878283;3271.247613048988;3621.6740493355724;3861.903452413684;3873.1091848874917;29348.559771603228;30342.393152136832;31027;31834.522482162785;31902.20244493883;3134.9216269593217;3192.425363434581;3212.245122396235;3230.2570408806105;3251.203455153479;493633;494275;494956;494967.9999999964;496298;53418.73290633522;54831.177532337046;61400.38599614036;63125.368746312866;63252.36747632557;62996;63025.05462418067;65138.67430662911;65794;65939.67030164819;14513.564593062225;16761.916190419215;16852.91573542149;16874.74687879683;16898.070606116537;12960.67598310031;13018.544350947672;13058.54295099686;13099.95200383986;13217.33913304331;16019.599510012109;16529.09915359725;16545;18249.270029198684;18998.71501927472;7348.77953661391;7472.70109195637;7489.85020299591;7510.474266801271;7519.43604229674;841.4362377207163;930.5951910918772;984.9162821160138;1007.9395236285847;1022.1362948308667;29115.56326655102;29834;30320.090397288117;30687.846560767055;30866.537001944987;1042.9739256518496;1114.8272017837087;1141.8230174322994;1145.2212495503138;1192.862820775622;15198.392064317304;15213.087214767149;15550.300236489385;15606.453774117852;15964.600884977735;385407;389460;391039.08960910595;391140.04429978237;391218;51244.74377628088;51905.2214216787;57696;58797.706011470524;58844.41155588475;1333.3333333333333;1358.483776165051;1368.1244003837553;1369.5617402431126;1371.3828777050367;27971.881124754782;27983;30839.845800770854;31225.123387995794;31902.042938711875;51311.486885132166;51984.74007629938;52012.479875202276;52081.21878171754;52136.739316303174;602926;605434;606624;607434;609790;27005.189844304703;27425.45149096967;27451.31371715723;27454.588181177696;27523.449531009668;47773;48368;48487.03025939391;48559;48910.26634600555;38806;39132.217355653294;39158;39829.00427489336;40862.9784255396;38686;39130;39391;39689.80155099206;41000;35690.821545892104;38082.428763568016;38125.428118577685;38989.415158773205;39001.6099838998;32803.34393312168;34251.657483424846;35144.121396964256;35151.82424087863;35378.64621353753;25847;25849.741502585486;25900.348039972137;26123.869380652974;26556.601650974866 04:47:31 INFO - PROCESS | 1647 | |2;jquery.html;318.43636762929617;356.4848793493403;370.17635760433024;381.1272186692473;406.729524865964;14871.628209294773;15030.849691503081;15963.999999999985;18409.07954602268;18834.681572289945;19996;20292.18831246752;20995;21077.683834742493;21351;5968.432998865101;6245.156903817971;6252.437280644741;6253.343398943114;6255.218097737783;5249.973750131263;6850.554713943603;6947.374736273734;6987.825304367406;7051.823704407379;6676.933230667704;6845.8973115403305;6885.758998435056;6951.721931122749;6971;6397.264314603834;6650.86698266032;6834.487413443987;6916.619585922797;6933.72265109395;5789.421057894219;5917.437843404869;5926.1110833374905;5926.199963004982;5931.555133364972;23993.640095398583;25365.73171341444;25410.729463526935;25552.233432996854;25733.228003159747;2161.8919054047233;2440.487497625501;2750.876210570529;2966.209571541966;3028.4700177469076;9733.513324333755;9809.558569864374;9828.606855725762;10189.59241630334;10265.230107741874;1816.1645643004233;1881.5014021284371;1887.6224755049045;1946.6885298352195;2034.2371610646007;96698;119117.13243013617;126916.65416729219;127485.36257318746;130398;11087.445627718582;11345.602903898489;11461.681906580683;11557.768844623228;11670.241434306743;14819.259037048105;14831.11013339203;14852.183129927958;14865.628359290888;14902.403903843724;7350.4119670426235;8460.196281353261;8599.52702601363;8625.396222264506;8713.520756358334;8547.059823419419;8556.315494760403;8558.871616925751;8727.738167854848;8736;4489.977550112294;4556.120165086809;4570.428696412949;4570.7943142558;4619.930701039487;1629.7473891546829;1710.9572260693333;1790.2480957997673;1909.5417099895924;1912.6270377276298;833.3333333333309;866.8786369908217;911.6034524981521;958.6932181701928;963.5663951221978;20716.689249661267;21776.23783167613;21916.561668766535;21919;21955.90220488969;941.223490620241;945.7210123013728;947.507296205969;983.1053741095569;1030.9175265978854;10666.78666426667;11212.327260364404;11336.829947550794;11368.204225704287;11448.542058317575;602066;604012;608812;614530;614595.927020362;88497.67253491202;123844;127335;128920;134715;893.8614514750224;913.4930113786779;945.3099237556622;947.4362754161263;948.3598570964572;15912.840871591136;18850.52873678169;19289;19333.226670933003;19504.90247548753;53766.655833604476;55873;56371;56571.71714141403;57532.71233643805;79675.60162199152;80890.59554702189;81869;83161.58419207865;84224;7567.31894129531;7757.961210194138;7925.365970722443;8007.759767206993;8143.6742530298125;8905.109489051043;9642.951785241028;11211.943940280247;12586.18189817659;13322.933385333012;11203.663890083311;11306.604268850551;11307.497969414158;11355.716107097389;11470.025047870691;11184.776304474028;11468.713282168013;11490.253133546294;11655.941720291345;11707.941460292985;5846.298444186725;6767.966160169168;9494.857577136487;11388.540505968604;11878.406079696153;8116.2695357418115;8183.6726530938095;8257.339412847077;8267.173282671685;8309.792255193426;10129.848052279369;10795.19036072282;10964.013238808546;11033.613823516138;11063.889361106287 04:47:31 INFO - PROCESS | 1647 | |3;mootools.html;1440.1287221231157;1490.0612614053146;1631.6084139806442;1787.1689664306111;1831.2308830291277;8353.582320883954;8929.1517305856;8936.508492032935;8940.999999999993;8948.507832069234;7732.072151341833;7967.083785364684;7967.322777563914;8502.617382217799;8660.133986601337;2117.258959364218;2327.138958585326;2343.742188359279;2370.6207006878903;2375.8574485530835;2332.4402143485527;2345.9648105278347;2375.714914210297;2376.1564644551195;2376.2514807835564;2351.8588884666888;2364.3025307534317;2368.6210206366986;2378.250850981935;2384.2012925669833;2321.8258630602604;2343.5195784864145;2348.330725743172;2352.5530149271754;2357.8938947747392;2007.5181956330375;2350.25966820451;2351.6825228594093;2352.0003998300654;2352.3766201956496;8826.779330516723;8829.470231786114;8925;8927.508987005713;8942;5128.666636668605;5297.4437684043005;5303.973480132613;5308.495692909168;5315.760790764425;3404.1829960809227;3472.9652703472893;3634.6001939786865;3649.1242101895355;3659.743817932746;1067.2529229539352;1090.4275255490852;1090.574675876409;1115.9218854680175;1119.121489630636;11535.596254131066;11646.883531164665;11655.592054278144;11661.416929153509;11679.948804607626;4488.708233964782;4669.556392142741;4766.261229509431;4777.259524773665;4799.688020278671;9723.854142187873;9731.41611503312;9737.367071140354;9759.219262458986;9797;5313.362396512443;5315.202719592092;5317.521423071942;5317.813876514381;5320.095583750772;4346.978265108654;4415.470143582726;4499.955000450019;4806.735629540409;4879.097366987119;3870.2259548090497;3896.668783153407;3974.668486057203;4005.579414161471;4007.73949693269;1287.5171810571037;1291.2252648411065;1294.0359432223054;1308.2739079810606;1308.4373719300793;781.2109769133103;818.4475479051616;861.5390765940192;870.3559366069063;896.551724137931;5491.258680078138;5561.610687251934;5570.749316280777;5624.353199382042;5659.207710920475;432.89610493481337;435.3926272849357;437.7723583736439;440.2471773267684;441.66212847171937;3264.347130573895;3830.7893065881085;3835.6931445484292;3858.3633700439113;4022.738521996061;8514;10850.403227822546;10930.453477326102;10930.508127134299;10941.4529273536;10895.455227238606;10906;10907.127429805596;10921.962413570698;10932.890671093346;8026.719064832703;8132.878006829902;8169.63236654352;8331.750047498463;8333.33333333332;5535.916961245504;5754.769809207585;5822.097574875901;5829.242198514166;5853.9121913172185;9955.20358371343;9957.153641940517;10162.949185254027;10183.847242291224;10291.7427064321;10292.581243407643;10322.174226062047;10346.32748871321;10398.428086455015;10472.319299245524;7267.927320726936;7342.889856652261;7411.258874112761;7438.107427108782;7485.588292643739;8113.634886430007;8197.75406737775;8199.344052475668;8204.466709663853;8231.218034286732;7284.344409003215;7399.112106547249;7458.5151965122095;7567.394608431422;7623.656935437808;7218.3503484686635;7313.780586582411;7369.336759691653;7456.589887556236;7539.019927409402;6320.715567799552;6752.527323087336;6907.309269073053;6913.827154321182;6913.827154321182;4879.39007624047;4932.21084626458;4955.108080545537;4967.950320496893;5062.848114556569;4874.463808980939;4949.455559888337;4974.527419895249;5065.746712664279;5116.334876466036 04:47:31 INFO - PROCESS | 1647 | |4;prototype.html;294.6802719049832;302.9242689327668;314.6255955413059;315.24184336670316;318.1917928461706;4733.668643194977;4889.2421674640445;5236.836714811724;5397.190421436787;5525.585581081415;5211.348581427322;5223.425423203445;5439.5376393006545;5461.726913654321;5486.670799752018;4174.914522224213;4178.247915375231;4184.372344148372;4197.586387827012;4209.389638502415;3785.7663978252826;3914.6868250540033;4189.9790501047455;4199.55904630014;4208.642265407444;4131.814068366915;4134.470246008981;4163.68772342074;4165.687573431989;4178.268802959486;3495.02922515862;3848.749831260959;3866.903327416809;4152.896177595554;4156.771377574232;3485.89542313731;3647.708183345326;3652.1782598915297;3656.8537258509627;3658.32321020612;5309.814156504543;5335.653182543161;5352.304200453955;5363.973180134074;5385.838424847261;4245.554216807222;4792.544708252711;4832.395950506187;4843.754684361486;4848.490908454597;5352.625316227865;5394.514493695547;5556.972215138939;5756.683382413966;5792.594518383715;3326.4365748098353;3904.7852368119743;3916.8237429315463;3933.9016524586827;3949.8617548385955;5494.587905907073;5688.971555142198;5758.176560775494;5873.324567674729;6248.437640612321;3621.1852333224815;3708.978606659377;3764.1906989997283;3936.8622098226997;3959.544652364957;3431.8455669494933;3954.7429417088374;3975.6421922027157;3986.5216174059296;3989.960100399017;4003.899902502461;4674.859754207379;4683.414573178353;4693.5775780179265;4709.175894218498;5099.3370861787735;5679.488846003796;5751.827445176651;5796.884062318814;5819.301683797971;1328.2760895312078;1362.7751421015619;1363.4137320951888;1376.876081152681;1378.7931810228547;793.8848866914265;825.2284114353099;832.875617915821;835.2148979958819;841.6465084664455;4239.788010599519;4244.554321796229;4320.395144679747;4605.812239186426;4684.320773487893;4922.483139270396;5023.748812559357;5038.370203724535;5043.394792624908;5059.5952323814745;4046.309204379114;4196.853110141192;4332.458442694663;4644.605208557243;4700.2057900940845;2428.162284012013;2434.2857713649155;2544.7200807911113;2650.5494066008823;2657.641218435525;5191.870203244949;5216.478352164753;5242.9213561796605;5277.947220527745;5297.443768404339;4323.951614112044;4742.842006886858;4797.880052998703;4812.967830266979;4959.752012399365;4755.310479980383;4781.784819683053;4992.950070499322;5191.766370513336;5213.765380557884;4261.403403523571;4477.865664030084;4672.859814205579;4728.40894888139;4962.478939711278;3934.9409758854213;4729.716217026989;4782.6847616905625;4889.608831293559;4902.362692849907;4666.906661866811;4711.199096153594;4933.703977761345;5022.899542009212;5174.741262936914;2980.925476863096;3388.203772113502;3693.2059607184583;3708.9629103708617;3870.477485539416;5521.309836270466;5911.290645122613;5968.552358573212;5997.970010150096;6021.668808215591;4730.834420795393;4909.9018019640125;5580.916286255629;5734.369219385948;5879.501211984975;4990.437131533822;5018.42288136869;5525.613207075467;5554.861128471821;5767.279090113736;5186.611004174777;5415.1029199378145;5617.606767526398;5617.915731264116;5669.4047125051275;4638.680659670165;4907.68100073494;5755.769769209185;5791.652500849962;5837.94162058391;5531.534143452069;5757.704516483757;5762.0121058234845;5812.18629391894;5835.67903765297 04:47:31 INFO - PROCESS | 1647 | |5;yui.html;679.0968012543316;686.135469308671;712.2307907459942;763.2253262938116;781.4022272961182;14840.109593424402;16005.839941600581;16023.439179628715;16059.919700401482;16105.919470402632;14412;14563.417463301455;14573.05275157114;14593.927030364834;14599.635009124777;663.9767608133716;689.4794430205188;694.3646563394487;837.9874301885477;864.2178828160525;850.2262940723942;851.4763420496381;858.6737039924819;859.2524503681806;859.291084854994;911.4713466189594;912.4616476278994;916.1067958740242;916.3951791817402;917.7063339731288;703.4513079797766;911.3347256502724;912.1972664055622;912.6212621761961;918.4213945214472;545.4736179586678;546.8632841789553;548.4707257496535;549.343534476301;659.960402375859;14671.193084380355;15081.849181508263;15105.924470377688;15114.848851511455;15120.924395378062;12553.184043037265;12786.680332991657;13952.2326272055;13988.654068954525;14052.789208161887;11025.558977640885;11457.656270311903;11574.958253757119;12486.50053997839;12637.557685480964;4556.612687921531;4584.656150788671;4611.423572053493;4752.07334569759;4762.761861906925;70261.08172427933;70941.93587096197;110109.39343639408;115615;119681.40159299235;10183.287169898183;10399.48002599882;10806;10963.890361096286;10969.616063437741;20537;20582.897085514476;20593.89703051505;20615;20632.96835158236;7301.452391070691;7621.618919054025;7800.648970796327;7855.7250496232355;7891.921080789233;4239.766812825324;4243.215005223981;4380.737155770664;4384.8246070157475;4494.168578812864;3377.7297816174646;3509.175343794206;3513.9121521962156;3514.0512061743184;3515.9121021974656;622.2781573374864;643.1285608001184;644.8323435906698;650.8860949333848;662.159057996342;516.7364644031571;562.530287210184;569.63827969239;615.2831950777384;640.6636515829227;8881.42270752412;8963.103689630985;9000;9058.54707264634;9153.697762051825;612.1429998002743;625.6402568523026;629.0846817879974;630.4420587779848;631.6336524815596;4317.848875289413;4438.822447102079;4448.799804008828;4451.933221001687;4545.795439205243;90808;127387.36306318594;161145;169956.1502192481;178132;151455;154913.2254338721;155856;156260.43739562685;158579.20710396604;106475;126205;127428.36285818697;130256.3487182577;130772;9210.006747807123;9690.403866584888;9793.51032448389;9956.850647240153;10038.85623194199;57305;65330.67334663296;66510.66978660303;67816.64366712737;68950;82266.06403615802;88667.22665546525;95167.52416238151;95794;97665;12735.872641273469;12980.98794686825;13234.205947643171;13802.792958105838;14151.858481415054;12739.872601273868;14051.789223161457;14541.709165816414;14550.345234464263;15743.842561574696;12247.326397047891;12489.375531223584;12718.745625087631;12931.159474634118;13666.93166534161;13337.733245335234;13382.59237314723;13690.315484225948;13931.233782142079;13940;12998;13476.393562289917;13692.65768355799;13774.793378099135;13780.242086684928;10766.730831728955;11117.499712513118;11360.318380897173;11574.305541667527;11894;11091.334519928507;11404.828927565926;11597.420128993348;11606.071514278668;11638.476268567765 04:47:31 INFO - PROCESS | 1647 | __end_tp_report 04:47:31 INFO - PROCESS | 1647 | __start_cc_report 04:47:31 INFO - PROCESS | 1647 | _x_x_mozilla_cycle_collect,1263 04:47:31 INFO - PROCESS | 1647 | __end_cc_report 04:47:31 INFO - PROCESS | 1647 | __startTimestamp1476359251653__endTimestamp 04:47:31 INFO - PROCESS | 1647 | 04:47:31 INFO - PROCESS | 1647 | ------- Summary: start ------- 04:47:31 INFO - PROCESS | 1647 | Number of tests: 6 04:47:31 INFO - PROCESS | 1647 | 04:47:31 INFO - PROCESS | 1647 | [#0] dojo.html Cycles:165 Average:5664.22 Median:5787.62 stddev:649.69 (11.2%) stddev-sans-first:619.92 04:47:31 INFO - PROCESS | 1647 | Values: 3106.5 3299.2 3314.5 3331.3 3366.8 5624.5 5643.5 5679.7 5727.4 5731.4 5652.5 5730.1 5735.3 5735.4 5741.1 5158.3 5190.3 5192.9 5193.1 5229.4 4375.2 5126.3 5151.7 5273.0 5319.9 5186.8 5191.7 5259.6 5262.7 5268.4 5172.5 5184.4 5190.6 5208.5 5264.2 5106.9 5218.3 5227.1 5271.0 5295.4 5483.0 5522.5 5528.6 5633.9 5703.1 5306.9 6056.5 6136.5 6189.6 6233.9 6250.6 6309.6 6310.8 6316.2 6320.9 5600.7 5647.9 5776.6 5787.6 5806.5 6209.9 6257.8 6257.9 6280.2 6304.3 5987.2 6057.1 6058.8 6066.5 6067.7 4648.5 6074.7 6191.9 6218.0 6222.3 5156.7 5929.7 6048.5 6063.6 6079.1 5294.4 6081.2 6118.9 6143.9 6235.5 4932.2 4933.8 4934.2 4941.2 4947.0 4308.1 4360.8 4392.6 4443.2 4452.4 5684.2 5691.2 5756.9 5759.3 5777.9 5391.0 6203.7 6360.5 6360.7 6372.2 5755.7 5805.6 5809.2 5818.4 5829.7 5208.9 5328.8 5332.7 5376.4 5410.3 6218.3 6250.7 6307.1 6342.0 6368.9 6304.2 6306.8 6323.5 6331.1 6339.5 6160.0 6306.1 6327.4 6347.3 6356.4 6044.4 6051.3 6132.8 6134.5 6142.2 6165.8 6290.5 6295.6 6298.1 6300.8 6010.0 6035.1 6043.5 6074.1 6098.5 5798.5 5801.7 5831.2 5988.8 5992.0 4782.3 5708.9 5722.1 5739.0 5742.7 5860.2 5866.3 5869.6 5875.9 5895.2 5704.7 5709.5 5733.0 5833.4 5841.9 04:47:31 INFO - PROCESS | 1647 | 04:47:31 INFO - PROCESS | 1647 | [#1] ext.html Cycles:180 Average:64267.27 Median:194634.45 stddev:134490.02 (69.1%) stddev-sans-first:134782.03 04:47:31 INFO - PROCESS | 1647 | Values: 482.1 514.6 523.2 523.5 552.0 29917.6 30291.0 32249.8 32343.2 40070.6 39614.4 40865.0 42118.0 42288.4 42318.0 9747.2 9915.6 9942.3 9945.5 9954.6 8786.6 8959.0 9736.6 9852.0 11845.1 11904.9 12139.9 12142.4 12161.5 12166.9 12154.9 12231.4 12232.8 12235.1 12268.0 8743.3 8922.0 8926.2 9047.2 12009.6 31899.5 39083.6 39412.4 39418.8 41785.8 3241.3 3271.2 3621.7 3861.9 3873.1 29348.6 30342.4 31027.0 31834.5 31902.2 3134.9 3192.4 3212.2 3230.3 3251.2 493633.0 494275.0 494956.0 494968.0 496298.0 53418.7 54831.2 61400.4 63125.4 63252.4 62996.0 63025.1 65138.7 65794.0 65939.7 14513.6 16761.9 16852.9 16874.7 16898.1 12960.7 13018.5 13058.5 13100.0 13217.3 16019.6 16529.1 16545.0 18249.3 18998.7 7348.8 7472.7 7489.9 7510.5 7519.4 841.4 930.6 984.9 1007.9 1022.1 29115.6 29834.0 30320.1 30687.8 30866.5 1043.0 1114.8 1141.8 1145.2 1192.9 15198.4 15213.1 15550.3 15606.5 15964.6 385407.0 389460.0 391039.1 391140.0 391218.0 51244.7 51905.2 57696.0 58797.7 58844.4 1333.3 1358.5 1368.1 1369.6 1371.4 27971.9 27983.0 30839.8 31225.1 31902.0 51311.5 51984.7 52012.5 52081.2 52136.7 602926.0 605434.0 606624.0 607434.0 609790.0 27005.2 27425.5 27451.3 27454.6 27523.4 47773.0 48368.0 48487.0 48559.0 48910.3 38806.0 39132.2 39158.0 39829.0 40863.0 38686.0 39130.0 39391.0 39689.8 41000.0 35690.8 38082.4 38125.4 38989.4 39001.6 32803.3 34251.7 35144.1 35151.8 35378.6 25847.0 25849.7 25900.3 26123.9 26556.6 04:47:31 INFO - PROCESS | 1647 | 04:47:31 INFO - PROCESS | 1647 | [#2] jquery.html Cycles:180 Average:35310.74 Median:2448.35 stddev:101511.77 (4146.1%) stddev-sans-first:101762.53 04:47:31 INFO - PROCESS | 1647 | Values: 318.4 356.5 370.2 381.1 406.7 14871.6 15030.8 15964.0 18409.1 18834.7 19996.0 20292.2 20995.0 21077.7 21351.0 5968.4 6245.2 6252.4 6253.3 6255.2 5250.0 6850.6 6947.4 6987.8 7051.8 6676.9 6845.9 6885.8 6951.7 6971.0 6397.3 6650.9 6834.5 6916.6 6933.7 5789.4 5917.4 5926.1 5926.2 5931.6 23993.6 25365.7 25410.7 25552.2 25733.2 2161.9 2440.5 2750.9 2966.2 3028.5 9733.5 9809.6 9828.6 10189.6 10265.2 1816.2 1881.5 1887.6 1946.7 2034.2 96698.0 119117.1 126916.7 127485.4 130398.0 11087.4 11345.6 11461.7 11557.8 11670.2 14819.3 14831.1 14852.2 14865.6 14902.4 7350.4 8460.2 8599.5 8625.4 8713.5 8547.1 8556.3 8558.9 8727.7 8736.0 4490.0 4556.1 4570.4 4570.8 4619.9 1629.7 1711.0 1790.2 1909.5 1912.6 833.3 866.9 911.6 958.7 963.6 20716.7 21776.2 21916.6 21919.0 21955.9 941.2 945.7 947.5 983.1 1030.9 10666.8 11212.3 11336.8 11368.2 11448.5 602066.0 604012.0 608812.0 614530.0 614595.9 88497.7 123844.0 127335.0 128920.0 134715.0 893.9 913.5 945.3 947.4 948.4 15912.8 18850.5 19289.0 19333.2 19504.9 53766.7 55873.0 56371.0 56571.7 57532.7 79675.6 80890.6 81869.0 83161.6 84224.0 7567.3 7758.0 7925.4 8007.8 8143.7 8905.1 9643.0 11211.9 12586.2 13322.9 11203.7 11306.6 11307.5 11355.7 11470.0 11184.8 11468.7 11490.3 11655.9 11707.9 5846.3 6768.0 9494.9 11388.5 11878.4 8116.3 8183.7 8257.3 8267.2 8309.8 10129.8 10795.2 10964.0 11033.6 11063.9 04:47:31 INFO - PROCESS | 1647 | 04:47:31 INFO - PROCESS | 1647 | [#3] mootools.html Cycles:180 Average:5663.93 Median:4840.60 stddev:3224.57 (66.6%) stddev-sans-first:3218.00 04:47:31 INFO - PROCESS | 1647 | Values: 1440.1 1490.1 1631.6 1787.2 1831.2 8353.6 8929.2 8936.5 8941.0 8948.5 7732.1 7967.1 7967.3 8502.6 8660.1 2117.3 2327.1 2343.7 2370.6 2375.9 2332.4 2346.0 2375.7 2376.2 2376.3 2351.9 2364.3 2368.6 2378.3 2384.2 2321.8 2343.5 2348.3 2352.6 2357.9 2007.5 2350.3 2351.7 2352.0 2352.4 8826.8 8829.5 8925.0 8927.5 8942.0 5128.7 5297.4 5304.0 5308.5 5315.8 3404.2 3473.0 3634.6 3649.1 3659.7 1067.3 1090.4 1090.6 1115.9 1119.1 11535.6 11646.9 11655.6 11661.4 11679.9 4488.7 4669.6 4766.3 4777.3 4799.7 9723.9 9731.4 9737.4 9759.2 9797.0 5313.4 5315.2 5317.5 5317.8 5320.1 4347.0 4415.5 4500.0 4806.7 4879.1 3870.2 3896.7 3974.7 4005.6 4007.7 1287.5 1291.2 1294.0 1308.3 1308.4 781.2 818.4 861.5 870.4 896.6 5491.3 5561.6 5570.7 5624.4 5659.2 432.9 435.4 437.8 440.2 441.7 3264.3 3830.8 3835.7 3858.4 4022.7 8514.0 10850.4 10930.5 10930.5 10941.5 10895.5 10906.0 10907.1 10922.0 10932.9 8026.7 8132.9 8169.6 8331.8 8333.3 5535.9 5754.8 5822.1 5829.2 5853.9 9955.2 9957.2 10162.9 10183.8 10291.7 10292.6 10322.2 10346.3 10398.4 10472.3 7267.9 7342.9 7411.3 7438.1 7485.6 8113.6 8197.8 8199.3 8204.5 8231.2 7284.3 7399.1 7458.5 7567.4 7623.7 7218.4 7313.8 7369.3 7456.6 7539.0 6320.7 6752.5 6907.3 6913.8 6913.8 4879.4 4932.2 4955.1 4968.0 5062.8 4874.5 4949.5 4974.5 5065.7 5116.3 04:47:31 INFO - PROCESS | 1647 | 04:47:31 INFO - PROCESS | 1647 | [#4] prototype.html Cycles:180 Average:4397.72 Median:4782.23 stddev:1338.96 (28.0%) stddev-sans-first:1306.82 04:47:31 INFO - PROCESS | 1647 | Values: 294.7 302.9 314.6 315.2 318.2 4733.7 4889.2 5236.8 5397.2 5525.6 5211.3 5223.4 5439.5 5461.7 5486.7 4174.9 4178.2 4184.4 4197.6 4209.4 3785.8 3914.7 4190.0 4199.6 4208.6 4131.8 4134.5 4163.7 4165.7 4178.3 3495.0 3848.7 3866.9 4152.9 4156.8 3485.9 3647.7 3652.2 3656.9 3658.3 5309.8 5335.7 5352.3 5364.0 5385.8 4245.6 4792.5 4832.4 4843.8 4848.5 5352.6 5394.5 5557.0 5756.7 5792.6 3326.4 3904.8 3916.8 3933.9 3949.9 5494.6 5689.0 5758.2 5873.3 6248.4 3621.2 3709.0 3764.2 3936.9 3959.5 3431.8 3954.7 3975.6 3986.5 3990.0 4003.9 4674.9 4683.4 4693.6 4709.2 5099.3 5679.5 5751.8 5796.9 5819.3 1328.3 1362.8 1363.4 1376.9 1378.8 793.9 825.2 832.9 835.2 841.6 4239.8 4244.6 4320.4 4605.8 4684.3 4922.5 5023.7 5038.4 5043.4 5059.6 4046.3 4196.9 4332.5 4644.6 4700.2 2428.2 2434.3 2544.7 2650.5 2657.6 5191.9 5216.5 5242.9 5277.9 5297.4 4324.0 4742.8 4797.9 4813.0 4959.8 4755.3 4781.8 4993.0 5191.8 5213.8 4261.4 4477.9 4672.9 4728.4 4962.5 3934.9 4729.7 4782.7 4889.6 4902.4 4666.9 4711.2 4933.7 5022.9 5174.7 2980.9 3388.2 3693.2 3709.0 3870.5 5521.3 5911.3 5968.6 5998.0 6021.7 4730.8 4909.9 5580.9 5734.4 5879.5 4990.4 5018.4 5525.6 5554.9 5767.3 5186.6 5415.1 5617.6 5617.9 5669.4 4638.7 4907.7 5755.8 5791.7 5837.9 5531.5 5757.7 5762.0 5812.2 5835.7 04:47:31 INFO - PROCESS | 1647 | 04:47:31 INFO - PROCESS | 1647 | [#5] yui.html Cycles:180 Average:25608.76 Median:3513.98 stddev:42287.38 (1203.4%) stddev-sans-first:42364.58 04:47:31 INFO - PROCESS | 1647 | Values: 679.1 686.1 712.2 763.2 781.4 14840.1 16005.8 16023.4 16059.9 16105.9 14412.0 14563.4 14573.1 14593.9 14599.6 664.0 689.5 694.4 838.0 864.2 850.2 851.5 858.7 859.3 859.3 911.5 912.5 916.1 916.4 917.7 703.5 911.3 912.2 912.6 918.4 545.5 546.9 548.5 549.3 660.0 14671.2 15081.8 15105.9 15114.8 15120.9 12553.2 12786.7 13952.2 13988.7 14052.8 11025.6 11457.7 11575.0 12486.5 12637.6 4556.6 4584.7 4611.4 4752.1 4762.8 70261.1 70941.9 110109.4 115615.0 119681.4 10183.3 10399.5 10806.0 10963.9 10969.6 20537.0 20582.9 20593.9 20615.0 20633.0 7301.5 7621.6 7800.6 7855.7 7891.9 4239.8 4243.2 4380.7 4384.8 4494.2 3377.7 3509.2 3513.9 3514.1 3515.9 622.3 643.1 644.8 650.9 662.2 516.7 562.5 569.6 615.3 640.7 8881.4 8963.1 9000.0 9058.5 9153.7 612.1 625.6 629.1 630.4 631.6 4317.8 4438.8 4448.8 4451.9 4545.8 90808.0 127387.4 161145.0 169956.2 178132.0 151455.0 154913.2 155856.0 156260.4 158579.2 106475.0 126205.0 127428.4 130256.3 130772.0 9210.0 9690.4 9793.5 9956.9 10038.9 57305.0 65330.7 66510.7 67816.6 68950.0 82266.1 88667.2 95167.5 95794.0 97665.0 12735.9 12981.0 13234.2 13802.8 14151.9 12739.9 14051.8 14541.7 14550.3 15743.8 12247.3 12489.4 12718.7 12931.2 13666.9 13337.7 13382.6 13690.3 13931.2 13940.0 12998.0 13476.4 13692.7 13774.8 13780.2 10766.7 11117.5 11360.3 11574.3 11894.0 11091.3 11404.8 11597.4 11606.1 11638.5 04:47:31 INFO - PROCESS | 1647 | -------- Summary: end -------- 04:47:31 INFO - PROCESS | 1647 | 04:47:32 INFO - TEST-INFO | 1647: exit 0 04:47:32 INFO - TEST-OK | dromaeo_css | took 1116317ms 04:47:32 INFO - TEST-START | kraken 04:47:32 INFO - operating with platform_type : mac_ 04:47:32 INFO - Initialising browser for kraken test... 04:47:32 INFO - TEST-INFO | started process 1657 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/tmpssamY3/profile http://localhost:49268/getInfo.html) 04:47:34 INFO - PROCESS | 1657 | __metrics Screen width/height:1600/1200 04:47:34 INFO - PROCESS | 1657 | colorDepth:24 04:47:34 INFO - PROCESS | 1657 | Browser inner width/height: 1024/689 04:47:34 INFO - PROCESS | 1657 | __metrics 04:47:34 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" 04:47:34 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] 04:47:35 INFO - TEST-INFO | 1657: exit 0 04:47:35 INFO - Browser initialized. 04:47:35 INFO - Running cycle 1/1 for kraken test... 04:47:35 INFO - TEST-INFO | started process 1658 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/tmpssamY3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:47:47 INFO - PROCESS | 1658 | RSS: Main: 218931200 04:47:47 INFO - PROCESS | 1658 | 04:47:50 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49268/tests/kraken/driver.html?testName=audio-beat-detection) 04:47:51 INFO - PROCESS | 1658 | RSS: Main: 269230080 04:47:51 INFO - PROCESS | 1658 | 04:47:53 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49268/tests/kraken/driver.html?testName=audio-dft) 04:47:54 INFO - PROCESS | 1658 | RSS: Main: 280698880 04:47:54 INFO - PROCESS | 1658 | 04:47:57 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49268/tests/kraken/driver.html?testName=audio-fft) 04:47:57 INFO - PROCESS | 1658 | RSS: Main: 376147968 04:47:57 INFO - PROCESS | 1658 | 04:48:00 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49268/tests/kraken/driver.html?testName=audio-oscillator) 04:48:00 INFO - PROCESS | 1658 | RSS: Main: 280047616 04:48:00 INFO - PROCESS | 1658 | 04:48:02 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49268/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:48:03 INFO - PROCESS | 1658 | RSS: Main: 280891392 04:48:03 INFO - PROCESS | 1658 | 04:48:05 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49268/tests/kraken/driver.html?testName=imaging-darkroom) 04:48:06 INFO - PROCESS | 1658 | RSS: Main: 318533632 04:48:06 INFO - PROCESS | 1658 | 04:48:09 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49268/tests/kraken/driver.html?testName=imaging-desaturate) 04:48:10 INFO - PROCESS | 1658 | RSS: Main: 318603264 04:48:10 INFO - PROCESS | 1658 | 04:48:12 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49268/tests/kraken/driver.html?testName=json-parse-financial) 04:48:13 INFO - PROCESS | 1658 | RSS: Main: 318750720 04:48:13 INFO - PROCESS | 1658 | 04:48:14 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49268/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:48:15 INFO - PROCESS | 1658 | RSS: Main: 289656832 04:48:15 INFO - PROCESS | 1658 | 04:48:17 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:48:18 INFO - PROCESS | 1658 | RSS: Main: 293793792 04:48:18 INFO - PROCESS | 1658 | 04:48:20 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:48:20 INFO - PROCESS | 1658 | RSS: Main: 299458560 04:48:20 INFO - PROCESS | 1658 | 04:48:23 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:48:24 INFO - PROCESS | 1658 | RSS: Main: 314675200 04:48:24 INFO - PROCESS | 1658 | 04:48:27 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:48:27 INFO - PROCESS | 1658 | RSS: Main: 308465664 04:48:27 INFO - PROCESS | 1658 | 04:48:29 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49268/tests/kraken/driver.html?testName=ai-astar) 04:48:29 INFO - PROCESS | 1658 | RSS: Main: 352587776 04:48:29 INFO - PROCESS | 1658 | 04:48:29 INFO - PROCESS | 1658 | __start_tp_report 04:48:29 INFO - PROCESS | 1658 | _x_x_mozilla_page_load 04:48:29 INFO - PROCESS | 1658 | _x_x_mozilla_page_load_details 04:48:29 INFO - PROCESS | 1658 | |i|pagename|runs| 04:48:29 INFO - PROCESS | 1658 | |0;ai-astar;114;113;112;112;113;113;112;113;112;113 04:48:29 INFO - PROCESS | 1658 | |1;audio-beat-detection;146;111;115;169;107;108;105;109;139;107 04:48:29 INFO - PROCESS | 1658 | |2;audio-dft;182;183;185;184;184;183;183;181;183;182 04:48:29 INFO - PROCESS | 1658 | |3;audio-fft;83;59;58;89;60;58;74;80;106;67 04:48:29 INFO - PROCESS | 1658 | |4;audio-oscillator;85;69;96;69;68;68;93;69;69;91 04:48:29 INFO - PROCESS | 1658 | |5;imaging-gaussian-blur;86;84;86;84;87;84;87;84;87;85 04:48:29 INFO - PROCESS | 1658 | |6;imaging-darkroom;93;92;92;92;92;92;101;145;135;92 04:48:29 INFO - PROCESS | 1658 | |7;imaging-desaturate;86;84;87;86;87;84;84;86;86;86 04:48:29 INFO - PROCESS | 1658 | |8;json-parse-financial;58;54;53;54;56;57;58;57;57;58 04:48:29 INFO - PROCESS | 1658 | |9;json-stringify-tinderbox;65;72;68;79;71;69;69;70;70;71 04:48:29 INFO - PROCESS | 1658 | |10;stanford-crypto-aes;83;83;80;87;85;74;98;97;101;100 04:48:29 INFO - PROCESS | 1658 | |11;stanford-crypto-ccm;145;144;152;135;135;144;152;147;164;137 04:48:29 INFO - PROCESS | 1658 | |12;stanford-crypto-pbkdf2;164;191;168;161;162;162;162;162;161;162 04:48:29 INFO - PROCESS | 1658 | |13;stanford-crypto-sha256-iterative;67;66;66;67;65;65;68;64;66;68 04:48:29 INFO - PROCESS | 1658 | __end_tp_report 04:48:29 INFO - PROCESS | 1658 | __start_cc_report 04:48:29 INFO - PROCESS | 1658 | _x_x_mozilla_cycle_collect,1955 04:48:29 INFO - PROCESS | 1658 | __end_cc_report 04:48:29 INFO - PROCESS | 1658 | __startTimestamp1476359309916__endTimestamp 04:48:29 INFO - PROCESS | 1658 | 04:48:29 INFO - PROCESS | 1658 | ------- Summary: start ------- 04:48:29 INFO - PROCESS | 1658 | Number of tests: 14 04:48:29 INFO - PROCESS | 1658 | 04:48:29 INFO - PROCESS | 1658 | [#0] ai-astar Cycles:10 Average:112.70 Median:113.00 stddev:0.67 (0.6%) stddev-sans-first:0.53 04:48:29 INFO - PROCESS | 1658 | Values: 114.0 113.0 112.0 112.0 113.0 113.0 112.0 113.0 112.0 113.0 04:48:29 INFO - PROCESS | 1658 | 04:48:29 INFO - PROCESS | 1658 | [#1] audio-beat-detection Cycles:10 Average:121.60 Median:113.00 stddev:21.98 (19.4%) stddev-sans-first:21.46 04:48:29 INFO - PROCESS | 1658 | Values: 146.0 111.0 115.0 169.0 107.0 108.0 105.0 109.0 139.0 107.0 04:48:29 INFO - PROCESS | 1658 | 04:48:29 INFO - PROCESS | 1658 | [#2] audio-dft Cycles:10 Average:183.00 Median:183.00 stddev:1.15 (0.6%) stddev-sans-first:1.17 04:48:29 INFO - PROCESS | 1658 | Values: 182.0 183.0 185.0 184.0 184.0 183.0 183.0 181.0 183.0 182.0 04:48:29 INFO - PROCESS | 1658 | 04:48:29 INFO - PROCESS | 1658 | [#3] audio-fft Cycles:10 Average:73.40 Median:70.50 stddev:16.14 (22.9%) stddev-sans-first:16.74 04:48:29 INFO - PROCESS | 1658 | Values: 83.0 59.0 58.0 89.0 60.0 58.0 74.0 80.0 106.0 67.0 04:48:29 INFO - PROCESS | 1658 | 04:48:29 INFO - PROCESS | 1658 | [#4] audio-oscillator Cycles:10 Average:77.70 Median:77.00 stddev:11.97 (15.5%) stddev-sans-first:12.40 04:48:29 INFO - PROCESS | 1658 | Values: 85.0 69.0 96.0 69.0 68.0 68.0 93.0 69.0 69.0 91.0 04:48:29 INFO - PROCESS | 1658 | 04:48:29 INFO - PROCESS | 1658 | [#5] imaging-gaussian-blur Cycles:10 Average:85.40 Median:86.00 stddev:1.35 (1.6%) stddev-sans-first:1.41 04:48:29 INFO - PROCESS | 1658 | Values: 86.0 84.0 86.0 84.0 87.0 84.0 87.0 84.0 87.0 85.0 04:48:29 INFO - PROCESS | 1658 | 04:48:29 INFO - PROCESS | 1658 | [#6] imaging-darkroom Cycles:10 Average:102.60 Median:92.00 stddev:20.05 (21.8%) stddev-sans-first:20.96 04:48:29 INFO - PROCESS | 1658 | Values: 93.0 92.0 92.0 92.0 92.0 92.0 101.0 145.0 135.0 92.0 04:48:29 INFO - PROCESS | 1658 | 04:48:29 INFO - PROCESS | 1658 | [#7] imaging-desaturate Cycles:10 Average:85.60 Median:86.00 stddev:1.17 (1.4%) stddev-sans-first:1.24 04:48:29 INFO - PROCESS | 1658 | Values: 86.0 84.0 87.0 86.0 87.0 84.0 84.0 86.0 86.0 86.0 04:48:29 INFO - PROCESS | 1658 | 04:48:29 INFO - PROCESS | 1658 | [#8] json-parse-financial Cycles:10 Average:56.20 Median:57.00 stddev:1.87 (3.3%) stddev-sans-first:1.87 04:48:29 INFO - PROCESS | 1658 | Values: 58.0 54.0 53.0 54.0 56.0 57.0 58.0 57.0 57.0 58.0 04:48:29 INFO - PROCESS | 1658 | 04:48:29 INFO - PROCESS | 1658 | [#9] json-stringify-tinderbox Cycles:10 Average:70.40 Median:70.50 stddev:3.60 (5.1%) stddev-sans-first:3.24 04:48:29 INFO - PROCESS | 1658 | Values: 65.0 72.0 68.0 79.0 71.0 69.0 69.0 70.0 70.0 71.0 04:48:29 INFO - PROCESS | 1658 | 04:48:29 INFO - PROCESS | 1658 | [#10] stanford-crypto-aes Cycles:10 Average:88.80 Median:84.00 stddev:9.47 (11.3%) stddev-sans-first:9.81 04:48:29 INFO - PROCESS | 1658 | Values: 83.0 83.0 80.0 87.0 85.0 74.0 98.0 97.0 101.0 100.0 04:48:29 INFO - PROCESS | 1658 | 04:48:29 INFO - PROCESS | 1658 | [#11] stanford-crypto-ccm Cycles:10 Average:145.50 Median:146.00 stddev:8.98 (6.2%) stddev-sans-first:9.53 04:48:29 INFO - PROCESS | 1658 | Values: 145.0 144.0 152.0 135.0 135.0 144.0 152.0 147.0 164.0 137.0 04:48:29 INFO - PROCESS | 1658 | 04:48:29 INFO - PROCESS | 1658 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.50 Median:162.00 stddev:9.19 (5.7%) stddev-sans-first:9.73 04:48:29 INFO - PROCESS | 1658 | Values: 164.0 191.0 168.0 161.0 162.0 162.0 162.0 162.0 161.0 162.0 04:48:29 INFO - PROCESS | 1658 | 04:48:29 INFO - PROCESS | 1658 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.20 Median:66.50 stddev:1.32 (2.0%) stddev-sans-first:1.36 04:48:29 INFO - PROCESS | 1658 | Values: 67.0 66.0 66.0 67.0 65.0 65.0 68.0 64.0 66.0 68.0 04:48:29 INFO - PROCESS | 1658 | -------- Summary: end -------- 04:48:29 INFO - PROCESS | 1658 | 04:48:30 INFO - TEST-INFO | 1658: exit 0 04:48:30 INFO - TEST-OK | kraken | took 58550ms 04:48:30 INFO - SUITE-END | took 1174s 04:48:31 INFO - Completed test suite (00:19:35) 04:48:31 INFO - javascript benchmark 04:48:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3106.4563701352263, 3299.208190034392, 3314.5028245763147, 3331.2837739885917, 3366.7811592246503, 5624.465675760801, 5643.492085712285, 5679.659220446766, 5727.42725727427, 5731.369549349573, 5652.547796176306, 5730.05454100074, 5735.283089613798, 5735.426457354273, 5741.052726300166, 5158.277841102249, 5190.299309593213, 5192.92210616842, 5193.065248255312, 5229.372475302969, 4375.234333991555, 5126.307948426952, 5151.665141765792, 5273.0, 5319.867003324909, 5186.844394668147, 5191.688498690071, 5259.579233661317, 5262.657927234736, 5268.367795864501, 5172.456892026321, 5184.429712731597, 5190.636655434121, 5208.5312321891215, 5264.210368444726, 5106.872328191825, 5218.269442278084, 5227.137522308853, 5271.0, 5295.443978382253, 5483.0, 5522.475364840374, 5528.55771538276, 5633.887322253573, 5703.116017017369, 5306.946930530684, 6056.454919057262, 6136.509079273692, 6189.597676151081, 6233.877901977642, 6250.624962502219, 6309.589876658002, 6310.8106756796915, 6316.242050953915, 6320.905186422161, 5600.747966341524, 5647.858803529863, 5776.595638305363, 5787.623804452697, 5806.477417032487, 6209.9379006210265, 6257.843553911098, 6257.8748425031245, 6280.214973128359, 6304.338044505353, 5987.221661184019, 6057.091436284504, 6058.818235452944, 6066.545009124334, 6067.7269522871575, 4648.465426475998, 6074.726637301332, 6191.876162476815, 6217.9689101555105, 6222.315545290015, 5156.664816786897, 5929.673867937218, 6048.546359023003, 6063.575549711566, 6079.118527813443, 5294.41761406245, 6081.179040829431, 6118.908216376758, 6143.938560614426, 6235.532335074888, 4932.235503496964, 4933.827316043921, 4934.210526315772, 4941.234108713155, 4946.950530494721, 4308.052228509723, 4360.847370342086, 4392.604665580113, 4443.200223959654, 4452.354408610733, 5684.204211410406, 5691.203231547586, 5756.856078597984, 5759.280089988752, 5777.884442311214, 5391.0, 6203.720832562545, 6360.52296077796, 6360.7137678804565, 6372.171617689671, 5755.740991655385, 5805.564582656318, 5809.215755872988, 5818.4472475115645, 5829.708514574254, 5208.947910520847, 5328.786848526015, 5332.733363331818, 5376.435474275223, 5410.323709536308, 6218.347073557211, 6250.6874656267, 6307.05394190875, 6342.0, 6368.9044664330995, 6304.243490780952, 6306.842328941813, 6323.462505687068, 6331.113644089924, 6339.4928405726505, 6159.952808022557, 6306.054091886253, 6327.430531252209, 6347.333529979471, 6356.4279214870885, 6044.365341639064, 6051.273847138195, 6132.816015519542, 6134.509239260759, 6142.222533141996, 6165.753369865155, 6290.49676025926, 6295.622262664255, 6298.149749783904, 6300.779472718433, 6009.969950150221, 6035.094735789491, 6043.45608895184, 6074.119252708421, 6098.5426093042315, 5798.478136967693, 5801.680907550125, 5831.241938547962, 5988.760449581968, 5991.970040149771, 4782.258749893772, 5708.885822283614, 5722.113072473773, 5738.971305143447, 5742.655440673573, 5860.150278209721, 5866.2960444746905, 5869.559783016376, 5875.853103672443, 5895.20414744004, 5704.657720536781, 5709.54323654115, 5733.0, 5833.387494313036, 5841.912371314349], "value": 5623.720495339729, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [482.08404032338564, 514.5729044892738, 523.2177894048396, 523.5079025715827, 552.0284299632646, 29917.55123673144, 30291.0, 32249.83875080621, 32343.191420214476, 40070.59929400705, 39614.40578391319, 40865.0, 42118.0, 42288.36567451483, 42318.0, 9747.220222382228, 9915.603375864957, 9942.304038717293, 9945.502724863763, 9954.552045157949, 8786.64853405863, 8959.01450840407, 9736.561854716554, 9852.0, 11845.111616628787, 11904.940475297655, 12139.878601214008, 12142.39288035599, 12161.452734626962, 12166.939165304206, 12154.93922530386, 12231.449584768707, 12232.755344893141, 12235.143539952207, 12267.957223635956, 8743.256823170039, 8921.955390223073, 8926.2412694921, 9047.18575328217, 12009.579664711693, 31899.52150717741, 39083.609163908564, 39412.40881386781, 39418.802905985285, 41785.791071044754, 3241.286916878283, 3271.247613048988, 3621.6740493355724, 3861.903452413684, 3873.1091848874917, 29348.559771603228, 30342.393152136832, 31027.0, 31834.522482162785, 31902.20244493883, 3134.9216269593217, 3192.425363434581, 3212.245122396235, 3230.2570408806105, 3251.203455153479, 493633.0, 494275.0, 494956.0, 494967.9999999964, 496298.0, 53418.73290633522, 54831.177532337046, 61400.38599614036, 63125.368746312866, 63252.36747632557, 62996.0, 63025.05462418067, 65138.67430662911, 65794.0, 65939.67030164819, 14513.564593062225, 16761.916190419215, 16852.91573542149, 16874.74687879683, 16898.070606116537, 12960.67598310031, 13018.544350947672, 13058.54295099686, 13099.95200383986, 13217.33913304331, 16019.599510012109, 16529.09915359725, 16545.0, 18249.270029198684, 18998.71501927472, 7348.77953661391, 7472.70109195637, 7489.85020299591, 7510.474266801271, 7519.43604229674, 841.4362377207163, 930.5951910918772, 984.9162821160138, 1007.9395236285847, 1022.1362948308667, 29115.56326655102, 29834.0, 30320.090397288117, 30687.846560767055, 30866.537001944987, 1042.9739256518496, 1114.8272017837087, 1141.8230174322994, 1145.2212495503138, 1192.862820775622, 15198.392064317304, 15213.087214767149, 15550.300236489385, 15606.453774117852, 15964.600884977735, 385407.0, 389460.0, 391039.08960910595, 391140.04429978237, 391218.0, 51244.74377628088, 51905.2214216787, 57696.0, 58797.706011470524, 58844.41155588475, 1333.3333333333333, 1358.483776165051, 1368.1244003837553, 1369.5617402431126, 1371.3828777050367, 27971.881124754782, 27983.0, 30839.845800770854, 31225.123387995794, 31902.042938711875, 51311.486885132166, 51984.74007629938, 52012.479875202276, 52081.21878171754, 52136.739316303174, 602926.0, 605434.0, 606624.0, 607434.0, 609790.0, 27005.189844304703, 27425.45149096967, 27451.31371715723, 27454.588181177696, 27523.449531009668, 47773.0, 48368.0, 48487.03025939391, 48559.0, 48910.26634600555, 38806.0, 39132.217355653294, 39158.0, 39829.00427489336, 40862.9784255396, 38686.0, 39130.0, 39391.0, 39689.80155099206, 41000.0, 35690.821545892104, 38082.428763568016, 38125.428118577685, 38989.415158773205, 39001.6099838998, 32803.34393312168, 34251.657483424846, 35144.121396964256, 35151.82424087863, 35378.64621353753, 25847.0, 25849.741502585486, 25900.348039972137, 26123.869380652974, 26556.601650974866], "value": 20003.48189637207, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [318.43636762929617, 356.4848793493403, 370.17635760433024, 381.1272186692473, 406.729524865964, 14871.628209294773, 15030.849691503081, 15963.999999999985, 18409.07954602268, 18834.681572289945, 19996.0, 20292.18831246752, 20995.0, 21077.683834742493, 21351.0, 5968.432998865101, 6245.156903817971, 6252.437280644741, 6253.343398943114, 6255.218097737783, 5249.973750131263, 6850.554713943603, 6947.374736273734, 6987.825304367406, 7051.823704407379, 6676.933230667704, 6845.8973115403305, 6885.758998435056, 6951.721931122749, 6971.0, 6397.264314603834, 6650.86698266032, 6834.487413443987, 6916.619585922797, 6933.72265109395, 5789.421057894219, 5917.437843404869, 5926.1110833374905, 5926.199963004982, 5931.555133364972, 23993.640095398583, 25365.73171341444, 25410.729463526935, 25552.233432996854, 25733.228003159747, 2161.8919054047233, 2440.487497625501, 2750.876210570529, 2966.209571541966, 3028.4700177469076, 9733.513324333755, 9809.558569864374, 9828.606855725762, 10189.59241630334, 10265.230107741874, 1816.1645643004233, 1881.5014021284371, 1887.6224755049045, 1946.6885298352195, 2034.2371610646007, 96698.0, 119117.13243013617, 126916.65416729219, 127485.36257318746, 130398.0, 11087.445627718582, 11345.602903898489, 11461.681906580683, 11557.768844623228, 11670.241434306743, 14819.259037048105, 14831.11013339203, 14852.183129927958, 14865.628359290888, 14902.403903843724, 7350.4119670426235, 8460.196281353261, 8599.52702601363, 8625.396222264506, 8713.520756358334, 8547.059823419419, 8556.315494760403, 8558.871616925751, 8727.738167854848, 8736.0, 4489.977550112294, 4556.120165086809, 4570.428696412949, 4570.7943142558, 4619.930701039487, 1629.7473891546829, 1710.9572260693333, 1790.2480957997673, 1909.5417099895924, 1912.6270377276298, 833.3333333333309, 866.8786369908217, 911.6034524981521, 958.6932181701928, 963.5663951221978, 20716.689249661267, 21776.23783167613, 21916.561668766535, 21919.0, 21955.90220488969, 941.223490620241, 945.7210123013728, 947.507296205969, 983.1053741095569, 1030.9175265978854, 10666.78666426667, 11212.327260364404, 11336.829947550794, 11368.204225704287, 11448.542058317575, 602066.0, 604012.0, 608812.0, 614530.0, 614595.927020362, 88497.67253491202, 123844.0, 127335.0, 128920.0, 134715.0, 893.8614514750224, 913.4930113786779, 945.3099237556622, 947.4362754161263, 948.3598570964572, 15912.840871591136, 18850.52873678169, 19289.0, 19333.226670933003, 19504.90247548753, 53766.655833604476, 55873.0, 56371.0, 56571.71714141403, 57532.71233643805, 79675.60162199152, 80890.59554702189, 81869.0, 83161.58419207865, 84224.0, 7567.31894129531, 7757.961210194138, 7925.365970722443, 8007.759767206993, 8143.6742530298125, 8905.109489051043, 9642.951785241028, 11211.943940280247, 12586.18189817659, 13322.933385333012, 11203.663890083311, 11306.604268850551, 11307.497969414158, 11355.716107097389, 11470.025047870691, 11184.776304474028, 11468.713282168013, 11490.253133546294, 11655.941720291345, 11707.941460292985, 5846.298444186725, 6767.966160169168, 9494.857577136487, 11388.540505968604, 11878.406079696153, 8116.2695357418115, 8183.6726530938095, 8257.339412847077, 8267.173282671685, 8309.792255193426, 10129.848052279369, 10795.19036072282, 10964.013238808546, 11033.613823516138, 11063.889361106287], "value": 9623.494141777343, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1440.1287221231157, 1490.0612614053146, 1631.6084139806442, 1787.1689664306111, 1831.2308830291277, 8353.582320883954, 8929.1517305856, 8936.508492032935, 8940.999999999993, 8948.507832069234, 7732.072151341833, 7967.083785364684, 7967.322777563914, 8502.617382217799, 8660.133986601337, 2117.258959364218, 2327.138958585326, 2343.742188359279, 2370.6207006878903, 2375.8574485530835, 2332.4402143485527, 2345.9648105278347, 2375.714914210297, 2376.1564644551195, 2376.2514807835564, 2351.8588884666888, 2364.3025307534317, 2368.6210206366986, 2378.250850981935, 2384.2012925669833, 2321.8258630602604, 2343.5195784864145, 2348.330725743172, 2352.5530149271754, 2357.8938947747392, 2007.5181956330375, 2350.25966820451, 2351.6825228594093, 2352.0003998300654, 2352.3766201956496, 8826.779330516723, 8829.470231786114, 8925.0, 8927.508987005713, 8942.0, 5128.666636668605, 5297.4437684043005, 5303.973480132613, 5308.495692909168, 5315.760790764425, 3404.1829960809227, 3472.9652703472893, 3634.6001939786865, 3649.1242101895355, 3659.743817932746, 1067.2529229539352, 1090.4275255490852, 1090.574675876409, 1115.9218854680175, 1119.121489630636, 11535.596254131066, 11646.883531164665, 11655.592054278144, 11661.416929153509, 11679.948804607626, 4488.708233964782, 4669.556392142741, 4766.261229509431, 4777.259524773665, 4799.688020278671, 9723.854142187873, 9731.41611503312, 9737.367071140354, 9759.219262458986, 9797.0, 5313.362396512443, 5315.202719592092, 5317.521423071942, 5317.813876514381, 5320.095583750772, 4346.978265108654, 4415.470143582726, 4499.955000450019, 4806.735629540409, 4879.097366987119, 3870.2259548090497, 3896.668783153407, 3974.668486057203, 4005.579414161471, 4007.73949693269, 1287.5171810571037, 1291.2252648411065, 1294.0359432223054, 1308.2739079810606, 1308.4373719300793, 781.2109769133103, 818.4475479051616, 861.5390765940192, 870.3559366069063, 896.551724137931, 5491.258680078138, 5561.610687251934, 5570.749316280777, 5624.353199382042, 5659.207710920475, 432.89610493481337, 435.3926272849357, 437.7723583736439, 440.2471773267684, 441.66212847171937, 3264.347130573895, 3830.7893065881085, 3835.6931445484292, 3858.3633700439113, 4022.738521996061, 8514.0, 10850.403227822546, 10930.453477326102, 10930.508127134299, 10941.4529273536, 10895.455227238606, 10906.0, 10907.127429805596, 10921.962413570698, 10932.890671093346, 8026.719064832703, 8132.878006829902, 8169.63236654352, 8331.750047498463, 8333.33333333332, 5535.916961245504, 5754.769809207585, 5822.097574875901, 5829.242198514166, 5853.9121913172185, 9955.20358371343, 9957.153641940517, 10162.949185254027, 10183.847242291224, 10291.7427064321, 10292.581243407643, 10322.174226062047, 10346.32748871321, 10398.428086455015, 10472.319299245524, 7267.927320726936, 7342.889856652261, 7411.258874112761, 7438.107427108782, 7485.588292643739, 8113.634886430007, 8197.75406737775, 8199.344052475668, 8204.466709663853, 8231.218034286732, 7284.344409003215, 7399.112106547249, 7458.5151965122095, 7567.394608431422, 7623.656935437808, 7218.3503484686635, 7313.780586582411, 7369.336759691653, 7456.589887556236, 7539.019927409402, 6320.715567799552, 6752.527323087336, 6907.309269073053, 6913.827154321182, 6913.827154321182, 4879.39007624047, 4932.21084626458, 4955.108080545537, 4967.950320496893, 5062.848114556569, 4874.463808980939, 4949.455559888337, 4974.527419895249, 5065.746712664279, 5116.334876466036], "value": 4463.40423033995, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [294.6802719049832, 302.9242689327668, 314.6255955413059, 315.24184336670316, 318.1917928461706, 4733.668643194977, 4889.2421674640445, 5236.836714811724, 5397.190421436787, 5525.585581081415, 5211.348581427322, 5223.425423203445, 5439.5376393006545, 5461.726913654321, 5486.670799752018, 4174.914522224213, 4178.247915375231, 4184.372344148372, 4197.586387827012, 4209.389638502415, 3785.7663978252826, 3914.6868250540033, 4189.9790501047455, 4199.55904630014, 4208.642265407444, 4131.814068366915, 4134.470246008981, 4163.68772342074, 4165.687573431989, 4178.268802959486, 3495.02922515862, 3848.749831260959, 3866.903327416809, 4152.896177595554, 4156.771377574232, 3485.89542313731, 3647.708183345326, 3652.1782598915297, 3656.8537258509627, 3658.32321020612, 5309.814156504543, 5335.653182543161, 5352.304200453955, 5363.973180134074, 5385.838424847261, 4245.554216807222, 4792.544708252711, 4832.395950506187, 4843.754684361486, 4848.490908454597, 5352.625316227865, 5394.514493695547, 5556.972215138939, 5756.683382413966, 5792.594518383715, 3326.4365748098353, 3904.7852368119743, 3916.8237429315463, 3933.9016524586827, 3949.8617548385955, 5494.587905907073, 5688.971555142198, 5758.176560775494, 5873.324567674729, 6248.437640612321, 3621.1852333224815, 3708.978606659377, 3764.1906989997283, 3936.8622098226997, 3959.544652364957, 3431.8455669494933, 3954.7429417088374, 3975.6421922027157, 3986.5216174059296, 3989.960100399017, 4003.899902502461, 4674.859754207379, 4683.414573178353, 4693.5775780179265, 4709.175894218498, 5099.3370861787735, 5679.488846003796, 5751.827445176651, 5796.884062318814, 5819.301683797971, 1328.2760895312078, 1362.7751421015619, 1363.4137320951888, 1376.876081152681, 1378.7931810228547, 793.8848866914265, 825.2284114353099, 832.875617915821, 835.2148979958819, 841.6465084664455, 4239.788010599519, 4244.554321796229, 4320.395144679747, 4605.812239186426, 4684.320773487893, 4922.483139270396, 5023.748812559357, 5038.370203724535, 5043.394792624908, 5059.5952323814745, 4046.309204379114, 4196.853110141192, 4332.458442694663, 4644.605208557243, 4700.2057900940845, 2428.162284012013, 2434.2857713649155, 2544.7200807911113, 2650.5494066008823, 2657.641218435525, 5191.870203244949, 5216.478352164753, 5242.9213561796605, 5277.947220527745, 5297.443768404339, 4323.951614112044, 4742.842006886858, 4797.880052998703, 4812.967830266979, 4959.752012399365, 4755.310479980383, 4781.784819683053, 4992.950070499322, 5191.766370513336, 5213.765380557884, 4261.403403523571, 4477.865664030084, 4672.859814205579, 4728.40894888139, 4962.478939711278, 3934.9409758854213, 4729.716217026989, 4782.6847616905625, 4889.608831293559, 4902.362692849907, 4666.906661866811, 4711.199096153594, 4933.703977761345, 5022.899542009212, 5174.741262936914, 2980.925476863096, 3388.203772113502, 3693.2059607184583, 3708.9629103708617, 3870.477485539416, 5521.309836270466, 5911.290645122613, 5968.552358573212, 5997.970010150096, 6021.668808215591, 4730.834420795393, 4909.9018019640125, 5580.916286255629, 5734.369219385948, 5879.501211984975, 4990.437131533822, 5018.42288136869, 5525.613207075467, 5554.861128471821, 5767.279090113736, 5186.611004174777, 5415.1029199378145, 5617.606767526398, 5617.915731264116, 5669.4047125051275, 4638.680659670165, 4907.68100073494, 5755.769769209185, 5791.652500849962, 5837.94162058391, 5531.534143452069, 5757.704516483757, 5762.0121058234845, 5812.18629391894, 5835.67903765297], "value": 3972.786363407074, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [679.0968012543316, 686.135469308671, 712.2307907459942, 763.2253262938116, 781.4022272961182, 14840.109593424402, 16005.839941600581, 16023.439179628715, 16059.919700401482, 16105.919470402632, 14412.0, 14563.417463301455, 14573.05275157114, 14593.927030364834, 14599.635009124777, 663.9767608133716, 689.4794430205188, 694.3646563394487, 837.9874301885477, 864.2178828160525, 850.2262940723942, 851.4763420496381, 858.6737039924819, 859.2524503681806, 859.291084854994, 911.4713466189594, 912.4616476278994, 916.1067958740242, 916.3951791817402, 917.7063339731288, 703.4513079797766, 911.3347256502724, 912.1972664055622, 912.6212621761961, 918.4213945214472, 545.4736179586678, 546.8632841789553, 548.4707257496535, 549.343534476301, 659.960402375859, 14671.193084380355, 15081.849181508263, 15105.924470377688, 15114.848851511455, 15120.924395378062, 12553.184043037265, 12786.680332991657, 13952.2326272055, 13988.654068954525, 14052.789208161887, 11025.558977640885, 11457.656270311903, 11574.958253757119, 12486.50053997839, 12637.557685480964, 4556.612687921531, 4584.656150788671, 4611.423572053493, 4752.07334569759, 4762.761861906925, 70261.08172427933, 70941.93587096197, 110109.39343639408, 115615.0, 119681.40159299235, 10183.287169898183, 10399.48002599882, 10806.0, 10963.890361096286, 10969.616063437741, 20537.0, 20582.897085514476, 20593.89703051505, 20615.0, 20632.96835158236, 7301.452391070691, 7621.618919054025, 7800.648970796327, 7855.7250496232355, 7891.921080789233, 4239.766812825324, 4243.215005223981, 4380.737155770664, 4384.8246070157475, 4494.168578812864, 3377.7297816174646, 3509.175343794206, 3513.9121521962156, 3514.0512061743184, 3515.9121021974656, 622.2781573374864, 643.1285608001184, 644.8323435906698, 650.8860949333848, 662.159057996342, 516.7364644031571, 562.530287210184, 569.63827969239, 615.2831950777384, 640.6636515829227, 8881.42270752412, 8963.103689630985, 9000.0, 9058.54707264634, 9153.697762051825, 612.1429998002743, 625.6402568523026, 629.0846817879974, 630.4420587779848, 631.6336524815596, 4317.848875289413, 4438.822447102079, 4448.799804008828, 4451.933221001687, 4545.795439205243, 90808.0, 127387.36306318594, 161145.0, 169956.1502192481, 178132.0, 151455.0, 154913.2254338721, 155856.0, 156260.43739562685, 158579.20710396604, 106475.0, 126205.0, 127428.36285818697, 130256.3487182577, 130772.0, 9210.006747807123, 9690.403866584888, 9793.51032448389, 9956.850647240153, 10038.85623194199, 57305.0, 65330.67334663296, 66510.66978660303, 67816.64366712737, 68950.0, 82266.06403615802, 88667.22665546525, 95167.52416238151, 95794.0, 97665.0, 12735.872641273469, 12980.98794686825, 13234.205947643171, 13802.792958105838, 14151.858481415054, 12739.872601273868, 14051.789223161457, 14541.709165816414, 14550.345234464263, 15743.842561574696, 12247.326397047891, 12489.375531223584, 12718.745625087631, 12931.159474634118, 13666.93166534161, 13337.733245335234, 13382.59237314723, 13690.315484225948, 13931.233782142079, 13940.0, 12998.0, 13476.393562289917, 13692.65768355799, 13774.793378099135, 13780.242086684928, 10766.730831728955, 11117.499712513118, 11360.318380897173, 11574.305541667527, 11894.0, 11091.334519928507, 11404.828927565926, 11597.420128993348, 11606.071514278668, 11638.476268567765], "value": 7788.788342619365, "unit": "score"}], "name": "dromaeo_css", "value": 7285.460949498036, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 112.0, 112.0, 113.0, 113.0, 112.0, 113.0, 112.0, 113.0], "value": 112.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 111.0, 115.0, 169.0, 107.0, 108.0, 105.0, 109.0, 139.0, 107.0], "value": 121.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 183.0, 185.0, 184.0, 184.0, 183.0, 183.0, 181.0, 183.0, 182.0], "value": 183.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 59.0, 58.0, 89.0, 60.0, 58.0, 74.0, 80.0, 106.0, 67.0], "value": 73.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 69.0, 96.0, 69.0, 68.0, 68.0, 93.0, 69.0, 69.0, 91.0], "value": 77.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 86.0, 84.0, 87.0, 84.0, 87.0, 84.0, 87.0, 85.0], "value": 85.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 92.0, 92.0, 92.0, 92.0, 92.0, 101.0, 145.0, 135.0, 92.0], "value": 102.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 87.0, 86.0, 87.0, 84.0, 84.0, 86.0, 86.0, 86.0], "value": 85.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 54.0, 53.0, 54.0, 56.0, 57.0, 58.0, 57.0, 57.0, 58.0], "value": 56.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 72.0, 68.0, 79.0, 71.0, 69.0, 69.0, 70.0, 70.0, 71.0], "value": 70.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 80.0, 87.0, 85.0, 74.0, 98.0, 97.0, 101.0, 100.0], "value": 88.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 144.0, 152.0, 135.0, 135.0, 144.0, 152.0, 147.0, 164.0, 137.0], "value": 145.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 191.0, 168.0, 161.0, 162.0, 162.0, 162.0, 162.0, 161.0, 162.0], "value": 165.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 66.0, 67.0, 65.0, 65.0, 68.0, 64.0, 66.0, 68.0], "value": 66.2, "unit": "score"}], "name": "kraken", "value": 1434.6000000000001, "alertThreshold": 2.0}]} 04:48:31 INFO - Return code: 0 04:48:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:48:31 INFO - # TBPL SUCCESS # 04:48:31 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:48:31 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:48:31 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:48:31 INFO - 2016-10-13 04:48:31.227 screenresolution[1662:9780] starting screenresolution argv=screenresolution get 04:48:31 INFO - 2016-10-13 04:48:31.230 screenresolution[1662:9780] Display 0: 1600x1200x32@60 04:48:31 INFO - 2016-10-13 04:48:31.236 screenresolution[1663:9783] starting screenresolution argv=screenresolution list 04:48:31 INFO - Available Modes on Display 0 04:48:31 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:48:31 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:48:31 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:48:31 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:48:31 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:48:31 INFO - Intel Iris: 04:48:31 INFO - Chipset Model: Intel Iris 04:48:31 INFO - Type: GPU 04:48:31 INFO - Bus: Built-In 04:48:31 INFO - VRAM (Dynamic, Max): 1536 MB 04:48:31 INFO - Vendor: Intel (0x8086) 04:48:31 INFO - Device ID: 0x0a2e 04:48:31 INFO - Revision ID: 0x0009 04:48:31 INFO - Displays: 04:48:31 INFO - Display: 04:48:31 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:48:31 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:48:31 INFO - Display Serial Number: 1600x1200 60 04:48:31 INFO - Main Display: Yes 04:48:31 INFO - Mirror: Off 04:48:31 INFO - Online: Yes 04:48:31 INFO - Rotation: Supported 04:48:31 INFO - Return code: 0 04:48:31 INFO - Running post-action listener: _resource_record_post_action 04:48:31 INFO - [mozharness: 2016-10-13 11:48:31.472914Z] Finished run-tests step (success) 04:48:31 INFO - Running post-run listener: _resource_record_post_run 04:48:31 INFO - Total resource usage - Wall time: 1208s; CPU: 54.0%; Read bytes: 38441984; Write bytes: 663513600; Read time: 391; Write time: 2189 04:48:31 INFO - TinderboxPrint: CPU usage
54.0% 04:48:31 INFO - TinderboxPrint: I/O read bytes / time
38,441,984 / 391 04:48:31 INFO - TinderboxPrint: I/O write bytes / time
663,513,600 / 2,189 04:48:31 INFO - TinderboxPrint: CPU idle
2,225.2 (46.0%) 04:48:31 INFO - TinderboxPrint: CPU system
972.4 (20.1%) 04:48:31 INFO - TinderboxPrint: CPU user
1,636.2 (33.8%) 04:48:31 INFO - TinderboxPrint: Swap in / out
401,592,320 / 0 04:48:31 INFO - install - Wall time: 33s; CPU: 54.0%; Read bytes: 355174912; Write bytes: 356796416; Read time: 27181; Write time: 843 04:48:31 INFO - run-tests - Wall time: 1176s; CPU: 54.0%; Read bytes: 37479424; Write bytes: 296530432; Read time: 376; Write time: 1318 04:48:31 INFO - Running post-run listener: _upload_blobber_files 04:48:31 INFO - Blob upload gear active. 04:48:31 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:48:31 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 04:48:31 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'] 04:48:31 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 04:48:32 INFO - (blobuploader) - INFO - Open directory for files ... 04:48:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:48:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:48:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:48:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:48:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:48:33 INFO - (blobuploader) - INFO - Done attempting. 04:48:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:48:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:48:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:48:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:48:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:48:34 INFO - (blobuploader) - INFO - Done attempting. 04:48:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:48:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:48:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:48:36 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:48:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:48:36 INFO - (blobuploader) - INFO - Done attempting. 04:48:36 INFO - (blobuploader) - INFO - Iteration through files over. 04:48:36 INFO - Return code: 0 04:48:36 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:48:36 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:48:36 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3006563b3f978cc9e9e67e8b6c93f51e765cf56628baf2b8e3a1a25ea94d54b2fe6d4e893c6bbb0648d8657572cad960a154ea1cb91f2e00e8fde78724ade277", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cc2e96ea058d1a8f19cfe92c495c131c3ea8fddaf4ae0cb5fc06d82b4ae380dc5951f1601e9842dc740fd451d3919cfe07a06ad88460e7820ed0b30dd4e20a8e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/47752a2499e28493caf7829c265d619339e766b955670cb9de26ef2b5e3180a312aeb9aa894b3656bac70a87cc72d716756cd72a983caab4f817e52b02eb318f"} 04:48:36 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:48:36 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:48:36 INFO - Contents: 04:48:36 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3006563b3f978cc9e9e67e8b6c93f51e765cf56628baf2b8e3a1a25ea94d54b2fe6d4e893c6bbb0648d8657572cad960a154ea1cb91f2e00e8fde78724ade277", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cc2e96ea058d1a8f19cfe92c495c131c3ea8fddaf4ae0cb5fc06d82b4ae380dc5951f1601e9842dc740fd451d3919cfe07a06ad88460e7820ed0b30dd4e20a8e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/47752a2499e28493caf7829c265d619339e766b955670cb9de26ef2b5e3180a312aeb9aa894b3656bac70a87cc72d716756cd72a983caab4f817e52b02eb318f"} 04:48:36 INFO - Running post-run listener: copy_logs_to_upload_dir 04:48:36 INFO - Copying logs to upload dir... 04:48:36 INFO - mkdir: /builds/slave/test/build/upload/logs 04:48:36 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1268.274252 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-10-13 04:48:36.746064) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-13 04:48:36.749273) ========= 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.HBi8CMr0dW/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.o6L2gEYnAb/Listeners TMPDIR=/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/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/3006563b3f978cc9e9e67e8b6c93f51e765cf56628baf2b8e3a1a25ea94d54b2fe6d4e893c6bbb0648d8657572cad960a154ea1cb91f2e00e8fde78724ade277", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cc2e96ea058d1a8f19cfe92c495c131c3ea8fddaf4ae0cb5fc06d82b4ae380dc5951f1601e9842dc740fd451d3919cfe07a06ad88460e7820ed0b30dd4e20a8e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/47752a2499e28493caf7829c265d619339e766b955670cb9de26ef2b5e3180a312aeb9aa894b3656bac70a87cc72d716756cd72a983caab4f817e52b02eb318f"} build_url:https://queue.taskcluster.net/v1/task/Kyp2yyZGSjiT03QJcMTLOw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010975 build_url: 'https://queue.taskcluster.net/v1/task/Kyp2yyZGSjiT03QJcMTLOw/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/3006563b3f978cc9e9e67e8b6c93f51e765cf56628baf2b8e3a1a25ea94d54b2fe6d4e893c6bbb0648d8657572cad960a154ea1cb91f2e00e8fde78724ade277", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cc2e96ea058d1a8f19cfe92c495c131c3ea8fddaf4ae0cb5fc06d82b4ae380dc5951f1601e9842dc740fd451d3919cfe07a06ad88460e7820ed0b30dd4e20a8e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/47752a2499e28493caf7829c265d619339e766b955670cb9de26ef2b5e3180a312aeb9aa894b3656bac70a87cc72d716756cd72a983caab4f817e52b02eb318f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-13 04:48:36.781686) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 04:48:36.782032) ========= 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.HBi8CMr0dW/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.o6L2gEYnAb/Listeners TMPDIR=/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/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.005256 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 04:48:36.830451) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-13 04:48:36.830784) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-13 04:48:36.831097) ========= ========= Total master_lag: 0.16 =========