builder: autoland_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0281 starttime: 1471278215.63 results: success (0) buildid: 20160815065716 builduid: dadb80c49d0a438980690350a5a10d56 revision: af8f5fa2d6ca5957791e68583679522ee0f08902 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-15 09:23:35.630175) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-15 09:23:35.630715) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-15 09:23:35.630985) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-15 09:23:35.856825) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-15 09:23:35.857113) ========= 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.yIAoJJJUHI/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.EFEr2Lv5uh/Listeners TMPDIR=/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/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-15 09:23:35-- 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% 64.7M=0s 2016-08-15 09:23:36 (64.7 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.594768 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-15 09:23:36.486358) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-15 09:23:36.486643) ========= 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.yIAoJJJUHI/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.EFEr2Lv5uh/Listeners TMPDIR=/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/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.024901 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-15 09:23:36.536177) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-15 09:23:36.536627) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev af8f5fa2d6ca5957791e68583679522ee0f08902 --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 af8f5fa2d6ca5957791e68583679522ee0f08902 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.yIAoJJJUHI/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.EFEr2Lv5uh/Listeners TMPDIR=/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/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-15 09:23:36,620 truncating revision to first 12 chars 2016-08-15 09:23:36,621 Setting DEBUG logging. 2016-08-15 09:23:36,621 attempt 1/10 2016-08-15 09:23:36,621 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/af8f5fa2d6ca?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-15 09:23:37,369 unpacking tar archive at: autoland-af8f5fa2d6ca/testing/mozharness/ program finished with exit code 0 elapsedTime=1.047009 ========= master_lag: 0.07 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-15 09:23:37.651401) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-15 09:23:37.651704) ========= script_repo_revision: af8f5fa2d6ca5957791e68583679522ee0f08902 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-15 09:23:37.652068) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-15 09:23:37.652356) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-15 09:23:37.672461) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-08-15 09:23:37.672884) ========= /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.yIAoJJJUHI/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.EFEr2Lv5uh/Listeners TMPDIR=/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/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 09:23:37 INFO - MultiFileLogger online at 20160815 09:23:37 in /builds/slave/test 09:23:37 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 09:23:37 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:23:37 INFO - {'append_to_log': False, 09:23:37 INFO - 'base_work_dir': '/builds/slave/test', 09:23:37 INFO - 'blob_upload_branch': 'Autoland', 09:23:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:23:37 INFO - 'branch': 'Autoland', 09:23:37 INFO - 'buildbot_json_path': 'buildprops.json', 09:23:37 INFO - 'config_files': ('talos/mac_config.py',), 09:23:37 INFO - 'default_actions': ('clobber', 09:23:37 INFO - 'read-buildbot-config', 09:23:37 INFO - 'download-and-extract', 09:23:37 INFO - 'populate-webroot', 09:23:37 INFO - 'create-virtualenv', 09:23:37 INFO - 'install', 09:23:37 INFO - 'run-tests'), 09:23:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:23:37 INFO - 'download_minidump_stackwalk': True, 09:23:37 INFO - 'download_symbols': 'ondemand', 09:23:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:23:37 INFO - 'tooltool.py': '/tools/tooltool.py', 09:23:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:23:37 INFO - '/tools/misc-python/virtualenv.py')}, 09:23:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:23:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:23:37 INFO - 'installer_path': 'installer.exe', 09:23:37 INFO - 'log_level': 'info', 09:23:37 INFO - 'log_name': 'talos', 09:23:37 INFO - 'log_to_console': True, 09:23:37 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:23:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:23:37 INFO - 'opt_config_files': (), 09:23:37 INFO - 'pip_index': False, 09:23:37 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:23:37 INFO - 'cmd': ('bash', 09:23:37 INFO - '-c', 09:23:37 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:23:37 INFO - 'enabled': True, 09:23:37 INFO - 'halt_on_failure': False, 09:23:37 INFO - 'name': 'check_screen_resolution'},), 09:23:37 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:23:37 INFO - 'cmd': ('bash', 09:23:37 INFO - '-c', 09:23:37 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:23:37 INFO - 'enabled': True, 09:23:37 INFO - 'halt_on_failure': False, 09:23:37 INFO - 'name': 'check_screen_resolution'},), 09:23:37 INFO - 'run_cmd_checks_enabled': True, 09:23:37 INFO - 'sps_profile': False, 09:23:37 INFO - 'sps_profile_interval': 0, 09:23:37 INFO - 'suite': 'dromaeojs-e10s', 09:23:37 INFO - 'system_bits': '32', 09:23:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:23:37 INFO - 'title': 't-yosemite-r7-0281', 09:23:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:23:37 INFO - 'use_talos_json': True, 09:23:37 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:23:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:23:37 INFO - 'work_dir': 'build'} 09:23:37 INFO - [mozharness: 2016-08-15 16:23:37.868124Z] Running clobber step. 09:23:37 INFO - Running pre-action listener: _resource_record_pre_action 09:23:37 INFO - Running main action method: clobber 09:23:37 INFO - rmtree: /builds/slave/test/build 09:23:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:23:40 INFO - Running post-action listener: _resource_record_post_action 09:23:40 INFO - [mozharness: 2016-08-15 16:23:40.038047Z] Finished clobber step (success) 09:23:40 INFO - [mozharness: 2016-08-15 16:23:40.038180Z] Running read-buildbot-config step. 09:23:40 INFO - Running pre-action listener: _resource_record_pre_action 09:23:40 INFO - Running main action method: read_buildbot_config 09:23:40 INFO - Using buildbot properties: 09:23:40 INFO - { 09:23:40 INFO - "project": "", 09:23:40 INFO - "product": "firefox", 09:23:40 INFO - "script_repo_revision": "production", 09:23:40 INFO - "builddir": "autoland_yosemite_r7_test-dromaeojs-e10s", 09:23:40 INFO - "repository": "", 09:23:40 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 autoland talos dromaeojs-e10s", 09:23:40 INFO - "buildid": "20160815065716", 09:23:40 INFO - "pgo_build": "False", 09:23:40 INFO - "basedir": "/builds/slave/test", 09:23:40 INFO - "buildnumber": 120, 09:23:40 INFO - "slavename": "t-yosemite-r7-0281", 09:23:40 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 09:23:40 INFO - "platform": "yosemite_r7", 09:23:40 INFO - "scheduler": "tests-autoland-macosx64-talos", 09:23:40 INFO - "branch": "autoland", 09:23:40 INFO - "repo_path": "integration/autoland", 09:23:40 INFO - "revision": "af8f5fa2d6ca5957791e68583679522ee0f08902", 09:23:40 INFO - "stage_platform": "macosx64", 09:23:40 INFO - "builduid": "dadb80c49d0a438980690350a5a10d56", 09:23:40 INFO - "slavebuilddir": "test" 09:23:40 INFO - } 09:23:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/NUY8soEiTqOBnh0MmJ_ZgQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 09:23:40 INFO - Running post-action listener: _resource_record_post_action 09:23:40 INFO - [mozharness: 2016-08-15 16:23:40.041554Z] Finished read-buildbot-config step (success) 09:23:40 INFO - [mozharness: 2016-08-15 16:23:40.041655Z] Running download-and-extract step. 09:23:40 INFO - Running pre-action listener: _resource_record_pre_action 09:23:40 INFO - Running main action method: download_and_extract 09:23:40 INFO - mkdir: /builds/slave/test/build/tests 09:23:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:23:40 INFO - trying https://queue.taskcluster.net/v1/task/NUY8soEiTqOBnh0MmJ_ZgQ/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 09:23:40 INFO - Downloading https://queue.taskcluster.net/v1/task/NUY8soEiTqOBnh0MmJ_ZgQ/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 09:23:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NUY8soEiTqOBnh0MmJ_ZgQ/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 09:23:41 INFO - Downloaded 1199 bytes. 09:23:41 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 09:23:41 INFO - Using the following test package requirements: 09:23:41 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 09:23:41 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 09:23:41 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 09:23:41 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 09:23:41 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 09:23:41 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 09:23:41 INFO - u'jsshell-mac.zip'], 09:23:41 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 09:23:41 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 09:23:41 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 09:23:41 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 09:23:41 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 09:23:41 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 09:23:41 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 09:23:41 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 09:23:41 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 09:23:41 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 09:23:41 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 09:23:41 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 09:23:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:23:41 INFO - trying https://queue.taskcluster.net/v1/task/NUY8soEiTqOBnh0MmJ_ZgQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 09:23:41 INFO - Downloading https://queue.taskcluster.net/v1/task/NUY8soEiTqOBnh0MmJ_ZgQ/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 09:23:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NUY8soEiTqOBnh0MmJ_ZgQ/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 09:23:42 INFO - Downloaded 16331582 bytes. 09:23:42 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 09:23:49 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 09:23:49 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')]} 09:23:49 INFO - trying https://queue.taskcluster.net/v1/task/NUY8soEiTqOBnh0MmJ_ZgQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 09:23:49 INFO - Downloading https://queue.taskcluster.net/v1/task/NUY8soEiTqOBnh0MmJ_ZgQ/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 09:23:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NUY8soEiTqOBnh0MmJ_ZgQ/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 09:23:50 INFO - Downloaded 16331582 bytes. 09:23:50 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 09:23:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:23:56 INFO - trying https://queue.taskcluster.net/v1/task/NUY8soEiTqOBnh0MmJ_ZgQ/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 09:23:56 INFO - Downloading https://queue.taskcluster.net/v1/task/NUY8soEiTqOBnh0MmJ_ZgQ/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 09:23:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NUY8soEiTqOBnh0MmJ_ZgQ/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 09:23:58 INFO - Downloaded 14413719 bytes. 09:23:58 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/tests 09:23:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:23:58 INFO - trying https://queue.taskcluster.net/v1/task/NUY8soEiTqOBnh0MmJ_ZgQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 09:23:58 INFO - Downloading https://queue.taskcluster.net/v1/task/NUY8soEiTqOBnh0MmJ_ZgQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 09:23:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NUY8soEiTqOBnh0MmJ_ZgQ/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 09:24:04 INFO - Downloaded 111031003 bytes. 09:24:04 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NUY8soEiTqOBnh0MmJ_ZgQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 09:24:04 INFO - mkdir: /builds/slave/test/properties 09:24:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:24:04 INFO - Writing to file /builds/slave/test/properties/build_url 09:24:04 INFO - Contents: 09:24:04 INFO - build_url:https://queue.taskcluster.net/v1/task/NUY8soEiTqOBnh0MmJ_ZgQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 09:24:05 INFO - Running post-action listener: _resource_record_post_action 09:24:05 INFO - Running post-action listener: set_extra_try_arguments 09:24:05 INFO - [mozharness: 2016-08-15 16:24:05.746750Z] Finished download-and-extract step (success) 09:24:05 INFO - [mozharness: 2016-08-15 16:24:05.746899Z] Running populate-webroot step. 09:24:05 INFO - Running pre-action listener: _resource_record_pre_action 09:24:05 INFO - Running main action method: populate_webroot 09:24:05 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:24:05 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:24:05 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:24:05 INFO - '--tppagecycles', 09:24:05 INFO - '7'], 09:24:05 INFO - 'tests': ['tsvgm']}}, 09:24:05 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:24:05 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:24:05 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:24:05 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:24:05 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:24:05 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:24:05 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:24:05 INFO - 'talos_options': ['--disable-e10s'], 09:24:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:24:05 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:24:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:24:05 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:24:05 INFO - 'talos_options': ['--disable-e10s'], 09:24:05 INFO - 'tests': ['damp', 'tps']}, 09:24:05 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:24:05 INFO - 'tests': ['damp', 'tps']}, 09:24:05 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:24:05 INFO - 'tests': ['dromaeo_dom']}, 09:24:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:24:05 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:24:05 INFO - 'tests': ['basic_compositor_video']}, 09:24:05 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:24:05 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:24:05 INFO - 'tests': ['a11yr', 09:24:05 INFO - 'ts_paint', 09:24:05 INFO - 'tpaint', 09:24:05 INFO - 'sessionrestore', 09:24:05 INFO - 'sessionrestore_no_auto_restore', 09:24:05 INFO - 'tabpaint']}, 09:24:05 INFO - 'other-e10s': {'tests': ['a11yr', 09:24:05 INFO - 'ts_paint', 09:24:05 INFO - 'tpaint', 09:24:05 INFO - 'sessionrestore', 09:24:05 INFO - 'sessionrestore_no_auto_restore', 09:24:05 INFO - 'tabpaint']}, 09:24:05 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:24:05 INFO - 'ts_paint', 09:24:05 INFO - 'tpaint', 09:24:05 INFO - 'sessionrestore', 09:24:05 INFO - 'sessionrestore_no_auto_restore', 09:24:05 INFO - 'tabpaint']}, 09:24:05 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:24:05 INFO - 'ts_paint', 09:24:05 INFO - 'tpaint', 09:24:05 INFO - 'sessionrestore', 09:24:05 INFO - 'sessionrestore_no_auto_restore', 09:24:05 INFO - 'tabpaint']}, 09:24:05 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:24:05 INFO - 'tests': ['a11yr', 09:24:05 INFO - 'ts_paint', 09:24:05 INFO - 'tpaint', 09:24:05 INFO - 'sessionrestore', 09:24:05 INFO - 'sessionrestore_no_auto_restore', 09:24:05 INFO - 'tabpaint']}, 09:24:05 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:24:05 INFO - 'tests': ['a11yr', 09:24:05 INFO - 'ts_paint', 09:24:05 INFO - 'tpaint', 09:24:05 INFO - 'sessionrestore', 09:24:05 INFO - 'sessionrestore_no_auto_restore', 09:24:05 INFO - 'tabpaint']}, 09:24:05 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:24:05 INFO - 'tests': ['tsvgx', 09:24:05 INFO - 'tsvgr_opacity', 09:24:05 INFO - 'tart', 09:24:05 INFO - 'tscrollx', 09:24:05 INFO - 'cart']}, 09:24:05 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:24:05 INFO - 'tsvgr_opacity', 09:24:05 INFO - 'tart', 09:24:05 INFO - 'tscrollx', 09:24:05 INFO - 'cart']}, 09:24:05 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:24:05 INFO - 'talos_options': ['--disable-e10s'], 09:24:05 INFO - 'tests': ['tp5o']}, 09:24:05 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:24:05 INFO - 'tests': ['tp5o']}, 09:24:05 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:24:05 INFO - 'talos_options': ['--disable-e10s', 09:24:05 INFO - '--xperf_path', 09:24:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:24:05 INFO - 'tests': ['tp5n']}, 09:24:05 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:24:05 INFO - 'talos_options': ['--xperf_path', 09:24:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:24:05 INFO - 'tests': ['tp5n']}}, 09:24:05 INFO - 'talos.zip': {'path': '', 09:24:05 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:24:05 INFO - Running post-action listener: _resource_record_post_action 09:24:05 INFO - [mozharness: 2016-08-15 16:24:05.765998Z] Finished populate-webroot step (success) 09:24:05 INFO - [mozharness: 2016-08-15 16:24:05.766134Z] Running create-virtualenv step. 09:24:05 INFO - Running pre-action listener: _resource_record_pre_action 09:24:05 INFO - Running main action method: create_virtualenv 09:24:05 INFO - Creating virtualenv /builds/slave/test/build/venv 09:24:05 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 09:24:05 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:24:05 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:24:05 INFO - Using real prefix '/tools/python27' 09:24:05 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:24:06 INFO - Installing distribute.............................................................................................................................................................................................done. 09:24:09 INFO - Installing pip.................done. 09:24:09 INFO - Return code: 0 09:24:09 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:24:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:24:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:24:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:24:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:24:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:09 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 0x10d4bba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d550618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c1847c970>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d41fd30>, '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 0x10d184db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d417b20>, '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.yIAoJJJUHI/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.EFEr2Lv5uh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/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 09:24:09 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 09:24:09 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 09:24:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yIAoJJJUHI/Render', 09:24:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:24:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:24:09 INFO - 'HOME': '/Users/cltbld', 09:24:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:24:09 INFO - 'LOGNAME': 'cltbld', 09:24:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:24:09 INFO - 'MOZ_NO_REMOTE': '1', 09:24:09 INFO - 'NO_EM_RESTART': '1', 09:24:09 INFO - 'PAGER': '/bin/cat', 09:24:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:24:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:24:09 INFO - 'PWD': '/builds/slave/test', 09:24:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:24:09 INFO - 'SHELL': '/bin/bash', 09:24:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EFEr2Lv5uh/Listeners', 09:24:09 INFO - 'TMPDIR': '/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/', 09:24:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:24:09 INFO - 'USER': 'cltbld', 09:24:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:24:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:24:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:24:09 INFO - 'XPC_FLAGS': '0x0', 09:24:09 INFO - 'XPC_SERVICE_NAME': '0', 09:24:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:24:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:24:09 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 09:24:09 INFO - Cleaning up... 09:24:09 INFO - Return code: 0 09:24:09 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:24:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:24:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:24:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:24:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:24:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:09 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 0x10d4bba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d550618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c1847c970>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d41fd30>, '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 0x10d184db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d417b20>, '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.yIAoJJJUHI/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.EFEr2Lv5uh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/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 09:24:09 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 09:24:09 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 09:24:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yIAoJJJUHI/Render', 09:24:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:24:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:24:09 INFO - 'HOME': '/Users/cltbld', 09:24:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:24:09 INFO - 'LOGNAME': 'cltbld', 09:24:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:24:09 INFO - 'MOZ_NO_REMOTE': '1', 09:24:09 INFO - 'NO_EM_RESTART': '1', 09:24:09 INFO - 'PAGER': '/bin/cat', 09:24:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:24:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:24:09 INFO - 'PWD': '/builds/slave/test', 09:24:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:24:09 INFO - 'SHELL': '/bin/bash', 09:24:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EFEr2Lv5uh/Listeners', 09:24:09 INFO - 'TMPDIR': '/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/', 09:24:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:24:09 INFO - 'USER': 'cltbld', 09:24:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:24:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:24:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:24:09 INFO - 'XPC_FLAGS': '0x0', 09:24:09 INFO - 'XPC_SERVICE_NAME': '0', 09:24:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:24:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:24:10 INFO - Downloading/unpacking psutil>=3.1.1 09:24:10 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 09:24:10 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 09:24:10 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 09:24:10 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 09:24:10 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 09:24:10 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 09:24:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:24:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:24:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:24:13 INFO - Installing collected packages: psutil 09:24:13 INFO - Running setup.py install for psutil 09:24:13 INFO - building 'psutil._psutil_osx' extension 09:24:13 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 09:24:13 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 09:24:13 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 09:24:14 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 09:24:14 INFO - building 'psutil._psutil_posix' extension 09:24:14 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 09:24:14 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:24:14 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:24:14 INFO - ^ 09:24:14 INFO - 1 warning generated. 09:24:14 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 09:24:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:24:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:24:14 INFO - Successfully installed psutil 09:24:14 INFO - Cleaning up... 09:24:14 INFO - Return code: 0 09:24:14 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:24:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:24:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:24:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:24:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:24:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d4bba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d550618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c1847c970>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d41fd30>, '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 0x10d184db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d417b20>, '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.yIAoJJJUHI/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.EFEr2Lv5uh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/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 09:24:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:24:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:24:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yIAoJJJUHI/Render', 09:24:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:24:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:24:14 INFO - 'HOME': '/Users/cltbld', 09:24:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:24:14 INFO - 'LOGNAME': 'cltbld', 09:24:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:24:14 INFO - 'MOZ_NO_REMOTE': '1', 09:24:14 INFO - 'NO_EM_RESTART': '1', 09:24:14 INFO - 'PAGER': '/bin/cat', 09:24:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:24:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:24:14 INFO - 'PWD': '/builds/slave/test', 09:24:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:24:14 INFO - 'SHELL': '/bin/bash', 09:24:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EFEr2Lv5uh/Listeners', 09:24:14 INFO - 'TMPDIR': '/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/', 09:24:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:24:14 INFO - 'USER': 'cltbld', 09:24:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:24:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:24:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:24:14 INFO - 'XPC_FLAGS': '0x0', 09:24:14 INFO - 'XPC_SERVICE_NAME': '0', 09:24:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:24:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:24:14 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:24:14 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 09:24:14 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 09:24:14 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 09:24:14 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 09:24:14 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 09:24:14 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 09:24:17 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:24:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:24:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:24:17 INFO - Installing collected packages: mozsystemmonitor 09:24:17 INFO - Running setup.py install for mozsystemmonitor 09:24:17 INFO - Successfully installed mozsystemmonitor 09:24:17 INFO - Cleaning up... 09:24:17 INFO - Return code: 0 09:24:17 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:24:17 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')]} 09:24:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:24:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:17 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')]} 09:24:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:24:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:17 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 0x10d4bba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d550618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c1847c970>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d41fd30>, '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 0x10d184db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d417b20>, '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.yIAoJJJUHI/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.EFEr2Lv5uh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/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 09:24:17 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 09:24:17 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 09:24:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yIAoJJJUHI/Render', 09:24:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:24:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:24:17 INFO - 'HOME': '/Users/cltbld', 09:24:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:24:17 INFO - 'LOGNAME': 'cltbld', 09:24:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:24:17 INFO - 'MOZ_NO_REMOTE': '1', 09:24:17 INFO - 'NO_EM_RESTART': '1', 09:24:17 INFO - 'PAGER': '/bin/cat', 09:24:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:24:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:24:17 INFO - 'PWD': '/builds/slave/test', 09:24:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:24:17 INFO - 'SHELL': '/bin/bash', 09:24:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EFEr2Lv5uh/Listeners', 09:24:17 INFO - 'TMPDIR': '/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/', 09:24:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:24:17 INFO - 'USER': 'cltbld', 09:24:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:24:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:24:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:24:17 INFO - 'XPC_FLAGS': '0x0', 09:24:17 INFO - 'XPC_SERVICE_NAME': '0', 09:24:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:24:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:24:17 INFO - Downloading/unpacking jsonschema==2.5.1 09:24:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:24:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:24:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:24:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:24:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:24:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:24:20 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:24:20 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:24:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:24:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:24:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:24:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:24:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:24:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:24:20 INFO - Downloading functools32-3.2.3-2.tar.gz 09:24:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:24:20 INFO - warning: no files found matching '*.txt' 09:24:20 INFO - no previously-included directories found matching 'build' 09:24:20 INFO - no previously-included directories found matching 'dist' 09:24:20 INFO - no previously-included directories found matching '.git*' 09:24:20 INFO - Installing collected packages: jsonschema, functools32 09:24:20 INFO - Running setup.py install for functools32 09:24:20 INFO - warning: no files found matching '*.txt' 09:24:20 INFO - no previously-included directories found matching 'build' 09:24:20 INFO - no previously-included directories found matching 'dist' 09:24:20 INFO - no previously-included directories found matching '.git*' 09:24:20 INFO - Successfully installed jsonschema functools32 09:24:20 INFO - Cleaning up... 09:24:20 INFO - Return code: 0 09:24:20 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:24:20 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')]} 09:24:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:24:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:20 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')]} 09:24:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:24:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:20 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 0x10d4bba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d550618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c1847c970>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d41fd30>, '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 0x10d184db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d417b20>, '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.yIAoJJJUHI/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.EFEr2Lv5uh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/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 09:24:20 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 09:24:20 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 09:24:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yIAoJJJUHI/Render', 09:24:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:24:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:24:20 INFO - 'HOME': '/Users/cltbld', 09:24:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:24:20 INFO - 'LOGNAME': 'cltbld', 09:24:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:24:20 INFO - 'MOZ_NO_REMOTE': '1', 09:24:20 INFO - 'NO_EM_RESTART': '1', 09:24:20 INFO - 'PAGER': '/bin/cat', 09:24:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:24:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:24:20 INFO - 'PWD': '/builds/slave/test', 09:24:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:24:20 INFO - 'SHELL': '/bin/bash', 09:24:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EFEr2Lv5uh/Listeners', 09:24:20 INFO - 'TMPDIR': '/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/', 09:24:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:24:20 INFO - 'USER': 'cltbld', 09:24:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:24:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:24:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:24:20 INFO - 'XPC_FLAGS': '0x0', 09:24:20 INFO - 'XPC_SERVICE_NAME': '0', 09:24:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:24:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:24:21 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:24:21 INFO - Cleaning up... 09:24:21 INFO - Return code: 0 09:24:21 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:24:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:24:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:24:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:24:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:24:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d4bba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d550618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c1847c970>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d41fd30>, '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 0x10d184db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d417b20>, '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.yIAoJJJUHI/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.EFEr2Lv5uh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/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 09:24:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:24:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:24:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yIAoJJJUHI/Render', 09:24:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:24:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:24:21 INFO - 'HOME': '/Users/cltbld', 09:24:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:24:21 INFO - 'LOGNAME': 'cltbld', 09:24:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:24:21 INFO - 'MOZ_NO_REMOTE': '1', 09:24:21 INFO - 'NO_EM_RESTART': '1', 09:24:21 INFO - 'PAGER': '/bin/cat', 09:24:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:24:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:24:21 INFO - 'PWD': '/builds/slave/test', 09:24:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:24:21 INFO - 'SHELL': '/bin/bash', 09:24:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EFEr2Lv5uh/Listeners', 09:24:21 INFO - 'TMPDIR': '/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/', 09:24:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:24:21 INFO - 'USER': 'cltbld', 09:24:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:24:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:24:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:24:21 INFO - 'XPC_FLAGS': '0x0', 09:24:21 INFO - 'XPC_SERVICE_NAME': '0', 09:24:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:24:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:24:21 INFO - Downloading/unpacking blobuploader==1.2.4 09:24:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:24:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:24:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:24:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:24:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:24:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:24:23 INFO - Downloading blobuploader-1.2.4.tar.gz 09:24:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:24:23 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:24: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 09:24: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 09:24: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 09:24: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 09:24: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 09:24: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 09:24:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:24:24 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:24:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:24:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:24:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:24:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:24:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:24:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:24:25 INFO - Downloading docopt-0.6.1.tar.gz 09:24:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:24:25 INFO - Installing collected packages: blobuploader, requests, docopt 09:24:25 INFO - Running setup.py install for blobuploader 09:24:25 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:24:25 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:24:25 INFO - Running setup.py install for requests 09:24:25 INFO - Running setup.py install for docopt 09:24:25 INFO - Successfully installed blobuploader requests docopt 09:24:25 INFO - Cleaning up... 09:24:25 INFO - Return code: 0 09:24:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:24:25 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')]} 09:24:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:24:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:25 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')]} 09:24:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:24:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:26 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 0x10d4bba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d550618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c1847c970>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d41fd30>, '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 0x10d184db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d417b20>, '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.yIAoJJJUHI/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.EFEr2Lv5uh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/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 09:24:26 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 09:24:26 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 09:24:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yIAoJJJUHI/Render', 09:24:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:24:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:24:26 INFO - 'HOME': '/Users/cltbld', 09:24:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:24:26 INFO - 'LOGNAME': 'cltbld', 09:24:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:24:26 INFO - 'MOZ_NO_REMOTE': '1', 09:24:26 INFO - 'NO_EM_RESTART': '1', 09:24:26 INFO - 'PAGER': '/bin/cat', 09:24:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:24:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:24:26 INFO - 'PWD': '/builds/slave/test', 09:24:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:24:26 INFO - 'SHELL': '/bin/bash', 09:24:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EFEr2Lv5uh/Listeners', 09:24:26 INFO - 'TMPDIR': '/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/', 09:24:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:24:26 INFO - 'USER': 'cltbld', 09:24:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:24:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:24:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:24:26 INFO - 'XPC_FLAGS': '0x0', 09:24:26 INFO - 'XPC_SERVICE_NAME': '0', 09:24:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:24:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:24:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:24:26 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-y_UIJJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:24:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:24:26 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-7qZ7zi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:24:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:24:26 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-ts1oED-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:24:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:24:26 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-fUgFHY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:24:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:24:26 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-X3ese3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:24:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:24:26 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-lwIKC2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:24:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:24:26 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-oIPQFu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:24:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:24:26 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-STKLAK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:24:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:24:27 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-Xx1sFH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:24:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:24:27 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-xiLZFl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:24:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:24:27 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-tIIXYK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:24:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:24:27 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-YISb1e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:24:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:24:27 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-H2sRaC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:24:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:24:27 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-ZUs5H4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:24:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:24:27 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-zShfM4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:24:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:24:27 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-8GPnsU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:24:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:24:27 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-bd0E01-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:24:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:24:28 INFO - Running setup.py install for manifestparser 09:24:28 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:24:28 INFO - Running setup.py install for mozcrash 09:24:28 INFO - Running setup.py install for mozdebug 09:24:28 INFO - Running setup.py install for mozdevice 09:24:28 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:24:28 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:24:28 INFO - Running setup.py install for mozfile 09:24:28 INFO - Running setup.py install for mozhttpd 09:24:28 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:24:28 INFO - Running setup.py install for mozinfo 09:24:29 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:24:29 INFO - Running setup.py install for mozInstall 09:24:29 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:24:29 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:24:29 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:24:29 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:24:29 INFO - Running setup.py install for mozleak 09:24:29 INFO - Running setup.py install for mozlog 09:24:29 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:24:29 INFO - Running setup.py install for moznetwork 09:24:29 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:24:29 INFO - Running setup.py install for mozprocess 09:24:29 INFO - Running setup.py install for mozprofile 09:24:29 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:24:29 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:24:29 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:24:30 INFO - Running setup.py install for mozrunner 09:24:30 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:24:30 INFO - Running setup.py install for mozscreenshot 09:24:30 INFO - Running setup.py install for moztest 09:24:30 INFO - Running setup.py install for mozversion 09:24:30 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:24:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:24:30 INFO - Cleaning up... 09:24:30 INFO - Return code: 0 09:24:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:24:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:24:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:24:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:24:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:24:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:30 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 0x10d4bba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d550618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c1847c970>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d41fd30>, '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 0x10d184db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d417b20>, '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.yIAoJJJUHI/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.EFEr2Lv5uh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/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 09:24:30 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 09:24:30 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 09:24:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yIAoJJJUHI/Render', 09:24:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:24:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:24:30 INFO - 'HOME': '/Users/cltbld', 09:24:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:24:30 INFO - 'LOGNAME': 'cltbld', 09:24:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:24:30 INFO - 'MOZ_NO_REMOTE': '1', 09:24:30 INFO - 'NO_EM_RESTART': '1', 09:24:30 INFO - 'PAGER': '/bin/cat', 09:24:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:24:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:24:30 INFO - 'PWD': '/builds/slave/test', 09:24:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:24:30 INFO - 'SHELL': '/bin/bash', 09:24:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EFEr2Lv5uh/Listeners', 09:24:30 INFO - 'TMPDIR': '/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/', 09:24:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:24:30 INFO - 'USER': 'cltbld', 09:24:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:24:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:24:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:24:30 INFO - 'XPC_FLAGS': '0x0', 09:24:30 INFO - 'XPC_SERVICE_NAME': '0', 09:24:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:24:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:24:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:24:30 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-qiKlIc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:24:31 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)) 09:24:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:24:31 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-7NoH0I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:24:31 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)) 09:24:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:24:31 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-H2iOG2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:24:31 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)) 09:24:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:24:31 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-g3bQpi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:24:31 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)) 09:24:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:24:31 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-SL3KOe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:24:31 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)) 09:24:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:24:31 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-Ko_zhK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:24:31 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)) 09:24:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:24:31 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-E5AJ6c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:24:31 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)) 09:24:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:24:31 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-09R0Fa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:24:31 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)) 09:24:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:24:31 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-FvMQOU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:24:31 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)) 09:24:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:24:31 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-nBfVEv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:24:31 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)) 09:24:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:24:31 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-P7386x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:24:32 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)) 09:24:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:24:32 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-kdAcEL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:24:32 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)) 09:24:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:24:32 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-wdhOnf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:24:32 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)) 09:24:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:24:32 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-mPW5t5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:24:32 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)) 09:24:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:24:32 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-1YaQAe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:24:32 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)) 09:24:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:24:32 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-e4NTVI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:24:32 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)) 09:24:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:24:32 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-SzYynw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:24:32 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)) 09:24:32 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)) 09:24:32 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)) 09:24:32 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)) 09:24:32 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)) 09:24:32 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)) 09:24:32 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:24:32 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 09:24:32 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 09:24:32 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 09:24:32 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 09:24:32 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 09:24:32 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 09:24:35 INFO - Downloading blessings-1.6.tar.gz 09:24:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:24:35 INFO - Installing collected packages: blessings 09:24:35 INFO - Running setup.py install for blessings 09:24:35 INFO - Successfully installed blessings 09:24:35 INFO - Cleaning up... 09:24:35 INFO - Return code: 0 09:24:35 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:24:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:24:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:24:35 INFO - Reading from file tmpfile_stdout 09:24:35 INFO - Current package versions: 09:24:35 INFO - blessings == 1.6 09:24:35 INFO - blobuploader == 1.2.4 09:24:35 INFO - docopt == 0.6.1 09:24:35 INFO - functools32 == 3.2.3-2 09:24:35 INFO - jsonschema == 2.5.1 09:24:35 INFO - manifestparser == 1.1 09:24:35 INFO - mozInstall == 1.12 09:24:35 INFO - mozcrash == 0.17 09:24:35 INFO - mozdebug == 0.1 09:24:35 INFO - mozdevice == 0.48 09:24:35 INFO - mozfile == 1.2 09:24:35 INFO - mozhttpd == 0.7 09:24:35 INFO - mozinfo == 0.9 09:24:35 INFO - mozleak == 0.1 09:24:35 INFO - mozlog == 3.3 09:24:35 INFO - moznetwork == 0.27 09:24:35 INFO - mozprocess == 0.23 09:24:35 INFO - mozprofile == 0.28 09:24:35 INFO - mozrunner == 6.12 09:24:35 INFO - mozscreenshot == 0.1 09:24:35 INFO - mozsystemmonitor == 0.3 09:24:35 INFO - moztest == 0.7 09:24:35 INFO - mozversion == 1.4 09:24:35 INFO - psutil == 3.1.1 09:24:35 INFO - requests == 1.2.3 09:24:35 INFO - wsgiref == 0.1.2 09:24:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:24:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:24:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:24:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:24:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:24:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:35 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 0x10d4bba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d550618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c1847c970>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d41fd30>, '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 0x10d184db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d417b20>, '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.yIAoJJJUHI/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.EFEr2Lv5uh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/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 09:24:35 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 09:24:35 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 09:24:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yIAoJJJUHI/Render', 09:24:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:24:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:24:35 INFO - 'HOME': '/Users/cltbld', 09:24:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:24:35 INFO - 'LOGNAME': 'cltbld', 09:24:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:24:35 INFO - 'MOZ_NO_REMOTE': '1', 09:24:35 INFO - 'NO_EM_RESTART': '1', 09:24:35 INFO - 'PAGER': '/bin/cat', 09:24:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:24:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:24:35 INFO - 'PWD': '/builds/slave/test', 09:24:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:24:35 INFO - 'SHELL': '/bin/bash', 09:24:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EFEr2Lv5uh/Listeners', 09:24:35 INFO - 'TMPDIR': '/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/', 09:24:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:24:35 INFO - 'USER': 'cltbld', 09:24:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:24:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:24:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:24:35 INFO - 'XPC_FLAGS': '0x0', 09:24:35 INFO - 'XPC_SERVICE_NAME': '0', 09:24:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:24:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:24:36 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)) 09:24:36 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)) 09:24:36 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)) 09:24:36 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)) 09:24:36 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)) 09:24:36 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)) 09:24:36 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)) 09:24:36 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)) 09:24:36 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)) 09:24:36 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)) 09:24:36 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)) 09:24:36 INFO - Cleaning up... 09:24:36 INFO - Return code: 0 09:24:36 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:24:36 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')]} 09:24:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:24:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:36 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')]} 09:24:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:24:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:36 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 0x10d4bba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d550618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c1847c970>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d41fd30>, '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 0x10d184db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d417b20>, '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.yIAoJJJUHI/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.EFEr2Lv5uh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/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 09:24:36 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 09:24:36 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 09:24:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yIAoJJJUHI/Render', 09:24:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:24:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:24:36 INFO - 'HOME': '/Users/cltbld', 09:24:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:24:36 INFO - 'LOGNAME': 'cltbld', 09:24:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:24:36 INFO - 'MOZ_NO_REMOTE': '1', 09:24:36 INFO - 'NO_EM_RESTART': '1', 09:24:36 INFO - 'PAGER': '/bin/cat', 09:24:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:24:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:24:36 INFO - 'PWD': '/builds/slave/test', 09:24:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:24:36 INFO - 'SHELL': '/bin/bash', 09:24:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EFEr2Lv5uh/Listeners', 09:24:36 INFO - 'TMPDIR': '/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/', 09:24:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:24:36 INFO - 'USER': 'cltbld', 09:24:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:24:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:24:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:24:36 INFO - 'XPC_FLAGS': '0x0', 09:24:36 INFO - 'XPC_SERVICE_NAME': '0', 09:24:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:24:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:24:36 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:24:36 INFO - Cleaning up... 09:24:36 INFO - Return code: 0 09:24:36 INFO - Running post-action listener: _resource_record_post_action 09:24:36 INFO - Running post-action listener: _start_resource_monitoring 09:24:36 INFO - Starting resource monitoring. 09:24:36 INFO - [mozharness: 2016-08-15 16:24:36.411447Z] Finished create-virtualenv step (success) 09:24:36 INFO - [mozharness: 2016-08-15 16:24:36.412402Z] Running install step. 09:24:36 INFO - Running pre-action listener: _resource_record_pre_action 09:24:36 INFO - Running main action method: install 09:24:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:24:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:24:36 INFO - Reading from file tmpfile_stdout 09:24:36 INFO - Detecting whether we're running mozinstall >=1.0... 09:24:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:24:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:24:36 INFO - Reading from file tmpfile_stdout 09:24:36 INFO - Output received: 09:24:36 INFO - Usage: mozinstall [options] installer 09:24:36 INFO - Options: 09:24:36 INFO - -h, --help show this help message and exit 09:24:36 INFO - -d DEST, --destination=DEST 09:24:36 INFO - Directory to install application into. [default: 09:24:36 INFO - "/builds/slave/test"] 09:24:36 INFO - --app=APP Application being installed. [default: firefox] 09:24:36 INFO - mkdir: /builds/slave/test/build/application 09:24:36 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'] 09:24:36 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 09:25:10 INFO - Reading from file tmpfile_stdout 09:25:10 INFO - Output received: 09:25:10 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 09:25:10 INFO - Running post-action listener: _resource_record_post_action 09:25:10 INFO - [mozharness: 2016-08-15 16:25:10.957777Z] Finished install step (success) 09:25:10 INFO - [mozharness: 2016-08-15 16:25:10.957914Z] Running run-tests step. 09:25:10 INFO - Running pre-action listener: _resource_record_pre_action 09:25:10 INFO - Running main action method: run_tests 09:25:10 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:25:10 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:25:10 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:25:10 INFO - 2016-08-15 09:25:10.972 screenresolution[1643:8408] starting screenresolution argv=screenresolution get 09:25:10 INFO - 2016-08-15 09:25:10.974 screenresolution[1643:8408] Display 0: 1600x1200x32@60 09:25:10 INFO - 2016-08-15 09:25:10.981 screenresolution[1644:8410] starting screenresolution argv=screenresolution list 09:25:10 INFO - Available Modes on Display 0 09:25:10 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:25:10 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:25:10 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:25:10 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:25:11 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:25:11 INFO - Intel Iris: 09:25:11 INFO - Chipset Model: Intel Iris 09:25:11 INFO - Type: GPU 09:25:11 INFO - Bus: Built-In 09:25:11 INFO - VRAM (Dynamic, Max): 1536 MB 09:25:11 INFO - Vendor: Intel (0x8086) 09:25:11 INFO - Device ID: 0x0a2e 09:25:11 INFO - Revision ID: 0x0009 09:25:11 INFO - Displays: 09:25:11 INFO - Display: 09:25:11 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:25:11 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:25:11 INFO - Display Serial Number: 1600x1200 60 09:25:11 INFO - Main Display: Yes 09:25:11 INFO - Mirror: Off 09:25:11 INFO - Online: Yes 09:25:11 INFO - Rotation: Supported 09:25:11 INFO - Return code: 0 09:25:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:25:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:25:11 INFO - Python 2.7.3 09:25:11 INFO - Return code: 0 09:25:11 INFO - grabbing minidump binary from tooltool 09:25: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')]} 09:25:11 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 0x10d41fd30>, '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 0x10d184db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d417b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:25:11 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 09:25:11 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 09:25:11 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 09:25:11 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:25:11 INFO - Return code: 0 09:25:11 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:25:11 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:25:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:25:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:25:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:25:11 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/NUY8soEiTqOBnh0MmJ_ZgQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0281', '--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 09:25:11 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/NUY8soEiTqOBnh0MmJ_ZgQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0281 --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 09:25:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yIAoJJJUHI/Render', 09:25:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:25:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:25:11 INFO - 'HOME': '/Users/cltbld', 09:25:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:25:11 INFO - 'LOGNAME': 'cltbld', 09:25:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:25:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:25:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:25:11 INFO - 'MOZ_NO_REMOTE': '1', 09:25:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:25:11 INFO - 'NO_EM_RESTART': '1', 09:25:11 INFO - 'PAGER': '/bin/cat', 09:25:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:25:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:25:11 INFO - 'PWD': '/builds/slave/test', 09:25:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:25:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:25:11 INFO - 'SHELL': '/bin/bash', 09:25:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EFEr2Lv5uh/Listeners', 09:25:11 INFO - 'TMPDIR': '/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/', 09:25:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:25:11 INFO - 'USER': 'cltbld', 09:25:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:25:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:25:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:25:11 INFO - 'XPC_FLAGS': '0x0', 09:25:11 INFO - 'XPC_SERVICE_NAME': '0', 09:25:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:25:11 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/NUY8soEiTqOBnh0MmJ_ZgQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0281', '--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 09:25:11 INFO - mozversion application_buildid: 20160815065716 09:25:11 INFO - mozversion application_changeset: af8f5fa2d6ca5957791e68583679522ee0f08902 09:25:11 INFO - mozversion application_display_name: Nightly 09:25:11 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:25:11 INFO - mozversion application_name: Firefox 09:25:11 INFO - mozversion application_remotingname: firefox 09:25:11 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 09:25:11 INFO - mozversion application_vendor: Mozilla 09:25:11 INFO - mozversion application_version: 51.0a1 09:25:11 INFO - mozversion platform_buildid: 20160815065716 09:25:11 INFO - mozversion platform_changeset: af8f5fa2d6ca5957791e68583679522ee0f08902 09:25:11 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 09:25:11 INFO - mozversion platform_version: 51.0a1 09:25:11 INFO - using testdate: 1471278311 09:25:11 INFO - actual date: 1471278311 09:25:11 INFO - starting webserver on 'localhost:49274' 09:25:11 INFO - SUITE-START | Running 2 tests 09:25:11 INFO - TEST-START | dromaeo_css 09:25:11 INFO - operating with platform_type : mac_ 09:25:11 INFO - Initialising browser for dromaeo_css test... 09:25:11 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/tmpeNAKBc/profile http://localhost:49274/getInfo.html) 09:25:14 INFO - PROCESS | 1654 | __metrics Screen width/height:1600/1200 09:25:14 INFO - PROCESS | 1654 | colorDepth:24 09:25:14 INFO - PROCESS | 1654 | Browser inner width/height: 1024/689 09:25:14 INFO - PROCESS | 1654 | __metrics 09:25:14 ERROR - PROCESS | 1654 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2983: TypeError: this.tabs is undefined 09:25:15 INFO - TEST-INFO | 1654: exit 0 09:25:15 INFO - Browser initialized. 09:25:15 INFO - Running cycle 1/1 for dromaeo_css test... 09:25:15 INFO - TEST-INFO | started process 1658 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/tmpeNAKBc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:25:27 INFO - PROCESS | 1658 | RSS: Main: 239513600 09:25:27 INFO - PROCESS | 1658 | 09:26:16 INFO - PROCESS | 1658 | 1471278376746 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] 09:28:28 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49274/tests/dromaeo/cssquery-ext.html) 09:28:29 INFO - PROCESS | 1658 | RSS: Main: 255954944 09:28:29 INFO - PROCESS | 1658 | 09:31:32 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-ext.html (next: http://localhost:49274/tests/dromaeo/cssquery-jquery.html) 09:31:33 INFO - PROCESS | 1658 | RSS: Main: 266989568 09:31:33 INFO - PROCESS | 1658 | 09:34:34 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49274/tests/dromaeo/cssquery-mootools.html) 09:34:35 INFO - PROCESS | 1658 | RSS: Main: 272769024 09:34:35 INFO - PROCESS | 1658 | 09:37:37 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49274/tests/dromaeo/cssquery-prototype.html) 09:37:38 INFO - PROCESS | 1658 | RSS: Main: 272101376 09:37:38 INFO - PROCESS | 1658 | 09:40:40 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49274/tests/dromaeo/cssquery-yui.html) 09:40:41 INFO - PROCESS | 1658 | RSS: Main: 277557248 09:40:41 INFO - PROCESS | 1658 | 09:43:44 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-yui.html (next: http://localhost:49274/tests/dromaeo/cssquery-dojo.html) 09:43:44 INFO - PROCESS | 1658 | RSS: Main: 281260032 09:43:44 INFO - PROCESS | 1658 | 09:43:44 INFO - PROCESS | 1658 | __start_tp_report 09:43:44 INFO - PROCESS | 1658 | _x_x_mozilla_page_load 09:43:44 INFO - PROCESS | 1658 | _x_x_mozilla_page_load_details 09:43:44 INFO - PROCESS | 1658 | |i|pagename|runs| 09:43:44 INFO - PROCESS | 1658 | |0;dojo.html;3061.4183305172014;3439.6732310430502;3448.8792892248775;3451.965480345197;3461.238527523944;5739.426057394264;5772.509336706385;5833.241678581784;5839.79560715375;5841.269841269841;5767;5774.3936886626925;5776.277965254343;5787.305523337205;5810.709464526767;5221.164613661815;5288.418273989858;5330.093884039703;5330.893382132355;5375.731213439332;5155.5360017598405;5209.921851172236;5277.8944421111555;5336.59975501837;5359.5712343012465;5263.815766448156;5278.313819203518;5281.709505977151;5292.073887069786;5295.602829787762;5267.499587539216;5282.128448805943;5311.415744268127;5318.30861987943;5352.437994010612;5083.415407228179;5169.25045868347;5170.302009228743;5259.974305010524;5285.973570132163;5456.48163424478;5585.301837270341;5726.226959360475;5728.97135514324;5802.071668533056;5697.77208911643;5880.206172166788;6231.719572619243;6272.686365681698;6282.78010269643;6038.758449662052;6133.059244993061;6184.165137706442;6218.31598524162;6224.377562243784;5474.972625136849;5499.477549632778;5516.255305533742;5541.556675465953;5546.639468434539;6244.812655620339;6293.181886354744;6295.622262664255;6302.653354065479;6310.684465776784;5939.554533410012;6105.755769769248;6154.846128846814;6216.906746398808;6246.156768836149;4615.769211539477;6158.414950579688;6295.748170073146;6298;6303.054541818672;6225.097360882647;6266.091416744638;6269.7178626961895;6280.780172693934;6286.214223222098;6125.326214116443;6135.04893764628;6217.502599792006;6224.346443623445;6302.684865756785;5023.472535383732;5040.092783298968;5041.495850414929;5043.84868453947;5052.873678158076;4540.477845047796;4552.203364411214;4553.908921821545;4554;4557.225271703818;5550.389457159709;5801.9419805802245;5834.066549352168;5873.588848780544;5879.853003674857;6189.907151392733;6209.316975132731;6226.501879849601;6231.781887633911;6239.656818874914;5859.5019423349495;5866.882662346729;5884.764609415575;5894.616849904828;5923.08192230205;5347.759350829222;5452.182172674051;5466.070767969455;5493.093639549509;5501.174823776386;6359.332270111664;6375.458086062737;6384.7126879290545;6395.392437718409;6410.935890641033;6222.62664240147;6237.4698150657705;6240.375962403723;6258.593191442542;6274.027525733336;6127.724252408741;6155.322914479493;6172.845678858064;6178.443940045418;6333.113364129118;6133.290727167522;6139.833431647972;6151;6151.630902145886;6166.105914642441;6201.10084037821;6228.972219583718;6230.937690623035;6240.875182496234;6260.123582698517;5908.793192238423;5993.790217342372;6004.579679422399;6045.727942242522;6117.816465506042;6108.4807791338235;6111.834843226386;6122.245686735438;6133.877322453615;6142.570020098729;5054.963732434916;5873.765049397976;5997.370276120944;6034.818955431344;6074.665893375906;6154.138420621206;6198.287196972406;6227.595206311576;6233.345498722569;6274;5826.359100499027;5999.970000149971;6018.699065046818;6041.848953776191;6065.54508411862 09:43:44 INFO - PROCESS | 1658 | |1;ext.html;466.8039423442154;472.72109455421315;513.5044681881983;531.7447625139935;549.4615277028512;37663.24673506532;40393.99015024626;40462.583809566706;40491.59508404915;40566.39150412746;40919.181616367656;41212.79393603035;41456.756297311054;41512.377314340236;41537;9639.855402168972;9796.804063918717;9809.950950245238;9824.508774561244;9831.459269740162;8098.554579498125;8370.665173393087;9663.710088697351;9734.805303893918;9771.071748183911;9786.5596048178;9808.50957452128;9830.852537211947;9867.851982220272;9869.358491698016;9711.028897110304;9747.610095596168;9764.609415623367;9789.510524473748;9811;9631.3258071935;9662.275329350257;9680.080392362785;9712.70861874145;9722.513874306256;39149;39326.60673393258;39398.60601393978;39489.802550987064;39586.60413395858;2583.1992082454312;3162.794418362799;3386.745994050456;3625.782453052825;4117.21772863155;28797.85601072002;31794.205144871332;32446.351072978407;33266.50100248498;35571;3288.2108294009504;3317.7511686623357;3318.9170270743184;3441.2601290722614;3476.66971637694;465674;471655;472360;473862;474530;65605.01592476117;66738.66630666913;66809.33190668128;66835;66841.66579167171;35381.46927796085;36651.633483664824;36760.448593271125;51543;51859;16893.32426702918;17044.573885652957;17060.914695426443;17119.48641540756;17125.314987400365;13012.544560940321;13139.67150821218;13143.671408214872;13159.473621055242;13177.604671859859;16692.330766923453;20879.686804697943;20899.74601523883;20907.68638470424;21031.474213144793;7481.663325150382;8876.872254401735;8934.642614295486;8950.328725345626;8951.507667078244;868.8957325120899;1012.9949350253202;1075.6181555547823;1123.5058170860675;1146.9455474896201;29482.557761633594;30094.398112037637;30099.548506772415;30780.69219307823;30843.074707758802;964.5129209749172;1029.3978022856563;1109.4397329348628;1122.2761318949233;1123.4214379594516;14044.297785110704;14280.714735673839;15703.68592628141;16077.919610401874;16561.917190414213;685606;699014;699458;700111.4994424995;701294;59306.70346648325;59874.101888471705;59957.40042599606;60005.69997149986;60040.399596004354;1391.930403479822;1392.3177642955081;1434.0821874000649;1444.8049513315777;1445.6169115184696;29244.853775730986;31108.222294441915;32021.039368818972;32173.67826321707;32464.67535324711;53341.46658533365;53669.463305366444;53967;54211;54247;629740;631399.8430007821;633511;634763;638221;42446.363304549835;43301.783491082344;43465.13069738524;43583.78208108939;43801.12397752091;47513;48713;48751.5124848747;49016.5098349012;49784;31748;39494.01264968284;39783.403248951865;40517.98705032398;40916.59083409128;39543.604563953995;39917;40294;40738.59261407348;40796.79601601973;37245.25509489741;37277.62722372742;37676;39569;39582.80208598939;32802;34297.657023430445;34630.653693462744;35353.82323088368;35705;24067.759322406553;24831;25822.225333240032;26109.608355875058;26359 09:43:44 INFO - PROCESS | 1658 | |2;jquery.html;357.8783213707339;370.5072253902309;373.1157157536638;378.8522476234268;401.64855751217664;15575.844241557581;20531.692024619642;20986.05562749678;21298.787012129895;21565.1373945042;19954.800451995477;20281.18875244992;20772.792272077273;20986.580268394624;20987.580248395025;5340.279062326575;5947.286325640929;6021.09683547467;6135.846603834895;6188.938110618904;5134.820281290155;6043.637381757087;6091.2690477142805;6098.512119030467;6111.633302001872;5913.231279933602;5943.138244954479;5950.04799232123;5969.940300597003;6037.607555508878;5903.409659034084;5945.851353716192;6014.218151640281;6055.6063855849225;6059.091136329564;4500.122476117159;5051.267566202917;5240.213967904845;5245.580353571705;5251.133562962106;20948.266810661553;25347.366315842068;25484.87257563719;25758.742412575823;25764.48471030569;2190.123950419829;2424.8181386395913;2471.4192164841247;2912.941741165165;3135.9216019599467;11884.524619015228;12579.874201258053;14914.105153690705;15339.846601534065;16020.35918563256;1770.7343898415213;1818.4090170694444;1835.8990255535941;1947.260041184355;1972.0829814136496;108341.37487937688;121306.78693213043;122459;123096;123296.38351808273;9541.614596350912;9652.75868103303;10754.34352320215;10758.462076896123;11021.338719676845;13446.798298025538;13461.394237259346;13478.595642130556;13489.527866524624;13529.32353382327;6956.930430695729;8099.149589293157;8293.33653307734;8324.084350721416;8521.616527256288;7284.688756023967;7989.2809647132035;8330.208630180123;8438.451500652438;8523.147685231428;6523.3150519194805;6524.869502610016;6526.608403495806;6529.085927970088;6536.509761767887;1788.6869797785334;1817.354839032151;1827.5796566789713;1834.4771740054287;1847.131848031423;863.4301361101643;869.4174902815129;892.6340200517886;947.5262368815593;1009.0262896305101;21183.395879451702;21958.780412195993;22213.44505884605;22279.888600557217;22394.440138996655;845.8074115497119;912.4844462878585;982.3614650477247;1002.4636819301638;1037.5486663301488;10043.497825108861;11421.600243991586;11528.308301501937;11615.76768464626;11634.76730465386;606459;611455;616365;618666;621768;112706;119661;123728;126428.36785816013;128684;937.7046230437527;980.3431700760508;1008.5612758450097;1011.7672935224939;1011.9038691324313;18499.075046247905;18510.07449627486;18539.35112271064;18806.623867522845;18982.43052708421;56629.58426039382;57037.71481142568;57117;57305;58671;83982.58008709918;85403.14596853952;85943.57028214818;86838;87262;8010.879836802336;8032;8108.878366824384;8191.836163276582;8256.050554186106;11616.94191529037;12842.35788210567;12933.353332333158;13339.599812005656;13397.263150526425;11172.776544469227;11208.159388046091;11428.714282143013;11485;11549.769004620028;8696.913030869864;10286.331388459726;10792.514336855018;11222.607208747655;11254.606088786853;11382.601608943647;11476.540938362707;11503.942480287546;11734.88265117372;11775.175737698279;7771.378289736695;7807.492512986638;7965.56189409588;8028.799280018046;8135.267825895698;8270.917290827256;10848.891511084788;11023.944880275547;11108.50011749457;11288.604898828502 09:43:44 INFO - PROCESS | 1658 | |3;mootools.html;1506.4576752369146;1538.8153421589411;1734.8178441263674;1768.8856020706953;1880.0693656639965;7916.6833326666865;8458.619362128704;8577.614007369668;8954.820903581924;8963.46219226847;8635.69775057873;8819.779505512366;8830.91169088309;8836.0722124177;8842.425242359259;2325.662778897059;2377.0610608809598;2378.8453750506246;2382.5115851250453;2385.642153676945;2334.8832558372096;2353.8116950643907;2377.393764590036;2381.0832829360647;2393.018862266471;2362.83460157789;2364.196173301077;2370.679958205646;2381.345130089222;2387.438951846315;2002.3392280547457;2291.9656205156934;2329.2895666821614;2341.3678306857137;2367.3963139399516;1946.581484980736;2341.2976107167783;2341.4263505441104;2353.8940747666397;2359.315798418457;8785.560721963877;8868.37921345506;8886.600102995317;8893.28853691703;8905.688300909502;5234.633575649668;5371.81198658049;5382.650127741724;5387.24578559002;5396.514313711746;3531.399662057456;3589.8025608591515;3643.8360273787744;3670.1742108025746;3721.106934335767;1078.3583767658308;1101.4602844606086;1118.8209886418215;1119.5186069989902;1138.9316641001483;11363.602273920456;11408.030317422947;11442.48508817097;11493.942530287379;11579.957803797615;4526.207913615104;4608.723476591348;4806.206975848946;4806.2310030395665;4807.6394270429855;9790.804183916282;9881.407115573089;9898.257630677728;9910.603575857029;9918.25613079022;5352.357717073898;5368.355797304349;5371.033214021513;5374.811881584204;5381.246625472437;4418.7127836690515;4751.358566593535;4892.486288939681;4923.384576927884;4949.752512374367;3796.240751849641;3870.0905287257474;3930.0567863712504;3936.1143742658246;3947.0527073502153;1280.8398950131234;1282.923024618526;1287.11832394808;1293.1465232946211;1297.1762930538987;757.394084732212;825.2902503846688;857.5412154497315;915.9084091590788;942.8774259346241;4960.454350021495;5570.025245582007;5761.991651460978;5847.94152058474;6045.969770151121;410.3291119020423;414.33292399237206;426.3817464676232;427.95078565965315;429.49963292764204;3232.6767323267954;3639.0356555512813;3976.045749020272;4066.1257829566784;4097.651699605567;9281.72154835356;10189.23580731448;10598.099161571352;10695.930406959242;10806.02745752886;10620.681379558626;10838.67483975482;10843.891561084445;10851.240413171003;10885;7912.762617121495;8260.8347833043;8265.710700125466;8273.793155171048;8302.294304984023;4935.580475659609;5958.076498142795;6067.575269731076;6078.7264573093435;6140.631562106288;9965.900340996497;10017.248706347198;10022.24833137503;10081.344712593658;10083.546240419346;9986.35088719231;10203.081722644998;10284.845727314247;10295.794084118126;10386.42874641902;6878.828029299308;7510.173880872991;7649.349805266392;7951.3638908886;8061;8212.46618969765;8416.4950102994;8426.115257898078;8430.15698430152;8443.704470343508;6362.331955144643;7432;7454.068241469817;7511.624418779148;7580.583067931317;6063.878722425438;7322.926770732224;7413.2957369049855;7414.851702965802;7420.369268612229;6955.374016338554;6994.405475534637;7080.044194033945;7092.787216383516;7106.751263705745;4993.625478089085;5023.497650235094;5037.319961805109;5072.67027643202;5100.693958362362;3875.573686894383;4378.846740364072;5012.573931215888;5168.457311982188;5259.763310650953 09:43:44 INFO - PROCESS | 1658 | |4;prototype.html;299.8171115619472;307.3944329670549;313.49683757569113;316.21578485356315;317.0946946467834;4529.773511324433;4750.667453278272;5106.08090543702;5263.973680131594;5470.234167216588;4953.687272872691;5129.2562578426105;5600.695589602134;5612.579056570763;5631.549476041917;3707.8146092695256;4238.643634037109;4244.893877653052;4250.04374015847;4270.27405341092;3452.6719961603735;4112.650424713888;4241.257779888522;4249.617534421902;4270.508891477473;4106.342985122381;4118.279301122307;4178.6657067434535;4218.282891908368;4237.597428244312;3448.4310088835314;4176.331786914095;4208.085321178856;4212.473440819897;4265.274903266452;3197.9840100799347;3673.9081522961874;3680;3680.9815950920342;3705.314516814398;5155.587552995751;5259.710715910624;5410.321890664107;5426.104692725696;5441.129419292934;4761.8095276188915;4777.211760059586;4820.9517904821205;4840.668816075572;4858.46556878743;5483.643563168421;5685.602007859451;5773.364929857712;5784.508316793078;5800.114962637118;3672.7245456590863;3827.2777250237505;3836.462895194675;3872.961270387288;3881.941770873439;4931.753412329369;6061.605995610315;6070.6661133637635;6115.4190351916495;6132.754689812402;3516.5955915070094;4039.7980100994832;4046.473958385391;4057.16828050249;4057.5536690963972;3934.7639141651593;4043.838246470108;4057.1885622875543;4115.156392939441;4153.584641535883;4018.0377234115845;4692.694974826625;4705.12955103307;4803.519648035169;4828;4819.734914579662;5787.726700125965;5831.825045248649;5840.8539786504825;5857.179994800731;1195.9521619135312;1279.6289076167993;1300.752856957175;1327.7742783726596;1421.3248706864363;929.818685356349;939.3377668743656;955.3551352836807;961.5048250151178;965.4062751407974;4385.736855788663;4716.962268301037;5303.302943058262;5376.784928602812;5410.8917821643345;5869.354371019184;5882.264716910387;5891.528677705774;5906.114082887601;5930.703464826742;4162.4796900387455;4481.339407016666;4976.800927962913;5236.9526094781195;5373.2208829719475;2655.442357104991;3049.7648452376825;3097.3340731742783;3169.4136584731436;3169.8256595886987;5051.873703157377;6078.179445774852;6079.565045749137;6105.694715264308;6295.401936815995;5434.750007498218;5816.883662326814;6094.695265236721;6159.5072394208355;6190.845228869224;5331.173668081454;6130.78542251028;6196.411340922605;6238.968805156036;6253.874922501524;5755.510781583613;5908.261467316585;5991.621926956912;5999.670018149044;6038.396160383926;5511.751971161227;5859.707014649165;5993.340732519332;6034.732706131762;6035.219610214909;4957.454679985127;5125.103711626722;5972.462478376967;6118.60229085108;6301.369863013845;3873.8256778445602;3891.2606604745006;3945.3626744900544;3973.562908080051;3986.4418981343215;4982.925256121089;5385.461453854583;5650.26546548946;5897.410258974069;5934.703264836828;4770.928436073531;5547.5007249347755;5764.481196692318;5823.475887170175;5835.44563266489;5700.600957932905;5760.156749840178;5815.539753846455;5823.330317013429;5923.940760592339;4794.017226468496;5496.917546236889;5716.742746576498;5746.626469279484;5771.451712087345;5912.822615321547;5933.673647949404;5942.881142377042;5943.702814859326;5949.077892926603;4393.055493069006;4399.802008909671;5527.093152862256;5754.129907780072;5790.768369265183 09:43:44 INFO - PROCESS | 1658 | |5;yui.html;731.4989232375823;768.9577073260969;772.5248971882294;816;864.9005364383096;15320.080795152298;15700.842991570094;15862.682746345066;15893.125878076702;15934.203289835505;14092.436302547885;14194.645133871658;14202.14787112774;14214.786778198335;14244.857551424482;838.5555655502593;845.6110189312908;865.0786911938796;884.8495755721543;886.4371124336061;871.4553404122423;877.8156587116713;880.5993273060742;882.2500874256895;887.8002449448854;918.9127032931895;927.0266220468515;928.2388441477957;933.2673851026946;936.4147407870081;909.0500427053712;926.6617684545092;929.0987741890356;929.739672891588;932.137772560379;670.3932940688636;684.9863002739967;691.0118530501381;692.8995295682098;694.350782018814;13012.86987130126;14837.25813709321;15280.694386112216;15406.537803865902;15452.613684657861;14165.362558684781;14237.359318830677;14337.35481903317;14367.13797172173;14379.568612941628;10225.233107516966;11935;12027.398630068461;12081.637550873487;12268.079894007986;3859.556151042638;3889.591592882735;3906.785126818024;3927.7643341399607;3939.862104826317;89647.10352896452;114475;117209;120276;120420;11101.722456938642;11415.143864210217;11463.713407164887;11593.362365069834;11772.293662380112;17863.57091432682;21111.83884886346;21960.780392196193;21984.670229946565;22672.659910101363;8295.170482951777;8405.789855253668;8463.66145354179;8625.741227763177;8629.223369896614;4397.516273209944;4601.28680054592;4615.8846028848875;4651.37206477128;4748.6438517111355;3376.561047063915;3445.620981692012;3473.010192095291;3493.63316851732;3498.7900725956524;543.3208489388264;622.8287221014257;628.9716962736687;633.6768248193363;635.2091645900883;599.9040153575407;611.788932818177;625.2746813696091;626.7305058824658;632.165541485235;9129.771755706028;9313.580888860017;9391.389559678599;9414;9576.281778866613;608.7412849538928;612.8253447767365;627.8626426679247;630.124127462827;641.9743210271537;4358.063016451478;4556.794944227518;4557.772111394417;4577.382053422745;4580.725156490621;167679.30253600675;169097.3090269106;169427;174093;177053;105483;108164.05097719544;110495;130835;134278;112076.43961780138;112993;113893.86106138998;114487;115682;9407.43555386679;9547;9988.300818942604;9999.900000999896;10271.845922311022;59014.52463688271;60779.08831367621;61937.690311548155;64809.67595162183;65435.345646542926;89563.55218223867;96067;97141.51429242808;98296;100864.49567752115;12926.547570835352;13163.670908226988;13193.340332983504;13268.93365533166;13289.667758305734;11047.72380690457;13555.118917270345;13796.724065518834;14903.627409314853;15165.696686066438;13665.86334136646;13797.724045519235;13820.34938973698;13865.376058077612;13876.791848122488;13711.640648041293;13827.861721382658;13854.792178117537;13958;14407.783883241551;13563.93218033943;13720.313984300945;13722.245276509888;13727.382267797773;14385.496507622602;11265.610917986443;11316.83024754613;11484.598039068593;11494.425278735862;11937.880621193677;9935.850962235716;11316.04188314311;11696;11708.180427370344;11730.530778768754 09:43:44 INFO - PROCESS | 1658 | __end_tp_report 09:43:44 INFO - PROCESS | 1658 | __start_cc_report 09:43:44 INFO - PROCESS | 1658 | _x_x_mozilla_cycle_collect,412 09:43:44 INFO - PROCESS | 1658 | __end_cc_report 09:43:44 INFO - PROCESS | 1658 | __startTimestamp1471279424445__endTimestamp 09:43:44 INFO - PROCESS | 1658 | 09:43:44 INFO - PROCESS | 1658 | ------- Summary: start ------- 09:43:44 INFO - PROCESS | 1658 | Number of tests: 6 09:43:44 INFO - PROCESS | 1658 | 09:43:44 INFO - PROCESS | 1658 | [#0] dojo.html Cycles:165 Average:5752.97 Median:5939.55 stddev:625.61 (10.5%) stddev-sans-first:590.83 09:43:44 INFO - PROCESS | 1658 | Values: 3061.4 3439.7 3448.9 3452.0 3461.2 5739.4 5772.5 5833.2 5839.8 5841.3 5767.0 5774.4 5776.3 5787.3 5810.7 5221.2 5288.4 5330.1 5330.9 5375.7 5155.5 5209.9 5277.9 5336.6 5359.6 5263.8 5278.3 5281.7 5292.1 5295.6 5267.5 5282.1 5311.4 5318.3 5352.4 5083.4 5169.3 5170.3 5260.0 5286.0 5456.5 5585.3 5726.2 5729.0 5802.1 5697.8 5880.2 6231.7 6272.7 6282.8 6038.8 6133.1 6184.2 6218.3 6224.4 5475.0 5499.5 5516.3 5541.6 5546.6 6244.8 6293.2 6295.6 6302.7 6310.7 5939.6 6105.8 6154.8 6216.9 6246.2 4615.8 6158.4 6295.7 6298.0 6303.1 6225.1 6266.1 6269.7 6280.8 6286.2 6125.3 6135.0 6217.5 6224.3 6302.7 5023.5 5040.1 5041.5 5043.8 5052.9 4540.5 4552.2 4553.9 4554.0 4557.2 5550.4 5801.9 5834.1 5873.6 5879.9 6189.9 6209.3 6226.5 6231.8 6239.7 5859.5 5866.9 5884.8 5894.6 5923.1 5347.8 5452.2 5466.1 5493.1 5501.2 6359.3 6375.5 6384.7 6395.4 6410.9 6222.6 6237.5 6240.4 6258.6 6274.0 6127.7 6155.3 6172.8 6178.4 6333.1 6133.3 6139.8 6151.0 6151.6 6166.1 6201.1 6229.0 6230.9 6240.9 6260.1 5908.8 5993.8 6004.6 6045.7 6117.8 6108.5 6111.8 6122.2 6133.9 6142.6 5055.0 5873.8 5997.4 6034.8 6074.7 6154.1 6198.3 6227.6 6233.3 6274.0 5826.4 6000.0 6018.7 6041.8 6065.5 09:43:44 INFO - PROCESS | 1658 | 09:43:44 INFO - PROCESS | 1658 | [#1] ext.html Cycles:180 Average:73387.12 Median:40542.19 stddev:162798.95 (401.6%) stddev-sans-first:163163.58 09:43:44 INFO - PROCESS | 1658 | Values: 466.8 472.7 513.5 531.7 549.5 37663.2 40394.0 40462.6 40491.6 40566.4 40919.2 41212.8 41456.8 41512.4 41537.0 9639.9 9796.8 9810.0 9824.5 9831.5 8098.6 8370.7 9663.7 9734.8 9771.1 9786.6 9808.5 9830.9 9867.9 9869.4 9711.0 9747.6 9764.6 9789.5 9811.0 9631.3 9662.3 9680.1 9712.7 9722.5 39149.0 39326.6 39398.6 39489.8 39586.6 2583.2 3162.8 3386.7 3625.8 4117.2 28797.9 31794.2 32446.4 33266.5 35571.0 3288.2 3317.8 3318.9 3441.3 3476.7 465674.0 471655.0 472360.0 473862.0 474530.0 65605.0 66738.7 66809.3 66835.0 66841.7 35381.5 36651.6 36760.4 51543.0 51859.0 16893.3 17044.6 17060.9 17119.5 17125.3 13012.5 13139.7 13143.7 13159.5 13177.6 16692.3 20879.7 20899.7 20907.7 21031.5 7481.7 8876.9 8934.6 8950.3 8951.5 868.9 1013.0 1075.6 1123.5 1146.9 29482.6 30094.4 30099.5 30780.7 30843.1 964.5 1029.4 1109.4 1122.3 1123.4 14044.3 14280.7 15703.7 16077.9 16561.9 685606.0 699014.0 699458.0 700111.5 701294.0 59306.7 59874.1 59957.4 60005.7 60040.4 1391.9 1392.3 1434.1 1444.8 1445.6 29244.9 31108.2 32021.0 32173.7 32464.7 53341.5 53669.5 53967.0 54211.0 54247.0 629740.0 631399.8 633511.0 634763.0 638221.0 42446.4 43301.8 43465.1 43583.8 43801.1 47513.0 48713.0 48751.5 49016.5 49784.0 31748.0 39494.0 39783.4 40518.0 40916.6 39543.6 39917.0 40294.0 40738.6 40796.8 37245.3 37277.6 37676.0 39569.0 39582.8 32802.0 34297.7 34630.7 35353.8 35705.0 24067.8 24831.0 25822.2 26109.6 26359.0 09:43:44 INFO - PROCESS | 1658 | 09:43:44 INFO - PROCESS | 1658 | [#2] jquery.html Cycles:180 Average:35809.29 Median:13909.39 stddev:102490.34 (736.8%) stddev-sans-first:102743.28 09:43:44 INFO - PROCESS | 1658 | Values: 357.9 370.5 373.1 378.9 401.6 15575.8 20531.7 20986.1 21298.8 21565.1 19954.8 20281.2 20772.8 20986.6 20987.6 5340.3 5947.3 6021.1 6135.8 6188.9 5134.8 6043.6 6091.3 6098.5 6111.6 5913.2 5943.1 5950.0 5969.9 6037.6 5903.4 5945.9 6014.2 6055.6 6059.1 4500.1 5051.3 5240.2 5245.6 5251.1 20948.3 25347.4 25484.9 25758.7 25764.5 2190.1 2424.8 2471.4 2912.9 3135.9 11884.5 12579.9 14914.1 15339.8 16020.4 1770.7 1818.4 1835.9 1947.3 1972.1 108341.4 121306.8 122459.0 123096.0 123296.4 9541.6 9652.8 10754.3 10758.5 11021.3 13446.8 13461.4 13478.6 13489.5 13529.3 6956.9 8099.1 8293.3 8324.1 8521.6 7284.7 7989.3 8330.2 8438.5 8523.1 6523.3 6524.9 6526.6 6529.1 6536.5 1788.7 1817.4 1827.6 1834.5 1847.1 863.4 869.4 892.6 947.5 1009.0 21183.4 21958.8 22213.4 22279.9 22394.4 845.8 912.5 982.4 1002.5 1037.5 10043.5 11421.6 11528.3 11615.8 11634.8 606459.0 611455.0 616365.0 618666.0 621768.0 112706.0 119661.0 123728.0 126428.4 128684.0 937.7 980.3 1008.6 1011.8 1011.9 18499.1 18510.1 18539.4 18806.6 18982.4 56629.6 57037.7 57117.0 57305.0 58671.0 83982.6 85403.1 85943.6 86838.0 87262.0 8010.9 8032.0 8108.9 8191.8 8256.1 11616.9 12842.4 12933.4 13339.6 13397.3 11172.8 11208.2 11428.7 11485.0 11549.8 8696.9 10286.3 10792.5 11222.6 11254.6 11382.6 11476.5 11503.9 11734.9 11775.2 7771.4 7807.5 7965.6 8028.8 8135.3 8270.9 10848.9 11023.9 11108.5 11288.6 09:43:44 INFO - PROCESS | 1658 | 09:43:44 INFO - PROCESS | 1658 | [#3] mootools.html Cycles:180 Average:5678.42 Median:4850.06 stddev:3214.68 (66.3%) stddev-sans-first:3208.41 09:43:44 INFO - PROCESS | 1658 | Values: 1506.5 1538.8 1734.8 1768.9 1880.1 7916.7 8458.6 8577.6 8954.8 8963.5 8635.7 8819.8 8830.9 8836.1 8842.4 2325.7 2377.1 2378.8 2382.5 2385.6 2334.9 2353.8 2377.4 2381.1 2393.0 2362.8 2364.2 2370.7 2381.3 2387.4 2002.3 2292.0 2329.3 2341.4 2367.4 1946.6 2341.3 2341.4 2353.9 2359.3 8785.6 8868.4 8886.6 8893.3 8905.7 5234.6 5371.8 5382.7 5387.2 5396.5 3531.4 3589.8 3643.8 3670.2 3721.1 1078.4 1101.5 1118.8 1119.5 1138.9 11363.6 11408.0 11442.5 11493.9 11580.0 4526.2 4608.7 4806.2 4806.2 4807.6 9790.8 9881.4 9898.3 9910.6 9918.3 5352.4 5368.4 5371.0 5374.8 5381.2 4418.7 4751.4 4892.5 4923.4 4949.8 3796.2 3870.1 3930.1 3936.1 3947.1 1280.8 1282.9 1287.1 1293.1 1297.2 757.4 825.3 857.5 915.9 942.9 4960.5 5570.0 5762.0 5847.9 6046.0 410.3 414.3 426.4 428.0 429.5 3232.7 3639.0 3976.0 4066.1 4097.7 9281.7 10189.2 10598.1 10695.9 10806.0 10620.7 10838.7 10843.9 10851.2 10885.0 7912.8 8260.8 8265.7 8273.8 8302.3 4935.6 5958.1 6067.6 6078.7 6140.6 9965.9 10017.2 10022.2 10081.3 10083.5 9986.4 10203.1 10284.8 10295.8 10386.4 6878.8 7510.2 7649.3 7951.4 8061.0 8212.5 8416.5 8426.1 8430.2 8443.7 6362.3 7432.0 7454.1 7511.6 7580.6 6063.9 7322.9 7413.3 7414.9 7420.4 6955.4 6994.4 7080.0 7092.8 7106.8 4993.6 5023.5 5037.3 5072.7 5100.7 3875.6 4378.8 5012.6 5168.5 5259.8 09:43:44 INFO - PROCESS | 1658 | 09:43:44 INFO - PROCESS | 1658 | [#4] prototype.html Cycles:180 Average:4679.90 Median:5196.27 stddev:1450.13 (27.9%) stddev-sans-first:1416.44 09:43:44 INFO - PROCESS | 1658 | Values: 299.8 307.4 313.5 316.2 317.1 4529.8 4750.7 5106.1 5264.0 5470.2 4953.7 5129.3 5600.7 5612.6 5631.5 3707.8 4238.6 4244.9 4250.0 4270.3 3452.7 4112.7 4241.3 4249.6 4270.5 4106.3 4118.3 4178.7 4218.3 4237.6 3448.4 4176.3 4208.1 4212.5 4265.3 3198.0 3673.9 3680.0 3681.0 3705.3 5155.6 5259.7 5410.3 5426.1 5441.1 4761.8 4777.2 4821.0 4840.7 4858.5 5483.6 5685.6 5773.4 5784.5 5800.1 3672.7 3827.3 3836.5 3873.0 3881.9 4931.8 6061.6 6070.7 6115.4 6132.8 3516.6 4039.8 4046.5 4057.2 4057.6 3934.8 4043.8 4057.2 4115.2 4153.6 4018.0 4692.7 4705.1 4803.5 4828.0 4819.7 5787.7 5831.8 5840.9 5857.2 1196.0 1279.6 1300.8 1327.8 1421.3 929.8 939.3 955.4 961.5 965.4 4385.7 4717.0 5303.3 5376.8 5410.9 5869.4 5882.3 5891.5 5906.1 5930.7 4162.5 4481.3 4976.8 5237.0 5373.2 2655.4 3049.8 3097.3 3169.4 3169.8 5051.9 6078.2 6079.6 6105.7 6295.4 5434.8 5816.9 6094.7 6159.5 6190.8 5331.2 6130.8 6196.4 6239.0 6253.9 5755.5 5908.3 5991.6 5999.7 6038.4 5511.8 5859.7 5993.3 6034.7 6035.2 4957.5 5125.1 5972.5 6118.6 6301.4 3873.8 3891.3 3945.4 3973.6 3986.4 4982.9 5385.5 5650.3 5897.4 5934.7 4770.9 5547.5 5764.5 5823.5 5835.4 5700.6 5760.2 5815.5 5823.3 5923.9 4794.0 5496.9 5716.7 5746.6 5771.5 5912.8 5933.7 5942.9 5943.7 5949.1 4393.1 4399.8 5527.1 5754.1 5790.8 09:43:44 INFO - PROCESS | 1658 | 09:43:44 INFO - PROCESS | 1658 | [#5] yui.html Cycles:180 Average:25555.36 Median:3411.09 stddev:41613.21 (1219.9%) stddev-sans-first:41688.20 09:43:44 INFO - PROCESS | 1658 | Values: 731.5 769.0 772.5 816.0 864.9 15320.1 15700.8 15862.7 15893.1 15934.2 14092.4 14194.6 14202.1 14214.8 14244.9 838.6 845.6 865.1 884.8 886.4 871.5 877.8 880.6 882.3 887.8 918.9 927.0 928.2 933.3 936.4 909.1 926.7 929.1 929.7 932.1 670.4 685.0 691.0 692.9 694.4 13012.9 14837.3 15280.7 15406.5 15452.6 14165.4 14237.4 14337.4 14367.1 14379.6 10225.2 11935.0 12027.4 12081.6 12268.1 3859.6 3889.6 3906.8 3927.8 3939.9 89647.1 114475.0 117209.0 120276.0 120420.0 11101.7 11415.1 11463.7 11593.4 11772.3 17863.6 21111.8 21960.8 21984.7 22672.7 8295.2 8405.8 8463.7 8625.7 8629.2 4397.5 4601.3 4615.9 4651.4 4748.6 3376.6 3445.6 3473.0 3493.6 3498.8 543.3 622.8 629.0 633.7 635.2 599.9 611.8 625.3 626.7 632.2 9129.8 9313.6 9391.4 9414.0 9576.3 608.7 612.8 627.9 630.1 642.0 4358.1 4556.8 4557.8 4577.4 4580.7 167679.3 169097.3 169427.0 174093.0 177053.0 105483.0 108164.1 110495.0 130835.0 134278.0 112076.4 112993.0 113893.9 114487.0 115682.0 9407.4 9547.0 9988.3 9999.9 10271.8 59014.5 60779.1 61937.7 64809.7 65435.3 89563.6 96067.0 97141.5 98296.0 100864.5 12926.5 13163.7 13193.3 13268.9 13289.7 11047.7 13555.1 13796.7 14903.6 15165.7 13665.9 13797.7 13820.3 13865.4 13876.8 13711.6 13827.9 13854.8 13958.0 14407.8 13563.9 13720.3 13722.2 13727.4 14385.5 11265.6 11316.8 11484.6 11494.4 11937.9 9935.9 11316.0 11696.0 11708.2 11730.5 09:43:44 INFO - PROCESS | 1658 | -------- Summary: end -------- 09:43:44 INFO - PROCESS | 1658 | 09:43:45 INFO - TEST-INFO | 1658: exit 0 09:43:45 INFO - TEST-OK | dromaeo_css | took 1113444ms 09:43:45 INFO - TEST-START | kraken 09:43:45 INFO - operating with platform_type : mac_ 09:43:45 INFO - Initialising browser for kraken test... 09:43:45 INFO - TEST-INFO | started process 1666 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/tmpRaHVxY/profile http://localhost:49274/getInfo.html) 09:43:47 INFO - PROCESS | 1666 | __metrics Screen width/height:1600/1200 09:43:47 INFO - PROCESS | 1666 | colorDepth:24 09:43:47 INFO - PROCESS | 1666 | Browser inner width/height: 1024/689 09:43:47 INFO - PROCESS | 1666 | __metrics 09:43:47 ERROR - PROCESS | 1666 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2983: TypeError: this.tabs is undefined 09:43:48 INFO - TEST-INFO | 1666: exit 0 09:43:48 INFO - Browser initialized. 09:43:48 INFO - Running cycle 1/1 for kraken test... 09:43:48 INFO - TEST-INFO | started process 1668 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/tmpRaHVxY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:44:00 INFO - PROCESS | 1668 | RSS: Main: 239960064 09:44:00 INFO - PROCESS | 1668 | 09:44:03 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection) 09:44:04 INFO - PROCESS | 1668 | RSS: Main: 252452864 09:44:04 INFO - PROCESS | 1668 | 09:44:06 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-dft) 09:44:07 INFO - PROCESS | 1668 | RSS: Main: 261234688 09:44:07 INFO - PROCESS | 1668 | 09:44:11 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-fft) 09:44:11 INFO - PROCESS | 1668 | RSS: Main: 263983104 09:44:11 INFO - PROCESS | 1668 | 09:44:13 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator) 09:44:14 INFO - PROCESS | 1668 | RSS: Main: 266412032 09:44:14 INFO - PROCESS | 1668 | 09:44:16 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:44:17 INFO - PROCESS | 1668 | RSS: Main: 266653696 09:44:17 INFO - PROCESS | 1668 | 09:44:20 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom) 09:44:20 INFO - PROCESS | 1668 | RSS: Main: 266792960 09:44:20 INFO - PROCESS | 1668 | 09:44:24 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate) 09:44:24 INFO - PROCESS | 1668 | RSS: Main: 267173888 09:44:24 INFO - PROCESS | 1668 | 09:44:27 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial) 09:44:28 INFO - PROCESS | 1668 | RSS: Main: 267218944 09:44:28 INFO - PROCESS | 1668 | 09:44:29 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:44:30 INFO - PROCESS | 1668 | RSS: Main: 267128832 09:44:30 INFO - PROCESS | 1668 | 09:44:32 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:44:32 INFO - PROCESS | 1668 | RSS: Main: 267218944 09:44:32 INFO - PROCESS | 1668 | 09:44:35 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:44:36 INFO - PROCESS | 1668 | RSS: Main: 267550720 09:44:36 INFO - PROCESS | 1668 | 09:44:38 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:44:39 INFO - PROCESS | 1668 | RSS: Main: 267685888 09:44:39 INFO - PROCESS | 1668 | 09:44:42 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:44:43 INFO - PROCESS | 1668 | RSS: Main: 267681792 09:44:43 INFO - PROCESS | 1668 | 09:44:44 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49274/tests/kraken/driver.html?testName=ai-astar) 09:44:45 INFO - PROCESS | 1668 | RSS: Main: 268795904 09:44:45 INFO - PROCESS | 1668 | 09:44:45 INFO - PROCESS | 1668 | __start_tp_report 09:44:45 INFO - PROCESS | 1668 | _x_x_mozilla_page_load 09:44:45 INFO - PROCESS | 1668 | _x_x_mozilla_page_load_details 09:44:45 INFO - PROCESS | 1668 | |i|pagename|runs| 09:44:45 INFO - PROCESS | 1668 | |0;ai-astar;107;118;110;119;117;119;120;115;117;117 09:44:45 INFO - PROCESS | 1668 | |1;audio-beat-detection;144;111;138;161;121;126;146;96;199;108 09:44:45 INFO - PROCESS | 1668 | |2;audio-dft;197;216;208;218;231;192;240;281;261;276 09:44:45 INFO - PROCESS | 1668 | |3;audio-fft;67;108;108;184;81;63;60;61;137;59 09:44:45 INFO - PROCESS | 1668 | |4;audio-oscillator;64;104;164;104;93;90;114;81;105;145 09:44:45 INFO - PROCESS | 1668 | |5;imaging-gaussian-blur;90;89;96;74;78;131;137;105;92;133 09:44:45 INFO - PROCESS | 1668 | |6;imaging-darkroom;95;141;154;95;95;153;152;95;97;121 09:44:45 INFO - PROCESS | 1668 | |7;imaging-desaturate;89;92;91;91;96;91;89;95;89;80 09:44:45 INFO - PROCESS | 1668 | |8;json-parse-financial;48;89;58;58;58;60;56;56;59;60 09:44:45 INFO - PROCESS | 1668 | |9;json-stringify-tinderbox;64;70;66;66;74;75;74;72;69;69 09:44:45 INFO - PROCESS | 1668 | |10;stanford-crypto-aes;99;107;113;87;86;86;111;112;82;88 09:44:45 INFO - PROCESS | 1668 | |11;stanford-crypto-ccm;141;140;156;154;145;140;136;144;158;141 09:44:45 INFO - PROCESS | 1668 | |12;stanford-crypto-pbkdf2;172;175;174;169;186;223;167;153;233;238 09:44:45 INFO - PROCESS | 1668 | |13;stanford-crypto-sha256-iterative;74;86;96;77;69;68;70;68;67;70 09:44:45 INFO - PROCESS | 1668 | __end_tp_report 09:44:45 INFO - PROCESS | 1668 | __start_cc_report 09:44:45 INFO - PROCESS | 1668 | _x_x_mozilla_cycle_collect,1041 09:44:45 INFO - PROCESS | 1668 | __end_cc_report 09:44:45 INFO - PROCESS | 1668 | __startTimestamp1471279485150__endTimestamp 09:44:45 INFO - PROCESS | 1668 | 09:44:45 INFO - PROCESS | 1668 | ------- Summary: start ------- 09:44:45 INFO - PROCESS | 1668 | Number of tests: 14 09:44:45 INFO - PROCESS | 1668 | 09:44:45 INFO - PROCESS | 1668 | [#0] ai-astar Cycles:10 Average:115.90 Median:117.50 stddev:4.20 (3.6%) stddev-sans-first:2.98 09:44:45 INFO - PROCESS | 1668 | Values: 107.0 118.0 110.0 119.0 117.0 119.0 120.0 115.0 117.0 117.0 09:44:45 INFO - PROCESS | 1668 | 09:44:45 INFO - PROCESS | 1668 | [#1] audio-beat-detection Cycles:10 Average:135.00 Median:145.00 stddev:29.97 (20.7%) stddev-sans-first:31.61 09:44:45 INFO - PROCESS | 1668 | Values: 144.0 111.0 138.0 161.0 121.0 126.0 146.0 96.0 199.0 108.0 09:44:45 INFO - PROCESS | 1668 | 09:44:45 INFO - PROCESS | 1668 | [#2] audio-dft Cycles:10 Average:232.00 Median:235.50 stddev:31.79 (13.5%) stddev-sans-first:31.09 09:44:45 INFO - PROCESS | 1668 | Values: 197.0 216.0 208.0 218.0 231.0 192.0 240.0 281.0 261.0 276.0 09:44:45 INFO - PROCESS | 1668 | 09:44:45 INFO - PROCESS | 1668 | [#3] audio-fft Cycles:10 Average:92.80 Median:60.50 stddev:41.71 (68.9%) stddev-sans-first:43.18 09:44:45 INFO - PROCESS | 1668 | Values: 67.0 108.0 108.0 184.0 81.0 63.0 60.0 61.0 137.0 59.0 09:44:45 INFO - PROCESS | 1668 | 09:44:45 INFO - PROCESS | 1668 | [#4] audio-oscillator Cycles:10 Average:106.40 Median:114.00 stddev:29.38 (25.8%) stddev-sans-first:26.86 09:44:45 INFO - PROCESS | 1668 | Values: 64.0 104.0 164.0 104.0 93.0 90.0 114.0 81.0 105.0 145.0 09:44:45 INFO - PROCESS | 1668 | 09:44:45 INFO - PROCESS | 1668 | [#5] imaging-gaussian-blur Cycles:10 Average:102.50 Median:83.50 stddev:23.20 (27.8%) stddev-sans-first:24.16 09:44:45 INFO - PROCESS | 1668 | Values: 90.0 89.0 96.0 74.0 78.0 131.0 137.0 105.0 92.0 133.0 09:44:45 INFO - PROCESS | 1668 | 09:44:45 INFO - PROCESS | 1668 | [#6] imaging-darkroom Cycles:10 Average:119.80 Median:95.00 stddev:27.37 (28.8%) stddev-sans-first:27.51 09:44:45 INFO - PROCESS | 1668 | Values: 95.0 141.0 154.0 95.0 95.0 153.0 152.0 95.0 97.0 121.0 09:44:45 INFO - PROCESS | 1668 | 09:44:45 INFO - PROCESS | 1668 | [#7] imaging-desaturate Cycles:10 Average:90.30 Median:91.00 stddev:4.35 (4.8%) stddev-sans-first:4.59 09:44:45 INFO - PROCESS | 1668 | Values: 89.0 92.0 91.0 91.0 96.0 91.0 89.0 95.0 89.0 80.0 09:44:45 INFO - PROCESS | 1668 | 09:44:45 INFO - PROCESS | 1668 | [#8] json-parse-financial Cycles:10 Average:60.20 Median:58.50 stddev:10.70 (18.3%) stddev-sans-first:10.39 09:44:45 INFO - PROCESS | 1668 | Values: 48.0 89.0 58.0 58.0 58.0 60.0 56.0 56.0 59.0 60.0 09:44:45 INFO - PROCESS | 1668 | 09:44:45 INFO - PROCESS | 1668 | [#9] json-stringify-tinderbox Cycles:10 Average:69.90 Median:71.00 stddev:3.81 (5.4%) stddev-sans-first:3.40 09:44:45 INFO - PROCESS | 1668 | Values: 64.0 70.0 66.0 66.0 74.0 75.0 74.0 72.0 69.0 69.0 09:44:45 INFO - PROCESS | 1668 | 09:44:45 INFO - PROCESS | 1668 | [#10] stanford-crypto-aes Cycles:10 Average:97.10 Median:86.00 stddev:12.60 (14.7%) stddev-sans-first:13.35 09:44:45 INFO - PROCESS | 1668 | Values: 99.0 107.0 113.0 87.0 86.0 86.0 111.0 112.0 82.0 88.0 09:44:45 INFO - PROCESS | 1668 | 09:44:45 INFO - PROCESS | 1668 | [#11] stanford-crypto-ccm Cycles:10 Average:145.50 Median:144.50 stddev:7.69 (5.3%) stddev-sans-first:7.98 09:44:45 INFO - PROCESS | 1668 | Values: 141.0 140.0 156.0 154.0 145.0 140.0 136.0 144.0 158.0 141.0 09:44:45 INFO - PROCESS | 1668 | 09:44:45 INFO - PROCESS | 1668 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:189.00 Median:180.50 stddev:30.54 (16.9%) stddev-sans-first:31.76 09:44:45 INFO - PROCESS | 1668 | Values: 172.0 175.0 174.0 169.0 186.0 223.0 167.0 153.0 233.0 238.0 09:44:45 INFO - PROCESS | 1668 | 09:44:45 INFO - PROCESS | 1668 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.50 Median:72.00 stddev:9.50 (13.2%) stddev-sans-first:10.08 09:44:45 INFO - PROCESS | 1668 | Values: 74.0 86.0 96.0 77.0 69.0 68.0 70.0 68.0 67.0 70.0 09:44:45 INFO - PROCESS | 1668 | -------- Summary: end -------- 09:44:45 INFO - PROCESS | 1668 | 09:44:46 INFO - TEST-INFO | 1668: exit 0 09:44:46 INFO - TEST-OK | kraken | took 61020ms 09:44:46 INFO - SUITE-END | took 1174s 09:44:46 INFO - Completed test suite (00:19:34) 09:44:46 INFO - javascript benchmark 09:44:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7454.95255182772, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3061.4183305172014, 3439.6732310430502, 3448.8792892248775, 3451.965480345197, 3461.238527523944, 5739.426057394264, 5772.509336706385, 5833.241678581784, 5839.79560715375, 5841.269841269841, 5767.0, 5774.3936886626925, 5776.277965254343, 5787.305523337205, 5810.709464526767, 5221.164613661815, 5288.418273989858, 5330.093884039703, 5330.893382132355, 5375.731213439332, 5155.5360017598405, 5209.921851172236, 5277.8944421111555, 5336.59975501837, 5359.5712343012465, 5263.815766448156, 5278.313819203518, 5281.709505977151, 5292.073887069786, 5295.602829787762, 5267.499587539216, 5282.128448805943, 5311.415744268127, 5318.30861987943, 5352.437994010612, 5083.415407228179, 5169.25045868347, 5170.302009228743, 5259.974305010524, 5285.973570132163, 5456.48163424478, 5585.301837270341, 5726.226959360475, 5728.97135514324, 5802.071668533056, 5697.77208911643, 5880.206172166788, 6231.719572619243, 6272.686365681698, 6282.78010269643, 6038.758449662052, 6133.059244993061, 6184.165137706442, 6218.31598524162, 6224.377562243784, 5474.972625136849, 5499.477549632778, 5516.255305533742, 5541.556675465953, 5546.639468434539, 6244.812655620339, 6293.181886354744, 6295.622262664255, 6302.653354065479, 6310.684465776784, 5939.554533410012, 6105.755769769248, 6154.846128846814, 6216.906746398808, 6246.156768836149, 4615.769211539477, 6158.414950579688, 6295.748170073146, 6298.0, 6303.054541818672, 6225.097360882647, 6266.091416744638, 6269.7178626961895, 6280.780172693934, 6286.214223222098, 6125.326214116443, 6135.04893764628, 6217.502599792006, 6224.346443623445, 6302.684865756785, 5023.472535383732, 5040.092783298968, 5041.495850414929, 5043.84868453947, 5052.873678158076, 4540.477845047796, 4552.203364411214, 4553.908921821545, 4554.0, 4557.225271703818, 5550.389457159709, 5801.9419805802245, 5834.066549352168, 5873.588848780544, 5879.853003674857, 6189.907151392733, 6209.316975132731, 6226.501879849601, 6231.781887633911, 6239.656818874914, 5859.5019423349495, 5866.882662346729, 5884.764609415575, 5894.616849904828, 5923.08192230205, 5347.759350829222, 5452.182172674051, 5466.070767969455, 5493.093639549509, 5501.174823776386, 6359.332270111664, 6375.458086062737, 6384.7126879290545, 6395.392437718409, 6410.935890641033, 6222.62664240147, 6237.4698150657705, 6240.375962403723, 6258.593191442542, 6274.027525733336, 6127.724252408741, 6155.322914479493, 6172.845678858064, 6178.443940045418, 6333.113364129118, 6133.290727167522, 6139.833431647972, 6151.0, 6151.630902145886, 6166.105914642441, 6201.10084037821, 6228.972219583718, 6230.937690623035, 6240.875182496234, 6260.123582698517, 5908.793192238423, 5993.790217342372, 6004.579679422399, 6045.727942242522, 6117.816465506042, 6108.4807791338235, 6111.834843226386, 6122.245686735438, 6133.877322453615, 6142.570020098729, 5054.963732434916, 5873.765049397976, 5997.370276120944, 6034.818955431344, 6074.665893375906, 6154.138420621206, 6198.287196972406, 6227.595206311576, 6233.345498722569, 6274.0, 5826.359100499027, 5999.970000149971, 6018.699065046818, 6041.848953776191, 6065.54508411862], "value": 5714.71794861835, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [466.8039423442154, 472.72109455421315, 513.5044681881983, 531.7447625139935, 549.4615277028512, 37663.24673506532, 40393.99015024626, 40462.583809566706, 40491.59508404915, 40566.39150412746, 40919.181616367656, 41212.79393603035, 41456.756297311054, 41512.377314340236, 41537.0, 9639.855402168972, 9796.804063918717, 9809.950950245238, 9824.508774561244, 9831.459269740162, 8098.554579498125, 8370.665173393087, 9663.710088697351, 9734.805303893918, 9771.071748183911, 9786.5596048178, 9808.50957452128, 9830.852537211947, 9867.851982220272, 9869.358491698016, 9711.028897110304, 9747.610095596168, 9764.609415623367, 9789.510524473748, 9811.0, 9631.3258071935, 9662.275329350257, 9680.080392362785, 9712.70861874145, 9722.513874306256, 39149.0, 39326.60673393258, 39398.60601393978, 39489.802550987064, 39586.60413395858, 2583.1992082454312, 3162.794418362799, 3386.745994050456, 3625.782453052825, 4117.21772863155, 28797.85601072002, 31794.205144871332, 32446.351072978407, 33266.50100248498, 35571.0, 3288.2108294009504, 3317.7511686623357, 3318.9170270743184, 3441.2601290722614, 3476.66971637694, 465674.0, 471655.0, 472360.0, 473862.0, 474530.0, 65605.01592476117, 66738.66630666913, 66809.33190668128, 66835.0, 66841.66579167171, 35381.46927796085, 36651.633483664824, 36760.448593271125, 51543.0, 51859.0, 16893.32426702918, 17044.573885652957, 17060.914695426443, 17119.48641540756, 17125.314987400365, 13012.544560940321, 13139.67150821218, 13143.671408214872, 13159.473621055242, 13177.604671859859, 16692.330766923453, 20879.686804697943, 20899.74601523883, 20907.68638470424, 21031.474213144793, 7481.663325150382, 8876.872254401735, 8934.642614295486, 8950.328725345626, 8951.507667078244, 868.8957325120899, 1012.9949350253202, 1075.6181555547823, 1123.5058170860675, 1146.9455474896201, 29482.557761633594, 30094.398112037637, 30099.548506772415, 30780.69219307823, 30843.074707758802, 964.5129209749172, 1029.3978022856563, 1109.4397329348628, 1122.2761318949233, 1123.4214379594516, 14044.297785110704, 14280.714735673839, 15703.68592628141, 16077.919610401874, 16561.917190414213, 685606.0, 699014.0, 699458.0, 700111.4994424995, 701294.0, 59306.70346648325, 59874.101888471705, 59957.40042599606, 60005.69997149986, 60040.399596004354, 1391.930403479822, 1392.3177642955081, 1434.0821874000649, 1444.8049513315777, 1445.6169115184696, 29244.853775730986, 31108.222294441915, 32021.039368818972, 32173.67826321707, 32464.67535324711, 53341.46658533365, 53669.463305366444, 53967.0, 54211.0, 54247.0, 629740.0, 631399.8430007821, 633511.0, 634763.0, 638221.0, 42446.363304549835, 43301.783491082344, 43465.13069738524, 43583.78208108939, 43801.12397752091, 47513.0, 48713.0, 48751.5124848747, 49016.5098349012, 49784.0, 31748.0, 39494.01264968284, 39783.403248951865, 40517.98705032398, 40916.59083409128, 39543.604563953995, 39917.0, 40294.0, 40738.59261407348, 40796.79601601973, 37245.25509489741, 37277.62722372742, 37676.0, 39569.0, 39582.80208598939, 32802.0, 34297.657023430445, 34630.653693462744, 35353.82323088368, 35705.0, 24067.759322406553, 24831.0, 25822.225333240032, 26109.608355875058, 26359.0], "value": 20572.973157357555, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [357.8783213707339, 370.5072253902309, 373.1157157536638, 378.8522476234268, 401.64855751217664, 15575.844241557581, 20531.692024619642, 20986.05562749678, 21298.787012129895, 21565.1373945042, 19954.800451995477, 20281.18875244992, 20772.792272077273, 20986.580268394624, 20987.580248395025, 5340.279062326575, 5947.286325640929, 6021.09683547467, 6135.846603834895, 6188.938110618904, 5134.820281290155, 6043.637381757087, 6091.2690477142805, 6098.512119030467, 6111.633302001872, 5913.231279933602, 5943.138244954479, 5950.04799232123, 5969.940300597003, 6037.607555508878, 5903.409659034084, 5945.851353716192, 6014.218151640281, 6055.6063855849225, 6059.091136329564, 4500.122476117159, 5051.267566202917, 5240.213967904845, 5245.580353571705, 5251.133562962106, 20948.266810661553, 25347.366315842068, 25484.87257563719, 25758.742412575823, 25764.48471030569, 2190.123950419829, 2424.8181386395913, 2471.4192164841247, 2912.941741165165, 3135.9216019599467, 11884.524619015228, 12579.874201258053, 14914.105153690705, 15339.846601534065, 16020.35918563256, 1770.7343898415213, 1818.4090170694444, 1835.8990255535941, 1947.260041184355, 1972.0829814136496, 108341.37487937688, 121306.78693213043, 122459.0, 123096.0, 123296.38351808273, 9541.614596350912, 9652.75868103303, 10754.34352320215, 10758.462076896123, 11021.338719676845, 13446.798298025538, 13461.394237259346, 13478.595642130556, 13489.527866524624, 13529.32353382327, 6956.930430695729, 8099.149589293157, 8293.33653307734, 8324.084350721416, 8521.616527256288, 7284.688756023967, 7989.2809647132035, 8330.208630180123, 8438.451500652438, 8523.147685231428, 6523.3150519194805, 6524.869502610016, 6526.608403495806, 6529.085927970088, 6536.509761767887, 1788.6869797785334, 1817.354839032151, 1827.5796566789713, 1834.4771740054287, 1847.131848031423, 863.4301361101643, 869.4174902815129, 892.6340200517886, 947.5262368815593, 1009.0262896305101, 21183.395879451702, 21958.780412195993, 22213.44505884605, 22279.888600557217, 22394.440138996655, 845.8074115497119, 912.4844462878585, 982.3614650477247, 1002.4636819301638, 1037.5486663301488, 10043.497825108861, 11421.600243991586, 11528.308301501937, 11615.76768464626, 11634.76730465386, 606459.0, 611455.0, 616365.0, 618666.0, 621768.0, 112706.0, 119661.0, 123728.0, 126428.36785816013, 128684.0, 937.7046230437527, 980.3431700760508, 1008.5612758450097, 1011.7672935224939, 1011.9038691324313, 18499.075046247905, 18510.07449627486, 18539.35112271064, 18806.623867522845, 18982.43052708421, 56629.58426039382, 57037.71481142568, 57117.0, 57305.0, 58671.0, 83982.58008709918, 85403.14596853952, 85943.57028214818, 86838.0, 87262.0, 8010.879836802336, 8032.0, 8108.878366824384, 8191.836163276582, 8256.050554186106, 11616.94191529037, 12842.35788210567, 12933.353332333158, 13339.599812005656, 13397.263150526425, 11172.776544469227, 11208.159388046091, 11428.714282143013, 11485.0, 11549.769004620028, 8696.913030869864, 10286.331388459726, 10792.514336855018, 11222.607208747655, 11254.606088786853, 11382.601608943647, 11476.540938362707, 11503.942480287546, 11734.88265117372, 11775.175737698279, 7771.378289736695, 7807.492512986638, 7965.56189409588, 8028.799280018046, 8135.267825895698, 8270.917290827256, 10848.891511084788, 11023.944880275547, 11108.50011749457, 11288.604898828502], "value": 9740.441138981525, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1506.4576752369146, 1538.8153421589411, 1734.8178441263674, 1768.8856020706953, 1880.0693656639965, 7916.6833326666865, 8458.619362128704, 8577.614007369668, 8954.820903581924, 8963.46219226847, 8635.69775057873, 8819.779505512366, 8830.91169088309, 8836.0722124177, 8842.425242359259, 2325.662778897059, 2377.0610608809598, 2378.8453750506246, 2382.5115851250453, 2385.642153676945, 2334.8832558372096, 2353.8116950643907, 2377.393764590036, 2381.0832829360647, 2393.018862266471, 2362.83460157789, 2364.196173301077, 2370.679958205646, 2381.345130089222, 2387.438951846315, 2002.3392280547457, 2291.9656205156934, 2329.2895666821614, 2341.3678306857137, 2367.3963139399516, 1946.581484980736, 2341.2976107167783, 2341.4263505441104, 2353.8940747666397, 2359.315798418457, 8785.560721963877, 8868.37921345506, 8886.600102995317, 8893.28853691703, 8905.688300909502, 5234.633575649668, 5371.81198658049, 5382.650127741724, 5387.24578559002, 5396.514313711746, 3531.399662057456, 3589.8025608591515, 3643.8360273787744, 3670.1742108025746, 3721.106934335767, 1078.3583767658308, 1101.4602844606086, 1118.8209886418215, 1119.5186069989902, 1138.9316641001483, 11363.602273920456, 11408.030317422947, 11442.48508817097, 11493.942530287379, 11579.957803797615, 4526.207913615104, 4608.723476591348, 4806.206975848946, 4806.2310030395665, 4807.6394270429855, 9790.804183916282, 9881.407115573089, 9898.257630677728, 9910.603575857029, 9918.25613079022, 5352.357717073898, 5368.355797304349, 5371.033214021513, 5374.811881584204, 5381.246625472437, 4418.7127836690515, 4751.358566593535, 4892.486288939681, 4923.384576927884, 4949.752512374367, 3796.240751849641, 3870.0905287257474, 3930.0567863712504, 3936.1143742658246, 3947.0527073502153, 1280.8398950131234, 1282.923024618526, 1287.11832394808, 1293.1465232946211, 1297.1762930538987, 757.394084732212, 825.2902503846688, 857.5412154497315, 915.9084091590788, 942.8774259346241, 4960.454350021495, 5570.025245582007, 5761.991651460978, 5847.94152058474, 6045.969770151121, 410.3291119020423, 414.33292399237206, 426.3817464676232, 427.95078565965315, 429.49963292764204, 3232.6767323267954, 3639.0356555512813, 3976.045749020272, 4066.1257829566784, 4097.651699605567, 9281.72154835356, 10189.23580731448, 10598.099161571352, 10695.930406959242, 10806.02745752886, 10620.681379558626, 10838.67483975482, 10843.891561084445, 10851.240413171003, 10885.0, 7912.762617121495, 8260.8347833043, 8265.710700125466, 8273.793155171048, 8302.294304984023, 4935.580475659609, 5958.076498142795, 6067.575269731076, 6078.7264573093435, 6140.631562106288, 9965.900340996497, 10017.248706347198, 10022.24833137503, 10081.344712593658, 10083.546240419346, 9986.35088719231, 10203.081722644998, 10284.845727314247, 10295.794084118126, 10386.42874641902, 6878.828029299308, 7510.173880872991, 7649.349805266392, 7951.3638908886, 8061.0, 8212.46618969765, 8416.4950102994, 8426.115257898078, 8430.15698430152, 8443.704470343508, 6362.331955144643, 7432.0, 7454.068241469817, 7511.624418779148, 7580.583067931317, 6063.878722425438, 7322.926770732224, 7413.2957369049855, 7414.851702965802, 7420.369268612229, 6955.374016338554, 6994.405475534637, 7080.044194033945, 7092.787216383516, 7106.751263705745, 4993.625478089085, 5023.497650235094, 5037.319961805109, 5072.67027643202, 5100.693958362362, 3875.573686894383, 4378.846740364072, 5012.573931215888, 5168.457311982188, 5259.763310650953], "value": 4477.275618796501, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [299.8171115619472, 307.3944329670549, 313.49683757569113, 316.21578485356315, 317.0946946467834, 4529.773511324433, 4750.667453278272, 5106.08090543702, 5263.973680131594, 5470.234167216588, 4953.687272872691, 5129.2562578426105, 5600.695589602134, 5612.579056570763, 5631.549476041917, 3707.8146092695256, 4238.643634037109, 4244.893877653052, 4250.04374015847, 4270.27405341092, 3452.6719961603735, 4112.650424713888, 4241.257779888522, 4249.617534421902, 4270.508891477473, 4106.342985122381, 4118.279301122307, 4178.6657067434535, 4218.282891908368, 4237.597428244312, 3448.4310088835314, 4176.331786914095, 4208.085321178856, 4212.473440819897, 4265.274903266452, 3197.9840100799347, 3673.9081522961874, 3680.0, 3680.9815950920342, 3705.314516814398, 5155.587552995751, 5259.710715910624, 5410.321890664107, 5426.104692725696, 5441.129419292934, 4761.8095276188915, 4777.211760059586, 4820.9517904821205, 4840.668816075572, 4858.46556878743, 5483.643563168421, 5685.602007859451, 5773.364929857712, 5784.508316793078, 5800.114962637118, 3672.7245456590863, 3827.2777250237505, 3836.462895194675, 3872.961270387288, 3881.941770873439, 4931.753412329369, 6061.605995610315, 6070.6661133637635, 6115.4190351916495, 6132.754689812402, 3516.5955915070094, 4039.7980100994832, 4046.473958385391, 4057.16828050249, 4057.5536690963972, 3934.7639141651593, 4043.838246470108, 4057.1885622875543, 4115.156392939441, 4153.584641535883, 4018.0377234115845, 4692.694974826625, 4705.12955103307, 4803.519648035169, 4828.0, 4819.734914579662, 5787.726700125965, 5831.825045248649, 5840.8539786504825, 5857.179994800731, 1195.9521619135312, 1279.6289076167993, 1300.752856957175, 1327.7742783726596, 1421.3248706864363, 929.818685356349, 939.3377668743656, 955.3551352836807, 961.5048250151178, 965.4062751407974, 4385.736855788663, 4716.962268301037, 5303.302943058262, 5376.784928602812, 5410.8917821643345, 5869.354371019184, 5882.264716910387, 5891.528677705774, 5906.114082887601, 5930.703464826742, 4162.4796900387455, 4481.339407016666, 4976.800927962913, 5236.9526094781195, 5373.2208829719475, 2655.442357104991, 3049.7648452376825, 3097.3340731742783, 3169.4136584731436, 3169.8256595886987, 5051.873703157377, 6078.179445774852, 6079.565045749137, 6105.694715264308, 6295.401936815995, 5434.750007498218, 5816.883662326814, 6094.695265236721, 6159.5072394208355, 6190.845228869224, 5331.173668081454, 6130.78542251028, 6196.411340922605, 6238.968805156036, 6253.874922501524, 5755.510781583613, 5908.261467316585, 5991.621926956912, 5999.670018149044, 6038.396160383926, 5511.751971161227, 5859.707014649165, 5993.340732519332, 6034.732706131762, 6035.219610214909, 4957.454679985127, 5125.103711626722, 5972.462478376967, 6118.60229085108, 6301.369863013845, 3873.8256778445602, 3891.2606604745006, 3945.3626744900544, 3973.562908080051, 3986.4418981343215, 4982.925256121089, 5385.461453854583, 5650.26546548946, 5897.410258974069, 5934.703264836828, 4770.928436073531, 5547.5007249347755, 5764.481196692318, 5823.475887170175, 5835.44563266489, 5700.600957932905, 5760.156749840178, 5815.539753846455, 5823.330317013429, 5923.940760592339, 4794.017226468496, 5496.917546236889, 5716.742746576498, 5746.626469279484, 5771.451712087345, 5912.822615321547, 5933.673647949404, 5942.881142377042, 5943.702814859326, 5949.077892926603, 4393.055493069006, 4399.802008909671, 5527.093152862256, 5754.129907780072, 5790.768369265183], "value": 4218.62952349172, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [731.4989232375823, 768.9577073260969, 772.5248971882294, 816.0, 864.9005364383096, 15320.080795152298, 15700.842991570094, 15862.682746345066, 15893.125878076702, 15934.203289835505, 14092.436302547885, 14194.645133871658, 14202.14787112774, 14214.786778198335, 14244.857551424482, 838.5555655502593, 845.6110189312908, 865.0786911938796, 884.8495755721543, 886.4371124336061, 871.4553404122423, 877.8156587116713, 880.5993273060742, 882.2500874256895, 887.8002449448854, 918.9127032931895, 927.0266220468515, 928.2388441477957, 933.2673851026946, 936.4147407870081, 909.0500427053712, 926.6617684545092, 929.0987741890356, 929.739672891588, 932.137772560379, 670.3932940688636, 684.9863002739967, 691.0118530501381, 692.8995295682098, 694.350782018814, 13012.86987130126, 14837.25813709321, 15280.694386112216, 15406.537803865902, 15452.613684657861, 14165.362558684781, 14237.359318830677, 14337.35481903317, 14367.13797172173, 14379.568612941628, 10225.233107516966, 11935.0, 12027.398630068461, 12081.637550873487, 12268.079894007986, 3859.556151042638, 3889.591592882735, 3906.785126818024, 3927.7643341399607, 3939.862104826317, 89647.10352896452, 114475.0, 117209.0, 120276.0, 120420.0, 11101.722456938642, 11415.143864210217, 11463.713407164887, 11593.362365069834, 11772.293662380112, 17863.57091432682, 21111.83884886346, 21960.780392196193, 21984.670229946565, 22672.659910101363, 8295.170482951777, 8405.789855253668, 8463.66145354179, 8625.741227763177, 8629.223369896614, 4397.516273209944, 4601.28680054592, 4615.8846028848875, 4651.37206477128, 4748.6438517111355, 3376.561047063915, 3445.620981692012, 3473.010192095291, 3493.63316851732, 3498.7900725956524, 543.3208489388264, 622.8287221014257, 628.9716962736687, 633.6768248193363, 635.2091645900883, 599.9040153575407, 611.788932818177, 625.2746813696091, 626.7305058824658, 632.165541485235, 9129.771755706028, 9313.580888860017, 9391.389559678599, 9414.0, 9576.281778866613, 608.7412849538928, 612.8253447767365, 627.8626426679247, 630.124127462827, 641.9743210271537, 4358.063016451478, 4556.794944227518, 4557.772111394417, 4577.382053422745, 4580.725156490621, 167679.30253600675, 169097.3090269106, 169427.0, 174093.0, 177053.0, 105483.0, 108164.05097719544, 110495.0, 130835.0, 134278.0, 112076.43961780138, 112993.0, 113893.86106138998, 114487.0, 115682.0, 9407.43555386679, 9547.0, 9988.300818942604, 9999.900000999896, 10271.845922311022, 59014.52463688271, 60779.08831367621, 61937.690311548155, 64809.67595162183, 65435.345646542926, 89563.55218223867, 96067.0, 97141.51429242808, 98296.0, 100864.49567752115, 12926.547570835352, 13163.670908226988, 13193.340332983504, 13268.93365533166, 13289.667758305734, 11047.72380690457, 13555.118917270345, 13796.724065518834, 14903.627409314853, 15165.696686066438, 13665.86334136646, 13797.724045519235, 13820.34938973698, 13865.376058077612, 13876.791848122488, 13711.640648041293, 13827.861721382658, 13854.792178117537, 13958.0, 14407.783883241551, 13563.93218033943, 13720.313984300945, 13722.245276509888, 13727.382267797773, 14385.496507622602, 11265.610917986443, 11316.83024754613, 11484.598039068593, 11494.425278735862, 11937.880621193677, 9935.850962235716, 11316.04188314311, 11696.0, 11708.180427370344, 11730.530778768754], "value": 7935.3626201245615, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1630.8999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 118.0, 110.0, 119.0, 117.0, 119.0, 120.0, 115.0, 117.0, 117.0], "value": 115.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 111.0, 138.0, 161.0, 121.0, 126.0, 146.0, 96.0, 199.0, 108.0], "value": 135.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [197.0, 216.0, 208.0, 218.0, 231.0, 192.0, 240.0, 281.0, 261.0, 276.0], "value": 232.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 108.0, 108.0, 184.0, 81.0, 63.0, 60.0, 61.0, 137.0, 59.0], "value": 92.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 104.0, 164.0, 104.0, 93.0, 90.0, 114.0, 81.0, 105.0, 145.0], "value": 106.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 89.0, 96.0, 74.0, 78.0, 131.0, 137.0, 105.0, 92.0, 133.0], "value": 102.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 141.0, 154.0, 95.0, 95.0, 153.0, 152.0, 95.0, 97.0, 121.0], "value": 119.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 92.0, 91.0, 91.0, 96.0, 91.0, 89.0, 95.0, 89.0, 80.0], "value": 90.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [48.0, 89.0, 58.0, 58.0, 58.0, 60.0, 56.0, 56.0, 59.0, 60.0], "value": 60.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 70.0, 66.0, 66.0, 74.0, 75.0, 74.0, 72.0, 69.0, 69.0], "value": 69.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 107.0, 113.0, 87.0, 86.0, 86.0, 111.0, 112.0, 82.0, 88.0], "value": 97.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 140.0, 156.0, 154.0, 145.0, 140.0, 136.0, 144.0, 158.0, 141.0], "value": 145.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 175.0, 174.0, 169.0, 186.0, 223.0, 167.0, 153.0, 233.0, 238.0], "value": 189.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 86.0, 96.0, 77.0, 69.0, 68.0, 70.0, 68.0, 67.0, 70.0], "value": 74.5, "unit": "score"}]}]} 09:44:46 INFO - Return code: 0 09:44:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:44:46 ERROR - # TBPL SUCCESS # 09:44:46 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:44:46 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:44:46 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:44:46 INFO - 2016-08-15 09:44:46.498 screenresolution[1673:11236] starting screenresolution argv=screenresolution get 09:44:46 INFO - 2016-08-15 09:44:46.501 screenresolution[1673:11236] Display 0: 1600x1200x32@60 09:44:46 INFO - 2016-08-15 09:44:46.507 screenresolution[1674:11239] starting screenresolution argv=screenresolution list 09:44:46 INFO - Available Modes on Display 0 09:44:46 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:44:46 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:44:46 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:44:46 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:44:46 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:44:46 INFO - Intel Iris: 09:44:46 INFO - Chipset Model: Intel Iris 09:44:46 INFO - Type: GPU 09:44:46 INFO - Bus: Built-In 09:44:46 INFO - VRAM (Dynamic, Max): 1536 MB 09:44:46 INFO - Vendor: Intel (0x8086) 09:44:46 INFO - Device ID: 0x0a2e 09:44:46 INFO - Revision ID: 0x0009 09:44:46 INFO - Displays: 09:44:46 INFO - Display: 09:44:46 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:44:46 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:44:46 INFO - Display Serial Number: 1600x1200 60 09:44:46 INFO - Main Display: Yes 09:44:46 INFO - Mirror: Off 09:44:46 INFO - Online: Yes 09:44:46 INFO - Rotation: Supported 09:44:46 INFO - Return code: 0 09:44:46 INFO - Running post-action listener: _resource_record_post_action 09:44:46 INFO - [mozharness: 2016-08-15 16:44:46.742119Z] Finished run-tests step (success) 09:44:46 INFO - Running post-run listener: _resource_record_post_run 09:44:46 INFO - Total resource usage - Wall time: 1209s; CPU: 54.0%; Read bytes: 31697920; Write bytes: 707686400; Read time: 193; Write time: 2110 09:44:46 INFO - TinderboxPrint: CPU usage
54.5% 09:44:46 INFO - TinderboxPrint: I/O read bytes / time
31,697,920 / 193 09:44:46 INFO - TinderboxPrint: I/O write bytes / time
707,686,400 / 2,110 09:44:46 INFO - TinderboxPrint: CPU idle
2,201.4 (45.5%) 09:44:46 INFO - TinderboxPrint: CPU system
983.2 (20.3%) 09:44:46 INFO - TinderboxPrint: CPU user
1,653.0 (34.2%) 09:44:46 INFO - TinderboxPrint: Swap in / out
432,402,432 / 0 09:44:46 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 394160640; Write bytes: 388196352; Read time: 29497; Write time: 871 09:44:46 INFO - run-tests - Wall time: 1176s; CPU: 54.0%; Read bytes: 29821952; Write bytes: 299497472; Read time: 177; Write time: 1182 09:44:47 INFO - Running post-run listener: _upload_blobber_files 09:44:47 INFO - Blob upload gear active. 09:44:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:44:47 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 09:44:47 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'] 09:44:47 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 09:44:47 INFO - (blobuploader) - INFO - Open directory for files ... 09:44:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:44:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:44:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:44:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:44:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:44:48 INFO - (blobuploader) - INFO - Done attempting. 09:44:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:44:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:44:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:44:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:44:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:44:49 INFO - (blobuploader) - INFO - Done attempting. 09:44:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:44:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:44:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:44:52 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:44:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:44:52 INFO - (blobuploader) - INFO - Done attempting. 09:44:52 INFO - (blobuploader) - INFO - Iteration through files over. 09:44:52 INFO - Return code: 0 09:44:52 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:44:52 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:44:52 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/6362abaccd2b2859148539df0ae8fcaa2962fe9f5fe862b6121983eac81da6ae8da2e92e4acc6b606c7d312922f920eac2070c48c7241a994bfbc1383324dbb0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/1ca1a85a9a7a42b5b84bf4ca4e498490421f6526468b5a22136d3fcbf538b84264cf0f1de98360280032fe3b1785ec8ec7a924071a2c1c0f9a1e2f7ddc13d6a0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/3a55b0a24fb9d9f3a1b576c43b7230a9c0969a0e68910cd9a0aa56de26ab808f3beb006e0621353278a438ed09d12af2a7f21d7b4b61ecedd9b1ca5266056e75"} 09:44:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:44:52 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:44:52 INFO - Contents: 09:44:52 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/6362abaccd2b2859148539df0ae8fcaa2962fe9f5fe862b6121983eac81da6ae8da2e92e4acc6b606c7d312922f920eac2070c48c7241a994bfbc1383324dbb0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/1ca1a85a9a7a42b5b84bf4ca4e498490421f6526468b5a22136d3fcbf538b84264cf0f1de98360280032fe3b1785ec8ec7a924071a2c1c0f9a1e2f7ddc13d6a0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/3a55b0a24fb9d9f3a1b576c43b7230a9c0969a0e68910cd9a0aa56de26ab808f3beb006e0621353278a438ed09d12af2a7f21d7b4b61ecedd9b1ca5266056e75"} 09:44:52 INFO - Running post-run listener: copy_logs_to_upload_dir 09:44:52 INFO - Copying logs to upload dir... 09:44:52 INFO - mkdir: /builds/slave/test/build/upload/logs 09:44:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1274.436924 ========= master_lag: 2.43 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-08-15 09:44:54.542212) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-15 09:44:54.545685) ========= 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.yIAoJJJUHI/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.EFEr2Lv5uh/Listeners TMPDIR=/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/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/6362abaccd2b2859148539df0ae8fcaa2962fe9f5fe862b6121983eac81da6ae8da2e92e4acc6b606c7d312922f920eac2070c48c7241a994bfbc1383324dbb0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/1ca1a85a9a7a42b5b84bf4ca4e498490421f6526468b5a22136d3fcbf538b84264cf0f1de98360280032fe3b1785ec8ec7a924071a2c1c0f9a1e2f7ddc13d6a0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/3a55b0a24fb9d9f3a1b576c43b7230a9c0969a0e68910cd9a0aa56de26ab808f3beb006e0621353278a438ed09d12af2a7f21d7b4b61ecedd9b1ca5266056e75"} build_url:https://queue.taskcluster.net/v1/task/NUY8soEiTqOBnh0MmJ_ZgQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011080 build_url: 'https://queue.taskcluster.net/v1/task/NUY8soEiTqOBnh0MmJ_ZgQ/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/6362abaccd2b2859148539df0ae8fcaa2962fe9f5fe862b6121983eac81da6ae8da2e92e4acc6b606c7d312922f920eac2070c48c7241a994bfbc1383324dbb0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/1ca1a85a9a7a42b5b84bf4ca4e498490421f6526468b5a22136d3fcbf538b84264cf0f1de98360280032fe3b1785ec8ec7a924071a2c1c0f9a1e2f7ddc13d6a0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/3a55b0a24fb9d9f3a1b576c43b7230a9c0969a0e68910cd9a0aa56de26ab808f3beb006e0621353278a438ed09d12af2a7f21d7b4b61ecedd9b1ca5266056e75"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-15 09:44:54.581025) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-15 09:44:54.581439) ========= 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.yIAoJJJUHI/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.EFEr2Lv5uh/Listeners TMPDIR=/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/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.005314 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-15 09:44:54.631418) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-15 09:44:54.631739) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-15 09:44:54.632158) ========= ========= Total master_lag: 2.63 =========