builder: pine_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0029 starttime: 1492822577.28 results: success (0) buildid: 20170421151719 builduid: 307d785614ac456a8655988a8892ce9c revision: 73d3f203c63c5aec21b15d10e36783c592c18d13 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-21 17:56:17.276122) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-21 17:56:17.276581) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-21 17:56:17.276866) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-21 17:56:17.318984) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-21 17:56:17.319398) ========= 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.k9f9pv0C3m/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.jAaQXqMjbz/Listeners TMPDIR=/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/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-21 17:56:17-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 166M=0s 2017-04-21 17:56:17 (166 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.085593 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-21 17:56:17.430364) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-21 17:56:17.430683) ========= 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.k9f9pv0C3m/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.jAaQXqMjbz/Listeners TMPDIR=/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/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.029391 ========= master_lag: 0.30 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-21 17:56:17.763120) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-21 17:56:17.763617) ========= bash -c 'python archiver_client.py mozharness --repo projects/pine --rev 73d3f203c63c5aec21b15d10e36783c592c18d13 --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 73d3f203c63c5aec21b15d10e36783c592c18d13 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.k9f9pv0C3m/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.jAaQXqMjbz/Listeners TMPDIR=/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/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-21 17:56:17,867 truncating revision to first 12 chars 2017-04-21 17:56:17,867 Setting DEBUG logging. 2017-04-21 17:56:17,868 attempt 1/10 2017-04-21 17:56:17,868 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/pine/73d3f203c63c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-21 17:56:18,945 unpacking tar archive at: pine-73d3f203c63c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.348899 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-21 17:56:19.137854) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-21 17:56:19.138220) ========= script_repo_revision: 73d3f203c63c5aec21b15d10e36783c592c18d13 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-21 17:56:19.138803) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-21 17:56:19.139167) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-21 17:56:19.160486) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 27 secs) (at 2017-04-21 17:56:19.161084) ========= /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.k9f9pv0C3m/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.jAaQXqMjbz/Listeners TMPDIR=/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/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:56:19 INFO - MultiFileLogger online at 20170421 17:56:19 in /builds/slave/test 17:56:19 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:56:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:56:19 INFO - {'append_to_log': False, 17:56:19 INFO - 'base_work_dir': '/builds/slave/test', 17:56:19 INFO - 'blob_upload_branch': 'Pine', 17:56:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:56:19 INFO - 'branch': 'Pine', 17:56:19 INFO - 'buildbot_json_path': 'buildprops.json', 17:56:19 INFO - 'config_files': ('talos/mac_config.py',), 17:56:19 INFO - 'default_actions': ('clobber', 17:56:19 INFO - 'read-buildbot-config', 17:56:19 INFO - 'download-and-extract', 17:56:19 INFO - 'populate-webroot', 17:56:19 INFO - 'create-virtualenv', 17:56:19 INFO - 'install', 17:56:19 INFO - 'run-tests'), 17:56:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:56:19 INFO - 'download_minidump_stackwalk': True, 17:56:19 INFO - 'download_symbols': 'ondemand', 17:56:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:56:19 INFO - 'tooltool.py': '/tools/tooltool.py', 17:56:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:56:19 INFO - '/tools/misc-python/virtualenv.py')}, 17:56:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:56:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:56:19 INFO - 'gecko_profile': False, 17:56:19 INFO - 'gecko_profile_interval': 0, 17:56:19 INFO - 'installer_path': 'installer.exe', 17:56:19 INFO - 'log_level': 'info', 17:56:19 INFO - 'log_name': 'talos', 17:56:19 INFO - 'log_to_console': True, 17:56:19 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 17:56:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 17:56:19 INFO - 'opt_config_files': (), 17:56:19 INFO - 'pip_index': False, 17:56:19 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:56:19 INFO - 'cmd': ('bash', 17:56:19 INFO - '-c', 17:56:19 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:56:19 INFO - 'enabled': True, 17:56:19 INFO - 'halt_on_failure': False, 17:56:19 INFO - 'name': 'check_screen_resolution'},), 17:56:19 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:56:19 INFO - 'cmd': ('bash', 17:56:19 INFO - '-c', 17:56:19 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:56:19 INFO - 'enabled': True, 17:56:19 INFO - 'halt_on_failure': False, 17:56:19 INFO - 'name': 'check_screen_resolution'},), 17:56:19 INFO - 'run_cmd_checks_enabled': True, 17:56:19 INFO - 'suite': 'dromaeojs', 17:56:19 INFO - 'system_bits': '32', 17:56:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:56:19 INFO - 'title': 't-yosemite-r7-0029', 17:56:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:56:19 INFO - 'use_talos_json': True, 17:56:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:56:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:56:19 INFO - 'work_dir': 'build'} 17:56:19 INFO - [mozharness: 2017-04-22 00:56:19.377535Z] Running clobber step. 17:56:19 INFO - Running pre-action listener: _resource_record_pre_action 17:56:19 INFO - Running main action method: clobber 17:56:19 INFO - rmtree: /builds/slave/test/build 17:56:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:56:21 INFO - Running post-action listener: _resource_record_post_action 17:56:21 INFO - [mozharness: 2017-04-22 00:56:21.978103Z] Finished clobber step (success) 17:56:21 INFO - [mozharness: 2017-04-22 00:56:21.978280Z] Running read-buildbot-config step. 17:56:21 INFO - Running pre-action listener: _resource_record_pre_action 17:56:21 INFO - Running main action method: read_buildbot_config 17:56:21 INFO - Using buildbot properties: 17:56:21 INFO - { 17:56:21 INFO - "project": "", 17:56:21 INFO - "product": "firefox", 17:56:21 INFO - "script_repo_revision": "default", 17:56:21 INFO - "builddir": "pine_yosemite_r7_test-dromaeojs", 17:56:21 INFO - "repository": "", 17:56:21 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 pine talos dromaeojs", 17:56:21 INFO - "buildid": "20170421151719", 17:56:21 INFO - "pgo_build": "False", 17:56:21 INFO - "basedir": "/builds/slave/test", 17:56:21 INFO - "buildnumber": 2, 17:56:21 INFO - "slavename": "t-yosemite-r7-0029", 17:56:21 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 17:56:21 INFO - "platform": "yosemite_r7", 17:56:21 INFO - "scheduler": "tests-pine-macosx64-talos", 17:56:21 INFO - "branch": "pine", 17:56:21 INFO - "repo_path": "projects/pine", 17:56:21 INFO - "revision": "73d3f203c63c5aec21b15d10e36783c592c18d13", 17:56:21 INFO - "stage_platform": "macosx64", 17:56:21 INFO - "builduid": "307d785614ac456a8655988a8892ce9c", 17:56:21 INFO - "slavebuilddir": "test" 17:56:21 INFO - } 17:56:21 INFO - Found installer url https://queue.taskcluster.net/v1/task/QAPOB5PRRoOcPDxZAQEj9w/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 17:56:21 INFO - Running post-action listener: _resource_record_post_action 17:56:21 INFO - [mozharness: 2017-04-22 00:56:21.981614Z] Finished read-buildbot-config step (success) 17:56:21 INFO - [mozharness: 2017-04-22 00:56:21.981751Z] Running download-and-extract step. 17:56:21 INFO - Running pre-action listener: _resource_record_pre_action 17:56:21 INFO - Running main action method: download_and_extract 17:56:21 INFO - mkdir: /builds/slave/test/build/tests 17:56:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:56:21 INFO - trying https://queue.taskcluster.net/v1/task/QAPOB5PRRoOcPDxZAQEj9w/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 17:56:21 INFO - Downloading https://queue.taskcluster.net/v1/task/QAPOB5PRRoOcPDxZAQEj9w/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:56:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QAPOB5PRRoOcPDxZAQEj9w/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:56:23 INFO - Downloaded 1325 bytes. 17:56:23 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 17:56:23 INFO - Using the following test package requirements: 17:56:23 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:56:23 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 17:56:23 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 17:56:23 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:56:23 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 17:56:23 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:56:23 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 17:56:23 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:56:23 INFO - u'jsshell-mac.zip'], 17:56:23 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:56:23 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 17:56:23 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 17:56:23 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:56:23 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 17:56:23 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:56:23 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 17:56:23 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:56:23 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 17:56:23 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:56:23 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 17:56:23 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 17:56:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QAPOB5PRRoOcPDxZAQEj9w/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 17:56:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QAPOB5PRRoOcPDxZAQEj9w/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 17:56:23 INFO - Fetch https://queue.taskcluster.net/v1/task/QAPOB5PRRoOcPDxZAQEj9w/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 17:56:24 INFO - Content-Length response header: 52526372 17:56:24 INFO - Bytes received: 52526372 17:56:41 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:56:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QAPOB5PRRoOcPDxZAQEj9w/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 17:56:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QAPOB5PRRoOcPDxZAQEj9w/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 17:56:41 INFO - Fetch https://queue.taskcluster.net/v1/task/QAPOB5PRRoOcPDxZAQEj9w/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 17:56:43 INFO - Content-Length response header: 52526372 17:56:43 INFO - Bytes received: 52526372 17:56:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QAPOB5PRRoOcPDxZAQEj9w/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 17:56:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QAPOB5PRRoOcPDxZAQEj9w/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 17:56:58 INFO - Fetch https://queue.taskcluster.net/v1/task/QAPOB5PRRoOcPDxZAQEj9w/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 17:57:00 INFO - Content-Length response header: 14408811 17:57:00 INFO - Bytes received: 14408811 17:57:01 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:57:01 INFO - trying https://queue.taskcluster.net/v1/task/QAPOB5PRRoOcPDxZAQEj9w/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 17:57:01 INFO - Downloading https://queue.taskcluster.net/v1/task/QAPOB5PRRoOcPDxZAQEj9w/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 17:57:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QAPOB5PRRoOcPDxZAQEj9w/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:57:03 INFO - Downloaded 71108496 bytes. 17:57:03 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QAPOB5PRRoOcPDxZAQEj9w/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 17:57:03 INFO - mkdir: /builds/slave/test/properties 17:57:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:57:03 INFO - Writing to file /builds/slave/test/properties/build_url 17:57:03 INFO - Contents: 17:57:03 INFO - build_url:https://queue.taskcluster.net/v1/task/QAPOB5PRRoOcPDxZAQEj9w/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 17:57:03 INFO - Running post-action listener: _resource_record_post_action 17:57:03 INFO - Running post-action listener: set_extra_try_arguments 17:57:03 INFO - [mozharness: 2017-04-22 00:57:03.836514Z] Finished download-and-extract step (success) 17:57:03 INFO - [mozharness: 2017-04-22 00:57:03.836642Z] Running populate-webroot step. 17:57:03 INFO - Running pre-action listener: _resource_record_pre_action 17:57:03 INFO - Running main action method: populate_webroot 17:57:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:57:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:57:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:57:03 INFO - '--tppagecycles', 17:57:03 INFO - '7'], 17:57:03 INFO - 'tests': ['tsvgm']}}, 17:57:03 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:57:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:57:03 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:57:03 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:57:03 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:57:03 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:57:03 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 17:57:03 INFO - 'talos_options': ['--disable-e10s'], 17:57:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:57:03 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 17:57:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:57:03 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 17:57:03 INFO - 'talos_options': ['--disable-e10s'], 17:57:03 INFO - 'tests': ['damp', 'tps']}, 17:57:03 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 17:57:03 INFO - 'tests': ['damp', 'tps']}, 17:57:03 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:57:03 INFO - 'tests': ['dromaeo_dom']}, 17:57:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:57:03 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:57:03 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 17:57:03 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 17:57:03 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:57:03 INFO - 'tests': ['a11yr', 17:57:03 INFO - 'ts_paint', 17:57:03 INFO - 'tpaint', 17:57:03 INFO - 'sessionrestore', 17:57:03 INFO - 'sessionrestore_no_auto_restore', 17:57:03 INFO - 'tabpaint']}, 17:57:03 INFO - 'other-e10s': {'tests': ['a11yr', 17:57:03 INFO - 'ts_paint', 17:57:03 INFO - 'tpaint', 17:57:03 INFO - 'sessionrestore', 17:57:03 INFO - 'sessionrestore_no_auto_restore', 17:57:03 INFO - 'tabpaint']}, 17:57:03 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:57:03 INFO - 'ts_paint', 17:57:03 INFO - 'tpaint', 17:57:03 INFO - 'sessionrestore', 17:57:03 INFO - 'sessionrestore_no_auto_restore', 17:57:03 INFO - 'tabpaint']}, 17:57:03 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:57:03 INFO - 'ts_paint', 17:57:03 INFO - 'tpaint', 17:57:03 INFO - 'sessionrestore', 17:57:03 INFO - 'sessionrestore_no_auto_restore', 17:57:03 INFO - 'tabpaint']}, 17:57:03 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:57:03 INFO - 'tests': ['a11yr', 17:57:03 INFO - 'ts_paint', 17:57:03 INFO - 'tpaint', 17:57:03 INFO - 'sessionrestore', 17:57:03 INFO - 'sessionrestore_no_auto_restore', 17:57:03 INFO - 'tabpaint']}, 17:57:03 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:57:03 INFO - 'tests': ['a11yr', 17:57:03 INFO - 'ts_paint', 17:57:03 INFO - 'tpaint', 17:57:03 INFO - 'sessionrestore', 17:57:03 INFO - 'sessionrestore_no_auto_restore', 17:57:03 INFO - 'tabpaint']}, 17:57:03 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 17:57:03 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 17:57:03 INFO - 'bloom_basic_ref']}, 17:57:03 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:57:03 INFO - 'tests': ['tsvgx', 17:57:03 INFO - 'tsvgr_opacity', 17:57:03 INFO - 'tart', 17:57:03 INFO - 'tscrollx', 17:57:03 INFO - 'cart', 17:57:03 INFO - 'tsvg_static']}, 17:57:03 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:57:03 INFO - 'tsvgr_opacity', 17:57:03 INFO - 'tart', 17:57:03 INFO - 'tscrollx', 17:57:03 INFO - 'cart', 17:57:03 INFO - 'tsvg_static']}, 17:57:03 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 17:57:03 INFO - 'talos_options': ['--disable-e10s'], 17:57:03 INFO - 'tests': ['tp5o']}, 17:57:03 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 17:57:03 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 17:57:03 INFO - 'talos_options': ['--disable-e10s', 17:57:03 INFO - '--xperf_path', 17:57:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:57:03 INFO - 'tests': ['tp5n']}, 17:57:03 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 17:57:03 INFO - 'talos_options': ['--xperf_path', 17:57:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:57:03 INFO - 'tests': ['tp5n']}}, 17:57:03 INFO - 'talos.zip': {'path': '', 17:57:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:57:03 INFO - Running post-action listener: _resource_record_post_action 17:57:03 INFO - [mozharness: 2017-04-22 00:57:03.855999Z] Finished populate-webroot step (success) 17:57:03 INFO - [mozharness: 2017-04-22 00:57:03.856132Z] Running create-virtualenv step. 17:57:03 INFO - Running pre-action listener: _resource_record_pre_action 17:57:03 INFO - Running main action method: create_virtualenv 17:57:03 INFO - Creating virtualenv /builds/slave/test/build/venv 17:57:03 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:57:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:57:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:57:03 INFO - Using real prefix '/tools/python27' 17:57:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:57:04 INFO - Installing distribute.............................................................................................................................................................................................done. 17:57:07 INFO - Installing pip.................done. 17:57:07 INFO - Return code: 0 17:57:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 17:57:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 17:57:07 INFO - Reading from file tmpfile_stdout 17:57:07 INFO - Output received: 17:57:07 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:57:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:57:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:57:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:57:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:57:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:57:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:57:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:57:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109d84b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d87768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae8b4b4090>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b62d30>, '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 0x109a88db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109b57be8>, '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.k9f9pv0C3m/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.jAaQXqMjbz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/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:57:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 17:57:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:57:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.k9f9pv0C3m/Render', 17:57:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:57:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:57:07 INFO - 'HOME': '/Users/cltbld', 17:57:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:57:07 INFO - 'LOGNAME': 'cltbld', 17:57:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:57:07 INFO - 'MOZ_NO_REMOTE': '1', 17:57:07 INFO - 'NO_EM_RESTART': '1', 17:57:07 INFO - 'PAGER': '/bin/cat', 17:57:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:57:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:57:07 INFO - 'PWD': '/builds/slave/test', 17:57:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:57:07 INFO - 'SHELL': '/bin/bash', 17:57:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jAaQXqMjbz/Listeners', 17:57:07 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 17:57:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:57:07 INFO - 'USER': 'cltbld', 17:57:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:57:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:57:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:57:07 INFO - 'XPC_FLAGS': '0x0', 17:57:07 INFO - 'XPC_SERVICE_NAME': '0', 17:57:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:57:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:57:08 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:57:08 INFO - Cleaning up... 17:57:08 INFO - Return code: 0 17:57:08 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:57:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:57:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:57:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:57:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:57:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:57:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:57:08 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 0x109d84b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d87768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae8b4b4090>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b62d30>, '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 0x109a88db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109b57be8>, '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.k9f9pv0C3m/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.jAaQXqMjbz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/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:57:08 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:57:08 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:57:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.k9f9pv0C3m/Render', 17:57:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:57:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:57:08 INFO - 'HOME': '/Users/cltbld', 17:57:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:57:08 INFO - 'LOGNAME': 'cltbld', 17:57:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:57:08 INFO - 'MOZ_NO_REMOTE': '1', 17:57:08 INFO - 'NO_EM_RESTART': '1', 17:57:08 INFO - 'PAGER': '/bin/cat', 17:57:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:57:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:57:08 INFO - 'PWD': '/builds/slave/test', 17:57:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:57:08 INFO - 'SHELL': '/bin/bash', 17:57:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jAaQXqMjbz/Listeners', 17:57:08 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 17:57:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:57:08 INFO - 'USER': 'cltbld', 17:57:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:57:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:57:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:57:08 INFO - 'XPC_FLAGS': '0x0', 17:57:08 INFO - 'XPC_SERVICE_NAME': '0', 17:57:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:57:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:57:09 INFO - Downloading/unpacking psutil>=3.1.1 17:57:09 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:57:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:57:09 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:57:09 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:57:09 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:57:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:57:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:57:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:57:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:57:13 INFO - Installing collected packages: psutil 17:57:13 INFO - Running setup.py install for psutil 17:57:13 INFO - building 'psutil._psutil_osx' extension 17:57:13 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:57:13 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:57:13 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:57:14 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:57:14 INFO - building 'psutil._psutil_posix' extension 17:57:14 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:57:14 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 17:57:14 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 17:57:14 INFO - ^ 17:57:14 INFO - 1 warning generated. 17:57:14 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:57:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:57:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:57:14 INFO - Successfully installed psutil 17:57:14 INFO - Cleaning up... 17:57:14 INFO - Return code: 0 17:57:14 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:57:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:57:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:57:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:57:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:57:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:57:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:57:14 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 0x109d84b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d87768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae8b4b4090>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b62d30>, '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 0x109a88db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109b57be8>, '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.k9f9pv0C3m/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.jAaQXqMjbz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/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:57:14 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:57:14 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:57:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.k9f9pv0C3m/Render', 17:57:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:57:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:57:14 INFO - 'HOME': '/Users/cltbld', 17:57:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:57:14 INFO - 'LOGNAME': 'cltbld', 17:57:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:57:14 INFO - 'MOZ_NO_REMOTE': '1', 17:57:14 INFO - 'NO_EM_RESTART': '1', 17:57:14 INFO - 'PAGER': '/bin/cat', 17:57:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:57:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:57:14 INFO - 'PWD': '/builds/slave/test', 17:57:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:57:14 INFO - 'SHELL': '/bin/bash', 17:57:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jAaQXqMjbz/Listeners', 17:57:14 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 17:57:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:57:14 INFO - 'USER': 'cltbld', 17:57:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:57:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:57:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:57:14 INFO - 'XPC_FLAGS': '0x0', 17:57:14 INFO - 'XPC_SERVICE_NAME': '0', 17:57:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:57:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:57:15 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:57: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:57: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:57: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:57: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:57: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:57: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:57:17 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:57:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:57:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:57:17 INFO - Installing collected packages: mozsystemmonitor 17:57:17 INFO - Running setup.py install for mozsystemmonitor 17:57:17 INFO - Successfully installed mozsystemmonitor 17:57:17 INFO - Cleaning up... 17:57:18 INFO - Return code: 0 17:57:18 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:57: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:57:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:57:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:57: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:57:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:57:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:57:18 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 0x109d84b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d87768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae8b4b4090>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b62d30>, '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 0x109a88db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109b57be8>, '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.k9f9pv0C3m/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.jAaQXqMjbz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/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:57:18 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:57:18 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:57:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.k9f9pv0C3m/Render', 17:57:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:57:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:57:18 INFO - 'HOME': '/Users/cltbld', 17:57:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:57:18 INFO - 'LOGNAME': 'cltbld', 17:57:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:57:18 INFO - 'MOZ_NO_REMOTE': '1', 17:57:18 INFO - 'NO_EM_RESTART': '1', 17:57:18 INFO - 'PAGER': '/bin/cat', 17:57:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:57:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:57:18 INFO - 'PWD': '/builds/slave/test', 17:57:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:57:18 INFO - 'SHELL': '/bin/bash', 17:57:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jAaQXqMjbz/Listeners', 17:57:18 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 17:57:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:57:18 INFO - 'USER': 'cltbld', 17:57:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:57:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:57:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:57:18 INFO - 'XPC_FLAGS': '0x0', 17:57:18 INFO - 'XPC_SERVICE_NAME': '0', 17:57:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:57:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:57:18 INFO - Downloading/unpacking jsonschema==2.5.1 17:57:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:57:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:57:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:57:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:57:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:57:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:57:20 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:57:20 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:57:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:57:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:57:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:57:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:57:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:57:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:57:21 INFO - Downloading functools32-3.2.3-2.tar.gz 17:57:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:57:21 INFO - warning: no files found matching '*.txt' 17:57:21 INFO - no previously-included directories found matching 'build' 17:57:21 INFO - no previously-included directories found matching 'dist' 17:57:21 INFO - no previously-included directories found matching '.git*' 17:57:21 INFO - Installing collected packages: jsonschema, functools32 17:57:21 INFO - Running setup.py install for functools32 17:57:21 INFO - warning: no files found matching '*.txt' 17:57:21 INFO - no previously-included directories found matching 'build' 17:57:21 INFO - no previously-included directories found matching 'dist' 17:57:21 INFO - no previously-included directories found matching '.git*' 17:57:21 INFO - Successfully installed jsonschema functools32 17:57:21 INFO - Cleaning up... 17:57:21 INFO - Return code: 0 17:57:21 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:57:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:57:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:57:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:57:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:57:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:57:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:57:21 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 0x109d84b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d87768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae8b4b4090>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b62d30>, '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 0x109a88db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109b57be8>, '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.k9f9pv0C3m/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.jAaQXqMjbz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/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:57:21 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:57:21 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:57:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.k9f9pv0C3m/Render', 17:57:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:57:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:57:21 INFO - 'HOME': '/Users/cltbld', 17:57:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:57:21 INFO - 'LOGNAME': 'cltbld', 17:57:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:57:21 INFO - 'MOZ_NO_REMOTE': '1', 17:57:21 INFO - 'NO_EM_RESTART': '1', 17:57:21 INFO - 'PAGER': '/bin/cat', 17:57:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:57:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:57:21 INFO - 'PWD': '/builds/slave/test', 17:57:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:57:21 INFO - 'SHELL': '/bin/bash', 17:57:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jAaQXqMjbz/Listeners', 17:57:21 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 17:57:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:57:21 INFO - 'USER': 'cltbld', 17:57:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:57:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:57:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:57:21 INFO - 'XPC_FLAGS': '0x0', 17:57:21 INFO - 'XPC_SERVICE_NAME': '0', 17:57:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:57:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:57:21 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:57:21 INFO - Cleaning up... 17:57:21 INFO - Return code: 0 17:57:21 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:57:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:57:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:57:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:57:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:57:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:57:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:57:21 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 0x109d84b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d87768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae8b4b4090>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b62d30>, '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 0x109a88db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109b57be8>, '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.k9f9pv0C3m/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.jAaQXqMjbz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/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:57:21 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:57:21 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:57:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.k9f9pv0C3m/Render', 17:57:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:57:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:57:21 INFO - 'HOME': '/Users/cltbld', 17:57:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:57:21 INFO - 'LOGNAME': 'cltbld', 17:57:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:57:21 INFO - 'MOZ_NO_REMOTE': '1', 17:57:21 INFO - 'NO_EM_RESTART': '1', 17:57:21 INFO - 'PAGER': '/bin/cat', 17:57:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:57:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:57:21 INFO - 'PWD': '/builds/slave/test', 17:57:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:57:21 INFO - 'SHELL': '/bin/bash', 17:57:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jAaQXqMjbz/Listeners', 17:57:21 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 17:57:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:57:21 INFO - 'USER': 'cltbld', 17:57:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:57:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:57:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:57:21 INFO - 'XPC_FLAGS': '0x0', 17:57:21 INFO - 'XPC_SERVICE_NAME': '0', 17:57:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:57:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:57:22 INFO - Downloading/unpacking blobuploader==1.2.4 17:57: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:57: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:57: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:57: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:57: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:57: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:57:24 INFO - Downloading blobuploader-1.2.4.tar.gz 17:57:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:57:24 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:57: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:57: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:57: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:57: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:57: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:57: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:57:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:57:25 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:57:25 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:57:25 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:57:25 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:57:25 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:57:25 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:57:25 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:57:25 INFO - Downloading docopt-0.6.1.tar.gz 17:57:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:57:26 INFO - Installing collected packages: blobuploader, requests, docopt 17:57:26 INFO - Running setup.py install for blobuploader 17:57:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:57:26 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:57:26 INFO - Running setup.py install for requests 17:57:26 INFO - Running setup.py install for docopt 17:57:26 INFO - Successfully installed blobuploader requests docopt 17:57:26 INFO - Cleaning up... 17:57:27 INFO - Return code: 0 17:57:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:57:27 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:57:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:57:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:57:27 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:57:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:57:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:57:27 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 0x109d84b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d87768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae8b4b4090>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b62d30>, '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 0x109a88db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109b57be8>, '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.k9f9pv0C3m/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.jAaQXqMjbz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/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:57:27 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:57:27 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:57:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.k9f9pv0C3m/Render', 17:57:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:57:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:57:27 INFO - 'HOME': '/Users/cltbld', 17:57:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:57:27 INFO - 'LOGNAME': 'cltbld', 17:57:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:57:27 INFO - 'MOZ_NO_REMOTE': '1', 17:57:27 INFO - 'NO_EM_RESTART': '1', 17:57:27 INFO - 'PAGER': '/bin/cat', 17:57:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:57:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:57:27 INFO - 'PWD': '/builds/slave/test', 17:57:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:57:27 INFO - 'SHELL': '/bin/bash', 17:57:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jAaQXqMjbz/Listeners', 17:57:27 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 17:57:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:57:27 INFO - 'USER': 'cltbld', 17:57:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:57:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:57:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:57:27 INFO - 'XPC_FLAGS': '0x0', 17:57:27 INFO - 'XPC_SERVICE_NAME': '0', 17:57:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:57:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:57:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:57:27 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-CkykPP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:57:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:57:27 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-lfJ1_n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:57:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:57:27 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-X1kuB4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:57:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:57:27 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-hjeOfq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:57:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:57:27 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-to5bib-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:57:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:57:27 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-Y2kzoC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:57:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:57:27 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-s4PvkB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:57:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:57:28 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-Q7xEAG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:57:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:57:28 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-70lRNF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:57:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:57:28 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-ctwmNL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:57:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:57:28 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-YORn2S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:57:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:57:28 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-aJM2oN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:57:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:57:28 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-B3V8Ui-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:57:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:57:28 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-kIK32S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:57:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:57:28 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-hTed9C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:57:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:57:28 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-mqNnHi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:57:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:57:28 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-LNx7ZQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:57:29 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:57:29 INFO - Running setup.py install for manifestparser 17:57:29 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:57:29 INFO - Running setup.py install for mozcrash 17:57:29 INFO - Running setup.py install for mozdebug 17:57:29 INFO - Running setup.py install for mozdevice 17:57:29 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:57:29 INFO - Running setup.py install for mozfile 17:57:29 INFO - Running setup.py install for mozhttpd 17:57:29 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:57:29 INFO - Running setup.py install for mozinfo 17:57:30 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:57:30 INFO - Running setup.py install for mozInstall 17:57:30 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:57:30 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:57:30 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:57:30 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:57:30 INFO - Running setup.py install for mozleak 17:57:30 INFO - Running setup.py install for mozlog 17:57:30 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:57:30 INFO - Running setup.py install for moznetwork 17:57:30 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:57:30 INFO - Running setup.py install for mozprocess 17:57:30 INFO - Running setup.py install for mozprofile 17:57:31 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:57:31 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:57:31 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:57:31 INFO - Running setup.py install for mozrunner 17:57:31 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:57:31 INFO - Running setup.py install for mozscreenshot 17:57:31 INFO - Running setup.py install for moztest 17:57:31 INFO - Running setup.py install for mozversion 17:57:31 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:57:31 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:57:31 INFO - Cleaning up... 17:57:31 INFO - Return code: 0 17:57:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:57:31 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:57:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:57:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:57:31 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:57:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:57:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:57:31 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 0x109d84b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d87768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae8b4b4090>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b62d30>, '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 0x109a88db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109b57be8>, '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.k9f9pv0C3m/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.jAaQXqMjbz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/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:57:31 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:57:31 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:57:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.k9f9pv0C3m/Render', 17:57:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:57:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:57:31 INFO - 'HOME': '/Users/cltbld', 17:57:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:57:31 INFO - 'LOGNAME': 'cltbld', 17:57:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:57:31 INFO - 'MOZ_NO_REMOTE': '1', 17:57:31 INFO - 'NO_EM_RESTART': '1', 17:57:31 INFO - 'PAGER': '/bin/cat', 17:57:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:57:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:57:31 INFO - 'PWD': '/builds/slave/test', 17:57:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:57:31 INFO - 'SHELL': '/bin/bash', 17:57:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jAaQXqMjbz/Listeners', 17:57:31 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 17:57:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:57:31 INFO - 'USER': 'cltbld', 17:57:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:57:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:57:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:57:31 INFO - 'XPC_FLAGS': '0x0', 17:57:31 INFO - 'XPC_SERVICE_NAME': '0', 17:57:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:57:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:57:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:57:31 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-VWMslI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:57:32 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:57:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:57:32 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-Olv_qd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:57:32 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:57:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:57:32 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-VS3lVh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:57:32 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:57:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:57:32 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-tk7HjV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:57:32 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:57:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:57:32 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-MzzMyj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:57:32 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:57:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:57:32 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-HXYdRY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:57:32 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:57:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:57:32 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-kulmKN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:57:32 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:57:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:57:32 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-z4j5pT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:57:32 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:57:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:57:32 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-F_WwtH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:57:32 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:57:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:57:32 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-dTLE3U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:57:33 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:57:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:57:33 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-ssl1Gw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:57:33 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:57:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:57:33 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-xnG6pI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:57:33 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:57:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:57:33 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-5BmxFA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:57:33 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:57:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:57:33 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-byqn8t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:57:33 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:57:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:57:33 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-hCwZEZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:57:33 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:57:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:57:33 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-r3B2zY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:57:33 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:57:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:57:33 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-ppiIym-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:57:33 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:57:33 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:57:33 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:57:33 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:57:33 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:57:33 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:57:33 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:57:33 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:57:33 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:57:33 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:57:33 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:57:33 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:57:33 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:57:36 INFO - Downloading blessings-1.6.tar.gz 17:57:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:57:36 INFO - Installing collected packages: blessings 17:57:36 INFO - Running setup.py install for blessings 17:57:36 INFO - Successfully installed blessings 17:57:36 INFO - Cleaning up... 17:57:36 INFO - Return code: 0 17:57:36 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:57:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:57:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:57:37 INFO - Reading from file tmpfile_stdout 17:57:37 INFO - Current package versions: 17:57:37 INFO - blessings == 1.6 17:57:37 INFO - blobuploader == 1.2.4 17:57:37 INFO - docopt == 0.6.1 17:57:37 INFO - functools32 == 3.2.3-2 17:57:37 INFO - jsonschema == 2.5.1 17:57:37 INFO - manifestparser == 1.1 17:57:37 INFO - mozInstall == 1.12 17:57:37 INFO - mozcrash == 1.0 17:57:37 INFO - mozdebug == 0.1 17:57:37 INFO - mozdevice == 0.50 17:57:37 INFO - mozfile == 1.2 17:57:37 INFO - mozhttpd == 0.7 17:57:37 INFO - mozinfo == 0.9 17:57:37 INFO - mozleak == 0.1 17:57:37 INFO - mozlog == 3.4 17:57:37 INFO - moznetwork == 0.27 17:57:37 INFO - mozprocess == 0.25 17:57:37 INFO - mozprofile == 0.28 17:57:37 INFO - mozrunner == 6.13 17:57:37 INFO - mozscreenshot == 0.1 17:57:37 INFO - mozsystemmonitor == 0.3 17:57:37 INFO - moztest == 0.8 17:57:37 INFO - mozversion == 1.4 17:57:37 INFO - psutil == 3.1.1 17:57:37 INFO - requests == 1.2.3 17:57:37 INFO - wsgiref == 0.1.2 17:57:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:57:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:57:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:57:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:57:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:57:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:57:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:57:37 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 0x109d84b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d87768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae8b4b4090>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b62d30>, '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 0x109a88db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109b57be8>, '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.k9f9pv0C3m/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.jAaQXqMjbz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/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:57:37 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:57:37 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:57:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.k9f9pv0C3m/Render', 17:57:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:57:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:57:37 INFO - 'HOME': '/Users/cltbld', 17:57:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:57:37 INFO - 'LOGNAME': 'cltbld', 17:57:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:57:37 INFO - 'MOZ_NO_REMOTE': '1', 17:57:37 INFO - 'NO_EM_RESTART': '1', 17:57:37 INFO - 'PAGER': '/bin/cat', 17:57:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:57:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:57:37 INFO - 'PWD': '/builds/slave/test', 17:57:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:57:37 INFO - 'SHELL': '/bin/bash', 17:57:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jAaQXqMjbz/Listeners', 17:57:37 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 17:57:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:57:37 INFO - 'USER': 'cltbld', 17:57:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:57:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:57:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:57:37 INFO - 'XPC_FLAGS': '0x0', 17:57:37 INFO - 'XPC_SERVICE_NAME': '0', 17:57:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:57:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:57:37 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:57:37 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:57:37 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:57:37 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:57:37 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:57:37 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:57:37 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:57:37 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:57:37 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:57:37 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:57:37 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:57:37 INFO - Cleaning up... 17:57:37 INFO - Return code: 0 17:57:37 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:57:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:57:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:57:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:57:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:57:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:57:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:57:37 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 0x109d84b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d87768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae8b4b4090>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b62d30>, '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 0x109a88db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109b57be8>, '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.k9f9pv0C3m/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.jAaQXqMjbz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/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:57:37 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:57:37 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:57:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.k9f9pv0C3m/Render', 17:57:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:57:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:57:37 INFO - 'HOME': '/Users/cltbld', 17:57:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:57:37 INFO - 'LOGNAME': 'cltbld', 17:57:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:57:37 INFO - 'MOZ_NO_REMOTE': '1', 17:57:37 INFO - 'NO_EM_RESTART': '1', 17:57:37 INFO - 'PAGER': '/bin/cat', 17:57:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:57:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:57:37 INFO - 'PWD': '/builds/slave/test', 17:57:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:57:37 INFO - 'SHELL': '/bin/bash', 17:57:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jAaQXqMjbz/Listeners', 17:57:37 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 17:57:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:57:37 INFO - 'USER': 'cltbld', 17:57:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:57:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:57:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:57:37 INFO - 'XPC_FLAGS': '0x0', 17:57:37 INFO - 'XPC_SERVICE_NAME': '0', 17:57:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:57:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:57:37 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:57:37 INFO - Cleaning up... 17:57:37 INFO - Return code: 0 17:57:37 INFO - Running post-action listener: _resource_record_post_action 17:57:37 INFO - Running post-action listener: _start_resource_monitoring 17:57:37 INFO - Starting resource monitoring. 17:57:37 INFO - [mozharness: 2017-04-22 00:57:37.617452Z] Finished create-virtualenv step (success) 17:57:37 INFO - [mozharness: 2017-04-22 00:57:37.618446Z] Running install step. 17:57:37 INFO - Running pre-action listener: _resource_record_pre_action 17:57:37 INFO - Running main action method: install 17:57:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:57:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:57:37 INFO - Reading from file tmpfile_stdout 17:57:37 INFO - Detecting whether we're running mozinstall >=1.0... 17:57:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:57:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:57:37 INFO - Reading from file tmpfile_stdout 17:57:37 INFO - Output received: 17:57:37 INFO - Usage: mozinstall [options] installer 17:57:37 INFO - Options: 17:57:37 INFO - -h, --help show this help message and exit 17:57:37 INFO - -d DEST, --destination=DEST 17:57:37 INFO - Directory to install application into. [default: 17:57:37 INFO - "/builds/slave/test"] 17:57:37 INFO - --app=APP Application being installed. [default: firefox] 17:57:37 INFO - mkdir: /builds/slave/test/build/application 17:57:37 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:57:37 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:57:58 INFO - Reading from file tmpfile_stdout 17:57:58 INFO - Output received: 17:57:58 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 17:57:58 INFO - Running post-action listener: _resource_record_post_action 17:57:58 INFO - [mozharness: 2017-04-22 00:57:58.264847Z] Finished install step (success) 17:57:58 INFO - [mozharness: 2017-04-22 00:57:58.265003Z] Running run-tests step. 17:57:58 INFO - Running pre-action listener: _resource_record_pre_action 17:57:58 INFO - Running main action method: run_tests 17:57:58 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:57:58 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:57:58 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:57:58 INFO - 2017-04-21 17:57:58.279 screenresolution[1625:7358] starting screenresolution argv=screenresolution get 17:57:58 INFO - 2017-04-21 17:57:58.282 screenresolution[1625:7358] Display 0: 1600x1200x32@60 17:57:58 INFO - 2017-04-21 17:57:58.287 screenresolution[1626:7360] starting screenresolution argv=screenresolution list 17:57:58 INFO - Available Modes on Display 0 17:57:58 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:57:58 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:57:58 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:57:58 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:57:58 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:57:58 INFO - Intel Iris: 17:57:58 INFO - Chipset Model: Intel Iris 17:57:58 INFO - Type: GPU 17:57:58 INFO - Bus: Built-In 17:57:58 INFO - VRAM (Dynamic, Max): 1536 MB 17:57:58 INFO - Vendor: Intel (0x8086) 17:57:58 INFO - Device ID: 0x0a2e 17:57:58 INFO - Revision ID: 0x0009 17:57:58 INFO - Displays: 17:57:58 INFO - Display: 17:57:58 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:57:58 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:57:58 INFO - Display Serial Number: 1600x1200 60 17:57:58 INFO - Main Display: Yes 17:57:58 INFO - Mirror: Off 17:57:58 INFO - Online: Yes 17:57:58 INFO - Rotation: Supported 17:57:58 INFO - Return code: 0 17:57:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:57:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:57:58 INFO - Python 2.7.3 17:57:58 INFO - Return code: 0 17:57:58 INFO - grabbing minidump binary from tooltool 17:57:58 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:57:58 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 0x109b62d30>, '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 0x109a88db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109b57be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:57:58 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:57:58 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:57:58 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:57:58 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:57:58 INFO - Return code: 0 17:57:58 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 17:57:58 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:57:58 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:57:58 INFO - ENV: RUST_BACKTRACE is now 1 17:57:58 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 17:57:58 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:57:58 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/QAPOB5PRRoOcPDxZAQEj9w/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0029', '--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:57:58 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/QAPOB5PRRoOcPDxZAQEj9w/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0029 --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:57:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.k9f9pv0C3m/Render', 17:57:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:57:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:57:58 INFO - 'HOME': '/Users/cltbld', 17:57:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:57:58 INFO - 'LOGNAME': 'cltbld', 17:57:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:57:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 17:57:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:57:58 INFO - 'MOZ_NO_REMOTE': '1', 17:57:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:57:58 INFO - 'NO_EM_RESTART': '1', 17:57:58 INFO - 'PAGER': '/bin/cat', 17:57:58 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:57:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:57:58 INFO - 'PWD': '/builds/slave/test', 17:57:58 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:57:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:57:58 INFO - 'RUST_BACKTRACE': '1', 17:57:58 INFO - 'SHELL': '/bin/bash', 17:57:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jAaQXqMjbz/Listeners', 17:57:58 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 17:57:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:57:58 INFO - 'USER': 'cltbld', 17:57:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:57:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:57:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:57:58 INFO - 'XPC_FLAGS': '0x0', 17:57:58 INFO - 'XPC_SERVICE_NAME': '0', 17:57:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:57:58 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/QAPOB5PRRoOcPDxZAQEj9w/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0029', '--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:57:58 INFO - mozversion application_buildid: 20170421151719 17:57:58 INFO - mozversion application_changeset: 73d3f203c63c5aec21b15d10e36783c592c18d13 17:57:58 INFO - mozversion application_display_name: Nightly 17:57:58 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:57:58 INFO - mozversion application_name: Firefox 17:57:58 INFO - mozversion application_remotingname: firefox 17:57:58 INFO - mozversion application_repository: https://hg.mozilla.org/projects/pine 17:57:58 INFO - mozversion application_vendor: Mozilla 17:57:58 INFO - mozversion application_version: 55.0a1 17:57:58 INFO - mozversion platform_buildid: 20170421151719 17:57:58 INFO - mozversion platform_changeset: 73d3f203c63c5aec21b15d10e36783c592c18d13 17:57:58 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/pine 17:57:58 INFO - mozversion platform_version: 55.0a1 17:57:58 INFO - using testdate: 1492822678 17:57:58 INFO - actual date: 1492822678 17:57:58 INFO - starting webserver on 'localhost:49236' 17:57:58 INFO - SUITE-START | Running 2 tests 17:57:58 INFO - TEST-START | dromaeo_css 17:57:58 INFO - operating with platform_type : mac_ 17:57:58 INFO - Initialising browser for dromaeo_css test... 17:57:58 INFO - TEST-INFO | started process 1636 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/tmp1BynG_/profile http://localhost:49236/getInfo.html) 17:58:01 INFO - PID 1636 | __metrics Screen width/height:1600/1200 17:58:01 INFO - PID 1636 | colorDepth:24 17:58:01 INFO - PID 1636 | Browser inner width/height: 1024/689 17:58:01 INFO - PID 1636 | __metrics 17:58:01 INFO - PID 1636 | 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:58:01 INFO - PID 1636 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:58:02 INFO - TEST-INFO | 1636: exit 0 17:58:02 INFO - Browser initialized. 17:58:02 INFO - Running cycle 1/1 for dromaeo_css test... 17:58:02 INFO - TEST-INFO | started process 1638 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/tmp1BynG_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:58:14 INFO - PID 1638 | RSS: Main: 242909184 17:58:14 INFO - PID 1638 | 18:01:20 INFO - PID 1638 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49236/tests/dromaeo/cssquery-ext.html) 18:01:21 INFO - PID 1638 | RSS: Main: 358154240 18:01:21 INFO - PID 1638 | 18:03:04 INFO - PID 1638 | ************************* 18:03:04 INFO - PID 1638 | A coding exception was thrown and uncaught in a Task. 18:03:04 INFO - PID 1638 | 18:03:04 ERROR - PID 1638 | Full message: TypeError: NetworkError when attempting to fetch resource. 18:03:04 INFO - PID 1638 | Full stack: 18:03:04 INFO - PID 1638 | ************************* 18:03:04 INFO - PID 1638 | ************************* 18:03:04 INFO - PID 1638 | A coding exception was thrown and uncaught in a Task. 18:03:04 INFO - PID 1638 | 18:03:04 ERROR - PID 1638 | Full message: TypeError: NetworkError when attempting to fetch resource. 18:03:04 INFO - PID 1638 | Full stack: 18:03:04 INFO - PID 1638 | ************************* 18:03:04 INFO - PID 1638 | ************************* 18:03:04 INFO - PID 1638 | A coding exception was thrown and uncaught in a Task. 18:03:04 INFO - PID 1638 | 18:03:04 ERROR - PID 1638 | Full message: TypeError: NetworkError when attempting to fetch resource. 18:03:04 INFO - PID 1638 | Full stack: 18:03:04 INFO - PID 1638 | ************************* 18:03:04 INFO - PID 1638 | ************************* 18:03:04 INFO - PID 1638 | A coding exception was thrown and uncaught in a Task. 18:03:04 INFO - PID 1638 | 18:03:04 ERROR - PID 1638 | Full message: TypeError: NetworkError when attempting to fetch resource. 18:03:04 INFO - PID 1638 | Full stack: 18:03:04 INFO - PID 1638 | ************************* 18:04:24 INFO - PID 1638 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-ext.html (next: http://localhost:49236/tests/dromaeo/cssquery-jquery.html) 18:04:25 INFO - PID 1638 | RSS: Main: 367710208 18:04:25 INFO - PID 1638 | 18:07:27 INFO - PID 1638 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49236/tests/dromaeo/cssquery-mootools.html) 18:07:28 INFO - PID 1638 | RSS: Main: 340418560 18:07:28 INFO - PID 1638 | 18:10:30 INFO - PID 1638 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49236/tests/dromaeo/cssquery-prototype.html) 18:10:31 INFO - PID 1638 | RSS: Main: 363106304 18:10:31 INFO - PID 1638 | 18:13:34 INFO - PID 1638 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49236/tests/dromaeo/cssquery-yui.html) 18:13:35 INFO - PID 1638 | RSS: Main: 331300864 18:13:35 INFO - PID 1638 | 18:16:37 INFO - PID 1638 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-yui.html (next: http://localhost:49236/tests/dromaeo/cssquery-dojo.html) 18:16:38 INFO - PID 1638 | RSS: Main: 376893440 18:16:38 INFO - PID 1638 | 18:16:38 INFO - PID 1638 | __start_tp_report 18:16:38 INFO - PID 1638 | _x_x_mozilla_page_load 18:16:38 INFO - PID 1638 | _x_x_mozilla_page_load_details 18:16:38 INFO - PID 1638 | |i|pagename|runs| 18:16:38 INFO - PID 1638 | |0;dojo.html;3199.8240096794666;3473.565804274466;3536.610972792993;3550.55618047744;3588.120910376958;5945.762169513225;6078.270607527103;6181.505479561635;6194.008958566619;6199.783007594735;6139.478144357735;6141.762184092984;6145.740123274729;6199.101130336098;6200.193974783272;5165.974170129144;5333.306670132877;5340.706261155635;5354.785808567653;5406.810761623344;5436.238926550286;5456.290682211307;5476.452354764511;5494.423085576017;5524.751386187611;5260.6580572263065;5309.840704778863;5321.467853214647;5342.706151161685;5435.2934118564535;5287;5322.787088516493;5351.518363347279;5353.705546194958;5355.973220133913;5310.867228319285;5331.1470164773455;5348.144296912515;5391.919121213185;5426.348838139448;6148.38516148386;6172.07418887166;6184.938150618481;6199.783007594758;6234.688265586748;6196.2874269459135;6328.810135695937;6515.8696826063215;6532.444742196919;6541.28045914949;6372.299047104815;6488.643124628144;6547.050677651761;6579.901301480481;6591.967040164816;6225.066240064027;6246.718897649571;6267.122602835607;6283.340249273806;6307.180066591313;6767.221769496571;6768.7292508299115;6771.356721111487;6771.492138089663;6791.320867913169;5411.567074634098;6318.273398559132;6349.714262858182;6389.872202555923;6427.775027874096;6199.411055949678;6560.147180866456;6575.342465753386;6600.5049621278595;6600.53796234259;6402.103705481143;6421.229452465641;6459.321771214049;6469.256035555877;6504.772332968323;6265.248170219603;6317.399847014526;6318.368163183645;6497.707603157869;6500.122483464766;5186.714730689773;5208.218767184877;5233.450487698813;5248.081585722483;5251.579873610102;4633.536646335339;4633.745144017044;4641.559051890065;4647.697899636512;4685.344051832746;5999.430054144849;6130.29501607312;6201.162843016225;6208;6212.7263910898155;6325.114483972247;6348.079528468346;6470.12653291809;6482.546221764525;6527.477801775846;6240.563160578807;6251.3123556408755;6261.843453913689;6262.185915830913;6267.9971204607045;5766.596338256366;5768.769249229984;5768.855778605484;5776.249087618583;5804.477597016289;6467.126937863516;6550.181227346582;6550.377714117151;6553.606783593;6752.696128674123;5443.265159203615;6295.244570651551;6373.745050198126;6382.585131966407;6411.4229719325485;6752.08846805675;6760.695768690322;6765.492588056014;6796.184457865088;6797.694103765243;6410.551261411656;6413.16628838248;6424.807255782334;6425.58233714807;6425.775097871552;6279.811605651837;6345.1434056401795;6509.772157974448;6526.836829079311;6529.9347006531225;6279.340669229848;6292.559520833498;6353.301136875032;6354.6822658867795;6364.64994425311;6307.369263073656;6308.243010838729;6312.179416675803;6331.366863313632;6338.683065846782;6292.024736165901;6294.527910406646;6299.464545513682;6308.211473565804;6313.90529142054;6254;6328.683565821599;6340.239171299474;6372.681365931592;6380.712867920862;6296.779612713533;6298.118263443213;6299.937000630119;6301.905471418024;6313.05304204373 18:16:38 INFO - PID 1638 | |1;ext.html;795.2365728900257;795.6300320351036;1093.3112139352206;1110.7945030169415;1114.0530549033317;35709.46435803465;36244;36254.45618315724;36281.45577816335;36317.81841090791;38434.42348364777;38757.612423875755;38843;38843.41734873979;38846.8057659712;6075.665838378887;6184.690765461732;8419.368547358958;8502.914970850305;8552.315814734837;8179.813926980584;8380.20388063133;8581;8583.313334933191;8587.95706021469;7777.5333479991095;8642.481451112923;8644.740657780276;8662.52356120413;8675.739727808175;8563.700270490534;8617.35369847264;8622.65509379624;8634.956825215833;8643.827123457495;8445.83108337836;8469.872951905727;8470.237678608893;8478.533680647624;8490.278326342268;36615.63384366149;36731.08172295687;36745.448818267745;36756;36805.63194368049;3586.946195807065;3597;3610.819459027038;3617.728670349708;3619.8009109498967;30647;30696.53955190674;30697.386052279053;30750;30751.692483075105;3105.45654510462;3143.764217683683;3156.1793933577437;3166.4458719723957;3179.998300535347;234309;291862;291959;292131;293035;37810.43284350737;37916.43125353122;48376.27435588469;48499.5150048495;48559.51440485621;40312.1937561253;48501;48812.755936220805;48880.75559622179;49486.75256623694;13451.125676830974;13535.86464135346;13559.525416610371;13563.321833908463;13573;9636.46999415039;10994.945025274983;10995.615153469591;10999.560017599366;11000.22998390121;10619.787604247871;10714.624988125379;10723.946380268204;10725.51735171919;12161.878381216251;5048.343715316985;5106.795728170906;5108.591312694975;5110.565601923804;5118.974405128025;973.8733964584559;985.1527686189871;987.1905037868878;1021.2034613001871;1039.3296323871211;23814;23981.280561583182;24002.639960400607;24020.63969040466;24057.398565036015;1080.3895798873612;1082.377632861108;1112.666200139971;1114.4706264524286;1129.9943500282445;9722.659706910224;11616.244944078608;12184.20802647825;12251.32617706017;12304.015678745678;303015;303277;303371;303701;304023;50375;50376.95476542838;50378.24432633514;50481;50580.98838023219;1475.1517877220426;1480.163707505256;1515.9317830697426;1520.8022957015517;1528.388644542192;19134.330298439487;22244.77755222427;23301.92216362096;23432;23434;36840.81579592085;36970.8151459241;37025;37035.81482092572;37072.44391334078;286907;286948;287197;287439;287650;33082.33835323328;33094.83452582722;33120.006399808044;33172.336553269284;33177;33944.490832637035;35553.75561855322;41498;42140.52508162322;42268.577314226466;28586.85706571454;29248.976285829893;29785.85107074451;29885.402291953604;30183.69816301809;23771.52456950886;28617.427651446436;29518;29528.557071644373;29736.851315743283;34778.13054673653;34792.82603586966;35249;35503;35554.46668299926;29094.854525727234;29856.955006574666;29885.402291954473;29885.551716723832;30207.546886797154;18277.634447311244;23058.192963246205;23059.96450621168;23325;23404.414889627213 18:16:38 INFO - PID 1638 | |2;jquery.html;378.9738934607163;427.07814833250376;439.4836067620545;441.57608695652175;456.4298812086424;17286;21092.261770838024;21832.23587174449;21899.291652294753;22191.11235550576;22515.54968900621;22556.774432255672;22781.772182278215;22806.31581052567;23624.936877840497;4992.375953005874;6224.15973843531;6321.146645202908;6392.840178995516;6410.487161027107;6285.654289014103;6326.778562750304;6336.778212762554;6341.8097457076365;6349.873002539946;6088.573799834014;6144.754209831602;6296.685165741717;6298.527610429213;6325.27259365172;5207.687538747668;5867.442592953663;6230.688465576703;6240.188775459184;6245.032020036879;5421.647592906448;5479;5490.80782172622;5496.80761173361;5501.119820828648;24980.5003899921;27269;27356.31609209766;28351.72417241229;28560;2206.3270702435752;2250.8199344052437;2251.572201281768;2254.211026140854;2254.627986382245;16863.15684215784;18331.26674933001;18430.53923651906;18496.907515462335;18678.62642747151;2080.91676332948;2110.97617655437;2160.6650969099815;2167.783221677835;2174.7716489768663;153844;163806;166582;168800;169484;10330.0259679858;11206.21556491054;12340.629781106582;12353.197042192229;12556.121071524905;16478.83521164773;16735.74896376531;16742.665146696996;16781.832181678026;16803.327866885433;8922.68770593026;8938.731838044869;9001.279897608176;9120.996690364054;9202.435585950405;8503.914960850312;8508.361872859561;8538.957305213435;8705.260052895575;8729.039805621376;7016.543924644881;7397.926020739831;7968.243016913384;7993.240642138988;8026;2162.9567408652056;2193.4187440328324;2193.8573992690426;2206.9668954965687;2343.83593148478;918.7381596245039;950.2303134461108;951.9252813412716;955.9187469065207;956.6221342569646;20755.8962205188;21060.26289079875;21216.575668486545;21250.468738281666;21386.78613213848;828.4118276024091;985;998.7403275148368;1001.5277542013229;1004.5077911823154;10417.791644167226;10883.673489795161;10886.836697449544;10935.781284374269;10962.890371096346;543156;555930;565350;567381;569127;129328.3533582326;142110;142128.28935855255;147256.52743472642;148332.25833870762;1152.4181493803976;1169.1932566529067;1220.7192345760348;1226.7669142863006;1232.3160645841465;20068.69896951576;22396;22440.438989025406;22860.4284892879;22952.540949181257;57364.71317643552;58417.70791146017;58993.705031474565;59467.40532594792;60253;78285.60857195678;79279;79603;80486;81087;12756.744865102832;13335;13345.933270333586;13695.109817861807;13761.931190344385;14614.707705846036;14631.487897923522;14841.554753357417;15019.249037547861;15037.947343685837;11936.283822970303;12139.939300303795;12432.937835310766;12466.252024878537;12587.118901676795;11441.485133169193;11554.191206615456;11694.239874408137;12011.699707507381;12027.518899243933;11537.769244615229;12084.978755311173;12183.756324873275;12715.364231788188;12863.099583029098;12913.096083274457;12994.855848785222;13024.674383140497;13236.669083272995;13243;12000.75998480043;12058;12132;12214.877851221729;12290.877091228973 18:16:38 INFO - PID 1638 | |3;mootools.html;1348.3999620169025;1395.065306244816;1418.5602463236391;1419.3258202353884;1419.4676996126452;11126.276792008513;11643.708907277321;11644.534218631266;11645.475953582089;11661.41692915354;11290.379029153393;11448.48481818318;11646.767064658701;11797.646070617873;11815.7636847263;2513.7863281621085;2561.1036137351966;2563.8718064096815;2564.5127425789133;2567.4608332250154;2476.0962248779156;2520.2943175910773;2521.1680145552014;2522.8738563071774;2527.1028784781415;2376.714794224687;2457.447074408262;2457.7665121813397;2463.716672582658;2467.2721547143638;2472.0606169655416;2482.342179322481;2495.9126430575025;2498.4503409249937;2503.173952595639;2494.5759220932487;2528.7218405975327;2528.898844046236;2530.316814460104;2530.6457096006575;11254.774904501865;11674.766504669944;11681.591144309994;11685.357305348203;11691.532338706442;6562.179727534059;6809.080774095483;6818.659067046628;6825.453963682893;6829.453643708541;3931.0958479549577;4270.530241673413;4355.128974205171;4360.803763830635;4365.912681746379;1225.7548490301974;1239.9504019839196;1292.6445227562401;1292.8513220979614;1293.6701141208932;15155.469558565508;15536.844631553766;15561;16488.587785305343;16682.249298781462;5488.286522752017;5600.607957443021;5787.305523337226;5788.942110578924;5846.649201047951;12138.332391718364;12182.451789669487;12197.817032744517;12198.756024879453;12203.511859525697;6542.182227221598;6543.1821022372205;6547.247066587308;6552.868942621121;6555.410013098749;6090.025595904634;6161.907571386433;6177.320494745574;6199.907001394983;6259.843503912439;4189.8212929277215;4320.503142138631;4369.80335884886;4421.911561768747;4427;1283.8523569789406;1308.770965081126;1310.3382791690135;1325.9867401326055;1329.6210579984659;660.4650233311033;711.4308553157454;772.2856357869061;773.3233420756837;778.8014056415577;6015.30823955242;6020.759169633166;6082.452579267887;6201.44277250309;6364.459020983176;577.6967092276589;596.3916804859019;603.9818805435845;605.340179204669;608.4068033667139;3638.7089032877307;3789.9242015160094;4072.572379900127;4186.6859985501205;4416.4037854889175;14580.270986450634;14919.552413427615;14923.70152596942;15278.312475938386;15354.616134596725;14713.55859324222;15000.924995375171;15222.391104355702;15301.387944482318;15313.770293445607;8240.711575094843;8489.61796719149;8586.184312490428;8598.355123365773;8612.009618893908;6436.967815160894;6849.794506164823;7098.00627912103;7130.964345178241;7204.76652237787;11620.825687614524;13626.1143025703;13839.238841863391;13845.307734613027;13883;12709;13934;13936.72126557443;13940.790888136484;14276.857231427553;9456.763580910532;9500.524973751146;9613.567389467631;9616.326857119935;9616.567254473426;9450.858237126586;9850;10459.94770026145;10561.788764224519;10581.788364232518;8854.468731876108;8892.955535222283;8960.68637597681;8969.955150224207;9050.366474346733;8702.869456958024;8711.390202686005;8767.605457754544;8791.428557143765;8853.247473964786;7569.053868266466;7731.265529774662;7734.845303094019;7736.458447908817;7739.380849532136;5575.804846830341;5971.790987315423;6079.848003799763;6169.01295792671;6206.193194884636;5883.470487656132;5928.436798504308;6055.212822333068;6117.1741814856205;6202.937970620236 18:16:38 INFO - PID 1638 | |4;prototype.html;347.30019011691445;389.80120138729245;402.45467391684247;404.11297202640196;405.87417900450845;4752.667313288067;5231.372235331765;5257.526822585966;5736.537183018329;5777.364489906117;4820.349252850873;5457.481539253775;5539.972300138504;5620.57845661575;5691.971540142304;4250.957490425087;4260.914781704364;4262.722923009995;4266.765327906964;4270.402143699885;3824.3498605237037;4012.1775036117524;4260.72305300156;4261.083866968601;4267.829286828523;3636.4727114568373;3932.2528719543197;4004.796163069547;4156.750594964296;4223.345381465878;4173.64524015459;4173.937390939153;4177.540470548237;4186.518550366686;4192.538820729717;3625.7099432045375;3640.526731524911;3671.2290419011774;3677.6506231908193;3680.650338217865;4414.955850441486;4715.622750179978;4997.925031124536;5042.873928151789;5508.421615730331;4244;4686.882827929295;4814.951850481485;4829.613630909554;4941.530554597308;4982;6005.789797357115;6012.518998480155;6021.909671354933;6031.492126968258;3886.4558961745097;4128.380742888591;4137.668986481074;4140.751554906716;4144.212599606095;5516.779328826842;5866.941330586725;6053.878922421571;6268.435840774352;6365.204349456318;3475.826208689555;4101.7744024078365;4140.399642051885;4146.398772178018;4157.210130075276;4206.390073439334;4214.093969796447;4216.177845320133;4232.2647714436935;4240.554741752133;3964.2467931093;4492.28123500245;4594.609458196091;4885.1680619767585;4906.754662266872;5864.765409383577;5928.318243401977;5998.5508332708;6003.369646187175;6015.826913751776;1121.5906194239208;1436.3967133803828;1436.7557515222438;1438.8489208632943;1452.4408102880468;947.2374738335706;955.9569819358146;958.5621567648527;962.1629182611173;973.7468258252906;5628.577856660767;5637;5638.013347664142;5663.546916246691;5679;5104.69371837691;5213.400458947193;5849.941500585025;6140.539459540552;6163.691815409212;5376.542993845489;5573.498385145356;5645.209670646031;5647.265855438766;5648.237487939158;3020.275133967832;3147.898235617561;3154.227214332457;3197.536357228189;3212.566303548991;5508.669479831223;6017.398260174035;6314.273858506239;6395.104685344056;6401.9039714404325;6299.5275354348605;6317.052442133717;6317.4946004319545;6325.272593651697;6395.104685344056;5214.556762675215;5891;6351.301356850743;6358.395952384423;6367.204099487564;5528.894221155704;5821.621594596338;6135.907961380493;6141;6187.071939209155;5165.560927321069;6039.667818270037;6043.8186854394435;6058.878822423615;6092.482139018233;4994.80020799164;5907.232059832366;6178.691065446799;6266.467350275096;6404.839879002876;3484.5121682964914;4133.297339452361;4134.359174327984;4143.958560414358;4145.8963525912095;5919.4968427684125;6194.349593292639;6207.720652570555;6210.627362358273;6228.968855155696;5210.838864214872;5489.87457571205;5966.761329546943;5984.84545563588;5988.850278742892;4630.861074167646;5012.323336349692;5203.947960520346;5205.973970130125;5911.231539899785;5627.127795191752;5804.21643078179;5822.301323841166;5831.571265040092;5883.529317654663;4694.319323698113;4930.531599498042;5947.553933454921;5956.642601443928;5998.430149135826;5247.658902171346;5504.202100550608;5560.860978475571;5709.343425505954;5877.4122587740885 18:16:38 INFO - PID 1638 | |5;yui.html;691.6472598974522;724.5507785173193;836.5858899844574;845.2688424512796;847.940644154909;12856.807147892778;17969.371072012484;18063.729044064334;18457.35399261028;18494.44516664499;16750;17009.829901700978;17286.913565432187;17331.22009509572;17358.47924562262;874.1739056591508;886.1227384888978;887.1704955866253;889.3996552327153;890.1765866573426;641.275358844505;656.4879394072631;905.7373361725092;915.7069737683944;944.9558238146852;981.6318880419842;982.1749730226608;983.1446641421973;986.5856340337076;998.0568362897066;975.073680003999;976.9560369783342;977.5552123783662;979.2802290316612;993.4436715439341;617.7837756785134;722.3101937649532;722.4328901812105;724.6087112958995;735.672625681572;15738;16153.353865845353;16297.103659298733;16470.258838352303;16775.32898684051;16201;16278.348866045344;16442.095684737335;16659.91710538823;16689.582760430963;12531.56139535121;12758.553450629277;12809.10336276461;12962.092653514257;12982;3394.8472318745717;3409.352223077632;3415.3681568909833;3415.9316813663836;3416.145963509123;111357.99999999919;115404;115546.42226788812;116040;116164;10728.141748660088;11034.944825275823;13132.277724725232;13477.932610336886;13484;15751.739860811107;17440.558321834953;24732.010719571375;24786;24807.25578232656;7620.276073772982;7722.498037627536;7816.06207255133;7888.447808653339;7895.526268423913;3836.731428800013;3899.005753532831;3905.6094390561284;3906.980465097656;3911.4523966644692;3561.893143205708;4179.393987871742;4243.702940794176;4321.049369138847;4327.3725309830525;916.8303863785221;944.0748066894482;946.8485042393322;949.1362859797551;950.4107453378949;526.4919352824543;586.6362855029909;649.3117295666608;657.5824351536809;697.3688811625487;11101.278416902875;11631.941840290745;11819.940900295443;11991.280523168638;12103.394830258452;653.7646447278976;660.455124522271;663.1213641924469;669.100060418736;686.0361192524512;5370.731463426813;5400.972995135077;5582.190582365534;5600.831975040674;5708.65748055118;87538.68691969625;92084;95929;96801.51599241959;97872.02127978772;81224;82112;83233;83604;84958;72067;73331.63334183402;74251.88622170672;74258.8861167083;75379;10384;11811.881881181078;12296;12417.875821242033;12492.125551211691;39711.2057758849;39896.60103399045;40058.799706001286;40518.79740601278;40986.38520422136;38827.25277362582;45218.77390613026;51155;51443.74278128735;52321.21518177306;15971.840281597035;16001;16062.955907865951;16179.514614561582;16430.75353869717;14906.701865962837;14986.80105591572;17728;18179.27282908722;18249.178786954355;16759.664806703553;17116.315347386462;17170.96974181553;17396.217170227115;17623.295068197127;16957.830421695624;17132.486025419257;17386.391476298268;17548.12259387051;17605.911970440065;16324.265408056428;16567;16817.243224054702;16880.746788798424;17133.74299385535;10426.635067772591;11700.824487632863;11884.76230475403;12023.633382652872;12104.394780260776;11752.23610465317;13146.474141034252;13291.53479628247;13316.105343503896;13458.663533411744 18:16:38 INFO - PID 1638 | __end_tp_report 18:16:38 INFO - PID 1638 | __start_cc_report 18:16:38 INFO - PID 1638 | _x_x_mozilla_cycle_collect,1823 18:16:38 INFO - PID 1638 | __end_cc_report 18:16:38 INFO - PID 1638 | __startTimestamp1492823798045__endTimestamp 18:16:38 INFO - PID 1638 | 18:16:38 INFO - PID 1638 | ------- Summary: start ------- 18:16:38 INFO - PID 1638 | Number of tests: 6 18:16:38 INFO - PID 1638 | 18:16:38 INFO - PID 1638 | [#0] dojo.html Cycles:165 Average:6022.18 Median:6292.02 stddev:682.11 (10.8%) stddev-sans-first:647.27 18:16:38 INFO - PID 1638 | Values: 3199.8 3473.6 3536.6 3550.6 3588.1 5945.8 6078.3 6181.5 6194.0 6199.8 6139.5 6141.8 6145.7 6199.1 6200.2 5166.0 5333.3 5340.7 5354.8 5406.8 5436.2 5456.3 5476.5 5494.4 5524.8 5260.7 5309.8 5321.5 5342.7 5435.3 5287.0 5322.8 5351.5 5353.7 5356.0 5310.9 5331.1 5348.1 5391.9 5426.3 6148.4 6172.1 6184.9 6199.8 6234.7 6196.3 6328.8 6515.9 6532.4 6541.3 6372.3 6488.6 6547.1 6579.9 6592.0 6225.1 6246.7 6267.1 6283.3 6307.2 6767.2 6768.7 6771.4 6771.5 6791.3 5411.6 6318.3 6349.7 6389.9 6427.8 6199.4 6560.1 6575.3 6600.5 6600.5 6402.1 6421.2 6459.3 6469.3 6504.8 6265.2 6317.4 6318.4 6497.7 6500.1 5186.7 5208.2 5233.5 5248.1 5251.6 4633.5 4633.7 4641.6 4647.7 4685.3 5999.4 6130.3 6201.2 6208.0 6212.7 6325.1 6348.1 6470.1 6482.5 6527.5 6240.6 6251.3 6261.8 6262.2 6268.0 5766.6 5768.8 5768.9 5776.2 5804.5 6467.1 6550.2 6550.4 6553.6 6752.7 5443.3 6295.2 6373.7 6382.6 6411.4 6752.1 6760.7 6765.5 6796.2 6797.7 6410.6 6413.2 6424.8 6425.6 6425.8 6279.8 6345.1 6509.8 6526.8 6529.9 6279.3 6292.6 6353.3 6354.7 6364.6 6307.4 6308.2 6312.2 6331.4 6338.7 6292.0 6294.5 6299.5 6308.2 6313.9 6254.0 6328.7 6340.2 6372.7 6380.7 6296.8 6298.1 6299.9 6301.9 6313.1 18:16:38 INFO - PID 1638 | 18:16:38 INFO - PID 1638 | [#1] ext.html Cycles:180 Average:43358.73 Median:33146.17 stddev:76302.76 (230.2%) stddev-sans-first:76449.89 18:16:38 INFO - PID 1638 | Values: 795.2 795.6 1093.3 1110.8 1114.1 35709.5 36244.0 36254.5 36281.5 36317.8 38434.4 38757.6 38843.0 38843.4 38846.8 6075.7 6184.7 8419.4 8502.9 8552.3 8179.8 8380.2 8581.0 8583.3 8588.0 7777.5 8642.5 8644.7 8662.5 8675.7 8563.7 8617.4 8622.7 8635.0 8643.8 8445.8 8469.9 8470.2 8478.5 8490.3 36615.6 36731.1 36745.4 36756.0 36805.6 3586.9 3597.0 3610.8 3617.7 3619.8 30647.0 30696.5 30697.4 30750.0 30751.7 3105.5 3143.8 3156.2 3166.4 3180.0 234309.0 291862.0 291959.0 292131.0 293035.0 37810.4 37916.4 48376.3 48499.5 48559.5 40312.2 48501.0 48812.8 48880.8 49486.8 13451.1 13535.9 13559.5 13563.3 13573.0 9636.5 10994.9 10995.6 10999.6 11000.2 10619.8 10714.6 10723.9 10725.5 12161.9 5048.3 5106.8 5108.6 5110.6 5119.0 973.9 985.2 987.2 1021.2 1039.3 23814.0 23981.3 24002.6 24020.6 24057.4 1080.4 1082.4 1112.7 1114.5 1130.0 9722.7 11616.2 12184.2 12251.3 12304.0 303015.0 303277.0 303371.0 303701.0 304023.0 50375.0 50377.0 50378.2 50481.0 50581.0 1475.2 1480.2 1515.9 1520.8 1528.4 19134.3 22244.8 23301.9 23432.0 23434.0 36840.8 36970.8 37025.0 37035.8 37072.4 286907.0 286948.0 287197.0 287439.0 287650.0 33082.3 33094.8 33120.0 33172.3 33177.0 33944.5 35553.8 41498.0 42140.5 42268.6 28586.9 29249.0 29785.9 29885.4 30183.7 23771.5 28617.4 29518.0 29528.6 29736.9 34778.1 34792.8 35249.0 35503.0 35554.5 29094.9 29857.0 29885.4 29885.6 30207.5 18277.6 23058.2 23060.0 23325.0 23404.4 18:16:38 INFO - PID 1638 | 18:16:38 INFO - PID 1638 | [#2] jquery.html Cycles:180 Average:37005.48 Median:2206.65 stddev:95539.74 (4329.6%) stddev-sans-first:95768.17 18:16:38 INFO - PID 1638 | Values: 379.0 427.1 439.5 441.6 456.4 17286.0 21092.3 21832.2 21899.3 22191.1 22515.5 22556.8 22781.8 22806.3 23624.9 4992.4 6224.2 6321.1 6392.8 6410.5 6285.7 6326.8 6336.8 6341.8 6349.9 6088.6 6144.8 6296.7 6298.5 6325.3 5207.7 5867.4 6230.7 6240.2 6245.0 5421.6 5479.0 5490.8 5496.8 5501.1 24980.5 27269.0 27356.3 28351.7 28560.0 2206.3 2250.8 2251.6 2254.2 2254.6 16863.2 18331.3 18430.5 18496.9 18678.6 2080.9 2111.0 2160.7 2167.8 2174.8 153844.0 163806.0 166582.0 168800.0 169484.0 10330.0 11206.2 12340.6 12353.2 12556.1 16478.8 16735.7 16742.7 16781.8 16803.3 8922.7 8938.7 9001.3 9121.0 9202.4 8503.9 8508.4 8539.0 8705.3 8729.0 7016.5 7397.9 7968.2 7993.2 8026.0 2163.0 2193.4 2193.9 2207.0 2343.8 918.7 950.2 951.9 955.9 956.6 20755.9 21060.3 21216.6 21250.5 21386.8 828.4 985.0 998.7 1001.5 1004.5 10417.8 10883.7 10886.8 10935.8 10962.9 543156.0 555930.0 565350.0 567381.0 569127.0 129328.4 142110.0 142128.3 147256.5 148332.3 1152.4 1169.2 1220.7 1226.8 1232.3 20068.7 22396.0 22440.4 22860.4 22952.5 57364.7 58417.7 58993.7 59467.4 60253.0 78285.6 79279.0 79603.0 80486.0 81087.0 12756.7 13335.0 13345.9 13695.1 13761.9 14614.7 14631.5 14841.6 15019.2 15037.9 11936.3 12139.9 12432.9 12466.3 12587.1 11441.5 11554.2 11694.2 12011.7 12027.5 11537.8 12085.0 12183.8 12715.4 12863.1 12913.1 12994.9 13024.7 13236.7 13243.0 12000.8 12058.0 12132.0 12214.9 12290.9 18:16:38 INFO - PID 1638 | 18:16:38 INFO - PID 1638 | [#3] mootools.html Cycles:180 Average:7069.40 Median:4001.83 stddev:4483.91 (112.0%) stddev-sans-first:4475.88 18:16:38 INFO - PID 1638 | Values: 1348.4 1395.1 1418.6 1419.3 1419.5 11126.3 11643.7 11644.5 11645.5 11661.4 11290.4 11448.5 11646.8 11797.6 11815.8 2513.8 2561.1 2563.9 2564.5 2567.5 2476.1 2520.3 2521.2 2522.9 2527.1 2376.7 2457.4 2457.8 2463.7 2467.3 2472.1 2482.3 2495.9 2498.5 2503.2 2494.6 2528.7 2528.9 2530.3 2530.6 11254.8 11674.8 11681.6 11685.4 11691.5 6562.2 6809.1 6818.7 6825.5 6829.5 3931.1 4270.5 4355.1 4360.8 4365.9 1225.8 1240.0 1292.6 1292.9 1293.7 15155.5 15536.8 15561.0 16488.6 16682.2 5488.3 5600.6 5787.3 5788.9 5846.6 12138.3 12182.5 12197.8 12198.8 12203.5 6542.2 6543.2 6547.2 6552.9 6555.4 6090.0 6161.9 6177.3 6199.9 6259.8 4189.8 4320.5 4369.8 4421.9 4427.0 1283.9 1308.8 1310.3 1326.0 1329.6 660.5 711.4 772.3 773.3 778.8 6015.3 6020.8 6082.5 6201.4 6364.5 577.7 596.4 604.0 605.3 608.4 3638.7 3789.9 4072.6 4186.7 4416.4 14580.3 14919.6 14923.7 15278.3 15354.6 14713.6 15000.9 15222.4 15301.4 15313.8 8240.7 8489.6 8586.2 8598.4 8612.0 6437.0 6849.8 7098.0 7131.0 7204.8 11620.8 13626.1 13839.2 13845.3 13883.0 12709.0 13934.0 13936.7 13940.8 14276.9 9456.8 9500.5 9613.6 9616.3 9616.6 9450.9 9850.0 10459.9 10561.8 10581.8 8854.5 8893.0 8960.7 8970.0 9050.4 8702.9 8711.4 8767.6 8791.4 8853.2 7569.1 7731.3 7734.8 7736.5 7739.4 5575.8 5971.8 6079.8 6169.0 6206.2 5883.5 5928.4 6055.2 6117.2 6202.9 18:16:38 INFO - PID 1638 | 18:16:38 INFO - PID 1638 | [#4] prototype.html Cycles:180 Average:4787.46 Median:5252.59 stddev:1473.26 (28.0%) stddev-sans-first:1439.20 18:16:38 INFO - PID 1638 | Values: 347.3 389.8 402.5 404.1 405.9 4752.7 5231.4 5257.5 5736.5 5777.4 4820.3 5457.5 5540.0 5620.6 5692.0 4251.0 4260.9 4262.7 4266.8 4270.4 3824.3 4012.2 4260.7 4261.1 4267.8 3636.5 3932.3 4004.8 4156.8 4223.3 4173.6 4173.9 4177.5 4186.5 4192.5 3625.7 3640.5 3671.2 3677.7 3680.7 4415.0 4715.6 4997.9 5042.9 5508.4 4244.0 4686.9 4815.0 4829.6 4941.5 4982.0 6005.8 6012.5 6021.9 6031.5 3886.5 4128.4 4137.7 4140.8 4144.2 5516.8 5866.9 6053.9 6268.4 6365.2 3475.8 4101.8 4140.4 4146.4 4157.2 4206.4 4214.1 4216.2 4232.3 4240.6 3964.2 4492.3 4594.6 4885.2 4906.8 5864.8 5928.3 5998.6 6003.4 6015.8 1121.6 1436.4 1436.8 1438.8 1452.4 947.2 956.0 958.6 962.2 973.7 5628.6 5637.0 5638.0 5663.5 5679.0 5104.7 5213.4 5849.9 6140.5 6163.7 5376.5 5573.5 5645.2 5647.3 5648.2 3020.3 3147.9 3154.2 3197.5 3212.6 5508.7 6017.4 6314.3 6395.1 6401.9 6299.5 6317.1 6317.5 6325.3 6395.1 5214.6 5891.0 6351.3 6358.4 6367.2 5528.9 5821.6 6135.9 6141.0 6187.1 5165.6 6039.7 6043.8 6058.9 6092.5 4994.8 5907.2 6178.7 6266.5 6404.8 3484.5 4133.3 4134.4 4144.0 4145.9 5919.5 6194.3 6207.7 6210.6 6229.0 5210.8 5489.9 5966.8 5984.8 5988.9 4630.9 5012.3 5203.9 5206.0 5911.2 5627.1 5804.2 5822.3 5831.6 5883.5 4694.3 4930.5 5947.6 5956.6 5998.4 5247.7 5504.2 5560.9 5709.3 5877.4 18:16:38 INFO - PID 1638 | 18:16:38 INFO - PID 1638 | [#5] yui.html Cycles:180 Average:20338.72 Median:3699.31 stddev:27730.03 (749.6%) stddev-sans-first:27768.57 18:16:38 INFO - PID 1638 | Values: 691.6 724.6 836.6 845.3 847.9 12856.8 17969.4 18063.7 18457.4 18494.4 16750.0 17009.8 17286.9 17331.2 17358.5 874.2 886.1 887.2 889.4 890.2 641.3 656.5 905.7 915.7 945.0 981.6 982.2 983.1 986.6 998.1 975.1 977.0 977.6 979.3 993.4 617.8 722.3 722.4 724.6 735.7 15738.0 16153.4 16297.1 16470.3 16775.3 16201.0 16278.3 16442.1 16659.9 16689.6 12531.6 12758.6 12809.1 12962.1 12982.0 3394.8 3409.4 3415.4 3415.9 3416.1 111358.0 115404.0 115546.4 116040.0 116164.0 10728.1 11034.9 13132.3 13477.9 13484.0 15751.7 17440.6 24732.0 24786.0 24807.3 7620.3 7722.5 7816.1 7888.4 7895.5 3836.7 3899.0 3905.6 3907.0 3911.5 3561.9 4179.4 4243.7 4321.0 4327.4 916.8 944.1 946.8 949.1 950.4 526.5 586.6 649.3 657.6 697.4 11101.3 11631.9 11819.9 11991.3 12103.4 653.8 660.5 663.1 669.1 686.0 5370.7 5401.0 5582.2 5600.8 5708.7 87538.7 92084.0 95929.0 96801.5 97872.0 81224.0 82112.0 83233.0 83604.0 84958.0 72067.0 73331.6 74251.9 74258.9 75379.0 10384.0 11811.9 12296.0 12417.9 12492.1 39711.2 39896.6 40058.8 40518.8 40986.4 38827.3 45218.8 51155.0 51443.7 52321.2 15971.8 16001.0 16063.0 16179.5 16430.8 14906.7 14986.8 17728.0 18179.3 18249.2 16759.7 17116.3 17171.0 17396.2 17623.3 16957.8 17132.5 17386.4 17548.1 17605.9 16324.3 16567.0 16817.2 16880.7 17133.7 10426.6 11700.8 11884.8 12023.6 12104.4 11752.2 13146.5 13291.5 13316.1 13458.7 18:16:38 INFO - PID 1638 | -------- Summary: end -------- 18:16:38 INFO - PID 1638 | 18:16:38 INFO - TEST-INFO | 1638: exit 0 18:16:38 INFO - TEST-OK | dromaeo_css | took 1119850ms 18:16:38 INFO - TEST-START | kraken 18:16:38 INFO - operating with platform_type : mac_ 18:16:38 INFO - Initialising browser for kraken test... 18:16:38 INFO - TEST-INFO | started process 1647 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/tmppbIEWl/profile http://localhost:49236/getInfo.html) 18:16:41 INFO - PID 1647 | __metrics Screen width/height:1600/1200 18:16:41 INFO - PID 1647 | colorDepth:24 18:16:41 INFO - PID 1647 | Browser inner width/height: 1024/689 18:16:41 INFO - PID 1647 | __metrics 18:16:41 INFO - PID 1647 | 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" 18:16:41 INFO - PID 1647 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:16:42 INFO - TEST-INFO | 1647: exit 0 18:16:42 INFO - Browser initialized. 18:16:42 INFO - Running cycle 1/1 for kraken test... 18:16:42 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/tmppbIEWl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:16:54 INFO - PID 1648 | RSS: Main: 243798016 18:16:54 INFO - PID 1648 | 18:16:57 INFO - PID 1648 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-beat-detection) 18:16:58 INFO - PID 1648 | RSS: Main: 313401344 18:16:58 INFO - PID 1648 | 18:17:01 INFO - PID 1648 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-dft) 18:17:01 INFO - PID 1648 | RSS: Main: 295911424 18:17:01 INFO - PID 1648 | 18:17:05 INFO - PID 1648 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-fft) 18:17:05 INFO - PID 1648 | RSS: Main: 388943872 18:17:05 INFO - PID 1648 | 18:17:07 INFO - PID 1648 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-oscillator) 18:17:08 INFO - PID 1648 | RSS: Main: 290066432 18:17:08 INFO - PID 1648 | 18:17:10 INFO - PID 1648 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:17:11 INFO - PID 1648 | RSS: Main: 293543936 18:17:11 INFO - PID 1648 | 18:17:14 INFO - PID 1648 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-darkroom) 18:17:14 INFO - PID 1648 | RSS: Main: 357470208 18:17:14 INFO - PID 1648 | 18:17:17 INFO - PID 1648 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-desaturate) 18:17:18 INFO - PID 1648 | RSS: Main: 374624256 18:17:18 INFO - PID 1648 | 18:17:20 INFO - PID 1648 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49236/tests/kraken/driver.html?testName=json-parse-financial) 18:17:21 INFO - PID 1648 | RSS: Main: 384057344 18:17:21 INFO - PID 1648 | 18:17:23 INFO - PID 1648 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49236/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:17:23 INFO - PID 1648 | RSS: Main: 333348864 18:17:23 INFO - PID 1648 | 18:17:25 INFO - PID 1648 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:17:26 INFO - PID 1648 | RSS: Main: 333795328 18:17:26 INFO - PID 1648 | 18:17:28 INFO - PID 1648 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:17:28 INFO - PID 1648 | RSS: Main: 336134144 18:17:28 INFO - PID 1648 | 18:17:31 INFO - PID 1648 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:17:32 INFO - PID 1648 | RSS: Main: 335732736 18:17:32 INFO - PID 1648 | 18:17:35 INFO - PID 1648 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:17:36 INFO - PID 1648 | RSS: Main: 346238976 18:17:36 INFO - PID 1648 | 18:17:38 INFO - PID 1648 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49236/tests/kraken/driver.html?testName=ai-astar) 18:17:38 INFO - PID 1648 | RSS: Main: 389496832 18:17:38 INFO - PID 1648 | 18:17:38 INFO - PID 1648 | __start_tp_report 18:17:38 INFO - PID 1648 | _x_x_mozilla_page_load 18:17:38 INFO - PID 1648 | _x_x_mozilla_page_load_details 18:17:38 INFO - PID 1648 | |i|pagename|runs| 18:17:38 INFO - PID 1648 | |0;ai-astar;155;165;141;110;111;110;110;110;110;110 18:17:38 INFO - PID 1648 | |1;audio-beat-detection;145;136;142;149;142;142;110;112;148;91 18:17:38 INFO - PID 1648 | |2;audio-dft;184;186;186;186;187;184;186;184;180;185 18:17:38 INFO - PID 1648 | |3;audio-fft;81;57;56;90;91;87;79;58;82;59 18:17:38 INFO - PID 1648 | |4;audio-oscillator;93;69;85;76;70;69;87;69;69;92 18:17:38 INFO - PID 1648 | |5;imaging-gaussian-blur;90;90;90;89;99;134;90;90;90;89 18:17:38 INFO - PID 1648 | |6;imaging-darkroom;97;95;97;96;98;96;95;96;98;96 18:17:38 INFO - PID 1648 | |7;imaging-desaturate;88;83;84;84;84;86;86;85;86;84 18:17:38 INFO - PID 1648 | |8;json-parse-financial;50;47;48;47;48;48;48;48;49;48 18:17:38 INFO - PID 1648 | |9;json-stringify-tinderbox;54;58;55;61;64;57;55;54;56;57 18:17:38 INFO - PID 1648 | |10;stanford-crypto-aes;84;84;81;82;81;84;84;84;83;83 18:17:38 INFO - PID 1648 | |11;stanford-crypto-ccm;138;137;137;137;137;137;140;142;202;140 18:17:38 INFO - PID 1648 | |12;stanford-crypto-pbkdf2;183;186;191;235;185;187;187;184;186;187 18:17:38 INFO - PID 1648 | |13;stanford-crypto-sha256-iterative;67;67;66;67;67;68;68;69;68;68 18:17:38 INFO - PID 1648 | __end_tp_report 18:17:38 INFO - PID 1648 | __start_cc_report 18:17:38 INFO - PID 1648 | _x_x_mozilla_cycle_collect,2247 18:17:38 INFO - PID 1648 | __end_cc_report 18:17:38 INFO - PID 1648 | __startTimestamp1492823858298__endTimestamp 18:17:38 INFO - PID 1648 | 18:17:38 INFO - PID 1648 | ------- Summary: start ------- 18:17:38 INFO - PID 1648 | Number of tests: 14 18:17:38 INFO - PID 1648 | 18:17:38 INFO - PID 1648 | [#0] ai-astar Cycles:10 Average:123.20 Median:110.50 stddev:21.78 (19.7%) stddev-sans-first:19.83 18:17:38 INFO - PID 1648 | Values: 155.0 165.0 141.0 110.0 111.0 110.0 110.0 110.0 110.0 110.0 18:17:38 INFO - PID 1648 | 18:17:38 INFO - PID 1648 | [#1] audio-beat-detection Cycles:10 Average:131.70 Median:143.50 stddev:19.98 (13.9%) stddev-sans-first:20.61 18:17:38 INFO - PID 1648 | Values: 145.0 136.0 142.0 149.0 142.0 142.0 110.0 112.0 148.0 91.0 18:17:38 INFO - PID 1648 | 18:17:38 INFO - PID 1648 | [#2] audio-dft Cycles:10 Average:184.80 Median:186.00 stddev:1.99 (1.1%) stddev-sans-first:2.09 18:17:38 INFO - PID 1648 | Values: 184.0 186.0 186.0 186.0 187.0 184.0 186.0 184.0 180.0 185.0 18:17:38 INFO - PID 1648 | 18:17:38 INFO - PID 1648 | [#3] audio-fft Cycles:10 Average:74.00 Median:81.50 stddev:14.70 (18.0%) stddev-sans-first:15.38 18:17:38 INFO - PID 1648 | Values: 81.0 57.0 56.0 90.0 91.0 87.0 79.0 58.0 82.0 59.0 18:17:38 INFO - PID 1648 | 18:17:38 INFO - PID 1648 | [#4] audio-oscillator Cycles:10 Average:77.90 Median:80.50 stddev:10.24 (12.7%) stddev-sans-first:9.28 18:17:38 INFO - PID 1648 | Values: 93.0 69.0 85.0 76.0 70.0 69.0 87.0 69.0 69.0 92.0 18:17:38 INFO - PID 1648 | 18:17:38 INFO - PID 1648 | [#5] imaging-gaussian-blur Cycles:10 Average:95.10 Median:90.00 stddev:13.98 (15.5%) stddev-sans-first:14.71 18:17:38 INFO - PID 1648 | Values: 90.0 90.0 90.0 89.0 99.0 134.0 90.0 90.0 90.0 89.0 18:17:38 INFO - PID 1648 | 18:17:38 INFO - PID 1648 | [#6] imaging-darkroom Cycles:10 Average:96.40 Median:96.50 stddev:1.07 (1.1%) stddev-sans-first:1.12 18:17:38 INFO - PID 1648 | Values: 97.0 95.0 97.0 96.0 98.0 96.0 95.0 96.0 98.0 96.0 18:17:38 INFO - PID 1648 | 18:17:38 INFO - PID 1648 | [#7] imaging-desaturate Cycles:10 Average:85.00 Median:85.50 stddev:1.49 (1.7%) stddev-sans-first:1.12 18:17:38 INFO - PID 1648 | Values: 88.0 83.0 84.0 84.0 84.0 86.0 86.0 85.0 86.0 84.0 18:17:38 INFO - PID 1648 | 18:17:38 INFO - PID 1648 | [#8] json-parse-financial Cycles:10 Average:48.10 Median:48.00 stddev:0.88 (1.8%) stddev-sans-first:0.60 18:17:38 INFO - PID 1648 | Values: 50.0 47.0 48.0 47.0 48.0 48.0 48.0 48.0 49.0 48.0 18:17:38 INFO - PID 1648 | 18:17:38 INFO - PID 1648 | [#9] json-stringify-tinderbox Cycles:10 Average:57.10 Median:57.00 stddev:3.21 (5.6%) stddev-sans-first:3.21 18:17:38 INFO - PID 1648 | Values: 54.0 58.0 55.0 61.0 64.0 57.0 55.0 54.0 56.0 57.0 18:17:38 INFO - PID 1648 | 18:17:38 INFO - PID 1648 | [#10] stanford-crypto-aes Cycles:10 Average:83.00 Median:84.00 stddev:1.25 (1.5%) stddev-sans-first:1.27 18:17:38 INFO - PID 1648 | Values: 84.0 84.0 81.0 82.0 81.0 84.0 84.0 84.0 83.0 83.0 18:17:38 INFO - PID 1648 | 18:17:38 INFO - PID 1648 | [#11] stanford-crypto-ccm Cycles:10 Average:144.70 Median:139.00 stddev:20.21 (14.5%) stddev-sans-first:21.29 18:17:38 INFO - PID 1648 | Values: 138.0 137.0 137.0 137.0 137.0 137.0 140.0 142.0 202.0 140.0 18:17:38 INFO - PID 1648 | 18:17:38 INFO - PID 1648 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:191.10 Median:187.00 stddev:15.57 (8.3%) stddev-sans-first:16.24 18:17:38 INFO - PID 1648 | Values: 183.0 186.0 191.0 235.0 185.0 187.0 187.0 184.0 186.0 187.0 18:17:38 INFO - PID 1648 | 18:17:38 INFO - PID 1648 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.50 Median:68.00 stddev:0.85 (1.2%) stddev-sans-first:0.88 18:17:38 INFO - PID 1648 | Values: 67.0 67.0 66.0 67.0 67.0 68.0 68.0 69.0 68.0 68.0 18:17:38 INFO - PID 1648 | -------- Summary: end -------- 18:17:38 INFO - PID 1648 | 18:17:39 INFO - TEST-INFO | 1648: exit 0 18:17:39 INFO - TEST-OK | kraken | took 60804ms 18:17:39 INFO - SUITE-END | took 1180s 18:17:39 INFO - Completed test suite (00:19:41) 18:17:39 INFO - javascript benchmark 18:17:40 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7655.168286560708, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3199.8240096794666, 3473.565804274466, 3536.610972792993, 3550.55618047744, 3588.120910376958, 5945.762169513225, 6078.270607527103, 6181.505479561635, 6194.008958566619, 6199.783007594735, 6139.478144357735, 6141.762184092984, 6145.740123274729, 6199.101130336098, 6200.193974783272, 5165.974170129144, 5333.306670132877, 5340.706261155635, 5354.785808567653, 5406.810761623344, 5436.238926550286, 5456.290682211307, 5476.452354764511, 5494.423085576017, 5524.751386187611, 5260.6580572263065, 5309.840704778863, 5321.467853214647, 5342.706151161685, 5435.2934118564535, 5287.0, 5322.787088516493, 5351.518363347279, 5353.705546194958, 5355.973220133913, 5310.867228319285, 5331.1470164773455, 5348.144296912515, 5391.919121213185, 5426.348838139448, 6148.38516148386, 6172.07418887166, 6184.938150618481, 6199.783007594758, 6234.688265586748, 6196.2874269459135, 6328.810135695937, 6515.8696826063215, 6532.444742196919, 6541.28045914949, 6372.299047104815, 6488.643124628144, 6547.050677651761, 6579.901301480481, 6591.967040164816, 6225.066240064027, 6246.718897649571, 6267.122602835607, 6283.340249273806, 6307.180066591313, 6767.221769496571, 6768.7292508299115, 6771.356721111487, 6771.492138089663, 6791.320867913169, 5411.567074634098, 6318.273398559132, 6349.714262858182, 6389.872202555923, 6427.775027874096, 6199.411055949678, 6560.147180866456, 6575.342465753386, 6600.5049621278595, 6600.53796234259, 6402.103705481143, 6421.229452465641, 6459.321771214049, 6469.256035555877, 6504.772332968323, 6265.248170219603, 6317.399847014526, 6318.368163183645, 6497.707603157869, 6500.122483464766, 5186.714730689773, 5208.218767184877, 5233.450487698813, 5248.081585722483, 5251.579873610102, 4633.536646335339, 4633.745144017044, 4641.559051890065, 4647.697899636512, 4685.344051832746, 5999.430054144849, 6130.29501607312, 6201.162843016225, 6208.0, 6212.7263910898155, 6325.114483972247, 6348.079528468346, 6470.12653291809, 6482.546221764525, 6527.477801775846, 6240.563160578807, 6251.3123556408755, 6261.843453913689, 6262.185915830913, 6267.9971204607045, 5766.596338256366, 5768.769249229984, 5768.855778605484, 5776.249087618583, 5804.477597016289, 6467.126937863516, 6550.181227346582, 6550.377714117151, 6553.606783593, 6752.696128674123, 5443.265159203615, 6295.244570651551, 6373.745050198126, 6382.585131966407, 6411.4229719325485, 6752.08846805675, 6760.695768690322, 6765.492588056014, 6796.184457865088, 6797.694103765243, 6410.551261411656, 6413.16628838248, 6424.807255782334, 6425.58233714807, 6425.775097871552, 6279.811605651837, 6345.1434056401795, 6509.772157974448, 6526.836829079311, 6529.9347006531225, 6279.340669229848, 6292.559520833498, 6353.301136875032, 6354.6822658867795, 6364.64994425311, 6307.369263073656, 6308.243010838729, 6312.179416675803, 6331.366863313632, 6338.683065846782, 6292.024736165901, 6294.527910406646, 6299.464545513682, 6308.211473565804, 6313.90529142054, 6254.0, 6328.683565821599, 6340.239171299474, 6372.681365931592, 6380.712867920862, 6296.779612713533, 6298.118263443213, 6299.937000630119, 6301.905471418024, 6313.05304204373], "value": 5977.164908168597, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [795.2365728900257, 795.6300320351036, 1093.3112139352206, 1110.7945030169415, 1114.0530549033317, 35709.46435803465, 36244.0, 36254.45618315724, 36281.45577816335, 36317.81841090791, 38434.42348364777, 38757.612423875755, 38843.0, 38843.41734873979, 38846.8057659712, 6075.665838378887, 6184.690765461732, 8419.368547358958, 8502.914970850305, 8552.315814734837, 8179.813926980584, 8380.20388063133, 8581.0, 8583.313334933191, 8587.95706021469, 7777.5333479991095, 8642.481451112923, 8644.740657780276, 8662.52356120413, 8675.739727808175, 8563.700270490534, 8617.35369847264, 8622.65509379624, 8634.956825215833, 8643.827123457495, 8445.83108337836, 8469.872951905727, 8470.237678608893, 8478.533680647624, 8490.278326342268, 36615.63384366149, 36731.08172295687, 36745.448818267745, 36756.0, 36805.63194368049, 3586.946195807065, 3597.0, 3610.819459027038, 3617.728670349708, 3619.8009109498967, 30647.0, 30696.53955190674, 30697.386052279053, 30750.0, 30751.692483075105, 3105.45654510462, 3143.764217683683, 3156.1793933577437, 3166.4458719723957, 3179.998300535347, 234309.0, 291862.0, 291959.0, 292131.0, 293035.0, 37810.43284350737, 37916.43125353122, 48376.27435588469, 48499.5150048495, 48559.51440485621, 40312.1937561253, 48501.0, 48812.755936220805, 48880.75559622179, 49486.75256623694, 13451.125676830974, 13535.86464135346, 13559.525416610371, 13563.321833908463, 13573.0, 9636.46999415039, 10994.945025274983, 10995.615153469591, 10999.560017599366, 11000.22998390121, 10619.787604247871, 10714.624988125379, 10723.946380268204, 10725.51735171919, 12161.878381216251, 5048.343715316985, 5106.795728170906, 5108.591312694975, 5110.565601923804, 5118.974405128025, 973.8733964584559, 985.1527686189871, 987.1905037868878, 1021.2034613001871, 1039.3296323871211, 23814.0, 23981.280561583182, 24002.639960400607, 24020.63969040466, 24057.398565036015, 1080.3895798873612, 1082.377632861108, 1112.666200139971, 1114.4706264524286, 1129.9943500282445, 9722.659706910224, 11616.244944078608, 12184.20802647825, 12251.32617706017, 12304.015678745678, 303015.0, 303277.0, 303371.0, 303701.0, 304023.0, 50375.0, 50376.95476542838, 50378.24432633514, 50481.0, 50580.98838023219, 1475.1517877220426, 1480.163707505256, 1515.9317830697426, 1520.8022957015517, 1528.388644542192, 19134.330298439487, 22244.77755222427, 23301.92216362096, 23432.0, 23434.0, 36840.81579592085, 36970.8151459241, 37025.0, 37035.81482092572, 37072.44391334078, 286907.0, 286948.0, 287197.0, 287439.0, 287650.0, 33082.33835323328, 33094.83452582722, 33120.006399808044, 33172.336553269284, 33177.0, 33944.490832637035, 35553.75561855322, 41498.0, 42140.52508162322, 42268.577314226466, 28586.85706571454, 29248.976285829893, 29785.85107074451, 29885.402291953604, 30183.69816301809, 23771.52456950886, 28617.427651446436, 29518.0, 29528.557071644373, 29736.851315743283, 34778.13054673653, 34792.82603586966, 35249.0, 35503.0, 35554.46668299926, 29094.854525727234, 29856.955006574666, 29885.402291954473, 29885.551716723832, 30207.546886797154, 18277.634447311244, 23058.192963246205, 23059.96450621168, 23325.0, 23404.414889627213], "value": 16840.440672337067, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [378.9738934607163, 427.07814833250376, 439.4836067620545, 441.57608695652175, 456.4298812086424, 17286.0, 21092.261770838024, 21832.23587174449, 21899.291652294753, 22191.11235550576, 22515.54968900621, 22556.774432255672, 22781.772182278215, 22806.31581052567, 23624.936877840497, 4992.375953005874, 6224.15973843531, 6321.146645202908, 6392.840178995516, 6410.487161027107, 6285.654289014103, 6326.778562750304, 6336.778212762554, 6341.8097457076365, 6349.873002539946, 6088.573799834014, 6144.754209831602, 6296.685165741717, 6298.527610429213, 6325.27259365172, 5207.687538747668, 5867.442592953663, 6230.688465576703, 6240.188775459184, 6245.032020036879, 5421.647592906448, 5479.0, 5490.80782172622, 5496.80761173361, 5501.119820828648, 24980.5003899921, 27269.0, 27356.31609209766, 28351.72417241229, 28560.0, 2206.3270702435752, 2250.8199344052437, 2251.572201281768, 2254.211026140854, 2254.627986382245, 16863.15684215784, 18331.26674933001, 18430.53923651906, 18496.907515462335, 18678.62642747151, 2080.91676332948, 2110.97617655437, 2160.6650969099815, 2167.783221677835, 2174.7716489768663, 153844.0, 163806.0, 166582.0, 168800.0, 169484.0, 10330.0259679858, 11206.21556491054, 12340.629781106582, 12353.197042192229, 12556.121071524905, 16478.83521164773, 16735.74896376531, 16742.665146696996, 16781.832181678026, 16803.327866885433, 8922.68770593026, 8938.731838044869, 9001.279897608176, 9120.996690364054, 9202.435585950405, 8503.914960850312, 8508.361872859561, 8538.957305213435, 8705.260052895575, 8729.039805621376, 7016.543924644881, 7397.926020739831, 7968.243016913384, 7993.240642138988, 8026.0, 2162.9567408652056, 2193.4187440328324, 2193.8573992690426, 2206.9668954965687, 2343.83593148478, 918.7381596245039, 950.2303134461108, 951.9252813412716, 955.9187469065207, 956.6221342569646, 20755.8962205188, 21060.26289079875, 21216.575668486545, 21250.468738281666, 21386.78613213848, 828.4118276024091, 985.0, 998.7403275148368, 1001.5277542013229, 1004.5077911823154, 10417.791644167226, 10883.673489795161, 10886.836697449544, 10935.781284374269, 10962.890371096346, 543156.0, 555930.0, 565350.0, 567381.0, 569127.0, 129328.3533582326, 142110.0, 142128.28935855255, 147256.52743472642, 148332.25833870762, 1152.4181493803976, 1169.1932566529067, 1220.7192345760348, 1226.7669142863006, 1232.3160645841465, 20068.69896951576, 22396.0, 22440.438989025406, 22860.4284892879, 22952.540949181257, 57364.71317643552, 58417.70791146017, 58993.705031474565, 59467.40532594792, 60253.0, 78285.60857195678, 79279.0, 79603.0, 80486.0, 81087.0, 12756.744865102832, 13335.0, 13345.933270333586, 13695.109817861807, 13761.931190344385, 14614.707705846036, 14631.487897923522, 14841.554753357417, 15019.249037547861, 15037.947343685837, 11936.283822970303, 12139.939300303795, 12432.937835310766, 12466.252024878537, 12587.118901676795, 11441.485133169193, 11554.191206615456, 11694.239874408137, 12011.699707507381, 12027.518899243933, 11537.769244615229, 12084.978755311173, 12183.756324873275, 12715.364231788188, 12863.099583029098, 12913.096083274457, 12994.855848785222, 13024.674383140497, 13236.669083272995, 13243.0, 12000.75998480043, 12058.0, 12132.0, 12214.877851221729, 12290.877091228973], "value": 10851.084268855395, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1348.3999620169025, 1395.065306244816, 1418.5602463236391, 1419.3258202353884, 1419.4676996126452, 11126.276792008513, 11643.708907277321, 11644.534218631266, 11645.475953582089, 11661.41692915354, 11290.379029153393, 11448.48481818318, 11646.767064658701, 11797.646070617873, 11815.7636847263, 2513.7863281621085, 2561.1036137351966, 2563.8718064096815, 2564.5127425789133, 2567.4608332250154, 2476.0962248779156, 2520.2943175910773, 2521.1680145552014, 2522.8738563071774, 2527.1028784781415, 2376.714794224687, 2457.447074408262, 2457.7665121813397, 2463.716672582658, 2467.2721547143638, 2472.0606169655416, 2482.342179322481, 2495.9126430575025, 2498.4503409249937, 2503.173952595639, 2494.5759220932487, 2528.7218405975327, 2528.898844046236, 2530.316814460104, 2530.6457096006575, 11254.774904501865, 11674.766504669944, 11681.591144309994, 11685.357305348203, 11691.532338706442, 6562.179727534059, 6809.080774095483, 6818.659067046628, 6825.453963682893, 6829.453643708541, 3931.0958479549577, 4270.530241673413, 4355.128974205171, 4360.803763830635, 4365.912681746379, 1225.7548490301974, 1239.9504019839196, 1292.6445227562401, 1292.8513220979614, 1293.6701141208932, 15155.469558565508, 15536.844631553766, 15561.0, 16488.587785305343, 16682.249298781462, 5488.286522752017, 5600.607957443021, 5787.305523337226, 5788.942110578924, 5846.649201047951, 12138.332391718364, 12182.451789669487, 12197.817032744517, 12198.756024879453, 12203.511859525697, 6542.182227221598, 6543.1821022372205, 6547.247066587308, 6552.868942621121, 6555.410013098749, 6090.025595904634, 6161.907571386433, 6177.320494745574, 6199.907001394983, 6259.843503912439, 4189.8212929277215, 4320.503142138631, 4369.80335884886, 4421.911561768747, 4427.0, 1283.8523569789406, 1308.770965081126, 1310.3382791690135, 1325.9867401326055, 1329.6210579984659, 660.4650233311033, 711.4308553157454, 772.2856357869061, 773.3233420756837, 778.8014056415577, 6015.30823955242, 6020.759169633166, 6082.452579267887, 6201.44277250309, 6364.459020983176, 577.6967092276589, 596.3916804859019, 603.9818805435845, 605.340179204669, 608.4068033667139, 3638.7089032877307, 3789.9242015160094, 4072.572379900127, 4186.6859985501205, 4416.4037854889175, 14580.270986450634, 14919.552413427615, 14923.70152596942, 15278.312475938386, 15354.616134596725, 14713.55859324222, 15000.924995375171, 15222.391104355702, 15301.387944482318, 15313.770293445607, 8240.711575094843, 8489.61796719149, 8586.184312490428, 8598.355123365773, 8612.009618893908, 6436.967815160894, 6849.794506164823, 7098.00627912103, 7130.964345178241, 7204.76652237787, 11620.825687614524, 13626.1143025703, 13839.238841863391, 13845.307734613027, 13883.0, 12709.0, 13934.0, 13936.72126557443, 13940.790888136484, 14276.857231427553, 9456.763580910532, 9500.524973751146, 9613.567389467631, 9616.326857119935, 9616.567254473426, 9450.858237126586, 9850.0, 10459.94770026145, 10561.788764224519, 10581.788364232518, 8854.468731876108, 8892.955535222283, 8960.68637597681, 8969.955150224207, 9050.366474346733, 8702.869456958024, 8711.390202686005, 8767.605457754544, 8791.428557143765, 8853.247473964786, 7569.053868266466, 7731.265529774662, 7734.845303094019, 7736.458447908817, 7739.380849532136, 5575.804846830341, 5971.790987315423, 6079.848003799763, 6169.01295792671, 6206.193194884636, 5883.470487656132, 5928.436798504308, 6055.212822333068, 6117.1741814856205, 6202.937970620236], "value": 5295.102776676925, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [347.30019011691445, 389.80120138729245, 402.45467391684247, 404.11297202640196, 405.87417900450845, 4752.667313288067, 5231.372235331765, 5257.526822585966, 5736.537183018329, 5777.364489906117, 4820.349252850873, 5457.481539253775, 5539.972300138504, 5620.57845661575, 5691.971540142304, 4250.957490425087, 4260.914781704364, 4262.722923009995, 4266.765327906964, 4270.402143699885, 3824.3498605237037, 4012.1775036117524, 4260.72305300156, 4261.083866968601, 4267.829286828523, 3636.4727114568373, 3932.2528719543197, 4004.796163069547, 4156.750594964296, 4223.345381465878, 4173.64524015459, 4173.937390939153, 4177.540470548237, 4186.518550366686, 4192.538820729717, 3625.7099432045375, 3640.526731524911, 3671.2290419011774, 3677.6506231908193, 3680.650338217865, 4414.955850441486, 4715.622750179978, 4997.925031124536, 5042.873928151789, 5508.421615730331, 4244.0, 4686.882827929295, 4814.951850481485, 4829.613630909554, 4941.530554597308, 4982.0, 6005.789797357115, 6012.518998480155, 6021.909671354933, 6031.492126968258, 3886.4558961745097, 4128.380742888591, 4137.668986481074, 4140.751554906716, 4144.212599606095, 5516.779328826842, 5866.941330586725, 6053.878922421571, 6268.435840774352, 6365.204349456318, 3475.826208689555, 4101.7744024078365, 4140.399642051885, 4146.398772178018, 4157.210130075276, 4206.390073439334, 4214.093969796447, 4216.177845320133, 4232.2647714436935, 4240.554741752133, 3964.2467931093, 4492.28123500245, 4594.609458196091, 4885.1680619767585, 4906.754662266872, 5864.765409383577, 5928.318243401977, 5998.5508332708, 6003.369646187175, 6015.826913751776, 1121.5906194239208, 1436.3967133803828, 1436.7557515222438, 1438.8489208632943, 1452.4408102880468, 947.2374738335706, 955.9569819358146, 958.5621567648527, 962.1629182611173, 973.7468258252906, 5628.577856660767, 5637.0, 5638.013347664142, 5663.546916246691, 5679.0, 5104.69371837691, 5213.400458947193, 5849.941500585025, 6140.539459540552, 6163.691815409212, 5376.542993845489, 5573.498385145356, 5645.209670646031, 5647.265855438766, 5648.237487939158, 3020.275133967832, 3147.898235617561, 3154.227214332457, 3197.536357228189, 3212.566303548991, 5508.669479831223, 6017.398260174035, 6314.273858506239, 6395.104685344056, 6401.9039714404325, 6299.5275354348605, 6317.052442133717, 6317.4946004319545, 6325.272593651697, 6395.104685344056, 5214.556762675215, 5891.0, 6351.301356850743, 6358.395952384423, 6367.204099487564, 5528.894221155704, 5821.621594596338, 6135.907961380493, 6141.0, 6187.071939209155, 5165.560927321069, 6039.667818270037, 6043.8186854394435, 6058.878822423615, 6092.482139018233, 4994.80020799164, 5907.232059832366, 6178.691065446799, 6266.467350275096, 6404.839879002876, 3484.5121682964914, 4133.297339452361, 4134.359174327984, 4143.958560414358, 4145.8963525912095, 5919.4968427684125, 6194.349593292639, 6207.720652570555, 6210.627362358273, 6228.968855155696, 5210.838864214872, 5489.87457571205, 5966.761329546943, 5984.84545563588, 5988.850278742892, 4630.861074167646, 5012.323336349692, 5203.947960520346, 5205.973970130125, 5911.231539899785, 5627.127795191752, 5804.21643078179, 5822.301323841166, 5831.571265040092, 5883.529317654663, 4694.319323698113, 4930.531599498042, 5947.553933454921, 5956.642601443928, 5998.430149135826, 5247.658902171346, 5504.202100550608, 5560.860978475571, 5709.343425505954, 5877.4122587740885], "value": 4339.345651045993, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [691.6472598974522, 724.5507785173193, 836.5858899844574, 845.2688424512796, 847.940644154909, 12856.807147892778, 17969.371072012484, 18063.729044064334, 18457.35399261028, 18494.44516664499, 16750.0, 17009.829901700978, 17286.913565432187, 17331.22009509572, 17358.47924562262, 874.1739056591508, 886.1227384888978, 887.1704955866253, 889.3996552327153, 890.1765866573426, 641.275358844505, 656.4879394072631, 905.7373361725092, 915.7069737683944, 944.9558238146852, 981.6318880419842, 982.1749730226608, 983.1446641421973, 986.5856340337076, 998.0568362897066, 975.073680003999, 976.9560369783342, 977.5552123783662, 979.2802290316612, 993.4436715439341, 617.7837756785134, 722.3101937649532, 722.4328901812105, 724.6087112958995, 735.672625681572, 15738.0, 16153.353865845353, 16297.103659298733, 16470.258838352303, 16775.32898684051, 16201.0, 16278.348866045344, 16442.095684737335, 16659.91710538823, 16689.582760430963, 12531.56139535121, 12758.553450629277, 12809.10336276461, 12962.092653514257, 12982.0, 3394.8472318745717, 3409.352223077632, 3415.3681568909833, 3415.9316813663836, 3416.145963509123, 111357.99999999919, 115404.0, 115546.42226788812, 116040.0, 116164.0, 10728.141748660088, 11034.944825275823, 13132.277724725232, 13477.932610336886, 13484.0, 15751.739860811107, 17440.558321834953, 24732.010719571375, 24786.0, 24807.25578232656, 7620.276073772982, 7722.498037627536, 7816.06207255133, 7888.447808653339, 7895.526268423913, 3836.731428800013, 3899.005753532831, 3905.6094390561284, 3906.980465097656, 3911.4523966644692, 3561.893143205708, 4179.393987871742, 4243.702940794176, 4321.049369138847, 4327.3725309830525, 916.8303863785221, 944.0748066894482, 946.8485042393322, 949.1362859797551, 950.4107453378949, 526.4919352824543, 586.6362855029909, 649.3117295666608, 657.5824351536809, 697.3688811625487, 11101.278416902875, 11631.941840290745, 11819.940900295443, 11991.280523168638, 12103.394830258452, 653.7646447278976, 660.455124522271, 663.1213641924469, 669.100060418736, 686.0361192524512, 5370.731463426813, 5400.972995135077, 5582.190582365534, 5600.831975040674, 5708.65748055118, 87538.68691969625, 92084.0, 95929.0, 96801.51599241959, 97872.02127978772, 81224.0, 82112.0, 83233.0, 83604.0, 84958.0, 72067.0, 73331.63334183402, 74251.88622170672, 74258.8861167083, 75379.0, 10384.0, 11811.881881181078, 12296.0, 12417.875821242033, 12492.125551211691, 39711.2057758849, 39896.60103399045, 40058.799706001286, 40518.79740601278, 40986.38520422136, 38827.25277362582, 45218.77390613026, 51155.0, 51443.74278128735, 52321.21518177306, 15971.840281597035, 16001.0, 16062.955907865951, 16179.514614561582, 16430.75353869717, 14906.701865962837, 14986.80105591572, 17728.0, 18179.27282908722, 18249.178786954355, 16759.664806703553, 17116.315347386462, 17170.96974181553, 17396.217170227115, 17623.295068197127, 16957.830421695624, 17132.486025419257, 17386.391476298268, 17548.12259387051, 17605.911970440065, 16324.265408056428, 16567.0, 16817.243224054702, 16880.746788798424, 17133.74299385535, 10426.635067772591, 11700.824487632863, 11884.76230475403, 12023.633382652872, 12104.394780260776, 11752.23610465317, 13146.474141034252, 13291.53479628247, 13316.105343503896, 13458.663533411744], "value": 8018.140378220755, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1459.6000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 165.0, 141.0, 110.0, 111.0, 110.0, 110.0, 110.0, 110.0, 110.0], "value": 123.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 136.0, 142.0, 149.0, 142.0, 142.0, 110.0, 112.0, 148.0, 91.0], "value": 131.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 186.0, 186.0, 186.0, 187.0, 184.0, 186.0, 184.0, 180.0, 185.0], "value": 184.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 57.0, 56.0, 90.0, 91.0, 87.0, 79.0, 58.0, 82.0, 59.0], "value": 74.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 69.0, 85.0, 76.0, 70.0, 69.0, 87.0, 69.0, 69.0, 92.0], "value": 77.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 90.0, 90.0, 89.0, 99.0, 134.0, 90.0, 90.0, 90.0, 89.0], "value": 95.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 95.0, 97.0, 96.0, 98.0, 96.0, 95.0, 96.0, 98.0, 96.0], "value": 96.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 83.0, 84.0, 84.0, 84.0, 86.0, 86.0, 85.0, 86.0, 84.0], "value": 85.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 47.0, 48.0, 47.0, 48.0, 48.0, 48.0, 48.0, 49.0, 48.0], "value": 48.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 58.0, 55.0, 61.0, 64.0, 57.0, 55.0, 54.0, 56.0, 57.0], "value": 57.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 81.0, 82.0, 81.0, 84.0, 84.0, 84.0, 83.0, 83.0], "value": 83.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 137.0, 137.0, 137.0, 137.0, 137.0, 140.0, 142.0, 202.0, 140.0], "value": 144.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 186.0, 191.0, 235.0, 185.0, 187.0, 187.0, 184.0, 186.0, 187.0], "value": 191.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 66.0, 67.0, 67.0, 68.0, 68.0, 69.0, 68.0, 68.0], "value": 67.5, "unit": "score"}]}]} 18:17:40 INFO - Return code: 0 18:17:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:17:40 ERROR - # TBPL SUCCESS # 18:17:40 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:17:40 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:17:40 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:17:40 INFO - 2017-04-21 18:17:40.103 screenresolution[1652:9751] starting screenresolution argv=screenresolution get 18:17:40 INFO - 2017-04-21 18:17:40.106 screenresolution[1652:9751] Display 0: 1600x1200x32@60 18:17:40 INFO - 2017-04-21 18:17:40.112 screenresolution[1653:9754] starting screenresolution argv=screenresolution list 18:17:40 INFO - Available Modes on Display 0 18:17:40 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:17:40 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:17:40 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:17:40 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:17:40 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:17:40 INFO - Intel Iris: 18:17:40 INFO - Chipset Model: Intel Iris 18:17:40 INFO - Type: GPU 18:17:40 INFO - Bus: Built-In 18:17:40 INFO - VRAM (Dynamic, Max): 1536 MB 18:17:40 INFO - Vendor: Intel (0x8086) 18:17:40 INFO - Device ID: 0x0a2e 18:17:40 INFO - Revision ID: 0x0009 18:17:40 INFO - Displays: 18:17:40 INFO - Display: 18:17:40 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:17:40 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:17:40 INFO - Display Serial Number: 1600x1200 60 18:17:40 INFO - Main Display: Yes 18:17:40 INFO - Mirror: Off 18:17:40 INFO - Online: Yes 18:17:40 INFO - Rotation: Supported 18:17:40 INFO - Return code: 0 18:17:40 INFO - Running post-action listener: _resource_record_post_action 18:17:40 INFO - [mozharness: 2017-04-22 01:17:40.346590Z] Finished run-tests step (success) 18:17:40 INFO - Running post-run listener: _resource_record_post_run 18:17:40 INFO - Total resource usage - Wall time: 1202s; CPU: 53.0%; Read bytes: 47981568; Write bytes: 520558080; Read time: 539; Write time: 1838 18:17:40 INFO - TinderboxPrint: CPU usage
53.3% 18:17:40 INFO - TinderboxPrint: I/O read bytes / time
47,981,568 / 539 18:17:40 INFO - TinderboxPrint: I/O write bytes / time
520,558,080 / 1,838 18:17:40 INFO - TinderboxPrint: CPU idle
2,244.8 (46.7%) 18:17:40 INFO - TinderboxPrint: CPU system
960.6 (20.0%) 18:17:40 INFO - TinderboxPrint: CPU user
1,604.1 (33.4%) 18:17:40 INFO - TinderboxPrint: Swap in / out
247,005,184 / 0 18:17:40 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 201040384; Write bytes: 197011456; Read time: 16006; Write time: 550 18:17:40 INFO - run-tests - Wall time: 1182s; CPU: 53.0%; Read bytes: 46085120; Write bytes: 306904576; Read time: 516; Write time: 1240 18:17:40 INFO - Running post-run listener: _upload_blobber_files 18:17:40 INFO - Blob upload gear active. 18:17:40 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:17:40 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 18:17:40 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'] 18:17:40 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 18:17:41 INFO - (blobuploader) - INFO - Open directory for files ... 18:17:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 18:17:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:17:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:17:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 18:17:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:17:41 INFO - (blobuploader) - INFO - Done attempting. 18:17:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 18:17:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:17:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:17:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 18:17:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:17:42 INFO - (blobuploader) - INFO - Done attempting. 18:17:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 18:17:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:17:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:17:44 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 18:17:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:17:44 INFO - (blobuploader) - INFO - Done attempting. 18:17:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:17:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:17:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:17:46 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:17:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:17:46 INFO - (blobuploader) - INFO - Done attempting. 18:17:46 INFO - (blobuploader) - INFO - Iteration through files over. 18:17:46 INFO - Return code: 0 18:17:46 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:17:46 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:17:46 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/b558a105b8644f7e15157800fe77d795323f72e3d5168eebf75b09b113f7fb77e424d24d9c47f53e09514b28e415bdc0bf0fb8c2796208ec5c72eaa5d5cc9e2c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/efcd7c879ddcf686c76369d679897c99f836522c63d846fe8eb54f955899d14a813e979351993a0331667a37e4d309176799825368df35b78a25291e9b6d8545", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/ac1fe2fecf9b55065d784321b97d23a4b18e3a294b1f11044eec65061a9be40c41ca0c616ac7d094dcb322af8b6e32ad164ae5d2d21bb4a6c2b0a14d6984f918", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/e5aa054c7aa3028226b64e88dbbfeb3f7400ee2bccf418470201e5e76ef5953a5c89c03da8ba8c93c3efa56ec3219f55f4f0adf7e23b305cabdb0ca38839bc74"} 18:17:46 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:17:46 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:17:46 INFO - Contents: 18:17:46 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/b558a105b8644f7e15157800fe77d795323f72e3d5168eebf75b09b113f7fb77e424d24d9c47f53e09514b28e415bdc0bf0fb8c2796208ec5c72eaa5d5cc9e2c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/efcd7c879ddcf686c76369d679897c99f836522c63d846fe8eb54f955899d14a813e979351993a0331667a37e4d309176799825368df35b78a25291e9b6d8545", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/ac1fe2fecf9b55065d784321b97d23a4b18e3a294b1f11044eec65061a9be40c41ca0c616ac7d094dcb322af8b6e32ad164ae5d2d21bb4a6c2b0a14d6984f918", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/e5aa054c7aa3028226b64e88dbbfeb3f7400ee2bccf418470201e5e76ef5953a5c89c03da8ba8c93c3efa56ec3219f55f4f0adf7e23b305cabdb0ca38839bc74"} 18:17:46 INFO - Running post-run listener: copy_logs_to_upload_dir 18:17:46 INFO - Copying logs to upload dir... 18:17:46 INFO - mkdir: /builds/slave/test/build/upload/logs 18:17:46 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1287.125021 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 27 secs) (at 2017-04-21 18:17:46.324668) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-21 18:17:46.328741) ========= 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.k9f9pv0C3m/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.jAaQXqMjbz/Listeners TMPDIR=/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/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/b558a105b8644f7e15157800fe77d795323f72e3d5168eebf75b09b113f7fb77e424d24d9c47f53e09514b28e415bdc0bf0fb8c2796208ec5c72eaa5d5cc9e2c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/efcd7c879ddcf686c76369d679897c99f836522c63d846fe8eb54f955899d14a813e979351993a0331667a37e4d309176799825368df35b78a25291e9b6d8545", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/ac1fe2fecf9b55065d784321b97d23a4b18e3a294b1f11044eec65061a9be40c41ca0c616ac7d094dcb322af8b6e32ad164ae5d2d21bb4a6c2b0a14d6984f918", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/e5aa054c7aa3028226b64e88dbbfeb3f7400ee2bccf418470201e5e76ef5953a5c89c03da8ba8c93c3efa56ec3219f55f4f0adf7e23b305cabdb0ca38839bc74"} build_url:https://queue.taskcluster.net/v1/task/QAPOB5PRRoOcPDxZAQEj9w/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011255 build_url: 'https://queue.taskcluster.net/v1/task/QAPOB5PRRoOcPDxZAQEj9w/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/b558a105b8644f7e15157800fe77d795323f72e3d5168eebf75b09b113f7fb77e424d24d9c47f53e09514b28e415bdc0bf0fb8c2796208ec5c72eaa5d5cc9e2c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/efcd7c879ddcf686c76369d679897c99f836522c63d846fe8eb54f955899d14a813e979351993a0331667a37e4d309176799825368df35b78a25291e9b6d8545", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/ac1fe2fecf9b55065d784321b97d23a4b18e3a294b1f11044eec65061a9be40c41ca0c616ac7d094dcb322af8b6e32ad164ae5d2d21bb4a6c2b0a14d6984f918", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/e5aa054c7aa3028226b64e88dbbfeb3f7400ee2bccf418470201e5e76ef5953a5c89c03da8ba8c93c3efa56ec3219f55f4f0adf7e23b305cabdb0ca38839bc74"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-21 18:17:46.364318) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-21 18:17:46.364651) ========= 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.k9f9pv0C3m/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.jAaQXqMjbz/Listeners TMPDIR=/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/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.005068 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-21 18:17:46.413313) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-21 18:17:46.413654) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-21 18:17:46.414005) ========= ========= Total master_lag: 0.46 =========