builder: autoland_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0112 starttime: 1471909189.96 results: success (0) buildid: 20160822152313 builduid: aee3f5ad40024ef7ad75ca4f80c62c33 revision: a22d1d1dbb3e7fd7a446c5bc6b6ce927eb4c62e7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-22 16:39:49.960237) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-22 16:39:49.961300) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-22 16:39:49.962073) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-22 16:39:49.992158) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 16:39:49.992856) ========= 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.iLmjzJt7Uf/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.HziM8vcF2H/Listeners TMPDIR=/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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-08-22 16:39:50-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 18.5M=0.001s 2016-08-22 16:39:50 (18.5 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.079298 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 16:39:50.100348) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 16:39:50.101138) ========= 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.iLmjzJt7Uf/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.HziM8vcF2H/Listeners TMPDIR=/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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.028118 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 16:39:50.154468) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-22 16:39:50.155276) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev a22d1d1dbb3e7fd7a446c5bc6b6ce927eb4c62e7 --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 a22d1d1dbb3e7fd7a446c5bc6b6ce927eb4c62e7 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.iLmjzJt7Uf/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.HziM8vcF2H/Listeners TMPDIR=/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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-08-22 16:39:50,227 truncating revision to first 12 chars 2016-08-22 16:39:50,227 Setting DEBUG logging. 2016-08-22 16:39:50,227 attempt 1/10 2016-08-22 16:39:50,227 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/a22d1d1dbb3e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-22 16:39:50,872 unpacking tar archive at: autoland-a22d1d1dbb3e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.913094 ========= master_lag: 0.15 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-22 16:39:51.215818) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-22 16:39:51.216139) ========= script_repo_revision: a22d1d1dbb3e7fd7a446c5bc6b6ce927eb4c62e7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-22 16:39:51.216521) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-22 16:39:51.216797) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-22 16:39:51.415017) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2016-08-22 16:39:51.415719) ========= /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.iLmjzJt7Uf/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.HziM8vcF2H/Listeners TMPDIR=/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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 16:39:51 INFO - MultiFileLogger online at 20160822 16:39:51 in /builds/slave/test 16:39:51 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 16:39:51 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:39:51 INFO - {'append_to_log': False, 16:39:51 INFO - 'base_work_dir': '/builds/slave/test', 16:39:51 INFO - 'blob_upload_branch': 'Autoland', 16:39:51 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:39:51 INFO - 'branch': 'Autoland', 16:39:51 INFO - 'buildbot_json_path': 'buildprops.json', 16:39:51 INFO - 'config_files': ('talos/mac_config.py',), 16:39:51 INFO - 'default_actions': ('clobber', 16:39:51 INFO - 'read-buildbot-config', 16:39:51 INFO - 'download-and-extract', 16:39:51 INFO - 'populate-webroot', 16:39:51 INFO - 'create-virtualenv', 16:39:51 INFO - 'install', 16:39:51 INFO - 'run-tests'), 16:39:51 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:39:51 INFO - 'download_minidump_stackwalk': True, 16:39:51 INFO - 'download_symbols': 'ondemand', 16:39:51 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:39:51 INFO - 'tooltool.py': '/tools/tooltool.py', 16:39:51 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:39:51 INFO - '/tools/misc-python/virtualenv.py')}, 16:39:51 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:39:51 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:39:51 INFO - 'installer_path': 'installer.exe', 16:39:51 INFO - 'log_level': 'info', 16:39:51 INFO - 'log_name': 'talos', 16:39:51 INFO - 'log_to_console': True, 16:39:51 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 16:39:51 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 16:39:51 INFO - 'opt_config_files': (), 16:39:51 INFO - 'pip_index': False, 16:39:51 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:39:51 INFO - 'cmd': ('bash', 16:39:51 INFO - '-c', 16:39:51 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:39:51 INFO - 'enabled': True, 16:39:51 INFO - 'halt_on_failure': False, 16:39:51 INFO - 'name': 'check_screen_resolution'},), 16:39:51 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:39:51 INFO - 'cmd': ('bash', 16:39:51 INFO - '-c', 16:39:51 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:39:51 INFO - 'enabled': True, 16:39:51 INFO - 'halt_on_failure': False, 16:39:51 INFO - 'name': 'check_screen_resolution'},), 16:39:51 INFO - 'run_cmd_checks_enabled': True, 16:39:51 INFO - 'sps_profile': False, 16:39:51 INFO - 'sps_profile_interval': 0, 16:39:51 INFO - 'suite': 'dromaeojs', 16:39:51 INFO - 'system_bits': '32', 16:39:51 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:39:51 INFO - 'title': 't-yosemite-r7-0112', 16:39:51 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:39:51 INFO - 'use_talos_json': True, 16:39:51 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:39:51 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:39:51 INFO - 'work_dir': 'build'} 16:39:51 INFO - [mozharness: 2016-08-22 23:39:51.629448Z] Running clobber step. 16:39:51 INFO - Running pre-action listener: _resource_record_pre_action 16:39:51 INFO - Running main action method: clobber 16:39:51 INFO - rmtree: /builds/slave/test/build 16:39:51 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:39:53 INFO - Running post-action listener: _resource_record_post_action 16:39:53 INFO - [mozharness: 2016-08-22 23:39:53.814019Z] Finished clobber step (success) 16:39:53 INFO - [mozharness: 2016-08-22 23:39:53.814148Z] Running read-buildbot-config step. 16:39:53 INFO - Running pre-action listener: _resource_record_pre_action 16:39:53 INFO - Running main action method: read_buildbot_config 16:39:53 INFO - Using buildbot properties: 16:39:53 INFO - { 16:39:53 INFO - "project": "", 16:39:53 INFO - "product": "firefox", 16:39:53 INFO - "script_repo_revision": "production", 16:39:53 INFO - "builddir": "autoland_yosemite_r7_test-dromaeojs", 16:39:53 INFO - "repository": "", 16:39:53 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 autoland talos dromaeojs", 16:39:53 INFO - "buildid": "20160822152313", 16:39:53 INFO - "pgo_build": "False", 16:39:53 INFO - "basedir": "/builds/slave/test", 16:39:53 INFO - "buildnumber": 112, 16:39:53 INFO - "slavename": "t-yosemite-r7-0112", 16:39:53 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 16:39:53 INFO - "platform": "yosemite_r7", 16:39:53 INFO - "scheduler": "tests-autoland-macosx64-talos", 16:39:53 INFO - "branch": "autoland", 16:39:53 INFO - "repo_path": "integration/autoland", 16:39:53 INFO - "revision": "a22d1d1dbb3e7fd7a446c5bc6b6ce927eb4c62e7", 16:39:53 INFO - "stage_platform": "macosx64", 16:39:53 INFO - "builduid": "aee3f5ad40024ef7ad75ca4f80c62c33", 16:39:53 INFO - "slavebuilddir": "test" 16:39:53 INFO - } 16:39:53 INFO - Found installer url https://queue.taskcluster.net/v1/task/dzq8yXiKSMqfiScuI7jkFA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 16:39:53 INFO - Running post-action listener: _resource_record_post_action 16:39:53 INFO - [mozharness: 2016-08-22 23:39:53.817554Z] Finished read-buildbot-config step (success) 16:39:53 INFO - [mozharness: 2016-08-22 23:39:53.817707Z] Running download-and-extract step. 16:39:53 INFO - Running pre-action listener: _resource_record_pre_action 16:39:53 INFO - Running main action method: download_and_extract 16:39:53 INFO - mkdir: /builds/slave/test/build/tests 16:39:53 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')]} 16:39:53 INFO - trying https://queue.taskcluster.net/v1/task/dzq8yXiKSMqfiScuI7jkFA/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 16:39:53 INFO - Downloading https://queue.taskcluster.net/v1/task/dzq8yXiKSMqfiScuI7jkFA/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 16:39:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dzq8yXiKSMqfiScuI7jkFA/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json'}, attempt #1 16:39:55 INFO - Downloaded 1199 bytes. 16:39:55 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 16:39:55 INFO - Using the following test package requirements: 16:39:55 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 16:39:55 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 16:39:55 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 16:39:55 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 16:39:55 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 16:39:55 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 16:39:55 INFO - u'jsshell-mac.zip'], 16:39:55 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 16:39:55 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 16:39:55 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 16:39:55 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 16:39:55 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 16:39:55 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 16:39:55 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 16:39:55 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 16:39:55 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 16:39:55 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 16:39:55 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 16:39:55 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 16:39:55 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')]} 16:39:55 INFO - trying https://queue.taskcluster.net/v1/task/dzq8yXiKSMqfiScuI7jkFA/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 16:39:55 INFO - Downloading https://queue.taskcluster.net/v1/task/dzq8yXiKSMqfiScuI7jkFA/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip 16:39:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dzq8yXiKSMqfiScuI7jkFA/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip'}, attempt #1 16:39:56 INFO - Downloaded 16353728 bytes. 16:39:56 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 16:40:02 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip', u'firefox-51.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 16:40:02 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')]} 16:40:02 INFO - trying https://queue.taskcluster.net/v1/task/dzq8yXiKSMqfiScuI7jkFA/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 16:40:02 INFO - Downloading https://queue.taskcluster.net/v1/task/dzq8yXiKSMqfiScuI7jkFA/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip 16:40:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dzq8yXiKSMqfiScuI7jkFA/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip'}, attempt #1 16:40:03 INFO - Downloaded 16353728 bytes. 16:40:03 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 16:40:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:40:10 INFO - trying https://queue.taskcluster.net/v1/task/dzq8yXiKSMqfiScuI7jkFA/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 16:40:10 INFO - Downloading https://queue.taskcluster.net/v1/task/dzq8yXiKSMqfiScuI7jkFA/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip 16:40:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dzq8yXiKSMqfiScuI7jkFA/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip'}, attempt #1 16:40:11 INFO - Downloaded 14413981 bytes. 16:40:11 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/tests 16:40:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:40:11 INFO - trying https://queue.taskcluster.net/v1/task/dzq8yXiKSMqfiScuI7jkFA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 16:40:11 INFO - Downloading https://queue.taskcluster.net/v1/task/dzq8yXiKSMqfiScuI7jkFA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 16:40:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dzq8yXiKSMqfiScuI7jkFA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg'}, attempt #1 16:40:14 INFO - Downloaded 111459991 bytes. 16:40:14 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dzq8yXiKSMqfiScuI7jkFA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 16:40:14 INFO - mkdir: /builds/slave/test/properties 16:40:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:40:14 INFO - Writing to file /builds/slave/test/properties/build_url 16:40:14 INFO - Contents: 16:40:14 INFO - build_url:https://queue.taskcluster.net/v1/task/dzq8yXiKSMqfiScuI7jkFA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 16:40:15 INFO - Running post-action listener: _resource_record_post_action 16:40:15 INFO - Running post-action listener: set_extra_try_arguments 16:40:15 INFO - [mozharness: 2016-08-22 23:40:15.715511Z] Finished download-and-extract step (success) 16:40:15 INFO - [mozharness: 2016-08-22 23:40:15.715633Z] Running populate-webroot step. 16:40:15 INFO - Running pre-action listener: _resource_record_pre_action 16:40:15 INFO - Running main action method: populate_webroot 16:40:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:40:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:40:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:40:15 INFO - '--tppagecycles', 16:40:15 INFO - '7'], 16:40:15 INFO - 'tests': ['tsvgm']}}, 16:40:15 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:40:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:40:15 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:40:15 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:40:15 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:40:15 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:40:15 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:40:15 INFO - 'talos_options': ['--disable-e10s'], 16:40:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:40:15 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:40:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:40:15 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:40:15 INFO - 'talos_options': ['--disable-e10s'], 16:40:15 INFO - 'tests': ['damp', 'tps']}, 16:40:15 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:40:15 INFO - 'tests': ['damp', 'tps']}, 16:40:15 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:40:15 INFO - 'tests': ['dromaeo_dom']}, 16:40:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:40:15 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:40:15 INFO - 'tests': ['basic_compositor_video']}, 16:40:15 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:40:15 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:40:15 INFO - 'tests': ['a11yr', 16:40:15 INFO - 'ts_paint', 16:40:15 INFO - 'tpaint', 16:40:15 INFO - 'sessionrestore', 16:40:15 INFO - 'sessionrestore_no_auto_restore', 16:40:15 INFO - 'tabpaint']}, 16:40:15 INFO - 'other-e10s': {'tests': ['a11yr', 16:40:15 INFO - 'ts_paint', 16:40:15 INFO - 'tpaint', 16:40:15 INFO - 'sessionrestore', 16:40:15 INFO - 'sessionrestore_no_auto_restore', 16:40:15 INFO - 'tabpaint']}, 16:40:15 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:40:15 INFO - 'ts_paint', 16:40:15 INFO - 'tpaint', 16:40:15 INFO - 'sessionrestore', 16:40:15 INFO - 'sessionrestore_no_auto_restore', 16:40:15 INFO - 'tabpaint']}, 16:40:15 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:40:15 INFO - 'ts_paint', 16:40:15 INFO - 'tpaint', 16:40:15 INFO - 'sessionrestore', 16:40:15 INFO - 'sessionrestore_no_auto_restore', 16:40:15 INFO - 'tabpaint']}, 16:40:15 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:40:15 INFO - 'tests': ['a11yr', 16:40:15 INFO - 'ts_paint', 16:40:15 INFO - 'tpaint', 16:40:15 INFO - 'sessionrestore', 16:40:15 INFO - 'sessionrestore_no_auto_restore', 16:40:15 INFO - 'tabpaint']}, 16:40:15 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:40:15 INFO - 'tests': ['a11yr', 16:40:15 INFO - 'ts_paint', 16:40:15 INFO - 'tpaint', 16:40:15 INFO - 'sessionrestore', 16:40:15 INFO - 'sessionrestore_no_auto_restore', 16:40:15 INFO - 'tabpaint']}, 16:40:15 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:40:15 INFO - 'tests': ['tsvgx', 16:40:15 INFO - 'tsvgr_opacity', 16:40:15 INFO - 'tart', 16:40:15 INFO - 'tscrollx', 16:40:15 INFO - 'cart']}, 16:40:15 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:40:15 INFO - 'tsvgr_opacity', 16:40:15 INFO - 'tart', 16:40:15 INFO - 'tscrollx', 16:40:15 INFO - 'cart']}, 16:40:15 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:40:15 INFO - 'talos_options': ['--disable-e10s'], 16:40:15 INFO - 'tests': ['tp5o']}, 16:40:15 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:40:15 INFO - 'tests': ['tp5o']}, 16:40:15 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:40:15 INFO - 'talos_options': ['--disable-e10s', 16:40:15 INFO - '--xperf_path', 16:40:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:40:15 INFO - 'tests': ['tp5n']}, 16:40:15 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:40:15 INFO - 'talos_options': ['--xperf_path', 16:40:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:40:15 INFO - 'tests': ['tp5n']}}, 16:40:15 INFO - 'talos.zip': {'path': '', 16:40:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:40:15 INFO - Running post-action listener: _resource_record_post_action 16:40:15 INFO - [mozharness: 2016-08-22 23:40:15.734171Z] Finished populate-webroot step (success) 16:40:15 INFO - [mozharness: 2016-08-22 23:40:15.734292Z] Running create-virtualenv step. 16:40:15 INFO - Running pre-action listener: _resource_record_pre_action 16:40:15 INFO - Running main action method: create_virtualenv 16:40:15 INFO - Creating virtualenv /builds/slave/test/build/venv 16:40:15 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 16:40:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:40:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:40:15 INFO - Using real prefix '/tools/python27' 16:40:15 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:40:16 INFO - Installing distribute.............................................................................................................................................................................................done. 16:40:19 INFO - Installing pip.................done. 16:40:19 INFO - Return code: 0 16:40:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:40:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:40:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:40:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:40:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:40:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:40:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:40:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10906ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109101618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa43da5970>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108fd0d30>, '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 0x108d35db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108fc8b20>, '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.iLmjzJt7Uf/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.HziM8vcF2H/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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 16:40:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 16:40:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:40:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iLmjzJt7Uf/Render', 16:40:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:40:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:40:19 INFO - 'HOME': '/Users/cltbld', 16:40:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:40:19 INFO - 'LOGNAME': 'cltbld', 16:40:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:40:19 INFO - 'MOZ_NO_REMOTE': '1', 16:40:19 INFO - 'NO_EM_RESTART': '1', 16:40:19 INFO - 'PAGER': '/bin/cat', 16:40:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:40:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:40:19 INFO - 'PWD': '/builds/slave/test', 16:40:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:40:19 INFO - 'SHELL': '/bin/bash', 16:40:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HziM8vcF2H/Listeners', 16:40:19 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 16:40:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:40:19 INFO - 'USER': 'cltbld', 16:40:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:40:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:40:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:40:19 INFO - 'XPC_FLAGS': '0x0', 16:40:19 INFO - 'XPC_SERVICE_NAME': '0', 16:40:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:40:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:40:19 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 16:40:19 INFO - Cleaning up... 16:40:19 INFO - Return code: 0 16:40:19 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:40:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:40:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:40:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:40:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:40:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:40:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:40:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10906ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109101618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa43da5970>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108fd0d30>, '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 0x108d35db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108fc8b20>, '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.iLmjzJt7Uf/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.HziM8vcF2H/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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 16:40:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 16:40:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 16:40:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iLmjzJt7Uf/Render', 16:40:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:40:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:40:19 INFO - 'HOME': '/Users/cltbld', 16:40:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:40:19 INFO - 'LOGNAME': 'cltbld', 16:40:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:40:19 INFO - 'MOZ_NO_REMOTE': '1', 16:40:19 INFO - 'NO_EM_RESTART': '1', 16:40:19 INFO - 'PAGER': '/bin/cat', 16:40:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:40:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:40:19 INFO - 'PWD': '/builds/slave/test', 16:40:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:40:19 INFO - 'SHELL': '/bin/bash', 16:40:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HziM8vcF2H/Listeners', 16:40:19 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 16:40:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:40:19 INFO - 'USER': 'cltbld', 16:40:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:40:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:40:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:40:19 INFO - 'XPC_FLAGS': '0x0', 16:40:19 INFO - 'XPC_SERVICE_NAME': '0', 16:40:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:40:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:40:19 INFO - Downloading/unpacking psutil>=3.1.1 16: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 16: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 16: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 16: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 16: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 16: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 16:40:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:40:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:40:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:40:22 INFO - Installing collected packages: psutil 16:40:22 INFO - Running setup.py install for psutil 16:40:23 INFO - building 'psutil._psutil_osx' extension 16:40:23 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 16:40:23 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 16:40:23 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 16:40:23 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 16:40:23 INFO - building 'psutil._psutil_posix' extension 16:40:23 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 16:40:23 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 16:40:23 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 16:40:23 INFO - ^ 16:40:24 INFO - 1 warning generated. 16:40:24 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 16:40:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:40:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:40:24 INFO - Successfully installed psutil 16:40:24 INFO - Cleaning up... 16:40:24 INFO - Return code: 0 16:40:24 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:40:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:40:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:40:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:40:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:40:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:40:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:40:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10906ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109101618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa43da5970>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108fd0d30>, '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 0x108d35db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108fc8b20>, '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.iLmjzJt7Uf/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.HziM8vcF2H/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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 16:40:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 16:40:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 16:40:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iLmjzJt7Uf/Render', 16:40:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:40:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:40:24 INFO - 'HOME': '/Users/cltbld', 16:40:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:40:24 INFO - 'LOGNAME': 'cltbld', 16:40:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:40:24 INFO - 'MOZ_NO_REMOTE': '1', 16:40:24 INFO - 'NO_EM_RESTART': '1', 16:40:24 INFO - 'PAGER': '/bin/cat', 16:40:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:40:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:40:24 INFO - 'PWD': '/builds/slave/test', 16:40:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:40:24 INFO - 'SHELL': '/bin/bash', 16:40:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HziM8vcF2H/Listeners', 16:40:24 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 16:40:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:40:24 INFO - 'USER': 'cltbld', 16:40:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:40:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:40:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:40:24 INFO - 'XPC_FLAGS': '0x0', 16:40:24 INFO - 'XPC_SERVICE_NAME': '0', 16:40:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:40:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:40:24 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:40:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:40:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:40:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:40:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:40:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:40:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:40:26 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:40:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:40:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:40:27 INFO - Installing collected packages: mozsystemmonitor 16:40:27 INFO - Running setup.py install for mozsystemmonitor 16:40:27 INFO - Successfully installed mozsystemmonitor 16:40:27 INFO - Cleaning up... 16:40:27 INFO - Return code: 0 16:40:27 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:40:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:40:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:40:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:40:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:40:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:40:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:40:27 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 0x10906ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109101618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa43da5970>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108fd0d30>, '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 0x108d35db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108fc8b20>, '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.iLmjzJt7Uf/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.HziM8vcF2H/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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 16:40:27 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 16:40:27 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 16:40:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iLmjzJt7Uf/Render', 16:40:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:40:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:40:27 INFO - 'HOME': '/Users/cltbld', 16:40:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:40:27 INFO - 'LOGNAME': 'cltbld', 16:40:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:40:27 INFO - 'MOZ_NO_REMOTE': '1', 16:40:27 INFO - 'NO_EM_RESTART': '1', 16:40:27 INFO - 'PAGER': '/bin/cat', 16:40:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:40:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:40:27 INFO - 'PWD': '/builds/slave/test', 16:40:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:40:27 INFO - 'SHELL': '/bin/bash', 16:40:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HziM8vcF2H/Listeners', 16:40:27 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 16:40:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:40:27 INFO - 'USER': 'cltbld', 16:40:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:40:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:40:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:40:27 INFO - 'XPC_FLAGS': '0x0', 16:40:27 INFO - 'XPC_SERVICE_NAME': '0', 16:40:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:40:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:40:27 INFO - Downloading/unpacking jsonschema==2.5.1 16:40:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:40:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:40:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:40:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:40:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:40:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:40:29 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:40:29 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:40:29 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 16:40:29 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 16:40:29 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 16:40:29 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 16:40:29 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 16:40:29 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 16:40:30 INFO - Downloading functools32-3.2.3-2.tar.gz 16:40:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:40:30 INFO - warning: no files found matching '*.txt' 16:40:30 INFO - no previously-included directories found matching 'build' 16:40:30 INFO - no previously-included directories found matching 'dist' 16:40:30 INFO - no previously-included directories found matching '.git*' 16:40:30 INFO - Installing collected packages: jsonschema, functools32 16:40:30 INFO - Running setup.py install for functools32 16:40:30 INFO - warning: no files found matching '*.txt' 16:40:30 INFO - no previously-included directories found matching 'build' 16:40:30 INFO - no previously-included directories found matching 'dist' 16:40:30 INFO - no previously-included directories found matching '.git*' 16:40:30 INFO - Successfully installed jsonschema functools32 16:40:30 INFO - Cleaning up... 16:40:30 INFO - Return code: 0 16:40:30 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:40:30 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')]} 16:40:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:40:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:40:30 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')]} 16:40:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:40:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:40:30 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 0x10906ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109101618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa43da5970>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108fd0d30>, '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 0x108d35db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108fc8b20>, '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.iLmjzJt7Uf/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.HziM8vcF2H/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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 16:40:30 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 16:40:30 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 16:40:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iLmjzJt7Uf/Render', 16:40:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:40:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:40:30 INFO - 'HOME': '/Users/cltbld', 16:40:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:40:30 INFO - 'LOGNAME': 'cltbld', 16:40:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:40:30 INFO - 'MOZ_NO_REMOTE': '1', 16:40:30 INFO - 'NO_EM_RESTART': '1', 16:40:30 INFO - 'PAGER': '/bin/cat', 16:40:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:40:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:40:30 INFO - 'PWD': '/builds/slave/test', 16:40:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:40:30 INFO - 'SHELL': '/bin/bash', 16:40:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HziM8vcF2H/Listeners', 16:40:30 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 16:40:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:40:30 INFO - 'USER': 'cltbld', 16:40:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:40:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:40:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:40:30 INFO - 'XPC_FLAGS': '0x0', 16:40:30 INFO - 'XPC_SERVICE_NAME': '0', 16:40:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:40:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:40:30 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:40:30 INFO - Cleaning up... 16:40:30 INFO - Return code: 0 16:40:30 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:40:30 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')]} 16:40:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:40:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:40:30 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')]} 16:40:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:40:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:40:30 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 0x10906ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109101618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa43da5970>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108fd0d30>, '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 0x108d35db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108fc8b20>, '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.iLmjzJt7Uf/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.HziM8vcF2H/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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 16:40:30 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 16:40:30 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 16:40:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iLmjzJt7Uf/Render', 16:40:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:40:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:40:30 INFO - 'HOME': '/Users/cltbld', 16:40:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:40:30 INFO - 'LOGNAME': 'cltbld', 16:40:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:40:30 INFO - 'MOZ_NO_REMOTE': '1', 16:40:30 INFO - 'NO_EM_RESTART': '1', 16:40:30 INFO - 'PAGER': '/bin/cat', 16:40:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:40:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:40:30 INFO - 'PWD': '/builds/slave/test', 16:40:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:40:30 INFO - 'SHELL': '/bin/bash', 16:40:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HziM8vcF2H/Listeners', 16:40:30 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 16:40:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:40:30 INFO - 'USER': 'cltbld', 16:40:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:40:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:40:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:40:30 INFO - 'XPC_FLAGS': '0x0', 16:40:30 INFO - 'XPC_SERVICE_NAME': '0', 16:40:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:40:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:40:31 INFO - Downloading/unpacking blobuploader==1.2.4 16:40:31 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 16:40:31 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 16:40:31 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 16:40:31 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 16:40:31 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 16:40:31 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 16:40:33 INFO - Downloading blobuploader-1.2.4.tar.gz 16:40:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:40:33 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:40:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:40:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:40:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:40:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:40:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:40:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:40:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:40:34 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:40:34 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 16:40:34 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 16:40:34 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 16:40:34 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 16:40:34 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 16:40:34 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 16:40:34 INFO - Downloading docopt-0.6.1.tar.gz 16:40:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:40:34 INFO - Installing collected packages: blobuploader, requests, docopt 16:40:34 INFO - Running setup.py install for blobuploader 16:40:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:40:35 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:40:35 INFO - Running setup.py install for requests 16:40:35 INFO - Running setup.py install for docopt 16:40:35 INFO - Successfully installed blobuploader requests docopt 16:40:35 INFO - Cleaning up... 16:40:35 INFO - Return code: 0 16:40:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:40:35 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')]} 16:40:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:40:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:40:35 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')]} 16:40:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:40:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:40:35 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 0x10906ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109101618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa43da5970>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108fd0d30>, '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 0x108d35db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108fc8b20>, '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.iLmjzJt7Uf/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.HziM8vcF2H/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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 16:40:35 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 16:40:35 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 16:40:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iLmjzJt7Uf/Render', 16:40:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:40:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:40:35 INFO - 'HOME': '/Users/cltbld', 16:40:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:40:35 INFO - 'LOGNAME': 'cltbld', 16:40:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:40:35 INFO - 'MOZ_NO_REMOTE': '1', 16:40:35 INFO - 'NO_EM_RESTART': '1', 16:40:35 INFO - 'PAGER': '/bin/cat', 16:40:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:40:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:40:35 INFO - 'PWD': '/builds/slave/test', 16:40:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:40:35 INFO - 'SHELL': '/bin/bash', 16:40:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HziM8vcF2H/Listeners', 16:40:35 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 16:40:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:40:35 INFO - 'USER': 'cltbld', 16:40:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:40:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:40:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:40:35 INFO - 'XPC_FLAGS': '0x0', 16:40:35 INFO - 'XPC_SERVICE_NAME': '0', 16:40:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:40:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:40:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:40:36 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-vC6qFr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:40:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:40:36 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-9VCJdf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:40:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:40:36 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-oI3TRe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:40:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:40:36 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-lQo716-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:40:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:40:36 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-zjBvOj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:40:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:40:36 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-Kx_roj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:40:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:40:36 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-XE7fgd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:40:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:40:36 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-znKXWj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:40:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:40:36 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-xq1nfG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:40:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:40:36 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-9ksOQB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:40:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:40:37 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-12SnEY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:40:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:40:37 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-0T3yQ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:40:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:40:37 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-339N73-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:40:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:40:37 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-SvaB9k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:40:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:40:37 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-flkZZe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:40:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:40:37 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-J8uQja-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:40:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:40:37 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-hndvYX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:40:37 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:40:37 INFO - Running setup.py install for manifestparser 16:40:37 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:40:37 INFO - Running setup.py install for mozcrash 16:40:38 INFO - Running setup.py install for mozdebug 16:40:38 INFO - Running setup.py install for mozdevice 16:40:38 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:40:38 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:40:38 INFO - Running setup.py install for mozfile 16:40:38 INFO - Running setup.py install for mozhttpd 16:40:38 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:40:38 INFO - Running setup.py install for mozinfo 16:40:38 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:40:38 INFO - Running setup.py install for mozInstall 16:40:38 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:40:38 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:40:38 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:40:38 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:40:38 INFO - Running setup.py install for mozleak 16:40:39 INFO - Running setup.py install for mozlog 16:40:39 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:40:39 INFO - Running setup.py install for moznetwork 16:40:39 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:40:39 INFO - Running setup.py install for mozprocess 16:40:39 INFO - Running setup.py install for mozprofile 16:40:39 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:40:39 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:40:39 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:40:39 INFO - Running setup.py install for mozrunner 16:40:39 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:40:39 INFO - Running setup.py install for mozscreenshot 16:40:40 INFO - Running setup.py install for moztest 16:40:40 INFO - Running setup.py install for mozversion 16:40:40 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:40:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:40:40 INFO - Cleaning up... 16:40:40 INFO - Return code: 0 16:40:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:40:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:40:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:40:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:40:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:40:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:40:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:40:40 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 0x10906ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109101618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa43da5970>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108fd0d30>, '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 0x108d35db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108fc8b20>, '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.iLmjzJt7Uf/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.HziM8vcF2H/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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 16:40:40 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 16:40:40 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 16:40:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iLmjzJt7Uf/Render', 16:40:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:40:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:40:40 INFO - 'HOME': '/Users/cltbld', 16:40:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:40:40 INFO - 'LOGNAME': 'cltbld', 16:40:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:40:40 INFO - 'MOZ_NO_REMOTE': '1', 16:40:40 INFO - 'NO_EM_RESTART': '1', 16:40:40 INFO - 'PAGER': '/bin/cat', 16:40:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:40:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:40:40 INFO - 'PWD': '/builds/slave/test', 16:40:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:40:40 INFO - 'SHELL': '/bin/bash', 16:40:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HziM8vcF2H/Listeners', 16:40:40 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 16:40:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:40:40 INFO - 'USER': 'cltbld', 16:40:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:40:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:40:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:40:40 INFO - 'XPC_FLAGS': '0x0', 16:40:40 INFO - 'XPC_SERVICE_NAME': '0', 16:40:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:40:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:40:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:40:40 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-3lDiTS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:40:40 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)) 16:40:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:40:40 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-t5xTdi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:40:40 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)) 16:40:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:40:40 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-w8xzey-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:40:40 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)) 16:40:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:40:40 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-f5TgLg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:40:41 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)) 16:40:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:40:41 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-xihnRq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:40:41 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)) 16:40:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:40:41 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-y4xgCo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:40:41 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)) 16:40:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:40:41 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-jIMbex-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:40:41 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)) 16:40:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:40:41 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-YZ7snh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:40:41 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)) 16:40:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:40:41 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-InLeMa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:40:41 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)) 16:40:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:40:41 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-fqalDC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:40:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 16:40:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:40:41 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-GcYcm7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:40:41 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)) 16:40:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:40:41 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-DI8Ity-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:40:41 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)) 16:40:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:40:41 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-ecPLux-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:40:42 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)) 16:40:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:40:42 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-wGacbd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:40:42 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)) 16:40:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:40:42 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-KxvLZW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:40:42 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)) 16:40:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:40:42 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-MPrVqV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:40:42 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)) 16:40:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:40:42 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-4nNM4M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:40:42 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)) 16:40:42 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)) 16:40:42 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)) 16:40:42 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)) 16:40:42 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)) 16:40:42 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)) 16:40:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:40:42 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 16:40:42 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 16:40:42 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 16:40:42 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 16:40:42 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 16:40:42 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 16:40:44 INFO - Downloading blessings-1.6.tar.gz 16:40:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:40:44 INFO - Installing collected packages: blessings 16:40:44 INFO - Running setup.py install for blessings 16:40:45 INFO - Successfully installed blessings 16:40:45 INFO - Cleaning up... 16:40:45 INFO - Return code: 0 16:40:45 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:40:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:40:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:40:45 INFO - Reading from file tmpfile_stdout 16:40:45 INFO - Current package versions: 16:40:45 INFO - blessings == 1.6 16:40:45 INFO - blobuploader == 1.2.4 16:40:45 INFO - docopt == 0.6.1 16:40:45 INFO - functools32 == 3.2.3-2 16:40:45 INFO - jsonschema == 2.5.1 16:40:45 INFO - manifestparser == 1.1 16:40:45 INFO - mozInstall == 1.12 16:40:45 INFO - mozcrash == 0.17 16:40:45 INFO - mozdebug == 0.1 16:40:45 INFO - mozdevice == 0.48 16:40:45 INFO - mozfile == 1.2 16:40:45 INFO - mozhttpd == 0.7 16:40:45 INFO - mozinfo == 0.9 16:40:45 INFO - mozleak == 0.1 16:40:45 INFO - mozlog == 3.3 16:40:45 INFO - moznetwork == 0.27 16:40:45 INFO - mozprocess == 0.23 16:40:45 INFO - mozprofile == 0.28 16:40:45 INFO - mozrunner == 6.12 16:40:45 INFO - mozscreenshot == 0.1 16:40:45 INFO - mozsystemmonitor == 0.3 16:40:45 INFO - moztest == 0.7 16:40:45 INFO - mozversion == 1.4 16:40:45 INFO - psutil == 3.1.1 16:40:45 INFO - requests == 1.2.3 16:40:45 INFO - wsgiref == 0.1.2 16:40:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:40:45 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')]} 16:40:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:40:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:40:46 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')]} 16:40:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:40:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:40:46 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 0x10906ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109101618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa43da5970>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108fd0d30>, '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 0x108d35db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108fc8b20>, '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.iLmjzJt7Uf/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.HziM8vcF2H/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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 16:40:46 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 16:40:46 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 16:40:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iLmjzJt7Uf/Render', 16:40:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:40:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:40:46 INFO - 'HOME': '/Users/cltbld', 16:40:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:40:46 INFO - 'LOGNAME': 'cltbld', 16:40:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:40:46 INFO - 'MOZ_NO_REMOTE': '1', 16:40:46 INFO - 'NO_EM_RESTART': '1', 16:40:46 INFO - 'PAGER': '/bin/cat', 16:40:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:40:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:40:46 INFO - 'PWD': '/builds/slave/test', 16:40:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:40:46 INFO - 'SHELL': '/bin/bash', 16:40:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HziM8vcF2H/Listeners', 16:40:46 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 16:40:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:40:46 INFO - 'USER': 'cltbld', 16:40:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:40:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:40:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:40:46 INFO - 'XPC_FLAGS': '0x0', 16:40:46 INFO - 'XPC_SERVICE_NAME': '0', 16:40:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:40:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:40:46 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)) 16:40:46 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)) 16:40:46 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)) 16:40:46 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)) 16:40:46 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)) 16:40:46 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)) 16:40:46 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)) 16:40:46 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)) 16:40:46 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)) 16:40:46 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)) 16:40:46 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)) 16:40:46 INFO - Cleaning up... 16:40:46 INFO - Return code: 0 16:40:46 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:40:46 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')]} 16:40:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:40:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:40:46 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')]} 16:40:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:40:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:40:46 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 0x10906ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109101618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa43da5970>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108fd0d30>, '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 0x108d35db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108fc8b20>, '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.iLmjzJt7Uf/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.HziM8vcF2H/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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 16:40:46 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 16:40:46 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 16:40:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iLmjzJt7Uf/Render', 16:40:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:40:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:40:46 INFO - 'HOME': '/Users/cltbld', 16:40:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:40:46 INFO - 'LOGNAME': 'cltbld', 16:40:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:40:46 INFO - 'MOZ_NO_REMOTE': '1', 16:40:46 INFO - 'NO_EM_RESTART': '1', 16:40:46 INFO - 'PAGER': '/bin/cat', 16:40:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:40:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:40:46 INFO - 'PWD': '/builds/slave/test', 16:40:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:40:46 INFO - 'SHELL': '/bin/bash', 16:40:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HziM8vcF2H/Listeners', 16:40:46 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 16:40:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:40:46 INFO - 'USER': 'cltbld', 16:40:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:40:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:40:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:40:46 INFO - 'XPC_FLAGS': '0x0', 16:40:46 INFO - 'XPC_SERVICE_NAME': '0', 16:40:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:40:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:40:46 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:40:46 INFO - Cleaning up... 16:40:46 INFO - Return code: 0 16:40:46 INFO - Running post-action listener: _resource_record_post_action 16:40:46 INFO - Running post-action listener: _start_resource_monitoring 16:40:46 INFO - Starting resource monitoring. 16:40:46 INFO - [mozharness: 2016-08-22 23:40:46.786291Z] Finished create-virtualenv step (success) 16:40:46 INFO - [mozharness: 2016-08-22 23:40:46.787324Z] Running install step. 16:40:46 INFO - Running pre-action listener: _resource_record_pre_action 16:40:46 INFO - Running main action method: install 16:40:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:40:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:40:47 INFO - Reading from file tmpfile_stdout 16:40:47 INFO - Detecting whether we're running mozinstall >=1.0... 16:40:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:40:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:40:47 INFO - Reading from file tmpfile_stdout 16:40:47 INFO - Output received: 16:40:47 INFO - Usage: mozinstall [options] installer 16:40:47 INFO - Options: 16:40:47 INFO - -h, --help show this help message and exit 16:40:47 INFO - -d DEST, --destination=DEST 16:40:47 INFO - Directory to install application into. [default: 16:40:47 INFO - "/builds/slave/test"] 16:40:47 INFO - --app=APP Application being installed. [default: firefox] 16:40:47 INFO - mkdir: /builds/slave/test/build/application 16:40:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 16:40:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 16:41:21 INFO - Reading from file tmpfile_stdout 16:41:21 INFO - Output received: 16:41:21 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 16:41:21 INFO - Running post-action listener: _resource_record_post_action 16:41:21 INFO - [mozharness: 2016-08-22 23:41:21.790515Z] Finished install step (success) 16:41:21 INFO - [mozharness: 2016-08-22 23:41:21.790662Z] Running run-tests step. 16:41:21 INFO - Running pre-action listener: _resource_record_pre_action 16:41:21 INFO - Running main action method: run_tests 16:41:21 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:41:21 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:41:21 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:41:21 INFO - 2016-08-22 16:41:21.805 screenresolution[1632:7585] starting screenresolution argv=screenresolution get 16:41:21 INFO - 2016-08-22 16:41:21.808 screenresolution[1632:7585] Display 0: 1600x1200x32@60 16:41:21 INFO - 2016-08-22 16:41:21.814 screenresolution[1633:7587] starting screenresolution argv=screenresolution list 16:41:21 INFO - Available Modes on Display 0 16:41:21 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:41:21 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:41:21 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:41:21 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:41:22 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:41:22 INFO - Intel Iris: 16:41:22 INFO - Chipset Model: Intel Iris 16:41:22 INFO - Type: GPU 16:41:22 INFO - Bus: Built-In 16:41:22 INFO - VRAM (Dynamic, Max): 1536 MB 16:41:22 INFO - Vendor: Intel (0x8086) 16:41:22 INFO - Device ID: 0x0a2e 16:41:22 INFO - Revision ID: 0x0009 16:41:22 INFO - Displays: 16:41:22 INFO - Display: 16:41:22 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:41:22 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:41:22 INFO - Display Serial Number: 1600x1200 60 16:41:22 INFO - Main Display: Yes 16:41:22 INFO - Mirror: Off 16:41:22 INFO - Online: Yes 16:41:22 INFO - Rotation: Supported 16:41:22 INFO - Return code: 0 16:41:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:41:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:41:22 INFO - Python 2.7.3 16:41:22 INFO - Return code: 0 16:41:22 INFO - grabbing minidump binary from tooltool 16:41:22 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')]} 16:41:22 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 0x108fd0d30>, '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 0x108d35db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108fc8b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:41:22 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 16:41:22 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 16:41:22 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 16:41:22 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:41:22 INFO - Return code: 0 16:41:22 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 16:41:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:41:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:41:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 16:41:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:41:22 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/dzq8yXiKSMqfiScuI7jkFA/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0112', '--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 16:41:22 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/dzq8yXiKSMqfiScuI7jkFA/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0112 --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 16:41:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iLmjzJt7Uf/Render', 16:41:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:41:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:41:22 INFO - 'HOME': '/Users/cltbld', 16:41:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:41:22 INFO - 'LOGNAME': 'cltbld', 16:41:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:41:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 16:41:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:41:22 INFO - 'MOZ_NO_REMOTE': '1', 16:41:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:41:22 INFO - 'NO_EM_RESTART': '1', 16:41:22 INFO - 'PAGER': '/bin/cat', 16:41:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:41:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:41:22 INFO - 'PWD': '/builds/slave/test', 16:41:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:41:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:41:22 INFO - 'SHELL': '/bin/bash', 16:41:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HziM8vcF2H/Listeners', 16:41:22 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 16:41:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:41:22 INFO - 'USER': 'cltbld', 16:41:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:41:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:41:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:41:22 INFO - 'XPC_FLAGS': '0x0', 16:41:22 INFO - 'XPC_SERVICE_NAME': '0', 16:41:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:41:22 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/dzq8yXiKSMqfiScuI7jkFA/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0112', '--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 16:41:22 INFO - mozversion application_buildid: 20160822152313 16:41:22 INFO - mozversion application_changeset: a22d1d1dbb3e7fd7a446c5bc6b6ce927eb4c62e7 16:41:22 INFO - mozversion application_display_name: Nightly 16:41:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:41:22 INFO - mozversion application_name: Firefox 16:41:22 INFO - mozversion application_remotingname: firefox 16:41:22 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 16:41:22 INFO - mozversion application_vendor: Mozilla 16:41:22 INFO - mozversion application_version: 51.0a1 16:41:22 INFO - mozversion platform_buildid: 20160822152313 16:41:22 INFO - mozversion platform_changeset: a22d1d1dbb3e7fd7a446c5bc6b6ce927eb4c62e7 16:41:22 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 16:41:22 INFO - mozversion platform_version: 51.0a1 16:41:22 INFO - using testdate: 1471909282 16:41:22 INFO - actual date: 1471909282 16:41:22 INFO - starting webserver on 'localhost:49277' 16:41:22 INFO - SUITE-START | Running 2 tests 16:41:22 INFO - TEST-START | dromaeo_css 16:41:22 INFO - operating with platform_type : mac_ 16:41:22 INFO - Initialising browser for dromaeo_css test... 16:41:22 INFO - TEST-INFO | started process 1643 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/tmpKWaDQv/profile http://localhost:49277/getInfo.html) 16:41:24 INFO - PROCESS | 1643 | __metrics Screen width/height:1600/1200 16:41:24 INFO - PROCESS | 1643 | colorDepth:24 16:41:24 INFO - PROCESS | 1643 | Browser inner width/height: 1024/689 16:41:24 INFO - PROCESS | 1643 | __metrics 16:41:24 INFO - PROCESS | 1643 | 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" 16:41:24 INFO - PROCESS | 1643 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:41:25 INFO - TEST-INFO | 1643: exit 0 16:41:25 INFO - Browser initialized. 16:41:25 INFO - Running cycle 1/1 for dromaeo_css test... 16:41:25 INFO - TEST-INFO | started process 1645 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/tmpKWaDQv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:41:37 INFO - PROCESS | 1645 | RSS: Main: 228614144 16:41:37 INFO - PROCESS | 1645 | 16:42:28 INFO - PROCESS | 1645 | 1471909348793 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] 16:44:41 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49277/tests/dromaeo/cssquery-ext.html) 16:44:42 INFO - PROCESS | 1645 | RSS: Main: 342593536 16:44:42 INFO - PROCESS | 1645 | 16:47:45 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-ext.html (next: http://localhost:49277/tests/dromaeo/cssquery-jquery.html) 16:47:46 INFO - PROCESS | 1645 | RSS: Main: 371851264 16:47:46 INFO - PROCESS | 1645 | 16:50:48 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49277/tests/dromaeo/cssquery-mootools.html) 16:50:49 INFO - PROCESS | 1645 | RSS: Main: 359624704 16:50:49 INFO - PROCESS | 1645 | 16:53:51 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49277/tests/dromaeo/cssquery-prototype.html) 16:53:52 INFO - PROCESS | 1645 | RSS: Main: 330862592 16:53:52 INFO - PROCESS | 1645 | 16:56:55 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49277/tests/dromaeo/cssquery-yui.html) 16:56:56 INFO - PROCESS | 1645 | RSS: Main: 327045120 16:56:56 INFO - PROCESS | 1645 | 16:59:59 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-yui.html (next: http://localhost:49277/tests/dromaeo/cssquery-dojo.html) 16:59:59 INFO - PROCESS | 1645 | RSS: Main: 571731968 16:59:59 INFO - PROCESS | 1645 | 16:59:59 INFO - PROCESS | 1645 | __start_tp_report 16:59:59 INFO - PROCESS | 1645 | _x_x_mozilla_page_load 16:59:59 INFO - PROCESS | 1645 | _x_x_mozilla_page_load_details 16:59:59 INFO - PROCESS | 1645 | |i|pagename|runs| 16:59:59 INFO - PROCESS | 1645 | |0;dojo.html;3349.5143204235387;3391.9660803391967;3394.5926488821315;3414.248865249644;3422.6919577238045;5631;5703.629264097841;5744.454276843703;5873.7650493980245;5889.941100588992;5646;5728.112142617891;5805.042168042268;5831;5916.437938395857;5147.459516750743;5177.145770947808;5217.973910130444;5222.268882356473;5230.34620672416;5244.527992480676;5257.815976440826;5278.47215278471;5281.075811732951;5286.709230992294;5116.872078198075;5184.429712731597;5213.765380557884;5250.474952504738;5298.867528311785;4408.228560002019;5129.871753206163;5194.402643695986;5236.528712415901;5246.921296180561;5198.714070726146;5214.113600687892;5241.68549887008;5265.157574788015;5272.1300985337375;5836.9124463133085;5857.7949771757785;5873.001589729756;5877.794277200277;5893.58744887858;6118.877622447526;6192.318844927055;6220.657863817488;6247.219097612799;6268.937310626881;5624.859378515529;5897.849919265745;6192;6222.657753823538;6251.437370636619;5748.31020277561;5896.204012458306;5909.940900591025;5915.142304365886;5917.112433134978;6159.384061593805;6191.040388739752;6221.09794079865;6243.37566243372;6249;6159.692015399212;6205.565610407319;6229.813105606839;6230.7819226326865;6235.594686345464;6157.384261573897;6285.654289014148;6287;6292.4966002719675;6301.558890877594;6193.349698281616;6250.624962502265;6259.874802504016;6292.46514046302;6294.370562943669;5188.844334669966;6268.028455589391;6268.874622507525;6272.8118156455375;6289.811305660837;4869.366982292279;5038.470960549163;5066.670666406745;5068.797248110034;5073.594112471067;4403.779811009501;4430.579094985971;4451.933221001687;4477.97006688457;4521.367008618796;5806.535477161817;5809.651420914759;5809.941900581025;5826.1552074948895;5836.708164591839;6152.384761523812;6184;6194.5044396448175;6228.190335256388;6242.656653883989;5633.549316054706;5707.971460142756;5766.279215098113;5822.184894114827;5834.620749651259;4823.831165909176;5388.488093631177;5463.699496527729;5471.960327537835;5475.863103422446;6143.262808463013;6181.041938499539;6266.373362663697;6270.184875966095;6276.905846412307;6177.907331390123;6235.906461403173;6243.906341404791;6249.843753906189;6261.342559031236;6256.217972753406;6260.092286618506;6272.968635156795;6276.089966954674;6293.779717709858;6030.60801047948;6175.722092505938;6196.070589411444;6218.657973811484;6234.2830574482705;6052.092186172109;6169.290531588925;6197.4732147767945;6219.844503887439;6235.719392627252;6191.721372538156;6197.845053873689;6222.346653601488;6226.968865155645;6237.937620623736;5948.940510595012;6195.380461953769;6209.937900621117;6212.316645169119;6221.191245138103;5148.253503241934;5949.970250148722;5991.820245392645;6029.125776762433;6122.142899994094;6222.377762223741;6225.128482012431;6226.159468471698;6231.158793562811;6253.437190652863;5825.543614096476;5857.58996870215;6030.3668114847305;6082.2093127893095;6114.969425152845 16:59:59 INFO - PROCESS | 1645 | |1;ext.html;485.66974457368974;509.3861896414823;516.7338820507438;522.7725939216439;533.6451259912159;30505;32061.19847003826;39541.406878896836;40647.79676101623;40772;42011;42343;42396.78801605988;42404.57595424045;42520.362194567104;9811.705648830528;9946.452945088018;9955.651552195675;9960.302778805486;9962.153216976565;8776.99064607572;8992.820143597124;8992.820143597124;9008.099190081006;9019.549022548847;11976.041916646647;12201;12229.449674764657;12388.876111238862;12414.379281035957;11984.280943143396;12079.577214797528;12097.758044839054;12099.153059285854;12118.697032574211;11999.460024298927;12037.398130093461;12040.458179381949;12044.457999390048;12069.456874440672;39923;40192.59807401947;40219.1956160878;40240;40295.19409611791;3369.7809642373168;3431.9828400857837;3445.586529616462;3578.8389522471552;3770.622937706235;29824.850875745484;30367.937122200838;31088.844555777076;31097;31367.529487057713;3262.1192278084786;3269.1336795749144;3289.687479689426;3386.0519054664733;3437.5187473753695;508352;510455;511921;512164;516553.4172329152;29058;32892;57280;57536.2326085973;57537.712311438176;34963.300733985176;35138.29723405518;35144;35155;35157;14481.710365792625;14663.853361466463;14682.853171468363;14689.192094434695;14696.779548306784;12420.00639948802;12527.498900044078;12534.185277956904;12542.937285313516;12551.3096779678;6659.86680266392;7338.321512647952;7370.48406611532;7549.962250188714;7745.922540774633;3201.0716892101495;3247.399231142246;3257.1368587324378;3269.8692052318115;3288.342331533655;924.8335299646128;1001.884783249921;1023.9913685020249;1074.011909043666;1077.590515604081;29660.555091673643;29869.55195672067;30240.69759302379;30642.233944151576;30729.078127656205;896.1576118448637;977.0766625538939;1009.7778488732467;1092.6940456672144;1116.564539829467;13176.879965202874;13661.726765464833;14264.144151350953;14453.710925781426;15404.998675086084;686839;691188;691252;691713;692203;47576.334828280844;48147.518524815;54821;55311;55969.440305597236;1376.662717634186;1389.1317926296065;1417.1709549913417;1422;1423.3737155651481;27368;28402.005929792358;29839.806407744316;30707.692923071376;30958.22604434907;54911.90176196374;55788.72105639446;55824.16263755965;55848.883022338516;56178.719106404205;614719;883003;895140;899807;901611;38633;41191.382129268684;41444.58555414528;41490.58509414867;41911;42814.92962675958;45766.448535991185;45957.540424595325;46268.768656156506;46740;38243.235135296585;38259.80870095632;38486;39044;39926.80036599799;31801.8409907949;33371.49942750812;38069.04827379338;38118.618813812616;38923.41614875723;37200.25599487941;37362.8131859339;37961.81019094887;37979.43030854484;38019;32151.51772723458;32736.774000896025;33354.99935001954;33524.83237583796;33674.326513470085;24603;24684.629730554414;25074.498510030062;25305.87347063253;25325.98696052211 16:59:59 INFO - PROCESS | 1645 | |2;jquery.html;319.16856588586734;336.940322685155;366.1541838353406;380.5832613288449;404.14321638127177;14641.560753177408;15183.772243416357;17613.911930440347;18546;21278.680819787714;21026.158953641876;21092.367228983116;21532.354029379105;21756.45608859779;21934;5936.970315148418;6152.107944348067;6211.440970312671;6240.781572644958;6246.718897649616;5522.6134170608075;5902.527797776189;5914.792982245623;6113.266408031021;6190.752369905198;6116.357782432848;6117.69411529424;6128.785492507763;6137.294211165706;6139.87720245597;5169.2504586835075;5690;6085.2393450818645;6088.391160883921;6149.815505534841;5817.912731308991;5902.675352855591;5918.7928422505;5925.4963328117165;5931.584789064767;13204.293119910491;13481.74336848835;13615;13616.591502254949;13636.522721704692;2154.53677459347;2267.3764714703425;2306.3888069661552;2471.3698007008097;2698.0961377938415;9980.650677226262;10086.949565252127;10264.79470410595;10387.961203879628;10407.947960260226;1818.4271954334342;1897.8386837118862;1913.206019501905;1928.421473557941;1981.37586660203;95333.98993105763;101970.47044294342;116319.67360652825;129185.35407322997;136743;11289.887101129048;11337.603183888525;11348.829767553494;11384.772304553862;11760.294382337088;14390.928045359706;14398.352074156688;14402.783958240634;14404.495842645458;14447.85552144486;8248.381371397169;8541.957290213633;8559.74320770378;8638;8638.654453821902;8464.32285417165;8478.448900821428;8479.448835825651;8623;8645.221930026202;3796.430535419654;4473.4408198975125;4483.865484035484;4498.347739577743;4572;1666.7249903765985;1897.5161333859778;1899.5441094137584;1901.9049047547567;1937.6609093408879;675.2133764164792;705.7575211848942;836.1638361638362;938.8826396700413;946.9668561600449;21352.893235533724;21457.872200098893;22093.37138979253;22257;22341.888290558443;904.8597467392565;922.197688011421;936.0966667166217;971.0532231074787;1008.742770593494;9811.313228019775;11447.771044579229;11580.826287605692;11610.361430121424;11692.824607630891;510090;611914;624992;625945;627383;142042;143843;145208;149623;151240.48759512263;939.7509659940122;955.7132860141929;997.4663554998041;1005.6932635546083;1016.202281209262;18159.727604085685;19383.224671013002;19556.706649399985;19677.622566420785;19755.901220493804;55878.44121558732;56065.719671401384;56986.575335616944;57424;57972.710136449045;85200.57399712961;86705;86767;86859.1314086851;87170.1282987162;7998.440109192301;8020.197980201933;8022.1977802221645;8338.583070846313;8457;9367.156955874005;12512.562060327844;13005.934970325088;13417.932910335387;13645.249511276976;11251.718707032389;11296.830547541958;11629.127815413709;11645.41772911368;11719.296842189497;11316.20786544934;11391.658250252505;11452.713682157679;11543.422828858356;11762.529683789526;11350;11380.43097845121;11776.88223117792;11799.76400472003;11810.114241431755;7963.601819909098;8089.716859909875;8128.715494957648;8225.300849427866;8345.374096942633;8165;9910.653127140515;10197.18422526211;10459.477026148814;11599.478023488795 16:59:59 INFO - PROCESS | 1645 | |3;mootools.html;1502.6093215763901;1539.684364705235;1702.3105642214907;1834.0279651784542;1867.8599105067124;8581.570921453926;9130.954345228265;9156.2217211537;9156.2217211537;9160.175584197437;7964.641591128398;8181.100078991321;8636.30909527238;8844.115588441153;8881.91118088819;2368.6683864258976;2396.2332053742807;2408.1451084864884;2410.1564452441594;2416.1543459789023;2366.0417530900013;2384.4515761374896;2417.2748175547354;2418.903243870243;2420.8668523231217;2378.7383387827326;2406.446517301013;2408.590539608271;2410.554047501209;2416.504616553611;2073.3676228750223;2364.6334818103223;2366.1127077345996;2372.1697405907967;2372.6203807390907;2370.0401337458356;2382.797462215714;2388.1283331584023;2389.6654468374268;2390.581648211556;8956.8656470153;9014.323925705532;9123.270138388913;9140.542972851397;9146.954265228698;5284.920726189111;5454.072807622713;5464.12573988164;5466.453354664502;5479.780808767645;3544.2734239480847;3616.981915090434;3693.9630603693886;3701.8889433316776;3771.8114094295174;1108.5177947592822;1117.6255954255334;1118.3960661242918;1134.4157758754247;1146.140394703972;11772.941135294355;11806;11885.584004559885;11886.940565297118;11920.582779602759;4355.673324500675;4466.709663871903;4648.047150334173;4664.533546645308;4669.066186762661;9154.908450915405;9171.174594286545;9177.862332064891;9178.495182765013;9188.310876684276;5246.265522826808;5248.921266181011;5255.0540902637895;5255.106631872591;5274.92087618686;4414.404055452473;4637.536246375335;4754.881127971759;4915.459299477055;4919.852404427873;3752.81235938202;3817.709374375408;3899.53205615328;3959.92080158401;3999.4800675911947;1022.3661329975314;1175.1304035014027;1184.8104303311602;1194.3908606610516;1199.2564609941717;780.7033327335577;912.466207268742;935.8034812689275;945.4258659332272;976.6435251133286;5875.059990401515;6160.557854436776;6188.81433556994;6249.812505624838;6340.705938563864;930.2046750028763;960.841461158915;965.7489052846311;969.8011907558933;1017.3387298256044;3987.5445462406014;4087.5094988600963;4090.570490098556;4144.854930077433;4192.790360481964;10761.192910531741;11032.944835275934;11125.109991200685;11126.443677816238;11132.49903754333;10424.270301078852;10922.508487118099;11070.612528561462;11082.889171108347;11107.222494425312;8078.55567943757;8312.21034001769;8318.62566184511;8325.375596830261;8332.541710205996;5917.142014407801;5938.168656388023;5992.64044157352;6157.692115394123;6356.491480681627;9949.154321882721;10191.184705223415;10235.48822558884;10245.948770256102;10277.794444110927;10467.371957682564;10467.685969420929;10482.842757358798;10493.003164699341;10512.0013598708;6202.782902598387;6853.554518956451;7310.488265821554;7657.57883316423;7814.921850781647;8634.438761480484;8692.608832602422;8745.344099192458;8761.342899282452;8765.780855478664;7575.166731659623;7686.231376862269;7698.538087714755;7755.146933837161;7835.177306382748;7214.71141154369;7359.153697324876;7410.147832999274;7478.214787447239;7547.660355284135;7056.929430705833;7249.093863267091;7249.311315425026;7260.310270524292;7268.127824661075;4134.813933372945;4938.407391113089;5054.671446355975;5097.541221290102;5194.402643696023;4978.800847966041;5044.612731498867;5088.033273677989;5277.2875661785165;5343.412224655207 16:59:59 INFO - PROCESS | 1645 | |4;prototype.html;301.35810723159665;307.8122345369324;311.34461957579293;314.99370012599746;318.9378071276102;4691.247002398085;5194.896067092824;5324.7071411072375;5414.485623865731;5473.67157970522;5327.627066105374;5391.460853914607;5411.053065713494;5412.485813847678;5426.701531415771;3588.4796704477835;3818.9497888080723;3846.942295865564;3988.820503077354;4025.2352053109817;3169.904902852918;3558.953601679032;4003.639672429481;4028.8187031583648;4111.506619205685;3711.517502724642;4015.2371049500503;4034.9798251008706;4045;4087.7547347159116;3869.729118961674;4018.6985976051915;4071.531773846016;4077.347624380085;4084.8570300039505;3114.76639252057;3530.5586801649793;3544.6530318478813;3552.662497062775;3573.803440810754;4365.388845561624;5185.611079169077;5256.9474305256845;5282.683039017671;5290.994711004897;4241.36379543068;4645.558671926162;4680.134175177603;4688.859334219945;4700.694454860423;4760.143174228638;4967.857392799677;5593.804216852432;5636.267285252932;5748.166515855178;3449.448088305884;3453.963810856758;3736.252749450121;3874.1089549403796;3884.8057597120032;4932.926006109911;4934.950650493485;5090.116656836957;5914.746889210916;5932.406759324076;3811.599782022903;3855.9396166054557;3865.5168103987003;3867.5165604299464;3883.7377852198147;3923.2938071146896;3933.6263055009726;3941.684665226775;3949.7827619481204;3961.3661814109605;3851.67260782831;4300.913981720348;4593.54064593538;4618.321373603302;4625.5836974671765;4543.274514897818;4834.679353910073;5625.521830644441;5642.971785141131;5645.830625081254;1291.7803973324558;1324.4635922451423;1341.6981179234594;1357.592722183341;1361.6868120332379;729.7594090046836;759.6353750199825;772.6909236305522;827.3287958324152;833.8576150673495;4030.979845100756;4925.458199598042;5068.6451948364;5078.5937125029905;5279.656822306614;5546.528545073714;5746.586433697857;5806.5645076618575;5821.621594596338;5825.893080314727;4789.832355867528;5020.59835213182;5299.5886871473385;5319.521243088141;5321.281626980385;2786.4148528808773;3018.758499320049;3024.682408347092;3029.863801074597;3038.893638722634;5363.383210930715;6026.156338112668;6055.548337447701;6063.969680151659;6066.028540724282;5617.550595952314;5903.940960590425;6016.308124565731;6031.8793624127275;6111.633302001894;5360.839174824761;5833.329167145833;6016;6043.758249670052;6133.3866613339205;4961.6030717543235;5632.324121105494;5635.915461268002;5882.352941176553;5892.823215303548;5001.324821149098;5743.6840973745175;5752.511036561939;5764.567657425626;5831.912521312269;4788.712677239377;6017.509844290214;6101.481374083252;6104.481119104926;6113.786017489544;3361.9495707564897;3673.7612055216327;3841.4621952926054;3986.581408952018;4051.6961227907436;5750.827475175752;5772;5774.364819869895;5803.564732644984;5807.883842323215;5360.812371566976;5549.472800083986;5649.322081350264;5669.007923613269;5683.9715801420725;4484.775761211861;5500.4499550044675;5557.499825015768;5583.297094386089;5602.52378547828;5435.565154787687;5445.673259604437;5449.918251226314;5481.779879148951;5491.395946445808;4708.92936605958;5241.61097309221;5378.97310513445;5599.440055994368;5658.943410565842;5053.469385714594;5478.165284301085;5554.777808887599;5599.384067752462;5613.214150018919 16:59:59 INFO - PROCESS | 1645 | |5;yui.html;709.7515869445693;760.2283682062707;769.2230846844685;797.2306724011328;861.8017855893146;15383.307751151196;15964.441244556443;16588;16609.667806643858;16953.406630767924;14848.628784280398;15279.923600381982;15336.61658458539;15338.233088345565;15402;680.799164246546;700.0199720391441;841.3899922556144;862.469581207556;864.2481041493878;835.7409203147014;861.7027125641644;868.4572142410993;870.6604424274537;873.5501216873315;914.4284821986258;916.3493919317293;916.4134953629682;916.6104405627615;917.9862302065475;708.9964550177216;732.6190381001902;912.8311262416474;914.8719179314901;917.6788124156559;535.8419266316446;659.0904551718597;660.7951535024158;662.2483481248769;665.6339013542532;14984.47554335593;15051.172185529791;15067.547973560811;15071.246437678183;15089.170095644735;14034.789478157836;14150.787738183935;14214.573562793134;14246.786298205536;14654.487092951695;11245.325280483197;13309.600711978655;13377.464901403931;13425.932870335586;13745.587632371045;4540.500544940054;4565.543445655408;4764.356811830393;4870.561649451531;4871.853844384674;116347;118668.81331186664;118697;118735;118924;11029.172812039129;11274.379909104913;11355;11525.308481491138;11679.240849344766;22841.428964275692;22841.972111255032;22847.543049138923;22902;22907.876582215362;7980.561069141253;8081.191880811872;8133.593320334078;8273.131321211307;8300.792480188044;4328.480582330078;4416.0197952627295;4426.070525189682;4579.7252164870215;4619.699719518288;3551.4317709166407;3661.0847288177956;3671.6328367163605;3675.1730860556163;3690.7970061646865;648.18652590998;658.3613894522306;669.1602039440568;676.9153855768029;680.210955291859;599.6462087368386;602.8312072619674;614.7295190116334;634.3909846547274;651.3909494622543;7685.23147685227;9135.360524763335;9194.172524472695;9230.169284764403;9407.247420206368;511.91553393690367;563.7153237614979;616.1404840247918;624.497279689854;652.116382301974;4390.824367025283;4432.867013989586;4475.820967161277;4544.068465964469;4595.9080818383445;94424;95141.52429237809;95653;141369.29315353357;164394;81635;127103.72896271104;140665;141810;144829.27585362006;101485.49257253815;103650;124546.37726811308;125125.49749004969;127284.36357818337;9436.575354108943;9802.901970980483;9922.255830812863;9938.602455901972;10152.593896244067;63408.68295658492;64064.71870562469;64687;65128;65221.673891632134;67198.99201512079;87081;98143.50928245598;99348;101475;11289.153313501356;11593.710157246136;11898.22661526998;11941.880581194424;14129.788053179005;13095.148815326973;13109.868901310865;13366;13561.254131022888;13572.86427135716;12070.27578345302;12445.564405245774;14221.857781422053;14410.927945360207;14984.400623975354;13296.078812238226;14057.437702491785;14313.499027533986;14466.782998255245;14679.779803302745;13928.442862285801;14092.154470731788;14136.575902722934;14423.711525769635;14454.638634033812;11177.217594768614;11549.769004620028;11566.537338506701;11637.592684256011;11784.469698863742;9987.300888937705;10230.846537301797;10323.81276153252;11507.367094809866;11913.880861191277 16:59:59 INFO - PROCESS | 1645 | __end_tp_report 16:59:59 INFO - PROCESS | 1645 | __start_cc_report 16:59:59 INFO - PROCESS | 1645 | _x_x_mozilla_cycle_collect,1252 16:59:59 INFO - PROCESS | 1645 | __end_cc_report 16:59:59 INFO - PROCESS | 1645 | __startTimestamp1471910399972__endTimestamp 16:59:59 INFO - PROCESS | 1645 | 16:59:59 INFO - PROCESS | 1645 | ------- Summary: start ------- 16:59:59 INFO - PROCESS | 1645 | Number of tests: 6 16:59:59 INFO - PROCESS | 1645 | 16:59:59 INFO - PROCESS | 1645 | [#0] dojo.html Cycles:165 Average:5757.59 Median:5949.97 stddev:641.34 (10.8%) stddev-sans-first:614.85 16:59:59 INFO - PROCESS | 1645 | Values: 3349.5 3392.0 3394.6 3414.2 3422.7 5631.0 5703.6 5744.5 5873.8 5889.9 5646.0 5728.1 5805.0 5831.0 5916.4 5147.5 5177.1 5218.0 5222.3 5230.3 5244.5 5257.8 5278.5 5281.1 5286.7 5116.9 5184.4 5213.8 5250.5 5298.9 4408.2 5129.9 5194.4 5236.5 5246.9 5198.7 5214.1 5241.7 5265.2 5272.1 5836.9 5857.8 5873.0 5877.8 5893.6 6118.9 6192.3 6220.7 6247.2 6268.9 5624.9 5897.8 6192.0 6222.7 6251.4 5748.3 5896.2 5909.9 5915.1 5917.1 6159.4 6191.0 6221.1 6243.4 6249.0 6159.7 6205.6 6229.8 6230.8 6235.6 6157.4 6285.7 6287.0 6292.5 6301.6 6193.3 6250.6 6259.9 6292.5 6294.4 5188.8 6268.0 6268.9 6272.8 6289.8 4869.4 5038.5 5066.7 5068.8 5073.6 4403.8 4430.6 4451.9 4478.0 4521.4 5806.5 5809.7 5809.9 5826.2 5836.7 6152.4 6184.0 6194.5 6228.2 6242.7 5633.5 5708.0 5766.3 5822.2 5834.6 4823.8 5388.5 5463.7 5472.0 5475.9 6143.3 6181.0 6266.4 6270.2 6276.9 6177.9 6235.9 6243.9 6249.8 6261.3 6256.2 6260.1 6273.0 6276.1 6293.8 6030.6 6175.7 6196.1 6218.7 6234.3 6052.1 6169.3 6197.5 6219.8 6235.7 6191.7 6197.8 6222.3 6227.0 6237.9 5948.9 6195.4 6209.9 6212.3 6221.2 5148.3 5950.0 5991.8 6029.1 6122.1 6222.4 6225.1 6226.2 6231.2 6253.4 5825.5 5857.6 6030.4 6082.2 6115.0 16:59:59 INFO - PROCESS | 1645 | 16:59:59 INFO - PROCESS | 1645 | [#1] ext.html Cycles:180 Average:78226.33 Median:19367.92 stddev:187824.88 (969.8%) stddev-sans-first:188261.09 16:59:59 INFO - PROCESS | 1645 | Values: 485.7 509.4 516.7 522.8 533.6 30505.0 32061.2 39541.4 40647.8 40772.0 42011.0 42343.0 42396.8 42404.6 42520.4 9811.7 9946.5 9955.7 9960.3 9962.2 8777.0 8992.8 8992.8 9008.1 9019.5 11976.0 12201.0 12229.4 12388.9 12414.4 11984.3 12079.6 12097.8 12099.2 12118.7 11999.5 12037.4 12040.5 12044.5 12069.5 39923.0 40192.6 40219.2 40240.0 40295.2 3369.8 3432.0 3445.6 3578.8 3770.6 29824.9 30367.9 31088.8 31097.0 31367.5 3262.1 3269.1 3289.7 3386.1 3437.5 508352.0 510455.0 511921.0 512164.0 516553.4 29058.0 32892.0 57280.0 57536.2 57537.7 34963.3 35138.3 35144.0 35155.0 35157.0 14481.7 14663.9 14682.9 14689.2 14696.8 12420.0 12527.5 12534.2 12542.9 12551.3 6659.9 7338.3 7370.5 7550.0 7745.9 3201.1 3247.4 3257.1 3269.9 3288.3 924.8 1001.9 1024.0 1074.0 1077.6 29660.6 29869.6 30240.7 30642.2 30729.1 896.2 977.1 1009.8 1092.7 1116.6 13176.9 13661.7 14264.1 14453.7 15405.0 686839.0 691188.0 691252.0 691713.0 692203.0 47576.3 48147.5 54821.0 55311.0 55969.4 1376.7 1389.1 1417.2 1422.0 1423.4 27368.0 28402.0 29839.8 30707.7 30958.2 54911.9 55788.7 55824.2 55848.9 56178.7 614719.0 883003.0 895140.0 899807.0 901611.0 38633.0 41191.4 41444.6 41490.6 41911.0 42814.9 45766.4 45957.5 46268.8 46740.0 38243.2 38259.8 38486.0 39044.0 39926.8 31801.8 33371.5 38069.0 38118.6 38923.4 37200.3 37362.8 37961.8 37979.4 38019.0 32151.5 32736.8 33355.0 33524.8 33674.3 24603.0 24684.6 25074.5 25305.9 25326.0 16:59:59 INFO - PROCESS | 1645 | 16:59:59 INFO - PROCESS | 1645 | [#2] jquery.html Cycles:180 Average:35576.06 Median:2584.73 stddev:101103.39 (3911.6%) stddev-sans-first:101352.35 16:59:59 INFO - PROCESS | 1645 | Values: 319.2 336.9 366.2 380.6 404.1 14641.6 15183.8 17613.9 18546.0 21278.7 21026.2 21092.4 21532.4 21756.5 21934.0 5937.0 6152.1 6211.4 6240.8 6246.7 5522.6 5902.5 5914.8 6113.3 6190.8 6116.4 6117.7 6128.8 6137.3 6139.9 5169.3 5690.0 6085.2 6088.4 6149.8 5817.9 5902.7 5918.8 5925.5 5931.6 13204.3 13481.7 13615.0 13616.6 13636.5 2154.5 2267.4 2306.4 2471.4 2698.1 9980.7 10086.9 10264.8 10388.0 10407.9 1818.4 1897.8 1913.2 1928.4 1981.4 95334.0 101970.5 116319.7 129185.4 136743.0 11289.9 11337.6 11348.8 11384.8 11760.3 14390.9 14398.4 14402.8 14404.5 14447.9 8248.4 8542.0 8559.7 8638.0 8638.7 8464.3 8478.4 8479.4 8623.0 8645.2 3796.4 4473.4 4483.9 4498.3 4572.0 1666.7 1897.5 1899.5 1901.9 1937.7 675.2 705.8 836.2 938.9 947.0 21352.9 21457.9 22093.4 22257.0 22341.9 904.9 922.2 936.1 971.1 1008.7 9811.3 11447.8 11580.8 11610.4 11692.8 510090.0 611914.0 624992.0 625945.0 627383.0 142042.0 143843.0 145208.0 149623.0 151240.5 939.8 955.7 997.5 1005.7 1016.2 18159.7 19383.2 19556.7 19677.6 19755.9 55878.4 56065.7 56986.6 57424.0 57972.7 85200.6 86705.0 86767.0 86859.1 87170.1 7998.4 8020.2 8022.2 8338.6 8457.0 9367.2 12512.6 13005.9 13417.9 13645.2 11251.7 11296.8 11629.1 11645.4 11719.3 11316.2 11391.7 11452.7 11543.4 11762.5 11350.0 11380.4 11776.9 11799.8 11810.1 7963.6 8089.7 8128.7 8225.3 8345.4 8165.0 9910.7 10197.2 10459.5 11599.5 16:59:59 INFO - PROCESS | 1645 | 16:59:59 INFO - PROCESS | 1645 | [#3] mootools.html Cycles:180 Average:5788.79 Median:4929.13 stddev:3253.01 (66.0%) stddev-sans-first:3246.19 16:59:59 INFO - PROCESS | 1645 | Values: 1502.6 1539.7 1702.3 1834.0 1867.9 8581.6 9131.0 9156.2 9156.2 9160.2 7964.6 8181.1 8636.3 8844.1 8881.9 2368.7 2396.2 2408.1 2410.2 2416.2 2366.0 2384.5 2417.3 2418.9 2420.9 2378.7 2406.4 2408.6 2410.6 2416.5 2073.4 2364.6 2366.1 2372.2 2372.6 2370.0 2382.8 2388.1 2389.7 2390.6 8956.9 9014.3 9123.3 9140.5 9147.0 5284.9 5454.1 5464.1 5466.5 5479.8 3544.3 3617.0 3694.0 3701.9 3771.8 1108.5 1117.6 1118.4 1134.4 1146.1 11772.9 11806.0 11885.6 11886.9 11920.6 4355.7 4466.7 4648.0 4664.5 4669.1 9154.9 9171.2 9177.9 9178.5 9188.3 5246.3 5248.9 5255.1 5255.1 5274.9 4414.4 4637.5 4754.9 4915.5 4919.9 3752.8 3817.7 3899.5 3959.9 3999.5 1022.4 1175.1 1184.8 1194.4 1199.3 780.7 912.5 935.8 945.4 976.6 5875.1 6160.6 6188.8 6249.8 6340.7 930.2 960.8 965.7 969.8 1017.3 3987.5 4087.5 4090.6 4144.9 4192.8 10761.2 11032.9 11125.1 11126.4 11132.5 10424.3 10922.5 11070.6 11082.9 11107.2 8078.6 8312.2 8318.6 8325.4 8332.5 5917.1 5938.2 5992.6 6157.7 6356.5 9949.2 10191.2 10235.5 10245.9 10277.8 10467.4 10467.7 10482.8 10493.0 10512.0 6202.8 6853.6 7310.5 7657.6 7814.9 8634.4 8692.6 8745.3 8761.3 8765.8 7575.2 7686.2 7698.5 7755.1 7835.2 7214.7 7359.2 7410.1 7478.2 7547.7 7056.9 7249.1 7249.3 7260.3 7268.1 4134.8 4938.4 5054.7 5097.5 5194.4 4978.8 5044.6 5088.0 5277.3 5343.4 16:59:59 INFO - PROCESS | 1645 | 16:59:59 INFO - PROCESS | 1645 | [#4] prototype.html Cycles:180 Average:4552.93 Median:5137.86 stddev:1423.72 (27.7%) stddev-sans-first:1391.49 16:59:59 INFO - PROCESS | 1645 | Values: 301.4 307.8 311.3 315.0 318.9 4691.2 5194.9 5324.7 5414.5 5473.7 5327.6 5391.5 5411.1 5412.5 5426.7 3588.5 3818.9 3846.9 3988.8 4025.2 3169.9 3559.0 4003.6 4028.8 4111.5 3711.5 4015.2 4035.0 4045.0 4087.8 3869.7 4018.7 4071.5 4077.3 4084.9 3114.8 3530.6 3544.7 3552.7 3573.8 4365.4 5185.6 5256.9 5282.7 5291.0 4241.4 4645.6 4680.1 4688.9 4700.7 4760.1 4967.9 5593.8 5636.3 5748.2 3449.4 3454.0 3736.3 3874.1 3884.8 4932.9 4935.0 5090.1 5914.7 5932.4 3811.6 3855.9 3865.5 3867.5 3883.7 3923.3 3933.6 3941.7 3949.8 3961.4 3851.7 4300.9 4593.5 4618.3 4625.6 4543.3 4834.7 5625.5 5643.0 5645.8 1291.8 1324.5 1341.7 1357.6 1361.7 729.8 759.6 772.7 827.3 833.9 4031.0 4925.5 5068.6 5078.6 5279.7 5546.5 5746.6 5806.6 5821.6 5825.9 4789.8 5020.6 5299.6 5319.5 5321.3 2786.4 3018.8 3024.7 3029.9 3038.9 5363.4 6026.2 6055.5 6064.0 6066.0 5617.6 5903.9 6016.3 6031.9 6111.6 5360.8 5833.3 6016.0 6043.8 6133.4 4961.6 5632.3 5635.9 5882.4 5892.8 5001.3 5743.7 5752.5 5764.6 5831.9 4788.7 6017.5 6101.5 6104.5 6113.8 3361.9 3673.8 3841.5 3986.6 4051.7 5750.8 5772.0 5774.4 5803.6 5807.9 5360.8 5549.5 5649.3 5669.0 5684.0 4484.8 5500.4 5557.5 5583.3 5602.5 5435.6 5445.7 5449.9 5481.8 5491.4 4708.9 5241.6 5379.0 5599.4 5658.9 5053.5 5478.2 5554.8 5599.4 5613.2 16:59:59 INFO - PROCESS | 1645 | 16:59:59 INFO - PROCESS | 1645 | [#5] yui.html Cycles:180 Average:24560.56 Median:3682.99 stddev:38586.66 (1047.7%) stddev-sans-first:38653.35 16:59:59 INFO - PROCESS | 1645 | Values: 709.8 760.2 769.2 797.2 861.8 15383.3 15964.4 16588.0 16609.7 16953.4 14848.6 15279.9 15336.6 15338.2 15402.0 680.8 700.0 841.4 862.5 864.2 835.7 861.7 868.5 870.7 873.6 914.4 916.3 916.4 916.6 918.0 709.0 732.6 912.8 914.9 917.7 535.8 659.1 660.8 662.2 665.6 14984.5 15051.2 15067.5 15071.2 15089.2 14034.8 14150.8 14214.6 14246.8 14654.5 11245.3 13309.6 13377.5 13425.9 13745.6 4540.5 4565.5 4764.4 4870.6 4871.9 116347.0 118668.8 118697.0 118735.0 118924.0 11029.2 11274.4 11355.0 11525.3 11679.2 22841.4 22842.0 22847.5 22902.0 22907.9 7980.6 8081.2 8133.6 8273.1 8300.8 4328.5 4416.0 4426.1 4579.7 4619.7 3551.4 3661.1 3671.6 3675.2 3690.8 648.2 658.4 669.2 676.9 680.2 599.6 602.8 614.7 634.4 651.4 7685.2 9135.4 9194.2 9230.2 9407.2 511.9 563.7 616.1 624.5 652.1 4390.8 4432.9 4475.8 4544.1 4595.9 94424.0 95141.5 95653.0 141369.3 164394.0 81635.0 127103.7 140665.0 141810.0 144829.3 101485.5 103650.0 124546.4 125125.5 127284.4 9436.6 9802.9 9922.3 9938.6 10152.6 63408.7 64064.7 64687.0 65128.0 65221.7 67199.0 87081.0 98143.5 99348.0 101475.0 11289.2 11593.7 11898.2 11941.9 14129.8 13095.1 13109.9 13366.0 13561.3 13572.9 12070.3 12445.6 14221.9 14410.9 14984.4 13296.1 14057.4 14313.5 14466.8 14679.8 13928.4 14092.2 14136.6 14423.7 14454.6 11177.2 11549.8 11566.5 11637.6 11784.5 9987.3 10230.8 10323.8 11507.4 11913.9 16:59:59 INFO - PROCESS | 1645 | -------- Summary: end -------- 16:59:59 INFO - PROCESS | 1645 | 17:00:00 INFO - TEST-INFO | 1645: exit 0 17:00:00 INFO - TEST-OK | dromaeo_css | took 1118313ms 17:00:00 INFO - TEST-START | kraken 17:00:00 INFO - operating with platform_type : mac_ 17:00:00 INFO - Initialising browser for kraken test... 17:00:00 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/tmp8VuKWy/profile http://localhost:49277/getInfo.html) 17:00:02 INFO - PROCESS | 1654 | __metrics Screen width/height:1600/1200 17:00:02 INFO - PROCESS | 1654 | colorDepth:24 17:00:02 INFO - PROCESS | 1654 | Browser inner width/height: 1024/689 17:00:02 INFO - PROCESS | 1654 | __metrics 17:00:02 INFO - PROCESS | 1654 | 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" 17:00:02 INFO - PROCESS | 1654 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:00:03 INFO - TEST-INFO | 1654: exit 0 17:00:03 INFO - Browser initialized. 17:00:03 INFO - Running cycle 1/1 for kraken test... 17:00:03 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/tmp8VuKWy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:00:15 INFO - PROCESS | 1655 | RSS: Main: 228651008 17:00:15 INFO - PROCESS | 1655 | 17:00:18 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-beat-detection) 17:00:19 INFO - PROCESS | 1655 | RSS: Main: 294178816 17:00:19 INFO - PROCESS | 1655 | 17:00:21 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-dft) 17:00:22 INFO - PROCESS | 1655 | RSS: Main: 295055360 17:00:22 INFO - PROCESS | 1655 | 17:00:25 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-fft) 17:00:26 INFO - PROCESS | 1655 | RSS: Main: 379015168 17:00:26 INFO - PROCESS | 1655 | 17:00:28 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-oscillator) 17:00:29 INFO - PROCESS | 1655 | RSS: Main: 281792512 17:00:29 INFO - PROCESS | 1655 | 17:00:31 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49277/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:00:31 INFO - PROCESS | 1655 | RSS: Main: 286011392 17:00:31 INFO - PROCESS | 1655 | 17:00:34 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49277/tests/kraken/driver.html?testName=imaging-darkroom) 17:00:35 INFO - PROCESS | 1655 | RSS: Main: 323473408 17:00:35 INFO - PROCESS | 1655 | 17:00:38 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49277/tests/kraken/driver.html?testName=imaging-desaturate) 17:00:39 INFO - PROCESS | 1655 | RSS: Main: 326545408 17:00:39 INFO - PROCESS | 1655 | 17:00:41 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49277/tests/kraken/driver.html?testName=json-parse-financial) 17:00:42 INFO - PROCESS | 1655 | RSS: Main: 324759552 17:00:42 INFO - PROCESS | 1655 | 17:00:44 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49277/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:00:44 INFO - PROCESS | 1655 | RSS: Main: 302297088 17:00:44 INFO - PROCESS | 1655 | 17:00:46 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:00:47 INFO - PROCESS | 1655 | RSS: Main: 304025600 17:00:47 INFO - PROCESS | 1655 | 17:00:49 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:00:50 INFO - PROCESS | 1655 | RSS: Main: 305455104 17:00:50 INFO - PROCESS | 1655 | 17:00:53 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:00:53 INFO - PROCESS | 1655 | RSS: Main: 314372096 17:00:53 INFO - PROCESS | 1655 | 17:00:56 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:00:57 INFO - PROCESS | 1655 | RSS: Main: 317091840 17:00:57 INFO - PROCESS | 1655 | 17:00:59 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49277/tests/kraken/driver.html?testName=ai-astar) 17:00:59 INFO - PROCESS | 1655 | RSS: Main: 360603648 17:00:59 INFO - PROCESS | 1655 | 17:00:59 INFO - PROCESS | 1655 | __start_tp_report 17:00:59 INFO - PROCESS | 1655 | _x_x_mozilla_page_load 17:00:59 INFO - PROCESS | 1655 | _x_x_mozilla_page_load_details 17:00:59 INFO - PROCESS | 1655 | |i|pagename|runs| 17:00:59 INFO - PROCESS | 1655 | |0;ai-astar;99;111;106;113;114;113;117;112;113;111 17:00:59 INFO - PROCESS | 1655 | |1;audio-beat-detection;145;110;129;161;109;128;128;106;192;132 17:00:59 INFO - PROCESS | 1655 | |2;audio-dft;184;182;180;181;263;186;184;181;180;197 17:00:59 INFO - PROCESS | 1655 | |3;audio-fft;76;78;105;95;57;61;62;83;87;56 17:00:59 INFO - PROCESS | 1655 | |4;audio-oscillator;78;87;135;70;71;75;117;71;70;120 17:00:59 INFO - PROCESS | 1655 | |5;imaging-gaussian-blur;89;97;130;126;85;124;130;88;89;86 17:00:59 INFO - PROCESS | 1655 | |6;imaging-darkroom;95;95;95;95;97;95;94;96;95;95 17:00:59 INFO - PROCESS | 1655 | |7;imaging-desaturate;86;87;84;84;84;87;85;86;86;85 17:00:59 INFO - PROCESS | 1655 | |8;json-parse-financial;56;53;54;55;54;54;55;55;54;54 17:00:59 INFO - PROCESS | 1655 | |9;json-stringify-tinderbox;68;66;68;74;81;74;70;71;70;70 17:00:59 INFO - PROCESS | 1655 | |10;stanford-crypto-aes;82;88;84;84;86;85;95;103;103;105 17:00:59 INFO - PROCESS | 1655 | |11;stanford-crypto-ccm;149;192;146;151;136;143;154;142;212;137 17:00:59 INFO - PROCESS | 1655 | |12;stanford-crypto-pbkdf2;172;170;168;175;175;164;155;227;224;170 17:00:59 INFO - PROCESS | 1655 | |13;stanford-crypto-sha256-iterative;66;67;68;67;68;67;67;68;66;67 17:00:59 INFO - PROCESS | 1655 | __end_tp_report 17:00:59 INFO - PROCESS | 1655 | __start_cc_report 17:00:59 INFO - PROCESS | 1655 | _x_x_mozilla_cycle_collect,2105 17:00:59 INFO - PROCESS | 1655 | __end_cc_report 17:00:59 INFO - PROCESS | 1655 | __startTimestamp1471910459486__endTimestamp 17:00:59 INFO - PROCESS | 1655 | 17:00:59 INFO - PROCESS | 1655 | ------- Summary: start ------- 17:00:59 INFO - PROCESS | 1655 | Number of tests: 14 17:00:59 INFO - PROCESS | 1655 | 17:00:59 INFO - PROCESS | 1655 | [#0] ai-astar Cycles:10 Average:110.90 Median:113.00 stddev:5.02 (4.4%) stddev-sans-first:2.95 17:00:59 INFO - PROCESS | 1655 | Values: 99.0 111.0 106.0 113.0 114.0 113.0 117.0 112.0 113.0 111.0 17:00:59 INFO - PROCESS | 1655 | 17:00:59 INFO - PROCESS | 1655 | [#1] audio-beat-detection Cycles:10 Average:134.00 Median:130.50 stddev:26.46 (20.3%) stddev-sans-first:27.76 17:00:59 INFO - PROCESS | 1655 | Values: 145.0 110.0 129.0 161.0 109.0 128.0 128.0 106.0 192.0 132.0 17:00:59 INFO - PROCESS | 1655 | 17:00:59 INFO - PROCESS | 1655 | [#2] audio-dft Cycles:10 Average:191.80 Median:184.00 stddev:25.52 (13.9%) stddev-sans-first:26.91 17:00:59 INFO - PROCESS | 1655 | Values: 184.0 182.0 180.0 181.0 263.0 186.0 184.0 181.0 180.0 197.0 17:00:59 INFO - PROCESS | 1655 | 17:00:59 INFO - PROCESS | 1655 | [#3] audio-fft Cycles:10 Average:76.00 Median:77.00 stddev:16.86 (21.9%) stddev-sans-first:17.88 17:00:59 INFO - PROCESS | 1655 | Values: 76.0 78.0 105.0 95.0 57.0 61.0 62.0 83.0 87.0 56.0 17:00:59 INFO - PROCESS | 1655 | 17:00:59 INFO - PROCESS | 1655 | [#4] audio-oscillator Cycles:10 Average:89.40 Median:71.00 stddev:24.83 (35.0%) stddev-sans-first:26.00 17:00:59 INFO - PROCESS | 1655 | Values: 78.0 87.0 135.0 70.0 71.0 75.0 117.0 71.0 70.0 120.0 17:00:59 INFO - PROCESS | 1655 | 17:00:59 INFO - PROCESS | 1655 | [#5] imaging-gaussian-blur Cycles:10 Average:104.40 Median:87.00 stddev:20.21 (23.2%) stddev-sans-first:20.65 17:00:59 INFO - PROCESS | 1655 | Values: 89.0 97.0 130.0 126.0 85.0 124.0 130.0 88.0 89.0 86.0 17:00:59 INFO - PROCESS | 1655 | 17:00:59 INFO - PROCESS | 1655 | [#6] imaging-darkroom Cycles:10 Average:95.20 Median:95.00 stddev:0.79 (0.8%) stddev-sans-first:0.83 17:00:59 INFO - PROCESS | 1655 | Values: 95.0 95.0 95.0 95.0 97.0 95.0 94.0 96.0 95.0 95.0 17:00:59 INFO - PROCESS | 1655 | 17:00:59 INFO - PROCESS | 1655 | [#7] imaging-desaturate Cycles:10 Average:85.40 Median:86.00 stddev:1.17 (1.4%) stddev-sans-first:1.22 17:00:59 INFO - PROCESS | 1655 | Values: 86.0 87.0 84.0 84.0 84.0 87.0 85.0 86.0 86.0 85.0 17:00:59 INFO - PROCESS | 1655 | 17:00:59 INFO - PROCESS | 1655 | [#8] json-parse-financial Cycles:10 Average:54.40 Median:54.50 stddev:0.84 (1.5%) stddev-sans-first:0.67 17:00:59 INFO - PROCESS | 1655 | Values: 56.0 53.0 54.0 55.0 54.0 54.0 55.0 55.0 54.0 54.0 17:00:59 INFO - PROCESS | 1655 | 17:00:59 INFO - PROCESS | 1655 | [#9] json-stringify-tinderbox Cycles:10 Average:71.20 Median:70.50 stddev:4.26 (6.0%) stddev-sans-first:4.36 17:00:59 INFO - PROCESS | 1655 | Values: 68.0 66.0 68.0 74.0 81.0 74.0 70.0 71.0 70.0 70.0 17:00:59 INFO - PROCESS | 1655 | 17:00:59 INFO - PROCESS | 1655 | [#10] stanford-crypto-aes Cycles:10 Average:91.50 Median:84.50 stddev:9.11 (10.8%) stddev-sans-first:8.99 17:00:59 INFO - PROCESS | 1655 | Values: 82.0 88.0 84.0 84.0 86.0 85.0 95.0 103.0 103.0 105.0 17:00:59 INFO - PROCESS | 1655 | 17:00:59 INFO - PROCESS | 1655 | [#11] stanford-crypto-ccm Cycles:10 Average:156.20 Median:150.00 stddev:25.24 (16.8%) stddev-sans-first:26.64 17:00:59 INFO - PROCESS | 1655 | Values: 149.0 192.0 146.0 151.0 136.0 143.0 154.0 142.0 212.0 137.0 17:00:59 INFO - PROCESS | 1655 | 17:00:59 INFO - PROCESS | 1655 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:180.00 Median:173.50 stddev:24.68 (14.2%) stddev-sans-first:26.01 17:00:59 INFO - PROCESS | 1655 | Values: 172.0 170.0 168.0 175.0 175.0 164.0 155.0 227.0 224.0 170.0 17:00:59 INFO - PROCESS | 1655 | 17:00:59 INFO - PROCESS | 1655 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.10 Median:67.00 stddev:0.74 (1.1%) stddev-sans-first:0.67 17:00:59 INFO - PROCESS | 1655 | Values: 66.0 67.0 68.0 67.0 68.0 67.0 67.0 68.0 66.0 67.0 17:00:59 INFO - PROCESS | 1655 | -------- Summary: end -------- 17:00:59 INFO - PROCESS | 1655 | 17:01:00 INFO - TEST-INFO | 1655: exit 0 17:01:00 INFO - TEST-OK | kraken | took 59715ms 17:01:00 INFO - SUITE-END | took 1178s 17:01:00 INFO - Completed test suite (00:19:38) 17:01:00 INFO - javascript benchmark 17:01:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3349.5143204235387, 3391.9660803391967, 3394.5926488821315, 3414.248865249644, 3422.6919577238045, 5631.0, 5703.629264097841, 5744.454276843703, 5873.7650493980245, 5889.941100588992, 5646.0, 5728.112142617891, 5805.042168042268, 5831.0, 5916.437938395857, 5147.459516750743, 5177.145770947808, 5217.973910130444, 5222.268882356473, 5230.34620672416, 5244.527992480676, 5257.815976440826, 5278.47215278471, 5281.075811732951, 5286.709230992294, 5116.872078198075, 5184.429712731597, 5213.765380557884, 5250.474952504738, 5298.867528311785, 4408.228560002019, 5129.871753206163, 5194.402643695986, 5236.528712415901, 5246.921296180561, 5198.714070726146, 5214.113600687892, 5241.68549887008, 5265.157574788015, 5272.1300985337375, 5836.9124463133085, 5857.7949771757785, 5873.001589729756, 5877.794277200277, 5893.58744887858, 6118.877622447526, 6192.318844927055, 6220.657863817488, 6247.219097612799, 6268.937310626881, 5624.859378515529, 5897.849919265745, 6192.0, 6222.657753823538, 6251.437370636619, 5748.31020277561, 5896.204012458306, 5909.940900591025, 5915.142304365886, 5917.112433134978, 6159.384061593805, 6191.040388739752, 6221.09794079865, 6243.37566243372, 6249.0, 6159.692015399212, 6205.565610407319, 6229.813105606839, 6230.7819226326865, 6235.594686345464, 6157.384261573897, 6285.654289014148, 6287.0, 6292.4966002719675, 6301.558890877594, 6193.349698281616, 6250.624962502265, 6259.874802504016, 6292.46514046302, 6294.370562943669, 5188.844334669966, 6268.028455589391, 6268.874622507525, 6272.8118156455375, 6289.811305660837, 4869.366982292279, 5038.470960549163, 5066.670666406745, 5068.797248110034, 5073.594112471067, 4403.779811009501, 4430.579094985971, 4451.933221001687, 4477.97006688457, 4521.367008618796, 5806.535477161817, 5809.651420914759, 5809.941900581025, 5826.1552074948895, 5836.708164591839, 6152.384761523812, 6184.0, 6194.5044396448175, 6228.190335256388, 6242.656653883989, 5633.549316054706, 5707.971460142756, 5766.279215098113, 5822.184894114827, 5834.620749651259, 4823.831165909176, 5388.488093631177, 5463.699496527729, 5471.960327537835, 5475.863103422446, 6143.262808463013, 6181.041938499539, 6266.373362663697, 6270.184875966095, 6276.905846412307, 6177.907331390123, 6235.906461403173, 6243.906341404791, 6249.843753906189, 6261.342559031236, 6256.217972753406, 6260.092286618506, 6272.968635156795, 6276.089966954674, 6293.779717709858, 6030.60801047948, 6175.722092505938, 6196.070589411444, 6218.657973811484, 6234.2830574482705, 6052.092186172109, 6169.290531588925, 6197.4732147767945, 6219.844503887439, 6235.719392627252, 6191.721372538156, 6197.845053873689, 6222.346653601488, 6226.968865155645, 6237.937620623736, 5948.940510595012, 6195.380461953769, 6209.937900621117, 6212.316645169119, 6221.191245138103, 5148.253503241934, 5949.970250148722, 5991.820245392645, 6029.125776762433, 6122.142899994094, 6222.377762223741, 6225.128482012431, 6226.159468471698, 6231.158793562811, 6253.437190652863, 5825.543614096476, 5857.58996870215, 6030.3668114847305, 6082.2093127893095, 6114.969425152845], "value": 5717.146335381131, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [485.66974457368974, 509.3861896414823, 516.7338820507438, 522.7725939216439, 533.6451259912159, 30505.0, 32061.19847003826, 39541.406878896836, 40647.79676101623, 40772.0, 42011.0, 42343.0, 42396.78801605988, 42404.57595424045, 42520.362194567104, 9811.705648830528, 9946.452945088018, 9955.651552195675, 9960.302778805486, 9962.153216976565, 8776.99064607572, 8992.820143597124, 8992.820143597124, 9008.099190081006, 9019.549022548847, 11976.041916646647, 12201.0, 12229.449674764657, 12388.876111238862, 12414.379281035957, 11984.280943143396, 12079.577214797528, 12097.758044839054, 12099.153059285854, 12118.697032574211, 11999.460024298927, 12037.398130093461, 12040.458179381949, 12044.457999390048, 12069.456874440672, 39923.0, 40192.59807401947, 40219.1956160878, 40240.0, 40295.19409611791, 3369.7809642373168, 3431.9828400857837, 3445.586529616462, 3578.8389522471552, 3770.622937706235, 29824.850875745484, 30367.937122200838, 31088.844555777076, 31097.0, 31367.529487057713, 3262.1192278084786, 3269.1336795749144, 3289.687479689426, 3386.0519054664733, 3437.5187473753695, 508352.0, 510455.0, 511921.0, 512164.0, 516553.4172329152, 29058.0, 32892.0, 57280.0, 57536.2326085973, 57537.712311438176, 34963.300733985176, 35138.29723405518, 35144.0, 35155.0, 35157.0, 14481.710365792625, 14663.853361466463, 14682.853171468363, 14689.192094434695, 14696.779548306784, 12420.00639948802, 12527.498900044078, 12534.185277956904, 12542.937285313516, 12551.3096779678, 6659.86680266392, 7338.321512647952, 7370.48406611532, 7549.962250188714, 7745.922540774633, 3201.0716892101495, 3247.399231142246, 3257.1368587324378, 3269.8692052318115, 3288.342331533655, 924.8335299646128, 1001.884783249921, 1023.9913685020249, 1074.011909043666, 1077.590515604081, 29660.555091673643, 29869.55195672067, 30240.69759302379, 30642.233944151576, 30729.078127656205, 896.1576118448637, 977.0766625538939, 1009.7778488732467, 1092.6940456672144, 1116.564539829467, 13176.879965202874, 13661.726765464833, 14264.144151350953, 14453.710925781426, 15404.998675086084, 686839.0, 691188.0, 691252.0, 691713.0, 692203.0, 47576.334828280844, 48147.518524815, 54821.0, 55311.0, 55969.440305597236, 1376.662717634186, 1389.1317926296065, 1417.1709549913417, 1422.0, 1423.3737155651481, 27368.0, 28402.005929792358, 29839.806407744316, 30707.692923071376, 30958.22604434907, 54911.90176196374, 55788.72105639446, 55824.16263755965, 55848.883022338516, 56178.719106404205, 614719.0, 883003.0, 895140.0, 899807.0, 901611.0, 38633.0, 41191.382129268684, 41444.58555414528, 41490.58509414867, 41911.0, 42814.92962675958, 45766.448535991185, 45957.540424595325, 46268.768656156506, 46740.0, 38243.235135296585, 38259.80870095632, 38486.0, 39044.0, 39926.80036599799, 31801.8409907949, 33371.49942750812, 38069.04827379338, 38118.618813812616, 38923.41614875723, 37200.25599487941, 37362.8131859339, 37961.81019094887, 37979.43030854484, 38019.0, 32151.51772723458, 32736.774000896025, 33354.99935001954, 33524.83237583796, 33674.326513470085, 24603.0, 24684.629730554414, 25074.498510030062, 25305.87347063253, 25325.98696052211], "value": 19243.531340817917, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [319.16856588586734, 336.940322685155, 366.1541838353406, 380.5832613288449, 404.14321638127177, 14641.560753177408, 15183.772243416357, 17613.911930440347, 18546.0, 21278.680819787714, 21026.158953641876, 21092.367228983116, 21532.354029379105, 21756.45608859779, 21934.0, 5936.970315148418, 6152.107944348067, 6211.440970312671, 6240.781572644958, 6246.718897649616, 5522.6134170608075, 5902.527797776189, 5914.792982245623, 6113.266408031021, 6190.752369905198, 6116.357782432848, 6117.69411529424, 6128.785492507763, 6137.294211165706, 6139.87720245597, 5169.2504586835075, 5690.0, 6085.2393450818645, 6088.391160883921, 6149.815505534841, 5817.912731308991, 5902.675352855591, 5918.7928422505, 5925.4963328117165, 5931.584789064767, 13204.293119910491, 13481.74336848835, 13615.0, 13616.591502254949, 13636.522721704692, 2154.53677459347, 2267.3764714703425, 2306.3888069661552, 2471.3698007008097, 2698.0961377938415, 9980.650677226262, 10086.949565252127, 10264.79470410595, 10387.961203879628, 10407.947960260226, 1818.4271954334342, 1897.8386837118862, 1913.206019501905, 1928.421473557941, 1981.37586660203, 95333.98993105763, 101970.47044294342, 116319.67360652825, 129185.35407322997, 136743.0, 11289.887101129048, 11337.603183888525, 11348.829767553494, 11384.772304553862, 11760.294382337088, 14390.928045359706, 14398.352074156688, 14402.783958240634, 14404.495842645458, 14447.85552144486, 8248.381371397169, 8541.957290213633, 8559.74320770378, 8638.0, 8638.654453821902, 8464.32285417165, 8478.448900821428, 8479.448835825651, 8623.0, 8645.221930026202, 3796.430535419654, 4473.4408198975125, 4483.865484035484, 4498.347739577743, 4572.0, 1666.7249903765985, 1897.5161333859778, 1899.5441094137584, 1901.9049047547567, 1937.6609093408879, 675.2133764164792, 705.7575211848942, 836.1638361638362, 938.8826396700413, 946.9668561600449, 21352.893235533724, 21457.872200098893, 22093.37138979253, 22257.0, 22341.888290558443, 904.8597467392565, 922.197688011421, 936.0966667166217, 971.0532231074787, 1008.742770593494, 9811.313228019775, 11447.771044579229, 11580.826287605692, 11610.361430121424, 11692.824607630891, 510090.0, 611914.0, 624992.0, 625945.0, 627383.0, 142042.0, 143843.0, 145208.0, 149623.0, 151240.48759512263, 939.7509659940122, 955.7132860141929, 997.4663554998041, 1005.6932635546083, 1016.202281209262, 18159.727604085685, 19383.224671013002, 19556.706649399985, 19677.622566420785, 19755.901220493804, 55878.44121558732, 56065.719671401384, 56986.575335616944, 57424.0, 57972.710136449045, 85200.57399712961, 86705.0, 86767.0, 86859.1314086851, 87170.1282987162, 7998.440109192301, 8020.197980201933, 8022.1977802221645, 8338.583070846313, 8457.0, 9367.156955874005, 12512.562060327844, 13005.934970325088, 13417.932910335387, 13645.249511276976, 11251.718707032389, 11296.830547541958, 11629.127815413709, 11645.41772911368, 11719.296842189497, 11316.20786544934, 11391.658250252505, 11452.713682157679, 11543.422828858356, 11762.529683789526, 11350.0, 11380.43097845121, 11776.88223117792, 11799.76400472003, 11810.114241431755, 7963.601819909098, 8089.716859909875, 8128.715494957648, 8225.300849427866, 8345.374096942633, 8165.0, 9910.653127140515, 10197.18422526211, 10459.477026148814, 11599.478023488795], "value": 9484.664390781592, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1502.6093215763901, 1539.684364705235, 1702.3105642214907, 1834.0279651784542, 1867.8599105067124, 8581.570921453926, 9130.954345228265, 9156.2217211537, 9156.2217211537, 9160.175584197437, 7964.641591128398, 8181.100078991321, 8636.30909527238, 8844.115588441153, 8881.91118088819, 2368.6683864258976, 2396.2332053742807, 2408.1451084864884, 2410.1564452441594, 2416.1543459789023, 2366.0417530900013, 2384.4515761374896, 2417.2748175547354, 2418.903243870243, 2420.8668523231217, 2378.7383387827326, 2406.446517301013, 2408.590539608271, 2410.554047501209, 2416.504616553611, 2073.3676228750223, 2364.6334818103223, 2366.1127077345996, 2372.1697405907967, 2372.6203807390907, 2370.0401337458356, 2382.797462215714, 2388.1283331584023, 2389.6654468374268, 2390.581648211556, 8956.8656470153, 9014.323925705532, 9123.270138388913, 9140.542972851397, 9146.954265228698, 5284.920726189111, 5454.072807622713, 5464.12573988164, 5466.453354664502, 5479.780808767645, 3544.2734239480847, 3616.981915090434, 3693.9630603693886, 3701.8889433316776, 3771.8114094295174, 1108.5177947592822, 1117.6255954255334, 1118.3960661242918, 1134.4157758754247, 1146.140394703972, 11772.941135294355, 11806.0, 11885.584004559885, 11886.940565297118, 11920.582779602759, 4355.673324500675, 4466.709663871903, 4648.047150334173, 4664.533546645308, 4669.066186762661, 9154.908450915405, 9171.174594286545, 9177.862332064891, 9178.495182765013, 9188.310876684276, 5246.265522826808, 5248.921266181011, 5255.0540902637895, 5255.106631872591, 5274.92087618686, 4414.404055452473, 4637.536246375335, 4754.881127971759, 4915.459299477055, 4919.852404427873, 3752.81235938202, 3817.709374375408, 3899.53205615328, 3959.92080158401, 3999.4800675911947, 1022.3661329975314, 1175.1304035014027, 1184.8104303311602, 1194.3908606610516, 1199.2564609941717, 780.7033327335577, 912.466207268742, 935.8034812689275, 945.4258659332272, 976.6435251133286, 5875.059990401515, 6160.557854436776, 6188.81433556994, 6249.812505624838, 6340.705938563864, 930.2046750028763, 960.841461158915, 965.7489052846311, 969.8011907558933, 1017.3387298256044, 3987.5445462406014, 4087.5094988600963, 4090.570490098556, 4144.854930077433, 4192.790360481964, 10761.192910531741, 11032.944835275934, 11125.109991200685, 11126.443677816238, 11132.49903754333, 10424.270301078852, 10922.508487118099, 11070.612528561462, 11082.889171108347, 11107.222494425312, 8078.55567943757, 8312.21034001769, 8318.62566184511, 8325.375596830261, 8332.541710205996, 5917.142014407801, 5938.168656388023, 5992.64044157352, 6157.692115394123, 6356.491480681627, 9949.154321882721, 10191.184705223415, 10235.48822558884, 10245.948770256102, 10277.794444110927, 10467.371957682564, 10467.685969420929, 10482.842757358798, 10493.003164699341, 10512.0013598708, 6202.782902598387, 6853.554518956451, 7310.488265821554, 7657.57883316423, 7814.921850781647, 8634.438761480484, 8692.608832602422, 8745.344099192458, 8761.342899282452, 8765.780855478664, 7575.166731659623, 7686.231376862269, 7698.538087714755, 7755.146933837161, 7835.177306382748, 7214.71141154369, 7359.153697324876, 7410.147832999274, 7478.214787447239, 7547.660355284135, 7056.929430705833, 7249.093863267091, 7249.311315425026, 7260.310270524292, 7268.127824661075, 4134.813933372945, 4938.407391113089, 5054.671446355975, 5097.541221290102, 5194.402643696023, 4978.800847966041, 5044.612731498867, 5088.033273677989, 5277.2875661785165, 5343.412224655207], "value": 4646.763183862418, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [301.35810723159665, 307.8122345369324, 311.34461957579293, 314.99370012599746, 318.9378071276102, 4691.247002398085, 5194.896067092824, 5324.7071411072375, 5414.485623865731, 5473.67157970522, 5327.627066105374, 5391.460853914607, 5411.053065713494, 5412.485813847678, 5426.701531415771, 3588.4796704477835, 3818.9497888080723, 3846.942295865564, 3988.820503077354, 4025.2352053109817, 3169.904902852918, 3558.953601679032, 4003.639672429481, 4028.8187031583648, 4111.506619205685, 3711.517502724642, 4015.2371049500503, 4034.9798251008706, 4045.0, 4087.7547347159116, 3869.729118961674, 4018.6985976051915, 4071.531773846016, 4077.347624380085, 4084.8570300039505, 3114.76639252057, 3530.5586801649793, 3544.6530318478813, 3552.662497062775, 3573.803440810754, 4365.388845561624, 5185.611079169077, 5256.9474305256845, 5282.683039017671, 5290.994711004897, 4241.36379543068, 4645.558671926162, 4680.134175177603, 4688.859334219945, 4700.694454860423, 4760.143174228638, 4967.857392799677, 5593.804216852432, 5636.267285252932, 5748.166515855178, 3449.448088305884, 3453.963810856758, 3736.252749450121, 3874.1089549403796, 3884.8057597120032, 4932.926006109911, 4934.950650493485, 5090.116656836957, 5914.746889210916, 5932.406759324076, 3811.599782022903, 3855.9396166054557, 3865.5168103987003, 3867.5165604299464, 3883.7377852198147, 3923.2938071146896, 3933.6263055009726, 3941.684665226775, 3949.7827619481204, 3961.3661814109605, 3851.67260782831, 4300.913981720348, 4593.54064593538, 4618.321373603302, 4625.5836974671765, 4543.274514897818, 4834.679353910073, 5625.521830644441, 5642.971785141131, 5645.830625081254, 1291.7803973324558, 1324.4635922451423, 1341.6981179234594, 1357.592722183341, 1361.6868120332379, 729.7594090046836, 759.6353750199825, 772.6909236305522, 827.3287958324152, 833.8576150673495, 4030.979845100756, 4925.458199598042, 5068.6451948364, 5078.5937125029905, 5279.656822306614, 5546.528545073714, 5746.586433697857, 5806.5645076618575, 5821.621594596338, 5825.893080314727, 4789.832355867528, 5020.59835213182, 5299.5886871473385, 5319.521243088141, 5321.281626980385, 2786.4148528808773, 3018.758499320049, 3024.682408347092, 3029.863801074597, 3038.893638722634, 5363.383210930715, 6026.156338112668, 6055.548337447701, 6063.969680151659, 6066.028540724282, 5617.550595952314, 5903.940960590425, 6016.308124565731, 6031.8793624127275, 6111.633302001894, 5360.839174824761, 5833.329167145833, 6016.0, 6043.758249670052, 6133.3866613339205, 4961.6030717543235, 5632.324121105494, 5635.915461268002, 5882.352941176553, 5892.823215303548, 5001.324821149098, 5743.6840973745175, 5752.511036561939, 5764.567657425626, 5831.912521312269, 4788.712677239377, 6017.509844290214, 6101.481374083252, 6104.481119104926, 6113.786017489544, 3361.9495707564897, 3673.7612055216327, 3841.4621952926054, 3986.581408952018, 4051.6961227907436, 5750.827475175752, 5772.0, 5774.364819869895, 5803.564732644984, 5807.883842323215, 5360.812371566976, 5549.472800083986, 5649.322081350264, 5669.007923613269, 5683.9715801420725, 4484.775761211861, 5500.4499550044675, 5557.499825015768, 5583.297094386089, 5602.52378547828, 5435.565154787687, 5445.673259604437, 5449.918251226314, 5481.779879148951, 5491.395946445808, 4708.92936605958, 5241.61097309221, 5378.97310513445, 5599.440055994368, 5658.943410565842, 5053.469385714594, 5478.165284301085, 5554.777808887599, 5599.384067752462, 5613.214150018919], "value": 4092.9777071299463, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [709.7515869445693, 760.2283682062707, 769.2230846844685, 797.2306724011328, 861.8017855893146, 15383.307751151196, 15964.441244556443, 16588.0, 16609.667806643858, 16953.406630767924, 14848.628784280398, 15279.923600381982, 15336.61658458539, 15338.233088345565, 15402.0, 680.799164246546, 700.0199720391441, 841.3899922556144, 862.469581207556, 864.2481041493878, 835.7409203147014, 861.7027125641644, 868.4572142410993, 870.6604424274537, 873.5501216873315, 914.4284821986258, 916.3493919317293, 916.4134953629682, 916.6104405627615, 917.9862302065475, 708.9964550177216, 732.6190381001902, 912.8311262416474, 914.8719179314901, 917.6788124156559, 535.8419266316446, 659.0904551718597, 660.7951535024158, 662.2483481248769, 665.6339013542532, 14984.47554335593, 15051.172185529791, 15067.547973560811, 15071.246437678183, 15089.170095644735, 14034.789478157836, 14150.787738183935, 14214.573562793134, 14246.786298205536, 14654.487092951695, 11245.325280483197, 13309.600711978655, 13377.464901403931, 13425.932870335586, 13745.587632371045, 4540.500544940054, 4565.543445655408, 4764.356811830393, 4870.561649451531, 4871.853844384674, 116347.0, 118668.81331186664, 118697.0, 118735.0, 118924.0, 11029.172812039129, 11274.379909104913, 11355.0, 11525.308481491138, 11679.240849344766, 22841.428964275692, 22841.972111255032, 22847.543049138923, 22902.0, 22907.876582215362, 7980.561069141253, 8081.191880811872, 8133.593320334078, 8273.131321211307, 8300.792480188044, 4328.480582330078, 4416.0197952627295, 4426.070525189682, 4579.7252164870215, 4619.699719518288, 3551.4317709166407, 3661.0847288177956, 3671.6328367163605, 3675.1730860556163, 3690.7970061646865, 648.18652590998, 658.3613894522306, 669.1602039440568, 676.9153855768029, 680.210955291859, 599.6462087368386, 602.8312072619674, 614.7295190116334, 634.3909846547274, 651.3909494622543, 7685.23147685227, 9135.360524763335, 9194.172524472695, 9230.169284764403, 9407.247420206368, 511.91553393690367, 563.7153237614979, 616.1404840247918, 624.497279689854, 652.116382301974, 4390.824367025283, 4432.867013989586, 4475.820967161277, 4544.068465964469, 4595.9080818383445, 94424.0, 95141.52429237809, 95653.0, 141369.29315353357, 164394.0, 81635.0, 127103.72896271104, 140665.0, 141810.0, 144829.27585362006, 101485.49257253815, 103650.0, 124546.37726811308, 125125.49749004969, 127284.36357818337, 9436.575354108943, 9802.901970980483, 9922.255830812863, 9938.602455901972, 10152.593896244067, 63408.68295658492, 64064.71870562469, 64687.0, 65128.0, 65221.673891632134, 67198.99201512079, 87081.0, 98143.50928245598, 99348.0, 101475.0, 11289.153313501356, 11593.710157246136, 11898.22661526998, 11941.880581194424, 14129.788053179005, 13095.148815326973, 13109.868901310865, 13366.0, 13561.254131022888, 13572.86427135716, 12070.27578345302, 12445.564405245774, 14221.857781422053, 14410.927945360207, 14984.400623975354, 13296.078812238226, 14057.437702491785, 14313.499027533986, 14466.782998255245, 14679.779803302745, 13928.442862285801, 14092.154470731788, 14136.575902722934, 14423.711525769635, 14454.638634033812, 11177.217594768614, 11549.769004620028, 11566.537338506701, 11637.592684256011, 11784.469698863742, 9987.300888937705, 10230.846537301797, 10323.81276153252, 11507.367094809866, 11913.880861191277], "value": 7886.088919745884, "unit": "score"}], "name": "dromaeo_css", "value": 7341.1416719189165, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 111.0, 106.0, 113.0, 114.0, 113.0, 117.0, 112.0, 113.0, 111.0], "value": 110.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 110.0, 129.0, 161.0, 109.0, 128.0, 128.0, 106.0, 192.0, 132.0], "value": 134.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 182.0, 180.0, 181.0, 263.0, 186.0, 184.0, 181.0, 180.0, 197.0], "value": 191.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 78.0, 105.0, 95.0, 57.0, 61.0, 62.0, 83.0, 87.0, 56.0], "value": 76.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 87.0, 135.0, 70.0, 71.0, 75.0, 117.0, 71.0, 70.0, 120.0], "value": 89.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 97.0, 130.0, 126.0, 85.0, 124.0, 130.0, 88.0, 89.0, 86.0], "value": 104.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 97.0, 95.0, 94.0, 96.0, 95.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 87.0, 84.0, 84.0, 84.0, 87.0, 85.0, 86.0, 86.0, 85.0], "value": 85.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 53.0, 54.0, 55.0, 54.0, 54.0, 55.0, 55.0, 54.0, 54.0], "value": 54.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 66.0, 68.0, 74.0, 81.0, 74.0, 70.0, 71.0, 70.0, 70.0], "value": 71.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 88.0, 84.0, 84.0, 86.0, 85.0, 95.0, 103.0, 103.0, 105.0], "value": 91.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 192.0, 146.0, 151.0, 136.0, 143.0, 154.0, 142.0, 212.0, 137.0], "value": 156.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 170.0, 168.0, 175.0, 175.0, 164.0, 155.0, 227.0, 224.0, 170.0], "value": 180.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 68.0, 67.0, 68.0, 67.0, 67.0, 68.0, 66.0, 67.0], "value": 67.1, "unit": "score"}], "name": "kraken", "value": 1507.5, "alertThreshold": 2.0}]} 17:01:00 INFO - Return code: 0 17:01:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:01:00 INFO - # TBPL SUCCESS # 17:01:00 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:01:00 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:01:00 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:01:00 INFO - 2016-08-22 17:01:00.833 screenresolution[1659:9870] starting screenresolution argv=screenresolution get 17:01:00 INFO - 2016-08-22 17:01:00.837 screenresolution[1659:9870] Display 0: 1600x1200x32@60 17:01:00 INFO - 2016-08-22 17:01:00.843 screenresolution[1660:9873] starting screenresolution argv=screenresolution list 17:01:00 INFO - Available Modes on Display 0 17:01:00 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:01:00 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:01:00 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:01:00 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:01:01 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:01:01 INFO - Intel Iris: 17:01:01 INFO - Chipset Model: Intel Iris 17:01:01 INFO - Type: GPU 17:01:01 INFO - Bus: Built-In 17:01:01 INFO - VRAM (Dynamic, Max): 1536 MB 17:01:01 INFO - Vendor: Intel (0x8086) 17:01:01 INFO - Device ID: 0x0a2e 17:01:01 INFO - Revision ID: 0x0009 17:01:01 INFO - Displays: 17:01:01 INFO - Display: 17:01:01 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:01:01 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:01:01 INFO - Display Serial Number: 1600x1200 60 17:01:01 INFO - Main Display: Yes 17:01:01 INFO - Mirror: Off 17:01:01 INFO - Online: Yes 17:01:01 INFO - Rotation: Supported 17:01:01 INFO - Return code: 0 17:01:01 INFO - Running post-action listener: _resource_record_post_action 17:01:01 INFO - [mozharness: 2016-08-23 00:01:01.078637Z] Finished run-tests step (success) 17:01:01 INFO - Running post-run listener: _resource_record_post_run 17:01:01 INFO - Total resource usage - Wall time: 1213s; CPU: 54.0%; Read bytes: 38237184; Write bytes: 702531584; Read time: 374; Write time: 1893 17:01:01 INFO - TinderboxPrint: CPU usage
53.6% 17:01:01 INFO - TinderboxPrint: I/O read bytes / time
38,237,184 / 374 17:01:01 INFO - TinderboxPrint: I/O write bytes / time
702,531,584 / 1,893 17:01:01 INFO - TinderboxPrint: CPU idle
2,251.4 (46.4%) 17:01:01 INFO - TinderboxPrint: CPU system
973.9 (20.1%) 17:01:01 INFO - TinderboxPrint: CPU user
1,628.4 (33.6%) 17:01:01 INFO - TinderboxPrint: Swap in / out
444,162,048 / 0 17:01:01 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 384993792; Write bytes: 379635712; Read time: 29170; Write time: 716 17:01:01 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 37270528; Write bytes: 293191680; Read time: 358; Write time: 1119 17:01:01 INFO - Running post-run listener: _upload_blobber_files 17:01:01 INFO - Blob upload gear active. 17:01:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:01:01 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 17:01:01 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'] 17:01:01 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 17:01:01 INFO - (blobuploader) - INFO - Open directory for files ... 17:01:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:01:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:01:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:01:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:01:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:01:02 INFO - (blobuploader) - INFO - Done attempting. 17:01:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:01:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:01:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:01:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:01:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:01:03 INFO - (blobuploader) - INFO - Done attempting. 17:01:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:01:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:01:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:01:07 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:01:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:01:07 INFO - (blobuploader) - INFO - Done attempting. 17:01:07 INFO - (blobuploader) - INFO - Iteration through files over. 17:01:07 INFO - Return code: 0 17:01:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:01:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:01:07 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/ee77331c0d34b39aaae735b8522d96dc8c377e317a3ced6362b2dc0f5bd15b66b881e1a0caa7fd5342174682ad5c17b1d2fbb45755951371580e73c7b80ff724", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/7cc67022d230d567b997c03f47e9b43787a571c56450eb6f50b128a95b36c7e833129f51b447369893819901092089e9eee8008d6722bb0ade447adc2a158cbb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/1450cf07913493c420fde52430b9561a5dace1d8d20e1fdcd9c54aab67a4d223425529bb22d51e304c58ed24cc4d1fc6eb793fa466079dcf2a4d8fac4a2ab1e7"} 17:01:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:01:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:01:07 INFO - Contents: 17:01:07 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/ee77331c0d34b39aaae735b8522d96dc8c377e317a3ced6362b2dc0f5bd15b66b881e1a0caa7fd5342174682ad5c17b1d2fbb45755951371580e73c7b80ff724", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/7cc67022d230d567b997c03f47e9b43787a571c56450eb6f50b128a95b36c7e833129f51b447369893819901092089e9eee8008d6722bb0ade447adc2a158cbb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/1450cf07913493c420fde52430b9561a5dace1d8d20e1fdcd9c54aab67a4d223425529bb22d51e304c58ed24cc4d1fc6eb793fa466079dcf2a4d8fac4a2ab1e7"} 17:01:07 INFO - Running post-run listener: copy_logs_to_upload_dir 17:01:07 INFO - Copying logs to upload dir... 17:01:07 INFO - mkdir: /builds/slave/test/build/upload/logs 17:01:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1275.887468 ========= master_lag: 4.50 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2016-08-22 17:01:11.798980) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-22 17:01:11.802163) ========= 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.iLmjzJt7Uf/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.HziM8vcF2H/Listeners TMPDIR=/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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/ee77331c0d34b39aaae735b8522d96dc8c377e317a3ced6362b2dc0f5bd15b66b881e1a0caa7fd5342174682ad5c17b1d2fbb45755951371580e73c7b80ff724", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/7cc67022d230d567b997c03f47e9b43787a571c56450eb6f50b128a95b36c7e833129f51b447369893819901092089e9eee8008d6722bb0ade447adc2a158cbb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/1450cf07913493c420fde52430b9561a5dace1d8d20e1fdcd9c54aab67a4d223425529bb22d51e304c58ed24cc4d1fc6eb793fa466079dcf2a4d8fac4a2ab1e7"} build_url:https://queue.taskcluster.net/v1/task/dzq8yXiKSMqfiScuI7jkFA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011833 build_url: 'https://queue.taskcluster.net/v1/task/dzq8yXiKSMqfiScuI7jkFA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/ee77331c0d34b39aaae735b8522d96dc8c377e317a3ced6362b2dc0f5bd15b66b881e1a0caa7fd5342174682ad5c17b1d2fbb45755951371580e73c7b80ff724", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/7cc67022d230d567b997c03f47e9b43787a571c56450eb6f50b128a95b36c7e833129f51b447369893819901092089e9eee8008d6722bb0ade447adc2a158cbb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/1450cf07913493c420fde52430b9561a5dace1d8d20e1fdcd9c54aab67a4d223425529bb22d51e304c58ed24cc4d1fc6eb793fa466079dcf2a4d8fac4a2ab1e7"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-22 17:01:11.840177) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 17:01:11.840461) ========= 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.iLmjzJt7Uf/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.HziM8vcF2H/Listeners TMPDIR=/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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.005224 ========= master_lag: 0.67 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 17:01:12.514809) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-22 17:01:12.515118) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-22 17:01:12.515550) ========= ========= Total master_lag: 5.39 =========