builder: pine_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0188 starttime: 1491982582.2 results: success (0) buildid: 20170411153607 builduid: 4654b5365f2e4eba86a8e1001345804d revision: 099d239a4f861e204320e2c7fa81001fce31b2cf ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-12 00:36:22.202996) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-12 00:36:22.203418) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-12 00:36:22.203704) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-12 00:36:22.228468) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-12 00:36:22.228811) ========= 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.hSLFcbxuqK/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.mGw6yviE3V/Listeners TMPDIR=/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/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-12 00:36:22-- 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% 153M=0s 2017-04-12 00:36:22 (153 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.376724 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-12 00:36:22.628908) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-12 00:36:22.629272) ========= 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.hSLFcbxuqK/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.mGw6yviE3V/Listeners TMPDIR=/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/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.021647 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-12 00:36:22.677700) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-12 00:36:22.678061) ========= bash -c 'python archiver_client.py mozharness --repo projects/pine --rev 099d239a4f861e204320e2c7fa81001fce31b2cf --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/pine --rev 099d239a4f861e204320e2c7fa81001fce31b2cf --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.hSLFcbxuqK/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.mGw6yviE3V/Listeners TMPDIR=/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/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-12 00:36:22,765 truncating revision to first 12 chars 2017-04-12 00:36:22,765 Setting DEBUG logging. 2017-04-12 00:36:22,765 attempt 1/10 2017-04-12 00:36:22,766 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/pine/099d239a4f86?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-12 00:36:23,391 unpacking tar archive at: pine-099d239a4f86/testing/mozharness/ program finished with exit code 0 elapsedTime=0.886215 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-12 00:36:23.590443) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-12 00:36:23.590937) ========= script_repo_revision: 099d239a4f861e204320e2c7fa81001fce31b2cf ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-12 00:36:23.591472) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-12 00:36:23.591895) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-12 00:36:23.612836) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2017-04-12 00:36:23.613294) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Pine --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Pine 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', 'Pine', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Pine'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.hSLFcbxuqK/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.mGw6yviE3V/Listeners TMPDIR=/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/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 00:36:23 INFO - MultiFileLogger online at 20170412 00:36:23 in /builds/slave/test 00:36:23 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Pine --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Pine 00:36:23 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 00:36:23 INFO - {'append_to_log': False, 00:36:23 INFO - 'base_work_dir': '/builds/slave/test', 00:36:23 INFO - 'blob_upload_branch': 'Pine', 00:36:23 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 00:36:23 INFO - 'branch': 'Pine', 00:36:23 INFO - 'buildbot_json_path': 'buildprops.json', 00:36:23 INFO - 'config_files': ('talos/mac_config.py',), 00:36:23 INFO - 'default_actions': ('clobber', 00:36:23 INFO - 'read-buildbot-config', 00:36:23 INFO - 'download-and-extract', 00:36:23 INFO - 'populate-webroot', 00:36:23 INFO - 'create-virtualenv', 00:36:23 INFO - 'install', 00:36:23 INFO - 'run-tests'), 00:36:23 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 00:36:23 INFO - 'download_minidump_stackwalk': True, 00:36:23 INFO - 'download_symbols': 'ondemand', 00:36:23 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 00:36:23 INFO - 'tooltool.py': '/tools/tooltool.py', 00:36:23 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 00:36:23 INFO - '/tools/misc-python/virtualenv.py')}, 00:36:23 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 00:36:23 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 00:36:23 INFO - 'gecko_profile': False, 00:36:23 INFO - 'gecko_profile_interval': 0, 00:36:23 INFO - 'installer_path': 'installer.exe', 00:36:23 INFO - 'log_level': 'info', 00:36:23 INFO - 'log_name': 'talos', 00:36:23 INFO - 'log_to_console': True, 00:36:23 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 00:36:23 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 00:36:23 INFO - 'opt_config_files': (), 00:36:23 INFO - 'pip_index': False, 00:36:23 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 00:36:23 INFO - 'cmd': ('bash', 00:36:23 INFO - '-c', 00:36:23 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 00:36:23 INFO - 'enabled': True, 00:36:23 INFO - 'halt_on_failure': False, 00:36:23 INFO - 'name': 'check_screen_resolution'},), 00:36:23 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 00:36:23 INFO - 'cmd': ('bash', 00:36:23 INFO - '-c', 00:36:23 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 00:36:23 INFO - 'enabled': True, 00:36:23 INFO - 'halt_on_failure': False, 00:36:23 INFO - 'name': 'check_screen_resolution'},), 00:36:23 INFO - 'run_cmd_checks_enabled': True, 00:36:23 INFO - 'suite': 'dromaeojs', 00:36:23 INFO - 'system_bits': '32', 00:36:23 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 00:36:23 INFO - 'title': 't-yosemite-r7-0188', 00:36:23 INFO - 'tooltool_cache': '/builds/tooltool_cache', 00:36:23 INFO - 'use_talos_json': True, 00:36:23 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 00:36:23 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 00:36:23 INFO - 'work_dir': 'build'} 00:36:23 INFO - [mozharness: 2017-04-12 07:36:23.832388Z] Running clobber step. 00:36:23 INFO - Running pre-action listener: _resource_record_pre_action 00:36:23 INFO - Running main action method: clobber 00:36:23 INFO - rmtree: /builds/slave/test/build 00:36:23 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 00:36:25 INFO - Running post-action listener: _resource_record_post_action 00:36:25 INFO - [mozharness: 2017-04-12 07:36:25.860331Z] Finished clobber step (success) 00:36:25 INFO - [mozharness: 2017-04-12 07:36:25.860495Z] Running read-buildbot-config step. 00:36:25 INFO - Running pre-action listener: _resource_record_pre_action 00:36:25 INFO - Running main action method: read_buildbot_config 00:36:25 INFO - Using buildbot properties: 00:36:25 INFO - { 00:36:25 INFO - "project": "", 00:36:25 INFO - "product": "firefox", 00:36:25 INFO - "script_repo_revision": "default", 00:36:25 INFO - "builddir": "pine_yosemite_r7_test-dromaeojs", 00:36:25 INFO - "repository": "", 00:36:25 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 pine talos dromaeojs", 00:36:25 INFO - "buildid": "20170411153607", 00:36:25 INFO - "pgo_build": "False", 00:36:25 INFO - "basedir": "/builds/slave/test", 00:36:25 INFO - "buildnumber": 5, 00:36:25 INFO - "slavename": "t-yosemite-r7-0188", 00:36:25 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 00:36:25 INFO - "platform": "yosemite_r7", 00:36:25 INFO - "scheduler": "tests-pine-macosx64-talos", 00:36:25 INFO - "branch": "pine", 00:36:25 INFO - "repo_path": "projects/pine", 00:36:25 INFO - "revision": "099d239a4f861e204320e2c7fa81001fce31b2cf", 00:36:25 INFO - "stage_platform": "macosx64", 00:36:25 INFO - "builduid": "4654b5365f2e4eba86a8e1001345804d", 00:36:25 INFO - "slavebuilddir": "test" 00:36:25 INFO - } 00:36:25 INFO - Found installer url https://queue.taskcluster.net/v1/task/Ro9uj5nrR9y22GYTTTEaEw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 00:36:25 INFO - Running post-action listener: _resource_record_post_action 00:36:25 INFO - [mozharness: 2017-04-12 07:36:25.863951Z] Finished read-buildbot-config step (success) 00:36:25 INFO - [mozharness: 2017-04-12 07:36:25.864075Z] Running download-and-extract step. 00:36:25 INFO - Running pre-action listener: _resource_record_pre_action 00:36:25 INFO - Running main action method: download_and_extract 00:36:25 INFO - mkdir: /builds/slave/test/build/tests 00:36:25 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')]} 00:36:25 INFO - trying https://queue.taskcluster.net/v1/task/Ro9uj5nrR9y22GYTTTEaEw/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 00:36:25 INFO - Downloading https://queue.taskcluster.net/v1/task/Ro9uj5nrR9y22GYTTTEaEw/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 00:36:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ro9uj5nrR9y22GYTTTEaEw/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 00:36:26 INFO - Downloaded 1325 bytes. 00:36:26 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 00:36:26 INFO - Using the following test package requirements: 00:36:26 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 00:36:26 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 00:36:26 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 00:36:26 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 00:36:26 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 00:36:26 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 00:36:26 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 00:36:26 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 00:36:26 INFO - u'jsshell-mac.zip'], 00:36:26 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 00:36:26 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 00:36:26 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 00:36:26 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 00:36:26 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 00:36:26 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 00:36:26 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 00:36:26 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 00:36:26 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 00:36:26 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 00:36:26 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 00:36:26 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 00:36:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ro9uj5nrR9y22GYTTTEaEw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 00:36:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ro9uj5nrR9y22GYTTTEaEw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 00:36:26 INFO - Fetch https://queue.taskcluster.net/v1/task/Ro9uj5nrR9y22GYTTTEaEw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 00:36:28 INFO - Expected file size: 52581320 00:36:28 INFO - Obtained file size: 52581320 00:36:44 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 00:36:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ro9uj5nrR9y22GYTTTEaEw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 00:36:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ro9uj5nrR9y22GYTTTEaEw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 00:36:44 INFO - Fetch https://queue.taskcluster.net/v1/task/Ro9uj5nrR9y22GYTTTEaEw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 00:36:46 INFO - Expected file size: 52581320 00:36:46 INFO - Obtained file size: 52581320 00:37:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ro9uj5nrR9y22GYTTTEaEw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 00:37:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ro9uj5nrR9y22GYTTTEaEw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 00:37:01 INFO - Fetch https://queue.taskcluster.net/v1/task/Ro9uj5nrR9y22GYTTTEaEw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 00:37:02 INFO - Expected file size: 14405596 00:37:02 INFO - Obtained file size: 14405596 00:37:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:37:03 INFO - trying https://queue.taskcluster.net/v1/task/Ro9uj5nrR9y22GYTTTEaEw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 00:37:03 INFO - Downloading https://queue.taskcluster.net/v1/task/Ro9uj5nrR9y22GYTTTEaEw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 00:37:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ro9uj5nrR9y22GYTTTEaEw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 00:37:05 INFO - Downloaded 71000210 bytes. 00:37:05 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Ro9uj5nrR9y22GYTTTEaEw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 00:37:05 INFO - mkdir: /builds/slave/test/properties 00:37:05 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 00:37:05 INFO - Writing to file /builds/slave/test/properties/build_url 00:37:05 INFO - Contents: 00:37:05 INFO - build_url:https://queue.taskcluster.net/v1/task/Ro9uj5nrR9y22GYTTTEaEw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 00:37:06 INFO - Running post-action listener: _resource_record_post_action 00:37:06 INFO - Running post-action listener: set_extra_try_arguments 00:37:06 INFO - [mozharness: 2017-04-12 07:37:06.335899Z] Finished download-and-extract step (success) 00:37:06 INFO - [mozharness: 2017-04-12 07:37:06.336030Z] Running populate-webroot step. 00:37:06 INFO - Running pre-action listener: _resource_record_pre_action 00:37:06 INFO - Running main action method: populate_webroot 00:37:06 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 00:37:06 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 00:37:06 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 00:37:06 INFO - '--tppagecycles', 00:37:06 INFO - '7'], 00:37:06 INFO - 'tests': ['tsvgm']}}, 00:37:06 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 00:37:06 INFO - 'tests': ['tresize', 'tcanvasmark']}, 00:37:06 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 00:37:06 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 00:37:06 INFO - 'tests': ['dromaeo_css', 'kraken']}, 00:37:06 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 00:37:06 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 00:37:06 INFO - 'talos_options': ['--disable-e10s'], 00:37:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:37:06 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 00:37:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:37:06 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 00:37:06 INFO - 'talos_options': ['--disable-e10s'], 00:37:06 INFO - 'tests': ['damp', 'tps']}, 00:37:06 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 00:37:06 INFO - 'tests': ['damp', 'tps']}, 00:37:06 INFO - 'g3': {'talos_options': ['--disable-e10s'], 00:37:06 INFO - 'tests': ['dromaeo_dom']}, 00:37:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 00:37:06 INFO - 'g4': {'talos_options': ['--disable-e10s'], 00:37:06 INFO - 'tests': ['basic_compositor_video']}, 00:37:06 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 00:37:06 INFO - 'other': {'talos_options': ['--disable-e10s'], 00:37:06 INFO - 'tests': ['a11yr', 00:37:06 INFO - 'ts_paint', 00:37:06 INFO - 'tpaint', 00:37:06 INFO - 'sessionrestore', 00:37:06 INFO - 'sessionrestore_no_auto_restore', 00:37:06 INFO - 'tabpaint']}, 00:37:06 INFO - 'other-e10s': {'tests': ['a11yr', 00:37:06 INFO - 'ts_paint', 00:37:06 INFO - 'tpaint', 00:37:06 INFO - 'sessionrestore', 00:37:06 INFO - 'sessionrestore_no_auto_restore', 00:37:06 INFO - 'tabpaint']}, 00:37:06 INFO - 'other-e10s_l64': {'tests': ['a11yr', 00:37:06 INFO - 'ts_paint', 00:37:06 INFO - 'tpaint', 00:37:06 INFO - 'sessionrestore', 00:37:06 INFO - 'sessionrestore_no_auto_restore', 00:37:06 INFO - 'tabpaint']}, 00:37:06 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 00:37:06 INFO - 'ts_paint', 00:37:06 INFO - 'tpaint', 00:37:06 INFO - 'sessionrestore', 00:37:06 INFO - 'sessionrestore_no_auto_restore', 00:37:06 INFO - 'tabpaint']}, 00:37:06 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 00:37:06 INFO - 'tests': ['a11yr', 00:37:06 INFO - 'ts_paint', 00:37:06 INFO - 'tpaint', 00:37:06 INFO - 'sessionrestore', 00:37:06 INFO - 'sessionrestore_no_auto_restore', 00:37:06 INFO - 'tabpaint']}, 00:37:06 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 00:37:06 INFO - 'tests': ['a11yr', 00:37:06 INFO - 'ts_paint', 00:37:06 INFO - 'tpaint', 00:37:06 INFO - 'sessionrestore', 00:37:06 INFO - 'sessionrestore_no_auto_restore', 00:37:06 INFO - 'tabpaint']}, 00:37:06 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 00:37:06 INFO - 'tests': ['tsvgx', 00:37:06 INFO - 'tsvgr_opacity', 00:37:06 INFO - 'tart', 00:37:06 INFO - 'tscrollx', 00:37:06 INFO - 'cart', 00:37:06 INFO - 'tsvg_static']}, 00:37:06 INFO - 'svgr-e10s': {'tests': ['tsvgx', 00:37:06 INFO - 'tsvgr_opacity', 00:37:06 INFO - 'tart', 00:37:06 INFO - 'tscrollx', 00:37:06 INFO - 'cart', 00:37:06 INFO - 'tsvg_static']}, 00:37:06 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 00:37:06 INFO - 'talos_options': ['--disable-e10s'], 00:37:06 INFO - 'tests': ['tp5o']}, 00:37:06 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 00:37:06 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 00:37:06 INFO - 'talos_options': ['--disable-e10s', 00:37:06 INFO - '--xperf_path', 00:37:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:37:06 INFO - 'tests': ['tp5n']}, 00:37:06 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 00:37:06 INFO - 'talos_options': ['--xperf_path', 00:37:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:37:06 INFO - 'tests': ['tp5n']}}, 00:37:06 INFO - 'talos.zip': {'path': '', 00:37:06 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 00:37:06 INFO - Running post-action listener: _resource_record_post_action 00:37:06 INFO - [mozharness: 2017-04-12 07:37:06.354173Z] Finished populate-webroot step (success) 00:37:06 INFO - [mozharness: 2017-04-12 07:37:06.354308Z] Running create-virtualenv step. 00:37:06 INFO - Running pre-action listener: _resource_record_pre_action 00:37:06 INFO - Running main action method: create_virtualenv 00:37:06 INFO - Creating virtualenv /builds/slave/test/build/venv 00:37:06 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 00:37:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 00:37:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 00:37:06 INFO - Using real prefix '/tools/python27' 00:37:06 INFO - New python executable in /builds/slave/test/build/venv/bin/python 00:37:07 INFO - Installing distribute.............................................................................................................................................................................................done. 00:37:10 INFO - Installing pip.................done. 00:37:10 INFO - Return code: 0 00:37:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 00:37:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 00:37:10 INFO - Reading from file tmpfile_stdout 00:37:10 INFO - Output received: 00:37:10 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) 00:37:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 00:37:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:37:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:37:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:37:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:37:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:37:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:37:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100c93b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c96768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa71d5ace0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a71d30>, '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 0x100998db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a66be8>, '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.hSLFcbxuqK/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.mGw6yviE3V/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/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 00:37:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 00:37:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 00:37:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hSLFcbxuqK/Render', 00:37:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:37:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:37:10 INFO - 'HOME': '/Users/cltbld', 00:37:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:37:10 INFO - 'LOGNAME': 'cltbld', 00:37:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:37:10 INFO - 'MOZ_NO_REMOTE': '1', 00:37:10 INFO - 'NO_EM_RESTART': '1', 00:37:10 INFO - 'PAGER': '/bin/cat', 00:37:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:37:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:37:10 INFO - 'PWD': '/builds/slave/test', 00:37:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:37:10 INFO - 'SHELL': '/bin/bash', 00:37:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mGw6yviE3V/Listeners', 00:37:10 INFO - 'TMPDIR': '/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/', 00:37:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:37:10 INFO - 'USER': 'cltbld', 00:37:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:37:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:37:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:37:10 INFO - 'XPC_FLAGS': '0x0', 00:37:10 INFO - 'XPC_SERVICE_NAME': '0', 00:37:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:37:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:37:10 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 00:37:10 INFO - Cleaning up... 00:37:10 INFO - Return code: 0 00:37:10 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 00:37:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:37:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:37:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:37:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:37:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:37:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:37:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100c93b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c96768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa71d5ace0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a71d30>, '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 0x100998db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a66be8>, '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.hSLFcbxuqK/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.mGw6yviE3V/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/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 00:37:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 00:37:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 00:37:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hSLFcbxuqK/Render', 00:37:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:37:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:37:10 INFO - 'HOME': '/Users/cltbld', 00:37:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:37:10 INFO - 'LOGNAME': 'cltbld', 00:37:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:37:10 INFO - 'MOZ_NO_REMOTE': '1', 00:37:10 INFO - 'NO_EM_RESTART': '1', 00:37:10 INFO - 'PAGER': '/bin/cat', 00:37:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:37:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:37:10 INFO - 'PWD': '/builds/slave/test', 00:37:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:37:10 INFO - 'SHELL': '/bin/bash', 00:37:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mGw6yviE3V/Listeners', 00:37:10 INFO - 'TMPDIR': '/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/', 00:37:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:37:10 INFO - 'USER': 'cltbld', 00:37:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:37:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:37:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:37:10 INFO - 'XPC_FLAGS': '0x0', 00:37:10 INFO - 'XPC_SERVICE_NAME': '0', 00:37:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:37:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:37:10 INFO - Downloading/unpacking psutil>=3.1.1 00:37:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:37:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:37:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:37:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:37:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:37:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:37:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 00:37:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:37:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:37:14 INFO - Installing collected packages: psutil 00:37:14 INFO - Running setup.py install for psutil 00:37:14 INFO - building 'psutil._psutil_osx' extension 00:37:14 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 00:37:14 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 00:37:14 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 00:37:15 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 00:37:15 INFO - building 'psutil._psutil_posix' extension 00:37:15 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 00:37:15 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 00:37:15 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 00:37:15 INFO - ^ 00:37:15 INFO - 1 warning generated. 00:37:15 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 00:37:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:37:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:37:15 INFO - Successfully installed psutil 00:37:15 INFO - Cleaning up... 00:37:15 INFO - Return code: 0 00:37:15 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 00:37:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:37:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:37:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:37:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:37:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:37:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:37:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100c93b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c96768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa71d5ace0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a71d30>, '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 0x100998db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a66be8>, '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.hSLFcbxuqK/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.mGw6yviE3V/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/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 00:37:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 00:37:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 00:37:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hSLFcbxuqK/Render', 00:37:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:37:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:37:15 INFO - 'HOME': '/Users/cltbld', 00:37:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:37:15 INFO - 'LOGNAME': 'cltbld', 00:37:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:37:15 INFO - 'MOZ_NO_REMOTE': '1', 00:37:15 INFO - 'NO_EM_RESTART': '1', 00:37:15 INFO - 'PAGER': '/bin/cat', 00:37:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:37:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:37:15 INFO - 'PWD': '/builds/slave/test', 00:37:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:37:15 INFO - 'SHELL': '/bin/bash', 00:37:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mGw6yviE3V/Listeners', 00:37:15 INFO - 'TMPDIR': '/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/', 00:37:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:37:15 INFO - 'USER': 'cltbld', 00:37:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:37:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:37:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:37:15 INFO - 'XPC_FLAGS': '0x0', 00:37:15 INFO - 'XPC_SERVICE_NAME': '0', 00:37:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:37:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:37:15 INFO - Downloading/unpacking mozsystemmonitor==0.3 00:37:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:37:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:37:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:37:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:37:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:37:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:37:18 INFO - Downloading mozsystemmonitor-0.3.tar.gz 00:37:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 00:37:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 00:37:18 INFO - Installing collected packages: mozsystemmonitor 00:37:18 INFO - Running setup.py install for mozsystemmonitor 00:37:18 INFO - Successfully installed mozsystemmonitor 00:37:18 INFO - Cleaning up... 00:37:18 INFO - Return code: 0 00:37:18 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 00:37:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:37:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:37:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:37:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:37:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:37:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:37: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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100c93b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c96768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa71d5ace0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a71d30>, '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 0x100998db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a66be8>, '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.hSLFcbxuqK/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.mGw6yviE3V/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/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 00:37: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==2.5.1'] in /builds/slave/test/build 00:37: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==2.5.1 00:37:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hSLFcbxuqK/Render', 00:37:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:37:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:37:20 INFO - 'HOME': '/Users/cltbld', 00:37:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:37:20 INFO - 'LOGNAME': 'cltbld', 00:37:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:37:20 INFO - 'MOZ_NO_REMOTE': '1', 00:37:20 INFO - 'NO_EM_RESTART': '1', 00:37:20 INFO - 'PAGER': '/bin/cat', 00:37:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:37:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:37:20 INFO - 'PWD': '/builds/slave/test', 00:37:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:37:20 INFO - 'SHELL': '/bin/bash', 00:37:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mGw6yviE3V/Listeners', 00:37:20 INFO - 'TMPDIR': '/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/', 00:37:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:37:20 INFO - 'USER': 'cltbld', 00:37:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:37:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:37:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:37:20 INFO - 'XPC_FLAGS': '0x0', 00:37:20 INFO - 'XPC_SERVICE_NAME': '0', 00:37:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:37:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:37:20 INFO - Downloading/unpacking jsonschema==2.5.1 00:37:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:37:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:37:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:37:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:37:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:37:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:37:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 00:37:23 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 00:37:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:37:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:37:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:37:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:37:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:37:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:37:23 INFO - Downloading functools32-3.2.3-2.tar.gz 00:37:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 00:37:23 INFO - warning: no files found matching '*.txt' 00:37:23 INFO - no previously-included directories found matching 'build' 00:37:23 INFO - no previously-included directories found matching 'dist' 00:37:23 INFO - no previously-included directories found matching '.git*' 00:37:23 INFO - Installing collected packages: jsonschema, functools32 00:37:23 INFO - Running setup.py install for functools32 00:37:24 INFO - warning: no files found matching '*.txt' 00:37:24 INFO - no previously-included directories found matching 'build' 00:37:24 INFO - no previously-included directories found matching 'dist' 00:37:24 INFO - no previously-included directories found matching '.git*' 00:37:24 INFO - Successfully installed jsonschema functools32 00:37:24 INFO - Cleaning up... 00:37:24 INFO - Return code: 0 00:37:24 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 00:37:24 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')]} 00:37:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:37:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:37:24 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')]} 00:37:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:37:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:37:24 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 0x100c93b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c96768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa71d5ace0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a71d30>, '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 0x100998db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a66be8>, '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.hSLFcbxuqK/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.mGw6yviE3V/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/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 00:37:24 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 00:37:24 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 00:37:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hSLFcbxuqK/Render', 00:37:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:37:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:37:24 INFO - 'HOME': '/Users/cltbld', 00:37:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:37:24 INFO - 'LOGNAME': 'cltbld', 00:37:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:37:24 INFO - 'MOZ_NO_REMOTE': '1', 00:37:24 INFO - 'NO_EM_RESTART': '1', 00:37:24 INFO - 'PAGER': '/bin/cat', 00:37:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:37:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:37:24 INFO - 'PWD': '/builds/slave/test', 00:37:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:37:24 INFO - 'SHELL': '/bin/bash', 00:37:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mGw6yviE3V/Listeners', 00:37:24 INFO - 'TMPDIR': '/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/', 00:37:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:37:24 INFO - 'USER': 'cltbld', 00:37:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:37:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:37:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:37:24 INFO - 'XPC_FLAGS': '0x0', 00:37:24 INFO - 'XPC_SERVICE_NAME': '0', 00:37:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:37:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:37:24 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 00:37:24 INFO - Cleaning up... 00:37:24 INFO - Return code: 0 00:37:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 00:37:24 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')]} 00:37:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:37:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:37:24 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')]} 00:37:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:37:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:37:24 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 0x100c93b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c96768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa71d5ace0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a71d30>, '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 0x100998db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a66be8>, '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.hSLFcbxuqK/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.mGw6yviE3V/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/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 00:37:24 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 00:37:24 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 00:37:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hSLFcbxuqK/Render', 00:37:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:37:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:37:24 INFO - 'HOME': '/Users/cltbld', 00:37:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:37:24 INFO - 'LOGNAME': 'cltbld', 00:37:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:37:24 INFO - 'MOZ_NO_REMOTE': '1', 00:37:24 INFO - 'NO_EM_RESTART': '1', 00:37:24 INFO - 'PAGER': '/bin/cat', 00:37:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:37:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:37:24 INFO - 'PWD': '/builds/slave/test', 00:37:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:37:24 INFO - 'SHELL': '/bin/bash', 00:37:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mGw6yviE3V/Listeners', 00:37:24 INFO - 'TMPDIR': '/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/', 00:37:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:37:24 INFO - 'USER': 'cltbld', 00:37:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:37:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:37:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:37:24 INFO - 'XPC_FLAGS': '0x0', 00:37:24 INFO - 'XPC_SERVICE_NAME': '0', 00:37:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:37:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:37:24 INFO - Downloading/unpacking blobuploader==1.2.4 00:37:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:37:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:37:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:37:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:37:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:37:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:37:27 INFO - Downloading blobuploader-1.2.4.tar.gz 00:37:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 00:37:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 00:37:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:37:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:37:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:37:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:37:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:37:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:37:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 00:37:28 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 00:37:28 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 00:37:28 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 00:37:28 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 00:37:28 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 00:37:28 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 00:37:28 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 00:37:28 INFO - Downloading docopt-0.6.1.tar.gz 00:37:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 00:37:28 INFO - Installing collected packages: blobuploader, requests, docopt 00:37:28 INFO - Running setup.py install for blobuploader 00:37:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 00:37:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 00:37:28 INFO - Running setup.py install for requests 00:37:29 INFO - Running setup.py install for docopt 00:37:29 INFO - Successfully installed blobuploader requests docopt 00:37:29 INFO - Cleaning up... 00:37:29 INFO - Return code: 0 00:37:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:37:29 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')]} 00:37:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:37:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:37:29 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')]} 00:37:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:37:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:37:29 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 0x100c93b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c96768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa71d5ace0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a71d30>, '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 0x100998db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a66be8>, '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.hSLFcbxuqK/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.mGw6yviE3V/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/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 00:37:29 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 00:37:29 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 00:37:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hSLFcbxuqK/Render', 00:37:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:37:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:37:29 INFO - 'HOME': '/Users/cltbld', 00:37:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:37:29 INFO - 'LOGNAME': 'cltbld', 00:37:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:37:29 INFO - 'MOZ_NO_REMOTE': '1', 00:37:29 INFO - 'NO_EM_RESTART': '1', 00:37:29 INFO - 'PAGER': '/bin/cat', 00:37:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:37:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:37:29 INFO - 'PWD': '/builds/slave/test', 00:37:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:37:29 INFO - 'SHELL': '/bin/bash', 00:37:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mGw6yviE3V/Listeners', 00:37:29 INFO - 'TMPDIR': '/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/', 00:37:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:37:29 INFO - 'USER': 'cltbld', 00:37:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:37:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:37:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:37:29 INFO - 'XPC_FLAGS': '0x0', 00:37:29 INFO - 'XPC_SERVICE_NAME': '0', 00:37:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:37:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:37:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:37:29 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-Jb5LeO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:37:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:37:29 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-5JozHc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:37:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:37:30 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-9_uFzA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:37:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:37:30 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-4XMDzD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:37:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:37:30 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-0ucvk7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:37:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:37:30 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-u4apET-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:37:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:37:30 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-hstTWx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:37:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:37:30 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-xpaL4B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:37:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:37:30 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-WQyR1Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:37:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:37:30 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-7BZGxh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:37:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:37:30 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-44pTNS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:37:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:37:30 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-B9wxqh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:37:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:37:31 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-seM3S4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:37:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:37:31 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-eFDbrj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:37:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:37:31 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-UY8D6z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:37:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:37:31 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-OVB_1T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:37:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:37:31 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-wK_YRx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:37:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 00:37:31 INFO - Running setup.py install for manifestparser 00:37:31 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 00:37:31 INFO - Running setup.py install for mozcrash 00:37:31 INFO - Running setup.py install for mozdebug 00:37:31 INFO - Running setup.py install for mozdevice 00:37:32 INFO - Installing dm script to /builds/slave/test/build/venv/bin 00:37:32 INFO - Running setup.py install for mozfile 00:37:32 INFO - Running setup.py install for mozhttpd 00:37:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 00:37:32 INFO - Running setup.py install for mozinfo 00:37:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 00:37:32 INFO - Running setup.py install for mozInstall 00:37:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 00:37:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 00:37:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 00:37:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 00:37:32 INFO - Running setup.py install for mozleak 00:37:32 INFO - Running setup.py install for mozlog 00:37:33 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 00:37:33 INFO - Running setup.py install for moznetwork 00:37:33 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 00:37:33 INFO - Running setup.py install for mozprocess 00:37:33 INFO - Running setup.py install for mozprofile 00:37:33 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 00:37:33 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 00:37:33 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 00:37:33 INFO - Running setup.py install for mozrunner 00:37:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 00:37:33 INFO - Running setup.py install for mozscreenshot 00:37:33 INFO - Running setup.py install for moztest 00:37:33 INFO - Running setup.py install for mozversion 00:37:34 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 00:37:34 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 00:37:34 INFO - Cleaning up... 00:37:34 INFO - Return code: 0 00:37:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:37:34 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')]} 00:37:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:37:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:37:34 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')]} 00:37:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:37:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:37:34 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 0x100c93b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c96768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa71d5ace0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a71d30>, '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 0x100998db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a66be8>, '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.hSLFcbxuqK/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.mGw6yviE3V/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/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 00:37:34 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 00:37:34 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 00:37:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hSLFcbxuqK/Render', 00:37:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:37:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:37:34 INFO - 'HOME': '/Users/cltbld', 00:37:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:37:34 INFO - 'LOGNAME': 'cltbld', 00:37:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:37:34 INFO - 'MOZ_NO_REMOTE': '1', 00:37:34 INFO - 'NO_EM_RESTART': '1', 00:37:34 INFO - 'PAGER': '/bin/cat', 00:37:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:37:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:37:34 INFO - 'PWD': '/builds/slave/test', 00:37:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:37:34 INFO - 'SHELL': '/bin/bash', 00:37:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mGw6yviE3V/Listeners', 00:37:34 INFO - 'TMPDIR': '/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/', 00:37:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:37:34 INFO - 'USER': 'cltbld', 00:37:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:37:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:37:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:37:34 INFO - 'XPC_FLAGS': '0x0', 00:37:34 INFO - 'XPC_SERVICE_NAME': '0', 00:37:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:37:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:37:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:37:34 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-RjhiMn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:37:34 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)) 00:37:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:37:34 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-SzLCNy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:37:34 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)) 00:37:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:37:34 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-2RRXeJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:37:34 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)) 00:37:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:37:34 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-V93dxP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:37:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 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)) 00:37:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:37:34 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-kupBCA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:37:34 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)) 00:37:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:37:34 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-ePhFOV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:37:35 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)) 00:37:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:37:35 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-Dt_B8z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:37:35 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)) 00:37:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:37:35 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-JIywjm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:37:35 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)) 00:37:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:37:35 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-47GBHd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:37:35 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)) 00:37:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:37:35 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-JaoPbI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:37:35 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)) 00:37:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:37:35 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-_fdWgj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:37:35 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)) 00:37:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:37:35 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-iE9fwx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:37:35 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)) 00:37:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:37:35 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-gT_hBo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:37:35 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)) 00:37:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:37:35 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-tW8l3V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:37:35 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)) 00:37:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:37:35 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-kn04vw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:37:36 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)) 00:37:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:37:36 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-8GnBPh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:37:36 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)) 00:37:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:37:36 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-IWec5I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:37:36 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)) 00:37:36 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)) 00:37:36 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)) 00:37:36 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)) 00:37:36 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 00:37:36 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 00:37:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 00:37:36 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 00:37:36 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 00:37:36 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 00:37:36 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 00:37:36 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 00:37:36 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 00:37:38 INFO - Downloading blessings-1.6.tar.gz 00:37:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 00:37:39 INFO - Installing collected packages: blessings 00:37:39 INFO - Running setup.py install for blessings 00:37:39 INFO - Successfully installed blessings 00:37:39 INFO - Cleaning up... 00:37:39 INFO - Return code: 0 00:37:39 INFO - Done creating virtualenv /builds/slave/test/build/venv. 00:37:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:37:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:37:39 INFO - Reading from file tmpfile_stdout 00:37:39 INFO - Current package versions: 00:37:39 INFO - blessings == 1.6 00:37:39 INFO - blobuploader == 1.2.4 00:37:39 INFO - docopt == 0.6.1 00:37:39 INFO - functools32 == 3.2.3-2 00:37:39 INFO - jsonschema == 2.5.1 00:37:39 INFO - manifestparser == 1.1 00:37:39 INFO - mozInstall == 1.12 00:37:39 INFO - mozcrash == 1.0 00:37:39 INFO - mozdebug == 0.1 00:37:39 INFO - mozdevice == 0.50 00:37:39 INFO - mozfile == 1.2 00:37:39 INFO - mozhttpd == 0.7 00:37:39 INFO - mozinfo == 0.9 00:37:39 INFO - mozleak == 0.1 00:37:39 INFO - mozlog == 3.4 00:37:39 INFO - moznetwork == 0.27 00:37:39 INFO - mozprocess == 0.25 00:37:39 INFO - mozprofile == 0.28 00:37:39 INFO - mozrunner == 6.13 00:37:39 INFO - mozscreenshot == 0.1 00:37:39 INFO - mozsystemmonitor == 0.3 00:37:39 INFO - moztest == 0.8 00:37:39 INFO - mozversion == 1.4 00:37:39 INFO - psutil == 3.1.1 00:37:39 INFO - requests == 1.2.3 00:37:39 INFO - wsgiref == 0.1.2 00:37:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:37:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:37:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:37:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:37:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:37:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:37:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:37:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100c93b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c96768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa71d5ace0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a71d30>, '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 0x100998db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a66be8>, '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.hSLFcbxuqK/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.mGw6yviE3V/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/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 00:37:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 00:37:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 00:37:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hSLFcbxuqK/Render', 00:37:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:37:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:37:39 INFO - 'HOME': '/Users/cltbld', 00:37:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:37:39 INFO - 'LOGNAME': 'cltbld', 00:37:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:37:39 INFO - 'MOZ_NO_REMOTE': '1', 00:37:39 INFO - 'NO_EM_RESTART': '1', 00:37:39 INFO - 'PAGER': '/bin/cat', 00:37:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:37:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:37:39 INFO - 'PWD': '/builds/slave/test', 00:37:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:37:39 INFO - 'SHELL': '/bin/bash', 00:37:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mGw6yviE3V/Listeners', 00:37:39 INFO - 'TMPDIR': '/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/', 00:37:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:37:39 INFO - 'USER': 'cltbld', 00:37:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:37:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:37:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:37:39 INFO - 'XPC_FLAGS': '0x0', 00:37:39 INFO - 'XPC_SERVICE_NAME': '0', 00:37:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:37:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:37:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 00:37:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 00:37:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 00:37:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 00:37:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 00:37:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 00:37:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 00:37:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 00:37:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 00:37:39 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 00:37:39 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 00:37:39 INFO - Cleaning up... 00:37:39 INFO - Return code: 0 00:37:39 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 00:37:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:37:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:37:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:37:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:37:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:37:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:37:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100c93b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c96768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa71d5ace0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a71d30>, '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 0x100998db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a66be8>, '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.hSLFcbxuqK/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.mGw6yviE3V/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/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 00:37:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 00:37:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 00:37:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hSLFcbxuqK/Render', 00:37:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:37:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:37:39 INFO - 'HOME': '/Users/cltbld', 00:37:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:37:39 INFO - 'LOGNAME': 'cltbld', 00:37:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:37:39 INFO - 'MOZ_NO_REMOTE': '1', 00:37:39 INFO - 'NO_EM_RESTART': '1', 00:37:39 INFO - 'PAGER': '/bin/cat', 00:37:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:37:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:37:39 INFO - 'PWD': '/builds/slave/test', 00:37:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:37:39 INFO - 'SHELL': '/bin/bash', 00:37:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mGw6yviE3V/Listeners', 00:37:39 INFO - 'TMPDIR': '/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/', 00:37:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:37:39 INFO - 'USER': 'cltbld', 00:37:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:37:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:37:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:37:39 INFO - 'XPC_FLAGS': '0x0', 00:37:39 INFO - 'XPC_SERVICE_NAME': '0', 00:37:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:37:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:37:40 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 00:37:40 INFO - Cleaning up... 00:37:40 INFO - Return code: 0 00:37:40 INFO - Running post-action listener: _resource_record_post_action 00:37:40 INFO - Running post-action listener: _start_resource_monitoring 00:37:40 INFO - Starting resource monitoring. 00:37:40 INFO - [mozharness: 2017-04-12 07:37:40.150200Z] Finished create-virtualenv step (success) 00:37:40 INFO - [mozharness: 2017-04-12 07:37:40.151082Z] Running install step. 00:37:40 INFO - Running pre-action listener: _resource_record_pre_action 00:37:40 INFO - Running main action method: install 00:37:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:37:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:37:40 INFO - Reading from file tmpfile_stdout 00:37:40 INFO - Detecting whether we're running mozinstall >=1.0... 00:37:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 00:37:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 00:37:40 INFO - Reading from file tmpfile_stdout 00:37:40 INFO - Output received: 00:37:40 INFO - Usage: mozinstall [options] installer 00:37:40 INFO - Options: 00:37:40 INFO - -h, --help show this help message and exit 00:37:40 INFO - -d DEST, --destination=DEST 00:37:40 INFO - Directory to install application into. [default: 00:37:40 INFO - "/builds/slave/test"] 00:37:40 INFO - --app=APP Application being installed. [default: firefox] 00:37:40 INFO - mkdir: /builds/slave/test/build/application 00:37:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 00:37:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 00:37:59 INFO - Reading from file tmpfile_stdout 00:37:59 INFO - Output received: 00:37:59 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 00:37:59 INFO - Running post-action listener: _resource_record_post_action 00:37:59 INFO - [mozharness: 2017-04-12 07:37:59.937258Z] Finished install step (success) 00:37:59 INFO - [mozharness: 2017-04-12 07:37:59.937406Z] Running run-tests step. 00:37:59 INFO - Running pre-action listener: _resource_record_pre_action 00:37:59 INFO - Running main action method: run_tests 00:37:59 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 00:37:59 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 00:37:59 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 00:37:59 INFO - 2017-04-12 00:37:59.952 screenresolution[1967:14543] starting screenresolution argv=screenresolution get 00:37:59 INFO - 2017-04-12 00:37:59.955 screenresolution[1967:14543] Display 0: 1600x1200x32@60 00:37:59 INFO - 2017-04-12 00:37:59.961 screenresolution[1968:14547] starting screenresolution argv=screenresolution list 00:37:59 INFO - Available Modes on Display 0 00:37:59 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 00:37:59 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 00:37:59 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 00:37:59 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 00:38:00 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 00:38:00 INFO - Intel Iris: 00:38:00 INFO - Chipset Model: Intel Iris 00:38:00 INFO - Type: GPU 00:38:00 INFO - Bus: Built-In 00:38:00 INFO - VRAM (Dynamic, Max): 1536 MB 00:38:00 INFO - Vendor: Intel (0x8086) 00:38:00 INFO - Device ID: 0x0a2e 00:38:00 INFO - Revision ID: 0x0009 00:38:00 INFO - Displays: 00:38:00 INFO - Display: 00:38:00 INFO - Resolution: 1600 x 1200 @ 60 Hz 00:38:00 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 00:38:00 INFO - Display Serial Number: 1600x1200 60 00:38:00 INFO - Main Display: Yes 00:38:00 INFO - Mirror: Off 00:38:00 INFO - Online: Yes 00:38:00 INFO - Rotation: Supported 00:38:00 INFO - Return code: 0 00:38:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 00:38:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 00:38:00 INFO - Python 2.7.3 00:38:00 INFO - Return code: 0 00:38:00 INFO - grabbing minidump binary from tooltool 00:38: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')]} 00:38:00 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 0x100a71d30>, '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 0x100998db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a66be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 00:38:00 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 00:38:00 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 00:38:00 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 00:38:00 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 00:38:00 INFO - Return code: 0 00:38:00 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 00:38:00 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 00:38:00 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 00:38:00 INFO - ENV: RUST_BACKTRACE is now 1 00:38:00 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 00:38:00 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 00:38:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Pine', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ro9uj5nrR9y22GYTTTEaEw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0188', '--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 00:38:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Pine --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Ro9uj5nrR9y22GYTTTEaEw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0188 --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 00:38:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hSLFcbxuqK/Render', 00:38:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:38:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:38:00 INFO - 'HOME': '/Users/cltbld', 00:38:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:38:00 INFO - 'LOGNAME': 'cltbld', 00:38:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 00:38:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 00:38:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:38:00 INFO - 'MOZ_NO_REMOTE': '1', 00:38:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 00:38:00 INFO - 'NO_EM_RESTART': '1', 00:38:00 INFO - 'PAGER': '/bin/cat', 00:38:00 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:38:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:38:00 INFO - 'PWD': '/builds/slave/test', 00:38:00 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 00:38:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:38:00 INFO - 'RUST_BACKTRACE': '1', 00:38:00 INFO - 'SHELL': '/bin/bash', 00:38:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mGw6yviE3V/Listeners', 00:38:00 INFO - 'TMPDIR': '/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/', 00:38:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:38:00 INFO - 'USER': 'cltbld', 00:38:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:38:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:38:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:38:00 INFO - 'XPC_FLAGS': '0x0', 00:38:00 INFO - 'XPC_SERVICE_NAME': '0', 00:38:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:38:00 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Pine', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ro9uj5nrR9y22GYTTTEaEw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0188', '--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 00:38:00 INFO - mozversion application_buildid: 20170411153607 00:38:00 INFO - mozversion application_changeset: 099d239a4f861e204320e2c7fa81001fce31b2cf 00:38:00 INFO - mozversion application_display_name: Nightly 00:38:00 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 00:38:00 INFO - mozversion application_name: Firefox 00:38:00 INFO - mozversion application_remotingname: firefox 00:38:00 INFO - mozversion application_repository: https://hg.mozilla.org/projects/pine 00:38:00 INFO - mozversion application_vendor: Mozilla 00:38:00 INFO - mozversion application_version: 55.0a1 00:38:00 INFO - mozversion platform_buildid: 20170411153607 00:38:00 INFO - mozversion platform_changeset: 099d239a4f861e204320e2c7fa81001fce31b2cf 00:38:00 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/pine 00:38:00 INFO - mozversion platform_version: 55.0a1 00:38:00 INFO - using testdate: 1491982680 00:38:00 INFO - actual date: 1491982680 00:38:00 INFO - starting webserver on 'localhost:49660' 00:38:00 INFO - SUITE-START | Running 2 tests 00:38:00 INFO - TEST-START | dromaeo_css 00:38:00 INFO - operating with platform_type : mac_ 00:38:00 INFO - Initialising browser for dromaeo_css test... 00:38:00 INFO - TEST-INFO | started process 1978 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/tmpBZWOZk/profile http://localhost:49660/getInfo.html) 00:38:03 INFO - PID 1978 | __metrics Screen width/height:1600/1200 00:38:03 INFO - PID 1978 | colorDepth:24 00:38:03 INFO - PID 1978 | Browser inner width/height: 1024/689 00:38:03 INFO - PID 1978 | __metrics 00:38:03 INFO - PID 1978 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 00:38:03 INFO - PID 1978 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 304: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 00:38:04 INFO - TEST-INFO | 1978: exit 0 00:38:04 INFO - Browser initialized. 00:38:04 INFO - Running cycle 1/1 for dromaeo_css test... 00:38:04 INFO - TEST-INFO | started process 1980 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/tmpBZWOZk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:38:16 INFO - PID 1980 | RSS: Main: 240160768 00:38:16 INFO - PID 1980 | 00:41:22 INFO - PID 1980 | Cycle 1(1): loaded http://localhost:49660/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49660/tests/dromaeo/cssquery-ext.html) 00:41:23 INFO - PID 1980 | RSS: Main: 397615104 00:41:23 INFO - PID 1980 | 00:43:06 INFO - PID 1980 | ************************* 00:43:06 INFO - PID 1980 | A coding exception was thrown and uncaught in a Task. 00:43:06 INFO - PID 1980 | 00:43:06 ERROR - PID 1980 | Full message: TypeError: NetworkError when attempting to fetch resource. 00:43:06 INFO - PID 1980 | Full stack: 00:43:06 INFO - PID 1980 | ************************* 00:43:06 INFO - PID 1980 | ************************* 00:43:06 INFO - PID 1980 | A coding exception was thrown and uncaught in a Task. 00:43:06 INFO - PID 1980 | 00:43:06 ERROR - PID 1980 | Full message: TypeError: NetworkError when attempting to fetch resource. 00:43:06 INFO - PID 1980 | Full stack: 00:43:06 INFO - PID 1980 | ************************* 00:43:06 INFO - PID 1980 | ************************* 00:43:06 INFO - PID 1980 | A coding exception was thrown and uncaught in a Task. 00:43:06 INFO - PID 1980 | 00:43:06 ERROR - PID 1980 | Full message: TypeError: NetworkError when attempting to fetch resource. 00:43:06 INFO - PID 1980 | Full stack: 00:43:06 INFO - PID 1980 | ************************* 00:43:06 INFO - PID 1980 | ************************* 00:43:06 INFO - PID 1980 | A coding exception was thrown and uncaught in a Task. 00:43:06 INFO - PID 1980 | 00:43:06 ERROR - PID 1980 | Full message: TypeError: NetworkError when attempting to fetch resource. 00:43:06 INFO - PID 1980 | Full stack: 00:43:06 INFO - PID 1980 | ************************* 00:44:26 INFO - PID 1980 | Cycle 1(1): loaded http://localhost:49660/tests/dromaeo/cssquery-ext.html (next: http://localhost:49660/tests/dromaeo/cssquery-jquery.html) 00:44:26 INFO - PID 1980 | RSS: Main: 366968832 00:44:26 INFO - PID 1980 | 00:47:29 INFO - PID 1980 | Cycle 1(1): loaded http://localhost:49660/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49660/tests/dromaeo/cssquery-mootools.html) 00:47:29 INFO - PID 1980 | RSS: Main: 329691136 00:47:29 INFO - PID 1980 | 00:50:32 INFO - PID 1980 | Cycle 1(1): loaded http://localhost:49660/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49660/tests/dromaeo/cssquery-prototype.html) 00:50:32 INFO - PID 1980 | RSS: Main: 333037568 00:50:32 INFO - PID 1980 | 00:53:36 INFO - PID 1980 | Cycle 1(1): loaded http://localhost:49660/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49660/tests/dromaeo/cssquery-yui.html) 00:53:37 INFO - PID 1980 | RSS: Main: 341688320 00:53:37 INFO - PID 1980 | 00:56:39 INFO - PID 1980 | Cycle 1(1): loaded http://localhost:49660/tests/dromaeo/cssquery-yui.html (next: http://localhost:49660/tests/dromaeo/cssquery-dojo.html) 00:56:39 INFO - PID 1980 | RSS: Main: 378429440 00:56:39 INFO - PID 1980 | 00:56:39 INFO - PID 1980 | __start_tp_report 00:56:39 INFO - PID 1980 | _x_x_mozilla_page_load 00:56:39 INFO - PID 1980 | _x_x_mozilla_page_load_details 00:56:39 INFO - PID 1980 | |i|pagename|runs| 00:56:39 INFO - PID 1980 | |0;dojo.html;3402.8298585070747;3411.692947634714;3415.265717870657;3424.2295483516205;3483.8432270547823;5086.262491938666;5895.408239775258;6062.878742425154;6087.965045942195;6104.206453161089;6020.217371741678;6020.488258498022;6029.668368239745;6050.062240352752;6050.667213303266;4792.329073929653;5071.644984851053;5266.34170728659;5266.605004624649;5327.813526526573;5135.460776618457;5283.63014588979;5299.311089558352;5343;5359.38367087786;5243.632945693803;5251.947480525184;5261.973690131525;5311.362636483646;5358.758855851496;4299.441072660566;5215;5254.028004819121;5264.631475796696;5344.812931547416;5238.449962753933;5251.396089449724;5272.340957380327;5283.947160528384;5286.550643195333;5822.097574875901;5844.503217226541;5851.531877449836;5982.132590774357;6066.514678825683;6375.043743438475;6379.138816259839;6389;6400.583962042452;6413.903791443132;5435.592330575223;6495.253045899687;6504.837379065514;6511.925532287167;6519.217693876718;5978.521718262528;6046.455818976226;6111.87776244477;6175.2898416681755;6180.134781130645;6419.325970773001;6491.058796474485;6605.07528945948;6627.635480048643;6632.1709786276715;6347.682615869188;6358.841028974312;6369.331220221903;6373.936260637334;6379.968100159563;6302.054691796176;6388.904166437507;6424.935750642528;6442.098106265126;6452.483801295885;6323.494120470351;6352.301246862841;6354.809355719243;6368.363163683594;6376.171097757262;6339.144215530844;6393.488520918316;6397.744090236339;6402.199725034371;6407.679616019181;5127.66670166438;5185.274061631375;5207.3230480037355;5211.557017653542;5257.947420525746;4512.097580483916;4586.312053192048;4638.257878739386;4640.396748422683;4658.114958157939;6013.819585412444;6019.337872833985;6033.607815491979;6048.6975651218145;6058.575899687068;6350.396712312323;6351.269603995507;6359.268684101295;6370.0763389308295;6373.71318290678;5221.947780522222;5974.522038236931;6001.159837622737;6060.272767267956;6062.939370606326;5637.985162670759;5638.2670252866865;5648.74580643872;5650.180723795027;5656.745446454919;6453.9677301612255;6455.580387274812;6457.903131453126;6464.321246269168;6468.708908099241;6290.811275661737;6390.073439351361;6403.807885763435;6492.870142597028;6504.991726282434;6612.735490580515;6622.801315960529;6623.701933413105;6636.568623039487;6642.368974947372;6251.68741562911;6299.559030867796;6314.431701146918;6328.050792381179;6388.39310265524;6325.367463253638;6403.231612206565;6436.67816609177;6466.4503517201565;6466.676666166579;4926.852194434029;6271.9053688067115;6318.210223722035;6351.523635727432;6363.745450181941;6198;6313.210848643919;6322;6340.1440805490665;6350.7459701611415;6125.867432399968;6179.783707570214;6217.440430361289;6283.02613094971;6302.779402720883;6284.214473190851;6293.622382657055;6337.493000559852;6346.174997250328;6355.713992870239;6232.688365581794;6254.437100660963;6270.811875643738;6295.370462953668;6327.303996560467 00:56:39 INFO - PID 1980 | |1;ext.html;752.1425574844678;794.5947566740962;816.5223344343559;1074.5594306334403;1141.8287256911458;27384.726152738465;27917.441651166966;27927.720722792816;27959;27979.860100699494;28049.158525244224;36553;36824.63175368246;36888;36901.44647830278;8447.662093516252;8568.914310856906;8594.699185528507;8602.35482338827;8604.440711353773;5189.792408303663;8532.658693652247;8673.349498787584;8675.522846243453;8683.652653893869;6202.611994382173;8403.621837017348;8595.656173753074;8597.957010214941;8628.137186281385;8525.744227673149;8591.957040214822;8609.139086091403;8610.397272190949;8627.65489380424;8386.916130838674;8505.19200675941;8505.95747021261;8511.489310641382;8516.616752246164;25934;26327.21018369452;36211.63788362109;36596;36712.81643591791;3516.261585067139;3544.805035723034;3558.2349794794245;3558.4128618777872;3560.3769340365334;24865.135114866458;30475.542866857017;30511.847440762653;30529;30582.694173058208;3100.410921924827;3139.827309497977;3153.779235453519;3155.984220078908;3162.936741265185;271639;275747;276433;277044;277897;36147.55409783579;47924.28113578299;48092.759536202095;48194;48317.275240871415;50510;50548.24177637338;50580.241296380584;50629.74685126551;50637.48087557379;14070.71858562823;14224.14655120696;14233.92883035599;14246.43014279438;14251.78622320666;11681.707957301136;11682.824757628643;11695.005924496512;11696.649100526827;11711.355875426932;8695.565221738887;11829.171957963032;11971.221870578385;12105.334206618545;12146.939265303618;3908.5700572936953;3928.096537796323;5308.46915308466;5621.494065534122;5949.375315591887;1014.3508154780947;1024.6055268721448;1027.9280450368403;1054.7099547624464;1058.1851973979992;21981.883608388136;23518;24747.305676441072;24806.00775968941;24849;1097.1716354152563;1097.8627671541058;1113.1373185781085;1143.519721716881;1148.62095508482;12196;12319.014478841671;12329.013678905667;12336.383180840921;12432.440540175714;364065;365934;366049.92276119813;366457;367010;54277;54547;54608.453915461134;54806.45193548014;54983.45016549863;1482.495951376537;1512.6445285357931;1537.7923980262522;1543.5446543269763;1555.8839977630414;21862.89068554647;22019.22932697348;23768.168114115924;23847.642285365386;23925;38054.048648784;38113.80943095378;38146.809265953496;38162;38242;321604;321872;321910.39044805564;322207;323774;35234.29531409409;35380.27774722794;35518.75684351035;35546.28907421889;35637.64362356447;36118.8194059028;37126.44310335293;44086.11827763363;45212;45229;25412.74587254104;26758.063467778535;28184.43631127325;30779.538306924966;31096.22259443532;29721.10836674903;30476.695233047387;31061;31291.530627040156;31317.74729010905;36192.45711314385;37269.81365093266;37341.4398784013;37440.251194975404;37650.43524347192;30962;31179.064628061195;31192.064238072893;31756;32213.355732884742;23898.163564275168;23933.16233931804;23992.520149597258;24320.87839560791;24402.389940251636 00:56:39 INFO - PID 1980 | |2;jquery.html;401.97588144711335;402.84691817109496;432.5695932547116;438.6249756458227;444.218176010222;13277.867221327784;20819.27132550361;22238.110475580957;22301.553968920613;22547.436314092156;22881.19915802947;22985.080596776108;23147.421314467105;23251.953662085205;23587.410314742097;6115.357887421824;6262.906056409169;6336.58812177207;6399.296077431479;6454.9677251613675;3775.5469343678797;5792.68140252286;6011.789587364443;6219.689015549227;6300.149479820211;3940.6847452203897;5495.725213739317;6090.451859332659;6348.30168681447;6388.744450221986;6102.20671312731;6215.658138802364;6274.937250627481;6368.681565921708;6385.297617262097;5591.916121258185;5600.27196464457;5601.383847776741;5601.523870471015;5605.439456054402;27240.863795681093;27344.45311093787;28050.71949280522;28253;28351.57472637912;2238.5746708125403;2288.6338185890345;2289.564982653307;2290.3701482092392;2291.598970180212;15409;17107.31570737169;18232.817671823377;18330.90834545832;18343.89936603808;2114.7039414481983;2152.913883444676;2160.0387827416807;2191.0140436803504;2194.440417693494;149893.25907297785;149936;151515;152495;154922.22538887346;11296.435178241056;11791.410429478492;12368.876311236772;12411.937940310241;12442.626721198378;15542.844571554366;15550.14474203907;15595.532134035997;15602.609934751723;16214;8874.86687699685;8885.582502603702;9029.051949545334;9152.725418237464;9171.724848254564;8570.142985701379;8584.65661373538;8591.09793471689;8746.518941458153;8763.430377025474;7666.233376662401;7810.960945195237;7832.300619628291;7857.842843143219;7884.2260491390125;1807.4577626711934;2136.7863213678506;2140.571885622882;2160.79472450117;2319.4085508195303;740.5223630758131;875.4397185801092;900.3967341880824;924.847400178963;930.3487558708931;13901.235432051131;17234.138293085547;17797.911010444866;18166.00086995228;18263.45209643713;876.6756300168978;915.716128000322;924.7225832250298;927.9628814847465;946.2099147212017;8853.73438796837;9065.954670226607;9075.228605568469;9162.908370916206;9326.440413575072;645276;655484;660696;674653.0277577782;679477.2575016745;153840;153928;154388;157036;157055;1134.5688638317552;1163.5811108001112;1191.1721353659298;1191.541256616209;1193.8149586814059;16947.91526042362;17079.829201707824;17649.647007060044;17833.197506111996;18039.007854568124;61963.6901815488;62056;63021.05468418069;63665;64394.35605644071;88856;90098.54950725204;90395.0960490413;91107.0889291125;91199.54400227957;7439.739609113655;8574.485530868167;8638.956805215934;8747.737567872973;8875.890513685788;13574.796378054534;13848;13935.930320348334;14095.788563171765;14286.785698214328;11513.251638643462;11669.416529173337;11937.701557461132;11959.461824217757;12071.75856482883;10614.310069845744;10735.516901739284;10938.781224375309;11095.278806877526;11095.334279943228;11763.411829408666;11788;12106.213096148722;12144;12157.696057598278;8693.739187824121;8730.214280714767;8785.121487851164;8949.284057275532;9227.35408521397;11197;11742.765144697229;11778.646640600795;12268.877311226774;12310.322932238812 00:56:39 INFO - PID 1980 | |3;mootools.html;1109.4563663804736;1432.5630682641797;1458.883289336853;1459.6350912271928;1468.4640106361169;9895.703128906145;11488.597899073535;11988.40057997101;12063.698407539816;12064.457099430525;11537.596184133557;11707.063434925207;11932.522699092026;11963.700907477318;11992.220505667126;2493.463905260369;2539.5555777738914;2543.3895864992455;2544.4656622109287;2550.4516528946274;2294.8181686431503;2409.6867407237037;2467.469494058777;2501.949961000779;2530.6204069389646;2414.9637755433596;2515.4843257132334;2520.5463016656995;2521.596544552872;2523.1673547729206;2453.5092981403614;2496.6754321938033;2497.463045445229;2501.5497210502103;2527.0397249045336;2422.685050943366;2447.510497900409;2447.669564608773;2455.6316552517264;2464.5440593490084;11814.64556063311;11954.402279886059;11957.880421195763;11959.461824217931;11989.280643161439;6584.8024559263295;6837.965810170967;6846.383825455683;6849.075374824385;6850.520463567552;3389.440742277521;4004.7797371144575;4045.8064870862872;4267.871963841089;4396.472423309191;1222.572099765084;1230.2249582762893;1282.3588205897051;1286.0483242400555;1288.2656885575225;15093.622659433493;15599.766003509843;16599.087050212234;16852.494425167264;16862.578435539086;5132.538071573576;5648.8870222595315;5841.766329346779;5846.181534585162;5858.297004359504;12324.50701971911;12350.320732359807;12367.567135150226;12388.62834114978;12398;6445.4199122079235;6611.074449577063;6625.370589793962;6632.237292711304;6656.201255849329;5993.160957465958;6071.483923866433;6143.508519318533;6231.594946328565;6256.061590761422;4428.535003824616;4431.955680443219;4454.710443821141;4505.346724724896;4539.251023581072;1272.3701767625084;1297.0725930959409;1298.9870101299055;1312.7308901675133;1314.9934250328688;772.058089131259;781.8592653322343;797.8803179523118;801.3188789528854;803.5098589860181;6521.771737989147;6629.502787290972;7008.929910700827;7041;7066.787996360117;911.2163539356148;924.4407133684159;929.1312622697799;934.2619330728784;938.474454305591;3351.4470112431177;3953;4061.289274376972;4215.156968606291;4288.807003684841;14464.27678616065;15404.845951540341;15415.92292038555;15435.768463473058;15480.303386347641;11408.315501069963;12356.443960021641;14858.29129650104;15401.922990384975;15428;10922.18083643714;11128.499217535069;11129.220954533266;11151;11177.552897883994;6616.867662646817;6624.091785846374;6780.288069752605;6822.931770682429;6874.072000279898;13557.661058473617;13910.860891390956;13925.79111313311;13997.50062484379;14054.086484378482;12698.30159341245;12701.618951431472;12864.614061577793;13837.515686950908;14407.639809004439;8689.391742577958;8973.50645714492;8984;8988.415752976036;8993.010768815295;10722;10746.785064298514;10762.041087076823;10838.403887786248;10865.619703310662;8619.138086191331;9238.722838314861;9274.582643781181;9282.9535852323;9373.484458354584;8402.663893444194;9107.180353768194;9154.359194856295;9156.816863662556;9221.262299015929;8033.6786528538205;8199.057108432607;8199.672013119647;8200.876986845322;8211.425200236165;5114.616403769658;5766.336871259691;5786.247787787561;5867.647941123546;5986.9401305986385;5990.231038925986;6101.725422355916;6160.691965401802;6203.906941395973;6306.369363063657 00:56:39 INFO - PID 1980 | |4;prototype.html;363.4439307858975;373.65063665472786;388.7783963141009;407.2672368407982;415.84405847807074;4331.718438301512;5759.308882934043;5769.769209231631;5897.646141231529;5914.88170236595;4342.522322544525;4532.4334458192725;5553.8333849984465;5700.144978253254;5755.510781583571;3770.359038963369;4063.167050754588;4242.915141697172;4261.8082186301535;4267.460860787842;3610.5667319921645;4202.600752928467;4292.441982542281;4304.483461984566;4308.80610372534;4130.752154870717;4238.5761423857675;4241.809118589656;4243.893902652428;4283.400323954649;3570.3394871948512;3938.35017222158;4212.978935105336;4224.176285624305;4251.404803327537;3191.872325106993;3267.509873518967;3497.8775742849134;3715.5727091384565;3726.366517691999;5572.275604171432;5572.7770889164385;5581.348859291804;5584.888302233973;5597.972010139923;4725.243960966229;4967.230079337708;5007.198848184309;5047.369078865142;5052.433745538895;5513.807016754395;5870.823875283749;6071.241094863142;6073.240844894388;6084.209052823105;4145.253854306224;4156.39978608235;4166.208420400145;4169.97915010426;4174.436451079096;5047.242913562958;6009.444982477881;6353.142325786052;6409.711562979677;6423.775167869149;3583.9820800895827;4199.391088292181;4212.915741685149;4224.978875105605;4228.217779710763;4267.103908179317;4290.785460726951;4295.205387003414;4308.418363520947;4501.15452664406;3839.9232015359535;4911.9754401227765;4975.975120124376;4988.775505102279;5010.148274793221;6061.424164704346;6079.024317096962;6084.209052823193;6084.30030546484;6088.756449742049;1445.7975883376337;1463.3707505772406;1471.757160068598;1474.2849717886816;1479.6448852275591;782.85517179322;840.9453385529921;969.1762002297991;980.2843923935567;993.8608594796734;5680.914786278209;5697.886042279131;5713.942860571424;5721.856953576111;5728.255326807572;5605.747741351649;6117.898778219963;6245;6247.781327653601;6269.373062693785;4932;5397.031632602132;5691.658500489983;5695.800646977419;5722.914156287576;2756.3935934094466;3007.1279328994783;3261.4834102142618;3269.7057264846276;3270.6565810590023;6175.69121543921;6215.316315205324;6365.204349456318;6407.679616019273;6416.582922110048;6080.209572755602;6310.9609849696235;6374.840628984312;6391;6405.871882562323;6126.785562505291;6243.875122497525;6282.528810339243;6293.898567750625;6296.905546416808;5337.9466205339;5411.567074634098;5570.888582228414;6192.2569291683485;6200.937990620036;5340.679559226459;5403.027455058127;5959.95700752358;6085.38737234642;6158.891399548124;5400.810971615974;5697.971510142423;6013.428724271187;6381.712822923072;6395.1454078316765;4182.853600123981;4182.853600123981;4183.853565125206;4198.6221240088535;4205.516365617993;5278.920816187837;5749.73505828717;6135.9079613806725;6245.00079987218;6257.806021002466;4997.5002499749735;5704.914426283526;5955.612885162451;5997.880042399215;6009.639421634541;5273.446288139843;5499.477549632778;5684.232628595087;5974.61165024272;6007.30915944672;5576.33084029919;5593.650666720068;5883.323417807007;5889.204957330706;5914.112883067574;5465.9726701366235;5996.520278377632;6015.157877897185;6034.849128771816;6050.2437195350585;4383.956160438483;4930.556249937523;5613.90528846871;5860.0113941890795;5899 00:56:39 INFO - PID 1980 | |5;yui.html;707.8371974445874;838.7106448275343;855.6620135046657;857.2584714222196;873.9563021848908;13375.26436046017;17761.733573996386;17960.191791369387;18470;18554.35059772908;17621.207045682942;17710.822891771077;18114.818851811477;18133.45599632013;18204.271829126817;959.3620242538703;997.0777031246068;999.535216124502;1000.1698590170141;1000.3297790480395;676.5331920974512;699.5452955578863;870.3863776037878;1034.415555211307;1045.1482042135674;1007.4761124215404;1049.8792638846553;1059.6873922192933;1059.9682009539727;1061.2200032975757;1037.543480868423;1038.9948050259775;1045.5765415006933;1046.6284469013506;1051.8527406163143;783.9925695481336;784.3254800871246;786.3394748411305;786.6342150899859;794.1026639896937;14161.929190353982;16603.584910377216;16827;17277.740833887503;17282.740758888627;14055.508057217949;16670.666586668198;17050.147492625318;17087.889287196416;17316.480505584852;12542.937285313606;12654.304013279267;12770.29763363024;12835.03737219703;12915.095943283974;3380.3746306933294;3407.9659203407896;3411.113110591264;3412.334594754024;3412.505186747908;106505;106890.46554767255;106983;107088;107112.99999999921;11355.432228388547;11970;12018.939905300418;12111.939440302918;12200.633980980585;19415.61168776645;19785.911774852233;20226.595468090556;20259.8987005067;25444.109456169317;7870.881936770953;8970.955145224232;8979.820403591892;8980.236679882284;8986.730398088068;4669.299605059268;4847.709137451764;4849.806007759721;4853.611711063107;4857.854264372004;3905.7461265017682;4249.575042495726;4364.454443194601;4367.519572846984;4368.890777730582;891.1890179936227;933.3746389918771;943.0428115462811;943.9433633981984;946.6875930942911;637.1971316141695;652.9738810447529;659;667.1893649216129;679.0696745458753;11272.380019099028;11740.354280514654;11938.701532461759;11991.880081199251;12207.145499815106;651.6513665189195;651.775137577535;653.6666300186939;666.466826538767;680.9897851532231;5391.460853914656;5418.972905135449;5485.177223416519;5710.65736055838;5731.512821410143;90444.6433303501;102457;107190;107536;107588;86585.25653156957;89542.65686014715;89778.55110724404;90963;91752.5412372934;78044;78375.21624783793;80376.37365384366;80411.59794200992;80851;9731.2492523625;10778.514966826355;11017.394043327373;11375.976162145447;12216.87783122193;39213.41179882247;39251;39782.40326395049;40136.59863401329;40507;67382;67986.66006669935;68870;69195.30804691889;69483;15881.205939703199;16017.519474415787;16059.518214453585;16148.838511614733;16188.757168642243;17509.649807004043;17586;17700.46898593044;18109.637807244046;18117.637647247244;16124.758128627846;16200;16323.938943968604;16347.836521635107;16511.83488165103;16073;16106.838931610533;16142.1928903552;16270.918645406697;16362.181890905646;15859;15926.442574509836;16023.198840058183;16036.358545658042;16179.191040448166;9029.819403612022;10118.79762404733;11443.542258309575;11767.352795596324;11984.340861252715;11596.188266821242;11750.059995200534;11974.101942354184;12346.506139754309;12533.122681412213 00:56:39 INFO - PID 1980 | __end_tp_report 00:56:39 INFO - PID 1980 | __start_cc_report 00:56:39 INFO - PID 1980 | _x_x_mozilla_cycle_collect,1596 00:56:39 INFO - PID 1980 | __end_cc_report 00:56:39 INFO - PID 1980 | __startTimestamp1491983799747__endTimestamp 00:56:39 INFO - PID 1980 | 00:56:39 INFO - PID 1980 | ------- Summary: start ------- 00:56:39 INFO - PID 1980 | Number of tests: 6 00:56:39 INFO - PID 1980 | 00:56:39 INFO - PID 1980 | [#0] dojo.html Cycles:165 Average:5916.76 Median:6251.69 stddev:697.14 (11.2%) stddev-sans-first:670.80 00:56:39 INFO - PID 1980 | Values: 3402.8 3411.7 3415.3 3424.2 3483.8 5086.3 5895.4 6062.9 6088.0 6104.2 6020.2 6020.5 6029.7 6050.1 6050.7 4792.3 5071.6 5266.3 5266.6 5327.8 5135.5 5283.6 5299.3 5343.0 5359.4 5243.6 5251.9 5262.0 5311.4 5358.8 4299.4 5215.0 5254.0 5264.6 5344.8 5238.4 5251.4 5272.3 5283.9 5286.6 5822.1 5844.5 5851.5 5982.1 6066.5 6375.0 6379.1 6389.0 6400.6 6413.9 5435.6 6495.3 6504.8 6511.9 6519.2 5978.5 6046.5 6111.9 6175.3 6180.1 6419.3 6491.1 6605.1 6627.6 6632.2 6347.7 6358.8 6369.3 6373.9 6380.0 6302.1 6388.9 6424.9 6442.1 6452.5 6323.5 6352.3 6354.8 6368.4 6376.2 6339.1 6393.5 6397.7 6402.2 6407.7 5127.7 5185.3 5207.3 5211.6 5257.9 4512.1 4586.3 4638.3 4640.4 4658.1 6013.8 6019.3 6033.6 6048.7 6058.6 6350.4 6351.3 6359.3 6370.1 6373.7 5221.9 5974.5 6001.2 6060.3 6062.9 5638.0 5638.3 5648.7 5650.2 5656.7 6454.0 6455.6 6457.9 6464.3 6468.7 6290.8 6390.1 6403.8 6492.9 6505.0 6612.7 6622.8 6623.7 6636.6 6642.4 6251.7 6299.6 6314.4 6328.1 6388.4 6325.4 6403.2 6436.7 6466.5 6466.7 4926.9 6271.9 6318.2 6351.5 6363.7 6198.0 6313.2 6322.0 6340.1 6350.7 6125.9 6179.8 6217.4 6283.0 6302.8 6284.2 6293.6 6337.5 6346.2 6355.7 6232.7 6254.4 6270.8 6295.4 6327.3 00:56:39 INFO - PID 1980 | 00:56:39 INFO - PID 1980 | [#1] ext.html Cycles:180 Average:46144.23 Median:177061.87 stddev:85230.30 (48.1%) stddev-sans-first:85401.26 00:56:39 INFO - PID 1980 | Values: 752.1 794.6 816.5 1074.6 1141.8 27384.7 27917.4 27927.7 27959.0 27979.9 28049.2 36553.0 36824.6 36888.0 36901.4 8447.7 8568.9 8594.7 8602.4 8604.4 5189.8 8532.7 8673.3 8675.5 8683.7 6202.6 8403.6 8595.7 8598.0 8628.1 8525.7 8592.0 8609.1 8610.4 8627.7 8386.9 8505.2 8506.0 8511.5 8516.6 25934.0 26327.2 36211.6 36596.0 36712.8 3516.3 3544.8 3558.2 3558.4 3560.4 24865.1 30475.5 30511.8 30529.0 30582.7 3100.4 3139.8 3153.8 3156.0 3162.9 271639.0 275747.0 276433.0 277044.0 277897.0 36147.6 47924.3 48092.8 48194.0 48317.3 50510.0 50548.2 50580.2 50629.7 50637.5 14070.7 14224.1 14233.9 14246.4 14251.8 11681.7 11682.8 11695.0 11696.6 11711.4 8695.6 11829.2 11971.2 12105.3 12146.9 3908.6 3928.1 5308.5 5621.5 5949.4 1014.4 1024.6 1027.9 1054.7 1058.2 21981.9 23518.0 24747.3 24806.0 24849.0 1097.2 1097.9 1113.1 1143.5 1148.6 12196.0 12319.0 12329.0 12336.4 12432.4 364065.0 365934.0 366049.9 366457.0 367010.0 54277.0 54547.0 54608.5 54806.5 54983.5 1482.5 1512.6 1537.8 1543.5 1555.9 21862.9 22019.2 23768.2 23847.6 23925.0 38054.0 38113.8 38146.8 38162.0 38242.0 321604.0 321872.0 321910.4 322207.0 323774.0 35234.3 35380.3 35518.8 35546.3 35637.6 36118.8 37126.4 44086.1 45212.0 45229.0 25412.7 26758.1 28184.4 30779.5 31096.2 29721.1 30476.7 31061.0 31291.5 31317.7 36192.5 37269.8 37341.4 37440.3 37650.4 30962.0 31179.1 31192.1 31756.0 32213.4 23898.2 23933.2 23992.5 24320.9 24402.4 00:56:39 INFO - PID 1980 | 00:56:39 INFO - PID 1980 | [#2] jquery.html Cycles:180 Average:39622.19 Median:27292.66 stddev:111747.25 (409.4%) stddev-sans-first:112021.93 00:56:39 INFO - PID 1980 | Values: 402.0 402.8 432.6 438.6 444.2 13277.9 20819.3 22238.1 22301.6 22547.4 22881.2 22985.1 23147.4 23252.0 23587.4 6115.4 6262.9 6336.6 6399.3 6455.0 3775.5 5792.7 6011.8 6219.7 6300.1 3940.7 5495.7 6090.5 6348.3 6388.7 6102.2 6215.7 6274.9 6368.7 6385.3 5591.9 5600.3 5601.4 5601.5 5605.4 27240.9 27344.5 28050.7 28253.0 28351.6 2238.6 2288.6 2289.6 2290.4 2291.6 15409.0 17107.3 18232.8 18330.9 18343.9 2114.7 2152.9 2160.0 2191.0 2194.4 149893.3 149936.0 151515.0 152495.0 154922.2 11296.4 11791.4 12368.9 12411.9 12442.6 15542.8 15550.1 15595.5 15602.6 16214.0 8874.9 8885.6 9029.1 9152.7 9171.7 8570.1 8584.7 8591.1 8746.5 8763.4 7666.2 7811.0 7832.3 7857.8 7884.2 1807.5 2136.8 2140.6 2160.8 2319.4 740.5 875.4 900.4 924.8 930.3 13901.2 17234.1 17797.9 18166.0 18263.5 876.7 915.7 924.7 928.0 946.2 8853.7 9066.0 9075.2 9162.9 9326.4 645276.0 655484.0 660696.0 674653.0 679477.3 153840.0 153928.0 154388.0 157036.0 157055.0 1134.6 1163.6 1191.2 1191.5 1193.8 16947.9 17079.8 17649.6 17833.2 18039.0 61963.7 62056.0 63021.1 63665.0 64394.4 88856.0 90098.5 90395.1 91107.1 91199.5 7439.7 8574.5 8639.0 8747.7 8875.9 13574.8 13848.0 13935.9 14095.8 14286.8 11513.3 11669.4 11937.7 11959.5 12071.8 10614.3 10735.5 10938.8 11095.3 11095.3 11763.4 11788.0 12106.2 12144.0 12157.7 8693.7 8730.2 8785.1 8949.3 9227.4 11197.0 11742.8 11778.6 12268.9 12310.3 00:56:39 INFO - PID 1980 | 00:56:39 INFO - PID 1980 | [#3] mootools.html Cycles:180 Average:7180.47 Median:2541.47 stddev:4537.70 (178.5%) stddev-sans-first:4527.49 00:56:39 INFO - PID 1980 | Values: 1109.5 1432.6 1458.9 1459.6 1468.5 9895.7 11488.6 11988.4 12063.7 12064.5 11537.6 11707.1 11932.5 11963.7 11992.2 2493.5 2539.6 2543.4 2544.5 2550.5 2294.8 2409.7 2467.5 2501.9 2530.6 2415.0 2515.5 2520.5 2521.6 2523.2 2453.5 2496.7 2497.5 2501.5 2527.0 2422.7 2447.5 2447.7 2455.6 2464.5 11814.6 11954.4 11957.9 11959.5 11989.3 6584.8 6838.0 6846.4 6849.1 6850.5 3389.4 4004.8 4045.8 4267.9 4396.5 1222.6 1230.2 1282.4 1286.0 1288.3 15093.6 15599.8 16599.1 16852.5 16862.6 5132.5 5648.9 5841.8 5846.2 5858.3 12324.5 12350.3 12367.6 12388.6 12398.0 6445.4 6611.1 6625.4 6632.2 6656.2 5993.2 6071.5 6143.5 6231.6 6256.1 4428.5 4432.0 4454.7 4505.3 4539.3 1272.4 1297.1 1299.0 1312.7 1315.0 772.1 781.9 797.9 801.3 803.5 6521.8 6629.5 7008.9 7041.0 7066.8 911.2 924.4 929.1 934.3 938.5 3351.4 3953.0 4061.3 4215.2 4288.8 14464.3 15404.8 15415.9 15435.8 15480.3 11408.3 12356.4 14858.3 15401.9 15428.0 10922.2 11128.5 11129.2 11151.0 11177.6 6616.9 6624.1 6780.3 6822.9 6874.1 13557.7 13910.9 13925.8 13997.5 14054.1 12698.3 12701.6 12864.6 13837.5 14407.6 8689.4 8973.5 8984.0 8988.4 8993.0 10722.0 10746.8 10762.0 10838.4 10865.6 8619.1 9238.7 9274.6 9283.0 9373.5 8402.7 9107.2 9154.4 9156.8 9221.3 8033.7 8199.1 8199.7 8200.9 8211.4 5114.6 5766.3 5786.2 5867.6 5986.9 5990.2 6101.7 6160.7 6203.9 6306.4 00:56:39 INFO - PID 1980 | 00:56:39 INFO - PID 1980 | [#4] prototype.html Cycles:180 Average:4854.92 Median:5571.58 stddev:1500.22 (26.9%) stddev-sans-first:1466.06 00:56:39 INFO - PID 1980 | Values: 363.4 373.7 388.8 407.3 415.8 4331.7 5759.3 5769.8 5897.6 5914.9 4342.5 4532.4 5553.8 5700.1 5755.5 3770.4 4063.2 4242.9 4261.8 4267.5 3610.6 4202.6 4292.4 4304.5 4308.8 4130.8 4238.6 4241.8 4243.9 4283.4 3570.3 3938.4 4213.0 4224.2 4251.4 3191.9 3267.5 3497.9 3715.6 3726.4 5572.3 5572.8 5581.3 5584.9 5598.0 4725.2 4967.2 5007.2 5047.4 5052.4 5513.8 5870.8 6071.2 6073.2 6084.2 4145.3 4156.4 4166.2 4170.0 4174.4 5047.2 6009.4 6353.1 6409.7 6423.8 3584.0 4199.4 4212.9 4225.0 4228.2 4267.1 4290.8 4295.2 4308.4 4501.2 3839.9 4912.0 4976.0 4988.8 5010.1 6061.4 6079.0 6084.2 6084.3 6088.8 1445.8 1463.4 1471.8 1474.3 1479.6 782.9 840.9 969.2 980.3 993.9 5680.9 5697.9 5713.9 5721.9 5728.3 5605.7 6117.9 6245.0 6247.8 6269.4 4932.0 5397.0 5691.7 5695.8 5722.9 2756.4 3007.1 3261.5 3269.7 3270.7 6175.7 6215.3 6365.2 6407.7 6416.6 6080.2 6311.0 6374.8 6391.0 6405.9 6126.8 6243.9 6282.5 6293.9 6296.9 5337.9 5411.6 5570.9 6192.3 6200.9 5340.7 5403.0 5960.0 6085.4 6158.9 5400.8 5698.0 6013.4 6381.7 6395.1 4182.9 4182.9 4183.9 4198.6 4205.5 5278.9 5749.7 6135.9 6245.0 6257.8 4997.5 5704.9 5955.6 5997.9 6009.6 5273.4 5499.5 5684.2 5974.6 6007.3 5576.3 5593.7 5883.3 5889.2 5914.1 5466.0 5996.5 6015.2 6034.8 6050.2 4384.0 4930.6 5613.9 5860.0 5899.0 00:56:39 INFO - PID 1980 | 00:56:39 INFO - PID 1980 | [#5] yui.html Cycles:180 Average:21225.58 Median:18116.23 stddev:29199.97 (161.2%) stddev-sans-first:29241.24 00:56:39 INFO - PID 1980 | Values: 707.8 838.7 855.7 857.3 874.0 13375.3 17761.7 17960.2 18470.0 18554.4 17621.2 17710.8 18114.8 18133.5 18204.3 959.4 997.1 999.5 1000.2 1000.3 676.5 699.5 870.4 1034.4 1045.1 1007.5 1049.9 1059.7 1060.0 1061.2 1037.5 1039.0 1045.6 1046.6 1051.9 784.0 784.3 786.3 786.6 794.1 14161.9 16603.6 16827.0 17277.7 17282.7 14055.5 16670.7 17050.1 17087.9 17316.5 12542.9 12654.3 12770.3 12835.0 12915.1 3380.4 3408.0 3411.1 3412.3 3412.5 106505.0 106890.5 106983.0 107088.0 107113.0 11355.4 11970.0 12018.9 12111.9 12200.6 19415.6 19785.9 20226.6 20259.9 25444.1 7870.9 8971.0 8979.8 8980.2 8986.7 4669.3 4847.7 4849.8 4853.6 4857.9 3905.7 4249.6 4364.5 4367.5 4368.9 891.2 933.4 943.0 943.9 946.7 637.2 653.0 659.0 667.2 679.1 11272.4 11740.4 11938.7 11991.9 12207.1 651.7 651.8 653.7 666.5 681.0 5391.5 5419.0 5485.2 5710.7 5731.5 90444.6 102457.0 107190.0 107536.0 107588.0 86585.3 89542.7 89778.6 90963.0 91752.5 78044.0 78375.2 80376.4 80411.6 80851.0 9731.2 10778.5 11017.4 11376.0 12216.9 39213.4 39251.0 39782.4 40136.6 40507.0 67382.0 67986.7 68870.0 69195.3 69483.0 15881.2 16017.5 16059.5 16148.8 16188.8 17509.6 17586.0 17700.5 18109.6 18117.6 16124.8 16200.0 16323.9 16347.8 16511.8 16073.0 16106.8 16142.2 16270.9 16362.2 15859.0 15926.4 16023.2 16036.4 16179.2 9029.8 10118.8 11443.5 11767.4 11984.3 11596.2 11750.1 11974.1 12346.5 12533.1 00:56:39 INFO - PID 1980 | -------- Summary: end -------- 00:56:39 INFO - PID 1980 | 00:56:40 INFO - TEST-INFO | 1980: exit 0 00:56:40 INFO - TEST-OK | dromaeo_css | took 1119909ms 00:56:40 INFO - TEST-START | kraken 00:56:40 INFO - operating with platform_type : mac_ 00:56:40 INFO - Initialising browser for kraken test... 00:56:40 INFO - TEST-INFO | started process 1983 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/tmpiq_YTY/profile http://localhost:49660/getInfo.html) 00:56:43 INFO - PID 1983 | __metrics Screen width/height:1600/1200 00:56:43 INFO - PID 1983 | colorDepth:24 00:56:43 INFO - PID 1983 | Browser inner width/height: 1024/689 00:56:43 INFO - PID 1983 | __metrics 00:56:43 INFO - PID 1983 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 00:56:43 INFO - PID 1983 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 304: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 00:56:44 INFO - TEST-INFO | 1983: exit 0 00:56:44 INFO - Browser initialized. 00:56:44 INFO - Running cycle 1/1 for kraken test... 00:56:44 INFO - TEST-INFO | started process 1984 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/tmpiq_YTY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:56:56 INFO - PID 1984 | RSS: Main: 231669760 00:56:56 INFO - PID 1984 | 00:56:59 INFO - PID 1984 | Cycle 1(1): loaded http://localhost:49660/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49660/tests/kraken/driver.html?testName=audio-beat-detection) 00:57:00 INFO - PID 1984 | RSS: Main: 292159488 00:57:00 INFO - PID 1984 | 00:57:03 INFO - PID 1984 | Cycle 1(1): loaded http://localhost:49660/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49660/tests/kraken/driver.html?testName=audio-dft) 00:57:03 INFO - PID 1984 | RSS: Main: 295776256 00:57:03 INFO - PID 1984 | 00:57:07 INFO - PID 1984 | Cycle 1(1): loaded http://localhost:49660/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49660/tests/kraken/driver.html?testName=audio-fft) 00:57:07 INFO - PID 1984 | RSS: Main: 388509696 00:57:07 INFO - PID 1984 | 00:57:10 INFO - PID 1984 | Cycle 1(1): loaded http://localhost:49660/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49660/tests/kraken/driver.html?testName=audio-oscillator) 00:57:10 INFO - PID 1984 | RSS: Main: 289841152 00:57:10 INFO - PID 1984 | 00:57:12 INFO - PID 1984 | Cycle 1(1): loaded http://localhost:49660/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49660/tests/kraken/driver.html?testName=imaging-gaussian-blur) 00:57:13 INFO - PID 1984 | RSS: Main: 293195776 00:57:13 INFO - PID 1984 | 00:57:16 INFO - PID 1984 | Cycle 1(1): loaded http://localhost:49660/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49660/tests/kraken/driver.html?testName=imaging-darkroom) 00:57:17 INFO - PID 1984 | RSS: Main: 335253504 00:57:17 INFO - PID 1984 | 00:57:20 INFO - PID 1984 | Cycle 1(1): loaded http://localhost:49660/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49660/tests/kraken/driver.html?testName=imaging-desaturate) 00:57:21 INFO - PID 1984 | RSS: Main: 349937664 00:57:21 INFO - PID 1984 | 00:57:24 INFO - PID 1984 | Cycle 1(1): loaded http://localhost:49660/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49660/tests/kraken/driver.html?testName=json-parse-financial) 00:57:24 INFO - PID 1984 | RSS: Main: 358047744 00:57:24 INFO - PID 1984 | 00:57:26 INFO - PID 1984 | Cycle 1(1): loaded http://localhost:49660/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49660/tests/kraken/driver.html?testName=json-stringify-tinderbox) 00:57:27 INFO - PID 1984 | RSS: Main: 309968896 00:57:27 INFO - PID 1984 | 00:57:29 INFO - PID 1984 | Cycle 1(1): loaded http://localhost:49660/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49660/tests/kraken/driver.html?testName=stanford-crypto-aes) 00:57:29 INFO - PID 1984 | RSS: Main: 313769984 00:57:29 INFO - PID 1984 | 00:57:31 INFO - PID 1984 | Cycle 1(1): loaded http://localhost:49660/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49660/tests/kraken/driver.html?testName=stanford-crypto-ccm) 00:57:32 INFO - PID 1984 | RSS: Main: 316272640 00:57:32 INFO - PID 1984 | 00:57:35 INFO - PID 1984 | Cycle 1(1): loaded http://localhost:49660/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49660/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 00:57:36 INFO - PID 1984 | RSS: Main: 333070336 00:57:36 INFO - PID 1984 | 00:57:40 INFO - PID 1984 | Cycle 1(1): loaded http://localhost:49660/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49660/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 00:57:40 INFO - PID 1984 | RSS: Main: 315908096 00:57:40 INFO - PID 1984 | 00:57:42 INFO - PID 1984 | Cycle 1(1): loaded http://localhost:49660/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49660/tests/kraken/driver.html?testName=ai-astar) 00:57:42 INFO - PID 1984 | RSS: Main: 381890560 00:57:42 INFO - PID 1984 | 00:57:42 INFO - PID 1984 | __start_tp_report 00:57:42 INFO - PID 1984 | _x_x_mozilla_page_load 00:57:42 INFO - PID 1984 | _x_x_mozilla_page_load_details 00:57:42 INFO - PID 1984 | |i|pagename|runs| 00:57:42 INFO - PID 1984 | |0;ai-astar;123;123;122;123;122;128;124;123;122;123 00:57:42 INFO - PID 1984 | |1;audio-beat-detection;162;121;118;166;122;119;114;119;147;119 00:57:42 INFO - PID 1984 | |2;audio-dft;210;216;213;209;208;210;219;222;220;212 00:57:42 INFO - PID 1984 | |3;audio-fft;87;66;63;102;68;65;68;72;112;64 00:57:42 INFO - PID 1984 | |4;audio-oscillator;95;77;94;76;75;74;92;73;75;91 00:57:42 INFO - PID 1984 | |5;imaging-gaussian-blur;90;92;90;105;137;91;92;91;91;92 00:57:42 INFO - PID 1984 | |6;imaging-darkroom;98;99;100;101;100;99;100;100;99;99 00:57:42 INFO - PID 1984 | |7;imaging-desaturate;143;163;111;106;102;100;102;101;101;102 00:57:42 INFO - PID 1984 | |8;json-parse-financial;54;50;51;50;51;52;52;52;53;51 00:57:42 INFO - PID 1984 | |9;json-stringify-tinderbox;57;69;64;70;66;64;67;65;65;65 00:57:42 INFO - PID 1984 | |10;stanford-crypto-aes;89;92;89;93;90;91;90;91;88;92 00:57:42 INFO - PID 1984 | |11;stanford-crypto-ccm;166;154;175;168;155;141;158;168;222;176 00:57:42 INFO - PID 1984 | |12;stanford-crypto-pbkdf2;200;199;206;202;224;199;259;261;224;253 00:57:42 INFO - PID 1984 | |13;stanford-crypto-sha256-iterative;74;75;71;71;72;75;71;73;74;72 00:57:42 INFO - PID 1984 | __end_tp_report 00:57:42 INFO - PID 1984 | __start_cc_report 00:57:42 INFO - PID 1984 | _x_x_mozilla_cycle_collect,2184 00:57:42 INFO - PID 1984 | __end_cc_report 00:57:42 INFO - PID 1984 | __startTimestamp1491983862822__endTimestamp 00:57:42 INFO - PID 1984 | 00:57:42 INFO - PID 1984 | ------- Summary: start ------- 00:57:42 INFO - PID 1984 | Number of tests: 14 00:57:42 INFO - PID 1984 | 00:57:42 INFO - PID 1984 | [#0] ai-astar Cycles:10 Average:123.30 Median:123.00 stddev:1.77 (1.4%) stddev-sans-first:1.87 00:57:42 INFO - PID 1984 | Values: 123.0 123.0 122.0 123.0 122.0 128.0 124.0 123.0 122.0 123.0 00:57:42 INFO - PID 1984 | 00:57:42 INFO - PID 1984 | [#1] audio-beat-detection Cycles:10 Average:130.70 Median:121.50 stddev:19.75 (16.3%) stddev-sans-first:17.41 00:57:42 INFO - PID 1984 | Values: 162.0 121.0 118.0 166.0 122.0 119.0 114.0 119.0 147.0 119.0 00:57:42 INFO - PID 1984 | 00:57:42 INFO - PID 1984 | [#2] audio-dft Cycles:10 Average:213.90 Median:214.50 stddev:5.02 (2.3%) stddev-sans-first:5.12 00:57:42 INFO - PID 1984 | Values: 210.0 216.0 213.0 209.0 208.0 210.0 219.0 222.0 220.0 212.0 00:57:42 INFO - PID 1984 | 00:57:42 INFO - PID 1984 | [#3] audio-fft Cycles:10 Average:76.70 Median:67.00 stddev:17.53 (26.2%) stddev-sans-first:18.19 00:57:42 INFO - PID 1984 | Values: 87.0 66.0 63.0 102.0 68.0 65.0 68.0 72.0 112.0 64.0 00:57:42 INFO - PID 1984 | 00:57:42 INFO - PID 1984 | [#4] audio-oscillator Cycles:10 Average:82.20 Median:84.00 stddev:9.41 (11.2%) stddev-sans-first:8.77 00:57:42 INFO - PID 1984 | Values: 95.0 77.0 94.0 76.0 75.0 74.0 92.0 73.0 75.0 91.0 00:57:42 INFO - PID 1984 | 00:57:42 INFO - PID 1984 | [#5] imaging-gaussian-blur Cycles:10 Average:97.10 Median:91.00 stddev:14.70 (16.2%) stddev-sans-first:15.37 00:57:42 INFO - PID 1984 | Values: 90.0 92.0 90.0 105.0 137.0 91.0 92.0 91.0 91.0 92.0 00:57:42 INFO - PID 1984 | 00:57:42 INFO - PID 1984 | [#6] imaging-darkroom Cycles:10 Average:99.50 Median:98.50 stddev:0.85 (0.9%) stddev-sans-first:0.71 00:57:42 INFO - PID 1984 | Values: 98.0 99.0 100.0 101.0 100.0 99.0 100.0 100.0 99.0 99.0 00:57:42 INFO - PID 1984 | 00:57:42 INFO - PID 1984 | [#7] imaging-desaturate Cycles:10 Average:113.10 Median:104.00 stddev:21.79 (21.0%) stddev-sans-first:20.25 00:57:42 INFO - PID 1984 | Values: 143.0 163.0 111.0 106.0 102.0 100.0 102.0 101.0 101.0 102.0 00:57:42 INFO - PID 1984 | 00:57:42 INFO - PID 1984 | [#8] json-parse-financial Cycles:10 Average:51.60 Median:52.00 stddev:1.26 (2.4%) stddev-sans-first:1.00 00:57:42 INFO - PID 1984 | Values: 54.0 50.0 51.0 50.0 51.0 52.0 52.0 52.0 53.0 51.0 00:57:42 INFO - PID 1984 | 00:57:42 INFO - PID 1984 | [#9] json-stringify-tinderbox Cycles:10 Average:65.20 Median:65.50 stddev:3.52 (5.4%) stddev-sans-first:2.15 00:57:42 INFO - PID 1984 | Values: 57.0 69.0 64.0 70.0 66.0 64.0 67.0 65.0 65.0 65.0 00:57:42 INFO - PID 1984 | 00:57:42 INFO - PID 1984 | [#10] stanford-crypto-aes Cycles:10 Average:90.50 Median:91.00 stddev:1.58 (1.7%) stddev-sans-first:1.58 00:57:42 INFO - PID 1984 | Values: 89.0 92.0 89.0 93.0 90.0 91.0 90.0 91.0 88.0 92.0 00:57:42 INFO - PID 1984 | 00:57:42 INFO - PID 1984 | [#11] stanford-crypto-ccm Cycles:10 Average:168.30 Median:168.00 stddev:21.67 (12.9%) stddev-sans-first:22.97 00:57:42 INFO - PID 1984 | Values: 166.0 154.0 175.0 168.0 155.0 141.0 158.0 168.0 222.0 176.0 00:57:42 INFO - PID 1984 | 00:57:42 INFO - PID 1984 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:222.70 Median:224.00 stddev:25.93 (11.6%) stddev-sans-first:26.17 00:57:42 INFO - PID 1984 | Values: 200.0 199.0 206.0 202.0 224.0 199.0 259.0 261.0 224.0 253.0 00:57:42 INFO - PID 1984 | 00:57:42 INFO - PID 1984 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.80 Median:73.50 stddev:1.62 (2.2%) stddev-sans-first:1.66 00:57:42 INFO - PID 1984 | Values: 74.0 75.0 71.0 71.0 72.0 75.0 71.0 73.0 74.0 72.0 00:57:42 INFO - PID 1984 | -------- Summary: end -------- 00:57:42 INFO - PID 1984 | 00:57:43 INFO - TEST-INFO | 1984: exit 0 00:57:43 INFO - TEST-OK | kraken | took 63469ms 00:57:43 INFO - SUITE-END | took 1183s 00:57:43 INFO - Completed test suite (00:19:43) 00:57:43 INFO - javascript benchmark 00:57:44 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7675.659877967056, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3402.8298585070747, 3411.692947634714, 3415.265717870657, 3424.2295483516205, 3483.8432270547823, 5086.262491938666, 5895.408239775258, 6062.878742425154, 6087.965045942195, 6104.206453161089, 6020.217371741678, 6020.488258498022, 6029.668368239745, 6050.062240352752, 6050.667213303266, 4792.329073929653, 5071.644984851053, 5266.34170728659, 5266.605004624649, 5327.813526526573, 5135.460776618457, 5283.63014588979, 5299.311089558352, 5343.0, 5359.38367087786, 5243.632945693803, 5251.947480525184, 5261.973690131525, 5311.362636483646, 5358.758855851496, 4299.441072660566, 5215.0, 5254.028004819121, 5264.631475796696, 5344.812931547416, 5238.449962753933, 5251.396089449724, 5272.340957380327, 5283.947160528384, 5286.550643195333, 5822.097574875901, 5844.503217226541, 5851.531877449836, 5982.132590774357, 6066.514678825683, 6375.043743438475, 6379.138816259839, 6389.0, 6400.583962042452, 6413.903791443132, 5435.592330575223, 6495.253045899687, 6504.837379065514, 6511.925532287167, 6519.217693876718, 5978.521718262528, 6046.455818976226, 6111.87776244477, 6175.2898416681755, 6180.134781130645, 6419.325970773001, 6491.058796474485, 6605.07528945948, 6627.635480048643, 6632.1709786276715, 6347.682615869188, 6358.841028974312, 6369.331220221903, 6373.936260637334, 6379.968100159563, 6302.054691796176, 6388.904166437507, 6424.935750642528, 6442.098106265126, 6452.483801295885, 6323.494120470351, 6352.301246862841, 6354.809355719243, 6368.363163683594, 6376.171097757262, 6339.144215530844, 6393.488520918316, 6397.744090236339, 6402.199725034371, 6407.679616019181, 5127.66670166438, 5185.274061631375, 5207.3230480037355, 5211.557017653542, 5257.947420525746, 4512.097580483916, 4586.312053192048, 4638.257878739386, 4640.396748422683, 4658.114958157939, 6013.819585412444, 6019.337872833985, 6033.607815491979, 6048.6975651218145, 6058.575899687068, 6350.396712312323, 6351.269603995507, 6359.268684101295, 6370.0763389308295, 6373.71318290678, 5221.947780522222, 5974.522038236931, 6001.159837622737, 6060.272767267956, 6062.939370606326, 5637.985162670759, 5638.2670252866865, 5648.74580643872, 5650.180723795027, 5656.745446454919, 6453.9677301612255, 6455.580387274812, 6457.903131453126, 6464.321246269168, 6468.708908099241, 6290.811275661737, 6390.073439351361, 6403.807885763435, 6492.870142597028, 6504.991726282434, 6612.735490580515, 6622.801315960529, 6623.701933413105, 6636.568623039487, 6642.368974947372, 6251.68741562911, 6299.559030867796, 6314.431701146918, 6328.050792381179, 6388.39310265524, 6325.367463253638, 6403.231612206565, 6436.67816609177, 6466.4503517201565, 6466.676666166579, 4926.852194434029, 6271.9053688067115, 6318.210223722035, 6351.523635727432, 6363.745450181941, 6198.0, 6313.210848643919, 6322.0, 6340.1440805490665, 6350.7459701611415, 6125.867432399968, 6179.783707570214, 6217.440430361289, 6283.02613094971, 6302.779402720883, 6284.214473190851, 6293.622382657055, 6337.493000559852, 6346.174997250328, 6355.713992870239, 6232.688365581794, 6254.437100660963, 6270.811875643738, 6295.370462953668, 6327.303996560467], "value": 5871.150370234938, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [752.1425574844678, 794.5947566740962, 816.5223344343559, 1074.5594306334403, 1141.8287256911458, 27384.726152738465, 27917.441651166966, 27927.720722792816, 27959.0, 27979.860100699494, 28049.158525244224, 36553.0, 36824.63175368246, 36888.0, 36901.44647830278, 8447.662093516252, 8568.914310856906, 8594.699185528507, 8602.35482338827, 8604.440711353773, 5189.792408303663, 8532.658693652247, 8673.349498787584, 8675.522846243453, 8683.652653893869, 6202.611994382173, 8403.621837017348, 8595.656173753074, 8597.957010214941, 8628.137186281385, 8525.744227673149, 8591.957040214822, 8609.139086091403, 8610.397272190949, 8627.65489380424, 8386.916130838674, 8505.19200675941, 8505.95747021261, 8511.489310641382, 8516.616752246164, 25934.0, 26327.21018369452, 36211.63788362109, 36596.0, 36712.81643591791, 3516.261585067139, 3544.805035723034, 3558.2349794794245, 3558.4128618777872, 3560.3769340365334, 24865.135114866458, 30475.542866857017, 30511.847440762653, 30529.0, 30582.694173058208, 3100.410921924827, 3139.827309497977, 3153.779235453519, 3155.984220078908, 3162.936741265185, 271639.0, 275747.0, 276433.0, 277044.0, 277897.0, 36147.55409783579, 47924.28113578299, 48092.759536202095, 48194.0, 48317.275240871415, 50510.0, 50548.24177637338, 50580.241296380584, 50629.74685126551, 50637.48087557379, 14070.71858562823, 14224.14655120696, 14233.92883035599, 14246.43014279438, 14251.78622320666, 11681.707957301136, 11682.824757628643, 11695.005924496512, 11696.649100526827, 11711.355875426932, 8695.565221738887, 11829.171957963032, 11971.221870578385, 12105.334206618545, 12146.939265303618, 3908.5700572936953, 3928.096537796323, 5308.46915308466, 5621.494065534122, 5949.375315591887, 1014.3508154780947, 1024.6055268721448, 1027.9280450368403, 1054.7099547624464, 1058.1851973979992, 21981.883608388136, 23518.0, 24747.305676441072, 24806.00775968941, 24849.0, 1097.1716354152563, 1097.8627671541058, 1113.1373185781085, 1143.519721716881, 1148.62095508482, 12196.0, 12319.014478841671, 12329.013678905667, 12336.383180840921, 12432.440540175714, 364065.0, 365934.0, 366049.92276119813, 366457.0, 367010.0, 54277.0, 54547.0, 54608.453915461134, 54806.45193548014, 54983.45016549863, 1482.495951376537, 1512.6445285357931, 1537.7923980262522, 1543.5446543269763, 1555.8839977630414, 21862.89068554647, 22019.22932697348, 23768.168114115924, 23847.642285365386, 23925.0, 38054.048648784, 38113.80943095378, 38146.809265953496, 38162.0, 38242.0, 321604.0, 321872.0, 321910.39044805564, 322207.0, 323774.0, 35234.29531409409, 35380.27774722794, 35518.75684351035, 35546.28907421889, 35637.64362356447, 36118.8194059028, 37126.44310335293, 44086.11827763363, 45212.0, 45229.0, 25412.74587254104, 26758.063467778535, 28184.43631127325, 30779.538306924966, 31096.22259443532, 29721.10836674903, 30476.695233047387, 31061.0, 31291.530627040156, 31317.74729010905, 36192.45711314385, 37269.81365093266, 37341.4398784013, 37440.251194975404, 37650.43524347192, 30962.0, 31179.064628061195, 31192.064238072893, 31756.0, 32213.355732884742, 23898.163564275168, 23933.16233931804, 23992.520149597258, 24320.87839560791, 24402.389940251636], "value": 17101.687739241042, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [401.97588144711335, 402.84691817109496, 432.5695932547116, 438.6249756458227, 444.218176010222, 13277.867221327784, 20819.27132550361, 22238.110475580957, 22301.553968920613, 22547.436314092156, 22881.19915802947, 22985.080596776108, 23147.421314467105, 23251.953662085205, 23587.410314742097, 6115.357887421824, 6262.906056409169, 6336.58812177207, 6399.296077431479, 6454.9677251613675, 3775.5469343678797, 5792.68140252286, 6011.789587364443, 6219.689015549227, 6300.149479820211, 3940.6847452203897, 5495.725213739317, 6090.451859332659, 6348.30168681447, 6388.744450221986, 6102.20671312731, 6215.658138802364, 6274.937250627481, 6368.681565921708, 6385.297617262097, 5591.916121258185, 5600.27196464457, 5601.383847776741, 5601.523870471015, 5605.439456054402, 27240.863795681093, 27344.45311093787, 28050.71949280522, 28253.0, 28351.57472637912, 2238.5746708125403, 2288.6338185890345, 2289.564982653307, 2290.3701482092392, 2291.598970180212, 15409.0, 17107.31570737169, 18232.817671823377, 18330.90834545832, 18343.89936603808, 2114.7039414481983, 2152.913883444676, 2160.0387827416807, 2191.0140436803504, 2194.440417693494, 149893.25907297785, 149936.0, 151515.0, 152495.0, 154922.22538887346, 11296.435178241056, 11791.410429478492, 12368.876311236772, 12411.937940310241, 12442.626721198378, 15542.844571554366, 15550.14474203907, 15595.532134035997, 15602.609934751723, 16214.0, 8874.86687699685, 8885.582502603702, 9029.051949545334, 9152.725418237464, 9171.724848254564, 8570.142985701379, 8584.65661373538, 8591.09793471689, 8746.518941458153, 8763.430377025474, 7666.233376662401, 7810.960945195237, 7832.300619628291, 7857.842843143219, 7884.2260491390125, 1807.4577626711934, 2136.7863213678506, 2140.571885622882, 2160.79472450117, 2319.4085508195303, 740.5223630758131, 875.4397185801092, 900.3967341880824, 924.847400178963, 930.3487558708931, 13901.235432051131, 17234.138293085547, 17797.911010444866, 18166.00086995228, 18263.45209643713, 876.6756300168978, 915.716128000322, 924.7225832250298, 927.9628814847465, 946.2099147212017, 8853.73438796837, 9065.954670226607, 9075.228605568469, 9162.908370916206, 9326.440413575072, 645276.0, 655484.0, 660696.0, 674653.0277577782, 679477.2575016745, 153840.0, 153928.0, 154388.0, 157036.0, 157055.0, 1134.5688638317552, 1163.5811108001112, 1191.1721353659298, 1191.541256616209, 1193.8149586814059, 16947.91526042362, 17079.829201707824, 17649.647007060044, 17833.197506111996, 18039.007854568124, 61963.6901815488, 62056.0, 63021.05468418069, 63665.0, 64394.35605644071, 88856.0, 90098.54950725204, 90395.0960490413, 91107.0889291125, 91199.54400227957, 7439.739609113655, 8574.485530868167, 8638.956805215934, 8747.737567872973, 8875.890513685788, 13574.796378054534, 13848.0, 13935.930320348334, 14095.788563171765, 14286.785698214328, 11513.251638643462, 11669.416529173337, 11937.701557461132, 11959.461824217757, 12071.75856482883, 10614.310069845744, 10735.516901739284, 10938.781224375309, 11095.278806877526, 11095.334279943228, 11763.411829408666, 11788.0, 12106.213096148722, 12144.0, 12157.696057598278, 8693.739187824121, 8730.214280714767, 8785.121487851164, 8949.284057275532, 9227.35408521397, 11197.0, 11742.765144697229, 11778.646640600795, 12268.877311226774, 12310.322932238812], "value": 10363.152980783421, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1109.4563663804736, 1432.5630682641797, 1458.883289336853, 1459.6350912271928, 1468.4640106361169, 9895.703128906145, 11488.597899073535, 11988.40057997101, 12063.698407539816, 12064.457099430525, 11537.596184133557, 11707.063434925207, 11932.522699092026, 11963.700907477318, 11992.220505667126, 2493.463905260369, 2539.5555777738914, 2543.3895864992455, 2544.4656622109287, 2550.4516528946274, 2294.8181686431503, 2409.6867407237037, 2467.469494058777, 2501.949961000779, 2530.6204069389646, 2414.9637755433596, 2515.4843257132334, 2520.5463016656995, 2521.596544552872, 2523.1673547729206, 2453.5092981403614, 2496.6754321938033, 2497.463045445229, 2501.5497210502103, 2527.0397249045336, 2422.685050943366, 2447.510497900409, 2447.669564608773, 2455.6316552517264, 2464.5440593490084, 11814.64556063311, 11954.402279886059, 11957.880421195763, 11959.461824217931, 11989.280643161439, 6584.8024559263295, 6837.965810170967, 6846.383825455683, 6849.075374824385, 6850.520463567552, 3389.440742277521, 4004.7797371144575, 4045.8064870862872, 4267.871963841089, 4396.472423309191, 1222.572099765084, 1230.2249582762893, 1282.3588205897051, 1286.0483242400555, 1288.2656885575225, 15093.622659433493, 15599.766003509843, 16599.087050212234, 16852.494425167264, 16862.578435539086, 5132.538071573576, 5648.8870222595315, 5841.766329346779, 5846.181534585162, 5858.297004359504, 12324.50701971911, 12350.320732359807, 12367.567135150226, 12388.62834114978, 12398.0, 6445.4199122079235, 6611.074449577063, 6625.370589793962, 6632.237292711304, 6656.201255849329, 5993.160957465958, 6071.483923866433, 6143.508519318533, 6231.594946328565, 6256.061590761422, 4428.535003824616, 4431.955680443219, 4454.710443821141, 4505.346724724896, 4539.251023581072, 1272.3701767625084, 1297.0725930959409, 1298.9870101299055, 1312.7308901675133, 1314.9934250328688, 772.058089131259, 781.8592653322343, 797.8803179523118, 801.3188789528854, 803.5098589860181, 6521.771737989147, 6629.502787290972, 7008.929910700827, 7041.0, 7066.787996360117, 911.2163539356148, 924.4407133684159, 929.1312622697799, 934.2619330728784, 938.474454305591, 3351.4470112431177, 3953.0, 4061.289274376972, 4215.156968606291, 4288.807003684841, 14464.27678616065, 15404.845951540341, 15415.92292038555, 15435.768463473058, 15480.303386347641, 11408.315501069963, 12356.443960021641, 14858.29129650104, 15401.922990384975, 15428.0, 10922.18083643714, 11128.499217535069, 11129.220954533266, 11151.0, 11177.552897883994, 6616.867662646817, 6624.091785846374, 6780.288069752605, 6822.931770682429, 6874.072000279898, 13557.661058473617, 13910.860891390956, 13925.79111313311, 13997.50062484379, 14054.086484378482, 12698.30159341245, 12701.618951431472, 12864.614061577793, 13837.515686950908, 14407.639809004439, 8689.391742577958, 8973.50645714492, 8984.0, 8988.415752976036, 8993.010768815295, 10722.0, 10746.785064298514, 10762.041087076823, 10838.403887786248, 10865.619703310662, 8619.138086191331, 9238.722838314861, 9274.582643781181, 9282.9535852323, 9373.484458354584, 8402.663893444194, 9107.180353768194, 9154.359194856295, 9156.816863662556, 9221.262299015929, 8033.6786528538205, 8199.057108432607, 8199.672013119647, 8200.876986845322, 8211.425200236165, 5114.616403769658, 5766.336871259691, 5786.247787787561, 5867.647941123546, 5986.9401305986385, 5990.231038925986, 6101.725422355916, 6160.691965401802, 6203.906941395973, 6306.369363063657], "value": 5417.68962344199, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [363.4439307858975, 373.65063665472786, 388.7783963141009, 407.2672368407982, 415.84405847807074, 4331.718438301512, 5759.308882934043, 5769.769209231631, 5897.646141231529, 5914.88170236595, 4342.522322544525, 4532.4334458192725, 5553.8333849984465, 5700.144978253254, 5755.510781583571, 3770.359038963369, 4063.167050754588, 4242.915141697172, 4261.8082186301535, 4267.460860787842, 3610.5667319921645, 4202.600752928467, 4292.441982542281, 4304.483461984566, 4308.80610372534, 4130.752154870717, 4238.5761423857675, 4241.809118589656, 4243.893902652428, 4283.400323954649, 3570.3394871948512, 3938.35017222158, 4212.978935105336, 4224.176285624305, 4251.404803327537, 3191.872325106993, 3267.509873518967, 3497.8775742849134, 3715.5727091384565, 3726.366517691999, 5572.275604171432, 5572.7770889164385, 5581.348859291804, 5584.888302233973, 5597.972010139923, 4725.243960966229, 4967.230079337708, 5007.198848184309, 5047.369078865142, 5052.433745538895, 5513.807016754395, 5870.823875283749, 6071.241094863142, 6073.240844894388, 6084.209052823105, 4145.253854306224, 4156.39978608235, 4166.208420400145, 4169.97915010426, 4174.436451079096, 5047.242913562958, 6009.444982477881, 6353.142325786052, 6409.711562979677, 6423.775167869149, 3583.9820800895827, 4199.391088292181, 4212.915741685149, 4224.978875105605, 4228.217779710763, 4267.103908179317, 4290.785460726951, 4295.205387003414, 4308.418363520947, 4501.15452664406, 3839.9232015359535, 4911.9754401227765, 4975.975120124376, 4988.775505102279, 5010.148274793221, 6061.424164704346, 6079.024317096962, 6084.209052823193, 6084.30030546484, 6088.756449742049, 1445.7975883376337, 1463.3707505772406, 1471.757160068598, 1474.2849717886816, 1479.6448852275591, 782.85517179322, 840.9453385529921, 969.1762002297991, 980.2843923935567, 993.8608594796734, 5680.914786278209, 5697.886042279131, 5713.942860571424, 5721.856953576111, 5728.255326807572, 5605.747741351649, 6117.898778219963, 6245.0, 6247.781327653601, 6269.373062693785, 4932.0, 5397.031632602132, 5691.658500489983, 5695.800646977419, 5722.914156287576, 2756.3935934094466, 3007.1279328994783, 3261.4834102142618, 3269.7057264846276, 3270.6565810590023, 6175.69121543921, 6215.316315205324, 6365.204349456318, 6407.679616019273, 6416.582922110048, 6080.209572755602, 6310.9609849696235, 6374.840628984312, 6391.0, 6405.871882562323, 6126.785562505291, 6243.875122497525, 6282.528810339243, 6293.898567750625, 6296.905546416808, 5337.9466205339, 5411.567074634098, 5570.888582228414, 6192.2569291683485, 6200.937990620036, 5340.679559226459, 5403.027455058127, 5959.95700752358, 6085.38737234642, 6158.891399548124, 5400.810971615974, 5697.971510142423, 6013.428724271187, 6381.712822923072, 6395.1454078316765, 4182.853600123981, 4182.853600123981, 4183.853565125206, 4198.6221240088535, 4205.516365617993, 5278.920816187837, 5749.73505828717, 6135.9079613806725, 6245.00079987218, 6257.806021002466, 4997.5002499749735, 5704.914426283526, 5955.612885162451, 5997.880042399215, 6009.639421634541, 5273.446288139843, 5499.477549632778, 5684.232628595087, 5974.61165024272, 6007.30915944672, 5576.33084029919, 5593.650666720068, 5883.323417807007, 5889.204957330706, 5914.112883067574, 5465.9726701366235, 5996.520278377632, 6015.157877897185, 6034.849128771816, 6050.2437195350585, 4383.956160438483, 4930.556249937523, 5613.90528846871, 5860.0113941890795, 5899.0], "value": 4394.675999401844, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [707.8371974445874, 838.7106448275343, 855.6620135046657, 857.2584714222196, 873.9563021848908, 13375.26436046017, 17761.733573996386, 17960.191791369387, 18470.0, 18554.35059772908, 17621.207045682942, 17710.822891771077, 18114.818851811477, 18133.45599632013, 18204.271829126817, 959.3620242538703, 997.0777031246068, 999.535216124502, 1000.1698590170141, 1000.3297790480395, 676.5331920974512, 699.5452955578863, 870.3863776037878, 1034.415555211307, 1045.1482042135674, 1007.4761124215404, 1049.8792638846553, 1059.6873922192933, 1059.9682009539727, 1061.2200032975757, 1037.543480868423, 1038.9948050259775, 1045.5765415006933, 1046.6284469013506, 1051.8527406163143, 783.9925695481336, 784.3254800871246, 786.3394748411305, 786.6342150899859, 794.1026639896937, 14161.929190353982, 16603.584910377216, 16827.0, 17277.740833887503, 17282.740758888627, 14055.508057217949, 16670.666586668198, 17050.147492625318, 17087.889287196416, 17316.480505584852, 12542.937285313606, 12654.304013279267, 12770.29763363024, 12835.03737219703, 12915.095943283974, 3380.3746306933294, 3407.9659203407896, 3411.113110591264, 3412.334594754024, 3412.505186747908, 106505.0, 106890.46554767255, 106983.0, 107088.0, 107112.99999999921, 11355.432228388547, 11970.0, 12018.939905300418, 12111.939440302918, 12200.633980980585, 19415.61168776645, 19785.911774852233, 20226.595468090556, 20259.8987005067, 25444.109456169317, 7870.881936770953, 8970.955145224232, 8979.820403591892, 8980.236679882284, 8986.730398088068, 4669.299605059268, 4847.709137451764, 4849.806007759721, 4853.611711063107, 4857.854264372004, 3905.7461265017682, 4249.575042495726, 4364.454443194601, 4367.519572846984, 4368.890777730582, 891.1890179936227, 933.3746389918771, 943.0428115462811, 943.9433633981984, 946.6875930942911, 637.1971316141695, 652.9738810447529, 659.0, 667.1893649216129, 679.0696745458753, 11272.380019099028, 11740.354280514654, 11938.701532461759, 11991.880081199251, 12207.145499815106, 651.6513665189195, 651.775137577535, 653.6666300186939, 666.466826538767, 680.9897851532231, 5391.460853914656, 5418.972905135449, 5485.177223416519, 5710.65736055838, 5731.512821410143, 90444.6433303501, 102457.0, 107190.0, 107536.0, 107588.0, 86585.25653156957, 89542.65686014715, 89778.55110724404, 90963.0, 91752.5412372934, 78044.0, 78375.21624783793, 80376.37365384366, 80411.59794200992, 80851.0, 9731.2492523625, 10778.514966826355, 11017.394043327373, 11375.976162145447, 12216.87783122193, 39213.41179882247, 39251.0, 39782.40326395049, 40136.59863401329, 40507.0, 67382.0, 67986.66006669935, 68870.0, 69195.30804691889, 69483.0, 15881.205939703199, 16017.519474415787, 16059.518214453585, 16148.838511614733, 16188.757168642243, 17509.649807004043, 17586.0, 17700.46898593044, 18109.637807244046, 18117.637647247244, 16124.758128627846, 16200.0, 16323.938943968604, 16347.836521635107, 16511.83488165103, 16073.0, 16106.838931610533, 16142.1928903552, 16270.918645406697, 16362.181890905646, 15859.0, 15926.442574509836, 16023.198840058183, 16036.358545658042, 16179.191040448166, 9029.819403612022, 10118.79762404733, 11443.542258309575, 11767.352795596324, 11984.340861252715, 11596.188266821242, 11750.059995200534, 11974.101942354184, 12346.506139754309, 12533.122681412213], "value": 8254.026966859372, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1607.6000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 123.0, 122.0, 123.0, 122.0, 128.0, 124.0, 123.0, 122.0, 123.0], "value": 123.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 121.0, 118.0, 166.0, 122.0, 119.0, 114.0, 119.0, 147.0, 119.0], "value": 130.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [210.0, 216.0, 213.0, 209.0, 208.0, 210.0, 219.0, 222.0, 220.0, 212.0], "value": 213.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 66.0, 63.0, 102.0, 68.0, 65.0, 68.0, 72.0, 112.0, 64.0], "value": 76.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 77.0, 94.0, 76.0, 75.0, 74.0, 92.0, 73.0, 75.0, 91.0], "value": 82.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 92.0, 90.0, 105.0, 137.0, 91.0, 92.0, 91.0, 91.0, 92.0], "value": 97.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 99.0, 100.0, 101.0, 100.0, 99.0, 100.0, 100.0, 99.0, 99.0], "value": 99.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 163.0, 111.0, 106.0, 102.0, 100.0, 102.0, 101.0, 101.0, 102.0], "value": 113.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 50.0, 51.0, 50.0, 51.0, 52.0, 52.0, 52.0, 53.0, 51.0], "value": 51.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 69.0, 64.0, 70.0, 66.0, 64.0, 67.0, 65.0, 65.0, 65.0], "value": 65.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 92.0, 89.0, 93.0, 90.0, 91.0, 90.0, 91.0, 88.0, 92.0], "value": 90.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 154.0, 175.0, 168.0, 155.0, 141.0, 158.0, 168.0, 222.0, 176.0], "value": 168.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [200.0, 199.0, 206.0, 202.0, 224.0, 199.0, 259.0, 261.0, 224.0, 253.0], "value": 222.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 71.0, 71.0, 72.0, 75.0, 71.0, 73.0, 74.0, 72.0], "value": 72.8, "unit": "score"}]}]} 00:57:44 INFO - Return code: 0 00:57:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 00:57:44 ERROR - # TBPL SUCCESS # 00:57:44 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 00:57:44 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 00:57:44 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 00:57:44 INFO - 2017-04-12 00:57:44.109 screenresolution[1988:16625] starting screenresolution argv=screenresolution get 00:57:44 INFO - 2017-04-12 00:57:44.112 screenresolution[1988:16625] Display 0: 1600x1200x32@60 00:57:44 INFO - 2017-04-12 00:57:44.118 screenresolution[1989:16628] starting screenresolution argv=screenresolution list 00:57:44 INFO - Available Modes on Display 0 00:57:44 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 00:57:44 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 00:57:44 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 00:57:44 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 00:57:44 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 00:57:44 INFO - Intel Iris: 00:57:44 INFO - Chipset Model: Intel Iris 00:57:44 INFO - Type: GPU 00:57:44 INFO - Bus: Built-In 00:57:44 INFO - VRAM (Dynamic, Max): 1536 MB 00:57:44 INFO - Vendor: Intel (0x8086) 00:57:44 INFO - Device ID: 0x0a2e 00:57:44 INFO - Revision ID: 0x0009 00:57:44 INFO - Displays: 00:57:44 INFO - Display: 00:57:44 INFO - Resolution: 1600 x 1200 @ 60 Hz 00:57:44 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 00:57:44 INFO - Display Serial Number: 1600x1200 60 00:57:44 INFO - Main Display: Yes 00:57:44 INFO - Mirror: Off 00:57:44 INFO - Online: Yes 00:57:44 INFO - Rotation: Supported 00:57:44 INFO - Return code: 0 00:57:44 INFO - Running post-action listener: _resource_record_post_action 00:57:44 INFO - [mozharness: 2017-04-12 07:57:44.372670Z] Finished run-tests step (success) 00:57:44 INFO - Running post-run listener: _resource_record_post_run 00:57:44 INFO - Total resource usage - Wall time: 1203s; CPU: 53.0%; Read bytes: 348160; Write bytes: 515003392; Read time: 7; Write time: 1671 00:57:44 INFO - TinderboxPrint: CPU usage
53.5% 00:57:44 INFO - TinderboxPrint: I/O read bytes / time
348,160 / 7 00:57:44 INFO - TinderboxPrint: I/O write bytes / time
515,003,392 / 1,671 00:57:44 INFO - TinderboxPrint: CPU idle
2,239.8 (46.5%) 00:57:44 INFO - TinderboxPrint: CPU system
959.2 (19.9%) 00:57:44 INFO - TinderboxPrint: CPU user
1,614.8 (33.5%) 00:57:44 INFO - TinderboxPrint: Swap in / out
208,138,240 / 0 00:57:44 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 198318592; Write bytes: 193046016; Read time: 14995; Write time: 368 00:57:44 INFO - run-tests - Wall time: 1184s; CPU: 53.0%; Read bytes: 348160; Write bytes: 305110528; Read time: 7; Write time: 1253 00:57:44 INFO - Running post-run listener: _upload_blobber_files 00:57:44 INFO - Blob upload gear active. 00:57:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 00:57:44 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 00:57:44 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', 'Pine', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 00:57:44 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 Pine -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 00:57:45 INFO - (blobuploader) - INFO - Open directory for files ... 00:57:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 00:57:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:57:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:57:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 00:57:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:57:46 INFO - (blobuploader) - INFO - Done attempting. 00:57:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 00:57:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:57:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:57:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 00:57:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:57:47 INFO - (blobuploader) - INFO - Done attempting. 00:57:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 00:57:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:57:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:57:48 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 00:57:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:57:48 INFO - (blobuploader) - INFO - Done attempting. 00:57:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 00:57:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:57:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:57:50 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 00:57:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:57:50 INFO - (blobuploader) - INFO - Done attempting. 00:57:50 INFO - (blobuploader) - INFO - Iteration through files over. 00:57:50 INFO - Return code: 0 00:57:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 00:57:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 00:57:50 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/91745113fa1a88965c2479ad354d9084c5d7ceac2ec3ff35045e77f47136ecd6f5123aca14d46b12bb987cd8531dd1f543ed9ef8628ed3529c4de82a6e9fed00", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/02c17d0f35c9ff64a58bf2c754a90d8d451800301a224a1b1c9a26e68fc8eee7391db7c5c7adad0e9fecfb1ff743c640be7e95ce0bf1a746264c5ecd89fdac9e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/b966b889529fc3423a3df19316cc79b13db694e8e17b56157fd18077009c197b8babcc44244ac0dac09778728475d7894cdcc1e8f67d7ed06ab17ecdbfe96d68", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/cfb5eecfd92db49aa56cb2c8a84510af412bf89b0ddab3aef363cb38135133c149c632536a892ddfc5228f374e04f7ab866c133265f65b119ac97bac286cd311"} 00:57:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 00:57:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 00:57:50 INFO - Contents: 00:57:50 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/91745113fa1a88965c2479ad354d9084c5d7ceac2ec3ff35045e77f47136ecd6f5123aca14d46b12bb987cd8531dd1f543ed9ef8628ed3529c4de82a6e9fed00", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/02c17d0f35c9ff64a58bf2c754a90d8d451800301a224a1b1c9a26e68fc8eee7391db7c5c7adad0e9fecfb1ff743c640be7e95ce0bf1a746264c5ecd89fdac9e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/b966b889529fc3423a3df19316cc79b13db694e8e17b56157fd18077009c197b8babcc44244ac0dac09778728475d7894cdcc1e8f67d7ed06ab17ecdbfe96d68", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/cfb5eecfd92db49aa56cb2c8a84510af412bf89b0ddab3aef363cb38135133c149c632536a892ddfc5228f374e04f7ab866c133265f65b119ac97bac286cd311"} 00:57:50 INFO - Running post-run listener: copy_logs_to_upload_dir 00:57:50 INFO - Copying logs to upload dir... 00:57:50 INFO - mkdir: /builds/slave/test/build/upload/logs 00:57:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1286.493839 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2017-04-12 00:57:50.147648) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-12 00:57:50.151299) ========= 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.hSLFcbxuqK/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.mGw6yviE3V/Listeners TMPDIR=/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/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/Pine/sha512/91745113fa1a88965c2479ad354d9084c5d7ceac2ec3ff35045e77f47136ecd6f5123aca14d46b12bb987cd8531dd1f543ed9ef8628ed3529c4de82a6e9fed00", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/02c17d0f35c9ff64a58bf2c754a90d8d451800301a224a1b1c9a26e68fc8eee7391db7c5c7adad0e9fecfb1ff743c640be7e95ce0bf1a746264c5ecd89fdac9e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/b966b889529fc3423a3df19316cc79b13db694e8e17b56157fd18077009c197b8babcc44244ac0dac09778728475d7894cdcc1e8f67d7ed06ab17ecdbfe96d68", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/cfb5eecfd92db49aa56cb2c8a84510af412bf89b0ddab3aef363cb38135133c149c632536a892ddfc5228f374e04f7ab866c133265f65b119ac97bac286cd311"} build_url:https://queue.taskcluster.net/v1/task/Ro9uj5nrR9y22GYTTTEaEw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011237 build_url: 'https://queue.taskcluster.net/v1/task/Ro9uj5nrR9y22GYTTTEaEw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/91745113fa1a88965c2479ad354d9084c5d7ceac2ec3ff35045e77f47136ecd6f5123aca14d46b12bb987cd8531dd1f543ed9ef8628ed3529c4de82a6e9fed00", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/02c17d0f35c9ff64a58bf2c754a90d8d451800301a224a1b1c9a26e68fc8eee7391db7c5c7adad0e9fecfb1ff743c640be7e95ce0bf1a746264c5ecd89fdac9e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/b966b889529fc3423a3df19316cc79b13db694e8e17b56157fd18077009c197b8babcc44244ac0dac09778728475d7894cdcc1e8f67d7ed06ab17ecdbfe96d68", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/cfb5eecfd92db49aa56cb2c8a84510af412bf89b0ddab3aef363cb38135133c149c632536a892ddfc5228f374e04f7ab866c133265f65b119ac97bac286cd311"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-12 00:57:50.184954) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-12 00:57:50.185291) ========= 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.hSLFcbxuqK/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.mGw6yviE3V/Listeners TMPDIR=/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/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.005192 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-12 00:57:50.233839) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-12 00:57:50.234167) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-12 00:57:50.234484) ========= ========= Total master_lag: 0.18 =========