builder: autoland_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0142 starttime: 1470913873.75 results: success (0) buildid: 20160811015321 builduid: 0d1d3774b37549ecbe78f3fb74293eb9 revision: f4f41b355cf02a757995e18bd4878efb90086818 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-11 04:11:13.754960) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-11 04:11:13.755584) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-11 04:11:13.756003) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-11 04:11:13.781496) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 04:11:13.781993) ========= 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.tMvUegWvFx/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.TlWqHhePFE/Listeners TMPDIR=/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/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-11 04:11:13-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 5.70M=0.002s 2016-08-11 04:11:13 (5.70 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.151427 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 04:11:13.955372) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 04:11:13.955691) ========= 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.tMvUegWvFx/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.TlWqHhePFE/Listeners TMPDIR=/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/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.021467 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 04:11:14.004274) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-11 04:11:14.004631) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev f4f41b355cf02a757995e18bd4878efb90086818 --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 f4f41b355cf02a757995e18bd4878efb90086818 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.tMvUegWvFx/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.TlWqHhePFE/Listeners TMPDIR=/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/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-11 04:11:14,079 truncating revision to first 12 chars 2016-08-11 04:11:14,079 Setting DEBUG logging. 2016-08-11 04:11:14,079 attempt 1/10 2016-08-11 04:11:14,079 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/f4f41b355cf0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-11 04:11:15,087 unpacking tar archive at: autoland-f4f41b355cf0/testing/mozharness/ program finished with exit code 0 elapsedTime=1.266711 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-11 04:11:15.293162) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-11 04:11:15.293501) ========= script_repo_revision: f4f41b355cf02a757995e18bd4878efb90086818 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-11 04:11:15.293912) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-11 04:11:15.294179) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-11 04:11:15.313512) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-08-11 04:11:15.313924) ========= /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.tMvUegWvFx/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.TlWqHhePFE/Listeners TMPDIR=/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/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 04:11:15 INFO - MultiFileLogger online at 20160811 04:11:15 in /builds/slave/test 04:11:15 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 04:11:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:11:15 INFO - {'append_to_log': False, 04:11:15 INFO - 'base_work_dir': '/builds/slave/test', 04:11:15 INFO - 'blob_upload_branch': 'Autoland', 04:11:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:11:15 INFO - 'branch': 'Autoland', 04:11:15 INFO - 'buildbot_json_path': 'buildprops.json', 04:11:15 INFO - 'config_files': ('talos/mac_config.py',), 04:11:15 INFO - 'default_actions': ('clobber', 04:11:15 INFO - 'read-buildbot-config', 04:11:15 INFO - 'download-and-extract', 04:11:15 INFO - 'populate-webroot', 04:11:15 INFO - 'create-virtualenv', 04:11:15 INFO - 'install', 04:11:15 INFO - 'run-tests'), 04:11:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:11:15 INFO - 'download_minidump_stackwalk': True, 04:11:15 INFO - 'download_symbols': 'ondemand', 04:11:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:11:15 INFO - 'tooltool.py': '/tools/tooltool.py', 04:11:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:11:15 INFO - '/tools/misc-python/virtualenv.py')}, 04:11:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:11:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:11:15 INFO - 'installer_path': 'installer.exe', 04:11:15 INFO - 'log_level': 'info', 04:11:15 INFO - 'log_name': 'talos', 04:11:15 INFO - 'log_to_console': True, 04:11:15 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:11:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:11:15 INFO - 'opt_config_files': (), 04:11:15 INFO - 'pip_index': False, 04:11:15 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:11:15 INFO - 'cmd': ('bash', 04:11:15 INFO - '-c', 04:11:15 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:11:15 INFO - 'enabled': True, 04:11:15 INFO - 'halt_on_failure': False, 04:11:15 INFO - 'name': 'check_screen_resolution'},), 04:11:15 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:11:15 INFO - 'cmd': ('bash', 04:11:15 INFO - '-c', 04:11:15 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:11:15 INFO - 'enabled': True, 04:11:15 INFO - 'halt_on_failure': False, 04:11:15 INFO - 'name': 'check_screen_resolution'},), 04:11:15 INFO - 'run_cmd_checks_enabled': True, 04:11:15 INFO - 'sps_profile': False, 04:11:15 INFO - 'sps_profile_interval': 0, 04:11:15 INFO - 'suite': 'dromaeojs-e10s', 04:11:15 INFO - 'system_bits': '32', 04:11:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:11:15 INFO - 'title': 't-yosemite-r7-0142', 04:11:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:11:15 INFO - 'use_talos_json': True, 04:11:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:11:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:11:15 INFO - 'work_dir': 'build'} 04:11:15 INFO - [mozharness: 2016-08-11 11:11:15.509670Z] Running clobber step. 04:11:15 INFO - Running pre-action listener: _resource_record_pre_action 04:11:15 INFO - Running main action method: clobber 04:11:15 INFO - rmtree: /builds/slave/test/build 04:11:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:11:16 INFO - Running post-action listener: _resource_record_post_action 04:11:16 INFO - [mozharness: 2016-08-11 11:11:16.937886Z] Finished clobber step (success) 04:11:16 INFO - [mozharness: 2016-08-11 11:11:16.938017Z] Running read-buildbot-config step. 04:11:16 INFO - Running pre-action listener: _resource_record_pre_action 04:11:16 INFO - Running main action method: read_buildbot_config 04:11:16 INFO - Using buildbot properties: 04:11:16 INFO - { 04:11:16 INFO - "project": "", 04:11:16 INFO - "product": "firefox", 04:11:16 INFO - "script_repo_revision": "production", 04:11:16 INFO - "builddir": "autoland_yosemite_r7_test-dromaeojs-e10s", 04:11:16 INFO - "repository": "", 04:11:16 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 autoland talos dromaeojs-e10s", 04:11:16 INFO - "buildid": "20160811015321", 04:11:16 INFO - "pgo_build": "False", 04:11:16 INFO - "basedir": "/builds/slave/test", 04:11:16 INFO - "buildnumber": 103, 04:11:16 INFO - "slavename": "t-yosemite-r7-0142", 04:11:16 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 04:11:16 INFO - "platform": "yosemite_r7", 04:11:16 INFO - "scheduler": "tests-autoland-macosx64-talos", 04:11:16 INFO - "branch": "autoland", 04:11:16 INFO - "repo_path": "integration/autoland", 04:11:16 INFO - "revision": "f4f41b355cf02a757995e18bd4878efb90086818", 04:11:16 INFO - "stage_platform": "macosx64", 04:11:16 INFO - "builduid": "0d1d3774b37549ecbe78f3fb74293eb9", 04:11:16 INFO - "slavebuilddir": "test" 04:11:16 INFO - } 04:11:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/YF6jk806Qde1Ot4Pud_1vQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 04:11:16 INFO - Running post-action listener: _resource_record_post_action 04:11:16 INFO - [mozharness: 2016-08-11 11:11:16.941550Z] Finished read-buildbot-config step (success) 04:11:16 INFO - [mozharness: 2016-08-11 11:11:16.941643Z] Running download-and-extract step. 04:11:16 INFO - Running pre-action listener: _resource_record_pre_action 04:11:16 INFO - Running main action method: download_and_extract 04:11:16 INFO - mkdir: /builds/slave/test/build/tests 04: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')]} 04:11:16 INFO - trying https://queue.taskcluster.net/v1/task/YF6jk806Qde1Ot4Pud_1vQ/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 04:11:16 INFO - Downloading https://queue.taskcluster.net/v1/task/YF6jk806Qde1Ot4Pud_1vQ/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 04:11:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YF6jk806Qde1Ot4Pud_1vQ/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 04:11:18 INFO - Downloaded 1199 bytes. 04:11:18 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 04:11:18 INFO - Using the following test package requirements: 04:11:18 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 04:11:18 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 04:11:18 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 04:11:18 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 04:11:18 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 04:11:18 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 04:11:18 INFO - u'jsshell-mac.zip'], 04:11:18 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 04:11:18 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 04:11:18 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 04:11:18 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 04:11:18 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 04:11:18 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 04:11:18 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 04:11:18 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 04:11:18 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 04:11:18 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 04:11:18 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 04:11:18 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04: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')]} 04:11:18 INFO - trying https://queue.taskcluster.net/v1/task/YF6jk806Qde1Ot4Pud_1vQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 04:11:18 INFO - Downloading https://queue.taskcluster.net/v1/task/YF6jk806Qde1Ot4Pud_1vQ/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 04:11:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YF6jk806Qde1Ot4Pud_1vQ/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 04:11:19 INFO - Downloaded 16328339 bytes. 04:11:19 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 04:11:26 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 04:11: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')]} 04:11:26 INFO - trying https://queue.taskcluster.net/v1/task/YF6jk806Qde1Ot4Pud_1vQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 04:11:26 INFO - Downloading https://queue.taskcluster.net/v1/task/YF6jk806Qde1Ot4Pud_1vQ/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 04:11:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YF6jk806Qde1Ot4Pud_1vQ/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 04:11:26 INFO - Downloaded 16328339 bytes. 04:11:26 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 04: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')]} 04:11:33 INFO - trying https://queue.taskcluster.net/v1/task/YF6jk806Qde1Ot4Pud_1vQ/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 04:11:33 INFO - Downloading https://queue.taskcluster.net/v1/task/YF6jk806Qde1Ot4Pud_1vQ/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 04:11:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YF6jk806Qde1Ot4Pud_1vQ/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 04:11:34 INFO - Downloaded 14413719 bytes. 04:11:34 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/tests 04:11:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:11:35 INFO - trying https://queue.taskcluster.net/v1/task/YF6jk806Qde1Ot4Pud_1vQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 04:11:35 INFO - Downloading https://queue.taskcluster.net/v1/task/YF6jk806Qde1Ot4Pud_1vQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 04:11:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YF6jk806Qde1Ot4Pud_1vQ/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 04:11:37 INFO - Downloaded 110902329 bytes. 04:11:37 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YF6jk806Qde1Ot4Pud_1vQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 04:11:37 INFO - mkdir: /builds/slave/test/properties 04:11:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:11:37 INFO - Writing to file /builds/slave/test/properties/build_url 04:11:37 INFO - Contents: 04:11:37 INFO - build_url:https://queue.taskcluster.net/v1/task/YF6jk806Qde1Ot4Pud_1vQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 04:11:38 INFO - Running post-action listener: _resource_record_post_action 04:11:38 INFO - Running post-action listener: set_extra_try_arguments 04:11:38 INFO - [mozharness: 2016-08-11 11:11:38.491789Z] Finished download-and-extract step (success) 04:11:38 INFO - [mozharness: 2016-08-11 11:11:38.491916Z] Running populate-webroot step. 04:11:38 INFO - Running pre-action listener: _resource_record_pre_action 04:11:38 INFO - Running main action method: populate_webroot 04:11:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:11:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:11:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:11:38 INFO - '--tppagecycles', 04:11:38 INFO - '7'], 04:11:38 INFO - 'tests': ['tsvgm']}}, 04:11:38 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:11:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:11:38 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:11:38 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:11:38 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:11:38 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:11:38 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:11:38 INFO - 'talos_options': ['--disable-e10s'], 04:11:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:11:38 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:11:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:11:38 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:11:38 INFO - 'talos_options': ['--disable-e10s'], 04:11:38 INFO - 'tests': ['damp', 'tps']}, 04:11:38 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:11:38 INFO - 'tests': ['damp', 'tps']}, 04:11:38 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:11:38 INFO - 'tests': ['dromaeo_dom']}, 04:11:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:11:38 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:11:38 INFO - 'tests': ['basic_compositor_video']}, 04:11:38 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:11:38 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:11:38 INFO - 'tests': ['a11yr', 04:11:38 INFO - 'ts_paint', 04:11:38 INFO - 'tpaint', 04:11:38 INFO - 'sessionrestore', 04:11:38 INFO - 'sessionrestore_no_auto_restore', 04:11:38 INFO - 'tabpaint']}, 04:11:38 INFO - 'other-e10s': {'tests': ['a11yr', 04:11:38 INFO - 'ts_paint', 04:11:38 INFO - 'tpaint', 04:11:38 INFO - 'sessionrestore', 04:11:38 INFO - 'sessionrestore_no_auto_restore', 04:11:38 INFO - 'tabpaint']}, 04:11:38 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:11:38 INFO - 'ts_paint', 04:11:38 INFO - 'tpaint', 04:11:38 INFO - 'sessionrestore', 04:11:38 INFO - 'sessionrestore_no_auto_restore', 04:11:38 INFO - 'tabpaint']}, 04:11:38 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:11:38 INFO - 'ts_paint', 04:11:38 INFO - 'tpaint', 04:11:38 INFO - 'sessionrestore', 04:11:38 INFO - 'sessionrestore_no_auto_restore', 04:11:38 INFO - 'tabpaint']}, 04:11:38 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:11:38 INFO - 'tests': ['a11yr', 04:11:38 INFO - 'ts_paint', 04:11:38 INFO - 'tpaint', 04:11:38 INFO - 'sessionrestore', 04:11:38 INFO - 'sessionrestore_no_auto_restore', 04:11:38 INFO - 'tabpaint']}, 04:11:38 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:11:38 INFO - 'tests': ['a11yr', 04:11:38 INFO - 'ts_paint', 04:11:38 INFO - 'tpaint', 04:11:38 INFO - 'sessionrestore', 04:11:38 INFO - 'sessionrestore_no_auto_restore', 04:11:38 INFO - 'tabpaint']}, 04:11:38 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:11:38 INFO - 'tests': ['tsvgx', 04:11:38 INFO - 'tsvgr_opacity', 04:11:38 INFO - 'tart', 04:11:38 INFO - 'tscrollx', 04:11:38 INFO - 'cart']}, 04:11:38 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:11:38 INFO - 'tsvgr_opacity', 04:11:38 INFO - 'tart', 04:11:38 INFO - 'tscrollx', 04:11:38 INFO - 'cart']}, 04:11:38 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:11:38 INFO - 'talos_options': ['--disable-e10s'], 04:11:38 INFO - 'tests': ['tp5o']}, 04:11:38 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:11:38 INFO - 'tests': ['tp5o']}, 04:11:38 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:11:38 INFO - 'talos_options': ['--disable-e10s', 04:11:38 INFO - '--xperf_path', 04:11:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:11:38 INFO - 'tests': ['tp5n']}, 04:11:38 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:11:38 INFO - 'talos_options': ['--xperf_path', 04:11:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:11:38 INFO - 'tests': ['tp5n']}}, 04:11:38 INFO - 'talos.zip': {'path': '', 04:11:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:11:38 INFO - Running post-action listener: _resource_record_post_action 04:11:38 INFO - [mozharness: 2016-08-11 11:11:38.511000Z] Finished populate-webroot step (success) 04:11:38 INFO - [mozharness: 2016-08-11 11:11:38.511117Z] Running create-virtualenv step. 04:11:38 INFO - Running pre-action listener: _resource_record_pre_action 04:11:38 INFO - Running main action method: create_virtualenv 04:11:38 INFO - Creating virtualenv /builds/slave/test/build/venv 04:11:38 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 04:11:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:11:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:11:38 INFO - Using real prefix '/tools/python27' 04:11:38 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:11:39 INFO - Installing distribute.............................................................................................................................................................................................done. 04:11:42 INFO - Installing pip.................done. 04:11:42 INFO - Return code: 0 04:11:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:11:42 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')]} 04:11:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:11:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:42 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')]} 04:11:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:11:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:42 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 0x104018a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1040ad618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe4e2dd8720>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103f7cd30>, '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 0x103ce1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103f74b20>, '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.tMvUegWvFx/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.TlWqHhePFE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/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 04:11:42 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 04:11:42 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 04:11:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tMvUegWvFx/Render', 04:11:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:11:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:11:42 INFO - 'HOME': '/Users/cltbld', 04:11:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:11:42 INFO - 'LOGNAME': 'cltbld', 04:11:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:11:42 INFO - 'MOZ_NO_REMOTE': '1', 04:11:42 INFO - 'NO_EM_RESTART': '1', 04:11:42 INFO - 'PAGER': '/bin/cat', 04:11:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:11:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:11:42 INFO - 'PWD': '/builds/slave/test', 04:11:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:11:42 INFO - 'SHELL': '/bin/bash', 04:11:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TlWqHhePFE/Listeners', 04:11:42 INFO - 'TMPDIR': '/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/', 04:11:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:11:42 INFO - 'USER': 'cltbld', 04:11:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:11:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:11:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:11:42 INFO - 'XPC_FLAGS': '0x0', 04:11:42 INFO - 'XPC_SERVICE_NAME': '0', 04:11:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:11:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:11:42 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 04:11:42 INFO - Cleaning up... 04:11:42 INFO - Return code: 0 04:11:42 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:11:42 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')]} 04:11:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:11:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:42 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')]} 04:11:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:11:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:42 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 0x104018a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1040ad618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe4e2dd8720>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103f7cd30>, '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 0x103ce1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103f74b20>, '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.tMvUegWvFx/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.TlWqHhePFE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/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 04:11:42 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 04:11:42 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 04:11:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tMvUegWvFx/Render', 04:11:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:11:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:11:42 INFO - 'HOME': '/Users/cltbld', 04:11:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:11:42 INFO - 'LOGNAME': 'cltbld', 04:11:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:11:42 INFO - 'MOZ_NO_REMOTE': '1', 04:11:42 INFO - 'NO_EM_RESTART': '1', 04:11:42 INFO - 'PAGER': '/bin/cat', 04:11:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:11:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:11:42 INFO - 'PWD': '/builds/slave/test', 04:11:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:11:42 INFO - 'SHELL': '/bin/bash', 04:11:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TlWqHhePFE/Listeners', 04:11:42 INFO - 'TMPDIR': '/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/', 04:11:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:11:42 INFO - 'USER': 'cltbld', 04:11:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:11:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:11:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:11:42 INFO - 'XPC_FLAGS': '0x0', 04:11:42 INFO - 'XPC_SERVICE_NAME': '0', 04:11:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:11:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:11:42 INFO - Downloading/unpacking psutil>=3.1.1 04:11:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:11:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:11:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:11:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:11:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:11:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:11:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:11:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:11:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:11:45 INFO - Installing collected packages: psutil 04:11:45 INFO - Running setup.py install for psutil 04:11:45 INFO - building 'psutil._psutil_osx' extension 04:11:45 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 04:11:46 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 04:11:46 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 04:11:46 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 04:11:46 INFO - building 'psutil._psutil_posix' extension 04:11:46 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 04:11:46 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:11:46 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:11:46 INFO - ^ 04:11:46 INFO - 1 warning generated. 04:11:46 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 04:11:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:11:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:11:46 INFO - Successfully installed psutil 04:11:46 INFO - Cleaning up... 04:11:46 INFO - Return code: 0 04:11:46 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04: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')]} 04:11:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:11:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04: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')]} 04:11:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:11:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104018a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1040ad618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe4e2dd8720>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103f7cd30>, '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 0x103ce1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103f74b20>, '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.tMvUegWvFx/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.TlWqHhePFE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/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 04:11:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:11:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:11:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tMvUegWvFx/Render', 04:11:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:11:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:11:46 INFO - 'HOME': '/Users/cltbld', 04:11:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:11:46 INFO - 'LOGNAME': 'cltbld', 04:11:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:11:46 INFO - 'MOZ_NO_REMOTE': '1', 04:11:46 INFO - 'NO_EM_RESTART': '1', 04:11:46 INFO - 'PAGER': '/bin/cat', 04:11:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:11:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:11:46 INFO - 'PWD': '/builds/slave/test', 04:11:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:11:46 INFO - 'SHELL': '/bin/bash', 04:11:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TlWqHhePFE/Listeners', 04:11:46 INFO - 'TMPDIR': '/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/', 04:11:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:11:46 INFO - 'USER': 'cltbld', 04:11:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:11:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:11:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:11:46 INFO - 'XPC_FLAGS': '0x0', 04:11:46 INFO - 'XPC_SERVICE_NAME': '0', 04:11:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:11:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:11:46 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:11:46 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 04:11:46 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 04:11:46 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 04:11:46 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 04:11:46 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 04:11:46 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 04:11:49 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:11:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:11:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:11:49 INFO - Installing collected packages: mozsystemmonitor 04:11:49 INFO - Running setup.py install for mozsystemmonitor 04:11:49 INFO - Successfully installed mozsystemmonitor 04:11:49 INFO - Cleaning up... 04:11:49 INFO - Return code: 0 04:11:49 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:11:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:11:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:11:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:11:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:11:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x104018a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1040ad618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe4e2dd8720>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103f7cd30>, '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 0x103ce1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103f74b20>, '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.tMvUegWvFx/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.TlWqHhePFE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/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 04:11:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:11:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 04:11:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tMvUegWvFx/Render', 04:11:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:11:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:11:49 INFO - 'HOME': '/Users/cltbld', 04:11:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:11:49 INFO - 'LOGNAME': 'cltbld', 04:11:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:11:49 INFO - 'MOZ_NO_REMOTE': '1', 04:11:49 INFO - 'NO_EM_RESTART': '1', 04:11:49 INFO - 'PAGER': '/bin/cat', 04:11:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:11:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:11:49 INFO - 'PWD': '/builds/slave/test', 04:11:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:11:49 INFO - 'SHELL': '/bin/bash', 04:11:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TlWqHhePFE/Listeners', 04:11:49 INFO - 'TMPDIR': '/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/', 04:11:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:11:49 INFO - 'USER': 'cltbld', 04:11:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:11:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:11:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:11:49 INFO - 'XPC_FLAGS': '0x0', 04:11:49 INFO - 'XPC_SERVICE_NAME': '0', 04:11:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:11:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:11:49 INFO - Downloading/unpacking jsonschema==2.5.1 04:11:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:11:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:11:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:11:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:11:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:11:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:11:52 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:11:52 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:11:52 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 04:11:52 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 04:11:52 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 04:11:52 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 04:11:52 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 04:11:52 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 04:11:52 INFO - Downloading functools32-3.2.3-2.tar.gz 04:11:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:11:52 INFO - warning: no files found matching '*.txt' 04:11:52 INFO - no previously-included directories found matching 'build' 04:11:52 INFO - no previously-included directories found matching 'dist' 04:11:52 INFO - no previously-included directories found matching '.git*' 04:11:52 INFO - Installing collected packages: jsonschema, functools32 04:11:52 INFO - Running setup.py install for functools32 04:11:53 INFO - warning: no files found matching '*.txt' 04:11:53 INFO - no previously-included directories found matching 'build' 04:11:53 INFO - no previously-included directories found matching 'dist' 04:11:53 INFO - no previously-included directories found matching '.git*' 04:11:53 INFO - Successfully installed jsonschema functools32 04:11:53 INFO - Cleaning up... 04:11:53 INFO - Return code: 0 04:11:53 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:11:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:11:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:11:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:11:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:11:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x104018a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1040ad618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe4e2dd8720>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103f7cd30>, '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 0x103ce1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103f74b20>, '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.tMvUegWvFx/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.TlWqHhePFE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/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 04:11:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 04:11:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 04:11:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tMvUegWvFx/Render', 04:11:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:11:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:11:53 INFO - 'HOME': '/Users/cltbld', 04:11:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:11:53 INFO - 'LOGNAME': 'cltbld', 04:11:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:11:53 INFO - 'MOZ_NO_REMOTE': '1', 04:11:53 INFO - 'NO_EM_RESTART': '1', 04:11:53 INFO - 'PAGER': '/bin/cat', 04:11:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:11:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:11:53 INFO - 'PWD': '/builds/slave/test', 04:11:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:11:53 INFO - 'SHELL': '/bin/bash', 04:11:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TlWqHhePFE/Listeners', 04:11:53 INFO - 'TMPDIR': '/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/', 04:11:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:11:53 INFO - 'USER': 'cltbld', 04:11:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:11:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:11:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:11:53 INFO - 'XPC_FLAGS': '0x0', 04:11:53 INFO - 'XPC_SERVICE_NAME': '0', 04:11:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:11:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:11:53 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:11:53 INFO - Cleaning up... 04:11:53 INFO - Return code: 0 04:11:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:11:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:11:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:11:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:11:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:11:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x104018a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1040ad618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe4e2dd8720>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103f7cd30>, '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 0x103ce1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103f74b20>, '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.tMvUegWvFx/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.TlWqHhePFE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/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 04:11:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:11:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:11:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tMvUegWvFx/Render', 04:11:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:11:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:11:53 INFO - 'HOME': '/Users/cltbld', 04:11:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:11:53 INFO - 'LOGNAME': 'cltbld', 04:11:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:11:53 INFO - 'MOZ_NO_REMOTE': '1', 04:11:53 INFO - 'NO_EM_RESTART': '1', 04:11:53 INFO - 'PAGER': '/bin/cat', 04:11:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:11:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:11:53 INFO - 'PWD': '/builds/slave/test', 04:11:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:11:53 INFO - 'SHELL': '/bin/bash', 04:11:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TlWqHhePFE/Listeners', 04:11:53 INFO - 'TMPDIR': '/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/', 04:11:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:11:53 INFO - 'USER': 'cltbld', 04:11:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:11:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:11:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:11:53 INFO - 'XPC_FLAGS': '0x0', 04:11:53 INFO - 'XPC_SERVICE_NAME': '0', 04:11:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:11:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:11:53 INFO - Downloading/unpacking blobuploader==1.2.4 04:11:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:11:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:11:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:11:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:11:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:11:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:11:56 INFO - Downloading blobuploader-1.2.4.tar.gz 04:11:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:11:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:11:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:11:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:11:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:11:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:11:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:11:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:11:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:11:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:11:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:11:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:11:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:11:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:11:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:11:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:11:57 INFO - Downloading docopt-0.6.1.tar.gz 04:11:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:11:57 INFO - Installing collected packages: blobuploader, requests, docopt 04:11:57 INFO - Running setup.py install for blobuploader 04:11:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:11:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:11:57 INFO - Running setup.py install for requests 04:11:57 INFO - Running setup.py install for docopt 04:11:58 INFO - Successfully installed blobuploader requests docopt 04:11:58 INFO - Cleaning up... 04:11:58 INFO - Return code: 0 04:11:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:11:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:11:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:11:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:11:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:11:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:58 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 0x104018a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1040ad618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe4e2dd8720>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103f7cd30>, '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 0x103ce1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103f74b20>, '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.tMvUegWvFx/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.TlWqHhePFE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/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 04:11:58 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 04:11:58 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 04:11:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tMvUegWvFx/Render', 04:11:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:11:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:11:58 INFO - 'HOME': '/Users/cltbld', 04:11:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:11:58 INFO - 'LOGNAME': 'cltbld', 04:11:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:11:58 INFO - 'MOZ_NO_REMOTE': '1', 04:11:58 INFO - 'NO_EM_RESTART': '1', 04:11:58 INFO - 'PAGER': '/bin/cat', 04:11:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:11:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:11:58 INFO - 'PWD': '/builds/slave/test', 04:11:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:11:58 INFO - 'SHELL': '/bin/bash', 04:11:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TlWqHhePFE/Listeners', 04:11:58 INFO - 'TMPDIR': '/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/', 04:11:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:11:58 INFO - 'USER': 'cltbld', 04:11:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:11:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:11:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:11:58 INFO - 'XPC_FLAGS': '0x0', 04:11:58 INFO - 'XPC_SERVICE_NAME': '0', 04:11:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:11:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:11:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:11:58 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-hqJeTU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:11:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:11:58 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-nnDvck-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:11:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:11:58 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-Jyc5Nk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:11:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:11:58 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-bgMTBA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:11:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:11:58 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-Lh2eQ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:11:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:11:59 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-Km7Cfl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:11:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:11:59 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-T0Jcde-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:11:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:11:59 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-2i0LD0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:11:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:11:59 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-o80mCh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:11:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:11:59 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-7qXo0S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:11:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:11:59 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-fl2rxT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:11:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:11:59 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-v68PTQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:11:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:11:59 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-bkGOMj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:11:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:11:59 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-d1WFjS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:11:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:11:59 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-WBhPBk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:12:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:12:00 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-WEKyJk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:12:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:12:00 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-GvCqhY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:12:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:12:00 INFO - Running setup.py install for manifestparser 04:12:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:12:00 INFO - Running setup.py install for mozcrash 04:12:00 INFO - Running setup.py install for mozdebug 04:12:00 INFO - Running setup.py install for mozdevice 04:12:00 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:12:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:12:00 INFO - Running setup.py install for mozfile 04:12:00 INFO - Running setup.py install for mozhttpd 04:12:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:12:01 INFO - Running setup.py install for mozinfo 04:12:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:12:01 INFO - Running setup.py install for mozInstall 04:12:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:12:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:12:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:12:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:12:01 INFO - Running setup.py install for mozleak 04:12:01 INFO - Running setup.py install for mozlog 04:12:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:12:01 INFO - Running setup.py install for moznetwork 04:12:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:12:01 INFO - Running setup.py install for mozprocess 04:12:02 INFO - Running setup.py install for mozprofile 04:12:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:12:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:12:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:12:02 INFO - Running setup.py install for mozrunner 04:12:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:12:02 INFO - Running setup.py install for mozscreenshot 04:12:02 INFO - Running setup.py install for moztest 04:12:02 INFO - Running setup.py install for mozversion 04:12:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:12:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:12:02 INFO - Cleaning up... 04:12:02 INFO - Return code: 0 04:12:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:12:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:12:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:12:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:12:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:12:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:02 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 0x104018a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1040ad618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe4e2dd8720>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103f7cd30>, '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 0x103ce1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103f74b20>, '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.tMvUegWvFx/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.TlWqHhePFE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/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 04:12:02 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 04:12:02 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 04:12:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tMvUegWvFx/Render', 04:12:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:12:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:12:02 INFO - 'HOME': '/Users/cltbld', 04:12:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:12:02 INFO - 'LOGNAME': 'cltbld', 04:12:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:12:02 INFO - 'MOZ_NO_REMOTE': '1', 04:12:02 INFO - 'NO_EM_RESTART': '1', 04:12:02 INFO - 'PAGER': '/bin/cat', 04:12:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:12:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:12:02 INFO - 'PWD': '/builds/slave/test', 04:12:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:12:02 INFO - 'SHELL': '/bin/bash', 04:12:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TlWqHhePFE/Listeners', 04:12:02 INFO - 'TMPDIR': '/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/', 04:12:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:12:02 INFO - 'USER': 'cltbld', 04:12:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:12:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:12:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:12:02 INFO - 'XPC_FLAGS': '0x0', 04:12:02 INFO - 'XPC_SERVICE_NAME': '0', 04:12:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:12:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:12:03 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-xNz66F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:12:03 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)) 04:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:12:03 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-6mZbvG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:12:03 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)) 04:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:12:03 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-zFuKTi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:12:03 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)) 04:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:12:03 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-jnU412-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:12:03 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)) 04:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:12:03 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-Y14fJ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:12:03 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)) 04:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:12:03 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-0AKzpi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:12:03 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)) 04:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:12:03 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-URQxps-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:12:03 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)) 04:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:12:03 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-So_INx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:12:03 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)) 04:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:12:03 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-fb02Hd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:12:04 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)) 04:12:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:12:04 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-H71gwM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:12:04 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)) 04:12:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:12:04 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-wiA6_J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:12:04 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)) 04:12:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:12:04 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-2UL6kL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:12:04 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)) 04:12:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:12:04 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-AimMIu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:12:04 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)) 04:12:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:12:04 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-b0GSQk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:12:04 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)) 04:12:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:12:04 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-NGQMyW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:12:04 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)) 04:12:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:12:04 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-IH2Zvx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:12:04 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)) 04:12:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:12:04 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-ICm3KZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:12:04 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)) 04:12:04 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)) 04:12:04 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)) 04:12:04 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)) 04:12:04 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)) 04:12:04 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)) 04:12:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:12:04 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 04:12:04 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 04:12:04 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 04:12:04 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 04:12:04 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 04:12:04 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 04:12:07 INFO - Downloading blessings-1.6.tar.gz 04:12:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:12:07 INFO - Installing collected packages: blessings 04:12:07 INFO - Running setup.py install for blessings 04:12:07 INFO - Successfully installed blessings 04:12:07 INFO - Cleaning up... 04:12:07 INFO - Return code: 0 04:12:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:12:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:12:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:12:07 INFO - Reading from file tmpfile_stdout 04:12:07 INFO - Current package versions: 04:12:07 INFO - blessings == 1.6 04:12:07 INFO - blobuploader == 1.2.4 04:12:07 INFO - docopt == 0.6.1 04:12:07 INFO - functools32 == 3.2.3-2 04:12:07 INFO - jsonschema == 2.5.1 04:12:07 INFO - manifestparser == 1.1 04:12:07 INFO - mozInstall == 1.12 04:12:07 INFO - mozcrash == 0.17 04:12:07 INFO - mozdebug == 0.1 04:12:07 INFO - mozdevice == 0.48 04:12:07 INFO - mozfile == 1.2 04:12:07 INFO - mozhttpd == 0.7 04:12:07 INFO - mozinfo == 0.9 04:12:07 INFO - mozleak == 0.1 04:12:07 INFO - mozlog == 3.3 04:12:07 INFO - moznetwork == 0.27 04:12:07 INFO - mozprocess == 0.23 04:12:07 INFO - mozprofile == 0.28 04:12:07 INFO - mozrunner == 6.12 04:12:07 INFO - mozscreenshot == 0.1 04:12:07 INFO - mozsystemmonitor == 0.3 04:12:07 INFO - moztest == 0.7 04:12:07 INFO - mozversion == 1.4 04:12:07 INFO - psutil == 3.1.1 04:12:07 INFO - requests == 1.2.3 04:12:07 INFO - wsgiref == 0.1.2 04:12:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:12:07 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')]} 04:12:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:12:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:07 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')]} 04:12:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:12:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:07 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 0x104018a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1040ad618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe4e2dd8720>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103f7cd30>, '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 0x103ce1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103f74b20>, '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.tMvUegWvFx/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.TlWqHhePFE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/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 04:12:07 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 04:12:07 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 04:12:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tMvUegWvFx/Render', 04:12:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:12:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:12:07 INFO - 'HOME': '/Users/cltbld', 04:12:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:12:07 INFO - 'LOGNAME': 'cltbld', 04:12:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:12:07 INFO - 'MOZ_NO_REMOTE': '1', 04:12:07 INFO - 'NO_EM_RESTART': '1', 04:12:07 INFO - 'PAGER': '/bin/cat', 04:12:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:12:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:12:07 INFO - 'PWD': '/builds/slave/test', 04:12:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:12:07 INFO - 'SHELL': '/bin/bash', 04:12:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TlWqHhePFE/Listeners', 04:12:07 INFO - 'TMPDIR': '/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/', 04:12:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:12:07 INFO - 'USER': 'cltbld', 04:12:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:12:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:12:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:12:07 INFO - 'XPC_FLAGS': '0x0', 04:12:07 INFO - 'XPC_SERVICE_NAME': '0', 04:12:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:12:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:12:08 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)) 04:12:08 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)) 04:12:08 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)) 04:12:08 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)) 04:12:08 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)) 04:12:08 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)) 04:12:08 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)) 04:12:08 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)) 04:12:08 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)) 04:12:08 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)) 04:12:08 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)) 04:12:08 INFO - Cleaning up... 04:12:08 INFO - Return code: 0 04:12:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:12: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')]} 04:12:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:12:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12: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')]} 04:12:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:12:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:08 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 0x104018a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1040ad618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe4e2dd8720>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103f7cd30>, '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 0x103ce1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103f74b20>, '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.tMvUegWvFx/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.TlWqHhePFE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/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 04:12:08 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 04:12:08 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 04:12:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tMvUegWvFx/Render', 04:12:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:12:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:12:08 INFO - 'HOME': '/Users/cltbld', 04:12:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:12:08 INFO - 'LOGNAME': 'cltbld', 04:12:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:12:08 INFO - 'MOZ_NO_REMOTE': '1', 04:12:08 INFO - 'NO_EM_RESTART': '1', 04:12:08 INFO - 'PAGER': '/bin/cat', 04:12:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:12:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:12:08 INFO - 'PWD': '/builds/slave/test', 04:12:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:12:08 INFO - 'SHELL': '/bin/bash', 04:12:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TlWqHhePFE/Listeners', 04:12:08 INFO - 'TMPDIR': '/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/', 04:12:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:12:08 INFO - 'USER': 'cltbld', 04:12:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:12:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:12:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:12:08 INFO - 'XPC_FLAGS': '0x0', 04:12:08 INFO - 'XPC_SERVICE_NAME': '0', 04:12:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:12:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:12:08 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:12:08 INFO - Cleaning up... 04:12:08 INFO - Return code: 0 04:12:08 INFO - Running post-action listener: _resource_record_post_action 04:12:08 INFO - Running post-action listener: _start_resource_monitoring 04:12:08 INFO - Starting resource monitoring. 04:12:08 INFO - [mozharness: 2016-08-11 11:12:08.494650Z] Finished create-virtualenv step (success) 04:12:08 INFO - [mozharness: 2016-08-11 11:12:08.495628Z] Running install step. 04:12:08 INFO - Running pre-action listener: _resource_record_pre_action 04:12:08 INFO - Running main action method: install 04:12:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:12:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:12:08 INFO - Reading from file tmpfile_stdout 04:12:08 INFO - Detecting whether we're running mozinstall >=1.0... 04:12:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:12:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:12:08 INFO - Reading from file tmpfile_stdout 04:12:08 INFO - Output received: 04:12:08 INFO - Usage: mozinstall [options] installer 04:12:08 INFO - Options: 04:12:08 INFO - -h, --help show this help message and exit 04:12:08 INFO - -d DEST, --destination=DEST 04:12:08 INFO - Directory to install application into. [default: 04:12:08 INFO - "/builds/slave/test"] 04:12:08 INFO - --app=APP Application being installed. [default: firefox] 04:12:08 INFO - mkdir: /builds/slave/test/build/application 04:12:08 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'] 04:12:08 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 04:12:42 INFO - Reading from file tmpfile_stdout 04:12:42 INFO - Output received: 04:12:42 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 04:12:42 INFO - Running post-action listener: _resource_record_post_action 04:12:42 INFO - [mozharness: 2016-08-11 11:12:42.684214Z] Finished install step (success) 04:12:42 INFO - [mozharness: 2016-08-11 11:12:42.684376Z] Running run-tests step. 04:12:42 INFO - Running pre-action listener: _resource_record_pre_action 04:12:42 INFO - Running main action method: run_tests 04:12:42 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:12:42 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:12:42 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:12:42 INFO - 2016-08-11 04:12:42.698 screenresolution[1945:15658] starting screenresolution argv=screenresolution get 04:12:42 INFO - 2016-08-11 04:12:42.701 screenresolution[1945:15658] Display 0: 1600x1200x32@60 04:12:42 INFO - 2016-08-11 04:12:42.707 screenresolution[1946:15660] starting screenresolution argv=screenresolution list 04:12:42 INFO - Available Modes on Display 0 04:12:42 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:12:42 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:12:42 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:12:42 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:12:42 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:12:42 INFO - Intel Iris: 04:12:42 INFO - Chipset Model: Intel Iris 04:12:42 INFO - Type: GPU 04:12:42 INFO - Bus: Built-In 04:12:42 INFO - VRAM (Dynamic, Max): 1536 MB 04:12:42 INFO - Vendor: Intel (0x8086) 04:12:42 INFO - Device ID: 0x0a2e 04:12:42 INFO - Revision ID: 0x0009 04:12:42 INFO - Displays: 04:12:42 INFO - Display: 04:12:42 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:12:42 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:12:42 INFO - Display Serial Number: 1600x1200 60 04:12:42 INFO - Main Display: Yes 04:12:42 INFO - Mirror: Off 04:12:42 INFO - Online: Yes 04:12:42 INFO - Rotation: Supported 04:12:42 INFO - Return code: 0 04:12:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:12:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:12:42 INFO - Python 2.7.3 04:12:42 INFO - Return code: 0 04:12:42 INFO - grabbing minidump binary from tooltool 04:12:42 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')]} 04:12:42 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 0x103f7cd30>, '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 0x103ce1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103f74b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:12:42 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 04:12:42 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 04:12:42 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 04:12:43 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:12:43 INFO - Return code: 0 04:12:43 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:12:43 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:12:43 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:12:43 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:12:43 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:12:43 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/YF6jk806Qde1Ot4Pud_1vQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0142', '--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 04:12:43 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/YF6jk806Qde1Ot4Pud_1vQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0142 --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 04:12:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tMvUegWvFx/Render', 04:12:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:12:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:12:43 INFO - 'HOME': '/Users/cltbld', 04:12:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:12:43 INFO - 'LOGNAME': 'cltbld', 04:12:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:12:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:12:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:12:43 INFO - 'MOZ_NO_REMOTE': '1', 04:12:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:12:43 INFO - 'NO_EM_RESTART': '1', 04:12:43 INFO - 'PAGER': '/bin/cat', 04:12:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:12:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:12:43 INFO - 'PWD': '/builds/slave/test', 04:12:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:12:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:12:43 INFO - 'SHELL': '/bin/bash', 04:12:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TlWqHhePFE/Listeners', 04:12:43 INFO - 'TMPDIR': '/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/', 04:12:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:12:43 INFO - 'USER': 'cltbld', 04:12:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:12:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:12:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:12:43 INFO - 'XPC_FLAGS': '0x0', 04:12:43 INFO - 'XPC_SERVICE_NAME': '0', 04:12:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:12:43 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/YF6jk806Qde1Ot4Pud_1vQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0142', '--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 04:12:43 INFO - mozversion application_buildid: 20160811015321 04:12:43 INFO - mozversion application_changeset: f4f41b355cf02a757995e18bd4878efb90086818 04:12:43 INFO - mozversion application_display_name: Nightly 04:12:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:12:43 INFO - mozversion application_name: Firefox 04:12:43 INFO - mozversion application_remotingname: firefox 04:12:43 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 04:12:43 INFO - mozversion application_vendor: Mozilla 04:12:43 INFO - mozversion application_version: 51.0a1 04:12:43 INFO - mozversion platform_buildid: 20160811015321 04:12:43 INFO - mozversion platform_changeset: f4f41b355cf02a757995e18bd4878efb90086818 04:12:43 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 04:12:43 INFO - mozversion platform_version: 51.0a1 04:12:43 INFO - using testdate: 1470913963 04:12:43 INFO - actual date: 1470913963 04:12:43 INFO - starting webserver on 'localhost:52476' 04:12:43 INFO - SUITE-START | Running 2 tests 04:12:43 INFO - TEST-START | dromaeo_css 04:12:43 INFO - operating with platform_type : mac_ 04:12:43 INFO - Initialising browser for dromaeo_css test... 04:12:43 INFO - TEST-INFO | started process 1956 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/tmp9UI98e/profile http://localhost:52476/getInfo.html) 04:12:45 INFO - PROCESS | 1956 | __metrics Screen width/height:1600/1200 04:12:45 INFO - PROCESS | 1956 | colorDepth:24 04:12:45 INFO - PROCESS | 1956 | Browser inner width/height: 1024/663 04:12:45 INFO - PROCESS | 1956 | __metrics 04:12:46 ERROR - PROCESS | 1956 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2983: TypeError: this.tabs is undefined 04:12:46 INFO - TEST-INFO | 1956: exit 0 04:12:46 INFO - Browser initialized. 04:12:46 INFO - Running cycle 1/1 for dromaeo_css test... 04:12:46 INFO - TEST-INFO | started process 1959 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/tmp9UI98e/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:12:58 INFO - PROCESS | 1959 | RSS: Main: 264065024 04:12:58 INFO - PROCESS | 1959 | 04:13:48 INFO - PROCESS | 1959 | 1470914028251 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] 04:16:00 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:52476/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52476/tests/dromaeo/cssquery-ext.html) 04:16:02 INFO - PROCESS | 1959 | RSS: Main: 276701184 04:16:02 INFO - PROCESS | 1959 | 04:19:04 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:52476/tests/dromaeo/cssquery-ext.html (next: http://localhost:52476/tests/dromaeo/cssquery-jquery.html) 04:19:05 INFO - PROCESS | 1959 | RSS: Main: 285769728 04:19:05 INFO - PROCESS | 1959 | 04:22:07 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:52476/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52476/tests/dromaeo/cssquery-mootools.html) 04:22:07 INFO - PROCESS | 1959 | RSS: Main: 291401728 04:22:07 INFO - PROCESS | 1959 | 04:25:09 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:52476/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52476/tests/dromaeo/cssquery-prototype.html) 04:25:10 INFO - PROCESS | 1959 | RSS: Main: 290430976 04:25:10 INFO - PROCESS | 1959 | 04:28:13 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:52476/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52476/tests/dromaeo/cssquery-yui.html) 04:28:13 INFO - PROCESS | 1959 | RSS: Main: 294096896 04:28:13 INFO - PROCESS | 1959 | 04:31:16 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:52476/tests/dromaeo/cssquery-yui.html (next: http://localhost:52476/tests/dromaeo/cssquery-dojo.html) 04:31:16 INFO - PROCESS | 1959 | RSS: Main: 295587840 04:31:16 INFO - PROCESS | 1959 | 04:31:16 INFO - PROCESS | 1959 | __start_tp_report 04:31:16 INFO - PROCESS | 1959 | _x_x_mozilla_page_load 04:31:16 INFO - PROCESS | 1959 | _x_x_mozilla_page_load_details 04:31:16 INFO - PROCESS | 1959 | |i|pagename|runs| 04:31:16 INFO - PROCESS | 1959 | |0;dojo.html;3372.865085396584;3398.7450941179404;3419.111031131905;3426.4860270959343;3455.844486998085;5530.723463826813;5739.368669446358;5764.6541207527525;5769.682667453289;5840.678762668052;5679.460451257124;5688.886222275552;5745.971270143644;5759.654420734759;5781.710914454282;5082.618803589727;5215.1655735082395;5216.7913283468615;5273;5297.073012222865;5301.443348448415;5333.2000199969925;5349.304590403242;5373.623846330758;5388.164834450667;5102.285680004802;5161.329027226474;5175.508326708957;5202.479752024768;5251.684898906059;5190.636655434121;5194.27280180775;5234.084035293847;5237.004969055867;5262.92105618416;5137.537621614073;5194.896102077975;5217.530422261977;5226.372835259755;5238.083335416325;5492.1212605982855;5521.917171242394;5566.805161819317;5593.720313984325;5691.516221121168;6130.459285710746;6177.196964394645;6211.2857021442205;6219.129321894939;6232.844178895519;6275.96862015687;6281.3404592518045;6292.402221788969;6310.905336419957;6327.303996560375;5631.63394379364;5784.710764461802;5800.187973683687;5802.738876750598;5831.1544826000845;5756.752038704174;5816.214811000461;6300.810975670645;6328.7468501260355;6334.334894836068;4466.9279372950905;5120.462351453119;5815.82552523425;5910.763569457259;6059.8485037873525;5462.0441422751655;6017.909731354033;6129.389354848411;6138.202033735586;6145.354737752561;5069.340985671913;6155.045967874987;6190.133381326618;6199.256089269316;6225.252969643581;5112.744362781846;5124.12889808726;6101.511879049665;6199.783007594712;6212.627242365473;4836.879078023077;4930.975345123252;4975.328330675385;4976.328195693607;4995.450500444948;4458.420405347284;4509.436320459942;4532.592066714012;4534.659900507475;4578.427696537933;4912.680675756064;5821.679807610537;5913.526917846562;5926.407359264125;5952.0476723724;5442.2380866678695;5987;6132.324915438597;6255.96872015637;6269.529785266032;5768.538516918637;5776.884462310731;5784.4504772046585;5813.3605303417435;5829.242198514166;4697.859064228079;5407.405185429599;5434.429384914606;5439.3200849893765;5444.646098003696;6229.844253893689;6240.095186198067;6248.187735594343;6322.747090116344;6328.557001009885;6295.842603934938;6304.495640348853;6315.431611155018;6315.8315711593505;6336.96831515858;6300.369963003663;6307.495400368051;6327.90508142369;6338.239411270677;6349.238091429058;6029.336772955059;6111.743676692254;6157.753689852535;6249.031400132987;6276.686165691788;6254.874902502015;6299.622022678654;6330.113784070142;6346.111544383883;6356.046593011085;6150.384961503813;6182.289036760651;6207.16203312547;6223.37766223374;6226.968865155645;5873.4126587340925;5893.823185304448;6036.939630603638;6148.50811935053;6149.754009839557;5755.942440575541;5953.553483488669;5972.25346831646;6011.338752737282;6031.909521357095;6092.512598992159;6138.557439001742;6139.416755408229;6155.538334624832;6168.938310616836;5745.511631511368;5907.527397808251;5928.110783382527;5990.041593345044;5997.280326360865 04:31:16 INFO - PROCESS | 1959 | |1;ext.html;445.68133784344195;494.130330618112;496.5034965034965;522.5506064784287;537.2129829799343;38795.80602096989;41774.58225417745;41814.79092604533;41938.790306048424;41972.58027419725;41010.58989410105;43103.78448107755;43263;43422.13155736883;43494;9752.07355301247;9922.702318930444;9964.252681048914;9968.601255949754;10000.04999525044;9835.95082024589;9912.752181195456;9942.602295908155;9950.55222514985;9959;8666.350023748213;9876.407415555053;9972.15236704881;9989.100980911717;10007.399556026661;8433.367497437686;9923.950380248125;9946.900530994706;9948.303618746691;9965.451900145488;8521.80694702742;9473.573689184002;9692.22462203022;9767.951160244224;9796.412215267106;38424.80787596044;40383;40712.38931416031;40767.59232407668;41019.58980410187;2152.7954844289925;3258.6089669239605;3313.1385839681857;3547.8580856765698;3974.920501589981;23205.651915221286;25891;28300.009499667412;28571.285717857012;31821.681783182335;2674.304680782991;2731.1942976821883;3111.5643809866638;3162.3675264946874;3239.671734588831;446101.2339259655;451040.99999999674;451462.48537514533;453749;454609;30605.846970765448;32907.341853163285;34989.125271868405;35008.649913501045;35105.12237194039;32524.67475325264;34497.482537761956;35769;35859.310551708724;35913.64086359155;15560;17085;17145.05702186392;17155.970641761534;17175.656486870193;12989.870101299055;13029.218246905217;13128;13154.934225328812;13214.867851321556;19511.121999510055;19770.703439448418;19771.703424448646;19779.703304450446;19795.802041979685;6821.249662537117;8065;8091.878621820678;8143.104258531557;8143.714969976022;920.9217216536535;948.8244674735196;1002.5839276700234;1043.2227990147237;1134.432783608196;29269.56095658567;30640.54039189414;30880.845595772327;31384.21539461486;31728.778985471257;1035.9482025898826;1066.8666416697913;1073.221914112278;1125.454154734953;1175.8647755508225;15606.843931560767;16155.838441615433;16163.676726465404;16173.59566010859;16362.936409133368;686533;693596.5320173367;695659;696810;696951;60339.79320413567;60485.39514604885;60937.69531152316;61130.083048754306;61142.69428652828;1343.4223283987783;1377.5109836008273;1397.084909384355;1401.6495876031197;1410.7883817427262;26527;27351.452970940867;30674;30766;30985.690143099182;48013.7996550089;49247.75376123097;53345.46654533405;53349.46650533445;53976.46023539714;559475;590043;593456;593671.031644839;596884;27539.31151721223;27640.861795690893;27932.581011285252;27986.72013279841;28020.43959120847;48777.75611121922;48778.75610621924;49707.751461242464;49908.00183996227;50518;36267.63732362748;39881.08872533941;41492.79253603713;41773.582264178185;43087.784561076995;39288.803555982035;41187;41244.76265712034;41354.793226033675;43388.56611433845;39551.60448395479;40066;40470.59529404786;40575.39136913008;40879.795601021804;35215.64784352226;35882.64117358793;36335.45496817497;36796.448053278684;37063;26006.86996565005;26351;26614.600780987912;26625.46749064969;27035.783389747114 04:31:16 INFO - PROCESS | 1959 | |2;jquery.html;374.59917887859984;383.79275191396647;384.0628865568014;390.4163275902526;406.74781635386046;15726.606834829121;20911.37265882024;20982.475438114016;21078.367648970536;21629.891850540724;20016.599668006667;20261.493462663402;21026.474338141554;21118.83846388448;21384.037718302676;5884.235049443577;5944.197533333009;5980.6112602680905;6069.877072741535;6070.57505974582;4186.37204419338;5968.850778730523;6028.909566356509;6402.263739669927;6676.499262555303;6642;6702.664866756667;6721.294264102247;6728.697208625624;6732.259451460335;6490.091387205795;6602.9669851650915;6633.402993730563;6644.601323920532;6719.697613607375;4813.95186048142;5682.431756824326;5762.855928601776;5777.335606405275;5784.68184249866;26125.73874261271;26165.953361865504;26319.34201644955;26433.867830660914;26466;2387.928362149138;2414.879256037191;2682.557378032622;2836.4327134572964;3080.661127275998;15573.844261557353;15728.37086516538;15910.284037218353;15960.263909875592;16317.347306107742;1633.4772872680746;1860.2280053777665;1888.055972013993;1914.7223652570437;1928.421473557941;115040.42479787632;116443.835561645;117397;117448;117527.82472175255;9777.364471309342;9792.902070979342;9923.751906202402;10131.594736210616;10321.380717156995;13352.732945341038;13493.190408575518;13509.324533773468;13515.324233788271;13529.86470135286;8220.876686849702;8297.58512074394;8496.447730897471;8559.272461840688;8608.655653773903;7395.889061664079;8506.31949444043;8572.271356934605;8728.825423491495;8745.125487451203;5389.757460914268;6434.453071488976;6604.603723776589;6613.437857782046;6689.832754181184;1596.3295415925338;1633.052829358969;1653.264297387675;1696.830316968318;1789.6152327249442;935.5275585829113;985.3447457440722;1003.1523362758458;1011.3881101933372;1014.2393205096178;18628.441146765617;21489.570208595742;21655.89172054161;22364;22375.88812055929;968.85674903613;993.1607791416242;999.4103478947311;1020.550957578663;1031.5203430404747;10586.576536938435;11226.7193320166;11597.942010289895;11739.943405093412;11781.175317727677;530537;533129.5873896176;563442;596345;613757;95786;130024;133057;136619;137701;955.8470644696815;987.0820137272406;1022.2180032275315;1033.3748082410184;1037.1443559063653;13961.092528985584;16701.415450459175;18894.244230231187;18951.43145705631;19104.426867194008;54155.45844541504;55104.448955509935;58405.83188336124;58446.12330814956;59990.70004650123;85473;87900;89737;89939;92040;6811.693473793592;8048.83902321962;8322.08457069734;8372.706955256537;8412.242898139197;10452.477376131315;12720.936395317964;13155.210687358789;13210.669733256746;13520.25638589887;11336.696279927914;11521.82717259225;11571.421428928352;11579.884201158218;11621.302721836717;10757.46212689378;11222.66332010041;11264.267822591506;11460.713482162679;11596.94201528987;11335.546578136782;11442.313461192354;11549.595764148215;11848.348340841336;11853.466594003117;6514.869702605826;7091.574505529478;7333.156686981066;7550.735724249625;8463.407561470638;9772.804543909224;11130.721731956766;11757.882421175678;11844.170908036354;11866.288022718665 04:31:16 INFO - PROCESS | 1959 | |3;mootools.html;1555.2690235589273;1573.6459296658254;1625.2686291168977;1827.1503750755903;1925.7592800899897;8030.5984700764875;8570.314374850004;8700.52147131909;9149.804047028707;9156;8725.956370218157;8926.59830307636;8938.508382038985;8945.194932456077;8951.283897288218;2290.2442194075957;2332.568474832153;2335.9065637374483;2346.4251258441705;2352.9058987570775;2311.52613714189;2333.743288238301;2363.420961864346;2369.917052903149;2371.9762802372015;2323.8373313868037;2328.4062564046144;2336.766323367658;2347.190219374313;2363.917262895799;2310.5263420998654;2319.814414846808;2326.220716060122;2334.2063698342645;2339.613963696005;2318.1075286015007;2331.0442718485338;2331.1724337859987;2332.207049603143;2340.157543284416;8877.51173685447;8953.462792232487;9000.234980026706;9000.369974101815;9003.459792412476;5268.736563171826;5317.335333083364;5376.11294136467;5407.134858422673;5462.590305727047;3561.6438356164435;3622.7826330419994;3645.85416583339;3695.501107350527;3702.315071711715;1070.5931745936573;1096.7313008313015;1110.7112150840758;1113.4599719136213;1122.4668282565797;11834.289942603471;11903.880961190363;11932;11971.102167337485;12010.519579216822;4706.708473733226;4730.645201609893;4766.547178018082;4838.879028024257;4890.364252647204;9932.503374831229;10169.644062457926;10203.081722644998;10204.540795664212;10216.978302169724;5400.810971615974;5402.540784033323;5404.864878378072;5424.376196737347;5428.864278393072;4379.759113248802;4777.211760059621;4912.6561140719805;4940.975295123501;4945.876353091202;3870.612938706107;3967.6230758077936;3993.600639935983;4013.3177359848896;4073.124278280184;1284.653143651209;1302.9609111726663;1303.1203937342257;1305.6344223617402;1309.5351150341683;839.6347588798892;880.4189235104928;903.4940433357341;911.8221946720325;950.496236994394;5786.363500014995;5900.557458190653;6091.817245482643;6110.297315808739;6300.495960323163;850.4897061762892;884.2130503851578;990.094063931509;992.8808542974889;1021.2493817044466;3996.220736956324;4068.572799856032;4139.151473947833;4147.6267135957305;4199.286121359376;10576.259661823753;10667.19996000303;10810.891891081146;10876.456177191109;10982.341059536453;10893.891061089445;10903.34579925207;10918.836217456745;10921.781564368826;10955.50700218492;6921.550099243533;7607.847843043108;8084.191580841869;8213.425060245845;8340.582970851434;5213.426523082534;5804.82585522435;5898.1152827076285;6018.307894592178;6046.123312119806;9760.707178784647;10156.847647285149;10173.491325433846;10203.795924081625;10223.846642300223;9861.260405469475;10305.278630495794;10395.376277423378;10407.167426606005;10422.843657344994;7136.4290856730295;7389.371903388273;7513.511621744569;7540;7647.158812530506;8333.083360830182;8459.95770021146;8524.062353141026;8534.189252021048;8549.529775862138;7432.591207483641;7436.144843343085;7571.886421703569;7667.11828139771;7688.346490548366;7365.7790266292095;7469.514481558898;7485.550866947783;7591.848163036598;7653.387728981779;7061.2938706131035;7228.9277107230355;7229.819254518679;7234.385077268281;7242.927570724436;4962.503749625009;5166.040675376039;5177.8673902290075;5188.636795424435;5229.424763275961;5090.898182036412;5099.719515426687;5108.744562771921;5190.299309593157;5293.391260004994 04:31:16 INFO - PROCESS | 1959 | |4;prototype.html;286.21006023375486;300;313.77314699524857;314.20192710515295;315.6780084314;5508.9724551377185;5727.198192253088;5740.67964368195;5782.508486778624;5854.707264636772;4896.510348965102;5313.3868969100995;5667.433256674341;5784.392638772932;5824.7476792489715;3354.916127096824;4411.470623525165;4424.97787511062;4428.490723566799;4431.158079964813;3605.4591811228265;3842.53889533255;3870.78710670913;4462.576055274743;4478.97760511197;3974.5429275633383;4001.3997900314894;4097.631213190813;4200.810963506634;4373.032135539004;4017.2568074906235;4193.161367726467;4385.166818304512;4401.471823381183;4416.779161041935;3326.868864586028;3812.370958791796;3819.250139899268;3828.2343531293573;3832.7317087803863;4427;5579.358373786985;5621.578381621394;5659.971700141514;5671.829845104653;4312.7708603048295;4327.7186982846015;4659.464161621389;4881.973176630512;4936.432310284292;5051.444341122474;5573.182370076511;6091.786787462417;6106.7558047157245;6110.327863934964;3715.777053376806;4002.8598999035185;4044.534878488982;4065.8983525411804;4091.959080409217;6411.4229719325485;6456.451201647866;6468.3182372583;6500.569874627575;6519.924212504931;3467.913302167466;3808.5717855804073;4125.50493940729;4142.958570414317;4159.710489748188;3658.9817050914576;4098.200850834059;4159.7920103994675;4171.395147703627;4182.2890108681595;4541.364209010741;4858.246971719389;4883.609311255091;4910.631702622318;4910.754462276872;5788.450097240755;5832.475077243069;5906.763729450774;6031.185789918392;6125.1424800527075;1269.4224128021729;1295.6242689619905;1415.393528345315;1417.0080943339703;1418.2412409360943;818.8485130250923;844.9704260350858;845.4124383553371;860.9096044915194;866.5797088412115;3980.542237642708;4680.648951328664;4789.9105077224995;4824.975875120602;4852.684575502581;4256.87229383119;4829.541193586674;4997.5002499749735;5247.48418559566;5305.169716447819;4008.9799551002643;4660.603848672833;4718.693284936468;4860.77112911769;4890.682105663121;2407.8916448759496;2530.3547595363434;2734.8359098454157;2747.821391609539;2769.252301878522;5047.646664733506;5351.384590772111;5364.30264065669;5450.427705090988;5458.2904222451625;4576.473705523841;4646.512116227747;4897.363342765418;5376.758045887945;5410.567154627621;4339.934900976488;4560.977195114003;5159.484051594811;5365.356157261153;5440.259117082495;4540.750258735801;4916.82791102324;4930.013997200503;5077.7715002824225;5304.628675992798;4277.743335399886;4597.609203217764;4690.6247500199215;5094.5160209780015;5221.425643179323;5010.298558201927;5379.515843574097;5386.919196211981;5389.919151212814;5410.567154627699;3363.6131844837178;3580;3939.192465544499;4039.636432721069;4094.2630326541507;5788.855278618068;5959.73181206838;6165.784197553064;6290.968545157245;6297.1813664223355;5321.840344789663;5722.941255867678;6074.119252708244;6089.604175728564;6103.7558497661375;5955.04719244936;6037.1927053920135;6059.3637668045985;6061.605995610271;6084.330723620486;4748.572628463455;5644.9839028975175;5873.647581145145;5914.142449344907;5951.732172052181;5421.1055175895535;5643.492085712305;5694;6019.428154325332;6212.502999759918;5011.574016208663;5310.283111780015;6051.515878729779;6073.423024812636;6102.847428814315 04:31:16 INFO - PROCESS | 1959 | |5;yui.html;677.5054210426389;688.7086712414223;698.8008417600978;729.2925861913942;817.5626040068563;15407;16281.592960176002;16294.10382428966;16309.266083026263;16351.345946162153;13184.868151318484;14601.634959126028;14663.046901951393;14788.18664973426;14804.40782368704;682.3074579302013;803.5018288661024;835.5655059369125;861.1474640106281;864.476991420188;778.7002004228357;859.7162936231028;868.3270465389311;870.8606622940331;872.3108744092191;887.6715615222345;923.5336155241594;924.117467818232;924.2790623313826;924.7826760711228;900.5137225898008;911.9224865886341;913.6619450803212;917.591671706091;919.8068405634825;677.7356830835978;689.9551529150589;691.2016620802981;692.4737199728193;694.447913908439;15282.235888205656;15317.234138293152;15369.769453458208;15378.077315361114;15401.922990385088;14864.851351486563;14914.254287285592;14919.2540372982;14970.850291497054;15034.548963531111;12065;12186.57346992851;12224.304454375115;12604.873951260462;12616;3770.698344132463;3810.371288737355;3905.3946638271113;3913.3347330953807;4005;75552.24447755507;110812;111320;113489.43255283753;113769.29346059816;11326;11453.312801231952;11463.197576169754;11516.654500365003;11678.416079196006;24107.39731506691;24193.15323963653;24227.030918763052;24259.75740242575;24264.878675606862;8075.959620201861;8084.729229900879;8157.55133467665;8167.14245004266;8324.833503329899;3684.926301474009;4523.7285762854335;4544.704594201433;4562.612177964844;4615.838445654386;3212.566303549038;3672.338978983755;3759.6992240620684;3777.546694396635;3785.072657199004;619.8574327904607;634.330781026022;680.5848432456198;704.3555147040503;707.4234498883496;416.9687273454503;582.0396346029002;595.4670569839969;632.8101569529123;637.8277864976524;9312.627494900127;9484.67214589958;9559.856602150974;9724.465154416434;10191.592336306612;561.4049107945591;576.3256989322502;585.3619554685413;588.4145275450868;667.9866402672017;3941.802909854553;4421.40311058003;4595.471520775153;4627.6529260305615;4812.951870481321;158185.20907395388;160427;163116;164153;170114;120665;139039;142634;143548.28225858803;143922.2803885995;120189;121539.39230303792;122416;122629.77370226361;125788;8366;8838.292936565187;9059.909400905906;9411.647833105675;9543.618255269712;64198.67900660467;64248.357516426106;64892.35107648863;65040.123610626906;68001.65999169972;64641.35358646541;72783;94958;97570.51214743881;100053.99946000447;11997.280163190237;12089.81865272004;12142.210756300812;12147.331896745764;12192.207506512048;13448.731025379242;13477.595672129852;13848.09987350819;14082.577522674335;14267.286635668383;12491;12683.30241836671;12741.426635801226;12780.808287875876;13176.670583235496;12850.35748212567;12874.717299997292;12954.80567791465;13152.539661111816;13221.933890330487;12482.126251162332;12593.496260149857;12622.810657839957;12677.936610316889;12875.935620321838;10199.133073688523;10648.041676249175;10654.946725266323;10706.768721597116;10881.891181088087;8144.633491492778;8923.73228803137;10717.502400963445;10958.452077396258;11015.559377624806 04:31:16 INFO - PROCESS | 1959 | __end_tp_report 04:31:16 INFO - PROCESS | 1959 | __start_cc_report 04:31:16 INFO - PROCESS | 1959 | _x_x_mozilla_cycle_collect,414 04:31:16 INFO - PROCESS | 1959 | __end_cc_report 04:31:16 INFO - PROCESS | 1959 | __startTimestamp1470915076595__endTimestamp 04:31:16 INFO - PROCESS | 1959 | 04:31:16 INFO - PROCESS | 1959 | ------- Summary: start ------- 04:31:16 INFO - PROCESS | 1959 | Number of tests: 6 04:31:16 INFO - PROCESS | 1959 | 04:31:16 INFO - PROCESS | 1959 | [#0] dojo.html Cycles:165 Average:5698.13 Median:5831.15 stddev:636.59 (10.9%) stddev-sans-first:611.85 04:31:16 INFO - PROCESS | 1959 | Values: 3372.9 3398.7 3419.1 3426.5 3455.8 5530.7 5739.4 5764.7 5769.7 5840.7 5679.5 5688.9 5746.0 5759.7 5781.7 5082.6 5215.2 5216.8 5273.0 5297.1 5301.4 5333.2 5349.3 5373.6 5388.2 5102.3 5161.3 5175.5 5202.5 5251.7 5190.6 5194.3 5234.1 5237.0 5262.9 5137.5 5194.9 5217.5 5226.4 5238.1 5492.1 5521.9 5566.8 5593.7 5691.5 6130.5 6177.2 6211.3 6219.1 6232.8 6276.0 6281.3 6292.4 6310.9 6327.3 5631.6 5784.7 5800.2 5802.7 5831.2 5756.8 5816.2 6300.8 6328.7 6334.3 4466.9 5120.5 5815.8 5910.8 6059.8 5462.0 6017.9 6129.4 6138.2 6145.4 5069.3 6155.0 6190.1 6199.3 6225.3 5112.7 5124.1 6101.5 6199.8 6212.6 4836.9 4931.0 4975.3 4976.3 4995.5 4458.4 4509.4 4532.6 4534.7 4578.4 4912.7 5821.7 5913.5 5926.4 5952.0 5442.2 5987.0 6132.3 6256.0 6269.5 5768.5 5776.9 5784.5 5813.4 5829.2 4697.9 5407.4 5434.4 5439.3 5444.6 6229.8 6240.1 6248.2 6322.7 6328.6 6295.8 6304.5 6315.4 6315.8 6337.0 6300.4 6307.5 6327.9 6338.2 6349.2 6029.3 6111.7 6157.8 6249.0 6276.7 6254.9 6299.6 6330.1 6346.1 6356.0 6150.4 6182.3 6207.2 6223.4 6227.0 5873.4 5893.8 6036.9 6148.5 6149.8 5755.9 5953.6 5972.3 6011.3 6031.9 6092.5 6138.6 6139.4 6155.5 6168.9 5745.5 5907.5 5928.1 5990.0 5997.3 04:31:16 INFO - PROCESS | 1959 | 04:31:16 INFO - PROCESS | 1959 | [#1] ext.html Cycles:180 Average:69992.43 Median:39973.54 stddev:156934.31 (392.6%) stddev-sans-first:157287.68 04:31:16 INFO - PROCESS | 1959 | Values: 445.7 494.1 496.5 522.6 537.2 38795.8 41774.6 41814.8 41938.8 41972.6 41010.6 43103.8 43263.0 43422.1 43494.0 9752.1 9922.7 9964.3 9968.6 10000.0 9836.0 9912.8 9942.6 9950.6 9959.0 8666.4 9876.4 9972.2 9989.1 10007.4 8433.4 9924.0 9946.9 9948.3 9965.5 8521.8 9473.6 9692.2 9768.0 9796.4 38424.8 40383.0 40712.4 40767.6 41019.6 2152.8 3258.6 3313.1 3547.9 3974.9 23205.7 25891.0 28300.0 28571.3 31821.7 2674.3 2731.2 3111.6 3162.4 3239.7 446101.2 451041.0 451462.5 453749.0 454609.0 30605.8 32907.3 34989.1 35008.6 35105.1 32524.7 34497.5 35769.0 35859.3 35913.6 15560.0 17085.0 17145.1 17156.0 17175.7 12989.9 13029.2 13128.0 13154.9 13214.9 19511.1 19770.7 19771.7 19779.7 19795.8 6821.2 8065.0 8091.9 8143.1 8143.7 920.9 948.8 1002.6 1043.2 1134.4 29269.6 30640.5 30880.8 31384.2 31728.8 1035.9 1066.9 1073.2 1125.5 1175.9 15606.8 16155.8 16163.7 16173.6 16362.9 686533.0 693596.5 695659.0 696810.0 696951.0 60339.8 60485.4 60937.7 61130.1 61142.7 1343.4 1377.5 1397.1 1401.6 1410.8 26527.0 27351.5 30674.0 30766.0 30985.7 48013.8 49247.8 53345.5 53349.5 53976.5 559475.0 590043.0 593456.0 593671.0 596884.0 27539.3 27640.9 27932.6 27986.7 28020.4 48777.8 48778.8 49707.8 49908.0 50518.0 36267.6 39881.1 41492.8 41773.6 43087.8 39288.8 41187.0 41244.8 41354.8 43388.6 39551.6 40066.0 40470.6 40575.4 40879.8 35215.6 35882.6 36335.5 36796.4 37063.0 26006.9 26351.0 26614.6 26625.5 27035.8 04:31:16 INFO - PROCESS | 1959 | 04:31:16 INFO - PROCESS | 1959 | [#2] jquery.html Cycles:180 Average:34748.64 Median:26145.85 stddev:95266.29 (364.4%) stddev-sans-first:95498.57 04:31:16 INFO - PROCESS | 1959 | Values: 374.6 383.8 384.1 390.4 406.7 15726.6 20911.4 20982.5 21078.4 21629.9 20016.6 20261.5 21026.5 21118.8 21384.0 5884.2 5944.2 5980.6 6069.9 6070.6 4186.4 5968.9 6028.9 6402.3 6676.5 6642.0 6702.7 6721.3 6728.7 6732.3 6490.1 6603.0 6633.4 6644.6 6719.7 4814.0 5682.4 5762.9 5777.3 5784.7 26125.7 26166.0 26319.3 26433.9 26466.0 2387.9 2414.9 2682.6 2836.4 3080.7 15573.8 15728.4 15910.3 15960.3 16317.3 1633.5 1860.2 1888.1 1914.7 1928.4 115040.4 116443.8 117397.0 117448.0 117527.8 9777.4 9792.9 9923.8 10131.6 10321.4 13352.7 13493.2 13509.3 13515.3 13529.9 8220.9 8297.6 8496.4 8559.3 8608.7 7395.9 8506.3 8572.3 8728.8 8745.1 5389.8 6434.5 6604.6 6613.4 6689.8 1596.3 1633.1 1653.3 1696.8 1789.6 935.5 985.3 1003.2 1011.4 1014.2 18628.4 21489.6 21655.9 22364.0 22375.9 968.9 993.2 999.4 1020.6 1031.5 10586.6 11226.7 11597.9 11739.9 11781.2 530537.0 533129.6 563442.0 596345.0 613757.0 95786.0 130024.0 133057.0 136619.0 137701.0 955.8 987.1 1022.2 1033.4 1037.1 13961.1 16701.4 18894.2 18951.4 19104.4 54155.5 55104.4 58405.8 58446.1 59990.7 85473.0 87900.0 89737.0 89939.0 92040.0 6811.7 8048.8 8322.1 8372.7 8412.2 10452.5 12720.9 13155.2 13210.7 13520.3 11336.7 11521.8 11571.4 11579.9 11621.3 10757.5 11222.7 11264.3 11460.7 11596.9 11335.5 11442.3 11549.6 11848.3 11853.5 6514.9 7091.6 7333.2 7550.7 8463.4 9772.8 11130.7 11757.9 11844.2 11866.3 04:31:16 INFO - PROCESS | 1959 | 04:31:16 INFO - PROCESS | 1959 | [#3] mootools.html Cycles:180 Average:5795.45 Median:4926.82 stddev:3248.88 (65.9%) stddev-sans-first:3242.37 04:31:16 INFO - PROCESS | 1959 | Values: 1555.3 1573.6 1625.3 1827.2 1925.8 8030.6 8570.3 8700.5 9149.8 9156.0 8726.0 8926.6 8938.5 8945.2 8951.3 2290.2 2332.6 2335.9 2346.4 2352.9 2311.5 2333.7 2363.4 2369.9 2372.0 2323.8 2328.4 2336.8 2347.2 2363.9 2310.5 2319.8 2326.2 2334.2 2339.6 2318.1 2331.0 2331.2 2332.2 2340.2 8877.5 8953.5 9000.2 9000.4 9003.5 5268.7 5317.3 5376.1 5407.1 5462.6 3561.6 3622.8 3645.9 3695.5 3702.3 1070.6 1096.7 1110.7 1113.5 1122.5 11834.3 11903.9 11932.0 11971.1 12010.5 4706.7 4730.6 4766.5 4838.9 4890.4 9932.5 10169.6 10203.1 10204.5 10217.0 5400.8 5402.5 5404.9 5424.4 5428.9 4379.8 4777.2 4912.7 4941.0 4945.9 3870.6 3967.6 3993.6 4013.3 4073.1 1284.7 1303.0 1303.1 1305.6 1309.5 839.6 880.4 903.5 911.8 950.5 5786.4 5900.6 6091.8 6110.3 6300.5 850.5 884.2 990.1 992.9 1021.2 3996.2 4068.6 4139.2 4147.6 4199.3 10576.3 10667.2 10810.9 10876.5 10982.3 10893.9 10903.3 10918.8 10921.8 10955.5 6921.6 7607.8 8084.2 8213.4 8340.6 5213.4 5804.8 5898.1 6018.3 6046.1 9760.7 10156.8 10173.5 10203.8 10223.8 9861.3 10305.3 10395.4 10407.2 10422.8 7136.4 7389.4 7513.5 7540.0 7647.2 8333.1 8460.0 8524.1 8534.2 8549.5 7432.6 7436.1 7571.9 7667.1 7688.3 7365.8 7469.5 7485.6 7591.8 7653.4 7061.3 7228.9 7229.8 7234.4 7242.9 4962.5 5166.0 5177.9 5188.6 5229.4 5090.9 5099.7 5108.7 5190.3 5293.4 04:31:16 INFO - PROCESS | 1959 | 04:31:16 INFO - PROCESS | 1959 | [#4] prototype.html Cycles:180 Average:4590.00 Median:4904.00 stddev:1434.05 (29.2%) stddev-sans-first:1401.22 04:31:16 INFO - PROCESS | 1959 | Values: 286.2 300.0 313.8 314.2 315.7 5509.0 5727.2 5740.7 5782.5 5854.7 4896.5 5313.4 5667.4 5784.4 5824.7 3354.9 4411.5 4425.0 4428.5 4431.2 3605.5 3842.5 3870.8 4462.6 4479.0 3974.5 4001.4 4097.6 4200.8 4373.0 4017.3 4193.2 4385.2 4401.5 4416.8 3326.9 3812.4 3819.3 3828.2 3832.7 4427.0 5579.4 5621.6 5660.0 5671.8 4312.8 4327.7 4659.5 4882.0 4936.4 5051.4 5573.2 6091.8 6106.8 6110.3 3715.8 4002.9 4044.5 4065.9 4092.0 6411.4 6456.5 6468.3 6500.6 6519.9 3467.9 3808.6 4125.5 4143.0 4159.7 3659.0 4098.2 4159.8 4171.4 4182.3 4541.4 4858.2 4883.6 4910.6 4910.8 5788.5 5832.5 5906.8 6031.2 6125.1 1269.4 1295.6 1415.4 1417.0 1418.2 818.8 845.0 845.4 860.9 866.6 3980.5 4680.6 4789.9 4825.0 4852.7 4256.9 4829.5 4997.5 5247.5 5305.2 4009.0 4660.6 4718.7 4860.8 4890.7 2407.9 2530.4 2734.8 2747.8 2769.3 5047.6 5351.4 5364.3 5450.4 5458.3 4576.5 4646.5 4897.4 5376.8 5410.6 4339.9 4561.0 5159.5 5365.4 5440.3 4540.8 4916.8 4930.0 5077.8 5304.6 4277.7 4597.6 4690.6 5094.5 5221.4 5010.3 5379.5 5386.9 5389.9 5410.6 3363.6 3580.0 3939.2 4039.6 4094.3 5788.9 5959.7 6165.8 6291.0 6297.2 5321.8 5722.9 6074.1 6089.6 6103.8 5955.0 6037.2 6059.4 6061.6 6084.3 4748.6 5645.0 5873.6 5914.1 5951.7 5421.1 5643.5 5694.0 6019.4 6212.5 5011.6 5310.3 6051.5 6073.4 6102.8 04:31:16 INFO - PROCESS | 1959 | 04:31:16 INFO - PROCESS | 1959 | [#5] yui.html Cycles:180 Average:25659.36 Median:3678.63 stddev:42061.50 (1143.4%) stddev-sans-first:42137.67 04:31:16 INFO - PROCESS | 1959 | Values: 677.5 688.7 698.8 729.3 817.6 15407.0 16281.6 16294.1 16309.3 16351.3 13184.9 14601.6 14663.0 14788.2 14804.4 682.3 803.5 835.6 861.1 864.5 778.7 859.7 868.3 870.9 872.3 887.7 923.5 924.1 924.3 924.8 900.5 911.9 913.7 917.6 919.8 677.7 690.0 691.2 692.5 694.4 15282.2 15317.2 15369.8 15378.1 15401.9 14864.9 14914.3 14919.3 14970.9 15034.5 12065.0 12186.6 12224.3 12604.9 12616.0 3770.7 3810.4 3905.4 3913.3 4005.0 75552.2 110812.0 111320.0 113489.4 113769.3 11326.0 11453.3 11463.2 11516.7 11678.4 24107.4 24193.2 24227.0 24259.8 24264.9 8076.0 8084.7 8157.6 8167.1 8324.8 3684.9 4523.7 4544.7 4562.6 4615.8 3212.6 3672.3 3759.7 3777.5 3785.1 619.9 634.3 680.6 704.4 707.4 417.0 582.0 595.5 632.8 637.8 9312.6 9484.7 9559.9 9724.5 10191.6 561.4 576.3 585.4 588.4 668.0 3941.8 4421.4 4595.5 4627.7 4813.0 158185.2 160427.0 163116.0 164153.0 170114.0 120665.0 139039.0 142634.0 143548.3 143922.3 120189.0 121539.4 122416.0 122629.8 125788.0 8366.0 8838.3 9059.9 9411.6 9543.6 64198.7 64248.4 64892.4 65040.1 68001.7 64641.4 72783.0 94958.0 97570.5 100054.0 11997.3 12089.8 12142.2 12147.3 12192.2 13448.7 13477.6 13848.1 14082.6 14267.3 12491.0 12683.3 12741.4 12780.8 13176.7 12850.4 12874.7 12954.8 13152.5 13221.9 12482.1 12593.5 12622.8 12677.9 12875.9 10199.1 10648.0 10654.9 10706.8 10881.9 8144.6 8923.7 10717.5 10958.5 11015.6 04:31:16 INFO - PROCESS | 1959 | -------- Summary: end -------- 04:31:16 INFO - PROCESS | 1959 | 04:31:17 INFO - TEST-INFO | 1959: exit 0 04:31:17 INFO - TEST-OK | dromaeo_css | took 1113923ms 04:31:17 INFO - TEST-START | kraken 04:31:17 INFO - operating with platform_type : mac_ 04:31:17 INFO - Initialising browser for kraken test... 04:31:17 INFO - TEST-INFO | started process 1966 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/tmp4kxCQP/profile http://localhost:52476/getInfo.html) 04:31:19 INFO - PROCESS | 1966 | __metrics Screen width/height:1600/1200 04:31:19 INFO - PROCESS | 1966 | colorDepth:24 04:31:19 INFO - PROCESS | 1966 | Browser inner width/height: 1024/663 04:31:19 INFO - PROCESS | 1966 | __metrics 04:31:19 ERROR - PROCESS | 1966 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2983: TypeError: this.tabs is undefined 04:31:20 INFO - TEST-INFO | 1966: exit 0 04:31:20 INFO - Browser initialized. 04:31:20 INFO - Running cycle 1/1 for kraken test... 04:31:20 INFO - TEST-INFO | started process 1968 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/tmp4kxCQP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:31:32 INFO - PROCESS | 1968 | RSS: Main: 261718016 04:31:32 INFO - PROCESS | 1968 | 04:31:35 INFO - PROCESS | 1968 | Cycle 1(1): loaded http://localhost:52476/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52476/tests/kraken/driver.html?testName=audio-beat-detection) 04:31:36 INFO - PROCESS | 1968 | RSS: Main: 272171008 04:31:36 INFO - PROCESS | 1968 | 04:31:39 INFO - PROCESS | 1968 | Cycle 1(1): loaded http://localhost:52476/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52476/tests/kraken/driver.html?testName=audio-dft) 04:31:39 INFO - PROCESS | 1968 | RSS: Main: 281440256 04:31:39 INFO - PROCESS | 1968 | 04:31:43 INFO - PROCESS | 1968 | Cycle 1(1): loaded http://localhost:52476/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52476/tests/kraken/driver.html?testName=audio-fft) 04:31:43 INFO - PROCESS | 1968 | RSS: Main: 280932352 04:31:43 INFO - PROCESS | 1968 | 04:31:46 INFO - PROCESS | 1968 | Cycle 1(1): loaded http://localhost:52476/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52476/tests/kraken/driver.html?testName=audio-oscillator) 04:31:46 INFO - PROCESS | 1968 | RSS: Main: 281751552 04:31:46 INFO - PROCESS | 1968 | 04:31:48 INFO - PROCESS | 1968 | Cycle 1(1): loaded http://localhost:52476/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52476/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:31:49 INFO - PROCESS | 1968 | RSS: Main: 282124288 04:31:49 INFO - PROCESS | 1968 | 04:31:52 INFO - PROCESS | 1968 | Cycle 1(1): loaded http://localhost:52476/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52476/tests/kraken/driver.html?testName=imaging-darkroom) 04:31:53 INFO - PROCESS | 1968 | RSS: Main: 282136576 04:31:53 INFO - PROCESS | 1968 | 04:31:55 INFO - PROCESS | 1968 | Cycle 1(1): loaded http://localhost:52476/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52476/tests/kraken/driver.html?testName=imaging-desaturate) 04:31:56 INFO - PROCESS | 1968 | RSS: Main: 282439680 04:31:56 INFO - PROCESS | 1968 | 04:31:59 INFO - PROCESS | 1968 | Cycle 1(1): loaded http://localhost:52476/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52476/tests/kraken/driver.html?testName=json-parse-financial) 04:32:00 INFO - PROCESS | 1968 | RSS: Main: 282710016 04:32:00 INFO - PROCESS | 1968 | 04:32:01 INFO - PROCESS | 1968 | Cycle 1(1): loaded http://localhost:52476/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52476/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:32:02 INFO - PROCESS | 1968 | RSS: Main: 282320896 04:32:02 INFO - PROCESS | 1968 | 04:32:04 INFO - PROCESS | 1968 | Cycle 1(1): loaded http://localhost:52476/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52476/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:32:05 INFO - PROCESS | 1968 | RSS: Main: 282517504 04:32:05 INFO - PROCESS | 1968 | 04:32:07 INFO - PROCESS | 1968 | Cycle 1(1): loaded http://localhost:52476/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52476/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:32:08 INFO - PROCESS | 1968 | RSS: Main: 282746880 04:32:08 INFO - PROCESS | 1968 | 04:32:11 INFO - PROCESS | 1968 | Cycle 1(1): loaded http://localhost:52476/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52476/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:32:11 INFO - PROCESS | 1968 | RSS: Main: 282771456 04:32:11 INFO - PROCESS | 1968 | 04:32:14 INFO - PROCESS | 1968 | Cycle 1(1): loaded http://localhost:52476/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52476/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:32:15 INFO - PROCESS | 1968 | RSS: Main: 282750976 04:32:15 INFO - PROCESS | 1968 | 04:32:16 INFO - PROCESS | 1968 | Cycle 1(1): loaded http://localhost:52476/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52476/tests/kraken/driver.html?testName=ai-astar) 04:32:17 INFO - PROCESS | 1968 | RSS: Main: 283758592 04:32:17 INFO - PROCESS | 1968 | 04:32:17 INFO - PROCESS | 1968 | __start_tp_report 04:32:17 INFO - PROCESS | 1968 | _x_x_mozilla_page_load 04:32:17 INFO - PROCESS | 1968 | _x_x_mozilla_page_load_details 04:32:17 INFO - PROCESS | 1968 | |i|pagename|runs| 04:32:17 INFO - PROCESS | 1968 | |0;ai-astar;105;117;125;162;117;117;116;116;117;116 04:32:17 INFO - PROCESS | 1968 | |1;audio-beat-detection;144;130;172;193;96;159;155;118;202;142 04:32:17 INFO - PROCESS | 1968 | |2;audio-dft;208;237;199;197;196;195;261;202;197;195 04:32:17 INFO - PROCESS | 1968 | |3;audio-fft;74;79;78;150;81;51;67;83;168;86 04:32:17 INFO - PROCESS | 1968 | |4;audio-oscillator;70;72;132;71;72;86;118;70;78;149 04:32:17 INFO - PROCESS | 1968 | |5;imaging-gaussian-blur;90;87;76;132;133;86;107;131;110;87 04:32:17 INFO - PROCESS | 1968 | |6;imaging-darkroom;95;96;95;101;96;95;95;97;99;95 04:32:17 INFO - PROCESS | 1968 | |7;imaging-desaturate;110;135;82;137;146;74;134;126;98;152 04:32:17 INFO - PROCESS | 1968 | |8;json-parse-financial;55;57;56;52;55;56;57;56;54;54 04:32:17 INFO - PROCESS | 1968 | |9;json-stringify-tinderbox;95;69;75;83;88;88;76;73;76;72 04:32:17 INFO - PROCESS | 1968 | |10;stanford-crypto-aes;108;70;98;103;108;83;86;81;86;85 04:32:17 INFO - PROCESS | 1968 | |11;stanford-crypto-ccm;164;132;144;148;155;139;143;149;171;157 04:32:17 INFO - PROCESS | 1968 | |12;stanford-crypto-pbkdf2;168;168;188;166;167;162;168;165;165;166 04:32:17 INFO - PROCESS | 1968 | |13;stanford-crypto-sha256-iterative;66;67;69;68;68;65;69;68;66;66 04:32:17 INFO - PROCESS | 1968 | __end_tp_report 04:32:17 INFO - PROCESS | 1968 | __start_cc_report 04:32:17 INFO - PROCESS | 1968 | _x_x_mozilla_cycle_collect,1055 04:32:17 INFO - PROCESS | 1968 | __end_cc_report 04:32:17 INFO - PROCESS | 1968 | __startTimestamp1470915137184__endTimestamp 04:32:17 INFO - PROCESS | 1968 | 04:32:17 INFO - PROCESS | 1968 | ------- Summary: start ------- 04:32:17 INFO - PROCESS | 1968 | Number of tests: 14 04:32:17 INFO - PROCESS | 1968 | 04:32:17 INFO - PROCESS | 1968 | [#0] ai-astar Cycles:10 Average:120.80 Median:117.00 stddev:15.24 (13.0%) stddev-sans-first:15.06 04:32:17 INFO - PROCESS | 1968 | Values: 105.0 117.0 125.0 162.0 117.0 117.0 116.0 116.0 117.0 116.0 04:32:17 INFO - PROCESS | 1968 | 04:32:17 INFO - PROCESS | 1968 | [#1] audio-beat-detection Cycles:10 Average:151.10 Median:165.50 stddev:32.61 (19.7%) stddev-sans-first:34.49 04:32:17 INFO - PROCESS | 1968 | Values: 144.0 130.0 172.0 193.0 96.0 159.0 155.0 118.0 202.0 142.0 04:32:17 INFO - PROCESS | 1968 | 04:32:17 INFO - PROCESS | 1968 | [#2] audio-dft Cycles:10 Average:208.70 Median:200.50 stddev:22.33 (11.1%) stddev-sans-first:23.68 04:32:17 INFO - PROCESS | 1968 | Values: 208.0 237.0 199.0 197.0 196.0 195.0 261.0 202.0 197.0 195.0 04:32:17 INFO - PROCESS | 1968 | 04:32:17 INFO - PROCESS | 1968 | [#3] audio-fft Cycles:10 Average:91.70 Median:78.50 stddev:37.08 (47.2%) stddev-sans-first:38.77 04:32:17 INFO - PROCESS | 1968 | Values: 74.0 79.0 78.0 150.0 81.0 51.0 67.0 83.0 168.0 86.0 04:32:17 INFO - PROCESS | 1968 | 04:32:17 INFO - PROCESS | 1968 | [#4] audio-oscillator Cycles:10 Average:91.80 Median:71.50 stddev:29.75 (41.6%) stddev-sans-first:30.49 04:32:17 INFO - PROCESS | 1968 | Values: 70.0 72.0 132.0 71.0 72.0 86.0 118.0 70.0 78.0 149.0 04:32:17 INFO - PROCESS | 1968 | 04:32:17 INFO - PROCESS | 1968 | [#5] imaging-gaussian-blur Cycles:10 Average:103.90 Median:81.00 stddev:21.81 (26.9%) stddev-sans-first:22.55 04:32:17 INFO - PROCESS | 1968 | Values: 90.0 87.0 76.0 132.0 133.0 86.0 107.0 131.0 110.0 87.0 04:32:17 INFO - PROCESS | 1968 | 04:32:17 INFO - PROCESS | 1968 | [#6] imaging-darkroom Cycles:10 Average:96.40 Median:95.50 stddev:2.07 (2.2%) stddev-sans-first:2.13 04:32:17 INFO - PROCESS | 1968 | Values: 95.0 96.0 95.0 101.0 96.0 95.0 95.0 97.0 99.0 95.0 04:32:17 INFO - PROCESS | 1968 | 04:32:17 INFO - PROCESS | 1968 | [#7] imaging-desaturate Cycles:10 Average:119.40 Median:149.00 stddev:27.05 (18.2%) stddev-sans-first:28.48 04:32:17 INFO - PROCESS | 1968 | Values: 110.0 135.0 82.0 137.0 146.0 74.0 134.0 126.0 98.0 152.0 04:32:17 INFO - PROCESS | 1968 | 04:32:17 INFO - PROCESS | 1968 | [#8] json-parse-financial Cycles:10 Average:55.20 Median:56.00 stddev:1.55 (2.8%) stddev-sans-first:1.64 04:32:17 INFO - PROCESS | 1968 | Values: 55.0 57.0 56.0 52.0 55.0 56.0 57.0 56.0 54.0 54.0 04:32:17 INFO - PROCESS | 1968 | 04:32:17 INFO - PROCESS | 1968 | [#9] json-stringify-tinderbox Cycles:10 Average:79.50 Median:79.50 stddev:8.50 (10.7%) stddev-sans-first:6.92 04:32:17 INFO - PROCESS | 1968 | Values: 95.0 69.0 75.0 83.0 88.0 88.0 76.0 73.0 76.0 72.0 04:32:17 INFO - PROCESS | 1968 | 04:32:17 INFO - PROCESS | 1968 | [#10] stanford-crypto-aes Cycles:10 Average:90.80 Median:84.00 stddev:12.74 (15.2%) stddev-sans-first:11.90 04:32:17 INFO - PROCESS | 1968 | Values: 108.0 70.0 98.0 103.0 108.0 83.0 86.0 81.0 86.0 85.0 04:32:17 INFO - PROCESS | 1968 | 04:32:17 INFO - PROCESS | 1968 | [#11] stanford-crypto-ccm Cycles:10 Average:150.20 Median:152.00 stddev:11.76 (7.7%) stddev-sans-first:11.37 04:32:17 INFO - PROCESS | 1968 | Values: 164.0 132.0 144.0 148.0 155.0 139.0 143.0 149.0 171.0 157.0 04:32:17 INFO - PROCESS | 1968 | 04:32:17 INFO - PROCESS | 1968 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.30 Median:167.50 stddev:7.17 (4.3%) stddev-sans-first:7.60 04:32:17 INFO - PROCESS | 1968 | Values: 168.0 168.0 188.0 166.0 167.0 162.0 168.0 165.0 165.0 166.0 04:32:17 INFO - PROCESS | 1968 | 04:32:17 INFO - PROCESS | 1968 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.20 Median:68.00 stddev:1.40 (2.1%) stddev-sans-first:1.41 04:32:17 INFO - PROCESS | 1968 | Values: 66.0 67.0 69.0 68.0 68.0 65.0 69.0 68.0 66.0 66.0 04:32:17 INFO - PROCESS | 1968 | -------- Summary: end -------- 04:32:17 INFO - PROCESS | 1968 | 04:32:18 INFO - TEST-INFO | 1968: exit 0 04:32:18 INFO - TEST-OK | kraken | took 60935ms 04:32:18 INFO - SUITE-END | took 1174s 04:32:18 INFO - Completed test suite (00:19:35) 04:32:18 INFO - javascript benchmark 04:32:18 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7411.877717150831, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3372.865085396584, 3398.7450941179404, 3419.111031131905, 3426.4860270959343, 3455.844486998085, 5530.723463826813, 5739.368669446358, 5764.6541207527525, 5769.682667453289, 5840.678762668052, 5679.460451257124, 5688.886222275552, 5745.971270143644, 5759.654420734759, 5781.710914454282, 5082.618803589727, 5215.1655735082395, 5216.7913283468615, 5273.0, 5297.073012222865, 5301.443348448415, 5333.2000199969925, 5349.304590403242, 5373.623846330758, 5388.164834450667, 5102.285680004802, 5161.329027226474, 5175.508326708957, 5202.479752024768, 5251.684898906059, 5190.636655434121, 5194.27280180775, 5234.084035293847, 5237.004969055867, 5262.92105618416, 5137.537621614073, 5194.896102077975, 5217.530422261977, 5226.372835259755, 5238.083335416325, 5492.1212605982855, 5521.917171242394, 5566.805161819317, 5593.720313984325, 5691.516221121168, 6130.459285710746, 6177.196964394645, 6211.2857021442205, 6219.129321894939, 6232.844178895519, 6275.96862015687, 6281.3404592518045, 6292.402221788969, 6310.905336419957, 6327.303996560375, 5631.63394379364, 5784.710764461802, 5800.187973683687, 5802.738876750598, 5831.1544826000845, 5756.752038704174, 5816.214811000461, 6300.810975670645, 6328.7468501260355, 6334.334894836068, 4466.9279372950905, 5120.462351453119, 5815.82552523425, 5910.763569457259, 6059.8485037873525, 5462.0441422751655, 6017.909731354033, 6129.389354848411, 6138.202033735586, 6145.354737752561, 5069.340985671913, 6155.045967874987, 6190.133381326618, 6199.256089269316, 6225.252969643581, 5112.744362781846, 5124.12889808726, 6101.511879049665, 6199.783007594712, 6212.627242365473, 4836.879078023077, 4930.975345123252, 4975.328330675385, 4976.328195693607, 4995.450500444948, 4458.420405347284, 4509.436320459942, 4532.592066714012, 4534.659900507475, 4578.427696537933, 4912.680675756064, 5821.679807610537, 5913.526917846562, 5926.407359264125, 5952.0476723724, 5442.2380866678695, 5987.0, 6132.324915438597, 6255.96872015637, 6269.529785266032, 5768.538516918637, 5776.884462310731, 5784.4504772046585, 5813.3605303417435, 5829.242198514166, 4697.859064228079, 5407.405185429599, 5434.429384914606, 5439.3200849893765, 5444.646098003696, 6229.844253893689, 6240.095186198067, 6248.187735594343, 6322.747090116344, 6328.557001009885, 6295.842603934938, 6304.495640348853, 6315.431611155018, 6315.8315711593505, 6336.96831515858, 6300.369963003663, 6307.495400368051, 6327.90508142369, 6338.239411270677, 6349.238091429058, 6029.336772955059, 6111.743676692254, 6157.753689852535, 6249.031400132987, 6276.686165691788, 6254.874902502015, 6299.622022678654, 6330.113784070142, 6346.111544383883, 6356.046593011085, 6150.384961503813, 6182.289036760651, 6207.16203312547, 6223.37766223374, 6226.968865155645, 5873.4126587340925, 5893.823185304448, 6036.939630603638, 6148.50811935053, 6149.754009839557, 5755.942440575541, 5953.553483488669, 5972.25346831646, 6011.338752737282, 6031.909521357095, 6092.512598992159, 6138.557439001742, 6139.416755408229, 6155.538334624832, 6168.938310616836, 5745.511631511368, 5907.527397808251, 5928.110783382527, 5990.041593345044, 5997.280326360865], "value": 5660.818137286122, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [445.68133784344195, 494.130330618112, 496.5034965034965, 522.5506064784287, 537.2129829799343, 38795.80602096989, 41774.58225417745, 41814.79092604533, 41938.790306048424, 41972.58027419725, 41010.58989410105, 43103.78448107755, 43263.0, 43422.13155736883, 43494.0, 9752.07355301247, 9922.702318930444, 9964.252681048914, 9968.601255949754, 10000.04999525044, 9835.95082024589, 9912.752181195456, 9942.602295908155, 9950.55222514985, 9959.0, 8666.350023748213, 9876.407415555053, 9972.15236704881, 9989.100980911717, 10007.399556026661, 8433.367497437686, 9923.950380248125, 9946.900530994706, 9948.303618746691, 9965.451900145488, 8521.80694702742, 9473.573689184002, 9692.22462203022, 9767.951160244224, 9796.412215267106, 38424.80787596044, 40383.0, 40712.38931416031, 40767.59232407668, 41019.58980410187, 2152.7954844289925, 3258.6089669239605, 3313.1385839681857, 3547.8580856765698, 3974.920501589981, 23205.651915221286, 25891.0, 28300.009499667412, 28571.285717857012, 31821.681783182335, 2674.304680782991, 2731.1942976821883, 3111.5643809866638, 3162.3675264946874, 3239.671734588831, 446101.2339259655, 451040.99999999674, 451462.48537514533, 453749.0, 454609.0, 30605.846970765448, 32907.341853163285, 34989.125271868405, 35008.649913501045, 35105.12237194039, 32524.67475325264, 34497.482537761956, 35769.0, 35859.310551708724, 35913.64086359155, 15560.0, 17085.0, 17145.05702186392, 17155.970641761534, 17175.656486870193, 12989.870101299055, 13029.218246905217, 13128.0, 13154.934225328812, 13214.867851321556, 19511.121999510055, 19770.703439448418, 19771.703424448646, 19779.703304450446, 19795.802041979685, 6821.249662537117, 8065.0, 8091.878621820678, 8143.104258531557, 8143.714969976022, 920.9217216536535, 948.8244674735196, 1002.5839276700234, 1043.2227990147237, 1134.432783608196, 29269.56095658567, 30640.54039189414, 30880.845595772327, 31384.21539461486, 31728.778985471257, 1035.9482025898826, 1066.8666416697913, 1073.221914112278, 1125.454154734953, 1175.8647755508225, 15606.843931560767, 16155.838441615433, 16163.676726465404, 16173.59566010859, 16362.936409133368, 686533.0, 693596.5320173367, 695659.0, 696810.0, 696951.0, 60339.79320413567, 60485.39514604885, 60937.69531152316, 61130.083048754306, 61142.69428652828, 1343.4223283987783, 1377.5109836008273, 1397.084909384355, 1401.6495876031197, 1410.7883817427262, 26527.0, 27351.452970940867, 30674.0, 30766.0, 30985.690143099182, 48013.7996550089, 49247.75376123097, 53345.46654533405, 53349.46650533445, 53976.46023539714, 559475.0, 590043.0, 593456.0, 593671.031644839, 596884.0, 27539.31151721223, 27640.861795690893, 27932.581011285252, 27986.72013279841, 28020.43959120847, 48777.75611121922, 48778.75610621924, 49707.751461242464, 49908.00183996227, 50518.0, 36267.63732362748, 39881.08872533941, 41492.79253603713, 41773.582264178185, 43087.784561076995, 39288.803555982035, 41187.0, 41244.76265712034, 41354.793226033675, 43388.56611433845, 39551.60448395479, 40066.0, 40470.59529404786, 40575.39136913008, 40879.795601021804, 35215.64784352226, 35882.64117358793, 36335.45496817497, 36796.448053278684, 37063.0, 26006.86996565005, 26351.0, 26614.600780987912, 26625.46749064969, 27035.783389747114], "value": 19676.951115891916, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [374.59917887859984, 383.79275191396647, 384.0628865568014, 390.4163275902526, 406.74781635386046, 15726.606834829121, 20911.37265882024, 20982.475438114016, 21078.367648970536, 21629.891850540724, 20016.599668006667, 20261.493462663402, 21026.474338141554, 21118.83846388448, 21384.037718302676, 5884.235049443577, 5944.197533333009, 5980.6112602680905, 6069.877072741535, 6070.57505974582, 4186.37204419338, 5968.850778730523, 6028.909566356509, 6402.263739669927, 6676.499262555303, 6642.0, 6702.664866756667, 6721.294264102247, 6728.697208625624, 6732.259451460335, 6490.091387205795, 6602.9669851650915, 6633.402993730563, 6644.601323920532, 6719.697613607375, 4813.95186048142, 5682.431756824326, 5762.855928601776, 5777.335606405275, 5784.68184249866, 26125.73874261271, 26165.953361865504, 26319.34201644955, 26433.867830660914, 26466.0, 2387.928362149138, 2414.879256037191, 2682.557378032622, 2836.4327134572964, 3080.661127275998, 15573.844261557353, 15728.37086516538, 15910.284037218353, 15960.263909875592, 16317.347306107742, 1633.4772872680746, 1860.2280053777665, 1888.055972013993, 1914.7223652570437, 1928.421473557941, 115040.42479787632, 116443.835561645, 117397.0, 117448.0, 117527.82472175255, 9777.364471309342, 9792.902070979342, 9923.751906202402, 10131.594736210616, 10321.380717156995, 13352.732945341038, 13493.190408575518, 13509.324533773468, 13515.324233788271, 13529.86470135286, 8220.876686849702, 8297.58512074394, 8496.447730897471, 8559.272461840688, 8608.655653773903, 7395.889061664079, 8506.31949444043, 8572.271356934605, 8728.825423491495, 8745.125487451203, 5389.757460914268, 6434.453071488976, 6604.603723776589, 6613.437857782046, 6689.832754181184, 1596.3295415925338, 1633.052829358969, 1653.264297387675, 1696.830316968318, 1789.6152327249442, 935.5275585829113, 985.3447457440722, 1003.1523362758458, 1011.3881101933372, 1014.2393205096178, 18628.441146765617, 21489.570208595742, 21655.89172054161, 22364.0, 22375.88812055929, 968.85674903613, 993.1607791416242, 999.4103478947311, 1020.550957578663, 1031.5203430404747, 10586.576536938435, 11226.7193320166, 11597.942010289895, 11739.943405093412, 11781.175317727677, 530537.0, 533129.5873896176, 563442.0, 596345.0, 613757.0, 95786.0, 130024.0, 133057.0, 136619.0, 137701.0, 955.8470644696815, 987.0820137272406, 1022.2180032275315, 1033.3748082410184, 1037.1443559063653, 13961.092528985584, 16701.415450459175, 18894.244230231187, 18951.43145705631, 19104.426867194008, 54155.45844541504, 55104.448955509935, 58405.83188336124, 58446.12330814956, 59990.70004650123, 85473.0, 87900.0, 89737.0, 89939.0, 92040.0, 6811.693473793592, 8048.83902321962, 8322.08457069734, 8372.706955256537, 8412.242898139197, 10452.477376131315, 12720.936395317964, 13155.210687358789, 13210.669733256746, 13520.25638589887, 11336.696279927914, 11521.82717259225, 11571.421428928352, 11579.884201158218, 11621.302721836717, 10757.46212689378, 11222.66332010041, 11264.267822591506, 11460.713482162679, 11596.94201528987, 11335.546578136782, 11442.313461192354, 11549.595764148215, 11848.348340841336, 11853.466594003117, 6514.869702605826, 7091.574505529478, 7333.156686981066, 7550.735724249625, 8463.407561470638, 9772.804543909224, 11130.721731956766, 11757.882421175678, 11844.170908036354, 11866.288022718665], "value": 9892.270609661497, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1555.2690235589273, 1573.6459296658254, 1625.2686291168977, 1827.1503750755903, 1925.7592800899897, 8030.5984700764875, 8570.314374850004, 8700.52147131909, 9149.804047028707, 9156.0, 8725.956370218157, 8926.59830307636, 8938.508382038985, 8945.194932456077, 8951.283897288218, 2290.2442194075957, 2332.568474832153, 2335.9065637374483, 2346.4251258441705, 2352.9058987570775, 2311.52613714189, 2333.743288238301, 2363.420961864346, 2369.917052903149, 2371.9762802372015, 2323.8373313868037, 2328.4062564046144, 2336.766323367658, 2347.190219374313, 2363.917262895799, 2310.5263420998654, 2319.814414846808, 2326.220716060122, 2334.2063698342645, 2339.613963696005, 2318.1075286015007, 2331.0442718485338, 2331.1724337859987, 2332.207049603143, 2340.157543284416, 8877.51173685447, 8953.462792232487, 9000.234980026706, 9000.369974101815, 9003.459792412476, 5268.736563171826, 5317.335333083364, 5376.11294136467, 5407.134858422673, 5462.590305727047, 3561.6438356164435, 3622.7826330419994, 3645.85416583339, 3695.501107350527, 3702.315071711715, 1070.5931745936573, 1096.7313008313015, 1110.7112150840758, 1113.4599719136213, 1122.4668282565797, 11834.289942603471, 11903.880961190363, 11932.0, 11971.102167337485, 12010.519579216822, 4706.708473733226, 4730.645201609893, 4766.547178018082, 4838.879028024257, 4890.364252647204, 9932.503374831229, 10169.644062457926, 10203.081722644998, 10204.540795664212, 10216.978302169724, 5400.810971615974, 5402.540784033323, 5404.864878378072, 5424.376196737347, 5428.864278393072, 4379.759113248802, 4777.211760059621, 4912.6561140719805, 4940.975295123501, 4945.876353091202, 3870.612938706107, 3967.6230758077936, 3993.600639935983, 4013.3177359848896, 4073.124278280184, 1284.653143651209, 1302.9609111726663, 1303.1203937342257, 1305.6344223617402, 1309.5351150341683, 839.6347588798892, 880.4189235104928, 903.4940433357341, 911.8221946720325, 950.496236994394, 5786.363500014995, 5900.557458190653, 6091.817245482643, 6110.297315808739, 6300.495960323163, 850.4897061762892, 884.2130503851578, 990.094063931509, 992.8808542974889, 1021.2493817044466, 3996.220736956324, 4068.572799856032, 4139.151473947833, 4147.6267135957305, 4199.286121359376, 10576.259661823753, 10667.19996000303, 10810.891891081146, 10876.456177191109, 10982.341059536453, 10893.891061089445, 10903.34579925207, 10918.836217456745, 10921.781564368826, 10955.50700218492, 6921.550099243533, 7607.847843043108, 8084.191580841869, 8213.425060245845, 8340.582970851434, 5213.426523082534, 5804.82585522435, 5898.1152827076285, 6018.307894592178, 6046.123312119806, 9760.707178784647, 10156.847647285149, 10173.491325433846, 10203.795924081625, 10223.846642300223, 9861.260405469475, 10305.278630495794, 10395.376277423378, 10407.167426606005, 10422.843657344994, 7136.4290856730295, 7389.371903388273, 7513.511621744569, 7540.0, 7647.158812530506, 8333.083360830182, 8459.95770021146, 8524.062353141026, 8534.189252021048, 8549.529775862138, 7432.591207483641, 7436.144843343085, 7571.886421703569, 7667.11828139771, 7688.346490548366, 7365.7790266292095, 7469.514481558898, 7485.550866947783, 7591.848163036598, 7653.387728981779, 7061.2938706131035, 7228.9277107230355, 7229.819254518679, 7234.385077268281, 7242.927570724436, 4962.503749625009, 5166.040675376039, 5177.8673902290075, 5188.636795424435, 5229.424763275961, 5090.898182036412, 5099.719515426687, 5108.744562771921, 5190.299309593157, 5293.391260004994], "value": 4655.3526710278975, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [286.21006023375486, 300.0, 313.77314699524857, 314.20192710515295, 315.6780084314, 5508.9724551377185, 5727.198192253088, 5740.67964368195, 5782.508486778624, 5854.707264636772, 4896.510348965102, 5313.3868969100995, 5667.433256674341, 5784.392638772932, 5824.7476792489715, 3354.916127096824, 4411.470623525165, 4424.97787511062, 4428.490723566799, 4431.158079964813, 3605.4591811228265, 3842.53889533255, 3870.78710670913, 4462.576055274743, 4478.97760511197, 3974.5429275633383, 4001.3997900314894, 4097.631213190813, 4200.810963506634, 4373.032135539004, 4017.2568074906235, 4193.161367726467, 4385.166818304512, 4401.471823381183, 4416.779161041935, 3326.868864586028, 3812.370958791796, 3819.250139899268, 3828.2343531293573, 3832.7317087803863, 4427.0, 5579.358373786985, 5621.578381621394, 5659.971700141514, 5671.829845104653, 4312.7708603048295, 4327.7186982846015, 4659.464161621389, 4881.973176630512, 4936.432310284292, 5051.444341122474, 5573.182370076511, 6091.786787462417, 6106.7558047157245, 6110.327863934964, 3715.777053376806, 4002.8598999035185, 4044.534878488982, 4065.8983525411804, 4091.959080409217, 6411.4229719325485, 6456.451201647866, 6468.3182372583, 6500.569874627575, 6519.924212504931, 3467.913302167466, 3808.5717855804073, 4125.50493940729, 4142.958570414317, 4159.710489748188, 3658.9817050914576, 4098.200850834059, 4159.7920103994675, 4171.395147703627, 4182.2890108681595, 4541.364209010741, 4858.246971719389, 4883.609311255091, 4910.631702622318, 4910.754462276872, 5788.450097240755, 5832.475077243069, 5906.763729450774, 6031.185789918392, 6125.1424800527075, 1269.4224128021729, 1295.6242689619905, 1415.393528345315, 1417.0080943339703, 1418.2412409360943, 818.8485130250923, 844.9704260350858, 845.4124383553371, 860.9096044915194, 866.5797088412115, 3980.542237642708, 4680.648951328664, 4789.9105077224995, 4824.975875120602, 4852.684575502581, 4256.87229383119, 4829.541193586674, 4997.5002499749735, 5247.48418559566, 5305.169716447819, 4008.9799551002643, 4660.603848672833, 4718.693284936468, 4860.77112911769, 4890.682105663121, 2407.8916448759496, 2530.3547595363434, 2734.8359098454157, 2747.821391609539, 2769.252301878522, 5047.646664733506, 5351.384590772111, 5364.30264065669, 5450.427705090988, 5458.2904222451625, 4576.473705523841, 4646.512116227747, 4897.363342765418, 5376.758045887945, 5410.567154627621, 4339.934900976488, 4560.977195114003, 5159.484051594811, 5365.356157261153, 5440.259117082495, 4540.750258735801, 4916.82791102324, 4930.013997200503, 5077.7715002824225, 5304.628675992798, 4277.743335399886, 4597.609203217764, 4690.6247500199215, 5094.5160209780015, 5221.425643179323, 5010.298558201927, 5379.515843574097, 5386.919196211981, 5389.919151212814, 5410.567154627699, 3363.6131844837178, 3580.0, 3939.192465544499, 4039.636432721069, 4094.2630326541507, 5788.855278618068, 5959.73181206838, 6165.784197553064, 6290.968545157245, 6297.1813664223355, 5321.840344789663, 5722.941255867678, 6074.119252708244, 6089.604175728564, 6103.7558497661375, 5955.04719244936, 6037.1927053920135, 6059.3637668045985, 6061.605995610271, 6084.330723620486, 4748.572628463455, 5644.9839028975175, 5873.647581145145, 5914.142449344907, 5951.732172052181, 5421.1055175895535, 5643.492085712305, 5694.0, 6019.428154325332, 6212.502999759918, 5011.574016208663, 5310.283111780015, 6051.515878729779, 6073.423024812636, 6102.847428814315], "value": 4131.190470799848, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [677.5054210426389, 688.7086712414223, 698.8008417600978, 729.2925861913942, 817.5626040068563, 15407.0, 16281.592960176002, 16294.10382428966, 16309.266083026263, 16351.345946162153, 13184.868151318484, 14601.634959126028, 14663.046901951393, 14788.18664973426, 14804.40782368704, 682.3074579302013, 803.5018288661024, 835.5655059369125, 861.1474640106281, 864.476991420188, 778.7002004228357, 859.7162936231028, 868.3270465389311, 870.8606622940331, 872.3108744092191, 887.6715615222345, 923.5336155241594, 924.117467818232, 924.2790623313826, 924.7826760711228, 900.5137225898008, 911.9224865886341, 913.6619450803212, 917.591671706091, 919.8068405634825, 677.7356830835978, 689.9551529150589, 691.2016620802981, 692.4737199728193, 694.447913908439, 15282.235888205656, 15317.234138293152, 15369.769453458208, 15378.077315361114, 15401.922990385088, 14864.851351486563, 14914.254287285592, 14919.2540372982, 14970.850291497054, 15034.548963531111, 12065.0, 12186.57346992851, 12224.304454375115, 12604.873951260462, 12616.0, 3770.698344132463, 3810.371288737355, 3905.3946638271113, 3913.3347330953807, 4005.0, 75552.24447755507, 110812.0, 111320.0, 113489.43255283753, 113769.29346059816, 11326.0, 11453.312801231952, 11463.197576169754, 11516.654500365003, 11678.416079196006, 24107.39731506691, 24193.15323963653, 24227.030918763052, 24259.75740242575, 24264.878675606862, 8075.959620201861, 8084.729229900879, 8157.55133467665, 8167.14245004266, 8324.833503329899, 3684.926301474009, 4523.7285762854335, 4544.704594201433, 4562.612177964844, 4615.838445654386, 3212.566303549038, 3672.338978983755, 3759.6992240620684, 3777.546694396635, 3785.072657199004, 619.8574327904607, 634.330781026022, 680.5848432456198, 704.3555147040503, 707.4234498883496, 416.9687273454503, 582.0396346029002, 595.4670569839969, 632.8101569529123, 637.8277864976524, 9312.627494900127, 9484.67214589958, 9559.856602150974, 9724.465154416434, 10191.592336306612, 561.4049107945591, 576.3256989322502, 585.3619554685413, 588.4145275450868, 667.9866402672017, 3941.802909854553, 4421.40311058003, 4595.471520775153, 4627.6529260305615, 4812.951870481321, 158185.20907395388, 160427.0, 163116.0, 164153.0, 170114.0, 120665.0, 139039.0, 142634.0, 143548.28225858803, 143922.2803885995, 120189.0, 121539.39230303792, 122416.0, 122629.77370226361, 125788.0, 8366.0, 8838.292936565187, 9059.909400905906, 9411.647833105675, 9543.618255269712, 64198.67900660467, 64248.357516426106, 64892.35107648863, 65040.123610626906, 68001.65999169972, 64641.35358646541, 72783.0, 94958.0, 97570.51214743881, 100053.99946000447, 11997.280163190237, 12089.81865272004, 12142.210756300812, 12147.331896745764, 12192.207506512048, 13448.731025379242, 13477.595672129852, 13848.09987350819, 14082.577522674335, 14267.286635668383, 12491.0, 12683.30241836671, 12741.426635801226, 12780.808287875876, 13176.670583235496, 12850.35748212567, 12874.717299997292, 12954.80567791465, 13152.539661111816, 13221.933890330487, 12482.126251162332, 12593.496260149857, 12622.810657839957, 12677.936610316889, 12875.935620321838, 10199.133073688523, 10648.041676249175, 10654.946725266323, 10706.768721597116, 10881.891181088087, 8144.633491492778, 8923.73228803137, 10717.502400963445, 10958.452077396258, 11015.559377624806], "value": 7822.825168347842, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1594.9999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 117.0, 125.0, 162.0, 117.0, 117.0, 116.0, 116.0, 117.0, 116.0], "value": 120.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 130.0, 172.0, 193.0, 96.0, 159.0, 155.0, 118.0, 202.0, 142.0], "value": 151.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [208.0, 237.0, 199.0, 197.0, 196.0, 195.0, 261.0, 202.0, 197.0, 195.0], "value": 208.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 79.0, 78.0, 150.0, 81.0, 51.0, 67.0, 83.0, 168.0, 86.0], "value": 91.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 72.0, 132.0, 71.0, 72.0, 86.0, 118.0, 70.0, 78.0, 149.0], "value": 91.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 87.0, 76.0, 132.0, 133.0, 86.0, 107.0, 131.0, 110.0, 87.0], "value": 103.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 101.0, 96.0, 95.0, 95.0, 97.0, 99.0, 95.0], "value": 96.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 135.0, 82.0, 137.0, 146.0, 74.0, 134.0, 126.0, 98.0, 152.0], "value": 119.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 57.0, 56.0, 52.0, 55.0, 56.0, 57.0, 56.0, 54.0, 54.0], "value": 55.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 69.0, 75.0, 83.0, 88.0, 88.0, 76.0, 73.0, 76.0, 72.0], "value": 79.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 70.0, 98.0, 103.0, 108.0, 83.0, 86.0, 81.0, 86.0, 85.0], "value": 90.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 132.0, 144.0, 148.0, 155.0, 139.0, 143.0, 149.0, 171.0, 157.0], "value": 150.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 168.0, 188.0, 166.0, 167.0, 162.0, 168.0, 165.0, 165.0, 166.0], "value": 168.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 69.0, 68.0, 68.0, 65.0, 69.0, 68.0, 66.0, 66.0], "value": 67.2, "unit": "score"}]}]} 04:32:18 INFO - Return code: 0 04:32:18 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:32:18 ERROR - # TBPL SUCCESS # 04:32:18 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:32:18 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:32:18 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:32:18 INFO - 2016-08-11 04:32:18.521 screenresolution[1973:18381] starting screenresolution argv=screenresolution get 04:32:18 INFO - 2016-08-11 04:32:18.524 screenresolution[1973:18381] Display 0: 1600x1200x32@60 04:32:18 INFO - 2016-08-11 04:32:18.530 screenresolution[1974:18384] starting screenresolution argv=screenresolution list 04:32:18 INFO - Available Modes on Display 0 04:32:18 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:32:18 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:32:18 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:32:18 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:32:18 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:32:18 INFO - Intel Iris: 04:32:18 INFO - Chipset Model: Intel Iris 04:32:18 INFO - Type: GPU 04:32:18 INFO - Bus: Built-In 04:32:18 INFO - VRAM (Dynamic, Max): 1536 MB 04:32:18 INFO - Vendor: Intel (0x8086) 04:32:18 INFO - Device ID: 0x0a2e 04:32:18 INFO - Revision ID: 0x0009 04:32:18 INFO - Displays: 04:32:18 INFO - Display: 04:32:18 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:32:18 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:32:18 INFO - Display Serial Number: 1600x1200 60 04:32:18 INFO - Main Display: Yes 04:32:18 INFO - Mirror: Off 04:32:18 INFO - Online: Yes 04:32:18 INFO - Rotation: Supported 04:32:18 INFO - Return code: 0 04:32:18 INFO - Running post-action listener: _resource_record_post_action 04:32:18 INFO - [mozharness: 2016-08-11 11:32:18.768077Z] Finished run-tests step (success) 04:32:18 INFO - Running post-run listener: _resource_record_post_run 04:32:18 INFO - Total resource usage - Wall time: 1209s; CPU: 55.0%; Read bytes: 827392; Write bytes: 705046528; Read time: 8; Write time: 1996 04:32:18 INFO - TinderboxPrint: CPU usage
54.6% 04:32:18 INFO - TinderboxPrint: I/O read bytes / time
827,392 / 8 04:32:18 INFO - TinderboxPrint: I/O write bytes / time
705,046,528 / 1,996 04:32:18 INFO - TinderboxPrint: CPU idle
2,197.1 (45.4%) 04:32:18 INFO - TinderboxPrint: CPU system
980.5 (20.3%) 04:32:18 INFO - TinderboxPrint: CPU user
1,660.1 (34.3%) 04:32:18 INFO - TinderboxPrint: Swap in / out
404,283,392 / 0 04:32:18 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 403573248; Write bytes: 398485504; Read time: 29701; Write time: 813 04:32:18 INFO - run-tests - Wall time: 1176s; CPU: 55.0%; Read bytes: 761856; Write bytes: 296759296; Read time: 7; Write time: 1143 04:32:19 INFO - Running post-run listener: _upload_blobber_files 04:32:19 INFO - Blob upload gear active. 04:32:19 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:32:19 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 04:32:19 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'] 04:32:19 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 04:32:19 INFO - (blobuploader) - INFO - Open directory for files ... 04:32:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:32:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:32:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:32:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:32:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:32:20 INFO - (blobuploader) - INFO - Done attempting. 04:32:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:32:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:32:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:32:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:32:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:32:21 INFO - (blobuploader) - INFO - Done attempting. 04:32:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:32:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:32:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:32:23 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:32:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:32:23 INFO - (blobuploader) - INFO - Done attempting. 04:32:23 INFO - (blobuploader) - INFO - Iteration through files over. 04:32:23 INFO - Return code: 0 04:32:23 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:32:23 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:32:23 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/74e122e284924cb4cc0ff28c73830a4f6744a122bc0fcc073d1bbf693744147266e69f957ae214a1a1e26221d35b0e5b03c8f3ed99cfa9b35e3f7aa93b4a6802", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/41f319b512da014a1070690f954eeff661103dd69aa026f94801f9eecaca5824bafffdb55a14a7d1baa8ff5c655927cbd8823f7b11cb664f6e552f3675a17e6a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/1403a555b6f0ed9b61d3e44165e930ede23b434293d3d69d8395a404edb53073530992e64053db201b4b5982255d28711eab60eb8c24814b721f8166b5d60e5f"} 04:32:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:32:23 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:32:23 INFO - Contents: 04:32:23 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/74e122e284924cb4cc0ff28c73830a4f6744a122bc0fcc073d1bbf693744147266e69f957ae214a1a1e26221d35b0e5b03c8f3ed99cfa9b35e3f7aa93b4a6802", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/41f319b512da014a1070690f954eeff661103dd69aa026f94801f9eecaca5824bafffdb55a14a7d1baa8ff5c655927cbd8823f7b11cb664f6e552f3675a17e6a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/1403a555b6f0ed9b61d3e44165e930ede23b434293d3d69d8395a404edb53073530992e64053db201b4b5982255d28711eab60eb8c24814b721f8166b5d60e5f"} 04:32:23 INFO - Running post-run listener: copy_logs_to_upload_dir 04:32:23 INFO - Copying logs to upload dir... 04:32:23 INFO - mkdir: /builds/slave/test/build/upload/logs 04:32:23 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1268.237627 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-08-11 04:32:23.588810) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-11 04:32:23.592664) ========= 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.tMvUegWvFx/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.TlWqHhePFE/Listeners TMPDIR=/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/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/74e122e284924cb4cc0ff28c73830a4f6744a122bc0fcc073d1bbf693744147266e69f957ae214a1a1e26221d35b0e5b03c8f3ed99cfa9b35e3f7aa93b4a6802", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/41f319b512da014a1070690f954eeff661103dd69aa026f94801f9eecaca5824bafffdb55a14a7d1baa8ff5c655927cbd8823f7b11cb664f6e552f3675a17e6a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/1403a555b6f0ed9b61d3e44165e930ede23b434293d3d69d8395a404edb53073530992e64053db201b4b5982255d28711eab60eb8c24814b721f8166b5d60e5f"} build_url:https://queue.taskcluster.net/v1/task/YF6jk806Qde1Ot4Pud_1vQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011134 build_url: 'https://queue.taskcluster.net/v1/task/YF6jk806Qde1Ot4Pud_1vQ/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/74e122e284924cb4cc0ff28c73830a4f6744a122bc0fcc073d1bbf693744147266e69f957ae214a1a1e26221d35b0e5b03c8f3ed99cfa9b35e3f7aa93b4a6802", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/41f319b512da014a1070690f954eeff661103dd69aa026f94801f9eecaca5824bafffdb55a14a7d1baa8ff5c655927cbd8823f7b11cb664f6e552f3675a17e6a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/1403a555b6f0ed9b61d3e44165e930ede23b434293d3d69d8395a404edb53073530992e64053db201b4b5982255d28711eab60eb8c24814b721f8166b5d60e5f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-11 04:32:23.625398) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 04:32:23.625715) ========= 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.tMvUegWvFx/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.TlWqHhePFE/Listeners TMPDIR=/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/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.005394 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 04:32:23.674338) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-11 04:32:23.674647) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-11 04:32:23.674986) ========= ========= Total master_lag: 0.17 =========