builder: autoland_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0098 starttime: 1470352255.89 results: success (0) buildid: 20160804140920 builduid: 81ff8df3f9f34eadadc68d6a5dc9e8bb revision: 8feacca30626875bcc86c49c9dd2b69cee281d98 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-04 16:10:55.895130) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-04 16:10:55.895590) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-04 16:10:55.896011) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-04 16:10:55.921128) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 16:10:55.921442) ========= 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.WuMJTvJYDm/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.Rc8TnckJ8D/Listeners TMPDIR=/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/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-04 16:10:55-- 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% 150M=0s 2016-08-04 16:10:56 (150 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.094755 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 16:10:56.038874) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 16:10:56.039208) ========= 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.WuMJTvJYDm/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.Rc8TnckJ8D/Listeners TMPDIR=/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/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.027964 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 16:10:56.088016) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-04 16:10:56.088409) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 8feacca30626875bcc86c49c9dd2b69cee281d98 --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 8feacca30626875bcc86c49c9dd2b69cee281d98 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.WuMJTvJYDm/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.Rc8TnckJ8D/Listeners TMPDIR=/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/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-04 16:10:56,164 truncating revision to first 12 chars 2016-08-04 16:10:56,165 Setting DEBUG logging. 2016-08-04 16:10:56,165 attempt 1/10 2016-08-04 16:10:56,165 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/8feacca30626?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-04 16:10:57,140 unpacking tar archive at: autoland-8feacca30626/testing/mozharness/ program finished with exit code 0 elapsedTime=1.289967 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-04 16:10:57.400414) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-04 16:10:57.400751) ========= script_repo_revision: 8feacca30626875bcc86c49c9dd2b69cee281d98 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-04 16:10:57.401165) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-04 16:10:57.401476) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-04 16:10:57.419493) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-08-04 16:10:57.419791) ========= /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.WuMJTvJYDm/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.Rc8TnckJ8D/Listeners TMPDIR=/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 16:10:57 INFO - MultiFileLogger online at 20160804 16:10:57 in /builds/slave/test 16:10:57 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 16:10:57 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:10:57 INFO - {'append_to_log': False, 16:10:57 INFO - 'base_work_dir': '/builds/slave/test', 16:10:57 INFO - 'blob_upload_branch': 'Autoland', 16:10:57 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:10:57 INFO - 'branch': 'Autoland', 16:10:57 INFO - 'buildbot_json_path': 'buildprops.json', 16:10:57 INFO - 'config_files': ('talos/mac_config.py',), 16:10:57 INFO - 'default_actions': ('clobber', 16:10:57 INFO - 'read-buildbot-config', 16:10:57 INFO - 'download-and-extract', 16:10:57 INFO - 'populate-webroot', 16:10:57 INFO - 'create-virtualenv', 16:10:57 INFO - 'install', 16:10:57 INFO - 'run-tests'), 16:10:57 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:10:57 INFO - 'download_minidump_stackwalk': True, 16:10:57 INFO - 'download_symbols': 'ondemand', 16:10:57 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:10:57 INFO - 'tooltool.py': '/tools/tooltool.py', 16:10:57 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:10:57 INFO - '/tools/misc-python/virtualenv.py')}, 16:10:57 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:10:57 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:10:57 INFO - 'installer_path': 'installer.exe', 16:10:57 INFO - 'log_level': 'info', 16:10:57 INFO - 'log_name': 'talos', 16:10:57 INFO - 'log_to_console': True, 16:10:57 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 16:10:57 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 16:10:57 INFO - 'opt_config_files': (), 16:10:57 INFO - 'pip_index': False, 16:10:57 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:10:57 INFO - 'cmd': ('bash', 16:10:57 INFO - '-c', 16:10:57 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:10:57 INFO - 'enabled': True, 16:10:57 INFO - 'halt_on_failure': False, 16:10:57 INFO - 'name': 'check_screen_resolution'},), 16:10:57 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:10:57 INFO - 'cmd': ('bash', 16:10:57 INFO - '-c', 16:10:57 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:10:57 INFO - 'enabled': True, 16:10:57 INFO - 'halt_on_failure': False, 16:10:57 INFO - 'name': 'check_screen_resolution'},), 16:10:57 INFO - 'run_cmd_checks_enabled': True, 16:10:57 INFO - 'sps_profile': False, 16:10:57 INFO - 'sps_profile_interval': 0, 16:10:57 INFO - 'suite': 'dromaeojs-e10s', 16:10:57 INFO - 'system_bits': '32', 16:10:57 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:10:57 INFO - 'title': 't-yosemite-r7-0098', 16:10:57 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:10:57 INFO - 'use_talos_json': True, 16:10:57 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:10:57 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:10:57 INFO - 'work_dir': 'build'} 16:10:57 INFO - [mozharness: 2016-08-04 23:10:57.615491Z] Running clobber step. 16:10:57 INFO - Running pre-action listener: _resource_record_pre_action 16:10:57 INFO - Running main action method: clobber 16:10:57 INFO - rmtree: /builds/slave/test/build 16:10:57 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:10:59 INFO - Running post-action listener: _resource_record_post_action 16:10:59 INFO - [mozharness: 2016-08-04 23:10:59.800620Z] Finished clobber step (success) 16:10:59 INFO - [mozharness: 2016-08-04 23:10:59.800754Z] Running read-buildbot-config step. 16:10:59 INFO - Running pre-action listener: _resource_record_pre_action 16:10:59 INFO - Running main action method: read_buildbot_config 16:10:59 INFO - Using buildbot properties: 16:10:59 INFO - { 16:10:59 INFO - "project": "", 16:10:59 INFO - "product": "firefox", 16:10:59 INFO - "script_repo_revision": "production", 16:10:59 INFO - "builddir": "autoland_yosemite_r7_test-dromaeojs-e10s", 16:10:59 INFO - "repository": "", 16:10:59 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 autoland talos dromaeojs-e10s", 16:10:59 INFO - "buildid": "20160804140920", 16:10:59 INFO - "pgo_build": "False", 16:10:59 INFO - "basedir": "/builds/slave/test", 16:10:59 INFO - "buildnumber": 97, 16:10:59 INFO - "slavename": "t-yosemite-r7-0098", 16:10:59 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 16:10:59 INFO - "platform": "yosemite_r7", 16:10:59 INFO - "scheduler": "tests-autoland-macosx64-talos", 16:10:59 INFO - "branch": "autoland", 16:10:59 INFO - "repo_path": "integration/autoland", 16:10:59 INFO - "revision": "8feacca30626875bcc86c49c9dd2b69cee281d98", 16:10:59 INFO - "stage_platform": "macosx64", 16:10:59 INFO - "builduid": "81ff8df3f9f34eadadc68d6a5dc9e8bb", 16:10:59 INFO - "slavebuilddir": "test" 16:10:59 INFO - } 16:10:59 INFO - Found installer url https://queue.taskcluster.net/v1/task/RzsrsBNcT0aybg8cY1DvaQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 16:10:59 INFO - Running post-action listener: _resource_record_post_action 16:10:59 INFO - [mozharness: 2016-08-04 23:10:59.804205Z] Finished read-buildbot-config step (success) 16:10:59 INFO - [mozharness: 2016-08-04 23:10:59.804317Z] Running download-and-extract step. 16:10:59 INFO - Running pre-action listener: _resource_record_pre_action 16:10:59 INFO - Running main action method: download_and_extract 16:10:59 INFO - mkdir: /builds/slave/test/build/tests 16:10:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:10:59 INFO - trying https://queue.taskcluster.net/v1/task/RzsrsBNcT0aybg8cY1DvaQ/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 16:10:59 INFO - Downloading https://queue.taskcluster.net/v1/task/RzsrsBNcT0aybg8cY1DvaQ/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 16:10:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RzsrsBNcT0aybg8cY1DvaQ/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json'}, attempt #1 16:11:00 INFO - Downloaded 1199 bytes. 16:11:00 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 16:11:00 INFO - Using the following test package requirements: 16:11:00 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 16:11:00 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 16:11:00 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 16:11:00 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 16:11:00 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 16:11:00 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 16:11:00 INFO - u'jsshell-mac.zip'], 16:11:00 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 16:11:00 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 16:11:00 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 16:11:00 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 16:11:00 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 16:11:00 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 16:11:00 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 16:11:00 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 16:11:00 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 16:11:00 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 16:11:00 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 16:11:00 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 16:11: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')]} 16:11:00 INFO - trying https://queue.taskcluster.net/v1/task/RzsrsBNcT0aybg8cY1DvaQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 16:11:00 INFO - Downloading https://queue.taskcluster.net/v1/task/RzsrsBNcT0aybg8cY1DvaQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip 16:11:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RzsrsBNcT0aybg8cY1DvaQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip'}, attempt #1 16:11:01 INFO - Downloaded 16316069 bytes. 16:11:01 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 16:11:08 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip', u'firefox-51.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 16:11:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:11:08 INFO - trying https://queue.taskcluster.net/v1/task/RzsrsBNcT0aybg8cY1DvaQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 16:11:08 INFO - Downloading https://queue.taskcluster.net/v1/task/RzsrsBNcT0aybg8cY1DvaQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip 16:11:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RzsrsBNcT0aybg8cY1DvaQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip'}, attempt #1 16:11:09 INFO - Downloaded 16316069 bytes. 16:11:09 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 16:11:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:11:16 INFO - trying https://queue.taskcluster.net/v1/task/RzsrsBNcT0aybg8cY1DvaQ/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 16:11:16 INFO - Downloading https://queue.taskcluster.net/v1/task/RzsrsBNcT0aybg8cY1DvaQ/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip 16:11:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RzsrsBNcT0aybg8cY1DvaQ/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip'}, attempt #1 16:11:17 INFO - Downloaded 14413723 bytes. 16:11:17 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/tests 16:11:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:11:18 INFO - trying https://queue.taskcluster.net/v1/task/RzsrsBNcT0aybg8cY1DvaQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 16:11:18 INFO - Downloading https://queue.taskcluster.net/v1/task/RzsrsBNcT0aybg8cY1DvaQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 16:11:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RzsrsBNcT0aybg8cY1DvaQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg'}, attempt #1 16:11:20 INFO - Downloaded 111189498 bytes. 16:11:20 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RzsrsBNcT0aybg8cY1DvaQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 16:11:20 INFO - mkdir: /builds/slave/test/properties 16:11:20 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:11:20 INFO - Writing to file /builds/slave/test/properties/build_url 16:11:20 INFO - Contents: 16:11:20 INFO - build_url:https://queue.taskcluster.net/v1/task/RzsrsBNcT0aybg8cY1DvaQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 16:11:21 INFO - Running post-action listener: _resource_record_post_action 16:11:21 INFO - Running post-action listener: set_extra_try_arguments 16:11:21 INFO - [mozharness: 2016-08-04 23:11:21.601994Z] Finished download-and-extract step (success) 16:11:21 INFO - [mozharness: 2016-08-04 23:11:21.602153Z] Running populate-webroot step. 16:11:21 INFO - Running pre-action listener: _resource_record_pre_action 16:11:21 INFO - Running main action method: populate_webroot 16:11:21 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:11:21 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:11:21 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:11:21 INFO - '--tppagecycles', 16:11:21 INFO - '7'], 16:11:21 INFO - 'tests': ['tsvgm']}}, 16:11:21 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:11:21 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:11:21 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:11:21 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:11:21 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:11:21 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:11:21 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:11:21 INFO - 'talos_options': ['--disable-e10s'], 16:11:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:11:21 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:11:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:11:21 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:11:21 INFO - 'talos_options': ['--disable-e10s'], 16:11:21 INFO - 'tests': ['damp', 'tps']}, 16:11:21 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:11:21 INFO - 'tests': ['damp', 'tps']}, 16:11:21 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:11:21 INFO - 'tests': ['dromaeo_dom']}, 16:11:21 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:11:21 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:11:21 INFO - 'tests': ['basic_compositor_video']}, 16:11:21 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:11:21 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:11:21 INFO - 'tests': ['a11yr', 16:11:21 INFO - 'ts_paint', 16:11:21 INFO - 'tpaint', 16:11:21 INFO - 'sessionrestore', 16:11:21 INFO - 'sessionrestore_no_auto_restore', 16:11:21 INFO - 'tabpaint']}, 16:11:21 INFO - 'other-e10s': {'tests': ['a11yr', 16:11:21 INFO - 'ts_paint', 16:11:21 INFO - 'tpaint', 16:11:21 INFO - 'sessionrestore', 16:11:21 INFO - 'sessionrestore_no_auto_restore', 16:11:21 INFO - 'tabpaint']}, 16:11:21 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:11:21 INFO - 'ts_paint', 16:11:21 INFO - 'tpaint', 16:11:21 INFO - 'sessionrestore', 16:11:21 INFO - 'sessionrestore_no_auto_restore', 16:11:21 INFO - 'tabpaint']}, 16:11:21 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:11:21 INFO - 'ts_paint', 16:11:21 INFO - 'tpaint', 16:11:21 INFO - 'sessionrestore', 16:11:21 INFO - 'sessionrestore_no_auto_restore', 16:11:21 INFO - 'tabpaint']}, 16:11:21 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:11:21 INFO - 'tests': ['a11yr', 16:11:21 INFO - 'ts_paint', 16:11:21 INFO - 'tpaint', 16:11:21 INFO - 'sessionrestore', 16:11:21 INFO - 'sessionrestore_no_auto_restore', 16:11:21 INFO - 'tabpaint']}, 16:11:21 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:11:21 INFO - 'tests': ['a11yr', 16:11:21 INFO - 'ts_paint', 16:11:21 INFO - 'tpaint', 16:11:21 INFO - 'sessionrestore', 16:11:21 INFO - 'sessionrestore_no_auto_restore', 16:11:21 INFO - 'tabpaint']}, 16:11:21 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:11:21 INFO - 'tests': ['tsvgx', 16:11:21 INFO - 'tsvgr_opacity', 16:11:21 INFO - 'tart', 16:11:21 INFO - 'tscrollx', 16:11:21 INFO - 'cart']}, 16:11:21 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:11:21 INFO - 'tsvgr_opacity', 16:11:21 INFO - 'tart', 16:11:21 INFO - 'tscrollx', 16:11:21 INFO - 'cart']}, 16:11:21 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:11:21 INFO - 'talos_options': ['--disable-e10s'], 16:11:21 INFO - 'tests': ['tp5o']}, 16:11:21 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:11:21 INFO - 'tests': ['tp5o']}, 16:11:21 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:11:21 INFO - 'talos_options': ['--disable-e10s', 16:11:21 INFO - '--xperf_path', 16:11:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:11:21 INFO - 'tests': ['tp5n']}, 16:11:21 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:11:21 INFO - 'talos_options': ['--xperf_path', 16:11:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:11:21 INFO - 'tests': ['tp5n']}}, 16:11:21 INFO - 'talos.zip': {'path': '', 16:11:21 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:11:21 INFO - Running post-action listener: _resource_record_post_action 16:11:21 INFO - [mozharness: 2016-08-04 23:11:21.622092Z] Finished populate-webroot step (success) 16:11:21 INFO - [mozharness: 2016-08-04 23:11:21.622225Z] Running create-virtualenv step. 16:11:21 INFO - Running pre-action listener: _resource_record_pre_action 16:11:21 INFO - Running main action method: create_virtualenv 16:11:21 INFO - Creating virtualenv /builds/slave/test/build/venv 16:11:21 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 16:11:21 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:11:21 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:11:21 INFO - Using real prefix '/tools/python27' 16:11:21 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:11:22 INFO - Installing distribute.............................................................................................................................................................................................done. 16:11:25 INFO - Installing pip.................done. 16:11:25 INFO - Return code: 0 16:11:25 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:11:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:11:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:11:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:11:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:11:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:11:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:11:25 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 0x106788a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10681d618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffbc3d6bab0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1066ecd30>, '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 0x106451db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1066e4b20>, '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.WuMJTvJYDm/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.Rc8TnckJ8D/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:11:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 16:11:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:11:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WuMJTvJYDm/Render', 16:11:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:11:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:11:25 INFO - 'HOME': '/Users/cltbld', 16:11:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:11:25 INFO - 'LOGNAME': 'cltbld', 16:11:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:11:25 INFO - 'MOZ_NO_REMOTE': '1', 16:11:25 INFO - 'NO_EM_RESTART': '1', 16:11:25 INFO - 'PAGER': '/bin/cat', 16:11:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:11:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:11:25 INFO - 'PWD': '/builds/slave/test', 16:11:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:11:25 INFO - 'SHELL': '/bin/bash', 16:11:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Rc8TnckJ8D/Listeners', 16:11:25 INFO - 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/', 16:11:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:11:25 INFO - 'USER': 'cltbld', 16:11:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:11:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:11:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:11:25 INFO - 'XPC_FLAGS': '0x0', 16:11:25 INFO - 'XPC_SERVICE_NAME': '0', 16:11:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:11:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:11:25 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 16:11:25 INFO - Cleaning up... 16:11:25 INFO - Return code: 0 16:11:25 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:11:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:11:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:11:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:11:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:11:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:11:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:11:25 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 0x106788a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10681d618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffbc3d6bab0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1066ecd30>, '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 0x106451db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1066e4b20>, '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.WuMJTvJYDm/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.Rc8TnckJ8D/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:11:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 16:11:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 16:11:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WuMJTvJYDm/Render', 16:11:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:11:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:11:25 INFO - 'HOME': '/Users/cltbld', 16:11:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:11:25 INFO - 'LOGNAME': 'cltbld', 16:11:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:11:25 INFO - 'MOZ_NO_REMOTE': '1', 16:11:25 INFO - 'NO_EM_RESTART': '1', 16:11:25 INFO - 'PAGER': '/bin/cat', 16:11:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:11:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:11:25 INFO - 'PWD': '/builds/slave/test', 16:11:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:11:25 INFO - 'SHELL': '/bin/bash', 16:11:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Rc8TnckJ8D/Listeners', 16:11:25 INFO - 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/', 16:11:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:11:25 INFO - 'USER': 'cltbld', 16:11:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:11:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:11:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:11:25 INFO - 'XPC_FLAGS': '0x0', 16:11:25 INFO - 'XPC_SERVICE_NAME': '0', 16:11:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:11:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:11:25 INFO - Downloading/unpacking psutil>=3.1.1 16:11:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:11:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:11:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:11:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:11:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:11:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:11:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:11:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:11:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:11:28 INFO - Installing collected packages: psutil 16:11:28 INFO - Running setup.py install for psutil 16:11:28 INFO - building 'psutil._psutil_osx' extension 16:11:28 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 16:11:29 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 16:11:29 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 16:11:29 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 16:11:29 INFO - building 'psutil._psutil_posix' extension 16:11:29 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 16:11:29 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 16:11:29 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 16:11:29 INFO - ^ 16:11:29 INFO - 1 warning generated. 16:11:29 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 16:11:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:11:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:11:30 INFO - Successfully installed psutil 16:11:30 INFO - Cleaning up... 16:11:30 INFO - Return code: 0 16:11:30 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16: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')]} 16:11:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:11:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16: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')]} 16:11:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:11:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:11:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106788a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10681d618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffbc3d6bab0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1066ecd30>, '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 0x106451db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1066e4b20>, '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.WuMJTvJYDm/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.Rc8TnckJ8D/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:11:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 16:11:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 16:11:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WuMJTvJYDm/Render', 16:11:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:11:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:11:30 INFO - 'HOME': '/Users/cltbld', 16:11:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:11:30 INFO - 'LOGNAME': 'cltbld', 16:11:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:11:30 INFO - 'MOZ_NO_REMOTE': '1', 16:11:30 INFO - 'NO_EM_RESTART': '1', 16:11:30 INFO - 'PAGER': '/bin/cat', 16:11:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:11:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:11:30 INFO - 'PWD': '/builds/slave/test', 16:11:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:11:30 INFO - 'SHELL': '/bin/bash', 16:11:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Rc8TnckJ8D/Listeners', 16:11:30 INFO - 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/', 16:11:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:11:30 INFO - 'USER': 'cltbld', 16:11:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:11:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:11:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:11:30 INFO - 'XPC_FLAGS': '0x0', 16:11:30 INFO - 'XPC_SERVICE_NAME': '0', 16:11:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:11:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:11:30 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:11:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:11:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:11:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:11:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:11:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:11:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:11:32 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:11:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:11:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:11:32 INFO - Installing collected packages: mozsystemmonitor 16:11:32 INFO - Running setup.py install for mozsystemmonitor 16:11:33 INFO - Successfully installed mozsystemmonitor 16:11:33 INFO - Cleaning up... 16:11:33 INFO - Return code: 0 16:11:33 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:11:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:11:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:11:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:11:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:11:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:11:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:11:33 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 0x106788a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10681d618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffbc3d6bab0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1066ecd30>, '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 0x106451db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1066e4b20>, '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.WuMJTvJYDm/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.Rc8TnckJ8D/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:11:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 16:11:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 16:11:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WuMJTvJYDm/Render', 16:11:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:11:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:11:33 INFO - 'HOME': '/Users/cltbld', 16:11:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:11:33 INFO - 'LOGNAME': 'cltbld', 16:11:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:11:33 INFO - 'MOZ_NO_REMOTE': '1', 16:11:33 INFO - 'NO_EM_RESTART': '1', 16:11:33 INFO - 'PAGER': '/bin/cat', 16:11:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:11:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:11:33 INFO - 'PWD': '/builds/slave/test', 16:11:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:11:33 INFO - 'SHELL': '/bin/bash', 16:11:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Rc8TnckJ8D/Listeners', 16:11:33 INFO - 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/', 16:11:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:11:33 INFO - 'USER': 'cltbld', 16:11:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:11:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:11:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:11:33 INFO - 'XPC_FLAGS': '0x0', 16:11:33 INFO - 'XPC_SERVICE_NAME': '0', 16:11:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:11:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:11:33 INFO - Downloading/unpacking jsonschema==2.5.1 16:11:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:11:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:11:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:11:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:11:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:11:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:11:35 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:11:35 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:11:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:11:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:11:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:11:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:11:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:11:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:11:36 INFO - Downloading functools32-3.2.3-2.tar.gz 16:11:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:11:36 INFO - warning: no files found matching '*.txt' 16:11:36 INFO - no previously-included directories found matching 'build' 16:11:36 INFO - no previously-included directories found matching 'dist' 16:11:36 INFO - no previously-included directories found matching '.git*' 16:11:36 INFO - Installing collected packages: jsonschema, functools32 16:11:36 INFO - Running setup.py install for functools32 16:11:36 INFO - warning: no files found matching '*.txt' 16:11:36 INFO - no previously-included directories found matching 'build' 16:11:36 INFO - no previously-included directories found matching 'dist' 16:11:36 INFO - no previously-included directories found matching '.git*' 16:11:36 INFO - Successfully installed jsonschema functools32 16:11:36 INFO - Cleaning up... 16:11:36 INFO - Return code: 0 16:11:36 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:11:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:11:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:11:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:11:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:11:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:11:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:11:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x106788a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10681d618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffbc3d6bab0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1066ecd30>, '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 0x106451db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1066e4b20>, '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.WuMJTvJYDm/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.Rc8TnckJ8D/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:11:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 16:11:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 16:11:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WuMJTvJYDm/Render', 16:11:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:11:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:11:36 INFO - 'HOME': '/Users/cltbld', 16:11:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:11:36 INFO - 'LOGNAME': 'cltbld', 16:11:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:11:36 INFO - 'MOZ_NO_REMOTE': '1', 16:11:36 INFO - 'NO_EM_RESTART': '1', 16:11:36 INFO - 'PAGER': '/bin/cat', 16:11:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:11:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:11:36 INFO - 'PWD': '/builds/slave/test', 16:11:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:11:36 INFO - 'SHELL': '/bin/bash', 16:11:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Rc8TnckJ8D/Listeners', 16:11:36 INFO - 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/', 16:11:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:11:36 INFO - 'USER': 'cltbld', 16:11:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:11:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:11:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:11:36 INFO - 'XPC_FLAGS': '0x0', 16:11:36 INFO - 'XPC_SERVICE_NAME': '0', 16:11:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:11:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:11:36 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:11:36 INFO - Cleaning up... 16:11:36 INFO - Return code: 0 16:11:36 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:11:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:11:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:11:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:11:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:11:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:11:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:11:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x106788a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10681d618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffbc3d6bab0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1066ecd30>, '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 0x106451db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1066e4b20>, '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.WuMJTvJYDm/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.Rc8TnckJ8D/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:11:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:11:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:11:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WuMJTvJYDm/Render', 16:11:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:11:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:11:36 INFO - 'HOME': '/Users/cltbld', 16:11:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:11:36 INFO - 'LOGNAME': 'cltbld', 16:11:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:11:36 INFO - 'MOZ_NO_REMOTE': '1', 16:11:36 INFO - 'NO_EM_RESTART': '1', 16:11:36 INFO - 'PAGER': '/bin/cat', 16:11:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:11:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:11:36 INFO - 'PWD': '/builds/slave/test', 16:11:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:11:36 INFO - 'SHELL': '/bin/bash', 16:11:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Rc8TnckJ8D/Listeners', 16:11:36 INFO - 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/', 16:11:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:11:36 INFO - 'USER': 'cltbld', 16:11:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:11:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:11:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:11:36 INFO - 'XPC_FLAGS': '0x0', 16:11:36 INFO - 'XPC_SERVICE_NAME': '0', 16:11:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:11:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:11:37 INFO - Downloading/unpacking blobuploader==1.2.4 16:11:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:11:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:11:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:11:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:11:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:11:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:11:39 INFO - Downloading blobuploader-1.2.4.tar.gz 16:11:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:11:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:11:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:11:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:11:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:11:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:11:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:11:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:11:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:11:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:11:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:11:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:11:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:11:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:11:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:11:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:11:40 INFO - Downloading docopt-0.6.1.tar.gz 16:11:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:11:40 INFO - Installing collected packages: blobuploader, requests, docopt 16:11:40 INFO - Running setup.py install for blobuploader 16:11:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:11:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:11:40 INFO - Running setup.py install for requests 16:11:41 INFO - Running setup.py install for docopt 16:11:41 INFO - Successfully installed blobuploader requests docopt 16:11:41 INFO - Cleaning up... 16:11:41 INFO - Return code: 0 16:11:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:11:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:11:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:11:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:11:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:11:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:11:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:11:41 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 0x106788a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10681d618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffbc3d6bab0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1066ecd30>, '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 0x106451db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1066e4b20>, '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.WuMJTvJYDm/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.Rc8TnckJ8D/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:11:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:11:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:11:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WuMJTvJYDm/Render', 16:11:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:11:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:11:41 INFO - 'HOME': '/Users/cltbld', 16:11:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:11:41 INFO - 'LOGNAME': 'cltbld', 16:11:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:11:41 INFO - 'MOZ_NO_REMOTE': '1', 16:11:41 INFO - 'NO_EM_RESTART': '1', 16:11:41 INFO - 'PAGER': '/bin/cat', 16:11:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:11:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:11:41 INFO - 'PWD': '/builds/slave/test', 16:11:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:11:41 INFO - 'SHELL': '/bin/bash', 16:11:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Rc8TnckJ8D/Listeners', 16:11:41 INFO - 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/', 16:11:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:11:41 INFO - 'USER': 'cltbld', 16:11:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:11:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:11:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:11:41 INFO - 'XPC_FLAGS': '0x0', 16:11:41 INFO - 'XPC_SERVICE_NAME': '0', 16:11:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:11:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:11:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:11:42 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-JKzrsk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:11:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:11:42 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-PSvmKJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:11:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:11:42 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-7hgnGL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:11:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:11:42 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-_4lnJL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:11:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:11:42 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-ai0L4K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:11:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:11:42 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-zVSUr0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:11:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:11:42 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-OQm5ZG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:11:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:11:42 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-myefho-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:11:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:11:42 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-_hyYnM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:11:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:11:42 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-AjGE1Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:11:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:11:43 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-za82Rn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:11:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:11:43 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-WXr1Gl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:11:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:11:43 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-YyjKPe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:11:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:11:43 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-1IvoWa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:11:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:11:43 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-HiGP3x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:11:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:11:43 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-TfAG8s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:11:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:11:43 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-l49TJl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:11:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:11:43 INFO - Running setup.py install for manifestparser 16:11:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:11:43 INFO - Running setup.py install for mozcrash 16:11:44 INFO - Running setup.py install for mozdebug 16:11:44 INFO - Running setup.py install for mozdevice 16:11:44 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:11:44 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:11:44 INFO - Running setup.py install for mozfile 16:11:44 INFO - Running setup.py install for mozhttpd 16:11:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:11:44 INFO - Running setup.py install for mozinfo 16:11:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:11:44 INFO - Running setup.py install for mozInstall 16:11:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:11:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:11:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:11:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:11:44 INFO - Running setup.py install for mozleak 16:11:45 INFO - Running setup.py install for mozlog 16:11:45 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:11:45 INFO - Running setup.py install for moznetwork 16:11:45 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:11:45 INFO - Running setup.py install for mozprocess 16:11:45 INFO - Running setup.py install for mozprofile 16:11:45 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:11:45 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:11:45 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:11:45 INFO - Running setup.py install for mozrunner 16:11:45 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:11:45 INFO - Running setup.py install for mozscreenshot 16:11:46 INFO - Running setup.py install for moztest 16:11:46 INFO - Running setup.py install for mozversion 16:11:46 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:11:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:11:46 INFO - Cleaning up... 16:11:46 INFO - Return code: 0 16:11:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:11:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:11:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:11:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:11:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:11:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:11:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:11:46 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 0x106788a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10681d618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffbc3d6bab0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1066ecd30>, '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 0x106451db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1066e4b20>, '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.WuMJTvJYDm/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.Rc8TnckJ8D/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:11:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:11:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:11:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WuMJTvJYDm/Render', 16:11:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:11:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:11:46 INFO - 'HOME': '/Users/cltbld', 16:11:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:11:46 INFO - 'LOGNAME': 'cltbld', 16:11:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:11:46 INFO - 'MOZ_NO_REMOTE': '1', 16:11:46 INFO - 'NO_EM_RESTART': '1', 16:11:46 INFO - 'PAGER': '/bin/cat', 16:11:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:11:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:11:46 INFO - 'PWD': '/builds/slave/test', 16:11:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:11:46 INFO - 'SHELL': '/bin/bash', 16:11:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Rc8TnckJ8D/Listeners', 16:11:46 INFO - 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/', 16:11:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:11:46 INFO - 'USER': 'cltbld', 16:11:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:11:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:11:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:11:46 INFO - 'XPC_FLAGS': '0x0', 16:11:46 INFO - 'XPC_SERVICE_NAME': '0', 16:11:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:11:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:11:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:11:46 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-pDdDM9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:11:46 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 16:11:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:11:46 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-QyjioO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:11:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:11:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:11:46 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-m8TEEk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:11:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:11:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:11:46 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-yGEi7r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:11:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:11:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:11:47 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-pRhf2m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:11:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 16:11:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:11:47 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-k2bMSB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:11:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 16:11:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:11:47 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-cSrxwE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:11:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 16:11:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:11:47 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-vGqGK0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:11:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 16:11:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:11:47 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-Ejx9Eg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:11:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 16:11:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:11:47 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-vjBVVa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:11:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:11:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:11:47 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-5xSCs2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:11:47 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 16:11:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:11:47 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-aavE5d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:11:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 16:11:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:11:47 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-grutrF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:11:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 16:11:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:11:48 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-hesQLo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:11:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 16:11:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:11:48 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-w0Z3z1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:11:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 16:11:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:11:48 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-v8Xq7i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:11:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 16:11:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:11:48 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-vkCWyd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:11:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 16:11:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:11:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:11:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:11:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:11:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:11:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:11:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:11:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:11:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:11:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:11:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:11:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:11:50 INFO - Downloading blessings-1.6.tar.gz 16:11:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:11:50 INFO - Installing collected packages: blessings 16:11:50 INFO - Running setup.py install for blessings 16:11:51 INFO - Successfully installed blessings 16:11:51 INFO - Cleaning up... 16:11:51 INFO - Return code: 0 16:11:51 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:11:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:11:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:11:51 INFO - Reading from file tmpfile_stdout 16:11:51 INFO - Current package versions: 16:11:51 INFO - blessings == 1.6 16:11:51 INFO - blobuploader == 1.2.4 16:11:51 INFO - docopt == 0.6.1 16:11:51 INFO - functools32 == 3.2.3-2 16:11:51 INFO - jsonschema == 2.5.1 16:11:51 INFO - manifestparser == 1.1 16:11:51 INFO - mozInstall == 1.12 16:11:51 INFO - mozcrash == 0.17 16:11:51 INFO - mozdebug == 0.1 16:11:51 INFO - mozdevice == 0.48 16:11:51 INFO - mozfile == 1.2 16:11:51 INFO - mozhttpd == 0.7 16:11:51 INFO - mozinfo == 0.9 16:11:51 INFO - mozleak == 0.1 16:11:51 INFO - mozlog == 3.3 16:11:51 INFO - moznetwork == 0.27 16:11:51 INFO - mozprocess == 0.23 16:11:51 INFO - mozprofile == 0.28 16:11:51 INFO - mozrunner == 6.12 16:11:51 INFO - mozscreenshot == 0.1 16:11:51 INFO - mozsystemmonitor == 0.3 16:11:51 INFO - moztest == 0.7 16:11:51 INFO - mozversion == 1.4 16:11:51 INFO - psutil == 3.1.1 16:11:51 INFO - requests == 1.2.3 16:11:51 INFO - wsgiref == 0.1.2 16:11:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:11:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:11:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:11:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:11:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:11:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:11:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:11:51 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 0x106788a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10681d618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffbc3d6bab0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1066ecd30>, '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 0x106451db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1066e4b20>, '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.WuMJTvJYDm/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.Rc8TnckJ8D/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:11:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 16:11:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:11:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WuMJTvJYDm/Render', 16:11:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:11:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:11:51 INFO - 'HOME': '/Users/cltbld', 16:11:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:11:51 INFO - 'LOGNAME': 'cltbld', 16:11:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:11:51 INFO - 'MOZ_NO_REMOTE': '1', 16:11:51 INFO - 'NO_EM_RESTART': '1', 16:11:51 INFO - 'PAGER': '/bin/cat', 16:11:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:11:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:11:51 INFO - 'PWD': '/builds/slave/test', 16:11:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:11:51 INFO - 'SHELL': '/bin/bash', 16:11:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Rc8TnckJ8D/Listeners', 16:11:51 INFO - 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/', 16:11:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:11:51 INFO - 'USER': 'cltbld', 16:11:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:11:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:11:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:11:51 INFO - 'XPC_FLAGS': '0x0', 16:11:51 INFO - 'XPC_SERVICE_NAME': '0', 16:11:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:11:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:11:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:11:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 16:11:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 16:11:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:11:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 16:11:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 16:11:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 16:11:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 16:11:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 16:11:51 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:11:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:11:51 INFO - Cleaning up... 16:11:51 INFO - Return code: 0 16:11:51 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:11:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:11:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:11:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:11:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:11:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:11:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:11:51 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 0x106788a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10681d618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffbc3d6bab0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1066ecd30>, '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 0x106451db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1066e4b20>, '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.WuMJTvJYDm/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.Rc8TnckJ8D/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:11:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 16:11:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:11:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WuMJTvJYDm/Render', 16:11:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:11:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:11:51 INFO - 'HOME': '/Users/cltbld', 16:11:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:11:51 INFO - 'LOGNAME': 'cltbld', 16:11:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:11:51 INFO - 'MOZ_NO_REMOTE': '1', 16:11:51 INFO - 'NO_EM_RESTART': '1', 16:11:51 INFO - 'PAGER': '/bin/cat', 16:11:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:11:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:11:51 INFO - 'PWD': '/builds/slave/test', 16:11:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:11:51 INFO - 'SHELL': '/bin/bash', 16:11:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Rc8TnckJ8D/Listeners', 16:11:51 INFO - 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/', 16:11:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:11:51 INFO - 'USER': 'cltbld', 16:11:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:11:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:11:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:11:51 INFO - 'XPC_FLAGS': '0x0', 16:11:51 INFO - 'XPC_SERVICE_NAME': '0', 16:11:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:11:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:11:52 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:11:52 INFO - Cleaning up... 16:11:52 INFO - Return code: 0 16:11:52 INFO - Running post-action listener: _resource_record_post_action 16:11:52 INFO - Running post-action listener: _start_resource_monitoring 16:11:52 INFO - Starting resource monitoring. 16:11:52 INFO - [mozharness: 2016-08-04 23:11:52.060892Z] Finished create-virtualenv step (success) 16:11:52 INFO - [mozharness: 2016-08-04 23:11:52.061820Z] Running install step. 16:11:52 INFO - Running pre-action listener: _resource_record_pre_action 16:11:52 INFO - Running main action method: install 16:11:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:11:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:11:52 INFO - Reading from file tmpfile_stdout 16:11:52 INFO - Detecting whether we're running mozinstall >=1.0... 16:11:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:11:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:11:52 INFO - Reading from file tmpfile_stdout 16:11:52 INFO - Output received: 16:11:52 INFO - Usage: mozinstall [options] installer 16:11:52 INFO - Options: 16:11:52 INFO - -h, --help show this help message and exit 16:11:52 INFO - -d DEST, --destination=DEST 16:11:52 INFO - Directory to install application into. [default: 16:11:52 INFO - "/builds/slave/test"] 16:11:52 INFO - --app=APP Application being installed. [default: firefox] 16:11:52 INFO - mkdir: /builds/slave/test/build/application 16:11:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 16:11:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 16:12:26 INFO - Reading from file tmpfile_stdout 16:12:26 INFO - Output received: 16:12:26 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 16:12:26 INFO - Running post-action listener: _resource_record_post_action 16:12:26 INFO - [mozharness: 2016-08-04 23:12:26.536029Z] Finished install step (success) 16:12:26 INFO - [mozharness: 2016-08-04 23:12:26.536151Z] Running run-tests step. 16:12:26 INFO - Running pre-action listener: _resource_record_pre_action 16:12:26 INFO - Running main action method: run_tests 16:12:26 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:12:26 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:12:26 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:12:26 INFO - 2016-08-04 16:12:26.551 screenresolution[1635:7517] starting screenresolution argv=screenresolution get 16:12:26 INFO - 2016-08-04 16:12:26.553 screenresolution[1635:7517] Display 0: 1600x1200x32@60 16:12:26 INFO - 2016-08-04 16:12:26.559 screenresolution[1636:7520] starting screenresolution argv=screenresolution list 16:12:26 INFO - Available Modes on Display 0 16:12:26 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:12:26 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:12:26 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:12:26 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:12:26 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:12:26 INFO - Intel Iris: 16:12:26 INFO - Chipset Model: Intel Iris 16:12:26 INFO - Type: GPU 16:12:26 INFO - Bus: Built-In 16:12:26 INFO - VRAM (Dynamic, Max): 1536 MB 16:12:26 INFO - Vendor: Intel (0x8086) 16:12:26 INFO - Device ID: 0x0a2e 16:12:26 INFO - Revision ID: 0x0009 16:12:26 INFO - Displays: 16:12:26 INFO - Display: 16:12:26 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:12:26 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:12:26 INFO - Display Serial Number: 1600x1200 60 16:12:26 INFO - Main Display: Yes 16:12:26 INFO - Mirror: Off 16:12:26 INFO - Online: Yes 16:12:26 INFO - Rotation: Supported 16:12:26 INFO - Return code: 0 16:12:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:12:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:12:26 INFO - Python 2.7.3 16:12:26 INFO - Return code: 0 16:12:26 INFO - grabbing minidump binary from tooltool 16:12:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:12:26 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 0x1066ecd30>, '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 0x106451db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1066e4b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:12:26 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 16:12:26 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 16:12:26 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 16:12:26 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:12:26 INFO - Return code: 0 16:12:26 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 16:12:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:12:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:12:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 16:12:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:12:26 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/RzsrsBNcT0aybg8cY1DvaQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0098', '--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 16:12:26 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/RzsrsBNcT0aybg8cY1DvaQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0098 --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 16:12:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WuMJTvJYDm/Render', 16:12:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:12:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:12:26 INFO - 'HOME': '/Users/cltbld', 16:12:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:12:26 INFO - 'LOGNAME': 'cltbld', 16:12:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:12:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 16:12:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:12:26 INFO - 'MOZ_NO_REMOTE': '1', 16:12:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:12:26 INFO - 'NO_EM_RESTART': '1', 16:12:26 INFO - 'PAGER': '/bin/cat', 16:12:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:12:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:12:26 INFO - 'PWD': '/builds/slave/test', 16:12:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:12:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:12:26 INFO - 'SHELL': '/bin/bash', 16:12:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Rc8TnckJ8D/Listeners', 16:12:26 INFO - 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/', 16:12:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:12:26 INFO - 'USER': 'cltbld', 16:12:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:12:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:12:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:12:26 INFO - 'XPC_FLAGS': '0x0', 16:12:26 INFO - 'XPC_SERVICE_NAME': '0', 16:12:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:12:26 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/RzsrsBNcT0aybg8cY1DvaQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0098', '--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 16:12:27 INFO - mozversion application_buildid: 20160804140920 16:12:27 INFO - mozversion application_changeset: 8feacca30626875bcc86c49c9dd2b69cee281d98 16:12:27 INFO - mozversion application_display_name: Nightly 16:12:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:12:27 INFO - mozversion application_name: Firefox 16:12:27 INFO - mozversion application_remotingname: firefox 16:12:27 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 16:12:27 INFO - mozversion application_vendor: Mozilla 16:12:27 INFO - mozversion application_version: 51.0a1 16:12:27 INFO - mozversion platform_buildid: 20160804140920 16:12:27 INFO - mozversion platform_changeset: 8feacca30626875bcc86c49c9dd2b69cee281d98 16:12:27 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 16:12:27 INFO - mozversion platform_version: 51.0a1 16:12:27 INFO - using testdate: 1470352347 16:12:27 INFO - actual date: 1470352347 16:12:27 INFO - starting webserver on 'localhost:49267' 16:12:27 INFO - SUITE-START | Running 2 tests 16:12:27 INFO - TEST-START | dromaeo_css 16:12:27 INFO - operating with platform_type : mac_ 16:12:27 INFO - Initialising browser for dromaeo_css test... 16:12:27 INFO - TEST-INFO | started process 1646 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/tmpR6ZqGs/profile http://localhost:49267/getInfo.html) 16:12:30 INFO - PROCESS | 1646 | __metrics Screen width/height:1600/1200 16:12:30 INFO - PROCESS | 1646 | colorDepth:24 16:12:30 INFO - PROCESS | 1646 | Browser inner width/height: 1024/689 16:12:30 INFO - PROCESS | 1646 | __metrics 16:12:30 ERROR - PROCESS | 1646 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 16:12:30 INFO - TEST-INFO | 1646: exit 0 16:12:30 INFO - Browser initialized. 16:12:30 INFO - Running cycle 1/1 for dromaeo_css test... 16:12:30 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/tmpR6ZqGs/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:12:43 INFO - PROCESS | 1649 | RSS: Main: 254394368 16:12:43 INFO - PROCESS | 1649 | 16:13:32 INFO - PROCESS | 1649 | 1470352412717 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 16:15:44 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49267/tests/dromaeo/cssquery-ext.html) 16:15:45 INFO - PROCESS | 1649 | RSS: Main: 267227136 16:15:45 INFO - PROCESS | 1649 | 16:18:48 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-ext.html (next: http://localhost:49267/tests/dromaeo/cssquery-jquery.html) 16:18:48 INFO - PROCESS | 1649 | RSS: Main: 282636288 16:18:48 INFO - PROCESS | 1649 | 16:21:50 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49267/tests/dromaeo/cssquery-mootools.html) 16:21:51 INFO - PROCESS | 1649 | RSS: Main: 289058816 16:21:51 INFO - PROCESS | 1649 | 16:24:53 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49267/tests/dromaeo/cssquery-prototype.html) 16:24:53 INFO - PROCESS | 1649 | RSS: Main: 288305152 16:24:53 INFO - PROCESS | 1649 | 16:27:56 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49267/tests/dromaeo/cssquery-yui.html) 16:27:57 INFO - PROCESS | 1649 | RSS: Main: 292864000 16:27:57 INFO - PROCESS | 1649 | 16:30:59 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-yui.html (next: http://localhost:49267/tests/dromaeo/cssquery-dojo.html) 16:31:00 INFO - PROCESS | 1649 | RSS: Main: 293044224 16:31:00 INFO - PROCESS | 1649 | 16:31:00 INFO - PROCESS | 1649 | __start_tp_report 16:31:00 INFO - PROCESS | 1649 | _x_x_mozilla_page_load 16:31:00 INFO - PROCESS | 1649 | _x_x_mozilla_page_load_details 16:31:00 INFO - PROCESS | 1649 | |i|pagename|runs| 16:31:00 INFO - PROCESS | 1649 | |0;dojo.html;3324.25204329026;3330.9500357494635;3352.966470335297;3353.882614108507;3354.362671092491;5339.5728341732665;5514.503694667479;5578.30271216098;5591;5655.745491452884;4485.394471746314;5569.637973531728;5582.581306402016;5620.494155526002;5683.943160568393;5000.07498612756;5129.666571672829;5157.9684063187515;5211.843644690646;5318.9202161967605;5216.426193118773;5222.529972302492;5255.159174532076;5291.31212942317;5296.3379577552805;5041.19340905457;5089.389273287192;5104.897902041938;5145.716985565792;5147;3842.9807850960847;5119.308893299394;5145.176771716545;5166;5174.870628234286;5098.260752190911;5163.432022477525;5170.405403378622;5191.428942816287;5196.532312091892;4499.572540608669;4905.386826646669;5031.616305515976;5589.105743081128;5642.435756424325;6096.542759293026;6100.816975490742;6126.081087836816;6128.846778830521;6169.5064394848305;6223.8132856013935;6225.7509699611965;6229.844253893643;6245.125682404467;6252.124702541648;5411.702356370398;5704.543636509069;5743.54051675865;5750.453706897838;5826.766929322865;6213.763045303687;6262.6868656566985;6270.498360131179;6272.6550039747335;6328.7468501260355;6098.451139397387;6107.633541987495;6131.693415329216;6141.877162456726;6143.96928015366;6052.213212282463;6126.78556250538;6147.846303842351;6158.692065396802;6212.596181248295;5626.831195064155;6105.786297479567;6143.143438301211;6153.384661533811;6204.410580994799;5965.991064943342;6162.168107305456;6164.229471316085;6197.504199664016;6227.159333490012;4778.068276686083;4839.467658557556;4894.412670479565;4921.557059864629;4925.704457732548;4265.829366825292;4348.0869017506675;4366.737995720267;4389.1660584488845;4424.933625995613;5618.932402843447;5651.886962260732;5684.602077854511;5685.431456854281;5705.800296989585;6270.968645156745;6273.435390814758;6285.77999770015;6286.434220920048;6297.023961286008;5477.698726570077;5580.469855363734;5660.603757737002;5669.149627555899;5670.347909990322;5317.255584218213;5321.095413779667;5368.7047212403695;5393.865153371197;5395.05586522357;6215.844603884849;6251.843703907348;6269.341719119427;6270.717817698123;6290.025046117859;6121.818815678178;6136.631802091889;6232.065190221322;6233.345498722569;6268.153799237045;6166.784162554289;6256.7810126645345;6264.780732674334;6266.185395898504;6284.717187726655;6129.724162412613;6138.907916381168;6145.139680444652;6158.983767678462;6167.660778657217;6072.544559157993;6104.822969073451;6210.844728881814;6217.129601855653;6284.277308109443;5760.654360738369;6001.339852616296;6011.218541589566;6038.818835434944;6094.908576371269;5907.675077870758;6000.429959153874;6018.127371531191;6049;6063.484603808549;5694.857628559153;5718.827640333805;5815.563832712648;5847.912281315698;5894.145348924468;6030.969845150747;6081.878362432815;6106.175666285172;6124.448799608057;6138.263408391022;5036.169032109661;5864.618799778001;5870.618409803349;5880.529557635294;5884.764609415575 16:31:00 INFO - PROCESS | 1649 | |1;ext.html;493.6791085794233;522.5323335614625;556.2879514221796;562.3139769481231;600.8828278485691;30515.847420762922;38857.83426497203;39157;40560.79719601398;40841.183176336526;41412.37881431781;41634.791826040826;41870;42244.78877605616;42264.15471690572;9488.098630630097;9675.806483870318;9735.367201131903;9750.12248897599;9771.755706107333;9631.71104866855;9654.903450965507;9678;9735.17251033663;9736.75658108546;9691.806163876754;9736.95131524345;9764.804703905953;9771.36486128403;9772.90227097727;9694.321397502177;9703.757406064835;9753.658621948198;9766.9511652442;9768.413895166314;9663.420194788336;9755.365901216399;9755.609775608968;9788.412695238309;9790.706278811647;39349;39428.80285598554;39732.80133599343;39824.80087599572;40127.39808902869;3199.792013519137;3735.477033215352;4065.878023659265;4072.7759973201464;4145.253854306224;30586.413318640585;30862.382752345053;31519.84240078785;31651.683483165103;31810.204744881332;3187.681231876817;3311.9006429806905;3332.216929021702;3339.6493368196475;3353;500964;501200.99999999633;504269;506100;508219;59082.70458647679;59733.402665973656;60239;60281.39718602846;60464.395356045876;59983.40016599865;60978.69510652418;61510;61510.38489615046;61770.38229617646;15723.292451839694;15819.288132034086;15986.76019859703;15996.920015399848;16003.679926401406;11887.821682674767;11897.286162830258;12362.258264504158;12410.317432541116;12446.315452650191;15698.293576789072;16277.267522961494;16372.426965056404;16381.83618163827;16414.09722465252;6904.482163837632;6977.197622273504;6986.755463558751;6991.860162796817;7101;901.3510272603846;920.852663573825;943.104051151409;959.0936564946198;1073.8335557988523;29521;29987.400251995274;30494.69505304963;30629.38741225163;30728.53235370484;1005.3465247589126;1067.8771941226858;1077.9461026948777;1078.924475286738;1093.5407129005837;15834.920825395799;15837.049777013415;15864.762028569581;16040.518784436486;16043.410759838272;645390;648823;650606;653010;654528;49231.75384123128;58536.12195817066;58650;58811.411885880596;58846.70576647089;1360.3946243921557;1362.3937347880296;1412.8587141285789;1413.8586141385779;1414.8655877691604;28421.147365579065;29083.70916290895;29580.852095740243;30322.938697145495;30885.382292353577;50790.74604626953;51103.233451499;51235;51246.74376628242;51305.23042154445;569452;573224;573478.1326093343;574178;575681;41129.588704112575;41279.58720412877;41702.95742606459;42016;42057;47278;47480;48863.02273954572;49083;49391.506084938694;33855.66144338525;39518;39971.60028399679;40528.392074118325;41432;38977.6102238974;39200.62797802063;39501.41530516057;40185.79907100446;40307.79846100751;32818;38877.222455551295;39387.01532461711;39487.80256098701;40507.59492405038;31656.525152122274;34286.82856585701;34457;34793.9561813146;35219.647803521635;22152.889235553717;26043.869780650977;26289.474210515302;26610.334741631614;26918 16:31:00 INFO - PROCESS | 1649 | |2;jquery.html;309.945759492089;373.80562107704;378.80112940706135;392.2958289869684;396.3836234655112;20102.296419625316;20407.387778366654;21043.47391315218;21262.57474850504;21495.67756483654;11592.536298548048;11776.7644647107;11910;12300.323482208474;12317.199382040184;5450.727463626823;5683.2895888014;5685.800996965107;5697.77208911643;5709.942900570983;3988.222296652154;5650.63270887391;6679.833004174886;7006.89489657653;7011.404030657375;6132.540059495534;6870.900655895058;6998.265182155877;7013.193482749472;7047.541909775849;6224;6282.465990390845;6285.43431091204;6298.496120310364;6310.400511951358;5439.945600543983;5753.683547404891;6067.696615169224;6081.635101893857;6124.540659450559;13412.329383530785;13798.034137610372;13802.585922422344;20697.58604827895;26524;2173.5218251984697;2193.0350645715835;2242.136777340719;2343.730470995823;2362.70466191726;10138.797224055477;10144.391336519759;10294.43380614066;10421.791564168674;10468.214883883738;1844.6402951424477;1931.2661188748327;1957.5595491014408;1960.0885588201554;1964.8919309437974;126758.36620816837;130690.3465482676;131046;133099.66900330968;133389.33305333508;11424.885751142383;11606.187566870407;11709.88290117105;11866;12005.699857503632;12299.69250768738;14662.266886655625;14705.632359191106;14761.188134652697;14780.778288325684;8335.637814561655;8619.060711340024;8622.870656940151;8632.69785557515;8766.736997890073;8100.878486822702;8398.41211115216;8505;8539.231469167804;8646.913530864611;3961.504811898513;4592.08158368321;4607.493175750665;4610.170169369479;4675.064987002613;1774.5829730013436;1815.228527875674;1888.291890541047;1918;1942.7760510878338;835.4903508859591;877.8463768840427;894.7494701483595;903.8508646073456;962.4369743700014;16519.587010324838;20857.791422085887;21031.474213144487;21268.680969785466;21315.573688526143;920.2867777472512;953.8125034332301;959.9232061435068;988.9357191782511;1034.1984961654778;10965.890341096647;11273.436328183721;11279.548818047351;11286.604968826052;11309.717257068474;574263;608879.9556002192;613061.8693813094;622412;629823;61884.38115618876;124180.37909810574;125618;125648;137959;954.355809828377;964.1611797736015;993.2997236947934;995.5918073589794;1000.6097621927454;18513.9074304633;18528.536786580444;18826.52933676669;18844;18847.24611015544;36427.45358819673;47746;50824;53970;55442;59871;65339.40633265216;75729.62135189289;80144;80312.59843700744;7677.654505547152;7840.176781438095;7909.802254943673;7993.6003199838615;8052.235037671412;10860.402677852479;11738.295702257892;13090.934545327213;13502.932485337904;13563.728725425239;9775.364601300893;10134.493275336055;10138.949305253427;10628.202884783517;11161.776764464828;9847.818261808628;10536.209784266364;10744.677659670222;11495.310281383145;11580.36308003068;8939.687110951085;10391.116755075904;11159.609413670483;11412.714682133013;11590.304581725124;8211.096779354386;8240.958795205986;8533.957330213558;8666.653333866574;8667;10064.597416103567;11549.307041577533;11796.410179491162;11860.40697965081;11943.462544185706 16:31:00 INFO - PROCESS | 1649 | |3;mootools.html;1518.2181176694005;1539.6766678997412;1746.4585978346706;1836.706127019677;1857.062183597284;7744.457887947846;8254.257116859482;8302.95848520758;8645.69740059098;8761.56192190391;8388.580570971457;8455.450395724289;8498.915010849889;8545.401821872472;8554.44396114252;2283.4519715268298;2320.0835669910375;2325.069972011192;2327.569399661068;2332.9533409331802;2253.7746225377414;2280.1107568048474;2292.4383526036145;2296.4144143243534;2305.3314538783734;2247.1573160064977;2272.1025195047946;2279.099755596538;2287.336672365012;2308.1113771198043;2230.353197572702;2236.250855963246;2239.8432109752325;2250.0999600159985;2255.01906670598;2250.077468238031;2282.3381219446505;2286.4969706664674;2286.8284878634004;2299.0229152610073;8517.148285171495;8558.400911936167;8600;8628.956855215683;8634.136586341316;4997.6501644884875;5000.0999820032375;5144.665596736238;5153.304303918961;5153.665011774223;3380.8309584520675;3484.61669216386;3549.112721819545;3563.94654080189;3574.267275208576;1070.336391437306;1076.386459717961;1077.4828082520355;1083.6153165626247;1098.280626189847;11072.833907491395;11087.168462365275;11165.939235772588;11188.944055279753;11235.04502117321;4261.595148460891;4261.637760790368;4426.490953540384;4436.733795972252;4439.733615983051;8575.957120214483;8622;8790.340724445692;8793;8797.868031979526;4974.9751251243515;5018.949810501921;5036.420811606712;5050.6464547482055;5077.136886729265;3822.9044273893373;4621.584057434847;4742.73914934675;4750.287456881426;4758.2386818108935;3578.1393675288705;3681.226942342138;3682.4660424238336;3723.4600982857332;3728.5525736911745;1076.5586109694987;1122.7698321844002;1126.645106791358;1128.227164392394;1130.513879032024;784.9882251766228;867.3884911137633;871.8605023196258;908.6274627402734;913.3104506097986;5540.612157149041;5547.750351234205;5770.913436298459;5847.970760146172;5953.9878220702585;955.8422860227985;1007.1238022920106;1022.0188618925914;1038.1642777564134;1039.6880935719255;3865.6714179295077;3869.8258578364043;3884.3396622573664;4010.6791456683395;4065.329220678555;8782.692605758895;10086.49567521621;10340.638077667245;10514.894851051391;10520.789584208425;10123.139533139618;10252;10465.738356540995;10482.580696772196;10501.947490262653;7713.112992005991;7773.144954055049;8048.839023219502;8050.718224862102;8056.113827478973;5240.371155461216;5628.60599758013;5650.773969041356;5756.136579513107;5766.769329226784;7458.776236712907;9386.389884657749;9552.713418597454;9625.614975401186;9657.855132173163;8664.78338041554;9651.806963860823;9719.708408747749;9833.065858743408;9912.950435247778;6419.325970773189;6867.484938629523;6899.482538809509;7000.474964377794;7005.579665220103;7168.605726685082;8234.835303293781;8368.20502052304;8413.747587572383;8417.116202798617;7348;7513.812154696177;7514.699412023458;7576.621168941641;7597.278258565428;7241;7280.126384833854;7362.969184314094;7409.444291678038;7448.9627551861895;6932.44540436774;6951.582905025714;6986.895196572157;7019.613921234381;7028.051213086168;4890.535399137077;4964.652474326763;5005.299258103795;5026.246063090565;5062.924056139234;4878.609711223165;4879.341288926092;5006.424261210008;5123.795048198031;5128.7179205144075 16:31:00 INFO - PROCESS | 1649 | |4;prototype.html;286.79637457405244;304.6100990731863;310.7110387339773;310.88808029109526;311.4005539336776;4166.520850102239;5212.817551385702;5227.843164705056;5508.724563771815;5532.280803495545;4873;5245.291885595453;5273.630845840793;5300.893982120365;5456.48163424474;3367.696907278338;4185.388625379236;4187.60217779312;4190.769507677077;4220.345846393814;3285.967140328602;3872.9806350968347;4209.1581683663235;4215.398148703488;4227.87316380509;3507.5966263879727;3551.5738111426535;3934;4053.5946405359523;4098.139390727951;4078.7552746835286;4086.223617512663;4106.486689163855;4128.380742888561;4138;3130.796498227608;3137.952930706041;3456.6024907135497;3552.8578856845697;3578.570571531433;5129.589632829365;5269.104252277122;5286.762095705702;5307.894881494331;5364.390682795146;4155.58444155585;4718.882027949295;4749.382580264578;4755.310479980418;4790.952090479085;5591.8881622367735;5671.2060311556415;5733.168690539848;5749.741261643236;5864.882702345972;3434.845431955568;3872.845086196549;3884.3590807516725;3887.1253967857288;3919.8432062717457;4712.929306060412;5449.836504904859;5710.573655806525;6125.816225513197;6141.188349436882;3579.087332730137;3601.6938560222675;3777.433384992218;3902.2780785554764;3929.2730844793805;3356.81537515439;3985.9202815943518;4007.499062617173;4020.557738648746;4027.81874815634;4116.58834116592;4467.6202522785925;4639.8608041758125;4728.267118596623;4733.242681170997;4936.407631084293;5653.717314134276;5818.389069147764;5906;5912.113183022581;1292.08907720059;1313.4614807928704;1334.8932085433141;1369.9931500342434;1388.4654408052972;724.1455083002108;805.778410936997;823.8517066927891;834.845553572591;840.7519781664423;4488.775561221926;4624.514425985223;4633.351330813689;4643.303504474356;4659.58063774262;4646.86059418218;4680.7191568506;4995.725235112103;5001.64988450805;5092.032513822362;4021.798910054544;4556.589906908394;4625.190591646448;4667.649926255544;4682.297655351656;2737.8090530619243;2798.398344355973;2867.985660071686;3089.2276930767307;3130.2330928922106;5807.0998995155815;5869.972754767899;6182.474489668429;6183.103449999725;6206.472449841724;5613.270274864323;5820.650760954356;6139.907901381483;6194.318624951252;6247.125402443661;5994.400559943971;6082.148499210026;6283.403076707706;6311.747530098744;6382.128042380948;5867.295924489089;6033.336333003454;6123.234595675541;6124.6325220486915;6166.229221347332;5044.798208071783;5901.996660567628;5918.615290006308;5985.790497332572;5997;6031.035034394476;6044.637321760709;6280.550585271656;6307.526935479766;6317.873642527032;2983.761738878428;3356.5468661730356;3374.827661997714;3925.4111883216606;3990.580988996114;4911.68074075184;4949.950500495093;5517.641353312022;5643.407442218508;6037.547183961133;4734.502877197845;5506.944930550643;5691.630044047124;5849.268841394825;5911.940880591139;5498.835034948958;5797.159411885337;5849.707514624167;5854.2389489367815;5856.184582779352;5061.633358993125;5426.728663566727;5629.8592535186945;5715.513322042343;5768.94231057684;5558.694271815089;5723.484886360247;5835.328937172109;5874.530037597067;5920.940790592039;4644.442666879996;5623.803166889139;5713.657180569013;5716.771329146787;5726.541876649775 16:31:00 INFO - PROCESS | 1649 | |5;yui.html;666.7066490744072;677.9728810847566;731.1737736357915;746.0450623202299;760.1600231743924;14116;14499.637509062253;14536.982411231218;14651.70696586069;14678.706425871489;13430.529931452402;13534.661633459169;13558.593242202725;13581.253031083286;13592.116512426684;676.4081428749844;831.584207896052;846.0566468387749;851.2891735400948;855.9914400855974;863.3136656358179;865.312076898867;865.9826803463927;867.7917299848023;868.409481552544;892.6161750447305;917.4541148016953;918.5361392496814;919.8114386550775;920.7606022434181;886.2953951608487;910.6858133943779;912.192709452133;912.7307444303913;916.894557125929;661.1141070964931;681.322084525895;682.1950098883316;682.6859644563507;684.685044879356;14073.5074272401;14248.92875535626;14257.64355891111;14258.28708564578;14266.92866535671;12037.458314375874;12324.260544367367;12952.287624180666;13042.673933151653;13311.800322995163;10706.839397409045;11019.338839669645;11046.392448415334;11142.49858756358;11542.36516991565;3548.6983606393487;3696.611855755134;3718.1262403335195;3748.9625103748886;3844.2695887781233;84206.57896710477;85566;118003.75770254647;124867.12699309608;126016.36991815074;9807.950960245153;9918.206543476505;10073;10085.848712269322;10294.124999374988;17663.38178163784;21820.563588728135;21850.12599496034;21867.12531498754;21961.890190548944;6320.8419789504715;7428.034355533746;7466.253374662599;7591.772246832494;7724.6910123594425;4204.411382406465;4263.317869140923;4306.978465107654;4377.080813029236;4454.354118652777;3101.8293993830557;3183.761217908666;3191.2181515528846;3193.3294008258063;3218.3241519281214;584.1558947321165;598.2641351138037;606.5875204860737;621.9098230756606;644.8549076457854;586.3110844757393;607.2834055814182;659.307726886767;670.9261981182066;681.8670359279992;7146.642667866586;8871.249912527137;9201.677941272023;9359.87681478227;9388.577514011886;667.2226855713039;672.5372315214389;672.5695554844904;688.9271075469718;697.2504557600599;4106.788497393276;4328.199283132631;4367.956320436755;4552;4553.817847286137;143298;160677;161009;166855;172630;133446.33276833553;135488.64511354957;135572;136627;136788;100615;122067.38966305289;123229.38385308016;123760.76239237672;126339;8201.30288925448;8487.363447741567;8508.404411691123;8891.836775100614;9015.594298256463;44021;56004;66432.6678366605;66615;69542.30457695358;69080.6545967267;86837.56581217053;87064;88135.27120737132;94759.52620236855;10688;11289.548418063514;11426.314421134759;12619.74760504803;13360.131591446525;12274.693132671755;12498.75002499963;12898.935505322414;14096.859031409555;15425.997310174802;13034.869651303745;13311.467541298627;13327.933360333136;13698.315084245549;14130.293485325486;13707.314634268447;13857.79213311781;13875.236861972688;13941.302934853014;13962.4415023402;13278.148997706425;13512.072890668884;13566.86433135656;13767.655808604864;13921.164730116225;11094.833577496505;11185.992503057432;11567.421628918688;11585.304881707125;12199.207051541622;9228.35401521887;9756.658516952157;10153.035461631132;10257.58969641206;10294.794104118026 16:31:00 INFO - PROCESS | 1649 | __end_tp_report 16:31:00 INFO - PROCESS | 1649 | __start_cc_report 16:31:00 INFO - PROCESS | 1649 | _x_x_mozilla_cycle_collect,412 16:31:00 INFO - PROCESS | 1649 | __end_cc_report 16:31:00 INFO - PROCESS | 1649 | __startTimestamp1470353460054__endTimestamp 16:31:00 INFO - PROCESS | 1649 | 16:31:00 INFO - PROCESS | 1649 | ------- Summary: start ------- 16:31:00 INFO - PROCESS | 1649 | Number of tests: 6 16:31:00 INFO - PROCESS | 1649 | 16:31:00 INFO - PROCESS | 1649 | [#0] dojo.html Cycles:165 Average:5652.25 Median:5864.62 stddev:669.46 (11.4%) stddev-sans-first:646.12 16:31:00 INFO - PROCESS | 1649 | Values: 3324.3 3331.0 3353.0 3353.9 3354.4 5339.6 5514.5 5578.3 5591.0 5655.7 4485.4 5569.6 5582.6 5620.5 5683.9 5000.1 5129.7 5158.0 5211.8 5318.9 5216.4 5222.5 5255.2 5291.3 5296.3 5041.2 5089.4 5104.9 5145.7 5147.0 3843.0 5119.3 5145.2 5166.0 5174.9 5098.3 5163.4 5170.4 5191.4 5196.5 4499.6 4905.4 5031.6 5589.1 5642.4 6096.5 6100.8 6126.1 6128.8 6169.5 6223.8 6225.8 6229.8 6245.1 6252.1 5411.7 5704.5 5743.5 5750.5 5826.8 6213.8 6262.7 6270.5 6272.7 6328.7 6098.5 6107.6 6131.7 6141.9 6144.0 6052.2 6126.8 6147.8 6158.7 6212.6 5626.8 6105.8 6143.1 6153.4 6204.4 5966.0 6162.2 6164.2 6197.5 6227.2 4778.1 4839.5 4894.4 4921.6 4925.7 4265.8 4348.1 4366.7 4389.2 4424.9 5618.9 5651.9 5684.6 5685.4 5705.8 6271.0 6273.4 6285.8 6286.4 6297.0 5477.7 5580.5 5660.6 5669.1 5670.3 5317.3 5321.1 5368.7 5393.9 5395.1 6215.8 6251.8 6269.3 6270.7 6290.0 6121.8 6136.6 6232.1 6233.3 6268.2 6166.8 6256.8 6264.8 6266.2 6284.7 6129.7 6138.9 6145.1 6159.0 6167.7 6072.5 6104.8 6210.8 6217.1 6284.3 5760.7 6001.3 6011.2 6038.8 6094.9 5907.7 6000.4 6018.1 6049.0 6063.5 5694.9 5718.8 5815.6 5847.9 5894.1 6031.0 6081.9 6106.2 6124.4 6138.3 5036.2 5864.6 5870.6 5880.5 5884.8 16:31:00 INFO - PROCESS | 1649 | 16:31:00 INFO - PROCESS | 1649 | [#1] ext.html Cycles:180 Average:71147.05 Median:41345.98 stddev:154660.89 (374.1%) stddev-sans-first:155003.78 16:31:00 INFO - PROCESS | 1649 | Values: 493.7 522.5 556.3 562.3 600.9 30515.8 38857.8 39157.0 40560.8 40841.2 41412.4 41634.8 41870.0 42244.8 42264.2 9488.1 9675.8 9735.4 9750.1 9771.8 9631.7 9654.9 9678.0 9735.2 9736.8 9691.8 9737.0 9764.8 9771.4 9772.9 9694.3 9703.8 9753.7 9767.0 9768.4 9663.4 9755.4 9755.6 9788.4 9790.7 39349.0 39428.8 39732.8 39824.8 40127.4 3199.8 3735.5 4065.9 4072.8 4145.3 30586.4 30862.4 31519.8 31651.7 31810.2 3187.7 3311.9 3332.2 3339.6 3353.0 500964.0 501201.0 504269.0 506100.0 508219.0 59082.7 59733.4 60239.0 60281.4 60464.4 59983.4 60978.7 61510.0 61510.4 61770.4 15723.3 15819.3 15986.8 15996.9 16003.7 11887.8 11897.3 12362.3 12410.3 12446.3 15698.3 16277.3 16372.4 16381.8 16414.1 6904.5 6977.2 6986.8 6991.9 7101.0 901.4 920.9 943.1 959.1 1073.8 29521.0 29987.4 30494.7 30629.4 30728.5 1005.3 1067.9 1077.9 1078.9 1093.5 15834.9 15837.0 15864.8 16040.5 16043.4 645390.0 648823.0 650606.0 653010.0 654528.0 49231.8 58536.1 58650.0 58811.4 58846.7 1360.4 1362.4 1412.9 1413.9 1414.9 28421.1 29083.7 29580.9 30322.9 30885.4 50790.7 51103.2 51235.0 51246.7 51305.2 569452.0 573224.0 573478.1 574178.0 575681.0 41129.6 41279.6 41703.0 42016.0 42057.0 47278.0 47480.0 48863.0 49083.0 49391.5 33855.7 39518.0 39971.6 40528.4 41432.0 38977.6 39200.6 39501.4 40185.8 40307.8 32818.0 38877.2 39387.0 39487.8 40507.6 31656.5 34286.8 34457.0 34794.0 35219.6 22152.9 26043.9 26289.5 26610.3 26918.0 16:31:00 INFO - PROCESS | 1649 | 16:31:00 INFO - PROCESS | 1649 | [#2] jquery.html Cycles:180 Average:34654.07 Median:2353.22 stddev:101814.02 (4326.6%) stddev-sans-first:102066.97 16:31:00 INFO - PROCESS | 1649 | Values: 309.9 373.8 378.8 392.3 396.4 20102.3 20407.4 21043.5 21262.6 21495.7 11592.5 11776.8 11910.0 12300.3 12317.2 5450.7 5683.3 5685.8 5697.8 5709.9 3988.2 5650.6 6679.8 7006.9 7011.4 6132.5 6870.9 6998.3 7013.2 7047.5 6224.0 6282.5 6285.4 6298.5 6310.4 5439.9 5753.7 6067.7 6081.6 6124.5 13412.3 13798.0 13802.6 20697.6 26524.0 2173.5 2193.0 2242.1 2343.7 2362.7 10138.8 10144.4 10294.4 10421.8 10468.2 1844.6 1931.3 1957.6 1960.1 1964.9 126758.4 130690.3 131046.0 133099.7 133389.3 11424.9 11606.2 11709.9 11866.0 12005.7 12299.7 14662.3 14705.6 14761.2 14780.8 8335.6 8619.1 8622.9 8632.7 8766.7 8100.9 8398.4 8505.0 8539.2 8646.9 3961.5 4592.1 4607.5 4610.2 4675.1 1774.6 1815.2 1888.3 1918.0 1942.8 835.5 877.8 894.7 903.9 962.4 16519.6 20857.8 21031.5 21268.7 21315.6 920.3 953.8 959.9 988.9 1034.2 10965.9 11273.4 11279.5 11286.6 11309.7 574263.0 608880.0 613061.9 622412.0 629823.0 61884.4 124180.4 125618.0 125648.0 137959.0 954.4 964.2 993.3 995.6 1000.6 18513.9 18528.5 18826.5 18844.0 18847.2 36427.5 47746.0 50824.0 53970.0 55442.0 59871.0 65339.4 75729.6 80144.0 80312.6 7677.7 7840.2 7909.8 7993.6 8052.2 10860.4 11738.3 13090.9 13502.9 13563.7 9775.4 10134.5 10138.9 10628.2 11161.8 9847.8 10536.2 10744.7 11495.3 11580.4 8939.7 10391.1 11159.6 11412.7 11590.3 8211.1 8241.0 8534.0 8666.7 8667.0 10064.6 11549.3 11796.4 11860.4 11943.5 16:31:00 INFO - PROCESS | 1649 | 16:31:00 INFO - PROCESS | 1649 | [#3] mootools.html Cycles:180 Average:5494.28 Median:5005.86 stddev:3029.68 (60.5%) stddev-sans-first:3023.44 16:31:00 INFO - PROCESS | 1649 | Values: 1518.2 1539.7 1746.5 1836.7 1857.1 7744.5 8254.3 8303.0 8645.7 8761.6 8388.6 8455.5 8498.9 8545.4 8554.4 2283.5 2320.1 2325.1 2327.6 2333.0 2253.8 2280.1 2292.4 2296.4 2305.3 2247.2 2272.1 2279.1 2287.3 2308.1 2230.4 2236.3 2239.8 2250.1 2255.0 2250.1 2282.3 2286.5 2286.8 2299.0 8517.1 8558.4 8600.0 8629.0 8634.1 4997.7 5000.1 5144.7 5153.3 5153.7 3380.8 3484.6 3549.1 3563.9 3574.3 1070.3 1076.4 1077.5 1083.6 1098.3 11072.8 11087.2 11165.9 11188.9 11235.0 4261.6 4261.6 4426.5 4436.7 4439.7 8576.0 8622.0 8790.3 8793.0 8797.9 4975.0 5018.9 5036.4 5050.6 5077.1 3822.9 4621.6 4742.7 4750.3 4758.2 3578.1 3681.2 3682.5 3723.5 3728.6 1076.6 1122.8 1126.6 1128.2 1130.5 785.0 867.4 871.9 908.6 913.3 5540.6 5547.8 5770.9 5848.0 5954.0 955.8 1007.1 1022.0 1038.2 1039.7 3865.7 3869.8 3884.3 4010.7 4065.3 8782.7 10086.5 10340.6 10514.9 10520.8 10123.1 10252.0 10465.7 10482.6 10501.9 7713.1 7773.1 8048.8 8050.7 8056.1 5240.4 5628.6 5650.8 5756.1 5766.8 7458.8 9386.4 9552.7 9625.6 9657.9 8664.8 9651.8 9719.7 9833.1 9913.0 6419.3 6867.5 6899.5 7000.5 7005.6 7168.6 8234.8 8368.2 8413.7 8417.1 7348.0 7513.8 7514.7 7576.6 7597.3 7241.0 7280.1 7363.0 7409.4 7449.0 6932.4 6951.6 6986.9 7019.6 7028.1 4890.5 4964.7 5005.3 5026.2 5062.9 4878.6 4879.3 5006.4 5123.8 5128.7 16:31:00 INFO - PROCESS | 1649 | 16:31:00 INFO - PROCESS | 1649 | [#4] prototype.html Cycles:180 Average:4590.11 Median:4998.69 stddev:1477.49 (29.6%) stddev-sans-first:1445.90 16:31:00 INFO - PROCESS | 1649 | Values: 286.8 304.6 310.7 310.9 311.4 4166.5 5212.8 5227.8 5508.7 5532.3 4873.0 5245.3 5273.6 5300.9 5456.5 3367.7 4185.4 4187.6 4190.8 4220.3 3286.0 3873.0 4209.2 4215.4 4227.9 3507.6 3551.6 3934.0 4053.6 4098.1 4078.8 4086.2 4106.5 4128.4 4138.0 3130.8 3138.0 3456.6 3552.9 3578.6 5129.6 5269.1 5286.8 5307.9 5364.4 4155.6 4718.9 4749.4 4755.3 4791.0 5591.9 5671.2 5733.2 5749.7 5864.9 3434.8 3872.8 3884.4 3887.1 3919.8 4712.9 5449.8 5710.6 6125.8 6141.2 3579.1 3601.7 3777.4 3902.3 3929.3 3356.8 3985.9 4007.5 4020.6 4027.8 4116.6 4467.6 4639.9 4728.3 4733.2 4936.4 5653.7 5818.4 5906.0 5912.1 1292.1 1313.5 1334.9 1370.0 1388.5 724.1 805.8 823.9 834.8 840.8 4488.8 4624.5 4633.4 4643.3 4659.6 4646.9 4680.7 4995.7 5001.6 5092.0 4021.8 4556.6 4625.2 4667.6 4682.3 2737.8 2798.4 2868.0 3089.2 3130.2 5807.1 5870.0 6182.5 6183.1 6206.5 5613.3 5820.7 6139.9 6194.3 6247.1 5994.4 6082.1 6283.4 6311.7 6382.1 5867.3 6033.3 6123.2 6124.6 6166.2 5044.8 5902.0 5918.6 5985.8 5997.0 6031.0 6044.6 6280.6 6307.5 6317.9 2983.8 3356.5 3374.8 3925.4 3990.6 4911.7 4950.0 5517.6 5643.4 6037.5 4734.5 5506.9 5691.6 5849.3 5911.9 5498.8 5797.2 5849.7 5854.2 5856.2 5061.6 5426.7 5629.9 5715.5 5768.9 5558.7 5723.5 5835.3 5874.5 5920.9 4644.4 5623.8 5713.7 5716.8 5726.5 16:31:00 INFO - PROCESS | 1649 | 16:31:00 INFO - PROCESS | 1649 | [#5] yui.html Cycles:180 Average:25032.23 Median:3707.37 stddev:41603.96 (1122.2%) stddev-sans-first:41680.45 16:31:00 INFO - PROCESS | 1649 | Values: 666.7 678.0 731.2 746.0 760.2 14116.0 14499.6 14537.0 14651.7 14678.7 13430.5 13534.7 13558.6 13581.3 13592.1 676.4 831.6 846.1 851.3 856.0 863.3 865.3 866.0 867.8 868.4 892.6 917.5 918.5 919.8 920.8 886.3 910.7 912.2 912.7 916.9 661.1 681.3 682.2 682.7 684.7 14073.5 14248.9 14257.6 14258.3 14266.9 12037.5 12324.3 12952.3 13042.7 13311.8 10706.8 11019.3 11046.4 11142.5 11542.4 3548.7 3696.6 3718.1 3749.0 3844.3 84206.6 85566.0 118003.8 124867.1 126016.4 9808.0 9918.2 10073.0 10085.8 10294.1 17663.4 21820.6 21850.1 21867.1 21961.9 6320.8 7428.0 7466.3 7591.8 7724.7 4204.4 4263.3 4307.0 4377.1 4454.4 3101.8 3183.8 3191.2 3193.3 3218.3 584.2 598.3 606.6 621.9 644.9 586.3 607.3 659.3 670.9 681.9 7146.6 8871.2 9201.7 9359.9 9388.6 667.2 672.5 672.6 688.9 697.3 4106.8 4328.2 4368.0 4552.0 4553.8 143298.0 160677.0 161009.0 166855.0 172630.0 133446.3 135488.6 135572.0 136627.0 136788.0 100615.0 122067.4 123229.4 123760.8 126339.0 8201.3 8487.4 8508.4 8891.8 9015.6 44021.0 56004.0 66432.7 66615.0 69542.3 69080.7 86837.6 87064.0 88135.3 94759.5 10688.0 11289.5 11426.3 12619.7 13360.1 12274.7 12498.8 12898.9 14096.9 15426.0 13034.9 13311.5 13327.9 13698.3 14130.3 13707.3 13857.8 13875.2 13941.3 13962.4 13278.1 13512.1 13566.9 13767.7 13921.2 11094.8 11186.0 11567.4 11585.3 12199.2 9228.4 9756.7 10153.0 10257.6 10294.8 16:31:00 INFO - PROCESS | 1649 | -------- Summary: end -------- 16:31:00 INFO - PROCESS | 1649 | 16:31:00 INFO - TEST-INFO | 1649: exit 0 16:31:00 INFO - TEST-OK | dromaeo_css | took 1113462ms 16:31:00 INFO - TEST-START | kraken 16:31:00 INFO - operating with platform_type : mac_ 16:31:00 INFO - Initialising browser for kraken test... 16:31:00 INFO - TEST-INFO | started process 1658 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/tmpRrrV1m/profile http://localhost:49267/getInfo.html) 16:31:03 INFO - PROCESS | 1658 | __metrics Screen width/height:1600/1200 16:31:03 INFO - PROCESS | 1658 | colorDepth:24 16:31:03 INFO - PROCESS | 1658 | Browser inner width/height: 1024/689 16:31:03 INFO - PROCESS | 1658 | __metrics 16:31:03 ERROR - PROCESS | 1658 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 16:31:03 INFO - TEST-INFO | 1658: exit 0 16:31:03 INFO - Browser initialized. 16:31:03 INFO - Running cycle 1/1 for kraken test... 16:31:03 INFO - TEST-INFO | started process 1660 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/tmpRrrV1m/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:31:15 INFO - PROCESS | 1660 | RSS: Main: 254554112 16:31:15 INFO - PROCESS | 1660 | 16:31:18 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-beat-detection) 16:31:19 INFO - PROCESS | 1660 | RSS: Main: 267661312 16:31:19 INFO - PROCESS | 1660 | 16:31:22 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-dft) 16:31:23 INFO - PROCESS | 1660 | RSS: Main: 276594688 16:31:23 INFO - PROCESS | 1660 | 16:31:26 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-fft) 16:31:27 INFO - PROCESS | 1660 | RSS: Main: 279658496 16:31:27 INFO - PROCESS | 1660 | 16:31:29 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-oscillator) 16:31:29 INFO - PROCESS | 1660 | RSS: Main: 281956352 16:31:29 INFO - PROCESS | 1660 | 16:31:31 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:31:32 INFO - PROCESS | 1660 | RSS: Main: 282419200 16:31:32 INFO - PROCESS | 1660 | 16:31:35 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-darkroom) 16:31:35 INFO - PROCESS | 1660 | RSS: Main: 282972160 16:31:35 INFO - PROCESS | 1660 | 16:31:38 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-desaturate) 16:31:39 INFO - PROCESS | 1660 | RSS: Main: 282484736 16:31:39 INFO - PROCESS | 1660 | 16:31:42 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49267/tests/kraken/driver.html?testName=json-parse-financial) 16:31:43 INFO - PROCESS | 1660 | RSS: Main: 283971584 16:31:43 INFO - PROCESS | 1660 | 16:31:44 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49267/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:31:45 INFO - PROCESS | 1660 | RSS: Main: 283770880 16:31:45 INFO - PROCESS | 1660 | 16:31:47 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:31:47 INFO - PROCESS | 1660 | RSS: Main: 283578368 16:31:47 INFO - PROCESS | 1660 | 16:31:50 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:31:50 INFO - PROCESS | 1660 | RSS: Main: 283570176 16:31:50 INFO - PROCESS | 1660 | 16:31:53 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:31:54 INFO - PROCESS | 1660 | RSS: Main: 282542080 16:31:54 INFO - PROCESS | 1660 | 16:31:57 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:31:57 INFO - PROCESS | 1660 | RSS: Main: 283582464 16:31:57 INFO - PROCESS | 1660 | 16:31:59 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49267/tests/kraken/driver.html?testName=ai-astar) 16:31:59 INFO - PROCESS | 1660 | RSS: Main: 284762112 16:31:59 INFO - PROCESS | 1660 | 16:31:59 INFO - PROCESS | 1660 | __start_tp_report 16:31:59 INFO - PROCESS | 1660 | _x_x_mozilla_page_load 16:31:59 INFO - PROCESS | 1660 | _x_x_mozilla_page_load_details 16:31:59 INFO - PROCESS | 1660 | |i|pagename|runs| 16:31:59 INFO - PROCESS | 1660 | |0;ai-astar;105;117;109;120;117;116;118;118;118;116 16:31:59 INFO - PROCESS | 1660 | |1;audio-beat-detection;143;121;168;193;111;130;130;110;160;111 16:31:59 INFO - PROCESS | 1660 | |2;audio-dft;196;230;229;249;236;272;226;201;200;198 16:31:59 INFO - PROCESS | 1660 | |3;audio-fft;71;74;70;150;52;50;51;88;141;52 16:31:59 INFO - PROCESS | 1660 | |4;audio-oscillator;70;71;116;72;72;77;123;69;96;118 16:31:59 INFO - PROCESS | 1660 | |5;imaging-gaussian-blur;90;88;89;88;91;86;90;125;92;85 16:31:59 INFO - PROCESS | 1660 | |6;imaging-darkroom;96;97;97;97;97;96;96;100;96;96 16:31:59 INFO - PROCESS | 1660 | |7;imaging-desaturate;149;137;86;138;148;115;91;91;95;93 16:31:59 INFO - PROCESS | 1660 | |8;json-parse-financial;56;57;58;57;57;59;57;56;57;56 16:31:59 INFO - PROCESS | 1660 | |9;json-stringify-tinderbox;64;85;70;79;76;73;77;71;69;70 16:31:59 INFO - PROCESS | 1660 | |10;stanford-crypto-aes;86;86;89;86;91;106;77;75;94;103 16:31:59 INFO - PROCESS | 1660 | |11;stanford-crypto-ccm;138;155;138;132;157;156;158;146;154;131 16:31:59 INFO - PROCESS | 1660 | |12;stanford-crypto-pbkdf2;169;169;169;163;171;167;171;170;168;168 16:31:59 INFO - PROCESS | 1660 | |13;stanford-crypto-sha256-iterative;64;88;86;99;93;89;69;67;69;66 16:31:59 INFO - PROCESS | 1660 | __end_tp_report 16:31:59 INFO - PROCESS | 1660 | __start_cc_report 16:31:59 INFO - PROCESS | 1660 | _x_x_mozilla_cycle_collect,1055 16:31:59 INFO - PROCESS | 1660 | __end_cc_report 16:31:59 INFO - PROCESS | 1660 | __startTimestamp1470353519961__endTimestamp 16:31:59 INFO - PROCESS | 1660 | 16:31:59 INFO - PROCESS | 1660 | ------- Summary: start ------- 16:31:59 INFO - PROCESS | 1660 | Number of tests: 14 16:31:59 INFO - PROCESS | 1660 | 16:31:59 INFO - PROCESS | 1660 | [#0] ai-astar Cycles:10 Average:115.40 Median:117.50 stddev:4.67 (4.0%) stddev-sans-first:3.09 16:31:59 INFO - PROCESS | 1660 | Values: 105.0 117.0 109.0 120.0 117.0 116.0 118.0 118.0 118.0 116.0 16:31:59 INFO - PROCESS | 1660 | 16:31:59 INFO - PROCESS | 1660 | [#1] audio-beat-detection Cycles:10 Average:137.70 Median:136.50 stddev:28.07 (20.6%) stddev-sans-first:29.71 16:31:59 INFO - PROCESS | 1660 | Values: 143.0 121.0 168.0 193.0 111.0 130.0 130.0 110.0 160.0 111.0 16:31:59 INFO - PROCESS | 1660 | 16:31:59 INFO - PROCESS | 1660 | [#2] audio-dft Cycles:10 Average:223.70 Median:229.50 stddev:25.17 (11.0%) stddev-sans-first:24.62 16:31:59 INFO - PROCESS | 1660 | Values: 196.0 230.0 229.0 249.0 236.0 272.0 226.0 201.0 200.0 198.0 16:31:59 INFO - PROCESS | 1660 | 16:31:59 INFO - PROCESS | 1660 | [#3] audio-fft Cycles:10 Average:79.90 Median:61.00 stddev:36.83 (60.4%) stddev-sans-first:38.93 16:31:59 INFO - PROCESS | 1660 | Values: 71.0 74.0 70.0 150.0 52.0 50.0 51.0 88.0 141.0 52.0 16:31:59 INFO - PROCESS | 1660 | 16:31:59 INFO - PROCESS | 1660 | [#4] audio-oscillator Cycles:10 Average:88.40 Median:71.50 stddev:22.55 (31.5%) stddev-sans-first:22.92 16:31:59 INFO - PROCESS | 1660 | Values: 70.0 71.0 116.0 72.0 72.0 77.0 123.0 69.0 96.0 118.0 16:31:59 INFO - PROCESS | 1660 | 16:31:59 INFO - PROCESS | 1660 | [#5] imaging-gaussian-blur Cycles:10 Average:92.40 Median:89.50 stddev:11.65 (13.0%) stddev-sans-first:12.33 16:31:59 INFO - PROCESS | 1660 | Values: 90.0 88.0 89.0 88.0 91.0 86.0 90.0 125.0 92.0 85.0 16:31:59 INFO - PROCESS | 1660 | 16:31:59 INFO - PROCESS | 1660 | [#6] imaging-darkroom Cycles:10 Average:96.80 Median:96.50 stddev:1.23 (1.3%) stddev-sans-first:1.27 16:31:59 INFO - PROCESS | 1660 | Values: 96.0 97.0 97.0 97.0 97.0 96.0 96.0 100.0 96.0 96.0 16:31:59 INFO - PROCESS | 1660 | 16:31:59 INFO - PROCESS | 1660 | [#7] imaging-desaturate Cycles:10 Average:114.30 Median:88.50 stddev:26.10 (29.5%) stddev-sans-first:24.48 16:31:59 INFO - PROCESS | 1660 | Values: 149.0 137.0 86.0 138.0 148.0 115.0 91.0 91.0 95.0 93.0 16:31:59 INFO - PROCESS | 1660 | 16:31:59 INFO - PROCESS | 1660 | [#8] json-parse-financial Cycles:10 Average:57.00 Median:57.00 stddev:0.94 (1.7%) stddev-sans-first:0.93 16:31:59 INFO - PROCESS | 1660 | Values: 56.0 57.0 58.0 57.0 57.0 59.0 57.0 56.0 57.0 56.0 16:31:59 INFO - PROCESS | 1660 | 16:31:59 INFO - PROCESS | 1660 | [#9] json-stringify-tinderbox Cycles:10 Average:73.40 Median:74.50 stddev:5.99 (8.0%) stddev-sans-first:5.29 16:31:59 INFO - PROCESS | 1660 | Values: 64.0 85.0 70.0 79.0 76.0 73.0 77.0 71.0 69.0 70.0 16:31:59 INFO - PROCESS | 1660 | 16:31:59 INFO - PROCESS | 1660 | [#10] stanford-crypto-aes Cycles:10 Average:89.30 Median:86.00 stddev:9.89 (11.5%) stddev-sans-first:10.42 16:31:59 INFO - PROCESS | 1660 | Values: 86.0 86.0 89.0 86.0 91.0 106.0 77.0 75.0 94.0 103.0 16:31:59 INFO - PROCESS | 1660 | 16:31:59 INFO - PROCESS | 1660 | [#11] stanford-crypto-ccm Cycles:10 Average:146.50 Median:154.50 stddev:10.83 (7.0%) stddev-sans-first:11.05 16:31:59 INFO - PROCESS | 1660 | Values: 138.0 155.0 138.0 132.0 157.0 156.0 158.0 146.0 154.0 131.0 16:31:59 INFO - PROCESS | 1660 | 16:31:59 INFO - PROCESS | 1660 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.50 Median:169.00 stddev:2.32 (1.4%) stddev-sans-first:2.46 16:31:59 INFO - PROCESS | 1660 | Values: 169.0 169.0 169.0 163.0 171.0 167.0 171.0 170.0 168.0 168.0 16:31:59 INFO - PROCESS | 1660 | 16:31:59 INFO - PROCESS | 1660 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:79.00 Median:87.00 stddev:13.18 (15.2%) stddev-sans-first:12.82 16:31:59 INFO - PROCESS | 1660 | Values: 64.0 88.0 86.0 99.0 93.0 89.0 69.0 67.0 69.0 66.0 16:31:59 INFO - PROCESS | 1660 | -------- Summary: end -------- 16:31:59 INFO - PROCESS | 1660 | 16:32:00 INFO - TEST-INFO | 1660: exit 0 16:32:00 INFO - TEST-OK | kraken | took 60148ms 16:32:00 INFO - SUITE-END | took 1173s 16:32:01 INFO - Completed test suite (00:19:33) 16:32:01 INFO - javascript benchmark 16:32:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7271.942135970876, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3324.25204329026, 3330.9500357494635, 3352.966470335297, 3353.882614108507, 3354.362671092491, 5339.5728341732665, 5514.503694667479, 5578.30271216098, 5591.0, 5655.745491452884, 4485.394471746314, 5569.637973531728, 5582.581306402016, 5620.494155526002, 5683.943160568393, 5000.07498612756, 5129.666571672829, 5157.9684063187515, 5211.843644690646, 5318.9202161967605, 5216.426193118773, 5222.529972302492, 5255.159174532076, 5291.31212942317, 5296.3379577552805, 5041.19340905457, 5089.389273287192, 5104.897902041938, 5145.716985565792, 5147.0, 3842.9807850960847, 5119.308893299394, 5145.176771716545, 5166.0, 5174.870628234286, 5098.260752190911, 5163.432022477525, 5170.405403378622, 5191.428942816287, 5196.532312091892, 4499.572540608669, 4905.386826646669, 5031.616305515976, 5589.105743081128, 5642.435756424325, 6096.542759293026, 6100.816975490742, 6126.081087836816, 6128.846778830521, 6169.5064394848305, 6223.8132856013935, 6225.7509699611965, 6229.844253893643, 6245.125682404467, 6252.124702541648, 5411.702356370398, 5704.543636509069, 5743.54051675865, 5750.453706897838, 5826.766929322865, 6213.763045303687, 6262.6868656566985, 6270.498360131179, 6272.6550039747335, 6328.7468501260355, 6098.451139397387, 6107.633541987495, 6131.693415329216, 6141.877162456726, 6143.96928015366, 6052.213212282463, 6126.78556250538, 6147.846303842351, 6158.692065396802, 6212.596181248295, 5626.831195064155, 6105.786297479567, 6143.143438301211, 6153.384661533811, 6204.410580994799, 5965.991064943342, 6162.168107305456, 6164.229471316085, 6197.504199664016, 6227.159333490012, 4778.068276686083, 4839.467658557556, 4894.412670479565, 4921.557059864629, 4925.704457732548, 4265.829366825292, 4348.0869017506675, 4366.737995720267, 4389.1660584488845, 4424.933625995613, 5618.932402843447, 5651.886962260732, 5684.602077854511, 5685.431456854281, 5705.800296989585, 6270.968645156745, 6273.435390814758, 6285.77999770015, 6286.434220920048, 6297.023961286008, 5477.698726570077, 5580.469855363734, 5660.603757737002, 5669.149627555899, 5670.347909990322, 5317.255584218213, 5321.095413779667, 5368.7047212403695, 5393.865153371197, 5395.05586522357, 6215.844603884849, 6251.843703907348, 6269.341719119427, 6270.717817698123, 6290.025046117859, 6121.818815678178, 6136.631802091889, 6232.065190221322, 6233.345498722569, 6268.153799237045, 6166.784162554289, 6256.7810126645345, 6264.780732674334, 6266.185395898504, 6284.717187726655, 6129.724162412613, 6138.907916381168, 6145.139680444652, 6158.983767678462, 6167.660778657217, 6072.544559157993, 6104.822969073451, 6210.844728881814, 6217.129601855653, 6284.277308109443, 5760.654360738369, 6001.339852616296, 6011.218541589566, 6038.818835434944, 6094.908576371269, 5907.675077870758, 6000.429959153874, 6018.127371531191, 6049.0, 6063.484603808549, 5694.857628559153, 5718.827640333805, 5815.563832712648, 5847.912281315698, 5894.145348924468, 6030.969845150747, 6081.878362432815, 6106.175666285172, 6124.448799608057, 6138.263408391022, 5036.169032109661, 5864.618799778001, 5870.618409803349, 5880.529557635294, 5884.764609415575], "value": 5609.132558566066, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [493.6791085794233, 522.5323335614625, 556.2879514221796, 562.3139769481231, 600.8828278485691, 30515.847420762922, 38857.83426497203, 39157.0, 40560.79719601398, 40841.183176336526, 41412.37881431781, 41634.791826040826, 41870.0, 42244.78877605616, 42264.15471690572, 9488.098630630097, 9675.806483870318, 9735.367201131903, 9750.12248897599, 9771.755706107333, 9631.71104866855, 9654.903450965507, 9678.0, 9735.17251033663, 9736.75658108546, 9691.806163876754, 9736.95131524345, 9764.804703905953, 9771.36486128403, 9772.90227097727, 9694.321397502177, 9703.757406064835, 9753.658621948198, 9766.9511652442, 9768.413895166314, 9663.420194788336, 9755.365901216399, 9755.609775608968, 9788.412695238309, 9790.706278811647, 39349.0, 39428.80285598554, 39732.80133599343, 39824.80087599572, 40127.39808902869, 3199.792013519137, 3735.477033215352, 4065.878023659265, 4072.7759973201464, 4145.253854306224, 30586.413318640585, 30862.382752345053, 31519.84240078785, 31651.683483165103, 31810.204744881332, 3187.681231876817, 3311.9006429806905, 3332.216929021702, 3339.6493368196475, 3353.0, 500964.0, 501200.99999999633, 504269.0, 506100.0, 508219.0, 59082.70458647679, 59733.402665973656, 60239.0, 60281.39718602846, 60464.395356045876, 59983.40016599865, 60978.69510652418, 61510.0, 61510.38489615046, 61770.38229617646, 15723.292451839694, 15819.288132034086, 15986.76019859703, 15996.920015399848, 16003.679926401406, 11887.821682674767, 11897.286162830258, 12362.258264504158, 12410.317432541116, 12446.315452650191, 15698.293576789072, 16277.267522961494, 16372.426965056404, 16381.83618163827, 16414.09722465252, 6904.482163837632, 6977.197622273504, 6986.755463558751, 6991.860162796817, 7101.0, 901.3510272603846, 920.852663573825, 943.104051151409, 959.0936564946198, 1073.8335557988523, 29521.0, 29987.400251995274, 30494.69505304963, 30629.38741225163, 30728.53235370484, 1005.3465247589126, 1067.8771941226858, 1077.9461026948777, 1078.924475286738, 1093.5407129005837, 15834.920825395799, 15837.049777013415, 15864.762028569581, 16040.518784436486, 16043.410759838272, 645390.0, 648823.0, 650606.0, 653010.0, 654528.0, 49231.75384123128, 58536.12195817066, 58650.0, 58811.411885880596, 58846.70576647089, 1360.3946243921557, 1362.3937347880296, 1412.8587141285789, 1413.8586141385779, 1414.8655877691604, 28421.147365579065, 29083.70916290895, 29580.852095740243, 30322.938697145495, 30885.382292353577, 50790.74604626953, 51103.233451499, 51235.0, 51246.74376628242, 51305.23042154445, 569452.0, 573224.0, 573478.1326093343, 574178.0, 575681.0, 41129.588704112575, 41279.58720412877, 41702.95742606459, 42016.0, 42057.0, 47278.0, 47480.0, 48863.02273954572, 49083.0, 49391.506084938694, 33855.66144338525, 39518.0, 39971.60028399679, 40528.392074118325, 41432.0, 38977.6102238974, 39200.62797802063, 39501.41530516057, 40185.79907100446, 40307.79846100751, 32818.0, 38877.222455551295, 39387.01532461711, 39487.80256098701, 40507.59492405038, 31656.525152122274, 34286.82856585701, 34457.0, 34793.9561813146, 35219.647803521635, 22152.889235553717, 26043.869780650977, 26289.474210515302, 26610.334741631614, 26918.0], "value": 20272.609459411935, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [309.945759492089, 373.80562107704, 378.80112940706135, 392.2958289869684, 396.3836234655112, 20102.296419625316, 20407.387778366654, 21043.47391315218, 21262.57474850504, 21495.67756483654, 11592.536298548048, 11776.7644647107, 11910.0, 12300.323482208474, 12317.199382040184, 5450.727463626823, 5683.2895888014, 5685.800996965107, 5697.77208911643, 5709.942900570983, 3988.222296652154, 5650.63270887391, 6679.833004174886, 7006.89489657653, 7011.404030657375, 6132.540059495534, 6870.900655895058, 6998.265182155877, 7013.193482749472, 7047.541909775849, 6224.0, 6282.465990390845, 6285.43431091204, 6298.496120310364, 6310.400511951358, 5439.945600543983, 5753.683547404891, 6067.696615169224, 6081.635101893857, 6124.540659450559, 13412.329383530785, 13798.034137610372, 13802.585922422344, 20697.58604827895, 26524.0, 2173.5218251984697, 2193.0350645715835, 2242.136777340719, 2343.730470995823, 2362.70466191726, 10138.797224055477, 10144.391336519759, 10294.43380614066, 10421.791564168674, 10468.214883883738, 1844.6402951424477, 1931.2661188748327, 1957.5595491014408, 1960.0885588201554, 1964.8919309437974, 126758.36620816837, 130690.3465482676, 131046.0, 133099.66900330968, 133389.33305333508, 11424.885751142383, 11606.187566870407, 11709.88290117105, 11866.0, 12005.699857503632, 12299.69250768738, 14662.266886655625, 14705.632359191106, 14761.188134652697, 14780.778288325684, 8335.637814561655, 8619.060711340024, 8622.870656940151, 8632.69785557515, 8766.736997890073, 8100.878486822702, 8398.41211115216, 8505.0, 8539.231469167804, 8646.913530864611, 3961.504811898513, 4592.08158368321, 4607.493175750665, 4610.170169369479, 4675.064987002613, 1774.5829730013436, 1815.228527875674, 1888.291890541047, 1918.0, 1942.7760510878338, 835.4903508859591, 877.8463768840427, 894.7494701483595, 903.8508646073456, 962.4369743700014, 16519.587010324838, 20857.791422085887, 21031.474213144487, 21268.680969785466, 21315.573688526143, 920.2867777472512, 953.8125034332301, 959.9232061435068, 988.9357191782511, 1034.1984961654778, 10965.890341096647, 11273.436328183721, 11279.548818047351, 11286.604968826052, 11309.717257068474, 574263.0, 608879.9556002192, 613061.8693813094, 622412.0, 629823.0, 61884.38115618876, 124180.37909810574, 125618.0, 125648.0, 137959.0, 954.355809828377, 964.1611797736015, 993.2997236947934, 995.5918073589794, 1000.6097621927454, 18513.9074304633, 18528.536786580444, 18826.52933676669, 18844.0, 18847.24611015544, 36427.45358819673, 47746.0, 50824.0, 53970.0, 55442.0, 59871.0, 65339.40633265216, 75729.62135189289, 80144.0, 80312.59843700744, 7677.654505547152, 7840.176781438095, 7909.802254943673, 7993.6003199838615, 8052.235037671412, 10860.402677852479, 11738.295702257892, 13090.934545327213, 13502.932485337904, 13563.728725425239, 9775.364601300893, 10134.493275336055, 10138.949305253427, 10628.202884783517, 11161.776764464828, 9847.818261808628, 10536.209784266364, 10744.677659670222, 11495.310281383145, 11580.36308003068, 8939.687110951085, 10391.116755075904, 11159.609413670483, 11412.714682133013, 11590.304581725124, 8211.096779354386, 8240.958795205986, 8533.957330213558, 8666.653333866574, 8667.0, 10064.597416103567, 11549.307041577533, 11796.410179491162, 11860.40697965081, 11943.462544185706], "value": 9346.936425111584, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1518.2181176694005, 1539.6766678997412, 1746.4585978346706, 1836.706127019677, 1857.062183597284, 7744.457887947846, 8254.257116859482, 8302.95848520758, 8645.69740059098, 8761.56192190391, 8388.580570971457, 8455.450395724289, 8498.915010849889, 8545.401821872472, 8554.44396114252, 2283.4519715268298, 2320.0835669910375, 2325.069972011192, 2327.569399661068, 2332.9533409331802, 2253.7746225377414, 2280.1107568048474, 2292.4383526036145, 2296.4144143243534, 2305.3314538783734, 2247.1573160064977, 2272.1025195047946, 2279.099755596538, 2287.336672365012, 2308.1113771198043, 2230.353197572702, 2236.250855963246, 2239.8432109752325, 2250.0999600159985, 2255.01906670598, 2250.077468238031, 2282.3381219446505, 2286.4969706664674, 2286.8284878634004, 2299.0229152610073, 8517.148285171495, 8558.400911936167, 8600.0, 8628.956855215683, 8634.136586341316, 4997.6501644884875, 5000.0999820032375, 5144.665596736238, 5153.304303918961, 5153.665011774223, 3380.8309584520675, 3484.61669216386, 3549.112721819545, 3563.94654080189, 3574.267275208576, 1070.336391437306, 1076.386459717961, 1077.4828082520355, 1083.6153165626247, 1098.280626189847, 11072.833907491395, 11087.168462365275, 11165.939235772588, 11188.944055279753, 11235.04502117321, 4261.595148460891, 4261.637760790368, 4426.490953540384, 4436.733795972252, 4439.733615983051, 8575.957120214483, 8622.0, 8790.340724445692, 8793.0, 8797.868031979526, 4974.9751251243515, 5018.949810501921, 5036.420811606712, 5050.6464547482055, 5077.136886729265, 3822.9044273893373, 4621.584057434847, 4742.73914934675, 4750.287456881426, 4758.2386818108935, 3578.1393675288705, 3681.226942342138, 3682.4660424238336, 3723.4600982857332, 3728.5525736911745, 1076.5586109694987, 1122.7698321844002, 1126.645106791358, 1128.227164392394, 1130.513879032024, 784.9882251766228, 867.3884911137633, 871.8605023196258, 908.6274627402734, 913.3104506097986, 5540.612157149041, 5547.750351234205, 5770.913436298459, 5847.970760146172, 5953.9878220702585, 955.8422860227985, 1007.1238022920106, 1022.0188618925914, 1038.1642777564134, 1039.6880935719255, 3865.6714179295077, 3869.8258578364043, 3884.3396622573664, 4010.6791456683395, 4065.329220678555, 8782.692605758895, 10086.49567521621, 10340.638077667245, 10514.894851051391, 10520.789584208425, 10123.139533139618, 10252.0, 10465.738356540995, 10482.580696772196, 10501.947490262653, 7713.112992005991, 7773.144954055049, 8048.839023219502, 8050.718224862102, 8056.113827478973, 5240.371155461216, 5628.60599758013, 5650.773969041356, 5756.136579513107, 5766.769329226784, 7458.776236712907, 9386.389884657749, 9552.713418597454, 9625.614975401186, 9657.855132173163, 8664.78338041554, 9651.806963860823, 9719.708408747749, 9833.065858743408, 9912.950435247778, 6419.325970773189, 6867.484938629523, 6899.482538809509, 7000.474964377794, 7005.579665220103, 7168.605726685082, 8234.835303293781, 8368.20502052304, 8413.747587572383, 8417.116202798617, 7348.0, 7513.812154696177, 7514.699412023458, 7576.621168941641, 7597.278258565428, 7241.0, 7280.126384833854, 7362.969184314094, 7409.444291678038, 7448.9627551861895, 6932.44540436774, 6951.582905025714, 6986.895196572157, 7019.613921234381, 7028.051213086168, 4890.535399137077, 4964.652474326763, 5005.299258103795, 5026.246063090565, 5062.924056139234, 4878.609711223165, 4879.341288926092, 5006.424261210008, 5123.795048198031, 5128.7179205144075], "value": 4445.479727855921, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [286.79637457405244, 304.6100990731863, 310.7110387339773, 310.88808029109526, 311.4005539336776, 4166.520850102239, 5212.817551385702, 5227.843164705056, 5508.724563771815, 5532.280803495545, 4873.0, 5245.291885595453, 5273.630845840793, 5300.893982120365, 5456.48163424474, 3367.696907278338, 4185.388625379236, 4187.60217779312, 4190.769507677077, 4220.345846393814, 3285.967140328602, 3872.9806350968347, 4209.1581683663235, 4215.398148703488, 4227.87316380509, 3507.5966263879727, 3551.5738111426535, 3934.0, 4053.5946405359523, 4098.139390727951, 4078.7552746835286, 4086.223617512663, 4106.486689163855, 4128.380742888561, 4138.0, 3130.796498227608, 3137.952930706041, 3456.6024907135497, 3552.8578856845697, 3578.570571531433, 5129.589632829365, 5269.104252277122, 5286.762095705702, 5307.894881494331, 5364.390682795146, 4155.58444155585, 4718.882027949295, 4749.382580264578, 4755.310479980418, 4790.952090479085, 5591.8881622367735, 5671.2060311556415, 5733.168690539848, 5749.741261643236, 5864.882702345972, 3434.845431955568, 3872.845086196549, 3884.3590807516725, 3887.1253967857288, 3919.8432062717457, 4712.929306060412, 5449.836504904859, 5710.573655806525, 6125.816225513197, 6141.188349436882, 3579.087332730137, 3601.6938560222675, 3777.433384992218, 3902.2780785554764, 3929.2730844793805, 3356.81537515439, 3985.9202815943518, 4007.499062617173, 4020.557738648746, 4027.81874815634, 4116.58834116592, 4467.6202522785925, 4639.8608041758125, 4728.267118596623, 4733.242681170997, 4936.407631084293, 5653.717314134276, 5818.389069147764, 5906.0, 5912.113183022581, 1292.08907720059, 1313.4614807928704, 1334.8932085433141, 1369.9931500342434, 1388.4654408052972, 724.1455083002108, 805.778410936997, 823.8517066927891, 834.845553572591, 840.7519781664423, 4488.775561221926, 4624.514425985223, 4633.351330813689, 4643.303504474356, 4659.58063774262, 4646.86059418218, 4680.7191568506, 4995.725235112103, 5001.64988450805, 5092.032513822362, 4021.798910054544, 4556.589906908394, 4625.190591646448, 4667.649926255544, 4682.297655351656, 2737.8090530619243, 2798.398344355973, 2867.985660071686, 3089.2276930767307, 3130.2330928922106, 5807.0998995155815, 5869.972754767899, 6182.474489668429, 6183.103449999725, 6206.472449841724, 5613.270274864323, 5820.650760954356, 6139.907901381483, 6194.318624951252, 6247.125402443661, 5994.400559943971, 6082.148499210026, 6283.403076707706, 6311.747530098744, 6382.128042380948, 5867.295924489089, 6033.336333003454, 6123.234595675541, 6124.6325220486915, 6166.229221347332, 5044.798208071783, 5901.996660567628, 5918.615290006308, 5985.790497332572, 5997.0, 6031.035034394476, 6044.637321760709, 6280.550585271656, 6307.526935479766, 6317.873642527032, 2983.761738878428, 3356.5468661730356, 3374.827661997714, 3925.4111883216606, 3990.580988996114, 4911.68074075184, 4949.950500495093, 5517.641353312022, 5643.407442218508, 6037.547183961133, 4734.502877197845, 5506.944930550643, 5691.630044047124, 5849.268841394825, 5911.940880591139, 5498.835034948958, 5797.159411885337, 5849.707514624167, 5854.2389489367815, 5856.184582779352, 5061.633358993125, 5426.728663566727, 5629.8592535186945, 5715.513322042343, 5768.94231057684, 5558.694271815089, 5723.484886360247, 5835.328937172109, 5874.530037597067, 5920.940790592039, 4644.442666879996, 5623.803166889139, 5713.657180569013, 5716.771329146787, 5726.541876649775], "value": 4114.047296868498, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [666.7066490744072, 677.9728810847566, 731.1737736357915, 746.0450623202299, 760.1600231743924, 14116.0, 14499.637509062253, 14536.982411231218, 14651.70696586069, 14678.706425871489, 13430.529931452402, 13534.661633459169, 13558.593242202725, 13581.253031083286, 13592.116512426684, 676.4081428749844, 831.584207896052, 846.0566468387749, 851.2891735400948, 855.9914400855974, 863.3136656358179, 865.312076898867, 865.9826803463927, 867.7917299848023, 868.409481552544, 892.6161750447305, 917.4541148016953, 918.5361392496814, 919.8114386550775, 920.7606022434181, 886.2953951608487, 910.6858133943779, 912.192709452133, 912.7307444303913, 916.894557125929, 661.1141070964931, 681.322084525895, 682.1950098883316, 682.6859644563507, 684.685044879356, 14073.5074272401, 14248.92875535626, 14257.64355891111, 14258.28708564578, 14266.92866535671, 12037.458314375874, 12324.260544367367, 12952.287624180666, 13042.673933151653, 13311.800322995163, 10706.839397409045, 11019.338839669645, 11046.392448415334, 11142.49858756358, 11542.36516991565, 3548.6983606393487, 3696.611855755134, 3718.1262403335195, 3748.9625103748886, 3844.2695887781233, 84206.57896710477, 85566.0, 118003.75770254647, 124867.12699309608, 126016.36991815074, 9807.950960245153, 9918.206543476505, 10073.0, 10085.848712269322, 10294.124999374988, 17663.38178163784, 21820.563588728135, 21850.12599496034, 21867.12531498754, 21961.890190548944, 6320.8419789504715, 7428.034355533746, 7466.253374662599, 7591.772246832494, 7724.6910123594425, 4204.411382406465, 4263.317869140923, 4306.978465107654, 4377.080813029236, 4454.354118652777, 3101.8293993830557, 3183.761217908666, 3191.2181515528846, 3193.3294008258063, 3218.3241519281214, 584.1558947321165, 598.2641351138037, 606.5875204860737, 621.9098230756606, 644.8549076457854, 586.3110844757393, 607.2834055814182, 659.307726886767, 670.9261981182066, 681.8670359279992, 7146.642667866586, 8871.249912527137, 9201.677941272023, 9359.87681478227, 9388.577514011886, 667.2226855713039, 672.5372315214389, 672.5695554844904, 688.9271075469718, 697.2504557600599, 4106.788497393276, 4328.199283132631, 4367.956320436755, 4552.0, 4553.817847286137, 143298.0, 160677.0, 161009.0, 166855.0, 172630.0, 133446.33276833553, 135488.64511354957, 135572.0, 136627.0, 136788.0, 100615.0, 122067.38966305289, 123229.38385308016, 123760.76239237672, 126339.0, 8201.30288925448, 8487.363447741567, 8508.404411691123, 8891.836775100614, 9015.594298256463, 44021.0, 56004.0, 66432.6678366605, 66615.0, 69542.30457695358, 69080.6545967267, 86837.56581217053, 87064.0, 88135.27120737132, 94759.52620236855, 10688.0, 11289.548418063514, 11426.314421134759, 12619.74760504803, 13360.131591446525, 12274.693132671755, 12498.75002499963, 12898.935505322414, 14096.859031409555, 15425.997310174802, 13034.869651303745, 13311.467541298627, 13327.933360333136, 13698.315084245549, 14130.293485325486, 13707.314634268447, 13857.79213311781, 13875.236861972688, 13941.302934853014, 13962.4415023402, 13278.148997706425, 13512.072890668884, 13566.86433135656, 13767.655808604864, 13921.164730116225, 11094.833577496505, 11185.992503057432, 11567.421628918688, 11585.304881707125, 12199.207051541622, 9228.35401521887, 9756.658516952157, 10153.035461631132, 10257.58969641206, 10294.794104118026], "value": 7606.635504743194, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1562.2999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 117.0, 109.0, 120.0, 117.0, 116.0, 118.0, 118.0, 118.0, 116.0], "value": 115.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 121.0, 168.0, 193.0, 111.0, 130.0, 130.0, 110.0, 160.0, 111.0], "value": 137.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [196.0, 230.0, 229.0, 249.0, 236.0, 272.0, 226.0, 201.0, 200.0, 198.0], "value": 223.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 74.0, 70.0, 150.0, 52.0, 50.0, 51.0, 88.0, 141.0, 52.0], "value": 79.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 71.0, 116.0, 72.0, 72.0, 77.0, 123.0, 69.0, 96.0, 118.0], "value": 88.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 88.0, 89.0, 88.0, 91.0, 86.0, 90.0, 125.0, 92.0, 85.0], "value": 92.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 97.0, 97.0, 97.0, 96.0, 96.0, 100.0, 96.0, 96.0], "value": 96.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 137.0, 86.0, 138.0, 148.0, 115.0, 91.0, 91.0, 95.0, 93.0], "value": 114.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 57.0, 58.0, 57.0, 57.0, 59.0, 57.0, 56.0, 57.0, 56.0], "value": 57.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 85.0, 70.0, 79.0, 76.0, 73.0, 77.0, 71.0, 69.0, 70.0], "value": 73.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 89.0, 86.0, 91.0, 106.0, 77.0, 75.0, 94.0, 103.0], "value": 89.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 155.0, 138.0, 132.0, 157.0, 156.0, 158.0, 146.0, 154.0, 131.0], "value": 146.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 169.0, 169.0, 163.0, 171.0, 167.0, 171.0, 170.0, 168.0, 168.0], "value": 168.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 88.0, 86.0, 99.0, 93.0, 89.0, 69.0, 67.0, 69.0, 66.0], "value": 79.0, "unit": "score"}]}]} 16:32:01 INFO - Return code: 0 16:32:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:32:01 ERROR - # TBPL SUCCESS # 16:32:01 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:32:01 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:32:01 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:32:01 INFO - 2016-08-04 16:32:01.283 screenresolution[1668:10628] starting screenresolution argv=screenresolution get 16:32:01 INFO - 2016-08-04 16:32:01.286 screenresolution[1668:10628] Display 0: 1600x1200x32@60 16:32:01 INFO - 2016-08-04 16:32:01.292 screenresolution[1669:10630] starting screenresolution argv=screenresolution list 16:32:01 INFO - Available Modes on Display 0 16:32:01 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:32:01 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:32:01 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:32:01 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:32:01 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:32:01 INFO - Intel Iris: 16:32:01 INFO - Chipset Model: Intel Iris 16:32:01 INFO - Type: GPU 16:32:01 INFO - Bus: Built-In 16:32:01 INFO - VRAM (Dynamic, Max): 1536 MB 16:32:01 INFO - Vendor: Intel (0x8086) 16:32:01 INFO - Device ID: 0x0a2e 16:32:01 INFO - Revision ID: 0x0009 16:32:01 INFO - Displays: 16:32:01 INFO - Display: 16:32:01 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:32:01 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:32:01 INFO - Display Serial Number: 1600x1200 60 16:32:01 INFO - Main Display: Yes 16:32:01 INFO - Mirror: Off 16:32:01 INFO - Online: Yes 16:32:01 INFO - Rotation: Supported 16:32:01 INFO - Return code: 0 16:32:01 INFO - Running post-action listener: _resource_record_post_action 16:32:01 INFO - [mozharness: 2016-08-04 23:32:01.528906Z] Finished run-tests step (success) 16:32:01 INFO - Running post-run listener: _resource_record_post_run 16:32:01 INFO - Total resource usage - Wall time: 1209s; CPU: 54.0%; Read bytes: 38114304; Write bytes: 705806336; Read time: 404; Write time: 2163 16:32:01 INFO - TinderboxPrint: CPU usage
54.2% 16:32:01 INFO - TinderboxPrint: I/O read bytes / time
38,114,304 / 404 16:32:01 INFO - TinderboxPrint: I/O write bytes / time
705,806,336 / 2,163 16:32:01 INFO - TinderboxPrint: CPU idle
2,216.0 (45.8%) 16:32:01 INFO - TinderboxPrint: CPU system
972.3 (20.1%) 16:32:01 INFO - TinderboxPrint: CPU user
1,649.3 (34.1%) 16:32:01 INFO - TinderboxPrint: Swap in / out
440,942,592 / 0 16:32:01 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 394539520; Write bytes: 389490688; Read time: 29550; Write time: 749 16:32:01 INFO - run-tests - Wall time: 1175s; CPU: 54.0%; Read bytes: 36099072; Write bytes: 298543104; Read time: 360; Write time: 1359 16:32:02 INFO - Running post-run listener: _upload_blobber_files 16:32:02 INFO - Blob upload gear active. 16:32:02 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:32:02 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 16:32:02 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'] 16:32:02 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 16:32:02 INFO - (blobuploader) - INFO - Open directory for files ... 16:32:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:32:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:32:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:32:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:32:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:32:03 INFO - (blobuploader) - INFO - Done attempting. 16:32:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:32:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:32:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:32:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:32:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:32:04 INFO - (blobuploader) - INFO - Done attempting. 16:32:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:32:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:32:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:32:06 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:32:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:32:06 INFO - (blobuploader) - INFO - Done attempting. 16:32:06 INFO - (blobuploader) - INFO - Iteration through files over. 16:32:06 INFO - Return code: 0 16:32:06 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:32:06 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:32:06 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/2cad3c0e493f900869804d5da870dfc3628f0d1ef56967e0a9072159e11d533b2540869cb5bdfc9046652ad43211fdfa08efb986137312fd00a08dada875e9de", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/a568d27cf6eec8bcd8582a00a15224b16c8a989e866db65d8f9e0b52f9d4ed562da99a81b6095bfa12e4b51ba275607aeabafa142fc83168aa380203413a8858", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/fa4b29a0050679bac19b99bd54606ddafde22d20a15c0e5fe03d89903dfd61167822cd7fe5edd8bc7b28b18a609df5c5507aa6ae4518d248ef663ba0082621b4"} 16:32:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:32:06 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:32:06 INFO - Contents: 16:32:06 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/2cad3c0e493f900869804d5da870dfc3628f0d1ef56967e0a9072159e11d533b2540869cb5bdfc9046652ad43211fdfa08efb986137312fd00a08dada875e9de", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/a568d27cf6eec8bcd8582a00a15224b16c8a989e866db65d8f9e0b52f9d4ed562da99a81b6095bfa12e4b51ba275607aeabafa142fc83168aa380203413a8858", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/fa4b29a0050679bac19b99bd54606ddafde22d20a15c0e5fe03d89903dfd61167822cd7fe5edd8bc7b28b18a609df5c5507aa6ae4518d248ef663ba0082621b4"} 16:32:06 INFO - Running post-run listener: copy_logs_to_upload_dir 16:32:06 INFO - Copying logs to upload dir... 16:32:06 INFO - mkdir: /builds/slave/test/build/upload/logs 16:32:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1269.329972 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-08-04 16:32:06.787574) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-04 16:32:06.791044) ========= 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.WuMJTvJYDm/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.Rc8TnckJ8D/Listeners TMPDIR=/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/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/2cad3c0e493f900869804d5da870dfc3628f0d1ef56967e0a9072159e11d533b2540869cb5bdfc9046652ad43211fdfa08efb986137312fd00a08dada875e9de", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/a568d27cf6eec8bcd8582a00a15224b16c8a989e866db65d8f9e0b52f9d4ed562da99a81b6095bfa12e4b51ba275607aeabafa142fc83168aa380203413a8858", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/fa4b29a0050679bac19b99bd54606ddafde22d20a15c0e5fe03d89903dfd61167822cd7fe5edd8bc7b28b18a609df5c5507aa6ae4518d248ef663ba0082621b4"} build_url:https://queue.taskcluster.net/v1/task/RzsrsBNcT0aybg8cY1DvaQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011351 build_url: 'https://queue.taskcluster.net/v1/task/RzsrsBNcT0aybg8cY1DvaQ/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/2cad3c0e493f900869804d5da870dfc3628f0d1ef56967e0a9072159e11d533b2540869cb5bdfc9046652ad43211fdfa08efb986137312fd00a08dada875e9de", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/a568d27cf6eec8bcd8582a00a15224b16c8a989e866db65d8f9e0b52f9d4ed562da99a81b6095bfa12e4b51ba275607aeabafa142fc83168aa380203413a8858", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/fa4b29a0050679bac19b99bd54606ddafde22d20a15c0e5fe03d89903dfd61167822cd7fe5edd8bc7b28b18a609df5c5507aa6ae4518d248ef663ba0082621b4"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-04 16:32:06.824070) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 16:32:06.824388) ========= 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.WuMJTvJYDm/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.Rc8TnckJ8D/Listeners TMPDIR=/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/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.005142 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 16:32:06.873561) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-04 16:32:06.873904) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-04 16:32:06.874256) ========= ========= Total master_lag: 0.17 =========