builder: autoland_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0063 starttime: 1472541762.52 results: success (0) buildid: 20160829225021 builduid: 5aaae1b1da6d408795427a8926c6102b revision: e11d9697af59672994c6cdc309c97564078b7dc1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-30 00:22:42.522704) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-30 00:22:42.523746) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-30 00:22:42.524447) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-30 00:22:42.549095) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 00:22:42.549797) ========= 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.GyJGWNINcd/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.wzxvG2mf3m/Listeners TMPDIR=/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/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-30 00:22:42-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 21.2M=0.001s 2016-08-30 00:22:42 (21.2 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.079952 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 00:22:42.657827) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 00:22:42.658537) ========= 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.GyJGWNINcd/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.wzxvG2mf3m/Listeners TMPDIR=/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/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.021032 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 00:22:42.711170) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-30 00:22:42.711985) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev e11d9697af59672994c6cdc309c97564078b7dc1 --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 e11d9697af59672994c6cdc309c97564078b7dc1 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.GyJGWNINcd/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.wzxvG2mf3m/Listeners TMPDIR=/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/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-30 00:22:42,781 truncating revision to first 12 chars 2016-08-30 00:22:42,782 Setting DEBUG logging. 2016-08-30 00:22:42,782 attempt 1/10 2016-08-30 00:22:42,782 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/e11d9697af59?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-30 00:22:44,138 unpacking tar archive at: autoland-e11d9697af59/testing/mozharness/ program finished with exit code 0 elapsedTime=1.604479 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-30 00:22:44.344584) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-30 00:22:44.345395) ========= script_repo_revision: e11d9697af59672994c6cdc309c97564078b7dc1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-30 00:22:44.345871) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-30 00:22:44.346176) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-30 00:22:44.365986) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-08-30 00:22:44.366732) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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.GyJGWNINcd/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.wzxvG2mf3m/Listeners TMPDIR=/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/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 00:22:44 INFO - MultiFileLogger online at 20160830 00:22:44 in /builds/slave/test 00:22:44 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 00:22:44 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 00:22:44 INFO - {'append_to_log': False, 00:22:44 INFO - 'base_work_dir': '/builds/slave/test', 00:22:44 INFO - 'blob_upload_branch': 'Autoland', 00:22:44 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 00:22:44 INFO - 'branch': 'Autoland', 00:22:44 INFO - 'buildbot_json_path': 'buildprops.json', 00:22:44 INFO - 'config_files': ('talos/mac_config.py',), 00:22:44 INFO - 'default_actions': ('clobber', 00:22:44 INFO - 'read-buildbot-config', 00:22:44 INFO - 'download-and-extract', 00:22:44 INFO - 'populate-webroot', 00:22:44 INFO - 'create-virtualenv', 00:22:44 INFO - 'install', 00:22:44 INFO - 'run-tests'), 00:22:44 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 00:22:44 INFO - 'download_minidump_stackwalk': True, 00:22:44 INFO - 'download_symbols': 'ondemand', 00:22:44 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 00:22:44 INFO - 'tooltool.py': '/tools/tooltool.py', 00:22:44 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 00:22:44 INFO - '/tools/misc-python/virtualenv.py')}, 00:22:44 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 00:22:44 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 00:22:44 INFO - 'installer_path': 'installer.exe', 00:22:44 INFO - 'log_level': 'info', 00:22:44 INFO - 'log_name': 'talos', 00:22:44 INFO - 'log_to_console': True, 00:22:44 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 00:22:44 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 00:22:44 INFO - 'opt_config_files': (), 00:22:44 INFO - 'pip_index': False, 00:22:44 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 00:22:44 INFO - 'cmd': ('bash', 00:22:44 INFO - '-c', 00:22:44 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 00:22:44 INFO - 'enabled': True, 00:22:44 INFO - 'halt_on_failure': False, 00:22:44 INFO - 'name': 'check_screen_resolution'},), 00:22:44 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 00:22:44 INFO - 'cmd': ('bash', 00:22:44 INFO - '-c', 00:22:44 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 00:22:44 INFO - 'enabled': True, 00:22:44 INFO - 'halt_on_failure': False, 00:22:44 INFO - 'name': 'check_screen_resolution'},), 00:22:44 INFO - 'run_cmd_checks_enabled': True, 00:22:44 INFO - 'sps_profile': False, 00:22:44 INFO - 'sps_profile_interval': 0, 00:22:44 INFO - 'suite': 'dromaeojs-e10s', 00:22:44 INFO - 'system_bits': '32', 00:22:44 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 00:22:44 INFO - 'title': 't-yosemite-r7-0063', 00:22:44 INFO - 'tooltool_cache': '/builds/tooltool_cache', 00:22:44 INFO - 'use_talos_json': True, 00:22:44 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 00:22:44 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 00:22:44 INFO - 'work_dir': 'build'} 00:22:44 INFO - [mozharness: 2016-08-30 07:22:44.554935Z] Running clobber step. 00:22:44 INFO - Running pre-action listener: _resource_record_pre_action 00:22:44 INFO - Running main action method: clobber 00:22:44 INFO - rmtree: /builds/slave/test/build 00:22:44 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 00:22:45 INFO - Running post-action listener: _resource_record_post_action 00:22:45 INFO - [mozharness: 2016-08-30 07:22:45.419283Z] Finished clobber step (success) 00:22:45 INFO - [mozharness: 2016-08-30 07:22:45.419432Z] Running read-buildbot-config step. 00:22:45 INFO - Running pre-action listener: _resource_record_pre_action 00:22:45 INFO - Running main action method: read_buildbot_config 00:22:45 INFO - Using buildbot properties: 00:22:45 INFO - { 00:22:45 INFO - "project": "", 00:22:45 INFO - "product": "firefox", 00:22:45 INFO - "script_repo_revision": "production", 00:22:45 INFO - "builddir": "autoland_yosemite_r7_test-dromaeojs-e10s", 00:22:45 INFO - "repository": "", 00:22:45 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 autoland talos dromaeojs-e10s", 00:22:45 INFO - "buildid": "20160829225021", 00:22:45 INFO - "pgo_build": "False", 00:22:45 INFO - "basedir": "/builds/slave/test", 00:22:45 INFO - "buildnumber": 156, 00:22:45 INFO - "slavename": "t-yosemite-r7-0063", 00:22:45 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 00:22:45 INFO - "platform": "yosemite_r7", 00:22:45 INFO - "scheduler": "tests-autoland-macosx64-talos-7-3600", 00:22:45 INFO - "branch": "autoland", 00:22:45 INFO - "repo_path": "integration/autoland", 00:22:45 INFO - "revision": "e11d9697af59672994c6cdc309c97564078b7dc1", 00:22:45 INFO - "stage_platform": "macosx64", 00:22:45 INFO - "builduid": "5aaae1b1da6d408795427a8926c6102b", 00:22:45 INFO - "slavebuilddir": "test" 00:22:45 INFO - } 00:22:45 INFO - Found installer url https://queue.taskcluster.net/v1/task/VJeiAS_DSTejRTyzlr-C9A/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 00:22:45 INFO - Running post-action listener: _resource_record_post_action 00:22:45 INFO - [mozharness: 2016-08-30 07:22:45.422791Z] Finished read-buildbot-config step (success) 00:22:45 INFO - [mozharness: 2016-08-30 07:22:45.422930Z] Running download-and-extract step. 00:22:45 INFO - Running pre-action listener: _resource_record_pre_action 00:22:45 INFO - Running main action method: download_and_extract 00:22:45 INFO - mkdir: /builds/slave/test/build/tests 00:22: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')]} 00:22:45 INFO - trying https://queue.taskcluster.net/v1/task/VJeiAS_DSTejRTyzlr-C9A/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 00:22:45 INFO - Downloading https://queue.taskcluster.net/v1/task/VJeiAS_DSTejRTyzlr-C9A/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 00:22:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VJeiAS_DSTejRTyzlr-C9A/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 00:22:46 INFO - Downloaded 1199 bytes. 00:22:46 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 00:22:46 INFO - Using the following test package requirements: 00:22:46 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 00:22:46 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 00:22:46 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 00:22:46 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 00:22:46 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 00:22:46 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 00:22:46 INFO - u'jsshell-mac.zip'], 00:22:46 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 00:22:46 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 00:22:46 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 00:22:46 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 00:22:46 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 00:22:46 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 00:22:46 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 00:22:46 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 00:22:46 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 00:22:46 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 00:22:46 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 00:22:46 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 00:22: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')]} 00:22:46 INFO - trying https://queue.taskcluster.net/v1/task/VJeiAS_DSTejRTyzlr-C9A/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 00:22:46 INFO - Downloading https://queue.taskcluster.net/v1/task/VJeiAS_DSTejRTyzlr-C9A/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 00:22:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VJeiAS_DSTejRTyzlr-C9A/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 00:22:47 INFO - Downloaded 16380454 bytes. 00:22:47 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 00:22:54 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 00:22:54 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')]} 00:22:54 INFO - trying https://queue.taskcluster.net/v1/task/VJeiAS_DSTejRTyzlr-C9A/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 00:22:54 INFO - Downloading https://queue.taskcluster.net/v1/task/VJeiAS_DSTejRTyzlr-C9A/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 00:22:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VJeiAS_DSTejRTyzlr-C9A/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 00:22:55 INFO - Downloaded 16380454 bytes. 00:22:55 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 00:23: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')]} 00:23:02 INFO - trying https://queue.taskcluster.net/v1/task/VJeiAS_DSTejRTyzlr-C9A/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 00:23:02 INFO - Downloading https://queue.taskcluster.net/v1/task/VJeiAS_DSTejRTyzlr-C9A/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 00:23:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VJeiAS_DSTejRTyzlr-C9A/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 00:23:04 INFO - Downloaded 14413998 bytes. 00:23:04 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/tests 00:23:04 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')]} 00:23:04 INFO - trying https://queue.taskcluster.net/v1/task/VJeiAS_DSTejRTyzlr-C9A/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 00:23:04 INFO - Downloading https://queue.taskcluster.net/v1/task/VJeiAS_DSTejRTyzlr-C9A/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 00:23:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VJeiAS_DSTejRTyzlr-C9A/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 00:23:07 INFO - Downloaded 111543898 bytes. 00:23:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VJeiAS_DSTejRTyzlr-C9A/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 00:23:07 INFO - mkdir: /builds/slave/test/properties 00:23:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 00:23:07 INFO - Writing to file /builds/slave/test/properties/build_url 00:23:07 INFO - Contents: 00:23:07 INFO - build_url:https://queue.taskcluster.net/v1/task/VJeiAS_DSTejRTyzlr-C9A/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 00:23:07 INFO - Running post-action listener: _resource_record_post_action 00:23:07 INFO - Running post-action listener: set_extra_try_arguments 00:23:07 INFO - [mozharness: 2016-08-30 07:23:07.973417Z] Finished download-and-extract step (success) 00:23:07 INFO - [mozharness: 2016-08-30 07:23:07.973562Z] Running populate-webroot step. 00:23:07 INFO - Running pre-action listener: _resource_record_pre_action 00:23:07 INFO - Running main action method: populate_webroot 00:23:07 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 00:23:07 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 00:23:07 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 00:23:07 INFO - '--tppagecycles', 00:23:07 INFO - '7'], 00:23:07 INFO - 'tests': ['tsvgm']}}, 00:23:07 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 00:23:07 INFO - 'tests': ['tresize', 'tcanvasmark']}, 00:23:07 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 00:23:07 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 00:23:07 INFO - 'tests': ['dromaeo_css', 'kraken']}, 00:23:07 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 00:23:07 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:23:07 INFO - 'talos_options': ['--disable-e10s'], 00:23:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:23:07 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:23:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:23:07 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:23:07 INFO - 'talos_options': ['--disable-e10s'], 00:23:07 INFO - 'tests': ['damp', 'tps']}, 00:23:07 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:23:07 INFO - 'tests': ['damp', 'tps']}, 00:23:07 INFO - 'g3': {'talos_options': ['--disable-e10s'], 00:23:07 INFO - 'tests': ['dromaeo_dom']}, 00:23:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 00:23:07 INFO - 'g4': {'talos_options': ['--disable-e10s'], 00:23:07 INFO - 'tests': ['basic_compositor_video']}, 00:23:07 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 00:23:07 INFO - 'other': {'talos_options': ['--disable-e10s'], 00:23:07 INFO - 'tests': ['a11yr', 00:23:07 INFO - 'ts_paint', 00:23:07 INFO - 'tpaint', 00:23:07 INFO - 'sessionrestore', 00:23:07 INFO - 'sessionrestore_no_auto_restore', 00:23:07 INFO - 'tabpaint']}, 00:23:07 INFO - 'other-e10s': {'tests': ['a11yr', 00:23:07 INFO - 'ts_paint', 00:23:07 INFO - 'tpaint', 00:23:07 INFO - 'sessionrestore', 00:23:07 INFO - 'sessionrestore_no_auto_restore', 00:23:07 INFO - 'tabpaint']}, 00:23:07 INFO - 'other-e10s_l64': {'tests': ['a11yr', 00:23:07 INFO - 'ts_paint', 00:23:07 INFO - 'tpaint', 00:23:07 INFO - 'sessionrestore', 00:23:07 INFO - 'sessionrestore_no_auto_restore', 00:23:07 INFO - 'tabpaint']}, 00:23:07 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 00:23:07 INFO - 'ts_paint', 00:23:07 INFO - 'tpaint', 00:23:07 INFO - 'sessionrestore', 00:23:07 INFO - 'sessionrestore_no_auto_restore', 00:23:07 INFO - 'tabpaint']}, 00:23:07 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 00:23:07 INFO - 'tests': ['a11yr', 00:23:07 INFO - 'ts_paint', 00:23:07 INFO - 'tpaint', 00:23:07 INFO - 'sessionrestore', 00:23:07 INFO - 'sessionrestore_no_auto_restore', 00:23:07 INFO - 'tabpaint']}, 00:23:07 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 00:23:07 INFO - 'tests': ['a11yr', 00:23:07 INFO - 'ts_paint', 00:23:07 INFO - 'tpaint', 00:23:07 INFO - 'sessionrestore', 00:23:07 INFO - 'sessionrestore_no_auto_restore', 00:23:07 INFO - 'tabpaint']}, 00:23:07 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 00:23:07 INFO - 'tests': ['tsvgx', 00:23:07 INFO - 'tsvgr_opacity', 00:23:07 INFO - 'tart', 00:23:07 INFO - 'tscrollx', 00:23:07 INFO - 'cart']}, 00:23:07 INFO - 'svgr-e10s': {'tests': ['tsvgx', 00:23:07 INFO - 'tsvgr_opacity', 00:23:07 INFO - 'tart', 00:23:07 INFO - 'tscrollx', 00:23:07 INFO - 'cart']}, 00:23:07 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:23:07 INFO - 'talos_options': ['--disable-e10s'], 00:23:07 INFO - 'tests': ['tp5o']}, 00:23:07 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:23:07 INFO - 'tests': ['tp5o']}, 00:23:07 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:23:07 INFO - 'talos_options': ['--disable-e10s', 00:23:07 INFO - '--xperf_path', 00:23:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:23:07 INFO - 'tests': ['tp5n']}, 00:23:07 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:23:07 INFO - 'talos_options': ['--xperf_path', 00:23:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:23:07 INFO - 'tests': ['tp5n']}}, 00:23:07 INFO - 'talos.zip': {'path': '', 00:23:07 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 00:23:07 INFO - Running post-action listener: _resource_record_post_action 00:23:07 INFO - [mozharness: 2016-08-30 07:23:07.991806Z] Finished populate-webroot step (success) 00:23:07 INFO - [mozharness: 2016-08-30 07:23:07.991937Z] Running create-virtualenv step. 00:23:07 INFO - Running pre-action listener: _resource_record_pre_action 00:23:07 INFO - Running main action method: create_virtualenv 00:23:07 INFO - Creating virtualenv /builds/slave/test/build/venv 00:23:07 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 00:23:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 00:23:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 00:23:08 INFO - Using real prefix '/tools/python27' 00:23:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 00:23:08 INFO - Installing distribute.............................................................................................................................................................................................done. 00:23:11 INFO - Installing pip.................done. 00:23:11 INFO - Return code: 0 00:23:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 00:23: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')]} 00:23:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:23:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:23: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')]} 00:23:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:23:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:23:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107b52a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107be7618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbd32482060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ab6d30>, '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 0x10781bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107aaeb20>, '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.GyJGWNINcd/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.wzxvG2mf3m/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/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 00:23:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 00:23:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 00:23:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GyJGWNINcd/Render', 00:23:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:23:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:23:11 INFO - 'HOME': '/Users/cltbld', 00:23:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:23:11 INFO - 'LOGNAME': 'cltbld', 00:23:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:23:11 INFO - 'MOZ_NO_REMOTE': '1', 00:23:11 INFO - 'NO_EM_RESTART': '1', 00:23:11 INFO - 'PAGER': '/bin/cat', 00:23:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:23:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:23:11 INFO - 'PWD': '/builds/slave/test', 00:23:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:23:11 INFO - 'SHELL': '/bin/bash', 00:23:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wzxvG2mf3m/Listeners', 00:23:11 INFO - 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/', 00:23:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:23:11 INFO - 'USER': 'cltbld', 00:23:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:23:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:23:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:23:11 INFO - 'XPC_FLAGS': '0x0', 00:23:11 INFO - 'XPC_SERVICE_NAME': '0', 00:23:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:23:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:23:11 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 00:23:11 INFO - Cleaning up... 00:23:11 INFO - Return code: 0 00:23:11 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 00:23: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')]} 00:23:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:23:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:23: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')]} 00:23:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:23:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:23:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107b52a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107be7618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbd32482060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ab6d30>, '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 0x10781bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107aaeb20>, '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.GyJGWNINcd/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.wzxvG2mf3m/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/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 00:23:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 00:23:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 00:23:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GyJGWNINcd/Render', 00:23:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:23:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:23:11 INFO - 'HOME': '/Users/cltbld', 00:23:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:23:11 INFO - 'LOGNAME': 'cltbld', 00:23:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:23:11 INFO - 'MOZ_NO_REMOTE': '1', 00:23:11 INFO - 'NO_EM_RESTART': '1', 00:23:11 INFO - 'PAGER': '/bin/cat', 00:23:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:23:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:23:11 INFO - 'PWD': '/builds/slave/test', 00:23:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:23:11 INFO - 'SHELL': '/bin/bash', 00:23:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wzxvG2mf3m/Listeners', 00:23:11 INFO - 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/', 00:23:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:23:11 INFO - 'USER': 'cltbld', 00:23:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:23:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:23:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:23:11 INFO - 'XPC_FLAGS': '0x0', 00:23:11 INFO - 'XPC_SERVICE_NAME': '0', 00:23:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:23:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:23:12 INFO - Downloading/unpacking psutil>=3.1.1 00:23:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:23:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:23:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:23:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:23:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:23:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:23:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 00:23:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:23:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:23:15 INFO - Installing collected packages: psutil 00:23:15 INFO - Running setup.py install for psutil 00:23:15 INFO - building 'psutil._psutil_osx' extension 00:23:15 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 00:23:15 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 00:23:15 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 00:23:16 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 00:23:16 INFO - building 'psutil._psutil_posix' extension 00:23:16 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 00:23:16 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 00:23:16 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 00:23:16 INFO - ^ 00:23:16 INFO - 1 warning generated. 00:23:16 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 00:23:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:23:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:23:16 INFO - Successfully installed psutil 00:23:16 INFO - Cleaning up... 00:23:16 INFO - Return code: 0 00:23:16 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 00:23:16 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')]} 00:23:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:23:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:23:16 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')]} 00:23:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:23:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:23:16 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 0x107b52a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107be7618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbd32482060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ab6d30>, '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 0x10781bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107aaeb20>, '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.GyJGWNINcd/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.wzxvG2mf3m/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/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 00:23:16 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 00:23:16 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 00:23:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GyJGWNINcd/Render', 00:23:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:23:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:23:16 INFO - 'HOME': '/Users/cltbld', 00:23:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:23:16 INFO - 'LOGNAME': 'cltbld', 00:23:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:23:16 INFO - 'MOZ_NO_REMOTE': '1', 00:23:16 INFO - 'NO_EM_RESTART': '1', 00:23:16 INFO - 'PAGER': '/bin/cat', 00:23:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:23:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:23:16 INFO - 'PWD': '/builds/slave/test', 00:23:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:23:16 INFO - 'SHELL': '/bin/bash', 00:23:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wzxvG2mf3m/Listeners', 00:23:16 INFO - 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/', 00:23:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:23:16 INFO - 'USER': 'cltbld', 00:23:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:23:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:23:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:23:16 INFO - 'XPC_FLAGS': '0x0', 00:23:16 INFO - 'XPC_SERVICE_NAME': '0', 00:23:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:23:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:23:16 INFO - Downloading/unpacking mozsystemmonitor==0.3 00:23:16 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 00:23:16 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 00:23:16 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 00:23:16 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 00:23:16 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 00:23:16 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 00:23:19 INFO - Downloading mozsystemmonitor-0.3.tar.gz 00:23:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 00:23:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 00:23:19 INFO - Installing collected packages: mozsystemmonitor 00:23:19 INFO - Running setup.py install for mozsystemmonitor 00:23:19 INFO - Successfully installed mozsystemmonitor 00:23:19 INFO - Cleaning up... 00:23:19 INFO - Return code: 0 00:23:19 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 00:23: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')]} 00:23:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:23:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:23: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')]} 00:23:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:23:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:23:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107b52a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107be7618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbd32482060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ab6d30>, '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 0x10781bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107aaeb20>, '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.GyJGWNINcd/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.wzxvG2mf3m/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/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 00:23:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 00:23:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 00:23:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GyJGWNINcd/Render', 00:23:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:23:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:23:19 INFO - 'HOME': '/Users/cltbld', 00:23:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:23:19 INFO - 'LOGNAME': 'cltbld', 00:23:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:23:19 INFO - 'MOZ_NO_REMOTE': '1', 00:23:19 INFO - 'NO_EM_RESTART': '1', 00:23:19 INFO - 'PAGER': '/bin/cat', 00:23:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:23:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:23:19 INFO - 'PWD': '/builds/slave/test', 00:23:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:23:19 INFO - 'SHELL': '/bin/bash', 00:23:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wzxvG2mf3m/Listeners', 00:23:19 INFO - 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/', 00:23:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:23:19 INFO - 'USER': 'cltbld', 00:23:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:23:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:23:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:23:19 INFO - 'XPC_FLAGS': '0x0', 00:23:19 INFO - 'XPC_SERVICE_NAME': '0', 00:23:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:23:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:23:19 INFO - Downloading/unpacking jsonschema==2.5.1 00:23: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 00:23: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 00:23: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 00:23: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 00:23: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 00:23: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 00:23:22 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 00:23:22 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 00:23:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:23:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:23:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:23:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:23:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:23:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:23:22 INFO - Downloading functools32-3.2.3-2.tar.gz 00:23:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 00:23:22 INFO - warning: no files found matching '*.txt' 00:23:22 INFO - no previously-included directories found matching 'build' 00:23:22 INFO - no previously-included directories found matching 'dist' 00:23:22 INFO - no previously-included directories found matching '.git*' 00:23:22 INFO - Installing collected packages: jsonschema, functools32 00:23:22 INFO - Running setup.py install for functools32 00:23:22 INFO - warning: no files found matching '*.txt' 00:23:22 INFO - no previously-included directories found matching 'build' 00:23:22 INFO - no previously-included directories found matching 'dist' 00:23:22 INFO - no previously-included directories found matching '.git*' 00:23:22 INFO - Successfully installed jsonschema functools32 00:23:22 INFO - Cleaning up... 00:23:23 INFO - Return code: 0 00:23:23 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 00:23:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:23:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:23:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:23:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:23:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:23:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:23:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107b52a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107be7618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbd32482060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ab6d30>, '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 0x10781bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107aaeb20>, '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.GyJGWNINcd/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.wzxvG2mf3m/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/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 00:23:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 00:23:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 00:23:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GyJGWNINcd/Render', 00:23:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:23:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:23:23 INFO - 'HOME': '/Users/cltbld', 00:23:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:23:23 INFO - 'LOGNAME': 'cltbld', 00:23:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:23:23 INFO - 'MOZ_NO_REMOTE': '1', 00:23:23 INFO - 'NO_EM_RESTART': '1', 00:23:23 INFO - 'PAGER': '/bin/cat', 00:23:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:23:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:23:23 INFO - 'PWD': '/builds/slave/test', 00:23:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:23:23 INFO - 'SHELL': '/bin/bash', 00:23:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wzxvG2mf3m/Listeners', 00:23:23 INFO - 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/', 00:23:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:23:23 INFO - 'USER': 'cltbld', 00:23:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:23:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:23:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:23:23 INFO - 'XPC_FLAGS': '0x0', 00:23:23 INFO - 'XPC_SERVICE_NAME': '0', 00:23:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:23:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:23:23 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 00:23:23 INFO - Cleaning up... 00:23:23 INFO - Return code: 0 00:23:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 00:23:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:23:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:23:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:23:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:23:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:23:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:23:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107b52a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107be7618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbd32482060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ab6d30>, '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 0x10781bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107aaeb20>, '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.GyJGWNINcd/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.wzxvG2mf3m/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/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 00:23:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 00:23:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 00:23:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GyJGWNINcd/Render', 00:23:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:23:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:23:23 INFO - 'HOME': '/Users/cltbld', 00:23:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:23:23 INFO - 'LOGNAME': 'cltbld', 00:23:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:23:23 INFO - 'MOZ_NO_REMOTE': '1', 00:23:23 INFO - 'NO_EM_RESTART': '1', 00:23:23 INFO - 'PAGER': '/bin/cat', 00:23:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:23:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:23:23 INFO - 'PWD': '/builds/slave/test', 00:23:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:23:23 INFO - 'SHELL': '/bin/bash', 00:23:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wzxvG2mf3m/Listeners', 00:23:23 INFO - 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/', 00:23:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:23:23 INFO - 'USER': 'cltbld', 00:23:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:23:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:23:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:23:23 INFO - 'XPC_FLAGS': '0x0', 00:23:23 INFO - 'XPC_SERVICE_NAME': '0', 00:23:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:23:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:23:23 INFO - Downloading/unpacking blobuploader==1.2.4 00:23:23 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 00:23:23 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 00:23:23 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 00:23:23 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 00:23:23 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 00:23:23 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 00:23:25 INFO - Downloading blobuploader-1.2.4.tar.gz 00:23:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 00:23:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 00:23:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:23:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:23:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:23:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:23:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:23:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:23:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 00:23:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 00:23:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:23:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:23:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:23:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:23:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:23:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:23:27 INFO - Downloading docopt-0.6.1.tar.gz 00:23:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 00:23:27 INFO - Installing collected packages: blobuploader, requests, docopt 00:23:27 INFO - Running setup.py install for blobuploader 00:23:27 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 00:23:27 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 00:23:27 INFO - Running setup.py install for requests 00:23:27 INFO - Running setup.py install for docopt 00:23:28 INFO - Successfully installed blobuploader requests docopt 00:23:28 INFO - Cleaning up... 00:23:28 INFO - Return code: 0 00:23:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:23:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:23:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:23:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:23:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:23:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:23:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:23:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107b52a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107be7618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbd32482060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ab6d30>, '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 0x10781bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107aaeb20>, '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.GyJGWNINcd/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.wzxvG2mf3m/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/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 00:23:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 00:23:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 00:23:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GyJGWNINcd/Render', 00:23:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:23:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:23:28 INFO - 'HOME': '/Users/cltbld', 00:23:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:23:28 INFO - 'LOGNAME': 'cltbld', 00:23:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:23:28 INFO - 'MOZ_NO_REMOTE': '1', 00:23:28 INFO - 'NO_EM_RESTART': '1', 00:23:28 INFO - 'PAGER': '/bin/cat', 00:23:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:23:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:23:28 INFO - 'PWD': '/builds/slave/test', 00:23:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:23:28 INFO - 'SHELL': '/bin/bash', 00:23:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wzxvG2mf3m/Listeners', 00:23:28 INFO - 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/', 00:23:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:23:28 INFO - 'USER': 'cltbld', 00:23:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:23:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:23:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:23:28 INFO - 'XPC_FLAGS': '0x0', 00:23:28 INFO - 'XPC_SERVICE_NAME': '0', 00:23:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:23:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:23:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:23:28 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-0ZFYJg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:23:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:23:28 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-GS_MPJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:23:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:23:28 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-VUj7OU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:23:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:23:28 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-lP1H9T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:23:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:23:28 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-u5vbLS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:23:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:23:28 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-stzdEn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:23:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:23:29 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-UmdkWD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:23:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:23:29 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-m9azlT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:23:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:23:29 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-VlHeLL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:23:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:23:29 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-7SDXrF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:23:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:23:29 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-TW_XpW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:23:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:23:29 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-vD0GNa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:23:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:23:29 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-tMING5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:23:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:23:29 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-_F_oNk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:23:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:23:29 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-eK5KsI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:23:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:23:29 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-cPw0fG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:23:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:23:30 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-TwZtnF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:23:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 00:23:30 INFO - Running setup.py install for manifestparser 00:23:30 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 00:23:30 INFO - Running setup.py install for mozcrash 00:23:30 INFO - Running setup.py install for mozdebug 00:23:30 INFO - Running setup.py install for mozdevice 00:23:30 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 00:23:30 INFO - Installing dm script to /builds/slave/test/build/venv/bin 00:23:30 INFO - Running setup.py install for mozfile 00:23:30 INFO - Running setup.py install for mozhttpd 00:23:31 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 00:23:31 INFO - Running setup.py install for mozinfo 00:23:31 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 00:23:31 INFO - Running setup.py install for mozInstall 00:23:31 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 00:23:31 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 00:23:31 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 00:23:31 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 00:23:31 INFO - Running setup.py install for mozleak 00:23:31 INFO - Running setup.py install for mozlog 00:23:31 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 00:23:31 INFO - Running setup.py install for moznetwork 00:23:31 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 00:23:31 INFO - Running setup.py install for mozprocess 00:23:31 INFO - Running setup.py install for mozprofile 00:23:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 00:23:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 00:23:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 00:23:32 INFO - Running setup.py install for mozrunner 00:23:32 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 00:23:32 INFO - Running setup.py install for mozscreenshot 00:23:32 INFO - Running setup.py install for moztest 00:23:32 INFO - Running setup.py install for mozversion 00:23:32 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 00:23:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 00:23:32 INFO - Cleaning up... 00:23:32 INFO - Return code: 0 00:23:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:23:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:23:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:23:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:23:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:23:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:23:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:23:32 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 0x107b52a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107be7618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbd32482060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ab6d30>, '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 0x10781bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107aaeb20>, '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.GyJGWNINcd/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.wzxvG2mf3m/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/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 00:23:32 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 00:23:32 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 00:23:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GyJGWNINcd/Render', 00:23:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:23:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:23:32 INFO - 'HOME': '/Users/cltbld', 00:23:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:23:32 INFO - 'LOGNAME': 'cltbld', 00:23:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:23:32 INFO - 'MOZ_NO_REMOTE': '1', 00:23:32 INFO - 'NO_EM_RESTART': '1', 00:23:32 INFO - 'PAGER': '/bin/cat', 00:23:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:23:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:23:32 INFO - 'PWD': '/builds/slave/test', 00:23:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:23:32 INFO - 'SHELL': '/bin/bash', 00:23:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wzxvG2mf3m/Listeners', 00:23:32 INFO - 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/', 00:23:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:23:32 INFO - 'USER': 'cltbld', 00:23:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:23:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:23:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:23:32 INFO - 'XPC_FLAGS': '0x0', 00:23:32 INFO - 'XPC_SERVICE_NAME': '0', 00:23:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:23:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:23:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:23:33 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-i6i9bT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:23:33 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 00:23:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:23:33 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-Ty1OZ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:23:33 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)) 00:23:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:23:33 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-1KIaSk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:23:33 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)) 00:23:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:23:33 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-XQJWep-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:23:33 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)) 00:23:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:23:33 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-G4kCvo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:23:33 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)) 00:23:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:23:33 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-RCx3Yl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:23:33 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)) 00:23:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:23:33 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-gADAFY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:23:33 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)) 00:23:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:23:33 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-zsWQWU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:23:33 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)) 00:23:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:23:33 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-8HWavi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:23:33 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)) 00:23:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:23:33 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-tLIezF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:23:34 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)) 00:23:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:23:34 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-ZwWlJO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:23:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 00:23:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:23:34 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-VpWnEf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:23:34 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)) 00:23:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:23:34 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-hK1oeG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:23:34 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)) 00:23:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:23:34 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-ve_dG4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:23:34 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)) 00:23:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:23:34 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-pQkZiS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:23:34 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)) 00:23:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:23:34 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-zHpcbB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:23:34 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)) 00:23:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:23:34 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-Ev96CN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:23:34 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)) 00:23:34 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)) 00:23:34 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)) 00:23:34 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)) 00:23:34 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)) 00:23:34 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)) 00:23:34 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 00:23: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 00:23: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 00:23: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 00:23: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 00:23: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 00:23: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 00:23:37 INFO - Downloading blessings-1.6.tar.gz 00:23:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 00:23:37 INFO - Installing collected packages: blessings 00:23:37 INFO - Running setup.py install for blessings 00:23:37 INFO - Successfully installed blessings 00:23:37 INFO - Cleaning up... 00:23:37 INFO - Return code: 0 00:23:37 INFO - Done creating virtualenv /builds/slave/test/build/venv. 00:23:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:23:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:23:37 INFO - Reading from file tmpfile_stdout 00:23:37 INFO - Current package versions: 00:23:37 INFO - blessings == 1.6 00:23:37 INFO - blobuploader == 1.2.4 00:23:37 INFO - docopt == 0.6.1 00:23:37 INFO - functools32 == 3.2.3-2 00:23:37 INFO - jsonschema == 2.5.1 00:23:37 INFO - manifestparser == 1.1 00:23:37 INFO - mozInstall == 1.12 00:23:37 INFO - mozcrash == 0.17 00:23:37 INFO - mozdebug == 0.1 00:23:37 INFO - mozdevice == 0.48 00:23:37 INFO - mozfile == 1.2 00:23:37 INFO - mozhttpd == 0.7 00:23:37 INFO - mozinfo == 0.9 00:23:37 INFO - mozleak == 0.1 00:23:37 INFO - mozlog == 3.3 00:23:37 INFO - moznetwork == 0.27 00:23:37 INFO - mozprocess == 0.23 00:23:37 INFO - mozprofile == 0.28 00:23:37 INFO - mozrunner == 6.12 00:23:37 INFO - mozscreenshot == 0.1 00:23:37 INFO - mozsystemmonitor == 0.3 00:23:37 INFO - moztest == 0.7 00:23:37 INFO - mozversion == 1.4 00:23:37 INFO - psutil == 3.1.1 00:23:37 INFO - requests == 1.2.3 00:23:37 INFO - wsgiref == 0.1.2 00:23:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:23:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:23:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:23:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:23:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:23:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:23:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:23:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107b52a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107be7618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbd32482060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ab6d30>, '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 0x10781bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107aaeb20>, '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.GyJGWNINcd/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.wzxvG2mf3m/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/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 00:23:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 00:23:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 00:23:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GyJGWNINcd/Render', 00:23:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:23:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:23:37 INFO - 'HOME': '/Users/cltbld', 00:23:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:23:37 INFO - 'LOGNAME': 'cltbld', 00:23:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:23:37 INFO - 'MOZ_NO_REMOTE': '1', 00:23:37 INFO - 'NO_EM_RESTART': '1', 00:23:37 INFO - 'PAGER': '/bin/cat', 00:23:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:23:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:23:37 INFO - 'PWD': '/builds/slave/test', 00:23:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:23:37 INFO - 'SHELL': '/bin/bash', 00:23:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wzxvG2mf3m/Listeners', 00:23:37 INFO - 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/', 00:23:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:23:37 INFO - 'USER': 'cltbld', 00:23:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:23:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:23:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:23:37 INFO - 'XPC_FLAGS': '0x0', 00:23:37 INFO - 'XPC_SERVICE_NAME': '0', 00:23:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:23:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:23:38 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)) 00:23:38 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)) 00:23:38 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)) 00:23:38 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)) 00:23:38 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)) 00:23:38 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)) 00:23:38 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)) 00:23:38 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)) 00:23:38 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)) 00:23:38 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)) 00:23:38 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)) 00:23:38 INFO - Cleaning up... 00:23:38 INFO - Return code: 0 00:23:38 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 00:23:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:23:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:23:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:23:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:23:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:23:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:23:38 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 0x107b52a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107be7618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbd32482060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ab6d30>, '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 0x10781bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107aaeb20>, '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.GyJGWNINcd/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.wzxvG2mf3m/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/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 00:23:38 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 00:23:38 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 00:23:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GyJGWNINcd/Render', 00:23:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:23:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:23:38 INFO - 'HOME': '/Users/cltbld', 00:23:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:23:38 INFO - 'LOGNAME': 'cltbld', 00:23:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:23:38 INFO - 'MOZ_NO_REMOTE': '1', 00:23:38 INFO - 'NO_EM_RESTART': '1', 00:23:38 INFO - 'PAGER': '/bin/cat', 00:23:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:23:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:23:38 INFO - 'PWD': '/builds/slave/test', 00:23:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:23:38 INFO - 'SHELL': '/bin/bash', 00:23:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wzxvG2mf3m/Listeners', 00:23:38 INFO - 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/', 00:23:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:23:38 INFO - 'USER': 'cltbld', 00:23:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:23:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:23:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:23:38 INFO - 'XPC_FLAGS': '0x0', 00:23:38 INFO - 'XPC_SERVICE_NAME': '0', 00:23:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:23:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:23:38 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 00:23:38 INFO - Cleaning up... 00:23:38 INFO - Return code: 0 00:23:38 INFO - Running post-action listener: _resource_record_post_action 00:23:38 INFO - Running post-action listener: _start_resource_monitoring 00:23:38 INFO - Starting resource monitoring. 00:23:38 INFO - [mozharness: 2016-08-30 07:23:38.467136Z] Finished create-virtualenv step (success) 00:23:38 INFO - [mozharness: 2016-08-30 07:23:38.468213Z] Running install step. 00:23:38 INFO - Running pre-action listener: _resource_record_pre_action 00:23:38 INFO - Running main action method: install 00:23:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:23:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:23:38 INFO - Reading from file tmpfile_stdout 00:23:38 INFO - Detecting whether we're running mozinstall >=1.0... 00:23:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 00:23:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 00:23:38 INFO - Reading from file tmpfile_stdout 00:23:38 INFO - Output received: 00:23:38 INFO - Usage: mozinstall [options] installer 00:23:38 INFO - Options: 00:23:38 INFO - -h, --help show this help message and exit 00:23:38 INFO - -d DEST, --destination=DEST 00:23:38 INFO - Directory to install application into. [default: 00:23:38 INFO - "/builds/slave/test"] 00:23:38 INFO - --app=APP Application being installed. [default: firefox] 00:23:38 INFO - mkdir: /builds/slave/test/build/application 00:23:38 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'] 00:23:38 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 00:24:12 INFO - Reading from file tmpfile_stdout 00:24:12 INFO - Output received: 00:24:12 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 00:24:12 INFO - Running post-action listener: _resource_record_post_action 00:24:12 INFO - [mozharness: 2016-08-30 07:24:12.566087Z] Finished install step (success) 00:24:12 INFO - [mozharness: 2016-08-30 07:24:12.566232Z] Running run-tests step. 00:24:12 INFO - Running pre-action listener: _resource_record_pre_action 00:24:12 INFO - Running main action method: run_tests 00:24:12 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 00:24:12 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 00:24:12 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 00:24:12 INFO - 2016-08-30 00:24:12.580 screenresolution[2045:11983] starting screenresolution argv=screenresolution get 00:24:12 INFO - 2016-08-30 00:24:12.583 screenresolution[2045:11983] Display 0: 1600x1200x32@60 00:24:12 INFO - 2016-08-30 00:24:12.589 screenresolution[2046:11985] starting screenresolution argv=screenresolution list 00:24:12 INFO - Available Modes on Display 0 00:24:12 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 00:24:12 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 00:24:12 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 00:24:12 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 00:24:12 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 00:24:12 INFO - Intel Iris: 00:24:12 INFO - Chipset Model: Intel Iris 00:24:12 INFO - Type: GPU 00:24:12 INFO - Bus: Built-In 00:24:12 INFO - VRAM (Dynamic, Max): 1536 MB 00:24:12 INFO - Vendor: Intel (0x8086) 00:24:12 INFO - Device ID: 0x0a2e 00:24:12 INFO - Revision ID: 0x0009 00:24:12 INFO - Displays: 00:24:12 INFO - Display: 00:24:12 INFO - Resolution: 1600 x 1200 @ 60 Hz 00:24:12 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 00:24:12 INFO - Display Serial Number: 1600x1200 60 00:24:12 INFO - Main Display: Yes 00:24:12 INFO - Mirror: Off 00:24:12 INFO - Online: Yes 00:24:12 INFO - Rotation: Supported 00:24:12 INFO - Return code: 0 00:24:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 00:24:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 00:24:12 INFO - Python 2.7.3 00:24:12 INFO - Return code: 0 00:24:12 INFO - grabbing minidump binary from tooltool 00:24:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:24:12 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 0x107ab6d30>, '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 0x10781bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107aaeb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 00:24:12 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 00:24:12 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 00:24:12 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 00:24:12 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 00:24:12 INFO - Return code: 0 00:24:12 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 00:24:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 00:24:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 00:24:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 00:24:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 00:24:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VJeiAS_DSTejRTyzlr-C9A/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0063', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 00:24:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/VJeiAS_DSTejRTyzlr-C9A/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0063 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 00:24:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GyJGWNINcd/Render', 00:24:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:24:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:24:12 INFO - 'HOME': '/Users/cltbld', 00:24:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:24:12 INFO - 'LOGNAME': 'cltbld', 00:24:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 00:24:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 00:24:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:24:12 INFO - 'MOZ_NO_REMOTE': '1', 00:24:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 00:24:12 INFO - 'NO_EM_RESTART': '1', 00:24:12 INFO - 'PAGER': '/bin/cat', 00:24:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:24:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:24:12 INFO - 'PWD': '/builds/slave/test', 00:24:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 00:24:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:24:12 INFO - 'SHELL': '/bin/bash', 00:24:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wzxvG2mf3m/Listeners', 00:24:12 INFO - 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/', 00:24:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:24:12 INFO - 'USER': 'cltbld', 00:24:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:24:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:24:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:24:12 INFO - 'XPC_FLAGS': '0x0', 00:24:12 INFO - 'XPC_SERVICE_NAME': '0', 00:24:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:24:12 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VJeiAS_DSTejRTyzlr-C9A/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0063', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 00:24:13 INFO - mozversion application_buildid: 20160829225021 00:24:13 INFO - mozversion application_changeset: e11d9697af59672994c6cdc309c97564078b7dc1 00:24:13 INFO - mozversion application_display_name: Nightly 00:24:13 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 00:24:13 INFO - mozversion application_name: Firefox 00:24:13 INFO - mozversion application_remotingname: firefox 00:24:13 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 00:24:13 INFO - mozversion application_vendor: Mozilla 00:24:13 INFO - mozversion application_version: 51.0a1 00:24:13 INFO - mozversion platform_buildid: 20160829225021 00:24:13 INFO - mozversion platform_changeset: e11d9697af59672994c6cdc309c97564078b7dc1 00:24:13 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 00:24:13 INFO - mozversion platform_version: 51.0a1 00:24:13 INFO - using testdate: 1472541853 00:24:13 INFO - actual date: 1472541853 00:24:13 INFO - starting webserver on 'localhost:50884' 00:24:13 INFO - SUITE-START | Running 2 tests 00:24:13 INFO - TEST-START | dromaeo_css 00:24:13 INFO - operating with platform_type : mac_ 00:24:13 INFO - Initialising browser for dromaeo_css test... 00:24:13 INFO - TEST-INFO | started process 2056 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/tmpPX_suu/profile http://localhost:50884/getInfo.html) 00:24:16 INFO - PROCESS | 2056 | __metrics Screen width/height:1600/1200 00:24:16 INFO - PROCESS | 2056 | colorDepth:24 00:24:16 INFO - PROCESS | 2056 | Browser inner width/height: 1024/689 00:24:16 INFO - PROCESS | 2056 | __metrics 00:24:16 ERROR - PROCESS | 2056 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2991: TypeError: this.tabs is undefined 00:24:16 INFO - TEST-INFO | 2056: exit 0 00:24:16 INFO - Browser initialized. 00:24:16 INFO - Running cycle 1/1 for dromaeo_css test... 00:24:16 INFO - TEST-INFO | started process 2059 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/tmpPX_suu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:24:28 INFO - PROCESS | 2059 | RSS: Main: 244494336 00:24:28 INFO - PROCESS | 2059 | 00:25:18 INFO - PROCESS | 2059 | 1472541918660 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] 00:27:30 INFO - PROCESS | 2059 | Cycle 1(1): loaded http://localhost:50884/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50884/tests/dromaeo/cssquery-ext.html) 00:27:31 INFO - PROCESS | 2059 | RSS: Main: 256589824 00:27:31 INFO - PROCESS | 2059 | 00:30:34 INFO - PROCESS | 2059 | Cycle 1(1): loaded http://localhost:50884/tests/dromaeo/cssquery-ext.html (next: http://localhost:50884/tests/dromaeo/cssquery-jquery.html) 00:30:34 INFO - PROCESS | 2059 | RSS: Main: 261439488 00:30:34 INFO - PROCESS | 2059 | 00:33:36 INFO - PROCESS | 2059 | Cycle 1(1): loaded http://localhost:50884/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50884/tests/dromaeo/cssquery-mootools.html) 00:33:37 INFO - PROCESS | 2059 | RSS: Main: 263708672 00:33:37 INFO - PROCESS | 2059 | 00:36:39 INFO - PROCESS | 2059 | Cycle 1(1): loaded http://localhost:50884/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50884/tests/dromaeo/cssquery-prototype.html) 00:36:39 INFO - PROCESS | 2059 | RSS: Main: 268730368 00:36:39 INFO - PROCESS | 2059 | 00:39:42 INFO - PROCESS | 2059 | Cycle 1(1): loaded http://localhost:50884/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50884/tests/dromaeo/cssquery-yui.html) 00:39:43 INFO - PROCESS | 2059 | RSS: Main: 268795904 00:39:43 INFO - PROCESS | 2059 | 00:42:46 INFO - PROCESS | 2059 | Cycle 1(1): loaded http://localhost:50884/tests/dromaeo/cssquery-yui.html (next: http://localhost:50884/tests/dromaeo/cssquery-dojo.html) 00:42:46 INFO - PROCESS | 2059 | RSS: Main: 273719296 00:42:46 INFO - PROCESS | 2059 | 00:42:46 INFO - PROCESS | 2059 | __start_tp_report 00:42:46 INFO - PROCESS | 2059 | _x_x_mozilla_page_load 00:42:46 INFO - PROCESS | 2059 | _x_x_mozilla_page_load_details 00:42:46 INFO - PROCESS | 2059 | |i|pagename|runs| 00:42:46 INFO - PROCESS | 2059 | |0;dojo.html;3339.1652086978256;3350.4471762159246;3351.3799947009807;3365.6129545102303;3404.2340473393488;5595.832125036255;5625.971870140654;5635.6618602883855;5658.943410565893;5703.116017017369;5735.455131762486;5735.971320143404;5801.245838041049;5871.765129394819;5911.172435858984;4280.9143817123795;5243.370795504545;5257.263983042377;5318.840434786944;5329.786808527654;5361;5379.435159308275;5403.243545903577;5423.945760542403;5439.428859969706;4055.574164712692;4271.252530807096;5148.330717006803;5304.230886521433;5346.732663366835;5260.763265653055;5282.656627319212;5286.656367336111;5296.443873393277;5327.094393952999;5209.921851172236;5227.843164705065;5229.633925625208;5259.789608415697;5261.342332208474;5647.265855438808;5700.344460387067;5730.570207234474;5810.099434587603;5861.736221870026;6183.1034499997695;6183.536234782409;6192.845178870564;6225.346338634424;6230.9065364019125;6200.937990620081;6236.064590311445;6236.750529978795;6238.844028899269;6341.746330146789;5736.56975726818;5782.421757824268;5817.156512305776;5873.882522349529;5882.000059989812;6278.277998030194;6312.779052733133;6315.747370105236;6318.810435686937;6334.746610135543;6187.195664563578;6195.690215489208;6206.596571222856;6228.750849966042;6234.096056071844;6106.855059071331;6135.998322733915;6142.682951206388;6189.876202476015;6278.434940855345;4737.928931066037;6164;6165.6743800083195;6168.642898562309;6183.227096612924;6166.321704612489;6174.289956654952;6177.1969643945995;6178.474829639441;6203.131561581382;4891.437484689306;4913.385826771653;4955.6531042826655;4961.70229786214;5001.874953126201;4450.5104438511735;4462;4480.39514665516;4514.616257618073;4558.521355257651;5411.836455162159;5706.657600543981;5708.0581704019205;5746.856328591819;5762.683052432073;6133.570650054543;6200.255969283715;6260.812175634738;6261.843453913689;6281.842953926189;4762.8333008345235;5759.8560035999435;5766.452187042224;5787.421257874263;5798.072308430631;5449.3188351456065;5471.316085489314;5473.562115030788;5496.945030549723;5498.340199176125;6194.690265486617;6207.472364849038;6311.810645680545;6324.08300796382;6337.397947195009;6205.844853878509;6281.277653069956;6287.497000240061;6292.496600271876;6298.244210694746;6275.497960163085;6339.144215530844;6354.5869518483;6362.554621176659;6402.10370548133;6099.007149909845;6105.206323177958;6140.933729672948;6206.162168107247;6237.812865614039;6227.875442491034;6247.5939063960695;6254.843628909313;6260.373962603703;6263.843403914939;5805.767769289181;6171.321154673072;6176.938230617637;6189.84525386869;6198.442140207403;5978.910316345171;6037.667928263988;6060.454559089703;6125.754969801158;6131.724072416663;5747.770089196385;5888.911666325094;5904.202932604216;5961.791337303173;5970.194023806731;6147.477464415575;6161.4146656067605;6169.074638804215;6185.350538193605;6201.379862013762;5945.940540594539;5963.642181469126;5977.372375900468;5987.401259873977;6015.518758499397 00:42:46 INFO - PROCESS | 2059 | |1;ext.html;515.4510446374611;515.6210185513648;528.3738769558074;551.7461967494958;551.8234165067179;28662.28344291391;39473.40789888154;39597.60402395975;39740.00649983752;39804.80097599515;40803.59196408035;40919.59080409195;41344;41361;41448.58551414485;8445.746627601182;9668.85496717548;9823.410595364265;9848.06443387877;9852.50737463124;9789;9816.656417025406;9851.90148098517;9860.852087218698;9861.457619830906;9831.754206144868;9858.408495490257;9861.901380986206;9866.90133098667;9867.506624668773;9815.558299876488;9830.508474576314;9836.852447213298;9836.90163098367;9853.359531630422;9712.70861874145;9802.607895684165;9809.460479673615;9827.90172098277;9839.212862970946;39074.21851562953;39257.21485570301;39307.41038884419;39417.40873886865;39563.80218098891;3220.21104829316;3333.6499667535045;3372.629010808809;3381.847816848248;3828.770273783582;30416.695833041827;30864.845675771703;31333.843330783428;31434;31605.525917111263;3209.518572214163;3216.404965081444;3249.382617302705;3278.098522906196;3339.5825521809775;510010;517212;518289.9999999962;519251;519634;29998.250043748645;30372.392552148835;59519;59784.10323845059;59830.10254846181;31892.521612175835;34028.48957265643;34243.486347704806;34252.65747342545;34524.482132768026;14461.060031098155;14562.927185364006;14586.270686465634;14590.927045364917;14651.413943442356;12526.561570344995;12582.937085314516;12592.874071259354;12623.495060197489;12633.684157895943;7548.886766698504;7565.751650977637;7606.847863042708;7643.770686879402;7667.53994760305;2801.8372375463955;3114.283714745621;3115.9532607010915;3177.8083218792954;3210.598675165604;801.1707882341865;886.8536691445839;951.5955718819474;960.3853533738413;995.4475266227169;22217.223072077784;24257.39356516066;27756.861215693792;28028.579571306447;28334.85832570824;754.9996254962197;968.3124981263381;1013.7313611892854;1020.8111499372492;1050.3540322701483;11873.643790686121;14038.36827342772;15259;15346.846531534542;15515.224238788242;656715;663938;667004;670152.6492367507;671918;55970.72014639982;56866.57833554112;57130;57219.42780572224;57339.71330143323;1321.7620828250815;1333.2200662612286;1355.8440779310308;1359.286374653295;1359.9728005439836;28275.858620706764;28558.857205713837;28635.14094577166;28983.275418114717;29190;41156.38265426081;48913;49475.50524494853;49481;49664.503354965986;579765;581291;581305;582128;582466;26199.214023579323;26236.606450903633;26645.200643980712;26671;27031;46638.83402914819;46842.76578617085;47526.049479010915;47868.28197576969;48417.27374089321;38397.040073997254;38652.420213697376;38715;39300.01749956274;39639.80180099196;37211.81394093012;37274.06814829651;37484;38360;38666.42000369941;36614;37940.62059379481;41014.15436305314;41508.1698366037;43081;34322.313553729284;36303.36634851491;36644.08389790277;41026.76919692295;41553.376699348926;27865.60671966434;29990;31137.688623114384;31528.52707209348;31685.20786980344 00:42:46 INFO - PROCESS | 2059 | |2;jquery.html;362.4327926794566;377.69784172661883;382.68046181438496;387.8700635287179;405.31704078627513;19008.14463349151;19798;21299.254526091572;21313.467163320904;21483.570328593418;11685.298882067082;12186.573469928555;12191.939040304786;12215;19676.803231967675;5318.867028324294;5591.245181900432;5614.69119198446;5618.5786066045;5641.576881733866;5289.603279754015;5467.617266791326;5497.890042199154;5506.229127922074;5513.641613295123;5480.835574932738;5499.7250137493165;5503.9174412383645;5510.559155267589;5524.950259450711;5369.48989845964;6003.729832157564;6048.0625503047095;6063.878722425527;6093.360197179299;5101.438841727407;5338.065838478251;5343;5346.465353464661;5353.277307563468;13122.86877131226;13444.529441469502;13490.932545337211;13502.594922152253;13539.458421663121;2114.12263910477;2232.229880691159;2359.3393849722106;2686.529857274969;2699.446613444239;9781.168600668952;9912.950435247778;10087.89912100877;10198.388096714147;10259.230557708202;1870.8971006594631;1931.8891637308463;1932.6811076172414;1935.9322423715103;1976.6244413561378;103777;117691.41154294345;117702;121700;124066.37966810199;10934.835977460345;11517.366544839946;11570.537178512934;11573.826392604118;11704;14335.211563364115;14345.569632911029;14346.713065738626;14381.77082552206;14394;8193.79515512117;8454.239118479367;8519.659213631385;8577.78555536104;8583.48499090044;7349.640316541457;8314.043884953187;8378.245957863699;8414.36892233085;8594.441361311494;4363.454568178978;4495.325701144854;4544.840930567414;4633.791479383436;4635.07644327607;1892.7634045744283;1928.1323404468046;1932.3623204342534;1935.535471486833;1936.2351871011153;795.2365728900205;801.3629164813987;838.6603425612636;898.5597057441806;961.8172547216146;15831.129287889047;19292.42122736292;19902.820973976304;20385.184592616424;22102.557948840935;763.4541302968404;824.3528829868525;875.3916028360228;920.2270093121809;923.0999775219242;10474.109700675375;10840;10848.403337816339;10970;11011.889881101246;554183;558293.3365330764;559326;572315;573281;78390;80600.59699701464;122251;133562;137133.3143334277;861.2076889261895;941.6280569175137;1004.0361253196867;1010.6917390195914;1018.9898101019044;18941.90529047346;19167;19203;19231.615367692848;19252.4224273272;56768.71615641895;57244.42755572391;57579.712101439225;57586.424135758105;57810.421895780506;82957;83348;83868;84720.15279847369;85755;6942.444604431735;6997.335253151146;7855.5286682799215;7915.604219789103;8224.300934420402;11761.411929403666;12301.323427211231;12349.135560511037;12663.620091397273;12707.93646031764;9545.711328970778;10732.409717465302;10768.46157692128;10894.836577451186;10955.616553420592;10547.419891905713;10549.314294570828;10569.788604228026;10904.236703430684;10918.454077296263;10451.790964180826;10473.633422830164;10577.94220577967;10621.946890265499;11350.829737553779;7939.126696063313;8033.517988920684;8122.7157049502985;8178.550179740171;8274.834503310021;10435.478226088513;10522.000409961041;10726.410047447465;10993.945030275117;11034.448277586249 00:42:46 INFO - PROCESS | 2059 | |3;mootools.html;1393.1153717389457;1458.3437453146084;1652.2564845819377;1801.86486013549;1860.4790658615584;7843.490173138742;8340.582970851463;8467.745967620966;8850.77873053174;8887.377883548153;8556.401051926368;8570.185832345916;8690.565471726404;8690.91309086909;8693.217610415062;2359.7876191142836;2379.3813608461837;2390.1156572068357;2390.784829365357;2391.7727815857465;2289.4848659051745;2321.4080409495555;2335.2060299498166;2341.8711970841596;2354.540864531417;2370.395549134968;2392.126873691099;2397.137030668958;2405.9037638494437;2410.819188560856;2363.3737059679197;2369.07606033647;2369.9052037918464;2377.263048454976;2388.3551441110803;2357.610994185957;2369.644553316999;2371.537550177716;2375.70303712036;2382.273406610983;8688.304935605136;8766.693165739169;8773.42972706772;8786;8787.340949428819;5129.3075434816565;5214.296070030536;5214.791408343662;5247.186686063628;5257.053730328539;2990.1179152149953;3577.195131095483;3631.94552081719;3643.617420170897;3650.543682039745;1076.386459717961;1092.2190633696946;1099.0932480703452;1104.618906477264;1107.7175320293275;11262.43687815614;11406.54373825046;11432.142589305835;11440.885591144148;11445.771084578346;3709.795961222159;4562.703424277478;4724.362211101457;4775.2359622460235;4778.761061946958;9651.71044868655;9662.033796620422;9665.226781857435;9666.371685840399;9735.853962190573;5243.344581927259;5296.788128474895;5305.946940530623;5327.067763141435;5332.786688532493;4377.4965878923695;4710.764461776897;4850.957044235506;4888.584470319992;4896.314515967767;3795.848166073326;3903.6096390361304;3903.765774053509;3936.3111455495746;3990.2219067281603;1285.3765923527083;1296.883280504759;1300.4148133340034;1310.1484035377082;1312.960611181666;832.8375966686438;849.392684230778;901.2789768185426;914.3645166609276;926.0600490502146;4911.557959783565;5414.539764120094;5725.484706376446;6003.609765365237;6026.397360263939;717.9784606461815;832.2759199496477;955.1642312976146;963.080258353285;972.8686627305365;3331.917126933756;3463.8049872793845;3583.7133029357587;3693.6306369362846;3990.1421194442755;8919.910800892038;10243.385396876061;10364.792704145875;10503.52734126966;10606.681799546026;8556.957215213884;10375.27373083892;10431.634892778868;10571.36571805694;10577.048065674126;8063.637136328879;8158.796030099176;8170.959145204236;8190.017197936286;8240.711575094963;5563;5652.406497317723;5783.566232532493;5825.0679891217205;5870.853228669317;9747.463889486145;9761.511924403894;9816.607335706778;9835.85246221293;9867.901320986699;9065.81868362616;9432.717018489457;10117.291789574954;10126.392416455037;10126.696199114038;6852.211995620568;7205.495615307088;7337.779866604011;7390.704371825282;7498.887516687363;8227.629756660845;8276;8335.249827515552;8346.04020537646;8347.12355202695;7300;7389.261073892568;7391.704331826667;7427.8143046424275;7526.698932042657;6495.642739649365;7251.709931602888;7391.186969433251;7452.850942981218;7586;6810;6933.514653974174;6983.336583024605;6997.895031574632;6998.720051197895;5057.291979123;5060.519250671327;5120.359955005624;5125.384953805567;5259.552938000313;5094.821681241138;5155.510226528474;5189.1859483279;5222.3472065991755;5308.283381743569 00:42:46 INFO - PROCESS | 2059 | |4;prototype.html;265.495558438966;273.68389510115816;296.04968052551294;315.51568342594123;317.6902520042958;5275.815346462875;5462.754176062077;5543.113101903701;5554.416786237448;5604.467575580324;5291.444398338177;5464;5519.972400137994;5533.253010843535;5535.446455354462;3513.525674034011;4235.512916014652;4238.5761423857675;4258.701890867641;4270.231358355495;3266.918327041831;3694.371956767356;4035.3341698619693;4147.854825081123;4282.571742825724;3603.477495763113;4121;4145.212409642173;4158.14757974616;4193.266178418779;4176.582341765814;4178.6657067434835;4187.581241875819;4207.305794543897;4207.852725154605;3160.98419507901;3589.46158076288;3592.8742494012845;3604.567451905762;3609.404448266033;4567.2920697291975;5015.774290156952;5342.786288548454;5392.622516423852;5418;4722.881927951795;4750.524947505256;4762.261849413347;4777.546133117383;4799.832005879777;4713.929291060636;5867.677277749722;5880.882382352372;5903.911441328383;6023.879522409527;3657.7073834093208;3844.903877403059;3882.495275614152;3890.3775395936514;3930.4474732480794;4987.152184128707;5313.362396512443;6077;6125.785597504066;6163.938360616381;3377.7128944040032;3696.094456858087;3769.3215221260434;3805.657490825839;3987.441758153861;3660.2679464107287;3877;3902.5316961964177;3971.92056158881;4028.4158796974275;4340.82636694535;4403.383526306319;4696.81212751493;4700.271457924027;4757.714537127714;4906.533879281463;4985.280078372955;5838.386969368155;5896.646201227854;5913.615614985012;1214.7023979125172;1272.344742457635;1335.4391155714623;1367.596559015093;1386.5632325817537;791.5475103185719;882.9977974998422;911.7720569857536;917.4770380882966;948.672707915768;4796.544328288807;5397.9460205397445;5407.863893761942;5407.864803379947;5413.536840737455;5507.228987941691;5758.186171356093;6013.488853447506;6015.248093988252;6148.44663980244;4252.48970123581;4763.880488085297;5415.53967912724;5425.240466334716;5475.233467314579;3120.188750924776;3205.845895477626;3211.1008917503136;3211.6948889855425;3241.7244534214383;5246.8425947220885;5553.861153471195;5817.621854579439;5993.550483713739;6003.279606447167;5399.516222537598;5651.587103224194;5840;6167.629942203482;6374.649394283359;5518.841043380935;5839.766409343579;5854.853628659318;6255.78104766331;6291.130954462972;5377.354717433776;5395.271638328775;5713.542916566582;5819.738111785065;5986.102084687332;4819.855404337875;5245.554127899171;5873.911891321719;5968.850778730566;5970.850728731816;5822.563307752021;6013.488853447506;6215.96892015537;6271.498280137669;6309.277526259529;2884.4519541287086;3438.7964212526417;3899.53205615328;3936.5866584008268;3938.232044751246;5187.974060129675;5673.971630141823;5980.641161530322;6002.579819412774;6050.9394906050375;5159.355080614923;5225.555827754683;5676.659400435987;5823.388544202798;5875.441833025856;5361;5849.853753656193;5855;5866.911996319973;5889.617174883619;4829.6860704054125;5030;5075.137226671401;5235.853300146921;5754.280714910637;4924.8276310328965;5073.644844860824;5922.466977971831;5933.169356290036;6000.339962604197;4791.856244312537;5410.783568657367;5622.97956960775;5810.593258471867;5814.389489103583 00:42:46 INFO - PROCESS | 2059 | |5;yui.html;663.0981864664059;676.5230512488696;693.2582137113287;699.1365663405695;704.9894251586227;11186.608468703587;15853.048817070983;16031.759523607156;16145.43490977816;16161.676766464663;14083.225422601752;14609.415623375078;14710.485133020346;14730.705385892275;14748.041377310466;857.8455877941968;860.862262038074;861.4357595774777;861.750092473182;862.2670729879584;683.4293365040197;832.9750107496785;837.3426859914968;857.8112815180682;872.4459967920353;912.9406588571754;919.5218486387075;921.1479381572019;922.3359181389422;924.154398725169;909.9636014559443;910.2444970674325;913.3287034029983;913.4610579757974;913.4793167894303;670.0485310858593;680.4828330468879;683.2859661653584;684.9691763870588;685.8868286732683;14778.48275310359;14808.259587020606;14862.331195096247;14871.405143794234;14881.255937203205;14134;14279;14320.713585728332;14547.927260363631;14590.70818583633;9826.355768414453;11892.702682432922;11899.405029748565;11980.10149238802;11985.22096063753;3812.4090765931046;3846.134619710571;3858.054776579728;3863.5750067492554;3867.845286188549;116626;119515;120004;122258;122686;9344.719658410258;10952.561897524169;10980.780384392427;11196.888031119584;11241.60654377093;22592.209272675376;22601.4349641257;22603.547929041655;22644.773552264265;22656.433589160402;8044.1955804419085;8140.990786513439;8161.918380816234;8174.305184059422;8183.345332373396;4482.849068836338;4502.414686090788;4527.796249168795;4552.931706024412;4636.11913736389;3197.6962188592047;3200.9679903201136;3483.860645574199;3609.8556057757396;3669.082729317671;567.7076305702567;568.5991376079854;660.8083655739781;665.0954701605813;681;550.8760528881049;565.1692012741264;602.9427204415573;640.6956695569568;641.5092454272485;7791.298783109434;9190.172884440299;9348.57931393089;9450.149486546245;9581.904180958241;518.8443466959973;552.9225908372831;600.8978473659402;644.4618743349262;648.4067078623101;4441.622462090694;4465.620422264079;4467.5755803198645;4646.4191976003;4754.09672162295;165943;165988;166021.16989415218;169847;177803;140690;142210;142578;145396;147907;119392.8060719399;121147.39426302812;121755.3912230451;122848.38575807064;123527;8717.912820871963;9067.138621830916;9162.954185229031;9201.534588178758;9334.533273336441;67238;67463.32536674767;68681.96977045249;68705.65647171732;69017.2745681362;63055;101689.49155254473;102189.48905255724;103452;104624.47687761512;11853.146505923703;11946.402679865798;12040.096992725405;12158.088143389105;12589.370531473573;13044.478220871059;13291.80062299047;13364.866351336363;13434.193948363129;13457.932710336385;12074.39628018613;12268.263904165779;12367.505299787908;12380.195287306296;12830.16603920742;12327.876721233031;12356.691082723004;12566.246025238515;12708.936455318035;12719.109662323548;11830.877033013852;12033.338166400932;12064.819027714415;12177.878221217674;12182.329971851634;9594.616215351307;10310.43292618913;10404.271700980858;10788.136949043901;10950.34297942126;9967.60129594837;10233.590656373663;10542.420166890895;10567.682969510926;10623.734406639896 00:42:46 INFO - PROCESS | 2059 | __end_tp_report 00:42:46 INFO - PROCESS | 2059 | __start_cc_report 00:42:46 INFO - PROCESS | 2059 | _x_x_mozilla_cycle_collect,379 00:42:46 INFO - PROCESS | 2059 | __end_cc_report 00:42:46 INFO - PROCESS | 2059 | __startTimestamp1472542966348__endTimestamp 00:42:46 INFO - PROCESS | 2059 | 00:42:46 INFO - PROCESS | 2059 | ------- Summary: start ------- 00:42:46 INFO - PROCESS | 2059 | Number of tests: 6 00:42:46 INFO - PROCESS | 2059 | 00:42:46 INFO - PROCESS | 2059 | [#0] dojo.html Cycles:165 Average:5737.82 Median:5963.64 stddev:662.38 (11.1%) stddev-sans-first:637.12 00:42:46 INFO - PROCESS | 2059 | Values: 3339.2 3350.4 3351.4 3365.6 3404.2 5595.8 5626.0 5635.7 5658.9 5703.1 5735.5 5736.0 5801.2 5871.8 5911.2 4280.9 5243.4 5257.3 5318.8 5329.8 5361.0 5379.4 5403.2 5423.9 5439.4 4055.6 4271.3 5148.3 5304.2 5346.7 5260.8 5282.7 5286.7 5296.4 5327.1 5209.9 5227.8 5229.6 5259.8 5261.3 5647.3 5700.3 5730.6 5810.1 5861.7 6183.1 6183.5 6192.8 6225.3 6230.9 6200.9 6236.1 6236.8 6238.8 6341.7 5736.6 5782.4 5817.2 5873.9 5882.0 6278.3 6312.8 6315.7 6318.8 6334.7 6187.2 6195.7 6206.6 6228.8 6234.1 6106.9 6136.0 6142.7 6189.9 6278.4 4737.9 6164.0 6165.7 6168.6 6183.2 6166.3 6174.3 6177.2 6178.5 6203.1 4891.4 4913.4 4955.7 4961.7 5001.9 4450.5 4462.0 4480.4 4514.6 4558.5 5411.8 5706.7 5708.1 5746.9 5762.7 6133.6 6200.3 6260.8 6261.8 6281.8 4762.8 5759.9 5766.5 5787.4 5798.1 5449.3 5471.3 5473.6 5496.9 5498.3 6194.7 6207.5 6311.8 6324.1 6337.4 6205.8 6281.3 6287.5 6292.5 6298.2 6275.5 6339.1 6354.6 6362.6 6402.1 6099.0 6105.2 6140.9 6206.2 6237.8 6227.9 6247.6 6254.8 6260.4 6263.8 5805.8 6171.3 6176.9 6189.8 6198.4 5978.9 6037.7 6060.5 6125.8 6131.7 5747.8 5888.9 5904.2 5961.8 5970.2 6147.5 6161.4 6169.1 6185.4 6201.4 5945.9 5963.6 5977.4 5987.4 6015.5 00:42:46 INFO - PROCESS | 2059 | 00:42:46 INFO - PROCESS | 2059 | [#1] ext.html Cycles:180 Average:70145.54 Median:39580.70 stddev:158461.08 (400.3%) stddev-sans-first:158819.37 00:42:46 INFO - PROCESS | 2059 | Values: 515.5 515.6 528.4 551.7 551.8 28662.3 39473.4 39597.6 39740.0 39804.8 40803.6 40919.6 41344.0 41361.0 41448.6 8445.7 9668.9 9823.4 9848.1 9852.5 9789.0 9816.7 9851.9 9860.9 9861.5 9831.8 9858.4 9861.9 9866.9 9867.5 9815.6 9830.5 9836.9 9836.9 9853.4 9712.7 9802.6 9809.5 9827.9 9839.2 39074.2 39257.2 39307.4 39417.4 39563.8 3220.2 3333.6 3372.6 3381.8 3828.8 30416.7 30864.8 31333.8 31434.0 31605.5 3209.5 3216.4 3249.4 3278.1 3339.6 510010.0 517212.0 518290.0 519251.0 519634.0 29998.3 30372.4 59519.0 59784.1 59830.1 31892.5 34028.5 34243.5 34252.7 34524.5 14461.1 14562.9 14586.3 14590.9 14651.4 12526.6 12582.9 12592.9 12623.5 12633.7 7548.9 7565.8 7606.8 7643.8 7667.5 2801.8 3114.3 3116.0 3177.8 3210.6 801.2 886.9 951.6 960.4 995.4 22217.2 24257.4 27756.9 28028.6 28334.9 755.0 968.3 1013.7 1020.8 1050.4 11873.6 14038.4 15259.0 15346.8 15515.2 656715.0 663938.0 667004.0 670152.6 671918.0 55970.7 56866.6 57130.0 57219.4 57339.7 1321.8 1333.2 1355.8 1359.3 1360.0 28275.9 28558.9 28635.1 28983.3 29190.0 41156.4 48913.0 49475.5 49481.0 49664.5 579765.0 581291.0 581305.0 582128.0 582466.0 26199.2 26236.6 26645.2 26671.0 27031.0 46638.8 46842.8 47526.0 47868.3 48417.3 38397.0 38652.4 38715.0 39300.0 39639.8 37211.8 37274.1 37484.0 38360.0 38666.4 36614.0 37940.6 41014.2 41508.2 43081.0 34322.3 36303.4 36644.1 41026.8 41553.4 27865.6 29990.0 31137.7 31528.5 31685.2 00:42:46 INFO - PROCESS | 2059 | 00:42:46 INFO - PROCESS | 2059 | [#2] jquery.html Cycles:180 Average:33177.34 Median:2522.93 stddev:94258.10 (3736.1%) stddev-sans-first:94490.31 00:42:46 INFO - PROCESS | 2059 | Values: 362.4 377.7 382.7 387.9 405.3 19008.1 19798.0 21299.3 21313.5 21483.6 11685.3 12186.6 12191.9 12215.0 19676.8 5318.9 5591.2 5614.7 5618.6 5641.6 5289.6 5467.6 5497.9 5506.2 5513.6 5480.8 5499.7 5503.9 5510.6 5525.0 5369.5 6003.7 6048.1 6063.9 6093.4 5101.4 5338.1 5343.0 5346.5 5353.3 13122.9 13444.5 13490.9 13502.6 13539.5 2114.1 2232.2 2359.3 2686.5 2699.4 9781.2 9913.0 10087.9 10198.4 10259.2 1870.9 1931.9 1932.7 1935.9 1976.6 103777.0 117691.4 117702.0 121700.0 124066.4 10934.8 11517.4 11570.5 11573.8 11704.0 14335.2 14345.6 14346.7 14381.8 14394.0 8193.8 8454.2 8519.7 8577.8 8583.5 7349.6 8314.0 8378.2 8414.4 8594.4 4363.5 4495.3 4544.8 4633.8 4635.1 1892.8 1928.1 1932.4 1935.5 1936.2 795.2 801.4 838.7 898.6 961.8 15831.1 19292.4 19902.8 20385.2 22102.6 763.5 824.4 875.4 920.2 923.1 10474.1 10840.0 10848.4 10970.0 11011.9 554183.0 558293.3 559326.0 572315.0 573281.0 78390.0 80600.6 122251.0 133562.0 137133.3 861.2 941.6 1004.0 1010.7 1019.0 18941.9 19167.0 19203.0 19231.6 19252.4 56768.7 57244.4 57579.7 57586.4 57810.4 82957.0 83348.0 83868.0 84720.2 85755.0 6942.4 6997.3 7855.5 7915.6 8224.3 11761.4 12301.3 12349.1 12663.6 12707.9 9545.7 10732.4 10768.5 10894.8 10955.6 10547.4 10549.3 10569.8 10904.2 10918.5 10451.8 10473.6 10577.9 10621.9 11350.8 7939.1 8033.5 8122.7 8178.6 8274.8 10435.5 10522.0 10726.4 10993.9 11034.4 00:42:46 INFO - PROCESS | 2059 | 00:42:46 INFO - PROCESS | 2059 | [#3] mootools.html Cycles:180 Average:5616.45 Median:5214.54 stddev:3104.48 (59.5%) stddev-sans-first:3096.96 00:42:46 INFO - PROCESS | 2059 | Values: 1393.1 1458.3 1652.3 1801.9 1860.5 7843.5 8340.6 8467.7 8850.8 8887.4 8556.4 8570.2 8690.6 8690.9 8693.2 2359.8 2379.4 2390.1 2390.8 2391.8 2289.5 2321.4 2335.2 2341.9 2354.5 2370.4 2392.1 2397.1 2405.9 2410.8 2363.4 2369.1 2369.9 2377.3 2388.4 2357.6 2369.6 2371.5 2375.7 2382.3 8688.3 8766.7 8773.4 8786.0 8787.3 5129.3 5214.3 5214.8 5247.2 5257.1 2990.1 3577.2 3631.9 3643.6 3650.5 1076.4 1092.2 1099.1 1104.6 1107.7 11262.4 11406.5 11432.1 11440.9 11445.8 3709.8 4562.7 4724.4 4775.2 4778.8 9651.7 9662.0 9665.2 9666.4 9735.9 5243.3 5296.8 5305.9 5327.1 5332.8 4377.5 4710.8 4851.0 4888.6 4896.3 3795.8 3903.6 3903.8 3936.3 3990.2 1285.4 1296.9 1300.4 1310.1 1313.0 832.8 849.4 901.3 914.4 926.1 4911.6 5414.5 5725.5 6003.6 6026.4 718.0 832.3 955.2 963.1 972.9 3331.9 3463.8 3583.7 3693.6 3990.1 8919.9 10243.4 10364.8 10503.5 10606.7 8557.0 10375.3 10431.6 10571.4 10577.0 8063.6 8158.8 8171.0 8190.0 8240.7 5563.0 5652.4 5783.6 5825.1 5870.9 9747.5 9761.5 9816.6 9835.9 9867.9 9065.8 9432.7 10117.3 10126.4 10126.7 6852.2 7205.5 7337.8 7390.7 7498.9 8227.6 8276.0 8335.2 8346.0 8347.1 7300.0 7389.3 7391.7 7427.8 7526.7 6495.6 7251.7 7391.2 7452.9 7586.0 6810.0 6933.5 6983.3 6997.9 6998.7 5057.3 5060.5 5120.4 5125.4 5259.6 5094.8 5155.5 5189.2 5222.3 5308.3 00:42:46 INFO - PROCESS | 2059 | 00:42:46 INFO - PROCESS | 2059 | [#4] prototype.html Cycles:180 Average:4649.44 Median:5246.20 stddev:1453.08 (27.7%) stddev-sans-first:1419.41 00:42:46 INFO - PROCESS | 2059 | Values: 265.5 273.7 296.0 315.5 317.7 5275.8 5462.8 5543.1 5554.4 5604.5 5291.4 5464.0 5520.0 5533.3 5535.4 3513.5 4235.5 4238.6 4258.7 4270.2 3266.9 3694.4 4035.3 4147.9 4282.6 3603.5 4121.0 4145.2 4158.1 4193.3 4176.6 4178.7 4187.6 4207.3 4207.9 3161.0 3589.5 3592.9 3604.6 3609.4 4567.3 5015.8 5342.8 5392.6 5418.0 4722.9 4750.5 4762.3 4777.5 4799.8 4713.9 5867.7 5880.9 5903.9 6023.9 3657.7 3844.9 3882.5 3890.4 3930.4 4987.2 5313.4 6077.0 6125.8 6163.9 3377.7 3696.1 3769.3 3805.7 3987.4 3660.3 3877.0 3902.5 3971.9 4028.4 4340.8 4403.4 4696.8 4700.3 4757.7 4906.5 4985.3 5838.4 5896.6 5913.6 1214.7 1272.3 1335.4 1367.6 1386.6 791.5 883.0 911.8 917.5 948.7 4796.5 5397.9 5407.9 5407.9 5413.5 5507.2 5758.2 6013.5 6015.2 6148.4 4252.5 4763.9 5415.5 5425.2 5475.2 3120.2 3205.8 3211.1 3211.7 3241.7 5246.8 5553.9 5817.6 5993.6 6003.3 5399.5 5651.6 5840.0 6167.6 6374.6 5518.8 5839.8 5854.9 6255.8 6291.1 5377.4 5395.3 5713.5 5819.7 5986.1 4819.9 5245.6 5873.9 5968.9 5970.9 5822.6 6013.5 6216.0 6271.5 6309.3 2884.5 3438.8 3899.5 3936.6 3938.2 5188.0 5674.0 5980.6 6002.6 6050.9 5159.4 5225.6 5676.7 5823.4 5875.4 5361.0 5849.9 5855.0 5866.9 5889.6 4829.7 5030.0 5075.1 5235.9 5754.3 4924.8 5073.6 5922.5 5933.2 6000.3 4791.9 5410.8 5623.0 5810.6 5814.4 00:42:46 INFO - PROCESS | 2059 | 00:42:46 INFO - PROCESS | 2059 | [#5] yui.html Cycles:180 Average:26511.02 Median:3199.33 stddev:44263.39 (1383.5%) stddev-sans-first:44345.02 00:42:46 INFO - PROCESS | 2059 | Values: 663.1 676.5 693.3 699.1 705.0 11186.6 15853.0 16031.8 16145.4 16161.7 14083.2 14609.4 14710.5 14730.7 14748.0 857.8 860.9 861.4 861.8 862.3 683.4 833.0 837.3 857.8 872.4 912.9 919.5 921.1 922.3 924.2 910.0 910.2 913.3 913.5 913.5 670.0 680.5 683.3 685.0 685.9 14778.5 14808.3 14862.3 14871.4 14881.3 14134.0 14279.0 14320.7 14547.9 14590.7 9826.4 11892.7 11899.4 11980.1 11985.2 3812.4 3846.1 3858.1 3863.6 3867.8 116626.0 119515.0 120004.0 122258.0 122686.0 9344.7 10952.6 10980.8 11196.9 11241.6 22592.2 22601.4 22603.5 22644.8 22656.4 8044.2 8141.0 8161.9 8174.3 8183.3 4482.8 4502.4 4527.8 4552.9 4636.1 3197.7 3201.0 3483.9 3609.9 3669.1 567.7 568.6 660.8 665.1 681.0 550.9 565.2 602.9 640.7 641.5 7791.3 9190.2 9348.6 9450.1 9581.9 518.8 552.9 600.9 644.5 648.4 4441.6 4465.6 4467.6 4646.4 4754.1 165943.0 165988.0 166021.2 169847.0 177803.0 140690.0 142210.0 142578.0 145396.0 147907.0 119392.8 121147.4 121755.4 122848.4 123527.0 8717.9 9067.1 9163.0 9201.5 9334.5 67238.0 67463.3 68682.0 68705.7 69017.3 63055.0 101689.5 102189.5 103452.0 104624.5 11853.1 11946.4 12040.1 12158.1 12589.4 13044.5 13291.8 13364.9 13434.2 13457.9 12074.4 12268.3 12367.5 12380.2 12830.2 12327.9 12356.7 12566.2 12708.9 12719.1 11830.9 12033.3 12064.8 12177.9 12182.3 9594.6 10310.4 10404.3 10788.1 10950.3 9967.6 10233.6 10542.4 10567.7 10623.7 00:42:46 INFO - PROCESS | 2059 | -------- Summary: end -------- 00:42:46 INFO - PROCESS | 2059 | 00:42:47 INFO - TEST-INFO | 2059: exit 0 00:42:47 INFO - TEST-OK | dromaeo_css | took 1113892ms 00:42:47 INFO - TEST-START | kraken 00:42:47 INFO - operating with platform_type : mac_ 00:42:47 INFO - Initialising browser for kraken test... 00:42:47 INFO - TEST-INFO | started process 2177 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/tmp7Ahe2l/profile http://localhost:50884/getInfo.html) 00:42:49 INFO - PROCESS | 2177 | __metrics Screen width/height:1600/1200 00:42:49 INFO - PROCESS | 2177 | colorDepth:24 00:42:49 INFO - PROCESS | 2177 | Browser inner width/height: 1024/689 00:42:49 INFO - PROCESS | 2177 | __metrics 00:42:49 ERROR - PROCESS | 2177 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2991: TypeError: this.tabs is undefined 00:42:50 INFO - TEST-INFO | 2177: exit 0 00:42:50 INFO - Browser initialized. 00:42:50 INFO - Running cycle 1/1 for kraken test... 00:42:50 INFO - TEST-INFO | started process 2180 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/tmp7Ahe2l/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:43:02 INFO - PROCESS | 2180 | RSS: Main: 244895744 00:43:02 INFO - PROCESS | 2180 | 00:43:05 INFO - PROCESS | 2180 | Cycle 1(1): loaded http://localhost:50884/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50884/tests/kraken/driver.html?testName=audio-beat-detection) 00:43:06 INFO - PROCESS | 2180 | RSS: Main: 257859584 00:43:06 INFO - PROCESS | 2180 | 00:43:08 INFO - PROCESS | 2180 | Cycle 1(1): loaded http://localhost:50884/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50884/tests/kraken/driver.html?testName=audio-dft) 00:43:09 INFO - PROCESS | 2180 | RSS: Main: 266092544 00:43:09 INFO - PROCESS | 2180 | 00:43:13 INFO - PROCESS | 2180 | Cycle 1(1): loaded http://localhost:50884/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50884/tests/kraken/driver.html?testName=audio-fft) 00:43:13 INFO - PROCESS | 2180 | RSS: Main: 263700480 00:43:13 INFO - PROCESS | 2180 | 00:43:15 INFO - PROCESS | 2180 | Cycle 1(1): loaded http://localhost:50884/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50884/tests/kraken/driver.html?testName=audio-oscillator) 00:43:16 INFO - PROCESS | 2180 | RSS: Main: 264970240 00:43:16 INFO - PROCESS | 2180 | 00:43:18 INFO - PROCESS | 2180 | Cycle 1(1): loaded http://localhost:50884/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50884/tests/kraken/driver.html?testName=imaging-gaussian-blur) 00:43:19 INFO - PROCESS | 2180 | RSS: Main: 265441280 00:43:19 INFO - PROCESS | 2180 | 00:43:22 INFO - PROCESS | 2180 | Cycle 1(1): loaded http://localhost:50884/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50884/tests/kraken/driver.html?testName=imaging-darkroom) 00:43:22 INFO - PROCESS | 2180 | RSS: Main: 267272192 00:43:22 INFO - PROCESS | 2180 | 00:43:25 INFO - PROCESS | 2180 | Cycle 1(1): loaded http://localhost:50884/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50884/tests/kraken/driver.html?testName=imaging-desaturate) 00:43:26 INFO - PROCESS | 2180 | RSS: Main: 267476992 00:43:26 INFO - PROCESS | 2180 | 00:43:29 INFO - PROCESS | 2180 | Cycle 1(1): loaded http://localhost:50884/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50884/tests/kraken/driver.html?testName=json-parse-financial) 00:43:29 INFO - PROCESS | 2180 | RSS: Main: 267657216 00:43:29 INFO - PROCESS | 2180 | 00:43:31 INFO - PROCESS | 2180 | Cycle 1(1): loaded http://localhost:50884/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50884/tests/kraken/driver.html?testName=json-stringify-tinderbox) 00:43:32 INFO - PROCESS | 2180 | RSS: Main: 267075584 00:43:32 INFO - PROCESS | 2180 | 00:43:34 INFO - PROCESS | 2180 | Cycle 1(1): loaded http://localhost:50884/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50884/tests/kraken/driver.html?testName=stanford-crypto-aes) 00:43:34 INFO - PROCESS | 2180 | RSS: Main: 267030528 00:43:34 INFO - PROCESS | 2180 | 00:43:36 INFO - PROCESS | 2180 | Cycle 1(1): loaded http://localhost:50884/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50884/tests/kraken/driver.html?testName=stanford-crypto-ccm) 00:43:37 INFO - PROCESS | 2180 | RSS: Main: 267333632 00:43:37 INFO - PROCESS | 2180 | 00:43:40 INFO - PROCESS | 2180 | Cycle 1(1): loaded http://localhost:50884/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50884/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 00:43:41 INFO - PROCESS | 2180 | RSS: Main: 267665408 00:43:41 INFO - PROCESS | 2180 | 00:43:44 INFO - PROCESS | 2180 | Cycle 1(1): loaded http://localhost:50884/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50884/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 00:43:44 INFO - PROCESS | 2180 | RSS: Main: 267718656 00:43:44 INFO - PROCESS | 2180 | 00:43:46 INFO - PROCESS | 2180 | Cycle 1(1): loaded http://localhost:50884/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50884/tests/kraken/driver.html?testName=ai-astar) 00:43:46 INFO - PROCESS | 2180 | RSS: Main: 269529088 00:43:46 INFO - PROCESS | 2180 | 00:43:46 INFO - PROCESS | 2180 | __start_tp_report 00:43:46 INFO - PROCESS | 2180 | _x_x_mozilla_page_load 00:43:46 INFO - PROCESS | 2180 | _x_x_mozilla_page_load_details 00:43:46 INFO - PROCESS | 2180 | |i|pagename|runs| 00:43:46 INFO - PROCESS | 2180 | |0;ai-astar;117;111;118;127;171;134;117;117;116;119 00:43:46 INFO - PROCESS | 2180 | |1;audio-beat-detection;161;142;172;152;102;161;160;141;183;110 00:43:46 INFO - PROCESS | 2180 | |2;audio-dft;202;211;242;177;268;266;195;221;220;215 00:43:46 INFO - PROCESS | 2180 | |3;audio-fft;70;85;78;144;63;78;83;90;151;60 00:43:46 INFO - PROCESS | 2180 | |4;audio-oscillator;69;73;123;69;78;113;142;96;98;114 00:43:46 INFO - PROCESS | 2180 | |5;imaging-gaussian-blur;88;74;137;129;87;85;88;76;136;132 00:43:46 INFO - PROCESS | 2180 | |6;imaging-darkroom;135;98;97;97;98;107;98;97;98;98 00:43:46 INFO - PROCESS | 2180 | |7;imaging-desaturate;98;93;91;95;78;147;149;90;90;91 00:43:46 INFO - PROCESS | 2180 | |8;json-parse-financial;57;59;58;58;59;60;58;56;58;56 00:43:46 INFO - PROCESS | 2180 | |9;json-stringify-tinderbox;71;70;79;80;86;77;72;76;79;74 00:43:46 INFO - PROCESS | 2180 | |10;stanford-crypto-aes;90;101;88;86;88;89;88;92;80;95 00:43:46 INFO - PROCESS | 2180 | |11;stanford-crypto-ccm;141;141;140;142;162;164;155;142;189;158 00:43:46 INFO - PROCESS | 2180 | |12;stanford-crypto-pbkdf2;216;238;177;175;204;202;172;170;173;173 00:43:46 INFO - PROCESS | 2180 | |13;stanford-crypto-sha256-iterative;68;68;70;66;70;68;68;68;68;69 00:43:46 INFO - PROCESS | 2180 | __end_tp_report 00:43:46 INFO - PROCESS | 2180 | __start_cc_report 00:43:46 INFO - PROCESS | 2180 | _x_x_mozilla_cycle_collect,976 00:43:46 INFO - PROCESS | 2180 | __end_cc_report 00:43:46 INFO - PROCESS | 2180 | __startTimestamp1472543026845__endTimestamp 00:43:46 INFO - PROCESS | 2180 | 00:43:46 INFO - PROCESS | 2180 | ------- Summary: start ------- 00:43:46 INFO - PROCESS | 2180 | Number of tests: 14 00:43:46 INFO - PROCESS | 2180 | 00:43:46 INFO - PROCESS | 2180 | [#0] ai-astar Cycles:10 Average:124.70 Median:118.50 stddev:17.49 (14.8%) stddev-sans-first:18.33 00:43:46 INFO - PROCESS | 2180 | Values: 117.0 111.0 118.0 127.0 171.0 134.0 117.0 117.0 116.0 119.0 00:43:46 INFO - PROCESS | 2180 | 00:43:46 INFO - PROCESS | 2180 | [#1] audio-beat-detection Cycles:10 Average:148.40 Median:160.50 stddev:25.70 (16.0%) stddev-sans-first:26.85 00:43:46 INFO - PROCESS | 2180 | Values: 161.0 142.0 172.0 152.0 102.0 161.0 160.0 141.0 183.0 110.0 00:43:46 INFO - PROCESS | 2180 | 00:43:46 INFO - PROCESS | 2180 | [#2] audio-dft Cycles:10 Average:221.70 Median:220.50 stddev:29.40 (13.3%) stddev-sans-first:30.31 00:43:46 INFO - PROCESS | 2180 | Values: 202.0 211.0 242.0 177.0 268.0 266.0 195.0 221.0 220.0 215.0 00:43:46 INFO - PROCESS | 2180 | 00:43:46 INFO - PROCESS | 2180 | [#3] audio-fft Cycles:10 Average:90.20 Median:78.00 stddev:31.67 (40.6%) stddev-sans-first:32.74 00:43:46 INFO - PROCESS | 2180 | Values: 70.0 85.0 78.0 144.0 63.0 78.0 83.0 90.0 151.0 60.0 00:43:46 INFO - PROCESS | 2180 | 00:43:46 INFO - PROCESS | 2180 | [#4] audio-oscillator Cycles:10 Average:97.50 Median:71.00 stddev:25.28 (35.6%) stddev-sans-first:24.62 00:43:46 INFO - PROCESS | 2180 | Values: 69.0 73.0 123.0 69.0 78.0 113.0 142.0 96.0 98.0 114.0 00:43:46 INFO - PROCESS | 2180 | 00:43:46 INFO - PROCESS | 2180 | [#5] imaging-gaussian-blur Cycles:10 Average:103.20 Median:80.50 stddev:26.59 (33.0%) stddev-sans-first:27.62 00:43:46 INFO - PROCESS | 2180 | Values: 88.0 74.0 137.0 129.0 87.0 85.0 88.0 76.0 136.0 132.0 00:43:46 INFO - PROCESS | 2180 | 00:43:46 INFO - PROCESS | 2180 | [#6] imaging-darkroom Cycles:10 Average:102.30 Median:98.00 stddev:11.87 (12.1%) stddev-sans-first:3.16 00:43:46 INFO - PROCESS | 2180 | Values: 135.0 98.0 97.0 97.0 98.0 107.0 98.0 97.0 98.0 98.0 00:43:46 INFO - PROCESS | 2180 | 00:43:46 INFO - PROCESS | 2180 | [#7] imaging-desaturate Cycles:10 Average:102.20 Median:91.00 stddev:24.69 (27.1%) stddev-sans-first:26.14 00:43:46 INFO - PROCESS | 2180 | Values: 98.0 93.0 91.0 95.0 78.0 147.0 149.0 90.0 90.0 91.0 00:43:46 INFO - PROCESS | 2180 | 00:43:46 INFO - PROCESS | 2180 | [#8] json-parse-financial Cycles:10 Average:57.90 Median:58.00 stddev:1.29 (2.2%) stddev-sans-first:1.32 00:43:46 INFO - PROCESS | 2180 | Values: 57.0 59.0 58.0 58.0 59.0 60.0 58.0 56.0 58.0 56.0 00:43:46 INFO - PROCESS | 2180 | 00:43:46 INFO - PROCESS | 2180 | [#9] json-stringify-tinderbox Cycles:10 Average:76.40 Median:78.00 stddev:4.88 (6.3%) stddev-sans-first:4.77 00:43:46 INFO - PROCESS | 2180 | Values: 71.0 70.0 79.0 80.0 86.0 77.0 72.0 76.0 79.0 74.0 00:43:46 INFO - PROCESS | 2180 | 00:43:46 INFO - PROCESS | 2180 | [#10] stanford-crypto-aes Cycles:10 Average:89.70 Median:88.50 stddev:5.56 (6.3%) stddev-sans-first:5.89 00:43:46 INFO - PROCESS | 2180 | Values: 90.0 101.0 88.0 86.0 88.0 89.0 88.0 92.0 80.0 95.0 00:43:46 INFO - PROCESS | 2180 | 00:43:46 INFO - PROCESS | 2180 | [#11] stanford-crypto-ccm Cycles:10 Average:153.40 Median:156.50 stddev:15.72 (10.0%) stddev-sans-first:16.02 00:43:46 INFO - PROCESS | 2180 | Values: 141.0 141.0 140.0 142.0 162.0 164.0 155.0 142.0 189.0 158.0 00:43:46 INFO - PROCESS | 2180 | 00:43:46 INFO - PROCESS | 2180 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:190.00 Median:189.50 stddev:23.61 (12.5%) stddev-sans-first:23.09 00:43:46 INFO - PROCESS | 2180 | Values: 216.0 238.0 177.0 175.0 204.0 202.0 172.0 170.0 173.0 173.0 00:43:46 INFO - PROCESS | 2180 | 00:43:46 INFO - PROCESS | 2180 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.30 Median:68.00 stddev:1.16 (1.7%) stddev-sans-first:1.22 00:43:46 INFO - PROCESS | 2180 | Values: 68.0 68.0 70.0 66.0 70.0 68.0 68.0 68.0 68.0 69.0 00:43:46 INFO - PROCESS | 2180 | -------- Summary: end -------- 00:43:46 INFO - PROCESS | 2180 | 00:43:47 INFO - TEST-INFO | 2180: exit 0 00:43:47 INFO - TEST-OK | kraken | took 60619ms 00:43:47 INFO - SUITE-END | took 1174s 00:43:48 INFO - Completed test suite (00:19:34) 00:43:48 INFO - javascript benchmark 00:43:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7218.996622130436, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3339.1652086978256, 3350.4471762159246, 3351.3799947009807, 3365.6129545102303, 3404.2340473393488, 5595.832125036255, 5625.971870140654, 5635.6618602883855, 5658.943410565893, 5703.116017017369, 5735.455131762486, 5735.971320143404, 5801.245838041049, 5871.765129394819, 5911.172435858984, 4280.9143817123795, 5243.370795504545, 5257.263983042377, 5318.840434786944, 5329.786808527654, 5361.0, 5379.435159308275, 5403.243545903577, 5423.945760542403, 5439.428859969706, 4055.574164712692, 4271.252530807096, 5148.330717006803, 5304.230886521433, 5346.732663366835, 5260.763265653055, 5282.656627319212, 5286.656367336111, 5296.443873393277, 5327.094393952999, 5209.921851172236, 5227.843164705065, 5229.633925625208, 5259.789608415697, 5261.342332208474, 5647.265855438808, 5700.344460387067, 5730.570207234474, 5810.099434587603, 5861.736221870026, 6183.1034499997695, 6183.536234782409, 6192.845178870564, 6225.346338634424, 6230.9065364019125, 6200.937990620081, 6236.064590311445, 6236.750529978795, 6238.844028899269, 6341.746330146789, 5736.56975726818, 5782.421757824268, 5817.156512305776, 5873.882522349529, 5882.000059989812, 6278.277998030194, 6312.779052733133, 6315.747370105236, 6318.810435686937, 6334.746610135543, 6187.195664563578, 6195.690215489208, 6206.596571222856, 6228.750849966042, 6234.096056071844, 6106.855059071331, 6135.998322733915, 6142.682951206388, 6189.876202476015, 6278.434940855345, 4737.928931066037, 6164.0, 6165.6743800083195, 6168.642898562309, 6183.227096612924, 6166.321704612489, 6174.289956654952, 6177.1969643945995, 6178.474829639441, 6203.131561581382, 4891.437484689306, 4913.385826771653, 4955.6531042826655, 4961.70229786214, 5001.874953126201, 4450.5104438511735, 4462.0, 4480.39514665516, 4514.616257618073, 4558.521355257651, 5411.836455162159, 5706.657600543981, 5708.0581704019205, 5746.856328591819, 5762.683052432073, 6133.570650054543, 6200.255969283715, 6260.812175634738, 6261.843453913689, 6281.842953926189, 4762.8333008345235, 5759.8560035999435, 5766.452187042224, 5787.421257874263, 5798.072308430631, 5449.3188351456065, 5471.316085489314, 5473.562115030788, 5496.945030549723, 5498.340199176125, 6194.690265486617, 6207.472364849038, 6311.810645680545, 6324.08300796382, 6337.397947195009, 6205.844853878509, 6281.277653069956, 6287.497000240061, 6292.496600271876, 6298.244210694746, 6275.497960163085, 6339.144215530844, 6354.5869518483, 6362.554621176659, 6402.10370548133, 6099.007149909845, 6105.206323177958, 6140.933729672948, 6206.162168107247, 6237.812865614039, 6227.875442491034, 6247.5939063960695, 6254.843628909313, 6260.373962603703, 6263.843403914939, 5805.767769289181, 6171.321154673072, 6176.938230617637, 6189.84525386869, 6198.442140207403, 5978.910316345171, 6037.667928263988, 6060.454559089703, 6125.754969801158, 6131.724072416663, 5747.770089196385, 5888.911666325094, 5904.202932604216, 5961.791337303173, 5970.194023806731, 6147.477464415575, 6161.4146656067605, 6169.074638804215, 6185.350538193605, 6201.379862013762, 5945.940540594539, 5963.642181469126, 5977.372375900468, 5987.401259873977, 6015.518758499397], "value": 5695.88615771892, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [515.4510446374611, 515.6210185513648, 528.3738769558074, 551.7461967494958, 551.8234165067179, 28662.28344291391, 39473.40789888154, 39597.60402395975, 39740.00649983752, 39804.80097599515, 40803.59196408035, 40919.59080409195, 41344.0, 41361.0, 41448.58551414485, 8445.746627601182, 9668.85496717548, 9823.410595364265, 9848.06443387877, 9852.50737463124, 9789.0, 9816.656417025406, 9851.90148098517, 9860.852087218698, 9861.457619830906, 9831.754206144868, 9858.408495490257, 9861.901380986206, 9866.90133098667, 9867.506624668773, 9815.558299876488, 9830.508474576314, 9836.852447213298, 9836.90163098367, 9853.359531630422, 9712.70861874145, 9802.607895684165, 9809.460479673615, 9827.90172098277, 9839.212862970946, 39074.21851562953, 39257.21485570301, 39307.41038884419, 39417.40873886865, 39563.80218098891, 3220.21104829316, 3333.6499667535045, 3372.629010808809, 3381.847816848248, 3828.770273783582, 30416.695833041827, 30864.845675771703, 31333.843330783428, 31434.0, 31605.525917111263, 3209.518572214163, 3216.404965081444, 3249.382617302705, 3278.098522906196, 3339.5825521809775, 510010.0, 517212.0, 518289.9999999962, 519251.0, 519634.0, 29998.250043748645, 30372.392552148835, 59519.0, 59784.10323845059, 59830.10254846181, 31892.521612175835, 34028.48957265643, 34243.486347704806, 34252.65747342545, 34524.482132768026, 14461.060031098155, 14562.927185364006, 14586.270686465634, 14590.927045364917, 14651.413943442356, 12526.561570344995, 12582.937085314516, 12592.874071259354, 12623.495060197489, 12633.684157895943, 7548.886766698504, 7565.751650977637, 7606.847863042708, 7643.770686879402, 7667.53994760305, 2801.8372375463955, 3114.283714745621, 3115.9532607010915, 3177.8083218792954, 3210.598675165604, 801.1707882341865, 886.8536691445839, 951.5955718819474, 960.3853533738413, 995.4475266227169, 22217.223072077784, 24257.39356516066, 27756.861215693792, 28028.579571306447, 28334.85832570824, 754.9996254962197, 968.3124981263381, 1013.7313611892854, 1020.8111499372492, 1050.3540322701483, 11873.643790686121, 14038.36827342772, 15259.0, 15346.846531534542, 15515.224238788242, 656715.0, 663938.0, 667004.0, 670152.6492367507, 671918.0, 55970.72014639982, 56866.57833554112, 57130.0, 57219.42780572224, 57339.71330143323, 1321.7620828250815, 1333.2200662612286, 1355.8440779310308, 1359.286374653295, 1359.9728005439836, 28275.858620706764, 28558.857205713837, 28635.14094577166, 28983.275418114717, 29190.0, 41156.38265426081, 48913.0, 49475.50524494853, 49481.0, 49664.503354965986, 579765.0, 581291.0, 581305.0, 582128.0, 582466.0, 26199.214023579323, 26236.606450903633, 26645.200643980712, 26671.0, 27031.0, 46638.83402914819, 46842.76578617085, 47526.049479010915, 47868.28197576969, 48417.27374089321, 38397.040073997254, 38652.420213697376, 38715.0, 39300.01749956274, 39639.80180099196, 37211.81394093012, 37274.06814829651, 37484.0, 38360.0, 38666.42000369941, 36614.0, 37940.62059379481, 41014.15436305314, 41508.1698366037, 43081.0, 34322.313553729284, 36303.36634851491, 36644.08389790277, 41026.76919692295, 41553.376699348926, 27865.60671966434, 29990.0, 31137.688623114384, 31528.52707209348, 31685.20786980344], "value": 18506.08520212823, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [362.4327926794566, 377.69784172661883, 382.68046181438496, 387.8700635287179, 405.31704078627513, 19008.14463349151, 19798.0, 21299.254526091572, 21313.467163320904, 21483.570328593418, 11685.298882067082, 12186.573469928555, 12191.939040304786, 12215.0, 19676.803231967675, 5318.867028324294, 5591.245181900432, 5614.69119198446, 5618.5786066045, 5641.576881733866, 5289.603279754015, 5467.617266791326, 5497.890042199154, 5506.229127922074, 5513.641613295123, 5480.835574932738, 5499.7250137493165, 5503.9174412383645, 5510.559155267589, 5524.950259450711, 5369.48989845964, 6003.729832157564, 6048.0625503047095, 6063.878722425527, 6093.360197179299, 5101.438841727407, 5338.065838478251, 5343.0, 5346.465353464661, 5353.277307563468, 13122.86877131226, 13444.529441469502, 13490.932545337211, 13502.594922152253, 13539.458421663121, 2114.12263910477, 2232.229880691159, 2359.3393849722106, 2686.529857274969, 2699.446613444239, 9781.168600668952, 9912.950435247778, 10087.89912100877, 10198.388096714147, 10259.230557708202, 1870.8971006594631, 1931.8891637308463, 1932.6811076172414, 1935.9322423715103, 1976.6244413561378, 103777.0, 117691.41154294345, 117702.0, 121700.0, 124066.37966810199, 10934.835977460345, 11517.366544839946, 11570.537178512934, 11573.826392604118, 11704.0, 14335.211563364115, 14345.569632911029, 14346.713065738626, 14381.77082552206, 14394.0, 8193.79515512117, 8454.239118479367, 8519.659213631385, 8577.78555536104, 8583.48499090044, 7349.640316541457, 8314.043884953187, 8378.245957863699, 8414.36892233085, 8594.441361311494, 4363.454568178978, 4495.325701144854, 4544.840930567414, 4633.791479383436, 4635.07644327607, 1892.7634045744283, 1928.1323404468046, 1932.3623204342534, 1935.535471486833, 1936.2351871011153, 795.2365728900205, 801.3629164813987, 838.6603425612636, 898.5597057441806, 961.8172547216146, 15831.129287889047, 19292.42122736292, 19902.820973976304, 20385.184592616424, 22102.557948840935, 763.4541302968404, 824.3528829868525, 875.3916028360228, 920.2270093121809, 923.0999775219242, 10474.109700675375, 10840.0, 10848.403337816339, 10970.0, 11011.889881101246, 554183.0, 558293.3365330764, 559326.0, 572315.0, 573281.0, 78390.0, 80600.59699701464, 122251.0, 133562.0, 137133.3143334277, 861.2076889261895, 941.6280569175137, 1004.0361253196867, 1010.6917390195914, 1018.9898101019044, 18941.90529047346, 19167.0, 19203.0, 19231.615367692848, 19252.4224273272, 56768.71615641895, 57244.42755572391, 57579.712101439225, 57586.424135758105, 57810.421895780506, 82957.0, 83348.0, 83868.0, 84720.15279847369, 85755.0, 6942.444604431735, 6997.335253151146, 7855.5286682799215, 7915.604219789103, 8224.300934420402, 11761.411929403666, 12301.323427211231, 12349.135560511037, 12663.620091397273, 12707.93646031764, 9545.711328970778, 10732.409717465302, 10768.46157692128, 10894.836577451186, 10955.616553420592, 10547.419891905713, 10549.314294570828, 10569.788604228026, 10904.236703430684, 10918.454077296263, 10451.790964180826, 10473.633422830164, 10577.94220577967, 10621.946890265499, 11350.829737553779, 7939.126696063313, 8033.517988920684, 8122.7157049502985, 8178.550179740171, 8274.834503310021, 10435.478226088513, 10522.000409961041, 10726.410047447465, 10993.945030275117, 11034.448277586249], "value": 9115.420194535927, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1393.1153717389457, 1458.3437453146084, 1652.2564845819377, 1801.86486013549, 1860.4790658615584, 7843.490173138742, 8340.582970851463, 8467.745967620966, 8850.77873053174, 8887.377883548153, 8556.401051926368, 8570.185832345916, 8690.565471726404, 8690.91309086909, 8693.217610415062, 2359.7876191142836, 2379.3813608461837, 2390.1156572068357, 2390.784829365357, 2391.7727815857465, 2289.4848659051745, 2321.4080409495555, 2335.2060299498166, 2341.8711970841596, 2354.540864531417, 2370.395549134968, 2392.126873691099, 2397.137030668958, 2405.9037638494437, 2410.819188560856, 2363.3737059679197, 2369.07606033647, 2369.9052037918464, 2377.263048454976, 2388.3551441110803, 2357.610994185957, 2369.644553316999, 2371.537550177716, 2375.70303712036, 2382.273406610983, 8688.304935605136, 8766.693165739169, 8773.42972706772, 8786.0, 8787.340949428819, 5129.3075434816565, 5214.296070030536, 5214.791408343662, 5247.186686063628, 5257.053730328539, 2990.1179152149953, 3577.195131095483, 3631.94552081719, 3643.617420170897, 3650.543682039745, 1076.386459717961, 1092.2190633696946, 1099.0932480703452, 1104.618906477264, 1107.7175320293275, 11262.43687815614, 11406.54373825046, 11432.142589305835, 11440.885591144148, 11445.771084578346, 3709.795961222159, 4562.703424277478, 4724.362211101457, 4775.2359622460235, 4778.761061946958, 9651.71044868655, 9662.033796620422, 9665.226781857435, 9666.371685840399, 9735.853962190573, 5243.344581927259, 5296.788128474895, 5305.946940530623, 5327.067763141435, 5332.786688532493, 4377.4965878923695, 4710.764461776897, 4850.957044235506, 4888.584470319992, 4896.314515967767, 3795.848166073326, 3903.6096390361304, 3903.765774053509, 3936.3111455495746, 3990.2219067281603, 1285.3765923527083, 1296.883280504759, 1300.4148133340034, 1310.1484035377082, 1312.960611181666, 832.8375966686438, 849.392684230778, 901.2789768185426, 914.3645166609276, 926.0600490502146, 4911.557959783565, 5414.539764120094, 5725.484706376446, 6003.609765365237, 6026.397360263939, 717.9784606461815, 832.2759199496477, 955.1642312976146, 963.080258353285, 972.8686627305365, 3331.917126933756, 3463.8049872793845, 3583.7133029357587, 3693.6306369362846, 3990.1421194442755, 8919.910800892038, 10243.385396876061, 10364.792704145875, 10503.52734126966, 10606.681799546026, 8556.957215213884, 10375.27373083892, 10431.634892778868, 10571.36571805694, 10577.048065674126, 8063.637136328879, 8158.796030099176, 8170.959145204236, 8190.017197936286, 8240.711575094963, 5563.0, 5652.406497317723, 5783.566232532493, 5825.0679891217205, 5870.853228669317, 9747.463889486145, 9761.511924403894, 9816.607335706778, 9835.85246221293, 9867.901320986699, 9065.81868362616, 9432.717018489457, 10117.291789574954, 10126.392416455037, 10126.696199114038, 6852.211995620568, 7205.495615307088, 7337.779866604011, 7390.704371825282, 7498.887516687363, 8227.629756660845, 8276.0, 8335.249827515552, 8346.04020537646, 8347.12355202695, 7300.0, 7389.261073892568, 7391.704331826667, 7427.8143046424275, 7526.698932042657, 6495.642739649365, 7251.709931602888, 7391.186969433251, 7452.850942981218, 7586.0, 6810.0, 6933.514653974174, 6983.336583024605, 6997.895031574632, 6998.720051197895, 5057.291979123, 5060.519250671327, 5120.359955005624, 5125.384953805567, 5259.552938000313, 5094.821681241138, 5155.510226528474, 5189.1859483279, 5222.3472065991755, 5308.283381743569], "value": 4536.112960252597, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [265.495558438966, 273.68389510115816, 296.04968052551294, 315.51568342594123, 317.6902520042958, 5275.815346462875, 5462.754176062077, 5543.113101903701, 5554.416786237448, 5604.467575580324, 5291.444398338177, 5464.0, 5519.972400137994, 5533.253010843535, 5535.446455354462, 3513.525674034011, 4235.512916014652, 4238.5761423857675, 4258.701890867641, 4270.231358355495, 3266.918327041831, 3694.371956767356, 4035.3341698619693, 4147.854825081123, 4282.571742825724, 3603.477495763113, 4121.0, 4145.212409642173, 4158.14757974616, 4193.266178418779, 4176.582341765814, 4178.6657067434835, 4187.581241875819, 4207.305794543897, 4207.852725154605, 3160.98419507901, 3589.46158076288, 3592.8742494012845, 3604.567451905762, 3609.404448266033, 4567.2920697291975, 5015.774290156952, 5342.786288548454, 5392.622516423852, 5418.0, 4722.881927951795, 4750.524947505256, 4762.261849413347, 4777.546133117383, 4799.832005879777, 4713.929291060636, 5867.677277749722, 5880.882382352372, 5903.911441328383, 6023.879522409527, 3657.7073834093208, 3844.903877403059, 3882.495275614152, 3890.3775395936514, 3930.4474732480794, 4987.152184128707, 5313.362396512443, 6077.0, 6125.785597504066, 6163.938360616381, 3377.7128944040032, 3696.094456858087, 3769.3215221260434, 3805.657490825839, 3987.441758153861, 3660.2679464107287, 3877.0, 3902.5316961964177, 3971.92056158881, 4028.4158796974275, 4340.82636694535, 4403.383526306319, 4696.81212751493, 4700.271457924027, 4757.714537127714, 4906.533879281463, 4985.280078372955, 5838.386969368155, 5896.646201227854, 5913.615614985012, 1214.7023979125172, 1272.344742457635, 1335.4391155714623, 1367.596559015093, 1386.5632325817537, 791.5475103185719, 882.9977974998422, 911.7720569857536, 917.4770380882966, 948.672707915768, 4796.544328288807, 5397.9460205397445, 5407.863893761942, 5407.864803379947, 5413.536840737455, 5507.228987941691, 5758.186171356093, 6013.488853447506, 6015.248093988252, 6148.44663980244, 4252.48970123581, 4763.880488085297, 5415.53967912724, 5425.240466334716, 5475.233467314579, 3120.188750924776, 3205.845895477626, 3211.1008917503136, 3211.6948889855425, 3241.7244534214383, 5246.8425947220885, 5553.861153471195, 5817.621854579439, 5993.550483713739, 6003.279606447167, 5399.516222537598, 5651.587103224194, 5840.0, 6167.629942203482, 6374.649394283359, 5518.841043380935, 5839.766409343579, 5854.853628659318, 6255.78104766331, 6291.130954462972, 5377.354717433776, 5395.271638328775, 5713.542916566582, 5819.738111785065, 5986.102084687332, 4819.855404337875, 5245.554127899171, 5873.911891321719, 5968.850778730566, 5970.850728731816, 5822.563307752021, 6013.488853447506, 6215.96892015537, 6271.498280137669, 6309.277526259529, 2884.4519541287086, 3438.7964212526417, 3899.53205615328, 3936.5866584008268, 3938.232044751246, 5187.974060129675, 5673.971630141823, 5980.641161530322, 6002.579819412774, 6050.9394906050375, 5159.355080614923, 5225.555827754683, 5676.659400435987, 5823.388544202798, 5875.441833025856, 5361.0, 5849.853753656193, 5855.0, 5866.911996319973, 5889.617174883619, 4829.6860704054125, 5030.0, 5075.137226671401, 5235.853300146921, 5754.280714910637, 4924.8276310328965, 5073.644844860824, 5922.466977971831, 5933.169356290036, 6000.339962604197, 4791.856244312537, 5410.783568657367, 5622.97956960775, 5810.593258471867, 5814.389489103583], "value": 4179.141534730761, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [663.0981864664059, 676.5230512488696, 693.2582137113287, 699.1365663405695, 704.9894251586227, 11186.608468703587, 15853.048817070983, 16031.759523607156, 16145.43490977816, 16161.676766464663, 14083.225422601752, 14609.415623375078, 14710.485133020346, 14730.705385892275, 14748.041377310466, 857.8455877941968, 860.862262038074, 861.4357595774777, 861.750092473182, 862.2670729879584, 683.4293365040197, 832.9750107496785, 837.3426859914968, 857.8112815180682, 872.4459967920353, 912.9406588571754, 919.5218486387075, 921.1479381572019, 922.3359181389422, 924.154398725169, 909.9636014559443, 910.2444970674325, 913.3287034029983, 913.4610579757974, 913.4793167894303, 670.0485310858593, 680.4828330468879, 683.2859661653584, 684.9691763870588, 685.8868286732683, 14778.48275310359, 14808.259587020606, 14862.331195096247, 14871.405143794234, 14881.255937203205, 14134.0, 14279.0, 14320.713585728332, 14547.927260363631, 14590.70818583633, 9826.355768414453, 11892.702682432922, 11899.405029748565, 11980.10149238802, 11985.22096063753, 3812.4090765931046, 3846.134619710571, 3858.054776579728, 3863.5750067492554, 3867.845286188549, 116626.0, 119515.0, 120004.0, 122258.0, 122686.0, 9344.719658410258, 10952.561897524169, 10980.780384392427, 11196.888031119584, 11241.60654377093, 22592.209272675376, 22601.4349641257, 22603.547929041655, 22644.773552264265, 22656.433589160402, 8044.1955804419085, 8140.990786513439, 8161.918380816234, 8174.305184059422, 8183.345332373396, 4482.849068836338, 4502.414686090788, 4527.796249168795, 4552.931706024412, 4636.11913736389, 3197.6962188592047, 3200.9679903201136, 3483.860645574199, 3609.8556057757396, 3669.082729317671, 567.7076305702567, 568.5991376079854, 660.8083655739781, 665.0954701605813, 681.0, 550.8760528881049, 565.1692012741264, 602.9427204415573, 640.6956695569568, 641.5092454272485, 7791.298783109434, 9190.172884440299, 9348.57931393089, 9450.149486546245, 9581.904180958241, 518.8443466959973, 552.9225908372831, 600.8978473659402, 644.4618743349262, 648.4067078623101, 4441.622462090694, 4465.620422264079, 4467.5755803198645, 4646.4191976003, 4754.09672162295, 165943.0, 165988.0, 166021.16989415218, 169847.0, 177803.0, 140690.0, 142210.0, 142578.0, 145396.0, 147907.0, 119392.8060719399, 121147.39426302812, 121755.3912230451, 122848.38575807064, 123527.0, 8717.912820871963, 9067.138621830916, 9162.954185229031, 9201.534588178758, 9334.533273336441, 67238.0, 67463.32536674767, 68681.96977045249, 68705.65647171732, 69017.2745681362, 63055.0, 101689.49155254473, 102189.48905255724, 103452.0, 104624.47687761512, 11853.146505923703, 11946.402679865798, 12040.096992725405, 12158.088143389105, 12589.370531473573, 13044.478220871059, 13291.80062299047, 13364.866351336363, 13434.193948363129, 13457.932710336385, 12074.39628018613, 12268.263904165779, 12367.505299787908, 12380.195287306296, 12830.16603920742, 12327.876721233031, 12356.691082723004, 12566.246025238515, 12708.936455318035, 12719.109662323548, 11830.877033013852, 12033.338166400932, 12064.819027714415, 12177.878221217674, 12182.329971851634, 9594.616215351307, 10310.43292618913, 10404.271700980858, 10788.136949043901, 10950.34297942126, 9967.60129594837, 10233.590656373663, 10542.420166890895, 10567.682969510926, 10623.734406639896], "value": 7769.545142553039, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1625.9000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 111.0, 118.0, 127.0, 171.0, 134.0, 117.0, 117.0, 116.0, 119.0], "value": 124.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 142.0, 172.0, 152.0, 102.0, 161.0, 160.0, 141.0, 183.0, 110.0], "value": 148.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [202.0, 211.0, 242.0, 177.0, 268.0, 266.0, 195.0, 221.0, 220.0, 215.0], "value": 221.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 85.0, 78.0, 144.0, 63.0, 78.0, 83.0, 90.0, 151.0, 60.0], "value": 90.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 73.0, 123.0, 69.0, 78.0, 113.0, 142.0, 96.0, 98.0, 114.0], "value": 97.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 74.0, 137.0, 129.0, 87.0, 85.0, 88.0, 76.0, 136.0, 132.0], "value": 103.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 98.0, 97.0, 97.0, 98.0, 107.0, 98.0, 97.0, 98.0, 98.0], "value": 102.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 93.0, 91.0, 95.0, 78.0, 147.0, 149.0, 90.0, 90.0, 91.0], "value": 102.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 59.0, 58.0, 58.0, 59.0, 60.0, 58.0, 56.0, 58.0, 56.0], "value": 57.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 70.0, 79.0, 80.0, 86.0, 77.0, 72.0, 76.0, 79.0, 74.0], "value": 76.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 101.0, 88.0, 86.0, 88.0, 89.0, 88.0, 92.0, 80.0, 95.0], "value": 89.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 141.0, 140.0, 142.0, 162.0, 164.0, 155.0, 142.0, 189.0, 158.0], "value": 153.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [216.0, 238.0, 177.0, 175.0, 204.0, 202.0, 172.0, 170.0, 173.0, 173.0], "value": 190.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 70.0, 66.0, 70.0, 68.0, 68.0, 68.0, 68.0, 69.0], "value": 68.3, "unit": "score"}]}]} 00:43:48 INFO - Return code: 0 00:43:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 00:43:48 ERROR - # TBPL SUCCESS # 00:43:48 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 00:43:48 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 00:43:48 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 00:43:48 INFO - 2016-08-30 00:43:48.192 screenresolution[2190:14820] starting screenresolution argv=screenresolution get 00:43:48 INFO - 2016-08-30 00:43:48.195 screenresolution[2190:14820] Display 0: 1600x1200x32@60 00:43:48 INFO - 2016-08-30 00:43:48.201 screenresolution[2191:14823] starting screenresolution argv=screenresolution list 00:43:48 INFO - Available Modes on Display 0 00:43:48 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 00:43:48 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 00:43:48 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 00:43:48 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 00:43:48 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 00:43:48 INFO - Intel Iris: 00:43:48 INFO - Chipset Model: Intel Iris 00:43:48 INFO - Type: GPU 00:43:48 INFO - Bus: Built-In 00:43:48 INFO - VRAM (Dynamic, Max): 1536 MB 00:43:48 INFO - Vendor: Intel (0x8086) 00:43:48 INFO - Device ID: 0x0a2e 00:43:48 INFO - Revision ID: 0x0009 00:43:48 INFO - Displays: 00:43:48 INFO - Display: 00:43:48 INFO - Resolution: 1600 x 1200 @ 60 Hz 00:43:48 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 00:43:48 INFO - Display Serial Number: 1600x1200 60 00:43:48 INFO - Main Display: Yes 00:43:48 INFO - Mirror: Off 00:43:48 INFO - Online: Yes 00:43:48 INFO - Rotation: Supported 00:43:48 INFO - Return code: 0 00:43:48 INFO - Running post-action listener: _resource_record_post_action 00:43:48 INFO - [mozharness: 2016-08-30 07:43:48.436463Z] Finished run-tests step (success) 00:43:48 INFO - Running post-run listener: _resource_record_post_run 00:43:48 INFO - Total resource usage - Wall time: 1209s; CPU: 55.0%; Read bytes: 1044480; Write bytes: 715437056; Read time: 20; Write time: 2174 00:43:48 INFO - TinderboxPrint: CPU usage
54.5% 00:43:48 INFO - TinderboxPrint: I/O read bytes / time
1,044,480 / 20 00:43:48 INFO - TinderboxPrint: I/O write bytes / time
715,437,056 / 2,174 00:43:48 INFO - TinderboxPrint: CPU idle
2,199.1 (45.5%) 00:43:48 INFO - TinderboxPrint: CPU system
981.2 (20.3%) 00:43:48 INFO - TinderboxPrint: CPU user
1,657.3 (34.3%) 00:43:48 INFO - TinderboxPrint: Swap in / out
406,786,048 / 0 00:43:48 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 406987264; Write bytes: 410638336; Read time: 29873; Write time: 805 00:43:48 INFO - run-tests - Wall time: 1176s; CPU: 55.0%; Read bytes: 745472; Write bytes: 303283200; Read time: 10; Write time: 1363 00:43:48 INFO - Running post-run listener: _upload_blobber_files 00:43:48 INFO - Blob upload gear active. 00:43:48 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 00:43:48 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 00:43:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Autoland', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 00:43:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Autoland -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 00:43:49 INFO - (blobuploader) - INFO - Open directory for files ... 00:43:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 00:43:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:43:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:43:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 00:43:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:43:50 INFO - (blobuploader) - INFO - Done attempting. 00:43:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 00:43:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:43:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:43:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 00:43:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:43:51 INFO - (blobuploader) - INFO - Done attempting. 00:43:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 00:43:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:43:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:43:53 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 00:43:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:43:53 INFO - (blobuploader) - INFO - Done attempting. 00:43:53 INFO - (blobuploader) - INFO - Iteration through files over. 00:43:53 INFO - Return code: 0 00:43:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 00:43:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 00:43:53 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/d18bfeabc273f9f99b5f6bc2fec9d71d68de557a1db4fa6a2edcd2771c1784d95779378d88565f6c18b2e5d818a243bad33323620491253c40fb90a82336df6f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/064d438e77c623ca86e9667be64fa547dd81174211d38051482503ae86e0d87a8df27b4bc4c5ea0211a91275e3424690a9dd70f1cd204228bd2108c63795e86a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/bfe8f03dbc405f82bc808e1b635545d7e92dd71fedd470b36914fbd81562e0929da040a72a5c54931765e591dd232ecfa03839320836e3351db10ce725dff72b"} 00:43:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 00:43:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 00:43:53 INFO - Contents: 00:43:53 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/d18bfeabc273f9f99b5f6bc2fec9d71d68de557a1db4fa6a2edcd2771c1784d95779378d88565f6c18b2e5d818a243bad33323620491253c40fb90a82336df6f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/064d438e77c623ca86e9667be64fa547dd81174211d38051482503ae86e0d87a8df27b4bc4c5ea0211a91275e3424690a9dd70f1cd204228bd2108c63795e86a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/bfe8f03dbc405f82bc808e1b635545d7e92dd71fedd470b36914fbd81562e0929da040a72a5c54931765e591dd232ecfa03839320836e3351db10ce725dff72b"} 00:43:53 INFO - Running post-run listener: copy_logs_to_upload_dir 00:43:53 INFO - Copying logs to upload dir... 00:43:53 INFO - mkdir: /builds/slave/test/build/upload/logs 00:43:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1269.177432 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-08-30 00:43:53.603776) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-30 00:43:53.611082) ========= 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.GyJGWNINcd/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.wzxvG2mf3m/Listeners TMPDIR=/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/d18bfeabc273f9f99b5f6bc2fec9d71d68de557a1db4fa6a2edcd2771c1784d95779378d88565f6c18b2e5d818a243bad33323620491253c40fb90a82336df6f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/064d438e77c623ca86e9667be64fa547dd81174211d38051482503ae86e0d87a8df27b4bc4c5ea0211a91275e3424690a9dd70f1cd204228bd2108c63795e86a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/bfe8f03dbc405f82bc808e1b635545d7e92dd71fedd470b36914fbd81562e0929da040a72a5c54931765e591dd232ecfa03839320836e3351db10ce725dff72b"} build_url:https://queue.taskcluster.net/v1/task/VJeiAS_DSTejRTyzlr-C9A/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011506 build_url: 'https://queue.taskcluster.net/v1/task/VJeiAS_DSTejRTyzlr-C9A/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/d18bfeabc273f9f99b5f6bc2fec9d71d68de557a1db4fa6a2edcd2771c1784d95779378d88565f6c18b2e5d818a243bad33323620491253c40fb90a82336df6f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/064d438e77c623ca86e9667be64fa547dd81174211d38051482503ae86e0d87a8df27b4bc4c5ea0211a91275e3424690a9dd70f1cd204228bd2108c63795e86a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/bfe8f03dbc405f82bc808e1b635545d7e92dd71fedd470b36914fbd81562e0929da040a72a5c54931765e591dd232ecfa03839320836e3351db10ce725dff72b"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-30 00:43:53.649344) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 00:43:53.649717) ========= 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.GyJGWNINcd/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.wzxvG2mf3m/Listeners TMPDIR=/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/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.005343 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 00:43:53.701039) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-30 00:43:53.701734) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-30 00:43:53.702361) ========= ========= Total master_lag: 0.22 =========