builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0321 starttime: 1475166196.52 results: success (0) buildid: 20160929071320 builduid: 8fae0d82656646d19535a15ba08811dc revision: 0e12aae055677772cabc476634a4100410035375 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-29 09:23:16.518851) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-29 09:23:16.519251) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-29 09:23:16.519544) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-29 09:23:16.542203) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-29 09:23:16.542487) ========= 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.bXAGOxWHz9/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.H1mTMoiL1x/Listeners TMPDIR=/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-09-29 09:23:16-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 140M=0s 2016-09-29 09:23:16 (140 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.126155 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-29 09:23:16.690193) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-29 09:23:16.690522) ========= 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.bXAGOxWHz9/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.H1mTMoiL1x/Listeners TMPDIR=/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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.019700 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-29 09:23:16.739138) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-29 09:23:16.739496) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 0e12aae055677772cabc476634a4100410035375 --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 0e12aae055677772cabc476634a4100410035375 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.bXAGOxWHz9/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.H1mTMoiL1x/Listeners TMPDIR=/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-09-29 09:23:16,816 truncating revision to first 12 chars 2016-09-29 09:23:16,816 Setting DEBUG logging. 2016-09-29 09:23:16,816 attempt 1/10 2016-09-29 09:23:16,817 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/0e12aae05567?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-29 09:23:17,477 unpacking tar archive at: mozilla-aurora-0e12aae05567/testing/mozharness/ program finished with exit code 0 elapsedTime=0.912239 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-29 09:23:17.674191) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-29 09:23:17.674528) ========= script_repo_revision: 0e12aae055677772cabc476634a4100410035375 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-29 09:23:17.674906) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-29 09:23:17.675179) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-29 09:23:17.692988) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-09-29 09:23:17.693326) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.bXAGOxWHz9/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.H1mTMoiL1x/Listeners TMPDIR=/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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 09:23:17 INFO - MultiFileLogger online at 20160929 09:23:17 in /builds/slave/test 09:23:17 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 09:23:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:23:17 INFO - {'append_to_log': False, 09:23:17 INFO - 'base_work_dir': '/builds/slave/test', 09:23:17 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 09:23:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:23:17 INFO - 'branch': 'Mozilla-Aurora', 09:23:17 INFO - 'buildbot_json_path': 'buildprops.json', 09:23:17 INFO - 'config_files': ('talos/mac_config.py',), 09:23:17 INFO - 'default_actions': ('clobber', 09:23:17 INFO - 'read-buildbot-config', 09:23:17 INFO - 'download-and-extract', 09:23:17 INFO - 'populate-webroot', 09:23:17 INFO - 'create-virtualenv', 09:23:17 INFO - 'install', 09:23:17 INFO - 'run-tests'), 09:23:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:23:17 INFO - 'download_minidump_stackwalk': True, 09:23:17 INFO - 'download_symbols': 'ondemand', 09:23:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:23:17 INFO - 'tooltool.py': '/tools/tooltool.py', 09:23:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:23:17 INFO - '/tools/misc-python/virtualenv.py')}, 09:23:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:23:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:23:17 INFO - 'installer_path': 'installer.exe', 09:23:17 INFO - 'log_level': 'info', 09:23:17 INFO - 'log_name': 'talos', 09:23:17 INFO - 'log_to_console': True, 09:23:17 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:23:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:23:17 INFO - 'opt_config_files': (), 09:23:17 INFO - 'pip_index': False, 09:23:17 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:23:17 INFO - 'cmd': ('bash', 09:23:17 INFO - '-c', 09:23:17 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:23:17 INFO - 'enabled': True, 09:23:17 INFO - 'halt_on_failure': False, 09:23:17 INFO - 'name': 'check_screen_resolution'},), 09:23:17 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:23:17 INFO - 'cmd': ('bash', 09:23:17 INFO - '-c', 09:23:17 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:23:17 INFO - 'enabled': True, 09:23:17 INFO - 'halt_on_failure': False, 09:23:17 INFO - 'name': 'check_screen_resolution'},), 09:23:17 INFO - 'run_cmd_checks_enabled': True, 09:23:17 INFO - 'sps_profile': False, 09:23:17 INFO - 'sps_profile_interval': 0, 09:23:17 INFO - 'suite': 'dromaeojs', 09:23:17 INFO - 'system_bits': '32', 09:23:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:23:17 INFO - 'title': 't-yosemite-r7-0321', 09:23:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:23:17 INFO - 'use_talos_json': True, 09:23:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:23:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:23:17 INFO - 'work_dir': 'build'} 09:23:17 INFO - [mozharness: 2016-09-29 16:23:17.886219Z] Running clobber step. 09:23:17 INFO - Running pre-action listener: _resource_record_pre_action 09:23:17 INFO - Running main action method: clobber 09:23:17 INFO - rmtree: /builds/slave/test/build 09:23:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:23:19 INFO - Running post-action listener: _resource_record_post_action 09:23:19 INFO - [mozharness: 2016-09-29 16:23:19.883320Z] Finished clobber step (success) 09:23:19 INFO - [mozharness: 2016-09-29 16:23:19.883445Z] Running read-buildbot-config step. 09:23:19 INFO - Running pre-action listener: _resource_record_pre_action 09:23:19 INFO - Running main action method: read_buildbot_config 09:23:19 INFO - Using buildbot properties: 09:23:19 INFO - { 09:23:19 INFO - "project": "", 09:23:19 INFO - "product": "firefox", 09:23:19 INFO - "script_repo_revision": "production", 09:23:19 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 09:23:19 INFO - "repository": "", 09:23:19 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 09:23:19 INFO - "buildid": "20160929071320", 09:23:19 INFO - "pgo_build": "False", 09:23:19 INFO - "basedir": "/builds/slave/test", 09:23:19 INFO - "buildnumber": 52, 09:23:19 INFO - "slavename": "t-yosemite-r7-0321", 09:23:19 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 09:23:19 INFO - "platform": "yosemite_r7", 09:23:19 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 09:23:19 INFO - "branch": "mozilla-aurora", 09:23:19 INFO - "repo_path": "releases/mozilla-aurora", 09:23:19 INFO - "revision": "0e12aae055677772cabc476634a4100410035375", 09:23:19 INFO - "stage_platform": "macosx64", 09:23:19 INFO - "builduid": "8fae0d82656646d19535a15ba08811dc", 09:23:19 INFO - "slavebuilddir": "test" 09:23:19 INFO - } 09:23:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/GeOAFR_YQluEjuegAbcEjg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 09:23:19 INFO - Running post-action listener: _resource_record_post_action 09:23:19 INFO - [mozharness: 2016-09-29 16:23:19.887194Z] Finished read-buildbot-config step (success) 09:23:19 INFO - [mozharness: 2016-09-29 16:23:19.887409Z] Running download-and-extract step. 09:23:19 INFO - Running pre-action listener: _resource_record_pre_action 09:23:19 INFO - Running main action method: download_and_extract 09:23:19 INFO - mkdir: /builds/slave/test/build/tests 09:23:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:23:19 INFO - trying https://queue.taskcluster.net/v1/task/GeOAFR_YQluEjuegAbcEjg/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 09:23:19 INFO - Downloading https://queue.taskcluster.net/v1/task/GeOAFR_YQluEjuegAbcEjg/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 09:23:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GeOAFR_YQluEjuegAbcEjg/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 09:23:20 INFO - Downloaded 1199 bytes. 09:23:20 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 09:23:20 INFO - Using the following test package requirements: 09:23:20 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 09:23:20 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 09:23:20 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 09:23:20 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 09:23:20 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 09:23:20 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 09:23:20 INFO - u'jsshell-mac.zip'], 09:23:20 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 09:23:20 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 09:23:20 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 09:23:20 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 09:23:20 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 09:23:20 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 09:23:20 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 09:23:20 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 09:23:20 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 09:23:20 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 09:23:20 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 09:23:20 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 09:23:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GeOAFR_YQluEjuegAbcEjg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 09:23:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GeOAFR_YQluEjuegAbcEjg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 09:23:20 INFO - Fetch https://queue.taskcluster.net/v1/task/GeOAFR_YQluEjuegAbcEjg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 09:23:21 INFO - Expected file size: 16433810 09:23:28 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 09:23:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GeOAFR_YQluEjuegAbcEjg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 09:23:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GeOAFR_YQluEjuegAbcEjg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 09:23:28 INFO - Fetch https://queue.taskcluster.net/v1/task/GeOAFR_YQluEjuegAbcEjg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 09:23:28 INFO - Expected file size: 16433810 09:23:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GeOAFR_YQluEjuegAbcEjg/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 09:23:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GeOAFR_YQluEjuegAbcEjg/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 09:23:35 INFO - Fetch https://queue.taskcluster.net/v1/task/GeOAFR_YQluEjuegAbcEjg/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 09:23:36 INFO - Expected file size: 14414059 09:23:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:23:37 INFO - trying https://queue.taskcluster.net/v1/task/GeOAFR_YQluEjuegAbcEjg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 09:23:37 INFO - Downloading https://queue.taskcluster.net/v1/task/GeOAFR_YQluEjuegAbcEjg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 09:23:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GeOAFR_YQluEjuegAbcEjg/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 09:23:39 INFO - Downloaded 115280426 bytes. 09:23:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GeOAFR_YQluEjuegAbcEjg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 09:23:39 INFO - mkdir: /builds/slave/test/properties 09:23:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:23:39 INFO - Writing to file /builds/slave/test/properties/build_url 09:23:39 INFO - Contents: 09:23:39 INFO - build_url:https://queue.taskcluster.net/v1/task/GeOAFR_YQluEjuegAbcEjg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 09:23:41 INFO - Running post-action listener: _resource_record_post_action 09:23:41 INFO - Running post-action listener: set_extra_try_arguments 09:23:41 INFO - [mozharness: 2016-09-29 16:23:41.201084Z] Finished download-and-extract step (success) 09:23:41 INFO - [mozharness: 2016-09-29 16:23:41.201251Z] Running populate-webroot step. 09:23:41 INFO - Running pre-action listener: _resource_record_pre_action 09:23:41 INFO - Running main action method: populate_webroot 09:23:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:23:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:23:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:23:41 INFO - '--tppagecycles', 09:23:41 INFO - '7'], 09:23:41 INFO - 'tests': ['tsvgm']}}, 09:23:41 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:23:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:23:41 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:23:41 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:23:41 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:23:41 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:23:41 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:23:41 INFO - 'talos_options': ['--disable-e10s'], 09:23:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:23:41 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:23:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:23:41 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:23:41 INFO - 'talos_options': ['--disable-e10s'], 09:23:41 INFO - 'tests': ['damp', 'tps']}, 09:23:41 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:23:41 INFO - 'tests': ['damp', 'tps']}, 09:23:41 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:23:41 INFO - 'tests': ['dromaeo_dom']}, 09:23:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:23:41 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:23:41 INFO - 'tests': ['basic_compositor_video']}, 09:23:41 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:23:41 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:23:41 INFO - 'tests': ['a11yr', 09:23:41 INFO - 'ts_paint', 09:23:41 INFO - 'tpaint', 09:23:41 INFO - 'sessionrestore', 09:23:41 INFO - 'sessionrestore_no_auto_restore', 09:23:41 INFO - 'tabpaint']}, 09:23:41 INFO - 'other-e10s': {'tests': ['a11yr', 09:23:41 INFO - 'ts_paint', 09:23:41 INFO - 'tpaint', 09:23:41 INFO - 'sessionrestore', 09:23:41 INFO - 'sessionrestore_no_auto_restore', 09:23:41 INFO - 'tabpaint']}, 09:23:41 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:23:41 INFO - 'ts_paint', 09:23:41 INFO - 'tpaint', 09:23:41 INFO - 'sessionrestore', 09:23:41 INFO - 'sessionrestore_no_auto_restore', 09:23:41 INFO - 'tabpaint']}, 09:23:41 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:23:41 INFO - 'ts_paint', 09:23:41 INFO - 'tpaint', 09:23:41 INFO - 'sessionrestore', 09:23:41 INFO - 'sessionrestore_no_auto_restore', 09:23:41 INFO - 'tabpaint']}, 09:23:41 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:23:41 INFO - 'tests': ['a11yr', 09:23:41 INFO - 'ts_paint', 09:23:41 INFO - 'tpaint', 09:23:41 INFO - 'sessionrestore', 09:23:41 INFO - 'sessionrestore_no_auto_restore', 09:23:41 INFO - 'tabpaint']}, 09:23:41 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:23:41 INFO - 'tests': ['a11yr', 09:23:41 INFO - 'ts_paint', 09:23:41 INFO - 'tpaint', 09:23:41 INFO - 'sessionrestore', 09:23:41 INFO - 'sessionrestore_no_auto_restore', 09:23:41 INFO - 'tabpaint']}, 09:23:41 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:23:41 INFO - 'tests': ['tsvgx', 09:23:41 INFO - 'tsvgr_opacity', 09:23:41 INFO - 'tart', 09:23:41 INFO - 'tscrollx', 09:23:41 INFO - 'cart']}, 09:23:41 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:23:41 INFO - 'tsvgr_opacity', 09:23:41 INFO - 'tart', 09:23:41 INFO - 'tscrollx', 09:23:41 INFO - 'cart']}, 09:23:41 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:23:41 INFO - 'talos_options': ['--disable-e10s'], 09:23:41 INFO - 'tests': ['tp5o']}, 09:23:41 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:23:41 INFO - 'tests': ['tp5o']}, 09:23:41 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:23:41 INFO - 'talos_options': ['--disable-e10s', 09:23:41 INFO - '--xperf_path', 09:23:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:23:41 INFO - 'tests': ['tp5n']}, 09:23:41 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:23:41 INFO - 'talos_options': ['--xperf_path', 09:23:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:23:41 INFO - 'tests': ['tp5n']}}, 09:23:41 INFO - 'talos.zip': {'path': '', 09:23:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:23:41 INFO - Running post-action listener: _resource_record_post_action 09:23:41 INFO - [mozharness: 2016-09-29 16:23:41.219763Z] Finished populate-webroot step (success) 09:23:41 INFO - [mozharness: 2016-09-29 16:23:41.219892Z] Running create-virtualenv step. 09:23:41 INFO - Running pre-action listener: _resource_record_pre_action 09:23:41 INFO - Running main action method: create_virtualenv 09:23:41 INFO - Creating virtualenv /builds/slave/test/build/venv 09:23:41 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 09:23:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:23:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:23:41 INFO - Using real prefix '/tools/python27' 09:23:41 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:23:42 INFO - Installing distribute.............................................................................................................................................................................................done. 09:23:44 INFO - Installing pip.................done. 09:23:44 INFO - Return code: 0 09:23:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:23:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:23:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:23:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:23:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:23:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100b4f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100ac5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc6db56c3f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100963d30>, '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 0x1007c9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10095bb20>, '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.bXAGOxWHz9/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.H1mTMoiL1x/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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 09:23:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:23:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:23:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bXAGOxWHz9/Render', 09:23:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:23:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:23:44 INFO - 'HOME': '/Users/cltbld', 09:23:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:23:44 INFO - 'LOGNAME': 'cltbld', 09:23:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:44 INFO - 'MOZ_NO_REMOTE': '1', 09:23:44 INFO - 'NO_EM_RESTART': '1', 09:23:44 INFO - 'PAGER': '/bin/cat', 09:23:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:23:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:23:44 INFO - 'PWD': '/builds/slave/test', 09:23:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:23:44 INFO - 'SHELL': '/bin/bash', 09:23:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.H1mTMoiL1x/Listeners', 09:23:44 INFO - 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/', 09:23:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:23:44 INFO - 'USER': 'cltbld', 09:23:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:23:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:23:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:44 INFO - 'XPC_FLAGS': '0x0', 09:23:44 INFO - 'XPC_SERVICE_NAME': '0', 09:23:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:23:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:23:45 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 09:23:45 INFO - Cleaning up... 09:23:45 INFO - Return code: 0 09:23:45 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:23:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:23:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:23:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:23:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:23:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23:45 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 0x100b4f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100ac5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc6db56c3f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100963d30>, '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 0x1007c9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10095bb20>, '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.bXAGOxWHz9/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.H1mTMoiL1x/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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 09:23:45 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 09:23:45 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 09:23:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bXAGOxWHz9/Render', 09:23:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:23:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:23:45 INFO - 'HOME': '/Users/cltbld', 09:23:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:23:45 INFO - 'LOGNAME': 'cltbld', 09:23:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:45 INFO - 'MOZ_NO_REMOTE': '1', 09:23:45 INFO - 'NO_EM_RESTART': '1', 09:23:45 INFO - 'PAGER': '/bin/cat', 09:23:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:23:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:23:45 INFO - 'PWD': '/builds/slave/test', 09:23:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:23:45 INFO - 'SHELL': '/bin/bash', 09:23:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.H1mTMoiL1x/Listeners', 09:23:45 INFO - 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/', 09:23:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:23:45 INFO - 'USER': 'cltbld', 09:23:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:23:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:23:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:45 INFO - 'XPC_FLAGS': '0x0', 09:23:45 INFO - 'XPC_SERVICE_NAME': '0', 09:23:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:23:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:23:45 INFO - Downloading/unpacking psutil>=3.1.1 09:23:45 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 09:23:45 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 09:23:45 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 09:23:45 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 09:23:45 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 09:23:45 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 09:23:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:23:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:23:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:23:48 INFO - Installing collected packages: psutil 09:23:48 INFO - Running setup.py install for psutil 09:23:48 INFO - building 'psutil._psutil_osx' extension 09:23:48 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 09:23:49 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 09:23:49 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 09:23:49 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 09:23:49 INFO - building 'psutil._psutil_posix' extension 09:23:49 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 09:23:49 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:23:49 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:23:49 INFO - ^ 09:23:49 INFO - 1 warning generated. 09:23:49 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 09:23:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:23:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:23:49 INFO - Successfully installed psutil 09:23:49 INFO - Cleaning up... 09:23:49 INFO - Return code: 0 09:23:49 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:23:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:23:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:23:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:23:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:23:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23:49 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 0x100b4f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100ac5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc6db56c3f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100963d30>, '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 0x1007c9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10095bb20>, '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.bXAGOxWHz9/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.H1mTMoiL1x/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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 09:23:49 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 09:23:49 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 09:23:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bXAGOxWHz9/Render', 09:23:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:23:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:23:49 INFO - 'HOME': '/Users/cltbld', 09:23:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:23:49 INFO - 'LOGNAME': 'cltbld', 09:23:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:49 INFO - 'MOZ_NO_REMOTE': '1', 09:23:49 INFO - 'NO_EM_RESTART': '1', 09:23:49 INFO - 'PAGER': '/bin/cat', 09:23:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:23:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:23:49 INFO - 'PWD': '/builds/slave/test', 09:23:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:23:49 INFO - 'SHELL': '/bin/bash', 09:23:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.H1mTMoiL1x/Listeners', 09:23:49 INFO - 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/', 09:23:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:23:49 INFO - 'USER': 'cltbld', 09:23:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:23:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:23:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:49 INFO - 'XPC_FLAGS': '0x0', 09:23:49 INFO - 'XPC_SERVICE_NAME': '0', 09:23:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:23:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:23:49 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:23:49 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 09:23:49 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 09:23:49 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 09:23:49 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 09:23:49 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 09:23:49 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 09:23:52 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:23:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:23:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:23:52 INFO - Installing collected packages: mozsystemmonitor 09:23:52 INFO - Running setup.py install for mozsystemmonitor 09:23:52 INFO - Successfully installed mozsystemmonitor 09:23:52 INFO - Cleaning up... 09:23:52 INFO - Return code: 0 09:23:52 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:23:52 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')]} 09:23:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:23:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23:52 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')]} 09:23:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:23:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23:52 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 0x100b4f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100ac5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc6db56c3f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100963d30>, '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 0x1007c9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10095bb20>, '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.bXAGOxWHz9/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.H1mTMoiL1x/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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 09:23:52 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 09:23:52 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 09:23:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bXAGOxWHz9/Render', 09:23:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:23:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:23:52 INFO - 'HOME': '/Users/cltbld', 09:23:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:23:52 INFO - 'LOGNAME': 'cltbld', 09:23:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:52 INFO - 'MOZ_NO_REMOTE': '1', 09:23:52 INFO - 'NO_EM_RESTART': '1', 09:23:52 INFO - 'PAGER': '/bin/cat', 09:23:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:23:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:23:52 INFO - 'PWD': '/builds/slave/test', 09:23:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:23:52 INFO - 'SHELL': '/bin/bash', 09:23:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.H1mTMoiL1x/Listeners', 09:23:52 INFO - 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/', 09:23:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:23:52 INFO - 'USER': 'cltbld', 09:23:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:23:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:23:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:52 INFO - 'XPC_FLAGS': '0x0', 09:23:52 INFO - 'XPC_SERVICE_NAME': '0', 09:23:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:23:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:23:52 INFO - Downloading/unpacking jsonschema==2.5.1 09:23:52 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 09:23:52 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 09:23:52 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 09:23:52 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 09:23:52 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 09:23:52 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 09:23:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:23:56 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:23: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 09:23: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 09:23: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 09:23: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 09:23: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 09:23: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 09:23:56 INFO - Downloading functools32-3.2.3-2.tar.gz 09:23:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:23:56 INFO - warning: no files found matching '*.txt' 09:23:56 INFO - no previously-included directories found matching 'build' 09:23:56 INFO - no previously-included directories found matching 'dist' 09:23:56 INFO - no previously-included directories found matching '.git*' 09:23:56 INFO - Installing collected packages: jsonschema, functools32 09:23:56 INFO - Running setup.py install for functools32 09:23:57 INFO - warning: no files found matching '*.txt' 09:23:57 INFO - no previously-included directories found matching 'build' 09:23:57 INFO - no previously-included directories found matching 'dist' 09:23:57 INFO - no previously-included directories found matching '.git*' 09:23:57 INFO - Successfully installed jsonschema functools32 09:23:57 INFO - Cleaning up... 09:23:57 INFO - Return code: 0 09:23:57 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:23:57 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')]} 09:23:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:23:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23:57 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')]} 09:23:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:23:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23:57 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 0x100b4f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100ac5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc6db56c3f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100963d30>, '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 0x1007c9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10095bb20>, '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.bXAGOxWHz9/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.H1mTMoiL1x/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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 09:23:57 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 09:23:57 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 09:23:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bXAGOxWHz9/Render', 09:23:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:23:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:23:57 INFO - 'HOME': '/Users/cltbld', 09:23:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:23:57 INFO - 'LOGNAME': 'cltbld', 09:23:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:57 INFO - 'MOZ_NO_REMOTE': '1', 09:23:57 INFO - 'NO_EM_RESTART': '1', 09:23:57 INFO - 'PAGER': '/bin/cat', 09:23:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:23:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:23:57 INFO - 'PWD': '/builds/slave/test', 09:23:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:23:57 INFO - 'SHELL': '/bin/bash', 09:23:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.H1mTMoiL1x/Listeners', 09:23:57 INFO - 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/', 09:23:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:23:57 INFO - 'USER': 'cltbld', 09:23:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:23:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:23:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:57 INFO - 'XPC_FLAGS': '0x0', 09:23:57 INFO - 'XPC_SERVICE_NAME': '0', 09:23:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:23:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:23:57 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:23:57 INFO - Cleaning up... 09:23:57 INFO - Return code: 0 09:23:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:23:57 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')]} 09:23:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:23:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23:57 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')]} 09:23:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:23:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23:57 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 0x100b4f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100ac5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc6db56c3f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100963d30>, '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 0x1007c9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10095bb20>, '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.bXAGOxWHz9/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.H1mTMoiL1x/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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 09:23:57 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 09:23:57 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 09:23:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bXAGOxWHz9/Render', 09:23:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:23:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:23:57 INFO - 'HOME': '/Users/cltbld', 09:23:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:23:57 INFO - 'LOGNAME': 'cltbld', 09:23:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:57 INFO - 'MOZ_NO_REMOTE': '1', 09:23:57 INFO - 'NO_EM_RESTART': '1', 09:23:57 INFO - 'PAGER': '/bin/cat', 09:23:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:23:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:23:57 INFO - 'PWD': '/builds/slave/test', 09:23:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:23:57 INFO - 'SHELL': '/bin/bash', 09:23:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.H1mTMoiL1x/Listeners', 09:23:57 INFO - 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/', 09:23:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:23:57 INFO - 'USER': 'cltbld', 09:23:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:23:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:23:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:57 INFO - 'XPC_FLAGS': '0x0', 09:23:57 INFO - 'XPC_SERVICE_NAME': '0', 09:23:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:23:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:23:57 INFO - Downloading/unpacking blobuploader==1.2.4 09:23:57 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 09:23:57 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 09:23:57 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 09:23:57 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 09:23:57 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 09:23:57 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 09:24:00 INFO - Downloading blobuploader-1.2.4.tar.gz 09:24:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:24:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:24: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 09:24: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 09:24: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 09:24: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 09:24: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 09:24: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 09:24:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:24:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:24: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 09:24: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 09:24: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 09:24: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 09:24: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 09:24: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 09:24:01 INFO - Downloading docopt-0.6.1.tar.gz 09:24:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:24:01 INFO - Installing collected packages: blobuploader, requests, docopt 09:24:01 INFO - Running setup.py install for blobuploader 09:24:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:24:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:24:01 INFO - Running setup.py install for requests 09:24:02 INFO - Running setup.py install for docopt 09:24:02 INFO - Successfully installed blobuploader requests docopt 09:24:02 INFO - Cleaning up... 09:24:02 INFO - Return code: 0 09:24:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:24:02 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')]} 09:24:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:24:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:02 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')]} 09:24:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:24:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:02 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 0x100b4f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100ac5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc6db56c3f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100963d30>, '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 0x1007c9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10095bb20>, '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.bXAGOxWHz9/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.H1mTMoiL1x/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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 09:24:02 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 09:24:02 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 09:24:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bXAGOxWHz9/Render', 09:24:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:24:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:24:02 INFO - 'HOME': '/Users/cltbld', 09:24:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:24:02 INFO - 'LOGNAME': 'cltbld', 09:24:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:24:02 INFO - 'MOZ_NO_REMOTE': '1', 09:24:02 INFO - 'NO_EM_RESTART': '1', 09:24:02 INFO - 'PAGER': '/bin/cat', 09:24:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:24:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:24:02 INFO - 'PWD': '/builds/slave/test', 09:24:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:24:02 INFO - 'SHELL': '/bin/bash', 09:24:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.H1mTMoiL1x/Listeners', 09:24:02 INFO - 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/', 09:24:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:24:02 INFO - 'USER': 'cltbld', 09:24:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:24:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:24:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:24:02 INFO - 'XPC_FLAGS': '0x0', 09:24:02 INFO - 'XPC_SERVICE_NAME': '0', 09:24:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:24:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:24:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:24:02 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-P5MzRm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:24:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:24:02 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-jsoADH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:24:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:24:02 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-65dKHW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:24:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:24:02 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-D0ES0n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:24:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:24:02 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-9THonB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:24:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:24:03 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-Wcgmfh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:24:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:24:03 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-bp1jaz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:24:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:24:03 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-7PwGsT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:24:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:24:03 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-CJUMbw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:24:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:24:03 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-93gZML-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:24:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:24:03 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-rXs6mp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:24:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:24:03 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-R5L5ds-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:24:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:24:03 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-YxBsJu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:24:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:24:03 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-fhXJlD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:24:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:24:04 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-7dTjHw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:24:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:24:04 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-CIkVXI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:24:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:24:04 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-_8xgtg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:24:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:24:04 INFO - Running setup.py install for manifestparser 09:24:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:24:04 INFO - Running setup.py install for mozcrash 09:24:04 INFO - Running setup.py install for mozdebug 09:24:04 INFO - Running setup.py install for mozdevice 09:24:04 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:24:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:24:04 INFO - Running setup.py install for mozfile 09:24:05 INFO - Running setup.py install for mozhttpd 09:24:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:24:05 INFO - Running setup.py install for mozinfo 09:24:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:24:05 INFO - Running setup.py install for mozInstall 09:24:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:24:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:24:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:24:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:24:05 INFO - Running setup.py install for mozleak 09:24:05 INFO - Running setup.py install for mozlog 09:24:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:24:05 INFO - Running setup.py install for moznetwork 09:24:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:24:05 INFO - Running setup.py install for mozprocess 09:24:06 INFO - Running setup.py install for mozprofile 09:24:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:24:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:24:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:24:06 INFO - Running setup.py install for mozrunner 09:24:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:24:06 INFO - Running setup.py install for mozscreenshot 09:24:06 INFO - Running setup.py install for moztest 09:24:06 INFO - Running setup.py install for mozversion 09:24:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:24:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:24:06 INFO - Cleaning up... 09:24:06 INFO - Return code: 0 09:24:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:24:06 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')]} 09:24:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:24:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:06 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')]} 09:24:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:24:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:06 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 0x100b4f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100ac5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc6db56c3f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100963d30>, '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 0x1007c9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10095bb20>, '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.bXAGOxWHz9/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.H1mTMoiL1x/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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 09:24:06 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 09:24:06 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 09:24:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bXAGOxWHz9/Render', 09:24:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:24:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:24:06 INFO - 'HOME': '/Users/cltbld', 09:24:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:24:06 INFO - 'LOGNAME': 'cltbld', 09:24:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:24:06 INFO - 'MOZ_NO_REMOTE': '1', 09:24:06 INFO - 'NO_EM_RESTART': '1', 09:24:06 INFO - 'PAGER': '/bin/cat', 09:24:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:24:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:24:06 INFO - 'PWD': '/builds/slave/test', 09:24:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:24:06 INFO - 'SHELL': '/bin/bash', 09:24:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.H1mTMoiL1x/Listeners', 09:24:06 INFO - 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/', 09:24:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:24:06 INFO - 'USER': 'cltbld', 09:24:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:24:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:24:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:24:06 INFO - 'XPC_FLAGS': '0x0', 09:24:06 INFO - 'XPC_SERVICE_NAME': '0', 09:24:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:24:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:24:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:24:07 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-jLcLvE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:24:07 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)) 09:24:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:24:07 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-54vUXP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:24:07 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)) 09:24:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:24:07 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-NpJWQW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:24:07 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)) 09:24:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:24:07 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-RnFuY4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:24:07 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)) 09:24:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:24:07 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-q4wTT9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:24:07 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)) 09:24:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:24:07 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-du7g1S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:24:07 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)) 09:24:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:24:07 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-FE1ulj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:24:07 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)) 09:24:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:24:07 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-_6bMEo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:24:08 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)) 09:24:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:24:08 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-sXK5pN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:24:08 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)) 09:24:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:24:08 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-pOdPG1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:24:08 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)) 09:24:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:24:08 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-Au5FkZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:24:08 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)) 09:24:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:24:08 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-CqHkQ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:24:08 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)) 09:24:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:24:08 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-2wvIDh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:24:08 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)) 09:24:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:24:08 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-URMcDv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:24:08 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)) 09:24:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:24:08 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-THSOZv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:24:08 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)) 09:24:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:24:08 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-Vt1uot-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:24:08 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)) 09:24:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:24:08 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-iNy0Ib-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:24:08 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)) 09:24:08 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)) 09:24:08 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)) 09:24:08 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)) 09:24:08 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)) 09:24:08 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)) 09:24:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:24:08 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 09:24:08 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 09:24:08 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 09:24:08 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 09:24:08 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 09:24:09 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 09:24:11 INFO - Downloading blessings-1.6.tar.gz 09:24:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:24:11 INFO - Installing collected packages: blessings 09:24:11 INFO - Running setup.py install for blessings 09:24:11 INFO - Successfully installed blessings 09:24:11 INFO - Cleaning up... 09:24:11 INFO - Return code: 0 09:24:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:24:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:24:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:24:12 INFO - Reading from file tmpfile_stdout 09:24:12 INFO - Current package versions: 09:24:12 INFO - blessings == 1.6 09:24:12 INFO - blobuploader == 1.2.4 09:24:12 INFO - docopt == 0.6.1 09:24:12 INFO - functools32 == 3.2.3-2 09:24:12 INFO - jsonschema == 2.5.1 09:24:12 INFO - manifestparser == 1.1 09:24:12 INFO - mozInstall == 1.12 09:24:12 INFO - mozcrash == 0.17 09:24:12 INFO - mozdebug == 0.1 09:24:12 INFO - mozdevice == 0.48 09:24:12 INFO - mozfile == 1.2 09:24:12 INFO - mozhttpd == 0.7 09:24:12 INFO - mozinfo == 0.9 09:24:12 INFO - mozleak == 0.1 09:24:12 INFO - mozlog == 3.4 09:24:12 INFO - moznetwork == 0.27 09:24:12 INFO - mozprocess == 0.23 09:24:12 INFO - mozprofile == 0.28 09:24:12 INFO - mozrunner == 6.12 09:24:12 INFO - mozscreenshot == 0.1 09:24:12 INFO - mozsystemmonitor == 0.3 09:24:12 INFO - moztest == 0.7 09:24:12 INFO - mozversion == 1.4 09:24:12 INFO - psutil == 3.1.1 09:24:12 INFO - requests == 1.2.3 09:24:12 INFO - wsgiref == 0.1.2 09:24:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:24: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')]} 09:24:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:24:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24: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')]} 09:24:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:24:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:12 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 0x100b4f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100ac5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc6db56c3f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100963d30>, '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 0x1007c9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10095bb20>, '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.bXAGOxWHz9/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.H1mTMoiL1x/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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 09:24:12 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 09:24:12 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 09:24:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bXAGOxWHz9/Render', 09:24:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:24:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:24:12 INFO - 'HOME': '/Users/cltbld', 09:24:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:24:12 INFO - 'LOGNAME': 'cltbld', 09:24:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:24:12 INFO - 'MOZ_NO_REMOTE': '1', 09:24:12 INFO - 'NO_EM_RESTART': '1', 09:24:12 INFO - 'PAGER': '/bin/cat', 09:24:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:24:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:24:12 INFO - 'PWD': '/builds/slave/test', 09:24:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:24:12 INFO - 'SHELL': '/bin/bash', 09:24:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.H1mTMoiL1x/Listeners', 09:24:12 INFO - 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/', 09:24:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:24:12 INFO - 'USER': 'cltbld', 09:24:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:24:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:24:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:24:12 INFO - 'XPC_FLAGS': '0x0', 09:24:12 INFO - 'XPC_SERVICE_NAME': '0', 09:24:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:24:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:24:12 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)) 09:24:12 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)) 09:24:12 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)) 09:24:12 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)) 09:24:12 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)) 09:24:12 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)) 09:24:12 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)) 09:24:12 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)) 09:24:12 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)) 09:24:12 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)) 09:24:12 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)) 09:24:12 INFO - Cleaning up... 09:24:12 INFO - Return code: 0 09:24:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:24: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')]} 09:24:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:24:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24: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')]} 09:24:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:24:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100b4f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100ac5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc6db56c3f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100963d30>, '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 0x1007c9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10095bb20>, '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.bXAGOxWHz9/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.H1mTMoiL1x/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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 09:24:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:24:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:24:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bXAGOxWHz9/Render', 09:24:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:24:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:24:12 INFO - 'HOME': '/Users/cltbld', 09:24:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:24:12 INFO - 'LOGNAME': 'cltbld', 09:24:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:24:12 INFO - 'MOZ_NO_REMOTE': '1', 09:24:12 INFO - 'NO_EM_RESTART': '1', 09:24:12 INFO - 'PAGER': '/bin/cat', 09:24:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:24:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:24:12 INFO - 'PWD': '/builds/slave/test', 09:24:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:24:12 INFO - 'SHELL': '/bin/bash', 09:24:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.H1mTMoiL1x/Listeners', 09:24:12 INFO - 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/', 09:24:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:24:12 INFO - 'USER': 'cltbld', 09:24:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:24:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:24:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:24:12 INFO - 'XPC_FLAGS': '0x0', 09:24:12 INFO - 'XPC_SERVICE_NAME': '0', 09:24:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:24:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:24:12 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:24:12 INFO - Cleaning up... 09:24:12 INFO - Return code: 0 09:24:12 INFO - Running post-action listener: _resource_record_post_action 09:24:12 INFO - Running post-action listener: _start_resource_monitoring 09:24:12 INFO - Starting resource monitoring. 09:24:12 INFO - [mozharness: 2016-09-29 16:24:12.698764Z] Finished create-virtualenv step (success) 09:24:12 INFO - [mozharness: 2016-09-29 16:24:12.699769Z] Running install step. 09:24:12 INFO - Running pre-action listener: _resource_record_pre_action 09:24:12 INFO - Running main action method: install 09:24:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:24:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:24:12 INFO - Reading from file tmpfile_stdout 09:24:12 INFO - Detecting whether we're running mozinstall >=1.0... 09:24:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:24:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:24:13 INFO - Reading from file tmpfile_stdout 09:24:13 INFO - Output received: 09:24:13 INFO - Usage: mozinstall [options] installer 09:24:13 INFO - Options: 09:24:13 INFO - -h, --help show this help message and exit 09:24:13 INFO - -d DEST, --destination=DEST 09:24:13 INFO - Directory to install application into. [default: 09:24:13 INFO - "/builds/slave/test"] 09:24:13 INFO - --app=APP Application being installed. [default: firefox] 09:24:13 INFO - mkdir: /builds/slave/test/build/application 09:24:13 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'] 09:24:13 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 09:24:45 INFO - Reading from file tmpfile_stdout 09:24:45 INFO - Output received: 09:24:45 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 09:24:45 INFO - Running post-action listener: _resource_record_post_action 09:24:45 INFO - [mozharness: 2016-09-29 16:24:45.452198Z] Finished install step (success) 09:24:45 INFO - [mozharness: 2016-09-29 16:24:45.452307Z] Running run-tests step. 09:24:45 INFO - Running pre-action listener: _resource_record_pre_action 09:24:45 INFO - Running main action method: run_tests 09:24:45 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:24:45 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:24:45 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:24:45 INFO - 2016-09-29 09:24:45.464 screenresolution[1913:18699] starting screenresolution argv=screenresolution get 09:24:45 INFO - 2016-09-29 09:24:45.467 screenresolution[1913:18699] Display 0: 1600x1200x32@60 09:24:45 INFO - 2016-09-29 09:24:45.471 screenresolution[1914:18701] starting screenresolution argv=screenresolution list 09:24:45 INFO - Available Modes on Display 0 09:24:45 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:24:45 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:24:45 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:24:45 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:24:45 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:24:45 INFO - Intel Iris: 09:24:45 INFO - Chipset Model: Intel Iris 09:24:45 INFO - Type: GPU 09:24:45 INFO - Bus: Built-In 09:24:45 INFO - VRAM (Dynamic, Max): 1536 MB 09:24:45 INFO - Vendor: Intel (0x8086) 09:24:45 INFO - Device ID: 0x0a2e 09:24:45 INFO - Revision ID: 0x0009 09:24:45 INFO - Displays: 09:24:45 INFO - Display: 09:24:45 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:24:45 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:24:45 INFO - Display Serial Number: 1600x1200 60 09:24:45 INFO - Main Display: Yes 09:24:45 INFO - Mirror: Off 09:24:45 INFO - Online: Yes 09:24:45 INFO - Rotation: Supported 09:24:45 INFO - Return code: 0 09:24:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:24:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:24:45 INFO - Python 2.7.3 09:24:45 INFO - Return code: 0 09:24:45 INFO - grabbing minidump binary from tooltool 09:24:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:24:45 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 0x100963d30>, '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 0x1007c9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10095bb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:24:45 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 09:24:45 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 09:24:45 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 09:24:45 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:24:45 INFO - Return code: 0 09:24:45 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:24:45 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:24:45 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:24:45 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:24:45 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:24:45 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/GeOAFR_YQluEjuegAbcEjg/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0321', '--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 09:24:45 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/GeOAFR_YQluEjuegAbcEjg/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0321 --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 09:24:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bXAGOxWHz9/Render', 09:24:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:24:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:24:45 INFO - 'HOME': '/Users/cltbld', 09:24:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:24:45 INFO - 'LOGNAME': 'cltbld', 09:24:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:24:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:24:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:24:45 INFO - 'MOZ_NO_REMOTE': '1', 09:24:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:24:45 INFO - 'NO_EM_RESTART': '1', 09:24:45 INFO - 'PAGER': '/bin/cat', 09:24:45 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:24:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:24:45 INFO - 'PWD': '/builds/slave/test', 09:24:45 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:24:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:24:45 INFO - 'SHELL': '/bin/bash', 09:24:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.H1mTMoiL1x/Listeners', 09:24:45 INFO - 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/', 09:24:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:24:45 INFO - 'USER': 'cltbld', 09:24:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:24:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:24:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:24:45 INFO - 'XPC_FLAGS': '0x0', 09:24:45 INFO - 'XPC_SERVICE_NAME': '0', 09:24:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:24:45 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/GeOAFR_YQluEjuegAbcEjg/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0321', '--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 09:24:46 INFO - mozversion application_buildid: 20160929071320 09:24:46 INFO - mozversion application_changeset: 0e12aae055677772cabc476634a4100410035375 09:24:46 INFO - mozversion application_display_name: FirefoxDeveloperEdition 09:24:46 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:24:46 INFO - mozversion application_name: Firefox 09:24:46 INFO - mozversion application_remotingname: firefox-dev 09:24:46 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:24:46 INFO - mozversion application_vendor: Mozilla 09:24:46 INFO - mozversion application_version: 51.0a2 09:24:46 INFO - mozversion platform_buildid: 20160929071320 09:24:46 INFO - mozversion platform_changeset: 0e12aae055677772cabc476634a4100410035375 09:24:46 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:24:46 INFO - mozversion platform_version: 51.0a2 09:24:46 INFO - using testdate: 1475166286 09:24:46 INFO - actual date: 1475166286 09:24:46 INFO - starting webserver on 'localhost:57296' 09:24:46 INFO - SUITE-START | Running 2 tests 09:24:46 INFO - TEST-START | dromaeo_css 09:24:46 INFO - operating with platform_type : mac_ 09:24:46 INFO - Initialising browser for dromaeo_css test... 09:24:46 INFO - TEST-INFO | started process 1924 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/tmp1al4th/profile http://localhost:57296/getInfo.html) 09:24:48 INFO - PROCESS | 1924 | __metrics Screen width/height:1600/1200 09:24:48 INFO - PROCESS | 1924 | colorDepth:24 09:24:48 INFO - PROCESS | 1924 | Browser inner width/height: 1024/689 09:24:48 INFO - PROCESS | 1924 | __metrics 09:24:48 INFO - PROCESS | 1924 | 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" 09:24:48 INFO - PROCESS | 1924 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:24:49 INFO - TEST-INFO | 1924: exit 0 09:24:49 INFO - Browser initialized. 09:24:49 INFO - Running cycle 1/1 for dromaeo_css test... 09:24:49 INFO - TEST-INFO | started process 1926 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/tmp1al4th/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:25:01 INFO - PROCESS | 1926 | RSS: Main: 219156480 09:25:01 INFO - PROCESS | 1926 | 09:25:52 INFO - PROCESS | 1926 | 1475166352219 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] 09:28:04 INFO - PROCESS | 1926 | Cycle 1(1): loaded http://localhost:57296/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57296/tests/dromaeo/cssquery-ext.html) 09:28:05 INFO - PROCESS | 1926 | RSS: Main: 326979584 09:28:05 INFO - PROCESS | 1926 | 09:31:08 INFO - PROCESS | 1926 | Cycle 1(1): loaded http://localhost:57296/tests/dromaeo/cssquery-ext.html (next: http://localhost:57296/tests/dromaeo/cssquery-jquery.html) 09:31:08 INFO - PROCESS | 1926 | RSS: Main: 352444416 09:31:08 INFO - PROCESS | 1926 | 09:34:11 INFO - PROCESS | 1926 | Cycle 1(1): loaded http://localhost:57296/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57296/tests/dromaeo/cssquery-mootools.html) 09:34:12 INFO - PROCESS | 1926 | RSS: Main: 317562880 09:34:12 INFO - PROCESS | 1926 | 09:37:14 INFO - PROCESS | 1926 | Cycle 1(1): loaded http://localhost:57296/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57296/tests/dromaeo/cssquery-prototype.html) 09:37:14 INFO - PROCESS | 1926 | RSS: Main: 328777728 09:37:14 INFO - PROCESS | 1926 | 09:40:18 INFO - PROCESS | 1926 | Cycle 1(1): loaded http://localhost:57296/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57296/tests/dromaeo/cssquery-yui.html) 09:40:18 INFO - PROCESS | 1926 | RSS: Main: 313827328 09:40:18 INFO - PROCESS | 1926 | 09:43:21 INFO - PROCESS | 1926 | Cycle 1(1): loaded http://localhost:57296/tests/dromaeo/cssquery-yui.html (next: http://localhost:57296/tests/dromaeo/cssquery-dojo.html) 09:43:22 INFO - PROCESS | 1926 | RSS: Main: 371847168 09:43:22 INFO - PROCESS | 1926 | 09:43:22 INFO - PROCESS | 1926 | __start_tp_report 09:43:22 INFO - PROCESS | 1926 | _x_x_mozilla_page_load 09:43:22 INFO - PROCESS | 1926 | _x_x_mozilla_page_load_details 09:43:22 INFO - PROCESS | 1926 | |i|pagename|runs| 09:43:22 INFO - PROCESS | 1926 | |0;dojo.html;2996.8651410686516;3313.2710803623195;3322.1030321813096;3330;3353.128186671466;5722.971385143073;5799.971000144993;5812.883742325151;5822.796202132926;5871.060630299153;5783.2481777368985;5852.063669812831;5861.15013323069;5868.442497962697;5877.235959325292;5239.633225674204;5325.254464374991;5334.146536554133;5336.9733151334185;5366.221897824813;5239.502247286502;5245.344331958505;5246.95060987802;5410.810621628244;5420.051490989081;5247.344081989751;5292.523672869441;5305.708186049766;5345.839624811242;5346.304980352549;5313.73431328434;5322.4411436799355;5345.385280692732;5383.057964856173;5385.865353366158;5129.7435128243815;5209.895802083975;5297.311349524537;5303.124984377573;5325.573954083664;5647.124695672136;5658.688772117532;5726.971365143189;5763.337216220147;5765.1352297155345;6230.127782110508;6273.8592528930685;6299.338569450188;6326.335734747831;6329.556931014831;6198.008318669036;6248.843778905518;6301.87396252077;6314.052892066181;6323.462505687022;5806.216160818278;5843.53251739864;5894.911576326359;5902;5907.202527658797;6338.429541341301;6355.110284560165;6364.204474440695;6386.2975072741965;6389.201349831271;6125.295591007091;6243.43809057178;6246.968765156145;6253.437190652863;6257.374262573706;6217.533684973645;6254.655993920287;6305.716242769086;6306.684665766693;6321.494280457552;6198.349173336825;6289.7484100635465;6292.968535157295;6310.9368906311265;6312.810615681537;6235.127082208494;6306.306306306303;6325.304216536178;6333.714982825784;6346.746130154742;4910.48439913811;4947.084789313988;4964.032013757283;4967.850964471072;5032.622553308516;4453.755043472575;4454.554544545519;4459.175052615276;4493.977530112394;4508.954910450919;5795.478406943395;5816.651000939873;5817.360090390053;5842.123681447817;5858.970705146447;6149.200603921461;6261.24865016201;6288.213973253343;6288.5598008138995;6291.653959032205;5740.167675687002;5812.215350927655;5812.651240925558;5828.329742079631;5918.082697181943;5504.119340905436;5505.559555235572;5509.5041446270025;5517.310336207974;5526;6421.486281097501;6445.0332450132855;6447.516436267392;6457.192850893638;6457.515686323451;6125.357545073132;6207.906881396873;6218.844528886814;6262.311145774052;6302.401271879165;6295.653739044214;6351.682415879095;6359.87280254383;6380.393862583047;6387.5209359297305;6211.409916057967;6243.188385509855;6258.843528911813;6258.906116408349;6271.560990730787;6033.818985430444;6222.875542489215;6233.158523599256;6257.1552840367785;6264.906026409516;6229.159063526366;6249;6253.187085678833;6262.4990000800735;6276.560640755103;6217.658028808459;6228.532860035425;6235.594686345555;6243.063540468785;6243.656598887105;5900.763969441175;5985.431384018511;6040.426159514839;6089.878202436015;6110.51115910735;5074.543291103819;6160.9383906160365;6219.346968568235;6242.250929888442;6261.906071408841;6084.11780291864;6097.817065488042;6104.694765261808;6114.0828875669;6120.873812997581 09:43:22 INFO - PROCESS | 1926 | |1;ext.html;483.3185208855514;493.33153576903294;507.30499216073963;512.9076766182086;515.2014377714542;30755.23111922203;40167;41499.75500734983;41708.37437438437;43778.78110609442;42783.14433711324;43361.56638433615;43375.78312108443;43389;43425.565744342544;9697.127258546712;9899.703008909708;9906.603735850558;9910.355826871266;9916.603335866594;8737.650493980233;8941.239994600466;8954.19412252897;9018.962819275768;9095.181433670969;10091.444970526618;11986.041116710685;11986.280823150595;12253.387330633477;12281.324527151002;11838.816118388178;11866.94066529666;11962.820557691599;12060.879391206063;12064.698382540419;8635.913640863573;8867.68963086289;11891.94054029733;11968.521259149624;11981.760364792743;39152.43390264386;39713.60286397128;39797.60708375222;41877.371839422434;41970.740877773715;3284.786488878215;3340.766146369755;3370.1574606348413;3614.4036234021355;3975.980120099381;29745.553816692765;29874.85062574695;30495.08514744561;31250.687493125006;32102.357952841045;3141.7957832741026;3228.668434487369;3275.42680030996;3275.672432756729;3375.746818988586;499010;507187;510532;511487;511873.4406327982;62155;62396;62549;62670.37329626645;62695.059574106424;65096.67451662806;65307;65333.346666533675;65398;65425.018624720666;16829;17053.317867285168;17059;17088.316467341167;17089.658206836044;13120.475180992653;13183.406746696422;13195.142315749446;13202.537911173064;13206.943444524415;16108.838911610968;16612.920160189547;16617.833821661872;17704.965013254412;19233.711494327596;7600.783874580041;7778.222177782177;7828.647710853025;7907.48601340911;7920.32677222431;699.4509310191476;929.5259417697023;970.8446648536342;971.9514024298757;978.3054031637474;24647;28927.710722892924;30038;30039.399212015636;30690.53964190539;1003.8393856982848;1007.7077647482295;1013.4071568132725;1038.89611038897;1042.7653777900064;14848;15605.921970390076;15659.373625055097;15686.607834803994;15911;672930;678553;679779;680302;680409;48490.757546212044;49447.25829112566;55939.72030139823;56899;56924.71537642285;1325.3439547423893;1343.8521762606106;1362.1486570893192;1371.945122195121;1377.6142680049602;29340.853295733385;30487.84756076294;30774;30851.845740771154;31583.526247106773;42986.14027719491;48987.5101248983;49390.75304623454;49462.75268623634;49467.25799113088;502527;608126;608166;608192;610304;26058.34854128662;26368.604470933336;26723.732762672902;26780.330491737863;26809.061682841006;43593.64063593615;43673.34489982589;46958.29562556496;47285.81785455391;47938;37908.43137352887;38918.6108138915;38977.6102238974;39252.01869953274;40346;37917;38239;38412.80793596014;38608.03479913025;40352.78941631756;37302.56681873377;37613.81193094017;38482.6151738479;38591.614083859924;38980.80509597434;30824.075277741704;32059.519107212946;32879.67120328766;34130.477137276575;34325;21835.70185830495;25730.228093157235;25815.12369892465;25863.353416164748;26125.216243512725 09:43:22 INFO - PROCESS | 1926 | |2;jquery.html;347.3019231344996;368.27817477743605;372.093951228758;377.6469001483613;394.9644531992122;15024.323905424255;15133.92433037836;16102;21076.789232107676;21119.049642766073;20663.690044649342;20689.172433102696;21294.467638309052;21424.8928755356;21495;5799.420057994188;5879.559033072515;6010.789622363218;6015.3383127855905;6073.180120683717;6034.426729460694;6149.046897730859;6174.938250617503;6176.073588961669;6179.721912513947;3288.4574045282498;4127.711060225785;5854.560907931901;6095.542834287424;6135.171751813515;6044.69776511177;6177.7837775677635;6181.289151747539;6197.25632924052;6732.350574109326;5932.317783454915;5948.345681974979;5949.494292985101;5968.820935371946;5974.2233509643465;12821.35893205336;12972.416241269166;13036.543720969816;13042.478300867953;13203.867961320457;2246.629306164481;2262.7737226277404;2317.8493397929083;2335.1943579465055;2932.501474749298;10453.320534165256;10465.79068418635;10483;12646.241225526497;14691.265436728228;1855.8144185581468;1881.9623607527774;1923.8749481283812;1977.2585280519804;1991.0144478483244;117054.41472792582;128583;130080;133557.33221333928;134470;11337.43312834355;11580;11688.006519445942;11714.1800073994;11814.409279535988;14286.642833929234;14649.414023439156;14664.486742963945;14690.26548672562;14705.117692938244;7505.924940750632;8432.156784321518;8584.914150858536;8789.077146899483;8829.11708829112;8638.913610863936;8675.175858293453;8699.826003479895;8836.64653413869;8854.734357969272;4544.727316361029;4556.1343344765055;4556.157110934488;4568.931466028012;4642.980303567959;1576.9842301577066;1780.6260685255982;1896.1656870976726;1932.2271091563487;1934.3616606519815;773.3581127664138;776.6155752902349;895.2703546609492;915.7069737683877;999.84018538495;18739.81260187408;21815.513959390875;21850.16856781998;21930.89977777143;22009.889950550143;894.3990257439241;905.4974489158449;919.544825311475;947.2280091725222;955.6320816485703;10685.946570267099;11298.717532061764;11418.314901105794;11440.141989350832;11450.942745286387;601717;602268;608608;621878;622982;96738.51630741802;120761;126983.36508317584;132007;132655;789.3842802613971;938.4088024544493;964.744342749172;968.1818863060703;975.9024097590326;18306.633867322846;18415.723764143815;18676.533086672942;18698.849632291916;18744;49623.263185788324;49746.756331092016;49811.00377992347;50732.49267507425;52176;70559;75853;76125.61937190278;77932.61033694795;78705.21294786979;6749.987501874758;7568.091828980558;8008.479448835807;8266.751997440086;8393.32853371741;12141;12370.62888113358;12573.74852502963;12941.158824676366;13006.414711338202;10605.787884242427;10665.573377064831;10722.51748671296;11174.161937854857;11384.43077846121;10687.412192329497;10779.838302425313;10803.300564254574;10890.945545272223;11177.66467005991;11125.44372781374;11218.214724969173;11271.832840567402;11451.885481145082;11574.421278935852;7858.878731333995;8044.678212871419;8362.372822038249;8366.790830229293;8474.237318641352;9630.229581633592;10721.35671859691;10745.086667633026;10932.726681832699;11233 09:43:22 INFO - PROCESS | 1926 | |3;mootools.html;1527.5035613425637;1533.5169421632186;1748.3793253395045;1890.6313268912568;1905.5426697592582;8586.313094952404;9113.544322783868;9127.178553930145;9128.954355228214;9202.171804537591;8059.91940080599;8287.91712082879;8304.95847520763;8717.782055448617;8915.286777057836;2399.496105817776;2431.3921519620094;2434.306222726523;2435;2448.816338774599;2397.3886658901956;2429.5505331513637;2453.2149712092137;2457.287386657876;2459.655648209252;2256.131389415079;2422.2612103308484;2428.9392765180924;2431.185552839801;2438.329459398662;2388.379021454417;2406.566817972764;2407.181558270188;2412.589859723851;2426.369144022567;2397.496525729599;2402.4954759500524;2405.4226985523524;2409.6987876515436;2416.4079800448826;8967.910320896774;9029;9107.089291070906;9120.498372589505;9137.451752894782;5268.0517506848755;5434.0218760623075;5446.91829622556;5456.317960254968;5459.262999495057;3447.172678557128;3619.529461170031;3665.7067434605433;3667.5965643779164;3671.045528162697;1062.3466568060664;1079.3416016230094;1099.8900109989017;1104.36499013067;1124.4602590756401;11857.762844743056;11882.940585297105;11891.108166887518;11895.94052029743;11899.881001189964;4566.383538222298;4703.6942598730975;4861.4895435978715;4876.049170411807;4889.633277504201;10208.43853588045;10215.387076775269;10220.642277520252;10220.897791022144;10236.744081398025;5440.6735595864375;5441.265429167091;5442.102053161263;5449.373322068013;5450.236966824647;4442.666799990014;4645.6980296280635;4671.883202919954;4940.851774446701;4986.127427700138;3953.683705303569;3990.8204130814183;4000.399940009022;4100.220958017967;4110.157417729359;1291.8837304642439;1291.9483220671068;1297.2864924291603;1304.62165971869;1312.08154291996;750.7034721285062;850.4217132350061;901.8917729872458;912.625823412411;922.5848368234322;5583.274174357308;5662.745176467069;5729.88540229193;5908.881822363614;6012.188354572077;932.6922115701802;936.9250459963187;938.2728385501155;948.2082461145021;988.1847475832467;3831.904202394907;3950.802459876995;3979.1245925896255;4007.599240075969;4096.487939007624;9906.950465247628;10925.672229833117;11114.888851111386;11123.110151187886;11126.276792008493;10862.293950893167;10869;10966.122710183326;11074.667759967213;11087.72280692989;7977.162397948132;8160;8390.119037501097;8420.915790842013;8504.192101750325;6001.969990150196;6024.728887199999;6026.397360263939;6228.844278893064;6252.781152659635;9843.0156984301;10221.897781022095;10227.94886025565;10388.48057597102;10395.94802025985;10315.329503582243;10646.89353106459;10663.733406664895;10665.626703065665;10676.57293708243;7110.43116550685;7351.522151060164;7353.485256032026;7673.232676732282;7820.765377038698;8319.126491718282;8443.240108390275;8616.00915894655;8718.17177368149;8729.039805621504;6582.76960306387;7587.886181707168;7698.307152356315;7761.0298712660915;7842.80392990157;7392.260773922565;7467.365273951775;7512;7532.7740167795055;7662.195469475625;7090.503664743418;7241.855162896607;7242.927570724225;7246.347828695232;7252.41980641558;4916.852494425173;4950.504949505021;5015.799368025384;5029.295898574275;5104.668196567211;4936.234883593049;4946.689127381175;5063.113955057776;5136.460671629425;5165.405978312392 09:43:22 INFO - PROCESS | 1926 | |4;prototype.html;298.60434923726064;304.21360782377553;305.6088207094919;317.26236500137173;319.4090931776213;5385.892282154359;5506.697131657757;5537.224788529604;5537.36320323163;5541.501264886159;5042.974785126078;5102.188723003327;5193.870153246171;5403.190750520883;5495.945040549604;3590.70734535567;4133.697885166178;4168.749875007494;4176.269152898246;4185.204811085891;3557.786532808027;3771.490848735427;3975.463312452811;4177.624013838754;4198.811053502584;3634.273145370936;3639.3267245559523;3873.573906870256;3925.41118832176;4058.9797051014702;3658.042947023356;4126.463559737245;4151.7924103794685;4154.462848745983;4182.707210495267;3006.9849650751826;3542.919409580077;3567.554055743032;3576.356255873942;3598.2008995502247;4484.977575112103;5046.62150338726;5383.703896285702;5407.702576358299;5407.972960135214;4071.9389209161886;4699.694519856233;4701.670883038189;4712.811487540494;4781.0676918001;5754.942450575482;5784.219130417424;5800;5855.590108692393;5892.528597712216;3824.8661296854757;3938.704597155196;3953.3279342511555;3955;3976.1848820991627;5302.549283310923;5577.430444515513;5850.970745146247;5985.832762611292;6147.661878596676;3374.7300215982664;3429.554157959499;3632.20091579852;3953.971967288468;3984.6015398460504;4049.0079930417237;4067.7559346439307;4069.918601627951;4086.3053280942313;4103.876883693494;3739.495168152265;4725.716457012591;4806.399200099988;4825.769428795635;4849.95150048495;5712.771489140471;5753;5791.725820319523;5807.506361959281;5809.651420914759;1341.557286095586;1376.593904798087;1402.3408997771032;1431.3272761801936;1431.8067060946846;762.268222506389;805.379857509726;869.8822013712349;895.7325384580876;906.243286855483;4081.97959010209;4118.835246590163;4259.977605374688;4464.955350446519;4488.977555112204;4191.601797829201;4352.934705979413;4812.470628230892;4968.590518231513;4977.628635346762;3647.854085836537;4067.6339129477897;4074.3277359235394;4322.227886566493;4521.864344069683;2188.321620297713;2434.805215582749;2443.765898221387;2563.269792889792;2609.973900261011;4302.913941721148;4735.313379559944;5061.772220250097;5064.20220821603;5115.514026167508;4055.904905675451;4713.74074425903;5060.418051924003;5127.41034781005;5147.242512965556;4734.668573199911;4809.615230781529;4878.268259761065;4884.242942343872;5050.696958182447;4651.395318608559;4904.705717656952;4918.827841025547;4953.281774142657;4963.833499127774;4560.95106917132;4866.80532778699;4884.9511504884495;4893.828715994923;4983.825566105169;5052.9494705052475;5055.848324550269;5069.9746501267255;5093.719845408538;5100.6429549931145;2998.160515055788;3028.5759993600473;3440.6559344065395;3536.5579302587175;3539.274448738054;4362.585554372329;4619.86140415788;4669.155683505064;4703.623710103115;5245.763940622757;5833.212516310244;5857.502112320501;5874.826314263579;5878.560397435017;5909.379515151019;5808.7095645218415;5848.56135789826;5868.77217530348;5889.733707252961;5919.970400147971;4389.714668546534;5637.746301416364;5714.971425142848;5715.828525144252;5723.627964182315;5093.8726531837;5794.797182098775;5820.796272130455;5831.585256218126;5844.415558444121;4809.951900480951;4958.553730164303;5682.374938756816;5684.602077854511;5718.485336319751 09:43:22 INFO - PROCESS | 1926 | |5;yui.html;704.383664293743;755.1391413788282;765.6914748723437;799.4963173200882;818.0592318833343;15096.622584435394;16356.754648680278;16441.588960276;16452.917735411334;16461.670766584662;14596.854031459683;14750.704985900276;14758;14781.408743650269;14805.703885922301;658.7266284491942;685.0648864300219;827.6896163938524;856.7815207122206;861.2636196052379;859.5014891363026;860.5912191708951;861.0657436681208;862.2412277196058;863.7754183912197;757.2843662738715;898.2364989758686;902.0979020979021;907.8910530736321;908.0193391137589;692.7263730826346;715.2132654080496;874.0516539554527;886.1360173830528;902.345799295512;674.0495900779925;675.8209074595236;676.9018492318636;677.8847595908658;678.2471456683078;14930.701385972328;15048.699026019418;15116.168610726405;15170.089794612359;15236.162011089385;13879.236641984688;14019.509317173952;14077.71844563103;14173.645658858508;14250.92874535631;12717.30054846983;12971.87028129716;13023.153495022889;13149.408276627575;13154.736905261936;4475.664325175625;4521.683482156251;4540.114677637862;4572.9314060289125;4628.143793398232;113388.433057835;116258.83741162565;116302;116497;116776.24835627472;10949.562017519369;11119.610813621484;11238.044766194802;11337.716557085974;11395.886041139649;21000.474988125112;21002.15991360359;21018.579628407348;21022;21054.894725526276;6041.395860414012;6704.463642908556;7462.626868656545;7961.761147165595;7971.40214483916;4195.748255104703;4365.759883206454;4421.586697584084;4452.910941781146;4606.608438282784;3286.8356582170795;3422.401079811073;3432.3650124727005;3433.2275238071234;3435.4159792835276;592.4253474130087;597.8014081766031;615.7136931326954;616.2666426951913;626.4706323156925;578.7887421091356;579.7217335678898;631.2771876201815;670.356457800517;677.2414895317178;9091.81816363669;9690.079442452956;9730.464824434583;9838.852417213748;9897;579.6753817862011;652.6345246661884;666.9155157397039;675.9526833121635;687.7558466744234;4285.271503844354;4741.359916411309;4752.477227504972;4786.138495070921;4798.73606951621;158418;159988;160657.39342606426;161559;166005;92000;137272.31363843317;141399;143131.2843435776;143599;116141.419292903;117758;120045.39977300058;122410;126397;8886.333524985523;9048.321375896703;9119.270458363182;9123.77190570241;9140.268778497837;54691;65225;65374.673126634065;66197.00704489533;68025;90427.09572904187;93650.53174734082;93770.12459750903;97189.54215686912;99407.50296248472;9852.852207216754;11644.941775291069;12080.154389192672;12172;12238.75522489563;10758.576899418591;12160.209586376857;12735.426905789447;13035.869641303465;13485.797713034508;10392.740181495523;11736.354500502553;12436.253824770543;12492.625221243377;12909.548165814527;10407.739806504595;12071.637850864488;12243.265404075784;12714.364281786058;12842.87157128454;11882.702932426759;11903.702407439538;12261.080418968791;12290.75418491643;12798.296093714562;9551.761205969906;9597.424154550748;10498.947505262426;10570.630027948984;10806.945965270123;10387.792244154924;10415.427151506437;10657.946710266398;10659.14726821868;10684 09:43:22 INFO - PROCESS | 1926 | __end_tp_report 09:43:22 INFO - PROCESS | 1926 | __start_cc_report 09:43:22 INFO - PROCESS | 1926 | _x_x_mozilla_cycle_collect,1077 09:43:22 INFO - PROCESS | 1926 | __end_cc_report 09:43:22 INFO - PROCESS | 1926 | __startTimestamp1475167402249__endTimestamp 09:43:22 INFO - PROCESS | 1926 | 09:43:22 INFO - PROCESS | 1926 | ------- Summary: start ------- 09:43:22 INFO - PROCESS | 1926 | Number of tests: 6 09:43:22 INFO - PROCESS | 1926 | 09:43:22 INFO - PROCESS | 1926 | [#0] dojo.html Cycles:165 Average:5818.69 Median:6097.82 stddev:658.61 (10.8%) stddev-sans-first:622.32 09:43:22 INFO - PROCESS | 1926 | Values: 2996.9 3313.3 3322.1 3330.0 3353.1 5723.0 5800.0 5812.9 5822.8 5871.1 5783.2 5852.1 5861.2 5868.4 5877.2 5239.6 5325.3 5334.1 5337.0 5366.2 5239.5 5245.3 5247.0 5410.8 5420.1 5247.3 5292.5 5305.7 5345.8 5346.3 5313.7 5322.4 5345.4 5383.1 5385.9 5129.7 5209.9 5297.3 5303.1 5325.6 5647.1 5658.7 5727.0 5763.3 5765.1 6230.1 6273.9 6299.3 6326.3 6329.6 6198.0 6248.8 6301.9 6314.1 6323.5 5806.2 5843.5 5894.9 5902.0 5907.2 6338.4 6355.1 6364.2 6386.3 6389.2 6125.3 6243.4 6247.0 6253.4 6257.4 6217.5 6254.7 6305.7 6306.7 6321.5 6198.3 6289.7 6293.0 6310.9 6312.8 6235.1 6306.3 6325.3 6333.7 6346.7 4910.5 4947.1 4964.0 4967.9 5032.6 4453.8 4454.6 4459.2 4494.0 4509.0 5795.5 5816.7 5817.4 5842.1 5859.0 6149.2 6261.2 6288.2 6288.6 6291.7 5740.2 5812.2 5812.7 5828.3 5918.1 5504.1 5505.6 5509.5 5517.3 5526.0 6421.5 6445.0 6447.5 6457.2 6457.5 6125.4 6207.9 6218.8 6262.3 6302.4 6295.7 6351.7 6359.9 6380.4 6387.5 6211.4 6243.2 6258.8 6258.9 6271.6 6033.8 6222.9 6233.2 6257.2 6264.9 6229.2 6249.0 6253.2 6262.5 6276.6 6217.7 6228.5 6235.6 6243.1 6243.7 5900.8 5985.4 6040.4 6089.9 6110.5 5074.5 6160.9 6219.3 6242.3 6261.9 6084.1 6097.8 6104.7 6114.1 6120.9 09:43:22 INFO - PROCESS | 1926 | 09:43:22 INFO - PROCESS | 1926 | [#1] ext.html Cycles:180 Average:72157.70 Median:38599.82 stddev:159404.77 (413.0%) stddev-sans-first:159761.11 09:43:22 INFO - PROCESS | 1926 | Values: 483.3 493.3 507.3 512.9 515.2 30755.2 40167.0 41499.8 41708.4 43778.8 42783.1 43361.6 43375.8 43389.0 43425.6 9697.1 9899.7 9906.6 9910.4 9916.6 8737.7 8941.2 8954.2 9019.0 9095.2 10091.4 11986.0 11986.3 12253.4 12281.3 11838.8 11866.9 11962.8 12060.9 12064.7 8635.9 8867.7 11891.9 11968.5 11981.8 39152.4 39713.6 39797.6 41877.4 41970.7 3284.8 3340.8 3370.2 3614.4 3976.0 29745.6 29874.9 30495.1 31250.7 32102.4 3141.8 3228.7 3275.4 3275.7 3375.7 499010.0 507187.0 510532.0 511487.0 511873.4 62155.0 62396.0 62549.0 62670.4 62695.1 65096.7 65307.0 65333.3 65398.0 65425.0 16829.0 17053.3 17059.0 17088.3 17089.7 13120.5 13183.4 13195.1 13202.5 13206.9 16108.8 16612.9 16617.8 17705.0 19233.7 7600.8 7778.2 7828.6 7907.5 7920.3 699.5 929.5 970.8 972.0 978.3 24647.0 28927.7 30038.0 30039.4 30690.5 1003.8 1007.7 1013.4 1038.9 1042.8 14848.0 15605.9 15659.4 15686.6 15911.0 672930.0 678553.0 679779.0 680302.0 680409.0 48490.8 49447.3 55939.7 56899.0 56924.7 1325.3 1343.9 1362.1 1371.9 1377.6 29340.9 30487.8 30774.0 30851.8 31583.5 42986.1 48987.5 49390.8 49462.8 49467.3 502527.0 608126.0 608166.0 608192.0 610304.0 26058.3 26368.6 26723.7 26780.3 26809.1 43593.6 43673.3 46958.3 47285.8 47938.0 37908.4 38918.6 38977.6 39252.0 40346.0 37917.0 38239.0 38412.8 38608.0 40352.8 37302.6 37613.8 38482.6 38591.6 38980.8 30824.1 32059.5 32879.7 34130.5 34325.0 21835.7 25730.2 25815.1 25863.4 26125.2 09:43:22 INFO - PROCESS | 1926 | 09:43:22 INFO - PROCESS | 1926 | [#2] jquery.html Cycles:180 Average:35056.24 Median:2326.52 stddev:102097.78 (4388.4%) stddev-sans-first:102350.93 09:43:22 INFO - PROCESS | 1926 | Values: 347.3 368.3 372.1 377.6 395.0 15024.3 15133.9 16102.0 21076.8 21119.0 20663.7 20689.2 21294.5 21424.9 21495.0 5799.4 5879.6 6010.8 6015.3 6073.2 6034.4 6149.0 6174.9 6176.1 6179.7 3288.5 4127.7 5854.6 6095.5 6135.2 6044.7 6177.8 6181.3 6197.3 6732.4 5932.3 5948.3 5949.5 5968.8 5974.2 12821.4 12972.4 13036.5 13042.5 13203.9 2246.6 2262.8 2317.8 2335.2 2932.5 10453.3 10465.8 10483.0 12646.2 14691.3 1855.8 1882.0 1923.9 1977.3 1991.0 117054.4 128583.0 130080.0 133557.3 134470.0 11337.4 11580.0 11688.0 11714.2 11814.4 14286.6 14649.4 14664.5 14690.3 14705.1 7505.9 8432.2 8584.9 8789.1 8829.1 8638.9 8675.2 8699.8 8836.6 8854.7 4544.7 4556.1 4556.2 4568.9 4643.0 1577.0 1780.6 1896.2 1932.2 1934.4 773.4 776.6 895.3 915.7 999.8 18739.8 21815.5 21850.2 21930.9 22009.9 894.4 905.5 919.5 947.2 955.6 10685.9 11298.7 11418.3 11440.1 11450.9 601717.0 602268.0 608608.0 621878.0 622982.0 96738.5 120761.0 126983.4 132007.0 132655.0 789.4 938.4 964.7 968.2 975.9 18306.6 18415.7 18676.5 18698.8 18744.0 49623.3 49746.8 49811.0 50732.5 52176.0 70559.0 75853.0 76125.6 77932.6 78705.2 6750.0 7568.1 8008.5 8266.8 8393.3 12141.0 12370.6 12573.7 12941.2 13006.4 10605.8 10665.6 10722.5 11174.2 11384.4 10687.4 10779.8 10803.3 10890.9 11177.7 11125.4 11218.2 11271.8 11451.9 11574.4 7858.9 8044.7 8362.4 8366.8 8474.2 9630.2 10721.4 10745.1 10932.7 11233.0 09:43:22 INFO - PROCESS | 1926 | 09:43:22 INFO - PROCESS | 1926 | [#3] mootools.html Cycles:180 Average:5826.96 Median:4903.24 stddev:3274.72 (66.8%) stddev-sans-first:3267.97 09:43:22 INFO - PROCESS | 1926 | Values: 1527.5 1533.5 1748.4 1890.6 1905.5 8586.3 9113.5 9127.2 9129.0 9202.2 8059.9 8287.9 8305.0 8717.8 8915.3 2399.5 2431.4 2434.3 2435.0 2448.8 2397.4 2429.6 2453.2 2457.3 2459.7 2256.1 2422.3 2428.9 2431.2 2438.3 2388.4 2406.6 2407.2 2412.6 2426.4 2397.5 2402.5 2405.4 2409.7 2416.4 8967.9 9029.0 9107.1 9120.5 9137.5 5268.1 5434.0 5446.9 5456.3 5459.3 3447.2 3619.5 3665.7 3667.6 3671.0 1062.3 1079.3 1099.9 1104.4 1124.5 11857.8 11882.9 11891.1 11895.9 11899.9 4566.4 4703.7 4861.5 4876.0 4889.6 10208.4 10215.4 10220.6 10220.9 10236.7 5440.7 5441.3 5442.1 5449.4 5450.2 4442.7 4645.7 4671.9 4940.9 4986.1 3953.7 3990.8 4000.4 4100.2 4110.2 1291.9 1291.9 1297.3 1304.6 1312.1 750.7 850.4 901.9 912.6 922.6 5583.3 5662.7 5729.9 5908.9 6012.2 932.7 936.9 938.3 948.2 988.2 3831.9 3950.8 3979.1 4007.6 4096.5 9907.0 10925.7 11114.9 11123.1 11126.3 10862.3 10869.0 10966.1 11074.7 11087.7 7977.2 8160.0 8390.1 8420.9 8504.2 6002.0 6024.7 6026.4 6228.8 6252.8 9843.0 10221.9 10227.9 10388.5 10395.9 10315.3 10646.9 10663.7 10665.6 10676.6 7110.4 7351.5 7353.5 7673.2 7820.8 8319.1 8443.2 8616.0 8718.2 8729.0 6582.8 7587.9 7698.3 7761.0 7842.8 7392.3 7467.4 7512.0 7532.8 7662.2 7090.5 7241.9 7242.9 7246.3 7252.4 4916.9 4950.5 5015.8 5029.3 5104.7 4936.2 4946.7 5063.1 5136.5 5165.4 09:43:22 INFO - PROCESS | 1926 | 09:43:22 INFO - PROCESS | 1926 | [#4] prototype.html Cycles:180 Average:4364.24 Median:4758.19 stddev:1357.12 (28.5%) stddev-sans-first:1326.17 09:43:22 INFO - PROCESS | 1926 | Values: 298.6 304.2 305.6 317.3 319.4 5385.9 5506.7 5537.2 5537.4 5541.5 5043.0 5102.2 5193.9 5403.2 5495.9 3590.7 4133.7 4168.7 4176.3 4185.2 3557.8 3771.5 3975.5 4177.6 4198.8 3634.3 3639.3 3873.6 3925.4 4059.0 3658.0 4126.5 4151.8 4154.5 4182.7 3007.0 3542.9 3567.6 3576.4 3598.2 4485.0 5046.6 5383.7 5407.7 5408.0 4071.9 4699.7 4701.7 4712.8 4781.1 5754.9 5784.2 5800.0 5855.6 5892.5 3824.9 3938.7 3953.3 3955.0 3976.2 5302.5 5577.4 5851.0 5985.8 6147.7 3374.7 3429.6 3632.2 3954.0 3984.6 4049.0 4067.8 4069.9 4086.3 4103.9 3739.5 4725.7 4806.4 4825.8 4850.0 5712.8 5753.0 5791.7 5807.5 5809.7 1341.6 1376.6 1402.3 1431.3 1431.8 762.3 805.4 869.9 895.7 906.2 4082.0 4118.8 4260.0 4465.0 4489.0 4191.6 4352.9 4812.5 4968.6 4977.6 3647.9 4067.6 4074.3 4322.2 4521.9 2188.3 2434.8 2443.8 2563.3 2610.0 4302.9 4735.3 5061.8 5064.2 5115.5 4055.9 4713.7 5060.4 5127.4 5147.2 4734.7 4809.6 4878.3 4884.2 5050.7 4651.4 4904.7 4918.8 4953.3 4963.8 4561.0 4866.8 4885.0 4893.8 4983.8 5052.9 5055.8 5070.0 5093.7 5100.6 2998.2 3028.6 3440.7 3536.6 3539.3 4362.6 4619.9 4669.2 4703.6 5245.8 5833.2 5857.5 5874.8 5878.6 5909.4 5808.7 5848.6 5868.8 5889.7 5920.0 4389.7 5637.7 5715.0 5715.8 5723.6 5093.9 5794.8 5820.8 5831.6 5844.4 4810.0 4958.6 5682.4 5684.6 5718.5 09:43:22 INFO - PROCESS | 1926 | 09:43:22 INFO - PROCESS | 1926 | [#5] yui.html Cycles:180 Average:25667.10 Median:3815.58 stddev:42274.43 (1107.9%) stddev-sans-first:42351.47 09:43:22 INFO - PROCESS | 1926 | Values: 704.4 755.1 765.7 799.5 818.1 15096.6 16356.8 16441.6 16452.9 16461.7 14596.9 14750.7 14758.0 14781.4 14805.7 658.7 685.1 827.7 856.8 861.3 859.5 860.6 861.1 862.2 863.8 757.3 898.2 902.1 907.9 908.0 692.7 715.2 874.1 886.1 902.3 674.0 675.8 676.9 677.9 678.2 14930.7 15048.7 15116.2 15170.1 15236.2 13879.2 14019.5 14077.7 14173.6 14250.9 12717.3 12971.9 13023.2 13149.4 13154.7 4475.7 4521.7 4540.1 4572.9 4628.1 113388.4 116258.8 116302.0 116497.0 116776.2 10949.6 11119.6 11238.0 11337.7 11395.9 21000.5 21002.2 21018.6 21022.0 21054.9 6041.4 6704.5 7462.6 7961.8 7971.4 4195.7 4365.8 4421.6 4452.9 4606.6 3286.8 3422.4 3432.4 3433.2 3435.4 592.4 597.8 615.7 616.3 626.5 578.8 579.7 631.3 670.4 677.2 9091.8 9690.1 9730.5 9838.9 9897.0 579.7 652.6 666.9 676.0 687.8 4285.3 4741.4 4752.5 4786.1 4798.7 158418.0 159988.0 160657.4 161559.0 166005.0 92000.0 137272.3 141399.0 143131.3 143599.0 116141.4 117758.0 120045.4 122410.0 126397.0 8886.3 9048.3 9119.3 9123.8 9140.3 54691.0 65225.0 65374.7 66197.0 68025.0 90427.1 93650.5 93770.1 97189.5 99407.5 9852.9 11644.9 12080.2 12172.0 12238.8 10758.6 12160.2 12735.4 13035.9 13485.8 10392.7 11736.4 12436.3 12492.6 12909.5 10407.7 12071.6 12243.3 12714.4 12842.9 11882.7 11903.7 12261.1 12290.8 12798.3 9551.8 9597.4 10498.9 10570.6 10806.9 10387.8 10415.4 10657.9 10659.1 10684.0 09:43:22 INFO - PROCESS | 1926 | -------- Summary: end -------- 09:43:22 INFO - PROCESS | 1926 | 09:43:22 INFO - TEST-INFO | 1926: exit 0 09:43:22 INFO - TEST-OK | dromaeo_css | took 1116816ms 09:43:22 INFO - TEST-START | kraken 09:43:22 INFO - operating with platform_type : mac_ 09:43:22 INFO - Initialising browser for kraken test... 09:43:22 INFO - TEST-INFO | started process 1930 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/tmpnh676n/profile http://localhost:57296/getInfo.html) 09:43:25 INFO - PROCESS | 1930 | __metrics Screen width/height:1600/1200 09:43:25 INFO - PROCESS | 1930 | colorDepth:24 09:43:25 INFO - PROCESS | 1930 | Browser inner width/height: 1024/689 09:43:25 INFO - PROCESS | 1930 | __metrics 09:43:25 INFO - PROCESS | 1930 | 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" 09:43:25 INFO - PROCESS | 1930 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:43:26 INFO - TEST-INFO | 1930: exit 0 09:43:26 INFO - Browser initialized. 09:43:26 INFO - Running cycle 1/1 for kraken test... 09:43:26 INFO - TEST-INFO | started process 1931 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/tmpnh676n/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:43:38 INFO - PROCESS | 1931 | RSS: Main: 219729920 09:43:38 INFO - PROCESS | 1931 | 09:43:41 INFO - PROCESS | 1931 | Cycle 1(1): loaded http://localhost:57296/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57296/tests/kraken/driver.html?testName=audio-beat-detection) 09:43:42 INFO - PROCESS | 1931 | RSS: Main: 269643776 09:43:42 INFO - PROCESS | 1931 | 09:43:44 INFO - PROCESS | 1931 | Cycle 1(1): loaded http://localhost:57296/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57296/tests/kraken/driver.html?testName=audio-dft) 09:43:45 INFO - PROCESS | 1931 | RSS: Main: 279388160 09:43:45 INFO - PROCESS | 1931 | 09:43:48 INFO - PROCESS | 1931 | Cycle 1(1): loaded http://localhost:57296/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57296/tests/kraken/driver.html?testName=audio-fft) 09:43:49 INFO - PROCESS | 1931 | RSS: Main: 376528896 09:43:49 INFO - PROCESS | 1931 | 09:43:51 INFO - PROCESS | 1931 | Cycle 1(1): loaded http://localhost:57296/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57296/tests/kraken/driver.html?testName=audio-oscillator) 09:43:51 INFO - PROCESS | 1931 | RSS: Main: 277946368 09:43:51 INFO - PROCESS | 1931 | 09:43:53 INFO - PROCESS | 1931 | Cycle 1(1): loaded http://localhost:57296/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57296/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:43:54 INFO - PROCESS | 1931 | RSS: Main: 278421504 09:43:54 INFO - PROCESS | 1931 | 09:43:57 INFO - PROCESS | 1931 | Cycle 1(1): loaded http://localhost:57296/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57296/tests/kraken/driver.html?testName=imaging-darkroom) 09:43:57 INFO - PROCESS | 1931 | RSS: Main: 318730240 09:43:57 INFO - PROCESS | 1931 | 09:44:00 INFO - PROCESS | 1931 | Cycle 1(1): loaded http://localhost:57296/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57296/tests/kraken/driver.html?testName=imaging-desaturate) 09:44:01 INFO - PROCESS | 1931 | RSS: Main: 319979520 09:44:01 INFO - PROCESS | 1931 | 09:44:04 INFO - PROCESS | 1931 | Cycle 1(1): loaded http://localhost:57296/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57296/tests/kraken/driver.html?testName=json-parse-financial) 09:44:04 INFO - PROCESS | 1931 | RSS: Main: 317616128 09:44:04 INFO - PROCESS | 1931 | 09:44:06 INFO - PROCESS | 1931 | Cycle 1(1): loaded http://localhost:57296/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57296/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:44:07 INFO - PROCESS | 1931 | RSS: Main: 288874496 09:44:07 INFO - PROCESS | 1931 | 09:44:09 INFO - PROCESS | 1931 | Cycle 1(1): loaded http://localhost:57296/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57296/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:44:09 INFO - PROCESS | 1931 | RSS: Main: 294248448 09:44:09 INFO - PROCESS | 1931 | 09:44:11 INFO - PROCESS | 1931 | Cycle 1(1): loaded http://localhost:57296/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57296/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:44:12 INFO - PROCESS | 1931 | RSS: Main: 296251392 09:44:12 INFO - PROCESS | 1931 | 09:44:15 INFO - PROCESS | 1931 | Cycle 1(1): loaded http://localhost:57296/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57296/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:44:16 INFO - PROCESS | 1931 | RSS: Main: 312541184 09:44:16 INFO - PROCESS | 1931 | 09:44:19 INFO - PROCESS | 1931 | Cycle 1(1): loaded http://localhost:57296/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57296/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:44:19 INFO - PROCESS | 1931 | RSS: Main: 308666368 09:44:19 INFO - PROCESS | 1931 | 09:44:21 INFO - PROCESS | 1931 | Cycle 1(1): loaded http://localhost:57296/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57296/tests/kraken/driver.html?testName=ai-astar) 09:44:21 INFO - PROCESS | 1931 | RSS: Main: 352419840 09:44:21 INFO - PROCESS | 1931 | 09:44:21 INFO - PROCESS | 1931 | __start_tp_report 09:44:21 INFO - PROCESS | 1931 | _x_x_mozilla_page_load 09:44:21 INFO - PROCESS | 1931 | _x_x_mozilla_page_load_details 09:44:21 INFO - PROCESS | 1931 | |i|pagename|runs| 09:44:21 INFO - PROCESS | 1931 | |0;ai-astar;114;113;112;111;113;121;168;99;157;170 09:44:21 INFO - PROCESS | 1931 | |1;audio-beat-detection;143;110;108;156;139;139;110;108;140;108 09:44:21 INFO - PROCESS | 1931 | |2;audio-dft;185;182;183;185;184;186;181;184;183;183 09:44:21 INFO - PROCESS | 1931 | |3;audio-fft;79;58;60;90;61;61;59;61;82;58 09:44:21 INFO - PROCESS | 1931 | |4;audio-oscillator;84;70;95;71;69;69;93;67;70;90 09:44:21 INFO - PROCESS | 1931 | |5;imaging-gaussian-blur;117;130;102;89;88;91;91;90;91;85 09:44:21 INFO - PROCESS | 1931 | |6;imaging-darkroom;94;94;95;94;94;93;94;95;94;93 09:44:21 INFO - PROCESS | 1931 | |7;imaging-desaturate;83;85;84;87;90;133;138;90;84;87 09:44:21 INFO - PROCESS | 1931 | |8;json-parse-financial;57;54;54;70;70;78;85;71;56;56 09:44:21 INFO - PROCESS | 1931 | |9;json-stringify-tinderbox;67;74;74;74;74;72;70;72;72;73 09:44:21 INFO - PROCESS | 1931 | |10;stanford-crypto-aes;83;83;86;85;101;97;102;85;89;83 09:44:21 INFO - PROCESS | 1931 | |11;stanford-crypto-ccm;137;134;137;136;139;138;141;142;185;151 09:44:21 INFO - PROCESS | 1931 | |12;stanford-crypto-pbkdf2;165;163;164;164;164;193;219;220;164;163 09:44:21 INFO - PROCESS | 1931 | |13;stanford-crypto-sha256-iterative;67;67;66;68;66;66;67;66;67;66 09:44:21 INFO - PROCESS | 1931 | __end_tp_report 09:44:21 INFO - PROCESS | 1931 | __start_cc_report 09:44:21 INFO - PROCESS | 1931 | _x_x_mozilla_cycle_collect,2017 09:44:21 INFO - PROCESS | 1931 | __end_cc_report 09:44:21 INFO - PROCESS | 1931 | __startTimestamp1475167461803__endTimestamp 09:44:21 INFO - PROCESS | 1931 | 09:44:21 INFO - PROCESS | 1931 | ------- Summary: start ------- 09:44:21 INFO - PROCESS | 1931 | Number of tests: 14 09:44:21 INFO - PROCESS | 1931 | 09:44:21 INFO - PROCESS | 1931 | [#0] ai-astar Cycles:10 Average:127.80 Median:139.00 stddev:26.43 (19.0%) stddev-sans-first:27.55 09:44:21 INFO - PROCESS | 1931 | Values: 114.0 113.0 112.0 111.0 113.0 121.0 168.0 99.0 157.0 170.0 09:44:21 INFO - PROCESS | 1931 | 09:44:21 INFO - PROCESS | 1931 | [#1] audio-beat-detection Cycles:10 Average:126.10 Median:139.00 stddev:18.88 (13.6%) stddev-sans-first:19.01 09:44:21 INFO - PROCESS | 1931 | Values: 143.0 110.0 108.0 156.0 139.0 139.0 110.0 108.0 140.0 108.0 09:44:21 INFO - PROCESS | 1931 | 09:44:21 INFO - PROCESS | 1931 | [#2] audio-dft Cycles:10 Average:183.60 Median:184.00 stddev:1.51 (0.8%) stddev-sans-first:1.51 09:44:21 INFO - PROCESS | 1931 | Values: 185.0 182.0 183.0 185.0 184.0 186.0 181.0 184.0 183.0 183.0 09:44:21 INFO - PROCESS | 1931 | 09:44:21 INFO - PROCESS | 1931 | [#3] audio-fft Cycles:10 Average:66.90 Median:61.00 stddev:11.93 (19.6%) stddev-sans-first:11.82 09:44:21 INFO - PROCESS | 1931 | Values: 79.0 58.0 60.0 90.0 61.0 61.0 59.0 61.0 82.0 58.0 09:44:21 INFO - PROCESS | 1931 | 09:44:21 INFO - PROCESS | 1931 | [#4] audio-oscillator Cycles:10 Average:77.80 Median:77.50 stddev:11.32 (14.6%) stddev-sans-first:11.78 09:44:21 INFO - PROCESS | 1931 | Values: 84.0 70.0 95.0 71.0 69.0 69.0 93.0 67.0 70.0 90.0 09:44:21 INFO - PROCESS | 1931 | 09:44:21 INFO - PROCESS | 1931 | [#5] imaging-gaussian-blur Cycles:10 Average:97.40 Median:89.50 stddev:14.75 (16.5%) stddev-sans-first:13.84 09:44:21 INFO - PROCESS | 1931 | Values: 117.0 130.0 102.0 89.0 88.0 91.0 91.0 90.0 91.0 85.0 09:44:21 INFO - PROCESS | 1931 | 09:44:21 INFO - PROCESS | 1931 | [#6] imaging-darkroom Cycles:10 Average:94.00 Median:94.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 09:44:21 INFO - PROCESS | 1931 | Values: 94.0 94.0 95.0 94.0 94.0 93.0 94.0 95.0 94.0 93.0 09:44:21 INFO - PROCESS | 1931 | 09:44:21 INFO - PROCESS | 1931 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:86.00 stddev:20.94 (24.3%) stddev-sans-first:21.66 09:44:21 INFO - PROCESS | 1931 | Values: 83.0 85.0 84.0 87.0 90.0 133.0 138.0 90.0 84.0 87.0 09:44:21 INFO - PROCESS | 1931 | 09:44:21 INFO - PROCESS | 1931 | [#8] json-parse-financial Cycles:10 Average:65.10 Median:70.00 stddev:11.17 (16.0%) stddev-sans-first:11.46 09:44:21 INFO - PROCESS | 1931 | Values: 57.0 54.0 54.0 70.0 70.0 78.0 85.0 71.0 56.0 56.0 09:44:21 INFO - PROCESS | 1931 | 09:44:21 INFO - PROCESS | 1931 | [#9] json-stringify-tinderbox Cycles:10 Average:72.20 Median:73.50 stddev:2.25 (3.1%) stddev-sans-first:1.39 09:44:21 INFO - PROCESS | 1931 | Values: 67.0 74.0 74.0 74.0 74.0 72.0 70.0 72.0 72.0 73.0 09:44:21 INFO - PROCESS | 1931 | 09:44:21 INFO - PROCESS | 1931 | [#10] stanford-crypto-aes Cycles:10 Average:89.40 Median:85.00 stddev:7.63 (9.0%) stddev-sans-first:7.74 09:44:21 INFO - PROCESS | 1931 | Values: 83.0 83.0 86.0 85.0 101.0 97.0 102.0 85.0 89.0 83.0 09:44:21 INFO - PROCESS | 1931 | 09:44:21 INFO - PROCESS | 1931 | [#11] stanford-crypto-ccm Cycles:10 Average:144.00 Median:140.00 stddev:15.15 (10.8%) stddev-sans-first:15.86 09:44:21 INFO - PROCESS | 1931 | Values: 137.0 134.0 137.0 136.0 139.0 138.0 141.0 142.0 185.0 151.0 09:44:21 INFO - PROCESS | 1931 | 09:44:21 INFO - PROCESS | 1931 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.90 Median:164.50 stddev:23.74 (14.4%) stddev-sans-first:24.72 09:44:21 INFO - PROCESS | 1931 | Values: 165.0 163.0 164.0 164.0 164.0 193.0 219.0 220.0 164.0 163.0 09:44:21 INFO - PROCESS | 1931 | 09:44:21 INFO - PROCESS | 1931 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.60 Median:67.00 stddev:0.70 (1.0%) stddev-sans-first:0.73 09:44:21 INFO - PROCESS | 1931 | Values: 67.0 67.0 66.0 68.0 66.0 66.0 67.0 66.0 67.0 66.0 09:44:21 INFO - PROCESS | 1931 | -------- Summary: end -------- 09:44:21 INFO - PROCESS | 1931 | 09:44:22 INFO - TEST-INFO | 1931: exit 0 09:44:22 INFO - TEST-OK | kraken | took 59892ms 09:44:22 INFO - SUITE-END | took 1176s 09:44:22 INFO - Completed test suite (00:19:36) 09:44:22 INFO - javascript benchmark 09:44:23 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2996.8651410686516, 3313.2710803623195, 3322.1030321813096, 3330.0, 3353.128186671466, 5722.971385143073, 5799.971000144993, 5812.883742325151, 5822.796202132926, 5871.060630299153, 5783.2481777368985, 5852.063669812831, 5861.15013323069, 5868.442497962697, 5877.235959325292, 5239.633225674204, 5325.254464374991, 5334.146536554133, 5336.9733151334185, 5366.221897824813, 5239.502247286502, 5245.344331958505, 5246.95060987802, 5410.810621628244, 5420.051490989081, 5247.344081989751, 5292.523672869441, 5305.708186049766, 5345.839624811242, 5346.304980352549, 5313.73431328434, 5322.4411436799355, 5345.385280692732, 5383.057964856173, 5385.865353366158, 5129.7435128243815, 5209.895802083975, 5297.311349524537, 5303.124984377573, 5325.573954083664, 5647.124695672136, 5658.688772117532, 5726.971365143189, 5763.337216220147, 5765.1352297155345, 6230.127782110508, 6273.8592528930685, 6299.338569450188, 6326.335734747831, 6329.556931014831, 6198.008318669036, 6248.843778905518, 6301.87396252077, 6314.052892066181, 6323.462505687022, 5806.216160818278, 5843.53251739864, 5894.911576326359, 5902.0, 5907.202527658797, 6338.429541341301, 6355.110284560165, 6364.204474440695, 6386.2975072741965, 6389.201349831271, 6125.295591007091, 6243.43809057178, 6246.968765156145, 6253.437190652863, 6257.374262573706, 6217.533684973645, 6254.655993920287, 6305.716242769086, 6306.684665766693, 6321.494280457552, 6198.349173336825, 6289.7484100635465, 6292.968535157295, 6310.9368906311265, 6312.810615681537, 6235.127082208494, 6306.306306306303, 6325.304216536178, 6333.714982825784, 6346.746130154742, 4910.48439913811, 4947.084789313988, 4964.032013757283, 4967.850964471072, 5032.622553308516, 4453.755043472575, 4454.554544545519, 4459.175052615276, 4493.977530112394, 4508.954910450919, 5795.478406943395, 5816.651000939873, 5817.360090390053, 5842.123681447817, 5858.970705146447, 6149.200603921461, 6261.24865016201, 6288.213973253343, 6288.5598008138995, 6291.653959032205, 5740.167675687002, 5812.215350927655, 5812.651240925558, 5828.329742079631, 5918.082697181943, 5504.119340905436, 5505.559555235572, 5509.5041446270025, 5517.310336207974, 5526.0, 6421.486281097501, 6445.0332450132855, 6447.516436267392, 6457.192850893638, 6457.515686323451, 6125.357545073132, 6207.906881396873, 6218.844528886814, 6262.311145774052, 6302.401271879165, 6295.653739044214, 6351.682415879095, 6359.87280254383, 6380.393862583047, 6387.5209359297305, 6211.409916057967, 6243.188385509855, 6258.843528911813, 6258.906116408349, 6271.560990730787, 6033.818985430444, 6222.875542489215, 6233.158523599256, 6257.1552840367785, 6264.906026409516, 6229.159063526366, 6249.0, 6253.187085678833, 6262.4990000800735, 6276.560640755103, 6217.658028808459, 6228.532860035425, 6235.594686345555, 6243.063540468785, 6243.656598887105, 5900.763969441175, 5985.431384018511, 6040.426159514839, 6089.878202436015, 6110.51115910735, 5074.543291103819, 6160.9383906160365, 6219.346968568235, 6242.250929888442, 6261.906071408841, 6084.11780291864, 6097.817065488042, 6104.694765261808, 6114.0828875669, 6120.873812997581], "value": 5774.188550633007, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [483.3185208855514, 493.33153576903294, 507.30499216073963, 512.9076766182086, 515.2014377714542, 30755.23111922203, 40167.0, 41499.75500734983, 41708.37437438437, 43778.78110609442, 42783.14433711324, 43361.56638433615, 43375.78312108443, 43389.0, 43425.565744342544, 9697.127258546712, 9899.703008909708, 9906.603735850558, 9910.355826871266, 9916.603335866594, 8737.650493980233, 8941.239994600466, 8954.19412252897, 9018.962819275768, 9095.181433670969, 10091.444970526618, 11986.041116710685, 11986.280823150595, 12253.387330633477, 12281.324527151002, 11838.816118388178, 11866.94066529666, 11962.820557691599, 12060.879391206063, 12064.698382540419, 8635.913640863573, 8867.68963086289, 11891.94054029733, 11968.521259149624, 11981.760364792743, 39152.43390264386, 39713.60286397128, 39797.60708375222, 41877.371839422434, 41970.740877773715, 3284.786488878215, 3340.766146369755, 3370.1574606348413, 3614.4036234021355, 3975.980120099381, 29745.553816692765, 29874.85062574695, 30495.08514744561, 31250.687493125006, 32102.357952841045, 3141.7957832741026, 3228.668434487369, 3275.42680030996, 3275.672432756729, 3375.746818988586, 499010.0, 507187.0, 510532.0, 511487.0, 511873.4406327982, 62155.0, 62396.0, 62549.0, 62670.37329626645, 62695.059574106424, 65096.67451662806, 65307.0, 65333.346666533675, 65398.0, 65425.018624720666, 16829.0, 17053.317867285168, 17059.0, 17088.316467341167, 17089.658206836044, 13120.475180992653, 13183.406746696422, 13195.142315749446, 13202.537911173064, 13206.943444524415, 16108.838911610968, 16612.920160189547, 16617.833821661872, 17704.965013254412, 19233.711494327596, 7600.783874580041, 7778.222177782177, 7828.647710853025, 7907.48601340911, 7920.32677222431, 699.4509310191476, 929.5259417697023, 970.8446648536342, 971.9514024298757, 978.3054031637474, 24647.0, 28927.710722892924, 30038.0, 30039.399212015636, 30690.53964190539, 1003.8393856982848, 1007.7077647482295, 1013.4071568132725, 1038.89611038897, 1042.7653777900064, 14848.0, 15605.921970390076, 15659.373625055097, 15686.607834803994, 15911.0, 672930.0, 678553.0, 679779.0, 680302.0, 680409.0, 48490.757546212044, 49447.25829112566, 55939.72030139823, 56899.0, 56924.71537642285, 1325.3439547423893, 1343.8521762606106, 1362.1486570893192, 1371.945122195121, 1377.6142680049602, 29340.853295733385, 30487.84756076294, 30774.0, 30851.845740771154, 31583.526247106773, 42986.14027719491, 48987.5101248983, 49390.75304623454, 49462.75268623634, 49467.25799113088, 502527.0, 608126.0, 608166.0, 608192.0, 610304.0, 26058.34854128662, 26368.604470933336, 26723.732762672902, 26780.330491737863, 26809.061682841006, 43593.64063593615, 43673.34489982589, 46958.29562556496, 47285.81785455391, 47938.0, 37908.43137352887, 38918.6108138915, 38977.6102238974, 39252.01869953274, 40346.0, 37917.0, 38239.0, 38412.80793596014, 38608.03479913025, 40352.78941631756, 37302.56681873377, 37613.81193094017, 38482.6151738479, 38591.614083859924, 38980.80509597434, 30824.075277741704, 32059.519107212946, 32879.67120328766, 34130.477137276575, 34325.0, 21835.70185830495, 25730.228093157235, 25815.12369892465, 25863.353416164748, 26125.216243512725], "value": 20236.576326670158, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [347.3019231344996, 368.27817477743605, 372.093951228758, 377.6469001483613, 394.9644531992122, 15024.323905424255, 15133.92433037836, 16102.0, 21076.789232107676, 21119.049642766073, 20663.690044649342, 20689.172433102696, 21294.467638309052, 21424.8928755356, 21495.0, 5799.420057994188, 5879.559033072515, 6010.789622363218, 6015.3383127855905, 6073.180120683717, 6034.426729460694, 6149.046897730859, 6174.938250617503, 6176.073588961669, 6179.721912513947, 3288.4574045282498, 4127.711060225785, 5854.560907931901, 6095.542834287424, 6135.171751813515, 6044.69776511177, 6177.7837775677635, 6181.289151747539, 6197.25632924052, 6732.350574109326, 5932.317783454915, 5948.345681974979, 5949.494292985101, 5968.820935371946, 5974.2233509643465, 12821.35893205336, 12972.416241269166, 13036.543720969816, 13042.478300867953, 13203.867961320457, 2246.629306164481, 2262.7737226277404, 2317.8493397929083, 2335.1943579465055, 2932.501474749298, 10453.320534165256, 10465.79068418635, 10483.0, 12646.241225526497, 14691.265436728228, 1855.8144185581468, 1881.9623607527774, 1923.8749481283812, 1977.2585280519804, 1991.0144478483244, 117054.41472792582, 128583.0, 130080.0, 133557.33221333928, 134470.0, 11337.43312834355, 11580.0, 11688.006519445942, 11714.1800073994, 11814.409279535988, 14286.642833929234, 14649.414023439156, 14664.486742963945, 14690.26548672562, 14705.117692938244, 7505.924940750632, 8432.156784321518, 8584.914150858536, 8789.077146899483, 8829.11708829112, 8638.913610863936, 8675.175858293453, 8699.826003479895, 8836.64653413869, 8854.734357969272, 4544.727316361029, 4556.1343344765055, 4556.157110934488, 4568.931466028012, 4642.980303567959, 1576.9842301577066, 1780.6260685255982, 1896.1656870976726, 1932.2271091563487, 1934.3616606519815, 773.3581127664138, 776.6155752902349, 895.2703546609492, 915.7069737683877, 999.84018538495, 18739.81260187408, 21815.513959390875, 21850.16856781998, 21930.89977777143, 22009.889950550143, 894.3990257439241, 905.4974489158449, 919.544825311475, 947.2280091725222, 955.6320816485703, 10685.946570267099, 11298.717532061764, 11418.314901105794, 11440.141989350832, 11450.942745286387, 601717.0, 602268.0, 608608.0, 621878.0, 622982.0, 96738.51630741802, 120761.0, 126983.36508317584, 132007.0, 132655.0, 789.3842802613971, 938.4088024544493, 964.744342749172, 968.1818863060703, 975.9024097590326, 18306.633867322846, 18415.723764143815, 18676.533086672942, 18698.849632291916, 18744.0, 49623.263185788324, 49746.756331092016, 49811.00377992347, 50732.49267507425, 52176.0, 70559.0, 75853.0, 76125.61937190278, 77932.61033694795, 78705.21294786979, 6749.987501874758, 7568.091828980558, 8008.479448835807, 8266.751997440086, 8393.32853371741, 12141.0, 12370.62888113358, 12573.74852502963, 12941.158824676366, 13006.414711338202, 10605.787884242427, 10665.573377064831, 10722.51748671296, 11174.161937854857, 11384.43077846121, 10687.412192329497, 10779.838302425313, 10803.300564254574, 10890.945545272223, 11177.66467005991, 11125.44372781374, 11218.214724969173, 11271.832840567402, 11451.885481145082, 11574.421278935852, 7858.878731333995, 8044.678212871419, 8362.372822038249, 8366.790830229293, 8474.237318641352, 9630.229581633592, 10721.35671859691, 10745.086667633026, 10932.726681832699, 11233.0], "value": 9385.654685470701, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1527.5035613425637, 1533.5169421632186, 1748.3793253395045, 1890.6313268912568, 1905.5426697592582, 8586.313094952404, 9113.544322783868, 9127.178553930145, 9128.954355228214, 9202.171804537591, 8059.91940080599, 8287.91712082879, 8304.95847520763, 8717.782055448617, 8915.286777057836, 2399.496105817776, 2431.3921519620094, 2434.306222726523, 2435.0, 2448.816338774599, 2397.3886658901956, 2429.5505331513637, 2453.2149712092137, 2457.287386657876, 2459.655648209252, 2256.131389415079, 2422.2612103308484, 2428.9392765180924, 2431.185552839801, 2438.329459398662, 2388.379021454417, 2406.566817972764, 2407.181558270188, 2412.589859723851, 2426.369144022567, 2397.496525729599, 2402.4954759500524, 2405.4226985523524, 2409.6987876515436, 2416.4079800448826, 8967.910320896774, 9029.0, 9107.089291070906, 9120.498372589505, 9137.451752894782, 5268.0517506848755, 5434.0218760623075, 5446.91829622556, 5456.317960254968, 5459.262999495057, 3447.172678557128, 3619.529461170031, 3665.7067434605433, 3667.5965643779164, 3671.045528162697, 1062.3466568060664, 1079.3416016230094, 1099.8900109989017, 1104.36499013067, 1124.4602590756401, 11857.762844743056, 11882.940585297105, 11891.108166887518, 11895.94052029743, 11899.881001189964, 4566.383538222298, 4703.6942598730975, 4861.4895435978715, 4876.049170411807, 4889.633277504201, 10208.43853588045, 10215.387076775269, 10220.642277520252, 10220.897791022144, 10236.744081398025, 5440.6735595864375, 5441.265429167091, 5442.102053161263, 5449.373322068013, 5450.236966824647, 4442.666799990014, 4645.6980296280635, 4671.883202919954, 4940.851774446701, 4986.127427700138, 3953.683705303569, 3990.8204130814183, 4000.399940009022, 4100.220958017967, 4110.157417729359, 1291.8837304642439, 1291.9483220671068, 1297.2864924291603, 1304.62165971869, 1312.08154291996, 750.7034721285062, 850.4217132350061, 901.8917729872458, 912.625823412411, 922.5848368234322, 5583.274174357308, 5662.745176467069, 5729.88540229193, 5908.881822363614, 6012.188354572077, 932.6922115701802, 936.9250459963187, 938.2728385501155, 948.2082461145021, 988.1847475832467, 3831.904202394907, 3950.802459876995, 3979.1245925896255, 4007.599240075969, 4096.487939007624, 9906.950465247628, 10925.672229833117, 11114.888851111386, 11123.110151187886, 11126.276792008493, 10862.293950893167, 10869.0, 10966.122710183326, 11074.667759967213, 11087.72280692989, 7977.162397948132, 8160.0, 8390.119037501097, 8420.915790842013, 8504.192101750325, 6001.969990150196, 6024.728887199999, 6026.397360263939, 6228.844278893064, 6252.781152659635, 9843.0156984301, 10221.897781022095, 10227.94886025565, 10388.48057597102, 10395.94802025985, 10315.329503582243, 10646.89353106459, 10663.733406664895, 10665.626703065665, 10676.57293708243, 7110.43116550685, 7351.522151060164, 7353.485256032026, 7673.232676732282, 7820.765377038698, 8319.126491718282, 8443.240108390275, 8616.00915894655, 8718.17177368149, 8729.039805621504, 6582.76960306387, 7587.886181707168, 7698.307152356315, 7761.0298712660915, 7842.80392990157, 7392.260773922565, 7467.365273951775, 7512.0, 7532.7740167795055, 7662.195469475625, 7090.503664743418, 7241.855162896607, 7242.927570724225, 7246.347828695232, 7252.41980641558, 4916.852494425173, 4950.504949505021, 5015.799368025384, 5029.295898574275, 5104.668196567211, 4936.234883593049, 4946.689127381175, 5063.113955057776, 5136.460671629425, 5165.405978312392], "value": 4679.022778749397, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [298.60434923726064, 304.21360782377553, 305.6088207094919, 317.26236500137173, 319.4090931776213, 5385.892282154359, 5506.697131657757, 5537.224788529604, 5537.36320323163, 5541.501264886159, 5042.974785126078, 5102.188723003327, 5193.870153246171, 5403.190750520883, 5495.945040549604, 3590.70734535567, 4133.697885166178, 4168.749875007494, 4176.269152898246, 4185.204811085891, 3557.786532808027, 3771.490848735427, 3975.463312452811, 4177.624013838754, 4198.811053502584, 3634.273145370936, 3639.3267245559523, 3873.573906870256, 3925.41118832176, 4058.9797051014702, 3658.042947023356, 4126.463559737245, 4151.7924103794685, 4154.462848745983, 4182.707210495267, 3006.9849650751826, 3542.919409580077, 3567.554055743032, 3576.356255873942, 3598.2008995502247, 4484.977575112103, 5046.62150338726, 5383.703896285702, 5407.702576358299, 5407.972960135214, 4071.9389209161886, 4699.694519856233, 4701.670883038189, 4712.811487540494, 4781.0676918001, 5754.942450575482, 5784.219130417424, 5800.0, 5855.590108692393, 5892.528597712216, 3824.8661296854757, 3938.704597155196, 3953.3279342511555, 3955.0, 3976.1848820991627, 5302.549283310923, 5577.430444515513, 5850.970745146247, 5985.832762611292, 6147.661878596676, 3374.7300215982664, 3429.554157959499, 3632.20091579852, 3953.971967288468, 3984.6015398460504, 4049.0079930417237, 4067.7559346439307, 4069.918601627951, 4086.3053280942313, 4103.876883693494, 3739.495168152265, 4725.716457012591, 4806.399200099988, 4825.769428795635, 4849.95150048495, 5712.771489140471, 5753.0, 5791.725820319523, 5807.506361959281, 5809.651420914759, 1341.557286095586, 1376.593904798087, 1402.3408997771032, 1431.3272761801936, 1431.8067060946846, 762.268222506389, 805.379857509726, 869.8822013712349, 895.7325384580876, 906.243286855483, 4081.97959010209, 4118.835246590163, 4259.977605374688, 4464.955350446519, 4488.977555112204, 4191.601797829201, 4352.934705979413, 4812.470628230892, 4968.590518231513, 4977.628635346762, 3647.854085836537, 4067.6339129477897, 4074.3277359235394, 4322.227886566493, 4521.864344069683, 2188.321620297713, 2434.805215582749, 2443.765898221387, 2563.269792889792, 2609.973900261011, 4302.913941721148, 4735.313379559944, 5061.772220250097, 5064.20220821603, 5115.514026167508, 4055.904905675451, 4713.74074425903, 5060.418051924003, 5127.41034781005, 5147.242512965556, 4734.668573199911, 4809.615230781529, 4878.268259761065, 4884.242942343872, 5050.696958182447, 4651.395318608559, 4904.705717656952, 4918.827841025547, 4953.281774142657, 4963.833499127774, 4560.95106917132, 4866.80532778699, 4884.9511504884495, 4893.828715994923, 4983.825566105169, 5052.9494705052475, 5055.848324550269, 5069.9746501267255, 5093.719845408538, 5100.6429549931145, 2998.160515055788, 3028.5759993600473, 3440.6559344065395, 3536.5579302587175, 3539.274448738054, 4362.585554372329, 4619.86140415788, 4669.155683505064, 4703.623710103115, 5245.763940622757, 5833.212516310244, 5857.502112320501, 5874.826314263579, 5878.560397435017, 5909.379515151019, 5808.7095645218415, 5848.56135789826, 5868.77217530348, 5889.733707252961, 5919.970400147971, 4389.714668546534, 5637.746301416364, 5714.971425142848, 5715.828525144252, 5723.627964182315, 5093.8726531837, 5794.797182098775, 5820.796272130455, 5831.585256218126, 5844.415558444121, 4809.951900480951, 4958.553730164303, 5682.374938756816, 5684.602077854511, 5718.485336319751], "value": 3940.7066311915855, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [704.383664293743, 755.1391413788282, 765.6914748723437, 799.4963173200882, 818.0592318833343, 15096.622584435394, 16356.754648680278, 16441.588960276, 16452.917735411334, 16461.670766584662, 14596.854031459683, 14750.704985900276, 14758.0, 14781.408743650269, 14805.703885922301, 658.7266284491942, 685.0648864300219, 827.6896163938524, 856.7815207122206, 861.2636196052379, 859.5014891363026, 860.5912191708951, 861.0657436681208, 862.2412277196058, 863.7754183912197, 757.2843662738715, 898.2364989758686, 902.0979020979021, 907.8910530736321, 908.0193391137589, 692.7263730826346, 715.2132654080496, 874.0516539554527, 886.1360173830528, 902.345799295512, 674.0495900779925, 675.8209074595236, 676.9018492318636, 677.8847595908658, 678.2471456683078, 14930.701385972328, 15048.699026019418, 15116.168610726405, 15170.089794612359, 15236.162011089385, 13879.236641984688, 14019.509317173952, 14077.71844563103, 14173.645658858508, 14250.92874535631, 12717.30054846983, 12971.87028129716, 13023.153495022889, 13149.408276627575, 13154.736905261936, 4475.664325175625, 4521.683482156251, 4540.114677637862, 4572.9314060289125, 4628.143793398232, 113388.433057835, 116258.83741162565, 116302.0, 116497.0, 116776.24835627472, 10949.562017519369, 11119.610813621484, 11238.044766194802, 11337.716557085974, 11395.886041139649, 21000.474988125112, 21002.15991360359, 21018.579628407348, 21022.0, 21054.894725526276, 6041.395860414012, 6704.463642908556, 7462.626868656545, 7961.761147165595, 7971.40214483916, 4195.748255104703, 4365.759883206454, 4421.586697584084, 4452.910941781146, 4606.608438282784, 3286.8356582170795, 3422.401079811073, 3432.3650124727005, 3433.2275238071234, 3435.4159792835276, 592.4253474130087, 597.8014081766031, 615.7136931326954, 616.2666426951913, 626.4706323156925, 578.7887421091356, 579.7217335678898, 631.2771876201815, 670.356457800517, 677.2414895317178, 9091.81816363669, 9690.079442452956, 9730.464824434583, 9838.852417213748, 9897.0, 579.6753817862011, 652.6345246661884, 666.9155157397039, 675.9526833121635, 687.7558466744234, 4285.271503844354, 4741.359916411309, 4752.477227504972, 4786.138495070921, 4798.73606951621, 158418.0, 159988.0, 160657.39342606426, 161559.0, 166005.0, 92000.0, 137272.31363843317, 141399.0, 143131.2843435776, 143599.0, 116141.419292903, 117758.0, 120045.39977300058, 122410.0, 126397.0, 8886.333524985523, 9048.321375896703, 9119.270458363182, 9123.77190570241, 9140.268778497837, 54691.0, 65225.0, 65374.673126634065, 66197.00704489533, 68025.0, 90427.09572904187, 93650.53174734082, 93770.12459750903, 97189.54215686912, 99407.50296248472, 9852.852207216754, 11644.941775291069, 12080.154389192672, 12172.0, 12238.75522489563, 10758.576899418591, 12160.209586376857, 12735.426905789447, 13035.869641303465, 13485.797713034508, 10392.740181495523, 11736.354500502553, 12436.253824770543, 12492.625221243377, 12909.548165814527, 10407.739806504595, 12071.637850864488, 12243.265404075784, 12714.364281786058, 12842.87157128454, 11882.702932426759, 11903.702407439538, 12261.080418968791, 12290.75418491643, 12798.296093714562, 9551.761205969906, 9597.424154550748, 10498.947505262426, 10570.630027948984, 10806.945965270123, 10387.792244154924, 10415.427151506437, 10657.946710266398, 10659.14726821868, 10684.0], "value": 7735.133146343178, "unit": "score"}], "name": "dromaeo_css", "value": 7340.451796673775, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 112.0, 111.0, 113.0, 121.0, 168.0, 99.0, 157.0, 170.0], "value": 127.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 110.0, 108.0, 156.0, 139.0, 139.0, 110.0, 108.0, 140.0, 108.0], "value": 126.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 182.0, 183.0, 185.0, 184.0, 186.0, 181.0, 184.0, 183.0, 183.0], "value": 183.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 58.0, 60.0, 90.0, 61.0, 61.0, 59.0, 61.0, 82.0, 58.0], "value": 66.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 70.0, 95.0, 71.0, 69.0, 69.0, 93.0, 67.0, 70.0, 90.0], "value": 77.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 130.0, 102.0, 89.0, 88.0, 91.0, 91.0, 90.0, 91.0, 85.0], "value": 97.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 94.0, 94.0, 93.0, 94.0, 95.0, 94.0, 93.0], "value": 94.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 85.0, 84.0, 87.0, 90.0, 133.0, 138.0, 90.0, 84.0, 87.0], "value": 96.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 54.0, 54.0, 70.0, 70.0, 78.0, 85.0, 71.0, 56.0, 56.0], "value": 65.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 74.0, 74.0, 74.0, 74.0, 72.0, 70.0, 72.0, 72.0, 73.0], "value": 72.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 86.0, 85.0, 101.0, 97.0, 102.0, 85.0, 89.0, 83.0], "value": 89.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 134.0, 137.0, 136.0, 139.0, 138.0, 141.0, 142.0, 185.0, 151.0], "value": 144.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 163.0, 164.0, 164.0, 164.0, 193.0, 219.0, 220.0, 164.0, 163.0], "value": 177.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 66.0, 68.0, 66.0, 66.0, 67.0, 66.0, 67.0, 66.0], "value": 66.6, "unit": "score"}], "name": "kraken", "value": 1484.9, "alertThreshold": 2.0}]} 09:44:23 INFO - Return code: 0 09:44:23 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:44:23 INFO - # TBPL SUCCESS # 09:44:23 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:44:23 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:44:23 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:44:23 INFO - 2016-09-29 09:44:23.114 screenresolution[1935:20764] starting screenresolution argv=screenresolution get 09:44:23 INFO - 2016-09-29 09:44:23.118 screenresolution[1935:20764] Display 0: 1600x1200x32@60 09:44:23 INFO - 2016-09-29 09:44:23.125 screenresolution[1936:20767] starting screenresolution argv=screenresolution list 09:44:23 INFO - Available Modes on Display 0 09:44:23 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:44:23 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:44:23 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:44:23 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:44:23 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:44:23 INFO - Intel Iris: 09:44:23 INFO - Chipset Model: Intel Iris 09:44:23 INFO - Type: GPU 09:44:23 INFO - Bus: Built-In 09:44:23 INFO - VRAM (Dynamic, Max): 1536 MB 09:44:23 INFO - Vendor: Intel (0x8086) 09:44:23 INFO - Device ID: 0x0a2e 09:44:23 INFO - Revision ID: 0x0009 09:44:23 INFO - Displays: 09:44:23 INFO - Display: 09:44:23 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:44:23 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:44:23 INFO - Display Serial Number: 1600x1200 60 09:44:23 INFO - Main Display: Yes 09:44:23 INFO - Mirror: Off 09:44:23 INFO - Online: Yes 09:44:23 INFO - Rotation: Supported 09:44:23 INFO - Return code: 0 09:44:23 INFO - Running post-action listener: _resource_record_post_action 09:44:23 INFO - [mozharness: 2016-09-29 16:44:23.370006Z] Finished run-tests step (success) 09:44:23 INFO - Running post-run listener: _resource_record_post_run 09:44:23 INFO - Total resource usage - Wall time: 1210s; CPU: 54.0%; Read bytes: 1069056; Write bytes: 661616128; Read time: 9; Write time: 1856 09:44:23 INFO - TinderboxPrint: CPU usage
53.5% 09:44:23 INFO - TinderboxPrint: I/O read bytes / time
1,069,056 / 9 09:44:23 INFO - TinderboxPrint: I/O write bytes / time
661,616,128 / 1,856 09:44:23 INFO - TinderboxPrint: CPU idle
2,250.0 (46.5%) 09:44:23 INFO - TinderboxPrint: CPU system
970.5 (20.0%) 09:44:23 INFO - TinderboxPrint: CPU user
1,621.2 (33.5%) 09:44:23 INFO - TinderboxPrint: Swap in / out
363,958,272 / 0 09:44:23 INFO - install - Wall time: 33s; CPU: 55.0%; Read bytes: 355760640; Write bytes: 356357632; Read time: 27520; Write time: 693 09:44:23 INFO - run-tests - Wall time: 1178s; CPU: 53.0%; Read bytes: 1069056; Write bytes: 295075840; Read time: 9; Write time: 1126 09:44:23 INFO - Running post-run listener: _upload_blobber_files 09:44:23 INFO - Blob upload gear active. 09:44:23 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:44:23 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 09:44:23 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'] 09:44:23 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 09:44:24 INFO - (blobuploader) - INFO - Open directory for files ... 09:44:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:44:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:44:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:44:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:44:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:44:24 INFO - (blobuploader) - INFO - Done attempting. 09:44:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:44:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:44:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:44:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:44:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:44:25 INFO - (blobuploader) - INFO - Done attempting. 09:44:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:44:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:44:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:44:28 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:44:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:44:28 INFO - (blobuploader) - INFO - Done attempting. 09:44:28 INFO - (blobuploader) - INFO - Iteration through files over. 09:44:28 INFO - Return code: 0 09:44:28 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:44:28 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:44:28 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e3311da93f8ba6b4553caf5c7853d8f96f41a2a0c1de708be183bd1afa0d7409be19e8962ca4cc7cbdaf01dc0ca4de5fcb1744237f71eaf1f12a8ba879eca4f6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7888da7a5b4c76e040fe1f618449e90c9fc3386b68593931e7ec9b3b8a53de196031e5351d9cb2ed92bf8b33c6478061a7b1cc1b329601417eaa5cc109f51bfd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/23a5fb8285e36a3c2a7828d82164384b82c460c026167c341406f385131768cf0555f078440b9bfca840a43f0d2924d6f78f8195020454e9e2c38e81980c70e6"} 09:44:28 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:44:28 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:44:28 INFO - Contents: 09:44:28 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e3311da93f8ba6b4553caf5c7853d8f96f41a2a0c1de708be183bd1afa0d7409be19e8962ca4cc7cbdaf01dc0ca4de5fcb1744237f71eaf1f12a8ba879eca4f6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7888da7a5b4c76e040fe1f618449e90c9fc3386b68593931e7ec9b3b8a53de196031e5351d9cb2ed92bf8b33c6478061a7b1cc1b329601417eaa5cc109f51bfd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/23a5fb8285e36a3c2a7828d82164384b82c460c026167c341406f385131768cf0555f078440b9bfca840a43f0d2924d6f78f8195020454e9e2c38e81980c70e6"} 09:44:28 INFO - Running post-run listener: copy_logs_to_upload_dir 09:44:28 INFO - Copying logs to upload dir... 09:44:28 INFO - mkdir: /builds/slave/test/build/upload/logs 09:44:28 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1271.283546 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-09-29 09:44:29.012631) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-29 09:44:29.015942) ========= 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.bXAGOxWHz9/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.H1mTMoiL1x/Listeners TMPDIR=/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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/e3311da93f8ba6b4553caf5c7853d8f96f41a2a0c1de708be183bd1afa0d7409be19e8962ca4cc7cbdaf01dc0ca4de5fcb1744237f71eaf1f12a8ba879eca4f6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7888da7a5b4c76e040fe1f618449e90c9fc3386b68593931e7ec9b3b8a53de196031e5351d9cb2ed92bf8b33c6478061a7b1cc1b329601417eaa5cc109f51bfd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/23a5fb8285e36a3c2a7828d82164384b82c460c026167c341406f385131768cf0555f078440b9bfca840a43f0d2924d6f78f8195020454e9e2c38e81980c70e6"} build_url:https://queue.taskcluster.net/v1/task/GeOAFR_YQluEjuegAbcEjg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011061 build_url: 'https://queue.taskcluster.net/v1/task/GeOAFR_YQluEjuegAbcEjg/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/e3311da93f8ba6b4553caf5c7853d8f96f41a2a0c1de708be183bd1afa0d7409be19e8962ca4cc7cbdaf01dc0ca4de5fcb1744237f71eaf1f12a8ba879eca4f6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7888da7a5b4c76e040fe1f618449e90c9fc3386b68593931e7ec9b3b8a53de196031e5351d9cb2ed92bf8b33c6478061a7b1cc1b329601417eaa5cc109f51bfd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/23a5fb8285e36a3c2a7828d82164384b82c460c026167c341406f385131768cf0555f078440b9bfca840a43f0d2924d6f78f8195020454e9e2c38e81980c70e6"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-29 09:44:29.048676) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-29 09:44:29.049009) ========= 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.bXAGOxWHz9/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.H1mTMoiL1x/Listeners TMPDIR=/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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.005187 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-29 09:44:29.097405) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-29 09:44:29.097738) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-29 09:44:29.098060) ========= ========= Total master_lag: 0.17 =========