builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0061 starttime: 1493142537.85 results: success (0) buildid: 20170425094824 builduid: 0d626cc0ebf84365ba6f0d5b55a55119 revision: 419d01b08a9ef9d9f8698c73b573eb2ffeeef0c1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-25 10:48:57.848973) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-25 10:48:57.849406) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-25 10:48:57.849681) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-25 10:48:57.877099) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-25 10:48:57.877416) ========= 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.PXXeLSpPzq/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.AL0l568wpr/Listeners TMPDIR=/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/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 --2017-04-25 10:48:57-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 9.22M=0.001s 2017-04-25 10:48:57 (9.22 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.105214 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-25 10:48:58.008583) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-25 10:48:58.008896) ========= 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.PXXeLSpPzq/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.AL0l568wpr/Listeners TMPDIR=/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/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.029374 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-25 10:48:58.062452) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 6 secs) (at 2017-04-25 10:48:58.062800) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 419d01b08a9ef9d9f8698c73b573eb2ffeeef0c1 --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-beta --rev 419d01b08a9ef9d9f8698c73b573eb2ffeeef0c1 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.PXXeLSpPzq/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.AL0l568wpr/Listeners TMPDIR=/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/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 2017-04-25 10:48:58,169 truncating revision to first 12 chars 2017-04-25 10:48:58,169 Setting DEBUG logging. 2017-04-25 10:48:58,169 attempt 1/10 2017-04-25 10:48:58,169 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/419d01b08a9e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-25 10:48:59,578 unpacking tar archive at: mozilla-beta-419d01b08a9e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.686126 ========= master_lag: 4.84 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 6 secs) (at 2017-04-25 10:49:04.584525) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-25 10:49:04.584852) ========= script_repo_revision: 419d01b08a9ef9d9f8698c73b573eb2ffeeef0c1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-25 10:49:04.585250) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-25 10:49:04.585518) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-25 10:49:05.412630) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2017-04-25 10:49:05.412960) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.PXXeLSpPzq/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.AL0l568wpr/Listeners TMPDIR=/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/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 10:49:05 INFO - MultiFileLogger online at 20170425 10:49:05 in /builds/slave/test 10:49:05 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 10:49:05 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:49:05 INFO - {'append_to_log': False, 10:49:05 INFO - 'base_work_dir': '/builds/slave/test', 10:49:05 INFO - 'blob_upload_branch': 'Mozilla-Beta', 10:49:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:49:05 INFO - 'branch': 'Mozilla-Beta', 10:49:05 INFO - 'buildbot_json_path': 'buildprops.json', 10:49:05 INFO - 'config_files': ('talos/mac_config.py',), 10:49:05 INFO - 'default_actions': ('clobber', 10:49:05 INFO - 'read-buildbot-config', 10:49:05 INFO - 'download-and-extract', 10:49:05 INFO - 'populate-webroot', 10:49:05 INFO - 'create-virtualenv', 10:49:05 INFO - 'install', 10:49:05 INFO - 'run-tests'), 10:49:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:49:05 INFO - 'download_minidump_stackwalk': True, 10:49:05 INFO - 'download_symbols': 'ondemand', 10:49:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:49:05 INFO - 'tooltool.py': '/tools/tooltool.py', 10:49:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:49:05 INFO - '/tools/misc-python/virtualenv.py')}, 10:49:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:49:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:49:05 INFO - 'gecko_profile': False, 10:49:05 INFO - 'gecko_profile_interval': 0, 10:49:05 INFO - 'installer_path': 'installer.exe', 10:49:05 INFO - 'log_level': 'info', 10:49:05 INFO - 'log_name': 'talos', 10:49:05 INFO - 'log_to_console': True, 10:49:05 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 10:49:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 10:49:05 INFO - 'opt_config_files': (), 10:49:05 INFO - 'pip_index': False, 10:49:05 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:49:05 INFO - 'cmd': ('bash', 10:49:05 INFO - '-c', 10:49:05 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:49:05 INFO - 'enabled': True, 10:49:05 INFO - 'halt_on_failure': False, 10:49:05 INFO - 'name': 'check_screen_resolution'},), 10:49:05 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:49:05 INFO - 'cmd': ('bash', 10:49:05 INFO - '-c', 10:49:05 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:49:05 INFO - 'enabled': True, 10:49:05 INFO - 'halt_on_failure': False, 10:49:05 INFO - 'name': 'check_screen_resolution'},), 10:49:05 INFO - 'run_cmd_checks_enabled': True, 10:49:05 INFO - 'suite': 'dromaeojs', 10:49:05 INFO - 'system_bits': '32', 10:49:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:49:05 INFO - 'title': 't-yosemite-r7-0061', 10:49:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:49:05 INFO - 'use_talos_json': True, 10:49:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:49:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:49:05 INFO - 'work_dir': 'build'} 10:49:05 INFO - [mozharness: 2017-04-25 17:49:05.626367Z] Running clobber step. 10:49:05 INFO - Running pre-action listener: _resource_record_pre_action 10:49:05 INFO - Running main action method: clobber 10:49:05 INFO - rmtree: /builds/slave/test/build 10:49:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:49:08 INFO - Running post-action listener: _resource_record_post_action 10:49:08 INFO - [mozharness: 2017-04-25 17:49:08.248352Z] Finished clobber step (success) 10:49:08 INFO - [mozharness: 2017-04-25 17:49:08.248485Z] Running read-buildbot-config step. 10:49:08 INFO - Running pre-action listener: _resource_record_pre_action 10:49:08 INFO - Running main action method: read_buildbot_config 10:49:08 INFO - Using buildbot properties: 10:49:08 INFO - { 10:49:08 INFO - "project": "", 10:49:08 INFO - "product": "firefox", 10:49:08 INFO - "script_repo_revision": "production", 10:49:08 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 10:49:08 INFO - "repository": "", 10:49:08 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 10:49:08 INFO - "buildid": "20170425094824", 10:49:08 INFO - "pgo_build": "False", 10:49:08 INFO - "basedir": "/builds/slave/test", 10:49:08 INFO - "buildnumber": 8, 10:49:08 INFO - "slavename": "t-yosemite-r7-0061", 10:49:08 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 10:49:08 INFO - "platform": "yosemite_r7", 10:49:08 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 10:49:08 INFO - "branch": "mozilla-beta", 10:49:08 INFO - "repo_path": "releases/mozilla-beta", 10:49:08 INFO - "revision": "419d01b08a9ef9d9f8698c73b573eb2ffeeef0c1", 10:49:08 INFO - "stage_platform": "macosx64", 10:49:08 INFO - "builduid": "0d626cc0ebf84365ba6f0d5b55a55119", 10:49:08 INFO - "slavebuilddir": "test" 10:49:08 INFO - } 10:49:08 INFO - Found installer url https://queue.taskcluster.net/v1/task/P8D13ObLQxu_ptB4VEUmaA/artifacts/public/build/firefox-54.0.en-US.mac.dmg. 10:49:08 INFO - Running post-action listener: _resource_record_post_action 10:49:08 INFO - [mozharness: 2017-04-25 17:49:08.251784Z] Finished read-buildbot-config step (success) 10:49:08 INFO - [mozharness: 2017-04-25 17:49:08.251897Z] Running download-and-extract step. 10:49:08 INFO - Running pre-action listener: _resource_record_pre_action 10:49:08 INFO - Running main action method: download_and_extract 10:49:08 INFO - mkdir: /builds/slave/test/build/tests 10:49:08 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')]} 10:49:08 INFO - trying https://queue.taskcluster.net/v1/task/P8D13ObLQxu_ptB4VEUmaA/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json 10:49:08 INFO - Downloading https://queue.taskcluster.net/v1/task/P8D13ObLQxu_ptB4VEUmaA/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json 10:49:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/P8D13ObLQxu_ptB4VEUmaA/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json'}, attempt #1 10:49:09 INFO - Downloaded 1165 bytes. 10:49:09 INFO - Reading from file /builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json 10:49:09 INFO - Using the following test package requirements: 10:49:09 INFO - {u'common': [u'firefox-54.0.en-US.mac.common.tests.zip'], 10:49:09 INFO - u'cppunittest': [u'firefox-54.0.en-US.mac.common.tests.zip', 10:49:09 INFO - u'firefox-54.0.en-US.mac.cppunittest.tests.zip'], 10:49:09 INFO - u'gtest': [u'firefox-54.0.en-US.mac.common.tests.zip', 10:49:09 INFO - u'firefox-54.0.en-US.mac.gtest.tests.zip'], 10:49:09 INFO - u'jittest': [u'firefox-54.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 10:49:09 INFO - u'mochitest': [u'firefox-54.0.en-US.mac.common.tests.zip', 10:49:09 INFO - u'firefox-54.0.en-US.mac.mochitest.tests.zip'], 10:49:09 INFO - u'mozbase': [u'firefox-54.0.en-US.mac.common.tests.zip'], 10:49:09 INFO - u'reftest': [u'firefox-54.0.en-US.mac.common.tests.zip', 10:49:09 INFO - u'firefox-54.0.en-US.mac.reftest.tests.zip'], 10:49:09 INFO - u'talos': [u'firefox-54.0.en-US.mac.common.tests.zip', 10:49:09 INFO - u'firefox-54.0.en-US.mac.talos.tests.zip'], 10:49:09 INFO - u'web-platform': [u'firefox-54.0.en-US.mac.common.tests.zip', 10:49:09 INFO - u'firefox-54.0.en-US.mac.web-platform.tests.zip'], 10:49:09 INFO - u'xpcshell': [u'firefox-54.0.en-US.mac.common.tests.zip', 10:49:09 INFO - u'firefox-54.0.en-US.mac.xpcshell.tests.zip']} 10:49:09 INFO - Downloading packages: [u'firefox-54.0.en-US.mac.common.tests.zip'] for test suite category: common 10:49:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/P8D13ObLQxu_ptB4VEUmaA/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip 10:49:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/P8D13ObLQxu_ptB4VEUmaA/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip'}, attempt #1 10:49:09 INFO - Fetch https://queue.taskcluster.net/v1/task/P8D13ObLQxu_ptB4VEUmaA/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip into memory 10:49:11 INFO - Expected file size: 51221072 10:49:11 INFO - Obtained file size: 51221072 10:49:26 INFO - Downloading packages: [u'firefox-54.0.en-US.mac.common.tests.zip', u'firefox-54.0.en-US.mac.talos.tests.zip'] for test suite category: talos 10:49:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/P8D13ObLQxu_ptB4VEUmaA/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip 10:49:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/P8D13ObLQxu_ptB4VEUmaA/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip'}, attempt #1 10:49:26 INFO - Fetch https://queue.taskcluster.net/v1/task/P8D13ObLQxu_ptB4VEUmaA/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip into memory 10:49:28 INFO - Expected file size: 51221072 10:49:28 INFO - Obtained file size: 51221072 10:49:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/P8D13ObLQxu_ptB4VEUmaA/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip 10:49:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/P8D13ObLQxu_ptB4VEUmaA/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip'}, attempt #1 10:49:43 INFO - Fetch https://queue.taskcluster.net/v1/task/P8D13ObLQxu_ptB4VEUmaA/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip into memory 10:49:44 INFO - Expected file size: 14404449 10:49:44 INFO - Obtained file size: 14404449 10:49: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')]} 10:49:44 INFO - trying https://queue.taskcluster.net/v1/task/P8D13ObLQxu_ptB4VEUmaA/artifacts/public/build/firefox-54.0.en-US.mac.dmg 10:49:44 INFO - Downloading https://queue.taskcluster.net/v1/task/P8D13ObLQxu_ptB4VEUmaA/artifacts/public/build/firefox-54.0.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0.en-US.mac.dmg 10:49:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/P8D13ObLQxu_ptB4VEUmaA/artifacts/public/build/firefox-54.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0.en-US.mac.dmg'}, attempt #1 10:49:46 INFO - Downloaded 59532350 bytes. 10:49:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/P8D13ObLQxu_ptB4VEUmaA/artifacts/public/build/firefox-54.0.en-US.mac.dmg 10:49:46 INFO - mkdir: /builds/slave/test/properties 10:49:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:49:46 INFO - Writing to file /builds/slave/test/properties/build_url 10:49:46 INFO - Contents: 10:49:46 INFO - build_url:https://queue.taskcluster.net/v1/task/P8D13ObLQxu_ptB4VEUmaA/artifacts/public/build/firefox-54.0.en-US.mac.dmg 10:49:47 INFO - Running post-action listener: _resource_record_post_action 10:49:47 INFO - Running post-action listener: set_extra_try_arguments 10:49:47 INFO - [mozharness: 2017-04-25 17:49:47.191745Z] Finished download-and-extract step (success) 10:49:47 INFO - [mozharness: 2017-04-25 17:49:47.191895Z] Running populate-webroot step. 10:49:47 INFO - Running pre-action listener: _resource_record_pre_action 10:49:47 INFO - Running main action method: populate_webroot 10:49:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:49:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:49:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:49:47 INFO - '--tppagecycles', 10:49:47 INFO - '7'], 10:49:47 INFO - 'tests': ['tsvgm']}}, 10:49:47 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:49:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:49:47 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:49:47 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:49:47 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:49:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:49:47 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 10:49:47 INFO - 'talos_options': ['--disable-e10s'], 10:49:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:49:47 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 10:49:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:49:47 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 10:49:47 INFO - 'talos_options': ['--disable-e10s'], 10:49:47 INFO - 'tests': ['damp', 'tps']}, 10:49:47 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 10:49:47 INFO - 'tests': ['damp', 'tps']}, 10:49:47 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:49:47 INFO - 'tests': ['dromaeo_dom']}, 10:49:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:49:47 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:49:47 INFO - 'tests': ['basic_compositor_video']}, 10:49:47 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:49:47 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:49:47 INFO - 'tests': ['a11yr', 10:49:47 INFO - 'ts_paint', 10:49:47 INFO - 'tpaint', 10:49:47 INFO - 'sessionrestore', 10:49:47 INFO - 'sessionrestore_no_auto_restore', 10:49:47 INFO - 'tabpaint']}, 10:49:47 INFO - 'other-e10s': {'tests': ['a11yr', 10:49:47 INFO - 'ts_paint', 10:49:47 INFO - 'tpaint', 10:49:47 INFO - 'sessionrestore', 10:49:47 INFO - 'sessionrestore_no_auto_restore', 10:49:47 INFO - 'tabpaint']}, 10:49:47 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:49:47 INFO - 'ts_paint', 10:49:47 INFO - 'tpaint', 10:49:47 INFO - 'sessionrestore', 10:49:47 INFO - 'sessionrestore_no_auto_restore', 10:49:47 INFO - 'tabpaint']}, 10:49:47 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:49:47 INFO - 'ts_paint', 10:49:47 INFO - 'tpaint', 10:49:47 INFO - 'sessionrestore', 10:49:47 INFO - 'sessionrestore_no_auto_restore', 10:49:47 INFO - 'tabpaint']}, 10:49:47 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:49:47 INFO - 'tests': ['a11yr', 10:49:47 INFO - 'ts_paint', 10:49:47 INFO - 'tpaint', 10:49:47 INFO - 'sessionrestore', 10:49:47 INFO - 'sessionrestore_no_auto_restore', 10:49:47 INFO - 'tabpaint']}, 10:49:47 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:49:47 INFO - 'tests': ['a11yr', 10:49:47 INFO - 'ts_paint', 10:49:47 INFO - 'tpaint', 10:49:47 INFO - 'sessionrestore', 10:49:47 INFO - 'sessionrestore_no_auto_restore', 10:49:47 INFO - 'tabpaint']}, 10:49:47 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:49:47 INFO - 'tests': ['tsvgx', 10:49:47 INFO - 'tsvgr_opacity', 10:49:47 INFO - 'tart', 10:49:47 INFO - 'tscrollx', 10:49:47 INFO - 'cart', 10:49:47 INFO - 'tsvg_static']}, 10:49:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:49:47 INFO - 'tsvgr_opacity', 10:49:47 INFO - 'tart', 10:49:47 INFO - 'tscrollx', 10:49:47 INFO - 'cart', 10:49:47 INFO - 'tsvg_static']}, 10:49:47 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 10:49:47 INFO - 'talos_options': ['--disable-e10s'], 10:49:47 INFO - 'tests': ['tp5o']}, 10:49:47 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 10:49:47 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 10:49:47 INFO - 'talos_options': ['--disable-e10s', 10:49:47 INFO - '--xperf_path', 10:49:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:49:47 INFO - 'tests': ['tp5n']}, 10:49:47 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 10:49:47 INFO - 'talos_options': ['--xperf_path', 10:49:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:49:47 INFO - 'tests': ['tp5n']}}, 10:49:47 INFO - 'talos.zip': {'path': '', 10:49:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:49:47 INFO - Running post-action listener: _resource_record_post_action 10:49:47 INFO - [mozharness: 2017-04-25 17:49:47.210522Z] Finished populate-webroot step (success) 10:49:47 INFO - [mozharness: 2017-04-25 17:49:47.210655Z] Running create-virtualenv step. 10:49:47 INFO - Running pre-action listener: _resource_record_pre_action 10:49:47 INFO - Running main action method: create_virtualenv 10:49:47 INFO - Creating virtualenv /builds/slave/test/build/venv 10:49:47 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 10:49:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:49:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:49:47 INFO - Using real prefix '/tools/python27' 10:49:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:49:48 INFO - Installing distribute.............................................................................................................................................................................................done. 10:49:50 INFO - Installing pip.................done. 10:49:50 INFO - Return code: 0 10:49:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:49:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:49:51 INFO - Reading from file tmpfile_stdout 10:49:51 INFO - Output received: 10:49:51 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 10:49:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:49:51 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')]} 10:49:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:49:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:49:51 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')]} 10:49:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:49:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:49:51 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 0x100f8fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f92768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faae24a55c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d6dd30>, '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 0x100c94db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100d62be8>, '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.PXXeLSpPzq/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.AL0l568wpr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/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 10:49:51 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 10:49:51 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 10:49:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PXXeLSpPzq/Render', 10:49:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:49:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:49:51 INFO - 'HOME': '/Users/cltbld', 10:49:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:49:51 INFO - 'LOGNAME': 'cltbld', 10:49:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:49:51 INFO - 'MOZ_NO_REMOTE': '1', 10:49:51 INFO - 'NO_EM_RESTART': '1', 10:49:51 INFO - 'PAGER': '/bin/cat', 10:49:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:49:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:49:51 INFO - 'PWD': '/builds/slave/test', 10:49:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:49:51 INFO - 'SHELL': '/bin/bash', 10:49:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AL0l568wpr/Listeners', 10:49:51 INFO - 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/', 10:49:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:49:51 INFO - 'USER': 'cltbld', 10:49:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:49:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:49:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:49:51 INFO - 'XPC_FLAGS': '0x0', 10:49:51 INFO - 'XPC_SERVICE_NAME': '0', 10:49:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:49:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:49:51 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 10:49:51 INFO - Cleaning up... 10:49:51 INFO - Return code: 0 10:49:51 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:49:51 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')]} 10:49:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:49:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:49:51 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')]} 10:49:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:49:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:49: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', '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 0x100f8fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f92768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faae24a55c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d6dd30>, '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 0x100c94db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100d62be8>, '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.PXXeLSpPzq/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.AL0l568wpr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/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 10:49: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', 'psutil>=3.1.1'] in /builds/slave/test/build 10:49: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 psutil>=3.1.1 10:49:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PXXeLSpPzq/Render', 10:49:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:49:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:49:52 INFO - 'HOME': '/Users/cltbld', 10:49:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:49:52 INFO - 'LOGNAME': 'cltbld', 10:49:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:49:52 INFO - 'MOZ_NO_REMOTE': '1', 10:49:52 INFO - 'NO_EM_RESTART': '1', 10:49:52 INFO - 'PAGER': '/bin/cat', 10:49:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:49:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:49:52 INFO - 'PWD': '/builds/slave/test', 10:49:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:49:52 INFO - 'SHELL': '/bin/bash', 10:49:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AL0l568wpr/Listeners', 10:49:52 INFO - 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/', 10:49:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:49:52 INFO - 'USER': 'cltbld', 10:49:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:49:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:49:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:49:52 INFO - 'XPC_FLAGS': '0x0', 10:49:52 INFO - 'XPC_SERVICE_NAME': '0', 10:49:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:49:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:49:52 INFO - Downloading/unpacking psutil>=3.1.1 10:49: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 10:49: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 10:49: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 10:49: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 10:49: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 10:49: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 10:49:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:49:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:49:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:49:56 INFO - Installing collected packages: psutil 10:49:56 INFO - Running setup.py install for psutil 10:49:56 INFO - building 'psutil._psutil_osx' extension 10:49:56 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 10:49:57 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 10:49:57 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 10:49:57 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 10:49:57 INFO - building 'psutil._psutil_posix' extension 10:49:57 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 10:49:57 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 10:49:57 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 10:49:57 INFO - ^ 10:49:57 INFO - 1 warning generated. 10:49:57 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 10:49:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:49:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:49:57 INFO - Successfully installed psutil 10:49:57 INFO - Cleaning up... 10:49:57 INFO - Return code: 0 10:49:57 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:49: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')]} 10:49:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:49:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:49: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')]} 10:49:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:49:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:49: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100f8fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f92768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faae24a55c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d6dd30>, '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 0x100c94db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100d62be8>, '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.PXXeLSpPzq/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.AL0l568wpr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/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 10:49: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 10:49: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 mozsystemmonitor==0.3 10:49:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PXXeLSpPzq/Render', 10:49:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:49:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:49:57 INFO - 'HOME': '/Users/cltbld', 10:49:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:49:57 INFO - 'LOGNAME': 'cltbld', 10:49:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:49:57 INFO - 'MOZ_NO_REMOTE': '1', 10:49:57 INFO - 'NO_EM_RESTART': '1', 10:49:57 INFO - 'PAGER': '/bin/cat', 10:49:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:49:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:49:57 INFO - 'PWD': '/builds/slave/test', 10:49:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:49:57 INFO - 'SHELL': '/bin/bash', 10:49:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AL0l568wpr/Listeners', 10:49:57 INFO - 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/', 10:49:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:49:57 INFO - 'USER': 'cltbld', 10:49:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:49:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:49:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:49:57 INFO - 'XPC_FLAGS': '0x0', 10:49:57 INFO - 'XPC_SERVICE_NAME': '0', 10:49:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:49:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:49:58 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:49:58 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 10:49:58 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 10:49:58 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 10:49:58 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 10:49:58 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 10:49:58 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 10:50:00 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:50:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:50:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:50:00 INFO - Installing collected packages: mozsystemmonitor 10:50:00 INFO - Running setup.py install for mozsystemmonitor 10:50:00 INFO - Successfully installed mozsystemmonitor 10:50:00 INFO - Cleaning up... 10:50:00 INFO - Return code: 0 10:50:00 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:50:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:50:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:50:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:50:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:50:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:50:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:50:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x100f8fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f92768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faae24a55c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d6dd30>, '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 0x100c94db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100d62be8>, '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.PXXeLSpPzq/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.AL0l568wpr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/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 10:50:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 10:50:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 10:50:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PXXeLSpPzq/Render', 10:50:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:50:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:50:00 INFO - 'HOME': '/Users/cltbld', 10:50:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:50:00 INFO - 'LOGNAME': 'cltbld', 10:50:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:50:00 INFO - 'MOZ_NO_REMOTE': '1', 10:50:00 INFO - 'NO_EM_RESTART': '1', 10:50:00 INFO - 'PAGER': '/bin/cat', 10:50:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:50:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:50:00 INFO - 'PWD': '/builds/slave/test', 10:50:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:50:00 INFO - 'SHELL': '/bin/bash', 10:50:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AL0l568wpr/Listeners', 10:50:00 INFO - 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/', 10:50:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:50:00 INFO - 'USER': 'cltbld', 10:50:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:50:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:50:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:50:00 INFO - 'XPC_FLAGS': '0x0', 10:50:00 INFO - 'XPC_SERVICE_NAME': '0', 10:50:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:50:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:50:01 INFO - Downloading/unpacking jsonschema==2.5.1 10:50:01 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 10:50:01 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 10:50:01 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 10:50:01 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 10:50:01 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 10:50:01 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 10:50:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:50:03 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:50:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:50:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:50:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:50:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:50:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:50:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:50:04 INFO - Downloading functools32-3.2.3-2.tar.gz 10:50:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:50:04 INFO - warning: no files found matching '*.txt' 10:50:04 INFO - no previously-included directories found matching 'build' 10:50:04 INFO - no previously-included directories found matching 'dist' 10:50:04 INFO - no previously-included directories found matching '.git*' 10:50:04 INFO - Installing collected packages: jsonschema, functools32 10:50:04 INFO - Running setup.py install for functools32 10:50:04 INFO - warning: no files found matching '*.txt' 10:50:04 INFO - no previously-included directories found matching 'build' 10:50:04 INFO - no previously-included directories found matching 'dist' 10:50:04 INFO - no previously-included directories found matching '.git*' 10:50:04 INFO - Successfully installed jsonschema functools32 10:50:04 INFO - Cleaning up... 10:50:04 INFO - Return code: 0 10:50:04 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:50:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:50:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:50:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:50:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:50:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:50:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:50:04 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 0x100f8fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f92768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faae24a55c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d6dd30>, '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 0x100c94db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100d62be8>, '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.PXXeLSpPzq/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.AL0l568wpr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/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 10:50:04 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 10:50:04 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 10:50:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PXXeLSpPzq/Render', 10:50:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:50:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:50:04 INFO - 'HOME': '/Users/cltbld', 10:50:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:50:04 INFO - 'LOGNAME': 'cltbld', 10:50:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:50:04 INFO - 'MOZ_NO_REMOTE': '1', 10:50:04 INFO - 'NO_EM_RESTART': '1', 10:50:04 INFO - 'PAGER': '/bin/cat', 10:50:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:50:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:50:04 INFO - 'PWD': '/builds/slave/test', 10:50:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:50:04 INFO - 'SHELL': '/bin/bash', 10:50:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AL0l568wpr/Listeners', 10:50:04 INFO - 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/', 10:50:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:50:04 INFO - 'USER': 'cltbld', 10:50:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:50:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:50:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:50:04 INFO - 'XPC_FLAGS': '0x0', 10:50:04 INFO - 'XPC_SERVICE_NAME': '0', 10:50:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:50:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:50:04 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:50:04 INFO - Cleaning up... 10:50:04 INFO - Return code: 0 10:50:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:50:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:50:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:50:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:50:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:50:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:50:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:50:04 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 0x100f8fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f92768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faae24a55c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d6dd30>, '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 0x100c94db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100d62be8>, '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.PXXeLSpPzq/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.AL0l568wpr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/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 10:50:04 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 10:50:04 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 10:50:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PXXeLSpPzq/Render', 10:50:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:50:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:50:04 INFO - 'HOME': '/Users/cltbld', 10:50:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:50:04 INFO - 'LOGNAME': 'cltbld', 10:50:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:50:04 INFO - 'MOZ_NO_REMOTE': '1', 10:50:04 INFO - 'NO_EM_RESTART': '1', 10:50:04 INFO - 'PAGER': '/bin/cat', 10:50:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:50:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:50:04 INFO - 'PWD': '/builds/slave/test', 10:50:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:50:04 INFO - 'SHELL': '/bin/bash', 10:50:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AL0l568wpr/Listeners', 10:50:04 INFO - 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/', 10:50:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:50:04 INFO - 'USER': 'cltbld', 10:50:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:50:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:50:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:50:04 INFO - 'XPC_FLAGS': '0x0', 10:50:04 INFO - 'XPC_SERVICE_NAME': '0', 10:50:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:50:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:50:05 INFO - Downloading/unpacking blobuploader==1.2.4 10:50:05 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 10:50:05 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 10:50:05 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 10:50:05 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 10:50:05 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 10:50:05 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 10:50:07 INFO - Downloading blobuploader-1.2.4.tar.gz 10:50:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:50:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:50:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:50:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:50:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:50:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:50:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:50:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:50:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:50:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:50: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 10:50: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 10:50: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 10:50: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 10:50: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 10:50: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 10:50:08 INFO - Downloading docopt-0.6.1.tar.gz 10:50:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:50:09 INFO - Installing collected packages: blobuploader, requests, docopt 10:50:09 INFO - Running setup.py install for blobuploader 10:50:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:50:09 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:50:09 INFO - Running setup.py install for requests 10:50:09 INFO - Running setup.py install for docopt 10:50:09 INFO - Successfully installed blobuploader requests docopt 10:50:09 INFO - Cleaning up... 10:50:09 INFO - Return code: 0 10:50:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:50:09 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')]} 10:50:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:50:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:50:09 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')]} 10:50:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:50:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:50:09 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 0x100f8fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f92768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faae24a55c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d6dd30>, '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 0x100c94db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100d62be8>, '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.PXXeLSpPzq/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.AL0l568wpr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/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 10:50:09 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 10:50:09 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 10:50:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PXXeLSpPzq/Render', 10:50:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:50:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:50:09 INFO - 'HOME': '/Users/cltbld', 10:50:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:50:09 INFO - 'LOGNAME': 'cltbld', 10:50:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:50:09 INFO - 'MOZ_NO_REMOTE': '1', 10:50:09 INFO - 'NO_EM_RESTART': '1', 10:50:09 INFO - 'PAGER': '/bin/cat', 10:50:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:50:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:50:09 INFO - 'PWD': '/builds/slave/test', 10:50:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:50:09 INFO - 'SHELL': '/bin/bash', 10:50:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AL0l568wpr/Listeners', 10:50:09 INFO - 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/', 10:50:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:50:09 INFO - 'USER': 'cltbld', 10:50:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:50:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:50:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:50:09 INFO - 'XPC_FLAGS': '0x0', 10:50:09 INFO - 'XPC_SERVICE_NAME': '0', 10:50:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:50:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:50:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:50:10 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-0xsCnd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:50:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:50:10 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-sM4oku-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:50:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:50:10 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-rGGiSH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:50:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:50:10 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-KMy_NL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:50:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:50:10 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-nRKXjg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:50:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:50:10 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-nsNPam-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:50:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:50:10 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-Vwub2c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:50:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:50:10 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-NUacPT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:50:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:50:11 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-2zdqw5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:50:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:50:11 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-KO7dWG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:50:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:50:11 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-E_bdeo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:50:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:50:11 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-eAe5Ve-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:50:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:50:11 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-FoIg1r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:50:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:50:11 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-gqofX8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:50:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:50:11 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-WqQufG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:50:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:50:11 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-dNuLOM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:50:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:50:11 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-JFzzo8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:50:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:50:12 INFO - Running setup.py install for manifestparser 10:50:12 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:50:12 INFO - Running setup.py install for mozcrash 10:50:12 INFO - Running setup.py install for mozdebug 10:50:12 INFO - Running setup.py install for mozdevice 10:50:12 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:50:12 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:50:12 INFO - Running setup.py install for mozfile 10:50:12 INFO - Running setup.py install for mozhttpd 10:50:12 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:50:12 INFO - Running setup.py install for mozinfo 10:50:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:50:13 INFO - Running setup.py install for mozInstall 10:50:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:50:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:50:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:50:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:50:13 INFO - Running setup.py install for mozleak 10:50:13 INFO - Running setup.py install for mozlog 10:50:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:50:13 INFO - Running setup.py install for moznetwork 10:50:13 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:50:13 INFO - Running setup.py install for mozprocess 10:50:13 INFO - Running setup.py install for mozprofile 10:50:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:50:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:50:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:50:14 INFO - Running setup.py install for mozrunner 10:50:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:50:14 INFO - Running setup.py install for mozscreenshot 10:50:14 INFO - Running setup.py install for moztest 10:50:14 INFO - Running setup.py install for mozversion 10:50:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:50:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:50:14 INFO - Cleaning up... 10:50:14 INFO - Return code: 0 10:50:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:50:14 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')]} 10:50:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:50:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:50:14 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')]} 10:50:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:50:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:50:14 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 0x100f8fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f92768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faae24a55c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d6dd30>, '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 0x100c94db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100d62be8>, '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.PXXeLSpPzq/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.AL0l568wpr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/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 10:50:14 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 10:50:14 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 10:50:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PXXeLSpPzq/Render', 10:50:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:50:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:50:14 INFO - 'HOME': '/Users/cltbld', 10:50:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:50:14 INFO - 'LOGNAME': 'cltbld', 10:50:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:50:14 INFO - 'MOZ_NO_REMOTE': '1', 10:50:14 INFO - 'NO_EM_RESTART': '1', 10:50:14 INFO - 'PAGER': '/bin/cat', 10:50:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:50:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:50:14 INFO - 'PWD': '/builds/slave/test', 10:50:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:50:14 INFO - 'SHELL': '/bin/bash', 10:50:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AL0l568wpr/Listeners', 10:50:14 INFO - 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/', 10:50:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:50:14 INFO - 'USER': 'cltbld', 10:50:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:50:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:50:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:50:14 INFO - 'XPC_FLAGS': '0x0', 10:50:14 INFO - 'XPC_SERVICE_NAME': '0', 10:50:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:50:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:50:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:50:14 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-zydXVR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:50:15 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)) 10:50:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:50:15 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-s5ulY4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:50:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 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)) 10:50:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:50:15 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-ysZXG_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:50:15 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)) 10:50:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:50:15 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-9oTU2j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:50:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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)) 10:50:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:50:15 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-xcnggH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:50:15 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)) 10:50:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:50:15 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-Vl8f6Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:50:15 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)) 10:50:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:50:15 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-pU4two-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:50:15 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)) 10:50:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:50:15 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-5OLtLR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:50:15 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)) 10:50:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:50:15 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-XZxe73-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:50:15 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)) 10:50:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:50:15 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-iITCqL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:50:16 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)) 10:50:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:50:16 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-Nj1IOW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:50:16 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)) 10:50:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:50:16 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-Yt8lGs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:50:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 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)) 10:50:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:50:16 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-rRv2gJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:50:16 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)) 10:50:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:50:16 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-9uuIQ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:50:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 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)) 10:50:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:50:16 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-oRYGO4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:50:16 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)) 10:50:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:50:16 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-lLvB7c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:50:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 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)) 10:50:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:50:16 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-MTApnx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:50:16 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)) 10:50:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:50:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:50:16 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)) 10:50:16 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:50:16 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:50:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:50:16 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 10:50:16 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 10:50:16 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 10:50:16 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 10:50:16 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 10:50:16 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 10:50:19 INFO - Downloading blessings-1.6.tar.gz 10:50:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:50:19 INFO - Installing collected packages: blessings 10:50:19 INFO - Running setup.py install for blessings 10:50:19 INFO - Successfully installed blessings 10:50:19 INFO - Cleaning up... 10:50:19 INFO - Return code: 0 10:50:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:50:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:50:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:50:20 INFO - Reading from file tmpfile_stdout 10:50:20 INFO - Current package versions: 10:50:20 INFO - blessings == 1.6 10:50:20 INFO - blobuploader == 1.2.4 10:50:20 INFO - docopt == 0.6.1 10:50:20 INFO - functools32 == 3.2.3-2 10:50:20 INFO - jsonschema == 2.5.1 10:50:20 INFO - manifestparser == 1.1 10:50:20 INFO - mozInstall == 1.12 10:50:20 INFO - mozcrash == 1.0 10:50:20 INFO - mozdebug == 0.1 10:50:20 INFO - mozdevice == 0.49 10:50:20 INFO - mozfile == 1.2 10:50:20 INFO - mozhttpd == 0.7 10:50:20 INFO - mozinfo == 0.9 10:50:20 INFO - mozleak == 0.1 10:50:20 INFO - mozlog == 3.4 10:50:20 INFO - moznetwork == 0.27 10:50:20 INFO - mozprocess == 0.25 10:50:20 INFO - mozprofile == 0.28 10:50:20 INFO - mozrunner == 6.13 10:50:20 INFO - mozscreenshot == 0.1 10:50:20 INFO - mozsystemmonitor == 0.3 10:50:20 INFO - moztest == 0.8 10:50:20 INFO - mozversion == 1.4 10:50:20 INFO - psutil == 3.1.1 10:50:20 INFO - requests == 1.2.3 10:50:20 INFO - wsgiref == 0.1.2 10:50:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:50:20 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')]} 10:50:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:50:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:50:20 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')]} 10:50:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:50:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:50:20 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 0x100f8fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f92768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faae24a55c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d6dd30>, '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 0x100c94db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100d62be8>, '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.PXXeLSpPzq/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.AL0l568wpr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/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 10:50:20 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 10:50:20 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 10:50:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PXXeLSpPzq/Render', 10:50:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:50:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:50:20 INFO - 'HOME': '/Users/cltbld', 10:50:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:50:20 INFO - 'LOGNAME': 'cltbld', 10:50:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:50:20 INFO - 'MOZ_NO_REMOTE': '1', 10:50:20 INFO - 'NO_EM_RESTART': '1', 10:50:20 INFO - 'PAGER': '/bin/cat', 10:50:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:50:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:50:20 INFO - 'PWD': '/builds/slave/test', 10:50:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:50:20 INFO - 'SHELL': '/bin/bash', 10:50:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AL0l568wpr/Listeners', 10:50:20 INFO - 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/', 10:50:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:50:20 INFO - 'USER': 'cltbld', 10:50:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:50:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:50:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:50:20 INFO - 'XPC_FLAGS': '0x0', 10:50:20 INFO - 'XPC_SERVICE_NAME': '0', 10:50:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:50:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:50:20 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)) 10:50:20 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)) 10:50:20 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)) 10:50:20 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)) 10:50:20 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)) 10:50:20 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)) 10:50:20 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)) 10:50:20 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)) 10:50:20 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)) 10:50:20 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)) 10:50:20 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)) 10:50:20 INFO - Cleaning up... 10:50:20 INFO - Return code: 0 10:50:20 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:50:20 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')]} 10:50:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:50:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:50:20 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')]} 10:50:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:50:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:50:20 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 0x100f8fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f92768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faae24a55c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d6dd30>, '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 0x100c94db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100d62be8>, '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.PXXeLSpPzq/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.AL0l568wpr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/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 10:50:20 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 10:50:20 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 10:50:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PXXeLSpPzq/Render', 10:50:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:50:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:50:20 INFO - 'HOME': '/Users/cltbld', 10:50:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:50:20 INFO - 'LOGNAME': 'cltbld', 10:50:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:50:20 INFO - 'MOZ_NO_REMOTE': '1', 10:50:20 INFO - 'NO_EM_RESTART': '1', 10:50:20 INFO - 'PAGER': '/bin/cat', 10:50:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:50:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:50:20 INFO - 'PWD': '/builds/slave/test', 10:50:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:50:20 INFO - 'SHELL': '/bin/bash', 10:50:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AL0l568wpr/Listeners', 10:50:20 INFO - 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/', 10:50:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:50:20 INFO - 'USER': 'cltbld', 10:50:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:50:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:50:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:50:20 INFO - 'XPC_FLAGS': '0x0', 10:50:20 INFO - 'XPC_SERVICE_NAME': '0', 10:50:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:50:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:50:20 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:50:20 INFO - Cleaning up... 10:50:20 INFO - Return code: 0 10:50:20 INFO - Running post-action listener: _resource_record_post_action 10:50:20 INFO - Running post-action listener: _start_resource_monitoring 10:50:20 INFO - Starting resource monitoring. 10:50:20 INFO - [mozharness: 2017-04-25 17:50:20.578595Z] Finished create-virtualenv step (success) 10:50:20 INFO - [mozharness: 2017-04-25 17:50:20.579548Z] Running install step. 10:50:20 INFO - Running pre-action listener: _resource_record_pre_action 10:50:20 INFO - Running main action method: install 10:50:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:50:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:50:20 INFO - Reading from file tmpfile_stdout 10:50:20 INFO - Detecting whether we're running mozinstall >=1.0... 10:50:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:50:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:50:20 INFO - Reading from file tmpfile_stdout 10:50:20 INFO - Output received: 10:50:20 INFO - Usage: mozinstall [options] installer 10:50:20 INFO - Options: 10:50:20 INFO - -h, --help show this help message and exit 10:50:20 INFO - -d DEST, --destination=DEST 10:50:20 INFO - Directory to install application into. [default: 10:50:20 INFO - "/builds/slave/test"] 10:50:20 INFO - --app=APP Application being installed. [default: firefox] 10:50:20 INFO - mkdir: /builds/slave/test/build/application 10:50:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 10:50:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0.en-US.mac.dmg --destination /builds/slave/test/build/application 10:50:35 INFO - Reading from file tmpfile_stdout 10:50:35 INFO - Output received: 10:50:35 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 10:50:35 INFO - Running post-action listener: _resource_record_post_action 10:50:35 INFO - [mozharness: 2017-04-25 17:50:35.852372Z] Finished install step (success) 10:50:35 INFO - [mozharness: 2017-04-25 17:50:35.852488Z] Running run-tests step. 10:50:35 INFO - Running pre-action listener: _resource_record_pre_action 10:50:35 INFO - Running main action method: run_tests 10:50:35 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:50:35 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:50:35 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:50:35 INFO - 2017-04-25 10:50:35.865 screenresolution[1626:7772] starting screenresolution argv=screenresolution get 10:50:35 INFO - 2017-04-25 10:50:35.868 screenresolution[1626:7772] Display 0: 1600x1200x32@60 10:50:35 INFO - 2017-04-25 10:50:35.873 screenresolution[1627:7774] starting screenresolution argv=screenresolution list 10:50:35 INFO - Available Modes on Display 0 10:50:35 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:50:35 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:50:35 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:50:35 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:50:36 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:50:36 INFO - Intel Iris: 10:50:36 INFO - Chipset Model: Intel Iris 10:50:36 INFO - Type: GPU 10:50:36 INFO - Bus: Built-In 10:50:36 INFO - VRAM (Dynamic, Max): 1536 MB 10:50:36 INFO - Vendor: Intel (0x8086) 10:50:36 INFO - Device ID: 0x0a2e 10:50:36 INFO - Revision ID: 0x0009 10:50:36 INFO - Displays: 10:50:36 INFO - Display: 10:50:36 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:50:36 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:50:36 INFO - Display Serial Number: 1600x1200 60 10:50:36 INFO - Main Display: Yes 10:50:36 INFO - Mirror: Off 10:50:36 INFO - Online: Yes 10:50:36 INFO - Rotation: Supported 10:50:36 INFO - Return code: 0 10:50:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:50:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:50:36 INFO - Python 2.7.3 10:50:36 INFO - Return code: 0 10:50:36 INFO - grabbing minidump binary from tooltool 10:50:36 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')]} 10:50:36 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 0x100d6dd30>, '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 0x100c94db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100d62be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:50:36 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 10:50:36 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 10:50:36 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 10:50:36 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:50:36 INFO - Return code: 0 10:50:36 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 10:50:36 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:50:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:50:36 INFO - ENV: RUST_BACKTRACE is now 1 10:50:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 10:50:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:50:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/P8D13ObLQxu_ptB4VEUmaA/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0061', '--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 10:50:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/P8D13ObLQxu_ptB4VEUmaA/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0061 --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 10:50:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PXXeLSpPzq/Render', 10:50:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:50:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:50:36 INFO - 'HOME': '/Users/cltbld', 10:50:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:50:36 INFO - 'LOGNAME': 'cltbld', 10:50:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:50:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 10:50:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:50:36 INFO - 'MOZ_NO_REMOTE': '1', 10:50:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:50:36 INFO - 'NO_EM_RESTART': '1', 10:50:36 INFO - 'PAGER': '/bin/cat', 10:50:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:50:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:50:36 INFO - 'PWD': '/builds/slave/test', 10:50:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:50:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:50:36 INFO - 'RUST_BACKTRACE': '1', 10:50:36 INFO - 'SHELL': '/bin/bash', 10:50:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AL0l568wpr/Listeners', 10:50:36 INFO - 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/', 10:50:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:50:36 INFO - 'USER': 'cltbld', 10:50:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:50:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:50:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:50:36 INFO - 'XPC_FLAGS': '0x0', 10:50:36 INFO - 'XPC_SERVICE_NAME': '0', 10:50:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:50:36 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/P8D13ObLQxu_ptB4VEUmaA/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0061', '--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 10:50:36 INFO - mozversion application_buildid: 20170425094824 10:50:36 INFO - mozversion application_changeset: 419d01b08a9ef9d9f8698c73b573eb2ffeeef0c1 10:50:36 INFO - mozversion application_display_name: Firefox 10:50:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:50:36 INFO - mozversion application_name: Firefox 10:50:36 INFO - mozversion application_remotingname: firefox 10:50:36 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 10:50:36 INFO - mozversion application_vendor: Mozilla 10:50:36 INFO - mozversion application_version: 54.0 10:50:36 INFO - mozversion platform_buildid: 20170425094824 10:50:36 INFO - mozversion platform_changeset: 419d01b08a9ef9d9f8698c73b573eb2ffeeef0c1 10:50:36 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 10:50:36 INFO - mozversion platform_version: 54.0 10:50:36 INFO - using testdate: 1493142636 10:50:36 INFO - actual date: 1493142636 10:50:36 INFO - starting webserver on 'localhost:49240' 10:50:36 INFO - SUITE-START | Running 2 tests 10:50:36 INFO - TEST-START | dromaeo_css 10:50:36 INFO - operating with platform_type : mac_ 10:50:36 INFO - Initialising browser for dromaeo_css test... 10:50:36 INFO - TEST-INFO | started process 1637 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/tmpAHarTM/profile http://localhost:49240/getInfo.html) 10:50:38 INFO - PROCESS | 1637 | __metrics Screen width/height:1600/1200 10:50:38 INFO - PROCESS | 1637 | colorDepth:24 10:50:38 INFO - PROCESS | 1637 | Browser inner width/height: 1024/689 10:50:38 INFO - PROCESS | 1637 | __metrics 10:50:39 INFO - PROCESS | 1637 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:50:39 INFO - PROCESS | 1637 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:50:39 INFO - TEST-INFO | 1637: exit 0 10:50:39 INFO - Browser initialized. 10:50:39 INFO - Running cycle 1/1 for dromaeo_css test... 10:50:39 INFO - TEST-INFO | started process 1640 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/tmpAHarTM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:50:51 INFO - PROCESS | 1640 | RSS: Main: 164990976 10:50:51 INFO - PROCESS | 1640 | 10:53:55 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49240/tests/dromaeo/cssquery-ext.html) 10:53:57 INFO - PROCESS | 1640 | RSS: Main: 313151488 10:53:57 INFO - PROCESS | 1640 | 10:56:59 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-ext.html (next: http://localhost:49240/tests/dromaeo/cssquery-jquery.html) 10:57:00 INFO - PROCESS | 1640 | RSS: Main: 305025024 10:57:00 INFO - PROCESS | 1640 | 11:00:02 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49240/tests/dromaeo/cssquery-mootools.html) 11:00:03 INFO - PROCESS | 1640 | RSS: Main: 278069248 11:00:03 INFO - PROCESS | 1640 | 11:03:05 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49240/tests/dromaeo/cssquery-prototype.html) 11:03:06 INFO - PROCESS | 1640 | RSS: Main: 271273984 11:03:06 INFO - PROCESS | 1640 | 11:06:09 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49240/tests/dromaeo/cssquery-yui.html) 11:06:10 INFO - PROCESS | 1640 | RSS: Main: 276058112 11:06:10 INFO - PROCESS | 1640 | 11:09:13 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-yui.html (next: http://localhost:49240/tests/dromaeo/cssquery-dojo.html) 11:09:13 INFO - PROCESS | 1640 | RSS: Main: 473882624 11:09:13 INFO - PROCESS | 1640 | 11:09:13 INFO - PROCESS | 1640 | __start_tp_report 11:09:13 INFO - PROCESS | 1640 | _x_x_mozilla_page_load 11:09:13 INFO - PROCESS | 1640 | _x_x_mozilla_page_load_details 11:09:13 INFO - PROCESS | 1640 | |i|pagename|runs| 11:09:13 INFO - PROCESS | 1640 | |0;dojo.html;3049.8627561759718;3511.8946431607046;3528.206153615435;3549.361114999299;3551.6270791566867;5996.430339117787;6061.151438798572;6062.484688801446;6095.420935011178;6118.357572454895;6041.4562689357945;6084.878302433949;6103.664298463583;6112.144299798032;6117.2965109012475;5385.757640906149;5389.6496727712765;5429.782808687648;5432.782688692448;5515.227868098469;5325.547328477084;5329.733513324319;5346.492083252085;5516.558675305986;5564.749586268607;5423.511883930445;5424.376196737387;5425.484578965012;5429.809956651518;5431.456854314576;5395.973020134894;5412.377576578704;5413.296271484721;5425.755840987125;5425.864353391157;5235.816746413857;5357.1696387060065;5357.276767636358;5369.4362091980565;5402.054640437907;6008.188894499231;6015.669138197398;6028.849278768022;6030.879382412327;6030.879382412327;6257.812265632038;6302.023186406114;6322.209723784527;6342.778002769927;6348.396902294275;6425.710843012076;6434.163558737334;6437.0666253393465;6438.066480360369;6445.291017988017;6092.9695351523405;6130.386961303879;6143.109249158847;6145.139680444741;6159.7536098556;6279.843003924939;6335.588186767845;6513.967430162867;6546.607203567801;6550.70521826519;6275.309715931244;6311.621302721851;6316.905246421307;6317.936820631827;6319.778807741707;6367.140436041168;6457.483401327882;6459.289478157399;6478.4169424752;6493.253275873335;6220.129181914535;6379.96810015947;6384.48924086072;6389.552731308764;6389.648569328731;6241.812745617639;6262.342454042351;6279.780207692709;6305.716242769086;6310.842228944313;5217.634765566374;5221.060209162387;5221.190715439113;5224.2947202127225;5232.712200828915;4625.190591646448;4634.189016922025;4637.675362724577;4645.140648979949;4675.392199014106;5856.795012174553;5885.087811389241;5894.67579283135;6084.087386892002;6119.785807496716;6254.3745625438005;6270.843228919313;6279.8116056517465;6282.560220784592;6294.842628934313;5954.106883967353;5957.6127551709;5966.373530779292;5986.49114825236;6005.309389420273;5533.6403133796175;5603.439656034446;5604.775808967677;5617.775288988477;5625.212470254168;6346.587471814225;6418.422341989243;6553.311902250195;6569.671516424255;6625.204975402982;6366.4588509977175;6418.390252925965;6432.871342573028;6446.967765161145;6451.645159516272;6618.602883826793;6648.90026649591;6670.166229221348;6696.59820410777;6696.899546506904;6235.781747638811;6259.718312676032;6291.748330066929;6377.2984971654005;6382.968085159545;6386.584871983307;6410.743570257137;6412.679366031586;6424.00427933671;6445.70994305248;6153.84615384619;6300;6329.17720696325;6341.968290158519;6357;6139.952147134979;6273.905891411724;6283.654399008098;6357.872842543031;6379.872402552016;6139.185504090546;6160.291566469913;6287.842803929939;6333.145025421509;6339.524535659752;6307.463865571478;6320.5259605528845;6320.810375688737;6326.335734747785;6326.620402775849;6075.058365953284;6122.571420000557;6134.355892631388;6225.315215326401;6296.842578935563 11:09:13 INFO - PROCESS | 1640 | |1;ext.html;771.4753967302232;806.3146325623221;824.8556502612043;899.1503029636996;909.1771946388512;29446;29803.25491862702;35448.46827297592;41065.58934410655;41399.58600413995;40660.18679626405;42248;42416;42541.7872910635;42584.935376615525;7943.285104340608;8984;9759.121679048883;9766.267529935283;9768.706938791847;7937.484063535851;11670.35813030283;11863;12101.576444824434;12110.939445302762;10925.399103049329;11030.117590592734;11902.702432439215;11929.940350298237;11954;11885;11909.583164589285;11925.045996320317;11927.940360298144;11943.283402995849;11621.012213961823;11668.299902005907;11681.941590291994;11685.88314116865;11696.941515292454;39590.20819583592;39773.80113099416;39838.80080599608;39848;39957.80021099876;3972.205558888234;4046.393041043867;4048.7165898387125;4054.6756259499466;4071.043304823364;28702.425951481062;29278;30079.548806767914;30783.692163078307;30952.535711964338;3207.262329664167;3219.500977348515;3256.5115232715048;3297.1427428868665;3391.745619078579;359193;360277;360348.198259007;360457;361090;52878.73560632172;52898;52900.677483063235;52907.470925291025;52951;54758.45241547534;55042;55104.448955510736;55109.448905510435;55165.72417137888;15395.384184632714;15525.534233973;15532.145731984623;15534;15548.68902621964;11759.706007349885;12024.45889934955;13145.802812957812;13159.342032898317;13189.340532973312;8984.011758706538;10545.99813017762;10615.893841061645;10621.415822129702;10635.627753028606;4855.102897942097;5223.242629818731;5425.02349577072;5763.740631671585;5766.192733017381;1059.8712371324514;1069.3316677076828;1096.3257596578046;1131.7510147767478;1137.243732917617;26725.599116013276;27552.586711199347;28170.718292816808;28252.85873570619;28291.858540707577;1054.1777413617237;1098.6319582939805;1158.2413519144804;1163.1741463560797;1202.296656455983;11622.0873604556;12101;14420.278986050656;14612.196329201783;14762.188079655722;442300;457652.42347576766;462316;580004;580976;48023.75988120037;48188.27717584239;48409.27386089211;48440.757796211496;48637;1071.9548440270673;1205.9336736479577;1399.433229542037;1434.770436730139;1442.697033622951;22506.774932250468;25449.60027198522;26791.330216744736;27598.310042249104;28149.577756333263;43718.125637487705;43872.56127438685;43895.56104438915;43957.68126956197;43994.34008489939;461790;463957;465248;465368;466970;27687.030953916517;28450.715492844807;28591.856325746736;28655;28715.42569148647;30616.84691576528;36553.81723091367;36786.89639310825;37095.814520927226;37226.6277337234;26974;27051.729482704923;27428.040018599255;27509.587356189273;28399.432011359244;23160.884195578914;26865.731342687104;26987.865060675358;27248.591271130554;27936.72063279341;31319.21701957469;31777.8411107943;32098.35803283968;32126.357472849944;32136.83931580327;21551.595177070314;23084.307470775904;25419.61870571906;26534.203973880816;28011.859940700167;21056.68414973746;22932.656010159528;23158.421039473473;23551.764482355644;23588.702621355304 11:09:13 INFO - PROCESS | 1640 | |2;jquery.html;407.65553107624066;413.98344066237354;422.6301985762459;432.81389002728827;443.9644828413727;20155.39533813988;21103.894480527593;22335.776642233574;22666.206682766107;22689.092436302548;23158.768412315872;23306.41733956652;23652.526949461;23860;24096.795160242007;6931.757388491404;7235.348818606324;7235.746748863791;7237.203907570163;7501.4748967572295;7728.845423091535;7819.139894611588;7864.921350786505;7867.134615192324;7884.724034658788;7714.961425192866;7780.377569794403;7790.259925307115;7845.176256493071;7854.567998760066;7574.242575742409;7759.689612415496;7829.412794040441;7844.568548729818;7877.0547534295965;7453.701851925916;7552;7584.2794934481135;7588.924110758877;7634.389248860133;26827.731722682718;27169.456610867674;27169.728302716918;27183.592246116325;27604;2595.8318756559624;2891.532859003111;2958.7189217024566;3015.62304711911;3029.2729744861294;15915.602109947227;16961.57596060096;16987.915060424617;17248.965062096315;17526.737098943526;2050.846186536001;2108.493961449241;2108.536122053146;2109;2129.116416687073;98654.01345986592;106239.4688026555;116072;122832.38583807024;166928;18663.81336186648;20850;20909.581808363746;21002.78997210039;21079.473013174793;26516.07193748248;31517;32073.679263207538;32351.838240808644;32518.837405813294;8436.78908027292;10876;11067.833982490269;11099.44502774858;11228.831567526493;7667.539947603162;9185.724428267029;9225.985141634415;9237.815243695222;9434.150926416656;8184.754457366289;9108.954455227682;9384.577694003787;9392.483413412328;9583;3395.898123056312;4087.202995415865;4125.422440858282;4135.58644135584;4140.875773726793;808.4785313472777;876.5843163291239;906.9909300906907;912.3157631776168;938.1978408460805;19663.803361966482;21304.36086917395;22674;22837.657435138488;23072.307830765105;909.8589718593629;924.3899026642518;931.6552875436132;942.2885721280389;943.2312665177858;8525.44584601999;11740.58907938218;11806.940965295118;11866.347350895783;11888.821667674993;684782;733691;748450;750765;773867;146865;150873.24563377112;152641;159376.20311898598;164028.97729250175;1266.8543117541417;1283.4994352202648;1323.5896871969912;1327.0180066750536;1327.4667758738478;20059;20440;20763.377098687062;20847.687284691045;20866.37400877976;60987.695061524406;61448.46378840565;61668.691656543226;61901.07148392868;62003.379966201566;81689.18310816816;86147.70778438203;87269;89055.55472222598;89434.55282723544;11719.41402929833;11963.538553496504;12146.574869879512;12191.329476878502;12239.877601223874;13269.336533173495;13329.133606315558;13561.864381356454;13787.379567919266;13898.652533686334;10170.288079834341;11675.299482031105;11762.647120586396;12019.939900300442;12150.57472988441;10685.038346548537;10907;10937.453127343442;11221.887781122085;11468.369239691898;11140.33158010522;11501.597444089417;11999;12017.879821201675;12039.819402708792;11718.589849355232;11762.529498820293;11879.287242765462;11997.280163190237;12115.394230288626;6220.160278362363;11643.243189192675;11703.063754899758;11735.061195104541;11963.222390544586 11:09:13 INFO - PROCESS | 1640 | |3;mootools.html;1329.6011196641011;1329.9933500332497;1554.3238691169336;1555.5333399980007;1574.126359870272;8643.74068777936;9015.233705135055;9039.954800225998;9119.77200569986;9126.817463650723;8942.865857012133;10351.534180961857;10659.253852230328;10806.081483073947;10888;2198.362474882282;2234.1398561553838;2236.2285011670947;2236.39617303328;2237.3847192022163;2187.9234226802064;2287.1308902617066;2323.604987152188;2357.0571771291534;2367.4673198530277;1883.6044430669576;1956.2370675436591;2040.0921589892503;2341.800946919514;2365.432296248905;2340.742518322983;2358.13927916311;2359.4809141988735;2366.751491093436;2366.9644955325684;2317.5712493188644;2341.988290058556;2347.7769611886843;2349.4361353275262;2353.294011796454;10470.267081304311;10653.680389588324;10671;10674.626388076458;10683.30558513694;5513.641613295163;5658.66048037115;5668.404817494145;5684.658920464785;5687.033204355228;3261.2173078461237;3355.865765369382;3541.1678255609913;3551.786892786415;3556.075420390717;1154.7979103656826;1163.8603367595858;1190.149043433949;1205.4454950722677;1207.5290636651712;14417.711645767025;14453.638659033502;14576.489822856256;14577.999999999894;14599.343029563588;3944.4872166618156;4486.887827804266;4601.079784043205;4704.623630109583;4774.355462012653;12331.321777302155;12337;12392.380380980914;12399.628011159679;12406.441710123067;5773.336066352339;5788.160716696139;5790.189373487715;5807.390224026501;5812.157237200582;4977.377827771528;5078.06055879656;5190.688558686491;5228.6339956203465;5235.0576896159055;3642.2897534980425;3717.182219911615;3719.479272901796;3761.1161377076364;3772.453294149386;955.3790036476207;1004.8492726090999;1009.5507499162949;1010.5048526222098;1020.3265844542566;695.8330000799772;824.6577670266892;826.3017750001239;831.4055450353027;839.8740188971581;6422.165118534654;6448.903266451007;6574.572652777554;6633.2040155181685;6757.459403247728;982.003266684316;984.625842179967;997.7455748784158;1001.3241062283075;1034.3225187502198;3661.9450708239397;3956.649577428244;4001.459802926626;4068.898277543085;4198.265303571924;12297.323647199311;12947.741045179044;12964;12968.35158242084;12968.935155324352;12465.501379944883;12674.556390526288;12950.093493455555;12953.028522860635;12982.285974271317;9964.501774911225;9972;9974.800503990025;9992.65025724096;10117.140043096271;6375.9362406377195;6418.679066046586;6457.483401327789;6523.347665233438;6612.272650008399;11833.290002599872;11962.46168922418;11971.76056478883;12093.758124837277;12239.204451710966;11927.701807454883;11957.820632690691;12055.57805476804;12165.452554634885;12273.263604183421;7924.366050716044;7970.521768693897;8064.516129032277;8075.798105047421;8090.11008789021;9762.072603102693;9950.402975821475;9964.202863771026;9966.50167491637;9997.850032249376;8152.144024877302;8377.790555236168;8383.748487545383;8389;8449.02836173848;8043.396745244013;8093.676252949816;8125.959370203112;8152.184781521801;8205.712800052208;7579.393648507996;7728.149903510497;7809.609519524115;7826.7651970440975;7833.608319583884;5606.635568688022;5617.494425501724;5752.7698892043845;5805.506531944832;5835.124731290341;5869.119632055226;5931.258592675916;5976;6012.488938440281;6112.358202388685 11:09:13 INFO - PROCESS | 1640 | |4;prototype.html;378.317137566692;379.6867584242999;382.74356181358485;386.94195870619404;391.962763537464;4678.543764523631;5195.220716892468;5215.731156946731;5258.842234732954;5264.921026184606;4498.482674492434;4996.525330093645;5009.373828271466;5118.436971933084;5162.889978654589;3384.798396569219;3499.8425070871745;3524.9953763177564;3983.4423180754716;4053.250148722496;3341.3484370547753;3372.5666591698555;3887.9891228280567;4003.259397011562;4027.2549578327958;3375.4093033719123;3770.9434358484646;3793.2825830685942;4009.7594144351287;4035.4955630546183;3082.460569400346;3805.3824320801286;3850.7304488685804;4012.598740125964;4020.597940205985;2906.6657334406605;3561.3411518869093;3568.678818906285;3570.6786389225094;3614.34941710492;4609.492955774862;5090.796368145269;5091.745412729349;5097.4197998620175;5150.742462876841;3955;4120.608542188487;4528.3207518872105;4657.930131048037;4767.284907263938;4928.507149285078;5072.467390923974;5226.320578324793;5316.680999140064;5448.972755136238;3765;3826.655600995896;3975.1652153047607;4010.375797801895;4034.11249525104;4997.375328083989;5219.295395121648;5561.582881283879;5868.354481007086;5919.881602367972;4745.549172828576;4934.432540257844;4934.851954441372;4937.543424689653;4963.8014479421145;4560.498345182027;5084.847454576368;5100.438951715309;5103.234514822732;5129.666571672829;4676.415448068991;5196.584273258206;5229.137192363293;5240.318758561439;5322.296865003162;4693.342931989524;5342.813001544927;5346.839594812084;5545.334559852843;5564.582656300713;1417.1922004457567;1536.347052502682;1587.3650539784178;1592.936282548685;1600;1094.5402930769096;1115.866096068477;1116.7040734205443;1200.8438902942562;1224.5530381410722;4751.3348131261655;4971.980743947482;5163.554204822655;5265.630935956602;5290;5407.810726624549;5421.539169170585;5648.71756412186;5759.90561793258;5807.128930660435;4502.099580083931;4893.657443978958;5226.320578324793;5269.573558211121;5271.576674297918;2617.167982412319;2644.7751941085226;2768.518842419296;2788.344738986337;3005.6844031376827;5396.487333703292;5807.738651760681;5979.531871514511;5980.2657229402985;6067.423594758579;4529.614982726439;4924.5980225706435;5366.517013468807;5477.780888764484;5689.345725241567;4890.975545122252;5200.439868039573;5882.588218824727;5990.850228744316;6029.613188966475;5135.794568217229;5706.944215320179;5707.6575405475805;5711.087904785235;5806.1000544915605;4761.76191190446;4913.887028577746;5398.892022159456;5692.686902220417;5749.885002299847;4949.901001980013;5164.690118592896;5772.19189313488;5992.370801065999;6023.3374328824675;4027.335489644176;4117.402976568321;4697.647676424213;4706.364640773589;4715.6227501799085;4983.700977941335;5137;5329.269511341999;5782.335031471434;5930.911036334544;4968.801247950186;5088.923666144937;5549.916751248816;5612.607117501736;5628.60599758013;5009.323741294878;5133.794648214179;5157.200633901752;5565.471280228372;5594.510367973132;5413.215083812904;5425;5428.7285635718845;5486.625725178907;5518.558515318685;5022.4977502249485;5572.099530328867;5578.386377498553;5582.581306402118;5631.465010824129;4309.653758826356;4464;4612.100640375094;5443.618946673695;5473.713677285914 11:09:13 INFO - PROCESS | 1640 | |5;yui.html;756.3608750605737;757.3297631596035;868.2099289646419;881.5680316644844;914.4787471141452;15602.141882196474;17087.401940932054;17088.829111708877;18097.819021809777;18572.814271857278;15247.39010439584;18231.72652410215;18634.34779782708;18685;18914.905425472887;992.4541502173794;1030.4538594544904;1034.120997152422;1035.223582313265;1036.119298596191;1008.2776503440739;1022.7085280695003;1027.0910244433692;1037.1547189040907;1039.516624769482;1074.7152004718755;1075.4461452352045;1078.4984981983375;1080.3140006096146;1081.3674000709555;1072.7318170457386;1073.5598404654133;1073.6295977887617;1074.1514203779004;1074.7474343529263;796.3788245168778;797.0515087046455;797.4816369359904;797.7447216890597;797.9281864632153;16532.83467165337;16553.917230413892;16586.917065414596;18086.276548938025;18324.35864744741;14666;14745.557633270912;14833.55499335011;14868;14871.553853384416;12070.637880863587;12162.635120946386;12191.695207619792;12270.938645306805;12451.190672606252;3816.141368192162;3818.064574179316;3874.128321127752;3888.8833334999713;3963.128111815396;58717.597057383886;100319;116900.41549792282;118976.40511797472;121565;11206.383648899226;11476.713082172846;11490.54037838477;11584.42077896102;12003.759924801456;22782.20262290812;22920.656190157162;22964.311070667907;23011.42471438194;23034.193803216807;8393.580320983927;8444.704435344733;8539.914600854036;8540.701075462453;8653.264472519906;4451.132029254329;4490.2142125127975;4528.252838281713;4588.105319462739;4640.32715256286;3489.5986961499243;3562.5724913010085;3575.3921833288405;3615.313090512794;3622.673959343672;642.1491523731075;645.7868903261913;654.2345455816705;656.5633853487377;659.2682122843639;561.7500212405522;582.7872826418327;583.76941108262;588.1677426441537;594.9940500595026;9075.909240907638;10983.584612867511;11050.944745276222;11105.83341249882;11112.888871111347;694.399344566946;729.2598013016792;735.4410647907629;739.0577014306801;745.1803016681607;4485.48416932057;4834.879128021757;5235.424103348629;5248.63259571834;5292.364916210079;98336.50831745795;108095.45952270189;108238;111934;112718;61977.760444791755;69074;87838;92053;94126;58300;80642.98392540234;80953.19046809574;83189.84050797558;87031;8685.91314086851;11257.592800899887;11512.251703639571;11582.94208528952;11611.883881161419;37835.432468512445;48973.04107835789;54170.64573385697;54453;55875.44124558865;70569.58860822857;71693;71952;72386;74081;14112.858871411565;14236.21700806424;14427.855721442651;14604.831613470684;14787.408503659733;15281.694366112837;15423.537293881202;15670.373185072469;15723.685526289639;15753.054816711034;13979.391535844863;14205.084661106004;14287.857121429068;14571.41714331415;14610.269486525418;13910.443582257001;14332.57002289933;14453.710925781215;14461.78307325412;15032.924835375754;11891.464884080064;11958.222715523463;13266.469341226242;14192.716145676823;14686.265686715835;9525.229186852555;9698.56356463975;10135.442550659785;10277.383356998604;10481;10134.442605656759;10186.696389474977;11381.477223169513;11751;11763.353015583883 11:09:13 INFO - PROCESS | 1640 | __end_tp_report 11:09:13 INFO - PROCESS | 1640 | __start_cc_report 11:09:13 INFO - PROCESS | 1640 | _x_x_mozilla_cycle_collect,1365 11:09:13 INFO - PROCESS | 1640 | __end_cc_report 11:09:13 INFO - PROCESS | 1640 | __startTimestamp1493143753941__endTimestamp 11:09:13 INFO - PROCESS | 1640 | 11:09:13 INFO - PROCESS | 1640 | ------- Summary: start ------- 11:09:13 INFO - PROCESS | 1640 | Number of tests: 6 11:09:13 INFO - PROCESS | 1640 | 11:09:13 INFO - PROCESS | 1640 | [#0] dojo.html Cycles:165 Average:5960.67 Median:6220.13 stddev:644.56 (10.4%) stddev-sans-first:604.74 11:09:13 INFO - PROCESS | 1640 | Values: 3049.9 3511.9 3528.2 3549.4 3551.6 5996.4 6061.2 6062.5 6095.4 6118.4 6041.5 6084.9 6103.7 6112.1 6117.3 5385.8 5389.6 5429.8 5432.8 5515.2 5325.5 5329.7 5346.5 5516.6 5564.7 5423.5 5424.4 5425.5 5429.8 5431.5 5396.0 5412.4 5413.3 5425.8 5425.9 5235.8 5357.2 5357.3 5369.4 5402.1 6008.2 6015.7 6028.8 6030.9 6030.9 6257.8 6302.0 6322.2 6342.8 6348.4 6425.7 6434.2 6437.1 6438.1 6445.3 6093.0 6130.4 6143.1 6145.1 6159.8 6279.8 6335.6 6514.0 6546.6 6550.7 6275.3 6311.6 6316.9 6317.9 6319.8 6367.1 6457.5 6459.3 6478.4 6493.3 6220.1 6380.0 6384.5 6389.6 6389.6 6241.8 6262.3 6279.8 6305.7 6310.8 5217.6 5221.1 5221.2 5224.3 5232.7 4625.2 4634.2 4637.7 4645.1 4675.4 5856.8 5885.1 5894.7 6084.1 6119.8 6254.4 6270.8 6279.8 6282.6 6294.8 5954.1 5957.6 5966.4 5986.5 6005.3 5533.6 5603.4 5604.8 5617.8 5625.2 6346.6 6418.4 6553.3 6569.7 6625.2 6366.5 6418.4 6432.9 6447.0 6451.6 6618.6 6648.9 6670.2 6696.6 6696.9 6235.8 6259.7 6291.7 6377.3 6383.0 6386.6 6410.7 6412.7 6424.0 6445.7 6153.8 6300.0 6329.2 6342.0 6357.0 6140.0 6273.9 6283.7 6357.9 6379.9 6139.2 6160.3 6287.8 6333.1 6339.5 6307.5 6320.5 6320.8 6326.3 6326.6 6075.1 6122.6 6134.4 6225.3 6296.8 11:09:13 INFO - PROCESS | 1640 | 11:09:13 INFO - PROCESS | 1640 | [#1] ext.html Cycles:180 Average:57032.56 Median:29624.63 stddev:119512.53 (403.4%) stddev-sans-first:119773.15 11:09:13 INFO - PROCESS | 1640 | Values: 771.5 806.3 824.9 899.2 909.2 29446.0 29803.3 35448.5 41065.6 41399.6 40660.2 42248.0 42416.0 42541.8 42584.9 7943.3 8984.0 9759.1 9766.3 9768.7 7937.5 11670.4 11863.0 12101.6 12110.9 10925.4 11030.1 11902.7 11929.9 11954.0 11885.0 11909.6 11925.0 11927.9 11943.3 11621.0 11668.3 11681.9 11685.9 11696.9 39590.2 39773.8 39838.8 39848.0 39957.8 3972.2 4046.4 4048.7 4054.7 4071.0 28702.4 29278.0 30079.5 30783.7 30952.5 3207.3 3219.5 3256.5 3297.1 3391.7 359193.0 360277.0 360348.2 360457.0 361090.0 52878.7 52898.0 52900.7 52907.5 52951.0 54758.5 55042.0 55104.4 55109.4 55165.7 15395.4 15525.5 15532.1 15534.0 15548.7 11759.7 12024.5 13145.8 13159.3 13189.3 8984.0 10546.0 10615.9 10621.4 10635.6 4855.1 5223.2 5425.0 5763.7 5766.2 1059.9 1069.3 1096.3 1131.8 1137.2 26725.6 27552.6 28170.7 28252.9 28291.9 1054.2 1098.6 1158.2 1163.2 1202.3 11622.1 12101.0 14420.3 14612.2 14762.2 442300.0 457652.4 462316.0 580004.0 580976.0 48023.8 48188.3 48409.3 48440.8 48637.0 1072.0 1205.9 1399.4 1434.8 1442.7 22506.8 25449.6 26791.3 27598.3 28149.6 43718.1 43872.6 43895.6 43957.7 43994.3 461790.0 463957.0 465248.0 465368.0 466970.0 27687.0 28450.7 28591.9 28655.0 28715.4 30616.8 36553.8 36786.9 37095.8 37226.6 26974.0 27051.7 27428.0 27509.6 28399.4 23160.9 26865.7 26987.9 27248.6 27936.7 31319.2 31777.8 32098.4 32126.4 32136.8 21551.6 23084.3 25419.6 26534.2 28011.9 21056.7 22932.7 23158.4 23551.8 23588.7 11:09:13 INFO - PROCESS | 1640 | 11:09:13 INFO - PROCESS | 1640 | [#2] jquery.html Cycles:180 Average:42224.45 Median:13346.31 stddev:122664.01 (919.1%) stddev-sans-first:122967.92 11:09:13 INFO - PROCESS | 1640 | Values: 407.7 414.0 422.6 432.8 444.0 20155.4 21103.9 22335.8 22666.2 22689.1 23158.8 23306.4 23652.5 23860.0 24096.8 6931.8 7235.3 7235.7 7237.2 7501.5 7728.8 7819.1 7864.9 7867.1 7884.7 7715.0 7780.4 7790.3 7845.2 7854.6 7574.2 7759.7 7829.4 7844.6 7877.1 7453.7 7552.0 7584.3 7588.9 7634.4 26827.7 27169.5 27169.7 27183.6 27604.0 2595.8 2891.5 2958.7 3015.6 3029.3 15915.6 16961.6 16987.9 17249.0 17526.7 2050.8 2108.5 2108.5 2109.0 2129.1 98654.0 106239.5 116072.0 122832.4 166928.0 18663.8 20850.0 20909.6 21002.8 21079.5 26516.1 31517.0 32073.7 32351.8 32518.8 8436.8 10876.0 11067.8 11099.4 11228.8 7667.5 9185.7 9226.0 9237.8 9434.2 8184.8 9109.0 9384.6 9392.5 9583.0 3395.9 4087.2 4125.4 4135.6 4140.9 808.5 876.6 907.0 912.3 938.2 19663.8 21304.4 22674.0 22837.7 23072.3 909.9 924.4 931.7 942.3 943.2 8525.4 11740.6 11806.9 11866.3 11888.8 684782.0 733691.0 748450.0 750765.0 773867.0 146865.0 150873.2 152641.0 159376.2 164029.0 1266.9 1283.5 1323.6 1327.0 1327.5 20059.0 20440.0 20763.4 20847.7 20866.4 60987.7 61448.5 61668.7 61901.1 62003.4 81689.2 86147.7 87269.0 89055.6 89434.6 11719.4 11963.5 12146.6 12191.3 12239.9 13269.3 13329.1 13561.9 13787.4 13898.7 10170.3 11675.3 11762.6 12019.9 12150.6 10685.0 10907.0 10937.5 11221.9 11468.4 11140.3 11501.6 11999.0 12017.9 12039.8 11718.6 11762.5 11879.3 11997.3 12115.4 6220.2 11643.2 11703.1 11735.1 11963.2 11:09:13 INFO - PROCESS | 1640 | 11:09:13 INFO - PROCESS | 1640 | [#3] mootools.html Cycles:180 Average:6459.89 Median:3766.78 stddev:4026.62 (106.9%) stddev-sans-first:4019.46 11:09:13 INFO - PROCESS | 1640 | Values: 1329.6 1330.0 1554.3 1555.5 1574.1 8643.7 9015.2 9040.0 9119.8 9126.8 8942.9 10351.5 10659.3 10806.1 10888.0 2198.4 2234.1 2236.2 2236.4 2237.4 2187.9 2287.1 2323.6 2357.1 2367.5 1883.6 1956.2 2040.1 2341.8 2365.4 2340.7 2358.1 2359.5 2366.8 2367.0 2317.6 2342.0 2347.8 2349.4 2353.3 10470.3 10653.7 10671.0 10674.6 10683.3 5513.6 5658.7 5668.4 5684.7 5687.0 3261.2 3355.9 3541.2 3551.8 3556.1 1154.8 1163.9 1190.1 1205.4 1207.5 14417.7 14453.6 14576.5 14578.0 14599.3 3944.5 4486.9 4601.1 4704.6 4774.4 12331.3 12337.0 12392.4 12399.6 12406.4 5773.3 5788.2 5790.2 5807.4 5812.2 4977.4 5078.1 5190.7 5228.6 5235.1 3642.3 3717.2 3719.5 3761.1 3772.5 955.4 1004.8 1009.6 1010.5 1020.3 695.8 824.7 826.3 831.4 839.9 6422.2 6448.9 6574.6 6633.2 6757.5 982.0 984.6 997.7 1001.3 1034.3 3661.9 3956.6 4001.5 4068.9 4198.3 12297.3 12947.7 12964.0 12968.4 12968.9 12465.5 12674.6 12950.1 12953.0 12982.3 9964.5 9972.0 9974.8 9992.7 10117.1 6375.9 6418.7 6457.5 6523.3 6612.3 11833.3 11962.5 11971.8 12093.8 12239.2 11927.7 11957.8 12055.6 12165.5 12273.3 7924.4 7970.5 8064.5 8075.8 8090.1 9762.1 9950.4 9964.2 9966.5 9997.9 8152.1 8377.8 8383.7 8389.0 8449.0 8043.4 8093.7 8126.0 8152.2 8205.7 7579.4 7728.1 7809.6 7826.8 7833.6 5606.6 5617.5 5752.8 5805.5 5835.1 5869.1 5931.3 5976.0 6012.5 6112.4 11:09:13 INFO - PROCESS | 1640 | 11:09:13 INFO - PROCESS | 1640 | [#4] prototype.html Cycles:180 Average:4553.50 Median:5015.94 stddev:1324.50 (26.4%) stddev-sans-first:1290.61 11:09:13 INFO - PROCESS | 1640 | Values: 378.3 379.7 382.7 386.9 392.0 4678.5 5195.2 5215.7 5258.8 5264.9 4498.5 4996.5 5009.4 5118.4 5162.9 3384.8 3499.8 3525.0 3983.4 4053.3 3341.3 3372.6 3888.0 4003.3 4027.3 3375.4 3770.9 3793.3 4009.8 4035.5 3082.5 3805.4 3850.7 4012.6 4020.6 2906.7 3561.3 3568.7 3570.7 3614.3 4609.5 5090.8 5091.7 5097.4 5150.7 3955.0 4120.6 4528.3 4657.9 4767.3 4928.5 5072.5 5226.3 5316.7 5449.0 3765.0 3826.7 3975.2 4010.4 4034.1 4997.4 5219.3 5561.6 5868.4 5919.9 4745.5 4934.4 4934.9 4937.5 4963.8 4560.5 5084.8 5100.4 5103.2 5129.7 4676.4 5196.6 5229.1 5240.3 5322.3 4693.3 5342.8 5346.8 5545.3 5564.6 1417.2 1536.3 1587.4 1592.9 1600.0 1094.5 1115.9 1116.7 1200.8 1224.6 4751.3 4972.0 5163.6 5265.6 5290.0 5407.8 5421.5 5648.7 5759.9 5807.1 4502.1 4893.7 5226.3 5269.6 5271.6 2617.2 2644.8 2768.5 2788.3 3005.7 5396.5 5807.7 5979.5 5980.3 6067.4 4529.6 4924.6 5366.5 5477.8 5689.3 4891.0 5200.4 5882.6 5990.9 6029.6 5135.8 5706.9 5707.7 5711.1 5806.1 4761.8 4913.9 5398.9 5692.7 5749.9 4949.9 5164.7 5772.2 5992.4 6023.3 4027.3 4117.4 4697.6 4706.4 4715.6 4983.7 5137.0 5329.3 5782.3 5930.9 4968.8 5088.9 5549.9 5612.6 5628.6 5009.3 5133.8 5157.2 5565.5 5594.5 5413.2 5425.0 5428.7 5486.6 5518.6 5022.5 5572.1 5578.4 5582.6 5631.5 4309.7 4464.0 4612.1 5443.6 5473.7 11:09:13 INFO - PROCESS | 1640 | 11:09:13 INFO - PROCESS | 1640 | [#5] yui.html Cycles:180 Average:20958.87 Median:18092.05 stddev:29600.71 (163.6%) stddev-sans-first:29644.87 11:09:13 INFO - PROCESS | 1640 | Values: 756.4 757.3 868.2 881.6 914.5 15602.1 17087.4 17088.8 18097.8 18572.8 15247.4 18231.7 18634.3 18685.0 18914.9 992.5 1030.5 1034.1 1035.2 1036.1 1008.3 1022.7 1027.1 1037.2 1039.5 1074.7 1075.4 1078.5 1080.3 1081.4 1072.7 1073.6 1073.6 1074.2 1074.7 796.4 797.1 797.5 797.7 797.9 16532.8 16553.9 16586.9 18086.3 18324.4 14666.0 14745.6 14833.6 14868.0 14871.6 12070.6 12162.6 12191.7 12270.9 12451.2 3816.1 3818.1 3874.1 3888.9 3963.1 58717.6 100319.0 116900.4 118976.4 121565.0 11206.4 11476.7 11490.5 11584.4 12003.8 22782.2 22920.7 22964.3 23011.4 23034.2 8393.6 8444.7 8539.9 8540.7 8653.3 4451.1 4490.2 4528.3 4588.1 4640.3 3489.6 3562.6 3575.4 3615.3 3622.7 642.1 645.8 654.2 656.6 659.3 561.8 582.8 583.8 588.2 595.0 9075.9 10983.6 11050.9 11105.8 11112.9 694.4 729.3 735.4 739.1 745.2 4485.5 4834.9 5235.4 5248.6 5292.4 98336.5 108095.5 108238.0 111934.0 112718.0 61977.8 69074.0 87838.0 92053.0 94126.0 58300.0 80643.0 80953.2 83189.8 87031.0 8685.9 11257.6 11512.3 11582.9 11611.9 37835.4 48973.0 54170.6 54453.0 55875.4 70569.6 71693.0 71952.0 72386.0 74081.0 14112.9 14236.2 14427.9 14604.8 14787.4 15281.7 15423.5 15670.4 15723.7 15753.1 13979.4 14205.1 14287.9 14571.4 14610.3 13910.4 14332.6 14453.7 14461.8 15032.9 11891.5 11958.2 13266.5 14192.7 14686.3 9525.2 9698.6 10135.4 10277.4 10481.0 10134.4 10186.7 11381.5 11751.0 11763.4 11:09:13 INFO - PROCESS | 1640 | -------- Summary: end -------- 11:09:13 INFO - PROCESS | 1640 | 11:09:14 INFO - TEST-INFO | 1640: exit 0 11:09:14 INFO - TEST-OK | dromaeo_css | took 1118074ms 11:09:14 INFO - TEST-START | kraken 11:09:14 INFO - operating with platform_type : mac_ 11:09:14 INFO - Initialising browser for kraken test... 11:09:14 INFO - TEST-INFO | started process 1647 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/tmpKhju3O/profile http://localhost:49240/getInfo.html) 11:09:16 INFO - PROCESS | 1647 | __metrics Screen width/height:1600/1200 11:09:16 INFO - PROCESS | 1647 | colorDepth:24 11:09:16 INFO - PROCESS | 1647 | Browser inner width/height: 1024/689 11:09:16 INFO - PROCESS | 1647 | __metrics 11:09:17 INFO - PROCESS | 1647 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:09:17 INFO - PROCESS | 1647 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:09:17 INFO - TEST-INFO | 1647: exit 0 11:09:17 INFO - Browser initialized. 11:09:17 INFO - Running cycle 1/1 for kraken test... 11:09:17 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/tmpKhju3O/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:09:29 INFO - PROCESS | 1649 | RSS: Main: 169365504 11:09:29 INFO - PROCESS | 1649 | 11:09:32 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-beat-detection) 11:09:33 INFO - PROCESS | 1649 | RSS: Main: 220020736 11:09:33 INFO - PROCESS | 1649 | 11:09:36 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-dft) 11:09:36 INFO - PROCESS | 1649 | RSS: Main: 229642240 11:09:36 INFO - PROCESS | 1649 | 11:09:39 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-fft) 11:09:40 INFO - PROCESS | 1649 | RSS: Main: 326541312 11:09:40 INFO - PROCESS | 1649 | 11:09:42 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-oscillator) 11:09:43 INFO - PROCESS | 1649 | RSS: Main: 230821888 11:09:43 INFO - PROCESS | 1649 | 11:09:45 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:09:45 INFO - PROCESS | 1649 | RSS: Main: 231948288 11:09:45 INFO - PROCESS | 1649 | 11:09:48 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-darkroom) 11:09:49 INFO - PROCESS | 1649 | RSS: Main: 272297984 11:09:49 INFO - PROCESS | 1649 | 11:09:52 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-desaturate) 11:09:52 INFO - PROCESS | 1649 | RSS: Main: 273100800 11:09:52 INFO - PROCESS | 1649 | 11:09:55 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49240/tests/kraken/driver.html?testName=json-parse-financial) 11:09:56 INFO - PROCESS | 1649 | RSS: Main: 272125952 11:09:56 INFO - PROCESS | 1649 | 11:09:57 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49240/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:09:58 INFO - PROCESS | 1649 | RSS: Main: 249937920 11:09:58 INFO - PROCESS | 1649 | 11:10:00 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:10:01 INFO - PROCESS | 1649 | RSS: Main: 252190720 11:10:01 INFO - PROCESS | 1649 | 11:10:03 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:10:03 INFO - PROCESS | 1649 | RSS: Main: 258662400 11:10:03 INFO - PROCESS | 1649 | 11:10:06 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:10:07 INFO - PROCESS | 1649 | RSS: Main: 273559552 11:10:07 INFO - PROCESS | 1649 | 11:10:10 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:10:10 INFO - PROCESS | 1649 | RSS: Main: 267808768 11:10:10 INFO - PROCESS | 1649 | 11:10:12 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49240/tests/kraken/driver.html?testName=ai-astar) 11:10:12 INFO - PROCESS | 1649 | RSS: Main: 312315904 11:10:12 INFO - PROCESS | 1649 | 11:10:12 INFO - PROCESS | 1649 | __start_tp_report 11:10:12 INFO - PROCESS | 1649 | _x_x_mozilla_page_load 11:10:12 INFO - PROCESS | 1649 | _x_x_mozilla_page_load_details 11:10:12 INFO - PROCESS | 1649 | |i|pagename|runs| 11:10:12 INFO - PROCESS | 1649 | |0;ai-astar;119;118;117;117;117;117;117;117;117;117 11:10:12 INFO - PROCESS | 1649 | |1;audio-beat-detection;129;108;105;139;109;108;131;135;151;106 11:10:12 INFO - PROCESS | 1649 | |2;audio-dft;187;186;199;263;203;195;185;185;185;188 11:10:12 INFO - PROCESS | 1649 | |3;audio-fft;82;59;60;91;63;59;60;58;75;60 11:10:12 INFO - PROCESS | 1649 | |4;audio-oscillator;86;69;86;70;71;70;105;99;98;86 11:10:12 INFO - PROCESS | 1649 | |5;imaging-gaussian-blur;89;88;89;88;88;88;89;87;89;88 11:10:12 INFO - PROCESS | 1649 | |6;imaging-darkroom;94;95;95;94;95;94;95;94;93;95 11:10:12 INFO - PROCESS | 1649 | |7;imaging-desaturate;83;84;85;87;85;85;84;84;83;86 11:10:12 INFO - PROCESS | 1649 | |8;json-parse-financial;64;62;60;63;64;64;66;63;62;63 11:10:12 INFO - PROCESS | 1649 | |9;json-stringify-tinderbox;59;66;64;63;60;58;61;62;83;86 11:10:12 INFO - PROCESS | 1649 | |10;stanford-crypto-aes;84;78;85;83;81;74;82;81;81;88 11:10:12 INFO - PROCESS | 1649 | |11;stanford-crypto-ccm;140;139;146;139;142;140;141;142;180;152 11:10:12 INFO - PROCESS | 1649 | |12;stanford-crypto-pbkdf2;163;160;162;167;162;162;162;162;162;163 11:10:12 INFO - PROCESS | 1649 | |13;stanford-crypto-sha256-iterative;64;65;64;64;64;66;63;65;63;63 11:10:12 INFO - PROCESS | 1649 | __end_tp_report 11:10:12 INFO - PROCESS | 1649 | __start_cc_report 11:10:12 INFO - PROCESS | 1649 | _x_x_mozilla_cycle_collect,2073 11:10:12 INFO - PROCESS | 1649 | __end_cc_report 11:10:12 INFO - PROCESS | 1649 | __startTimestamp1493143812789__endTimestamp 11:10:12 INFO - PROCESS | 1649 | 11:10:12 INFO - PROCESS | 1649 | ------- Summary: start ------- 11:10:12 INFO - PROCESS | 1649 | Number of tests: 14 11:10:12 INFO - PROCESS | 1649 | 11:10:12 INFO - PROCESS | 1649 | [#0] ai-astar Cycles:10 Average:117.30 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.33 11:10:12 INFO - PROCESS | 1649 | Values: 119.0 118.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 11:10:12 INFO - PROCESS | 1649 | 11:10:12 INFO - PROCESS | 1649 | [#1] audio-beat-detection Cycles:10 Average:122.10 Median:130.00 stddev:16.78 (12.9%) stddev-sans-first:17.61 11:10:12 INFO - PROCESS | 1649 | Values: 129.0 108.0 105.0 139.0 109.0 108.0 131.0 135.0 151.0 106.0 11:10:12 INFO - PROCESS | 1649 | 11:10:12 INFO - PROCESS | 1649 | [#2] audio-dft Cycles:10 Average:197.60 Median:191.50 stddev:23.88 (12.5%) stddev-sans-first:25.01 11:10:12 INFO - PROCESS | 1649 | Values: 187.0 186.0 199.0 263.0 203.0 195.0 185.0 185.0 185.0 188.0 11:10:12 INFO - PROCESS | 1649 | 11:10:12 INFO - PROCESS | 1649 | [#3] audio-fft Cycles:10 Average:66.70 Median:61.50 stddev:11.72 (19.1%) stddev-sans-first:11.05 11:10:12 INFO - PROCESS | 1649 | Values: 82.0 59.0 60.0 91.0 63.0 59.0 60.0 58.0 75.0 60.0 11:10:12 INFO - PROCESS | 1649 | 11:10:12 INFO - PROCESS | 1649 | [#4] audio-oscillator Cycles:10 Average:84.00 Median:86.00 stddev:13.58 (15.8%) stddev-sans-first:14.39 11:10:12 INFO - PROCESS | 1649 | Values: 86.0 69.0 86.0 70.0 71.0 70.0 105.0 99.0 98.0 86.0 11:10:12 INFO - PROCESS | 1649 | 11:10:12 INFO - PROCESS | 1649 | [#5] imaging-gaussian-blur Cycles:10 Average:88.30 Median:88.50 stddev:0.67 (0.8%) stddev-sans-first:0.67 11:10:12 INFO - PROCESS | 1649 | Values: 89.0 88.0 89.0 88.0 88.0 88.0 89.0 87.0 89.0 88.0 11:10:12 INFO - PROCESS | 1649 | 11:10:12 INFO - PROCESS | 1649 | [#6] imaging-darkroom Cycles:10 Average:94.40 Median:95.00 stddev:0.70 (0.7%) stddev-sans-first:0.73 11:10:12 INFO - PROCESS | 1649 | Values: 94.0 95.0 95.0 94.0 95.0 94.0 95.0 94.0 93.0 95.0 11:10:12 INFO - PROCESS | 1649 | 11:10:12 INFO - PROCESS | 1649 | [#7] imaging-desaturate Cycles:10 Average:84.60 Median:85.00 stddev:1.26 (1.5%) stddev-sans-first:1.20 11:10:12 INFO - PROCESS | 1649 | Values: 83.0 84.0 85.0 87.0 85.0 85.0 84.0 84.0 83.0 86.0 11:10:12 INFO - PROCESS | 1649 | 11:10:12 INFO - PROCESS | 1649 | [#8] json-parse-financial Cycles:10 Average:63.10 Median:63.50 stddev:1.60 (2.5%) stddev-sans-first:1.66 11:10:12 INFO - PROCESS | 1649 | Values: 64.0 62.0 60.0 63.0 64.0 64.0 66.0 63.0 62.0 63.0 11:10:12 INFO - PROCESS | 1649 | 11:10:12 INFO - PROCESS | 1649 | [#9] json-stringify-tinderbox Cycles:10 Average:66.20 Median:63.50 stddev:9.95 (15.7%) stddev-sans-first:10.21 11:10:12 INFO - PROCESS | 1649 | Values: 59.0 66.0 64.0 63.0 60.0 58.0 61.0 62.0 83.0 86.0 11:10:12 INFO - PROCESS | 1649 | 11:10:12 INFO - PROCESS | 1649 | [#10] stanford-crypto-aes Cycles:10 Average:81.70 Median:82.50 stddev:3.83 (4.6%) stddev-sans-first:3.97 11:10:12 INFO - PROCESS | 1649 | Values: 84.0 78.0 85.0 83.0 81.0 74.0 82.0 81.0 81.0 88.0 11:10:12 INFO - PROCESS | 1649 | 11:10:12 INFO - PROCESS | 1649 | [#11] stanford-crypto-ccm Cycles:10 Average:146.10 Median:142.00 stddev:12.56 (8.8%) stddev-sans-first:13.12 11:10:12 INFO - PROCESS | 1649 | Values: 140.0 139.0 146.0 139.0 142.0 140.0 141.0 142.0 180.0 152.0 11:10:12 INFO - PROCESS | 1649 | 11:10:12 INFO - PROCESS | 1649 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.50 Median:162.00 stddev:1.78 (1.1%) stddev-sans-first:1.88 11:10:12 INFO - PROCESS | 1649 | Values: 163.0 160.0 162.0 167.0 162.0 162.0 162.0 162.0 162.0 163.0 11:10:12 INFO - PROCESS | 1649 | 11:10:12 INFO - PROCESS | 1649 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.10 Median:64.00 stddev:0.99 (1.6%) stddev-sans-first:1.05 11:10:12 INFO - PROCESS | 1649 | Values: 64.0 65.0 64.0 64.0 64.0 66.0 63.0 65.0 63.0 63.0 11:10:12 INFO - PROCESS | 1649 | -------- Summary: end -------- 11:10:12 INFO - PROCESS | 1649 | 11:10:13 INFO - TEST-INFO | 1649: exit 0 11:10:13 INFO - TEST-OK | kraken | took 59205ms 11:10:13 INFO - SUITE-END | took 1177s 11:10:13 INFO - Completed test suite (00:19:37) 11:10:13 INFO - javascript benchmark 11:10:14 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7726.796625868643, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3049.8627561759718, 3511.8946431607046, 3528.206153615435, 3549.361114999299, 3551.6270791566867, 5996.430339117787, 6061.151438798572, 6062.484688801446, 6095.420935011178, 6118.357572454895, 6041.4562689357945, 6084.878302433949, 6103.664298463583, 6112.144299798032, 6117.2965109012475, 5385.757640906149, 5389.6496727712765, 5429.782808687648, 5432.782688692448, 5515.227868098469, 5325.547328477084, 5329.733513324319, 5346.492083252085, 5516.558675305986, 5564.749586268607, 5423.511883930445, 5424.376196737387, 5425.484578965012, 5429.809956651518, 5431.456854314576, 5395.973020134894, 5412.377576578704, 5413.296271484721, 5425.755840987125, 5425.864353391157, 5235.816746413857, 5357.1696387060065, 5357.276767636358, 5369.4362091980565, 5402.054640437907, 6008.188894499231, 6015.669138197398, 6028.849278768022, 6030.879382412327, 6030.879382412327, 6257.812265632038, 6302.023186406114, 6322.209723784527, 6342.778002769927, 6348.396902294275, 6425.710843012076, 6434.163558737334, 6437.0666253393465, 6438.066480360369, 6445.291017988017, 6092.9695351523405, 6130.386961303879, 6143.109249158847, 6145.139680444741, 6159.7536098556, 6279.843003924939, 6335.588186767845, 6513.967430162867, 6546.607203567801, 6550.70521826519, 6275.309715931244, 6311.621302721851, 6316.905246421307, 6317.936820631827, 6319.778807741707, 6367.140436041168, 6457.483401327882, 6459.289478157399, 6478.4169424752, 6493.253275873335, 6220.129181914535, 6379.96810015947, 6384.48924086072, 6389.552731308764, 6389.648569328731, 6241.812745617639, 6262.342454042351, 6279.780207692709, 6305.716242769086, 6310.842228944313, 5217.634765566374, 5221.060209162387, 5221.190715439113, 5224.2947202127225, 5232.712200828915, 4625.190591646448, 4634.189016922025, 4637.675362724577, 4645.140648979949, 4675.392199014106, 5856.795012174553, 5885.087811389241, 5894.67579283135, 6084.087386892002, 6119.785807496716, 6254.3745625438005, 6270.843228919313, 6279.8116056517465, 6282.560220784592, 6294.842628934313, 5954.106883967353, 5957.6127551709, 5966.373530779292, 5986.49114825236, 6005.309389420273, 5533.6403133796175, 5603.439656034446, 5604.775808967677, 5617.775288988477, 5625.212470254168, 6346.587471814225, 6418.422341989243, 6553.311902250195, 6569.671516424255, 6625.204975402982, 6366.4588509977175, 6418.390252925965, 6432.871342573028, 6446.967765161145, 6451.645159516272, 6618.602883826793, 6648.90026649591, 6670.166229221348, 6696.59820410777, 6696.899546506904, 6235.781747638811, 6259.718312676032, 6291.748330066929, 6377.2984971654005, 6382.968085159545, 6386.584871983307, 6410.743570257137, 6412.679366031586, 6424.00427933671, 6445.70994305248, 6153.84615384619, 6300.0, 6329.17720696325, 6341.968290158519, 6357.0, 6139.952147134979, 6273.905891411724, 6283.654399008098, 6357.872842543031, 6379.872402552016, 6139.185504090546, 6160.291566469913, 6287.842803929939, 6333.145025421509, 6339.524535659752, 6307.463865571478, 6320.5259605528845, 6320.810375688737, 6326.335734747785, 6326.620402775849, 6075.058365953284, 6122.571420000557, 6134.355892631388, 6225.315215326401, 6296.842578935563], "value": 5918.965080731146, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [771.4753967302232, 806.3146325623221, 824.8556502612043, 899.1503029636996, 909.1771946388512, 29446.0, 29803.25491862702, 35448.46827297592, 41065.58934410655, 41399.58600413995, 40660.18679626405, 42248.0, 42416.0, 42541.7872910635, 42584.935376615525, 7943.285104340608, 8984.0, 9759.121679048883, 9766.267529935283, 9768.706938791847, 7937.484063535851, 11670.35813030283, 11863.0, 12101.576444824434, 12110.939445302762, 10925.399103049329, 11030.117590592734, 11902.702432439215, 11929.940350298237, 11954.0, 11885.0, 11909.583164589285, 11925.045996320317, 11927.940360298144, 11943.283402995849, 11621.012213961823, 11668.299902005907, 11681.941590291994, 11685.88314116865, 11696.941515292454, 39590.20819583592, 39773.80113099416, 39838.80080599608, 39848.0, 39957.80021099876, 3972.205558888234, 4046.393041043867, 4048.7165898387125, 4054.6756259499466, 4071.043304823364, 28702.425951481062, 29278.0, 30079.548806767914, 30783.692163078307, 30952.535711964338, 3207.262329664167, 3219.500977348515, 3256.5115232715048, 3297.1427428868665, 3391.745619078579, 359193.0, 360277.0, 360348.198259007, 360457.0, 361090.0, 52878.73560632172, 52898.0, 52900.677483063235, 52907.470925291025, 52951.0, 54758.45241547534, 55042.0, 55104.448955510736, 55109.448905510435, 55165.72417137888, 15395.384184632714, 15525.534233973, 15532.145731984623, 15534.0, 15548.68902621964, 11759.706007349885, 12024.45889934955, 13145.802812957812, 13159.342032898317, 13189.340532973312, 8984.011758706538, 10545.99813017762, 10615.893841061645, 10621.415822129702, 10635.627753028606, 4855.102897942097, 5223.242629818731, 5425.02349577072, 5763.740631671585, 5766.192733017381, 1059.8712371324514, 1069.3316677076828, 1096.3257596578046, 1131.7510147767478, 1137.243732917617, 26725.599116013276, 27552.586711199347, 28170.718292816808, 28252.85873570619, 28291.858540707577, 1054.1777413617237, 1098.6319582939805, 1158.2413519144804, 1163.1741463560797, 1202.296656455983, 11622.0873604556, 12101.0, 14420.278986050656, 14612.196329201783, 14762.188079655722, 442300.0, 457652.42347576766, 462316.0, 580004.0, 580976.0, 48023.75988120037, 48188.27717584239, 48409.27386089211, 48440.757796211496, 48637.0, 1071.9548440270673, 1205.9336736479577, 1399.433229542037, 1434.770436730139, 1442.697033622951, 22506.774932250468, 25449.60027198522, 26791.330216744736, 27598.310042249104, 28149.577756333263, 43718.125637487705, 43872.56127438685, 43895.56104438915, 43957.68126956197, 43994.34008489939, 461790.0, 463957.0, 465248.0, 465368.0, 466970.0, 27687.030953916517, 28450.715492844807, 28591.856325746736, 28655.0, 28715.42569148647, 30616.84691576528, 36553.81723091367, 36786.89639310825, 37095.814520927226, 37226.6277337234, 26974.0, 27051.729482704923, 27428.040018599255, 27509.587356189273, 28399.432011359244, 23160.884195578914, 26865.731342687104, 26987.865060675358, 27248.591271130554, 27936.72063279341, 31319.21701957469, 31777.8411107943, 32098.35803283968, 32126.357472849944, 32136.83931580327, 21551.595177070314, 23084.307470775904, 25419.61870571906, 26534.203973880816, 28011.859940700167, 21056.68414973746, 22932.656010159528, 23158.421039473473, 23551.764482355644, 23588.702621355304], "value": 18482.276587458782, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [407.65553107624066, 413.98344066237354, 422.6301985762459, 432.81389002728827, 443.9644828413727, 20155.39533813988, 21103.894480527593, 22335.776642233574, 22666.206682766107, 22689.092436302548, 23158.768412315872, 23306.41733956652, 23652.526949461, 23860.0, 24096.795160242007, 6931.757388491404, 7235.348818606324, 7235.746748863791, 7237.203907570163, 7501.4748967572295, 7728.845423091535, 7819.139894611588, 7864.921350786505, 7867.134615192324, 7884.724034658788, 7714.961425192866, 7780.377569794403, 7790.259925307115, 7845.176256493071, 7854.567998760066, 7574.242575742409, 7759.689612415496, 7829.412794040441, 7844.568548729818, 7877.0547534295965, 7453.701851925916, 7552.0, 7584.2794934481135, 7588.924110758877, 7634.389248860133, 26827.731722682718, 27169.456610867674, 27169.728302716918, 27183.592246116325, 27604.0, 2595.8318756559624, 2891.532859003111, 2958.7189217024566, 3015.62304711911, 3029.2729744861294, 15915.602109947227, 16961.57596060096, 16987.915060424617, 17248.965062096315, 17526.737098943526, 2050.846186536001, 2108.493961449241, 2108.536122053146, 2109.0, 2129.116416687073, 98654.01345986592, 106239.4688026555, 116072.0, 122832.38583807024, 166928.0, 18663.81336186648, 20850.0, 20909.581808363746, 21002.78997210039, 21079.473013174793, 26516.07193748248, 31517.0, 32073.679263207538, 32351.838240808644, 32518.837405813294, 8436.78908027292, 10876.0, 11067.833982490269, 11099.44502774858, 11228.831567526493, 7667.539947603162, 9185.724428267029, 9225.985141634415, 9237.815243695222, 9434.150926416656, 8184.754457366289, 9108.954455227682, 9384.577694003787, 9392.483413412328, 9583.0, 3395.898123056312, 4087.202995415865, 4125.422440858282, 4135.58644135584, 4140.875773726793, 808.4785313472777, 876.5843163291239, 906.9909300906907, 912.3157631776168, 938.1978408460805, 19663.803361966482, 21304.36086917395, 22674.0, 22837.657435138488, 23072.307830765105, 909.8589718593629, 924.3899026642518, 931.6552875436132, 942.2885721280389, 943.2312665177858, 8525.44584601999, 11740.58907938218, 11806.940965295118, 11866.347350895783, 11888.821667674993, 684782.0, 733691.0, 748450.0, 750765.0, 773867.0, 146865.0, 150873.24563377112, 152641.0, 159376.20311898598, 164028.97729250175, 1266.8543117541417, 1283.4994352202648, 1323.5896871969912, 1327.0180066750536, 1327.4667758738478, 20059.0, 20440.0, 20763.377098687062, 20847.687284691045, 20866.37400877976, 60987.695061524406, 61448.46378840565, 61668.691656543226, 61901.07148392868, 62003.379966201566, 81689.18310816816, 86147.70778438203, 87269.0, 89055.55472222598, 89434.55282723544, 11719.41402929833, 11963.538553496504, 12146.574869879512, 12191.329476878502, 12239.877601223874, 13269.336533173495, 13329.133606315558, 13561.864381356454, 13787.379567919266, 13898.652533686334, 10170.288079834341, 11675.299482031105, 11762.647120586396, 12019.939900300442, 12150.57472988441, 10685.038346548537, 10907.0, 10937.453127343442, 11221.887781122085, 11468.369239691898, 11140.33158010522, 11501.597444089417, 11999.0, 12017.879821201675, 12039.819402708792, 11718.589849355232, 11762.529498820293, 11879.287242765462, 11997.280163190237, 12115.394230288626, 6220.160278362363, 11643.243189192675, 11703.063754899758, 11735.061195104541, 11963.222390544586], "value": 11840.398439946808, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1329.6011196641011, 1329.9933500332497, 1554.3238691169336, 1555.5333399980007, 1574.126359870272, 8643.74068777936, 9015.233705135055, 9039.954800225998, 9119.77200569986, 9126.817463650723, 8942.865857012133, 10351.534180961857, 10659.253852230328, 10806.081483073947, 10888.0, 2198.362474882282, 2234.1398561553838, 2236.2285011670947, 2236.39617303328, 2237.3847192022163, 2187.9234226802064, 2287.1308902617066, 2323.604987152188, 2357.0571771291534, 2367.4673198530277, 1883.6044430669576, 1956.2370675436591, 2040.0921589892503, 2341.800946919514, 2365.432296248905, 2340.742518322983, 2358.13927916311, 2359.4809141988735, 2366.751491093436, 2366.9644955325684, 2317.5712493188644, 2341.988290058556, 2347.7769611886843, 2349.4361353275262, 2353.294011796454, 10470.267081304311, 10653.680389588324, 10671.0, 10674.626388076458, 10683.30558513694, 5513.641613295163, 5658.66048037115, 5668.404817494145, 5684.658920464785, 5687.033204355228, 3261.2173078461237, 3355.865765369382, 3541.1678255609913, 3551.786892786415, 3556.075420390717, 1154.7979103656826, 1163.8603367595858, 1190.149043433949, 1205.4454950722677, 1207.5290636651712, 14417.711645767025, 14453.638659033502, 14576.489822856256, 14577.999999999894, 14599.343029563588, 3944.4872166618156, 4486.887827804266, 4601.079784043205, 4704.623630109583, 4774.355462012653, 12331.321777302155, 12337.0, 12392.380380980914, 12399.628011159679, 12406.441710123067, 5773.336066352339, 5788.160716696139, 5790.189373487715, 5807.390224026501, 5812.157237200582, 4977.377827771528, 5078.06055879656, 5190.688558686491, 5228.6339956203465, 5235.0576896159055, 3642.2897534980425, 3717.182219911615, 3719.479272901796, 3761.1161377076364, 3772.453294149386, 955.3790036476207, 1004.8492726090999, 1009.5507499162949, 1010.5048526222098, 1020.3265844542566, 695.8330000799772, 824.6577670266892, 826.3017750001239, 831.4055450353027, 839.8740188971581, 6422.165118534654, 6448.903266451007, 6574.572652777554, 6633.2040155181685, 6757.459403247728, 982.003266684316, 984.625842179967, 997.7455748784158, 1001.3241062283075, 1034.3225187502198, 3661.9450708239397, 3956.649577428244, 4001.459802926626, 4068.898277543085, 4198.265303571924, 12297.323647199311, 12947.741045179044, 12964.0, 12968.35158242084, 12968.935155324352, 12465.501379944883, 12674.556390526288, 12950.093493455555, 12953.028522860635, 12982.285974271317, 9964.501774911225, 9972.0, 9974.800503990025, 9992.65025724096, 10117.140043096271, 6375.9362406377195, 6418.679066046586, 6457.483401327789, 6523.347665233438, 6612.272650008399, 11833.290002599872, 11962.46168922418, 11971.76056478883, 12093.758124837277, 12239.204451710966, 11927.701807454883, 11957.820632690691, 12055.57805476804, 12165.452554634885, 12273.263604183421, 7924.366050716044, 7970.521768693897, 8064.516129032277, 8075.798105047421, 8090.11008789021, 9762.072603102693, 9950.402975821475, 9964.202863771026, 9966.50167491637, 9997.850032249376, 8152.144024877302, 8377.790555236168, 8383.748487545383, 8389.0, 8449.02836173848, 8043.396745244013, 8093.676252949816, 8125.959370203112, 8152.184781521801, 8205.712800052208, 7579.393648507996, 7728.149903510497, 7809.609519524115, 7826.7651970440975, 7833.608319583884, 5606.635568688022, 5617.494425501724, 5752.7698892043845, 5805.506531944832, 5835.124731290341, 5869.119632055226, 5931.258592675916, 5976.0, 6012.488938440281, 6112.358202388685], "value": 4924.631666398666, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [378.317137566692, 379.6867584242999, 382.74356181358485, 386.94195870619404, 391.962763537464, 4678.543764523631, 5195.220716892468, 5215.731156946731, 5258.842234732954, 5264.921026184606, 4498.482674492434, 4996.525330093645, 5009.373828271466, 5118.436971933084, 5162.889978654589, 3384.798396569219, 3499.8425070871745, 3524.9953763177564, 3983.4423180754716, 4053.250148722496, 3341.3484370547753, 3372.5666591698555, 3887.9891228280567, 4003.259397011562, 4027.2549578327958, 3375.4093033719123, 3770.9434358484646, 3793.2825830685942, 4009.7594144351287, 4035.4955630546183, 3082.460569400346, 3805.3824320801286, 3850.7304488685804, 4012.598740125964, 4020.597940205985, 2906.6657334406605, 3561.3411518869093, 3568.678818906285, 3570.6786389225094, 3614.34941710492, 4609.492955774862, 5090.796368145269, 5091.745412729349, 5097.4197998620175, 5150.742462876841, 3955.0, 4120.608542188487, 4528.3207518872105, 4657.930131048037, 4767.284907263938, 4928.507149285078, 5072.467390923974, 5226.320578324793, 5316.680999140064, 5448.972755136238, 3765.0, 3826.655600995896, 3975.1652153047607, 4010.375797801895, 4034.11249525104, 4997.375328083989, 5219.295395121648, 5561.582881283879, 5868.354481007086, 5919.881602367972, 4745.549172828576, 4934.432540257844, 4934.851954441372, 4937.543424689653, 4963.8014479421145, 4560.498345182027, 5084.847454576368, 5100.438951715309, 5103.234514822732, 5129.666571672829, 4676.415448068991, 5196.584273258206, 5229.137192363293, 5240.318758561439, 5322.296865003162, 4693.342931989524, 5342.813001544927, 5346.839594812084, 5545.334559852843, 5564.582656300713, 1417.1922004457567, 1536.347052502682, 1587.3650539784178, 1592.936282548685, 1600.0, 1094.5402930769096, 1115.866096068477, 1116.7040734205443, 1200.8438902942562, 1224.5530381410722, 4751.3348131261655, 4971.980743947482, 5163.554204822655, 5265.630935956602, 5290.0, 5407.810726624549, 5421.539169170585, 5648.71756412186, 5759.90561793258, 5807.128930660435, 4502.099580083931, 4893.657443978958, 5226.320578324793, 5269.573558211121, 5271.576674297918, 2617.167982412319, 2644.7751941085226, 2768.518842419296, 2788.344738986337, 3005.6844031376827, 5396.487333703292, 5807.738651760681, 5979.531871514511, 5980.2657229402985, 6067.423594758579, 4529.614982726439, 4924.5980225706435, 5366.517013468807, 5477.780888764484, 5689.345725241567, 4890.975545122252, 5200.439868039573, 5882.588218824727, 5990.850228744316, 6029.613188966475, 5135.794568217229, 5706.944215320179, 5707.6575405475805, 5711.087904785235, 5806.1000544915605, 4761.76191190446, 4913.887028577746, 5398.892022159456, 5692.686902220417, 5749.885002299847, 4949.901001980013, 5164.690118592896, 5772.19189313488, 5992.370801065999, 6023.3374328824675, 4027.335489644176, 4117.402976568321, 4697.647676424213, 4706.364640773589, 4715.6227501799085, 4983.700977941335, 5137.0, 5329.269511341999, 5782.335031471434, 5930.911036334544, 4968.801247950186, 5088.923666144937, 5549.916751248816, 5612.607117501736, 5628.60599758013, 5009.323741294878, 5133.794648214179, 5157.200633901752, 5565.471280228372, 5594.510367973132, 5413.215083812904, 5425.0, 5428.7285635718845, 5486.625725178907, 5518.558515318685, 5022.4977502249485, 5572.099530328867, 5578.386377498553, 5582.581306402118, 5631.465010824129, 4309.653758826356, 4464.0, 4612.100640375094, 5443.618946673695, 5473.713677285914], "value": 4173.300362197872, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [756.3608750605737, 757.3297631596035, 868.2099289646419, 881.5680316644844, 914.4787471141452, 15602.141882196474, 17087.401940932054, 17088.829111708877, 18097.819021809777, 18572.814271857278, 15247.39010439584, 18231.72652410215, 18634.34779782708, 18685.0, 18914.905425472887, 992.4541502173794, 1030.4538594544904, 1034.120997152422, 1035.223582313265, 1036.119298596191, 1008.2776503440739, 1022.7085280695003, 1027.0910244433692, 1037.1547189040907, 1039.516624769482, 1074.7152004718755, 1075.4461452352045, 1078.4984981983375, 1080.3140006096146, 1081.3674000709555, 1072.7318170457386, 1073.5598404654133, 1073.6295977887617, 1074.1514203779004, 1074.7474343529263, 796.3788245168778, 797.0515087046455, 797.4816369359904, 797.7447216890597, 797.9281864632153, 16532.83467165337, 16553.917230413892, 16586.917065414596, 18086.276548938025, 18324.35864744741, 14666.0, 14745.557633270912, 14833.55499335011, 14868.0, 14871.553853384416, 12070.637880863587, 12162.635120946386, 12191.695207619792, 12270.938645306805, 12451.190672606252, 3816.141368192162, 3818.064574179316, 3874.128321127752, 3888.8833334999713, 3963.128111815396, 58717.597057383886, 100319.0, 116900.41549792282, 118976.40511797472, 121565.0, 11206.383648899226, 11476.713082172846, 11490.54037838477, 11584.42077896102, 12003.759924801456, 22782.20262290812, 22920.656190157162, 22964.311070667907, 23011.42471438194, 23034.193803216807, 8393.580320983927, 8444.704435344733, 8539.914600854036, 8540.701075462453, 8653.264472519906, 4451.132029254329, 4490.2142125127975, 4528.252838281713, 4588.105319462739, 4640.32715256286, 3489.5986961499243, 3562.5724913010085, 3575.3921833288405, 3615.313090512794, 3622.673959343672, 642.1491523731075, 645.7868903261913, 654.2345455816705, 656.5633853487377, 659.2682122843639, 561.7500212405522, 582.7872826418327, 583.76941108262, 588.1677426441537, 594.9940500595026, 9075.909240907638, 10983.584612867511, 11050.944745276222, 11105.83341249882, 11112.888871111347, 694.399344566946, 729.2598013016792, 735.4410647907629, 739.0577014306801, 745.1803016681607, 4485.48416932057, 4834.879128021757, 5235.424103348629, 5248.63259571834, 5292.364916210079, 98336.50831745795, 108095.45952270189, 108238.0, 111934.0, 112718.0, 61977.760444791755, 69074.0, 87838.0, 92053.0, 94126.0, 58300.0, 80642.98392540234, 80953.19046809574, 83189.84050797558, 87031.0, 8685.91314086851, 11257.592800899887, 11512.251703639571, 11582.94208528952, 11611.883881161419, 37835.432468512445, 48973.04107835789, 54170.64573385697, 54453.0, 55875.44124558865, 70569.58860822857, 71693.0, 71952.0, 72386.0, 74081.0, 14112.858871411565, 14236.21700806424, 14427.855721442651, 14604.831613470684, 14787.408503659733, 15281.694366112837, 15423.537293881202, 15670.373185072469, 15723.685526289639, 15753.054816711034, 13979.391535844863, 14205.084661106004, 14287.857121429068, 14571.41714331415, 14610.269486525418, 13910.443582257001, 14332.57002289933, 14453.710925781215, 14461.78307325412, 15032.924835375754, 11891.464884080064, 11958.222715523463, 13266.469341226242, 14192.716145676823, 14686.265686715835, 9525.229186852555, 9698.56356463975, 10135.442550659785, 10277.383356998604, 10481.0, 10134.442605656759, 10186.696389474977, 11381.477223169513, 11751.0, 11763.353015583883], "value": 7993.427616207728, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1438.6999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 108.0, 105.0, 139.0, 109.0, 108.0, 131.0, 135.0, 151.0, 106.0], "value": 122.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 186.0, 199.0, 263.0, 203.0, 195.0, 185.0, 185.0, 185.0, 188.0], "value": 197.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 59.0, 60.0, 91.0, 63.0, 59.0, 60.0, 58.0, 75.0, 60.0], "value": 66.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 69.0, 86.0, 70.0, 71.0, 70.0, 105.0, 99.0, 98.0, 86.0], "value": 84.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 88.0, 89.0, 88.0, 88.0, 88.0, 89.0, 87.0, 89.0, 88.0], "value": 88.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 94.0, 95.0, 94.0, 95.0, 94.0, 93.0, 95.0], "value": 94.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 85.0, 87.0, 85.0, 85.0, 84.0, 84.0, 83.0, 86.0], "value": 84.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 62.0, 60.0, 63.0, 64.0, 64.0, 66.0, 63.0, 62.0, 63.0], "value": 63.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 66.0, 64.0, 63.0, 60.0, 58.0, 61.0, 62.0, 83.0, 86.0], "value": 66.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 78.0, 85.0, 83.0, 81.0, 74.0, 82.0, 81.0, 81.0, 88.0], "value": 81.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 139.0, 146.0, 139.0, 142.0, 140.0, 141.0, 142.0, 180.0, 152.0], "value": 146.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 160.0, 162.0, 167.0, 162.0, 162.0, 162.0, 162.0, 162.0, 163.0], "value": 162.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 64.0, 64.0, 64.0, 66.0, 63.0, 65.0, 63.0, 63.0], "value": 64.1, "unit": "score"}]}]} 11:10:14 INFO - Return code: 0 11:10:14 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:10:14 INFO - # TBPL SUCCESS # 11:10:14 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:10:14 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:10:14 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:10:14 INFO - 2017-04-25 11:10:14.142 screenresolution[1653:9979] starting screenresolution argv=screenresolution get 11:10:14 INFO - 2017-04-25 11:10:14.145 screenresolution[1653:9979] Display 0: 1600x1200x32@60 11:10:14 INFO - 2017-04-25 11:10:14.151 screenresolution[1654:9982] starting screenresolution argv=screenresolution list 11:10:14 INFO - Available Modes on Display 0 11:10:14 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:10:14 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:10:14 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:10:14 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:10:14 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:10:14 INFO - Intel Iris: 11:10:14 INFO - Chipset Model: Intel Iris 11:10:14 INFO - Type: GPU 11:10:14 INFO - Bus: Built-In 11:10:14 INFO - VRAM (Dynamic, Max): 1536 MB 11:10:14 INFO - Vendor: Intel (0x8086) 11:10:14 INFO - Device ID: 0x0a2e 11:10:14 INFO - Revision ID: 0x0009 11:10:14 INFO - Displays: 11:10:14 INFO - Display: 11:10:14 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:10:14 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:10:14 INFO - Display Serial Number: 1600x1200 60 11:10:14 INFO - Main Display: Yes 11:10:14 INFO - Mirror: Off 11:10:14 INFO - Online: Yes 11:10:14 INFO - Rotation: Supported 11:10:14 INFO - Return code: 0 11:10:14 INFO - Running post-action listener: _resource_record_post_action 11:10:14 INFO - [mozharness: 2017-04-25 18:10:14.388582Z] Finished run-tests step (success) 11:10:14 INFO - Running post-run listener: _resource_record_post_run 11:10:14 INFO - Total resource usage - Wall time: 1193s; CPU: 54.0%; Read bytes: 39994368; Write bytes: 422367232; Read time: 394; Write time: 1567 11:10:14 INFO - TinderboxPrint: CPU usage
53.8% 11:10:14 INFO - TinderboxPrint: I/O read bytes / time
39,994,368 / 394 11:10:14 INFO - TinderboxPrint: I/O write bytes / time
422,367,232 / 1,567 11:10:14 INFO - TinderboxPrint: CPU idle
2,205.1 (46.2%) 11:10:14 INFO - TinderboxPrint: CPU system
954.6 (20.0%) 11:10:14 INFO - TinderboxPrint: CPU user
1,614.0 (33.8%) 11:10:14 INFO - TinderboxPrint: Swap in / out
160,186,368 / 0 11:10:14 INFO - install - Wall time: 15s; CPU: 54.0%; Read bytes: 125412864; Write bytes: 113917952; Read time: 11161; Write time: 233 11:10:14 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 32533504; Write bytes: 298364928; Read time: 307; Write time: 1300 11:10:14 INFO - Running post-run listener: _upload_blobber_files 11:10:14 INFO - Blob upload gear active. 11:10:14 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:10:14 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 11:10:14 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-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:10:14 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-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:10:15 INFO - (blobuploader) - INFO - Open directory for files ... 11:10:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:10:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:10:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:10:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:10:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:10:16 INFO - (blobuploader) - INFO - Done attempting. 11:10:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:10:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:10:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:10:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:10:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:10:17 INFO - (blobuploader) - INFO - Done attempting. 11:10:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 11:10:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:10:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:10:18 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 11:10:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:10:18 INFO - (blobuploader) - INFO - Done attempting. 11:10:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:10:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:10:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:10:21 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:10:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:10:21 INFO - (blobuploader) - INFO - Done attempting. 11:10:21 INFO - (blobuploader) - INFO - Iteration through files over. 11:10:21 INFO - Return code: 0 11:10:21 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:10:21 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:10:21 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/36d6f16d0c17c2893726e47f4a8eb9fbae4c96c7713e674a877f23127e505350bdd5efc3f579866eb2957753521b10d05df60ca6481456aa82ceb5bf2cc26eb6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9c0aaa088ee95f943ec9f69fd58af3276042947d4ff922d9acb912b692c676e964a3fbada8c344875b0a2dfdeb4afdba2851f68751de9d50889165d977665a7a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2f91b923986b7583f8d81af25c58c47dad33f35ef04b21ebc1136fa4d72540fbfd9dd54a90438bc433cc9574edba9b5928c0461692138595a78326c57a3d5189", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9ce1b06cd0d8aaeff2b29dd652398a9af33d00dbc90d4de026694aa56c19d4e3cac32ab27bf31d3b15363d44b67182886c77e96eecbdf4f351642074320536f8"} 11:10:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:10:21 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:10:21 INFO - Contents: 11:10:21 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/36d6f16d0c17c2893726e47f4a8eb9fbae4c96c7713e674a877f23127e505350bdd5efc3f579866eb2957753521b10d05df60ca6481456aa82ceb5bf2cc26eb6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9c0aaa088ee95f943ec9f69fd58af3276042947d4ff922d9acb912b692c676e964a3fbada8c344875b0a2dfdeb4afdba2851f68751de9d50889165d977665a7a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2f91b923986b7583f8d81af25c58c47dad33f35ef04b21ebc1136fa4d72540fbfd9dd54a90438bc433cc9574edba9b5928c0461692138595a78326c57a3d5189", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9ce1b06cd0d8aaeff2b29dd652398a9af33d00dbc90d4de026694aa56c19d4e3cac32ab27bf31d3b15363d44b67182886c77e96eecbdf4f351642074320536f8"} 11:10:21 INFO - Running post-run listener: copy_logs_to_upload_dir 11:10:21 INFO - Copying logs to upload dir... 11:10:21 INFO - mkdir: /builds/slave/test/build/upload/logs 11:10:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1275.947808 ========= master_lag: 1.29 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2017-04-25 11:10:22.647118) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 7 secs) (at 2017-04-25 11:10:22.650805) ========= 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.PXXeLSpPzq/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.AL0l568wpr/Listeners TMPDIR=/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/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-Beta/sha512/36d6f16d0c17c2893726e47f4a8eb9fbae4c96c7713e674a877f23127e505350bdd5efc3f579866eb2957753521b10d05df60ca6481456aa82ceb5bf2cc26eb6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9c0aaa088ee95f943ec9f69fd58af3276042947d4ff922d9acb912b692c676e964a3fbada8c344875b0a2dfdeb4afdba2851f68751de9d50889165d977665a7a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2f91b923986b7583f8d81af25c58c47dad33f35ef04b21ebc1136fa4d72540fbfd9dd54a90438bc433cc9574edba9b5928c0461692138595a78326c57a3d5189", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9ce1b06cd0d8aaeff2b29dd652398a9af33d00dbc90d4de026694aa56c19d4e3cac32ab27bf31d3b15363d44b67182886c77e96eecbdf4f351642074320536f8"} build_url:https://queue.taskcluster.net/v1/task/P8D13ObLQxu_ptB4VEUmaA/artifacts/public/build/firefox-54.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011163 build_url: 'https://queue.taskcluster.net/v1/task/P8D13ObLQxu_ptB4VEUmaA/artifacts/public/build/firefox-54.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/36d6f16d0c17c2893726e47f4a8eb9fbae4c96c7713e674a877f23127e505350bdd5efc3f579866eb2957753521b10d05df60ca6481456aa82ceb5bf2cc26eb6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9c0aaa088ee95f943ec9f69fd58af3276042947d4ff922d9acb912b692c676e964a3fbada8c344875b0a2dfdeb4afdba2851f68751de9d50889165d977665a7a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2f91b923986b7583f8d81af25c58c47dad33f35ef04b21ebc1136fa4d72540fbfd9dd54a90438bc433cc9574edba9b5928c0461692138595a78326c57a3d5189", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9ce1b06cd0d8aaeff2b29dd652398a9af33d00dbc90d4de026694aa56c19d4e3cac32ab27bf31d3b15363d44b67182886c77e96eecbdf4f351642074320536f8"}' ========= master_lag: 7.27 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 7 secs) (at 2017-04-25 11:10:29.927186) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 1 secs) (at 2017-04-25 11:10:29.927581) ========= 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.PXXeLSpPzq/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.AL0l568wpr/Listeners TMPDIR=/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/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.005182 ========= master_lag: 1.48 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 1 secs) (at 2017-04-25 11:10:31.415432) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-25 11:10:31.415767) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-25 11:10:31.418318) ========= ========= Total master_lag: 14.92 =========