builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-085 starttime: 1501871749.79 results: success (0) revision: 357ef8a67e8893d91ec6716fb66f42031c34a14c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-04 11:35:49.794770) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-04 11:35:49.795213) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-04 11:35:49.795502) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-04 11:35:49.811488) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-04 11:35:49.811750) ========= 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: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5c37b704b588aaa989324530000001d0-1501871749.998862-157689734 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-04 11:35:50-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.6M=0s 2017-08-04 11:35:50 (42.6 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.076467 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-04 11:35:49.904703) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-04 11:35:49.905081) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5c37b704b588aaa989324530000001d0-1501871749.998862-157689734 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015176 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-04 11:35:49.954457) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-04 11:35:49.954802) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 357ef8a67e8893d91ec6716fb66f42031c34a14c --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev 357ef8a67e8893d91ec6716fb66f42031c34a14c --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5c37b704b588aaa989324530000001d0-1501871749.998862-157689734 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-04 11:35:51,111 truncating revision to first 12 chars 2017-08-04 11:35:51,111 Setting DEBUG logging. 2017-08-04 11:35:51,111 attempt 1/10 2017-08-04 11:35:51,111 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/357ef8a67e88?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-04 11:35:52,357 unpacking tar archive at: mozilla-central-357ef8a67e88/testing/mozharness/ program finished with exit code 0 elapsedTime=1.668497 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-04 11:35:51.639038) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-04 11:35:51.642380) ========= script_repo_revision: 357ef8a67e8893d91ec6716fb66f42031c34a14c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-04 11:35:51.642755) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-04 11:35:51.643052) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-04 11:35:51.653237) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2017-08-04 11:35:51.653542) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5c37b704b588aaa989324530000001d0-1501871749.998862-157689734 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:35:52 INFO - MultiFileLogger online at 20170804 11:35:52 in /builds/slave/test 11:35:52 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 11:35:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:35:52 INFO - {'append_to_log': False, 11:35:52 INFO - 'base_work_dir': '/builds/slave/test', 11:35:52 INFO - 'blob_upload_branch': 'Firefox', 11:35:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:35:52 INFO - 'branch': 'Firefox', 11:35:52 INFO - 'buildbot_json_path': 'buildprops.json', 11:35:52 INFO - 'code_coverage': False, 11:35:52 INFO - 'config_files': ('talos/linux_config.py',), 11:35:52 INFO - 'default_actions': ('clobber', 11:35:52 INFO - 'read-buildbot-config', 11:35:52 INFO - 'download-and-extract', 11:35:52 INFO - 'populate-webroot', 11:35:52 INFO - 'create-virtualenv', 11:35:52 INFO - 'install', 11:35:52 INFO - 'setup-mitmproxy', 11:35:52 INFO - 'run-tests'), 11:35:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:35:52 INFO - 'disable_ccov_upload': False, 11:35:52 INFO - 'download_minidump_stackwalk': True, 11:35:52 INFO - 'download_symbols': 'ondemand', 11:35:52 INFO - 'enable_stylo': False, 11:35:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:35:52 INFO - 'tooltool.py': '/tools/tooltool.py', 11:35:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:35:52 INFO - '/tools/misc-python/virtualenv.py')}, 11:35:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:35:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:35:52 INFO - 'gecko_profile': False, 11:35:52 INFO - 'gecko_profile_interval': 0, 11:35:52 INFO - 'installer_path': 'installer.exe', 11:35:52 INFO - 'log_level': 'info', 11:35:52 INFO - 'log_name': 'talos', 11:35:52 INFO - 'log_to_console': True, 11:35:52 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:35:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:35:52 INFO - 'opt_config_files': (), 11:35:52 INFO - 'pip_index': False, 11:35:52 INFO - 'suite': 'dromaeojs-e10s', 11:35:52 INFO - 'system_bits': '32', 11:35:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:35:52 INFO - 'title': 'talos-linux64-ix-085', 11:35:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:35:52 INFO - 'use_talos_json': True, 11:35:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:35:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:35:52 INFO - 'work_dir': 'build'} 11:35:52 INFO - [mozharness: 2017-08-04 18:35:52.912901Z] Running clobber step. 11:35:52 INFO - Running pre-action listener: _resource_record_pre_action 11:35:52 INFO - Running main action method: clobber 11:35:52 INFO - rmtree: /builds/slave/test/build 11:35:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:35:53 INFO - Running post-action listener: _resource_record_post_action 11:35:53 INFO - [mozharness: 2017-08-04 18:35:53.948944Z] Finished clobber step (success) 11:35:53 INFO - [mozharness: 2017-08-04 18:35:53.949046Z] Running read-buildbot-config step. 11:35:53 INFO - Running pre-action listener: _resource_record_pre_action 11:35:53 INFO - Running main action method: read_buildbot_config 11:35:53 INFO - Using buildbot properties: 11:35:53 INFO - { 11:35:53 INFO - "project": "", 11:35:53 INFO - "product": "firefox", 11:35:53 INFO - "who": "archaeopteryx@coole-files.de", 11:35:53 INFO - "installer_path": "public/build/target.tar.bz2", 11:35:53 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 11:35:53 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 11:35:53 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 11:35:53 INFO - "stage_platform": "linux64-pgo", 11:35:53 INFO - "basedir": "/builds/slave/test", 11:35:53 INFO - "buildnumber": 99, 11:35:53 INFO - "platform": "ubuntu64_hw", 11:35:53 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 11:35:53 INFO - "slavebuilddir": "test", 11:35:53 INFO - "taskId": "LTdqnY9qS36cUOHI1nbRrg", 11:35:53 INFO - "branch": "mozilla-central", 11:35:53 INFO - "script_repo_revision": "production", 11:35:53 INFO - "revision": "357ef8a67e8893d91ec6716fb66f42031c34a14c", 11:35:53 INFO - "slavename": "talos-linux64-ix-085", 11:35:53 INFO - "repo_path": "mozilla-central" 11:35:53 INFO - } 11:35:53 INFO - Finding installer, test and symbols from parent task. 11:35:53 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LTdqnY9qS36cUOHI1nbRrg'}, attempt #1 11:35:54 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LTdqnY9qS36cUOHI1nbRrg'}, attempt #1 11:35:54 INFO - Task dependencies: drQOCkkKRTWm0xE2BJ2h7w 11:35:54 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/drQOCkkKRTWm0xE2BJ2h7w'}, attempt #1 11:35:55 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/drQOCkkKRTWm0xE2BJ2h7w/artifacts/public/build/target.tar.bz2 11:35:55 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/drQOCkkKRTWm0xE2BJ2h7w/artifacts/public/build/target.test_packages.json 11:35:55 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/drQOCkkKRTWm0xE2BJ2h7w/artifacts/public/build/target.crashreporter-symbols.zip 11:35:55 INFO - Running post-action listener: _resource_record_post_action 11:35:55 INFO - [mozharness: 2017-08-04 18:35:55.318684Z] Finished read-buildbot-config step (success) 11:35:55 INFO - [mozharness: 2017-08-04 18:35:55.318907Z] Running download-and-extract step. 11:35:55 INFO - Running pre-action listener: _resource_record_pre_action 11:35:55 INFO - Running main action method: download_and_extract 11:35:55 INFO - mkdir: /builds/slave/test/build/tests 11:35:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 11:35:55 INFO - trying https://queue.taskcluster.net/v1/task/drQOCkkKRTWm0xE2BJ2h7w/artifacts/public/build/target.test_packages.json 11:35:55 INFO - Downloading https://queue.taskcluster.net/v1/task/drQOCkkKRTWm0xE2BJ2h7w/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 11:35:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/drQOCkkKRTWm0xE2BJ2h7w/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 11:35:55 INFO - Downloaded 989 bytes. 11:35:55 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 11:35:55 INFO - Using the following test package requirements: 11:35:55 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 11:35:55 INFO - u'common': [u'target.common.tests.zip'], 11:35:55 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 11:35:55 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 11:35:55 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 11:35:55 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 11:35:55 INFO - u'mozbase': [u'target.common.tests.zip'], 11:35:55 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 11:35:55 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 11:35:55 INFO - u'web-platform': [u'target.common.tests.zip', 11:35:55 INFO - u'target.web-platform.tests.tar.gz'], 11:35:55 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 11:35:55 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 11:35:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/drQOCkkKRTWm0xE2BJ2h7w/artifacts/public/build/target.common.tests.zip 11:35:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/drQOCkkKRTWm0xE2BJ2h7w/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:35:55 INFO - Fetch https://queue.taskcluster.net/v1/task/drQOCkkKRTWm0xE2BJ2h7w/artifacts/public/build/target.common.tests.zip into memory 11:35:57 INFO - Content-Length response header: 54890641 11:35:57 INFO - Bytes received: 54890641 11:36:08 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 11:36:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/drQOCkkKRTWm0xE2BJ2h7w/artifacts/public/build/target.common.tests.zip 11:36:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/drQOCkkKRTWm0xE2BJ2h7w/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:36:08 INFO - Fetch https://queue.taskcluster.net/v1/task/drQOCkkKRTWm0xE2BJ2h7w/artifacts/public/build/target.common.tests.zip into memory 11:36:09 INFO - Content-Length response header: 54890641 11:36:09 INFO - Bytes received: 54890641 11:36:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/drQOCkkKRTWm0xE2BJ2h7w/artifacts/public/build/target.talos.tests.zip 11:36:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/drQOCkkKRTWm0xE2BJ2h7w/artifacts/public/build/target.talos.tests.zip'}, attempt #1 11:36:21 INFO - Fetch https://queue.taskcluster.net/v1/task/drQOCkkKRTWm0xE2BJ2h7w/artifacts/public/build/target.talos.tests.zip into memory 11:36:22 INFO - Content-Length response header: 14496008 11:36:22 INFO - Bytes received: 14496008 11:36:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 11:36:22 INFO - trying https://queue.taskcluster.net/v1/task/drQOCkkKRTWm0xE2BJ2h7w/artifacts/public/build/target.tar.bz2 11:36:22 INFO - Downloading https://queue.taskcluster.net/v1/task/drQOCkkKRTWm0xE2BJ2h7w/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 11:36:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/drQOCkkKRTWm0xE2BJ2h7w/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 11:36:23 INFO - Downloaded 63036826 bytes. 11:36:23 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/drQOCkkKRTWm0xE2BJ2h7w/artifacts/public/build/target.tar.bz2 11:36:23 INFO - mkdir: /builds/slave/test/properties 11:36:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:36:23 INFO - Writing to file /builds/slave/test/properties/build_url 11:36:23 INFO - Contents: 11:36:23 INFO - build_url:https://queue.taskcluster.net/v1/task/drQOCkkKRTWm0xE2BJ2h7w/artifacts/public/build/target.tar.bz2 11:36:23 INFO - Running post-action listener: _resource_record_post_action 11:36:23 INFO - Running post-action listener: set_extra_try_arguments 11:36:23 INFO - [mozharness: 2017-08-04 18:36:23.440094Z] Finished download-and-extract step (success) 11:36:23 INFO - [mozharness: 2017-08-04 18:36:23.440193Z] Running populate-webroot step. 11:36:23 INFO - Running pre-action listener: _resource_record_pre_action 11:36:23 INFO - Running main action method: populate_webroot 11:36:23 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:36:23 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:36:23 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:36:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:36:23 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:36:23 INFO - 'tests': ['damp', 'tps']}, 11:36:23 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:36:23 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 11:36:23 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 11:36:23 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 11:36:23 INFO - 'other-e10s': {'tests': ['a11yr', 11:36:23 INFO - 'ts_paint', 11:36:23 INFO - 'tpaint', 11:36:23 INFO - 'sessionrestore', 11:36:23 INFO - 'sessionrestore_many_windows', 11:36:23 INFO - 'sessionrestore_no_auto_restore', 11:36:23 INFO - 'tabpaint']}, 11:36:23 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 11:36:23 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 11:36:23 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:36:23 INFO - 'tsvgr_opacity', 11:36:23 INFO - 'tart', 11:36:23 INFO - 'tscrollx', 11:36:23 INFO - 'tsvg_static']}, 11:36:23 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:36:23 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:36:23 INFO - 'talos_options': ['--mitmproxy', 11:36:23 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:36:23 INFO - '--firstNonBlankPaint'], 11:36:23 INFO - 'tests': ['tp6_google', 11:36:23 INFO - 'tp6_youtube', 11:36:23 INFO - 'tp6_amazon', 11:36:23 INFO - 'tp6_facebook']}, 11:36:23 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:36:23 INFO - 'talos_options': ['--stylo', 11:36:23 INFO - '--mitmproxy', 11:36:23 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:36:23 INFO - '--firstNonBlankPaint'], 11:36:23 INFO - 'tests': ['tp6_google', 11:36:23 INFO - 'tp6_youtube', 11:36:23 INFO - 'tp6_amazon', 11:36:23 INFO - 'tp6_facebook']}, 11:36:23 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:36:23 INFO - 'talos_options': ['--stylo', 11:36:23 INFO - '--stylo-threads=1', 11:36:23 INFO - '--mitmproxy', 11:36:23 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:36:23 INFO - '--firstNonBlankPaint'], 11:36:23 INFO - 'tests': ['tp6_google', 11:36:23 INFO - 'tp6_youtube', 11:36:23 INFO - 'tp6_amazon', 11:36:23 INFO - 'tp6_facebook']}, 11:36:23 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:36:23 INFO - 'talos_options': ['--xperf_path', 11:36:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:36:23 INFO - 'tests': ['tp5n']}}} 11:36:23 INFO - Running post-action listener: _resource_record_post_action 11:36:23 INFO - [mozharness: 2017-08-04 18:36:23.448604Z] Finished populate-webroot step (success) 11:36:23 INFO - [mozharness: 2017-08-04 18:36:23.448694Z] Running create-virtualenv step. 11:36:23 INFO - Running pre-action listener: _resource_record_pre_action 11:36:23 INFO - Running main action method: create_virtualenv 11:36:23 INFO - Creating virtualenv /builds/slave/test/build/venv 11:36:23 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 11:36:23 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:36:23 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 11:36:23 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:36:23 INFO - Using real prefix '/usr' 11:36:23 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:36:24 INFO - Installing distribute.............................................................................................................................................................................................done. 11:36:26 INFO - Installing pip.................done. 11:36:26 INFO - Return code: 0 11:36:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:36:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:36:26 INFO - Reading from file tmpfile_stdout 11:36:26 INFO - Output received: 11:36:26 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 11:36:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:36:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 11:36:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:36:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 11:36:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:36:26 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/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 0x1afd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cc9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e6cd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e69eb0>, '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 0x1e6adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e6b240>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1501871749.998862-157689734', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:36:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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 11:36:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:36:26 INFO - Using env: {'DISPLAY': ':0', 11:36:26 INFO - 'HOME': '/home/cltbld', 11:36:26 INFO - 'LANG': 'en_US.UTF-8', 11:36:26 INFO - 'LANGUAGE': 'en_US:en', 11:36:26 INFO - 'LOGNAME': 'cltbld', 11:36:26 INFO - 'MAIL': '/var/mail/cltbld', 11:36:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:36:26 INFO - 'MOZ_NO_REMOTE': '1', 11:36:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:36:26 INFO - 'NO_EM_RESTART': '1', 11:36:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:36:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:36:26 INFO - 'PWD': '/builds/slave/test', 11:36:26 INFO - 'SHELL': '/bin/bash', 11:36:26 INFO - 'SHLVL': '1', 11:36:26 INFO - 'TERM': 'linux', 11:36:26 INFO - 'TMOUT': '86400', 11:36:26 INFO - 'USER': 'cltbld', 11:36:26 INFO - 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1501871749.998862-157689734', 11:36:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:36:26 INFO - '_': '/tools/buildbot/bin/python'} 11:36:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:36:26 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 11:36:26 INFO - Cleaning up... 11:36:26 INFO - Return code: 0 11:36:26 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:36:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 11:36:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:36:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 11:36:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:36:26 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/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 0x1afd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cc9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e6cd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e69eb0>, '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 0x1e6adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e6b240>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1501871749.998862-157689734', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:36:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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 11:36:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 11:36:26 INFO - Using env: {'DISPLAY': ':0', 11:36:26 INFO - 'HOME': '/home/cltbld', 11:36:26 INFO - 'LANG': 'en_US.UTF-8', 11:36:26 INFO - 'LANGUAGE': 'en_US:en', 11:36:26 INFO - 'LOGNAME': 'cltbld', 11:36:26 INFO - 'MAIL': '/var/mail/cltbld', 11:36:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:36:26 INFO - 'MOZ_NO_REMOTE': '1', 11:36:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:36:26 INFO - 'NO_EM_RESTART': '1', 11:36:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:36:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:36:26 INFO - 'PWD': '/builds/slave/test', 11:36:26 INFO - 'SHELL': '/bin/bash', 11:36:26 INFO - 'SHLVL': '1', 11:36:26 INFO - 'TERM': 'linux', 11:36:26 INFO - 'TMOUT': '86400', 11:36:26 INFO - 'USER': 'cltbld', 11:36:26 INFO - 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1501871749.998862-157689734', 11:36:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:36:26 INFO - '_': '/tools/buildbot/bin/python'} 11:36:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:36:26 INFO - Downloading/unpacking psutil>=3.1.1 11:36:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:36:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:36:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:36:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:36:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:36:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:36:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:36:27 INFO - Installing collected packages: psutil 11:36:27 INFO - Running setup.py install for psutil 11:36:27 INFO - building 'psutil._psutil_linux' extension 11:36:27 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 11:36:28 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 11:36:28 INFO - building 'psutil._psutil_posix' extension 11:36:28 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 11:36:28 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 11:36:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:36:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:36:28 INFO - Successfully installed psutil 11:36:28 INFO - Cleaning up... 11:36:28 INFO - Return code: 0 11:36:28 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:36:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 11:36:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:36:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 11:36:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:36:28 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/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 0x1afd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cc9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e6cd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e69eb0>, '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 0x1e6adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e6b240>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1501871749.998862-157689734', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:36:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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 11:36:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 11:36:28 INFO - Using env: {'DISPLAY': ':0', 11:36:28 INFO - 'HOME': '/home/cltbld', 11:36:28 INFO - 'LANG': 'en_US.UTF-8', 11:36:28 INFO - 'LANGUAGE': 'en_US:en', 11:36:28 INFO - 'LOGNAME': 'cltbld', 11:36:28 INFO - 'MAIL': '/var/mail/cltbld', 11:36:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:36:28 INFO - 'MOZ_NO_REMOTE': '1', 11:36:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:36:28 INFO - 'NO_EM_RESTART': '1', 11:36:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:36:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:36:28 INFO - 'PWD': '/builds/slave/test', 11:36:28 INFO - 'SHELL': '/bin/bash', 11:36:28 INFO - 'SHLVL': '1', 11:36:28 INFO - 'TERM': 'linux', 11:36:28 INFO - 'TMOUT': '86400', 11:36:28 INFO - 'USER': 'cltbld', 11:36:28 INFO - 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1501871749.998862-157689734', 11:36:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:36:28 INFO - '_': '/tools/buildbot/bin/python'} 11:36:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:36:28 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:36:28 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 11:36:28 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 11:36:28 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 11:36:28 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 11:36:29 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:36:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:36:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:36:29 INFO - Installing collected packages: mozsystemmonitor 11:36:29 INFO - Running setup.py install for mozsystemmonitor 11:36:29 INFO - Successfully installed mozsystemmonitor 11:36:29 INFO - Cleaning up... 11:36:29 INFO - Return code: 0 11:36:29 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:36:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 11:36:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:36:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 11:36:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:36:29 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/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 0x1afd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cc9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e6cd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e69eb0>, '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 0x1e6adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e6b240>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1501871749.998862-157689734', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:36:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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 11:36:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 11:36:29 INFO - Using env: {'DISPLAY': ':0', 11:36:29 INFO - 'HOME': '/home/cltbld', 11:36:29 INFO - 'LANG': 'en_US.UTF-8', 11:36:29 INFO - 'LANGUAGE': 'en_US:en', 11:36:29 INFO - 'LOGNAME': 'cltbld', 11:36:29 INFO - 'MAIL': '/var/mail/cltbld', 11:36:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:36:29 INFO - 'MOZ_NO_REMOTE': '1', 11:36:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:36:29 INFO - 'NO_EM_RESTART': '1', 11:36:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:36:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:36:29 INFO - 'PWD': '/builds/slave/test', 11:36:29 INFO - 'SHELL': '/bin/bash', 11:36:29 INFO - 'SHLVL': '1', 11:36:29 INFO - 'TERM': 'linux', 11:36:29 INFO - 'TMOUT': '86400', 11:36:29 INFO - 'USER': 'cltbld', 11:36:29 INFO - 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1501871749.998862-157689734', 11:36:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:36:29 INFO - '_': '/tools/buildbot/bin/python'} 11:36:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:36:30 INFO - Downloading/unpacking jsonschema==2.5.1 11:36:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:36:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:36:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:36:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:36:31 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:36:31 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:36:31 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 11:36:31 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 11:36:31 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 11:36:31 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 11:36:31 INFO - Downloading functools32-3.2.3-2.tar.gz 11:36:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:36:31 INFO - warning: no files found matching '*.txt' 11:36:31 INFO - no previously-included directories found matching 'build' 11:36:31 INFO - no previously-included directories found matching 'dist' 11:36:31 INFO - no previously-included directories found matching '.git*' 11:36:31 INFO - Installing collected packages: jsonschema, functools32 11:36:31 INFO - Running setup.py install for functools32 11:36:31 INFO - warning: no files found matching '*.txt' 11:36:31 INFO - no previously-included directories found matching 'build' 11:36:31 INFO - no previously-included directories found matching 'dist' 11:36:31 INFO - no previously-included directories found matching '.git*' 11:36:31 INFO - Successfully installed jsonschema functools32 11:36:31 INFO - Cleaning up... 11:36:31 INFO - Return code: 0 11:36:31 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:36:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 11:36:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:36:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 11:36:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:36:31 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/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 0x1afd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cc9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e6cd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e69eb0>, '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 0x1e6adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e6b240>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1501871749.998862-157689734', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:36:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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 11:36:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 11:36:31 INFO - Using env: {'DISPLAY': ':0', 11:36:31 INFO - 'HOME': '/home/cltbld', 11:36:31 INFO - 'LANG': 'en_US.UTF-8', 11:36:31 INFO - 'LANGUAGE': 'en_US:en', 11:36:31 INFO - 'LOGNAME': 'cltbld', 11:36:31 INFO - 'MAIL': '/var/mail/cltbld', 11:36:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:36:31 INFO - 'MOZ_NO_REMOTE': '1', 11:36:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:36:31 INFO - 'NO_EM_RESTART': '1', 11:36:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:36:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:36:31 INFO - 'PWD': '/builds/slave/test', 11:36:31 INFO - 'SHELL': '/bin/bash', 11:36:31 INFO - 'SHLVL': '1', 11:36:31 INFO - 'TERM': 'linux', 11:36:31 INFO - 'TMOUT': '86400', 11:36:31 INFO - 'USER': 'cltbld', 11:36:31 INFO - 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1501871749.998862-157689734', 11:36:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:36:31 INFO - '_': '/tools/buildbot/bin/python'} 11:36:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:36:31 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:36:31 INFO - Cleaning up... 11:36:31 INFO - Return code: 0 11:36:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:36:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 11:36:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:36:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 11:36:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:36:31 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/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 0x1afd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cc9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e6cd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e69eb0>, '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 0x1e6adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e6b240>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1501871749.998862-157689734', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:36:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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 11:36:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:36:31 INFO - Using env: {'DISPLAY': ':0', 11:36:31 INFO - 'HOME': '/home/cltbld', 11:36:31 INFO - 'LANG': 'en_US.UTF-8', 11:36:31 INFO - 'LANGUAGE': 'en_US:en', 11:36:31 INFO - 'LOGNAME': 'cltbld', 11:36:31 INFO - 'MAIL': '/var/mail/cltbld', 11:36:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:36:31 INFO - 'MOZ_NO_REMOTE': '1', 11:36:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:36:31 INFO - 'NO_EM_RESTART': '1', 11:36:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:36:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:36:31 INFO - 'PWD': '/builds/slave/test', 11:36:31 INFO - 'SHELL': '/bin/bash', 11:36:31 INFO - 'SHLVL': '1', 11:36:31 INFO - 'TERM': 'linux', 11:36:31 INFO - 'TMOUT': '86400', 11:36:31 INFO - 'USER': 'cltbld', 11:36:31 INFO - 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1501871749.998862-157689734', 11:36:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:36:31 INFO - '_': '/tools/buildbot/bin/python'} 11:36:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:36:31 INFO - Downloading/unpacking blobuploader==1.2.4 11:36:31 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 11:36:31 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 11:36:31 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 11:36:31 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 11:36:33 INFO - Downloading blobuploader-1.2.4.tar.gz 11:36:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:36:33 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:36:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:36:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:36:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:36:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:36:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:36:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:36:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:36:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:36:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:36:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:36:33 INFO - Downloading docopt-0.6.1.tar.gz 11:36:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:36:33 INFO - Installing collected packages: blobuploader, requests, docopt 11:36:33 INFO - Running setup.py install for blobuploader 11:36:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:36:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:36:33 INFO - Running setup.py install for requests 11:36:34 INFO - Running setup.py install for docopt 11:36:34 INFO - Successfully installed blobuploader requests docopt 11:36:34 INFO - Cleaning up... 11:36:34 INFO - Return code: 0 11:36:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:36:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 11:36:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:36:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 11:36:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:36:34 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/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 0x1afd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cc9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e6cd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e69eb0>, '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 0x1e6adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e6b240>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1501871749.998862-157689734', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:36:34 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/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:36:34 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/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:36:34 INFO - Using env: {'DISPLAY': ':0', 11:36:34 INFO - 'HOME': '/home/cltbld', 11:36:34 INFO - 'LANG': 'en_US.UTF-8', 11:36:34 INFO - 'LANGUAGE': 'en_US:en', 11:36:34 INFO - 'LOGNAME': 'cltbld', 11:36:34 INFO - 'MAIL': '/var/mail/cltbld', 11:36:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:36:34 INFO - 'MOZ_NO_REMOTE': '1', 11:36:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:36:34 INFO - 'NO_EM_RESTART': '1', 11:36:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:36:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:36:34 INFO - 'PWD': '/builds/slave/test', 11:36:34 INFO - 'SHELL': '/bin/bash', 11:36:34 INFO - 'SHLVL': '1', 11:36:34 INFO - 'TERM': 'linux', 11:36:34 INFO - 'TMOUT': '86400', 11:36:34 INFO - 'USER': 'cltbld', 11:36:34 INFO - 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1501871749.998862-157689734', 11:36:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:36:34 INFO - '_': '/tools/buildbot/bin/python'} 11:36:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:36:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:36:34 INFO - Running setup.py (path:/tmp/pip-zoTjFV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:36:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:36:34 INFO - Running setup.py (path:/tmp/pip-hG96Jy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:36:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:36:34 INFO - Running setup.py (path:/tmp/pip-CBz1_F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:36:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:36:34 INFO - Running setup.py (path:/tmp/pip-rQzIdD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:36:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:36:34 INFO - Running setup.py (path:/tmp/pip-MwjQ_f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:36:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:36:34 INFO - Running setup.py (path:/tmp/pip-xibp8K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:36:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:36:34 INFO - Running setup.py (path:/tmp/pip-D57lYg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:36:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:36:34 INFO - Running setup.py (path:/tmp/pip-qNgxtJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:36:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:36:35 INFO - Running setup.py (path:/tmp/pip-g2rLF1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:36:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:36:35 INFO - Running setup.py (path:/tmp/pip-AsJaqg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:36:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:36:35 INFO - Running setup.py (path:/tmp/pip-uHjZoC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:36:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:36:35 INFO - Running setup.py (path:/tmp/pip-MTP3Hu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:36:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:36:35 INFO - Running setup.py (path:/tmp/pip-_1JA_Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:36:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:36:35 INFO - Running setup.py (path:/tmp/pip-zn4fEb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:36:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:36:35 INFO - Running setup.py (path:/tmp/pip-82GTmT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:36:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:36:35 INFO - Running setup.py (path:/tmp/pip-vhrIWg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:36:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:36:35 INFO - Running setup.py (path:/tmp/pip-4FnmDO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:36:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:36:35 INFO - Running setup.py install for manifestparser 11:36:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:36:35 INFO - Running setup.py install for mozcrash 11:36:35 INFO - Running setup.py install for mozdebug 11:36:35 INFO - Running setup.py install for mozdevice 11:36:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:36:36 INFO - Running setup.py install for mozfile 11:36:36 INFO - Running setup.py install for mozhttpd 11:36:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:36:36 INFO - Running setup.py install for mozinfo 11:36:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:36:36 INFO - Running setup.py install for mozInstall 11:36:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:36:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:36:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:36:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:36:36 INFO - Running setup.py install for mozleak 11:36:36 INFO - Running setup.py install for mozlog 11:36:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:36:36 INFO - Running setup.py install for moznetwork 11:36:36 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:36:36 INFO - Running setup.py install for mozprocess 11:36:36 INFO - Running setup.py install for mozprofile 11:36:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:36:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:36:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:36:37 INFO - Running setup.py install for mozrunner 11:36:37 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:36:37 INFO - Running setup.py install for mozscreenshot 11:36:37 INFO - Running setup.py install for moztest 11:36:37 INFO - Running setup.py install for mozversion 11:36:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:36:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:36:37 INFO - Cleaning up... 11:36:37 INFO - Return code: 0 11:36:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:36:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 11:36:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:36:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 11:36:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:36:37 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/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 0x1afd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cc9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e6cd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e69eb0>, '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 0x1e6adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e6b240>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1501871749.998862-157689734', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:36:37 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/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:36:37 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/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:36:37 INFO - Using env: {'DISPLAY': ':0', 11:36:37 INFO - 'HOME': '/home/cltbld', 11:36:37 INFO - 'LANG': 'en_US.UTF-8', 11:36:37 INFO - 'LANGUAGE': 'en_US:en', 11:36:37 INFO - 'LOGNAME': 'cltbld', 11:36:37 INFO - 'MAIL': '/var/mail/cltbld', 11:36:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:36:37 INFO - 'MOZ_NO_REMOTE': '1', 11:36:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:36:37 INFO - 'NO_EM_RESTART': '1', 11:36:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:36:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:36:37 INFO - 'PWD': '/builds/slave/test', 11:36:37 INFO - 'SHELL': '/bin/bash', 11:36:37 INFO - 'SHLVL': '1', 11:36:37 INFO - 'TERM': 'linux', 11:36:37 INFO - 'TMOUT': '86400', 11:36:37 INFO - 'USER': 'cltbld', 11:36:37 INFO - 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1501871749.998862-157689734', 11:36:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:36:37 INFO - '_': '/tools/buildbot/bin/python'} 11:36:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:36:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:36:37 INFO - Running setup.py (path:/tmp/pip-ayN6GH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:36:37 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)) 11:36:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:36:37 INFO - Running setup.py (path:/tmp/pip-kq7Fp9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:36:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 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)) 11:36:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:36:37 INFO - Running setup.py (path:/tmp/pip-oAlbjA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:36:37 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)) 11:36:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:36:37 INFO - Running setup.py (path:/tmp/pip-sRS3g6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:36:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 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)) 11:36:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:36:38 INFO - Running setup.py (path:/tmp/pip-LsEyhY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:36:38 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)) 11:36:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:36:38 INFO - Running setup.py (path:/tmp/pip-2Q86tV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:36:38 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)) 11:36:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:36:38 INFO - Running setup.py (path:/tmp/pip-AaZXoO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:36:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 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)) 11:36:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:36:38 INFO - Running setup.py (path:/tmp/pip-eD3bJ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:36:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 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)) 11:36:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:36:38 INFO - Running setup.py (path:/tmp/pip-oWxqSa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:36:38 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)) 11:36:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:36:38 INFO - Running setup.py (path:/tmp/pip-eaNXsz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:36:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 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)) 11:36:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:36:38 INFO - Running setup.py (path:/tmp/pip-HLrAmu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:36:38 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)) 11:36:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:36:38 INFO - Running setup.py (path:/tmp/pip-qDm95Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:36:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 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)) 11:36:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:36:38 INFO - Running setup.py (path:/tmp/pip-ATCcbo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:36:38 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)) 11:36:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:36:38 INFO - Running setup.py (path:/tmp/pip-wwjCgL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:36:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 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)) 11:36:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:36:38 INFO - Running setup.py (path:/tmp/pip-mir3Rw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:36:38 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)) 11:36:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:36:38 INFO - Running setup.py (path:/tmp/pip-VmwCb8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:36:39 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 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)) 11:36:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:36:39 INFO - Running setup.py (path:/tmp/pip-AhZFEi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:36:39 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)) 11:36:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:36:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:36:39 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)) 11:36:39 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.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:36:39 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.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:36:39 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 11:36:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:36:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:36:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:36:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:36:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:36:40 INFO - Downloading blessings-1.6.tar.gz 11:36:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:36:40 INFO - Installing collected packages: blessings 11:36:40 INFO - Running setup.py install for blessings 11:36:40 INFO - Successfully installed blessings 11:36:40 INFO - Cleaning up... 11:36:40 INFO - Return code: 0 11:36:40 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:36:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:36:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:36:40 INFO - Reading from file tmpfile_stdout 11:36:40 INFO - Current package versions: 11:36:40 INFO - argparse == 1.2.1 11:36:40 INFO - blessings == 1.6 11:36:40 INFO - blobuploader == 1.2.4 11:36:40 INFO - docopt == 0.6.1 11:36:40 INFO - functools32 == 3.2.3-2 11:36:40 INFO - jsonschema == 2.5.1 11:36:40 INFO - manifestparser == 1.1 11:36:40 INFO - mozInstall == 1.13 11:36:40 INFO - mozcrash == 1.0 11:36:40 INFO - mozdebug == 0.1 11:36:40 INFO - mozdevice == 0.51 11:36:40 INFO - mozfile == 1.2 11:36:40 INFO - mozhttpd == 0.7 11:36:40 INFO - mozinfo == 0.10 11:36:40 INFO - mozleak == 0.1 11:36:40 INFO - mozlog == 3.5 11:36:40 INFO - moznetwork == 0.27 11:36:40 INFO - mozprocess == 0.25 11:36:40 INFO - mozprofile == 0.28 11:36:40 INFO - mozrunner == 6.13 11:36:40 INFO - mozscreenshot == 0.1 11:36:40 INFO - mozsystemmonitor == 0.3 11:36:40 INFO - moztest == 0.8 11:36:40 INFO - mozversion == 1.4 11:36:40 INFO - psutil == 3.1.1 11:36:40 INFO - requests == 1.2.3 11:36:40 INFO - wsgiref == 0.1.2 11:36:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:36:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 11:36:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:36:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 11:36:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:36:40 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/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 0x1afd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cc9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e6cd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e69eb0>, '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 0x1e6adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e6b240>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1501871749.998862-157689734', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:36:40 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/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 11:36:40 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/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:36:40 INFO - Using env: {'DISPLAY': ':0', 11:36:40 INFO - 'HOME': '/home/cltbld', 11:36:40 INFO - 'LANG': 'en_US.UTF-8', 11:36:40 INFO - 'LANGUAGE': 'en_US:en', 11:36:40 INFO - 'LOGNAME': 'cltbld', 11:36:40 INFO - 'MAIL': '/var/mail/cltbld', 11:36:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:36:40 INFO - 'MOZ_NO_REMOTE': '1', 11:36:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:36:40 INFO - 'NO_EM_RESTART': '1', 11:36:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:36:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:36:40 INFO - 'PWD': '/builds/slave/test', 11:36:40 INFO - 'SHELL': '/bin/bash', 11:36:40 INFO - 'SHLVL': '1', 11:36:40 INFO - 'TERM': 'linux', 11:36:40 INFO - 'TMOUT': '86400', 11:36:40 INFO - 'USER': 'cltbld', 11:36:40 INFO - 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1501871749.998862-157689734', 11:36:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:36:40 INFO - '_': '/tools/buildbot/bin/python'} 11:36:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:36:40 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)) 11:36:40 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)) 11:36:40 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)) 11:36:40 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)) 11:36:40 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)) 11:36:40 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)) 11:36:40 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)) 11:36:40 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)) 11:36:40 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)) 11:36:40 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 11:36:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:36:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:36:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:36:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:36:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 11:36:42 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)) 11:36:42 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)) 11:36:42 INFO - Installing collected packages: simplejson 11:36:42 INFO - Running setup.py install for simplejson 11:36:42 INFO - building 'simplejson._speedups' extension 11:36:42 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 11:36:42 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 11:36:43 INFO - Successfully installed simplejson 11:36:43 INFO - Cleaning up... 11:36:43 INFO - Return code: 0 11:36:43 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:36:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 11:36:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:36:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 11:36:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:36:43 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/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 0x1afd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cc9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e6cd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e69eb0>, '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 0x1e6adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e6b240>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1501871749.998862-157689734', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:36:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:36:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:36:43 INFO - Using env: {'DISPLAY': ':0', 11:36:43 INFO - 'HOME': '/home/cltbld', 11:36:43 INFO - 'LANG': 'en_US.UTF-8', 11:36:43 INFO - 'LANGUAGE': 'en_US:en', 11:36:43 INFO - 'LOGNAME': 'cltbld', 11:36:43 INFO - 'MAIL': '/var/mail/cltbld', 11:36:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:36:43 INFO - 'MOZ_NO_REMOTE': '1', 11:36:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:36:43 INFO - 'NO_EM_RESTART': '1', 11:36:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:36:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:36:43 INFO - 'PWD': '/builds/slave/test', 11:36:43 INFO - 'SHELL': '/bin/bash', 11:36:43 INFO - 'SHLVL': '1', 11:36:43 INFO - 'TERM': 'linux', 11:36:43 INFO - 'TMOUT': '86400', 11:36:43 INFO - 'USER': 'cltbld', 11:36:43 INFO - 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1501871749.998862-157689734', 11:36:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:36:43 INFO - '_': '/tools/buildbot/bin/python'} 11:36:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:36:43 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:36:43 INFO - Cleaning up... 11:36:43 INFO - Return code: 0 11:36:43 INFO - Running post-action listener: _resource_record_post_action 11:36:43 INFO - Running post-action listener: _start_resource_monitoring 11:36:43 INFO - Starting resource monitoring. 11:36:43 INFO - [mozharness: 2017-08-04 18:36:43.372248Z] Finished create-virtualenv step (success) 11:36:43 INFO - [mozharness: 2017-08-04 18:36:43.372758Z] Running install step. 11:36:43 INFO - Running pre-action listener: _resource_record_pre_action 11:36:43 INFO - Running main action method: install 11:36:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:36:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:36:43 INFO - Reading from file tmpfile_stdout 11:36:43 INFO - Detecting whether we're running mozinstall >=1.0... 11:36:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:36:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:36:43 INFO - Reading from file tmpfile_stdout 11:36:43 INFO - Output received: 11:36:43 INFO - Usage: mozinstall [options] installer 11:36:43 INFO - Options: 11:36:43 INFO - -h, --help show this help message and exit 11:36:43 INFO - -d DEST, --destination=DEST 11:36:43 INFO - Directory to install application into. [default: 11:36:43 INFO - "/builds/slave/test"] 11:36:43 INFO - --app=APP Application being installed. [default: firefox] 11:36:43 INFO - mkdir: /builds/slave/test/build/application 11:36:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:36:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 11:37:01 INFO - Reading from file tmpfile_stdout 11:37:01 INFO - Output received: 11:37:01 INFO - /builds/slave/test/build/application/firefox/firefox 11:37:01 INFO - Running post-action listener: _resource_record_post_action 11:37:01 INFO - [mozharness: 2017-08-04 18:37:01.567569Z] Finished install step (success) 11:37:01 INFO - [mozharness: 2017-08-04 18:37:01.567860Z] Running setup-mitmproxy step. 11:37:01 INFO - Running pre-action listener: _resource_record_pre_action 11:37:01 INFO - Running main action method: setup_mitmproxy 11:37:01 INFO - Skipping: mitmproxy is not required 11:37:01 INFO - Running post-action listener: _resource_record_post_action 11:37:01 INFO - [mozharness: 2017-08-04 18:37:01.569020Z] Finished setup-mitmproxy step (success) 11:37:01 INFO - [mozharness: 2017-08-04 18:37:01.569240Z] Running run-tests step. 11:37:01 INFO - Running pre-action listener: _resource_record_pre_action 11:37:01 INFO - Running pre-action listener: _set_gcov_prefix 11:37:01 INFO - Running main action method: run_tests 11:37:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:37:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:37:01 INFO - Python 2.7.3 11:37:01 INFO - Return code: 0 11:37:01 INFO - grabbing minidump binary from tooltool 11:37:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 11:37:01 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/linux64/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 0x1e69eb0>, '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 0x1e6adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e6b240>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:37:01 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/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 11:37:01 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/linux64/releng.manifest -o -c /builds/tooltool_cache 11:37:01 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/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 11:37:01 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:37:01 INFO - Return code: 0 11:37:01 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:37:01 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:37:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:37:01 INFO - ENV: RUST_BACKTRACE is now 1 11:37:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:37:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:37:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/drQOCkkKRTWm0xE2BJ2h7w/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-085', '--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 11:37:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/drQOCkkKRTWm0xE2BJ2h7w/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-085 --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 11:37:01 INFO - Using env: {'DISPLAY': ':0', 11:37:01 INFO - 'HOME': '/home/cltbld', 11:37:01 INFO - 'LANG': 'en_US.UTF-8', 11:37:01 INFO - 'LANGUAGE': 'en_US:en', 11:37:01 INFO - 'LOGNAME': 'cltbld', 11:37:01 INFO - 'MAIL': '/var/mail/cltbld', 11:37:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:37:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:37:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:37:01 INFO - 'MOZ_NO_REMOTE': '1', 11:37:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:37:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:37:01 INFO - 'NO_EM_RESTART': '1', 11:37:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:37:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:37:01 INFO - 'PWD': '/builds/slave/test', 11:37:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:37:01 INFO - 'RUST_BACKTRACE': '1', 11:37:01 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:37:01 INFO - 'SHELL': '/bin/bash', 11:37:01 INFO - 'SHLVL': '1', 11:37:01 INFO - 'TERM': 'linux', 11:37:01 INFO - 'TMOUT': '86400', 11:37:01 INFO - 'USER': 'cltbld', 11:37:01 INFO - 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1501871749.998862-157689734', 11:37:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:37:01 INFO - '_': '/tools/buildbot/bin/python'} 11:37:01 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/drQOCkkKRTWm0xE2BJ2h7w/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-085', '--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 11:37:01 INFO - mozversion application_buildid: 20170804171917 11:37:01 INFO - mozversion application_changeset: 357ef8a67e8893d91ec6716fb66f42031c34a14c 11:37:01 INFO - mozversion application_display_name: Nightly 11:37:01 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:37:01 INFO - mozversion application_name: Firefox 11:37:01 INFO - mozversion application_remotingname: firefox 11:37:01 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 11:37:01 INFO - mozversion application_vendor: Mozilla 11:37:01 INFO - mozversion application_version: 57.0a1 11:37:01 INFO - mozversion platform_buildid: 20170804171917 11:37:01 INFO - mozversion platform_changeset: 357ef8a67e8893d91ec6716fb66f42031c34a14c 11:37:01 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 11:37:01 INFO - mozversion platform_version: 57.0a1 11:37:01 INFO - using testdate: 1501871821 11:37:01 INFO - actual date: 1501871821 11:37:01 INFO - starting webserver on 'localhost:59518' 11:37:01 INFO - SUITE-START | Running 2 tests 11:37:01 INFO - TEST-START | dromaeo_css 11:37:01 INFO - Initialising browser for dromaeo_css test... 11:37:01 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:59518/getInfo.html -profile /tmp/tmphCWOFq/profile 11:37:01 INFO - TEST-INFO | started process 32629 (/builds/slave/test/build/application/firefox/firefox http://localhost:59518/getInfo.html) 11:37:07 INFO - TEST-INFO | 32629: exit 0 11:37:07 INFO - Browser initialized. 11:37:07 INFO - Running cycle 1/1 for dromaeo_css test... 11:37:07 INFO - TEST-INFO | started process 368 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphCWOFq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:37:08 INFO - PID 368 | 11:37:08 INFO - PID 368 | (/builds/slave/test/build/application/firefox/firefox:420): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:37:08 INFO - PID 368 | 11:37:18 INFO - PID 368 | RSS: Main: 162037760 11:37:18 INFO - PID 368 | 11:40:17 INFO - PID 368 | Cycle 1(1): loaded http://localhost:59518/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59518/tests/dromaeo/cssquery-ext.html) 11:40:18 INFO - PID 368 | RSS: Main: 166981632 11:40:18 INFO - PID 368 | 11:43:19 INFO - PID 368 | Cycle 1(1): loaded http://localhost:59518/tests/dromaeo/cssquery-ext.html (next: http://localhost:59518/tests/dromaeo/cssquery-jquery.html) 11:43:20 INFO - PID 368 | RSS: Main: 164442112 11:43:20 INFO - PID 368 | 11:46:22 INFO - PID 368 | Cycle 1(1): loaded http://localhost:59518/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59518/tests/dromaeo/cssquery-mootools.html) 11:46:22 INFO - PID 368 | RSS: Main: 166813696 11:46:22 INFO - PID 368 | 11:49:24 INFO - PID 368 | Cycle 1(1): loaded http://localhost:59518/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59518/tests/dromaeo/cssquery-prototype.html) 11:49:24 INFO - PID 368 | RSS: Main: 165355520 11:49:24 INFO - PID 368 | 11:52:28 INFO - PID 368 | Cycle 1(1): loaded http://localhost:59518/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59518/tests/dromaeo/cssquery-yui.html) 11:52:29 INFO - PID 368 | RSS: Main: 168017920 11:52:29 INFO - PID 368 | 11:55:30 INFO - PID 368 | Cycle 1(1): loaded http://localhost:59518/tests/dromaeo/cssquery-yui.html (next: http://localhost:59518/tests/dromaeo/cssquery-dojo.html) 11:55:30 INFO - PID 368 | RSS: Main: 167313408 11:55:30 INFO - PID 368 | 11:55:30 INFO - PID 368 | __start_tp_report 11:55:30 INFO - PID 368 | _x_x_mozilla_page_load 11:55:30 INFO - PID 368 | _x_x_mozilla_page_load_details 11:55:30 INFO - PID 368 | |i|pagename|runs| 11:55:30 INFO - PID 368 | |0;dojo.html;3461;3475.6350583188764;3515.7187425006;3531.682148606625;3539;6112.694365281729;6173.722182501787;6191.969040154793;6196.0705894115845;6196.690165491725;6109.14471973924;6124.356942521038;6163.137160797492;6180.289266734327;6189.226346706661;5393;5403.189521571766;5419.83740487786;5424.294841670578;5437.401885792559;5443.673379597237;5463.672179669213;5476.698781567012;5482.616216864821;5498.3127109111365;5519.116941289394;5526.972365138189;5538.0585300498815;5562.082256427685;5563;5412.377576578704;5496.697681627529;5504.2294078829;5553.361363443195;5579.358373786985;5313.840584782462;5363.624546281723;5365.06111430502;5396.83809485716;5431.375391829951;5533.22534845122;5921.703914804242;6065.8180254592435;6070.423309785563;6184.412480814315;6665;6691.76578819739;6750.683616694747;6754.121964144679;6767.35710107539;6709.463242940553;6758;6761.661916904184;6777.525573209878;6840.486963477759;6229.2836323822885;6235.781747638856;6237.220347456568;6243.469305109071;6252.437280644764;6861;6861.416779573692;6872.553284036521;6874.346937040973;6887.414569761526;6506.479481641552;6578.605283682994;6589.17635295588;6598.73605055802;6599.307072757388;6653.833654158588;6710.597364158166;6711.463082953352;6719.932800672029;6720.32796720324;5776.249087618583;6635.535512514174;6639.634820084942;6721.462283017347;6739.123913891162;6670.332966703291;6692.364225398579;6750.392464678104;6754.932450675528;6762.459003279726;4757.524247575215;4863.8540843774745;4884.242942343943;4885.65800393969;4928.457869634337;4360.498542667634;4382.342648602735;4416.33754936762;4439.023414848728;4488.798004089824;6337.936620633827;6375.4262116409745;6377.266614339411;6448.322926092693;6451.677416129175;6717.932820671828;6723.428508576728;6752.122224110834;6813.591184528944;6859.211190713032;6428.678566071678;6472.35276472349;6487;6487.578307410097;6494.837629059217;5474.39781624021;5551;5560;5560.944390556124;5623.409541998113;7162.534435261796;7169.996200531826;7171.605561694157;7180.5691658500655;7192.496525243288;6760.357766012221;6769.661516924036;6779.694913728796;6811.9659401702675;6813.761518346834;7053.964730176316;7059.576425414286;7117.715291388494;7126.394256488256;7209.747658831916;6632.502562307943;6657.73369065232;6662.367075127855;6729.057931889637;6733.93266067333;6622.4702023838945;6730.93269067303;6768.763093291711;6811.386975172259;6865.965670171618;6595.241547222131;6639.468842492685;6641.203055633355;6659.866802664016;6667.166604174478;6484.286728459771;6546.509011824037;6562.048502966947;6572.80281591553;6636.170478690164;6501.08984742127;6529.640869752209;6600.306967768507;6600.735970561316;6630.336966303331;6532.660804535154;6549.115869357766;6594.076829243813;6597.175353080865;6622.470202383702;6326.557141000086;6340.49276057905;6401.3598640135615;6418.133551970611;6439.935600643934 11:55:30 INFO - PID 368 | |1;ext.html;890.6975468414149;920.6455514626866;938.704308142935;966.9758256043598;968.869202657641;42018.57981420189;43038.569614303844;43040.78479607601;43048;43104;40309.7984510077;40439;40560.18879622406;40596.39105413421;40639.59360406395;6789.2531821499715;6900.413464855468;6905.067815844872;6908.689108990107;6909.447244220475;6770.593764374129;6881;6899.931000690004;6918.135233095863;6936.0636314097455;6892.758753443631;6898.655067246643;6902.17173939128;6913.20498142715;6950.930490695104;6851.383375496204;6871;6879.277675844014;6880.655967201645;6894.517383783137;6374.362563743635;6379.234491861006;6383.808485745435;6405.29541750407;6411.198600174978;35732;35759.4636080459;35842.641573584195;35962.82018589917;35992.82003589992;3301.9339613207603;3310.470324748029;3315.8342082896;3329.284203896174;3337.8664853405835;28237.576436353473;28411.71588284132;28417;28454.146375608765;28471;4496.797644106023;4547.340635607851;4551.998560316725;4558.566936141061;4601.309803529464;208112;209335;209545;209618;209724;23633.881830590737;23807.7619223809;23829;23841.04635814548;23843.40391490192;24407.877960610083;24427;24612.138575149784;24638.87680561586;24648.753512464646;13764;13844;13903.582892513241;13905.096168749;13912.652183695287;13629.182249065088;13647.454101836014;13680.452781888613;13724.519641812489;13729.519466818614;6273.466755325757;6273.560850740496;6301.180846489927;6310.873782524415;6379.266384365765;2619.6725409323835;2625.2911713837157;2631.6184153297663;2643.458091091322;2654.9867250663624;1064.6007747094839;1090.4711215060688;1092.748667806409;1099.912007039435;1102.4322473925934;24984.375390615016;25110.623340649905;25184;25195.748042519706;25381.238562842776;1202.3026644546142;1203.524607779922;1207.7222238885106;1210.9091818113677;1224.3878060969516;13156.539521116714;13389.799153012713;13546.796798048037;13556.389962451713;13659.248741319323;260498;260530;260542;261360;262223;57003.14495282574;57012;57131.71434142886;57226.42773572211;61183;1471.6835880285576;1512.9319180636899;1521.710874933759;1523.169872419534;1525;29973;30373.544396833622;30432.543511847784;30543;30994.845025774728;40601;41030.1793964125;41112.1777564453;41118.177636447705;41134.794326028175;215374;217650;218226;218671;218806;32824.34351313008;33584.66415335913;33919.491207631414;33944.830275848464;33957.32085358328;45029.774851125534;45812.54187458083;46126.769366152956;46250.30624540567;46330.30504542502;33547.329053419286;33911.66088339085;34000.63997440174;34075.31849363048;34312.48531271983;33466;33632.15919602029;34084.82957585196;34157.65842341545;34163.48754768631;39158;39213.2157356857;39471.605283946796;39598.2080358397;39729.60270397259;35089.64910350966;35138.648613513535;35731.10672233111;35876;36166.457503138;26312.4737505245;34280.657193427745;34299.65700343064;34416.483752743225;34505.654943450245 11:55:30 INFO - PID 368 | |2;jquery.html;566.9489745922867;573.3664300947453;580.1413907417025;584.5820238529451;596.0701305962699;23377.883110584444;23505.29484115475;24155.39611509713;24158.879205603993;24268.8786556067;26985.32536686579;27969.440611187765;28006;28021.719782802167;28024.159275221777;5815.098659707752;6095.238095238106;6193.752249909998;6218.31598524162;6221.408966148231;6252.624842509441;6270.811875643738;6285.088662143987;6285.560010799246;6289.496840252768;6247.344028876971;6251.906221406683;6254.030625253093;6258.06129080637;6259.342769009257;6253.8123856284155;6254.718537665816;6255.280642726077;6261.27995280544;6261.998080307175;5836.533077353802;5837.182794408786;5843.474087332118;5845.09401042839;5846.50304724099;30168.166639212996;30885.536716949264;31212.68787312143;31466.37067258642;31603.20991975196;2284.920027799036;2324.2678556254896;2325.2559181062065;2326.5695846268495;2330.766923307656;20314.796852031584;20705.68941465879;20935.581288374146;20943.790562094488;20948.581028379347;2422.6123820188864;2431.55016321981;2459.5449841779327;2510.9874450627813;2524.394145405108;161140.19429902892;164421;164592;165083;165969;15570;15893.602659933595;16128.435504757277;16762.74855877163;16903;24806.5038699225;24811.25566233016;24931.252062438154;24938.501229975664;25042.499150016898;10826.18803589734;10878.238523303451;10934.234603577674;11019.228653994143;11364.829527557093;9356.204722598519;9750.609975600897;9750.75623109428;9805.264605154642;10047.24645651579;9917.256205784595;9920.900790992142;10051.69844904654;10052.145567626687;10247.538860751283;2795.5044051432387;2839.432113577293;2885.495038368277;2904.564315352714;2973.7769667274606;1066.898644628759;1081.5781845080426;1090.6400887707039;1103.0679076180616;1119.5018216893568;22097.558048839255;26384.472310554065;27140.864295678395;28314.292142696184;28528.28679282993;1154.6593754842343;1166.3643314393676;1170.9414529273502;1171.3967306836985;1176.353005846781;12232.633021009384;12728.363581820871;12763.361831908367;12801.911837493917;12809.295488748208;620530;620574;621252;637536;638371;135791;137828;139772;141661;141835.45411364798;1319.6568892088126;1402.4670625162578;1405.5642750747097;1406.289823639076;1408.978865317021;23091.076356945534;23340.183093591644;23353.41616459602;23393.649095263925;23685.64471532894;60858.69570652118;61172;61260.38739612725;62586.68706656437;63567;74912.62543687246;75759;75898;76427.61786191033;76433.61783191048;13140.145890517086;13553.25457099869;15298.388064477296;15393.76909346383;15947.202639868192;23463.413414664086;23675.40811479727;23853.642195366738;24009.159679411834;24477.755222447548;19577.31479398271;19992.20031198736;20018.299359522345;20078.297259595845;20263.392098237076;18022.65705458282;18468.81531184671;18553;18821.717674234624;19314.613707725486;20715.378538643865;21428.464288392915;21747.347579572637;21780;21916.671249930943;15555.611109722347;15568.844311557192;15592.298346574658;15613.375464981727;15775.605609859846;20468.181272748923;20609.58780824405;20670.689939651216;20693.068811903802;20763.480912977295 11:55:30 INFO - PID 368 | |3;mootools.html;1401.1803095189314;1433.3549902543857;1441.7476941535228;1441.8774404175645;1494.7458931981566;15155.166465844373;15715.528534143965;15755.842441575582;15759.290831912576;15765.132917689523;15119.773203401957;16081.597960050975;16096.275667594957;16112.677746445064;16123.677526449464;2675.4916565852473;2737.5209338365808;2737.685166205882;2738.945221095577;2741.2461573067367;2605.153325169318;2621.6985046719587;2655.2698008047746;2715.5247831629486;2717.4565086982584;2694.528457519926;2707.539718247893;2719.3745438549145;2719.9320016999636;2720.8095433319677;2472.5178590174924;2474.505098980202;2515.0945659562544;2518.546661600911;2522.495500899827;2655.150351887397;2673.5454972654697;2679.9866000670067;2724.6049322848075;2735.86320683967;15394.384224631001;15475;15475.071495710294;15493.845061549353;15498.5350439487;8042.155573664798;8337.541435221061;8359.540225287607;8360.163983601651;8367;4916.778744956449;5113.795448182068;5165.173572228463;5235.188545775411;5237.266782650432;1987.4037788663488;2003.4790954351827;2010.788867168941;2019.4951262184454;2046.334941144134;26538;26599.138060335783;26627.866860665574;26647.467050658877;26816.865915670493;6750.898736518956;6752.797416077526;6810.897836532456;6967.965160174167;6982.685779139951;18161.818381816014;18179.091045447676;18186.909065454587;18194.090295485174;18207.908960455377;8092.71675491355;8264.628091735887;8280.875786863202;8298.792530186673;8298.958505207556;7644.350230230381;7644.923550764421;7739.419543534257;7749.070111586646;7752.147263800977;5180.663256888291;5303.496167864047;5349;5382.573617991236;5407.080796264644;1371.8079468874366;1409.0840953380384;1439.8704116629553;1499.3477837140879;1518.8329283778776;914.6295750221171;919.2186641354795;929.716436486878;934.7336009237334;935.7426707655313;8339.958300208582;8619.224269815746;9001.684941027164;9216.308776841764;9345.878494580558;994.164901482758;1005.1657124586576;1005.6681295172575;1008.5159123620704;1041.4116024446164;5054.898902022012;5137.9743101285;5217.739113044333;5386.13821788512;5419.403865574784;21557.24549640755;21705.67441488379;21724;22382.776172238395;22474.213402530833;21581.892090539448;22094.558108838053;22154.446138846335;22286.442838928833;22448.551028979327;12104.757904841854;12289.446974886152;12339.07456940715;12439.813402798965;12581.93709031449;7926.167752385916;7935.1271360151495;8040.959795200986;8051.114377418362;8157;18950.336738214097;19260.903695481433;19392.515187120436;19659.311924082587;20011.199552017755;19274.32539861098;19744.703829442282;19866.701999470308;19909.203631855144;20074;12551.87448125507;12658.810117848056;12809.103362764517;12833.550825721055;12889.355532223539;14152.78770818418;14305.856941430453;14341.92829035848;14348;14348.928255358656;11083.778324433628;11119.499622517167;11188.328700278009;11209.663710088711;11302.886971130183;11473.82789258145;11489.482973266391;11562.653120406065;11607;11755.706107347043;9723.46520941355;9733.56198971062;9771.85342219853;9777.706668799947;9781.070798274153;7350.3384695375535;7425.7029718810645;7450.913744151646;7464.6267686614365;7529.284717951786;7613.428992825671;7633.503822251536;7664.386849052174;7668.57822819728;7784.494007889469 11:55:30 INFO - PID 368 | |4;prototype.html;514.9665271757336;516.4860963341473;542.2300333526392;550.4605486623107;557.3395526301333;5949.553783466246;5979.860573199073;5993.910091348628;6100.359462256461;6145.815625531236;5998.370171132034;6000.579959402833;6044.455998960093;6070.453659170674;6091.086337049444;4746.833860814872;4761.738104404257;4778.880527986802;4781.235002399617;4803.423589169304;4611.262198048313;4701.215521505187;4735.147673418784;4763.118823017736;4789.808407663707;4693.342931989524;4736.100140973222;4739.478657347706;4802.927956080662;4809.759512024402;4707.8587642370785;4734.857954261361;4762.714237145782;4772.498887616785;4787.473377928425;4368;4371.846985355529;4372.1255748850035;4383;4395.758233297167;6021.42796434338;6023.789167379121;6032.45707886288;6042.214512113397;6049.9697501512655;5663.7451314690525;5698.487136157724;5727.255456790591;5734.512566431858;5790.507806836424;6481.64350960697;6522.412982831568;6536.93463065368;6539.738410463576;6557.540972131953;4931.630127740434;4957.429895562021;4977.7262250576205;4991.376077990251;5007.749612519396;6843.281455447156;6844.486663500257;6853.280405557444;6882.552634078769;6889;5117.2068329409;5121.436641969381;5122.257272695439;5122.948770512247;5141.408737995103;5160.225966105039;5180.922286165635;5190.273361729361;5206.140986737221;5235;5702.914456283159;5706.971465142731;5715.31416230055;5737.311522617312;5777.3933736957015;6291.779787707408;6453.548251622341;6465.676716164173;6569.441597464173;6571.67141642916;1729.2132079903613;1846.3445476855522;1918.932837350714;1920.2511020701938;1928.3347245200384;1431.7279716853764;1432.8710416062395;1442.697033622951;1455.8107446032159;1475.5499572630235;6092.659614884718;6162.691865406801;6172.5679202456295;6229.626222426669;6241.126242326078;6601.3728695773825;6720.731170753213;6721.462283017347;6744.6627668616375;6797.776400248003;6244.46922011625;6253.843653908598;6276.560640755103;6286.465650419674;6321.968390158112;3523.7533372663665;3541.628129046413;3578.5169002184894;3587.318409502186;3598.8123919106633;7129.3583577478275;7131.643417829192;7156.427485801123;7171.426285897116;7187.712491500281;6849.383555480031;6900.171979362509;6942.132233470817;6952.443804495628;6978.406835419046;7039.577625342496;7073.61095139762;7118.216996130422;7137.321954414426;7172.175199851979;6731.158605174353;6743;6746.190457145174;6750.32496750321;6788.9660551696925;6671.366220209073;6685.565438246498;6687.364700353459;6711.530192886451;6719.596824190564;7085.14978202619;7093.716251349888;7098.964505177441;7107.218205997439;7112.359887609933;5107.540321371094;5112.36095488064;5130.204818253177;5146.433892271922;5160.664556803796;6498.512611554247;6610.735570577315;6678.565893216925;6916.757913473004;6925.896111558432;6272.905906411316;6445.838854028687;6456.54804163704;6477.190351206099;6516.804495865132;6470.935290647033;6475.902861457176;6527.967360163168;6531.836704082436;6569.704363303758;6430;6434.388733070351;6488.351164883663;6515.73937042532;6578.217524923284;6514.804555863332;6569;6637.236717777518;6666.300038495888;6668.466522678077;6395.20059992501;6402.295747467868;6431.742730290736;6462.967685161544;6498.252700939453 11:55:30 INFO - PID 368 | |5;yui.html;928.7074571509974;935.3031991166586;957.7844984878403;959.0697023886827;959.405168795347;18590.721139182908;19884.40346789597;19885.701714474293;19985;21614;19160.904195479005;21348.4662883428;21650.89174554129;21668.566628667457;21692.56614867702;1064.5794911010146;1068.6526878764414;1073.8765042020189;1075.2526993739355;1075.9515821788038;1054.804861100695;1063.8191507443753;1078.396098185015;1078.573963284502;1079.0288740133865;1140.3556990300494;1144.2162118948547;1148.8908553687386;1148.9597864074758;1159.91300652451;1124.8706398764166;1139.242403801471;1141.8972292493715;1145.7937571237173;1149.2127892393696;836.9748907532784;841.4278290762279;843.1989609870648;843.2621456225802;845.9974929708316;18662.626747464976;18725.344612938618;18842.90578547112;19809;20114;22379.440513987116;22439.77560224393;22638.66042009371;22774;22952.42618934523;16587.170641467877;16778.580535486588;16796.076215808127;16946.661066778717;16951.152442377956;3735.2156047230114;3744.5132132822832;3746.9437958430644;3757.5490941086973;3759.0978165240144;144083;144744;146418;146847;148017.2599137008;17054.232559534852;17454.389096381565;17473.56316092108;17628.735568966476;17633.206505707272;31678.524822127685;33022.50466243008;33937.32125357528;33982.81060162882;34061.48907766386;7751.961240193876;8078.515289082674;9471.810563788686;9694.75763105928;9697.660581879742;3568.803715795656;4458.687891847604;4624.329472226508;4633.027064316464;4650.279206722963;5629.211910332475;5639.210510528529;5700.885982280414;5728.198052272685;5728.79949201776;1115.7656892052598;1116.8380584815156;1128.074978517624;1130.9151813614012;1132.1452303510962;720.9891851622125;732.7948174511146;736.9484136110528;748.9325960663566;761.9923800762032;12148.817767733492;12618.684532886751;12951.417186226643;13161;13304.534341298007;731.9085114360705;732.1507051819864;737.2921994884971;749.2395218852869;751.8045308219793;5570.554355651539;5581.916271255935;5619.072852979212;5678.744456499468;5781.277340332458;129062.35468822595;129320;131495;132086;138949;116259;116328.41835790937;117375;118271;118472.40763796298;90266;94703;95000.52499737457;95700.52149739346;96296.51851740696;10993.725156871142;10997.285176463503;11099.278546894426;11119.221654484432;11497.655070347902;49691;50202.74898625483;50375;50627;52109;62400.687996559725;63086.36913630805;63497.36502634914;63618.36381636124;63742.68128659327;14255.215963122128;14624.70750584961;14642;14660.340284687001;14708.632284192981;16972.575685607957;17128.40050598223;17276.913615432346;20271.391858244275;20822.583548328646;19324.227030918606;19393.418197453535;20001.199952001756;20114.798852011292;20194.59610807805;18594.2562297512;18774.342897998504;19362.709559356903;19444.513887152934;19555.902220488806;19561.21755129836;19573.217071316987;19754.308599198957;19930;19958.800411996275;12109.75780484403;12475.563355282522;12498.75002499963;12627.242365458102;13353.198808071547;14659.340329685403;14845.035072720239;14989.850101498845;15134.243287835785;15142.697146056797 11:55:30 INFO - PID 368 | __end_tp_report 11:55:30 INFO - PID 368 | __start_cc_report 11:55:30 INFO - PID 368 | _x_x_mozilla_cycle_collect,334 11:55:30 INFO - PID 368 | __end_cc_report 11:55:30 INFO - PID 368 | __startTimestamp1501872930823__endTimestamp 11:55:30 INFO - PID 368 | 11:55:30 INFO - PID 368 | ------- Summary: start ------- 11:55:30 INFO - PID 368 | Number of tests: 6 11:55:30 INFO - PID 368 | 11:55:30 INFO - PID 368 | [#0] dojo.html Cycles:165 Average:6180.33 Median:6501.09 stddev:804.74 (12.4%) stddev-sans-first:778.42 11:55:30 INFO - PID 368 | Values: 3461.0 3475.6 3515.7 3531.7 3539.0 6112.7 6173.7 6192.0 6196.1 6196.7 6109.1 6124.4 6163.1 6180.3 6189.2 5393.0 5403.2 5419.8 5424.3 5437.4 5443.7 5463.7 5476.7 5482.6 5498.3 5519.1 5527.0 5538.1 5562.1 5563.0 5412.4 5496.7 5504.2 5553.4 5579.4 5313.8 5363.6 5365.1 5396.8 5431.4 5533.2 5921.7 6065.8 6070.4 6184.4 6665.0 6691.8 6750.7 6754.1 6767.4 6709.5 6758.0 6761.7 6777.5 6840.5 6229.3 6235.8 6237.2 6243.5 6252.4 6861.0 6861.4 6872.6 6874.3 6887.4 6506.5 6578.6 6589.2 6598.7 6599.3 6653.8 6710.6 6711.5 6719.9 6720.3 5776.2 6635.5 6639.6 6721.5 6739.1 6670.3 6692.4 6750.4 6754.9 6762.5 4757.5 4863.9 4884.2 4885.7 4928.5 4360.5 4382.3 4416.3 4439.0 4488.8 6337.9 6375.4 6377.3 6448.3 6451.7 6717.9 6723.4 6752.1 6813.6 6859.2 6428.7 6472.4 6487.0 6487.6 6494.8 5474.4 5551.0 5560.0 5560.9 5623.4 7162.5 7170.0 7171.6 7180.6 7192.5 6760.4 6769.7 6779.7 6812.0 6813.8 7054.0 7059.6 7117.7 7126.4 7209.7 6632.5 6657.7 6662.4 6729.1 6733.9 6622.5 6730.9 6768.8 6811.4 6866.0 6595.2 6639.5 6641.2 6659.9 6667.2 6484.3 6546.5 6562.0 6572.8 6636.2 6501.1 6529.6 6600.3 6600.7 6630.3 6532.7 6549.1 6594.1 6597.2 6622.5 6326.6 6340.5 6401.4 6418.1 6439.9 11:55:30 INFO - PID 368 | 11:55:30 INFO - PID 368 | [#1] ext.html Cycles:180 Average:38618.81 Median:34037.98 stddev:60101.65 (176.6%) stddev-sans-first:60203.49 11:55:30 INFO - PID 368 | Values: 890.7 920.6 938.7 967.0 968.9 42018.6 43038.6 43040.8 43048.0 43104.0 40309.8 40439.0 40560.2 40596.4 40639.6 6789.3 6900.4 6905.1 6908.7 6909.4 6770.6 6881.0 6899.9 6918.1 6936.1 6892.8 6898.7 6902.2 6913.2 6950.9 6851.4 6871.0 6879.3 6880.7 6894.5 6374.4 6379.2 6383.8 6405.3 6411.2 35732.0 35759.5 35842.6 35962.8 35992.8 3301.9 3310.5 3315.8 3329.3 3337.9 28237.6 28411.7 28417.0 28454.1 28471.0 4496.8 4547.3 4552.0 4558.6 4601.3 208112.0 209335.0 209545.0 209618.0 209724.0 23633.9 23807.8 23829.0 23841.0 23843.4 24407.9 24427.0 24612.1 24638.9 24648.8 13764.0 13844.0 13903.6 13905.1 13912.7 13629.2 13647.5 13680.5 13724.5 13729.5 6273.5 6273.6 6301.2 6310.9 6379.3 2619.7 2625.3 2631.6 2643.5 2655.0 1064.6 1090.5 1092.7 1099.9 1102.4 24984.4 25110.6 25184.0 25195.7 25381.2 1202.3 1203.5 1207.7 1210.9 1224.4 13156.5 13389.8 13546.8 13556.4 13659.2 260498.0 260530.0 260542.0 261360.0 262223.0 57003.1 57012.0 57131.7 57226.4 61183.0 1471.7 1512.9 1521.7 1523.2 1525.0 29973.0 30373.5 30432.5 30543.0 30994.8 40601.0 41030.2 41112.2 41118.2 41134.8 215374.0 217650.0 218226.0 218671.0 218806.0 32824.3 33584.7 33919.5 33944.8 33957.3 45029.8 45812.5 46126.8 46250.3 46330.3 33547.3 33911.7 34000.6 34075.3 34312.5 33466.0 33632.2 34084.8 34157.7 34163.5 39158.0 39213.2 39471.6 39598.2 39729.6 35089.6 35138.6 35731.1 35876.0 36166.5 26312.5 34280.7 34299.7 34416.5 34505.7 11:55:30 INFO - PID 368 | 11:55:30 INFO - PID 368 | [#2] jquery.html Cycles:180 Average:41240.36 Median:23484.35 stddev:105309.96 (448.4%) stddev-sans-first:105561.11 11:55:30 INFO - PID 368 | Values: 566.9 573.4 580.1 584.6 596.1 23377.9 23505.3 24155.4 24158.9 24268.9 26985.3 27969.4 28006.0 28021.7 28024.2 5815.1 6095.2 6193.8 6218.3 6221.4 6252.6 6270.8 6285.1 6285.6 6289.5 6247.3 6251.9 6254.0 6258.1 6259.3 6253.8 6254.7 6255.3 6261.3 6262.0 5836.5 5837.2 5843.5 5845.1 5846.5 30168.2 30885.5 31212.7 31466.4 31603.2 2284.9 2324.3 2325.3 2326.6 2330.8 20314.8 20705.7 20935.6 20943.8 20948.6 2422.6 2431.6 2459.5 2511.0 2524.4 161140.2 164421.0 164592.0 165083.0 165969.0 15570.0 15893.6 16128.4 16762.7 16903.0 24806.5 24811.3 24931.3 24938.5 25042.5 10826.2 10878.2 10934.2 11019.2 11364.8 9356.2 9750.6 9750.8 9805.3 10047.2 9917.3 9920.9 10051.7 10052.1 10247.5 2795.5 2839.4 2885.5 2904.6 2973.8 1066.9 1081.6 1090.6 1103.1 1119.5 22097.6 26384.5 27140.9 28314.3 28528.3 1154.7 1166.4 1170.9 1171.4 1176.4 12232.6 12728.4 12763.4 12801.9 12809.3 620530.0 620574.0 621252.0 637536.0 638371.0 135791.0 137828.0 139772.0 141661.0 141835.5 1319.7 1402.5 1405.6 1406.3 1409.0 23091.1 23340.2 23353.4 23393.6 23685.6 60858.7 61172.0 61260.4 62586.7 63567.0 74912.6 75759.0 75898.0 76427.6 76433.6 13140.1 13553.3 15298.4 15393.8 15947.2 23463.4 23675.4 23853.6 24009.2 24477.8 19577.3 19992.2 20018.3 20078.3 20263.4 18022.7 18468.8 18553.0 18821.7 19314.6 20715.4 21428.5 21747.3 21780.0 21916.7 15555.6 15568.8 15592.3 15613.4 15775.6 20468.2 20609.6 20670.7 20693.1 20763.5 11:55:30 INFO - PID 368 | 11:55:30 INFO - PID 368 | [#3] mootools.html Cycles:180 Average:9612.34 Median:14579.85 stddev:6882.21 (47.2%) stddev-sans-first:6873.87 11:55:30 INFO - PID 368 | Values: 1401.2 1433.4 1441.7 1441.9 1494.7 15155.2 15715.5 15755.8 15759.3 15765.1 15119.8 16081.6 16096.3 16112.7 16123.7 2675.5 2737.5 2737.7 2738.9 2741.2 2605.2 2621.7 2655.3 2715.5 2717.5 2694.5 2707.5 2719.4 2719.9 2720.8 2472.5 2474.5 2515.1 2518.5 2522.5 2655.2 2673.5 2680.0 2724.6 2735.9 15394.4 15475.0 15475.1 15493.8 15498.5 8042.2 8337.5 8359.5 8360.2 8367.0 4916.8 5113.8 5165.2 5235.2 5237.3 1987.4 2003.5 2010.8 2019.5 2046.3 26538.0 26599.1 26627.9 26647.5 26816.9 6750.9 6752.8 6810.9 6968.0 6982.7 18161.8 18179.1 18186.9 18194.1 18207.9 8092.7 8264.6 8280.9 8298.8 8299.0 7644.4 7644.9 7739.4 7749.1 7752.1 5180.7 5303.5 5349.0 5382.6 5407.1 1371.8 1409.1 1439.9 1499.3 1518.8 914.6 919.2 929.7 934.7 935.7 8340.0 8619.2 9001.7 9216.3 9345.9 994.2 1005.2 1005.7 1008.5 1041.4 5054.9 5138.0 5217.7 5386.1 5419.4 21557.2 21705.7 21724.0 22382.8 22474.2 21581.9 22094.6 22154.4 22286.4 22448.6 12104.8 12289.4 12339.1 12439.8 12581.9 7926.2 7935.1 8041.0 8051.1 8157.0 18950.3 19260.9 19392.5 19659.3 20011.2 19274.3 19744.7 19866.7 19909.2 20074.0 12551.9 12658.8 12809.1 12833.6 12889.4 14152.8 14305.9 14341.9 14348.0 14348.9 11083.8 11119.5 11188.3 11209.7 11302.9 11473.8 11489.5 11562.7 11607.0 11755.7 9723.5 9733.6 9771.9 9777.7 9781.1 7350.3 7425.7 7450.9 7464.6 7529.3 7613.4 7633.5 7664.4 7668.6 7784.5 11:55:30 INFO - PID 368 | 11:55:30 INFO - PID 368 | [#4] prototype.html Cycles:180 Average:5576.87 Median:6154.25 stddev:1574.91 (25.6%) stddev-sans-first:1532.81 11:55:30 INFO - PID 368 | Values: 515.0 516.5 542.2 550.5 557.3 5949.6 5979.9 5993.9 6100.4 6145.8 5998.4 6000.6 6044.5 6070.5 6091.1 4746.8 4761.7 4778.9 4781.2 4803.4 4611.3 4701.2 4735.1 4763.1 4789.8 4693.3 4736.1 4739.5 4802.9 4809.8 4707.9 4734.9 4762.7 4772.5 4787.5 4368.0 4371.8 4372.1 4383.0 4395.8 6021.4 6023.8 6032.5 6042.2 6050.0 5663.7 5698.5 5727.3 5734.5 5790.5 6481.6 6522.4 6536.9 6539.7 6557.5 4931.6 4957.4 4977.7 4991.4 5007.7 6843.3 6844.5 6853.3 6882.6 6889.0 5117.2 5121.4 5122.3 5122.9 5141.4 5160.2 5180.9 5190.3 5206.1 5235.0 5702.9 5707.0 5715.3 5737.3 5777.4 6291.8 6453.5 6465.7 6569.4 6571.7 1729.2 1846.3 1918.9 1920.3 1928.3 1431.7 1432.9 1442.7 1455.8 1475.5 6092.7 6162.7 6172.6 6229.6 6241.1 6601.4 6720.7 6721.5 6744.7 6797.8 6244.5 6253.8 6276.6 6286.5 6322.0 3523.8 3541.6 3578.5 3587.3 3598.8 7129.4 7131.6 7156.4 7171.4 7187.7 6849.4 6900.2 6942.1 6952.4 6978.4 7039.6 7073.6 7118.2 7137.3 7172.2 6731.2 6743.0 6746.2 6750.3 6789.0 6671.4 6685.6 6687.4 6711.5 6719.6 7085.1 7093.7 7099.0 7107.2 7112.4 5107.5 5112.4 5130.2 5146.4 5160.7 6498.5 6610.7 6678.6 6916.8 6925.9 6272.9 6445.8 6456.5 6477.2 6516.8 6470.9 6475.9 6528.0 6531.8 6569.7 6430.0 6434.4 6488.4 6515.7 6578.2 6514.8 6569.0 6637.2 6666.3 6668.5 6395.2 6402.3 6431.7 6463.0 6498.3 11:55:30 INFO - PID 368 | 11:55:30 INFO - PID 368 | [#5] yui.html Cycles:180 Average:25970.24 Median:19567.22 stddev:37286.82 (190.6%) stddev-sans-first:37344.01 11:55:30 INFO - PID 368 | Values: 928.7 935.3 957.8 959.1 959.4 18590.7 19884.4 19885.7 19985.0 21614.0 19160.9 21348.5 21650.9 21668.6 21692.6 1064.6 1068.7 1073.9 1075.3 1076.0 1054.8 1063.8 1078.4 1078.6 1079.0 1140.4 1144.2 1148.9 1149.0 1159.9 1124.9 1139.2 1141.9 1145.8 1149.2 837.0 841.4 843.2 843.3 846.0 18662.6 18725.3 18842.9 19809.0 20114.0 22379.4 22439.8 22638.7 22774.0 22952.4 16587.2 16778.6 16796.1 16946.7 16951.2 3735.2 3744.5 3746.9 3757.5 3759.1 144083.0 144744.0 146418.0 146847.0 148017.3 17054.2 17454.4 17473.6 17628.7 17633.2 31678.5 33022.5 33937.3 33982.8 34061.5 7752.0 8078.5 9471.8 9694.8 9697.7 3568.8 4458.7 4624.3 4633.0 4650.3 5629.2 5639.2 5700.9 5728.2 5728.8 1115.8 1116.8 1128.1 1130.9 1132.1 721.0 732.8 736.9 748.9 762.0 12148.8 12618.7 12951.4 13161.0 13304.5 731.9 732.2 737.3 749.2 751.8 5570.6 5581.9 5619.1 5678.7 5781.3 129062.4 129320.0 131495.0 132086.0 138949.0 116259.0 116328.4 117375.0 118271.0 118472.4 90266.0 94703.0 95000.5 95700.5 96296.5 10993.7 10997.3 11099.3 11119.2 11497.7 49691.0 50202.7 50375.0 50627.0 52109.0 62400.7 63086.4 63497.4 63618.4 63742.7 14255.2 14624.7 14642.0 14660.3 14708.6 16972.6 17128.4 17276.9 20271.4 20822.6 19324.2 19393.4 20001.2 20114.8 20194.6 18594.3 18774.3 19362.7 19444.5 19555.9 19561.2 19573.2 19754.3 19930.0 19958.8 12109.8 12475.6 12498.8 12627.2 13353.2 14659.3 14845.0 14989.9 15134.2 15142.7 11:55:30 INFO - PID 368 | -------- Summary: end -------- 11:55:30 INFO - PID 368 | 11:55:31 INFO - TEST-INFO | 368: exit 0 11:55:31 INFO - TEST-OK | dromaeo_css | took 1109598ms 11:55:31 INFO - TEST-START | kraken 11:55:31 INFO - Initialising browser for kraken test... 11:55:31 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:59518/getInfo.html -profile /tmp/tmpOAjJ10/profile 11:55:31 INFO - TEST-INFO | started process 739 (/builds/slave/test/build/application/firefox/firefox http://localhost:59518/getInfo.html) 11:55:36 INFO - TEST-INFO | 739: exit 0 11:55:36 INFO - Browser initialized. 11:55:36 INFO - Running cycle 1/1 for kraken test... 11:55:36 INFO - TEST-INFO | started process 958 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOAjJ10/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:55:37 INFO - PID 958 | 11:55:37 INFO - PID 958 | (/builds/slave/test/build/application/firefox/firefox:1008): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:55:37 INFO - PID 958 | 11:55:47 INFO - PID 958 | RSS: Main: 164544512 11:55:47 INFO - PID 958 | 11:55:50 INFO - PID 958 | Cycle 1(1): loaded http://localhost:59518/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59518/tests/kraken/driver.html?testName=audio-beat-detection) 11:55:51 INFO - PID 958 | RSS: Main: 169631744 11:55:51 INFO - PID 958 | 11:55:53 INFO - PID 958 | Cycle 1(1): loaded http://localhost:59518/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59518/tests/kraken/driver.html?testName=audio-dft) 11:55:54 INFO - PID 958 | RSS: Main: 169996288 11:55:54 INFO - PID 958 | 11:55:57 INFO - PID 958 | Cycle 1(1): loaded http://localhost:59518/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59518/tests/kraken/driver.html?testName=audio-fft) 11:55:57 INFO - PID 958 | RSS: Main: 163868672 11:55:57 INFO - PID 958 | 11:55:59 INFO - PID 958 | Cycle 1(1): loaded http://localhost:59518/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59518/tests/kraken/driver.html?testName=audio-oscillator) 11:56:00 INFO - PID 958 | RSS: Main: 165216256 11:56:00 INFO - PID 958 | 11:56:02 INFO - PID 958 | Cycle 1(1): loaded http://localhost:59518/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59518/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:56:03 INFO - PID 958 | RSS: Main: 165621760 11:56:03 INFO - PID 958 | 11:56:06 INFO - PID 958 | Cycle 1(1): loaded http://localhost:59518/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59518/tests/kraken/driver.html?testName=imaging-darkroom) 11:56:06 INFO - PID 958 | RSS: Main: 167624704 11:56:06 INFO - PID 958 | 11:56:10 INFO - PID 958 | Cycle 1(1): loaded http://localhost:59518/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59518/tests/kraken/driver.html?testName=imaging-desaturate) 11:56:10 INFO - PID 958 | RSS: Main: 170176512 11:56:10 INFO - PID 958 | 11:56:13 INFO - PID 958 | Cycle 1(1): loaded http://localhost:59518/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59518/tests/kraken/driver.html?testName=json-parse-financial) 11:56:14 INFO - PID 958 | RSS: Main: 168898560 11:56:14 INFO - PID 958 | 11:56:15 INFO - PID 958 | Cycle 1(1): loaded http://localhost:59518/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59518/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:56:16 INFO - PID 958 | RSS: Main: 168566784 11:56:16 INFO - PID 958 | 11:56:18 INFO - PID 958 | Cycle 1(1): loaded http://localhost:59518/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59518/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:56:18 INFO - PID 958 | RSS: Main: 168751104 11:56:18 INFO - PID 958 | 11:56:20 INFO - PID 958 | Cycle 1(1): loaded http://localhost:59518/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59518/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:56:21 INFO - PID 958 | RSS: Main: 165572608 11:56:21 INFO - PID 958 | 11:56:24 INFO - PID 958 | Cycle 1(1): loaded http://localhost:59518/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59518/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:56:24 INFO - PID 958 | RSS: Main: 165564416 11:56:24 INFO - PID 958 | 11:56:27 INFO - PID 958 | Cycle 1(1): loaded http://localhost:59518/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59518/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:56:28 INFO - PID 958 | RSS: Main: 166162432 11:56:28 INFO - PID 958 | 11:56:30 INFO - PID 958 | Cycle 1(1): loaded http://localhost:59518/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59518/tests/kraken/driver.html?testName=ai-astar) 11:56:30 INFO - PID 958 | RSS: Main: 167919616 11:56:30 INFO - PID 958 | 11:56:30 INFO - PID 958 | __start_tp_report 11:56:30 INFO - PID 958 | _x_x_mozilla_page_load 11:56:30 INFO - PID 958 | _x_x_mozilla_page_load_details 11:56:30 INFO - PID 958 | |i|pagename|runs| 11:56:30 INFO - PID 958 | |0;ai-astar;98;105;98;105;105;110;108;98;105;106 11:56:30 INFO - PID 958 | |1;audio-beat-detection;141;111;141;162;124;140;143;113;162;113 11:56:30 INFO - PID 958 | |2;audio-dft;163;166;162;163;161;163;163;162;165;168 11:56:30 INFO - PID 958 | |3;audio-fft;76;75;73;141;76;76;77;93;96;75 11:56:30 INFO - PID 958 | |4;audio-oscillator;78;78;132;77;78;78;128;78;79;124 11:56:30 INFO - PID 958 | |5;imaging-gaussian-blur;113;113;114;113;115;114;116;114;114;114 11:56:30 INFO - PID 958 | |6;imaging-darkroom;149;149;149;148;148;149;148;149;148;147 11:56:30 INFO - PID 958 | |7;imaging-desaturate;94;95;95;94;94;94;96;95;94;95 11:56:30 INFO - PID 958 | |8;json-parse-financial;48;47;46;47;49;56;48;46;47;46 11:56:30 INFO - PID 958 | |9;json-stringify-tinderbox;55;55;54;54;55;54;55;54;55;54 11:56:30 INFO - PID 958 | |10;stanford-crypto-aes;76;75;74;75;74;75;81;75;74;75 11:56:30 INFO - PID 958 | |11;stanford-crypto-ccm;120;124;131;132;124;119;127;115;125;155 11:56:30 INFO - PID 958 | |12;stanford-crypto-pbkdf2;171;167;163;160;181;163;163;163;160;165 11:56:30 INFO - PID 958 | |13;stanford-crypto-sha256-iterative;62;61;64;66;60;60;62;61;60;61 11:56:30 INFO - PID 958 | __end_tp_report 11:56:30 INFO - PID 958 | __start_cc_report 11:56:30 INFO - PID 958 | _x_x_mozilla_cycle_collect,858 11:56:30 INFO - PID 958 | __end_cc_report 11:56:30 INFO - PID 958 | __startTimestamp1501872990314__endTimestamp 11:56:30 INFO - PID 958 | 11:56:30 INFO - PID 958 | ------- Summary: start ------- 11:56:30 INFO - PID 958 | Number of tests: 14 11:56:30 INFO - PID 958 | 11:56:30 INFO - PID 958 | [#0] ai-astar Cycles:10 Average:103.80 Median:109.00 stddev:4.32 (4.0%) stddev-sans-first:4.03 11:56:30 INFO - PID 958 | Values: 98.0 105.0 98.0 105.0 105.0 110.0 108.0 98.0 105.0 106.0 11:56:30 INFO - PID 958 | 11:56:30 INFO - PID 958 | [#1] audio-beat-detection Cycles:10 Average:135.00 Median:141.00 stddev:19.10 (13.5%) stddev-sans-first:20.14 11:56:30 INFO - PID 958 | Values: 141.0 111.0 141.0 162.0 124.0 140.0 143.0 113.0 162.0 113.0 11:56:30 INFO - PID 958 | 11:56:30 INFO - PID 958 | [#2] audio-dft Cycles:10 Average:163.60 Median:163.00 stddev:2.12 (1.3%) stddev-sans-first:2.24 11:56:30 INFO - PID 958 | Values: 163.0 166.0 162.0 163.0 161.0 163.0 163.0 162.0 165.0 168.0 11:56:30 INFO - PID 958 | 11:56:30 INFO - PID 958 | [#3] audio-fft Cycles:10 Average:85.80 Median:76.00 stddev:20.99 (27.6%) stddev-sans-first:21.96 11:56:30 INFO - PID 958 | Values: 76.0 75.0 73.0 141.0 76.0 76.0 77.0 93.0 96.0 75.0 11:56:30 INFO - PID 958 | 11:56:30 INFO - PID 958 | [#4] audio-oscillator Cycles:10 Average:93.00 Median:78.00 stddev:24.23 (31.1%) stddev-sans-first:25.08 11:56:30 INFO - PID 958 | Values: 78.0 78.0 132.0 77.0 78.0 78.0 128.0 78.0 79.0 124.0 11:56:30 INFO - PID 958 | 11:56:30 INFO - PID 958 | [#5] imaging-gaussian-blur Cycles:10 Average:114.00 Median:114.00 stddev:0.94 (0.8%) stddev-sans-first:0.93 11:56:30 INFO - PID 958 | Values: 113.0 113.0 114.0 113.0 115.0 114.0 116.0 114.0 114.0 114.0 11:56:30 INFO - PID 958 | 11:56:30 INFO - PID 958 | [#6] imaging-darkroom Cycles:10 Average:148.40 Median:149.00 stddev:0.70 (0.5%) stddev-sans-first:0.71 11:56:30 INFO - PID 958 | Values: 149.0 149.0 149.0 148.0 148.0 149.0 148.0 149.0 148.0 147.0 11:56:30 INFO - PID 958 | 11:56:30 INFO - PID 958 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.70 (0.7%) stddev-sans-first:0.71 11:56:30 INFO - PID 958 | Values: 94.0 95.0 95.0 94.0 94.0 94.0 96.0 95.0 94.0 95.0 11:56:30 INFO - PID 958 | 11:56:30 INFO - PID 958 | [#8] json-parse-financial Cycles:10 Average:48.00 Median:47.50 stddev:2.98 (6.3%) stddev-sans-first:3.16 11:56:30 INFO - PID 958 | Values: 48.0 47.0 46.0 47.0 49.0 56.0 48.0 46.0 47.0 46.0 11:56:30 INFO - PID 958 | 11:56:30 INFO - PID 958 | [#9] json-stringify-tinderbox Cycles:10 Average:54.50 Median:55.00 stddev:0.53 (1.0%) stddev-sans-first:0.53 11:56:30 INFO - PID 958 | Values: 55.0 55.0 54.0 54.0 55.0 54.0 55.0 54.0 55.0 54.0 11:56:30 INFO - PID 958 | 11:56:30 INFO - PID 958 | [#10] stanford-crypto-aes Cycles:10 Average:75.40 Median:75.00 stddev:2.07 (2.8%) stddev-sans-first:2.18 11:56:30 INFO - PID 958 | Values: 76.0 75.0 74.0 75.0 74.0 75.0 81.0 75.0 74.0 75.0 11:56:30 INFO - PID 958 | 11:56:30 INFO - PID 958 | [#11] stanford-crypto-ccm Cycles:10 Average:127.20 Median:126.00 stddev:11.07 (8.8%) stddev-sans-first:11.43 11:56:30 INFO - PID 958 | Values: 120.0 124.0 131.0 132.0 124.0 119.0 127.0 115.0 125.0 155.0 11:56:30 INFO - PID 958 | 11:56:30 INFO - PID 958 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.60 Median:164.00 stddev:6.31 (3.8%) stddev-sans-first:6.38 11:56:30 INFO - PID 958 | Values: 171.0 167.0 163.0 160.0 181.0 163.0 163.0 163.0 160.0 165.0 11:56:30 INFO - PID 958 | 11:56:30 INFO - PID 958 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.70 Median:61.50 stddev:1.95 (3.2%) stddev-sans-first:2.06 11:56:30 INFO - PID 958 | Values: 62.0 61.0 64.0 66.0 60.0 60.0 62.0 61.0 60.0 61.0 11:56:30 INFO - PID 958 | -------- Summary: end -------- 11:56:30 INFO - PID 958 | 11:56:30 INFO - PID 958 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 11:56:31 INFO - TEST-INFO | 958: exit 0 11:56:31 INFO - TEST-OK | kraken | took 59540ms 11:56:31 INFO - SUITE-END | took 1169s 11:56:31 INFO - Completed test suite (00:19:29) 11:56:31 INFO - javascript benchmark 11:56:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8699.97398550779, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3461.0, 3475.6350583188764, 3515.7187425006, 3531.682148606625, 3539.0, 6112.694365281729, 6173.722182501787, 6191.969040154793, 6196.0705894115845, 6196.690165491725, 6109.14471973924, 6124.356942521038, 6163.137160797492, 6180.289266734327, 6189.226346706661, 5393.0, 5403.189521571766, 5419.83740487786, 5424.294841670578, 5437.401885792559, 5443.673379597237, 5463.672179669213, 5476.698781567012, 5482.616216864821, 5498.3127109111365, 5519.116941289394, 5526.972365138189, 5538.0585300498815, 5562.082256427685, 5563.0, 5412.377576578704, 5496.697681627529, 5504.2294078829, 5553.361363443195, 5579.358373786985, 5313.840584782462, 5363.624546281723, 5365.06111430502, 5396.83809485716, 5431.375391829951, 5533.22534845122, 5921.703914804242, 6065.8180254592435, 6070.423309785563, 6184.412480814315, 6665.0, 6691.76578819739, 6750.683616694747, 6754.121964144679, 6767.35710107539, 6709.463242940553, 6758.0, 6761.661916904184, 6777.525573209878, 6840.486963477759, 6229.2836323822885, 6235.781747638856, 6237.220347456568, 6243.469305109071, 6252.437280644764, 6861.0, 6861.416779573692, 6872.553284036521, 6874.346937040973, 6887.414569761526, 6506.479481641552, 6578.605283682994, 6589.17635295588, 6598.73605055802, 6599.307072757388, 6653.833654158588, 6710.597364158166, 6711.463082953352, 6719.932800672029, 6720.32796720324, 5776.249087618583, 6635.535512514174, 6639.634820084942, 6721.462283017347, 6739.123913891162, 6670.332966703291, 6692.364225398579, 6750.392464678104, 6754.932450675528, 6762.459003279726, 4757.524247575215, 4863.8540843774745, 4884.242942343943, 4885.65800393969, 4928.457869634337, 4360.498542667634, 4382.342648602735, 4416.33754936762, 4439.023414848728, 4488.798004089824, 6337.936620633827, 6375.4262116409745, 6377.266614339411, 6448.322926092693, 6451.677416129175, 6717.932820671828, 6723.428508576728, 6752.122224110834, 6813.591184528944, 6859.211190713032, 6428.678566071678, 6472.35276472349, 6487.0, 6487.578307410097, 6494.837629059217, 5474.39781624021, 5551.0, 5560.0, 5560.944390556124, 5623.409541998113, 7162.534435261796, 7169.996200531826, 7171.605561694157, 7180.5691658500655, 7192.496525243288, 6760.357766012221, 6769.661516924036, 6779.694913728796, 6811.9659401702675, 6813.761518346834, 7053.964730176316, 7059.576425414286, 7117.715291388494, 7126.394256488256, 7209.747658831916, 6632.502562307943, 6657.73369065232, 6662.367075127855, 6729.057931889637, 6733.93266067333, 6622.4702023838945, 6730.93269067303, 6768.763093291711, 6811.386975172259, 6865.965670171618, 6595.241547222131, 6639.468842492685, 6641.203055633355, 6659.866802664016, 6667.166604174478, 6484.286728459771, 6546.509011824037, 6562.048502966947, 6572.80281591553, 6636.170478690164, 6501.08984742127, 6529.640869752209, 6600.306967768507, 6600.735970561316, 6630.336966303331, 6532.660804535154, 6549.115869357766, 6594.076829243813, 6597.175353080865, 6622.470202383702, 6326.557141000086, 6340.49276057905, 6401.3598640135615, 6418.133551970611, 6439.935600643934], "value": 6119.30508000694, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [890.6975468414149, 920.6455514626866, 938.704308142935, 966.9758256043598, 968.869202657641, 42018.57981420189, 43038.569614303844, 43040.78479607601, 43048.0, 43104.0, 40309.7984510077, 40439.0, 40560.18879622406, 40596.39105413421, 40639.59360406395, 6789.2531821499715, 6900.413464855468, 6905.067815844872, 6908.689108990107, 6909.447244220475, 6770.593764374129, 6881.0, 6899.931000690004, 6918.135233095863, 6936.0636314097455, 6892.758753443631, 6898.655067246643, 6902.17173939128, 6913.20498142715, 6950.930490695104, 6851.383375496204, 6871.0, 6879.277675844014, 6880.655967201645, 6894.517383783137, 6374.362563743635, 6379.234491861006, 6383.808485745435, 6405.29541750407, 6411.198600174978, 35732.0, 35759.4636080459, 35842.641573584195, 35962.82018589917, 35992.82003589992, 3301.9339613207603, 3310.470324748029, 3315.8342082896, 3329.284203896174, 3337.8664853405835, 28237.576436353473, 28411.71588284132, 28417.0, 28454.146375608765, 28471.0, 4496.797644106023, 4547.340635607851, 4551.998560316725, 4558.566936141061, 4601.309803529464, 208112.0, 209335.0, 209545.0, 209618.0, 209724.0, 23633.881830590737, 23807.7619223809, 23829.0, 23841.04635814548, 23843.40391490192, 24407.877960610083, 24427.0, 24612.138575149784, 24638.87680561586, 24648.753512464646, 13764.0, 13844.0, 13903.582892513241, 13905.096168749, 13912.652183695287, 13629.182249065088, 13647.454101836014, 13680.452781888613, 13724.519641812489, 13729.519466818614, 6273.466755325757, 6273.560850740496, 6301.180846489927, 6310.873782524415, 6379.266384365765, 2619.6725409323835, 2625.2911713837157, 2631.6184153297663, 2643.458091091322, 2654.9867250663624, 1064.6007747094839, 1090.4711215060688, 1092.748667806409, 1099.912007039435, 1102.4322473925934, 24984.375390615016, 25110.623340649905, 25184.0, 25195.748042519706, 25381.238562842776, 1202.3026644546142, 1203.524607779922, 1207.7222238885106, 1210.9091818113677, 1224.3878060969516, 13156.539521116714, 13389.799153012713, 13546.796798048037, 13556.389962451713, 13659.248741319323, 260498.0, 260530.0, 260542.0, 261360.0, 262223.0, 57003.14495282574, 57012.0, 57131.71434142886, 57226.42773572211, 61183.0, 1471.6835880285576, 1512.9319180636899, 1521.710874933759, 1523.169872419534, 1525.0, 29973.0, 30373.544396833622, 30432.543511847784, 30543.0, 30994.845025774728, 40601.0, 41030.1793964125, 41112.1777564453, 41118.177636447705, 41134.794326028175, 215374.0, 217650.0, 218226.0, 218671.0, 218806.0, 32824.34351313008, 33584.66415335913, 33919.491207631414, 33944.830275848464, 33957.32085358328, 45029.774851125534, 45812.54187458083, 46126.769366152956, 46250.30624540567, 46330.30504542502, 33547.329053419286, 33911.66088339085, 34000.63997440174, 34075.31849363048, 34312.48531271983, 33466.0, 33632.15919602029, 34084.82957585196, 34157.65842341545, 34163.48754768631, 39158.0, 39213.2157356857, 39471.605283946796, 39598.2080358397, 39729.60270397259, 35089.64910350966, 35138.648613513535, 35731.10672233111, 35876.0, 36166.457503138, 26312.4737505245, 34280.657193427745, 34299.65700343064, 34416.483752743225, 34505.654943450245], "value": 16155.855241169918, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [566.9489745922867, 573.3664300947453, 580.1413907417025, 584.5820238529451, 596.0701305962699, 23377.883110584444, 23505.29484115475, 24155.39611509713, 24158.879205603993, 24268.8786556067, 26985.32536686579, 27969.440611187765, 28006.0, 28021.719782802167, 28024.159275221777, 5815.098659707752, 6095.238095238106, 6193.752249909998, 6218.31598524162, 6221.408966148231, 6252.624842509441, 6270.811875643738, 6285.088662143987, 6285.560010799246, 6289.496840252768, 6247.344028876971, 6251.906221406683, 6254.030625253093, 6258.06129080637, 6259.342769009257, 6253.8123856284155, 6254.718537665816, 6255.280642726077, 6261.27995280544, 6261.998080307175, 5836.533077353802, 5837.182794408786, 5843.474087332118, 5845.09401042839, 5846.50304724099, 30168.166639212996, 30885.536716949264, 31212.68787312143, 31466.37067258642, 31603.20991975196, 2284.920027799036, 2324.2678556254896, 2325.2559181062065, 2326.5695846268495, 2330.766923307656, 20314.796852031584, 20705.68941465879, 20935.581288374146, 20943.790562094488, 20948.581028379347, 2422.6123820188864, 2431.55016321981, 2459.5449841779327, 2510.9874450627813, 2524.394145405108, 161140.19429902892, 164421.0, 164592.0, 165083.0, 165969.0, 15570.0, 15893.602659933595, 16128.435504757277, 16762.74855877163, 16903.0, 24806.5038699225, 24811.25566233016, 24931.252062438154, 24938.501229975664, 25042.499150016898, 10826.18803589734, 10878.238523303451, 10934.234603577674, 11019.228653994143, 11364.829527557093, 9356.204722598519, 9750.609975600897, 9750.75623109428, 9805.264605154642, 10047.24645651579, 9917.256205784595, 9920.900790992142, 10051.69844904654, 10052.145567626687, 10247.538860751283, 2795.5044051432387, 2839.432113577293, 2885.495038368277, 2904.564315352714, 2973.7769667274606, 1066.898644628759, 1081.5781845080426, 1090.6400887707039, 1103.0679076180616, 1119.5018216893568, 22097.558048839255, 26384.472310554065, 27140.864295678395, 28314.292142696184, 28528.28679282993, 1154.6593754842343, 1166.3643314393676, 1170.9414529273502, 1171.3967306836985, 1176.353005846781, 12232.633021009384, 12728.363581820871, 12763.361831908367, 12801.911837493917, 12809.295488748208, 620530.0, 620574.0, 621252.0, 637536.0, 638371.0, 135791.0, 137828.0, 139772.0, 141661.0, 141835.45411364798, 1319.6568892088126, 1402.4670625162578, 1405.5642750747097, 1406.289823639076, 1408.978865317021, 23091.076356945534, 23340.183093591644, 23353.41616459602, 23393.649095263925, 23685.64471532894, 60858.69570652118, 61172.0, 61260.38739612725, 62586.68706656437, 63567.0, 74912.62543687246, 75759.0, 75898.0, 76427.61786191033, 76433.61783191048, 13140.145890517086, 13553.25457099869, 15298.388064477296, 15393.76909346383, 15947.202639868192, 23463.413414664086, 23675.40811479727, 23853.642195366738, 24009.159679411834, 24477.755222447548, 19577.31479398271, 19992.20031198736, 20018.299359522345, 20078.297259595845, 20263.392098237076, 18022.65705458282, 18468.81531184671, 18553.0, 18821.717674234624, 19314.613707725486, 20715.378538643865, 21428.464288392915, 21747.347579572637, 21780.0, 21916.671249930943, 15555.611109722347, 15568.844311557192, 15592.298346574658, 15613.375464981727, 15775.605609859846, 20468.181272748923, 20609.58780824405, 20670.689939651216, 20693.068811903802, 20763.480912977295], "value": 13019.77112126013, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1401.1803095189314, 1433.3549902543857, 1441.7476941535228, 1441.8774404175645, 1494.7458931981566, 15155.166465844373, 15715.528534143965, 15755.842441575582, 15759.290831912576, 15765.132917689523, 15119.773203401957, 16081.597960050975, 16096.275667594957, 16112.677746445064, 16123.677526449464, 2675.4916565852473, 2737.5209338365808, 2737.685166205882, 2738.945221095577, 2741.2461573067367, 2605.153325169318, 2621.6985046719587, 2655.2698008047746, 2715.5247831629486, 2717.4565086982584, 2694.528457519926, 2707.539718247893, 2719.3745438549145, 2719.9320016999636, 2720.8095433319677, 2472.5178590174924, 2474.505098980202, 2515.0945659562544, 2518.546661600911, 2522.495500899827, 2655.150351887397, 2673.5454972654697, 2679.9866000670067, 2724.6049322848075, 2735.86320683967, 15394.384224631001, 15475.0, 15475.071495710294, 15493.845061549353, 15498.5350439487, 8042.155573664798, 8337.541435221061, 8359.540225287607, 8360.163983601651, 8367.0, 4916.778744956449, 5113.795448182068, 5165.173572228463, 5235.188545775411, 5237.266782650432, 1987.4037788663488, 2003.4790954351827, 2010.788867168941, 2019.4951262184454, 2046.334941144134, 26538.0, 26599.138060335783, 26627.866860665574, 26647.467050658877, 26816.865915670493, 6750.898736518956, 6752.797416077526, 6810.897836532456, 6967.965160174167, 6982.685779139951, 18161.818381816014, 18179.091045447676, 18186.909065454587, 18194.090295485174, 18207.908960455377, 8092.71675491355, 8264.628091735887, 8280.875786863202, 8298.792530186673, 8298.958505207556, 7644.350230230381, 7644.923550764421, 7739.419543534257, 7749.070111586646, 7752.147263800977, 5180.663256888291, 5303.496167864047, 5349.0, 5382.573617991236, 5407.080796264644, 1371.8079468874366, 1409.0840953380384, 1439.8704116629553, 1499.3477837140879, 1518.8329283778776, 914.6295750221171, 919.2186641354795, 929.716436486878, 934.7336009237334, 935.7426707655313, 8339.958300208582, 8619.224269815746, 9001.684941027164, 9216.308776841764, 9345.878494580558, 994.164901482758, 1005.1657124586576, 1005.6681295172575, 1008.5159123620704, 1041.4116024446164, 5054.898902022012, 5137.9743101285, 5217.739113044333, 5386.13821788512, 5419.403865574784, 21557.24549640755, 21705.67441488379, 21724.0, 22382.776172238395, 22474.213402530833, 21581.892090539448, 22094.558108838053, 22154.446138846335, 22286.442838928833, 22448.551028979327, 12104.757904841854, 12289.446974886152, 12339.07456940715, 12439.813402798965, 12581.93709031449, 7926.167752385916, 7935.1271360151495, 8040.959795200986, 8051.114377418362, 8157.0, 18950.336738214097, 19260.903695481433, 19392.515187120436, 19659.311924082587, 20011.199552017755, 19274.32539861098, 19744.703829442282, 19866.701999470308, 19909.203631855144, 20074.0, 12551.87448125507, 12658.810117848056, 12809.103362764517, 12833.550825721055, 12889.355532223539, 14152.78770818418, 14305.856941430453, 14341.92829035848, 14348.0, 14348.928255358656, 11083.778324433628, 11119.499622517167, 11188.328700278009, 11209.663710088711, 11302.886971130183, 11473.82789258145, 11489.482973266391, 11562.653120406065, 11607.0, 11755.706107347043, 9723.46520941355, 9733.56198971062, 9771.85342219853, 9777.706668799947, 9781.070798274153, 7350.3384695375535, 7425.7029718810645, 7450.913744151646, 7464.6267686614365, 7529.284717951786, 7613.428992825671, 7633.503822251536, 7664.386849052174, 7668.57822819728, 7784.494007889469], "value": 6830.441927918312, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [514.9665271757336, 516.4860963341473, 542.2300333526392, 550.4605486623107, 557.3395526301333, 5949.553783466246, 5979.860573199073, 5993.910091348628, 6100.359462256461, 6145.815625531236, 5998.370171132034, 6000.579959402833, 6044.455998960093, 6070.453659170674, 6091.086337049444, 4746.833860814872, 4761.738104404257, 4778.880527986802, 4781.235002399617, 4803.423589169304, 4611.262198048313, 4701.215521505187, 4735.147673418784, 4763.118823017736, 4789.808407663707, 4693.342931989524, 4736.100140973222, 4739.478657347706, 4802.927956080662, 4809.759512024402, 4707.8587642370785, 4734.857954261361, 4762.714237145782, 4772.498887616785, 4787.473377928425, 4368.0, 4371.846985355529, 4372.1255748850035, 4383.0, 4395.758233297167, 6021.42796434338, 6023.789167379121, 6032.45707886288, 6042.214512113397, 6049.9697501512655, 5663.7451314690525, 5698.487136157724, 5727.255456790591, 5734.512566431858, 5790.507806836424, 6481.64350960697, 6522.412982831568, 6536.93463065368, 6539.738410463576, 6557.540972131953, 4931.630127740434, 4957.429895562021, 4977.7262250576205, 4991.376077990251, 5007.749612519396, 6843.281455447156, 6844.486663500257, 6853.280405557444, 6882.552634078769, 6889.0, 5117.2068329409, 5121.436641969381, 5122.257272695439, 5122.948770512247, 5141.408737995103, 5160.225966105039, 5180.922286165635, 5190.273361729361, 5206.140986737221, 5235.0, 5702.914456283159, 5706.971465142731, 5715.31416230055, 5737.311522617312, 5777.3933736957015, 6291.779787707408, 6453.548251622341, 6465.676716164173, 6569.441597464173, 6571.67141642916, 1729.2132079903613, 1846.3445476855522, 1918.932837350714, 1920.2511020701938, 1928.3347245200384, 1431.7279716853764, 1432.8710416062395, 1442.697033622951, 1455.8107446032159, 1475.5499572630235, 6092.659614884718, 6162.691865406801, 6172.5679202456295, 6229.626222426669, 6241.126242326078, 6601.3728695773825, 6720.731170753213, 6721.462283017347, 6744.6627668616375, 6797.776400248003, 6244.46922011625, 6253.843653908598, 6276.560640755103, 6286.465650419674, 6321.968390158112, 3523.7533372663665, 3541.628129046413, 3578.5169002184894, 3587.318409502186, 3598.8123919106633, 7129.3583577478275, 7131.643417829192, 7156.427485801123, 7171.426285897116, 7187.712491500281, 6849.383555480031, 6900.171979362509, 6942.132233470817, 6952.443804495628, 6978.406835419046, 7039.577625342496, 7073.61095139762, 7118.216996130422, 7137.321954414426, 7172.175199851979, 6731.158605174353, 6743.0, 6746.190457145174, 6750.32496750321, 6788.9660551696925, 6671.366220209073, 6685.565438246498, 6687.364700353459, 6711.530192886451, 6719.596824190564, 7085.14978202619, 7093.716251349888, 7098.964505177441, 7107.218205997439, 7112.359887609933, 5107.540321371094, 5112.36095488064, 5130.204818253177, 5146.433892271922, 5160.664556803796, 6498.512611554247, 6610.735570577315, 6678.565893216925, 6916.757913473004, 6925.896111558432, 6272.905906411316, 6445.838854028687, 6456.54804163704, 6477.190351206099, 6516.804495865132, 6470.935290647033, 6475.902861457176, 6527.967360163168, 6531.836704082436, 6569.704363303758, 6430.0, 6434.388733070351, 6488.351164883663, 6515.73937042532, 6578.217524923284, 6514.804555863332, 6569.0, 6637.236717777518, 6666.300038495888, 6668.466522678077, 6395.20059992501, 6402.295747467868, 6431.742730290736, 6462.967685161544, 6498.252700939453], "value": 5133.7542818588745, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [928.7074571509974, 935.3031991166586, 957.7844984878403, 959.0697023886827, 959.405168795347, 18590.721139182908, 19884.40346789597, 19885.701714474293, 19985.0, 21614.0, 19160.904195479005, 21348.4662883428, 21650.89174554129, 21668.566628667457, 21692.56614867702, 1064.5794911010146, 1068.6526878764414, 1073.8765042020189, 1075.2526993739355, 1075.9515821788038, 1054.804861100695, 1063.8191507443753, 1078.396098185015, 1078.573963284502, 1079.0288740133865, 1140.3556990300494, 1144.2162118948547, 1148.8908553687386, 1148.9597864074758, 1159.91300652451, 1124.8706398764166, 1139.242403801471, 1141.8972292493715, 1145.7937571237173, 1149.2127892393696, 836.9748907532784, 841.4278290762279, 843.1989609870648, 843.2621456225802, 845.9974929708316, 18662.626747464976, 18725.344612938618, 18842.90578547112, 19809.0, 20114.0, 22379.440513987116, 22439.77560224393, 22638.66042009371, 22774.0, 22952.42618934523, 16587.170641467877, 16778.580535486588, 16796.076215808127, 16946.661066778717, 16951.152442377956, 3735.2156047230114, 3744.5132132822832, 3746.9437958430644, 3757.5490941086973, 3759.0978165240144, 144083.0, 144744.0, 146418.0, 146847.0, 148017.2599137008, 17054.232559534852, 17454.389096381565, 17473.56316092108, 17628.735568966476, 17633.206505707272, 31678.524822127685, 33022.50466243008, 33937.32125357528, 33982.81060162882, 34061.48907766386, 7751.961240193876, 8078.515289082674, 9471.810563788686, 9694.75763105928, 9697.660581879742, 3568.803715795656, 4458.687891847604, 4624.329472226508, 4633.027064316464, 4650.279206722963, 5629.211910332475, 5639.210510528529, 5700.885982280414, 5728.198052272685, 5728.79949201776, 1115.7656892052598, 1116.8380584815156, 1128.074978517624, 1130.9151813614012, 1132.1452303510962, 720.9891851622125, 732.7948174511146, 736.9484136110528, 748.9325960663566, 761.9923800762032, 12148.817767733492, 12618.684532886751, 12951.417186226643, 13161.0, 13304.534341298007, 731.9085114360705, 732.1507051819864, 737.2921994884971, 749.2395218852869, 751.8045308219793, 5570.554355651539, 5581.916271255935, 5619.072852979212, 5678.744456499468, 5781.277340332458, 129062.35468822595, 129320.0, 131495.0, 132086.0, 138949.0, 116259.0, 116328.41835790937, 117375.0, 118271.0, 118472.40763796298, 90266.0, 94703.0, 95000.52499737457, 95700.52149739346, 96296.51851740696, 10993.725156871142, 10997.285176463503, 11099.278546894426, 11119.221654484432, 11497.655070347902, 49691.0, 50202.74898625483, 50375.0, 50627.0, 52109.0, 62400.687996559725, 63086.36913630805, 63497.36502634914, 63618.36381636124, 63742.68128659327, 14255.215963122128, 14624.70750584961, 14642.0, 14660.340284687001, 14708.632284192981, 16972.575685607957, 17128.40050598223, 17276.913615432346, 20271.391858244275, 20822.583548328646, 19324.227030918606, 19393.418197453535, 20001.199952001756, 20114.798852011292, 20194.59610807805, 18594.2562297512, 18774.342897998504, 19362.709559356903, 19444.513887152934, 19555.902220488806, 19561.21755129836, 19573.217071316987, 19754.308599198957, 19930.0, 19958.800411996275, 12109.75780484403, 12475.563355282522, 12498.75002499963, 12627.242365458102, 13353.198808071547, 14659.340329685403, 14845.035072720239, 14989.850101498845, 15134.243287835785, 15142.697146056797], "value": 9606.459549588726, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1470.6000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 105.0, 98.0, 105.0, 105.0, 110.0, 108.0, 98.0, 105.0, 106.0], "value": 103.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 111.0, 141.0, 162.0, 124.0, 140.0, 143.0, 113.0, 162.0, 113.0], "value": 135.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 166.0, 162.0, 163.0, 161.0, 163.0, 163.0, 162.0, 165.0, 168.0], "value": 163.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 73.0, 141.0, 76.0, 76.0, 77.0, 93.0, 96.0, 75.0], "value": 85.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 132.0, 77.0, 78.0, 78.0, 128.0, 78.0, 79.0, 124.0], "value": 93.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 114.0, 113.0, 115.0, 114.0, 116.0, 114.0, 114.0, 114.0], "value": 114.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 149.0, 149.0, 148.0, 148.0, 149.0, 148.0, 149.0, 148.0, 147.0], "value": 148.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 94.0, 94.0, 94.0, 96.0, 95.0, 94.0, 95.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [48.0, 47.0, 46.0, 47.0, 49.0, 56.0, 48.0, 46.0, 47.0, 46.0], "value": 48.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 54.0, 54.0, 55.0, 54.0, 55.0, 54.0, 55.0, 54.0], "value": 54.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 74.0, 75.0, 74.0, 75.0, 81.0, 75.0, 74.0, 75.0], "value": 75.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 124.0, 131.0, 132.0, 124.0, 119.0, 127.0, 115.0, 125.0, 155.0], "value": 127.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 167.0, 163.0, 160.0, 181.0, 163.0, 163.0, 163.0, 160.0, 165.0], "value": 165.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 64.0, 66.0, 60.0, 60.0, 62.0, 61.0, 60.0, 61.0], "value": 61.7, "unit": "score"}]}]} 11:56:31 INFO - Return code: 0 11:56:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:56:31 INFO - # TBPL SUCCESS # 11:56:31 INFO - Running post-action listener: _package_coverage_data 11:56:31 INFO - Running post-action listener: _resource_record_post_action 11:56:31 INFO - [mozharness: 2017-08-04 18:56:31.603544Z] Finished run-tests step (success) 11:56:31 INFO - Running post-run listener: _resource_record_post_run 11:56:31 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 16384; Write bytes: 426422272; Read time: 788; Write time: 463484 11:56:31 INFO - TinderboxPrint: CPU usage
13.1% 11:56:31 INFO - TinderboxPrint: I/O read bytes / time
16,384 / 788 11:56:31 INFO - TinderboxPrint: I/O write bytes / time
426,422,272 / 463,484 11:56:31 INFO - TinderboxPrint: CPU idle
8,233.5 (86.9%) 11:56:31 INFO - TinderboxPrint: CPU user
1,190.6 (12.6%) 11:56:31 INFO - TinderboxPrint: Swap in / out
0 / 0 11:56:31 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 4096; Write bytes: 108175360; Read time: 96; Write time: 105396 11:56:31 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 11:56:31 INFO - run-tests - Wall time: 1170s; CPU: 13.0%; Read bytes: 8192; Write bytes: 318246912; Read time: 680; Write time: 358088 11:56:32 INFO - Running post-run listener: _upload_blobber_files 11:56:32 INFO - Blob upload gear active. 11:56:32 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:56:32 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 11:56:32 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:56:32 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:56:32 INFO - (blobuploader) - INFO - Open directory for files ... 11:56:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 11:56:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:56:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:56:33 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 11:56:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:56:33 INFO - (blobuploader) - INFO - Done attempting. 11:56:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:56:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:56:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:56:39 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:56:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:56:39 INFO - (blobuploader) - INFO - Done attempting. 11:56:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:56:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:56:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:56:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:56:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:56:40 INFO - (blobuploader) - INFO - Done attempting. 11:56:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:56:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:56:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:56:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:56:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:56:41 INFO - (blobuploader) - INFO - Done attempting. 11:56:41 INFO - (blobuploader) - INFO - Iteration through files over. 11:56:41 INFO - Return code: 0 11:56:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:56:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:56:41 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/63066612ccaad42bb9a83cc4a3c70b5850ecc0b92c57dc9d84edbcb3988622b856829bbaf1035aa49a814248398a5c179e8d03d5b960ef5ce2d3d48aaff54a45", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c8640b88c3c6ff96b27e0b6f9ec0499a2bde1d03241d17a3e1eafeb858a0a73b001263429c937610d1c39bcd078ea0e0aa2e090f011d4f9bac1f751140fcc8dd", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3d7e1d64a917124cd6c243c7dee537e07ad17adf436db97a2d75f202ea1f1ca54736e846b157ff6d4d765938687d4bf6ac287decfb8d1242d5441e71cda43e2c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cb61f1cd5cea8873ef238b94da6c3ab6624a2eaf5548b1ab653ea4325d2db5df25ea4cafdca69e81804ed575a9bfb7ed0e7b68796744275cc0fb266678291a72"} 11:56:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:56:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:56:41 INFO - Contents: 11:56:41 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/63066612ccaad42bb9a83cc4a3c70b5850ecc0b92c57dc9d84edbcb3988622b856829bbaf1035aa49a814248398a5c179e8d03d5b960ef5ce2d3d48aaff54a45", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c8640b88c3c6ff96b27e0b6f9ec0499a2bde1d03241d17a3e1eafeb858a0a73b001263429c937610d1c39bcd078ea0e0aa2e090f011d4f9bac1f751140fcc8dd", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3d7e1d64a917124cd6c243c7dee537e07ad17adf436db97a2d75f202ea1f1ca54736e846b157ff6d4d765938687d4bf6ac287decfb8d1242d5441e71cda43e2c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cb61f1cd5cea8873ef238b94da6c3ab6624a2eaf5548b1ab653ea4325d2db5df25ea4cafdca69e81804ed575a9bfb7ed0e7b68796744275cc0fb266678291a72"} 11:56:41 INFO - Running post-run listener: copy_logs_to_upload_dir 11:56:41 INFO - Copying logs to upload dir... 11:56:41 INFO - mkdir: /builds/slave/test/build/upload/logs 11:56:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.548207 ========= master_lag: 0.56 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2017-08-04 11:56:40.760227) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-04 11:56:40.765009) ========= 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: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5c37b704b588aaa989324530000001d0-1501871749.998862-157689734 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/63066612ccaad42bb9a83cc4a3c70b5850ecc0b92c57dc9d84edbcb3988622b856829bbaf1035aa49a814248398a5c179e8d03d5b960ef5ce2d3d48aaff54a45", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c8640b88c3c6ff96b27e0b6f9ec0499a2bde1d03241d17a3e1eafeb858a0a73b001263429c937610d1c39bcd078ea0e0aa2e090f011d4f9bac1f751140fcc8dd", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3d7e1d64a917124cd6c243c7dee537e07ad17adf436db97a2d75f202ea1f1ca54736e846b157ff6d4d765938687d4bf6ac287decfb8d1242d5441e71cda43e2c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cb61f1cd5cea8873ef238b94da6c3ab6624a2eaf5548b1ab653ea4325d2db5df25ea4cafdca69e81804ed575a9bfb7ed0e7b68796744275cc0fb266678291a72"} build_url:https://queue.taskcluster.net/v1/task/drQOCkkKRTWm0xE2BJ2h7w/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011429 build_url: 'https://queue.taskcluster.net/v1/task/drQOCkkKRTWm0xE2BJ2h7w/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/63066612ccaad42bb9a83cc4a3c70b5850ecc0b92c57dc9d84edbcb3988622b856829bbaf1035aa49a814248398a5c179e8d03d5b960ef5ce2d3d48aaff54a45", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c8640b88c3c6ff96b27e0b6f9ec0499a2bde1d03241d17a3e1eafeb858a0a73b001263429c937610d1c39bcd078ea0e0aa2e090f011d4f9bac1f751140fcc8dd", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3d7e1d64a917124cd6c243c7dee537e07ad17adf436db97a2d75f202ea1f1ca54736e846b157ff6d4d765938687d4bf6ac287decfb8d1242d5441e71cda43e2c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cb61f1cd5cea8873ef238b94da6c3ab6624a2eaf5548b1ab653ea4325d2db5df25ea4cafdca69e81804ed575a9bfb7ed0e7b68796744275cc0fb266678291a72"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-04 11:56:40.792366) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-04 11:56:40.792673) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5c37b704b588aaa989324530000001d0-1501871749.998862-157689734 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004557 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-04 11:56:40.874293) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-04 11:56:40.874590) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-04 11:56:40.877878) ========= ========= Total master_lag: 0.72 =========