builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0029 starttime: 1477348391.51 results: success (0) buildid: 20161024132222 builduid: 1841bbc2e93d45fb993353b1dd2f6e7f revision: 6648f996b7024cd155e1a32757d83dfe63939041 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-24 15:33:11.509019) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-24 15:33:11.509503) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-24 15:33:11.509839) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-24 15:33:11.539730) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 15:33:11.540122) ========= 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.AC1Yxppj7c/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.i7iQcC0tnP/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 --2016-10-24 15:33:11-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 15.8M=0.001s 2016-10-24 15:33:11 (15.8 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.127371 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 15:33:11.690452) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 15:33:11.693954) ========= 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.AC1Yxppj7c/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.i7iQcC0tnP/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.027999 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 15:33:11.742783) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 15:33:11.743195) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 6648f996b7024cd155e1a32757d83dfe63939041 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 6648f996b7024cd155e1a32757d83dfe63939041 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.AC1Yxppj7c/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.i7iQcC0tnP/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 2016-10-24 15:33:11,816 truncating revision to first 12 chars 2016-10-24 15:33:11,816 Setting DEBUG logging. 2016-10-24 15:33:11,816 attempt 1/10 2016-10-24 15:33:11,816 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/6648f996b702?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-24 15:33:12,445 unpacking tar archive at: mozilla-aurora-6648f996b702/testing/mozharness/ program finished with exit code 0 elapsedTime=0.910221 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 15:33:12.678463) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-24 15:33:12.681887) ========= script_repo_revision: 6648f996b7024cd155e1a32757d83dfe63939041 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-24 15:33:12.682347) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-24 15:33:12.682622) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-24 15:33:12.700978) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-10-24 15:33:12.701377) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.AC1Yxppj7c/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.i7iQcC0tnP/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 15:33:12 INFO - MultiFileLogger online at 20161024 15:33:12 in /builds/slave/test 15:33:12 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 15:33:12 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:33:12 INFO - {'append_to_log': False, 15:33:12 INFO - 'base_work_dir': '/builds/slave/test', 15:33:12 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 15:33:12 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:33:12 INFO - 'branch': 'Mozilla-Aurora', 15:33:12 INFO - 'buildbot_json_path': 'buildprops.json', 15:33:12 INFO - 'config_files': ('talos/mac_config.py',), 15:33:12 INFO - 'default_actions': ('clobber', 15:33:12 INFO - 'read-buildbot-config', 15:33:12 INFO - 'download-and-extract', 15:33:12 INFO - 'populate-webroot', 15:33:12 INFO - 'create-virtualenv', 15:33:12 INFO - 'install', 15:33:12 INFO - 'run-tests'), 15:33:12 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:33:12 INFO - 'download_minidump_stackwalk': True, 15:33:12 INFO - 'download_symbols': 'ondemand', 15:33:12 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:33:12 INFO - 'tooltool.py': '/tools/tooltool.py', 15:33:12 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:33:12 INFO - '/tools/misc-python/virtualenv.py')}, 15:33:12 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:33:12 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:33:12 INFO - 'installer_path': 'installer.exe', 15:33:12 INFO - 'log_level': 'info', 15:33:12 INFO - 'log_name': 'talos', 15:33:12 INFO - 'log_to_console': True, 15:33:12 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 15:33:12 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 15:33:12 INFO - 'opt_config_files': (), 15:33:12 INFO - 'pip_index': False, 15:33:12 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:33:12 INFO - 'cmd': ('bash', 15:33:12 INFO - '-c', 15:33:12 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:33:12 INFO - 'enabled': True, 15:33:12 INFO - 'halt_on_failure': False, 15:33:12 INFO - 'name': 'check_screen_resolution'},), 15:33:12 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:33:12 INFO - 'cmd': ('bash', 15:33:12 INFO - '-c', 15:33:12 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:33:12 INFO - 'enabled': True, 15:33:12 INFO - 'halt_on_failure': False, 15:33:12 INFO - 'name': 'check_screen_resolution'},), 15:33:12 INFO - 'run_cmd_checks_enabled': True, 15:33:12 INFO - 'sps_profile': False, 15:33:12 INFO - 'sps_profile_interval': 0, 15:33:12 INFO - 'suite': 'dromaeojs', 15:33:12 INFO - 'system_bits': '32', 15:33:12 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:33:12 INFO - 'title': 't-yosemite-r7-0029', 15:33:12 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:33:12 INFO - 'use_talos_json': True, 15:33:12 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:33:12 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:33:12 INFO - 'work_dir': 'build'} 15:33:12 INFO - [mozharness: 2016-10-24 22:33:12.894812Z] Running clobber step. 15:33:12 INFO - Running pre-action listener: _resource_record_pre_action 15:33:12 INFO - Running main action method: clobber 15:33:12 INFO - rmtree: /builds/slave/test/build 15:33:12 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:33:15 INFO - Running post-action listener: _resource_record_post_action 15:33:15 INFO - [mozharness: 2016-10-24 22:33:15.079310Z] Finished clobber step (success) 15:33:15 INFO - [mozharness: 2016-10-24 22:33:15.079442Z] Running read-buildbot-config step. 15:33:15 INFO - Running pre-action listener: _resource_record_pre_action 15:33:15 INFO - Running main action method: read_buildbot_config 15:33:15 INFO - Using buildbot properties: 15:33:15 INFO - { 15:33:15 INFO - "project": "", 15:33:15 INFO - "product": "firefox", 15:33:15 INFO - "script_repo_revision": "production", 15:33:15 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 15:33:15 INFO - "repository": "", 15:33:15 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 15:33:15 INFO - "buildid": "20161024132222", 15:33:15 INFO - "pgo_build": "False", 15:33:15 INFO - "basedir": "/builds/slave/test", 15:33:15 INFO - "buildnumber": 108, 15:33:15 INFO - "slavename": "t-yosemite-r7-0029", 15:33:15 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 15:33:15 INFO - "platform": "yosemite_r7", 15:33:15 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 15:33:15 INFO - "branch": "mozilla-aurora", 15:33:15 INFO - "repo_path": "releases/mozilla-aurora", 15:33:15 INFO - "revision": "6648f996b7024cd155e1a32757d83dfe63939041", 15:33:15 INFO - "stage_platform": "macosx64", 15:33:15 INFO - "builduid": "1841bbc2e93d45fb993353b1dd2f6e7f", 15:33:15 INFO - "slavebuilddir": "test" 15:33:15 INFO - } 15:33:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/b0sObbcPRMK77bslfnNe9Q/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 15:33:15 INFO - Running post-action listener: _resource_record_post_action 15:33:15 INFO - [mozharness: 2016-10-24 22:33:15.082694Z] Finished read-buildbot-config step (success) 15:33:15 INFO - [mozharness: 2016-10-24 22:33:15.082843Z] Running download-and-extract step. 15:33:15 INFO - Running pre-action listener: _resource_record_pre_action 15:33:15 INFO - Running main action method: download_and_extract 15:33:15 INFO - mkdir: /builds/slave/test/build/tests 15:33:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:33:15 INFO - trying https://queue.taskcluster.net/v1/task/b0sObbcPRMK77bslfnNe9Q/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 15:33:15 INFO - Downloading https://queue.taskcluster.net/v1/task/b0sObbcPRMK77bslfnNe9Q/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 15:33:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/b0sObbcPRMK77bslfnNe9Q/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json'}, attempt #1 15:33:16 INFO - Downloaded 1199 bytes. 15:33:16 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 15:33:16 INFO - Using the following test package requirements: 15:33:16 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 15:33:16 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 15:33:16 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 15:33:16 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 15:33:16 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 15:33:16 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 15:33:16 INFO - u'jsshell-mac.zip'], 15:33:16 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 15:33:16 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 15:33:16 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 15:33:16 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 15:33:16 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 15:33:16 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 15:33:16 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 15:33:16 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 15:33:16 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 15:33:16 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 15:33:16 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 15:33:16 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 15:33:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/b0sObbcPRMK77bslfnNe9Q/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 15:33:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/b0sObbcPRMK77bslfnNe9Q/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 15:33:16 INFO - Fetch https://queue.taskcluster.net/v1/task/b0sObbcPRMK77bslfnNe9Q/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 15:33:16 INFO - Expected file size: 16438325 15:33:24 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip', u'firefox-51.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 15:33:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/b0sObbcPRMK77bslfnNe9Q/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 15:33:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/b0sObbcPRMK77bslfnNe9Q/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 15:33:24 INFO - Fetch https://queue.taskcluster.net/v1/task/b0sObbcPRMK77bslfnNe9Q/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 15:33:24 INFO - Expected file size: 16438325 15:33:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/b0sObbcPRMK77bslfnNe9Q/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 15:33:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/b0sObbcPRMK77bslfnNe9Q/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 15:33:31 INFO - Fetch https://queue.taskcluster.net/v1/task/b0sObbcPRMK77bslfnNe9Q/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 15:33:31 INFO - Expected file size: 14414081 15:33:32 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')]} 15:33:32 INFO - trying https://queue.taskcluster.net/v1/task/b0sObbcPRMK77bslfnNe9Q/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 15:33:32 INFO - Downloading https://queue.taskcluster.net/v1/task/b0sObbcPRMK77bslfnNe9Q/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 15:33:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/b0sObbcPRMK77bslfnNe9Q/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg'}, attempt #1 15:33:35 INFO - Downloaded 115438077 bytes. 15:33:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/b0sObbcPRMK77bslfnNe9Q/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 15:33:35 INFO - mkdir: /builds/slave/test/properties 15:33:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:33:35 INFO - Writing to file /builds/slave/test/properties/build_url 15:33:35 INFO - Contents: 15:33:35 INFO - build_url:https://queue.taskcluster.net/v1/task/b0sObbcPRMK77bslfnNe9Q/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 15:33:36 INFO - Running post-action listener: _resource_record_post_action 15:33:36 INFO - Running post-action listener: set_extra_try_arguments 15:33:36 INFO - [mozharness: 2016-10-24 22:33:36.410745Z] Finished download-and-extract step (success) 15:33:36 INFO - [mozharness: 2016-10-24 22:33:36.410845Z] Running populate-webroot step. 15:33:36 INFO - Running pre-action listener: _resource_record_pre_action 15:33:36 INFO - Running main action method: populate_webroot 15:33:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:33:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:33:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:33:36 INFO - '--tppagecycles', 15:33:36 INFO - '7'], 15:33:36 INFO - 'tests': ['tsvgm']}}, 15:33:36 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:33:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:33:36 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:33:36 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:33:36 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:33:36 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:33:36 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:33:36 INFO - 'talos_options': ['--disable-e10s'], 15:33:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:33:36 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:33:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:33:36 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:33:36 INFO - 'talos_options': ['--disable-e10s'], 15:33:36 INFO - 'tests': ['damp', 'tps']}, 15:33:36 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:33:36 INFO - 'tests': ['damp', 'tps']}, 15:33:36 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:33:36 INFO - 'tests': ['dromaeo_dom']}, 15:33:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:33:36 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:33:36 INFO - 'tests': ['basic_compositor_video']}, 15:33:36 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:33:36 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:33:36 INFO - 'tests': ['a11yr', 15:33:36 INFO - 'ts_paint', 15:33:36 INFO - 'tpaint', 15:33:36 INFO - 'sessionrestore', 15:33:36 INFO - 'sessionrestore_no_auto_restore', 15:33:36 INFO - 'tabpaint']}, 15:33:36 INFO - 'other-e10s': {'tests': ['a11yr', 15:33:36 INFO - 'ts_paint', 15:33:36 INFO - 'tpaint', 15:33:36 INFO - 'sessionrestore', 15:33:36 INFO - 'sessionrestore_no_auto_restore', 15:33:36 INFO - 'tabpaint']}, 15:33:36 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:33:36 INFO - 'ts_paint', 15:33:36 INFO - 'tpaint', 15:33:36 INFO - 'sessionrestore', 15:33:36 INFO - 'sessionrestore_no_auto_restore', 15:33:36 INFO - 'tabpaint']}, 15:33:36 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:33:36 INFO - 'ts_paint', 15:33:36 INFO - 'tpaint', 15:33:36 INFO - 'sessionrestore', 15:33:36 INFO - 'sessionrestore_no_auto_restore', 15:33:36 INFO - 'tabpaint']}, 15:33:36 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:33:36 INFO - 'tests': ['a11yr', 15:33:36 INFO - 'ts_paint', 15:33:36 INFO - 'tpaint', 15:33:36 INFO - 'sessionrestore', 15:33:36 INFO - 'sessionrestore_no_auto_restore', 15:33:36 INFO - 'tabpaint']}, 15:33:36 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:33:36 INFO - 'tests': ['a11yr', 15:33:36 INFO - 'ts_paint', 15:33:36 INFO - 'tpaint', 15:33:36 INFO - 'sessionrestore', 15:33:36 INFO - 'sessionrestore_no_auto_restore', 15:33:36 INFO - 'tabpaint']}, 15:33:36 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:33:36 INFO - 'tests': ['tsvgx', 15:33:36 INFO - 'tsvgr_opacity', 15:33:36 INFO - 'tart', 15:33:36 INFO - 'tscrollx', 15:33:36 INFO - 'cart']}, 15:33:36 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:33:36 INFO - 'tsvgr_opacity', 15:33:36 INFO - 'tart', 15:33:36 INFO - 'tscrollx', 15:33:36 INFO - 'cart']}, 15:33:36 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:33:36 INFO - 'talos_options': ['--disable-e10s'], 15:33:36 INFO - 'tests': ['tp5o']}, 15:33:36 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:33:36 INFO - 'tests': ['tp5o']}, 15:33:36 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:33:36 INFO - 'talos_options': ['--disable-e10s', 15:33:36 INFO - '--xperf_path', 15:33:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:33:36 INFO - 'tests': ['tp5n']}, 15:33:36 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:33:36 INFO - 'talos_options': ['--xperf_path', 15:33:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:33:36 INFO - 'tests': ['tp5n']}}, 15:33:36 INFO - 'talos.zip': {'path': '', 15:33:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:33:36 INFO - Running post-action listener: _resource_record_post_action 15:33:36 INFO - [mozharness: 2016-10-24 22:33:36.429951Z] Finished populate-webroot step (success) 15:33:36 INFO - [mozharness: 2016-10-24 22:33:36.430060Z] Running create-virtualenv step. 15:33:36 INFO - Running pre-action listener: _resource_record_pre_action 15:33:36 INFO - Running main action method: create_virtualenv 15:33:36 INFO - Creating virtualenv /builds/slave/test/build/venv 15:33:36 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 15:33:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:33:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:33:36 INFO - Using real prefix '/tools/python27' 15:33:36 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:33:37 INFO - Installing distribute.............................................................................................................................................................................................done. 15:33:40 INFO - Installing pip.................done. 15:33:40 INFO - Return code: 0 15:33:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:33:40 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')]} 15:33:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:33:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:40 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')]} 15:33:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:33:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:40 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 0x109e33490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109da9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb4eb574360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109c47d30>, '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 0x109aaddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109c3fb20>, '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.AC1Yxppj7c/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.i7iQcC0tnP/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 15:33:40 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 15:33:40 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 15:33:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AC1Yxppj7c/Render', 15:33:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:33:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:33:40 INFO - 'HOME': '/Users/cltbld', 15:33:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:33:40 INFO - 'LOGNAME': 'cltbld', 15:33:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:33:40 INFO - 'MOZ_NO_REMOTE': '1', 15:33:40 INFO - 'NO_EM_RESTART': '1', 15:33:40 INFO - 'PAGER': '/bin/cat', 15:33:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:33:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:33:40 INFO - 'PWD': '/builds/slave/test', 15:33:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:33:40 INFO - 'SHELL': '/bin/bash', 15:33:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.i7iQcC0tnP/Listeners', 15:33:40 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 15:33:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:33:40 INFO - 'USER': 'cltbld', 15:33:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:33:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:33:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:33:40 INFO - 'XPC_FLAGS': '0x0', 15:33:40 INFO - 'XPC_SERVICE_NAME': '0', 15:33:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:33:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:33:40 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 15:33:40 INFO - Cleaning up... 15:33:40 INFO - Return code: 0 15:33:40 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:33:40 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')]} 15:33:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:33:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:40 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')]} 15:33:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:33:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:40 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 0x109e33490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109da9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb4eb574360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109c47d30>, '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 0x109aaddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109c3fb20>, '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.AC1Yxppj7c/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.i7iQcC0tnP/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 15:33:40 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 15:33:40 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 15:33:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AC1Yxppj7c/Render', 15:33:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:33:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:33:40 INFO - 'HOME': '/Users/cltbld', 15:33:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:33:40 INFO - 'LOGNAME': 'cltbld', 15:33:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:33:40 INFO - 'MOZ_NO_REMOTE': '1', 15:33:40 INFO - 'NO_EM_RESTART': '1', 15:33:40 INFO - 'PAGER': '/bin/cat', 15:33:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:33:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:33:40 INFO - 'PWD': '/builds/slave/test', 15:33:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:33:40 INFO - 'SHELL': '/bin/bash', 15:33:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.i7iQcC0tnP/Listeners', 15:33:40 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 15:33:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:33:40 INFO - 'USER': 'cltbld', 15:33:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:33:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:33:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:33:40 INFO - 'XPC_FLAGS': '0x0', 15:33:40 INFO - 'XPC_SERVICE_NAME': '0', 15:33:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:33:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:33:40 INFO - Downloading/unpacking psutil>=3.1.1 15:33:40 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 15:33:40 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 15:33:40 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 15:33:40 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 15:33:40 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 15:33:40 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 15:33:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:33:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:33:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:33:43 INFO - Installing collected packages: psutil 15:33:43 INFO - Running setup.py install for psutil 15:33:43 INFO - building 'psutil._psutil_osx' extension 15:33:43 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 15:33:44 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 15:33:44 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 15:33:44 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 15:33:44 INFO - building 'psutil._psutil_posix' extension 15:33:44 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 15:33:44 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 15:33:44 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 15:33:44 INFO - ^ 15:33:44 INFO - 1 warning generated. 15:33:44 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 15:33:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:33:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:33:44 INFO - Successfully installed psutil 15:33:44 INFO - Cleaning up... 15:33:44 INFO - Return code: 0 15:33:44 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:33:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:33:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:33:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:33:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:33:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109e33490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109da9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb4eb574360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109c47d30>, '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 0x109aaddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109c3fb20>, '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.AC1Yxppj7c/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.i7iQcC0tnP/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 15:33:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 15:33:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 15:33:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AC1Yxppj7c/Render', 15:33:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:33:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:33:44 INFO - 'HOME': '/Users/cltbld', 15:33:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:33:44 INFO - 'LOGNAME': 'cltbld', 15:33:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:33:44 INFO - 'MOZ_NO_REMOTE': '1', 15:33:44 INFO - 'NO_EM_RESTART': '1', 15:33:44 INFO - 'PAGER': '/bin/cat', 15:33:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:33:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:33:44 INFO - 'PWD': '/builds/slave/test', 15:33:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:33:44 INFO - 'SHELL': '/bin/bash', 15:33:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.i7iQcC0tnP/Listeners', 15:33:44 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 15:33:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:33:44 INFO - 'USER': 'cltbld', 15:33:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:33:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:33:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:33:44 INFO - 'XPC_FLAGS': '0x0', 15:33:44 INFO - 'XPC_SERVICE_NAME': '0', 15:33:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:33:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:33:45 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:33:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:33:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:33:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:33:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:33:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:33:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:33:47 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:33:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:33:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:33:47 INFO - Installing collected packages: mozsystemmonitor 15:33:47 INFO - Running setup.py install for mozsystemmonitor 15:33:47 INFO - Successfully installed mozsystemmonitor 15:33:47 INFO - Cleaning up... 15:33:47 INFO - Return code: 0 15:33:47 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:33:47 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')]} 15:33:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:33:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:48 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')]} 15:33:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:33:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:48 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 0x109e33490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109da9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb4eb574360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109c47d30>, '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 0x109aaddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109c3fb20>, '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.AC1Yxppj7c/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.i7iQcC0tnP/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 15:33:48 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 15:33:48 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 15:33:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AC1Yxppj7c/Render', 15:33:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:33:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:33:48 INFO - 'HOME': '/Users/cltbld', 15:33:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:33:48 INFO - 'LOGNAME': 'cltbld', 15:33:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:33:48 INFO - 'MOZ_NO_REMOTE': '1', 15:33:48 INFO - 'NO_EM_RESTART': '1', 15:33:48 INFO - 'PAGER': '/bin/cat', 15:33:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:33:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:33:48 INFO - 'PWD': '/builds/slave/test', 15:33:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:33:48 INFO - 'SHELL': '/bin/bash', 15:33:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.i7iQcC0tnP/Listeners', 15:33:48 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 15:33:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:33:48 INFO - 'USER': 'cltbld', 15:33:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:33:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:33:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:33:48 INFO - 'XPC_FLAGS': '0x0', 15:33:48 INFO - 'XPC_SERVICE_NAME': '0', 15:33:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:33:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:33:48 INFO - Downloading/unpacking jsonschema==2.5.1 15:33:48 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 15:33:48 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 15:33:48 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 15:33:48 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 15:33:48 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 15:33:48 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 15:33:50 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:33:50 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:33:50 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 15:33:50 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 15:33:50 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 15:33:50 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 15:33:50 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 15:33:50 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 15:33:51 INFO - Downloading functools32-3.2.3-2.tar.gz 15:33:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:33:51 INFO - warning: no files found matching '*.txt' 15:33:51 INFO - no previously-included directories found matching 'build' 15:33:51 INFO - no previously-included directories found matching 'dist' 15:33:51 INFO - no previously-included directories found matching '.git*' 15:33:51 INFO - Installing collected packages: jsonschema, functools32 15:33:51 INFO - Running setup.py install for functools32 15:33:51 INFO - warning: no files found matching '*.txt' 15:33:51 INFO - no previously-included directories found matching 'build' 15:33:51 INFO - no previously-included directories found matching 'dist' 15:33:51 INFO - no previously-included directories found matching '.git*' 15:33:51 INFO - Successfully installed jsonschema functools32 15:33:51 INFO - Cleaning up... 15:33:51 INFO - Return code: 0 15:33:51 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:33:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:33:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:33:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:33:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:33:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x109e33490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109da9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb4eb574360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109c47d30>, '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 0x109aaddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109c3fb20>, '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.AC1Yxppj7c/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.i7iQcC0tnP/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 15:33:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 15:33:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 15:33:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AC1Yxppj7c/Render', 15:33:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:33:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:33:51 INFO - 'HOME': '/Users/cltbld', 15:33:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:33:51 INFO - 'LOGNAME': 'cltbld', 15:33:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:33:51 INFO - 'MOZ_NO_REMOTE': '1', 15:33:51 INFO - 'NO_EM_RESTART': '1', 15:33:51 INFO - 'PAGER': '/bin/cat', 15:33:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:33:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:33:51 INFO - 'PWD': '/builds/slave/test', 15:33:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:33:51 INFO - 'SHELL': '/bin/bash', 15:33:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.i7iQcC0tnP/Listeners', 15:33:51 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 15:33:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:33:51 INFO - 'USER': 'cltbld', 15:33:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:33:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:33:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:33:51 INFO - 'XPC_FLAGS': '0x0', 15:33:51 INFO - 'XPC_SERVICE_NAME': '0', 15:33:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:33:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:33:51 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:33:51 INFO - Cleaning up... 15:33:51 INFO - Return code: 0 15:33:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:33:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:33:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:33:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:33:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:33:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x109e33490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109da9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb4eb574360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109c47d30>, '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 0x109aaddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109c3fb20>, '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.AC1Yxppj7c/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.i7iQcC0tnP/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 15:33:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:33:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:33:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AC1Yxppj7c/Render', 15:33:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:33:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:33:51 INFO - 'HOME': '/Users/cltbld', 15:33:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:33:51 INFO - 'LOGNAME': 'cltbld', 15:33:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:33:51 INFO - 'MOZ_NO_REMOTE': '1', 15:33:51 INFO - 'NO_EM_RESTART': '1', 15:33:51 INFO - 'PAGER': '/bin/cat', 15:33:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:33:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:33:51 INFO - 'PWD': '/builds/slave/test', 15:33:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:33:51 INFO - 'SHELL': '/bin/bash', 15:33:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.i7iQcC0tnP/Listeners', 15:33:51 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 15:33:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:33:51 INFO - 'USER': 'cltbld', 15:33:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:33:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:33:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:33:51 INFO - 'XPC_FLAGS': '0x0', 15:33:51 INFO - 'XPC_SERVICE_NAME': '0', 15:33:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:33:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:33:52 INFO - Downloading/unpacking blobuploader==1.2.4 15:33:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:33:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:33:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:33:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:33:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:33:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:33:54 INFO - Downloading blobuploader-1.2.4.tar.gz 15:33:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:33:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:33:54 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 15:33:54 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 15:33:54 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 15:33:54 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 15:33:54 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 15:33:54 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 15:33:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:33:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:33:55 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 15:33:55 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 15:33:55 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 15:33:55 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 15:33:55 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 15:33:55 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 15:33:55 INFO - Downloading docopt-0.6.1.tar.gz 15:33:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:33:56 INFO - Installing collected packages: blobuploader, requests, docopt 15:33:56 INFO - Running setup.py install for blobuploader 15:33:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:33:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:33:56 INFO - Running setup.py install for requests 15:33:56 INFO - Running setup.py install for docopt 15:33:56 INFO - Successfully installed blobuploader requests docopt 15:33:56 INFO - Cleaning up... 15:33:56 INFO - Return code: 0 15:33:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:33:56 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')]} 15:33:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:33:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:56 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')]} 15:33:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:33:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:56 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 0x109e33490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109da9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb4eb574360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109c47d30>, '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 0x109aaddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109c3fb20>, '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.AC1Yxppj7c/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.i7iQcC0tnP/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 15:33:56 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 15:33:56 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 15:33:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AC1Yxppj7c/Render', 15:33:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:33:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:33:56 INFO - 'HOME': '/Users/cltbld', 15:33:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:33:56 INFO - 'LOGNAME': 'cltbld', 15:33:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:33:56 INFO - 'MOZ_NO_REMOTE': '1', 15:33:56 INFO - 'NO_EM_RESTART': '1', 15:33:56 INFO - 'PAGER': '/bin/cat', 15:33:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:33:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:33:56 INFO - 'PWD': '/builds/slave/test', 15:33:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:33:56 INFO - 'SHELL': '/bin/bash', 15:33:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.i7iQcC0tnP/Listeners', 15:33:56 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 15:33:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:33:56 INFO - 'USER': 'cltbld', 15:33:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:33:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:33:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:33:56 INFO - 'XPC_FLAGS': '0x0', 15:33:56 INFO - 'XPC_SERVICE_NAME': '0', 15:33:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:33:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:33:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:33:57 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-eVqnDL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:33:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:33:57 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-qIqngp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:33:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:33:57 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-UjzYp2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:33:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:33:57 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-lodVY3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:33:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:33:57 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-yLl_nn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:33:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:33:57 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-fVkz2R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:33:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:33:57 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-3gDnwI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:33:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:33:57 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-iBFxNN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:33:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:33:58 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-X6QldB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:33:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:33:58 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-qLWFEY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:33:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:33:58 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-ip3w4j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:33:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:33:58 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-kAYnjk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:33:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:33:58 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-DYqm_4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:33:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:33:58 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-laO7wz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:33:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:33:58 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-f0RMZE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:33:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:33:58 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-i0Vpsk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:33:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:33:58 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-nXD_br-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:33:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:33:58 INFO - Running setup.py install for manifestparser 15:33:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:33:59 INFO - Running setup.py install for mozcrash 15:33:59 INFO - Running setup.py install for mozdebug 15:33:59 INFO - Running setup.py install for mozdevice 15:33:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:33:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:33:59 INFO - Running setup.py install for mozfile 15:33:59 INFO - Running setup.py install for mozhttpd 15:33:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:33:59 INFO - Running setup.py install for mozinfo 15:33:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:33:59 INFO - Running setup.py install for mozInstall 15:34:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:34:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:34:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:34:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:34:00 INFO - Running setup.py install for mozleak 15:34:00 INFO - Running setup.py install for mozlog 15:34:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:34:00 INFO - Running setup.py install for moznetwork 15:34:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:34:00 INFO - Running setup.py install for mozprocess 15:34:00 INFO - Running setup.py install for mozprofile 15:34:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:34:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:34:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:34:00 INFO - Running setup.py install for mozrunner 15:34:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:34:01 INFO - Running setup.py install for mozscreenshot 15:34:01 INFO - Running setup.py install for moztest 15:34:01 INFO - Running setup.py install for mozversion 15:34:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:34:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:34:01 INFO - Cleaning up... 15:34:01 INFO - Return code: 0 15:34:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:34: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')]} 15:34:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:34:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:34: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')]} 15:34:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:34:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:34:01 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 0x109e33490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109da9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb4eb574360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109c47d30>, '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 0x109aaddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109c3fb20>, '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.AC1Yxppj7c/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.i7iQcC0tnP/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 15:34:01 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 15:34:01 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 15:34:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AC1Yxppj7c/Render', 15:34:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:34:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:34:01 INFO - 'HOME': '/Users/cltbld', 15:34:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:34:01 INFO - 'LOGNAME': 'cltbld', 15:34:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:34:01 INFO - 'MOZ_NO_REMOTE': '1', 15:34:01 INFO - 'NO_EM_RESTART': '1', 15:34:01 INFO - 'PAGER': '/bin/cat', 15:34:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:34:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:34:01 INFO - 'PWD': '/builds/slave/test', 15:34:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:34:01 INFO - 'SHELL': '/bin/bash', 15:34:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.i7iQcC0tnP/Listeners', 15:34:01 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 15:34:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:34:01 INFO - 'USER': 'cltbld', 15:34:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:34:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:34:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:34:01 INFO - 'XPC_FLAGS': '0x0', 15:34:01 INFO - 'XPC_SERVICE_NAME': '0', 15:34:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:34:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:34:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:34:01 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-OjicDH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:34:01 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)) 15:34:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:34:01 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-CtghCg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:34:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:34:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:34:02 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-dkMuQG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:34:02 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)) 15:34:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:34:02 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-5M1v2f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:34:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:34:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:34:02 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-IbDT3t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:34:02 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)) 15:34:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:34:02 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-RZ_M5d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:34:02 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)) 15:34:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:34:02 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-RPKym0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:34:02 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)) 15:34:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:34:02 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-PfMwMW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:34:02 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)) 15:34:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:34:02 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-e4Qmdb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:34:02 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)) 15:34:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:34:02 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-VJJYNc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:34:02 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)) 15:34:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:34:02 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-c1ecvg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:34:02 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)) 15:34:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:34:02 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-vx_a1m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:34:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 15:34:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:34:03 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-pLiie9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:34:03 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)) 15:34:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:34:03 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-0tcWQx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:34:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 15:34:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:34:03 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-YFzODz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:34:03 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)) 15:34:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:34:03 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-1req4e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:34:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 15:34:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:34:03 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-zRUZ1X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:34:03 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)) 15:34:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:34:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:34:03 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)) 15:34:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:34:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:34:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:34:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:34:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:34:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:34:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:34:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:34:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:34:06 INFO - Downloading blessings-1.6.tar.gz 15:34:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:34:06 INFO - Installing collected packages: blessings 15:34:06 INFO - Running setup.py install for blessings 15:34:06 INFO - Successfully installed blessings 15:34:06 INFO - Cleaning up... 15:34:06 INFO - Return code: 0 15:34:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:34:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:34:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:34:06 INFO - Reading from file tmpfile_stdout 15:34:06 INFO - Current package versions: 15:34:06 INFO - blessings == 1.6 15:34:06 INFO - blobuploader == 1.2.4 15:34:06 INFO - docopt == 0.6.1 15:34:06 INFO - functools32 == 3.2.3-2 15:34:06 INFO - jsonschema == 2.5.1 15:34:06 INFO - manifestparser == 1.1 15:34:06 INFO - mozInstall == 1.12 15:34:06 INFO - mozcrash == 0.17 15:34:06 INFO - mozdebug == 0.1 15:34:06 INFO - mozdevice == 0.48 15:34:06 INFO - mozfile == 1.2 15:34:06 INFO - mozhttpd == 0.7 15:34:06 INFO - mozinfo == 0.9 15:34:06 INFO - mozleak == 0.1 15:34:06 INFO - mozlog == 3.4 15:34:06 INFO - moznetwork == 0.27 15:34:06 INFO - mozprocess == 0.23 15:34:06 INFO - mozprofile == 0.28 15:34:06 INFO - mozrunner == 6.12 15:34:06 INFO - mozscreenshot == 0.1 15:34:06 INFO - mozsystemmonitor == 0.3 15:34:06 INFO - moztest == 0.7 15:34:06 INFO - mozversion == 1.4 15:34:06 INFO - psutil == 3.1.1 15:34:06 INFO - requests == 1.2.3 15:34:06 INFO - wsgiref == 0.1.2 15:34:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:34:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:34:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:34:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:34: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')]} 15:34:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:34:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:34:07 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 0x109e33490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109da9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb4eb574360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109c47d30>, '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 0x109aaddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109c3fb20>, '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.AC1Yxppj7c/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.i7iQcC0tnP/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 15:34:07 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 15:34:07 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 15:34:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AC1Yxppj7c/Render', 15:34:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:34:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:34:07 INFO - 'HOME': '/Users/cltbld', 15:34:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:34:07 INFO - 'LOGNAME': 'cltbld', 15:34:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:34:07 INFO - 'MOZ_NO_REMOTE': '1', 15:34:07 INFO - 'NO_EM_RESTART': '1', 15:34:07 INFO - 'PAGER': '/bin/cat', 15:34:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:34:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:34:07 INFO - 'PWD': '/builds/slave/test', 15:34:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:34:07 INFO - 'SHELL': '/bin/bash', 15:34:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.i7iQcC0tnP/Listeners', 15:34:07 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 15:34:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:34:07 INFO - 'USER': 'cltbld', 15:34:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:34:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:34:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:34:07 INFO - 'XPC_FLAGS': '0x0', 15:34:07 INFO - 'XPC_SERVICE_NAME': '0', 15:34:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:34:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:34:07 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)) 15:34:07 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)) 15:34:07 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)) 15:34:07 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)) 15:34:07 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)) 15:34:07 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)) 15:34:07 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)) 15:34:07 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)) 15:34:07 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)) 15:34:07 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)) 15:34:07 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)) 15:34:07 INFO - Cleaning up... 15:34:07 INFO - Return code: 0 15:34:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:34: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')]} 15:34:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:34:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:34: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')]} 15:34:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:34:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:34: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109e33490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109da9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb4eb574360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109c47d30>, '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 0x109aaddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109c3fb20>, '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.AC1Yxppj7c/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.i7iQcC0tnP/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 15:34: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', 'jsonschema'] in /builds/slave/test/build 15:34: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 jsonschema 15:34:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AC1Yxppj7c/Render', 15:34:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:34:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:34:07 INFO - 'HOME': '/Users/cltbld', 15:34:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:34:07 INFO - 'LOGNAME': 'cltbld', 15:34:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:34:07 INFO - 'MOZ_NO_REMOTE': '1', 15:34:07 INFO - 'NO_EM_RESTART': '1', 15:34:07 INFO - 'PAGER': '/bin/cat', 15:34:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:34:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:34:07 INFO - 'PWD': '/builds/slave/test', 15:34:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:34:07 INFO - 'SHELL': '/bin/bash', 15:34:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.i7iQcC0tnP/Listeners', 15:34:07 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 15:34:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:34:07 INFO - 'USER': 'cltbld', 15:34:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:34:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:34:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:34:07 INFO - 'XPC_FLAGS': '0x0', 15:34:07 INFO - 'XPC_SERVICE_NAME': '0', 15:34:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:34:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:34:08 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:34:08 INFO - Cleaning up... 15:34:08 INFO - Return code: 0 15:34:08 INFO - Running post-action listener: _resource_record_post_action 15:34:08 INFO - Running post-action listener: _start_resource_monitoring 15:34:08 INFO - Starting resource monitoring. 15:34:08 INFO - [mozharness: 2016-10-24 22:34:08.074226Z] Finished create-virtualenv step (success) 15:34:08 INFO - [mozharness: 2016-10-24 22:34:08.075176Z] Running install step. 15:34:08 INFO - Running pre-action listener: _resource_record_pre_action 15:34:08 INFO - Running main action method: install 15:34:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:34:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:34:08 INFO - Reading from file tmpfile_stdout 15:34:08 INFO - Detecting whether we're running mozinstall >=1.0... 15:34:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:34:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:34:08 INFO - Reading from file tmpfile_stdout 15:34:08 INFO - Output received: 15:34:08 INFO - Usage: mozinstall [options] installer 15:34:08 INFO - Options: 15:34:08 INFO - -h, --help show this help message and exit 15:34:08 INFO - -d DEST, --destination=DEST 15:34:08 INFO - Directory to install application into. [default: 15:34:08 INFO - "/builds/slave/test"] 15:34:08 INFO - --app=APP Application being installed. [default: firefox] 15:34:08 INFO - mkdir: /builds/slave/test/build/application 15:34:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 15:34:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 15:34:40 INFO - Reading from file tmpfile_stdout 15:34:40 INFO - Output received: 15:34:40 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 15:34:40 INFO - Running post-action listener: _resource_record_post_action 15:34:40 INFO - [mozharness: 2016-10-24 22:34:40.455786Z] Finished install step (success) 15:34:40 INFO - [mozharness: 2016-10-24 22:34:40.455949Z] Running run-tests step. 15:34:40 INFO - Running pre-action listener: _resource_record_pre_action 15:34:40 INFO - Running main action method: run_tests 15:34:40 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:34:40 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:34:40 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:34:40 INFO - 2016-10-24 15:34:40.471 screenresolution[1638:7425] starting screenresolution argv=screenresolution get 15:34:40 INFO - 2016-10-24 15:34:40.474 screenresolution[1638:7425] Display 0: 1600x1200x32@60 15:34:40 INFO - 2016-10-24 15:34:40.480 screenresolution[1639:7430] starting screenresolution argv=screenresolution list 15:34:40 INFO - Available Modes on Display 0 15:34:40 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:34:40 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:34:40 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:34:40 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:34:40 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:34:40 INFO - Intel Iris: 15:34:40 INFO - Chipset Model: Intel Iris 15:34:40 INFO - Type: GPU 15:34:40 INFO - Bus: Built-In 15:34:40 INFO - VRAM (Dynamic, Max): 1536 MB 15:34:40 INFO - Vendor: Intel (0x8086) 15:34:40 INFO - Device ID: 0x0a2e 15:34:40 INFO - Revision ID: 0x0009 15:34:40 INFO - Displays: 15:34:40 INFO - Display: 15:34:40 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:34:40 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:34:40 INFO - Display Serial Number: 1600x1200 60 15:34:40 INFO - Main Display: Yes 15:34:40 INFO - Mirror: Off 15:34:40 INFO - Online: Yes 15:34:40 INFO - Rotation: Supported 15:34:40 INFO - Return code: 0 15:34:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:34:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:34:40 INFO - Python 2.7.3 15:34:40 INFO - Return code: 0 15:34:40 INFO - grabbing minidump binary from tooltool 15:34:40 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')]} 15:34:40 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 0x109c47d30>, '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 0x109aaddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109c3fb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:34:40 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 15:34:40 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 15:34:40 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 15:34:40 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:34:40 INFO - Return code: 0 15:34:40 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 15:34:40 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:34:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:34:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 15:34:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:34:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/b0sObbcPRMK77bslfnNe9Q/artifacts/public/build/firefox-51.0a2.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 15:34:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/b0sObbcPRMK77bslfnNe9Q/artifacts/public/build/firefox-51.0a2.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 15:34:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AC1Yxppj7c/Render', 15:34:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:34:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:34:40 INFO - 'HOME': '/Users/cltbld', 15:34:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:34:40 INFO - 'LOGNAME': 'cltbld', 15:34:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:34:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 15:34:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:34:40 INFO - 'MOZ_NO_REMOTE': '1', 15:34:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:34:40 INFO - 'NO_EM_RESTART': '1', 15:34:40 INFO - 'PAGER': '/bin/cat', 15:34:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:34:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:34:40 INFO - 'PWD': '/builds/slave/test', 15:34:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:34:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:34:40 INFO - 'SHELL': '/bin/bash', 15:34:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.i7iQcC0tnP/Listeners', 15:34:40 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 15:34:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:34:40 INFO - 'USER': 'cltbld', 15:34:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:34:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:34:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:34:40 INFO - 'XPC_FLAGS': '0x0', 15:34:40 INFO - 'XPC_SERVICE_NAME': '0', 15:34:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:34:40 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/b0sObbcPRMK77bslfnNe9Q/artifacts/public/build/firefox-51.0a2.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 15:34:41 INFO - mozversion application_buildid: 20161024132222 15:34:41 INFO - mozversion application_changeset: 6648f996b7024cd155e1a32757d83dfe63939041 15:34:41 INFO - mozversion application_display_name: FirefoxDeveloperEdition 15:34:41 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:34:41 INFO - mozversion application_name: Firefox 15:34:41 INFO - mozversion application_remotingname: firefox-dev 15:34:41 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 15:34:41 INFO - mozversion application_vendor: Mozilla 15:34:41 INFO - mozversion application_version: 51.0a2 15:34:41 INFO - mozversion platform_buildid: 20161024132222 15:34:41 INFO - mozversion platform_changeset: 6648f996b7024cd155e1a32757d83dfe63939041 15:34:41 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 15:34:41 INFO - mozversion platform_version: 51.0a2 15:34:41 INFO - using testdate: 1477348481 15:34:41 INFO - actual date: 1477348481 15:34:41 INFO - starting webserver on 'localhost:49271' 15:34:41 INFO - SUITE-START | Running 2 tests 15:34:41 INFO - TEST-START | dromaeo_css 15:34:41 INFO - operating with platform_type : mac_ 15:34:41 INFO - Initialising browser for dromaeo_css test... 15:34:41 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/tmpe8dkJd/profile http://localhost:49271/getInfo.html) 15:34:43 INFO - PROCESS | 1649 | __metrics Screen width/height:1600/1200 15:34:43 INFO - PROCESS | 1649 | colorDepth:24 15:34:43 INFO - PROCESS | 1649 | Browser inner width/height: 1024/689 15:34:43 INFO - PROCESS | 1649 | __metrics 15:34:43 INFO - PROCESS | 1649 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 15:34:43 INFO - PROCESS | 1649 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:34:44 INFO - TEST-INFO | 1649: exit 0 15:34:44 INFO - Browser initialized. 15:34:44 INFO - Running cycle 1/1 for dromaeo_css test... 15:34:44 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/tmpe8dkJd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:34:56 INFO - PROCESS | 1650 | RSS: Main: 219873280 15:34:56 INFO - PROCESS | 1650 | 15:35:47 INFO - PROCESS | 1650 | 1477348547098 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 15:37:59 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49271/tests/dromaeo/cssquery-ext.html) 15:38:00 INFO - PROCESS | 1650 | RSS: Main: 360083456 15:38:00 INFO - PROCESS | 1650 | 15:41:03 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-ext.html (next: http://localhost:49271/tests/dromaeo/cssquery-jquery.html) 15:41:04 INFO - PROCESS | 1650 | RSS: Main: 352522240 15:41:04 INFO - PROCESS | 1650 | 15:44:06 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49271/tests/dromaeo/cssquery-mootools.html) 15:44:07 INFO - PROCESS | 1650 | RSS: Main: 325369856 15:44:07 INFO - PROCESS | 1650 | 15:47:09 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49271/tests/dromaeo/cssquery-prototype.html) 15:47:10 INFO - PROCESS | 1650 | RSS: Main: 333217792 15:47:10 INFO - PROCESS | 1650 | 15:50:13 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49271/tests/dromaeo/cssquery-yui.html) 15:50:14 INFO - PROCESS | 1650 | RSS: Main: 312643584 15:50:14 INFO - PROCESS | 1650 | 15:53:17 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-yui.html (next: http://localhost:49271/tests/dromaeo/cssquery-dojo.html) 15:53:17 INFO - PROCESS | 1650 | RSS: Main: 388284416 15:53:17 INFO - PROCESS | 1650 | 15:53:17 INFO - PROCESS | 1650 | __start_tp_report 15:53:17 INFO - PROCESS | 1650 | _x_x_mozilla_page_load 15:53:17 INFO - PROCESS | 1650 | _x_x_mozilla_page_load_details 15:53:17 INFO - PROCESS | 1650 | |i|pagename|runs| 15:53:17 INFO - PROCESS | 1650 | |0;dojo.html;3325.600927888653;3338.1988322802517;3349;3354.580677415323;3403.8468268927895;5734.913976290359;5792.102224155252;5797.652140871545;5802.274715660543;5855.385184555619;5634.32388113427;5714.457126572969;5779.16202150689;5788.131780232967;5805.564582656297;4457.286834106536;5227.895442091156;5239.240310155025;5280.128778751501;5280.471952804727;5207.895842083156;5210.973945130269;5219;5324.574034077284;5330.92003619946;5189.273501709764;5206.791728330882;5220.216967454874;5246.1606143017125;5275.788968441258;5200.947990520084;5257.18513630384;5259.76331065103;5272.710000949946;5310.9734451327495;5149.794008239666;5152.407473140599;5221.71280579568;5227.790888364499;5242.528172464458;5634.211210430543;5687.914681279784;5719.6854173020465;5723.399043100498;5756.107803290497;6174.166487524171;6225.657588832612;6235.095911092912;6246.500279977591;6279;6298.937010629881;6323.494120470351;6330.8100756977365;6346.460550853183;6354.364563543655;5700.686462244575;5766.654000759968;5774.076147816413;5780.0751879699465;5830.883382332329;6307.9369206308265;6312.337204593543;6321.810345689637;6329.525285603599;6344.429001389897;6203.503719702413;6207.099970504251;6208.689565521706;6211.409916057967;6213.192285003011;6115.724792384353;6209;6210.782622608187;6320.4311611955145;6338.714757835908;5436.809711660073;6130.551011451118;6209.534284928648;6236.095766113888;6264.968675156686;5110.48895110486;6227.346128656516;6268.373162683695;6270.7805226816845;6303.558750887394;4867.050925069649;4946.1344264753525;4965.875853103701;4973.726445045485;4975.0547395994645;4426.247537918497;4428.800703968329;4496.842610508616;4498.617617502484;4499.055198408306;5966.194563733927;5979.79070732531;5983.581149319593;5993.790217342372;6004.039353703386;6243.687815609202;6264.279607845065;6271.717772700239;6280.874382512324;6280.905786413207;4751.429828420612;5832.825015249549;5838.854028649318;5866.882662346729;5964.970175149097;5428.511433970962;5447.891042179134;5468.179773033997;5478.91781623276;5510.586705996986;5307.761150748225;6349.428551430394;6354.269259035178;6364.5863018905475;6367.554271201064;6093.238345206849;6221.688915554295;6290;6308.589941653778;6331.240251169889;6304.5586808922935;6325.082862984934;6333.619982801047;6339.080833279057;6351.015592583157;6113.567524283718;6127.509799216141;6132.724027418866;6195.194624698941;6212.9068063978175;6160.383961603804;6187.783427580013;6192.535559833121;6252.687365631791;6268.43584077417;6128.785492507741;6137.631742095488;6141.662208578571;6151;6153.815385538441;5997.940020599913;6063;6076.817695469143;6103.328633850362;6129.141920131096;5993.670348130895;6060.121282414113;6063.909041364295;6068.787592434243;6079.148919151411;6166.229221347332;6194.287656919512;6198.380161983766;6200.844978875564;6201.596896201732;5821.912671309849;5873.207117039145;5877.823665290048;5911.586188966903;5985.25184351956 15:53:17 INFO - PROCESS | 1650 | |1;ext.html;494.7155385653249;497.0655168283626;501.5310684509986;517.7825313368385;524.3105316508788;30914.690853091462;40020.39969400461;41194.97012574683;41354;41427.58572414275;34643.4803477948;43275;43379.13241735163;43430;45363;9274.397164184307;9673.70978870635;9874;9879.950600247024;9893.851592226123;9687;9782.951085244564;9811.313208075437;9812.165965892871;9816.607335706563;8267.338612910982;9774.853377199348;9855.26085543587;9855.457949812757;9857.162141218005;9784.657536986208;9833.606655733762;9848.359856609297;9851.014898510164;9878.456684882329;9718.31971761977;9731.56207970636;9800.607975680965;9801.558929848103;9804.01959804021;40315.395269070985;40576;40590.1881962362;40651.390229146586;40723.796381017906;2958.9704102959126;3242.5460435539044;3355.9664403355896;3368.629450760439;3761.492198553215;26021.869890650614;29289.414211715648;30000.849995749883;30185.396292074034;31933.201669958205;3122.8126312421327;3199.3121478882153;3221.951670724941;3242.0922141800334;3260.3316320154313;538431;541924;542423;542758;544985.27507363;33192;33926.49110263299;62293.37706622967;62887.371126289065;62986.37013629897;34783;35260.47109293363;35284.64715352814;35317.29365412729;35392.823035884656;15010.924945375204;15186;15187.848121518644;15196.696066078617;15225.467108651366;12860;13021.414036368385;13022.47910083586;13033.283169425584;13035.413406396545;7663.31030207284;7733.265339792823;7772.145064042951;7795.727149549852;7800.843983120306;2715.91852244433;3198.72810811079;3256.446404111307;3263.0537144228383;3296.620888597842;813.9715109971122;876.4653561327585;940.9764755881158;943.740471370365;994.9054839790208;29495.53535836715;29969.100926972227;30148.24629384283;30359.696403036127;30903.536446953312;932.421898422982;1042.5464922758472;1064.893510648929;1070.6787963610886;1173.5188572685158;15291.235438228045;15647.921760391353;15870.603234918988;16010.398043892836;16158.838411615734;683292;982145;1000487;1002200;1002901;56972.14541781876;57689.711551442815;57705.71147144237;57740.711296443245;57980.71009645009;1255.409957320058;1288.6391810293132;1290.4644572502493;1390.2909516146838;1414.8938829587821;28662.856685716437;31329.2576419214;31732.841335794095;32207.35585288328;32236.19409514781;53555.46444535505;54629.45370546244;54669.72665136649;54796.45203547914;54808.177877332666;585234;593497;593562;598587;598808;20778.376648700563;23677.763222367557;24288;26815.865920670272;27149.321266967694;42208.36687449752;45361.54638453573;45686;46322.073558529315;46322.53677463182;37299;37414.6258537422;38113;38292;39610;37621.435678465394;37856.43215351717;38445.6155438442;38638.420423693104;38897.41653875138;31563.684363156073;36563.45154822733;37219;37536.246375363335;37933.430998534495;31486.527702084946;32662;33917;33921.66078339185;34082.65917340795;21926.342209733735;23520.882395587912;24837.130700425398;24990.500189995735;25521.872390637927 15:53:17 INFO - PROCESS | 1650 | |2;jquery.html;363.6854121185175;370.3315515494533;374.5729867950536;385.4353372309566;398.10227936004304;17322.56693582661;20089.493288003403;20906.686399704016;21147.15411383543;21643.567128657436;20615.690764638504;20685.689714654254;20957.37127886162;21201;21769;5419.810306639269;6001.729922153502;6300.716467758939;6986.650667466632;7094.11323584552;3882.9029274268087;4077.4699289092523;7054.929450705505;7104.254053324404;7113.146422429316;4131.669466442692;4188.958110418887;7035.718571257144;7102.431805455577;7114;4723.905521889543;6104.542159338067;7030.753923612675;7086.71653133874;7111.751088711871;5926.140709597127;5929.140274660193;5946.167536544887;5953.1070339449;5962.135490353874;12967.546135885199;13068.738625227537;13146.14550054253;13162.210267383987;17663.410293073684;2279.11114665279;2475.4553998120386;2579.071534247669;2699.2307192450057;2721.4693134838712;10073.44596047217;12470.81293780594;14413.99102062856;15181.696366072616;15619.921900390538;1850.6668799616064;1860.804615515365;1882.190658017052;1900.1069497336368;1952.5021119614548;60962.695186523786;80959.38081238401;84864.57567712122;122725;123231.3838430811;11215.271007384494;11455.198136130392;11608.994896760603;11919.70200744971;12052.879471205175;14918.627034324012;14937.775933361008;14949.551513454613;14950.028248164052;14955.476558320624;8330.375221858263;8635.37763754686;9020.323475739346;9033.683821066232;9128.726138215865;8546.924095409382;8900.664900264883;8962.417442866323;8982.595783189772;9147.725568232963;4520.0507893342765;4585.220512512881;4585.518520555293;4639.930401043987;4673.182193116259;1909.7421848050612;1914.818092281259;1936.3416438410727;1954.7165660979078;1981.0787983587702;788.1842293226483;827.8634025385865;842.9884139033062;860.7761981884755;944.4994153098869;17803.643927121386;21481.78518214829;22269.777302226772;22476;22577.88711056434;810.3476701255546;941.9293552983554;958.4249450329746;1000.8598796168542;1006.1799633298838;7691.730789422455;10037.394016957252;11296.774064518828;11475.598354057567;11497;580817;598298;614487;621873;622142;88753.55623221843;129718;138845;148358.25820870826;149670;942.8255772682213;952.4713783850029;974.0843607009389;996.1632228927735;996.4270544436978;19285.61428771445;19413.826027404175;20371.59256814885;20447.591048178656;20460.59078818445;55717.72141139268;57374.42625573691;57470.42529574651;58013.709931450074;58350.12474812966;78048.21951780637;78517;79031.60484197772;81316;81873.59063204646;7881.881771773314;8060.468510982894;8128;8362.12197719255;8504.744857654281;13127.277999710108;13312.534061307808;13315.001374897116;13725.862741372459;13770.449182032606;10634.989675980769;10923.289986150874;11168.162387821108;11527.02020328248;11638.185327027028;11199.048080912888;11398.487068082122;11474.827877581676;11900.523979040741;11965.341906195243;11467.4266286687;11620.302781833117;11744.823827642422;12065.879341206826;12164.513419463123;8040.276375126266;8106.027276726831;8218.589070546568;8326.70856520019;8439.620217090123;7114.644267786486;11495;11614.128940329678;11661.008814250883;11696.532138714696 15:53:17 INFO - PROCESS | 1650 | |3;mootools.html;1350.270853738981;1507.9999999999995;1636.9918150409253;1826.6529359421718;1828.9634207315853;8690.478571285727;9219.49292788898;9233.722988310354;9237.953810230947;9239.168474837263;8085.353171746261;8329.250367466926;8723.65105395785;9023.18791308782;9055.185033346997;2098.5697931923996;2402.555527227464;2430.4652976345174;2452.288836237489;2459.9139030133947;2401.1955994741697;2433.598456254716;2443.951120977579;2448.436859522311;2452.5462789383932;2425.163318655061;2429.259075981825;2433.221369161869;2446.192756390387;2456.4841383309526;2395.3772019275116;2413.263954493879;2427.842190257645;2429.6112621980574;2431.440768623209;2357.233898982837;2373.3473294843884;2399.6400539918977;2413.227767114524;2414.1550457339968;9050.77373065672;9176.174144326977;9197.448153110834;9203.401778884418;9213.631454741802;5105.591552675777;5274.736263186825;5278.366596008504;5281.683099014033;5284.550813180885;3424.8697929683144;3560.5549306336707;3677.0439685681918;3749.2314075614436;3769.0765762388114;1052.7420781908481;1081.810683130449;1104.5589247762455;1131.0781712903956;1135.4720055174384;9959.900400996043;12033;12050.457729402198;12058.517659293619;12061.517539298506;4712.384411830758;4767.118083154558;4768.141734487756;4890.510948905081;4896.2410826321975;10250.436226007492;10257.17942564593;10272.33229840058;10278.434686092187;10283.07452329279;5460.453954604587;5464.890702185934;5467.617266791286;5472.671639701631;5486.670799752028;4510.143072816154;4651.534846515389;4664.137134630104;4979.3526841510375;5009.373828271466;3986.22268657609;3990.102226998902;4088.2232375848494;4118.382242663624;4129.545749967501;1283.4352884730688;1285.8199852020725;1286.7362190751062;1301.6420484366874;1303.6089173248176;920.6841070258024;922.7185708359015;923.6213152607532;934.4580143516744;960.13108137136;5900.321463031721;5993.310769261503;5994.430529099728;6138.539609529304;6193.504519638418;442.45136031321573;445.36090709831495;450.3897219267845;454.9921922940702;460.67062050633956;3337.8331083445732;4030.2946984277633;4053.43251944728;4055.7160998730396;4153.875383738493;9238.722838314861;11096.778064438666;11099.778004439866;11104.44477776108;11110.944445277722;11037.889621103846;11044.723881903017;11045.28205666629;11050.944745276222;11050.944745276383;8241.299489543337;8299.751007469786;8427.578621068922;8564.97220333564;8596.742097736953;5771.2208851806145;5928.110783382354;6028.156058151774;6067.605605635619;6084.452399284086;10091.899081009096;10195.337303075275;10271;10278.486075696335;10430.165586753194;9898.703038908845;10617.097546708615;10622.256442048982;10626.787464250518;10651.254412191072;7033.156021277275;7269.127704675473;7314.195438501654;7621.657025433758;7695.384369250334;7581.3176814087;7692.346150577264;8029.839403211786;8105.513669179868;8540.274076703301;7454.142773581108;7676.462647614613;7689.504191234141;7758.728444504415;7796.727114550963;7379.667914943733;7486.700531978878;7492.62536873165;7505.962470187614;7681.807954800951;7058.153021637437;7199.460040496879;7207.9279207207255;7208.675609597476;7210.387117095106;4932.334134891744;5024.692092580409;5107.41264754558;5125.410577783603;5154.8969020620125;4942.406911170682;4974.825881094144;5082.745862706924;5144.588432925282;5216.139337009351 15:53:17 INFO - PROCESS | 1650 | |4;prototype.html;245.8119538553006;282.15353938185444;298.74755831322534;301.9969800301996;302.34693062983956;4989.426215985162;5248.448912864152;5271.630985830993;5312.389075256347;5333.359996800385;4168.937465938014;4295.548967358422;4486.955130448695;4778.617710583154;5160.483951604838;3981.4625025621604;4014.5985401459766;4037.5356833964174;4050.898727531806;4058.7767672777986;3737.252549490099;4047.3203620497457;4054.0878302382025;4056.4523789288364;4067.8576249831262;3939.5469521005166;3953.892909985209;3983.800809959505;4001.1997600479876;4008.238434697398;3965.385365268374;3965.8300801263695;3971.7616942983223;3983.900402489932;3994.1811928554866;2864.928376790576;2901.7823663225345;3396.626371099177;3428.9142771430666;3433.8626454941773;3951.320688707288;4140.710150289481;5145.449639748562;5151.6908985461;5161.974190129063;4477.574630410106;4494.775261236958;4500.054988452429;4511.887202819923;4518.254488009475;4572.376806233772;4684.297355396684;4723.976380118112;5501.862453438656;5564.527015203713;3571.982140089283;3744.138848064933;3765.7928813915223;3772.2832661794446;3781.5462144542557;4788.664793464493;5708.400617935098;5785.537157027427;5796.855078623068;5824.970875145597;3174.476211425089;3402.795832250073;3804.2962052020466;3809.790461524643;3821.4840996465123;3227.725643320297;3860.729748917605;3871.9225615488094;3879.592642772525;3888.2612303662213;4279.165562715303;4342.08816148606;4502.234620114588;4533.977330113395;4569.725816451024;5050.949490505048;5141.3830340358645;5166.250893620404;5519.668819870741;5567.554595632339;1095.5508241620896;1225.6874497003207;1256.1960345378964;1266.7593157300084;1278.2905487454552;692.6363659079024;842.8230071685015;878.9296856251484;885.3271513649672;887.9511626860585;4757.238841785298;4784.856454306377;5205.141151710001;5211.609129315317;5249.343832020997;4491.685582009228;5161.045206636784;5467.234587157801;5679.829605111853;5691.516221121168;4048.5344185419053;4065.556727361744;4524.891401606627;5216.1221960094335;5278.604104692164;2267.8887345200733;2373.691420115374;2486.3038349262238;2497.5254701606636;2520.3447103752787;4149.232392007489;4354.238008348526;4765.1892280933025;4777.426708794897;5420.864478387993;4834.887975765593;4865.416150062015;5884.852878678067;5936.584439089309;5937.584369094122;5136.459062281376;5349.812756553502;5919.733611987471;5936.287645482484;5959.463648271676;5585.385607583082;5624.9024808862405;5752.856178595569;5776.682282474504;5797.4782269595935;4714.4106986626675;5655.773769049192;5669.270872383798;5698.572607054404;5774.855628609318;5365.248865158803;5484.808031718871;5682.659040457585;5936.5844390892225;5947.434993675594;3802.581716011181;3802.6007269236334;3810.1808111256214;3849.730518863653;3867.323218436706;4864.927026094682;5738.655680659173;5760.711964401847;5761.395053519488;5867.647941123546;4925.408950925912;5300.3904550975585;5466.633341664584;5667.858303542444;5690.402507736628;4550.658700597534;5004.949950500449;5038.722870242172;5584.3857175711455;5595.944040559542;4441.800118994717;4541.477730061085;5192.688438693691;5249.343832020997;5366.651167674088;5316.920246196233;5328.626996110235;5576.470235327637;5581.302337207849;5589.189567512769;4585.380973568525;4648.373069425809;5210.713410762444;5398.9190162146815;5450.918236226539 15:53:17 INFO - PROCESS | 1650 | |5;yui.html;721.1526456413712;741.7107328142022;756.2701992577162;778.179021132705;838.4256784102888;14481.637959051015;15493.690126197469;15641.687166256683;15676.372945082197;15711.057336559787;13798.586042418743;13849.584512464617;13942.093763905339;14528.636784080403;15298.929074964757;806.6249194124716;841.1840514700731;844.1474111147754;844.8479273730726;846.4075147396816;666.1506579111623;683.987698206652;810.3314765318606;825.3603457320595;829.7925518620345;878.8022694893662;885.716570697377;891.5987805487524;892.2906289499863;893.0266010049045;884.1821315283337;885.1988950000292;885.2873436883307;885.6723012485357;886.7251152142792;511.57028096399205;527.2039220776655;528.6141116984585;656.9441597464221;657.1161787395993;11530;11578;11584.42077896102;12561.685957851036;12903.677408064874;14064.578062658136;14382.71234575313;14511;14552.417903283857;14808;9988.700338989842;11433.714157146054;11804.291742495392;11974.161808673396;12070.396480175956;3665.2119794244363;3810.1046254130256;3816.1985982943615;3916.275489034509;3939.409088636699;114536.42731786371;115498;116154.41922790416;116726;117989.8201017996;8983.236424903957;10994.450277486094;11097.278676885977;11296.435178241056;11595.478203480863;22227;22550;22590.661140082913;22667.43331416695;22780.316590502312;7473.588952607659;7728.149903510609;7813.140554538996;7819.17898620648;7824;4202.2646036943415;4231.386448964883;4249.508411623324;4253.404523366731;4426.955730442654;3636.890893273206;3730.552333719971;3740.663340299386;3740.7381483296454;3751.249750050001;562.2409746841731;585.2625691628493;589.9705014749245;592.1029640095259;638.0684201066402;595.2410676387553;595.7587177193244;620.6803496199461;650.6453982579505;650.9283978762332;8858.822823543493;9095.454272743656;9386.530673466299;9737.172340351008;9770;585.2947198625645;647.9838004049936;667.502710480695;668.1047396488729;689.7722054742466;4380.474343078788;4645.450133222414;4669.766511674403;4711.7879695413785;4747.786349614275;166405;168367.1581642084;170326;172435;175981;122633;145438;152583;155448.33654990367;155789;102302.48848755709;103747.99170318624;105048;122875.38562307131;124699.37650311872;8804.427712198687;9045.773855653399;9115.906925031893;9122.543872806466;9328.766780830534;62970.796022139;67092.66453667701;67987.66006169938;70301;72668.90996635161;96665;99316;99662;104966;107420.462897685;11645.359505227294;12901.161424507378;12947.805782913452;12982.091253612156;13221.801672974721;13215.898466251505;14537.563873083824;14849.92575037118;15007.099574025593;15762.448314308944;13100.737985240432;13795.310234488436;13924.791128133289;13971.720565588834;14144.292785360896;13664.24846633405;13695.315234238049;13831;14049.297535122998;14135.929320353333;10963.671089867317;13289.933550332187;13402.396892140072;13475.989300802283;13530.526431574848;10450.68647940563;11349.716257093638;11777.882221177679;11826;11829.231099978473;10746.892531074902;11478.540858365572;11626.302421854716;11700.88299117032;11733.530658773894 15:53:17 INFO - PROCESS | 1650 | __end_tp_report 15:53:17 INFO - PROCESS | 1650 | __start_cc_report 15:53:17 INFO - PROCESS | 1650 | _x_x_mozilla_cycle_collect,1232 15:53:17 INFO - PROCESS | 1650 | __end_cc_report 15:53:17 INFO - PROCESS | 1650 | __startTimestamp1477349597280__endTimestamp 15:53:17 INFO - PROCESS | 1650 | 15:53:17 INFO - PROCESS | 1650 | ------- Summary: start ------- 15:53:17 INFO - PROCESS | 1650 | Number of tests: 6 15:53:17 INFO - PROCESS | 1650 | 15:53:17 INFO - PROCESS | 1650 | [#0] dojo.html Cycles:165 Average:5759.94 Median:5993.79 stddev:652.90 (10.9%) stddev-sans-first:626.36 15:53:17 INFO - PROCESS | 1650 | Values: 3325.6 3338.2 3349.0 3354.6 3403.8 5734.9 5792.1 5797.7 5802.3 5855.4 5634.3 5714.5 5779.2 5788.1 5805.6 4457.3 5227.9 5239.2 5280.1 5280.5 5207.9 5211.0 5219.0 5324.6 5330.9 5189.3 5206.8 5220.2 5246.2 5275.8 5200.9 5257.2 5259.8 5272.7 5311.0 5149.8 5152.4 5221.7 5227.8 5242.5 5634.2 5687.9 5719.7 5723.4 5756.1 6174.2 6225.7 6235.1 6246.5 6279.0 6298.9 6323.5 6330.8 6346.5 6354.4 5700.7 5766.7 5774.1 5780.1 5830.9 6307.9 6312.3 6321.8 6329.5 6344.4 6203.5 6207.1 6208.7 6211.4 6213.2 6115.7 6209.0 6210.8 6320.4 6338.7 5436.8 6130.6 6209.5 6236.1 6265.0 5110.5 6227.3 6268.4 6270.8 6303.6 4867.1 4946.1 4965.9 4973.7 4975.1 4426.2 4428.8 4496.8 4498.6 4499.1 5966.2 5979.8 5983.6 5993.8 6004.0 6243.7 6264.3 6271.7 6280.9 6280.9 4751.4 5832.8 5838.9 5866.9 5965.0 5428.5 5447.9 5468.2 5478.9 5510.6 5307.8 6349.4 6354.3 6364.6 6367.6 6093.2 6221.7 6290.0 6308.6 6331.2 6304.6 6325.1 6333.6 6339.1 6351.0 6113.6 6127.5 6132.7 6195.2 6212.9 6160.4 6187.8 6192.5 6252.7 6268.4 6128.8 6137.6 6141.7 6151.0 6153.8 5997.9 6063.0 6076.8 6103.3 6129.1 5993.7 6060.1 6063.9 6068.8 6079.1 6166.2 6194.3 6198.4 6200.8 6201.6 5821.9 5873.2 5877.8 5911.6 5985.3 15:53:17 INFO - PROCESS | 1650 | 15:53:17 INFO - PROCESS | 1650 | [#1] ext.html Cycles:180 Average:78739.48 Median:38202.50 stddev:193459.06 (506.4%) stddev-sans-first:193912.57 15:53:17 INFO - PROCESS | 1650 | Values: 494.7 497.1 501.5 517.8 524.3 30914.7 40020.4 41195.0 41354.0 41427.6 34643.5 43275.0 43379.1 43430.0 45363.0 9274.4 9673.7 9874.0 9880.0 9893.9 9687.0 9783.0 9811.3 9812.2 9816.6 8267.3 9774.9 9855.3 9855.5 9857.2 9784.7 9833.6 9848.4 9851.0 9878.5 9718.3 9731.6 9800.6 9801.6 9804.0 40315.4 40576.0 40590.2 40651.4 40723.8 2959.0 3242.5 3356.0 3368.6 3761.5 26021.9 29289.4 30000.8 30185.4 31933.2 3122.8 3199.3 3222.0 3242.1 3260.3 538431.0 541924.0 542423.0 542758.0 544985.3 33192.0 33926.5 62293.4 62887.4 62986.4 34783.0 35260.5 35284.6 35317.3 35392.8 15010.9 15186.0 15187.8 15196.7 15225.5 12860.0 13021.4 13022.5 13033.3 13035.4 7663.3 7733.3 7772.1 7795.7 7800.8 2715.9 3198.7 3256.4 3263.1 3296.6 814.0 876.5 941.0 943.7 994.9 29495.5 29969.1 30148.2 30359.7 30903.5 932.4 1042.5 1064.9 1070.7 1173.5 15291.2 15647.9 15870.6 16010.4 16158.8 683292.0 982145.0 1000487.0 1002200.0 1002901.0 56972.1 57689.7 57705.7 57740.7 57980.7 1255.4 1288.6 1290.5 1390.3 1414.9 28662.9 31329.3 31732.8 32207.4 32236.2 53555.5 54629.5 54669.7 54796.5 54808.2 585234.0 593497.0 593562.0 598587.0 598808.0 20778.4 23677.8 24288.0 26815.9 27149.3 42208.4 45361.5 45686.0 46322.1 46322.5 37299.0 37414.6 38113.0 38292.0 39610.0 37621.4 37856.4 38445.6 38638.4 38897.4 31563.7 36563.5 37219.0 37536.2 37933.4 31486.5 32662.0 33917.0 33921.7 34082.7 21926.3 23520.9 24837.1 24990.5 25521.9 15:53:17 INFO - PROCESS | 1650 | 15:53:17 INFO - PROCESS | 1650 | [#2] jquery.html Cycles:180 Average:34858.76 Median:1542.58 stddev:101147.34 (6557.0%) stddev-sans-first:101397.92 15:53:17 INFO - PROCESS | 1650 | Values: 363.7 370.3 374.6 385.4 398.1 17322.6 20089.5 20906.7 21147.2 21643.6 20615.7 20685.7 20957.4 21201.0 21769.0 5419.8 6001.7 6300.7 6986.7 7094.1 3882.9 4077.5 7054.9 7104.3 7113.1 4131.7 4189.0 7035.7 7102.4 7114.0 4723.9 6104.5 7030.8 7086.7 7111.8 5926.1 5929.1 5946.2 5953.1 5962.1 12967.5 13068.7 13146.1 13162.2 17663.4 2279.1 2475.5 2579.1 2699.2 2721.5 10073.4 12470.8 14414.0 15181.7 15619.9 1850.7 1860.8 1882.2 1900.1 1952.5 60962.7 80959.4 84864.6 122725.0 123231.4 11215.3 11455.2 11609.0 11919.7 12052.9 14918.6 14937.8 14949.6 14950.0 14955.5 8330.4 8635.4 9020.3 9033.7 9128.7 8546.9 8900.7 8962.4 8982.6 9147.7 4520.1 4585.2 4585.5 4639.9 4673.2 1909.7 1914.8 1936.3 1954.7 1981.1 788.2 827.9 843.0 860.8 944.5 17803.6 21481.8 22269.8 22476.0 22577.9 810.3 941.9 958.4 1000.9 1006.2 7691.7 10037.4 11296.8 11475.6 11497.0 580817.0 598298.0 614487.0 621873.0 622142.0 88753.6 129718.0 138845.0 148358.3 149670.0 942.8 952.5 974.1 996.2 996.4 19285.6 19413.8 20371.6 20447.6 20460.6 55717.7 57374.4 57470.4 58013.7 58350.1 78048.2 78517.0 79031.6 81316.0 81873.6 7881.9 8060.5 8128.0 8362.1 8504.7 13127.3 13312.5 13315.0 13725.9 13770.4 10635.0 10923.3 11168.2 11527.0 11638.2 11199.0 11398.5 11474.8 11900.5 11965.3 11467.4 11620.3 11744.8 12065.9 12164.5 8040.3 8106.0 8218.6 8326.7 8439.6 7114.6 11495.0 11614.1 11661.0 11696.5 15:53:17 INFO - PROCESS | 1650 | 15:53:17 INFO - PROCESS | 1650 | [#3] mootools.html Cycles:180 Average:5806.81 Median:4739.75 stddev:3287.88 (69.4%) stddev-sans-first:3280.04 15:53:17 INFO - PROCESS | 1650 | Values: 1350.3 1508.0 1637.0 1826.7 1829.0 8690.5 9219.5 9233.7 9238.0 9239.2 8085.4 8329.3 8723.7 9023.2 9055.2 2098.6 2402.6 2430.5 2452.3 2459.9 2401.2 2433.6 2444.0 2448.4 2452.5 2425.2 2429.3 2433.2 2446.2 2456.5 2395.4 2413.3 2427.8 2429.6 2431.4 2357.2 2373.3 2399.6 2413.2 2414.2 9050.8 9176.2 9197.4 9203.4 9213.6 5105.6 5274.7 5278.4 5281.7 5284.6 3424.9 3560.6 3677.0 3749.2 3769.1 1052.7 1081.8 1104.6 1131.1 1135.5 9959.9 12033.0 12050.5 12058.5 12061.5 4712.4 4767.1 4768.1 4890.5 4896.2 10250.4 10257.2 10272.3 10278.4 10283.1 5460.5 5464.9 5467.6 5472.7 5486.7 4510.1 4651.5 4664.1 4979.4 5009.4 3986.2 3990.1 4088.2 4118.4 4129.5 1283.4 1285.8 1286.7 1301.6 1303.6 920.7 922.7 923.6 934.5 960.1 5900.3 5993.3 5994.4 6138.5 6193.5 442.5 445.4 450.4 455.0 460.7 3337.8 4030.3 4053.4 4055.7 4153.9 9238.7 11096.8 11099.8 11104.4 11110.9 11037.9 11044.7 11045.3 11050.9 11050.9 8241.3 8299.8 8427.6 8565.0 8596.7 5771.2 5928.1 6028.2 6067.6 6084.5 10091.9 10195.3 10271.0 10278.5 10430.2 9898.7 10617.1 10622.3 10626.8 10651.3 7033.2 7269.1 7314.2 7621.7 7695.4 7581.3 7692.3 8029.8 8105.5 8540.3 7454.1 7676.5 7689.5 7758.7 7796.7 7379.7 7486.7 7492.6 7506.0 7681.8 7058.2 7199.5 7207.9 7208.7 7210.4 4932.3 5024.7 5107.4 5125.4 5154.9 4942.4 4974.8 5082.7 5144.6 5216.1 15:53:17 INFO - PROCESS | 1650 | 15:53:17 INFO - PROCESS | 1650 | [#4] prototype.html Cycles:180 Average:4376.92 Median:4761.21 stddev:1374.55 (28.9%) stddev-sans-first:1342.98 15:53:17 INFO - PROCESS | 1650 | Values: 245.8 282.2 298.7 302.0 302.3 4989.4 5248.4 5271.6 5312.4 5333.4 4168.9 4295.5 4487.0 4778.6 5160.5 3981.5 4014.6 4037.5 4050.9 4058.8 3737.3 4047.3 4054.1 4056.5 4067.9 3939.5 3953.9 3983.8 4001.2 4008.2 3965.4 3965.8 3971.8 3983.9 3994.2 2864.9 2901.8 3396.6 3428.9 3433.9 3951.3 4140.7 5145.4 5151.7 5162.0 4477.6 4494.8 4500.1 4511.9 4518.3 4572.4 4684.3 4724.0 5501.9 5564.5 3572.0 3744.1 3765.8 3772.3 3781.5 4788.7 5708.4 5785.5 5796.9 5825.0 3174.5 3402.8 3804.3 3809.8 3821.5 3227.7 3860.7 3871.9 3879.6 3888.3 4279.2 4342.1 4502.2 4534.0 4569.7 5050.9 5141.4 5166.3 5519.7 5567.6 1095.6 1225.7 1256.2 1266.8 1278.3 692.6 842.8 878.9 885.3 888.0 4757.2 4784.9 5205.1 5211.6 5249.3 4491.7 5161.0 5467.2 5679.8 5691.5 4048.5 4065.6 4524.9 5216.1 5278.6 2267.9 2373.7 2486.3 2497.5 2520.3 4149.2 4354.2 4765.2 4777.4 5420.9 4834.9 4865.4 5884.9 5936.6 5937.6 5136.5 5349.8 5919.7 5936.3 5959.5 5585.4 5624.9 5752.9 5776.7 5797.5 4714.4 5655.8 5669.3 5698.6 5774.9 5365.2 5484.8 5682.7 5936.6 5947.4 3802.6 3802.6 3810.2 3849.7 3867.3 4864.9 5738.7 5760.7 5761.4 5867.6 4925.4 5300.4 5466.6 5667.9 5690.4 4550.7 5004.9 5038.7 5584.4 5595.9 4441.8 4541.5 5192.7 5249.3 5366.7 5316.9 5328.6 5576.5 5581.3 5589.2 4585.4 4648.4 5210.7 5398.9 5450.9 15:53:17 INFO - PROCESS | 1650 | 15:53:17 INFO - PROCESS | 1650 | [#5] yui.html Cycles:180 Average:26553.70 Median:3651.05 stddev:44055.03 (1206.6%) stddev-sans-first:44135.92 15:53:17 INFO - PROCESS | 1650 | Values: 721.2 741.7 756.3 778.2 838.4 14481.6 15493.7 15641.7 15676.4 15711.1 13798.6 13849.6 13942.1 14528.6 15298.9 806.6 841.2 844.1 844.8 846.4 666.2 684.0 810.3 825.4 829.8 878.8 885.7 891.6 892.3 893.0 884.2 885.2 885.3 885.7 886.7 511.6 527.2 528.6 656.9 657.1 11530.0 11578.0 11584.4 12561.7 12903.7 14064.6 14382.7 14511.0 14552.4 14808.0 9988.7 11433.7 11804.3 11974.2 12070.4 3665.2 3810.1 3816.2 3916.3 3939.4 114536.4 115498.0 116154.4 116726.0 117989.8 8983.2 10994.5 11097.3 11296.4 11595.5 22227.0 22550.0 22590.7 22667.4 22780.3 7473.6 7728.1 7813.1 7819.2 7824.0 4202.3 4231.4 4249.5 4253.4 4427.0 3636.9 3730.6 3740.7 3740.7 3751.2 562.2 585.3 590.0 592.1 638.1 595.2 595.8 620.7 650.6 650.9 8858.8 9095.5 9386.5 9737.2 9770.0 585.3 648.0 667.5 668.1 689.8 4380.5 4645.5 4669.8 4711.8 4747.8 166405.0 168367.2 170326.0 172435.0 175981.0 122633.0 145438.0 152583.0 155448.3 155789.0 102302.5 103748.0 105048.0 122875.4 124699.4 8804.4 9045.8 9115.9 9122.5 9328.8 62970.8 67092.7 67987.7 70301.0 72668.9 96665.0 99316.0 99662.0 104966.0 107420.5 11645.4 12901.2 12947.8 12982.1 13221.8 13215.9 14537.6 14849.9 15007.1 15762.4 13100.7 13795.3 13924.8 13971.7 14144.3 13664.2 13695.3 13831.0 14049.3 14135.9 10963.7 13289.9 13402.4 13476.0 13530.5 10450.7 11349.7 11777.9 11826.0 11829.2 10746.9 11478.5 11626.3 11700.9 11733.5 15:53:17 INFO - PROCESS | 1650 | -------- Summary: end -------- 15:53:17 INFO - PROCESS | 1650 | 15:53:17 INFO - TEST-INFO | 1650: exit 0 15:53:17 INFO - TEST-OK | dromaeo_css | took 1116916ms 15:53:17 INFO - TEST-START | kraken 15:53:17 INFO - operating with platform_type : mac_ 15:53:17 INFO - Initialising browser for kraken test... 15:53:17 INFO - TEST-INFO | started process 1660 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/tmpIGQID1/profile http://localhost:49271/getInfo.html) 15:53:20 INFO - PROCESS | 1660 | __metrics Screen width/height:1600/1200 15:53:20 INFO - PROCESS | 1660 | colorDepth:24 15:53:20 INFO - PROCESS | 1660 | Browser inner width/height: 1024/689 15:53:20 INFO - PROCESS | 1660 | __metrics 15:53:20 INFO - PROCESS | 1660 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 15:53:20 INFO - PROCESS | 1660 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:53:20 INFO - TEST-INFO | 1660: exit 0 15:53:20 INFO - Browser initialized. 15:53:20 INFO - Running cycle 1/1 for kraken test... 15:53:20 INFO - TEST-INFO | started process 1661 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/tmpIGQID1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:53:32 INFO - PROCESS | 1661 | RSS: Main: 219291648 15:53:32 INFO - PROCESS | 1661 | 15:53:35 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection) 15:53:36 INFO - PROCESS | 1661 | RSS: Main: 269832192 15:53:36 INFO - PROCESS | 1661 | 15:53:39 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-dft) 15:53:39 INFO - PROCESS | 1661 | RSS: Main: 280416256 15:53:39 INFO - PROCESS | 1661 | 15:53:42 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-fft) 15:53:43 INFO - PROCESS | 1661 | RSS: Main: 376901632 15:53:43 INFO - PROCESS | 1661 | 15:53:45 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator) 15:53:46 INFO - PROCESS | 1661 | RSS: Main: 280915968 15:53:46 INFO - PROCESS | 1661 | 15:53:48 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:53:48 INFO - PROCESS | 1661 | RSS: Main: 281694208 15:53:48 INFO - PROCESS | 1661 | 15:53:51 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom) 15:53:52 INFO - PROCESS | 1661 | RSS: Main: 318394368 15:53:52 INFO - PROCESS | 1661 | 15:53:54 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate) 15:53:55 INFO - PROCESS | 1661 | RSS: Main: 320663552 15:53:55 INFO - PROCESS | 1661 | 15:53:58 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial) 15:53:58 INFO - PROCESS | 1661 | RSS: Main: 316133376 15:53:58 INFO - PROCESS | 1661 | 15:54:00 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:54:01 INFO - PROCESS | 1661 | RSS: Main: 290656256 15:54:01 INFO - PROCESS | 1661 | 15:54:02 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:54:03 INFO - PROCESS | 1661 | RSS: Main: 296345600 15:54:03 INFO - PROCESS | 1661 | 15:54:05 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:54:06 INFO - PROCESS | 1661 | RSS: Main: 301604864 15:54:06 INFO - PROCESS | 1661 | 15:54:09 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:54:10 INFO - PROCESS | 1661 | RSS: Main: 313405440 15:54:10 INFO - PROCESS | 1661 | 15:54:13 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:54:13 INFO - PROCESS | 1661 | RSS: Main: 312750080 15:54:13 INFO - PROCESS | 1661 | 15:54:15 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49271/tests/kraken/driver.html?testName=ai-astar) 15:54:15 INFO - PROCESS | 1661 | RSS: Main: 356671488 15:54:15 INFO - PROCESS | 1661 | 15:54:15 INFO - PROCESS | 1661 | __start_tp_report 15:54:15 INFO - PROCESS | 1661 | _x_x_mozilla_page_load 15:54:15 INFO - PROCESS | 1661 | _x_x_mozilla_page_load_details 15:54:15 INFO - PROCESS | 1661 | |i|pagename|runs| 15:54:15 INFO - PROCESS | 1661 | |0;ai-astar;112;113;112;112;111;112;110;112;110;111 15:54:15 INFO - PROCESS | 1661 | |1;audio-beat-detection;156;109;108;142;109;110;111;103;142;108 15:54:15 INFO - PROCESS | 1661 | |2;audio-dft;180;183;180;183;186;179;183;182;181;184 15:54:15 INFO - PROCESS | 1661 | |3;audio-fft;85;58;58;89;62;62;59;61;105;82 15:54:15 INFO - PROCESS | 1661 | |4;audio-oscillator;88;95;128;102;68;70;92;68;68;90 15:54:15 INFO - PROCESS | 1661 | |5;imaging-gaussian-blur;87;91;136;85;87;84;87;84;86;84 15:54:15 INFO - PROCESS | 1661 | |6;imaging-darkroom;96;93;94;94;94;94;94;94;93;95 15:54:15 INFO - PROCESS | 1661 | |7;imaging-desaturate;87;86;83;84;85;85;83;84;84;85 15:54:15 INFO - PROCESS | 1661 | |8;json-parse-financial;55;56;54;53;57;59;58;58;57;58 15:54:15 INFO - PROCESS | 1661 | |9;json-stringify-tinderbox;60;73;80;74;70;68;68;69;69;69 15:54:15 INFO - PROCESS | 1661 | |10;stanford-crypto-aes;82;83;86;84;84;85;82;82;83;88 15:54:15 INFO - PROCESS | 1661 | |11;stanford-crypto-ccm;137;139;139;138;144;149;157;156;174;140 15:54:15 INFO - PROCESS | 1661 | |12;stanford-crypto-pbkdf2;166;161;168;173;227;148;209;224;165;165 15:54:15 INFO - PROCESS | 1661 | |13;stanford-crypto-sha256-iterative;65;66;67;70;86;85;56;67;86;85 15:54:15 INFO - PROCESS | 1661 | __end_tp_report 15:54:15 INFO - PROCESS | 1661 | __start_cc_report 15:54:15 INFO - PROCESS | 1661 | _x_x_mozilla_cycle_collect,1984 15:54:15 INFO - PROCESS | 1661 | __end_cc_report 15:54:15 INFO - PROCESS | 1661 | __startTimestamp1477349655899__endTimestamp 15:54:15 INFO - PROCESS | 1661 | 15:54:15 INFO - PROCESS | 1661 | ------- Summary: start ------- 15:54:15 INFO - PROCESS | 1661 | Number of tests: 14 15:54:15 INFO - PROCESS | 1661 | 15:54:15 INFO - PROCESS | 1661 | [#0] ai-astar Cycles:10 Average:111.50 Median:112.00 stddev:0.97 (0.9%) stddev-sans-first:1.01 15:54:15 INFO - PROCESS | 1661 | Values: 112.0 113.0 112.0 112.0 111.0 112.0 110.0 112.0 110.0 111.0 15:54:15 INFO - PROCESS | 1661 | 15:54:15 INFO - PROCESS | 1661 | [#1] audio-beat-detection Cycles:10 Average:119.80 Median:110.50 stddev:19.04 (17.2%) stddev-sans-first:15.03 15:54:15 INFO - PROCESS | 1661 | Values: 156.0 109.0 108.0 142.0 109.0 110.0 111.0 103.0 142.0 108.0 15:54:15 INFO - PROCESS | 1661 | 15:54:15 INFO - PROCESS | 1661 | [#2] audio-dft Cycles:10 Average:182.10 Median:183.00 stddev:2.13 (1.2%) stddev-sans-first:2.12 15:54:15 INFO - PROCESS | 1661 | Values: 180.0 183.0 180.0 183.0 186.0 179.0 183.0 182.0 181.0 184.0 15:54:15 INFO - PROCESS | 1661 | 15:54:15 INFO - PROCESS | 1661 | [#3] audio-fft Cycles:10 Average:72.10 Median:62.00 stddev:16.76 (27.0%) stddev-sans-first:17.12 15:54:15 INFO - PROCESS | 1661 | Values: 85.0 58.0 58.0 89.0 62.0 62.0 59.0 61.0 105.0 82.0 15:54:15 INFO - PROCESS | 1661 | 15:54:15 INFO - PROCESS | 1661 | [#4] audio-oscillator Cycles:10 Average:86.90 Median:79.00 stddev:19.37 (24.5%) stddev-sans-first:20.54 15:54:15 INFO - PROCESS | 1661 | Values: 88.0 95.0 128.0 102.0 68.0 70.0 92.0 68.0 68.0 90.0 15:54:15 INFO - PROCESS | 1661 | 15:54:15 INFO - PROCESS | 1661 | [#5] imaging-gaussian-blur Cycles:10 Average:91.10 Median:86.50 stddev:15.92 (18.4%) stddev-sans-first:16.82 15:54:15 INFO - PROCESS | 1661 | Values: 87.0 91.0 136.0 85.0 87.0 84.0 87.0 84.0 86.0 84.0 15:54:15 INFO - PROCESS | 1661 | 15:54:15 INFO - PROCESS | 1661 | [#6] imaging-darkroom Cycles:10 Average:94.10 Median:94.00 stddev:0.88 (0.9%) stddev-sans-first:0.60 15:54:15 INFO - PROCESS | 1661 | Values: 96.0 93.0 94.0 94.0 94.0 94.0 94.0 94.0 93.0 95.0 15:54:15 INFO - PROCESS | 1661 | 15:54:15 INFO - PROCESS | 1661 | [#7] imaging-desaturate Cycles:10 Average:84.60 Median:85.00 stddev:1.26 (1.5%) stddev-sans-first:1.00 15:54:15 INFO - PROCESS | 1661 | Values: 87.0 86.0 83.0 84.0 85.0 85.0 83.0 84.0 84.0 85.0 15:54:15 INFO - PROCESS | 1661 | 15:54:15 INFO - PROCESS | 1661 | [#8] json-parse-financial Cycles:10 Average:56.50 Median:57.50 stddev:1.96 (3.4%) stddev-sans-first:2.00 15:54:15 INFO - PROCESS | 1661 | Values: 55.0 56.0 54.0 53.0 57.0 59.0 58.0 58.0 57.0 58.0 15:54:15 INFO - PROCESS | 1661 | 15:54:15 INFO - PROCESS | 1661 | [#9] json-stringify-tinderbox Cycles:10 Average:70.00 Median:69.50 stddev:5.12 (7.4%) stddev-sans-first:3.95 15:54:15 INFO - PROCESS | 1661 | Values: 60.0 73.0 80.0 74.0 70.0 68.0 68.0 69.0 69.0 69.0 15:54:15 INFO - PROCESS | 1661 | 15:54:15 INFO - PROCESS | 1661 | [#10] stanford-crypto-aes Cycles:10 Average:83.90 Median:84.00 stddev:1.97 (2.3%) stddev-sans-first:1.96 15:54:15 INFO - PROCESS | 1661 | Values: 82.0 83.0 86.0 84.0 84.0 85.0 82.0 82.0 83.0 88.0 15:54:15 INFO - PROCESS | 1661 | 15:54:15 INFO - PROCESS | 1661 | [#11] stanford-crypto-ccm Cycles:10 Average:147.30 Median:146.50 stddev:11.93 (8.1%) stddev-sans-first:12.05 15:54:15 INFO - PROCESS | 1661 | Values: 137.0 139.0 139.0 138.0 144.0 149.0 157.0 156.0 174.0 140.0 15:54:15 INFO - PROCESS | 1661 | 15:54:15 INFO - PROCESS | 1661 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:180.60 Median:170.50 stddev:28.30 (16.6%) stddev-sans-first:29.52 15:54:15 INFO - PROCESS | 1661 | Values: 166.0 161.0 168.0 173.0 227.0 148.0 209.0 224.0 165.0 165.0 15:54:15 INFO - PROCESS | 1661 | 15:54:15 INFO - PROCESS | 1661 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.30 Median:77.50 stddev:11.10 (14.3%) stddev-sans-first:11.36 15:54:15 INFO - PROCESS | 1661 | Values: 65.0 66.0 67.0 70.0 86.0 85.0 56.0 67.0 86.0 85.0 15:54:15 INFO - PROCESS | 1661 | -------- Summary: end -------- 15:54:15 INFO - PROCESS | 1661 | 15:54:16 INFO - TEST-INFO | 1661: exit 0 15:54:16 INFO - TEST-OK | kraken | took 58789ms 15:54:16 INFO - SUITE-END | took 1175s 15:54:17 INFO - Completed test suite (00:19:35) 15:54:17 INFO - javascript benchmark 15:54:17 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3325.600927888653, 3338.1988322802517, 3349.0, 3354.580677415323, 3403.8468268927895, 5734.913976290359, 5792.102224155252, 5797.652140871545, 5802.274715660543, 5855.385184555619, 5634.32388113427, 5714.457126572969, 5779.16202150689, 5788.131780232967, 5805.564582656297, 4457.286834106536, 5227.895442091156, 5239.240310155025, 5280.128778751501, 5280.471952804727, 5207.895842083156, 5210.973945130269, 5219.0, 5324.574034077284, 5330.92003619946, 5189.273501709764, 5206.791728330882, 5220.216967454874, 5246.1606143017125, 5275.788968441258, 5200.947990520084, 5257.18513630384, 5259.76331065103, 5272.710000949946, 5310.9734451327495, 5149.794008239666, 5152.407473140599, 5221.71280579568, 5227.790888364499, 5242.528172464458, 5634.211210430543, 5687.914681279784, 5719.6854173020465, 5723.399043100498, 5756.107803290497, 6174.166487524171, 6225.657588832612, 6235.095911092912, 6246.500279977591, 6279.0, 6298.937010629881, 6323.494120470351, 6330.8100756977365, 6346.460550853183, 6354.364563543655, 5700.686462244575, 5766.654000759968, 5774.076147816413, 5780.0751879699465, 5830.883382332329, 6307.9369206308265, 6312.337204593543, 6321.810345689637, 6329.525285603599, 6344.429001389897, 6203.503719702413, 6207.099970504251, 6208.689565521706, 6211.409916057967, 6213.192285003011, 6115.724792384353, 6209.0, 6210.782622608187, 6320.4311611955145, 6338.714757835908, 5436.809711660073, 6130.551011451118, 6209.534284928648, 6236.095766113888, 6264.968675156686, 5110.48895110486, 6227.346128656516, 6268.373162683695, 6270.7805226816845, 6303.558750887394, 4867.050925069649, 4946.1344264753525, 4965.875853103701, 4973.726445045485, 4975.0547395994645, 4426.247537918497, 4428.800703968329, 4496.842610508616, 4498.617617502484, 4499.055198408306, 5966.194563733927, 5979.79070732531, 5983.581149319593, 5993.790217342372, 6004.039353703386, 6243.687815609202, 6264.279607845065, 6271.717772700239, 6280.874382512324, 6280.905786413207, 4751.429828420612, 5832.825015249549, 5838.854028649318, 5866.882662346729, 5964.970175149097, 5428.511433970962, 5447.891042179134, 5468.179773033997, 5478.91781623276, 5510.586705996986, 5307.761150748225, 6349.428551430394, 6354.269259035178, 6364.5863018905475, 6367.554271201064, 6093.238345206849, 6221.688915554295, 6290.0, 6308.589941653778, 6331.240251169889, 6304.5586808922935, 6325.082862984934, 6333.619982801047, 6339.080833279057, 6351.015592583157, 6113.567524283718, 6127.509799216141, 6132.724027418866, 6195.194624698941, 6212.9068063978175, 6160.383961603804, 6187.783427580013, 6192.535559833121, 6252.687365631791, 6268.43584077417, 6128.785492507741, 6137.631742095488, 6141.662208578571, 6151.0, 6153.815385538441, 5997.940020599913, 6063.0, 6076.817695469143, 6103.328633850362, 6129.141920131096, 5993.670348130895, 6060.121282414113, 6063.909041364295, 6068.787592434243, 6079.148919151411, 6166.229221347332, 6194.287656919512, 6198.380161983766, 6200.844978875564, 6201.596896201732, 5821.912671309849, 5873.207117039145, 5877.823665290048, 5911.586188966903, 5985.25184351956], "value": 5718.463851899839, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [494.7155385653249, 497.0655168283626, 501.5310684509986, 517.7825313368385, 524.3105316508788, 30914.690853091462, 40020.39969400461, 41194.97012574683, 41354.0, 41427.58572414275, 34643.4803477948, 43275.0, 43379.13241735163, 43430.0, 45363.0, 9274.397164184307, 9673.70978870635, 9874.0, 9879.950600247024, 9893.851592226123, 9687.0, 9782.951085244564, 9811.313208075437, 9812.165965892871, 9816.607335706563, 8267.338612910982, 9774.853377199348, 9855.26085543587, 9855.457949812757, 9857.162141218005, 9784.657536986208, 9833.606655733762, 9848.359856609297, 9851.014898510164, 9878.456684882329, 9718.31971761977, 9731.56207970636, 9800.607975680965, 9801.558929848103, 9804.01959804021, 40315.395269070985, 40576.0, 40590.1881962362, 40651.390229146586, 40723.796381017906, 2958.9704102959126, 3242.5460435539044, 3355.9664403355896, 3368.629450760439, 3761.492198553215, 26021.869890650614, 29289.414211715648, 30000.849995749883, 30185.396292074034, 31933.201669958205, 3122.8126312421327, 3199.3121478882153, 3221.951670724941, 3242.0922141800334, 3260.3316320154313, 538431.0, 541924.0, 542423.0, 542758.0, 544985.27507363, 33192.0, 33926.49110263299, 62293.37706622967, 62887.371126289065, 62986.37013629897, 34783.0, 35260.47109293363, 35284.64715352814, 35317.29365412729, 35392.823035884656, 15010.924945375204, 15186.0, 15187.848121518644, 15196.696066078617, 15225.467108651366, 12860.0, 13021.414036368385, 13022.47910083586, 13033.283169425584, 13035.413406396545, 7663.31030207284, 7733.265339792823, 7772.145064042951, 7795.727149549852, 7800.843983120306, 2715.91852244433, 3198.72810811079, 3256.446404111307, 3263.0537144228383, 3296.620888597842, 813.9715109971122, 876.4653561327585, 940.9764755881158, 943.740471370365, 994.9054839790208, 29495.53535836715, 29969.100926972227, 30148.24629384283, 30359.696403036127, 30903.536446953312, 932.421898422982, 1042.5464922758472, 1064.893510648929, 1070.6787963610886, 1173.5188572685158, 15291.235438228045, 15647.921760391353, 15870.603234918988, 16010.398043892836, 16158.838411615734, 683292.0, 982145.0, 1000487.0, 1002200.0, 1002901.0, 56972.14541781876, 57689.711551442815, 57705.71147144237, 57740.711296443245, 57980.71009645009, 1255.409957320058, 1288.6391810293132, 1290.4644572502493, 1390.2909516146838, 1414.8938829587821, 28662.856685716437, 31329.2576419214, 31732.841335794095, 32207.35585288328, 32236.19409514781, 53555.46444535505, 54629.45370546244, 54669.72665136649, 54796.45203547914, 54808.177877332666, 585234.0, 593497.0, 593562.0, 598587.0, 598808.0, 20778.376648700563, 23677.763222367557, 24288.0, 26815.865920670272, 27149.321266967694, 42208.36687449752, 45361.54638453573, 45686.0, 46322.073558529315, 46322.53677463182, 37299.0, 37414.6258537422, 38113.0, 38292.0, 39610.0, 37621.435678465394, 37856.43215351717, 38445.6155438442, 38638.420423693104, 38897.41653875138, 31563.684363156073, 36563.45154822733, 37219.0, 37536.246375363335, 37933.430998534495, 31486.527702084946, 32662.0, 33917.0, 33921.66078339185, 34082.65917340795, 21926.342209733735, 23520.882395587912, 24837.130700425398, 24990.500189995735, 25521.872390637927], "value": 18756.64454488639, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [363.6854121185175, 370.3315515494533, 374.5729867950536, 385.4353372309566, 398.10227936004304, 17322.56693582661, 20089.493288003403, 20906.686399704016, 21147.15411383543, 21643.567128657436, 20615.690764638504, 20685.689714654254, 20957.37127886162, 21201.0, 21769.0, 5419.810306639269, 6001.729922153502, 6300.716467758939, 6986.650667466632, 7094.11323584552, 3882.9029274268087, 4077.4699289092523, 7054.929450705505, 7104.254053324404, 7113.146422429316, 4131.669466442692, 4188.958110418887, 7035.718571257144, 7102.431805455577, 7114.0, 4723.905521889543, 6104.542159338067, 7030.753923612675, 7086.71653133874, 7111.751088711871, 5926.140709597127, 5929.140274660193, 5946.167536544887, 5953.1070339449, 5962.135490353874, 12967.546135885199, 13068.738625227537, 13146.14550054253, 13162.210267383987, 17663.410293073684, 2279.11114665279, 2475.4553998120386, 2579.071534247669, 2699.2307192450057, 2721.4693134838712, 10073.44596047217, 12470.81293780594, 14413.99102062856, 15181.696366072616, 15619.921900390538, 1850.6668799616064, 1860.804615515365, 1882.190658017052, 1900.1069497336368, 1952.5021119614548, 60962.695186523786, 80959.38081238401, 84864.57567712122, 122725.0, 123231.3838430811, 11215.271007384494, 11455.198136130392, 11608.994896760603, 11919.70200744971, 12052.879471205175, 14918.627034324012, 14937.775933361008, 14949.551513454613, 14950.028248164052, 14955.476558320624, 8330.375221858263, 8635.37763754686, 9020.323475739346, 9033.683821066232, 9128.726138215865, 8546.924095409382, 8900.664900264883, 8962.417442866323, 8982.595783189772, 9147.725568232963, 4520.0507893342765, 4585.220512512881, 4585.518520555293, 4639.930401043987, 4673.182193116259, 1909.7421848050612, 1914.818092281259, 1936.3416438410727, 1954.7165660979078, 1981.0787983587702, 788.1842293226483, 827.8634025385865, 842.9884139033062, 860.7761981884755, 944.4994153098869, 17803.643927121386, 21481.78518214829, 22269.777302226772, 22476.0, 22577.88711056434, 810.3476701255546, 941.9293552983554, 958.4249450329746, 1000.8598796168542, 1006.1799633298838, 7691.730789422455, 10037.394016957252, 11296.774064518828, 11475.598354057567, 11497.0, 580817.0, 598298.0, 614487.0, 621873.0, 622142.0, 88753.55623221843, 129718.0, 138845.0, 148358.25820870826, 149670.0, 942.8255772682213, 952.4713783850029, 974.0843607009389, 996.1632228927735, 996.4270544436978, 19285.61428771445, 19413.826027404175, 20371.59256814885, 20447.591048178656, 20460.59078818445, 55717.72141139268, 57374.42625573691, 57470.42529574651, 58013.709931450074, 58350.12474812966, 78048.21951780637, 78517.0, 79031.60484197772, 81316.0, 81873.59063204646, 7881.881771773314, 8060.468510982894, 8128.0, 8362.12197719255, 8504.744857654281, 13127.277999710108, 13312.534061307808, 13315.001374897116, 13725.862741372459, 13770.449182032606, 10634.989675980769, 10923.289986150874, 11168.162387821108, 11527.02020328248, 11638.185327027028, 11199.048080912888, 11398.487068082122, 11474.827877581676, 11900.523979040741, 11965.341906195243, 11467.4266286687, 11620.302781833117, 11744.823827642422, 12065.879341206826, 12164.513419463123, 8040.276375126266, 8106.027276726831, 8218.589070546568, 8326.70856520019, 8439.620217090123, 7114.644267786486, 11495.0, 11614.128940329678, 11661.008814250883, 11696.532138714696], "value": 9642.292769863323, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1350.270853738981, 1507.9999999999995, 1636.9918150409253, 1826.6529359421718, 1828.9634207315853, 8690.478571285727, 9219.49292788898, 9233.722988310354, 9237.953810230947, 9239.168474837263, 8085.353171746261, 8329.250367466926, 8723.65105395785, 9023.18791308782, 9055.185033346997, 2098.5697931923996, 2402.555527227464, 2430.4652976345174, 2452.288836237489, 2459.9139030133947, 2401.1955994741697, 2433.598456254716, 2443.951120977579, 2448.436859522311, 2452.5462789383932, 2425.163318655061, 2429.259075981825, 2433.221369161869, 2446.192756390387, 2456.4841383309526, 2395.3772019275116, 2413.263954493879, 2427.842190257645, 2429.6112621980574, 2431.440768623209, 2357.233898982837, 2373.3473294843884, 2399.6400539918977, 2413.227767114524, 2414.1550457339968, 9050.77373065672, 9176.174144326977, 9197.448153110834, 9203.401778884418, 9213.631454741802, 5105.591552675777, 5274.736263186825, 5278.366596008504, 5281.683099014033, 5284.550813180885, 3424.8697929683144, 3560.5549306336707, 3677.0439685681918, 3749.2314075614436, 3769.0765762388114, 1052.7420781908481, 1081.810683130449, 1104.5589247762455, 1131.0781712903956, 1135.4720055174384, 9959.900400996043, 12033.0, 12050.457729402198, 12058.517659293619, 12061.517539298506, 4712.384411830758, 4767.118083154558, 4768.141734487756, 4890.510948905081, 4896.2410826321975, 10250.436226007492, 10257.17942564593, 10272.33229840058, 10278.434686092187, 10283.07452329279, 5460.453954604587, 5464.890702185934, 5467.617266791286, 5472.671639701631, 5486.670799752028, 4510.143072816154, 4651.534846515389, 4664.137134630104, 4979.3526841510375, 5009.373828271466, 3986.22268657609, 3990.102226998902, 4088.2232375848494, 4118.382242663624, 4129.545749967501, 1283.4352884730688, 1285.8199852020725, 1286.7362190751062, 1301.6420484366874, 1303.6089173248176, 920.6841070258024, 922.7185708359015, 923.6213152607532, 934.4580143516744, 960.13108137136, 5900.321463031721, 5993.310769261503, 5994.430529099728, 6138.539609529304, 6193.504519638418, 442.45136031321573, 445.36090709831495, 450.3897219267845, 454.9921922940702, 460.67062050633956, 3337.8331083445732, 4030.2946984277633, 4053.43251944728, 4055.7160998730396, 4153.875383738493, 9238.722838314861, 11096.778064438666, 11099.778004439866, 11104.44477776108, 11110.944445277722, 11037.889621103846, 11044.723881903017, 11045.28205666629, 11050.944745276222, 11050.944745276383, 8241.299489543337, 8299.751007469786, 8427.578621068922, 8564.97220333564, 8596.742097736953, 5771.2208851806145, 5928.110783382354, 6028.156058151774, 6067.605605635619, 6084.452399284086, 10091.899081009096, 10195.337303075275, 10271.0, 10278.486075696335, 10430.165586753194, 9898.703038908845, 10617.097546708615, 10622.256442048982, 10626.787464250518, 10651.254412191072, 7033.156021277275, 7269.127704675473, 7314.195438501654, 7621.657025433758, 7695.384369250334, 7581.3176814087, 7692.346150577264, 8029.839403211786, 8105.513669179868, 8540.274076703301, 7454.142773581108, 7676.462647614613, 7689.504191234141, 7758.728444504415, 7796.727114550963, 7379.667914943733, 7486.700531978878, 7492.62536873165, 7505.962470187614, 7681.807954800951, 7058.153021637437, 7199.460040496879, 7207.9279207207255, 7208.675609597476, 7210.387117095106, 4932.334134891744, 5024.692092580409, 5107.41264754558, 5125.410577783603, 5154.8969020620125, 4942.406911170682, 4974.825881094144, 5082.745862706924, 5144.588432925282, 5216.139337009351], "value": 4583.975445254855, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [245.8119538553006, 282.15353938185444, 298.74755831322534, 301.9969800301996, 302.34693062983956, 4989.426215985162, 5248.448912864152, 5271.630985830993, 5312.389075256347, 5333.359996800385, 4168.937465938014, 4295.548967358422, 4486.955130448695, 4778.617710583154, 5160.483951604838, 3981.4625025621604, 4014.5985401459766, 4037.5356833964174, 4050.898727531806, 4058.7767672777986, 3737.252549490099, 4047.3203620497457, 4054.0878302382025, 4056.4523789288364, 4067.8576249831262, 3939.5469521005166, 3953.892909985209, 3983.800809959505, 4001.1997600479876, 4008.238434697398, 3965.385365268374, 3965.8300801263695, 3971.7616942983223, 3983.900402489932, 3994.1811928554866, 2864.928376790576, 2901.7823663225345, 3396.626371099177, 3428.9142771430666, 3433.8626454941773, 3951.320688707288, 4140.710150289481, 5145.449639748562, 5151.6908985461, 5161.974190129063, 4477.574630410106, 4494.775261236958, 4500.054988452429, 4511.887202819923, 4518.254488009475, 4572.376806233772, 4684.297355396684, 4723.976380118112, 5501.862453438656, 5564.527015203713, 3571.982140089283, 3744.138848064933, 3765.7928813915223, 3772.2832661794446, 3781.5462144542557, 4788.664793464493, 5708.400617935098, 5785.537157027427, 5796.855078623068, 5824.970875145597, 3174.476211425089, 3402.795832250073, 3804.2962052020466, 3809.790461524643, 3821.4840996465123, 3227.725643320297, 3860.729748917605, 3871.9225615488094, 3879.592642772525, 3888.2612303662213, 4279.165562715303, 4342.08816148606, 4502.234620114588, 4533.977330113395, 4569.725816451024, 5050.949490505048, 5141.3830340358645, 5166.250893620404, 5519.668819870741, 5567.554595632339, 1095.5508241620896, 1225.6874497003207, 1256.1960345378964, 1266.7593157300084, 1278.2905487454552, 692.6363659079024, 842.8230071685015, 878.9296856251484, 885.3271513649672, 887.9511626860585, 4757.238841785298, 4784.856454306377, 5205.141151710001, 5211.609129315317, 5249.343832020997, 4491.685582009228, 5161.045206636784, 5467.234587157801, 5679.829605111853, 5691.516221121168, 4048.5344185419053, 4065.556727361744, 4524.891401606627, 5216.1221960094335, 5278.604104692164, 2267.8887345200733, 2373.691420115374, 2486.3038349262238, 2497.5254701606636, 2520.3447103752787, 4149.232392007489, 4354.238008348526, 4765.1892280933025, 4777.426708794897, 5420.864478387993, 4834.887975765593, 4865.416150062015, 5884.852878678067, 5936.584439089309, 5937.584369094122, 5136.459062281376, 5349.812756553502, 5919.733611987471, 5936.287645482484, 5959.463648271676, 5585.385607583082, 5624.9024808862405, 5752.856178595569, 5776.682282474504, 5797.4782269595935, 4714.4106986626675, 5655.773769049192, 5669.270872383798, 5698.572607054404, 5774.855628609318, 5365.248865158803, 5484.808031718871, 5682.659040457585, 5936.5844390892225, 5947.434993675594, 3802.581716011181, 3802.6007269236334, 3810.1808111256214, 3849.730518863653, 3867.323218436706, 4864.927026094682, 5738.655680659173, 5760.711964401847, 5761.395053519488, 5867.647941123546, 4925.408950925912, 5300.3904550975585, 5466.633341664584, 5667.858303542444, 5690.402507736628, 4550.658700597534, 5004.949950500449, 5038.722870242172, 5584.3857175711455, 5595.944040559542, 4441.800118994717, 4541.477730061085, 5192.688438693691, 5249.343832020997, 5366.651167674088, 5316.920246196233, 5328.626996110235, 5576.470235327637, 5581.302337207849, 5589.189567512769, 4585.380973568525, 4648.373069425809, 5210.713410762444, 5398.9190162146815, 5450.918236226539], "value": 3933.717246683171, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [721.1526456413712, 741.7107328142022, 756.2701992577162, 778.179021132705, 838.4256784102888, 14481.637959051015, 15493.690126197469, 15641.687166256683, 15676.372945082197, 15711.057336559787, 13798.586042418743, 13849.584512464617, 13942.093763905339, 14528.636784080403, 15298.929074964757, 806.6249194124716, 841.1840514700731, 844.1474111147754, 844.8479273730726, 846.4075147396816, 666.1506579111623, 683.987698206652, 810.3314765318606, 825.3603457320595, 829.7925518620345, 878.8022694893662, 885.716570697377, 891.5987805487524, 892.2906289499863, 893.0266010049045, 884.1821315283337, 885.1988950000292, 885.2873436883307, 885.6723012485357, 886.7251152142792, 511.57028096399205, 527.2039220776655, 528.6141116984585, 656.9441597464221, 657.1161787395993, 11530.0, 11578.0, 11584.42077896102, 12561.685957851036, 12903.677408064874, 14064.578062658136, 14382.71234575313, 14511.0, 14552.417903283857, 14808.0, 9988.700338989842, 11433.714157146054, 11804.291742495392, 11974.161808673396, 12070.396480175956, 3665.2119794244363, 3810.1046254130256, 3816.1985982943615, 3916.275489034509, 3939.409088636699, 114536.42731786371, 115498.0, 116154.41922790416, 116726.0, 117989.8201017996, 8983.236424903957, 10994.450277486094, 11097.278676885977, 11296.435178241056, 11595.478203480863, 22227.0, 22550.0, 22590.661140082913, 22667.43331416695, 22780.316590502312, 7473.588952607659, 7728.149903510609, 7813.140554538996, 7819.17898620648, 7824.0, 4202.2646036943415, 4231.386448964883, 4249.508411623324, 4253.404523366731, 4426.955730442654, 3636.890893273206, 3730.552333719971, 3740.663340299386, 3740.7381483296454, 3751.249750050001, 562.2409746841731, 585.2625691628493, 589.9705014749245, 592.1029640095259, 638.0684201066402, 595.2410676387553, 595.7587177193244, 620.6803496199461, 650.6453982579505, 650.9283978762332, 8858.822823543493, 9095.454272743656, 9386.530673466299, 9737.172340351008, 9770.0, 585.2947198625645, 647.9838004049936, 667.502710480695, 668.1047396488729, 689.7722054742466, 4380.474343078788, 4645.450133222414, 4669.766511674403, 4711.7879695413785, 4747.786349614275, 166405.0, 168367.1581642084, 170326.0, 172435.0, 175981.0, 122633.0, 145438.0, 152583.0, 155448.33654990367, 155789.0, 102302.48848755709, 103747.99170318624, 105048.0, 122875.38562307131, 124699.37650311872, 8804.427712198687, 9045.773855653399, 9115.906925031893, 9122.543872806466, 9328.766780830534, 62970.796022139, 67092.66453667701, 67987.66006169938, 70301.0, 72668.90996635161, 96665.0, 99316.0, 99662.0, 104966.0, 107420.462897685, 11645.359505227294, 12901.161424507378, 12947.805782913452, 12982.091253612156, 13221.801672974721, 13215.898466251505, 14537.563873083824, 14849.92575037118, 15007.099574025593, 15762.448314308944, 13100.737985240432, 13795.310234488436, 13924.791128133289, 13971.720565588834, 14144.292785360896, 13664.24846633405, 13695.315234238049, 13831.0, 14049.297535122998, 14135.929320353333, 10963.671089867317, 13289.933550332187, 13402.396892140072, 13475.989300802283, 13530.526431574848, 10450.68647940563, 11349.716257093638, 11777.882221177679, 11826.0, 11829.231099978473, 10746.892531074902, 11478.540858365572, 11626.302421854716, 11700.88299117032, 11733.530658773894], "value": 7824.339812130979, "unit": "score"}], "name": "dromaeo_css", "value": 7255.916405713734, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 113.0, 112.0, 112.0, 111.0, 112.0, 110.0, 112.0, 110.0, 111.0], "value": 111.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 109.0, 108.0, 142.0, 109.0, 110.0, 111.0, 103.0, 142.0, 108.0], "value": 119.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 183.0, 180.0, 183.0, 186.0, 179.0, 183.0, 182.0, 181.0, 184.0], "value": 182.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 58.0, 58.0, 89.0, 62.0, 62.0, 59.0, 61.0, 105.0, 82.0], "value": 72.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 95.0, 128.0, 102.0, 68.0, 70.0, 92.0, 68.0, 68.0, 90.0], "value": 86.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 91.0, 136.0, 85.0, 87.0, 84.0, 87.0, 84.0, 86.0, 84.0], "value": 91.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 93.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 93.0, 95.0], "value": 94.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 83.0, 84.0, 85.0, 85.0, 83.0, 84.0, 84.0, 85.0], "value": 84.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 54.0, 53.0, 57.0, 59.0, 58.0, 58.0, 57.0, 58.0], "value": 56.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 73.0, 80.0, 74.0, 70.0, 68.0, 68.0, 69.0, 69.0, 69.0], "value": 70.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 86.0, 84.0, 84.0, 85.0, 82.0, 82.0, 83.0, 88.0], "value": 83.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 139.0, 139.0, 138.0, 144.0, 149.0, 157.0, 156.0, 174.0, 140.0], "value": 147.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 161.0, 168.0, 173.0, 227.0, 148.0, 209.0, 224.0, 165.0, 165.0], "value": 180.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 67.0, 70.0, 86.0, 85.0, 56.0, 67.0, 86.0, 85.0], "value": 73.3, "unit": "score"}], "name": "kraken", "value": 1453.8, "alertThreshold": 2.0}]} 15:54:17 INFO - Return code: 0 15:54:17 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:54:17 INFO - # TBPL SUCCESS # 15:54:17 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:54:17 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:54:17 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:54:17 INFO - 2016-10-24 15:54:17.208 screenresolution[1665:9796] starting screenresolution argv=screenresolution get 15:54:17 INFO - 2016-10-24 15:54:17.211 screenresolution[1665:9796] Display 0: 1600x1200x32@60 15:54:17 INFO - 2016-10-24 15:54:17.217 screenresolution[1666:9799] starting screenresolution argv=screenresolution list 15:54:17 INFO - Available Modes on Display 0 15:54:17 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:54:17 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:54:17 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:54:17 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:54:17 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:54:17 INFO - Intel Iris: 15:54:17 INFO - Chipset Model: Intel Iris 15:54:17 INFO - Type: GPU 15:54:17 INFO - Bus: Built-In 15:54:17 INFO - VRAM (Dynamic, Max): 1536 MB 15:54:17 INFO - Vendor: Intel (0x8086) 15:54:17 INFO - Device ID: 0x0a2e 15:54:17 INFO - Revision ID: 0x0009 15:54:17 INFO - Displays: 15:54:17 INFO - Display: 15:54:17 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:54:17 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:54:17 INFO - Display Serial Number: 1600x1200 60 15:54:17 INFO - Main Display: Yes 15:54:17 INFO - Mirror: Off 15:54:17 INFO - Online: Yes 15:54:17 INFO - Rotation: Supported 15:54:17 INFO - Return code: 0 15:54:17 INFO - Running post-action listener: _resource_record_post_action 15:54:17 INFO - [mozharness: 2016-10-24 22:54:17.456652Z] Finished run-tests step (success) 15:54:17 INFO - Running post-run listener: _resource_record_post_run 15:54:17 INFO - Total resource usage - Wall time: 1208s; CPU: 53.0%; Read bytes: 36848640; Write bytes: 659973632; Read time: 383; Write time: 1923 15:54:17 INFO - TinderboxPrint: CPU usage
53.2% 15:54:17 INFO - TinderboxPrint: I/O read bytes / time
36,848,640 / 383 15:54:17 INFO - TinderboxPrint: I/O write bytes / time
659,973,632 / 1,923 15:54:17 INFO - TinderboxPrint: CPU idle
2,262.2 (46.8%) 15:54:17 INFO - TinderboxPrint: CPU system
964.4 (20.0%) 15:54:17 INFO - TinderboxPrint: CPU user
1,607.0 (33.2%) 15:54:17 INFO - TinderboxPrint: Swap in / out
400,265,216 / 0 15:54:17 INFO - install - Wall time: 32s; CPU: 54.0%; Read bytes: 360813056; Write bytes: 356395008; Read time: 27586; Write time: 674 15:54:17 INFO - run-tests - Wall time: 1177s; CPU: 53.0%; Read bytes: 34755584; Write bytes: 292273664; Read time: 352; Write time: 1211 15:54:17 INFO - Running post-run listener: _upload_blobber_files 15:54:17 INFO - Blob upload gear active. 15:54:17 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:54:17 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 15:54:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:54:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:54:18 INFO - (blobuploader) - INFO - Open directory for files ... 15:54:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:54:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:54:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:54:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:54:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:54:19 INFO - (blobuploader) - INFO - Done attempting. 15:54:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:54:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:54:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:54:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:54:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:54:20 INFO - (blobuploader) - INFO - Done attempting. 15:54:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:54:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:54:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:54:22 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:54:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:54:22 INFO - (blobuploader) - INFO - Done attempting. 15:54:22 INFO - (blobuploader) - INFO - Iteration through files over. 15:54:22 INFO - Return code: 0 15:54:22 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:54:22 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:54:22 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7911a35a19e3004ba397ba639249a71718b0028841c46b2bc31928d237b76e4737c7fe745ec850eb3c2bb3f0b86ecc533aa078849eb5405cf0b59bae96ca0c1a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e9b5301aea56fd7cf82369ff2fe1184c436fa7a910785b7112ff301d732d30df5753a64229ac881bffdad040bb721c976d4e4d445b0d42fc8ab3f682ed9bfcea", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/699a70770c0af5086b444a5a060b13ae5ddcc8c4c0000d25ffb7c0312d8e375493d1783097a58b31273b0bad50ef6655b652e7657e5cca1deecf6a264797e807"} 15:54:22 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:54:22 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:54:22 INFO - Contents: 15:54:22 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7911a35a19e3004ba397ba639249a71718b0028841c46b2bc31928d237b76e4737c7fe745ec850eb3c2bb3f0b86ecc533aa078849eb5405cf0b59bae96ca0c1a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e9b5301aea56fd7cf82369ff2fe1184c436fa7a910785b7112ff301d732d30df5753a64229ac881bffdad040bb721c976d4e4d445b0d42fc8ab3f682ed9bfcea", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/699a70770c0af5086b444a5a060b13ae5ddcc8c4c0000d25ffb7c0312d8e375493d1783097a58b31273b0bad50ef6655b652e7657e5cca1deecf6a264797e807"} 15:54:22 INFO - Running post-run listener: copy_logs_to_upload_dir 15:54:22 INFO - Copying logs to upload dir... 15:54:22 INFO - mkdir: /builds/slave/test/build/upload/logs 15:54:22 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1270.120473 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-10-24 15:54:22.873088) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-24 15:54:22.881048) ========= 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.AC1Yxppj7c/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.i7iQcC0tnP/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/Mozilla-Aurora/sha512/7911a35a19e3004ba397ba639249a71718b0028841c46b2bc31928d237b76e4737c7fe745ec850eb3c2bb3f0b86ecc533aa078849eb5405cf0b59bae96ca0c1a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e9b5301aea56fd7cf82369ff2fe1184c436fa7a910785b7112ff301d732d30df5753a64229ac881bffdad040bb721c976d4e4d445b0d42fc8ab3f682ed9bfcea", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/699a70770c0af5086b444a5a060b13ae5ddcc8c4c0000d25ffb7c0312d8e375493d1783097a58b31273b0bad50ef6655b652e7657e5cca1deecf6a264797e807"} build_url:https://queue.taskcluster.net/v1/task/b0sObbcPRMK77bslfnNe9Q/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010826 build_url: 'https://queue.taskcluster.net/v1/task/b0sObbcPRMK77bslfnNe9Q/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7911a35a19e3004ba397ba639249a71718b0028841c46b2bc31928d237b76e4737c7fe745ec850eb3c2bb3f0b86ecc533aa078849eb5405cf0b59bae96ca0c1a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e9b5301aea56fd7cf82369ff2fe1184c436fa7a910785b7112ff301d732d30df5753a64229ac881bffdad040bb721c976d4e4d445b0d42fc8ab3f682ed9bfcea", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/699a70770c0af5086b444a5a060b13ae5ddcc8c4c0000d25ffb7c0312d8e375493d1783097a58b31273b0bad50ef6655b652e7657e5cca1deecf6a264797e807"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-24 15:54:22.915749) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 15:54:22.916085) ========= 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.AC1Yxppj7c/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.i7iQcC0tnP/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.005227 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 15:54:22.964398) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-24 15:54:22.967771) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-24 15:54:22.968120) ========= ========= Total master_lag: 0.19 =========