builder: pine_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0024 starttime: 1491956001.45 results: success (0) buildid: 20170411150208 builduid: b6466c398afe47a8a77c7b4bb337bc4d revision: 32286c49912c0e68c22b57cc8ff85ee6470a90c1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-11 17:13:21.451806) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-11 17:13:21.452244) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-11 17:13:21.452534) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-11 17:13:21.493562) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-11 17:13:21.493950) ========= 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.OfOprDCk9d/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.qLbDYbCGBH/Listeners TMPDIR=/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/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-11 17:13:21-- 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% 20.7M=0.001s 2017-04-11 17:13:21 (20.7 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.352473 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-11 17:13:21.870292) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-11 17:13:21.870662) ========= 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.OfOprDCk9d/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.qLbDYbCGBH/Listeners TMPDIR=/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/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.021033 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-11 17:13:21.919337) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-11 17:13:21.919694) ========= bash -c 'python archiver_client.py mozharness --repo projects/pine --rev 32286c49912c0e68c22b57cc8ff85ee6470a90c1 --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 32286c49912c0e68c22b57cc8ff85ee6470a90c1 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.OfOprDCk9d/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.qLbDYbCGBH/Listeners TMPDIR=/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/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-11 17:13:22,005 truncating revision to first 12 chars 2017-04-11 17:13:22,005 Setting DEBUG logging. 2017-04-11 17:13:22,005 attempt 1/10 2017-04-11 17:13:22,005 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/pine/32286c49912c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-11 17:13:22,978 unpacking tar archive at: pine-32286c49912c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.229652 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-11 17:13:23.173145) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-11 17:13:23.173500) ========= script_repo_revision: 32286c49912c0e68c22b57cc8ff85ee6470a90c1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-11 17:13:23.173907) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-11 17:13:23.174181) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-11 17:13:23.194097) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2017-04-11 17:13:23.194521) ========= /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.OfOprDCk9d/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.qLbDYbCGBH/Listeners TMPDIR=/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/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 17:13:23 INFO - MultiFileLogger online at 20170411 17:13:23 in /builds/slave/test 17:13: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 17:13:23 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:13:23 INFO - {'append_to_log': False, 17:13:23 INFO - 'base_work_dir': '/builds/slave/test', 17:13:23 INFO - 'blob_upload_branch': 'Pine', 17:13:23 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:13:23 INFO - 'branch': 'Pine', 17:13:23 INFO - 'buildbot_json_path': 'buildprops.json', 17:13:23 INFO - 'config_files': ('talos/mac_config.py',), 17:13:23 INFO - 'default_actions': ('clobber', 17:13:23 INFO - 'read-buildbot-config', 17:13:23 INFO - 'download-and-extract', 17:13:23 INFO - 'populate-webroot', 17:13:23 INFO - 'create-virtualenv', 17:13:23 INFO - 'install', 17:13:23 INFO - 'run-tests'), 17:13:23 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:13:23 INFO - 'download_minidump_stackwalk': True, 17:13:23 INFO - 'download_symbols': 'ondemand', 17:13:23 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:13:23 INFO - 'tooltool.py': '/tools/tooltool.py', 17:13:23 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:13:23 INFO - '/tools/misc-python/virtualenv.py')}, 17:13:23 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:13:23 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:13:23 INFO - 'gecko_profile': False, 17:13:23 INFO - 'gecko_profile_interval': 0, 17:13:23 INFO - 'installer_path': 'installer.exe', 17:13:23 INFO - 'log_level': 'info', 17:13:23 INFO - 'log_name': 'talos', 17:13:23 INFO - 'log_to_console': True, 17:13:23 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 17:13:23 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 17:13:23 INFO - 'opt_config_files': (), 17:13:23 INFO - 'pip_index': False, 17:13:23 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:13:23 INFO - 'cmd': ('bash', 17:13:23 INFO - '-c', 17:13:23 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:13:23 INFO - 'enabled': True, 17:13:23 INFO - 'halt_on_failure': False, 17:13:23 INFO - 'name': 'check_screen_resolution'},), 17:13:23 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:13:23 INFO - 'cmd': ('bash', 17:13:23 INFO - '-c', 17:13:23 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:13:23 INFO - 'enabled': True, 17:13:23 INFO - 'halt_on_failure': False, 17:13:23 INFO - 'name': 'check_screen_resolution'},), 17:13:23 INFO - 'run_cmd_checks_enabled': True, 17:13:23 INFO - 'suite': 'dromaeojs', 17:13:23 INFO - 'system_bits': '32', 17:13:23 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:13:23 INFO - 'title': 't-yosemite-r7-0024', 17:13:23 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:13:23 INFO - 'use_talos_json': True, 17:13:23 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:13:23 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:13:23 INFO - 'work_dir': 'build'} 17:13:23 INFO - [mozharness: 2017-04-12 00:13:23.411610Z] Running clobber step. 17:13:23 INFO - Running pre-action listener: _resource_record_pre_action 17:13:23 INFO - Running main action method: clobber 17:13:23 INFO - rmtree: /builds/slave/test/build 17:13:23 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:13:25 INFO - Running post-action listener: _resource_record_post_action 17:13:25 INFO - [mozharness: 2017-04-12 00:13:25.285054Z] Finished clobber step (success) 17:13:25 INFO - [mozharness: 2017-04-12 00:13:25.285191Z] Running read-buildbot-config step. 17:13:25 INFO - Running pre-action listener: _resource_record_pre_action 17:13:25 INFO - Running main action method: read_buildbot_config 17:13:25 INFO - Using buildbot properties: 17:13:25 INFO - { 17:13:25 INFO - "project": "", 17:13:25 INFO - "product": "firefox", 17:13:25 INFO - "script_repo_revision": "default", 17:13:25 INFO - "builddir": "pine_yosemite_r7_test-dromaeojs", 17:13:25 INFO - "repository": "", 17:13:25 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 pine talos dromaeojs", 17:13:25 INFO - "buildid": "20170411150208", 17:13:25 INFO - "pgo_build": "False", 17:13:25 INFO - "basedir": "/builds/slave/test", 17:13:25 INFO - "buildnumber": 4, 17:13:25 INFO - "slavename": "t-yosemite-r7-0024", 17:13:25 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 17:13:25 INFO - "platform": "yosemite_r7", 17:13:25 INFO - "scheduler": "tests-pine-macosx64-talos", 17:13:25 INFO - "branch": "pine", 17:13:25 INFO - "repo_path": "projects/pine", 17:13:25 INFO - "revision": "32286c49912c0e68c22b57cc8ff85ee6470a90c1", 17:13:25 INFO - "stage_platform": "macosx64", 17:13:25 INFO - "builduid": "b6466c398afe47a8a77c7b4bb337bc4d", 17:13:25 INFO - "slavebuilddir": "test" 17:13:25 INFO - } 17:13:25 INFO - Found installer url https://queue.taskcluster.net/v1/task/Aem_OVofRHSs4hlCu-s-2A/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 17:13:25 INFO - Running post-action listener: _resource_record_post_action 17:13:25 INFO - [mozharness: 2017-04-12 00:13:25.288407Z] Finished read-buildbot-config step (success) 17:13:25 INFO - [mozharness: 2017-04-12 00:13:25.288540Z] Running download-and-extract step. 17:13:25 INFO - Running pre-action listener: _resource_record_pre_action 17:13:25 INFO - Running main action method: download_and_extract 17:13:25 INFO - mkdir: /builds/slave/test/build/tests 17:13: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')]} 17:13:25 INFO - trying https://queue.taskcluster.net/v1/task/Aem_OVofRHSs4hlCu-s-2A/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 17:13:25 INFO - Downloading https://queue.taskcluster.net/v1/task/Aem_OVofRHSs4hlCu-s-2A/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 17:13:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Aem_OVofRHSs4hlCu-s-2A/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 17:13:26 INFO - Downloaded 1325 bytes. 17:13:26 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 17:13:26 INFO - Using the following test package requirements: 17:13:26 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:13:26 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 17:13:26 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 17:13:26 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:13:26 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 17:13:26 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:13:26 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 17:13:26 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:13:26 INFO - u'jsshell-mac.zip'], 17:13:26 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:13:26 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 17:13:26 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 17:13:26 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:13:26 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 17:13:26 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:13:26 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 17:13:26 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:13:26 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 17:13:26 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:13:26 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 17:13:26 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 17:13:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Aem_OVofRHSs4hlCu-s-2A/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 17:13:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Aem_OVofRHSs4hlCu-s-2A/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 17:13:26 INFO - Fetch https://queue.taskcluster.net/v1/task/Aem_OVofRHSs4hlCu-s-2A/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 17:13:28 INFO - Expected file size: 52581535 17:13:28 INFO - Obtained file size: 52581535 17:13: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 17:13:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Aem_OVofRHSs4hlCu-s-2A/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 17:13:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Aem_OVofRHSs4hlCu-s-2A/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 17:13:44 INFO - Fetch https://queue.taskcluster.net/v1/task/Aem_OVofRHSs4hlCu-s-2A/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 17:13:46 INFO - Expected file size: 52581535 17:13:46 INFO - Obtained file size: 52581535 17:14:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Aem_OVofRHSs4hlCu-s-2A/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 17:14:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Aem_OVofRHSs4hlCu-s-2A/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 17:14:02 INFO - Fetch https://queue.taskcluster.net/v1/task/Aem_OVofRHSs4hlCu-s-2A/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 17:14:03 INFO - Expected file size: 14405596 17:14:03 INFO - Obtained file size: 14405596 17:14: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')]} 17:14:03 INFO - trying https://queue.taskcluster.net/v1/task/Aem_OVofRHSs4hlCu-s-2A/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 17:14:03 INFO - Downloading https://queue.taskcluster.net/v1/task/Aem_OVofRHSs4hlCu-s-2A/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 17:14:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Aem_OVofRHSs4hlCu-s-2A/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 17:14:05 INFO - Downloaded 71000911 bytes. 17:14:05 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Aem_OVofRHSs4hlCu-s-2A/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 17:14:05 INFO - mkdir: /builds/slave/test/properties 17:14:05 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:14:05 INFO - Writing to file /builds/slave/test/properties/build_url 17:14:05 INFO - Contents: 17:14:05 INFO - build_url:https://queue.taskcluster.net/v1/task/Aem_OVofRHSs4hlCu-s-2A/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 17:14:06 INFO - Running post-action listener: _resource_record_post_action 17:14:06 INFO - Running post-action listener: set_extra_try_arguments 17:14:06 INFO - [mozharness: 2017-04-12 00:14:06.653664Z] Finished download-and-extract step (success) 17:14:06 INFO - [mozharness: 2017-04-12 00:14:06.653759Z] Running populate-webroot step. 17:14:06 INFO - Running pre-action listener: _resource_record_pre_action 17:14:06 INFO - Running main action method: populate_webroot 17:14:06 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:14:06 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:14:06 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:14:06 INFO - '--tppagecycles', 17:14:06 INFO - '7'], 17:14:06 INFO - 'tests': ['tsvgm']}}, 17:14:06 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:14:06 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:14:06 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:14:06 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:14:06 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:14:06 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:14:06 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 17:14:06 INFO - 'talos_options': ['--disable-e10s'], 17:14:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:14:06 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 17:14:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:14:06 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 17:14:06 INFO - 'talos_options': ['--disable-e10s'], 17:14:06 INFO - 'tests': ['damp', 'tps']}, 17:14:06 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 17:14:06 INFO - 'tests': ['damp', 'tps']}, 17:14:06 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:14:06 INFO - 'tests': ['dromaeo_dom']}, 17:14:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:14:06 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:14:06 INFO - 'tests': ['basic_compositor_video']}, 17:14:06 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:14:06 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:14:06 INFO - 'tests': ['a11yr', 17:14:06 INFO - 'ts_paint', 17:14:06 INFO - 'tpaint', 17:14:06 INFO - 'sessionrestore', 17:14:06 INFO - 'sessionrestore_no_auto_restore', 17:14:06 INFO - 'tabpaint']}, 17:14:06 INFO - 'other-e10s': {'tests': ['a11yr', 17:14:06 INFO - 'ts_paint', 17:14:06 INFO - 'tpaint', 17:14:06 INFO - 'sessionrestore', 17:14:06 INFO - 'sessionrestore_no_auto_restore', 17:14:06 INFO - 'tabpaint']}, 17:14:06 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:14:06 INFO - 'ts_paint', 17:14:06 INFO - 'tpaint', 17:14:06 INFO - 'sessionrestore', 17:14:06 INFO - 'sessionrestore_no_auto_restore', 17:14:06 INFO - 'tabpaint']}, 17:14:06 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:14:06 INFO - 'ts_paint', 17:14:06 INFO - 'tpaint', 17:14:06 INFO - 'sessionrestore', 17:14:06 INFO - 'sessionrestore_no_auto_restore', 17:14:06 INFO - 'tabpaint']}, 17:14:06 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:14:06 INFO - 'tests': ['a11yr', 17:14:06 INFO - 'ts_paint', 17:14:06 INFO - 'tpaint', 17:14:06 INFO - 'sessionrestore', 17:14:06 INFO - 'sessionrestore_no_auto_restore', 17:14:06 INFO - 'tabpaint']}, 17:14:06 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:14:06 INFO - 'tests': ['a11yr', 17:14:06 INFO - 'ts_paint', 17:14:06 INFO - 'tpaint', 17:14:06 INFO - 'sessionrestore', 17:14:06 INFO - 'sessionrestore_no_auto_restore', 17:14:06 INFO - 'tabpaint']}, 17:14:06 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:14:06 INFO - 'tests': ['tsvgx', 17:14:06 INFO - 'tsvgr_opacity', 17:14:06 INFO - 'tart', 17:14:06 INFO - 'tscrollx', 17:14:06 INFO - 'cart', 17:14:06 INFO - 'tsvg_static']}, 17:14:06 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:14:06 INFO - 'tsvgr_opacity', 17:14:06 INFO - 'tart', 17:14:06 INFO - 'tscrollx', 17:14:06 INFO - 'cart', 17:14:06 INFO - 'tsvg_static']}, 17:14:06 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 17:14:06 INFO - 'talos_options': ['--disable-e10s'], 17:14:06 INFO - 'tests': ['tp5o']}, 17:14:06 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 17:14:06 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 17:14:06 INFO - 'talos_options': ['--disable-e10s', 17:14:06 INFO - '--xperf_path', 17:14:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:14:06 INFO - 'tests': ['tp5n']}, 17:14:06 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 17:14:06 INFO - 'talos_options': ['--xperf_path', 17:14:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:14:06 INFO - 'tests': ['tp5n']}}, 17:14:06 INFO - 'talos.zip': {'path': '', 17:14:06 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:14:06 INFO - Running post-action listener: _resource_record_post_action 17:14:06 INFO - [mozharness: 2017-04-12 00:14:06.671385Z] Finished populate-webroot step (success) 17:14:06 INFO - [mozharness: 2017-04-12 00:14:06.671499Z] Running create-virtualenv step. 17:14:06 INFO - Running pre-action listener: _resource_record_pre_action 17:14:06 INFO - Running main action method: create_virtualenv 17:14:06 INFO - Creating virtualenv /builds/slave/test/build/venv 17:14: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 17:14:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:14:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:14:06 INFO - Using real prefix '/tools/python27' 17:14:06 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:14:07 INFO - Installing distribute.............................................................................................................................................................................................done. 17:14:10 INFO - Installing pip.................done. 17:14:10 INFO - Return code: 0 17:14:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 17:14:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 17:14:10 INFO - Reading from file tmpfile_stdout 17:14:10 INFO - Output received: 17:14: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) 17:14:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:14: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')]} 17:14:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:14:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:14: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')]} 17:14:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:14:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:14: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 0x10717eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107181768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f952954f7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106f5cd30>, '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 0x106e83db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106f51be8>, '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.OfOprDCk9d/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.qLbDYbCGBH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/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 17:14: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 17:14: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 17:14:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OfOprDCk9d/Render', 17:14:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:14:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:14:10 INFO - 'HOME': '/Users/cltbld', 17:14:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:14:10 INFO - 'LOGNAME': 'cltbld', 17:14:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:14:10 INFO - 'MOZ_NO_REMOTE': '1', 17:14:10 INFO - 'NO_EM_RESTART': '1', 17:14:10 INFO - 'PAGER': '/bin/cat', 17:14:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:14:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:14:10 INFO - 'PWD': '/builds/slave/test', 17:14:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:14:10 INFO - 'SHELL': '/bin/bash', 17:14:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qLbDYbCGBH/Listeners', 17:14:10 INFO - 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/', 17:14:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:14:10 INFO - 'USER': 'cltbld', 17:14:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:14:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:14:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:14:10 INFO - 'XPC_FLAGS': '0x0', 17:14:10 INFO - 'XPC_SERVICE_NAME': '0', 17:14:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:14:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:14:11 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 17:14:11 INFO - Cleaning up... 17:14:11 INFO - Return code: 0 17:14:11 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:14:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:14:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:14:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:14:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:14:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:14:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:14:11 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 0x10717eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107181768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f952954f7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106f5cd30>, '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 0x106e83db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106f51be8>, '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.OfOprDCk9d/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.qLbDYbCGBH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/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 17:14:11 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 17:14:11 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 17:14:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OfOprDCk9d/Render', 17:14:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:14:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:14:11 INFO - 'HOME': '/Users/cltbld', 17:14:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:14:11 INFO - 'LOGNAME': 'cltbld', 17:14:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:14:11 INFO - 'MOZ_NO_REMOTE': '1', 17:14:11 INFO - 'NO_EM_RESTART': '1', 17:14:11 INFO - 'PAGER': '/bin/cat', 17:14:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:14:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:14:11 INFO - 'PWD': '/builds/slave/test', 17:14:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:14:11 INFO - 'SHELL': '/bin/bash', 17:14:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qLbDYbCGBH/Listeners', 17:14:11 INFO - 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/', 17:14:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:14:11 INFO - 'USER': 'cltbld', 17:14:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:14:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:14:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:14:11 INFO - 'XPC_FLAGS': '0x0', 17:14:11 INFO - 'XPC_SERVICE_NAME': '0', 17:14:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:14:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:14:11 INFO - Downloading/unpacking psutil>=3.1.1 17:14:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:14:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:14:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:14:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:14:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:14:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:14:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:14:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:14:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:14:14 INFO - Installing collected packages: psutil 17:14:14 INFO - Running setup.py install for psutil 17:14:14 INFO - building 'psutil._psutil_osx' extension 17:14: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 17:14:15 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 17:14:15 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 17:14: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 17:14:15 INFO - building 'psutil._psutil_posix' extension 17:14: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 17:14:15 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 17:14:15 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 17:14:15 INFO - ^ 17:14:15 INFO - 1 warning generated. 17:14: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 17:14:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:14:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:14:15 INFO - Successfully installed psutil 17:14:15 INFO - Cleaning up... 17:14:15 INFO - Return code: 0 17:14:15 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:14: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')]} 17:14:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:14:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:14: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')]} 17:14:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:14:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:14: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 0x10717eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107181768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f952954f7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106f5cd30>, '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 0x106e83db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106f51be8>, '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.OfOprDCk9d/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.qLbDYbCGBH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/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 17:14: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 17:14: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 17:14:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OfOprDCk9d/Render', 17:14:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:14:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:14:15 INFO - 'HOME': '/Users/cltbld', 17:14:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:14:15 INFO - 'LOGNAME': 'cltbld', 17:14:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:14:15 INFO - 'MOZ_NO_REMOTE': '1', 17:14:15 INFO - 'NO_EM_RESTART': '1', 17:14:15 INFO - 'PAGER': '/bin/cat', 17:14:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:14:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:14:15 INFO - 'PWD': '/builds/slave/test', 17:14:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:14:15 INFO - 'SHELL': '/bin/bash', 17:14:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qLbDYbCGBH/Listeners', 17:14:15 INFO - 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/', 17:14:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:14:15 INFO - 'USER': 'cltbld', 17:14:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:14:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:14:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:14:15 INFO - 'XPC_FLAGS': '0x0', 17:14:15 INFO - 'XPC_SERVICE_NAME': '0', 17:14:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:14:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:14:15 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:14: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 17:14: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 17:14: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 17:14: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 17:14: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 17:14: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 17:14:18 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:14:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:14:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:14:18 INFO - Installing collected packages: mozsystemmonitor 17:14:18 INFO - Running setup.py install for mozsystemmonitor 17:14:18 INFO - Successfully installed mozsystemmonitor 17:14:18 INFO - Cleaning up... 17:14:18 INFO - Return code: 0 17:14:18 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:14: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')]} 17:14:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:14:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:14: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')]} 17:14:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:14:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:14:19 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 0x10717eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107181768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f952954f7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106f5cd30>, '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 0x106e83db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106f51be8>, '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.OfOprDCk9d/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.qLbDYbCGBH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/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 17:14:19 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 17:14:19 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 17:14:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OfOprDCk9d/Render', 17:14:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:14:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:14:19 INFO - 'HOME': '/Users/cltbld', 17:14:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:14:19 INFO - 'LOGNAME': 'cltbld', 17:14:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:14:19 INFO - 'MOZ_NO_REMOTE': '1', 17:14:19 INFO - 'NO_EM_RESTART': '1', 17:14:19 INFO - 'PAGER': '/bin/cat', 17:14:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:14:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:14:19 INFO - 'PWD': '/builds/slave/test', 17:14:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:14:19 INFO - 'SHELL': '/bin/bash', 17:14:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qLbDYbCGBH/Listeners', 17:14:19 INFO - 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/', 17:14:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:14:19 INFO - 'USER': 'cltbld', 17:14:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:14:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:14:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:14:19 INFO - 'XPC_FLAGS': '0x0', 17:14:19 INFO - 'XPC_SERVICE_NAME': '0', 17:14:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:14:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:14:19 INFO - Downloading/unpacking jsonschema==2.5.1 17:14:19 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 17:14:19 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 17:14:19 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 17:14:19 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 17:14:19 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 17:14:19 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 17:14:22 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:14:22 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:14:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:14:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:14:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:14:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:14:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:14:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:14:23 INFO - Downloading functools32-3.2.3-2.tar.gz 17:14:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:14:23 INFO - warning: no files found matching '*.txt' 17:14:23 INFO - no previously-included directories found matching 'build' 17:14:23 INFO - no previously-included directories found matching 'dist' 17:14:23 INFO - no previously-included directories found matching '.git*' 17:14:23 INFO - Installing collected packages: jsonschema, functools32 17:14:23 INFO - Running setup.py install for functools32 17:14:23 INFO - warning: no files found matching '*.txt' 17:14:23 INFO - no previously-included directories found matching 'build' 17:14:23 INFO - no previously-included directories found matching 'dist' 17:14:23 INFO - no previously-included directories found matching '.git*' 17:14:23 INFO - Successfully installed jsonschema functools32 17:14:23 INFO - Cleaning up... 17:14:23 INFO - Return code: 0 17:14:23 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:14:23 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')]} 17:14:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:14:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:14:23 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')]} 17:14:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:14:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:14:23 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 0x10717eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107181768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f952954f7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106f5cd30>, '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 0x106e83db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106f51be8>, '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.OfOprDCk9d/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.qLbDYbCGBH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/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 17:14:23 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 17:14:23 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 17:14:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OfOprDCk9d/Render', 17:14:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:14:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:14:23 INFO - 'HOME': '/Users/cltbld', 17:14:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:14:23 INFO - 'LOGNAME': 'cltbld', 17:14:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:14:23 INFO - 'MOZ_NO_REMOTE': '1', 17:14:23 INFO - 'NO_EM_RESTART': '1', 17:14:23 INFO - 'PAGER': '/bin/cat', 17:14:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:14:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:14:23 INFO - 'PWD': '/builds/slave/test', 17:14:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:14:23 INFO - 'SHELL': '/bin/bash', 17:14:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qLbDYbCGBH/Listeners', 17:14:23 INFO - 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/', 17:14:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:14:23 INFO - 'USER': 'cltbld', 17:14:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:14:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:14:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:14:23 INFO - 'XPC_FLAGS': '0x0', 17:14:23 INFO - 'XPC_SERVICE_NAME': '0', 17:14:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:14:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:14:23 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:14:23 INFO - Cleaning up... 17:14:23 INFO - Return code: 0 17:14:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:14:23 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')]} 17:14:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:14:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:14:23 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')]} 17:14:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:14:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:14:23 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 0x10717eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107181768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f952954f7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106f5cd30>, '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 0x106e83db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106f51be8>, '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.OfOprDCk9d/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.qLbDYbCGBH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/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 17:14:23 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 17:14:23 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 17:14:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OfOprDCk9d/Render', 17:14:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:14:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:14:23 INFO - 'HOME': '/Users/cltbld', 17:14:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:14:23 INFO - 'LOGNAME': 'cltbld', 17:14:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:14:23 INFO - 'MOZ_NO_REMOTE': '1', 17:14:23 INFO - 'NO_EM_RESTART': '1', 17:14:23 INFO - 'PAGER': '/bin/cat', 17:14:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:14:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:14:23 INFO - 'PWD': '/builds/slave/test', 17:14:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:14:23 INFO - 'SHELL': '/bin/bash', 17:14:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qLbDYbCGBH/Listeners', 17:14:23 INFO - 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/', 17:14:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:14:23 INFO - 'USER': 'cltbld', 17:14:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:14:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:14:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:14:23 INFO - 'XPC_FLAGS': '0x0', 17:14:23 INFO - 'XPC_SERVICE_NAME': '0', 17:14:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:14:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:14:24 INFO - Downloading/unpacking blobuploader==1.2.4 17:14: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 17:14: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 17:14: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 17:14: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 17:14: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 17:14: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 17:14:26 INFO - Downloading blobuploader-1.2.4.tar.gz 17:14:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:14:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:14:26 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 17:14:26 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 17:14:26 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 17:14:26 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 17:14:26 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 17:14:26 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 17:14:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:14:27 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:14: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 17:14: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 17:14: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 17:14: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 17:14: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 17:14: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 17:14:27 INFO - Downloading docopt-0.6.1.tar.gz 17:14:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:14:28 INFO - Installing collected packages: blobuploader, requests, docopt 17:14:28 INFO - Running setup.py install for blobuploader 17:14:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:14:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:14:28 INFO - Running setup.py install for requests 17:14:28 INFO - Running setup.py install for docopt 17:14:28 INFO - Successfully installed blobuploader requests docopt 17:14:28 INFO - Cleaning up... 17:14:28 INFO - Return code: 0 17:14:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:14:28 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')]} 17:14:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:14:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:14:28 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')]} 17:14:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:14:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:14:28 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 0x10717eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107181768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f952954f7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106f5cd30>, '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 0x106e83db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106f51be8>, '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.OfOprDCk9d/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.qLbDYbCGBH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/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 17:14:28 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 17:14:28 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 17:14:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OfOprDCk9d/Render', 17:14:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:14:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:14:28 INFO - 'HOME': '/Users/cltbld', 17:14:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:14:28 INFO - 'LOGNAME': 'cltbld', 17:14:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:14:28 INFO - 'MOZ_NO_REMOTE': '1', 17:14:28 INFO - 'NO_EM_RESTART': '1', 17:14:28 INFO - 'PAGER': '/bin/cat', 17:14:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:14:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:14:28 INFO - 'PWD': '/builds/slave/test', 17:14:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:14:28 INFO - 'SHELL': '/bin/bash', 17:14:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qLbDYbCGBH/Listeners', 17:14:28 INFO - 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/', 17:14:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:14:28 INFO - 'USER': 'cltbld', 17:14:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:14:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:14:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:14:28 INFO - 'XPC_FLAGS': '0x0', 17:14:28 INFO - 'XPC_SERVICE_NAME': '0', 17:14:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:14:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:14:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:14:29 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-HfgFy5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:14:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:14:29 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-0WjMDh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:14:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:14:29 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-07uce_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:14:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:14:29 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-1VQtMQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:14:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:14:29 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-mspgRl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:14:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:14:29 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-TqaGJG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:14:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:14:29 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-zV8vrA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:14:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:14:29 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-Hs8rjx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:14:30 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-N7KuI6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:14:30 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-7aSaWk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:14:30 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-Hm5QnN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:14:30 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-cBqDxG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:14:30 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-1eKcpN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:14:30 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-tz8Raz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:14:30 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-tL272N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:14:30 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-zDpLXF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:14:30 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-oQlSXX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:14:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:14:30 INFO - Running setup.py install for manifestparser 17:14:31 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:14:31 INFO - Running setup.py install for mozcrash 17:14:31 INFO - Running setup.py install for mozdebug 17:14:31 INFO - Running setup.py install for mozdevice 17:14:31 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:14:31 INFO - Running setup.py install for mozfile 17:14:31 INFO - Running setup.py install for mozhttpd 17:14:31 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:14:31 INFO - Running setup.py install for mozinfo 17:14:31 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:14:31 INFO - Running setup.py install for mozInstall 17:14:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:14:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:14:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:14:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:14:32 INFO - Running setup.py install for mozleak 17:14:32 INFO - Running setup.py install for mozlog 17:14:32 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:14:32 INFO - Running setup.py install for moznetwork 17:14:32 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:14:32 INFO - Running setup.py install for mozprocess 17:14:32 INFO - Running setup.py install for mozprofile 17:14:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:14:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:14:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:14:32 INFO - Running setup.py install for mozrunner 17:14:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:14:33 INFO - Running setup.py install for mozscreenshot 17:14:33 INFO - Running setup.py install for moztest 17:14:33 INFO - Running setup.py install for mozversion 17:14:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:14:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:14:33 INFO - Cleaning up... 17:14:33 INFO - Return code: 0 17:14:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:14:33 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')]} 17:14:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:14:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:14:33 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')]} 17:14:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:14:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:14:33 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 0x10717eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107181768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f952954f7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106f5cd30>, '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 0x106e83db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106f51be8>, '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.OfOprDCk9d/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.qLbDYbCGBH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/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 17:14:33 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 17:14:33 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 17:14:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OfOprDCk9d/Render', 17:14:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:14:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:14:33 INFO - 'HOME': '/Users/cltbld', 17:14:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:14:33 INFO - 'LOGNAME': 'cltbld', 17:14:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:14:33 INFO - 'MOZ_NO_REMOTE': '1', 17:14:33 INFO - 'NO_EM_RESTART': '1', 17:14:33 INFO - 'PAGER': '/bin/cat', 17:14:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:14:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:14:33 INFO - 'PWD': '/builds/slave/test', 17:14:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:14:33 INFO - 'SHELL': '/bin/bash', 17:14:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qLbDYbCGBH/Listeners', 17:14:33 INFO - 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/', 17:14:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:14:33 INFO - 'USER': 'cltbld', 17:14:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:14:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:14:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:14:33 INFO - 'XPC_FLAGS': '0x0', 17:14:33 INFO - 'XPC_SERVICE_NAME': '0', 17:14:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:14:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:14:33 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-WwcmMj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:14:33 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)) 17:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:14:33 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-YtlL8o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:14: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)) 17:14:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:14:34 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-JY2Adf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:14: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)) 17:14:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:14:34 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-LhI5aZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:14: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)) 17:14:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:14:34 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-U1Knuf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:14: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)) 17:14:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:14:34 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-8UJ0Ja-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:14:34 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)) 17:14:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:14:34 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-BG9NZF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:14:34 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)) 17:14:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:14:34 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-Uc1gVy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:14:34 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)) 17:14:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:14:34 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-SAseyl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:14:34 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)) 17:14:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:14:34 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-VKPM2I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:14:34 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)) 17:14:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:14:34 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-fSnUxt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:14:34 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)) 17:14:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:14:34 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-5asAMd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:14: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)) 17:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:14:35 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-ecSvAC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:14: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)) 17:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:14:35 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-1zkdgI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:14: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)) 17:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:14:35 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-wrPv6R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:14:35 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)) 17:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:14:35 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-p9RvKH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:14:35 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)) 17:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:14:35 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-n9NP26-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:14:35 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)) 17:14:35 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)) 17:14:35 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)) 17:14:35 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)) 17:14:35 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)) 17:14:35 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)) 17:14:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:14:35 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 17:14:35 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 17:14:35 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 17:14:35 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 17:14:35 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 17:14:35 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 17:14:38 INFO - Downloading blessings-1.6.tar.gz 17:14:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:14:38 INFO - Installing collected packages: blessings 17:14:38 INFO - Running setup.py install for blessings 17:14:38 INFO - Successfully installed blessings 17:14:38 INFO - Cleaning up... 17:14:38 INFO - Return code: 0 17:14:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:14:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:14:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:14:38 INFO - Reading from file tmpfile_stdout 17:14:38 INFO - Current package versions: 17:14:38 INFO - blessings == 1.6 17:14:38 INFO - blobuploader == 1.2.4 17:14:38 INFO - docopt == 0.6.1 17:14:38 INFO - functools32 == 3.2.3-2 17:14:38 INFO - jsonschema == 2.5.1 17:14:38 INFO - manifestparser == 1.1 17:14:38 INFO - mozInstall == 1.12 17:14:38 INFO - mozcrash == 1.0 17:14:38 INFO - mozdebug == 0.1 17:14:38 INFO - mozdevice == 0.50 17:14:38 INFO - mozfile == 1.2 17:14:38 INFO - mozhttpd == 0.7 17:14:38 INFO - mozinfo == 0.9 17:14:38 INFO - mozleak == 0.1 17:14:38 INFO - mozlog == 3.4 17:14:38 INFO - moznetwork == 0.27 17:14:38 INFO - mozprocess == 0.25 17:14:38 INFO - mozprofile == 0.28 17:14:38 INFO - mozrunner == 6.13 17:14:38 INFO - mozscreenshot == 0.1 17:14:38 INFO - mozsystemmonitor == 0.3 17:14:38 INFO - moztest == 0.8 17:14:38 INFO - mozversion == 1.4 17:14:38 INFO - psutil == 3.1.1 17:14:38 INFO - requests == 1.2.3 17:14:38 INFO - wsgiref == 0.1.2 17:14:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:14:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:14:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:14:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:14:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:14:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:14:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:14:38 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 0x10717eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107181768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f952954f7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106f5cd30>, '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 0x106e83db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106f51be8>, '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.OfOprDCk9d/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.qLbDYbCGBH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/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 17:14:38 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 17:14:38 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 17:14:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OfOprDCk9d/Render', 17:14:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:14:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:14:38 INFO - 'HOME': '/Users/cltbld', 17:14:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:14:38 INFO - 'LOGNAME': 'cltbld', 17:14:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:14:38 INFO - 'MOZ_NO_REMOTE': '1', 17:14:38 INFO - 'NO_EM_RESTART': '1', 17:14:38 INFO - 'PAGER': '/bin/cat', 17:14:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:14:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:14:38 INFO - 'PWD': '/builds/slave/test', 17:14:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:14:38 INFO - 'SHELL': '/bin/bash', 17:14:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qLbDYbCGBH/Listeners', 17:14:38 INFO - 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/', 17:14:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:14:38 INFO - 'USER': 'cltbld', 17:14:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:14:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:14:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:14:38 INFO - 'XPC_FLAGS': '0x0', 17:14:38 INFO - 'XPC_SERVICE_NAME': '0', 17:14:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:14:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:14: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)) 17:14: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)) 17:14: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)) 17:14: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)) 17:14: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)) 17:14: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)) 17:14: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)) 17:14: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)) 17:14: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)) 17:14: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)) 17:14: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)) 17:14:39 INFO - Cleaning up... 17:14:39 INFO - Return code: 0 17:14:39 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:14: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')]} 17:14:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:14:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:14: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')]} 17:14:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:14:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:14: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 0x10717eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107181768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f952954f7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106f5cd30>, '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 0x106e83db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106f51be8>, '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.OfOprDCk9d/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.qLbDYbCGBH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/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 17:14: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 17:14: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 17:14:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OfOprDCk9d/Render', 17:14:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:14:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:14:39 INFO - 'HOME': '/Users/cltbld', 17:14:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:14:39 INFO - 'LOGNAME': 'cltbld', 17:14:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:14:39 INFO - 'MOZ_NO_REMOTE': '1', 17:14:39 INFO - 'NO_EM_RESTART': '1', 17:14:39 INFO - 'PAGER': '/bin/cat', 17:14:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:14:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:14:39 INFO - 'PWD': '/builds/slave/test', 17:14:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:14:39 INFO - 'SHELL': '/bin/bash', 17:14:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qLbDYbCGBH/Listeners', 17:14:39 INFO - 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/', 17:14:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:14:39 INFO - 'USER': 'cltbld', 17:14:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:14:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:14:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:14:39 INFO - 'XPC_FLAGS': '0x0', 17:14:39 INFO - 'XPC_SERVICE_NAME': '0', 17:14:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:14:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:14:39 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:14:39 INFO - Cleaning up... 17:14:39 INFO - Return code: 0 17:14:39 INFO - Running post-action listener: _resource_record_post_action 17:14:39 INFO - Running post-action listener: _start_resource_monitoring 17:14:39 INFO - Starting resource monitoring. 17:14:39 INFO - [mozharness: 2017-04-12 00:14:39.358580Z] Finished create-virtualenv step (success) 17:14:39 INFO - [mozharness: 2017-04-12 00:14:39.359513Z] Running install step. 17:14:39 INFO - Running pre-action listener: _resource_record_pre_action 17:14:39 INFO - Running main action method: install 17:14:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:14:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:14:39 INFO - Reading from file tmpfile_stdout 17:14:39 INFO - Detecting whether we're running mozinstall >=1.0... 17:14:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:14:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:14:39 INFO - Reading from file tmpfile_stdout 17:14:39 INFO - Output received: 17:14:39 INFO - Usage: mozinstall [options] installer 17:14:39 INFO - Options: 17:14:39 INFO - -h, --help show this help message and exit 17:14:39 INFO - -d DEST, --destination=DEST 17:14:39 INFO - Directory to install application into. [default: 17:14:39 INFO - "/builds/slave/test"] 17:14:39 INFO - --app=APP Application being installed. [default: firefox] 17:14:39 INFO - mkdir: /builds/slave/test/build/application 17:14:39 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'] 17:14:39 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 17:14:59 INFO - Reading from file tmpfile_stdout 17:14:59 INFO - Output received: 17:14:59 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 17:14:59 INFO - Running post-action listener: _resource_record_post_action 17:14:59 INFO - [mozharness: 2017-04-12 00:14:59.660917Z] Finished install step (success) 17:14:59 INFO - [mozharness: 2017-04-12 00:14:59.661086Z] Running run-tests step. 17:14:59 INFO - Running pre-action listener: _resource_record_pre_action 17:14:59 INFO - Running main action method: run_tests 17:14:59 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:14:59 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:14:59 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:14:59 INFO - 2017-04-11 17:14:59.673 screenresolution[2281:26322] starting screenresolution argv=screenresolution get 17:14:59 INFO - 2017-04-11 17:14:59.676 screenresolution[2281:26322] Display 0: 1600x1200x32@60 17:14:59 INFO - 2017-04-11 17:14:59.681 screenresolution[2282:26325] starting screenresolution argv=screenresolution list 17:14:59 INFO - Available Modes on Display 0 17:14:59 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:14:59 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:14:59 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:14:59 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:14:59 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:14:59 INFO - Intel Iris: 17:14:59 INFO - Chipset Model: Intel Iris 17:14:59 INFO - Type: GPU 17:14:59 INFO - Bus: Built-In 17:14:59 INFO - VRAM (Dynamic, Max): 1536 MB 17:14:59 INFO - Vendor: Intel (0x8086) 17:14:59 INFO - Device ID: 0x0a2e 17:14:59 INFO - Revision ID: 0x0009 17:14:59 INFO - Displays: 17:14:59 INFO - Display: 17:14:59 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:14:59 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:14:59 INFO - Display Serial Number: 1600x1200 60 17:14:59 INFO - Main Display: Yes 17:14:59 INFO - Mirror: Off 17:14:59 INFO - Online: Yes 17:14:59 INFO - Rotation: Supported 17:14:59 INFO - Return code: 0 17:14:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:14:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:14:59 INFO - Python 2.7.3 17:14:59 INFO - Return code: 0 17:14:59 INFO - grabbing minidump binary from tooltool 17:14:59 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')]} 17:14:59 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 0x106f5cd30>, '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 0x106e83db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106f51be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:14:59 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 17:14:59 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 17:14:59 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 17:14:59 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:15:00 INFO - Return code: 0 17:15:00 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 17:15:00 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:15:00 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:15:00 INFO - ENV: RUST_BACKTRACE is now 1 17:15:00 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 17:15:00 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:15: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/Aem_OVofRHSs4hlCu-s-2A/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0024', '--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 17:15: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/Aem_OVofRHSs4hlCu-s-2A/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0024 --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 17:15:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OfOprDCk9d/Render', 17:15:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:15:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:15:00 INFO - 'HOME': '/Users/cltbld', 17:15:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:15:00 INFO - 'LOGNAME': 'cltbld', 17:15:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:15:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 17:15:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:15:00 INFO - 'MOZ_NO_REMOTE': '1', 17:15:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:15:00 INFO - 'NO_EM_RESTART': '1', 17:15:00 INFO - 'PAGER': '/bin/cat', 17:15:00 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:15:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:15:00 INFO - 'PWD': '/builds/slave/test', 17:15:00 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:15:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:15:00 INFO - 'RUST_BACKTRACE': '1', 17:15:00 INFO - 'SHELL': '/bin/bash', 17:15:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qLbDYbCGBH/Listeners', 17:15:00 INFO - 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/', 17:15:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:15:00 INFO - 'USER': 'cltbld', 17:15:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:15:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:15:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:15:00 INFO - 'XPC_FLAGS': '0x0', 17:15:00 INFO - 'XPC_SERVICE_NAME': '0', 17:15:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:15: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/Aem_OVofRHSs4hlCu-s-2A/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0024', '--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 17:15:00 INFO - mozversion application_buildid: 20170411150208 17:15:00 INFO - mozversion application_changeset: 32286c49912c0e68c22b57cc8ff85ee6470a90c1 17:15:00 INFO - mozversion application_display_name: Nightly 17:15:00 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:15:00 INFO - mozversion application_name: Firefox 17:15:00 INFO - mozversion application_remotingname: firefox 17:15:00 INFO - mozversion application_repository: https://hg.mozilla.org/projects/pine 17:15:00 INFO - mozversion application_vendor: Mozilla 17:15:00 INFO - mozversion application_version: 55.0a1 17:15:00 INFO - mozversion platform_buildid: 20170411150208 17:15:00 INFO - mozversion platform_changeset: 32286c49912c0e68c22b57cc8ff85ee6470a90c1 17:15:00 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/pine 17:15:00 INFO - mozversion platform_version: 55.0a1 17:15:00 INFO - using testdate: 1491956100 17:15:00 INFO - actual date: 1491956100 17:15:00 INFO - starting webserver on 'localhost:56225' 17:15:00 INFO - SUITE-START | Running 2 tests 17:15:00 INFO - TEST-START | dromaeo_css 17:15:00 INFO - operating with platform_type : mac_ 17:15:00 INFO - Initialising browser for dromaeo_css test... 17:15:00 INFO - TEST-INFO | started process 2292 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/tmpbJLjDM/profile http://localhost:56225/getInfo.html) 17:15:03 INFO - PID 2292 | __metrics Screen width/height:1600/1200 17:15:03 INFO - PID 2292 | colorDepth:24 17:15:03 INFO - PID 2292 | Browser inner width/height: 1024/689 17:15:03 INFO - PID 2292 | __metrics 17:15:03 INFO - PID 2292 | 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" 17:15:03 INFO - PID 2292 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 304: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:15:04 INFO - TEST-INFO | 2292: exit 0 17:15:04 INFO - Browser initialized. 17:15:04 INFO - Running cycle 1/1 for dromaeo_css test... 17:15:04 INFO - TEST-INFO | started process 2294 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/tmpbJLjDM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:15:16 INFO - PID 2294 | RSS: Main: 240197632 17:15:16 INFO - PID 2294 | 17:18:21 INFO - PID 2294 | Cycle 1(1): loaded http://localhost:56225/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56225/tests/dromaeo/cssquery-ext.html) 17:18:23 INFO - PID 2294 | RSS: Main: 445915136 17:18:23 INFO - PID 2294 | 17:20:06 INFO - PID 2294 | ************************* 17:20:06 INFO - PID 2294 | A coding exception was thrown and uncaught in a Task. 17:20:06 INFO - PID 2294 | 17:20:06 ERROR - PID 2294 | Full message: TypeError: NetworkError when attempting to fetch resource. 17:20:06 INFO - PID 2294 | Full stack: 17:20:06 INFO - PID 2294 | ************************* 17:20:06 INFO - PID 2294 | ************************* 17:20:06 INFO - PID 2294 | A coding exception was thrown and uncaught in a Task. 17:20:06 INFO - PID 2294 | 17:20:06 ERROR - PID 2294 | Full message: TypeError: NetworkError when attempting to fetch resource. 17:20:06 INFO - PID 2294 | Full stack: 17:20:06 INFO - PID 2294 | ************************* 17:20:06 INFO - PID 2294 | ************************* 17:20:06 INFO - PID 2294 | A coding exception was thrown and uncaught in a Task. 17:20:06 INFO - PID 2294 | 17:20:06 ERROR - PID 2294 | Full message: TypeError: NetworkError when attempting to fetch resource. 17:20:06 INFO - PID 2294 | Full stack: 17:20:06 INFO - PID 2294 | ************************* 17:20:06 INFO - PID 2294 | ************************* 17:20:06 INFO - PID 2294 | A coding exception was thrown and uncaught in a Task. 17:20:06 INFO - PID 2294 | 17:20:06 ERROR - PID 2294 | Full message: TypeError: NetworkError when attempting to fetch resource. 17:20:06 INFO - PID 2294 | Full stack: 17:20:06 INFO - PID 2294 | ************************* 17:21:26 INFO - PID 2294 | Cycle 1(1): loaded http://localhost:56225/tests/dromaeo/cssquery-ext.html (next: http://localhost:56225/tests/dromaeo/cssquery-jquery.html) 17:21:27 INFO - PID 2294 | RSS: Main: 370790400 17:21:27 INFO - PID 2294 | 17:24:29 INFO - PID 2294 | Cycle 1(1): loaded http://localhost:56225/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56225/tests/dromaeo/cssquery-mootools.html) 17:24:30 INFO - PID 2294 | RSS: Main: 359268352 17:24:30 INFO - PID 2294 | 17:27:32 INFO - PID 2294 | Cycle 1(1): loaded http://localhost:56225/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56225/tests/dromaeo/cssquery-prototype.html) 17:27:32 INFO - PID 2294 | RSS: Main: 337649664 17:27:32 INFO - PID 2294 | 17:30:36 INFO - PID 2294 | Cycle 1(1): loaded http://localhost:56225/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56225/tests/dromaeo/cssquery-yui.html) 17:30:37 INFO - PID 2294 | RSS: Main: 341983232 17:30:37 INFO - PID 2294 | 17:33:39 INFO - PID 2294 | Cycle 1(1): loaded http://localhost:56225/tests/dromaeo/cssquery-yui.html (next: http://localhost:56225/tests/dromaeo/cssquery-dojo.html) 17:33:39 INFO - PID 2294 | RSS: Main: 379514880 17:33:39 INFO - PID 2294 | 17:33:39 INFO - PID 2294 | __start_tp_report 17:33:39 INFO - PID 2294 | _x_x_mozilla_page_load 17:33:39 INFO - PID 2294 | _x_x_mozilla_page_load_details 17:33:39 INFO - PID 2294 | |i|pagename|runs| 17:33:39 INFO - PID 2294 | |0;dojo.html;3256.07201947445;3448.8620455181795;3458.8443520041596;3509.84205710743;3522.524459198009;6021.2473440819895;6110.649890384128;6182.2581290245125;6199.659018753967;6222.439980401763;6130.948521380013;6133.969330153354;6175.938240617581;6188.195534580498;6191.659458729768;4858.344123543329;5156.355455568054;5279.102552566053;5317.521423071923;5431.103867861818;5391.191321301797;5429.185622156669;5434.212039254306;5435.157550579646;5454.181872719084;5223.138182199951;5285.920711189336;5296.814611488579;5314.202869569557;5320.228566857822;5276.815311464119;5301.761420736076;5306.734663266821;5312.070387682179;5319.2287118368;5225.947740522584;5280.155175171993;5283.1546952487415;5290.68255904647;5301.125314323171;6086.573939824214;6112.235970503687;6114.755409783604;6115.48018418435;6122.448979591813;6346.11154438379;6349.968250158766;6360.141380913564;6371.745130194787;6411.679416029227;6522.706478208444;6554.705038273241;6567.507436942248;6616.007598860161;6637.701303441357;5405.891882162374;6261.217347831521;6263;6277.05844123376;6282.465990390822;6476.643784591798;6571.080048793173;6730.259671436138;6745.291744366869;6756.594604323756;6323.083152942798;6353.174087368612;6378.968105159444;6390.392912673288;6402.743890244431;6515.250746164157;6538.738450461929;6548.116004339448;6551.508636852255;6562.540622156499;5655.604107712421;6448.903266451007;6454.290028096905;6463.418292353711;6480.060391243243;6259.217597800275;6307.558470906993;6320.747170113144;6369.872602547923;6401.423871851555;5238.371395432572;5239.345081864767;5248.790048398021;5249.658772179872;5284.5772338212855;4661.557152070548;4671.532846715301;4675.275332323496;4677;4712.269598212282;6068.696565171724;6083.574149809471;6108.311716707923;6183.783567575113;6224.813255602339;6372.936270637234;6508.707108180143;6543.1821022372205;6546.3453654635105;6574.737010519621;6187.752489900354;6190.2571691397325;6196.938030619636;6198.194234749544;6210.627362358273;5744.626599271034;5779.162021506942;5783.392743761844;5793.916735440597;5807.390224026416;6435.452986496013;6527;6531;6533.216014078341;6541.738330466918;6408.967955160381;6427.132337134427;6437.485001199799;6446.226452825504;6490.48076153916;6509.446697030806;6550.8362290943105;6562.5406221564035;6563.146790917151;6566.9343306566325;6337.144485494584;6341.239051313872;6343;6353.174087368612;6392.616443013248;6337.746490140527;6398.104265402941;6419.646919419477;6434.163558737334;6444.3233460487845;6289.371062893857;6328.398802113792;6337.7781777637565;6339.587926784744;6361.554691171574;6294.087357333069;6359.554831161774;6366.331535188924;6376.52176086786;6392.296847346695;4882.6826256293225;5961.791337303173;6137.693115344304;6264.060390941395;6270;6178.227721534809;6253.78111766086;6262.405071518198;6274.686265686789;6291.339409361951;6192.0711893214575;6219.191505104308;6224.221972253468;6228.4705800007505;6231.22109736283 17:33:39 INFO - PID 2294 | |1;ext.html;737.325347307214;804.7022601637395;1131.5982826096736;1155.6244220628294;1158.8435561199235;35871.82064089679;36523.452148217766;36617.45073823895;36645.816770916106;36890.26219475612;38572.61427385725;38908.61091389085;38929.805350973205;38980.61019389805;39004.60995390045;6107.267127944653;6250.343713910042;8440.662373505067;8578.227959483645;8607.6126574304;8288.502689838599;8442.704505342313;8443.324534037261;8465.111163327854;8467.153284671545;8435.451695639795;8522.57387130644;8523.914760852374;8530.530820804854;8533.95733021334;8445.451045682012;8491.150884911522;8503;8504.192101750325;8519.616617252239;8374.706885258987;8441.451305665174;8456.746297611082;8466.576671166416;8468.110848360957;36608.267834643426;36777.448338274946;36801.81599091987;36835.71075012362;36885.631143688486;3547.7161827053774;3580.5524309461316;3585.480105384731;3589.4436362363876;3592.335417947662;30041.69958300411;30061.947831826;30120.54819177714;30132.69867301321;30138.24654383636;3098.488749356376;3129.4836352001894;3147.937041259162;3150.1022208670647;3162.8892988745283;249876;283936;284599.9999999979;284851;286026;38050.85847424582;38863;45560.54439455563;48209.758951205724;48244.517554824706;48138.75930620325;48350.27474587884;48366.516334836204;48454.304099356355;48468.7576562122;11692.532298707956;13720.382582783799;13844.723105538034;13898.818600419077;13913.30433478322;9863.901360986441;9887.653932112342;11255.099592032619;11275.267107638141;11371.943140284246;11719.296842189497;11758.00056995165;11894.16740828151;11909.987651049585;11924.10569207313;4758.0508178212;5208.8437346879655;5237.109691352479;5266.815661451831;5289.603279754034;964.238251781099;1028.1158203944601;1050.0864248104199;1051.9076339994774;1079.082779637302;22683.773162268495;23930.7606923932;24012;24142.381968921996;24172.87913560421;1118.5022664914197;1123.2530367305812;1156.976860462803;1169.8011338072379;1170.777552265067;11699.969596227844;12228.483479383221;12312.322822244863;12320.568780092653;12341.938290308492;274738;276750;276986;277026;278163;50618.987620248125;50746.746266268434;50839;50868.74565627148;50976.21583244568;1474.233398632705;1509.4113295814423;1515.8408367121515;1516.7800668902946;1528.2129703202859;25521.106761263265;25778.742212578385;26502.469950601266;27460.58809117905;27614.309642259104;34901.47647785336;34916.65083349134;34959;35012.82493587516;35027.82486087655;235102;235406;235653;235977;236631;29939.55090673598;30145.849270753504;31323.927889375147;31958.36083278275;32074.6792532081;42207.577924221594;42971.78514107409;43044.35433468563;43107.70676879698;43179.568204317555;28553;28998.855005724836;29408.558871616515;30424.695753042186;30561.847190763903;28541.714582853907;29446.411071778017;30160.396792064475;30401.69598303989;30641.927532536254;36028.639713602526;36248.09379765527;36272;36288;36350.8182459086;29350.11949641514;29701.702982969895;29811.764117691695;30609.387812244076;30734;23662.81685915732;23729.406764831016;23818.52362952766;23908.52182956366;24104 17:33:39 INFO - PID 2294 | |2;jquery.html;386.777602878345;425.74700130251375;433.2894053751846;437.601782378036;455.97092936432864;17743.201555929983;21681.80750058748;22049.448763780874;22836.77163228367;23142.95856686449;22597.435064123405;22867.08531658736;22991.195308164217;23306.65040024397;23696.763032369672;4445.51099379068;5629.408912064236;6042.637441753498;6286.559940804145;6352.587081839665;6191.566590338678;6281.309056003836;6295.527835412362;6305.905411418832;6315;5977.5815692901515;6114.419130182626;6186.690665466709;6188.81433556994;6193.380661933816;5964.701764911737;6061.454469097758;6172.598781079238;6214.316425193225;6233.407826256521;5456.208849716809;5461.18082287656;5466.562674985991;5478.342598888119;5479.643823151482;26962.325941851414;27408.725912740818;27426.588601171;27525.724742752518;27758.722412776016;2190.145843121184;2217.2904670505445;2236.821054315667;2239.2386588559966;2242.035924552442;15664;16205.189740512928;16646.58383540409;17407.825921740747;17651.558711032198;2074.7199128117663;2080.8751474911555;2125.521757604542;2128.595566842295;2161.9351419457444;111128;130911.34544327218;132858;134386;135879.32060339733;9059.68291109808;9638.843338799248;11924.463399146885;12031.759364812655;12256.509739610494;12815.359232038361;15122.790176785831;16304.67390652204;16523.586910327336;16587.91706041486;8738.30093592511;8832.407148282857;8865.246454051477;9052.27581793455;9069.410488318239;7360.9694642750055;8258.752237432887;8417.116202798741;8451.112633173429;8657.870131948026;7536.321731044122;7711.7300894469545;7726.806829829186;7731.188225236382;7732.884006739903;1863.3571417860817;2149.871317558263;2165.6859755335704;2173.5652869426176;2195.87922664255;973.9610415583297;985.2856678907877;987.5062468765617;1000.8949060348705;1029.315505189041;21255.36233912985;21295.68056479154;21312.467188320417;21334.893325533274;21347.46631334198;933.0016881936263;1009.4952523738131;1018.6434747838346;1034.9896501034893;1044.9477526123662;10830;11085.22403431752;11111.38887361203;11111.499982500807;11143;646343;656585;684269;688421;704652;146824;147604;151685;158088.41911580967;163058;1157.670064031747;1174.0783484964263;1203.8796120388067;1203.9638810835688;1207.7584483103415;17790.91104544521;18155.45533633993;18196.27214911442;18317.3588924387;18589.72115418243;59641;61392.69303653453;61441.69279153576;62542.37457625366;62868;82716;83708;84125;84541.57729211314;88200;6724.29394913527;8863.335249856416;8905.287576993955;8926.73219803407;9043.32175086858;14189.432422703389;14323.78514322265;14336.068155569854;14604.561863144123;14659.267036648338;11484.540618375171;11623.07015438746;11742.530298788295;12032.578859739868;12086.456109474919;10877;11308.43457827089;11312.20814543007;11561.248518846249;11608.419579021183;11922.344271065174;11924.284542927453;12105.75788484243;12182.756344872876;12205.877941220475;7943.523388596703;8873.866891996497;8885.733427997171;9041.68354107603;9088.454692718458;11511.30932144074;11768.941155294511;12000.819987700017;12200.389980501117;12238.571649992207 17:33:39 INFO - PID 2294 | |3;mootools.html;1347.5957212836147;1397.7903314502826;1457.7157454296416;1484.732748105341;1488.092263719131;11429.314241145526;12110.212836165643;12124.939375303122;12130.211536250137;12133.332666703316;11695.707607309821;11703.531858725662;12022.81965770512;12091.093168012412;12119.575814846483;2503.4993001399703;2545.0710490670863;2548.0826902315152;2555.6933168019773;2556.5014822109697;2470.1231062972656;2483.3915690655726;2527.9747202527924;2535.366158460385;2538.327343254039;2438.8658623775686;2539.593665013589;2539.911103111382;2541.0471073347494;2543.5421624107653;2456.852588844675;2491.8380305280098;2496.3883848457153;2497.650328953948;2529.3676580854785;2476.2447453526665;2502.4995000999875;2503.7245902950663;2512.4975004999073;2513.5726926422553;11759.88240117605;12016.218945768585;12040.759184816343;12042.69893252667;12052.758944821142;6454.32229615893;6675.265720770712;6690.83272918176;6713.127293451869;6726.697298621574;4058.472398588194;4276.337167739005;4365.934510982338;4405.163019026375;4406.118776244732;1214.4170798017;1220.9755804883853;1294.987050129496;1296.572131196703;1297.772889744291;15152.393904243818;15589;15595.220238988006;16637.33450661972;16808.495745127544;5452.672839629556;5524.502794748492;5720;5726.828195154152;5736.110902810071;12397.814032789516;12404.56584019573;12419.316937568521;12421.75156496865;12430.627081187578;6009.45914867664;6166.691665416801;6529.314421985718;6556.672166391661;6559.672016399161;5156.381234251914;6076.726547305382;6163.568550201443;6173.6913154343;6224.595401298991;4225.112726327444;4340.175366680383;4379.430674012422;4382.802773875183;4394.318880573516;1130.3444002478543;1290.5741105435184;1295.598364507006;1300.3693208793727;1318.1432069154935;658.6245839871227;771.3327971304893;794.1185284334384;802.6668932393109;811.2941740685641;5173.534381905646;5682.374938756733;6300.653464059429;6350.904736428957;6988.650567471606;912.8950170730318;927.5455027036703;931.9627214911328;951.177231694593;967.56943160293;4084.203580301872;4177.895552611149;4200.537940826506;4241.766702831313;4362.454693163355;12432;14635.707285854436;15327.463538776312;15333.386664533295;15349;14675.41298348054;15258.542243732483;15330.540083797503;15342;15364.692706146037;10668.94665526683;10972.615958441416;10978.231523793258;10997;11002.724931876766;5608.439156084522;6965.164180298397;7160.498765086394;7191.964040179766;7193.064901562763;13070.516601845618;13123.34383280813;13366.532171373956;13456.5290214842;13716;12466.688332791753;13833.861661383256;13900.860991390362;14047.929760351133;14477.420903164177;9426.62293508252;9470.621175152917;9514.38156519824;9700.563474643517;9742.95128524353;10656.62701805433;10776.191785615953;10794.460276986276;10803.027727504563;10832.025117739442;9031.593578288861;9243.953780231055;9260.49067301305;9324.300677449082;9464.95267523658;9038.864417033881;9114.498702571422;9178.173964343241;9245.907540924774;9256.398334108262;8088.757337279891;8265.256126948603;8289.95855020721;8295.087540370434;8300.501969881827;4835.854924352275;5955.493783028491;6047.667378294236;6077.513798896166;6210.913090209105;4961.454240033521;5982.970085149546;6138.723757430837;6195.19462469876;6229.657368844757 17:33:39 INFO - PID 2294 | |4;prototype.html;395.825836631882;403.3647005965605;405.0602601963444;411.07713183902143;412.3381971935044;5249.055170069386;5915.757690884914;5946.226990491241;5957.6127551709105;5962.940370596298;4801.8151740957865;5414.648047876885;5560.825586388013;5651.886962260763;5835.44563266489;4432.756198409086;4434.556544345556;4466.397036400093;4466.9329960050545;4468.039371535119;4461.353103799947;4475.216837053519;4478.955210447886;4492.797824097907;4552.317152427129;3874.9806250968704;4260.744355338674;4391.9780401098105;4400.295952647577;4452.933206001912;4174.624283814456;4403.8238470461465;4403.9559604404185;4428.225060614412;4433.534478879719;3290.917727056819;3921.784246883475;3973.3443981742976;3985.322495175827;4001.479437813641;4755.524447555252;5601.29983752031;5622.662640241558;5725.112607545837;5742.712864356766;5280.577553795687;5287.360918115358;5297.6821390716295;5314.681119132864;5329.7601607927345;5539.639923404966;6097.969510152465;6130.233720784902;6159.922013647593;6163.907541386883;4362.8874636967685;4478.708883922567;4495.3931219285305;4502.347159661864;4538.251188553884;6228.5017198624;6415.8075257741875;6418.743250269984;6428.260750013715;6451.483881289486;4458.974435879766;4605.723656580549;4624.606908412756;4630.86107416778;4635.374224479652;4475.440569928759;4731.834385796481;4740.952590474051;4742.9762851186215;4750.406199225097;4867.7322747249245;5010.5240002199735;5156.458571849902;5243.632945693765;5273.683578985197;4961.5534601886;5836.490309167014;6111.51107911366;6120.510359171256;6147.415995480422;1401.2643362234908;1464.816897887764;1584.9128297943494;1612.7500237463212;1616.6039320366351;972.7519482531909;979.2361957673027;994.0655783563427;995.1143482300758;998.0668075349571;5424.321959755031;5475.534579560782;5483.972580137074;5793.8841223175305;5843.298804143445;5513.58648101386;5616.500657207585;6001.5798894077;6307.810765677037;6312.968435157794;4923.704577725348;5121.692698438031;5546.389897111315;5812.564057695689;5867.2959244890035;3313.5692359993045;3336.0325505603587;3343.414902392072;3344;3353.614334351532;5741.311042674905;6195.256569211723;6487.740490380426;6497.870042599122;6506.544541882117;5984.760609575568;6396.307286515005;6524.902126468107;6543.901841472381;6581.934180658132;5954.315253745788;6549.4936164682385;6562.901556476657;6599.571027883172;6622.682061278514;5381.5694744421135;6184.907226391518;6205.720742566505;6438.973682369279;6475.579087359307;5310.415854256106;6355.428011478989;6374.58565193261;6382.585131966407;6384.361563843579;5955.791547295824;6140.723667435065;6291.716872740646;6514.837129071811;6650.268470468342;3645.54430696163;4283.7001409901;4316.740995540277;4334.309619248433;4339.327404252346;6051.243594550681;6331.303556608677;6444.355564443518;6451.387118223761;6491.578047426902;5467.261919640957;6099.512039036777;6207.6585787782105;6220.253569571681;6228.844278893064;6004.309504407049;6125.621735109565;6169.619570105276;6229.626222426669;6242.781502647385;5116.641835071509;5999.430054144849;6063.757449701962;6085.869945519033;6100.267967843887;6148.907766383597;6225;6252.968735156295;6272.905906411499;6278.434940855345;5271.736413179402;5536.640118392453;6031.979286938925;6037.849053773691;6120.7857724981195 17:33:39 INFO - PID 2294 | |5;yui.html;711.6192836832296;844.8014716541612;860.9324437697253;861.8879545659063;867.2411639815161;13244.668883277911;17667.293308267668;17867.73198402025;18338.724919126205;18363.540911477186;16827;16932.661346773057;17224.741628875578;17331.133443327813;17341.7398739019;942.5711301357883;975.2539307429787;975.6682727872521;979.7844474215661;980.0983095552074;670.2593634034395;689.5793565924782;980.3039841712392;1010.7473131717071;1014.6043043213152;1061.6178175856724;1065.8614380130573;1067.6103222323873;1067.925245232834;1070.411273799411;1059.4120263253892;1060.0512541275555;1061.9150467962545;1062.914966802654;1064.4677661169414;790.7509134622633;791.3036527855451;792.9207079292082;793.131520984521;793.6190628498296;16405.58986025347;16594.83405165945;16780;17055;17334.739978900325;16315.673686526203;16550.586235344093;16758.162091895356;16790.328386864512;17059.232334544977;13520.932395338059;13733.45066197351;13745.656358591015;13889.374978126009;13944.093633913762;3453.568303962005;3485.0938755923644;3486.8779592714386;3488.5639295088113;3489.023073539413;85121;112316;112550;112697.43651281692;113509;11355.716107097389;11724.765504689858;13336.333183340794;13613.727725445633;13648.590542283748;19713.901430492755;20158.39524814258;20656.89671551663;25147.371315716886;25271;7950.801229969182;8838.29293656506;8866.290696744245;9079.81840363189;9089.5000774958;4710.293455981561;4805.6155507559315;4806.327114204014;4808.206645903457;4812.230043193073;4263.232618128704;4264.509581398117;4319.848805291863;4384.868453946387;4386.978065109654;925.8333499969935;952.457099453305;955.1594596754811;961.2886464016717;962;647.252423450915;652.6443088516675;663.9070530125787;673.1484671890063;695.5027155583782;9790.5594248259;11609.593664221711;11742.354170520703;11752.471138798604;11904.642860714192;643.3727116061802;661.163628010567;666.6733300682631;674.5379415100672;685.6537448588531;4558.612517935946;4967.776450059756;5418.45815418455;5428.4028756836715;5498.532624726863;104026.47986760018;105867.47066264773;106119;107192;108001;85451;85508;86158;86740.56629716937;93029;59148;76165;77631;78520.6073969638;84772;12118.515704280777;12593.748125037264;12625.053121016144;12670.02493864694;12733.363331833556;38646.420303694904;38768;39644.405333919436;39780;41215.587844121175;37970.30445433207;48983.755081224364;49417.011659767326;49679.75160124176;50555.73610659763;15741.291641875914;15998;16243.106629135038;16972.74540881863;16999.11888132777;17932;18095.00477473699;18096.72854907151;18605.06974651235;18728.719069214247;15449;15456.690866182838;15562.37750490013;15609.21953902323;17153.142342883057;16455.42406015784;16803.907745996472;17035.063071531185;17092.230849611547;17300.56748581245;16184.757228641814;16568.254428550987;16579.585510362336;16825.579360516083;16897;11642.825357619473;11715.648530544097;11894.821577676168;12020.158588898694;12098.818517722066;11405.885941140483;11772.46970794587;13091.541796037092;13124.73750524965;13142.342882855628 17:33:39 INFO - PID 2294 | __end_tp_report 17:33:39 INFO - PID 2294 | __start_cc_report 17:33:39 INFO - PID 2294 | _x_x_mozilla_cycle_collect,2307 17:33:39 INFO - PID 2294 | __end_cc_report 17:33:39 INFO - PID 2294 | __startTimestamp1491957219918__endTimestamp 17:33:39 INFO - PID 2294 | 17:33:39 INFO - PID 2294 | ------- Summary: start ------- 17:33:39 INFO - PID 2294 | Number of tests: 6 17:33:39 INFO - PID 2294 | 17:33:39 INFO - PID 2294 | [#0] dojo.html Cycles:165 Average:5984.72 Median:6259.22 stddev:682.76 (10.9%) stddev-sans-first:650.44 17:33:39 INFO - PID 2294 | Values: 3256.1 3448.9 3458.8 3509.8 3522.5 6021.2 6110.6 6182.3 6199.7 6222.4 6130.9 6134.0 6175.9 6188.2 6191.7 4858.3 5156.4 5279.1 5317.5 5431.1 5391.2 5429.2 5434.2 5435.2 5454.2 5223.1 5285.9 5296.8 5314.2 5320.2 5276.8 5301.8 5306.7 5312.1 5319.2 5225.9 5280.2 5283.2 5290.7 5301.1 6086.6 6112.2 6114.8 6115.5 6122.4 6346.1 6350.0 6360.1 6371.7 6411.7 6522.7 6554.7 6567.5 6616.0 6637.7 5405.9 6261.2 6263.0 6277.1 6282.5 6476.6 6571.1 6730.3 6745.3 6756.6 6323.1 6353.2 6379.0 6390.4 6402.7 6515.3 6538.7 6548.1 6551.5 6562.5 5655.6 6448.9 6454.3 6463.4 6480.1 6259.2 6307.6 6320.7 6369.9 6401.4 5238.4 5239.3 5248.8 5249.7 5284.6 4661.6 4671.5 4675.3 4677.0 4712.3 6068.7 6083.6 6108.3 6183.8 6224.8 6372.9 6508.7 6543.2 6546.3 6574.7 6187.8 6190.3 6196.9 6198.2 6210.6 5744.6 5779.2 5783.4 5793.9 5807.4 6435.5 6527.0 6531.0 6533.2 6541.7 6409.0 6427.1 6437.5 6446.2 6490.5 6509.4 6550.8 6562.5 6563.1 6566.9 6337.1 6341.2 6343.0 6353.2 6392.6 6337.7 6398.1 6419.6 6434.2 6444.3 6289.4 6328.4 6337.8 6339.6 6361.6 6294.1 6359.6 6366.3 6376.5 6392.3 4882.7 5961.8 6137.7 6264.1 6270.0 6178.2 6253.8 6262.4 6274.7 6291.3 6192.1 6219.2 6224.2 6228.5 6231.2 17:33:39 INFO - PID 2294 | 17:33:39 INFO - PID 2294 | [#1] ext.html Cycles:180 Average:41406.14 Median:3149.02 stddev:69040.54 (2192.4%) stddev-sans-first:69166.70 17:33:39 INFO - PID 2294 | Values: 737.3 804.7 1131.6 1155.6 1158.8 35871.8 36523.5 36617.5 36645.8 36890.3 38572.6 38908.6 38929.8 38980.6 39004.6 6107.3 6250.3 8440.7 8578.2 8607.6 8288.5 8442.7 8443.3 8465.1 8467.2 8435.5 8522.6 8523.9 8530.5 8534.0 8445.5 8491.2 8503.0 8504.2 8519.6 8374.7 8441.5 8456.7 8466.6 8468.1 36608.3 36777.4 36801.8 36835.7 36885.6 3547.7 3580.6 3585.5 3589.4 3592.3 30041.7 30061.9 30120.5 30132.7 30138.2 3098.5 3129.5 3147.9 3150.1 3162.9 249876.0 283936.0 284600.0 284851.0 286026.0 38050.9 38863.0 45560.5 48209.8 48244.5 48138.8 48350.3 48366.5 48454.3 48468.8 11692.5 13720.4 13844.7 13898.8 13913.3 9863.9 9887.7 11255.1 11275.3 11371.9 11719.3 11758.0 11894.2 11910.0 11924.1 4758.1 5208.8 5237.1 5266.8 5289.6 964.2 1028.1 1050.1 1051.9 1079.1 22683.8 23930.8 24012.0 24142.4 24172.9 1118.5 1123.3 1157.0 1169.8 1170.8 11700.0 12228.5 12312.3 12320.6 12341.9 274738.0 276750.0 276986.0 277026.0 278163.0 50619.0 50746.7 50839.0 50868.7 50976.2 1474.2 1509.4 1515.8 1516.8 1528.2 25521.1 25778.7 26502.5 27460.6 27614.3 34901.5 34916.7 34959.0 35012.8 35027.8 235102.0 235406.0 235653.0 235977.0 236631.0 29939.6 30145.8 31323.9 31958.4 32074.7 42207.6 42971.8 43044.4 43107.7 43179.6 28553.0 28998.9 29408.6 30424.7 30561.8 28541.7 29446.4 30160.4 30401.7 30641.9 36028.6 36248.1 36272.0 36288.0 36350.8 29350.1 29701.7 29811.8 30609.4 30734.0 23662.8 23729.4 23818.5 23908.5 24104.0 17:33:39 INFO - PID 2294 | 17:33:39 INFO - PID 2294 | [#2] jquery.html Cycles:180 Average:39277.65 Median:2240.64 stddev:113091.58 (5047.3%) stddev-sans-first:113371.13 17:33:39 INFO - PID 2294 | Values: 386.8 425.7 433.3 437.6 456.0 17743.2 21681.8 22049.4 22836.8 23143.0 22597.4 22867.1 22991.2 23306.7 23696.8 4445.5 5629.4 6042.6 6286.6 6352.6 6191.6 6281.3 6295.5 6305.9 6315.0 5977.6 6114.4 6186.7 6188.8 6193.4 5964.7 6061.5 6172.6 6214.3 6233.4 5456.2 5461.2 5466.6 5478.3 5479.6 26962.3 27408.7 27426.6 27525.7 27758.7 2190.1 2217.3 2236.8 2239.2 2242.0 15664.0 16205.2 16646.6 17407.8 17651.6 2074.7 2080.9 2125.5 2128.6 2161.9 111128.0 130911.3 132858.0 134386.0 135879.3 9059.7 9638.8 11924.5 12031.8 12256.5 12815.4 15122.8 16304.7 16523.6 16587.9 8738.3 8832.4 8865.2 9052.3 9069.4 7361.0 8258.8 8417.1 8451.1 8657.9 7536.3 7711.7 7726.8 7731.2 7732.9 1863.4 2149.9 2165.7 2173.6 2195.9 974.0 985.3 987.5 1000.9 1029.3 21255.4 21295.7 21312.5 21334.9 21347.5 933.0 1009.5 1018.6 1035.0 1044.9 10830.0 11085.2 11111.4 11111.5 11143.0 646343.0 656585.0 684269.0 688421.0 704652.0 146824.0 147604.0 151685.0 158088.4 163058.0 1157.7 1174.1 1203.9 1204.0 1207.8 17790.9 18155.5 18196.3 18317.4 18589.7 59641.0 61392.7 61441.7 62542.4 62868.0 82716.0 83708.0 84125.0 84541.6 88200.0 6724.3 8863.3 8905.3 8926.7 9043.3 14189.4 14323.8 14336.1 14604.6 14659.3 11484.5 11623.1 11742.5 12032.6 12086.5 10877.0 11308.4 11312.2 11561.2 11608.4 11922.3 11924.3 12105.8 12182.8 12205.9 7943.5 8873.9 8885.7 9041.7 9088.5 11511.3 11768.9 12000.8 12200.4 12238.6 17:33:39 INFO - PID 2294 | 17:33:39 INFO - PID 2294 | [#3] mootools.html Cycles:180 Average:7207.64 Median:2544.31 stddev:4566.13 (179.5%) stddev-sans-first:4557.71 17:33:39 INFO - PID 2294 | Values: 1347.6 1397.8 1457.7 1484.7 1488.1 11429.3 12110.2 12124.9 12130.2 12133.3 11695.7 11703.5 12022.8 12091.1 12119.6 2503.5 2545.1 2548.1 2555.7 2556.5 2470.1 2483.4 2528.0 2535.4 2538.3 2438.9 2539.6 2539.9 2541.0 2543.5 2456.9 2491.8 2496.4 2497.7 2529.4 2476.2 2502.5 2503.7 2512.5 2513.6 11759.9 12016.2 12040.8 12042.7 12052.8 6454.3 6675.3 6690.8 6713.1 6726.7 4058.5 4276.3 4365.9 4405.2 4406.1 1214.4 1221.0 1295.0 1296.6 1297.8 15152.4 15589.0 15595.2 16637.3 16808.5 5452.7 5524.5 5720.0 5726.8 5736.1 12397.8 12404.6 12419.3 12421.8 12430.6 6009.5 6166.7 6529.3 6556.7 6559.7 5156.4 6076.7 6163.6 6173.7 6224.6 4225.1 4340.2 4379.4 4382.8 4394.3 1130.3 1290.6 1295.6 1300.4 1318.1 658.6 771.3 794.1 802.7 811.3 5173.5 5682.4 6300.7 6350.9 6988.7 912.9 927.5 932.0 951.2 967.6 4084.2 4177.9 4200.5 4241.8 4362.5 12432.0 14635.7 15327.5 15333.4 15349.0 14675.4 15258.5 15330.5 15342.0 15364.7 10668.9 10972.6 10978.2 10997.0 11002.7 5608.4 6965.2 7160.5 7192.0 7193.1 13070.5 13123.3 13366.5 13456.5 13716.0 12466.7 13833.9 13900.9 14047.9 14477.4 9426.6 9470.6 9514.4 9700.6 9743.0 10656.6 10776.2 10794.5 10803.0 10832.0 9031.6 9244.0 9260.5 9324.3 9465.0 9038.9 9114.5 9178.2 9245.9 9256.4 8088.8 8265.3 8290.0 8295.1 8300.5 4835.9 5955.5 6047.7 6077.5 6210.9 4961.5 5983.0 6138.7 6195.2 6229.7 17:33:39 INFO - PID 2294 | 17:33:39 INFO - PID 2294 | [#4] prototype.html Cycles:180 Average:5062.93 Median:5608.90 stddev:1510.02 (26.9%) stddev-sans-first:1473.06 17:33:39 INFO - PID 2294 | Values: 395.8 403.4 405.1 411.1 412.3 5249.1 5915.8 5946.2 5957.6 5962.9 4801.8 5414.6 5560.8 5651.9 5835.4 4432.8 4434.6 4466.4 4466.9 4468.0 4461.4 4475.2 4479.0 4492.8 4552.3 3875.0 4260.7 4392.0 4400.3 4452.9 4174.6 4403.8 4404.0 4428.2 4433.5 3290.9 3921.8 3973.3 3985.3 4001.5 4755.5 5601.3 5622.7 5725.1 5742.7 5280.6 5287.4 5297.7 5314.7 5329.8 5539.6 6098.0 6130.2 6159.9 6163.9 4362.9 4478.7 4495.4 4502.3 4538.3 6228.5 6415.8 6418.7 6428.3 6451.5 4459.0 4605.7 4624.6 4630.9 4635.4 4475.4 4731.8 4741.0 4743.0 4750.4 4867.7 5010.5 5156.5 5243.6 5273.7 4961.6 5836.5 6111.5 6120.5 6147.4 1401.3 1464.8 1584.9 1612.8 1616.6 972.8 979.2 994.1 995.1 998.1 5424.3 5475.5 5484.0 5793.9 5843.3 5513.6 5616.5 6001.6 6307.8 6313.0 4923.7 5121.7 5546.4 5812.6 5867.3 3313.6 3336.0 3343.4 3344.0 3353.6 5741.3 6195.3 6487.7 6497.9 6506.5 5984.8 6396.3 6524.9 6543.9 6581.9 5954.3 6549.5 6562.9 6599.6 6622.7 5381.6 6184.9 6205.7 6439.0 6475.6 5310.4 6355.4 6374.6 6382.6 6384.4 5955.8 6140.7 6291.7 6514.8 6650.3 3645.5 4283.7 4316.7 4334.3 4339.3 6051.2 6331.3 6444.4 6451.4 6491.6 5467.3 6099.5 6207.7 6220.3 6228.8 6004.3 6125.6 6169.6 6229.6 6242.8 5116.6 5999.4 6063.8 6085.9 6100.3 6148.9 6225.0 6253.0 6272.9 6278.4 5271.7 5536.6 6032.0 6037.8 6120.8 17:33:39 INFO - PID 2294 | 17:33:39 INFO - PID 2294 | [#5] yui.html Cycles:180 Average:20729.52 Median:18217.73 stddev:28374.50 (155.8%) stddev-sans-first:28414.29 17:33:39 INFO - PID 2294 | Values: 711.6 844.8 860.9 861.9 867.2 13244.7 17667.3 17867.7 18338.7 18363.5 16827.0 16932.7 17224.7 17331.1 17341.7 942.6 975.3 975.7 979.8 980.1 670.3 689.6 980.3 1010.7 1014.6 1061.6 1065.9 1067.6 1067.9 1070.4 1059.4 1060.1 1061.9 1062.9 1064.5 790.8 791.3 792.9 793.1 793.6 16405.6 16594.8 16780.0 17055.0 17334.7 16315.7 16550.6 16758.2 16790.3 17059.2 13520.9 13733.5 13745.7 13889.4 13944.1 3453.6 3485.1 3486.9 3488.6 3489.0 85121.0 112316.0 112550.0 112697.4 113509.0 11355.7 11724.8 13336.3 13613.7 13648.6 19713.9 20158.4 20656.9 25147.4 25271.0 7950.8 8838.3 8866.3 9079.8 9089.5 4710.3 4805.6 4806.3 4808.2 4812.2 4263.2 4264.5 4319.8 4384.9 4387.0 925.8 952.5 955.2 961.3 962.0 647.3 652.6 663.9 673.1 695.5 9790.6 11609.6 11742.4 11752.5 11904.6 643.4 661.2 666.7 674.5 685.7 4558.6 4967.8 5418.5 5428.4 5498.5 104026.5 105867.5 106119.0 107192.0 108001.0 85451.0 85508.0 86158.0 86740.6 93029.0 59148.0 76165.0 77631.0 78520.6 84772.0 12118.5 12593.7 12625.1 12670.0 12733.4 38646.4 38768.0 39644.4 39780.0 41215.6 37970.3 48983.8 49417.0 49679.8 50555.7 15741.3 15998.0 16243.1 16972.7 16999.1 17932.0 18095.0 18096.7 18605.1 18728.7 15449.0 15456.7 15562.4 15609.2 17153.1 16455.4 16803.9 17035.1 17092.2 17300.6 16184.8 16568.3 16579.6 16825.6 16897.0 11642.8 11715.6 11894.8 12020.2 12098.8 11405.9 11772.5 13091.5 13124.7 13142.3 17:33:39 INFO - PID 2294 | -------- Summary: end -------- 17:33:39 INFO - PID 2294 | 17:33:40 INFO - TEST-INFO | 2294: exit 0 17:33:40 INFO - TEST-OK | dromaeo_css | took 1120344ms 17:33:40 INFO - TEST-START | kraken 17:33:40 INFO - operating with platform_type : mac_ 17:33:40 INFO - Initialising browser for kraken test... 17:33:40 INFO - TEST-INFO | started process 2297 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/tmpjvP6n7/profile http://localhost:56225/getInfo.html) 17:33:43 INFO - PID 2297 | __metrics Screen width/height:1600/1200 17:33:43 INFO - PID 2297 | colorDepth:24 17:33:43 INFO - PID 2297 | Browser inner width/height: 1024/689 17:33:43 INFO - PID 2297 | __metrics 17:33:43 INFO - PID 2297 | 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" 17:33:43 INFO - PID 2297 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 304: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:33:44 INFO - TEST-INFO | 2297: exit 0 17:33:44 INFO - Browser initialized. 17:33:44 INFO - Running cycle 1/1 for kraken test... 17:33:44 INFO - TEST-INFO | started process 2298 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/tmpjvP6n7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:33:56 INFO - PID 2298 | RSS: Main: 233140224 17:33:56 INFO - PID 2298 | 17:33:59 INFO - PID 2298 | Cycle 1(1): loaded http://localhost:56225/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56225/tests/kraken/driver.html?testName=audio-beat-detection) 17:34:00 INFO - PID 2298 | RSS: Main: 293097472 17:34:00 INFO - PID 2298 | 17:34:03 INFO - PID 2298 | Cycle 1(1): loaded http://localhost:56225/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56225/tests/kraken/driver.html?testName=audio-dft) 17:34:03 INFO - PID 2298 | RSS: Main: 296001536 17:34:03 INFO - PID 2298 | 17:34:07 INFO - PID 2298 | Cycle 1(1): loaded http://localhost:56225/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56225/tests/kraken/driver.html?testName=audio-fft) 17:34:08 INFO - PID 2298 | RSS: Main: 386113536 17:34:08 INFO - PID 2298 | 17:34:10 INFO - PID 2298 | Cycle 1(1): loaded http://localhost:56225/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56225/tests/kraken/driver.html?testName=audio-oscillator) 17:34:10 INFO - PID 2298 | RSS: Main: 288882688 17:34:10 INFO - PID 2298 | 17:34:12 INFO - PID 2298 | Cycle 1(1): loaded http://localhost:56225/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56225/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:34:13 INFO - PID 2298 | RSS: Main: 291950592 17:34:13 INFO - PID 2298 | 17:34:16 INFO - PID 2298 | Cycle 1(1): loaded http://localhost:56225/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56225/tests/kraken/driver.html?testName=imaging-darkroom) 17:34:17 INFO - PID 2298 | RSS: Main: 334843904 17:34:17 INFO - PID 2298 | 17:34:20 INFO - PID 2298 | Cycle 1(1): loaded http://localhost:56225/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56225/tests/kraken/driver.html?testName=imaging-desaturate) 17:34:20 INFO - PID 2298 | RSS: Main: 340758528 17:34:20 INFO - PID 2298 | 17:34:24 INFO - PID 2298 | Cycle 1(1): loaded http://localhost:56225/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56225/tests/kraken/driver.html?testName=json-parse-financial) 17:34:24 INFO - PID 2298 | RSS: Main: 340385792 17:34:24 INFO - PID 2298 | 17:34:26 INFO - PID 2298 | Cycle 1(1): loaded http://localhost:56225/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56225/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:34:27 INFO - PID 2298 | RSS: Main: 310865920 17:34:27 INFO - PID 2298 | 17:34:28 INFO - PID 2298 | Cycle 1(1): loaded http://localhost:56225/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56225/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:34:29 INFO - PID 2298 | RSS: Main: 311074816 17:34:29 INFO - PID 2298 | 17:34:31 INFO - PID 2298 | Cycle 1(1): loaded http://localhost:56225/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56225/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:34:32 INFO - PID 2298 | RSS: Main: 314605568 17:34:32 INFO - PID 2298 | 17:34:35 INFO - PID 2298 | Cycle 1(1): loaded http://localhost:56225/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56225/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:34:36 INFO - PID 2298 | RSS: Main: 333107200 17:34:36 INFO - PID 2298 | 17:34:39 INFO - PID 2298 | Cycle 1(1): loaded http://localhost:56225/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56225/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:34:40 INFO - PID 2298 | RSS: Main: 316157952 17:34:40 INFO - PID 2298 | 17:34:42 INFO - PID 2298 | Cycle 1(1): loaded http://localhost:56225/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56225/tests/kraken/driver.html?testName=ai-astar) 17:34:42 INFO - PID 2298 | RSS: Main: 382320640 17:34:42 INFO - PID 2298 | 17:34:42 INFO - PID 2298 | __start_tp_report 17:34:42 INFO - PID 2298 | _x_x_mozilla_page_load 17:34:42 INFO - PID 2298 | _x_x_mozilla_page_load_details 17:34:42 INFO - PID 2298 | |i|pagename|runs| 17:34:42 INFO - PID 2298 | |0;ai-astar;110;124;124;124;124;122;121;123;125;123 17:34:42 INFO - PID 2298 | |1;audio-beat-detection;154;117;117;160;119;118;119;115;139;137 17:34:42 INFO - PID 2298 | |2;audio-dft;213;219;210;211;213;215;211;211;219;210 17:34:42 INFO - PID 2298 | |3;audio-fft;87;62;65;105;66;62;61;67;83;62 17:34:42 INFO - PID 2298 | |4;audio-oscillator;91;73;97;74;76;75;91;73;75;93 17:34:42 INFO - PID 2298 | |5;imaging-gaussian-blur;93;93;93;93;94;94;94;95;94;94 17:34:42 INFO - PID 2298 | |6;imaging-darkroom;100;102;106;102;103;102;103;103;103;101 17:34:42 INFO - PID 2298 | |7;imaging-desaturate;103;100;102;100;101;102;101;130;153;101 17:34:42 INFO - PID 2298 | |8;json-parse-financial;52;52;51;51;53;52;52;53;53;52 17:34:42 INFO - PID 2298 | |9;json-stringify-tinderbox;60;68;69;70;66;62;63;64;65;63 17:34:42 INFO - PID 2298 | |10;stanford-crypto-aes;89;88;92;91;91;113;104;91;89;91 17:34:42 INFO - PID 2298 | |11;stanford-crypto-ccm;153;153;149;148;150;153;150;152;193;158 17:34:42 INFO - PID 2298 | |12;stanford-crypto-pbkdf2;245;243;201;204;203;206;199;203;203;231 17:34:42 INFO - PID 2298 | |13;stanford-crypto-sha256-iterative;86;99;100;96;72;72;74;72;71;73 17:34:42 INFO - PID 2298 | __end_tp_report 17:34:42 INFO - PID 2298 | __start_cc_report 17:34:42 INFO - PID 2298 | _x_x_mozilla_cycle_collect,2195 17:34:42 INFO - PID 2298 | __end_cc_report 17:34:42 INFO - PID 2298 | __startTimestamp1491957282607__endTimestamp 17:34:42 INFO - PID 2298 | 17:34:42 INFO - PID 2298 | ------- Summary: start ------- 17:34:42 INFO - PID 2298 | Number of tests: 14 17:34:42 INFO - PID 2298 | 17:34:42 INFO - PID 2298 | [#0] ai-astar Cycles:10 Average:122.00 Median:124.00 stddev:4.37 (3.5%) stddev-sans-first:1.22 17:34:42 INFO - PID 2298 | Values: 110.0 124.0 124.0 124.0 124.0 122.0 121.0 123.0 125.0 123.0 17:34:42 INFO - PID 2298 | 17:34:42 INFO - PID 2298 | [#1] audio-beat-detection Cycles:10 Average:129.50 Median:128.00 stddev:16.84 (13.2%) stddev-sans-first:15.35 17:34:42 INFO - PID 2298 | Values: 154.0 117.0 117.0 160.0 119.0 118.0 119.0 115.0 139.0 137.0 17:34:42 INFO - PID 2298 | 17:34:42 INFO - PID 2298 | [#2] audio-dft Cycles:10 Average:213.20 Median:213.00 stddev:3.43 (1.6%) stddev-sans-first:3.63 17:34:42 INFO - PID 2298 | Values: 213.0 219.0 210.0 211.0 213.0 215.0 211.0 211.0 219.0 210.0 17:34:42 INFO - PID 2298 | 17:34:42 INFO - PID 2298 | [#3] audio-fft Cycles:10 Average:72.00 Median:65.50 stddev:14.78 (22.6%) stddev-sans-first:14.65 17:34:42 INFO - PID 2298 | Values: 87.0 62.0 65.0 105.0 66.0 62.0 61.0 67.0 83.0 62.0 17:34:42 INFO - PID 2298 | 17:34:42 INFO - PID 2298 | [#4] audio-oscillator Cycles:10 Average:81.80 Median:83.50 stddev:9.82 (11.8%) stddev-sans-first:9.83 17:34:42 INFO - PID 2298 | Values: 91.0 73.0 97.0 74.0 76.0 75.0 91.0 73.0 75.0 93.0 17:34:42 INFO - PID 2298 | 17:34:42 INFO - PID 2298 | [#5] imaging-gaussian-blur Cycles:10 Average:93.70 Median:94.00 stddev:0.67 (0.7%) stddev-sans-first:0.67 17:34:42 INFO - PID 2298 | Values: 93.0 93.0 93.0 93.0 94.0 94.0 94.0 95.0 94.0 94.0 17:34:42 INFO - PID 2298 | 17:34:42 INFO - PID 2298 | [#6] imaging-darkroom Cycles:10 Average:102.50 Median:103.00 stddev:1.58 (1.5%) stddev-sans-first:1.39 17:34:42 INFO - PID 2298 | Values: 100.0 102.0 106.0 102.0 103.0 102.0 103.0 103.0 103.0 101.0 17:34:42 INFO - PID 2298 | 17:34:42 INFO - PID 2298 | [#7] imaging-desaturate Cycles:10 Average:109.30 Median:102.00 stddev:17.84 (17.5%) stddev-sans-first:18.77 17:34:42 INFO - PID 2298 | Values: 103.0 100.0 102.0 100.0 101.0 102.0 101.0 130.0 153.0 101.0 17:34:42 INFO - PID 2298 | 17:34:42 INFO - PID 2298 | [#8] json-parse-financial Cycles:10 Average:52.10 Median:52.00 stddev:0.74 (1.4%) stddev-sans-first:0.78 17:34:42 INFO - PID 2298 | Values: 52.0 52.0 51.0 51.0 53.0 52.0 52.0 53.0 53.0 52.0 17:34:42 INFO - PID 2298 | 17:34:42 INFO - PID 2298 | [#9] json-stringify-tinderbox Cycles:10 Average:65.00 Median:65.50 stddev:3.23 (4.9%) stddev-sans-first:2.88 17:34:42 INFO - PID 2298 | Values: 60.0 68.0 69.0 70.0 66.0 62.0 63.0 64.0 65.0 63.0 17:34:42 INFO - PID 2298 | 17:34:42 INFO - PID 2298 | [#10] stanford-crypto-aes Cycles:10 Average:93.90 Median:91.00 stddev:8.08 (8.9%) stddev-sans-first:8.37 17:34:42 INFO - PID 2298 | Values: 89.0 88.0 92.0 91.0 91.0 113.0 104.0 91.0 89.0 91.0 17:34:42 INFO - PID 2298 | 17:34:42 INFO - PID 2298 | [#11] stanford-crypto-ccm Cycles:10 Average:155.90 Median:153.00 stddev:13.34 (8.7%) stddev-sans-first:14.10 17:34:42 INFO - PID 2298 | Values: 153.0 153.0 149.0 148.0 150.0 153.0 150.0 152.0 193.0 158.0 17:34:42 INFO - PID 2298 | 17:34:42 INFO - PID 2298 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:213.80 Median:205.00 stddev:18.29 (8.9%) stddev-sans-first:15.53 17:34:42 INFO - PID 2298 | Values: 245.0 243.0 201.0 204.0 203.0 206.0 199.0 203.0 203.0 231.0 17:34:42 INFO - PID 2298 | 17:34:42 INFO - PID 2298 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:81.50 Median:73.50 stddev:12.42 (16.9%) stddev-sans-first:13.07 17:34:42 INFO - PID 2298 | Values: 86.0 99.0 100.0 96.0 72.0 72.0 74.0 72.0 71.0 73.0 17:34:42 INFO - PID 2298 | -------- Summary: end -------- 17:34:42 INFO - PID 2298 | 17:34:43 INFO - TEST-INFO | 2298: exit 0 17:34:43 INFO - TEST-OK | kraken | took 63092ms 17:34:43 INFO - SUITE-END | took 1183s 17:34:43 INFO - Completed test suite (00:19:43) 17:34:43 INFO - javascript benchmark 17:34:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7756.786606592443, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3256.07201947445, 3448.8620455181795, 3458.8443520041596, 3509.84205710743, 3522.524459198009, 6021.2473440819895, 6110.649890384128, 6182.2581290245125, 6199.659018753967, 6222.439980401763, 6130.948521380013, 6133.969330153354, 6175.938240617581, 6188.195534580498, 6191.659458729768, 4858.344123543329, 5156.355455568054, 5279.102552566053, 5317.521423071923, 5431.103867861818, 5391.191321301797, 5429.185622156669, 5434.212039254306, 5435.157550579646, 5454.181872719084, 5223.138182199951, 5285.920711189336, 5296.814611488579, 5314.202869569557, 5320.228566857822, 5276.815311464119, 5301.761420736076, 5306.734663266821, 5312.070387682179, 5319.2287118368, 5225.947740522584, 5280.155175171993, 5283.1546952487415, 5290.68255904647, 5301.125314323171, 6086.573939824214, 6112.235970503687, 6114.755409783604, 6115.48018418435, 6122.448979591813, 6346.11154438379, 6349.968250158766, 6360.141380913564, 6371.745130194787, 6411.679416029227, 6522.706478208444, 6554.705038273241, 6567.507436942248, 6616.007598860161, 6637.701303441357, 5405.891882162374, 6261.217347831521, 6263.0, 6277.05844123376, 6282.465990390822, 6476.643784591798, 6571.080048793173, 6730.259671436138, 6745.291744366869, 6756.594604323756, 6323.083152942798, 6353.174087368612, 6378.968105159444, 6390.392912673288, 6402.743890244431, 6515.250746164157, 6538.738450461929, 6548.116004339448, 6551.508636852255, 6562.540622156499, 5655.604107712421, 6448.903266451007, 6454.290028096905, 6463.418292353711, 6480.060391243243, 6259.217597800275, 6307.558470906993, 6320.747170113144, 6369.872602547923, 6401.423871851555, 5238.371395432572, 5239.345081864767, 5248.790048398021, 5249.658772179872, 5284.5772338212855, 4661.557152070548, 4671.532846715301, 4675.275332323496, 4677.0, 4712.269598212282, 6068.696565171724, 6083.574149809471, 6108.311716707923, 6183.783567575113, 6224.813255602339, 6372.936270637234, 6508.707108180143, 6543.1821022372205, 6546.3453654635105, 6574.737010519621, 6187.752489900354, 6190.2571691397325, 6196.938030619636, 6198.194234749544, 6210.627362358273, 5744.626599271034, 5779.162021506942, 5783.392743761844, 5793.916735440597, 5807.390224026416, 6435.452986496013, 6527.0, 6531.0, 6533.216014078341, 6541.738330466918, 6408.967955160381, 6427.132337134427, 6437.485001199799, 6446.226452825504, 6490.48076153916, 6509.446697030806, 6550.8362290943105, 6562.5406221564035, 6563.146790917151, 6566.9343306566325, 6337.144485494584, 6341.239051313872, 6343.0, 6353.174087368612, 6392.616443013248, 6337.746490140527, 6398.104265402941, 6419.646919419477, 6434.163558737334, 6444.3233460487845, 6289.371062893857, 6328.398802113792, 6337.7781777637565, 6339.587926784744, 6361.554691171574, 6294.087357333069, 6359.554831161774, 6366.331535188924, 6376.52176086786, 6392.296847346695, 4882.6826256293225, 5961.791337303173, 6137.693115344304, 6264.060390941395, 6270.0, 6178.227721534809, 6253.78111766086, 6262.405071518198, 6274.686265686789, 6291.339409361951, 6192.0711893214575, 6219.191505104308, 6224.221972253468, 6228.4705800007505, 6231.22109736283], "value": 5939.821753339749, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [737.325347307214, 804.7022601637395, 1131.5982826096736, 1155.6244220628294, 1158.8435561199235, 35871.82064089679, 36523.452148217766, 36617.45073823895, 36645.816770916106, 36890.26219475612, 38572.61427385725, 38908.61091389085, 38929.805350973205, 38980.61019389805, 39004.60995390045, 6107.267127944653, 6250.343713910042, 8440.662373505067, 8578.227959483645, 8607.6126574304, 8288.502689838599, 8442.704505342313, 8443.324534037261, 8465.111163327854, 8467.153284671545, 8435.451695639795, 8522.57387130644, 8523.914760852374, 8530.530820804854, 8533.95733021334, 8445.451045682012, 8491.150884911522, 8503.0, 8504.192101750325, 8519.616617252239, 8374.706885258987, 8441.451305665174, 8456.746297611082, 8466.576671166416, 8468.110848360957, 36608.267834643426, 36777.448338274946, 36801.81599091987, 36835.71075012362, 36885.631143688486, 3547.7161827053774, 3580.5524309461316, 3585.480105384731, 3589.4436362363876, 3592.335417947662, 30041.69958300411, 30061.947831826, 30120.54819177714, 30132.69867301321, 30138.24654383636, 3098.488749356376, 3129.4836352001894, 3147.937041259162, 3150.1022208670647, 3162.8892988745283, 249876.0, 283936.0, 284599.9999999979, 284851.0, 286026.0, 38050.85847424582, 38863.0, 45560.54439455563, 48209.758951205724, 48244.517554824706, 48138.75930620325, 48350.27474587884, 48366.516334836204, 48454.304099356355, 48468.7576562122, 11692.532298707956, 13720.382582783799, 13844.723105538034, 13898.818600419077, 13913.30433478322, 9863.901360986441, 9887.653932112342, 11255.099592032619, 11275.267107638141, 11371.943140284246, 11719.296842189497, 11758.00056995165, 11894.16740828151, 11909.987651049585, 11924.10569207313, 4758.0508178212, 5208.8437346879655, 5237.109691352479, 5266.815661451831, 5289.603279754034, 964.238251781099, 1028.1158203944601, 1050.0864248104199, 1051.9076339994774, 1079.082779637302, 22683.773162268495, 23930.7606923932, 24012.0, 24142.381968921996, 24172.87913560421, 1118.5022664914197, 1123.2530367305812, 1156.976860462803, 1169.8011338072379, 1170.777552265067, 11699.969596227844, 12228.483479383221, 12312.322822244863, 12320.568780092653, 12341.938290308492, 274738.0, 276750.0, 276986.0, 277026.0, 278163.0, 50618.987620248125, 50746.746266268434, 50839.0, 50868.74565627148, 50976.21583244568, 1474.233398632705, 1509.4113295814423, 1515.8408367121515, 1516.7800668902946, 1528.2129703202859, 25521.106761263265, 25778.742212578385, 26502.469950601266, 27460.58809117905, 27614.309642259104, 34901.47647785336, 34916.65083349134, 34959.0, 35012.82493587516, 35027.82486087655, 235102.0, 235406.0, 235653.0, 235977.0, 236631.0, 29939.55090673598, 30145.849270753504, 31323.927889375147, 31958.36083278275, 32074.6792532081, 42207.577924221594, 42971.78514107409, 43044.35433468563, 43107.70676879698, 43179.568204317555, 28553.0, 28998.855005724836, 29408.558871616515, 30424.695753042186, 30561.847190763903, 28541.714582853907, 29446.411071778017, 30160.396792064475, 30401.69598303989, 30641.927532536254, 36028.639713602526, 36248.09379765527, 36272.0, 36288.0, 36350.8182459086, 29350.11949641514, 29701.702982969895, 29811.764117691695, 30609.387812244076, 30734.0, 23662.81685915732, 23729.406764831016, 23818.52362952766, 23908.52182956366, 24104.0], "value": 16940.13329784149, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [386.777602878345, 425.74700130251375, 433.2894053751846, 437.601782378036, 455.97092936432864, 17743.201555929983, 21681.80750058748, 22049.448763780874, 22836.77163228367, 23142.95856686449, 22597.435064123405, 22867.08531658736, 22991.195308164217, 23306.65040024397, 23696.763032369672, 4445.51099379068, 5629.408912064236, 6042.637441753498, 6286.559940804145, 6352.587081839665, 6191.566590338678, 6281.309056003836, 6295.527835412362, 6305.905411418832, 6315.0, 5977.5815692901515, 6114.419130182626, 6186.690665466709, 6188.81433556994, 6193.380661933816, 5964.701764911737, 6061.454469097758, 6172.598781079238, 6214.316425193225, 6233.407826256521, 5456.208849716809, 5461.18082287656, 5466.562674985991, 5478.342598888119, 5479.643823151482, 26962.325941851414, 27408.725912740818, 27426.588601171, 27525.724742752518, 27758.722412776016, 2190.145843121184, 2217.2904670505445, 2236.821054315667, 2239.2386588559966, 2242.035924552442, 15664.0, 16205.189740512928, 16646.58383540409, 17407.825921740747, 17651.558711032198, 2074.7199128117663, 2080.8751474911555, 2125.521757604542, 2128.595566842295, 2161.9351419457444, 111128.0, 130911.34544327218, 132858.0, 134386.0, 135879.32060339733, 9059.68291109808, 9638.843338799248, 11924.463399146885, 12031.759364812655, 12256.509739610494, 12815.359232038361, 15122.790176785831, 16304.67390652204, 16523.586910327336, 16587.91706041486, 8738.30093592511, 8832.407148282857, 8865.246454051477, 9052.27581793455, 9069.410488318239, 7360.9694642750055, 8258.752237432887, 8417.116202798741, 8451.112633173429, 8657.870131948026, 7536.321731044122, 7711.7300894469545, 7726.806829829186, 7731.188225236382, 7732.884006739903, 1863.3571417860817, 2149.871317558263, 2165.6859755335704, 2173.5652869426176, 2195.87922664255, 973.9610415583297, 985.2856678907877, 987.5062468765617, 1000.8949060348705, 1029.315505189041, 21255.36233912985, 21295.68056479154, 21312.467188320417, 21334.893325533274, 21347.46631334198, 933.0016881936263, 1009.4952523738131, 1018.6434747838346, 1034.9896501034893, 1044.9477526123662, 10830.0, 11085.22403431752, 11111.38887361203, 11111.499982500807, 11143.0, 646343.0, 656585.0, 684269.0, 688421.0, 704652.0, 146824.0, 147604.0, 151685.0, 158088.41911580967, 163058.0, 1157.670064031747, 1174.0783484964263, 1203.8796120388067, 1203.9638810835688, 1207.7584483103415, 17790.91104544521, 18155.45533633993, 18196.27214911442, 18317.3588924387, 18589.72115418243, 59641.0, 61392.69303653453, 61441.69279153576, 62542.37457625366, 62868.0, 82716.0, 83708.0, 84125.0, 84541.57729211314, 88200.0, 6724.29394913527, 8863.335249856416, 8905.287576993955, 8926.73219803407, 9043.32175086858, 14189.432422703389, 14323.78514322265, 14336.068155569854, 14604.561863144123, 14659.267036648338, 11484.540618375171, 11623.07015438746, 11742.530298788295, 12032.578859739868, 12086.456109474919, 10877.0, 11308.43457827089, 11312.20814543007, 11561.248518846249, 11608.419579021183, 11922.344271065174, 11924.284542927453, 12105.75788484243, 12182.756344872876, 12205.877941220475, 7943.523388596703, 8873.866891996497, 8885.733427997171, 9041.68354107603, 9088.454692718458, 11511.30932144074, 11768.941155294511, 12000.819987700017, 12200.389980501117, 12238.571649992207], "value": 10463.205684510129, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1347.5957212836147, 1397.7903314502826, 1457.7157454296416, 1484.732748105341, 1488.092263719131, 11429.314241145526, 12110.212836165643, 12124.939375303122, 12130.211536250137, 12133.332666703316, 11695.707607309821, 11703.531858725662, 12022.81965770512, 12091.093168012412, 12119.575814846483, 2503.4993001399703, 2545.0710490670863, 2548.0826902315152, 2555.6933168019773, 2556.5014822109697, 2470.1231062972656, 2483.3915690655726, 2527.9747202527924, 2535.366158460385, 2538.327343254039, 2438.8658623775686, 2539.593665013589, 2539.911103111382, 2541.0471073347494, 2543.5421624107653, 2456.852588844675, 2491.8380305280098, 2496.3883848457153, 2497.650328953948, 2529.3676580854785, 2476.2447453526665, 2502.4995000999875, 2503.7245902950663, 2512.4975004999073, 2513.5726926422553, 11759.88240117605, 12016.218945768585, 12040.759184816343, 12042.69893252667, 12052.758944821142, 6454.32229615893, 6675.265720770712, 6690.83272918176, 6713.127293451869, 6726.697298621574, 4058.472398588194, 4276.337167739005, 4365.934510982338, 4405.163019026375, 4406.118776244732, 1214.4170798017, 1220.9755804883853, 1294.987050129496, 1296.572131196703, 1297.772889744291, 15152.393904243818, 15589.0, 15595.220238988006, 16637.33450661972, 16808.495745127544, 5452.672839629556, 5524.502794748492, 5720.0, 5726.828195154152, 5736.110902810071, 12397.814032789516, 12404.56584019573, 12419.316937568521, 12421.75156496865, 12430.627081187578, 6009.45914867664, 6166.691665416801, 6529.314421985718, 6556.672166391661, 6559.672016399161, 5156.381234251914, 6076.726547305382, 6163.568550201443, 6173.6913154343, 6224.595401298991, 4225.112726327444, 4340.175366680383, 4379.430674012422, 4382.802773875183, 4394.318880573516, 1130.3444002478543, 1290.5741105435184, 1295.598364507006, 1300.3693208793727, 1318.1432069154935, 658.6245839871227, 771.3327971304893, 794.1185284334384, 802.6668932393109, 811.2941740685641, 5173.534381905646, 5682.374938756733, 6300.653464059429, 6350.904736428957, 6988.650567471606, 912.8950170730318, 927.5455027036703, 931.9627214911328, 951.177231694593, 967.56943160293, 4084.203580301872, 4177.895552611149, 4200.537940826506, 4241.766702831313, 4362.454693163355, 12432.0, 14635.707285854436, 15327.463538776312, 15333.386664533295, 15349.0, 14675.41298348054, 15258.542243732483, 15330.540083797503, 15342.0, 15364.692706146037, 10668.94665526683, 10972.615958441416, 10978.231523793258, 10997.0, 11002.724931876766, 5608.439156084522, 6965.164180298397, 7160.498765086394, 7191.964040179766, 7193.064901562763, 13070.516601845618, 13123.34383280813, 13366.532171373956, 13456.5290214842, 13716.0, 12466.688332791753, 13833.861661383256, 13900.860991390362, 14047.929760351133, 14477.420903164177, 9426.62293508252, 9470.621175152917, 9514.38156519824, 9700.563474643517, 9742.95128524353, 10656.62701805433, 10776.191785615953, 10794.460276986276, 10803.027727504563, 10832.025117739442, 9031.593578288861, 9243.953780231055, 9260.49067301305, 9324.300677449082, 9464.95267523658, 9038.864417033881, 9114.498702571422, 9178.173964343241, 9245.907540924774, 9256.398334108262, 8088.757337279891, 8265.256126948603, 8289.95855020721, 8295.087540370434, 8300.501969881827, 4835.854924352275, 5955.493783028491, 6047.667378294236, 6077.513798896166, 6210.913090209105, 4961.454240033521, 5982.970085149546, 6138.723757430837, 6195.19462469876, 6229.657368844757], "value": 5434.046665990866, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [395.825836631882, 403.3647005965605, 405.0602601963444, 411.07713183902143, 412.3381971935044, 5249.055170069386, 5915.757690884914, 5946.226990491241, 5957.6127551709105, 5962.940370596298, 4801.8151740957865, 5414.648047876885, 5560.825586388013, 5651.886962260763, 5835.44563266489, 4432.756198409086, 4434.556544345556, 4466.397036400093, 4466.9329960050545, 4468.039371535119, 4461.353103799947, 4475.216837053519, 4478.955210447886, 4492.797824097907, 4552.317152427129, 3874.9806250968704, 4260.744355338674, 4391.9780401098105, 4400.295952647577, 4452.933206001912, 4174.624283814456, 4403.8238470461465, 4403.9559604404185, 4428.225060614412, 4433.534478879719, 3290.917727056819, 3921.784246883475, 3973.3443981742976, 3985.322495175827, 4001.479437813641, 4755.524447555252, 5601.29983752031, 5622.662640241558, 5725.112607545837, 5742.712864356766, 5280.577553795687, 5287.360918115358, 5297.6821390716295, 5314.681119132864, 5329.7601607927345, 5539.639923404966, 6097.969510152465, 6130.233720784902, 6159.922013647593, 6163.907541386883, 4362.8874636967685, 4478.708883922567, 4495.3931219285305, 4502.347159661864, 4538.251188553884, 6228.5017198624, 6415.8075257741875, 6418.743250269984, 6428.260750013715, 6451.483881289486, 4458.974435879766, 4605.723656580549, 4624.606908412756, 4630.86107416778, 4635.374224479652, 4475.440569928759, 4731.834385796481, 4740.952590474051, 4742.9762851186215, 4750.406199225097, 4867.7322747249245, 5010.5240002199735, 5156.458571849902, 5243.632945693765, 5273.683578985197, 4961.5534601886, 5836.490309167014, 6111.51107911366, 6120.510359171256, 6147.415995480422, 1401.2643362234908, 1464.816897887764, 1584.9128297943494, 1612.7500237463212, 1616.6039320366351, 972.7519482531909, 979.2361957673027, 994.0655783563427, 995.1143482300758, 998.0668075349571, 5424.321959755031, 5475.534579560782, 5483.972580137074, 5793.8841223175305, 5843.298804143445, 5513.58648101386, 5616.500657207585, 6001.5798894077, 6307.810765677037, 6312.968435157794, 4923.704577725348, 5121.692698438031, 5546.389897111315, 5812.564057695689, 5867.2959244890035, 3313.5692359993045, 3336.0325505603587, 3343.414902392072, 3344.0, 3353.614334351532, 5741.311042674905, 6195.256569211723, 6487.740490380426, 6497.870042599122, 6506.544541882117, 5984.760609575568, 6396.307286515005, 6524.902126468107, 6543.901841472381, 6581.934180658132, 5954.315253745788, 6549.4936164682385, 6562.901556476657, 6599.571027883172, 6622.682061278514, 5381.5694744421135, 6184.907226391518, 6205.720742566505, 6438.973682369279, 6475.579087359307, 5310.415854256106, 6355.428011478989, 6374.58565193261, 6382.585131966407, 6384.361563843579, 5955.791547295824, 6140.723667435065, 6291.716872740646, 6514.837129071811, 6650.268470468342, 3645.54430696163, 4283.7001409901, 4316.740995540277, 4334.309619248433, 4339.327404252346, 6051.243594550681, 6331.303556608677, 6444.355564443518, 6451.387118223761, 6491.578047426902, 5467.261919640957, 6099.512039036777, 6207.6585787782105, 6220.253569571681, 6228.844278893064, 6004.309504407049, 6125.621735109565, 6169.619570105276, 6229.626222426669, 6242.781502647385, 5116.641835071509, 5999.430054144849, 6063.757449701962, 6085.869945519033, 6100.267967843887, 6148.907766383597, 6225.0, 6252.968735156295, 6272.905906411499, 6278.434940855345, 5271.736413179402, 5536.640118392453, 6031.979286938925, 6037.849053773691, 6120.7857724981195], "value": 4598.064562394092, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [711.6192836832296, 844.8014716541612, 860.9324437697253, 861.8879545659063, 867.2411639815161, 13244.668883277911, 17667.293308267668, 17867.73198402025, 18338.724919126205, 18363.540911477186, 16827.0, 16932.661346773057, 17224.741628875578, 17331.133443327813, 17341.7398739019, 942.5711301357883, 975.2539307429787, 975.6682727872521, 979.7844474215661, 980.0983095552074, 670.2593634034395, 689.5793565924782, 980.3039841712392, 1010.7473131717071, 1014.6043043213152, 1061.6178175856724, 1065.8614380130573, 1067.6103222323873, 1067.925245232834, 1070.411273799411, 1059.4120263253892, 1060.0512541275555, 1061.9150467962545, 1062.914966802654, 1064.4677661169414, 790.7509134622633, 791.3036527855451, 792.9207079292082, 793.131520984521, 793.6190628498296, 16405.58986025347, 16594.83405165945, 16780.0, 17055.0, 17334.739978900325, 16315.673686526203, 16550.586235344093, 16758.162091895356, 16790.328386864512, 17059.232334544977, 13520.932395338059, 13733.45066197351, 13745.656358591015, 13889.374978126009, 13944.093633913762, 3453.568303962005, 3485.0938755923644, 3486.8779592714386, 3488.5639295088113, 3489.023073539413, 85121.0, 112316.0, 112550.0, 112697.43651281692, 113509.0, 11355.716107097389, 11724.765504689858, 13336.333183340794, 13613.727725445633, 13648.590542283748, 19713.901430492755, 20158.39524814258, 20656.89671551663, 25147.371315716886, 25271.0, 7950.801229969182, 8838.29293656506, 8866.290696744245, 9079.81840363189, 9089.5000774958, 4710.293455981561, 4805.6155507559315, 4806.327114204014, 4808.206645903457, 4812.230043193073, 4263.232618128704, 4264.509581398117, 4319.848805291863, 4384.868453946387, 4386.978065109654, 925.8333499969935, 952.457099453305, 955.1594596754811, 961.2886464016717, 962.0, 647.252423450915, 652.6443088516675, 663.9070530125787, 673.1484671890063, 695.5027155583782, 9790.5594248259, 11609.593664221711, 11742.354170520703, 11752.471138798604, 11904.642860714192, 643.3727116061802, 661.163628010567, 666.6733300682631, 674.5379415100672, 685.6537448588531, 4558.612517935946, 4967.776450059756, 5418.45815418455, 5428.4028756836715, 5498.532624726863, 104026.47986760018, 105867.47066264773, 106119.0, 107192.0, 108001.0, 85451.0, 85508.0, 86158.0, 86740.56629716937, 93029.0, 59148.0, 76165.0, 77631.0, 78520.6073969638, 84772.0, 12118.515704280777, 12593.748125037264, 12625.053121016144, 12670.02493864694, 12733.363331833556, 38646.420303694904, 38768.0, 39644.405333919436, 39780.0, 41215.587844121175, 37970.30445433207, 48983.755081224364, 49417.011659767326, 49679.75160124176, 50555.73610659763, 15741.291641875914, 15998.0, 16243.106629135038, 16972.74540881863, 16999.11888132777, 17932.0, 18095.00477473699, 18096.72854907151, 18605.06974651235, 18728.719069214247, 15449.0, 15456.690866182838, 15562.37750490013, 15609.21953902323, 17153.142342883057, 16455.42406015784, 16803.907745996472, 17035.063071531185, 17092.230849611547, 17300.56748581245, 16184.757228641814, 16568.254428550987, 16579.585510362336, 16825.579360516083, 16897.0, 11642.825357619473, 11715.648530544097, 11894.821577676168, 12020.158588898694, 12098.818517722066, 11405.885941140483, 11772.46970794587, 13091.541796037092, 13124.73750524965, 13142.342882855628], "value": 8279.545402781245, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1586.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 124.0, 124.0, 124.0, 124.0, 122.0, 121.0, 123.0, 125.0, 123.0], "value": 122.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 117.0, 117.0, 160.0, 119.0, 118.0, 119.0, 115.0, 139.0, 137.0], "value": 129.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [213.0, 219.0, 210.0, 211.0, 213.0, 215.0, 211.0, 211.0, 219.0, 210.0], "value": 213.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 62.0, 65.0, 105.0, 66.0, 62.0, 61.0, 67.0, 83.0, 62.0], "value": 72.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 73.0, 97.0, 74.0, 76.0, 75.0, 91.0, 73.0, 75.0, 93.0], "value": 81.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 93.0, 93.0, 94.0, 94.0, 94.0, 95.0, 94.0, 94.0], "value": 93.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 102.0, 106.0, 102.0, 103.0, 102.0, 103.0, 103.0, 103.0, 101.0], "value": 102.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 100.0, 102.0, 100.0, 101.0, 102.0, 101.0, 130.0, 153.0, 101.0], "value": 109.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 52.0, 51.0, 51.0, 53.0, 52.0, 52.0, 53.0, 53.0, 52.0], "value": 52.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 68.0, 69.0, 70.0, 66.0, 62.0, 63.0, 64.0, 65.0, 63.0], "value": 65.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 88.0, 92.0, 91.0, 91.0, 113.0, 104.0, 91.0, 89.0, 91.0], "value": 93.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 153.0, 149.0, 148.0, 150.0, 153.0, 150.0, 152.0, 193.0, 158.0], "value": 155.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [245.0, 243.0, 201.0, 204.0, 203.0, 206.0, 199.0, 203.0, 203.0, 231.0], "value": 213.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 99.0, 100.0, 96.0, 72.0, 72.0, 74.0, 72.0, 71.0, 73.0], "value": 81.5, "unit": "score"}]}]} 17:34:43 INFO - Return code: 0 17:34:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:34:43 ERROR - # TBPL SUCCESS # 17:34:43 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:34:43 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:34:43 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:34:43 INFO - 2017-04-11 17:34:43.923 screenresolution[2302:28328] starting screenresolution argv=screenresolution get 17:34:43 INFO - 2017-04-11 17:34:43.926 screenresolution[2302:28328] Display 0: 1600x1200x32@60 17:34:43 INFO - 2017-04-11 17:34:43.932 screenresolution[2303:28331] starting screenresolution argv=screenresolution list 17:34:43 INFO - Available Modes on Display 0 17:34:43 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:34:43 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:34:43 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:34:43 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:34:44 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:34:44 INFO - Intel Iris: 17:34:44 INFO - Chipset Model: Intel Iris 17:34:44 INFO - Type: GPU 17:34:44 INFO - Bus: Built-In 17:34:44 INFO - VRAM (Dynamic, Max): 1536 MB 17:34:44 INFO - Vendor: Intel (0x8086) 17:34:44 INFO - Device ID: 0x0a2e 17:34:44 INFO - Revision ID: 0x0009 17:34:44 INFO - Displays: 17:34:44 INFO - Display: 17:34:44 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:34:44 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:34:44 INFO - Display Serial Number: 1600x1200 60 17:34:44 INFO - Main Display: Yes 17:34:44 INFO - Mirror: Off 17:34:44 INFO - Online: Yes 17:34:44 INFO - Rotation: Supported 17:34:44 INFO - Return code: 0 17:34:44 INFO - Running post-action listener: _resource_record_post_action 17:34:44 INFO - [mozharness: 2017-04-12 00:34:44.182120Z] Finished run-tests step (success) 17:34:44 INFO - Running post-run listener: _resource_record_post_run 17:34:44 INFO - Total resource usage - Wall time: 1204s; CPU: 54.0%; Read bytes: 303104; Write bytes: 518366208; Read time: 3; Write time: 1648 17:34:44 INFO - TinderboxPrint: CPU usage
53.5% 17:34:44 INFO - TinderboxPrint: I/O read bytes / time
303,104 / 3 17:34:44 INFO - TinderboxPrint: I/O write bytes / time
518,366,208 / 1,648 17:34:44 INFO - TinderboxPrint: CPU idle
2,239.2 (46.5%) 17:34:44 INFO - TinderboxPrint: CPU system
962.4 (20.0%) 17:34:44 INFO - TinderboxPrint: CPU user
1,616.0 (33.5%) 17:34:44 INFO - TinderboxPrint: Swap in / out
207,568,896 / 0 17:34:44 INFO - install - Wall time: 20s; CPU: 55.0%; Read bytes: 205036032; Write bytes: 205613056; Read time: 16012; Write time: 450 17:34:44 INFO - run-tests - Wall time: 1185s; CPU: 53.0%; Read bytes: 262144; Write bytes: 305622016; Read time: 2; Write time: 1167 17:34:44 INFO - Running post-run listener: _upload_blobber_files 17:34:44 INFO - Blob upload gear active. 17:34:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:34: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 17:34: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'] 17:34: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 17:34:45 INFO - (blobuploader) - INFO - Open directory for files ... 17:34:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:34:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:34:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:34:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:34:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:34:45 INFO - (blobuploader) - INFO - Done attempting. 17:34:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:34:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:34:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:34:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:34:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:34:46 INFO - (blobuploader) - INFO - Done attempting. 17:34:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 17:34:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:34:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:34:47 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 17:34:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:34:47 INFO - (blobuploader) - INFO - Done attempting. 17:34:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:34:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:34:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:34:49 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:34:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:34:49 INFO - (blobuploader) - INFO - Done attempting. 17:34:49 INFO - (blobuploader) - INFO - Iteration through files over. 17:34:49 INFO - Return code: 0 17:34:49 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:34:49 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:34:49 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/6c010bda7d5d759974e36445ea7b8b847c93764fbfe132a6bf9f11feb93cbee33117b2f10a6d26f8cc35b56f7a2c8f688b4c06582641408e421500d28ea44520", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/3e6cab961052bbe7e978613252914568792643b1c8787cb40a4430d52b481cb609ab67458716e81a2c424eee901725ec691509384a18e65173da53bcbc4915f5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/0d3e3cb77911d31b654406d186d74dfa598f5e361d6e8afc5238a4885ad78f8c1724bb49fd7e0994fb7c193ab25fdf8f0a8a2d6ffb5e7386f0793111f0958aa3", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/f8f901de57c43140964a5ecb29d478c2610290bb112977d4fd59a62b31bb8c0820f2687b9f0b849ffa076a718c4753b3d1f555785cba28ed6ec37aeecb9ef16d"} 17:34:49 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:34:49 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:34:49 INFO - Contents: 17:34:49 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/6c010bda7d5d759974e36445ea7b8b847c93764fbfe132a6bf9f11feb93cbee33117b2f10a6d26f8cc35b56f7a2c8f688b4c06582641408e421500d28ea44520", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/3e6cab961052bbe7e978613252914568792643b1c8787cb40a4430d52b481cb609ab67458716e81a2c424eee901725ec691509384a18e65173da53bcbc4915f5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/0d3e3cb77911d31b654406d186d74dfa598f5e361d6e8afc5238a4885ad78f8c1724bb49fd7e0994fb7c193ab25fdf8f0a8a2d6ffb5e7386f0793111f0958aa3", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/f8f901de57c43140964a5ecb29d478c2610290bb112977d4fd59a62b31bb8c0820f2687b9f0b849ffa076a718c4753b3d1f555785cba28ed6ec37aeecb9ef16d"} 17:34:49 INFO - Running post-run listener: copy_logs_to_upload_dir 17:34:49 INFO - Copying logs to upload dir... 17:34:49 INFO - mkdir: /builds/slave/test/build/upload/logs 17:34:49 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1286.674714 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2017-04-11 17:34:49.907365) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-11 17:34:49.910885) ========= 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.OfOprDCk9d/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.qLbDYbCGBH/Listeners TMPDIR=/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/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/6c010bda7d5d759974e36445ea7b8b847c93764fbfe132a6bf9f11feb93cbee33117b2f10a6d26f8cc35b56f7a2c8f688b4c06582641408e421500d28ea44520", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/3e6cab961052bbe7e978613252914568792643b1c8787cb40a4430d52b481cb609ab67458716e81a2c424eee901725ec691509384a18e65173da53bcbc4915f5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/0d3e3cb77911d31b654406d186d74dfa598f5e361d6e8afc5238a4885ad78f8c1724bb49fd7e0994fb7c193ab25fdf8f0a8a2d6ffb5e7386f0793111f0958aa3", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/f8f901de57c43140964a5ecb29d478c2610290bb112977d4fd59a62b31bb8c0820f2687b9f0b849ffa076a718c4753b3d1f555785cba28ed6ec37aeecb9ef16d"} build_url:https://queue.taskcluster.net/v1/task/Aem_OVofRHSs4hlCu-s-2A/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011038 build_url: 'https://queue.taskcluster.net/v1/task/Aem_OVofRHSs4hlCu-s-2A/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/6c010bda7d5d759974e36445ea7b8b847c93764fbfe132a6bf9f11feb93cbee33117b2f10a6d26f8cc35b56f7a2c8f688b4c06582641408e421500d28ea44520", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/3e6cab961052bbe7e978613252914568792643b1c8787cb40a4430d52b481cb609ab67458716e81a2c424eee901725ec691509384a18e65173da53bcbc4915f5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/0d3e3cb77911d31b654406d186d74dfa598f5e361d6e8afc5238a4885ad78f8c1724bb49fd7e0994fb7c193ab25fdf8f0a8a2d6ffb5e7386f0793111f0958aa3", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/f8f901de57c43140964a5ecb29d478c2610290bb112977d4fd59a62b31bb8c0820f2687b9f0b849ffa076a718c4753b3d1f555785cba28ed6ec37aeecb9ef16d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-11 17:34:49.945508) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-11 17:34:49.945827) ========= 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.OfOprDCk9d/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.qLbDYbCGBH/Listeners TMPDIR=/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/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.005318 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-11 17:34:49.994408) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-11 17:34:49.994727) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-11 17:34:49.995052) ========= ========= Total master_lag: 0.18 =========