builder: autoland_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0167 starttime: 1474951176.74 results: success (0) buildid: 20160926193551 builduid: 14c3493286ca4e5382bc1df52caad847 revision: 7b050ca8ec6474c6d7131d0ebd352e8624992016 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-26 21:39:36.736318) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-26 21:39:36.736726) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-26 21:39:36.737014) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-26 21:39:36.768308) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 21:39:36.768583) ========= 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.wi2IelogNx/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.AJEeYJeFLZ/Listeners TMPDIR=/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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-09-26 21:39:36-- 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: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 9.11M=0.001s 2016-09-26 21:39:36 (9.11 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.104670 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 21:39:36.896221) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 21:39:36.896545) ========= 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.wi2IelogNx/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.AJEeYJeFLZ/Listeners TMPDIR=/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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.030434 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 21:39:36.948320) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-09-26 21:39:36.948671) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 7b050ca8ec6474c6d7131d0ebd352e8624992016 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev 7b050ca8ec6474c6d7131d0ebd352e8624992016 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.wi2IelogNx/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.AJEeYJeFLZ/Listeners TMPDIR=/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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-09-26 21:39:36,988 truncating revision to first 12 chars 2016-09-26 21:39:36,988 Setting DEBUG logging. 2016-09-26 21:39:36,988 attempt 1/10 2016-09-26 21:39:36,988 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/7b050ca8ec64?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-26 21:39:38,933 unpacking tar archive at: autoland-7b050ca8ec64/testing/mozharness/ program finished with exit code 0 elapsedTime=2.224883 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-09-26 21:39:39.195919) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-26 21:39:39.196228) ========= script_repo_revision: 7b050ca8ec6474c6d7131d0ebd352e8624992016 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-26 21:39:39.196653) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-26 21:39:39.196947) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-26 21:39:39.216146) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2016-09-26 21:39:39.216416) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.wi2IelogNx/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.AJEeYJeFLZ/Listeners TMPDIR=/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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 21:39:39 INFO - MultiFileLogger online at 20160926 21:39:39 in /builds/slave/test 21:39:39 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 21:39:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:39:39 INFO - {'append_to_log': False, 21:39:39 INFO - 'base_work_dir': '/builds/slave/test', 21:39:39 INFO - 'blob_upload_branch': 'Autoland', 21:39:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:39:39 INFO - 'branch': 'Autoland', 21:39:39 INFO - 'buildbot_json_path': 'buildprops.json', 21:39:39 INFO - 'config_files': ('talos/mac_config.py',), 21:39:39 INFO - 'default_actions': ('clobber', 21:39:39 INFO - 'read-buildbot-config', 21:39:39 INFO - 'download-and-extract', 21:39:39 INFO - 'populate-webroot', 21:39:39 INFO - 'create-virtualenv', 21:39:39 INFO - 'install', 21:39:39 INFO - 'run-tests'), 21:39:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:39:39 INFO - 'download_minidump_stackwalk': True, 21:39:39 INFO - 'download_symbols': 'ondemand', 21:39:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:39:39 INFO - 'tooltool.py': '/tools/tooltool.py', 21:39:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:39:39 INFO - '/tools/misc-python/virtualenv.py')}, 21:39:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:39:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:39:39 INFO - 'installer_path': 'installer.exe', 21:39:39 INFO - 'log_level': 'info', 21:39:39 INFO - 'log_name': 'talos', 21:39:39 INFO - 'log_to_console': True, 21:39:39 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 21:39:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 21:39:39 INFO - 'opt_config_files': (), 21:39:39 INFO - 'pip_index': False, 21:39:39 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:39:39 INFO - 'cmd': ('bash', 21:39:39 INFO - '-c', 21:39:39 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:39:39 INFO - 'enabled': True, 21:39:39 INFO - 'halt_on_failure': False, 21:39:39 INFO - 'name': 'check_screen_resolution'},), 21:39:39 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:39:39 INFO - 'cmd': ('bash', 21:39:39 INFO - '-c', 21:39:39 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:39:39 INFO - 'enabled': True, 21:39:39 INFO - 'halt_on_failure': False, 21:39:39 INFO - 'name': 'check_screen_resolution'},), 21:39:39 INFO - 'run_cmd_checks_enabled': True, 21:39:39 INFO - 'sps_profile': False, 21:39:39 INFO - 'sps_profile_interval': 0, 21:39:39 INFO - 'suite': 'dromaeojs', 21:39:39 INFO - 'system_bits': '32', 21:39:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:39:39 INFO - 'title': 't-yosemite-r7-0167', 21:39:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:39:39 INFO - 'use_talos_json': True, 21:39:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:39:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:39:39 INFO - 'work_dir': 'build'} 21:39:39 INFO - [mozharness: 2016-09-27 04:39:39.386150Z] Running clobber step. 21:39:39 INFO - Running pre-action listener: _resource_record_pre_action 21:39:39 INFO - Running main action method: clobber 21:39:39 INFO - rmtree: /builds/slave/test/build 21:39:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:39:41 INFO - Running post-action listener: _resource_record_post_action 21:39:41 INFO - [mozharness: 2016-09-27 04:39:41.487914Z] Finished clobber step (success) 21:39:41 INFO - [mozharness: 2016-09-27 04:39:41.488036Z] Running read-buildbot-config step. 21:39:41 INFO - Running pre-action listener: _resource_record_pre_action 21:39:41 INFO - Running main action method: read_buildbot_config 21:39:41 INFO - Using buildbot properties: 21:39:41 INFO - { 21:39:41 INFO - "project": "", 21:39:41 INFO - "product": "firefox", 21:39:41 INFO - "script_repo_revision": "production", 21:39:41 INFO - "builddir": "autoland_yosemite_r7_test-dromaeojs", 21:39:41 INFO - "repository": "", 21:39:41 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 autoland talos dromaeojs", 21:39:41 INFO - "buildid": "20160926193551", 21:39:41 INFO - "pgo_build": "False", 21:39:41 INFO - "basedir": "/builds/slave/test", 21:39:41 INFO - "buildnumber": 292, 21:39:41 INFO - "slavename": "t-yosemite-r7-0167", 21:39:41 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 21:39:41 INFO - "platform": "yosemite_r7", 21:39:41 INFO - "scheduler": "tests-autoland-macosx64-talos", 21:39:41 INFO - "branch": "autoland", 21:39:41 INFO - "repo_path": "integration/autoland", 21:39:41 INFO - "revision": "7b050ca8ec6474c6d7131d0ebd352e8624992016", 21:39:41 INFO - "stage_platform": "macosx64", 21:39:41 INFO - "builduid": "14c3493286ca4e5382bc1df52caad847", 21:39:41 INFO - "slavebuilddir": "test" 21:39:41 INFO - } 21:39:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/BtEWKrpvS8y0dzET7xAYsQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 21:39:41 INFO - Running post-action listener: _resource_record_post_action 21:39:41 INFO - [mozharness: 2016-09-27 04:39:41.491432Z] Finished read-buildbot-config step (success) 21:39:41 INFO - [mozharness: 2016-09-27 04:39:41.491558Z] Running download-and-extract step. 21:39:41 INFO - Running pre-action listener: _resource_record_pre_action 21:39:41 INFO - Running main action method: download_and_extract 21:39:41 INFO - mkdir: /builds/slave/test/build/tests 21:39:41 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')]} 21:39:41 INFO - trying https://queue.taskcluster.net/v1/task/BtEWKrpvS8y0dzET7xAYsQ/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 21:39:41 INFO - Downloading https://queue.taskcluster.net/v1/task/BtEWKrpvS8y0dzET7xAYsQ/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 21:39:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BtEWKrpvS8y0dzET7xAYsQ/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json'}, attempt #1 21:39:42 INFO - Downloaded 1199 bytes. 21:39:42 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 21:39:42 INFO - Using the following test package requirements: 21:39:42 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 21:39:42 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 21:39:42 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 21:39:42 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 21:39:42 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 21:39:42 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 21:39:42 INFO - u'jsshell-mac.zip'], 21:39:42 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 21:39:42 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 21:39:42 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 21:39:42 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 21:39:42 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 21:39:42 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 21:39:42 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 21:39:42 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 21:39:42 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 21:39:42 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 21:39:42 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 21:39:42 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 21:39:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BtEWKrpvS8y0dzET7xAYsQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 21:39:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BtEWKrpvS8y0dzET7xAYsQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 21:39:42 INFO - Fetch https://queue.taskcluster.net/v1/task/BtEWKrpvS8y0dzET7xAYsQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 21:39:43 INFO - Expected file size: 16468908 21:39:50 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip', u'firefox-52.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 21:39:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BtEWKrpvS8y0dzET7xAYsQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 21:39:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BtEWKrpvS8y0dzET7xAYsQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 21:39:50 INFO - Fetch https://queue.taskcluster.net/v1/task/BtEWKrpvS8y0dzET7xAYsQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 21:39:51 INFO - Expected file size: 16468908 21:39:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BtEWKrpvS8y0dzET7xAYsQ/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 21:39:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BtEWKrpvS8y0dzET7xAYsQ/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 21:39:57 INFO - Fetch https://queue.taskcluster.net/v1/task/BtEWKrpvS8y0dzET7xAYsQ/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 21:39:58 INFO - Expected file size: 14414057 21:39:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:39:59 INFO - trying https://queue.taskcluster.net/v1/task/BtEWKrpvS8y0dzET7xAYsQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 21:39:59 INFO - Downloading https://queue.taskcluster.net/v1/task/BtEWKrpvS8y0dzET7xAYsQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 21:39:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BtEWKrpvS8y0dzET7xAYsQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg'}, attempt #1 21:40:02 INFO - Downloaded 111600261 bytes. 21:40:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BtEWKrpvS8y0dzET7xAYsQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 21:40:02 INFO - mkdir: /builds/slave/test/properties 21:40:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:40:02 INFO - Writing to file /builds/slave/test/properties/build_url 21:40:02 INFO - Contents: 21:40:02 INFO - build_url:https://queue.taskcluster.net/v1/task/BtEWKrpvS8y0dzET7xAYsQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 21:40:02 INFO - Running post-action listener: _resource_record_post_action 21:40:02 INFO - Running post-action listener: set_extra_try_arguments 21:40:02 INFO - [mozharness: 2016-09-27 04:40:02.971981Z] Finished download-and-extract step (success) 21:40:02 INFO - [mozharness: 2016-09-27 04:40:02.972148Z] Running populate-webroot step. 21:40:02 INFO - Running pre-action listener: _resource_record_pre_action 21:40:02 INFO - Running main action method: populate_webroot 21:40:02 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:40:02 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:40:02 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:40:02 INFO - '--tppagecycles', 21:40:02 INFO - '7'], 21:40:02 INFO - 'tests': ['tsvgm']}}, 21:40:02 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:40:02 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:40:02 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:40:02 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:40:02 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:40:02 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:40:02 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:40:02 INFO - 'talos_options': ['--disable-e10s'], 21:40:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:40:02 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:40:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:40:02 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:40:02 INFO - 'talos_options': ['--disable-e10s'], 21:40:02 INFO - 'tests': ['damp', 'tps']}, 21:40:02 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:40:02 INFO - 'tests': ['damp', 'tps']}, 21:40:02 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:40:02 INFO - 'tests': ['dromaeo_dom']}, 21:40:02 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:40:02 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:40:02 INFO - 'tests': ['basic_compositor_video']}, 21:40:02 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 21:40:02 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:40:02 INFO - 'tests': ['a11yr', 21:40:02 INFO - 'ts_paint', 21:40:02 INFO - 'tpaint', 21:40:02 INFO - 'sessionrestore', 21:40:02 INFO - 'sessionrestore_no_auto_restore', 21:40:02 INFO - 'tabpaint']}, 21:40:02 INFO - 'other-e10s': {'tests': ['a11yr', 21:40:02 INFO - 'ts_paint', 21:40:02 INFO - 'tpaint', 21:40:02 INFO - 'sessionrestore', 21:40:02 INFO - 'sessionrestore_no_auto_restore', 21:40:02 INFO - 'tabpaint']}, 21:40:02 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:40:02 INFO - 'ts_paint', 21:40:02 INFO - 'tpaint', 21:40:02 INFO - 'sessionrestore', 21:40:02 INFO - 'sessionrestore_no_auto_restore', 21:40:02 INFO - 'tabpaint']}, 21:40:02 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:40:02 INFO - 'ts_paint', 21:40:02 INFO - 'tpaint', 21:40:02 INFO - 'sessionrestore', 21:40:02 INFO - 'sessionrestore_no_auto_restore', 21:40:02 INFO - 'tabpaint']}, 21:40:02 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:40:02 INFO - 'tests': ['a11yr', 21:40:02 INFO - 'ts_paint', 21:40:02 INFO - 'tpaint', 21:40:02 INFO - 'sessionrestore', 21:40:02 INFO - 'sessionrestore_no_auto_restore', 21:40:02 INFO - 'tabpaint']}, 21:40:02 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:40:02 INFO - 'tests': ['a11yr', 21:40:02 INFO - 'ts_paint', 21:40:02 INFO - 'tpaint', 21:40:02 INFO - 'sessionrestore', 21:40:02 INFO - 'sessionrestore_no_auto_restore', 21:40:02 INFO - 'tabpaint']}, 21:40:02 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:40:02 INFO - 'tests': ['tsvgx', 21:40:02 INFO - 'tsvgr_opacity', 21:40:02 INFO - 'tart', 21:40:02 INFO - 'tscrollx', 21:40:02 INFO - 'cart']}, 21:40:02 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:40:02 INFO - 'tsvgr_opacity', 21:40:02 INFO - 'tart', 21:40:02 INFO - 'tscrollx', 21:40:02 INFO - 'cart']}, 21:40:02 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:40:02 INFO - 'talos_options': ['--disable-e10s'], 21:40:02 INFO - 'tests': ['tp5o']}, 21:40:02 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:40:02 INFO - 'tests': ['tp5o']}, 21:40:02 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:40:02 INFO - 'talos_options': ['--disable-e10s', 21:40:02 INFO - '--xperf_path', 21:40:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:40:02 INFO - 'tests': ['tp5n']}, 21:40:02 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:40:02 INFO - 'talos_options': ['--xperf_path', 21:40:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:40:02 INFO - 'tests': ['tp5n']}}, 21:40:02 INFO - 'talos.zip': {'path': '', 21:40:02 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:40:02 INFO - Running post-action listener: _resource_record_post_action 21:40:02 INFO - [mozharness: 2016-09-27 04:40:02.990862Z] Finished populate-webroot step (success) 21:40:02 INFO - [mozharness: 2016-09-27 04:40:02.990994Z] Running create-virtualenv step. 21:40:02 INFO - Running pre-action listener: _resource_record_pre_action 21:40:02 INFO - Running main action method: create_virtualenv 21:40:02 INFO - Creating virtualenv /builds/slave/test/build/venv 21:40:02 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 21:40:02 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:40:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:40:03 INFO - Using real prefix '/tools/python27' 21:40:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:40:03 INFO - Installing distribute.............................................................................................................................................................................................done. 21:40:06 INFO - Installing pip.................done. 21:40:06 INFO - Return code: 0 21:40:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 21:40:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 21:40:06 INFO - Reading from file tmpfile_stdout 21:40:06 INFO - Output received: 21:40:06 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 21:40:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:40: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')]} 21:40:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:40:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:40: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')]} 21:40:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:40:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:40:06 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 0x106f22490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e98570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea995bf7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d36d30>, '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 0x106b5cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106d2eb20>, '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.wi2IelogNx/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.AJEeYJeFLZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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 21:40:06 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 21:40:06 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 21:40:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wi2IelogNx/Render', 21:40:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:40:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:40:06 INFO - 'HOME': '/Users/cltbld', 21:40:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:40:06 INFO - 'LOGNAME': 'cltbld', 21:40:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:40:06 INFO - 'MOZ_NO_REMOTE': '1', 21:40:06 INFO - 'NO_EM_RESTART': '1', 21:40:06 INFO - 'PAGER': '/bin/cat', 21:40:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:40:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:40:06 INFO - 'PWD': '/builds/slave/test', 21:40:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:40:06 INFO - 'SHELL': '/bin/bash', 21:40:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AJEeYJeFLZ/Listeners', 21:40:06 INFO - 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/', 21:40:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:40:06 INFO - 'USER': 'cltbld', 21:40:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:40:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:40:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:40:06 INFO - 'XPC_FLAGS': '0x0', 21:40:06 INFO - 'XPC_SERVICE_NAME': '0', 21:40:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:40:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:40:07 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 21:40:07 INFO - Cleaning up... 21:40:07 INFO - Return code: 0 21:40:07 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:40: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')]} 21:40:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:40:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:40: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')]} 21:40:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:40:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:40: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', '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 0x106f22490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e98570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea995bf7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d36d30>, '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 0x106b5cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106d2eb20>, '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.wi2IelogNx/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.AJEeYJeFLZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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 21:40: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', 'psutil>=3.1.1'] in /builds/slave/test/build 21:40: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 psutil>=3.1.1 21:40:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wi2IelogNx/Render', 21:40:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:40:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:40:07 INFO - 'HOME': '/Users/cltbld', 21:40:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:40:07 INFO - 'LOGNAME': 'cltbld', 21:40:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:40:07 INFO - 'MOZ_NO_REMOTE': '1', 21:40:07 INFO - 'NO_EM_RESTART': '1', 21:40:07 INFO - 'PAGER': '/bin/cat', 21:40:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:40:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:40:07 INFO - 'PWD': '/builds/slave/test', 21:40:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:40:07 INFO - 'SHELL': '/bin/bash', 21:40:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AJEeYJeFLZ/Listeners', 21:40:07 INFO - 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/', 21:40:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:40:07 INFO - 'USER': 'cltbld', 21:40:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:40:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:40:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:40:07 INFO - 'XPC_FLAGS': '0x0', 21:40:07 INFO - 'XPC_SERVICE_NAME': '0', 21:40:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:40:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:40:07 INFO - Downloading/unpacking psutil>=3.1.1 21:40:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:40:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:40:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:40:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:40:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:40:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:40:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:40:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:40:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:40:10 INFO - Installing collected packages: psutil 21:40:10 INFO - Running setup.py install for psutil 21:40:10 INFO - building 'psutil._psutil_osx' extension 21:40:10 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 21:40:11 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 21:40:11 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 21:40:11 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 21:40:11 INFO - building 'psutil._psutil_posix' extension 21:40:11 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 21:40:11 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 21:40:11 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 21:40:11 INFO - ^ 21:40:11 INFO - 1 warning generated. 21:40:11 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 21:40:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:40:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:40:11 INFO - Successfully installed psutil 21:40:11 INFO - Cleaning up... 21:40:12 INFO - Return code: 0 21:40:12 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:40:12 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')]} 21:40:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:40:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:40:12 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')]} 21:40:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:40:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:40:12 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 0x106f22490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e98570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea995bf7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d36d30>, '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 0x106b5cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106d2eb20>, '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.wi2IelogNx/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.AJEeYJeFLZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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 21:40:12 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 21:40:12 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 21:40:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wi2IelogNx/Render', 21:40:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:40:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:40:12 INFO - 'HOME': '/Users/cltbld', 21:40:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:40:12 INFO - 'LOGNAME': 'cltbld', 21:40:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:40:12 INFO - 'MOZ_NO_REMOTE': '1', 21:40:12 INFO - 'NO_EM_RESTART': '1', 21:40:12 INFO - 'PAGER': '/bin/cat', 21:40:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:40:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:40:12 INFO - 'PWD': '/builds/slave/test', 21:40:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:40:12 INFO - 'SHELL': '/bin/bash', 21:40:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AJEeYJeFLZ/Listeners', 21:40:12 INFO - 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/', 21:40:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:40:12 INFO - 'USER': 'cltbld', 21:40:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:40:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:40:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:40:12 INFO - 'XPC_FLAGS': '0x0', 21:40:12 INFO - 'XPC_SERVICE_NAME': '0', 21:40:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:40:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:40:12 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:40:12 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 21:40:12 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 21:40:12 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 21:40:12 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 21:40:12 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 21:40:12 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 21:40:14 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:40:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:40:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:40:14 INFO - Installing collected packages: mozsystemmonitor 21:40:14 INFO - Running setup.py install for mozsystemmonitor 21:40:15 INFO - Successfully installed mozsystemmonitor 21:40:15 INFO - Cleaning up... 21:40:15 INFO - Return code: 0 21:40:15 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:40: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')]} 21:40:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:40:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:40: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')]} 21:40:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:40:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:40:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x106f22490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e98570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea995bf7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d36d30>, '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 0x106b5cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106d2eb20>, '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.wi2IelogNx/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.AJEeYJeFLZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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 21:40:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 21:40:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 21:40:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wi2IelogNx/Render', 21:40:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:40:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:40:15 INFO - 'HOME': '/Users/cltbld', 21:40:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:40:15 INFO - 'LOGNAME': 'cltbld', 21:40:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:40:15 INFO - 'MOZ_NO_REMOTE': '1', 21:40:15 INFO - 'NO_EM_RESTART': '1', 21:40:15 INFO - 'PAGER': '/bin/cat', 21:40:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:40:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:40:15 INFO - 'PWD': '/builds/slave/test', 21:40:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:40:15 INFO - 'SHELL': '/bin/bash', 21:40:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AJEeYJeFLZ/Listeners', 21:40:15 INFO - 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/', 21:40:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:40:15 INFO - 'USER': 'cltbld', 21:40:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:40:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:40:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:40:15 INFO - 'XPC_FLAGS': '0x0', 21:40:15 INFO - 'XPC_SERVICE_NAME': '0', 21:40:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:40:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:40:15 INFO - Downloading/unpacking jsonschema==2.5.1 21:40:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:40:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:40:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:40:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:40:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:40:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:40:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:40:17 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:40:17 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 21:40:17 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 21:40:17 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 21:40:17 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 21:40:17 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 21:40:17 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 21:40:18 INFO - Downloading functools32-3.2.3-2.tar.gz 21:40:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:40:18 INFO - warning: no files found matching '*.txt' 21:40:18 INFO - no previously-included directories found matching 'build' 21:40:18 INFO - no previously-included directories found matching 'dist' 21:40:18 INFO - no previously-included directories found matching '.git*' 21:40:18 INFO - Installing collected packages: jsonschema, functools32 21:40:18 INFO - Running setup.py install for functools32 21:40:18 INFO - warning: no files found matching '*.txt' 21:40:18 INFO - no previously-included directories found matching 'build' 21:40:18 INFO - no previously-included directories found matching 'dist' 21:40:18 INFO - no previously-included directories found matching '.git*' 21:40:18 INFO - Successfully installed jsonschema functools32 21:40:18 INFO - Cleaning up... 21:40:18 INFO - Return code: 0 21:40:18 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:40:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:40:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:40:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:40:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:40:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:40:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:40:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x106f22490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e98570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea995bf7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d36d30>, '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 0x106b5cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106d2eb20>, '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.wi2IelogNx/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.AJEeYJeFLZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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 21:40:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 21:40:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 21:40:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wi2IelogNx/Render', 21:40:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:40:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:40:18 INFO - 'HOME': '/Users/cltbld', 21:40:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:40:18 INFO - 'LOGNAME': 'cltbld', 21:40:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:40:18 INFO - 'MOZ_NO_REMOTE': '1', 21:40:18 INFO - 'NO_EM_RESTART': '1', 21:40:18 INFO - 'PAGER': '/bin/cat', 21:40:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:40:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:40:18 INFO - 'PWD': '/builds/slave/test', 21:40:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:40:18 INFO - 'SHELL': '/bin/bash', 21:40:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AJEeYJeFLZ/Listeners', 21:40:18 INFO - 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/', 21:40:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:40:18 INFO - 'USER': 'cltbld', 21:40:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:40:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:40:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:40:18 INFO - 'XPC_FLAGS': '0x0', 21:40:18 INFO - 'XPC_SERVICE_NAME': '0', 21:40:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:40:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:40:18 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:40:18 INFO - Cleaning up... 21:40:18 INFO - Return code: 0 21:40:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:40:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:40:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:40:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:40:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:40:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:40:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:40:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x106f22490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e98570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea995bf7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d36d30>, '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 0x106b5cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106d2eb20>, '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.wi2IelogNx/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.AJEeYJeFLZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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 21:40:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 21:40:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 21:40:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wi2IelogNx/Render', 21:40:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:40:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:40:18 INFO - 'HOME': '/Users/cltbld', 21:40:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:40:18 INFO - 'LOGNAME': 'cltbld', 21:40:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:40:18 INFO - 'MOZ_NO_REMOTE': '1', 21:40:18 INFO - 'NO_EM_RESTART': '1', 21:40:18 INFO - 'PAGER': '/bin/cat', 21:40:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:40:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:40:18 INFO - 'PWD': '/builds/slave/test', 21:40:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:40:18 INFO - 'SHELL': '/bin/bash', 21:40:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AJEeYJeFLZ/Listeners', 21:40:18 INFO - 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/', 21:40:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:40:18 INFO - 'USER': 'cltbld', 21:40:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:40:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:40:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:40:18 INFO - 'XPC_FLAGS': '0x0', 21:40:18 INFO - 'XPC_SERVICE_NAME': '0', 21:40:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:40:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:40:19 INFO - Downloading/unpacking blobuploader==1.2.4 21:40:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:40:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:40:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:40:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:40:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:40:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:40:21 INFO - Downloading blobuploader-1.2.4.tar.gz 21:40:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:40:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:40:21 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 21:40:21 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 21:40:21 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 21:40:21 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 21:40:21 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 21:40:21 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 21:40:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:40:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:40:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:40:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:40:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:40:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:40:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:40:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:40:22 INFO - Downloading docopt-0.6.1.tar.gz 21:40:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:40:22 INFO - Installing collected packages: blobuploader, requests, docopt 21:40:22 INFO - Running setup.py install for blobuploader 21:40:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:40:23 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:40:23 INFO - Running setup.py install for requests 21:40:23 INFO - Running setup.py install for docopt 21:40:23 INFO - Successfully installed blobuploader requests docopt 21:40:23 INFO - Cleaning up... 21:40:23 INFO - Return code: 0 21:40:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:40:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:40:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:40:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:40:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:40:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:40:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:40:23 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 0x106f22490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e98570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea995bf7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d36d30>, '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 0x106b5cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106d2eb20>, '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.wi2IelogNx/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.AJEeYJeFLZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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 21:40:23 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 21:40:23 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 21:40:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wi2IelogNx/Render', 21:40:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:40:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:40:23 INFO - 'HOME': '/Users/cltbld', 21:40:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:40:23 INFO - 'LOGNAME': 'cltbld', 21:40:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:40:23 INFO - 'MOZ_NO_REMOTE': '1', 21:40:23 INFO - 'NO_EM_RESTART': '1', 21:40:23 INFO - 'PAGER': '/bin/cat', 21:40:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:40:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:40:23 INFO - 'PWD': '/builds/slave/test', 21:40:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:40:23 INFO - 'SHELL': '/bin/bash', 21:40:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AJEeYJeFLZ/Listeners', 21:40:23 INFO - 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/', 21:40:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:40:23 INFO - 'USER': 'cltbld', 21:40:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:40:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:40:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:40:23 INFO - 'XPC_FLAGS': '0x0', 21:40:23 INFO - 'XPC_SERVICE_NAME': '0', 21:40:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:40:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:40:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:40:24 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-tb29If-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:40:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:40:24 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-QdrJqP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:40:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:40:24 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-biyNHn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:40:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:40:24 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-zFGYFg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:40:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:40:24 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-wIO_hz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:40:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:40:24 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-AeqP8U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:40:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:40:24 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-jTTTfb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:40:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:40:24 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-ZsnecS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:40:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:40:24 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-VUq3AU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:40:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:40:25 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-X7Rhbv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:40:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:40:25 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-FEdeiL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:40:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:40:25 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-eF3Y02-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:40:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:40:25 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-0QX6pm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:40:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:40:25 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-9Pb91U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:40:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:40:25 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-_Wqmgk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:40:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:40:25 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-kfSd1a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:40:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:40:25 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-1M27UM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:40:25 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:40:25 INFO - Running setup.py install for manifestparser 21:40:25 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:40:25 INFO - Running setup.py install for mozcrash 21:40:26 INFO - Running setup.py install for mozdebug 21:40:26 INFO - Running setup.py install for mozdevice 21:40:26 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:40:26 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:40:26 INFO - Running setup.py install for mozfile 21:40:26 INFO - Running setup.py install for mozhttpd 21:40:26 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:40:26 INFO - Running setup.py install for mozinfo 21:40:26 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:40:26 INFO - Running setup.py install for mozInstall 21:40:26 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:40:26 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:40:26 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:40:26 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:40:26 INFO - Running setup.py install for mozleak 21:40:27 INFO - Running setup.py install for mozlog 21:40:27 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:40:27 INFO - Running setup.py install for moznetwork 21:40:27 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:40:27 INFO - Running setup.py install for mozprocess 21:40:27 INFO - Running setup.py install for mozprofile 21:40:27 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:40:27 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:40:27 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:40:27 INFO - Running setup.py install for mozrunner 21:40:27 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:40:27 INFO - Running setup.py install for mozscreenshot 21:40:28 INFO - Running setup.py install for moztest 21:40:28 INFO - Running setup.py install for mozversion 21:40:28 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:40:28 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:40:28 INFO - Cleaning up... 21:40:28 INFO - Return code: 0 21:40:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:40:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:40:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:40:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:40:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:40:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:40:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:40:28 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 0x106f22490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e98570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea995bf7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d36d30>, '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 0x106b5cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106d2eb20>, '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.wi2IelogNx/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.AJEeYJeFLZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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 21:40:28 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 21:40:28 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 21:40:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wi2IelogNx/Render', 21:40:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:40:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:40:28 INFO - 'HOME': '/Users/cltbld', 21:40:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:40:28 INFO - 'LOGNAME': 'cltbld', 21:40:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:40:28 INFO - 'MOZ_NO_REMOTE': '1', 21:40:28 INFO - 'NO_EM_RESTART': '1', 21:40:28 INFO - 'PAGER': '/bin/cat', 21:40:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:40:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:40:28 INFO - 'PWD': '/builds/slave/test', 21:40:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:40:28 INFO - 'SHELL': '/bin/bash', 21:40:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AJEeYJeFLZ/Listeners', 21:40:28 INFO - 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/', 21:40:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:40:28 INFO - 'USER': 'cltbld', 21:40:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:40:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:40:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:40:28 INFO - 'XPC_FLAGS': '0x0', 21:40:28 INFO - 'XPC_SERVICE_NAME': '0', 21:40:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:40:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:40:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:40:28 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-NfO3Qu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:40:28 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)) 21:40:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:40:28 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-VitTAB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:40:28 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)) 21:40:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:40:28 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-NB2SWo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:40:28 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)) 21:40:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:40:28 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-R9aHNp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:40:29 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)) 21:40:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:40:29 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-hf_ndk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:40:29 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)) 21:40:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:40:29 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-lsV96a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:40:29 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)) 21:40:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:40:29 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-KGPlxe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:40:29 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)) 21:40:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:40:29 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-NKLd86-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:40:29 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)) 21:40:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:40:29 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-OgbNXx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:40:29 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)) 21:40:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:40:29 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-RpxkSe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:40:29 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)) 21:40:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:40:29 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-wHNYHV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:40:29 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)) 21:40:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:40:29 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-MFRq6y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:40:29 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)) 21:40:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:40:29 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-nu4Baz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:40:30 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)) 21:40:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:40:30 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-1Gh_I4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:40:30 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)) 21:40:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:40:30 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-wt2foy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:40:30 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)) 21:40:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:40:30 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-En1Alx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:40:30 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)) 21:40:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:40:30 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-luOxx1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:40:30 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)) 21:40:30 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)) 21:40:30 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)) 21:40:30 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)) 21:40:30 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)) 21:40:30 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)) 21:40:30 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:40:30 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 21:40:30 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 21:40:30 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 21:40:30 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 21:40:30 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 21:40:30 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 21:40:33 INFO - Downloading blessings-1.6.tar.gz 21:40:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:40:33 INFO - Installing collected packages: blessings 21:40:33 INFO - Running setup.py install for blessings 21:40:33 INFO - Successfully installed blessings 21:40:33 INFO - Cleaning up... 21:40:33 INFO - Return code: 0 21:40:33 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:40:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:40:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:40:33 INFO - Reading from file tmpfile_stdout 21:40:33 INFO - Current package versions: 21:40:33 INFO - blessings == 1.6 21:40:33 INFO - blobuploader == 1.2.4 21:40:33 INFO - docopt == 0.6.1 21:40:33 INFO - functools32 == 3.2.3-2 21:40:33 INFO - jsonschema == 2.5.1 21:40:33 INFO - manifestparser == 1.1 21:40:33 INFO - mozInstall == 1.12 21:40:33 INFO - mozcrash == 0.17 21:40:33 INFO - mozdebug == 0.1 21:40:33 INFO - mozdevice == 0.48 21:40:33 INFO - mozfile == 1.2 21:40:33 INFO - mozhttpd == 0.7 21:40:33 INFO - mozinfo == 0.9 21:40:33 INFO - mozleak == 0.1 21:40:33 INFO - mozlog == 3.4 21:40:33 INFO - moznetwork == 0.27 21:40:33 INFO - mozprocess == 0.23 21:40:33 INFO - mozprofile == 0.28 21:40:33 INFO - mozrunner == 6.12 21:40:33 INFO - mozscreenshot == 0.1 21:40:33 INFO - mozsystemmonitor == 0.3 21:40:33 INFO - moztest == 0.7 21:40:33 INFO - mozversion == 1.4 21:40:33 INFO - psutil == 3.1.1 21:40:33 INFO - requests == 1.2.3 21:40:33 INFO - wsgiref == 0.1.2 21:40:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:40:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:40:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:40:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:40:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:40:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:40:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:40:34 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 0x106f22490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e98570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea995bf7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d36d30>, '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 0x106b5cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106d2eb20>, '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.wi2IelogNx/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.AJEeYJeFLZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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 21:40:34 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 21:40:34 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 21:40:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wi2IelogNx/Render', 21:40:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:40:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:40:34 INFO - 'HOME': '/Users/cltbld', 21:40:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:40:34 INFO - 'LOGNAME': 'cltbld', 21:40:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:40:34 INFO - 'MOZ_NO_REMOTE': '1', 21:40:34 INFO - 'NO_EM_RESTART': '1', 21:40:34 INFO - 'PAGER': '/bin/cat', 21:40:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:40:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:40:34 INFO - 'PWD': '/builds/slave/test', 21:40:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:40:34 INFO - 'SHELL': '/bin/bash', 21:40:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AJEeYJeFLZ/Listeners', 21:40:34 INFO - 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/', 21:40:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:40:34 INFO - 'USER': 'cltbld', 21:40:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:40:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:40:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:40:34 INFO - 'XPC_FLAGS': '0x0', 21:40:34 INFO - 'XPC_SERVICE_NAME': '0', 21:40:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:40:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:40:34 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)) 21:40:34 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)) 21:40:34 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)) 21:40:34 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)) 21:40:34 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)) 21:40:34 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)) 21:40:34 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)) 21:40:34 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)) 21:40:34 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)) 21:40:34 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)) 21:40:34 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)) 21:40:34 INFO - Cleaning up... 21:40:34 INFO - Return code: 0 21:40:34 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:40:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:40:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:40:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:40:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:40:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:40:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:40:34 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 0x106f22490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e98570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea995bf7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d36d30>, '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 0x106b5cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106d2eb20>, '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.wi2IelogNx/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.AJEeYJeFLZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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 21:40:34 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 21:40:34 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 21:40:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wi2IelogNx/Render', 21:40:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:40:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:40:34 INFO - 'HOME': '/Users/cltbld', 21:40:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:40:34 INFO - 'LOGNAME': 'cltbld', 21:40:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:40:34 INFO - 'MOZ_NO_REMOTE': '1', 21:40:34 INFO - 'NO_EM_RESTART': '1', 21:40:34 INFO - 'PAGER': '/bin/cat', 21:40:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:40:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:40:34 INFO - 'PWD': '/builds/slave/test', 21:40:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:40:34 INFO - 'SHELL': '/bin/bash', 21:40:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AJEeYJeFLZ/Listeners', 21:40:34 INFO - 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/', 21:40:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:40:34 INFO - 'USER': 'cltbld', 21:40:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:40:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:40:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:40:34 INFO - 'XPC_FLAGS': '0x0', 21:40:34 INFO - 'XPC_SERVICE_NAME': '0', 21:40:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:40:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:40:34 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:40:34 INFO - Cleaning up... 21:40:34 INFO - Return code: 0 21:40:34 INFO - Running post-action listener: _resource_record_post_action 21:40:34 INFO - Running post-action listener: _start_resource_monitoring 21:40:34 INFO - Starting resource monitoring. 21:40:34 INFO - [mozharness: 2016-09-27 04:40:34.929506Z] Finished create-virtualenv step (success) 21:40:34 INFO - [mozharness: 2016-09-27 04:40:34.930474Z] Running install step. 21:40:34 INFO - Running pre-action listener: _resource_record_pre_action 21:40:34 INFO - Running main action method: install 21:40:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:40:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:40:35 INFO - Reading from file tmpfile_stdout 21:40:35 INFO - Detecting whether we're running mozinstall >=1.0... 21:40:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:40:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:40:35 INFO - Reading from file tmpfile_stdout 21:40:35 INFO - Output received: 21:40:35 INFO - Usage: mozinstall [options] installer 21:40:35 INFO - Options: 21:40:35 INFO - -h, --help show this help message and exit 21:40:35 INFO - -d DEST, --destination=DEST 21:40:35 INFO - Directory to install application into. [default: 21:40:35 INFO - "/builds/slave/test"] 21:40:35 INFO - --app=APP Application being installed. [default: firefox] 21:40:35 INFO - mkdir: /builds/slave/test/build/application 21:40:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 21:40:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 21:41:09 INFO - Reading from file tmpfile_stdout 21:41:09 INFO - Output received: 21:41:09 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 21:41:09 INFO - Running post-action listener: _resource_record_post_action 21:41:09 INFO - [mozharness: 2016-09-27 04:41:09.588311Z] Finished install step (success) 21:41:09 INFO - [mozharness: 2016-09-27 04:41:09.588453Z] Running run-tests step. 21:41:09 INFO - Running pre-action listener: _resource_record_pre_action 21:41:09 INFO - Running main action method: run_tests 21:41:09 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 21:41:09 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 21:41:09 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 21:41:09 INFO - 2016-09-26 21:41:09.602 screenresolution[1637:7506] starting screenresolution argv=screenresolution get 21:41:09 INFO - 2016-09-26 21:41:09.605 screenresolution[1637:7506] Display 0: 1600x1200x32@60 21:41:09 INFO - 2016-09-26 21:41:09.611 screenresolution[1638:7508] starting screenresolution argv=screenresolution list 21:41:09 INFO - Available Modes on Display 0 21:41:09 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 21:41:09 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 21:41:09 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 21:41:09 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 21:41:09 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 21:41:09 INFO - Intel Iris: 21:41:09 INFO - Chipset Model: Intel Iris 21:41:09 INFO - Type: GPU 21:41:09 INFO - Bus: Built-In 21:41:09 INFO - VRAM (Dynamic, Max): 1536 MB 21:41:09 INFO - Vendor: Intel (0x8086) 21:41:09 INFO - Device ID: 0x0a2e 21:41:09 INFO - Revision ID: 0x0009 21:41:09 INFO - Displays: 21:41:09 INFO - Display: 21:41:09 INFO - Resolution: 1600 x 1200 @ 60 Hz 21:41:09 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 21:41:09 INFO - Display Serial Number: 1600x1200 60 21:41:09 INFO - Main Display: Yes 21:41:09 INFO - Mirror: Off 21:41:09 INFO - Online: Yes 21:41:09 INFO - Rotation: Supported 21:41:09 INFO - Return code: 0 21:41:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:41:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:41:09 INFO - Python 2.7.3 21:41:09 INFO - Return code: 0 21:41:09 INFO - grabbing minidump binary from tooltool 21:41:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:41:09 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 0x106d36d30>, '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 0x106b5cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106d2eb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:41:09 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 21:41:09 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 21:41:09 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 21:41:09 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:41:09 INFO - Return code: 0 21:41:09 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 21:41:09 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:41:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:41:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 21:41:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:41:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BtEWKrpvS8y0dzET7xAYsQ/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0167', '--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 21:41:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/BtEWKrpvS8y0dzET7xAYsQ/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0167 --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 21:41:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wi2IelogNx/Render', 21:41:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:41:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:41:09 INFO - 'HOME': '/Users/cltbld', 21:41:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:41:09 INFO - 'LOGNAME': 'cltbld', 21:41:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:41:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 21:41:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:41:09 INFO - 'MOZ_NO_REMOTE': '1', 21:41:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:41:09 INFO - 'NO_EM_RESTART': '1', 21:41:09 INFO - 'PAGER': '/bin/cat', 21:41:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:41:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:41:09 INFO - 'PWD': '/builds/slave/test', 21:41:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:41:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:41:09 INFO - 'SHELL': '/bin/bash', 21:41:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AJEeYJeFLZ/Listeners', 21:41:09 INFO - 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/', 21:41:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:41:09 INFO - 'USER': 'cltbld', 21:41:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:41:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:41:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:41:09 INFO - 'XPC_FLAGS': '0x0', 21:41:09 INFO - 'XPC_SERVICE_NAME': '0', 21:41:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:41:09 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BtEWKrpvS8y0dzET7xAYsQ/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0167', '--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 21:41:10 INFO - mozversion application_buildid: 20160926193551 21:41:10 INFO - mozversion application_changeset: 7b050ca8ec6474c6d7131d0ebd352e8624992016 21:41:10 INFO - mozversion application_display_name: Nightly 21:41:10 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:41:10 INFO - mozversion application_name: Firefox 21:41:10 INFO - mozversion application_remotingname: firefox 21:41:10 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 21:41:10 INFO - mozversion application_vendor: Mozilla 21:41:10 INFO - mozversion application_version: 52.0a1 21:41:10 INFO - mozversion platform_buildid: 20160926193551 21:41:10 INFO - mozversion platform_changeset: 7b050ca8ec6474c6d7131d0ebd352e8624992016 21:41:10 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 21:41:10 INFO - mozversion platform_version: 52.0a1 21:41:10 INFO - using testdate: 1474951270 21:41:10 INFO - actual date: 1474951270 21:41:10 INFO - starting webserver on 'localhost:49276' 21:41:10 INFO - SUITE-START | Running 2 tests 21:41:10 INFO - TEST-START | dromaeo_css 21:41:10 INFO - operating with platform_type : mac_ 21:41:10 INFO - Initialising browser for dromaeo_css test... 21:41:10 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/tmpvl45a_/profile http://localhost:49276/getInfo.html) 21:41:12 INFO - PROCESS | 1648 | __metrics Screen width/height:1600/1200 21:41:12 INFO - PROCESS | 1648 | colorDepth:24 21:41:12 INFO - PROCESS | 1648 | Browser inner width/height: 1024/689 21:41:12 INFO - PROCESS | 1648 | __metrics 21:41:12 INFO - PROCESS | 1648 | 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" 21:41:12 INFO - PROCESS | 1648 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:41:13 INFO - TEST-INFO | 1648: exit 0 21:41:13 INFO - Browser initialized. 21:41:13 INFO - Running cycle 1/1 for dromaeo_css test... 21:41:13 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/tmpvl45a_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:41:25 INFO - PROCESS | 1653 | RSS: Main: 235995136 21:41:25 INFO - PROCESS | 1653 | 21:42:16 INFO - PROCESS | 1653 | 1474951336419 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] 21:44:28 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49276/tests/dromaeo/cssquery-ext.html) 21:44:30 INFO - PROCESS | 1653 | RSS: Main: 382660608 21:44:30 INFO - PROCESS | 1653 | 21:47:33 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-ext.html (next: http://localhost:49276/tests/dromaeo/cssquery-jquery.html) 21:47:33 INFO - PROCESS | 1653 | RSS: Main: 374996992 21:47:33 INFO - PROCESS | 1653 | 21:50:36 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49276/tests/dromaeo/cssquery-mootools.html) 21:50:36 INFO - PROCESS | 1653 | RSS: Main: 354287616 21:50:36 INFO - PROCESS | 1653 | 21:53:39 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49276/tests/dromaeo/cssquery-prototype.html) 21:53:39 INFO - PROCESS | 1653 | RSS: Main: 356954112 21:53:39 INFO - PROCESS | 1653 | 21:56:43 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49276/tests/dromaeo/cssquery-yui.html) 21:56:43 INFO - PROCESS | 1653 | RSS: Main: 337354752 21:56:43 INFO - PROCESS | 1653 | 21:59:47 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-yui.html (next: http://localhost:49276/tests/dromaeo/cssquery-dojo.html) 21:59:47 INFO - PROCESS | 1653 | RSS: Main: 383217664 21:59:47 INFO - PROCESS | 1653 | 21:59:47 INFO - PROCESS | 1653 | __start_tp_report 21:59:47 INFO - PROCESS | 1653 | _x_x_mozilla_page_load 21:59:47 INFO - PROCESS | 1653 | _x_x_mozilla_page_load_details 21:59:47 INFO - PROCESS | 1653 | |i|pagename|runs| 21:59:47 INFO - PROCESS | 1653 | |0;dojo.html;2760.268528839857;3320.8837690680825;3340.482225255085;3362.8654853805847;3377.847996840142;5543.223948647193;5645.689487078214;5655.943440565593;5705.115707065401;5712.42875712429;5608.6073974821775;5668.036433806253;5719.742611582478;5731.054376027961;5786.247787787582;5214.687118772867;5288.629795914288;5296.708681022542;5297.788088476456;5308.964751873386;5210.947890521104;5222.7649755760895;5265.473452654723;5272.657277276984;5296.973515132419;4905.730184839832;5177.974110129444;5324.41431442541;5374.381946076192;5384.7846086156505;4740.928886066695;5116.232565115225;5122.231665250205;5135.666181698215;5143.279940808253;5035.647504674675;5081.364829396325;5082.74586270685;5135.229715542661;5196.636235463519;5577.96807590593;5596.916046259309;5632.873425314912;5684.744186511617;5699.715014249271;6233.470155036827;6241.563090583661;6248.31268560458;6253.062040693932;6274.592151510183;6130.509559235251;6134.344744984521;6193.752249910043;6291;6291.622502649856;5704;5712.80005199816;5749.511291540266;5781.71091445426;5787.334456537552;6290.182276304051;6294.307626161119;6298.244210694746;6318.652474113968;6319.146915166486;5964.31410387811;6146.262448506208;6158.599691020069;6168.136460895478;6173.59871608344;6097.207363042776;6128.105930682418;6179.474744646665;6193.597416167935;6220.564560480723;6188.597741146811;6217.96891015542;6245.125682404467;6253.374662533801;6265.65538895356;6172.4136207060255;6240;6241.126242326078;6259.155014073133;6273.435390814758;4863.294822250754;4896.559309662076;4903.166461701519;4953.876153096129;4995.450500445021;4441.267190913463;4453.1761624099645;4459.620932220798;4478.798454069574;4489.7979590918485;5590.608657393944;5655.462731040545;5674.517665998354;5707.971460142673;5759.827205183851;6160.229971253593;6202.72087756052;6214.471769899519;6222.719977601018;6250.0937364082865;5680.829575112753;5686.516646085046;5693.373728889819;5696.11710184922;5723.656580605094;4280;5356.0894647909945;5360.437154098841;5360.946390536123;5368.489993450694;6251.187345645037;6264.9373506265265;6295.276043255084;6357.110004599453;6366.490680745436;6239.407256310643;6273.090401891609;6274.215723034621;6279.183706118175;6281.685915704105;6220.688965551795;6338.778142764981;6347.206599175103;6348.71430785625;6366.872662546631;6103.624523775107;6110.236220472441;6128.167033931239;6129.754809807558;6218.253809542884;5006.299118123538;5974.924513587423;6243.406876346739;6268.153799237045;6268.717907694256;6084.148219249397;6143.96928015357;6156.78451254204;6157.32269450369;6167;5905.734241959208;6003.969980150246;6015.819525414245;6020.789272375446;6068.4841788448475;5984.251968503937;6000.459958603747;6012.278526576839;6027.849303767441;6064.757409703739;6082.36135205797;6085.665288409003;6110.7250173741395;6133.44798968095;6133.938660613515;5776.884462310814;5855.531557475477;5873.50075243592;5900.321463031806;5964.5526585505395 21:59:47 INFO - PROCESS | 1653 | |1;ext.html;502.4222144533787;519.2082074835874;528.1206790693495;531.9946800531993;557.4481263549087;27118.86440567797;38603.03492412688;39954.2009159817;40053.799731001374;42031.949201269985;39956;40268;40312.193756124936;40318.798406008005;40420.19159616806;8705.042445331008;9635.421874687541;9806.11744942955;9822.312438129335;9823.705288841345;8754.956225218864;11717.765644687144;12032.398380081006;12040.397980101005;12293.569725059624;11933.16467847251;11990.880091199064;12003.63989080329;12026.51893924242;12027.939860300687;11898.524059037629;11953.191000114966;11976.940115299367;11977.820332695017;11991.460384282727;11828.23116497425;11901.523939042429;11908.821367679491;11910.940445297805;11926.642200733992;38395.808020959994;38616.613833861586;38625;38655.61344386576;38664.80667596672;3212.4699424594914;3280.311134661724;3287.1289108386295;3306.8677252909856;3390.593128824532;29212.26969325784;29604.259893502618;30975.845120774477;31015;31031.689683103104;3238.951415728766;3276.1154488288266;3337.0989832745267;3369.663033696611;3374.3926093303194;362613.1869340663;363666;367142;367662;369877.9999999973;32234.032979010666;33055.50416743751;53861;54124.188137177975;54188.91622167535;34389;34510.82744586261;34678.47982280268;34687.65312346895;34729.65270347315;14189.290535473185;14322.212278324792;14340.426382944564;14344.56966291013;14348.210848403229;11066.502007409686;11259.549618015351;12101.878981210075;12204.938975305067;12287;6880.2431732509385;7426.220246874001;7614.162442131361;7725.575093369806;7746.728864489716;3234.530993006001;3262.5269335946155;3267.281198136406;3275.9361602190465;3301.471764517714;756.6481586062507;844.9986765682686;948.9335746497817;954.3844220477753;1136.3352438823215;27399.45201095967;28758.281042974093;28764.417957012145;29060.7093929058;29489.705102949127;1048.2871647279924;1051.5268129341828;1058.528954615189;1076.8169411200115;1089.5260561655705;12381.814272785916;15308.464203752816;15354.692906141814;15445.378235285358;15641.13973731433;522955;528433;528626;530633;530868;53331.46668533343;54128.458715412344;54308;54337.45662543324;54492.182617260776;1232.445399570179;1252.1735654468007;1352.918824870511;1380.6134282400742;1404.5365029540023;24148.51702965966;25761.484770304865;30041;30092.548611770402;30774.230644234074;44943.55056449524;45486.772566136955;45588.31617525673;45599.31601025921;45652.8586785333;351277;355761;356315;356482.21758891037;356691;25517.489650207262;26295.474090518466;26296.73703262943;27133.321666957694;27171.320716982234;44363;45469;45863;45960.770196148806;46162.07675846397;30929.69070309268;35670.28659426849;35967.92096237117;38094.047648809;38497;28948.565771513866;36567.902962911154;37021.81489092537;37922.62077379191;38246.42630360491;36374.8181259092;37063.444048339836;37165.25669486649;37472.437913430775;37503.43744843775;30921;33334.83328083505;33415.16462088467;33424.66575334215;33528.832355838065;21679.783202167775;21948.451288717908;22083.327102990093;24730.010799567815;25078.874605626854 21:59:47 INFO - PROCESS | 1653 | |2;jquery.html;351.8873960332691;372.05312479739064;373.7888093227328;379.7455704677865;400.7455265906149;13424.597262082129;14894.404223831034;15755.448559300426;20157.395278141677;20799.68800467994;19396.127174277157;19901.900490497563;20287.898560507212;20491.282805101826;21038.263660771878;5039.697618142914;5896.643771932459;6090.756369745205;6128.571000029978;6159.384061593827;4657.394538709963;6049.788257410992;6110.877782444349;6127.540434467411;6138.539609529281;5041.395032596093;5739.081746920494;6033.366496517869;6055.515558755289;6062.878742425149;5928.555358348141;5971.581989260753;5977.850553736148;5980.491658209057;5985.311689155759;4963.131451995886;5175.353080864892;5211.661242019257;5222.477752224785;5244.29202057725;25888.352791180183;25904.22287331383;26004.699765011865;26231.868840655865;26484.47031059387;2185.3225500095023;2429.6962879640046;2440.9267721968367;2573.2537564106387;3088.413201491732;14235.928820355935;15135.318910649048;15952.840471595251;16072.678546429122;16304.021758694516;1905.7903630600622;1911.8852868827914;1919.1747548554117;1963.7643482782157;2031.3601215617034;111235;115449;115821;116131.25803112876;117072.8292717079;11272.380019099028;11435.14236432271;11489.942550287195;11502.169088982648;11731.589394371327;14402.495912643008;14417.78373324401;14419.78370324446;14448.205348705711;14450.421983120768;8334.62494187763;8467.068622451648;8502.14978502145;8522.10517895612;8653.365586453705;8383.706570270011;8466.661333546712;8617.439866408664;8621.870671939925;8676.34927380449;3793.260314238752;4424.336349547593;4512.300593408027;4533.954660453419;4596.287575425815;1868.9719654205198;1889.3387314439835;1912.1873203888292;1933.1590758020307;1937.2444746548858;853.347189400097;925.6066171876926;956.6651671914774;998.5456617239139;1009.9192064634958;16218.837811621734;17949.37177198818;20452;21251.78748212529;21389;772.6909236305411;893.9106089391139;924.2190349154953;965.7971825916636;995.4226548601794;10474.423906685206;11392.715182120348;11431.714207144887;11435.371054591911;11454.942725286486;465222;470698;474270;478495;479925;111001.88998109916;117059;117474.41262793631;121668.17497737541;124008;987.3532835992437;991.6975322526555;1030.7165529479303;1030.7835354575623;1032.3496197395593;19181.136848841557;19400.544959128405;19503.21987120556;19749.506262343555;19784.63661177632;40987.00677083905;54628;55759.44240557543;56370.15444768414;56568.30295091154;77864.2213577857;78783;78933;81090.18830525273;82074.76887846568;8001.759947201594;8219.835603287782;8274.338052955869;8299.95850020746;8471.279941205066;13161.670958226121;13249;13437.86562134366;13451.663708406977;13636.65908352299;11199.272047316897;11388.94305528467;11494.770104598028;11656.766864662828;11708.531658733555;11258.268212566158;11305.491252893475;11384.089272858317;11445.656630301104;11618.012468940235;8827.382083254111;9790.510474476105;10578.730552333769;11545.884541154817;11900.345480998629;6740.966295168493;6773.356531129535;8123.47197432165;8274.627641756257;8358.87461688063;10039.397636141855;11275.7744845101;11314.264572802742;11553.364564948672;11783.76432471363 21:59:47 INFO - PROCESS | 1653 | |3;mootools.html;1379.1449301433101;1540.3530517182778;1559.4853698279567;1772.8581713462925;1925.239530385497;7878.803029924247;8387.622556984936;8569.571521423928;8911.866322005159;8915.73252802417;8729.25801306888;8731.869021964676;8733.825323493526;8824.558772061388;8837.513936733478;2357.2456813819626;2380.833341666084;2382.5354055959097;2386.200622791367;2386.940326491843;2340.660604212388;2375.9643605345846;2388.737238903719;2389.2951579284068;2391.0555330644384;2336.6261398176293;2336.813054955608;2347.4835536182013;2376.120835290945;2385.8926348314367;2211.635080211763;2235.6646503024594;2240.708707867983;2249.201533455632;2256.0862850545554;2146.4955735402323;2187.453136715821;2327.359976006595;2342.7188737351457;2344.3553022918663;8639.179277968582;8821.897262842145;8834.686992377858;8850.955745221232;8859.468431894107;5105.387353517602;5327.121025030865;5330.333708286465;5344.893102137974;5353.946460535422;3416.145963509123;3601.0817241603486;3610.9277814443562;3670.1558641512333;3691.778493290411;1045.9215558833118;1074;1075.5267682219876;1098.0447011100314;1103.3214573037603;11420;11499.827502587468;11554.711132221677;11555.711107222303;11586.594469193538;4314.331278651814;4407.823687052482;4549.226631472658;4565.292379681155;4566.383538222364;9128.817423651622;9142.268618510503;9147.313951453534;9159.633614655339;9181.127792859668;5222.92165617516;5225.581953443715;5230.110881150137;5231.738413079331;5234.9476505235225;4356.825726970949;4368.825246990084;4530.728156310632;4552.795124219418;4889.046635906036;3648.4892115103908;3724.1248306647917;3744.7191460640015;3767.811609419518;3771;996.4071377530358;1127.1490025031212;1141.7944769941323;1142.3831131189065;1150.5972909481613;776.8601651702747;870.9433886797337;906.4153620914474;926.6941909169958;926.8795056642729;5518.530924871431;5575.69333686643;5583.69289689071;5796.652200867961;5975.25309336333;916.2120576304372;937.2408349237139;937.329809186435;939.3143005605946;948.4972964328916;3017.8641961111803;3600.261946301002;3673.118451571657;3850.306944749972;3967.940480892789;10046.497675116216;10304.227182961307;10502.579896804195;10772.676819695422;10790.838137427945;10583.153347732163;10594.523246453928;10594.57621695139;10602.204834637432;10625.787484250272;6704.195496540447;8124.675012999413;8135.552544609985;8140.389470789714;8145.307648849915;5573.8507743125;5874.823755287348;5995.760169593342;6057.242844644419;6057.57596968208;9526.66656667041;9894.20846332306;9989.60041598357;10002.399856008371;10029.598816047277;7579.583122928292;9291.581878815334;9468.857967130636;10108.54511546997;10208.693739187836;7019.298070193144;7267.273272672691;7267.963660181666;7280.854382912418;7285.599292038989;8121.593920304079;8369.204925532065;8419.36854735885;8445.113263107285;8568.828623427622;6323.810285691437;7452.329290363893;7474.476786624884;7549.131849837339;7556.471047026876;7311.780646580611;7390.150132734804;7411.110666720028;7473.290037446434;7476.663550140365;6949.965250173716;7079.327463890922;7081.787546373617;7082.433405327459;7094.893576596252;4834.3231947528075;4934.55588996992;4946.826861059845;5007.949920500749;5116.079105760999;4861.27080937848;4913.729744864067;5016.799328026838;5043;5098.643094983316 21:59:47 INFO - PROCESS | 1653 | |4;prototype.html;251.94961007798443;296.45600323406546;304.09683240774905;308.9227693076731;315.1805306203872;4531.478879928809;4548.636109111271;5501.449855014492;5510.311211098613;5539.224508568804;5083.4662360452085;5252.921206181911;5266.157414813631;5294.497022782839;5418.783248670058;3557.1107223194203;3941.8620348287814;4095.1809638072355;4109.321961876287;4127.060281667626;4101.4668093148;4124.443200167984;4124.957541609225;4139.234241665286;4150.028736350225;3831.712621553381;4045.110075783323;4072.572379900112;4093.3041382964966;4131.814068366915;4052.4529188559463;4079.938800917989;4087.121268927165;4115.362118871565;4117.197146556423;3034.317278612317;3113.066080175938;3344.916377090568;3434.5019972103905;3545.503629491873;3879.922401551953;4401.138603021686;4798.136335459616;4799.528242954881;5282.471752824726;3963.623455771697;4425.513193548707;4695.765211739399;4704.341392205094;4735.786889589976;5644.3508996465525;5645.943540564624;5743.712814359265;5760.913586296209;5761.423857614247;3707.2751527627174;3802.6387493188104;3880.3791393376923;3903.551091624443;3917.8442359504015;5467.239044282612;5476.123820188791;5578.3584887738025;5657.321121465409;5900.400755539118;3881.3595756700392;3887.2031233597045;3893.5327760668333;3906.43356713275;3908.55051669056;3110.9267302780504;3385.5260263563123;3874.380099184117;3947.348687466593;3949.447077409165;3564.429691249388;4188.308929026737;4491.843914920791;4633.745144017044;4666.136764698542;5335.466453354634;5656.236408084856;5703.914441283384;5719.369979555807;5757.625754325955;1071.737424331044;1213.7329787446747;1352.6280272925023;1374.9206872604957;1375.917444953306;716.8279612892868;864.1272314961808;866.9380009488452;873.3624454148508;874.4010352908278;3712.5844223314616;4265.232258193493;4497.00948869005;4631.467381251199;4690.545930761406;4513.81944722214;4708.340832283483;4746.976265118652;4931.605471562267;5073.594112470993;3807.5240594925635;4132.421460995463;4401.63275094553;4420.690551661352;4593.425821772278;2184.967225491619;2469.9749603914174;2599.3631560267477;2622.2133359991926;2641.4452964877205;5111.623095260722;5126.4617215191865;5131.435542090367;5137.563307118937;5147.349115205672;4280.058387154821;4508.368828364031;4985.750712464363;5005.424376196711;5106.489351064938;4816.253480710496;4817.759112044454;4924.310596516419;5109.20807274873;5156.602179986325;4206.263903816881;4584.426946631671;4942.357493525818;4949;5038.380042378016;3660.6888414485065;4242.915141697211;4360.12514618717;4958.413307741633;5060.482964339749;4439.912221505751;4546.499885012712;4642.675012749075;4960.677555958851;4990.775415106256;2743.9710108709232;3392.202832334449;3407.897763067112;3411.607665118543;3435.914102147466;4310.525842157423;4969;4971.676841005323;4999.800007999639;5256.553192978639;4786;4960.851174464772;5255.132903071103;5816.651000939957;5820.272465941757;5097.954919241621;5260.736963151904;5733.627314224562;5740.942590574041;5804.912926306024;4412.793603198401;4705.55297246761;5624.35319938196;5636.2954630671165;5725.198472213977;5190.480951904779;5441;5605.5515558756015;5664.85837854057;5818.94181058184;4697.412823397075;4839.685420447659;4996.550310471929;5597.852440249821;5627.943720562906 21:59:47 INFO - PROCESS | 1653 | |5;yui.html;647.80242026182;757.3600307739958;761.3718682087276;791.0902462168509;798.0702481608926;15195.772063419057;15549.766753498707;15570.688586228269;15599.29803158859;15641.296141673623;13860.37628306726;13959.441622335095;13965.790513142285;14012.859871401282;14026.579202623938;667.4093427316835;685.3420716112513;844.2950136635916;844.3456321350941;868.1318681318681;851.1063383447387;860.4321148042293;862.5773371048173;864.0322838420946;868.0321441592611;928.2898582584328;928.5032507608431;930.5347326336831;930.7905721212741;931.2689538712112;919.5402298850574;920.9309301802392;921.6820197032014;922.34513495418;923.5705396990364;523.979040838366;538.0557122250465;539.231594977156;541.2098336428819;541.9674819510802;14001.089929154572;14559.053661511967;14594.854051459455;14803;14826.406943722239;13887;14277.571672849832;14368.568942931728;14503.92748036253;14579.927100364537;11596.304221746723;11776.411179440993;11966.700832479257;12031.278123312542;12192.57325993586;3803.334416477133;3825.7895815730403;3852.8266228019806;3878.1855810279876;3986.4418981342637;108412;108473.91526084796;109559.90440095577;109592.90407095906;110085.34871976927;8170.550619715854;11117.44298811278;11206.663800085847;11231.438428078563;11372.601958931398;22887.313380598276;23134.768652313596;23340;23409.531809364056;23466.64800028001;7781.144074151839;7876.84246315082;7982.600869956479;8030.558319292495;8054.59727013647;3853.7302388833073;4095.760887481502;4447.421835161408;4469.776511174428;4477.8432754854075;3263.3147039121577;3604.6395360463744;3645.325614761278;3646.070252085701;3651.9817400912825;649.7628365646505;652.9020646902908;659.7097277198113;667.2226855713137;670.2258890980925;557.4481263549138;666.6999850067489;666.8166254280112;669.387510427953;673.4040374268808;7982.121966583672;8492.363072769567;9511.334206605472;9586.194927230832;9687.225021998223;554.2517601238296;614.3365165621118;637.8851806674843;680.425040840489;684.2507454337492;4348.859315589361;4660.184467718136;4673.532646735367;4689.788959496763;4792.832250871273;94605.52697236607;140597;145661.27169364298;145803.06477014266;149773.25113374364;113454;127189.72810271964;127310.09034864485;128613.71386286205;130616.3469182648;69710.65144674244;70451;101367;107353.46323268334;108525.91474085316;8556.526922312687;8808.64765409402;8914.01945785976;9054.909450905407;9186.58660360272;47581.524184759095;56403.435965639816;61378.693106534185;62675.6866215666;63913;63197.42006449876;69644.6517767408;70454.72668553951;73447.26552734405;89583.55208224177;13163.802542961672;13226.735465290449;13419.396127174496;13506.459741610226;13655.522056727967;14789.630259243175;14833.480828170963;15037.172955487116;15387;15580.29888655036;13787.172769633453;13791.931040344734;13886;14202.857971420566;14431.49489767853;13539;13592.45630174782;14051.789223161864;14180.858191418367;14474.782878256625;13361.331933403486;13438.46246150143;13731.519396821062;13804.792928106288;14275.14349139055;11625.941870290595;11655.708607284885;11741.941290293495;11792.115591330514;11849.881501184878;8610;11360.147988901032;11472.139589530985;11615.477303521531;11666.70833229142 21:59:47 INFO - PROCESS | 1653 | __end_tp_report 21:59:47 INFO - PROCESS | 1653 | __start_cc_report 21:59:47 INFO - PROCESS | 1653 | _x_x_mozilla_cycle_collect,1334 21:59:47 INFO - PROCESS | 1653 | __end_cc_report 21:59:47 INFO - PROCESS | 1653 | __startTimestamp1474952387523__endTimestamp 21:59:47 INFO - PROCESS | 1653 | 21:59:47 INFO - PROCESS | 1653 | ------- Summary: start ------- 21:59:47 INFO - PROCESS | 1653 | Number of tests: 6 21:59:47 INFO - PROCESS | 1653 | 21:59:47 INFO - PROCESS | 1653 | [#0] dojo.html Cycles:165 Average:5717.37 Median:5964.55 stddev:666.23 (11.2%) stddev-sans-first:626.58 21:59:47 INFO - PROCESS | 1653 | Values: 2760.3 3320.9 3340.5 3362.9 3377.8 5543.2 5645.7 5655.9 5705.1 5712.4 5608.6 5668.0 5719.7 5731.1 5786.2 5214.7 5288.6 5296.7 5297.8 5309.0 5210.9 5222.8 5265.5 5272.7 5297.0 4905.7 5178.0 5324.4 5374.4 5384.8 4740.9 5116.2 5122.2 5135.7 5143.3 5035.6 5081.4 5082.7 5135.2 5196.6 5578.0 5596.9 5632.9 5684.7 5699.7 6233.5 6241.6 6248.3 6253.1 6274.6 6130.5 6134.3 6193.8 6291.0 6291.6 5704.0 5712.8 5749.5 5781.7 5787.3 6290.2 6294.3 6298.2 6318.7 6319.1 5964.3 6146.3 6158.6 6168.1 6173.6 6097.2 6128.1 6179.5 6193.6 6220.6 6188.6 6218.0 6245.1 6253.4 6265.7 6172.4 6240.0 6241.1 6259.2 6273.4 4863.3 4896.6 4903.2 4953.9 4995.5 4441.3 4453.2 4459.6 4478.8 4489.8 5590.6 5655.5 5674.5 5708.0 5759.8 6160.2 6202.7 6214.5 6222.7 6250.1 5680.8 5686.5 5693.4 5696.1 5723.7 4280.0 5356.1 5360.4 5360.9 5368.5 6251.2 6264.9 6295.3 6357.1 6366.5 6239.4 6273.1 6274.2 6279.2 6281.7 6220.7 6338.8 6347.2 6348.7 6366.9 6103.6 6110.2 6128.2 6129.8 6218.3 5006.3 5974.9 6243.4 6268.2 6268.7 6084.1 6144.0 6156.8 6157.3 6167.0 5905.7 6004.0 6015.8 6020.8 6068.5 5984.3 6000.5 6012.3 6027.8 6064.8 6082.4 6085.7 6110.7 6133.4 6133.9 5776.9 5855.5 5873.5 5900.3 5964.6 21:59:47 INFO - PROCESS | 1653 | 21:59:47 INFO - PROCESS | 1653 | [#1] ext.html Cycles:180 Average:55243.32 Median:33476.75 stddev:112702.99 (336.7%) stddev-sans-first:112944.21 21:59:47 INFO - PROCESS | 1653 | Values: 502.4 519.2 528.1 532.0 557.4 27118.9 38603.0 39954.2 40053.8 42031.9 39956.0 40268.0 40312.2 40318.8 40420.2 8705.0 9635.4 9806.1 9822.3 9823.7 8755.0 11717.8 12032.4 12040.4 12293.6 11933.2 11990.9 12003.6 12026.5 12027.9 11898.5 11953.2 11976.9 11977.8 11991.5 11828.2 11901.5 11908.8 11910.9 11926.6 38395.8 38616.6 38625.0 38655.6 38664.8 3212.5 3280.3 3287.1 3306.9 3390.6 29212.3 29604.3 30975.8 31015.0 31031.7 3239.0 3276.1 3337.1 3369.7 3374.4 362613.2 363666.0 367142.0 367662.0 369878.0 32234.0 33055.5 53861.0 54124.2 54188.9 34389.0 34510.8 34678.5 34687.7 34729.7 14189.3 14322.2 14340.4 14344.6 14348.2 11066.5 11259.5 12101.9 12204.9 12287.0 6880.2 7426.2 7614.2 7725.6 7746.7 3234.5 3262.5 3267.3 3275.9 3301.5 756.6 845.0 948.9 954.4 1136.3 27399.5 28758.3 28764.4 29060.7 29489.7 1048.3 1051.5 1058.5 1076.8 1089.5 12381.8 15308.5 15354.7 15445.4 15641.1 522955.0 528433.0 528626.0 530633.0 530868.0 53331.5 54128.5 54308.0 54337.5 54492.2 1232.4 1252.2 1352.9 1380.6 1404.5 24148.5 25761.5 30041.0 30092.5 30774.2 44943.6 45486.8 45588.3 45599.3 45652.9 351277.0 355761.0 356315.0 356482.2 356691.0 25517.5 26295.5 26296.7 27133.3 27171.3 44363.0 45469.0 45863.0 45960.8 46162.1 30929.7 35670.3 35967.9 38094.0 38497.0 28948.6 36567.9 37021.8 37922.6 38246.4 36374.8 37063.4 37165.3 37472.4 37503.4 30921.0 33334.8 33415.2 33424.7 33528.8 21679.8 21948.5 22083.3 24730.0 25078.9 21:59:47 INFO - PROCESS | 1653 | 21:59:47 INFO - PROCESS | 1653 | [#2] jquery.html Cycles:180 Average:31341.49 Median:14230.80 stddev:80074.60 (562.7%) stddev-sans-first:80265.43 21:59:47 INFO - PROCESS | 1653 | Values: 351.9 372.1 373.8 379.7 400.7 13424.6 14894.4 15755.4 20157.4 20799.7 19396.1 19901.9 20287.9 20491.3 21038.3 5039.7 5896.6 6090.8 6128.6 6159.4 4657.4 6049.8 6110.9 6127.5 6138.5 5041.4 5739.1 6033.4 6055.5 6062.9 5928.6 5971.6 5977.9 5980.5 5985.3 4963.1 5175.4 5211.7 5222.5 5244.3 25888.4 25904.2 26004.7 26231.9 26484.5 2185.3 2429.7 2440.9 2573.3 3088.4 14235.9 15135.3 15952.8 16072.7 16304.0 1905.8 1911.9 1919.2 1963.8 2031.4 111235.0 115449.0 115821.0 116131.3 117072.8 11272.4 11435.1 11489.9 11502.2 11731.6 14402.5 14417.8 14419.8 14448.2 14450.4 8334.6 8467.1 8502.1 8522.1 8653.4 8383.7 8466.7 8617.4 8621.9 8676.3 3793.3 4424.3 4512.3 4534.0 4596.3 1869.0 1889.3 1912.2 1933.2 1937.2 853.3 925.6 956.7 998.5 1009.9 16218.8 17949.4 20452.0 21251.8 21389.0 772.7 893.9 924.2 965.8 995.4 10474.4 11392.7 11431.7 11435.4 11454.9 465222.0 470698.0 474270.0 478495.0 479925.0 111001.9 117059.0 117474.4 121668.2 124008.0 987.4 991.7 1030.7 1030.8 1032.3 19181.1 19400.5 19503.2 19749.5 19784.6 40987.0 54628.0 55759.4 56370.2 56568.3 77864.2 78783.0 78933.0 81090.2 82074.8 8001.8 8219.8 8274.3 8300.0 8471.3 13161.7 13249.0 13437.9 13451.7 13636.7 11199.3 11388.9 11494.8 11656.8 11708.5 11258.3 11305.5 11384.1 11445.7 11618.0 8827.4 9790.5 10578.7 11545.9 11900.3 6741.0 6773.4 8123.5 8274.6 8358.9 10039.4 11275.8 11314.3 11553.4 11783.8 21:59:47 INFO - PROCESS | 1653 | 21:59:47 INFO - PROCESS | 1653 | [#3] mootools.html Cycles:180 Average:5599.95 Median:5070.82 stddev:3137.42 (61.9%) stddev-sans-first:3130.18 21:59:47 INFO - PROCESS | 1653 | Values: 1379.1 1540.4 1559.5 1772.9 1925.2 7878.8 8387.6 8569.6 8911.9 8915.7 8729.3 8731.9 8733.8 8824.6 8837.5 2357.2 2380.8 2382.5 2386.2 2386.9 2340.7 2376.0 2388.7 2389.3 2391.1 2336.6 2336.8 2347.5 2376.1 2385.9 2211.6 2235.7 2240.7 2249.2 2256.1 2146.5 2187.5 2327.4 2342.7 2344.4 8639.2 8821.9 8834.7 8851.0 8859.5 5105.4 5327.1 5330.3 5344.9 5353.9 3416.1 3601.1 3610.9 3670.2 3691.8 1045.9 1074.0 1075.5 1098.0 1103.3 11420.0 11499.8 11554.7 11555.7 11586.6 4314.3 4407.8 4549.2 4565.3 4566.4 9128.8 9142.3 9147.3 9159.6 9181.1 5222.9 5225.6 5230.1 5231.7 5234.9 4356.8 4368.8 4530.7 4552.8 4889.0 3648.5 3724.1 3744.7 3767.8 3771.0 996.4 1127.1 1141.8 1142.4 1150.6 776.9 870.9 906.4 926.7 926.9 5518.5 5575.7 5583.7 5796.7 5975.3 916.2 937.2 937.3 939.3 948.5 3017.9 3600.3 3673.1 3850.3 3967.9 10046.5 10304.2 10502.6 10772.7 10790.8 10583.2 10594.5 10594.6 10602.2 10625.8 6704.2 8124.7 8135.6 8140.4 8145.3 5573.9 5874.8 5995.8 6057.2 6057.6 9526.7 9894.2 9989.6 10002.4 10029.6 7579.6 9291.6 9468.9 10108.5 10208.7 7019.3 7267.3 7268.0 7280.9 7285.6 8121.6 8369.2 8419.4 8445.1 8568.8 6323.8 7452.3 7474.5 7549.1 7556.5 7311.8 7390.2 7411.1 7473.3 7476.7 6950.0 7079.3 7081.8 7082.4 7094.9 4834.3 4934.6 4946.8 5007.9 5116.1 4861.3 4913.7 5016.8 5043.0 5098.6 21:59:47 INFO - PROCESS | 1653 | 21:59:47 INFO - PROCESS | 1653 | [#4] prototype.html Cycles:180 Average:4271.82 Median:4638.21 stddev:1310.73 (28.3%) stddev-sans-first:1279.21 21:59:47 INFO - PROCESS | 1653 | Values: 251.9 296.5 304.1 308.9 315.2 4531.5 4548.6 5501.4 5510.3 5539.2 5083.5 5252.9 5266.2 5294.5 5418.8 3557.1 3941.9 4095.2 4109.3 4127.1 4101.5 4124.4 4125.0 4139.2 4150.0 3831.7 4045.1 4072.6 4093.3 4131.8 4052.5 4079.9 4087.1 4115.4 4117.2 3034.3 3113.1 3344.9 3434.5 3545.5 3879.9 4401.1 4798.1 4799.5 5282.5 3963.6 4425.5 4695.8 4704.3 4735.8 5644.4 5645.9 5743.7 5760.9 5761.4 3707.3 3802.6 3880.4 3903.6 3917.8 5467.2 5476.1 5578.4 5657.3 5900.4 3881.4 3887.2 3893.5 3906.4 3908.6 3110.9 3385.5 3874.4 3947.3 3949.4 3564.4 4188.3 4491.8 4633.7 4666.1 5335.5 5656.2 5703.9 5719.4 5757.6 1071.7 1213.7 1352.6 1374.9 1375.9 716.8 864.1 866.9 873.4 874.4 3712.6 4265.2 4497.0 4631.5 4690.5 4513.8 4708.3 4747.0 4931.6 5073.6 3807.5 4132.4 4401.6 4420.7 4593.4 2185.0 2470.0 2599.4 2622.2 2641.4 5111.6 5126.5 5131.4 5137.6 5147.3 4280.1 4508.4 4985.8 5005.4 5106.5 4816.3 4817.8 4924.3 5109.2 5156.6 4206.3 4584.4 4942.4 4949.0 5038.4 3660.7 4242.9 4360.1 4958.4 5060.5 4439.9 4546.5 4642.7 4960.7 4990.8 2744.0 3392.2 3407.9 3411.6 3435.9 4310.5 4969.0 4971.7 4999.8 5256.6 4786.0 4960.9 5255.1 5816.7 5820.3 5098.0 5260.7 5733.6 5740.9 5804.9 4412.8 4705.6 5624.4 5636.3 5725.2 5190.5 5441.0 5605.6 5664.9 5818.9 4697.4 4839.7 4996.6 5597.9 5627.9 21:59:47 INFO - PROCESS | 1653 | 21:59:47 INFO - PROCESS | 1653 | [#5] yui.html Cycles:180 Average:23308.06 Median:3814.56 stddev:36477.32 (956.3%) stddev-sans-first:36539.96 21:59:47 INFO - PROCESS | 1653 | Values: 647.8 757.4 761.4 791.1 798.1 15195.8 15549.8 15570.7 15599.3 15641.3 13860.4 13959.4 13965.8 14012.9 14026.6 667.4 685.3 844.3 844.3 868.1 851.1 860.4 862.6 864.0 868.0 928.3 928.5 930.5 930.8 931.3 919.5 920.9 921.7 922.3 923.6 524.0 538.1 539.2 541.2 542.0 14001.1 14559.1 14594.9 14803.0 14826.4 13887.0 14277.6 14368.6 14503.9 14579.9 11596.3 11776.4 11966.7 12031.3 12192.6 3803.3 3825.8 3852.8 3878.2 3986.4 108412.0 108473.9 109559.9 109592.9 110085.3 8170.6 11117.4 11206.7 11231.4 11372.6 22887.3 23134.8 23340.0 23409.5 23466.6 7781.1 7876.8 7982.6 8030.6 8054.6 3853.7 4095.8 4447.4 4469.8 4477.8 3263.3 3604.6 3645.3 3646.1 3652.0 649.8 652.9 659.7 667.2 670.2 557.4 666.7 666.8 669.4 673.4 7982.1 8492.4 9511.3 9586.2 9687.2 554.3 614.3 637.9 680.4 684.3 4348.9 4660.2 4673.5 4689.8 4792.8 94605.5 140597.0 145661.3 145803.1 149773.3 113454.0 127189.7 127310.1 128613.7 130616.3 69710.7 70451.0 101367.0 107353.5 108525.9 8556.5 8808.6 8914.0 9054.9 9186.6 47581.5 56403.4 61378.7 62675.7 63913.0 63197.4 69644.7 70454.7 73447.3 89583.6 13163.8 13226.7 13419.4 13506.5 13655.5 14789.6 14833.5 15037.2 15387.0 15580.3 13787.2 13791.9 13886.0 14202.9 14431.5 13539.0 13592.5 14051.8 14180.9 14474.8 13361.3 13438.5 13731.5 13804.8 14275.1 11625.9 11655.7 11741.9 11792.1 11849.9 8610.0 11360.1 11472.1 11615.5 11666.7 21:59:47 INFO - PROCESS | 1653 | -------- Summary: end -------- 21:59:47 INFO - PROCESS | 1653 | 21:59:48 INFO - TEST-INFO | 1653: exit 0 21:59:48 INFO - TEST-OK | dromaeo_css | took 1118109ms 21:59:48 INFO - TEST-START | kraken 21:59:48 INFO - operating with platform_type : mac_ 21:59:48 INFO - Initialising browser for kraken test... 21:59:48 INFO - TEST-INFO | started process 1659 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/tmpKMQpI2/profile http://localhost:49276/getInfo.html) 21:59:50 INFO - PROCESS | 1659 | __metrics Screen width/height:1600/1200 21:59:50 INFO - PROCESS | 1659 | colorDepth:24 21:59:50 INFO - PROCESS | 1659 | Browser inner width/height: 1024/689 21:59:50 INFO - PROCESS | 1659 | __metrics 21:59:50 INFO - PROCESS | 1659 | 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" 21:59:50 INFO - PROCESS | 1659 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:59:51 INFO - TEST-INFO | 1659: exit 0 21:59:51 INFO - Browser initialized. 21:59:51 INFO - Running cycle 1/1 for kraken test... 21:59:51 INFO - TEST-INFO | started process 1660 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/tmpKMQpI2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:00:03 INFO - PROCESS | 1660 | RSS: Main: 235601920 22:00:03 INFO - PROCESS | 1660 | 22:00:06 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-beat-detection) 22:00:07 INFO - PROCESS | 1660 | RSS: Main: 294256640 22:00:07 INFO - PROCESS | 1660 | 22:00:09 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-dft) 22:00:10 INFO - PROCESS | 1660 | RSS: Main: 293052416 22:00:10 INFO - PROCESS | 1660 | 22:00:13 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-fft) 22:00:14 INFO - PROCESS | 1660 | RSS: Main: 383381504 22:00:14 INFO - PROCESS | 1660 | 22:00:16 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-oscillator) 22:00:16 INFO - PROCESS | 1660 | RSS: Main: 286552064 22:00:16 INFO - PROCESS | 1660 | 22:00:19 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:00:19 INFO - PROCESS | 1660 | RSS: Main: 288870400 22:00:19 INFO - PROCESS | 1660 | 22:00:22 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-darkroom) 22:00:22 INFO - PROCESS | 1660 | RSS: Main: 328192000 22:00:22 INFO - PROCESS | 1660 | 22:00:25 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-desaturate) 22:00:26 INFO - PROCESS | 1660 | RSS: Main: 329453568 22:00:26 INFO - PROCESS | 1660 | 22:00:29 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49276/tests/kraken/driver.html?testName=json-parse-financial) 22:00:29 INFO - PROCESS | 1660 | RSS: Main: 326774784 22:00:29 INFO - PROCESS | 1660 | 22:00:31 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49276/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:00:31 INFO - PROCESS | 1660 | RSS: Main: 304738304 22:00:31 INFO - PROCESS | 1660 | 22:00:33 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:00:34 INFO - PROCESS | 1660 | RSS: Main: 307355648 22:00:34 INFO - PROCESS | 1660 | 22:00:36 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:00:37 INFO - PROCESS | 1660 | RSS: Main: 310550528 22:00:37 INFO - PROCESS | 1660 | 22:00:40 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:00:41 INFO - PROCESS | 1660 | RSS: Main: 316665856 22:00:41 INFO - PROCESS | 1660 | 22:00:44 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:00:44 INFO - PROCESS | 1660 | RSS: Main: 318799872 22:00:44 INFO - PROCESS | 1660 | 22:00:46 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49276/tests/kraken/driver.html?testName=ai-astar) 22:00:46 INFO - PROCESS | 1660 | RSS: Main: 362065920 22:00:46 INFO - PROCESS | 1660 | 22:00:46 INFO - PROCESS | 1660 | __start_tp_report 22:00:46 INFO - PROCESS | 1660 | _x_x_mozilla_page_load 22:00:46 INFO - PROCESS | 1660 | _x_x_mozilla_page_load_details 22:00:46 INFO - PROCESS | 1660 | |i|pagename|runs| 22:00:46 INFO - PROCESS | 1660 | |0;ai-astar;114;115;114;114;114;114;113;114;111;112 22:00:46 INFO - PROCESS | 1660 | |1;audio-beat-detection;146;110;110;144;111;110;110;107;139;108 22:00:46 INFO - PROCESS | 1660 | |2;audio-dft;184;184;182;183;185;185;183;184;185;185 22:00:46 INFO - PROCESS | 1660 | |3;audio-fft;81;59;59;87;60;59;60;59;91;58 22:00:46 INFO - PROCESS | 1660 | |4;audio-oscillator;84;69;93;69;69;91;127;96;76;90 22:00:46 INFO - PROCESS | 1660 | |5;imaging-gaussian-blur;89;86;90;86;89;85;89;86;88;86 22:00:46 INFO - PROCESS | 1660 | |6;imaging-darkroom;94;96;93;90;128;94;95;94;95;94 22:00:46 INFO - PROCESS | 1660 | |7;imaging-desaturate;84;85;84;86;86;86;85;87;85;84 22:00:46 INFO - PROCESS | 1660 | |8;json-parse-financial;55;54;54;54;54;55;57;53;55;54 22:00:46 INFO - PROCESS | 1660 | |9;json-stringify-tinderbox;70;72;97;113;79;70;69;71;70;70 22:00:46 INFO - PROCESS | 1660 | |10;stanford-crypto-aes;87;85;88;85;88;87;83;87;90;86 22:00:46 INFO - PROCESS | 1660 | |11;stanford-crypto-ccm;141;139;138;155;163;151;134;136;192;147 22:00:46 INFO - PROCESS | 1660 | |12;stanford-crypto-pbkdf2;169;167;169;169;168;168;170;167;168;199 22:00:46 INFO - PROCESS | 1660 | |13;stanford-crypto-sha256-iterative;69;69;68;69;68;67;66;68;67;66 22:00:46 INFO - PROCESS | 1660 | __end_tp_report 22:00:46 INFO - PROCESS | 1660 | __start_cc_report 22:00:46 INFO - PROCESS | 1660 | _x_x_mozilla_cycle_collect,1950 22:00:46 INFO - PROCESS | 1660 | __end_cc_report 22:00:46 INFO - PROCESS | 1660 | __startTimestamp1474952446649__endTimestamp 22:00:46 INFO - PROCESS | 1660 | 22:00:46 INFO - PROCESS | 1660 | ------- Summary: start ------- 22:00:46 INFO - PROCESS | 1660 | Number of tests: 14 22:00:46 INFO - PROCESS | 1660 | 22:00:46 INFO - PROCESS | 1660 | [#0] ai-astar Cycles:10 Average:113.50 Median:114.00 stddev:1.18 (1.0%) stddev-sans-first:1.24 22:00:46 INFO - PROCESS | 1660 | Values: 114.0 115.0 114.0 114.0 114.0 114.0 113.0 114.0 111.0 112.0 22:00:46 INFO - PROCESS | 1660 | 22:00:46 INFO - PROCESS | 1660 | [#1] audio-beat-detection Cycles:10 Average:119.50 Median:110.50 stddev:16.35 (14.8%) stddev-sans-first:14.25 22:00:46 INFO - PROCESS | 1660 | Values: 146.0 110.0 110.0 144.0 111.0 110.0 110.0 107.0 139.0 108.0 22:00:46 INFO - PROCESS | 1660 | 22:00:46 INFO - PROCESS | 1660 | [#2] audio-dft Cycles:10 Average:184.00 Median:184.50 stddev:1.05 (0.6%) stddev-sans-first:1.12 22:00:46 INFO - PROCESS | 1660 | Values: 184.0 184.0 182.0 183.0 185.0 185.0 183.0 184.0 185.0 185.0 22:00:46 INFO - PROCESS | 1660 | 22:00:46 INFO - PROCESS | 1660 | [#3] audio-fft Cycles:10 Average:67.30 Median:60.00 stddev:13.36 (22.3%) stddev-sans-first:13.22 22:00:46 INFO - PROCESS | 1660 | Values: 81.0 59.0 59.0 87.0 60.0 59.0 60.0 59.0 91.0 58.0 22:00:46 INFO - PROCESS | 1660 | 22:00:46 INFO - PROCESS | 1660 | [#4] audio-oscillator Cycles:10 Average:86.40 Median:87.00 stddev:17.77 (20.4%) stddev-sans-first:18.82 22:00:46 INFO - PROCESS | 1660 | Values: 84.0 69.0 93.0 69.0 69.0 91.0 127.0 96.0 76.0 90.0 22:00:46 INFO - PROCESS | 1660 | 22:00:46 INFO - PROCESS | 1660 | [#5] imaging-gaussian-blur Cycles:10 Average:87.40 Median:88.50 stddev:1.78 (2.0%) stddev-sans-first:1.79 22:00:46 INFO - PROCESS | 1660 | Values: 89.0 86.0 90.0 86.0 89.0 85.0 89.0 86.0 88.0 86.0 22:00:46 INFO - PROCESS | 1660 | 22:00:46 INFO - PROCESS | 1660 | [#6] imaging-darkroom Cycles:10 Average:97.30 Median:94.00 stddev:10.90 (11.6%) stddev-sans-first:11.50 22:00:46 INFO - PROCESS | 1660 | Values: 94.0 96.0 93.0 90.0 128.0 94.0 95.0 94.0 95.0 94.0 22:00:46 INFO - PROCESS | 1660 | 22:00:46 INFO - PROCESS | 1660 | [#7] imaging-desaturate Cycles:10 Average:85.20 Median:85.50 stddev:1.03 (1.2%) stddev-sans-first:1.00 22:00:46 INFO - PROCESS | 1660 | Values: 84.0 85.0 84.0 86.0 86.0 86.0 85.0 87.0 85.0 84.0 22:00:46 INFO - PROCESS | 1660 | 22:00:46 INFO - PROCESS | 1660 | [#8] json-parse-financial Cycles:10 Average:54.50 Median:54.50 stddev:1.08 (2.0%) stddev-sans-first:1.13 22:00:46 INFO - PROCESS | 1660 | Values: 55.0 54.0 54.0 54.0 54.0 55.0 57.0 53.0 55.0 54.0 22:00:46 INFO - PROCESS | 1660 | 22:00:46 INFO - PROCESS | 1660 | [#9] json-stringify-tinderbox Cycles:10 Average:78.10 Median:70.50 stddev:14.94 (21.2%) stddev-sans-first:15.56 22:00:46 INFO - PROCESS | 1660 | Values: 70.0 72.0 97.0 113.0 79.0 70.0 69.0 71.0 70.0 70.0 22:00:46 INFO - PROCESS | 1660 | 22:00:46 INFO - PROCESS | 1660 | [#10] stanford-crypto-aes Cycles:10 Average:86.60 Median:87.00 stddev:1.96 (2.2%) stddev-sans-first:2.07 22:00:46 INFO - PROCESS | 1660 | Values: 87.0 85.0 88.0 85.0 88.0 87.0 83.0 87.0 90.0 86.0 22:00:46 INFO - PROCESS | 1660 | 22:00:46 INFO - PROCESS | 1660 | [#11] stanford-crypto-ccm Cycles:10 Average:149.60 Median:149.00 stddev:17.53 (11.8%) stddev-sans-first:18.31 22:00:46 INFO - PROCESS | 1660 | Values: 141.0 139.0 138.0 155.0 163.0 151.0 134.0 136.0 192.0 147.0 22:00:46 INFO - PROCESS | 1660 | 22:00:46 INFO - PROCESS | 1660 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.40 Median:169.00 stddev:9.74 (5.8%) stddev-sans-first:10.30 22:00:46 INFO - PROCESS | 1660 | Values: 169.0 167.0 169.0 169.0 168.0 168.0 170.0 167.0 168.0 199.0 22:00:46 INFO - PROCESS | 1660 | 22:00:46 INFO - PROCESS | 1660 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.70 Median:68.00 stddev:1.16 (1.7%) stddev-sans-first:1.13 22:00:46 INFO - PROCESS | 1660 | Values: 69.0 69.0 68.0 69.0 68.0 67.0 66.0 68.0 67.0 66.0 22:00:46 INFO - PROCESS | 1660 | -------- Summary: end -------- 22:00:46 INFO - PROCESS | 1660 | 22:00:47 INFO - TEST-INFO | 1660: exit 0 22:00:47 INFO - TEST-OK | kraken | took 59303ms 22:00:47 INFO - SUITE-END | took 1177s 22:00:47 INFO - Completed test suite (00:19:37) 22:00:47 INFO - javascript benchmark 22:00:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2760.268528839857, 3320.8837690680825, 3340.482225255085, 3362.8654853805847, 3377.847996840142, 5543.223948647193, 5645.689487078214, 5655.943440565593, 5705.115707065401, 5712.42875712429, 5608.6073974821775, 5668.036433806253, 5719.742611582478, 5731.054376027961, 5786.247787787582, 5214.687118772867, 5288.629795914288, 5296.708681022542, 5297.788088476456, 5308.964751873386, 5210.947890521104, 5222.7649755760895, 5265.473452654723, 5272.657277276984, 5296.973515132419, 4905.730184839832, 5177.974110129444, 5324.41431442541, 5374.381946076192, 5384.7846086156505, 4740.928886066695, 5116.232565115225, 5122.231665250205, 5135.666181698215, 5143.279940808253, 5035.647504674675, 5081.364829396325, 5082.74586270685, 5135.229715542661, 5196.636235463519, 5577.96807590593, 5596.916046259309, 5632.873425314912, 5684.744186511617, 5699.715014249271, 6233.470155036827, 6241.563090583661, 6248.31268560458, 6253.062040693932, 6274.592151510183, 6130.509559235251, 6134.344744984521, 6193.752249910043, 6291.0, 6291.622502649856, 5704.0, 5712.80005199816, 5749.511291540266, 5781.71091445426, 5787.334456537552, 6290.182276304051, 6294.307626161119, 6298.244210694746, 6318.652474113968, 6319.146915166486, 5964.31410387811, 6146.262448506208, 6158.599691020069, 6168.136460895478, 6173.59871608344, 6097.207363042776, 6128.105930682418, 6179.474744646665, 6193.597416167935, 6220.564560480723, 6188.597741146811, 6217.96891015542, 6245.125682404467, 6253.374662533801, 6265.65538895356, 6172.4136207060255, 6240.0, 6241.126242326078, 6259.155014073133, 6273.435390814758, 4863.294822250754, 4896.559309662076, 4903.166461701519, 4953.876153096129, 4995.450500445021, 4441.267190913463, 4453.1761624099645, 4459.620932220798, 4478.798454069574, 4489.7979590918485, 5590.608657393944, 5655.462731040545, 5674.517665998354, 5707.971460142673, 5759.827205183851, 6160.229971253593, 6202.72087756052, 6214.471769899519, 6222.719977601018, 6250.0937364082865, 5680.829575112753, 5686.516646085046, 5693.373728889819, 5696.11710184922, 5723.656580605094, 4280.0, 5356.0894647909945, 5360.437154098841, 5360.946390536123, 5368.489993450694, 6251.187345645037, 6264.9373506265265, 6295.276043255084, 6357.110004599453, 6366.490680745436, 6239.407256310643, 6273.090401891609, 6274.215723034621, 6279.183706118175, 6281.685915704105, 6220.688965551795, 6338.778142764981, 6347.206599175103, 6348.71430785625, 6366.872662546631, 6103.624523775107, 6110.236220472441, 6128.167033931239, 6129.754809807558, 6218.253809542884, 5006.299118123538, 5974.924513587423, 6243.406876346739, 6268.153799237045, 6268.717907694256, 6084.148219249397, 6143.96928015357, 6156.78451254204, 6157.32269450369, 6167.0, 5905.734241959208, 6003.969980150246, 6015.819525414245, 6020.789272375446, 6068.4841788448475, 5984.251968503937, 6000.459958603747, 6012.278526576839, 6027.849303767441, 6064.757409703739, 6082.36135205797, 6085.665288409003, 6110.7250173741395, 6133.44798968095, 6133.938660613515, 5776.884462310814, 5855.531557475477, 5873.50075243592, 5900.321463031806, 5964.5526585505395], "value": 5672.707338980148, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [502.4222144533787, 519.2082074835874, 528.1206790693495, 531.9946800531993, 557.4481263549087, 27118.86440567797, 38603.03492412688, 39954.2009159817, 40053.799731001374, 42031.949201269985, 39956.0, 40268.0, 40312.193756124936, 40318.798406008005, 40420.19159616806, 8705.042445331008, 9635.421874687541, 9806.11744942955, 9822.312438129335, 9823.705288841345, 8754.956225218864, 11717.765644687144, 12032.398380081006, 12040.397980101005, 12293.569725059624, 11933.16467847251, 11990.880091199064, 12003.63989080329, 12026.51893924242, 12027.939860300687, 11898.524059037629, 11953.191000114966, 11976.940115299367, 11977.820332695017, 11991.460384282727, 11828.23116497425, 11901.523939042429, 11908.821367679491, 11910.940445297805, 11926.642200733992, 38395.808020959994, 38616.613833861586, 38625.0, 38655.61344386576, 38664.80667596672, 3212.4699424594914, 3280.311134661724, 3287.1289108386295, 3306.8677252909856, 3390.593128824532, 29212.26969325784, 29604.259893502618, 30975.845120774477, 31015.0, 31031.689683103104, 3238.951415728766, 3276.1154488288266, 3337.0989832745267, 3369.663033696611, 3374.3926093303194, 362613.1869340663, 363666.0, 367142.0, 367662.0, 369877.9999999973, 32234.032979010666, 33055.50416743751, 53861.0, 54124.188137177975, 54188.91622167535, 34389.0, 34510.82744586261, 34678.47982280268, 34687.65312346895, 34729.65270347315, 14189.290535473185, 14322.212278324792, 14340.426382944564, 14344.56966291013, 14348.210848403229, 11066.502007409686, 11259.549618015351, 12101.878981210075, 12204.938975305067, 12287.0, 6880.2431732509385, 7426.220246874001, 7614.162442131361, 7725.575093369806, 7746.728864489716, 3234.530993006001, 3262.5269335946155, 3267.281198136406, 3275.9361602190465, 3301.471764517714, 756.6481586062507, 844.9986765682686, 948.9335746497817, 954.3844220477753, 1136.3352438823215, 27399.45201095967, 28758.281042974093, 28764.417957012145, 29060.7093929058, 29489.705102949127, 1048.2871647279924, 1051.5268129341828, 1058.528954615189, 1076.8169411200115, 1089.5260561655705, 12381.814272785916, 15308.464203752816, 15354.692906141814, 15445.378235285358, 15641.13973731433, 522955.0, 528433.0, 528626.0, 530633.0, 530868.0, 53331.46668533343, 54128.458715412344, 54308.0, 54337.45662543324, 54492.182617260776, 1232.445399570179, 1252.1735654468007, 1352.918824870511, 1380.6134282400742, 1404.5365029540023, 24148.51702965966, 25761.484770304865, 30041.0, 30092.548611770402, 30774.230644234074, 44943.55056449524, 45486.772566136955, 45588.31617525673, 45599.31601025921, 45652.8586785333, 351277.0, 355761.0, 356315.0, 356482.21758891037, 356691.0, 25517.489650207262, 26295.474090518466, 26296.73703262943, 27133.321666957694, 27171.320716982234, 44363.0, 45469.0, 45863.0, 45960.770196148806, 46162.07675846397, 30929.69070309268, 35670.28659426849, 35967.92096237117, 38094.047648809, 38497.0, 28948.565771513866, 36567.902962911154, 37021.81489092537, 37922.62077379191, 38246.42630360491, 36374.8181259092, 37063.444048339836, 37165.25669486649, 37472.437913430775, 37503.43744843775, 30921.0, 33334.83328083505, 33415.16462088467, 33424.66575334215, 33528.832355838065, 21679.783202167775, 21948.451288717908, 22083.327102990093, 24730.010799567815, 25078.874605626854], "value": 17960.763486638236, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [351.8873960332691, 372.05312479739064, 373.7888093227328, 379.7455704677865, 400.7455265906149, 13424.597262082129, 14894.404223831034, 15755.448559300426, 20157.395278141677, 20799.68800467994, 19396.127174277157, 19901.900490497563, 20287.898560507212, 20491.282805101826, 21038.263660771878, 5039.697618142914, 5896.643771932459, 6090.756369745205, 6128.571000029978, 6159.384061593827, 4657.394538709963, 6049.788257410992, 6110.877782444349, 6127.540434467411, 6138.539609529281, 5041.395032596093, 5739.081746920494, 6033.366496517869, 6055.515558755289, 6062.878742425149, 5928.555358348141, 5971.581989260753, 5977.850553736148, 5980.491658209057, 5985.311689155759, 4963.131451995886, 5175.353080864892, 5211.661242019257, 5222.477752224785, 5244.29202057725, 25888.352791180183, 25904.22287331383, 26004.699765011865, 26231.868840655865, 26484.47031059387, 2185.3225500095023, 2429.6962879640046, 2440.9267721968367, 2573.2537564106387, 3088.413201491732, 14235.928820355935, 15135.318910649048, 15952.840471595251, 16072.678546429122, 16304.021758694516, 1905.7903630600622, 1911.8852868827914, 1919.1747548554117, 1963.7643482782157, 2031.3601215617034, 111235.0, 115449.0, 115821.0, 116131.25803112876, 117072.8292717079, 11272.380019099028, 11435.14236432271, 11489.942550287195, 11502.169088982648, 11731.589394371327, 14402.495912643008, 14417.78373324401, 14419.78370324446, 14448.205348705711, 14450.421983120768, 8334.62494187763, 8467.068622451648, 8502.14978502145, 8522.10517895612, 8653.365586453705, 8383.706570270011, 8466.661333546712, 8617.439866408664, 8621.870671939925, 8676.34927380449, 3793.260314238752, 4424.336349547593, 4512.300593408027, 4533.954660453419, 4596.287575425815, 1868.9719654205198, 1889.3387314439835, 1912.1873203888292, 1933.1590758020307, 1937.2444746548858, 853.347189400097, 925.6066171876926, 956.6651671914774, 998.5456617239139, 1009.9192064634958, 16218.837811621734, 17949.37177198818, 20452.0, 21251.78748212529, 21389.0, 772.6909236305411, 893.9106089391139, 924.2190349154953, 965.7971825916636, 995.4226548601794, 10474.423906685206, 11392.715182120348, 11431.714207144887, 11435.371054591911, 11454.942725286486, 465222.0, 470698.0, 474270.0, 478495.0, 479925.0, 111001.88998109916, 117059.0, 117474.41262793631, 121668.17497737541, 124008.0, 987.3532835992437, 991.6975322526555, 1030.7165529479303, 1030.7835354575623, 1032.3496197395593, 19181.136848841557, 19400.544959128405, 19503.21987120556, 19749.506262343555, 19784.63661177632, 40987.00677083905, 54628.0, 55759.44240557543, 56370.15444768414, 56568.30295091154, 77864.2213577857, 78783.0, 78933.0, 81090.18830525273, 82074.76887846568, 8001.759947201594, 8219.835603287782, 8274.338052955869, 8299.95850020746, 8471.279941205066, 13161.670958226121, 13249.0, 13437.86562134366, 13451.663708406977, 13636.65908352299, 11199.272047316897, 11388.94305528467, 11494.770104598028, 11656.766864662828, 11708.531658733555, 11258.268212566158, 11305.491252893475, 11384.089272858317, 11445.656630301104, 11618.012468940235, 8827.382083254111, 9790.510474476105, 10578.730552333769, 11545.884541154817, 11900.345480998629, 6740.966295168493, 6773.356531129535, 8123.47197432165, 8274.627641756257, 8358.87461688063, 10039.397636141855, 11275.7744845101, 11314.264572802742, 11553.364564948672, 11783.76432471363], "value": 9578.02158325429, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1379.1449301433101, 1540.3530517182778, 1559.4853698279567, 1772.8581713462925, 1925.239530385497, 7878.803029924247, 8387.622556984936, 8569.571521423928, 8911.866322005159, 8915.73252802417, 8729.25801306888, 8731.869021964676, 8733.825323493526, 8824.558772061388, 8837.513936733478, 2357.2456813819626, 2380.833341666084, 2382.5354055959097, 2386.200622791367, 2386.940326491843, 2340.660604212388, 2375.9643605345846, 2388.737238903719, 2389.2951579284068, 2391.0555330644384, 2336.6261398176293, 2336.813054955608, 2347.4835536182013, 2376.120835290945, 2385.8926348314367, 2211.635080211763, 2235.6646503024594, 2240.708707867983, 2249.201533455632, 2256.0862850545554, 2146.4955735402323, 2187.453136715821, 2327.359976006595, 2342.7188737351457, 2344.3553022918663, 8639.179277968582, 8821.897262842145, 8834.686992377858, 8850.955745221232, 8859.468431894107, 5105.387353517602, 5327.121025030865, 5330.333708286465, 5344.893102137974, 5353.946460535422, 3416.145963509123, 3601.0817241603486, 3610.9277814443562, 3670.1558641512333, 3691.778493290411, 1045.9215558833118, 1074.0, 1075.5267682219876, 1098.0447011100314, 1103.3214573037603, 11420.0, 11499.827502587468, 11554.711132221677, 11555.711107222303, 11586.594469193538, 4314.331278651814, 4407.823687052482, 4549.226631472658, 4565.292379681155, 4566.383538222364, 9128.817423651622, 9142.268618510503, 9147.313951453534, 9159.633614655339, 9181.127792859668, 5222.92165617516, 5225.581953443715, 5230.110881150137, 5231.738413079331, 5234.9476505235225, 4356.825726970949, 4368.825246990084, 4530.728156310632, 4552.795124219418, 4889.046635906036, 3648.4892115103908, 3724.1248306647917, 3744.7191460640015, 3767.811609419518, 3771.0, 996.4071377530358, 1127.1490025031212, 1141.7944769941323, 1142.3831131189065, 1150.5972909481613, 776.8601651702747, 870.9433886797337, 906.4153620914474, 926.6941909169958, 926.8795056642729, 5518.530924871431, 5575.69333686643, 5583.69289689071, 5796.652200867961, 5975.25309336333, 916.2120576304372, 937.2408349237139, 937.329809186435, 939.3143005605946, 948.4972964328916, 3017.8641961111803, 3600.261946301002, 3673.118451571657, 3850.306944749972, 3967.940480892789, 10046.497675116216, 10304.227182961307, 10502.579896804195, 10772.676819695422, 10790.838137427945, 10583.153347732163, 10594.523246453928, 10594.57621695139, 10602.204834637432, 10625.787484250272, 6704.195496540447, 8124.675012999413, 8135.552544609985, 8140.389470789714, 8145.307648849915, 5573.8507743125, 5874.823755287348, 5995.760169593342, 6057.242844644419, 6057.57596968208, 9526.66656667041, 9894.20846332306, 9989.60041598357, 10002.399856008371, 10029.598816047277, 7579.583122928292, 9291.581878815334, 9468.857967130636, 10108.54511546997, 10208.693739187836, 7019.298070193144, 7267.273272672691, 7267.963660181666, 7280.854382912418, 7285.599292038989, 8121.593920304079, 8369.204925532065, 8419.36854735885, 8445.113263107285, 8568.828623427622, 6323.810285691437, 7452.329290363893, 7474.476786624884, 7549.131849837339, 7556.471047026876, 7311.780646580611, 7390.150132734804, 7411.110666720028, 7473.290037446434, 7476.663550140365, 6949.965250173716, 7079.327463890922, 7081.787546373617, 7082.433405327459, 7094.893576596252, 4834.3231947528075, 4934.55588996992, 4946.826861059845, 5007.949920500749, 5116.079105760999, 4861.27080937848, 4913.729744864067, 5016.799328026838, 5043.0, 5098.643094983316], "value": 4498.1579592717035, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [251.94961007798443, 296.45600323406546, 304.09683240774905, 308.9227693076731, 315.1805306203872, 4531.478879928809, 4548.636109111271, 5501.449855014492, 5510.311211098613, 5539.224508568804, 5083.4662360452085, 5252.921206181911, 5266.157414813631, 5294.497022782839, 5418.783248670058, 3557.1107223194203, 3941.8620348287814, 4095.1809638072355, 4109.321961876287, 4127.060281667626, 4101.4668093148, 4124.443200167984, 4124.957541609225, 4139.234241665286, 4150.028736350225, 3831.712621553381, 4045.110075783323, 4072.572379900112, 4093.3041382964966, 4131.814068366915, 4052.4529188559463, 4079.938800917989, 4087.121268927165, 4115.362118871565, 4117.197146556423, 3034.317278612317, 3113.066080175938, 3344.916377090568, 3434.5019972103905, 3545.503629491873, 3879.922401551953, 4401.138603021686, 4798.136335459616, 4799.528242954881, 5282.471752824726, 3963.623455771697, 4425.513193548707, 4695.765211739399, 4704.341392205094, 4735.786889589976, 5644.3508996465525, 5645.943540564624, 5743.712814359265, 5760.913586296209, 5761.423857614247, 3707.2751527627174, 3802.6387493188104, 3880.3791393376923, 3903.551091624443, 3917.8442359504015, 5467.239044282612, 5476.123820188791, 5578.3584887738025, 5657.321121465409, 5900.400755539118, 3881.3595756700392, 3887.2031233597045, 3893.5327760668333, 3906.43356713275, 3908.55051669056, 3110.9267302780504, 3385.5260263563123, 3874.380099184117, 3947.348687466593, 3949.447077409165, 3564.429691249388, 4188.308929026737, 4491.843914920791, 4633.745144017044, 4666.136764698542, 5335.466453354634, 5656.236408084856, 5703.914441283384, 5719.369979555807, 5757.625754325955, 1071.737424331044, 1213.7329787446747, 1352.6280272925023, 1374.9206872604957, 1375.917444953306, 716.8279612892868, 864.1272314961808, 866.9380009488452, 873.3624454148508, 874.4010352908278, 3712.5844223314616, 4265.232258193493, 4497.00948869005, 4631.467381251199, 4690.545930761406, 4513.81944722214, 4708.340832283483, 4746.976265118652, 4931.605471562267, 5073.594112470993, 3807.5240594925635, 4132.421460995463, 4401.63275094553, 4420.690551661352, 4593.425821772278, 2184.967225491619, 2469.9749603914174, 2599.3631560267477, 2622.2133359991926, 2641.4452964877205, 5111.623095260722, 5126.4617215191865, 5131.435542090367, 5137.563307118937, 5147.349115205672, 4280.058387154821, 4508.368828364031, 4985.750712464363, 5005.424376196711, 5106.489351064938, 4816.253480710496, 4817.759112044454, 4924.310596516419, 5109.20807274873, 5156.602179986325, 4206.263903816881, 4584.426946631671, 4942.357493525818, 4949.0, 5038.380042378016, 3660.6888414485065, 4242.915141697211, 4360.12514618717, 4958.413307741633, 5060.482964339749, 4439.912221505751, 4546.499885012712, 4642.675012749075, 4960.677555958851, 4990.775415106256, 2743.9710108709232, 3392.202832334449, 3407.897763067112, 3411.607665118543, 3435.914102147466, 4310.525842157423, 4969.0, 4971.676841005323, 4999.800007999639, 5256.553192978639, 4786.0, 4960.851174464772, 5255.132903071103, 5816.651000939957, 5820.272465941757, 5097.954919241621, 5260.736963151904, 5733.627314224562, 5740.942590574041, 5804.912926306024, 4412.793603198401, 4705.55297246761, 5624.35319938196, 5636.2954630671165, 5725.198472213977, 5190.480951904779, 5441.0, 5605.5515558756015, 5664.85837854057, 5818.94181058184, 4697.412823397075, 4839.685420447659, 4996.550310471929, 5597.852440249821, 5627.943720562906], "value": 3859.0427111579397, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [647.80242026182, 757.3600307739958, 761.3718682087276, 791.0902462168509, 798.0702481608926, 15195.772063419057, 15549.766753498707, 15570.688586228269, 15599.29803158859, 15641.296141673623, 13860.37628306726, 13959.441622335095, 13965.790513142285, 14012.859871401282, 14026.579202623938, 667.4093427316835, 685.3420716112513, 844.2950136635916, 844.3456321350941, 868.1318681318681, 851.1063383447387, 860.4321148042293, 862.5773371048173, 864.0322838420946, 868.0321441592611, 928.2898582584328, 928.5032507608431, 930.5347326336831, 930.7905721212741, 931.2689538712112, 919.5402298850574, 920.9309301802392, 921.6820197032014, 922.34513495418, 923.5705396990364, 523.979040838366, 538.0557122250465, 539.231594977156, 541.2098336428819, 541.9674819510802, 14001.089929154572, 14559.053661511967, 14594.854051459455, 14803.0, 14826.406943722239, 13887.0, 14277.571672849832, 14368.568942931728, 14503.92748036253, 14579.927100364537, 11596.304221746723, 11776.411179440993, 11966.700832479257, 12031.278123312542, 12192.57325993586, 3803.334416477133, 3825.7895815730403, 3852.8266228019806, 3878.1855810279876, 3986.4418981342637, 108412.0, 108473.91526084796, 109559.90440095577, 109592.90407095906, 110085.34871976927, 8170.550619715854, 11117.44298811278, 11206.663800085847, 11231.438428078563, 11372.601958931398, 22887.313380598276, 23134.768652313596, 23340.0, 23409.531809364056, 23466.64800028001, 7781.144074151839, 7876.84246315082, 7982.600869956479, 8030.558319292495, 8054.59727013647, 3853.7302388833073, 4095.760887481502, 4447.421835161408, 4469.776511174428, 4477.8432754854075, 3263.3147039121577, 3604.6395360463744, 3645.325614761278, 3646.070252085701, 3651.9817400912825, 649.7628365646505, 652.9020646902908, 659.7097277198113, 667.2226855713137, 670.2258890980925, 557.4481263549138, 666.6999850067489, 666.8166254280112, 669.387510427953, 673.4040374268808, 7982.121966583672, 8492.363072769567, 9511.334206605472, 9586.194927230832, 9687.225021998223, 554.2517601238296, 614.3365165621118, 637.8851806674843, 680.425040840489, 684.2507454337492, 4348.859315589361, 4660.184467718136, 4673.532646735367, 4689.788959496763, 4792.832250871273, 94605.52697236607, 140597.0, 145661.27169364298, 145803.06477014266, 149773.25113374364, 113454.0, 127189.72810271964, 127310.09034864485, 128613.71386286205, 130616.3469182648, 69710.65144674244, 70451.0, 101367.0, 107353.46323268334, 108525.91474085316, 8556.526922312687, 8808.64765409402, 8914.01945785976, 9054.909450905407, 9186.58660360272, 47581.524184759095, 56403.435965639816, 61378.693106534185, 62675.6866215666, 63913.0, 63197.42006449876, 69644.6517767408, 70454.72668553951, 73447.26552734405, 89583.55208224177, 13163.802542961672, 13226.735465290449, 13419.396127174496, 13506.459741610226, 13655.522056727967, 14789.630259243175, 14833.480828170963, 15037.172955487116, 15387.0, 15580.29888655036, 13787.172769633453, 13791.931040344734, 13886.0, 14202.857971420566, 14431.49489767853, 13539.0, 13592.45630174782, 14051.789223161864, 14180.858191418367, 14474.782878256625, 13361.331933403486, 13438.46246150143, 13731.519396821062, 13804.792928106288, 14275.14349139055, 11625.941870290595, 11655.708607284885, 11741.941290293495, 11792.115591330514, 11849.881501184878, 8610.0, 11360.147988901032, 11472.139589530985, 11615.477303521531, 11666.70833229142], "value": 7680.584730583741, "unit": "score"}], "name": "dromaeo_css", "value": 7118.538977251172, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 114.0, 114.0, 114.0, 114.0, 113.0, 114.0, 111.0, 112.0], "value": 113.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 110.0, 110.0, 144.0, 111.0, 110.0, 110.0, 107.0, 139.0, 108.0], "value": 119.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 184.0, 182.0, 183.0, 185.0, 185.0, 183.0, 184.0, 185.0, 185.0], "value": 184.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 59.0, 59.0, 87.0, 60.0, 59.0, 60.0, 59.0, 91.0, 58.0], "value": 67.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 69.0, 93.0, 69.0, 69.0, 91.0, 127.0, 96.0, 76.0, 90.0], "value": 86.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 86.0, 90.0, 86.0, 89.0, 85.0, 89.0, 86.0, 88.0, 86.0], "value": 87.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 96.0, 93.0, 90.0, 128.0, 94.0, 95.0, 94.0, 95.0, 94.0], "value": 97.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 84.0, 86.0, 86.0, 86.0, 85.0, 87.0, 85.0, 84.0], "value": 85.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 54.0, 54.0, 54.0, 55.0, 57.0, 53.0, 55.0, 54.0], "value": 54.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 72.0, 97.0, 113.0, 79.0, 70.0, 69.0, 71.0, 70.0, 70.0], "value": 78.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 88.0, 85.0, 88.0, 87.0, 83.0, 87.0, 90.0, 86.0], "value": 86.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 139.0, 138.0, 155.0, 163.0, 151.0, 134.0, 136.0, 192.0, 147.0], "value": 149.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 167.0, 169.0, 169.0, 168.0, 168.0, 170.0, 167.0, 168.0, 199.0], "value": 171.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 68.0, 69.0, 68.0, 67.0, 66.0, 68.0, 67.0, 66.0], "value": 67.7, "unit": "score"}], "name": "kraken", "value": 1448.5, "alertThreshold": 2.0}]} 22:00:47 INFO - Return code: 0 22:00:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 22:00:47 INFO - # TBPL SUCCESS # 22:00:47 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 22:00:47 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 22:00:47 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 22:00:47 INFO - 2016-09-26 22:00:47.995 screenresolution[1664:9846] starting screenresolution argv=screenresolution get 22:00:47 INFO - 2016-09-26 22:00:47.999 screenresolution[1664:9846] Display 0: 1600x1200x32@60 22:00:48 INFO - 2016-09-26 22:00:48.005 screenresolution[1665:9849] starting screenresolution argv=screenresolution list 22:00:48 INFO - Available Modes on Display 0 22:00:48 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 22:00:48 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 22:00:48 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 22:00:48 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 22:00:48 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 22:00:48 INFO - Intel Iris: 22:00:48 INFO - Chipset Model: Intel Iris 22:00:48 INFO - Type: GPU 22:00:48 INFO - Bus: Built-In 22:00:48 INFO - VRAM (Dynamic, Max): 1536 MB 22:00:48 INFO - Vendor: Intel (0x8086) 22:00:48 INFO - Device ID: 0x0a2e 22:00:48 INFO - Revision ID: 0x0009 22:00:48 INFO - Displays: 22:00:48 INFO - Display: 22:00:48 INFO - Resolution: 1600 x 1200 @ 60 Hz 22:00:48 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 22:00:48 INFO - Display Serial Number: 1600x1200 60 22:00:48 INFO - Main Display: Yes 22:00:48 INFO - Mirror: Off 22:00:48 INFO - Online: Yes 22:00:48 INFO - Rotation: Supported 22:00:48 INFO - Return code: 0 22:00:48 INFO - Running post-action listener: _resource_record_post_action 22:00:48 INFO - [mozharness: 2016-09-27 05:00:48.241673Z] Finished run-tests step (success) 22:00:48 INFO - Running post-run listener: _resource_record_post_run 22:00:48 INFO - Total resource usage - Wall time: 1212s; CPU: 53.0%; Read bytes: 37958656; Write bytes: 704532480; Read time: 389; Write time: 2066 22:00:48 INFO - TinderboxPrint: CPU usage
53.5% 22:00:48 INFO - TinderboxPrint: I/O read bytes / time
37,958,656 / 389 22:00:48 INFO - TinderboxPrint: I/O write bytes / time
704,532,480 / 2,066 22:00:48 INFO - TinderboxPrint: CPU idle
2,256.2 (46.5%) 22:00:48 INFO - TinderboxPrint: CPU system
964.7 (19.9%) 22:00:48 INFO - TinderboxPrint: CPU user
1,628.6 (33.6%) 22:00:48 INFO - TinderboxPrint: Swap in / out
444,354,560 / 0 22:00:48 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 395293184; Write bytes: 389875712; Read time: 29705; Write time: 700 22:00:48 INFO - run-tests - Wall time: 1179s; CPU: 53.0%; Read bytes: 36123648; Write bytes: 293742592; Read time: 369; Write time: 1321 22:00:48 INFO - Running post-run listener: _upload_blobber_files 22:00:48 INFO - Blob upload gear active. 22:00:48 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:00:48 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 22:00:48 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', 'Autoland', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 22:00:48 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 Autoland -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 22:00:49 INFO - (blobuploader) - INFO - Open directory for files ... 22:00:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 22:00:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:00:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:00:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 22:00:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:00:50 INFO - (blobuploader) - INFO - Done attempting. 22:00:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 22:00:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:00:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:00:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 22:00:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:00:51 INFO - (blobuploader) - INFO - Done attempting. 22:00:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 22:00:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:00:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:00:54 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 22:00:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:00:54 INFO - (blobuploader) - INFO - Done attempting. 22:00:54 INFO - (blobuploader) - INFO - Iteration through files over. 22:00:54 INFO - Return code: 0 22:00:54 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:00:54 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:00:54 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/e1ca3daf43968afe7014521eb518c97ec6a28d5ca326d922e4ebb7ed6fc3c02c5c71605b2785ffd46556323c2e2b0561a6bf4d8b5998ce2453252d07cea15388", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/de2d15980ecaa02f34f5995b3e49333f90e34f53e29cfa2858646c55516fb6cbcc51793ba872268416fa4d2383d8eac455f44bb4c54540120ba87e2f19594008", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/2f5c47f0aec6daec64e5e76a92644e689a5aea8cbba9a089db855343e88269fd82ead1ce43e8827d069659400ddf6348201b5ed42c0860455201d564eadfcb19"} 22:00:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:00:54 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:00:54 INFO - Contents: 22:00:54 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/e1ca3daf43968afe7014521eb518c97ec6a28d5ca326d922e4ebb7ed6fc3c02c5c71605b2785ffd46556323c2e2b0561a6bf4d8b5998ce2453252d07cea15388", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/de2d15980ecaa02f34f5995b3e49333f90e34f53e29cfa2858646c55516fb6cbcc51793ba872268416fa4d2383d8eac455f44bb4c54540120ba87e2f19594008", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/2f5c47f0aec6daec64e5e76a92644e689a5aea8cbba9a089db855343e88269fd82ead1ce43e8827d069659400ddf6348201b5ed42c0860455201d564eadfcb19"} 22:00:54 INFO - Running post-run listener: copy_logs_to_upload_dir 22:00:54 INFO - Copying logs to upload dir... 22:00:54 INFO - mkdir: /builds/slave/test/build/upload/logs 22:00:54 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1275.143633 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2016-09-26 22:00:54.389694) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-26 22:00:54.393116) ========= 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.wi2IelogNx/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.AJEeYJeFLZ/Listeners TMPDIR=/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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/Autoland/sha512/e1ca3daf43968afe7014521eb518c97ec6a28d5ca326d922e4ebb7ed6fc3c02c5c71605b2785ffd46556323c2e2b0561a6bf4d8b5998ce2453252d07cea15388", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/de2d15980ecaa02f34f5995b3e49333f90e34f53e29cfa2858646c55516fb6cbcc51793ba872268416fa4d2383d8eac455f44bb4c54540120ba87e2f19594008", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/2f5c47f0aec6daec64e5e76a92644e689a5aea8cbba9a089db855343e88269fd82ead1ce43e8827d069659400ddf6348201b5ed42c0860455201d564eadfcb19"} build_url:https://queue.taskcluster.net/v1/task/BtEWKrpvS8y0dzET7xAYsQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011041 build_url: 'https://queue.taskcluster.net/v1/task/BtEWKrpvS8y0dzET7xAYsQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/e1ca3daf43968afe7014521eb518c97ec6a28d5ca326d922e4ebb7ed6fc3c02c5c71605b2785ffd46556323c2e2b0561a6bf4d8b5998ce2453252d07cea15388", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/de2d15980ecaa02f34f5995b3e49333f90e34f53e29cfa2858646c55516fb6cbcc51793ba872268416fa4d2383d8eac455f44bb4c54540120ba87e2f19594008", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/2f5c47f0aec6daec64e5e76a92644e689a5aea8cbba9a089db855343e88269fd82ead1ce43e8827d069659400ddf6348201b5ed42c0860455201d564eadfcb19"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-26 22:00:54.425392) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 22:00:54.425686) ========= 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.wi2IelogNx/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.AJEeYJeFLZ/Listeners TMPDIR=/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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.005073 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 22:00:54.473512) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-26 22:00:54.473844) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-26 22:00:54.474149) ========= ========= Total master_lag: 0.16 =========