builder: autoland_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0045 starttime: 1472105477.16 results: success (0) buildid: 20160824203626 builduid: cf6e5edb7dd6472ab3ee833d8950e160 revision: f992cf77d4548ecc1495642741de1534e013e60d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-24 23:11:17.158351) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-24 23:11:17.158825) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-24 23:11:17.159143) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-24 23:11:17.254049) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-24 23:11:17.254421) ========= 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.roCslYPobt/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.X2nR6uwQPa/Listeners TMPDIR=/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/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-24 23:11:17-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 8.96M=0.001s 2016-08-24 23:11:17 (8.96 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.090498 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-24 23:11:17.368184) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-24 23:11:17.368510) ========= 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.roCslYPobt/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.X2nR6uwQPa/Listeners TMPDIR=/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/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.027848 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-24 23:11:17.417933) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-24 23:11:17.418276) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev f992cf77d4548ecc1495642741de1534e013e60d --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 f992cf77d4548ecc1495642741de1534e013e60d --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.roCslYPobt/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.X2nR6uwQPa/Listeners TMPDIR=/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/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-24 23:11:17,496 truncating revision to first 12 chars 2016-08-24 23:11:17,496 Setting DEBUG logging. 2016-08-24 23:11:17,496 attempt 1/10 2016-08-24 23:11:17,497 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/f992cf77d454?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-24 23:11:18,513 unpacking tar archive at: autoland-f992cf77d454/testing/mozharness/ program finished with exit code 0 elapsedTime=1.267083 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-24 23:11:18.708237) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-24 23:11:18.708583) ========= script_repo_revision: f992cf77d4548ecc1495642741de1534e013e60d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-24 23:11:18.708979) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-24 23:11:18.709264) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-24 23:11:18.727803) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-08-24 23:11:18.728093) ========= /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.roCslYPobt/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.X2nR6uwQPa/Listeners TMPDIR=/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/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 23:11:18 INFO - MultiFileLogger online at 20160824 23:11:18 in /builds/slave/test 23:11:18 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 23:11:18 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:11:18 INFO - {'append_to_log': False, 23:11:18 INFO - 'base_work_dir': '/builds/slave/test', 23:11:18 INFO - 'blob_upload_branch': 'Autoland', 23:11:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:11:18 INFO - 'branch': 'Autoland', 23:11:18 INFO - 'buildbot_json_path': 'buildprops.json', 23:11:18 INFO - 'config_files': ('talos/mac_config.py',), 23:11:18 INFO - 'default_actions': ('clobber', 23:11:18 INFO - 'read-buildbot-config', 23:11:18 INFO - 'download-and-extract', 23:11:18 INFO - 'populate-webroot', 23:11:18 INFO - 'create-virtualenv', 23:11:18 INFO - 'install', 23:11:18 INFO - 'run-tests'), 23:11:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:11:18 INFO - 'download_minidump_stackwalk': True, 23:11:18 INFO - 'download_symbols': 'ondemand', 23:11:18 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:11:18 INFO - 'tooltool.py': '/tools/tooltool.py', 23:11:18 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:11:18 INFO - '/tools/misc-python/virtualenv.py')}, 23:11:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:11:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:11:18 INFO - 'installer_path': 'installer.exe', 23:11:18 INFO - 'log_level': 'info', 23:11:18 INFO - 'log_name': 'talos', 23:11:18 INFO - 'log_to_console': True, 23:11:18 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 23:11:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 23:11:18 INFO - 'opt_config_files': (), 23:11:18 INFO - 'pip_index': False, 23:11:18 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 23:11:18 INFO - 'cmd': ('bash', 23:11:18 INFO - '-c', 23:11:18 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 23:11:18 INFO - 'enabled': True, 23:11:18 INFO - 'halt_on_failure': False, 23:11:18 INFO - 'name': 'check_screen_resolution'},), 23:11:18 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 23:11:18 INFO - 'cmd': ('bash', 23:11:18 INFO - '-c', 23:11:18 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 23:11:18 INFO - 'enabled': True, 23:11:18 INFO - 'halt_on_failure': False, 23:11:18 INFO - 'name': 'check_screen_resolution'},), 23:11:18 INFO - 'run_cmd_checks_enabled': True, 23:11:18 INFO - 'sps_profile': False, 23:11:18 INFO - 'sps_profile_interval': 0, 23:11:18 INFO - 'suite': 'dromaeojs-e10s', 23:11:18 INFO - 'system_bits': '32', 23:11:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:11:18 INFO - 'title': 't-yosemite-r7-0045', 23:11:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:11:18 INFO - 'use_talos_json': True, 23:11:18 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:11:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:11:18 INFO - 'work_dir': 'build'} 23:11:18 INFO - [mozharness: 2016-08-25 06:11:18.925289Z] Running clobber step. 23:11:18 INFO - Running pre-action listener: _resource_record_pre_action 23:11:18 INFO - Running main action method: clobber 23:11:18 INFO - rmtree: /builds/slave/test/build 23:11:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:11:21 INFO - Running post-action listener: _resource_record_post_action 23:11:21 INFO - [mozharness: 2016-08-25 06:11:21.017592Z] Finished clobber step (success) 23:11:21 INFO - [mozharness: 2016-08-25 06:11:21.017723Z] Running read-buildbot-config step. 23:11:21 INFO - Running pre-action listener: _resource_record_pre_action 23:11:21 INFO - Running main action method: read_buildbot_config 23:11:21 INFO - Using buildbot properties: 23:11:21 INFO - { 23:11:21 INFO - "project": "", 23:11:21 INFO - "product": "firefox", 23:11:21 INFO - "script_repo_revision": "production", 23:11:21 INFO - "builddir": "autoland_yosemite_r7_test-dromaeojs-e10s", 23:11:21 INFO - "repository": "", 23:11:21 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 autoland talos dromaeojs-e10s", 23:11:21 INFO - "buildid": "20160824203626", 23:11:21 INFO - "pgo_build": "False", 23:11:21 INFO - "basedir": "/builds/slave/test", 23:11:21 INFO - "buildnumber": 158, 23:11:21 INFO - "slavename": "t-yosemite-r7-0045", 23:11:21 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 23:11:21 INFO - "platform": "yosemite_r7", 23:11:21 INFO - "scheduler": "tests-autoland-macosx64-talos-7-3600", 23:11:21 INFO - "branch": "autoland", 23:11:21 INFO - "repo_path": "integration/autoland", 23:11:21 INFO - "revision": "f992cf77d4548ecc1495642741de1534e013e60d", 23:11:21 INFO - "stage_platform": "macosx64", 23:11:21 INFO - "builduid": "cf6e5edb7dd6472ab3ee833d8950e160", 23:11:21 INFO - "slavebuilddir": "test" 23:11:21 INFO - } 23:11:21 INFO - Found installer url https://queue.taskcluster.net/v1/task/Jgt5S5z9QQiw8vLRLMv8zA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 23:11:21 INFO - Running post-action listener: _resource_record_post_action 23:11:21 INFO - [mozharness: 2016-08-25 06:11:21.020849Z] Finished read-buildbot-config step (success) 23:11:21 INFO - [mozharness: 2016-08-25 06:11:21.020946Z] Running download-and-extract step. 23:11:21 INFO - Running pre-action listener: _resource_record_pre_action 23:11:21 INFO - Running main action method: download_and_extract 23:11:21 INFO - mkdir: /builds/slave/test/build/tests 23:11: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')]} 23:11:21 INFO - trying https://queue.taskcluster.net/v1/task/Jgt5S5z9QQiw8vLRLMv8zA/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 23:11:21 INFO - Downloading https://queue.taskcluster.net/v1/task/Jgt5S5z9QQiw8vLRLMv8zA/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 23:11:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Jgt5S5z9QQiw8vLRLMv8zA/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 23:11:22 INFO - Downloaded 1199 bytes. 23:11:22 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 23:11:22 INFO - Using the following test package requirements: 23:11:22 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 23:11:22 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 23:11:22 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 23:11:22 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 23:11:22 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 23:11:22 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 23:11:22 INFO - u'jsshell-mac.zip'], 23:11:22 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 23:11:22 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 23:11:22 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 23:11:22 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 23:11:22 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 23:11:22 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 23:11:22 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 23:11:22 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 23:11:22 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 23:11:22 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 23:11:22 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 23:11:22 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 23:11:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:11:22 INFO - trying https://queue.taskcluster.net/v1/task/Jgt5S5z9QQiw8vLRLMv8zA/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 23:11:22 INFO - Downloading https://queue.taskcluster.net/v1/task/Jgt5S5z9QQiw8vLRLMv8zA/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 23:11:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Jgt5S5z9QQiw8vLRLMv8zA/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 23:11:24 INFO - Downloaded 16345952 bytes. 23:11:24 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 23:11:30 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 23:11: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')]} 23:11:30 INFO - trying https://queue.taskcluster.net/v1/task/Jgt5S5z9QQiw8vLRLMv8zA/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 23:11:30 INFO - Downloading https://queue.taskcluster.net/v1/task/Jgt5S5z9QQiw8vLRLMv8zA/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 23:11:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Jgt5S5z9QQiw8vLRLMv8zA/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 23:11:31 INFO - Downloaded 16345952 bytes. 23:11:31 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 23:11:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:11:38 INFO - trying https://queue.taskcluster.net/v1/task/Jgt5S5z9QQiw8vLRLMv8zA/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 23:11:38 INFO - Downloading https://queue.taskcluster.net/v1/task/Jgt5S5z9QQiw8vLRLMv8zA/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 23:11:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Jgt5S5z9QQiw8vLRLMv8zA/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 23:11:40 INFO - Downloaded 14413981 bytes. 23:11:40 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/tests 23:11: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')]} 23:11:40 INFO - trying https://queue.taskcluster.net/v1/task/Jgt5S5z9QQiw8vLRLMv8zA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 23:11:40 INFO - Downloading https://queue.taskcluster.net/v1/task/Jgt5S5z9QQiw8vLRLMv8zA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 23:11:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Jgt5S5z9QQiw8vLRLMv8zA/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 23:11:44 INFO - Downloaded 111408933 bytes. 23:11:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Jgt5S5z9QQiw8vLRLMv8zA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 23:11:44 INFO - mkdir: /builds/slave/test/properties 23:11:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:11:44 INFO - Writing to file /builds/slave/test/properties/build_url 23:11:44 INFO - Contents: 23:11:44 INFO - build_url:https://queue.taskcluster.net/v1/task/Jgt5S5z9QQiw8vLRLMv8zA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 23:11:45 INFO - Running post-action listener: _resource_record_post_action 23:11:45 INFO - Running post-action listener: set_extra_try_arguments 23:11:45 INFO - [mozharness: 2016-08-25 06:11:45.204916Z] Finished download-and-extract step (success) 23:11:45 INFO - [mozharness: 2016-08-25 06:11:45.205066Z] Running populate-webroot step. 23:11:45 INFO - Running pre-action listener: _resource_record_pre_action 23:11:45 INFO - Running main action method: populate_webroot 23:11:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:11:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:11:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:11:45 INFO - '--tppagecycles', 23:11:45 INFO - '7'], 23:11:45 INFO - 'tests': ['tsvgm']}}, 23:11:45 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 23:11:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:11:45 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:11:45 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 23:11:45 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:11:45 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:11:45 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:11:45 INFO - 'talos_options': ['--disable-e10s'], 23:11:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:11:45 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:11:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:11:45 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:11:45 INFO - 'talos_options': ['--disable-e10s'], 23:11:45 INFO - 'tests': ['damp', 'tps']}, 23:11:45 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:11:45 INFO - 'tests': ['damp', 'tps']}, 23:11:45 INFO - 'g3': {'talos_options': ['--disable-e10s'], 23:11:45 INFO - 'tests': ['dromaeo_dom']}, 23:11:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:11:45 INFO - 'g4': {'talos_options': ['--disable-e10s'], 23:11:45 INFO - 'tests': ['basic_compositor_video']}, 23:11:45 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 23:11:45 INFO - 'other': {'talos_options': ['--disable-e10s'], 23:11:45 INFO - 'tests': ['a11yr', 23:11:45 INFO - 'ts_paint', 23:11:45 INFO - 'tpaint', 23:11:45 INFO - 'sessionrestore', 23:11:45 INFO - 'sessionrestore_no_auto_restore', 23:11:45 INFO - 'tabpaint']}, 23:11:45 INFO - 'other-e10s': {'tests': ['a11yr', 23:11:45 INFO - 'ts_paint', 23:11:45 INFO - 'tpaint', 23:11:45 INFO - 'sessionrestore', 23:11:45 INFO - 'sessionrestore_no_auto_restore', 23:11:45 INFO - 'tabpaint']}, 23:11:45 INFO - 'other-e10s_l64': {'tests': ['a11yr', 23:11:45 INFO - 'ts_paint', 23:11:45 INFO - 'tpaint', 23:11:45 INFO - 'sessionrestore', 23:11:45 INFO - 'sessionrestore_no_auto_restore', 23:11:45 INFO - 'tabpaint']}, 23:11:45 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 23:11:45 INFO - 'ts_paint', 23:11:45 INFO - 'tpaint', 23:11:45 INFO - 'sessionrestore', 23:11:45 INFO - 'sessionrestore_no_auto_restore', 23:11:45 INFO - 'tabpaint']}, 23:11:45 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 23:11:45 INFO - 'tests': ['a11yr', 23:11:45 INFO - 'ts_paint', 23:11:45 INFO - 'tpaint', 23:11:45 INFO - 'sessionrestore', 23:11:45 INFO - 'sessionrestore_no_auto_restore', 23:11:45 INFO - 'tabpaint']}, 23:11:45 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 23:11:45 INFO - 'tests': ['a11yr', 23:11:45 INFO - 'ts_paint', 23:11:45 INFO - 'tpaint', 23:11:45 INFO - 'sessionrestore', 23:11:45 INFO - 'sessionrestore_no_auto_restore', 23:11:45 INFO - 'tabpaint']}, 23:11:45 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 23:11:45 INFO - 'tests': ['tsvgx', 23:11:45 INFO - 'tsvgr_opacity', 23:11:45 INFO - 'tart', 23:11:45 INFO - 'tscrollx', 23:11:45 INFO - 'cart']}, 23:11:45 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:11:45 INFO - 'tsvgr_opacity', 23:11:45 INFO - 'tart', 23:11:45 INFO - 'tscrollx', 23:11:45 INFO - 'cart']}, 23:11:45 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:11:45 INFO - 'talos_options': ['--disable-e10s'], 23:11:45 INFO - 'tests': ['tp5o']}, 23:11:45 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:11:45 INFO - 'tests': ['tp5o']}, 23:11:45 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:11:45 INFO - 'talos_options': ['--disable-e10s', 23:11:45 INFO - '--xperf_path', 23:11:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:11:45 INFO - 'tests': ['tp5n']}, 23:11:45 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:11:45 INFO - 'talos_options': ['--xperf_path', 23:11:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:11:45 INFO - 'tests': ['tp5n']}}, 23:11:45 INFO - 'talos.zip': {'path': '', 23:11:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:11:45 INFO - Running post-action listener: _resource_record_post_action 23:11:45 INFO - [mozharness: 2016-08-25 06:11:45.224047Z] Finished populate-webroot step (success) 23:11:45 INFO - [mozharness: 2016-08-25 06:11:45.224180Z] Running create-virtualenv step. 23:11:45 INFO - Running pre-action listener: _resource_record_pre_action 23:11:45 INFO - Running main action method: create_virtualenv 23:11:45 INFO - Creating virtualenv /builds/slave/test/build/venv 23:11:45 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 23:11:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:11:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:11:45 INFO - Using real prefix '/tools/python27' 23:11:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:11:46 INFO - Installing distribute.............................................................................................................................................................................................done. 23:11:48 INFO - Installing pip.................done. 23:11:48 INFO - Return code: 0 23:11:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:11:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:11:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:11:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:11:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:11:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:11:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:11:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10bc6da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bd02618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb1604ba900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bbd1d30>, '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 0x10b936db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bbc9b20>, '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.roCslYPobt/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.X2nR6uwQPa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/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 23:11:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 23:11:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 23:11:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.roCslYPobt/Render', 23:11:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:11:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:11:48 INFO - 'HOME': '/Users/cltbld', 23:11:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:11:48 INFO - 'LOGNAME': 'cltbld', 23:11:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:11:48 INFO - 'MOZ_NO_REMOTE': '1', 23:11:48 INFO - 'NO_EM_RESTART': '1', 23:11:48 INFO - 'PAGER': '/bin/cat', 23:11:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:11:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:11:48 INFO - 'PWD': '/builds/slave/test', 23:11:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:11:48 INFO - 'SHELL': '/bin/bash', 23:11:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.X2nR6uwQPa/Listeners', 23:11:48 INFO - 'TMPDIR': '/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/', 23:11:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:11:48 INFO - 'USER': 'cltbld', 23:11:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:11:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:11:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:11:48 INFO - 'XPC_FLAGS': '0x0', 23:11:48 INFO - 'XPC_SERVICE_NAME': '0', 23:11:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:11:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:11:49 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 23:11:49 INFO - Cleaning up... 23:11:49 INFO - Return code: 0 23:11:49 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 23:11: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')]} 23:11:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:11:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:11: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')]} 23:11:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:11:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:11:49 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 0x10bc6da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bd02618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb1604ba900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bbd1d30>, '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 0x10b936db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bbc9b20>, '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.roCslYPobt/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.X2nR6uwQPa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/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 23:11:49 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 23:11:49 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 23:11:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.roCslYPobt/Render', 23:11:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:11:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:11:49 INFO - 'HOME': '/Users/cltbld', 23:11:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:11:49 INFO - 'LOGNAME': 'cltbld', 23:11:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:11:49 INFO - 'MOZ_NO_REMOTE': '1', 23:11:49 INFO - 'NO_EM_RESTART': '1', 23:11:49 INFO - 'PAGER': '/bin/cat', 23:11:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:11:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:11:49 INFO - 'PWD': '/builds/slave/test', 23:11:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:11:49 INFO - 'SHELL': '/bin/bash', 23:11:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.X2nR6uwQPa/Listeners', 23:11:49 INFO - 'TMPDIR': '/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/', 23:11:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:11:49 INFO - 'USER': 'cltbld', 23:11:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:11:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:11:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:11:49 INFO - 'XPC_FLAGS': '0x0', 23:11:49 INFO - 'XPC_SERVICE_NAME': '0', 23:11:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:11:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:11:49 INFO - Downloading/unpacking psutil>=3.1.1 23:11:49 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 23:11:49 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 23:11:49 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 23:11:49 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 23:11:49 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 23:11:49 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 23:11:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:11:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:11:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:11:52 INFO - Installing collected packages: psutil 23:11:52 INFO - Running setup.py install for psutil 23:11:52 INFO - building 'psutil._psutil_osx' extension 23:11:52 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 23:11:53 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 23:11:53 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 23:11:53 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 23:11:53 INFO - building 'psutil._psutil_posix' extension 23:11:53 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 23:11:53 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 23:11:53 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 23:11:53 INFO - ^ 23:11:53 INFO - 1 warning generated. 23:11:53 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 23:11:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:11:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:11:53 INFO - Successfully installed psutil 23:11:53 INFO - Cleaning up... 23:11:53 INFO - Return code: 0 23:11:53 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 23:11:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:11:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:11:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:11:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:11:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:11:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:11:53 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 0x10bc6da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bd02618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb1604ba900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bbd1d30>, '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 0x10b936db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bbc9b20>, '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.roCslYPobt/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.X2nR6uwQPa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/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 23:11:53 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 23:11:53 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 23:11:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.roCslYPobt/Render', 23:11:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:11:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:11:53 INFO - 'HOME': '/Users/cltbld', 23:11:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:11:53 INFO - 'LOGNAME': 'cltbld', 23:11:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:11:53 INFO - 'MOZ_NO_REMOTE': '1', 23:11:53 INFO - 'NO_EM_RESTART': '1', 23:11:53 INFO - 'PAGER': '/bin/cat', 23:11:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:11:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:11:53 INFO - 'PWD': '/builds/slave/test', 23:11:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:11:53 INFO - 'SHELL': '/bin/bash', 23:11:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.X2nR6uwQPa/Listeners', 23:11:53 INFO - 'TMPDIR': '/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/', 23:11:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:11:53 INFO - 'USER': 'cltbld', 23:11:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:11:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:11:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:11:53 INFO - 'XPC_FLAGS': '0x0', 23:11:53 INFO - 'XPC_SERVICE_NAME': '0', 23:11:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:11:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:11:53 INFO - Downloading/unpacking mozsystemmonitor==0.3 23:11:53 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 23:11:53 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 23:11:53 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 23:11:53 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 23:11:53 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 23:11:53 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 23:11:56 INFO - Downloading mozsystemmonitor-0.3.tar.gz 23:11:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:11:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 23:11:56 INFO - Installing collected packages: mozsystemmonitor 23:11:56 INFO - Running setup.py install for mozsystemmonitor 23:11:56 INFO - Successfully installed mozsystemmonitor 23:11:56 INFO - Cleaning up... 23:11:56 INFO - Return code: 0 23:11:56 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 23:11: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')]} 23:11:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:11:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:11: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')]} 23:11:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:11:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:11:56 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 0x10bc6da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bd02618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb1604ba900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bbd1d30>, '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 0x10b936db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bbc9b20>, '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.roCslYPobt/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.X2nR6uwQPa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/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 23:11:56 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 23:11:56 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 23:11:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.roCslYPobt/Render', 23:11:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:11:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:11:56 INFO - 'HOME': '/Users/cltbld', 23:11:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:11:56 INFO - 'LOGNAME': 'cltbld', 23:11:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:11:56 INFO - 'MOZ_NO_REMOTE': '1', 23:11:56 INFO - 'NO_EM_RESTART': '1', 23:11:56 INFO - 'PAGER': '/bin/cat', 23:11:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:11:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:11:56 INFO - 'PWD': '/builds/slave/test', 23:11:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:11:56 INFO - 'SHELL': '/bin/bash', 23:11:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.X2nR6uwQPa/Listeners', 23:11:56 INFO - 'TMPDIR': '/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/', 23:11:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:11:56 INFO - 'USER': 'cltbld', 23:11:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:11:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:11:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:11:56 INFO - 'XPC_FLAGS': '0x0', 23:11:56 INFO - 'XPC_SERVICE_NAME': '0', 23:11:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:11:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:11:56 INFO - Downloading/unpacking jsonschema==2.5.1 23:11:56 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 23:11:56 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 23:11:56 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 23:11:56 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 23:11:56 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 23:11:56 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 23:11:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:11:59 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 23:11:59 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 23:11:59 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 23:11:59 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 23:11:59 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 23:11:59 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 23:11:59 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 23:11:59 INFO - Downloading functools32-3.2.3-2.tar.gz 23:11:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:11:59 INFO - warning: no files found matching '*.txt' 23:11:59 INFO - no previously-included directories found matching 'build' 23:11:59 INFO - no previously-included directories found matching 'dist' 23:11:59 INFO - no previously-included directories found matching '.git*' 23:11:59 INFO - Installing collected packages: jsonschema, functools32 23:11:59 INFO - Running setup.py install for functools32 23:12:00 INFO - warning: no files found matching '*.txt' 23:12:00 INFO - no previously-included directories found matching 'build' 23:12:00 INFO - no previously-included directories found matching 'dist' 23:12:00 INFO - no previously-included directories found matching '.git*' 23:12:00 INFO - Successfully installed jsonschema functools32 23:12:00 INFO - Cleaning up... 23:12:00 INFO - Return code: 0 23:12:00 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 23:12:00 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')]} 23:12:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:12:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:12:00 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')]} 23:12:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:12:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:12:00 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 0x10bc6da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bd02618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb1604ba900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bbd1d30>, '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 0x10b936db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bbc9b20>, '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.roCslYPobt/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.X2nR6uwQPa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/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 23:12:00 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 23:12:00 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 23:12:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.roCslYPobt/Render', 23:12:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:12:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:12:00 INFO - 'HOME': '/Users/cltbld', 23:12:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:12:00 INFO - 'LOGNAME': 'cltbld', 23:12:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:12:00 INFO - 'MOZ_NO_REMOTE': '1', 23:12:00 INFO - 'NO_EM_RESTART': '1', 23:12:00 INFO - 'PAGER': '/bin/cat', 23:12:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:12:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:12:00 INFO - 'PWD': '/builds/slave/test', 23:12:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:12:00 INFO - 'SHELL': '/bin/bash', 23:12:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.X2nR6uwQPa/Listeners', 23:12:00 INFO - 'TMPDIR': '/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/', 23:12:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:12:00 INFO - 'USER': 'cltbld', 23:12:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:12:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:12:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:12:00 INFO - 'XPC_FLAGS': '0x0', 23:12:00 INFO - 'XPC_SERVICE_NAME': '0', 23:12:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:12:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:12:00 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 23:12:00 INFO - Cleaning up... 23:12:00 INFO - Return code: 0 23:12:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:12:00 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')]} 23:12:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:12:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:12:00 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')]} 23:12:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:12:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:12:00 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 0x10bc6da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bd02618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb1604ba900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bbd1d30>, '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 0x10b936db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bbc9b20>, '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.roCslYPobt/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.X2nR6uwQPa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/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 23:12:00 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 23:12:00 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 23:12:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.roCslYPobt/Render', 23:12:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:12:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:12:00 INFO - 'HOME': '/Users/cltbld', 23:12:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:12:00 INFO - 'LOGNAME': 'cltbld', 23:12:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:12:00 INFO - 'MOZ_NO_REMOTE': '1', 23:12:00 INFO - 'NO_EM_RESTART': '1', 23:12:00 INFO - 'PAGER': '/bin/cat', 23:12:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:12:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:12:00 INFO - 'PWD': '/builds/slave/test', 23:12:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:12:00 INFO - 'SHELL': '/bin/bash', 23:12:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.X2nR6uwQPa/Listeners', 23:12:00 INFO - 'TMPDIR': '/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/', 23:12:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:12:00 INFO - 'USER': 'cltbld', 23:12:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:12:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:12:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:12:00 INFO - 'XPC_FLAGS': '0x0', 23:12:00 INFO - 'XPC_SERVICE_NAME': '0', 23:12:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:12:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:12:00 INFO - Downloading/unpacking blobuploader==1.2.4 23:12:00 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 23:12:00 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 23:12:00 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 23:12:00 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 23:12:00 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 23:12:00 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 23:12:03 INFO - Downloading blobuploader-1.2.4.tar.gz 23:12:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:12:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:12:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:12:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:12:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:12:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:12:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:12:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:12:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:12:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:12:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:12:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:12:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:12:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:12:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:12:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:12:04 INFO - Downloading docopt-0.6.1.tar.gz 23:12:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:12:04 INFO - Installing collected packages: blobuploader, requests, docopt 23:12:04 INFO - Running setup.py install for blobuploader 23:12:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:12:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:12:04 INFO - Running setup.py install for requests 23:12:05 INFO - Running setup.py install for docopt 23:12:05 INFO - Successfully installed blobuploader requests docopt 23:12:05 INFO - Cleaning up... 23:12:05 INFO - Return code: 0 23:12:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:12:05 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')]} 23:12:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:12:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:12:05 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')]} 23:12:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:12:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:12:05 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 0x10bc6da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bd02618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb1604ba900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bbd1d30>, '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 0x10b936db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bbc9b20>, '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.roCslYPobt/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.X2nR6uwQPa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/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 23:12:05 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 23:12:05 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 23:12:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.roCslYPobt/Render', 23:12:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:12:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:12:05 INFO - 'HOME': '/Users/cltbld', 23:12:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:12:05 INFO - 'LOGNAME': 'cltbld', 23:12:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:12:05 INFO - 'MOZ_NO_REMOTE': '1', 23:12:05 INFO - 'NO_EM_RESTART': '1', 23:12:05 INFO - 'PAGER': '/bin/cat', 23:12:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:12:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:12:05 INFO - 'PWD': '/builds/slave/test', 23:12:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:12:05 INFO - 'SHELL': '/bin/bash', 23:12:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.X2nR6uwQPa/Listeners', 23:12:05 INFO - 'TMPDIR': '/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/', 23:12:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:12:05 INFO - 'USER': 'cltbld', 23:12:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:12:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:12:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:12:05 INFO - 'XPC_FLAGS': '0x0', 23:12:05 INFO - 'XPC_SERVICE_NAME': '0', 23:12:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:12:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:12:05 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-9eV1J1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:12:05 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-6SOWnn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:12:05 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-rVxhwM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:12:05 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-LaLzt5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:12:05 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-iYyKMI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:12:06 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-rhkjbX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:12:06 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-_Vzv8a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:12:06 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-HpDXwM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:12:06 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-PKXELO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:12:06 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-V2fr2p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:12:06 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-M6ltWb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:12:06 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-JjP5tl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:12:06 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-HW0UCU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:12:06 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-L0l4Bd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:12:06 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-V53ChW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:12:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:12:07 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-bTa3QQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:12:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:12:07 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-Ew0BTk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:12:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:12:07 INFO - Running setup.py install for manifestparser 23:12:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:12:07 INFO - Running setup.py install for mozcrash 23:12:07 INFO - Running setup.py install for mozdebug 23:12:07 INFO - Running setup.py install for mozdevice 23:12:07 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:12:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:12:07 INFO - Running setup.py install for mozfile 23:12:08 INFO - Running setup.py install for mozhttpd 23:12:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:12:08 INFO - Running setup.py install for mozinfo 23:12:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:12:08 INFO - Running setup.py install for mozInstall 23:12:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:12:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:12:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:12:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:12:08 INFO - Running setup.py install for mozleak 23:12:08 INFO - Running setup.py install for mozlog 23:12:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:12:08 INFO - Running setup.py install for moznetwork 23:12:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:12:08 INFO - Running setup.py install for mozprocess 23:12:09 INFO - Running setup.py install for mozprofile 23:12:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:12:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:12:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:12:09 INFO - Running setup.py install for mozrunner 23:12:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:12:09 INFO - Running setup.py install for mozscreenshot 23:12:09 INFO - Running setup.py install for moztest 23:12:09 INFO - Running setup.py install for mozversion 23:12:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:12:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:12:09 INFO - Cleaning up... 23:12:09 INFO - Return code: 0 23:12:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:12: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')]} 23:12:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:12:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:12: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')]} 23:12:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:12:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:12:09 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 0x10bc6da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bd02618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb1604ba900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bbd1d30>, '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 0x10b936db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bbc9b20>, '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.roCslYPobt/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.X2nR6uwQPa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/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 23:12:09 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 23:12:09 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 23:12:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.roCslYPobt/Render', 23:12:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:12:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:12:09 INFO - 'HOME': '/Users/cltbld', 23:12:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:12:09 INFO - 'LOGNAME': 'cltbld', 23:12:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:12:09 INFO - 'MOZ_NO_REMOTE': '1', 23:12:09 INFO - 'NO_EM_RESTART': '1', 23:12:09 INFO - 'PAGER': '/bin/cat', 23:12:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:12:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:12:09 INFO - 'PWD': '/builds/slave/test', 23:12:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:12:09 INFO - 'SHELL': '/bin/bash', 23:12:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.X2nR6uwQPa/Listeners', 23:12:09 INFO - 'TMPDIR': '/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/', 23:12:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:12:09 INFO - 'USER': 'cltbld', 23:12:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:12:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:12:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:12:09 INFO - 'XPC_FLAGS': '0x0', 23:12:09 INFO - 'XPC_SERVICE_NAME': '0', 23:12:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:12:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:12:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:12:10 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-yY5Qhk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:12:10 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)) 23:12:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:12:10 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-3kcwSU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:12:10 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)) 23:12:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:12:10 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-tLIVUW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:12:10 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)) 23:12:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:12:10 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-nAT7q8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:12:10 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)) 23:12:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:12:10 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-TERi5v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:12:10 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)) 23:12:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:12:10 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-cGtYkh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:12:10 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)) 23:12:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:12:10 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-duwIHP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:12:10 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)) 23:12:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:12:10 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-WXJ_te-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:12:10 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)) 23:12:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:12:10 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-wFsbEN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:12:11 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)) 23:12:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:12:11 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-uxmYtM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:12:11 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)) 23:12:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:12:11 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-yqCR_q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:12:11 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)) 23:12:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:12:11 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-jaCgU1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:12:11 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)) 23:12:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:12:11 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-_w8j4N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:12:11 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)) 23:12:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:12:11 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-5K5aXU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:12:11 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)) 23:12:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:12:11 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-TuBVm2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:12:11 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)) 23:12:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:12:11 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-CvSBVJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:12:11 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)) 23:12:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:12:11 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-rLdN5R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:12:11 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)) 23:12:11 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)) 23:12:11 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)) 23:12:11 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)) 23:12:11 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)) 23:12:11 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)) 23:12:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:12:11 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 23:12:11 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 23:12:11 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 23:12:11 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 23:12:11 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 23:12:11 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 23:12:14 INFO - Downloading blessings-1.6.tar.gz 23:12:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:12:14 INFO - Installing collected packages: blessings 23:12:14 INFO - Running setup.py install for blessings 23:12:14 INFO - Successfully installed blessings 23:12:14 INFO - Cleaning up... 23:12:15 INFO - Return code: 0 23:12:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:12:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:12:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:12:15 INFO - Reading from file tmpfile_stdout 23:12:15 INFO - Current package versions: 23:12:15 INFO - blessings == 1.6 23:12:15 INFO - blobuploader == 1.2.4 23:12:15 INFO - docopt == 0.6.1 23:12:15 INFO - functools32 == 3.2.3-2 23:12:15 INFO - jsonschema == 2.5.1 23:12:15 INFO - manifestparser == 1.1 23:12:15 INFO - mozInstall == 1.12 23:12:15 INFO - mozcrash == 0.17 23:12:15 INFO - mozdebug == 0.1 23:12:15 INFO - mozdevice == 0.48 23:12:15 INFO - mozfile == 1.2 23:12:15 INFO - mozhttpd == 0.7 23:12:15 INFO - mozinfo == 0.9 23:12:15 INFO - mozleak == 0.1 23:12:15 INFO - mozlog == 3.3 23:12:15 INFO - moznetwork == 0.27 23:12:15 INFO - mozprocess == 0.23 23:12:15 INFO - mozprofile == 0.28 23:12:15 INFO - mozrunner == 6.12 23:12:15 INFO - mozscreenshot == 0.1 23:12:15 INFO - mozsystemmonitor == 0.3 23:12:15 INFO - moztest == 0.7 23:12:15 INFO - mozversion == 1.4 23:12:15 INFO - psutil == 3.1.1 23:12:15 INFO - requests == 1.2.3 23:12:15 INFO - wsgiref == 0.1.2 23:12:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:12:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:12:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:12:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:12:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:12:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:12:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:12:15 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 0x10bc6da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bd02618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb1604ba900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bbd1d30>, '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 0x10b936db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bbc9b20>, '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.roCslYPobt/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.X2nR6uwQPa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/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 23:12:15 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 23:12:15 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 23:12:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.roCslYPobt/Render', 23:12:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:12:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:12:15 INFO - 'HOME': '/Users/cltbld', 23:12:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:12:15 INFO - 'LOGNAME': 'cltbld', 23:12:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:12:15 INFO - 'MOZ_NO_REMOTE': '1', 23:12:15 INFO - 'NO_EM_RESTART': '1', 23:12:15 INFO - 'PAGER': '/bin/cat', 23:12:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:12:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:12:15 INFO - 'PWD': '/builds/slave/test', 23:12:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:12:15 INFO - 'SHELL': '/bin/bash', 23:12:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.X2nR6uwQPa/Listeners', 23:12:15 INFO - 'TMPDIR': '/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/', 23:12:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:12:15 INFO - 'USER': 'cltbld', 23:12:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:12:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:12:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:12:15 INFO - 'XPC_FLAGS': '0x0', 23:12:15 INFO - 'XPC_SERVICE_NAME': '0', 23:12:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:12:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:12:15 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)) 23:12:15 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)) 23:12:15 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)) 23:12:15 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)) 23:12:15 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)) 23:12:15 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)) 23:12:15 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)) 23:12:15 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)) 23:12:15 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)) 23:12:15 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)) 23:12:15 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)) 23:12:15 INFO - Cleaning up... 23:12:15 INFO - Return code: 0 23:12:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:12:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:12:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:12:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:12:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:12:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:12:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:12:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10bc6da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bd02618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb1604ba900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bbd1d30>, '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 0x10b936db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bbc9b20>, '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.roCslYPobt/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.X2nR6uwQPa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/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 23:12:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 23:12:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 23:12:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.roCslYPobt/Render', 23:12:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:12:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:12:15 INFO - 'HOME': '/Users/cltbld', 23:12:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:12:15 INFO - 'LOGNAME': 'cltbld', 23:12:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:12:15 INFO - 'MOZ_NO_REMOTE': '1', 23:12:15 INFO - 'NO_EM_RESTART': '1', 23:12:15 INFO - 'PAGER': '/bin/cat', 23:12:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:12:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:12:15 INFO - 'PWD': '/builds/slave/test', 23:12:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:12:15 INFO - 'SHELL': '/bin/bash', 23:12:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.X2nR6uwQPa/Listeners', 23:12:15 INFO - 'TMPDIR': '/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/', 23:12:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:12:15 INFO - 'USER': 'cltbld', 23:12:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:12:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:12:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:12:15 INFO - 'XPC_FLAGS': '0x0', 23:12:15 INFO - 'XPC_SERVICE_NAME': '0', 23:12:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:12:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:12:15 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 23:12:15 INFO - Cleaning up... 23:12:15 INFO - Return code: 0 23:12:15 INFO - Running post-action listener: _resource_record_post_action 23:12:15 INFO - Running post-action listener: _start_resource_monitoring 23:12:15 INFO - Starting resource monitoring. 23:12:15 INFO - [mozharness: 2016-08-25 06:12:15.891470Z] Finished create-virtualenv step (success) 23:12:15 INFO - [mozharness: 2016-08-25 06:12:15.892495Z] Running install step. 23:12:15 INFO - Running pre-action listener: _resource_record_pre_action 23:12:15 INFO - Running main action method: install 23:12:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:12:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:12:16 INFO - Reading from file tmpfile_stdout 23:12:16 INFO - Detecting whether we're running mozinstall >=1.0... 23:12:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:12:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:12:16 INFO - Reading from file tmpfile_stdout 23:12:16 INFO - Output received: 23:12:16 INFO - Usage: mozinstall [options] installer 23:12:16 INFO - Options: 23:12:16 INFO - -h, --help show this help message and exit 23:12:16 INFO - -d DEST, --destination=DEST 23:12:16 INFO - Directory to install application into. [default: 23:12:16 INFO - "/builds/slave/test"] 23:12:16 INFO - --app=APP Application being installed. [default: firefox] 23:12:16 INFO - mkdir: /builds/slave/test/build/application 23:12:16 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'] 23:12:16 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 23:12:50 INFO - Reading from file tmpfile_stdout 23:12:50 INFO - Output received: 23:12:50 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 23:12:50 INFO - Running post-action listener: _resource_record_post_action 23:12:50 INFO - [mozharness: 2016-08-25 06:12:50.095138Z] Finished install step (success) 23:12:50 INFO - [mozharness: 2016-08-25 06:12:50.095274Z] Running run-tests step. 23:12:50 INFO - Running pre-action listener: _resource_record_pre_action 23:12:50 INFO - Running main action method: run_tests 23:12:50 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 23:12:50 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 23:12:50 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 23:12:50 INFO - 2016-08-24 23:12:50.109 screenresolution[1638:7459] starting screenresolution argv=screenresolution get 23:12:50 INFO - 2016-08-24 23:12:50.112 screenresolution[1638:7459] Display 0: 1600x1200x32@60 23:12:50 INFO - 2016-08-24 23:12:50.117 screenresolution[1639:7461] starting screenresolution argv=screenresolution list 23:12:50 INFO - Available Modes on Display 0 23:12:50 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 23:12:50 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 23:12:50 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 23:12:50 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 23:12:50 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 23:12:50 INFO - Intel Iris: 23:12:50 INFO - Chipset Model: Intel Iris 23:12:50 INFO - Type: GPU 23:12:50 INFO - Bus: Built-In 23:12:50 INFO - VRAM (Dynamic, Max): 1536 MB 23:12:50 INFO - Vendor: Intel (0x8086) 23:12:50 INFO - Device ID: 0x0a2e 23:12:50 INFO - Revision ID: 0x0009 23:12:50 INFO - Displays: 23:12:50 INFO - Display: 23:12:50 INFO - Resolution: 1600 x 1200 @ 60 Hz 23:12:50 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 23:12:50 INFO - Display Serial Number: 1600x1200 60 23:12:50 INFO - Main Display: Yes 23:12:50 INFO - Mirror: Off 23:12:50 INFO - Online: Yes 23:12:50 INFO - Rotation: Supported 23:12:50 INFO - Return code: 0 23:12:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:12:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:12:50 INFO - Python 2.7.3 23:12:50 INFO - Return code: 0 23:12:50 INFO - grabbing minidump binary from tooltool 23:12:50 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')]} 23:12:50 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 0x10bbd1d30>, '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 0x10b936db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bbc9b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:12:50 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 23:12:50 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 23:12:50 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 23:12:50 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:12:50 INFO - Return code: 0 23:12:50 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 23:12:50 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:12:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:12:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 23:12:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:12:50 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/Jgt5S5z9QQiw8vLRLMv8zA/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0045', '--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 23:12:50 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/Jgt5S5z9QQiw8vLRLMv8zA/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0045 --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 23:12:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.roCslYPobt/Render', 23:12:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:12:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:12:50 INFO - 'HOME': '/Users/cltbld', 23:12:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:12:50 INFO - 'LOGNAME': 'cltbld', 23:12:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:12:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 23:12:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:12:50 INFO - 'MOZ_NO_REMOTE': '1', 23:12:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:12:50 INFO - 'NO_EM_RESTART': '1', 23:12:50 INFO - 'PAGER': '/bin/cat', 23:12:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:12:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:12:50 INFO - 'PWD': '/builds/slave/test', 23:12:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:12:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:12:50 INFO - 'SHELL': '/bin/bash', 23:12:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.X2nR6uwQPa/Listeners', 23:12:50 INFO - 'TMPDIR': '/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/', 23:12:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:12:50 INFO - 'USER': 'cltbld', 23:12:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:12:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:12:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:12:50 INFO - 'XPC_FLAGS': '0x0', 23:12:50 INFO - 'XPC_SERVICE_NAME': '0', 23:12:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:12:50 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/Jgt5S5z9QQiw8vLRLMv8zA/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0045', '--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 23:12:50 INFO - mozversion application_buildid: 20160824203626 23:12:50 INFO - mozversion application_changeset: f992cf77d4548ecc1495642741de1534e013e60d 23:12:50 INFO - mozversion application_display_name: Nightly 23:12:50 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:12:50 INFO - mozversion application_name: Firefox 23:12:50 INFO - mozversion application_remotingname: firefox 23:12:50 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 23:12:50 INFO - mozversion application_vendor: Mozilla 23:12:50 INFO - mozversion application_version: 51.0a1 23:12:50 INFO - mozversion platform_buildid: 20160824203626 23:12:50 INFO - mozversion platform_changeset: f992cf77d4548ecc1495642741de1534e013e60d 23:12:50 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 23:12:50 INFO - mozversion platform_version: 51.0a1 23:12:50 INFO - using testdate: 1472105570 23:12:50 INFO - actual date: 1472105570 23:12:50 INFO - starting webserver on 'localhost:49271' 23:12:50 INFO - SUITE-START | Running 2 tests 23:12:50 INFO - TEST-START | dromaeo_css 23:12:50 INFO - operating with platform_type : mac_ 23:12:50 INFO - Initialising browser for dromaeo_css test... 23:12:50 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/tmpErYapd/profile http://localhost:49271/getInfo.html) 23:12:53 INFO - PROCESS | 1649 | __metrics Screen width/height:1600/1200 23:12:53 INFO - PROCESS | 1649 | colorDepth:24 23:12:53 INFO - PROCESS | 1649 | Browser inner width/height: 1024/689 23:12:53 INFO - PROCESS | 1649 | __metrics 23:12:53 ERROR - PROCESS | 1649 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2991: TypeError: this.tabs is undefined 23:12:54 INFO - TEST-INFO | 1649: exit 0 23:12:54 INFO - Browser initialized. 23:12:54 INFO - Running cycle 1/1 for dromaeo_css test... 23:12:54 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/tmpErYapd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:13:06 INFO - PROCESS | 1652 | RSS: Main: 244801536 23:13:06 INFO - PROCESS | 1652 | 23:13:55 INFO - PROCESS | 1652 | 1472105635887 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] 23:16:07 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49271/tests/dromaeo/cssquery-ext.html) 23:16:08 INFO - PROCESS | 1652 | RSS: Main: 265056256 23:16:08 INFO - PROCESS | 1652 | 23:19:11 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-ext.html (next: http://localhost:49271/tests/dromaeo/cssquery-jquery.html) 23:19:11 INFO - PROCESS | 1652 | RSS: Main: 270266368 23:19:11 INFO - PROCESS | 1652 | 23:22:13 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49271/tests/dromaeo/cssquery-mootools.html) 23:22:14 INFO - PROCESS | 1652 | RSS: Main: 275005440 23:22:14 INFO - PROCESS | 1652 | 23:25:16 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49271/tests/dromaeo/cssquery-prototype.html) 23:25:16 INFO - PROCESS | 1652 | RSS: Main: 271355904 23:25:16 INFO - PROCESS | 1652 | 23:28:19 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49271/tests/dromaeo/cssquery-yui.html) 23:28:20 INFO - PROCESS | 1652 | RSS: Main: 277516288 23:28:20 INFO - PROCESS | 1652 | 23:31:23 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-yui.html (next: http://localhost:49271/tests/dromaeo/cssquery-dojo.html) 23:31:23 INFO - PROCESS | 1652 | RSS: Main: 280317952 23:31:23 INFO - PROCESS | 1652 | 23:31:23 INFO - PROCESS | 1652 | __start_tp_report 23:31:23 INFO - PROCESS | 1652 | _x_x_mozilla_page_load 23:31:23 INFO - PROCESS | 1652 | _x_x_mozilla_page_load_details 23:31:23 INFO - PROCESS | 1652 | |i|pagename|runs| 23:31:23 INFO - PROCESS | 1652 | |0;dojo.html;3367.3602015617016;3387.2378714789174;3391.6608339166087;3400.4049291374004;3435.072530416787;5107.310513080733;5215.904660021391;5687.914681279784;5700.857478563033;5762.078067509199;5564.221009058725;5738.7991420300295;5770.798022069229;5850.531957443405;5875.647461152334;5136.640435169549;5235.397929238129;5242.606804489659;5250.816221432251;5332.840014799563;5217.217417387385;5385.246065550826;5404.135338345865;5409.161579955094;5418.349798024243;5292.947070529284;5297.947020529822;5313.38896026958;5316.707581083039;5341.412444631107;5172.301739265189;5194.298769666085;5210.140326846066;5210.218467229908;5274.5780337572905;5143.665661731976;5176.55999240065;5180.715060671661;5196.68819870809;5247.527722504993;4695.295705644146;5313.256144139824;5769.163471296681;5786.189933409326;5809.070548712228;5138.511841375063;5141.228815677641;5341.973290133564;6196.845078873019;6232.065190221503;5269.7365131743645;6224.87550248997;6287.654179020152;6297.6536290504;6313.779017734358;4694.554017368345;4873.8781530461665;5852.063669812809;5858.970705146489;5862.736176872051;6158.107074474266;6191.473724733448;6194.659293738888;6260.029695397221;6265.404786545271;5404.756785944642;5941.643501389931;6157.107219453154;6162.414570615784;6206.627602343783;6125.540584456184;6239.563230573816;6256.405641464054;6262.2172228471445;6271;6101.3079194897555;6107.006761825686;6127.417895299939;6136.386361363828;6149.385061493815;6116.9179262861035;6194.473469755121;6251.499880009588;6256.74973001084;6286.057091436322;4897.2654101885;4953.90092198154;5017.89964200714;5025.673331233458;5026.572741317029;4419.292913133883;4447.310666846644;4451.376807246988;4470.441194850644;4550.795214215368;5462.153366228241;5862.912056319158;5866.354700982888;5868.149118377812;5874;6125.082842094287;6168.629882207082;6188.4739797116845;6197.783077592263;6211.627302361872;5743;5785.971070144622;5836;5840.8247752567495;5886.941130588725;5418.783248670009;5451.318585176853;5453.100238460689;5459.836204913859;5468.316460442445;6114.847128821815;6294.527910406646;6314.242290925118;6318.526110541636;6339.144215530844;5260.316158899319;6138.2044803098925;6140.4428991762525;6193.38066193377;6210.5652604317265;6284.717187726655;6293.118963345227;6307.337729538516;6317.684115794284;6399.648019358794;6069.817905462844;6169.938300616936;6183.876322473615;6201.069839524108;6224.097505861715;6022.6386416813375;6096.10339372222;6169.598976066542;6183.134361189347;6186.319504854552;6101.84745381369;6112.572119951738;6116.128775280677;6120.395005630133;6136.386361363828;5985.850353741192;6110.103144028831;6118.877622447437;6120.995732432883;6135.355787642234;5116.820911268088;5703.62926409782;5873.823785286449;5927.110933360031;6013.887430825312;6124.693765311806;6128.387161283836;6139.140520327069;6144.446999770043;6156.476699480594;5826.679532625577;6038.909416358846;6047.516198704181;6051.3041000283765;6064.090386442069 23:31:23 INFO - PROCESS | 1652 | |1;ext.html;466.66400191861845;494.42646530025166;496.05501519605156;521.9739013049347;554.8113641361936;39133.412998805004;41152;42110.78944605277;42118.94702632436;42138.789306053426;43013.78493107538;43611.78194109033;43622.12755744883;43639.78180109095;43640.69077927659;9781.315307928466;9988.30081894264;9998.900010999869;10002.84995725061;10008.49957502122;9829.459379734111;9968;9968.6510972116;9972.900270997307;9987.400755954666;9949.403035817837;9973.850392244121;9989.051040151211;10001.549930253119;10034.949825250864;9932.354396964174;9945.701628951107;9946.204303655762;9967.700968970943;9993.950030249838;9799.265055120895;9859.26055545837;9867.16129129025;9886.209103271722;9902.316606176968;41018.9745256368;41195.764127075934;41321.38017929733;41455.96360090992;41493.1701365974;3447.1899103710607;3484.4947482615135;3490.3891818931584;3957.1294315250598;4144.668426525871;31481.685183148104;32240.838795806107;32258.709651613906;32311;32420.351592968007;3194.0375326629196;3297.2086699192023;3303.80177189367;3356.7146792522667;3388.762786604939;471020;515385;519915;520541;523748.9999999962;61846.69076654588;62044.37955620386;62396.37603623996;62424;62597.748045039756;34925.476117858256;35812.64187358145;65613.34386656072;65966.67016664887;66040.33959660341;16291.91854040746;16606.335746570003;16699.248533816008;16728.749068763977;16751.58121046959;12622.431990560446;12745.808812867814;12746.36268186587;12775.552855650008;12799.680007999874;16485;18878.150483228288;19360;19438.352340697114;19567.736007351068;6754.324567543206;7606.277403646644;7686.769396918102;7766.37868970481;7778.8055298616855;822.8272062866865;964.2816102003911;975.1516180922642;1061.2836335473678;1102.7463683352714;29425.705742942726;30252.941147059748;30482.390352192833;31164.220894477818;31217.68782312148;1027.6300531808542;1059.4861492176287;1075.3816555480473;1079.2660990526517;1105.5246244115108;14257.287135643177;15355.923220383827;15377.846221537866;15586.766198507032;16602.58493537671;721080;762920;787627;788729;1032956;61426.692866535384;62381;62543;62549;62841.05738413836;1344.2270694350786;1366.064245991479;1402.3338914015558;1403.1090257686442;1409.5559898631898;31011.379772403976;31982.840085799424;32067.67932320647;32658.83670581632;32786.34427311488;53764.19353709776;54268.72865635646;54404.91190176095;54499.72750136224;54531;616032;616692;616889;618113.0037847961;618891;26863.86568067147;27971.622412094384;27972;28024.859875701306;28035.579466307612;47678.52321476741;48178.518214817406;48432;48931;50026.74986625044;35738.64261357353;37977.62022379741;38651.6134838648;39663.603363965995;41109.794451027556;38783.224335513696;39259.41110883396;39294;40835.183296333315;40921.79539102285;30273;37774.811125944194;37854.43218351672;38543;38780.8365749028;33564.496532551544;36511;36551.63448365482;36879.81560092182;37115.628843711216;25799.097031603804;25997.74002260029;26132.86933565396;26321.60517592199;26767.330816729736 23:31:23 INFO - PROCESS | 1652 | |2;jquery.html;329.2706654759707;374.3729253500386;376.9114258149335;381.8925117160236;405.6065616352137;19766.06610654327;20288;20424.591508169848;20876.47808804777;20889;19589;19729.605407891868;20002;20201.696974545357;20704.068316925735;5248.239005344223;5850.18097466354;5988.161657367972;6059.272887253535;6067.18093057436;5993.940060599403;5998.040313549833;6032.185654936593;6050.757969681207;6053.334133245339;5752.194692743019;5892.793752218673;5897.557683173758;5900.380460051697;5923.318818335882;5822.864541414426;5877.52979761618;5932.288125424955;5934.673592952386;5949.7025148742605;4992.675476094042;5170.689758614495;5172.922406163911;5186.1442861927735;5196.168613021936;24615.507689846283;24759.50480990388;24865.378365541008;25004.87497562519;25136.748632513805;2247.0342635357697;2251.0995601759264;2269.5914735347633;2329.4060014696315;3024.729613562309;12599.748005039848;15118.622034449118;15144.091354518765;15719.449819256386;15818.734501239873;1910.6751852185162;1913.6268427656612;1916.492129585661;1919.378165209655;1946.6301402733577;99710;106417.93582064158;124847;129124.35437822845;129377;8270.214329638675;9527.333086684004;10636.574537018587;11271.436428178558;11409.657710268706;11466.967972882481;12220.877791222152;13881.930590346983;13983.930080349737;14061;8115.261368361761;8290.253877151084;8374.455660382057;8400.537970411564;8428.115047920002;8364.790880227922;8378.329733621296;8434.460882685393;8559.786005349915;8595.269402100766;3685.355062863988;4347.5217726050105;4404.559544045634;4410.007748256617;4478.126765280804;1691.644754601523;1875.6905110656862;1894.2517705506248;1901.8478521718507;1905.6950887857877;831.4304701279643;831.7587899509195;904.3179685784436;954.2699834626517;1042.8122937871256;17293.443590076953;17603.5037021852;20084.89957550203;20334.796652033587;20688.689669654967;906.795970906554;912.4297314178639;922.89386720528;957.7366224288237;958.3626888119462;8864.512451815212;9684.854727179098;11106.500207490682;11111.333320000826;11139.832902506469;543892;547246;552467;667594;668637;95440;121927.39036304761;130653.69346306605;136767.94848077287;156856;951.923846092311;978.9853152202722;1026.7689769801884;1027.8509616105623;1029.4080903480528;17803.643927121127;18309.54226144357;18752;18855.057247137862;19080.427587172406;53132.73433632962;53952;54136.729316353165;55348.63490698621;57710;71262;72755.27244727696;73388;73949.2605073964;74689;7838.960805195938;8009.038915330198;8039.758807235792;8069.717559885611;8217.013958325038;11306.660800176009;12859.678508037374;12906.935465322613;13086.934565327112;13159.802602960772;10667.199960002876;10962.342259464458;11106.555737770399;11228.326300421673;11251.887481125084;9411.670591529537;10684.252102353072;10758.8386174209;11100.333979961228;11182.937620925999;9291.907080929104;9600.903990960001;11500.53997840077;11501.942490287494;11704.590339338423;7719.150893401609;7791.766247012599;8065.87901181471;8156.755297341089;8218.58907054633;9611.519424028911;11056;11090.057345125755;11191.104711622887;11241.831372529256 23:31:23 INFO - PROCESS | 1652 | |3;mootools.html;1459.8029266049084;1523.918018207073;1710.3500669745495;1737.1227530097299;1774.6007148391604;7905.130435652074;8416.95791521043;8424.241818236358;8993.145651163146;8993.325500587449;8485.448445851016;8661.393702440815;8765.868511972325;8773.56132193391;8811.118888111201;2350.3066595354326;2392.7009123859516;2393.664886915833;2398.9640155397597;2400.975990240093;2357.7642235776457;2377.6314671225987;2398.2205783120557;2402.939926501834;2407.2537513370826;2379.0840526397287;2385.666006759055;2393.904243830245;2404.2787163850776;2406.867622280774;2361.53949979754;2374.536965291769;2379.1910750344878;2385.5228954209056;2388.7014123234508;2027.9251996441762;2356.4580146566213;2365.349528879555;2366.4557151854997;2368.5973384524673;7946.602669866484;8761.08008659088;8818.162274583905;8840.8673869892;8871.778205544848;5289.761960711778;5403.081476149064;5405.37838148614;5437.673739575638;5448.972755136238;3519.1554027033585;3644.763090399142;3682.815859207029;3743.700503959704;3746.2507498500136;1089.319175515303;1106.1482658353104;1111.011200031964;1115.9497822598003;1118.7874303882318;11398.886011139866;11492.195546311761;11581.189316747746;11584.18910676253;11608.361540115291;4332.176886391576;4574.565416285448;4709.858704238878;4774.782430480274;4830.686005409637;9961.452120133317;10049.748756281151;10081.899181008243;10082.143017843566;10083.747906302255;5420.322459692538;5422.891542169214;5423.728813559385;5426.565874730012;5438.483344082306;4389.100234451929;4764.571188593043;4884.169691152512;4917.680350777259;4949.901001980013;3832.1186127190344;3907.8632247871187;3931.312020396419;3985.4818873546255;4009.298372784751;1269.320913311374;1294.2169987157822;1296.7017585955095;1300.998231361865;1302.9934850325687;797.8523973065002;894.1594900793234;913.0321858829661;933.5017297237971;955.9187469065068;5616.97191514048;5751.597388182787;5903.645781253139;5981.7607295707685;6109.633421994606;382.7148774163266;426.77807540079607;447.5189171640499;451.2419135851735;469.6172619315315;3429.5027221052806;3876.1666241758157;4057.797110144481;4060.918781624351;4130.194612050681;10330.690079297634;10772.622958196425;10774.78450430987;10775.78448431027;10805.945970270099;9305.860412093823;9995.90045095039;10129.341592796445;10753.462326883624;10762.139028877828;7901.723439679584;8174.182581741898;8183.263506284463;8194.672213111528;8213.014438267446;5687.175359572756;5767.423257674199;5845.357010728731;5858.502027327725;5915.112733090071;9851.359661621971;9869.259805514472;9894.653687120915;9919.305648604528;9927.305088643725;9623.663171788954;10055.497225138568;10143.949280253551;10158.187345012233;10159.390436573829;6937;7322.231165727522;7464.6267686614365;7564.054493188351;7635;8378.958105209435;8448.535330556633;8455.154484551496;8456.281216096455;8464.026636936585;7374.852502950018;7444.994925684963;7475.36459400957;7497.512661676974;7615.42884283692;6995.580265184105;7305.159906610807;7381.520201186906;7455.254474552501;7590.582517961565;5812.21535092757;6287.748490060347;6890.896636550356;7069.434445244471;7085;4597.770111494478;4598.678092533491;4617.746023968714;4642.558956899089;4704;4256.446661934053;4820.493848145894;4825.276208568743;4886.560209581155;4942.8764280893265 23:31:23 INFO - PROCESS | 1652 | |4;prototype.html;297.6681000684237;315.19782154417004;319.2195083022011;324.1539581691784;325.0702989450174;5435.320584926884;5560.972195139028;5632.35227948786;5716.799912003081;5730.312362516499;4673.83641572545;4809.653297076816;4821.300071959705;5389;5635.802746903859;3441.397755392809;3699.223163135745;3922.450856880032;4145.39891715701;4255.319148936171;4256.744595324275;4263.126059157865;4273.871783846474;4278.187144442546;4290.42079319291;3977.960220397788;4039.151778126597;4285.207236661212;4285.550017248191;4288.228118938589;3846.288401661262;4149.647279981205;4234.767087810169;4242.981684395722;4285.228658841407;3487.2676737885076;3602.585702644177;3677.2093999790172;3692.6521819535947;3708.61059588742;4828.95374333822;5260.763265653055;5490.725463726798;5511.862203444906;5525.309336332958;4324.43771820729;4810.35060266863;4893.143699852511;4951.727654978975;4954.455009948902;4715.420334188051;5205;5716.911948365916;5947.918228619992;5955.493783028448;4069.267531844267;4104.4664193654635;4109.958900410988;4113.6297733203855;4117.91764164718;5824.592278540504;5936.851578710523;6192.9999999999545;6195.876082478325;6227.688615569204;3544.220271540257;3897.3569361055675;4178.811953462102;4182;4193.986886294596;3760.360738674377;4055.2497787909333;4253.744775313429;4271.252530807158;4289.871303860889;4712.59942904857;4782.947751494666;4943.876403089952;4962.702237865739;4969.378827646544;4914.36113305268;5175.560077393388;5251.76367063483;5718.999175144333;5967.38972921385;1305.8889994350398;1390.7218556288783;1412.9576112716634;1452.7651496228332;1462.7147706197402;792.8820363287851;806.2381049907781;830.9127541608044;896.2740180453853;909.6907051602487;4439.045605194899;4870.1233777920315;5320.946790532123;5505.752241149158;5531.806386776443;4763.476017638057;5565.053940830068;6128.080787881853;6128.896798576299;6150;5181.455947125498;5481.862953426196;5502.2296878437055;5512.751926163332;5556.222128901957;3159.4470967580583;3237.2068843133584;3237.4658181399805;3239.4330992076293;3255.886043988449;5450.482204190595;5461.918071228934;6371.73094027003;6385.573482076874;6392.680365981682;5406.513413792777;6141.7543298268465;6151.108089327112;6370.745170193233;6415.358464153547;5981.730822113015;6470.773522926675;6476.190476190476;6503.317151699192;6560.770373036921;5332.240360680888;6001.969990150022;6031.065184896348;6106.847328816815;6151.477124444473;5423.701696406578;5758.531574448489;6185.443310102112;6200.0699895016105;6210.5652604317265;5461.726913654381;5611.270534830609;6290.748370065146;6379.489640828815;6515.934840651723;3301.8018918864946;4056.492938382702;4059.2490389276895;4063.7358571692744;4084.36692312692;5197.350331208599;6221.844453888689;6222.733065140656;6238.875222495434;6269.216347956505;5725.942740572541;5990.7903223386975;6014.578979471395;6112.113743507078;6124.448799608057;5249.868753281045;5984.700764961822;6007.339192688888;6036.426539478743;6044.727987240497;4501.392312037964;5691.3170419549915;5833.0375488044;5931.703414829328;5963.1514230588655;4779.450363208137;4864.683795553277;4932.8520144395725;5014.648974571745;5618.269624948731;5383.515483606494;5847.8245652630485;5849.707514624167;5889.705514724161;5896.852578685567 23:31:23 INFO - PROCESS | 1652 | |5;yui.html;703.852191039882;708.1325376413894;709.7267551992483;745.6942653512061;757.3751654884718;15062.849371506281;16195.433159839407;16364.590885227875;16375.724855029011;16399.67200655986;14724.705505889875;14808.925955370236;14824.258787060659;14861.702765944674;14879.628009299773;666.4901350466872;851.0893344121807;853.3642436384902;876.8509353409936;878.6265837019273;872.9912700872974;875.9649614015464;878.2622597018503;880.0495464897895;888.1118881118881;758.1205801270527;825.5789547330844;924.2929159193222;932.8507438809792;933.8926023507282;902.8871391076116;921.230772305126;921.235374639048;924.6255266616997;928.7585227840742;662.8276648071488;674.3762020131408;692.4114502672738;692.6813665713778;693.7259782385929;13326.666833329147;14749.55751327451;15236.619084522976;15278.465253716178;15287.694246115127;14866.182359970197;14868.553943381608;14908.925455372762;14914.254287285592;15206.467773627981;11299;11974.281543107441;12036.39818009096;12156.113862863302;12423.75152496954;3744.6255374462608;3905.9609403906165;4034.426573636284;4074.4092106644666;4075.2460794753065;120090;123123;123699;124341;124346.37826810808;9504.239660827117;10608.57565697379;11337.659870203906;11366.488508017159;11819.172657914036;21196.940152992287;23797.762022379902;23852.761472385053;23853.880730596236;23858.045678173024;7734.690612375554;8303.792405189919;8308.086110527836;8313.958430207811;8427.24154826067;4570.885727856764;4596.241620132708;4613.953860461353;4627.167109920179;4757.14371413149;3451.3269912366845;3537.699295559855;3561.2521370511963;3564.7861128332383;3881.165549406891;718.3534818663245;724.6594100772628;729.580491217552;751.7744676596999;758.525921299188;562.2774734466192;646.7930262316107;667.6928612838052;669.1902797614844;679.1035832700787;9368.812623747486;9455.385399948982;9580.425174489554;9916.702498925044;9925.454100024424;602.5051530046009;649.4122818848949;651.794684674326;672.7395949609308;712.4585315160411;3944.526656801202;4676.485586585472;4870.439899411542;4913.313543043865;4919.2867034279825;105060.47469762602;151748.72376914354;160736;160743.39256607517;161557;112663;113439;113985.43007285077;117647.8235217654;122094.38952805179;103819.48090259501;124531;124890.37554812168;124970.3751481255;127200.36399817941;9102.31732620043;9173.31200160004;9184.357095003286;9217;9218.262538996998;67484;67605.3239467599;67781;68956.6552167236;70594.94107588287;62825.68587157035;63959;67910;69107.30892691009;101381;12140.453679584263;12184.634460966185;12441.37793110359;12492.875071249171;12523.311217883103;13464.730705386033;13655.931720341334;13749.656258593215;13969.790453143009;14222.431102756187;12351.444185011876;12581;12692.238465692088;12915.22508649484;13099.148555343872;12422.689432763891;12538.56115036006;13127.474901004234;13317.933410332886;13332.533361332307;11978.64064078079;12311.938440307742;12374.62876113718;12619;12693.048021398617;10446.112080473245;10642.361458312216;10686.465676715978;10846.240763146505;10913.618023369145;9340.267459138187;9807.754806129904;10782.892171078189;10818;10872.61945831892 23:31:23 INFO - PROCESS | 1652 | __end_tp_report 23:31:23 INFO - PROCESS | 1652 | __start_cc_report 23:31:23 INFO - PROCESS | 1652 | _x_x_mozilla_cycle_collect,404 23:31:23 INFO - PROCESS | 1652 | __end_cc_report 23:31:23 INFO - PROCESS | 1652 | __startTimestamp1472106683469__endTimestamp 23:31:23 INFO - PROCESS | 1652 | 23:31:23 INFO - PROCESS | 1652 | ------- Summary: start ------- 23:31:23 INFO - PROCESS | 1652 | Number of tests: 6 23:31:23 INFO - PROCESS | 1652 | 23:31:23 INFO - PROCESS | 1652 | [#0] dojo.html Cycles:165 Average:5696.48 Median:5874.00 stddev:634.77 (10.8%) stddev-sans-first:609.85 23:31:23 INFO - PROCESS | 1652 | Values: 3367.4 3387.2 3391.7 3400.4 3435.1 5107.3 5215.9 5687.9 5700.9 5762.1 5564.2 5738.8 5770.8 5850.5 5875.6 5136.6 5235.4 5242.6 5250.8 5332.8 5217.2 5385.2 5404.1 5409.2 5418.3 5292.9 5297.9 5313.4 5316.7 5341.4 5172.3 5194.3 5210.1 5210.2 5274.6 5143.7 5176.6 5180.7 5196.7 5247.5 4695.3 5313.3 5769.2 5786.2 5809.1 5138.5 5141.2 5342.0 6196.8 6232.1 5269.7 6224.9 6287.7 6297.7 6313.8 4694.6 4873.9 5852.1 5859.0 5862.7 6158.1 6191.5 6194.7 6260.0 6265.4 5404.8 5941.6 6157.1 6162.4 6206.6 6125.5 6239.6 6256.4 6262.2 6271.0 6101.3 6107.0 6127.4 6136.4 6149.4 6116.9 6194.5 6251.5 6256.7 6286.1 4897.3 4953.9 5017.9 5025.7 5026.6 4419.3 4447.3 4451.4 4470.4 4550.8 5462.2 5862.9 5866.4 5868.1 5874.0 6125.1 6168.6 6188.5 6197.8 6211.6 5743.0 5786.0 5836.0 5840.8 5886.9 5418.8 5451.3 5453.1 5459.8 5468.3 6114.8 6294.5 6314.2 6318.5 6339.1 5260.3 6138.2 6140.4 6193.4 6210.6 6284.7 6293.1 6307.3 6317.7 6399.6 6069.8 6169.9 6183.9 6201.1 6224.1 6022.6 6096.1 6169.6 6183.1 6186.3 6101.8 6112.6 6116.1 6120.4 6136.4 5985.9 6110.1 6118.9 6121.0 6135.4 5116.8 5703.6 5873.8 5927.1 6013.9 6124.7 6128.4 6139.1 6144.4 6156.5 5826.7 6038.9 6047.5 6051.3 6064.1 23:31:23 INFO - PROCESS | 1652 | 23:31:23 INFO - PROCESS | 1652 | [#1] ext.html Cycles:180 Average:77364.92 Median:40249.39 stddev:178589.90 (443.7%) stddev-sans-first:178997.57 23:31:23 INFO - PROCESS | 1652 | Values: 466.7 494.4 496.1 522.0 554.8 39133.4 41152.0 42110.8 42118.9 42138.8 43013.8 43611.8 43622.1 43639.8 43640.7 9781.3 9988.3 9998.9 10002.8 10008.5 9829.5 9968.0 9968.7 9972.9 9987.4 9949.4 9973.9 9989.1 10001.5 10034.9 9932.4 9945.7 9946.2 9967.7 9994.0 9799.3 9859.3 9867.2 9886.2 9902.3 41019.0 41195.8 41321.4 41456.0 41493.2 3447.2 3484.5 3490.4 3957.1 4144.7 31481.7 32240.8 32258.7 32311.0 32420.4 3194.0 3297.2 3303.8 3356.7 3388.8 471020.0 515385.0 519915.0 520541.0 523749.0 61846.7 62044.4 62396.4 62424.0 62597.7 34925.5 35812.6 65613.3 65966.7 66040.3 16291.9 16606.3 16699.2 16728.7 16751.6 12622.4 12745.8 12746.4 12775.6 12799.7 16485.0 18878.2 19360.0 19438.4 19567.7 6754.3 7606.3 7686.8 7766.4 7778.8 822.8 964.3 975.2 1061.3 1102.7 29425.7 30252.9 30482.4 31164.2 31217.7 1027.6 1059.5 1075.4 1079.3 1105.5 14257.3 15355.9 15377.8 15586.8 16602.6 721080.0 762920.0 787627.0 788729.0 1032956.0 61426.7 62381.0 62543.0 62549.0 62841.1 1344.2 1366.1 1402.3 1403.1 1409.6 31011.4 31982.8 32067.7 32658.8 32786.3 53764.2 54268.7 54404.9 54499.7 54531.0 616032.0 616692.0 616889.0 618113.0 618891.0 26863.9 27971.6 27972.0 28024.9 28035.6 47678.5 48178.5 48432.0 48931.0 50026.7 35738.6 37977.6 38651.6 39663.6 41109.8 38783.2 39259.4 39294.0 40835.2 40921.8 30273.0 37774.8 37854.4 38543.0 38780.8 33564.5 36511.0 36551.6 36879.8 37115.6 25799.1 25997.7 26132.9 26321.6 26767.3 23:31:23 INFO - PROCESS | 1652 | 23:31:23 INFO - PROCESS | 1652 | [#2] jquery.html Cycles:180 Average:34810.46 Median:2029.86 stddev:100026.96 (4927.8%) stddev-sans-first:100274.06 23:31:23 INFO - PROCESS | 1652 | Values: 329.3 374.4 376.9 381.9 405.6 19766.1 20288.0 20424.6 20876.5 20889.0 19589.0 19729.6 20002.0 20201.7 20704.1 5248.2 5850.2 5988.2 6059.3 6067.2 5993.9 5998.0 6032.2 6050.8 6053.3 5752.2 5892.8 5897.6 5900.4 5923.3 5822.9 5877.5 5932.3 5934.7 5949.7 4992.7 5170.7 5172.9 5186.1 5196.2 24615.5 24759.5 24865.4 25004.9 25136.7 2247.0 2251.1 2269.6 2329.4 3024.7 12599.7 15118.6 15144.1 15719.4 15818.7 1910.7 1913.6 1916.5 1919.4 1946.6 99710.0 106417.9 124847.0 129124.4 129377.0 8270.2 9527.3 10636.6 11271.4 11409.7 11467.0 12220.9 13881.9 13983.9 14061.0 8115.3 8290.3 8374.5 8400.5 8428.1 8364.8 8378.3 8434.5 8559.8 8595.3 3685.4 4347.5 4404.6 4410.0 4478.1 1691.6 1875.7 1894.3 1901.8 1905.7 831.4 831.8 904.3 954.3 1042.8 17293.4 17603.5 20084.9 20334.8 20688.7 906.8 912.4 922.9 957.7 958.4 8864.5 9684.9 11106.5 11111.3 11139.8 543892.0 547246.0 552467.0 667594.0 668637.0 95440.0 121927.4 130653.7 136767.9 156856.0 951.9 979.0 1026.8 1027.9 1029.4 17803.6 18309.5 18752.0 18855.1 19080.4 53132.7 53952.0 54136.7 55348.6 57710.0 71262.0 72755.3 73388.0 73949.3 74689.0 7839.0 8009.0 8039.8 8069.7 8217.0 11306.7 12859.7 12906.9 13086.9 13159.8 10667.2 10962.3 11106.6 11228.3 11251.9 9411.7 10684.3 10758.8 11100.3 11182.9 9291.9 9600.9 11500.5 11501.9 11704.6 7719.2 7791.8 8065.9 8156.8 8218.6 9611.5 11056.0 11090.1 11191.1 11241.8 23:31:23 INFO - PROCESS | 1652 | 23:31:23 INFO - PROCESS | 1652 | [#3] mootools.html Cycles:180 Average:5659.53 Median:4737.21 stddev:3181.39 (67.2%) stddev-sans-first:3174.66 23:31:23 INFO - PROCESS | 1652 | Values: 1459.8 1523.9 1710.4 1737.1 1774.6 7905.1 8417.0 8424.2 8993.1 8993.3 8485.4 8661.4 8765.9 8773.6 8811.1 2350.3 2392.7 2393.7 2399.0 2401.0 2357.8 2377.6 2398.2 2402.9 2407.3 2379.1 2385.7 2393.9 2404.3 2406.9 2361.5 2374.5 2379.2 2385.5 2388.7 2027.9 2356.5 2365.3 2366.5 2368.6 7946.6 8761.1 8818.2 8840.9 8871.8 5289.8 5403.1 5405.4 5437.7 5449.0 3519.2 3644.8 3682.8 3743.7 3746.3 1089.3 1106.1 1111.0 1115.9 1118.8 11398.9 11492.2 11581.2 11584.2 11608.4 4332.2 4574.6 4709.9 4774.8 4830.7 9961.5 10049.7 10081.9 10082.1 10083.7 5420.3 5422.9 5423.7 5426.6 5438.5 4389.1 4764.6 4884.2 4917.7 4949.9 3832.1 3907.9 3931.3 3985.5 4009.3 1269.3 1294.2 1296.7 1301.0 1303.0 797.9 894.2 913.0 933.5 955.9 5617.0 5751.6 5903.6 5981.8 6109.6 382.7 426.8 447.5 451.2 469.6 3429.5 3876.2 4057.8 4060.9 4130.2 10330.7 10772.6 10774.8 10775.8 10805.9 9305.9 9995.9 10129.3 10753.5 10762.1 7901.7 8174.2 8183.3 8194.7 8213.0 5687.2 5767.4 5845.4 5858.5 5915.1 9851.4 9869.3 9894.7 9919.3 9927.3 9623.7 10055.5 10143.9 10158.2 10159.4 6937.0 7322.2 7464.6 7564.1 7635.0 8379.0 8448.5 8455.2 8456.3 8464.0 7374.9 7445.0 7475.4 7497.5 7615.4 6995.6 7305.2 7381.5 7455.3 7590.6 5812.2 6287.7 6890.9 7069.4 7085.0 4597.8 4598.7 4617.7 4642.6 4704.0 4256.4 4820.5 4825.3 4886.6 4942.9 23:31:23 INFO - PROCESS | 1652 | 23:31:23 INFO - PROCESS | 1652 | [#4] prototype.html Cycles:180 Average:4771.46 Median:5290.86 stddev:1484.08 (28.0%) stddev-sans-first:1449.76 23:31:23 INFO - PROCESS | 1652 | Values: 297.7 315.2 319.2 324.2 325.1 5435.3 5561.0 5632.4 5716.8 5730.3 4673.8 4809.7 4821.3 5389.0 5635.8 3441.4 3699.2 3922.5 4145.4 4255.3 4256.7 4263.1 4273.9 4278.2 4290.4 3978.0 4039.2 4285.2 4285.6 4288.2 3846.3 4149.6 4234.8 4243.0 4285.2 3487.3 3602.6 3677.2 3692.7 3708.6 4829.0 5260.8 5490.7 5511.9 5525.3 4324.4 4810.4 4893.1 4951.7 4954.5 4715.4 5205.0 5716.9 5947.9 5955.5 4069.3 4104.5 4110.0 4113.6 4117.9 5824.6 5936.9 6193.0 6195.9 6227.7 3544.2 3897.4 4178.8 4182.0 4194.0 3760.4 4055.2 4253.7 4271.3 4289.9 4712.6 4782.9 4943.9 4962.7 4969.4 4914.4 5175.6 5251.8 5719.0 5967.4 1305.9 1390.7 1413.0 1452.8 1462.7 792.9 806.2 830.9 896.3 909.7 4439.0 4870.1 5320.9 5505.8 5531.8 4763.5 5565.1 6128.1 6128.9 6150.0 5181.5 5481.9 5502.2 5512.8 5556.2 3159.4 3237.2 3237.5 3239.4 3255.9 5450.5 5461.9 6371.7 6385.6 6392.7 5406.5 6141.8 6151.1 6370.7 6415.4 5981.7 6470.8 6476.2 6503.3 6560.8 5332.2 6002.0 6031.1 6106.8 6151.5 5423.7 5758.5 6185.4 6200.1 6210.6 5461.7 5611.3 6290.7 6379.5 6515.9 3301.8 4056.5 4059.2 4063.7 4084.4 5197.4 6221.8 6222.7 6238.9 6269.2 5725.9 5990.8 6014.6 6112.1 6124.4 5249.9 5984.7 6007.3 6036.4 6044.7 4501.4 5691.3 5833.0 5931.7 5963.2 4779.5 4864.7 4932.9 5014.6 5618.3 5383.5 5847.8 5849.7 5889.7 5896.9 23:31:23 INFO - PROCESS | 1652 | 23:31:23 INFO - PROCESS | 1652 | [#5] yui.html Cycles:180 Average:24795.32 Median:3563.02 stddev:39876.03 (1119.2%) stddev-sans-first:39946.87 23:31:23 INFO - PROCESS | 1652 | Values: 703.9 708.1 709.7 745.7 757.4 15062.8 16195.4 16364.6 16375.7 16399.7 14724.7 14808.9 14824.3 14861.7 14879.6 666.5 851.1 853.4 876.9 878.6 873.0 876.0 878.3 880.0 888.1 758.1 825.6 924.3 932.9 933.9 902.9 921.2 921.2 924.6 928.8 662.8 674.4 692.4 692.7 693.7 13326.7 14749.6 15236.6 15278.5 15287.7 14866.2 14868.6 14908.9 14914.3 15206.5 11299.0 11974.3 12036.4 12156.1 12423.8 3744.6 3906.0 4034.4 4074.4 4075.2 120090.0 123123.0 123699.0 124341.0 124346.4 9504.2 10608.6 11337.7 11366.5 11819.2 21196.9 23797.8 23852.8 23853.9 23858.0 7734.7 8303.8 8308.1 8314.0 8427.2 4570.9 4596.2 4614.0 4627.2 4757.1 3451.3 3537.7 3561.3 3564.8 3881.2 718.4 724.7 729.6 751.8 758.5 562.3 646.8 667.7 669.2 679.1 9368.8 9455.4 9580.4 9916.7 9925.5 602.5 649.4 651.8 672.7 712.5 3944.5 4676.5 4870.4 4913.3 4919.3 105060.5 151748.7 160736.0 160743.4 161557.0 112663.0 113439.0 113985.4 117647.8 122094.4 103819.5 124531.0 124890.4 124970.4 127200.4 9102.3 9173.3 9184.4 9217.0 9218.3 67484.0 67605.3 67781.0 68956.7 70594.9 62825.7 63959.0 67910.0 69107.3 101381.0 12140.5 12184.6 12441.4 12492.9 12523.3 13464.7 13655.9 13749.7 13969.8 14222.4 12351.4 12581.0 12692.2 12915.2 13099.1 12422.7 12538.6 13127.5 13317.9 13332.5 11978.6 12311.9 12374.6 12619.0 12693.0 10446.1 10642.4 10686.5 10846.2 10913.6 9340.3 9807.8 10782.9 10818.0 10872.6 23:31:23 INFO - PROCESS | 1652 | -------- Summary: end -------- 23:31:23 INFO - PROCESS | 1652 | 23:31:24 INFO - TEST-INFO | 1652: exit 0 23:31:24 INFO - TEST-OK | dromaeo_css | took 1113425ms 23:31:24 INFO - TEST-START | kraken 23:31:24 INFO - operating with platform_type : mac_ 23:31:24 INFO - Initialising browser for kraken test... 23:31:24 INFO - TEST-INFO | started process 1664 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/tmpGItU2c/profile http://localhost:49271/getInfo.html) 23:31:26 INFO - PROCESS | 1664 | __metrics Screen width/height:1600/1200 23:31:26 INFO - PROCESS | 1664 | colorDepth:24 23:31:26 INFO - PROCESS | 1664 | Browser inner width/height: 1024/689 23:31:26 INFO - PROCESS | 1664 | __metrics 23:31:26 ERROR - PROCESS | 1664 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2991: TypeError: this.tabs is undefined 23:31:27 INFO - TEST-INFO | 1664: exit 0 23:31:27 INFO - Browser initialized. 23:31:27 INFO - Running cycle 1/1 for kraken test... 23:31:27 INFO - TEST-INFO | started process 1666 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/tmpGItU2c/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:31:39 INFO - PROCESS | 1666 | RSS: Main: 244973568 23:31:39 INFO - PROCESS | 1666 | 23:31:42 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection) 23:31:43 INFO - PROCESS | 1666 | RSS: Main: 257589248 23:31:43 INFO - PROCESS | 1666 | 23:31:45 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-dft) 23:31:46 INFO - PROCESS | 1666 | RSS: Main: 266182656 23:31:46 INFO - PROCESS | 1666 | 23:31:50 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-fft) 23:31:50 INFO - PROCESS | 1666 | RSS: Main: 263233536 23:31:50 INFO - PROCESS | 1666 | 23:31:52 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator) 23:31:53 INFO - PROCESS | 1666 | RSS: Main: 264093696 23:31:53 INFO - PROCESS | 1666 | 23:31:55 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:31:56 INFO - PROCESS | 1666 | RSS: Main: 265838592 23:31:56 INFO - PROCESS | 1666 | 23:31:58 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom) 23:31:59 INFO - PROCESS | 1666 | RSS: Main: 265846784 23:31:59 INFO - PROCESS | 1666 | 23:32:02 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate) 23:32:03 INFO - PROCESS | 1666 | RSS: Main: 267165696 23:32:03 INFO - PROCESS | 1666 | 23:32:06 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial) 23:32:07 INFO - PROCESS | 1666 | RSS: Main: 267538432 23:32:07 INFO - PROCESS | 1666 | 23:32:08 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:32:09 INFO - PROCESS | 1666 | RSS: Main: 266997760 23:32:09 INFO - PROCESS | 1666 | 23:32:11 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:32:12 INFO - PROCESS | 1666 | RSS: Main: 267145216 23:32:12 INFO - PROCESS | 1666 | 23:32:14 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:32:14 INFO - PROCESS | 1666 | RSS: Main: 267444224 23:32:14 INFO - PROCESS | 1666 | 23:32:17 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:32:18 INFO - PROCESS | 1666 | RSS: Main: 267653120 23:32:18 INFO - PROCESS | 1666 | 23:32:21 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:32:21 INFO - PROCESS | 1666 | RSS: Main: 267735040 23:32:21 INFO - PROCESS | 1666 | 23:32:23 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49271/tests/kraken/driver.html?testName=ai-astar) 23:32:24 INFO - PROCESS | 1666 | RSS: Main: 269688832 23:32:24 INFO - PROCESS | 1666 | 23:32:24 INFO - PROCESS | 1666 | __start_tp_report 23:32:24 INFO - PROCESS | 1666 | _x_x_mozilla_page_load 23:32:24 INFO - PROCESS | 1666 | _x_x_mozilla_page_load_details 23:32:24 INFO - PROCESS | 1666 | |i|pagename|runs| 23:32:24 INFO - PROCESS | 1666 | |0;ai-astar;116;111;116;117;118;138;112;169;167;130 23:32:24 INFO - PROCESS | 1666 | |1;audio-beat-detection;147;111;133;159;110;136;125;108;155;109 23:32:24 INFO - PROCESS | 1666 | |2;audio-dft;192;199;203;252;273;235;203;194;273;251 23:32:24 INFO - PROCESS | 1666 | |3;audio-fft;69;84;103;176;81;50;71;95;158;77 23:32:24 INFO - PROCESS | 1666 | |4;audio-oscillator;69;72;120;94;86;93;115;72;73;115 23:32:24 INFO - PROCESS | 1666 | |5;imaging-gaussian-blur;88;90;88;84;90;85;88;99;89;84 23:32:24 INFO - PROCESS | 1666 | |6;imaging-darkroom;109;98;130;96;150;105;99;149;151;103 23:32:24 INFO - PROCESS | 1666 | |7;imaging-desaturate;97;96;104;121;120;99;145;118;144;112 23:32:24 INFO - PROCESS | 1666 | |8;json-parse-financial;56;55;57;58;56;58;56;56;54;57 23:32:24 INFO - PROCESS | 1666 | |9;json-stringify-tinderbox;61;76;98;73;79;71;75;70;73;71 23:32:24 INFO - PROCESS | 1666 | |10;stanford-crypto-aes;89;90;92;90;86;89;88;90;92;92 23:32:24 INFO - PROCESS | 1666 | |11;stanford-crypto-ccm;139;145;138;157;181;131;125;162;170;158 23:32:24 INFO - PROCESS | 1666 | |12;stanford-crypto-pbkdf2;171;169;166;165;194;177;167;171;169;172 23:32:24 INFO - PROCESS | 1666 | |13;stanford-crypto-sha256-iterative;70;67;70;67;68;70;72;79;88;84 23:32:24 INFO - PROCESS | 1666 | __end_tp_report 23:32:24 INFO - PROCESS | 1666 | __start_cc_report 23:32:24 INFO - PROCESS | 1666 | _x_x_mozilla_cycle_collect,1075 23:32:24 INFO - PROCESS | 1666 | __end_cc_report 23:32:24 INFO - PROCESS | 1666 | __startTimestamp1472106744014__endTimestamp 23:32:24 INFO - PROCESS | 1666 | 23:32:24 INFO - PROCESS | 1666 | ------- Summary: start ------- 23:32:24 INFO - PROCESS | 1666 | Number of tests: 14 23:32:24 INFO - PROCESS | 1666 | 23:32:24 INFO - PROCESS | 1666 | [#0] ai-astar Cycles:10 Average:129.40 Median:124.00 stddev:21.96 (17.7%) stddev-sans-first:22.75 23:32:24 INFO - PROCESS | 1666 | Values: 116.0 111.0 116.0 117.0 118.0 138.0 112.0 169.0 167.0 130.0 23:32:24 INFO - PROCESS | 1666 | 23:32:24 INFO - PROCESS | 1666 | [#1] audio-beat-detection Cycles:10 Average:129.30 Median:134.50 stddev:19.74 (14.7%) stddev-sans-first:19.87 23:32:24 INFO - PROCESS | 1666 | Values: 147.0 111.0 133.0 159.0 110.0 136.0 125.0 108.0 155.0 109.0 23:32:24 INFO - PROCESS | 1666 | 23:32:24 INFO - PROCESS | 1666 | [#2] audio-dft Cycles:10 Average:227.50 Median:243.00 stddev:32.90 (13.5%) stddev-sans-first:32.30 23:32:24 INFO - PROCESS | 1666 | Values: 192.0 199.0 203.0 252.0 273.0 235.0 203.0 194.0 273.0 251.0 23:32:24 INFO - PROCESS | 1666 | 23:32:24 INFO - PROCESS | 1666 | [#3] audio-fft Cycles:10 Average:96.40 Median:74.00 stddev:40.13 (54.2%) stddev-sans-first:41.32 23:32:24 INFO - PROCESS | 1666 | Values: 69.0 84.0 103.0 176.0 81.0 50.0 71.0 95.0 158.0 77.0 23:32:24 INFO - PROCESS | 1666 | 23:32:24 INFO - PROCESS | 1666 | [#4] audio-oscillator Cycles:10 Average:90.90 Median:72.50 stddev:19.89 (27.4%) stddev-sans-first:19.46 23:32:24 INFO - PROCESS | 1666 | Values: 69.0 72.0 120.0 94.0 86.0 93.0 115.0 72.0 73.0 115.0 23:32:24 INFO - PROCESS | 1666 | 23:32:24 INFO - PROCESS | 1666 | [#5] imaging-gaussian-blur Cycles:10 Average:88.50 Median:88.50 stddev:4.33 (4.9%) stddev-sans-first:4.59 23:32:24 INFO - PROCESS | 1666 | Values: 88.0 90.0 88.0 84.0 90.0 85.0 88.0 99.0 89.0 84.0 23:32:24 INFO - PROCESS | 1666 | 23:32:24 INFO - PROCESS | 1666 | [#6] imaging-darkroom Cycles:10 Average:119.00 Median:150.50 stddev:23.40 (15.5%) stddev-sans-first:24.54 23:32:24 INFO - PROCESS | 1666 | Values: 109.0 98.0 130.0 96.0 150.0 105.0 99.0 149.0 151.0 103.0 23:32:24 INFO - PROCESS | 1666 | 23:32:24 INFO - PROCESS | 1666 | [#7] imaging-desaturate Cycles:10 Average:115.60 Median:144.50 stddev:17.88 (12.4%) stddev-sans-first:17.66 23:32:24 INFO - PROCESS | 1666 | Values: 97.0 96.0 104.0 121.0 120.0 99.0 145.0 118.0 144.0 112.0 23:32:24 INFO - PROCESS | 1666 | 23:32:24 INFO - PROCESS | 1666 | [#8] json-parse-financial Cycles:10 Average:56.30 Median:56.50 stddev:1.25 (2.2%) stddev-sans-first:1.32 23:32:24 INFO - PROCESS | 1666 | Values: 56.0 55.0 57.0 58.0 56.0 58.0 56.0 56.0 54.0 57.0 23:32:24 INFO - PROCESS | 1666 | 23:32:24 INFO - PROCESS | 1666 | [#9] json-stringify-tinderbox Cycles:10 Average:74.70 Median:74.00 stddev:9.46 (12.8%) stddev-sans-first:8.64 23:32:24 INFO - PROCESS | 1666 | Values: 61.0 76.0 98.0 73.0 79.0 71.0 75.0 70.0 73.0 71.0 23:32:24 INFO - PROCESS | 1666 | 23:32:24 INFO - PROCESS | 1666 | [#10] stanford-crypto-aes Cycles:10 Average:89.80 Median:90.00 stddev:1.93 (2.1%) stddev-sans-first:2.03 23:32:24 INFO - PROCESS | 1666 | Values: 89.0 90.0 92.0 90.0 86.0 89.0 88.0 90.0 92.0 92.0 23:32:24 INFO - PROCESS | 1666 | 23:32:24 INFO - PROCESS | 1666 | [#11] stanford-crypto-ccm Cycles:10 Average:150.60 Median:157.50 stddev:17.92 (11.4%) stddev-sans-first:18.51 23:32:24 INFO - PROCESS | 1666 | Values: 139.0 145.0 138.0 157.0 181.0 131.0 125.0 162.0 170.0 158.0 23:32:24 INFO - PROCESS | 1666 | 23:32:24 INFO - PROCESS | 1666 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.10 Median:171.00 stddev:8.43 (4.9%) stddev-sans-first:8.93 23:32:24 INFO - PROCESS | 1666 | Values: 171.0 169.0 166.0 165.0 194.0 177.0 167.0 171.0 169.0 172.0 23:32:24 INFO - PROCESS | 1666 | 23:32:24 INFO - PROCESS | 1666 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.50 Median:71.00 stddev:7.49 (10.5%) stddev-sans-first:7.83 23:32:24 INFO - PROCESS | 1666 | Values: 70.0 67.0 70.0 67.0 68.0 70.0 72.0 79.0 88.0 84.0 23:32:24 INFO - PROCESS | 1666 | -------- Summary: end -------- 23:32:24 INFO - PROCESS | 1666 | 23:32:24 INFO - TEST-INFO | 1666: exit 0 23:32:24 INFO - TEST-OK | kraken | took 60701ms 23:32:24 INFO - SUITE-END | took 1174s 23:32:25 INFO - Completed test suite (00:19:34) 23:32:25 INFO - javascript benchmark 23:32:25 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7422.570135070386, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3367.3602015617016, 3387.2378714789174, 3391.6608339166087, 3400.4049291374004, 3435.072530416787, 5107.310513080733, 5215.904660021391, 5687.914681279784, 5700.857478563033, 5762.078067509199, 5564.221009058725, 5738.7991420300295, 5770.798022069229, 5850.531957443405, 5875.647461152334, 5136.640435169549, 5235.397929238129, 5242.606804489659, 5250.816221432251, 5332.840014799563, 5217.217417387385, 5385.246065550826, 5404.135338345865, 5409.161579955094, 5418.349798024243, 5292.947070529284, 5297.947020529822, 5313.38896026958, 5316.707581083039, 5341.412444631107, 5172.301739265189, 5194.298769666085, 5210.140326846066, 5210.218467229908, 5274.5780337572905, 5143.665661731976, 5176.55999240065, 5180.715060671661, 5196.68819870809, 5247.527722504993, 4695.295705644146, 5313.256144139824, 5769.163471296681, 5786.189933409326, 5809.070548712228, 5138.511841375063, 5141.228815677641, 5341.973290133564, 6196.845078873019, 6232.065190221503, 5269.7365131743645, 6224.87550248997, 6287.654179020152, 6297.6536290504, 6313.779017734358, 4694.554017368345, 4873.8781530461665, 5852.063669812809, 5858.970705146489, 5862.736176872051, 6158.107074474266, 6191.473724733448, 6194.659293738888, 6260.029695397221, 6265.404786545271, 5404.756785944642, 5941.643501389931, 6157.107219453154, 6162.414570615784, 6206.627602343783, 6125.540584456184, 6239.563230573816, 6256.405641464054, 6262.2172228471445, 6271.0, 6101.3079194897555, 6107.006761825686, 6127.417895299939, 6136.386361363828, 6149.385061493815, 6116.9179262861035, 6194.473469755121, 6251.499880009588, 6256.74973001084, 6286.057091436322, 4897.2654101885, 4953.90092198154, 5017.89964200714, 5025.673331233458, 5026.572741317029, 4419.292913133883, 4447.310666846644, 4451.376807246988, 4470.441194850644, 4550.795214215368, 5462.153366228241, 5862.912056319158, 5866.354700982888, 5868.149118377812, 5874.0, 6125.082842094287, 6168.629882207082, 6188.4739797116845, 6197.783077592263, 6211.627302361872, 5743.0, 5785.971070144622, 5836.0, 5840.8247752567495, 5886.941130588725, 5418.783248670009, 5451.318585176853, 5453.100238460689, 5459.836204913859, 5468.316460442445, 6114.847128821815, 6294.527910406646, 6314.242290925118, 6318.526110541636, 6339.144215530844, 5260.316158899319, 6138.2044803098925, 6140.4428991762525, 6193.38066193377, 6210.5652604317265, 6284.717187726655, 6293.118963345227, 6307.337729538516, 6317.684115794284, 6399.648019358794, 6069.817905462844, 6169.938300616936, 6183.876322473615, 6201.069839524108, 6224.097505861715, 6022.6386416813375, 6096.10339372222, 6169.598976066542, 6183.134361189347, 6186.319504854552, 6101.84745381369, 6112.572119951738, 6116.128775280677, 6120.395005630133, 6136.386361363828, 5985.850353741192, 6110.103144028831, 6118.877622447437, 6120.995732432883, 6135.355787642234, 5116.820911268088, 5703.62926409782, 5873.823785286449, 5927.110933360031, 6013.887430825312, 6124.693765311806, 6128.387161283836, 6139.140520327069, 6144.446999770043, 6156.476699480594, 5826.679532625577, 6038.909416358846, 6047.516198704181, 6051.3041000283765, 6064.090386442069], "value": 5659.118856476776, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [466.66400191861845, 494.42646530025166, 496.05501519605156, 521.9739013049347, 554.8113641361936, 39133.412998805004, 41152.0, 42110.78944605277, 42118.94702632436, 42138.789306053426, 43013.78493107538, 43611.78194109033, 43622.12755744883, 43639.78180109095, 43640.69077927659, 9781.315307928466, 9988.30081894264, 9998.900010999869, 10002.84995725061, 10008.49957502122, 9829.459379734111, 9968.0, 9968.6510972116, 9972.900270997307, 9987.400755954666, 9949.403035817837, 9973.850392244121, 9989.051040151211, 10001.549930253119, 10034.949825250864, 9932.354396964174, 9945.701628951107, 9946.204303655762, 9967.700968970943, 9993.950030249838, 9799.265055120895, 9859.26055545837, 9867.16129129025, 9886.209103271722, 9902.316606176968, 41018.9745256368, 41195.764127075934, 41321.38017929733, 41455.96360090992, 41493.1701365974, 3447.1899103710607, 3484.4947482615135, 3490.3891818931584, 3957.1294315250598, 4144.668426525871, 31481.685183148104, 32240.838795806107, 32258.709651613906, 32311.0, 32420.351592968007, 3194.0375326629196, 3297.2086699192023, 3303.80177189367, 3356.7146792522667, 3388.762786604939, 471020.0, 515385.0, 519915.0, 520541.0, 523748.9999999962, 61846.69076654588, 62044.37955620386, 62396.37603623996, 62424.0, 62597.748045039756, 34925.476117858256, 35812.64187358145, 65613.34386656072, 65966.67016664887, 66040.33959660341, 16291.91854040746, 16606.335746570003, 16699.248533816008, 16728.749068763977, 16751.58121046959, 12622.431990560446, 12745.808812867814, 12746.36268186587, 12775.552855650008, 12799.680007999874, 16485.0, 18878.150483228288, 19360.0, 19438.352340697114, 19567.736007351068, 6754.324567543206, 7606.277403646644, 7686.769396918102, 7766.37868970481, 7778.8055298616855, 822.8272062866865, 964.2816102003911, 975.1516180922642, 1061.2836335473678, 1102.7463683352714, 29425.705742942726, 30252.941147059748, 30482.390352192833, 31164.220894477818, 31217.68782312148, 1027.6300531808542, 1059.4861492176287, 1075.3816555480473, 1079.2660990526517, 1105.5246244115108, 14257.287135643177, 15355.923220383827, 15377.846221537866, 15586.766198507032, 16602.58493537671, 721080.0, 762920.0, 787627.0, 788729.0, 1032956.0, 61426.692866535384, 62381.0, 62543.0, 62549.0, 62841.05738413836, 1344.2270694350786, 1366.064245991479, 1402.3338914015558, 1403.1090257686442, 1409.5559898631898, 31011.379772403976, 31982.840085799424, 32067.67932320647, 32658.83670581632, 32786.34427311488, 53764.19353709776, 54268.72865635646, 54404.91190176095, 54499.72750136224, 54531.0, 616032.0, 616692.0, 616889.0, 618113.0037847961, 618891.0, 26863.86568067147, 27971.622412094384, 27972.0, 28024.859875701306, 28035.579466307612, 47678.52321476741, 48178.518214817406, 48432.0, 48931.0, 50026.74986625044, 35738.64261357353, 37977.62022379741, 38651.6134838648, 39663.603363965995, 41109.794451027556, 38783.224335513696, 39259.41110883396, 39294.0, 40835.183296333315, 40921.79539102285, 30273.0, 37774.811125944194, 37854.43218351672, 38543.0, 38780.8365749028, 33564.496532551544, 36511.0, 36551.63448365482, 36879.81560092182, 37115.628843711216, 25799.097031603804, 25997.74002260029, 26132.86933565396, 26321.60517592199, 26767.330816729736], "value": 20602.99961532902, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [329.2706654759707, 374.3729253500386, 376.9114258149335, 381.8925117160236, 405.6065616352137, 19766.06610654327, 20288.0, 20424.591508169848, 20876.47808804777, 20889.0, 19589.0, 19729.605407891868, 20002.0, 20201.696974545357, 20704.068316925735, 5248.239005344223, 5850.18097466354, 5988.161657367972, 6059.272887253535, 6067.18093057436, 5993.940060599403, 5998.040313549833, 6032.185654936593, 6050.757969681207, 6053.334133245339, 5752.194692743019, 5892.793752218673, 5897.557683173758, 5900.380460051697, 5923.318818335882, 5822.864541414426, 5877.52979761618, 5932.288125424955, 5934.673592952386, 5949.7025148742605, 4992.675476094042, 5170.689758614495, 5172.922406163911, 5186.1442861927735, 5196.168613021936, 24615.507689846283, 24759.50480990388, 24865.378365541008, 25004.87497562519, 25136.748632513805, 2247.0342635357697, 2251.0995601759264, 2269.5914735347633, 2329.4060014696315, 3024.729613562309, 12599.748005039848, 15118.622034449118, 15144.091354518765, 15719.449819256386, 15818.734501239873, 1910.6751852185162, 1913.6268427656612, 1916.492129585661, 1919.378165209655, 1946.6301402733577, 99710.0, 106417.93582064158, 124847.0, 129124.35437822845, 129377.0, 8270.214329638675, 9527.333086684004, 10636.574537018587, 11271.436428178558, 11409.657710268706, 11466.967972882481, 12220.877791222152, 13881.930590346983, 13983.930080349737, 14061.0, 8115.261368361761, 8290.253877151084, 8374.455660382057, 8400.537970411564, 8428.115047920002, 8364.790880227922, 8378.329733621296, 8434.460882685393, 8559.786005349915, 8595.269402100766, 3685.355062863988, 4347.5217726050105, 4404.559544045634, 4410.007748256617, 4478.126765280804, 1691.644754601523, 1875.6905110656862, 1894.2517705506248, 1901.8478521718507, 1905.6950887857877, 831.4304701279643, 831.7587899509195, 904.3179685784436, 954.2699834626517, 1042.8122937871256, 17293.443590076953, 17603.5037021852, 20084.89957550203, 20334.796652033587, 20688.689669654967, 906.795970906554, 912.4297314178639, 922.89386720528, 957.7366224288237, 958.3626888119462, 8864.512451815212, 9684.854727179098, 11106.500207490682, 11111.333320000826, 11139.832902506469, 543892.0, 547246.0, 552467.0, 667594.0, 668637.0, 95440.0, 121927.39036304761, 130653.69346306605, 136767.94848077287, 156856.0, 951.923846092311, 978.9853152202722, 1026.7689769801884, 1027.8509616105623, 1029.4080903480528, 17803.643927121127, 18309.54226144357, 18752.0, 18855.057247137862, 19080.427587172406, 53132.73433632962, 53952.0, 54136.729316353165, 55348.63490698621, 57710.0, 71262.0, 72755.27244727696, 73388.0, 73949.2605073964, 74689.0, 7838.960805195938, 8009.038915330198, 8039.758807235792, 8069.717559885611, 8217.013958325038, 11306.660800176009, 12859.678508037374, 12906.935465322613, 13086.934565327112, 13159.802602960772, 10667.199960002876, 10962.342259464458, 11106.555737770399, 11228.326300421673, 11251.887481125084, 9411.670591529537, 10684.252102353072, 10758.8386174209, 11100.333979961228, 11182.937620925999, 9291.907080929104, 9600.903990960001, 11500.53997840077, 11501.942490287494, 11704.590339338423, 7719.150893401609, 7791.766247012599, 8065.87901181471, 8156.755297341089, 8218.58907054633, 9611.519424028911, 11056.0, 11090.057345125755, 11191.104711622887, 11241.831372529256], "value": 9500.312177510696, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1459.8029266049084, 1523.918018207073, 1710.3500669745495, 1737.1227530097299, 1774.6007148391604, 7905.130435652074, 8416.95791521043, 8424.241818236358, 8993.145651163146, 8993.325500587449, 8485.448445851016, 8661.393702440815, 8765.868511972325, 8773.56132193391, 8811.118888111201, 2350.3066595354326, 2392.7009123859516, 2393.664886915833, 2398.9640155397597, 2400.975990240093, 2357.7642235776457, 2377.6314671225987, 2398.2205783120557, 2402.939926501834, 2407.2537513370826, 2379.0840526397287, 2385.666006759055, 2393.904243830245, 2404.2787163850776, 2406.867622280774, 2361.53949979754, 2374.536965291769, 2379.1910750344878, 2385.5228954209056, 2388.7014123234508, 2027.9251996441762, 2356.4580146566213, 2365.349528879555, 2366.4557151854997, 2368.5973384524673, 7946.602669866484, 8761.08008659088, 8818.162274583905, 8840.8673869892, 8871.778205544848, 5289.761960711778, 5403.081476149064, 5405.37838148614, 5437.673739575638, 5448.972755136238, 3519.1554027033585, 3644.763090399142, 3682.815859207029, 3743.700503959704, 3746.2507498500136, 1089.319175515303, 1106.1482658353104, 1111.011200031964, 1115.9497822598003, 1118.7874303882318, 11398.886011139866, 11492.195546311761, 11581.189316747746, 11584.18910676253, 11608.361540115291, 4332.176886391576, 4574.565416285448, 4709.858704238878, 4774.782430480274, 4830.686005409637, 9961.452120133317, 10049.748756281151, 10081.899181008243, 10082.143017843566, 10083.747906302255, 5420.322459692538, 5422.891542169214, 5423.728813559385, 5426.565874730012, 5438.483344082306, 4389.100234451929, 4764.571188593043, 4884.169691152512, 4917.680350777259, 4949.901001980013, 3832.1186127190344, 3907.8632247871187, 3931.312020396419, 3985.4818873546255, 4009.298372784751, 1269.320913311374, 1294.2169987157822, 1296.7017585955095, 1300.998231361865, 1302.9934850325687, 797.8523973065002, 894.1594900793234, 913.0321858829661, 933.5017297237971, 955.9187469065068, 5616.97191514048, 5751.597388182787, 5903.645781253139, 5981.7607295707685, 6109.633421994606, 382.7148774163266, 426.77807540079607, 447.5189171640499, 451.2419135851735, 469.6172619315315, 3429.5027221052806, 3876.1666241758157, 4057.797110144481, 4060.918781624351, 4130.194612050681, 10330.690079297634, 10772.622958196425, 10774.78450430987, 10775.78448431027, 10805.945970270099, 9305.860412093823, 9995.90045095039, 10129.341592796445, 10753.462326883624, 10762.139028877828, 7901.723439679584, 8174.182581741898, 8183.263506284463, 8194.672213111528, 8213.014438267446, 5687.175359572756, 5767.423257674199, 5845.357010728731, 5858.502027327725, 5915.112733090071, 9851.359661621971, 9869.259805514472, 9894.653687120915, 9919.305648604528, 9927.305088643725, 9623.663171788954, 10055.497225138568, 10143.949280253551, 10158.187345012233, 10159.390436573829, 6937.0, 7322.231165727522, 7464.6267686614365, 7564.054493188351, 7635.0, 8378.958105209435, 8448.535330556633, 8455.154484551496, 8456.281216096455, 8464.026636936585, 7374.852502950018, 7444.994925684963, 7475.36459400957, 7497.512661676974, 7615.42884283692, 6995.580265184105, 7305.159906610807, 7381.520201186906, 7455.254474552501, 7590.582517961565, 5812.21535092757, 6287.748490060347, 6890.896636550356, 7069.434445244471, 7085.0, 4597.770111494478, 4598.678092533491, 4617.746023968714, 4642.558956899089, 4704.0, 4256.446661934053, 4820.493848145894, 4825.276208568743, 4886.560209581155, 4942.8764280893265], "value": 4481.390683491992, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [297.6681000684237, 315.19782154417004, 319.2195083022011, 324.1539581691784, 325.0702989450174, 5435.320584926884, 5560.972195139028, 5632.35227948786, 5716.799912003081, 5730.312362516499, 4673.83641572545, 4809.653297076816, 4821.300071959705, 5389.0, 5635.802746903859, 3441.397755392809, 3699.223163135745, 3922.450856880032, 4145.39891715701, 4255.319148936171, 4256.744595324275, 4263.126059157865, 4273.871783846474, 4278.187144442546, 4290.42079319291, 3977.960220397788, 4039.151778126597, 4285.207236661212, 4285.550017248191, 4288.228118938589, 3846.288401661262, 4149.647279981205, 4234.767087810169, 4242.981684395722, 4285.228658841407, 3487.2676737885076, 3602.585702644177, 3677.2093999790172, 3692.6521819535947, 3708.61059588742, 4828.95374333822, 5260.763265653055, 5490.725463726798, 5511.862203444906, 5525.309336332958, 4324.43771820729, 4810.35060266863, 4893.143699852511, 4951.727654978975, 4954.455009948902, 4715.420334188051, 5205.0, 5716.911948365916, 5947.918228619992, 5955.493783028448, 4069.267531844267, 4104.4664193654635, 4109.958900410988, 4113.6297733203855, 4117.91764164718, 5824.592278540504, 5936.851578710523, 6192.9999999999545, 6195.876082478325, 6227.688615569204, 3544.220271540257, 3897.3569361055675, 4178.811953462102, 4182.0, 4193.986886294596, 3760.360738674377, 4055.2497787909333, 4253.744775313429, 4271.252530807158, 4289.871303860889, 4712.59942904857, 4782.947751494666, 4943.876403089952, 4962.702237865739, 4969.378827646544, 4914.36113305268, 5175.560077393388, 5251.76367063483, 5718.999175144333, 5967.38972921385, 1305.8889994350398, 1390.7218556288783, 1412.9576112716634, 1452.7651496228332, 1462.7147706197402, 792.8820363287851, 806.2381049907781, 830.9127541608044, 896.2740180453853, 909.6907051602487, 4439.045605194899, 4870.1233777920315, 5320.946790532123, 5505.752241149158, 5531.806386776443, 4763.476017638057, 5565.053940830068, 6128.080787881853, 6128.896798576299, 6150.0, 5181.455947125498, 5481.862953426196, 5502.2296878437055, 5512.751926163332, 5556.222128901957, 3159.4470967580583, 3237.2068843133584, 3237.4658181399805, 3239.4330992076293, 3255.886043988449, 5450.482204190595, 5461.918071228934, 6371.73094027003, 6385.573482076874, 6392.680365981682, 5406.513413792777, 6141.7543298268465, 6151.108089327112, 6370.745170193233, 6415.358464153547, 5981.730822113015, 6470.773522926675, 6476.190476190476, 6503.317151699192, 6560.770373036921, 5332.240360680888, 6001.969990150022, 6031.065184896348, 6106.847328816815, 6151.477124444473, 5423.701696406578, 5758.531574448489, 6185.443310102112, 6200.0699895016105, 6210.5652604317265, 5461.726913654381, 5611.270534830609, 6290.748370065146, 6379.489640828815, 6515.934840651723, 3301.8018918864946, 4056.492938382702, 4059.2490389276895, 4063.7358571692744, 4084.36692312692, 5197.350331208599, 6221.844453888689, 6222.733065140656, 6238.875222495434, 6269.216347956505, 5725.942740572541, 5990.7903223386975, 6014.578979471395, 6112.113743507078, 6124.448799608057, 5249.868753281045, 5984.700764961822, 6007.339192688888, 6036.426539478743, 6044.727987240497, 4501.392312037964, 5691.3170419549915, 5833.0375488044, 5931.703414829328, 5963.1514230588655, 4779.450363208137, 4864.683795553277, 4932.8520144395725, 5014.648974571745, 5618.269624948731, 5383.515483606494, 5847.8245652630485, 5849.707514624167, 5889.705514724161, 5896.852578685567], "value": 4292.552851451948, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [703.852191039882, 708.1325376413894, 709.7267551992483, 745.6942653512061, 757.3751654884718, 15062.849371506281, 16195.433159839407, 16364.590885227875, 16375.724855029011, 16399.67200655986, 14724.705505889875, 14808.925955370236, 14824.258787060659, 14861.702765944674, 14879.628009299773, 666.4901350466872, 851.0893344121807, 853.3642436384902, 876.8509353409936, 878.6265837019273, 872.9912700872974, 875.9649614015464, 878.2622597018503, 880.0495464897895, 888.1118881118881, 758.1205801270527, 825.5789547330844, 924.2929159193222, 932.8507438809792, 933.8926023507282, 902.8871391076116, 921.230772305126, 921.235374639048, 924.6255266616997, 928.7585227840742, 662.8276648071488, 674.3762020131408, 692.4114502672738, 692.6813665713778, 693.7259782385929, 13326.666833329147, 14749.55751327451, 15236.619084522976, 15278.465253716178, 15287.694246115127, 14866.182359970197, 14868.553943381608, 14908.925455372762, 14914.254287285592, 15206.467773627981, 11299.0, 11974.281543107441, 12036.39818009096, 12156.113862863302, 12423.75152496954, 3744.6255374462608, 3905.9609403906165, 4034.426573636284, 4074.4092106644666, 4075.2460794753065, 120090.0, 123123.0, 123699.0, 124341.0, 124346.37826810808, 9504.239660827117, 10608.57565697379, 11337.659870203906, 11366.488508017159, 11819.172657914036, 21196.940152992287, 23797.762022379902, 23852.761472385053, 23853.880730596236, 23858.045678173024, 7734.690612375554, 8303.792405189919, 8308.086110527836, 8313.958430207811, 8427.24154826067, 4570.885727856764, 4596.241620132708, 4613.953860461353, 4627.167109920179, 4757.14371413149, 3451.3269912366845, 3537.699295559855, 3561.2521370511963, 3564.7861128332383, 3881.165549406891, 718.3534818663245, 724.6594100772628, 729.580491217552, 751.7744676596999, 758.525921299188, 562.2774734466192, 646.7930262316107, 667.6928612838052, 669.1902797614844, 679.1035832700787, 9368.812623747486, 9455.385399948982, 9580.425174489554, 9916.702498925044, 9925.454100024424, 602.5051530046009, 649.4122818848949, 651.794684674326, 672.7395949609308, 712.4585315160411, 3944.526656801202, 4676.485586585472, 4870.439899411542, 4913.313543043865, 4919.2867034279825, 105060.47469762602, 151748.72376914354, 160736.0, 160743.39256607517, 161557.0, 112663.0, 113439.0, 113985.43007285077, 117647.8235217654, 122094.38952805179, 103819.48090259501, 124531.0, 124890.37554812168, 124970.3751481255, 127200.36399817941, 9102.31732620043, 9173.31200160004, 9184.357095003286, 9217.0, 9218.262538996998, 67484.0, 67605.3239467599, 67781.0, 68956.6552167236, 70594.94107588287, 62825.68587157035, 63959.0, 67910.0, 69107.30892691009, 101381.0, 12140.453679584263, 12184.634460966185, 12441.37793110359, 12492.875071249171, 12523.311217883103, 13464.730705386033, 13655.931720341334, 13749.656258593215, 13969.790453143009, 14222.431102756187, 12351.444185011876, 12581.0, 12692.238465692088, 12915.22508649484, 13099.148555343872, 12422.689432763891, 12538.56115036006, 13127.474901004234, 13317.933410332886, 13332.533361332307, 11978.64064078079, 12311.938440307742, 12374.62876113718, 12619.0, 12693.048021398617, 10446.112080473245, 10642.361458312216, 10686.465676715978, 10846.240763146505, 10913.618023369145, 9340.267459138187, 9807.754806129904, 10782.892171078189, 10818.0, 10872.61945831892], "value": 7847.554961668761, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1613.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 111.0, 116.0, 117.0, 118.0, 138.0, 112.0, 169.0, 167.0, 130.0], "value": 129.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 111.0, 133.0, 159.0, 110.0, 136.0, 125.0, 108.0, 155.0, 109.0], "value": 129.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [192.0, 199.0, 203.0, 252.0, 273.0, 235.0, 203.0, 194.0, 273.0, 251.0], "value": 227.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 84.0, 103.0, 176.0, 81.0, 50.0, 71.0, 95.0, 158.0, 77.0], "value": 96.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 72.0, 120.0, 94.0, 86.0, 93.0, 115.0, 72.0, 73.0, 115.0], "value": 90.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 90.0, 88.0, 84.0, 90.0, 85.0, 88.0, 99.0, 89.0, 84.0], "value": 88.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 98.0, 130.0, 96.0, 150.0, 105.0, 99.0, 149.0, 151.0, 103.0], "value": 119.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 96.0, 104.0, 121.0, 120.0, 99.0, 145.0, 118.0, 144.0, 112.0], "value": 115.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 57.0, 58.0, 56.0, 58.0, 56.0, 56.0, 54.0, 57.0], "value": 56.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 76.0, 98.0, 73.0, 79.0, 71.0, 75.0, 70.0, 73.0, 71.0], "value": 74.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 90.0, 92.0, 90.0, 86.0, 89.0, 88.0, 90.0, 92.0, 92.0], "value": 89.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 145.0, 138.0, 157.0, 181.0, 131.0, 125.0, 162.0, 170.0, 158.0], "value": 150.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 169.0, 166.0, 165.0, 194.0, 177.0, 167.0, 171.0, 169.0, 172.0], "value": 172.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 67.0, 70.0, 67.0, 68.0, 70.0, 72.0, 79.0, 88.0, 84.0], "value": 73.5, "unit": "score"}]}]} 23:32:25 INFO - Return code: 0 23:32:25 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 23:32:25 ERROR - # TBPL SUCCESS # 23:32:25 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 23:32:25 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 23:32:25 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 23:32:25 INFO - 2016-08-24 23:32:25.320 screenresolution[1671:10398] starting screenresolution argv=screenresolution get 23:32:25 INFO - 2016-08-24 23:32:25.322 screenresolution[1671:10398] Display 0: 1600x1200x32@60 23:32:25 INFO - 2016-08-24 23:32:25.328 screenresolution[1672:10401] starting screenresolution argv=screenresolution list 23:32:25 INFO - Available Modes on Display 0 23:32:25 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 23:32:25 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 23:32:25 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 23:32:25 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 23:32:25 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 23:32:25 INFO - Intel Iris: 23:32:25 INFO - Chipset Model: Intel Iris 23:32:25 INFO - Type: GPU 23:32:25 INFO - Bus: Built-In 23:32:25 INFO - VRAM (Dynamic, Max): 1536 MB 23:32:25 INFO - Vendor: Intel (0x8086) 23:32:25 INFO - Device ID: 0x0a2e 23:32:25 INFO - Revision ID: 0x0009 23:32:25 INFO - Displays: 23:32:25 INFO - Display: 23:32:25 INFO - Resolution: 1600 x 1200 @ 60 Hz 23:32:25 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 23:32:25 INFO - Display Serial Number: 1600x1200 60 23:32:25 INFO - Main Display: Yes 23:32:25 INFO - Mirror: Off 23:32:25 INFO - Online: Yes 23:32:25 INFO - Rotation: Supported 23:32:25 INFO - Return code: 0 23:32:25 INFO - Running post-action listener: _resource_record_post_action 23:32:25 INFO - [mozharness: 2016-08-25 06:32:25.563547Z] Finished run-tests step (success) 23:32:25 INFO - Running post-run listener: _resource_record_post_run 23:32:25 INFO - Total resource usage - Wall time: 1209s; CPU: 55.0%; Read bytes: 38466560; Write bytes: 707577344; Read time: 378; Write time: 2457 23:32:25 INFO - TinderboxPrint: CPU usage
54.6% 23:32:25 INFO - TinderboxPrint: I/O read bytes / time
38,466,560 / 378 23:32:25 INFO - TinderboxPrint: I/O write bytes / time
707,577,344 / 2,457 23:32:25 INFO - TinderboxPrint: CPU idle
2,197.8 (45.4%) 23:32:25 INFO - TinderboxPrint: CPU system
981.4 (20.3%) 23:32:25 INFO - TinderboxPrint: CPU user
1,658.4 (34.3%) 23:32:25 INFO - TinderboxPrint: Swap in / out
443,817,984 / 0 23:32:25 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 405492224; Write bytes: 401037312; Read time: 30046; Write time: 801 23:32:25 INFO - run-tests - Wall time: 1175s; CPU: 55.0%; Read bytes: 34505728; Write bytes: 296717824; Read time: 346; Write time: 1627 23:32:26 INFO - Running post-run listener: _upload_blobber_files 23:32:26 INFO - Blob upload gear active. 23:32:26 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:32:26 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 23:32:26 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'] 23:32:26 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 23:32:26 INFO - (blobuploader) - INFO - Open directory for files ... 23:32:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 23:32:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:32:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:32:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 23:32:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:32:27 INFO - (blobuploader) - INFO - Done attempting. 23:32:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 23:32:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:32:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:32:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 23:32:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:32:27 INFO - (blobuploader) - INFO - Done attempting. 23:32:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 23:32:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:32:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:32:30 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 23:32:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:32:30 INFO - (blobuploader) - INFO - Done attempting. 23:32:30 INFO - (blobuploader) - INFO - Iteration through files over. 23:32:30 INFO - Return code: 0 23:32:30 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:32:30 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:32:30 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/112f8f6053b939f09e7b2aa651b1a17534086bc409010ab678f954f309adc94310078ea10481750bf2ec14f1a3b0fc798519b17a86be7a50441eb85a2a5e7536", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/e1b30845d015eb36eeb9b6506be6e540d232542e79950634a5b9a39754cd00bd7043ca48934d2e742376be74548f518c63fc1705bb9eee035363bff713191d9b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/e8fbe244c223b48b36447c5848bb74bce80cdc71c805efebc448a66aa6fbf980d768c4c947dae26ad264f5517d368936c9dd3cee554e353b1af5c933f8e2e70d"} 23:32:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:32:30 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:32:30 INFO - Contents: 23:32:30 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/112f8f6053b939f09e7b2aa651b1a17534086bc409010ab678f954f309adc94310078ea10481750bf2ec14f1a3b0fc798519b17a86be7a50441eb85a2a5e7536", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/e1b30845d015eb36eeb9b6506be6e540d232542e79950634a5b9a39754cd00bd7043ca48934d2e742376be74548f518c63fc1705bb9eee035363bff713191d9b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/e8fbe244c223b48b36447c5848bb74bce80cdc71c805efebc448a66aa6fbf980d768c4c947dae26ad264f5517d368936c9dd3cee554e353b1af5c933f8e2e70d"} 23:32:30 INFO - Running post-run listener: copy_logs_to_upload_dir 23:32:30 INFO - Copying logs to upload dir... 23:32:30 INFO - mkdir: /builds/slave/test/build/upload/logs 23:32:30 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1271.601940 ========= master_lag: 0.13 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-08-24 23:32:30.461567) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-24 23:32:30.464996) ========= 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.roCslYPobt/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.X2nR6uwQPa/Listeners TMPDIR=/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/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/112f8f6053b939f09e7b2aa651b1a17534086bc409010ab678f954f309adc94310078ea10481750bf2ec14f1a3b0fc798519b17a86be7a50441eb85a2a5e7536", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/e1b30845d015eb36eeb9b6506be6e540d232542e79950634a5b9a39754cd00bd7043ca48934d2e742376be74548f518c63fc1705bb9eee035363bff713191d9b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/e8fbe244c223b48b36447c5848bb74bce80cdc71c805efebc448a66aa6fbf980d768c4c947dae26ad264f5517d368936c9dd3cee554e353b1af5c933f8e2e70d"} build_url:https://queue.taskcluster.net/v1/task/Jgt5S5z9QQiw8vLRLMv8zA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011229 build_url: 'https://queue.taskcluster.net/v1/task/Jgt5S5z9QQiw8vLRLMv8zA/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/112f8f6053b939f09e7b2aa651b1a17534086bc409010ab678f954f309adc94310078ea10481750bf2ec14f1a3b0fc798519b17a86be7a50441eb85a2a5e7536", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/e1b30845d015eb36eeb9b6506be6e540d232542e79950634a5b9a39754cd00bd7043ca48934d2e742376be74548f518c63fc1705bb9eee035363bff713191d9b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/e8fbe244c223b48b36447c5848bb74bce80cdc71c805efebc448a66aa6fbf980d768c4c947dae26ad264f5517d368936c9dd3cee554e353b1af5c933f8e2e70d"}' ========= master_lag: 0.16 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-24 23:32:30.635447) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-24 23:32:30.635815) ========= 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.roCslYPobt/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.X2nR6uwQPa/Listeners TMPDIR=/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/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.005129 ========= master_lag: 0.46 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-24 23:32:31.105313) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-24 23:32:31.105651) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-24 23:32:31.106001) ========= ========= Total master_lag: 0.82 =========