builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s-pgo slave: talos-linux64-ix-028 starttime: 1506005179.46 results: success (0) revision: f7e9777221a34f9f23c2e4933307eb38b621b679 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-21 07:46:19.463738) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-21 07:46:19.464206) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-21 07:46:19.464479) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-21 07:46:19.553651) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-21 07:46:19.553990) ========= 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=836cfdc75598d54cb747368e000001a9-1506004283.846174-877056714 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-21 07:46:20-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 29.1M=0s 2017-09-21 07:46:20 (29.1 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.186702 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-21 07:46:19.780358) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-21 07:46:19.780665) ========= 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=836cfdc75598d54cb747368e000001a9-1506004283.846174-877056714 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019251 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-21 07:46:19.838655) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-21 07:46:19.838942) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev f7e9777221a34f9f23c2e4933307eb38b621b679 --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 f7e9777221a34f9f23c2e4933307eb38b621b679 --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=836cfdc75598d54cb747368e000001a9-1506004283.846174-877056714 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-21 07:46:20,570 truncating revision to first 12 chars 2017-09-21 07:46:20,570 Setting DEBUG logging. 2017-09-21 07:46:20,570 attempt 1/10 2017-09-21 07:46:20,570 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/f7e9777221a3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-21 07:46:21,035 unpacking tar archive at: mozilla-central-f7e9777221a3/testing/mozharness/ program finished with exit code 0 elapsedTime=0.729520 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-21 07:46:20.599454) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-21 07:46:20.599746) ========= script_repo_revision: f7e9777221a34f9f23c2e4933307eb38b621b679 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-21 07:46:20.600079) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-21 07:46:20.600339) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-21 07:46:20.627577) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2017-09-21 07:46:20.628863) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-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-stylo-disabled-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=836cfdc75598d54cb747368e000001a9-1506004283.846174-877056714 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:46:21 INFO - MultiFileLogger online at 20170921 07:46:21 in /builds/slave/test 07:46:21 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 07:46:21 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:46:21 INFO - {'append_to_log': False, 07:46:21 INFO - 'base_work_dir': '/builds/slave/test', 07:46:21 INFO - 'blob_upload_branch': 'Firefox', 07:46:21 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:46:21 INFO - 'branch': 'Firefox', 07:46:21 INFO - 'buildbot_json_path': 'buildprops.json', 07:46:21 INFO - 'code_coverage': False, 07:46:21 INFO - 'config_files': ('talos/linux_config.py',), 07:46:21 INFO - 'default_actions': ('clobber', 07:46:21 INFO - 'read-buildbot-config', 07:46:21 INFO - 'download-and-extract', 07:46:21 INFO - 'populate-webroot', 07:46:21 INFO - 'create-virtualenv', 07:46:21 INFO - 'install', 07:46:21 INFO - 'setup-mitmproxy', 07:46:21 INFO - 'run-tests'), 07:46:21 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:46:21 INFO - 'disable_ccov_upload': False, 07:46:21 INFO - 'disable_stylo': False, 07:46:21 INFO - 'download_minidump_stackwalk': True, 07:46:21 INFO - 'download_symbols': 'ondemand', 07:46:21 INFO - 'enable_stylo': False, 07:46:21 INFO - 'enable_webrender': False, 07:46:21 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 07:46:21 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:46:21 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:46:21 INFO - 'gecko_profile': False, 07:46:21 INFO - 'gecko_profile_interval': 0, 07:46:21 INFO - 'installer_path': 'installer.exe', 07:46:21 INFO - 'log_level': 'info', 07:46:21 INFO - 'log_name': 'talos', 07:46:21 INFO - 'log_to_console': True, 07:46:21 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:46:21 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:46:21 INFO - 'opt_config_files': (), 07:46:21 INFO - 'pip_index': False, 07:46:21 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 07:46:21 INFO - 'system_bits': '32', 07:46:21 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:46:21 INFO - 'title': 'talos-linux64-ix-028', 07:46:21 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:46:21 INFO - 'use_talos_json': True, 07:46:21 INFO - 'verify': 'False', 07:46:21 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:46:21 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:46:21 INFO - 'work_dir': 'build'} 07:46:21 INFO - [mozharness: 2017-09-21 14:46:21.506284Z] Running clobber step. 07:46:21 INFO - Running pre-action listener: _resource_record_pre_action 07:46:21 INFO - Running main action method: clobber 07:46:21 INFO - rmtree: /builds/slave/test/build 07:46:21 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:46:22 INFO - Running post-action listener: _resource_record_post_action 07:46:22 INFO - [mozharness: 2017-09-21 14:46:22.505437Z] Finished clobber step (success) 07:46:22 INFO - [mozharness: 2017-09-21 14:46:22.505534Z] Running read-buildbot-config step. 07:46:22 INFO - Running pre-action listener: _resource_record_pre_action 07:46:22 INFO - Running main action method: read_buildbot_config 07:46:22 INFO - Using buildbot properties: 07:46:22 INFO - { 07:46:22 INFO - "project": "", 07:46:22 INFO - "product": "firefox", 07:46:22 INFO - "who": "archaeopteryx@coole-files.de", 07:46:22 INFO - "installer_path": "public/build/target.tar.bz2", 07:46:22 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 07:46:22 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 07:46:22 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-stylo-disabled-e10s", 07:46:22 INFO - "stage_platform": "linux64-pgo", 07:46:22 INFO - "basedir": "/builds/slave/test", 07:46:22 INFO - "buildnumber": 44, 07:46:22 INFO - "platform": "ubuntu64_hw", 07:46:22 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 07:46:22 INFO - "slavebuilddir": "test", 07:46:22 INFO - "taskId": "WV8Vd9dJRVeXYop00rT-9g", 07:46:22 INFO - "branch": "mozilla-central", 07:46:22 INFO - "script_repo_revision": "production", 07:46:22 INFO - "revision": "f7e9777221a34f9f23c2e4933307eb38b621b679", 07:46:22 INFO - "slavename": "talos-linux64-ix-028", 07:46:22 INFO - "repo_path": "mozilla-central" 07:46:22 INFO - } 07:46:22 INFO - Finding installer, test and symbols from parent task. 07:46:22 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WV8Vd9dJRVeXYop00rT-9g'}, attempt #1 07:46:22 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WV8Vd9dJRVeXYop00rT-9g'}, attempt #1 07:46:23 INFO - Task dependencies: UMmLAK4MS9-u7NhJjbWm7w 07:46:23 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UMmLAK4MS9-u7NhJjbWm7w'}, attempt #1 07:46:23 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/UMmLAK4MS9-u7NhJjbWm7w/artifacts/public/build/target.tar.bz2 07:46:23 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/UMmLAK4MS9-u7NhJjbWm7w/artifacts/public/build/target.test_packages.json 07:46:23 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/UMmLAK4MS9-u7NhJjbWm7w/artifacts/public/build/target.crashreporter-symbols.zip 07:46:23 INFO - Running post-action listener: _resource_record_post_action 07:46:23 INFO - [mozharness: 2017-09-21 14:46:23.850389Z] Finished read-buildbot-config step (success) 07:46:23 INFO - [mozharness: 2017-09-21 14:46:23.850640Z] Running download-and-extract step. 07:46:23 INFO - Running pre-action listener: _resource_record_pre_action 07:46:23 INFO - Running main action method: download_and_extract 07:46:23 INFO - mkdir: /builds/slave/test/build/tests 07:46:23 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')]} 07:46:23 INFO - trying https://queue.taskcluster.net/v1/task/UMmLAK4MS9-u7NhJjbWm7w/artifacts/public/build/target.test_packages.json 07:46:23 INFO - Downloading https://queue.taskcluster.net/v1/task/UMmLAK4MS9-u7NhJjbWm7w/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 07:46:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UMmLAK4MS9-u7NhJjbWm7w/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 07:46:24 INFO - Downloaded 989 bytes. 07:46:24 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 07:46:24 INFO - Using the following test package requirements: 07:46:24 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 07:46:24 INFO - u'common': [u'target.common.tests.zip'], 07:46:24 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 07:46:24 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 07:46:24 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 07:46:24 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 07:46:24 INFO - u'mozbase': [u'target.common.tests.zip'], 07:46:24 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 07:46:24 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 07:46:24 INFO - u'web-platform': [u'target.common.tests.zip', 07:46:24 INFO - u'target.web-platform.tests.tar.gz'], 07:46:24 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 07:46:24 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 07:46:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UMmLAK4MS9-u7NhJjbWm7w/artifacts/public/build/target.common.tests.zip 07:46:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UMmLAK4MS9-u7NhJjbWm7w/artifacts/public/build/target.common.tests.zip'}, attempt #1 07:46:24 INFO - Fetch https://queue.taskcluster.net/v1/task/UMmLAK4MS9-u7NhJjbWm7w/artifacts/public/build/target.common.tests.zip into memory 07:46:26 INFO - Content-Length response header: 55332910 07:46:26 INFO - Bytes received: 55332910 07:46:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UMmLAK4MS9-u7NhJjbWm7w/artifacts/public/build/target.talos.tests.zip 07:46:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UMmLAK4MS9-u7NhJjbWm7w/artifacts/public/build/target.talos.tests.zip'}, attempt #1 07:46:37 INFO - Fetch https://queue.taskcluster.net/v1/task/UMmLAK4MS9-u7NhJjbWm7w/artifacts/public/build/target.talos.tests.zip into memory 07:46:38 INFO - Content-Length response header: 14509184 07:46:38 INFO - Bytes received: 14509184 07:46:38 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')]} 07:46:38 INFO - trying https://queue.taskcluster.net/v1/task/UMmLAK4MS9-u7NhJjbWm7w/artifacts/public/build/target.tar.bz2 07:46:38 INFO - Downloading https://queue.taskcluster.net/v1/task/UMmLAK4MS9-u7NhJjbWm7w/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 07:46:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UMmLAK4MS9-u7NhJjbWm7w/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 07:46:42 INFO - Downloaded 62318367 bytes. 07:46:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UMmLAK4MS9-u7NhJjbWm7w/artifacts/public/build/target.tar.bz2 07:46:42 INFO - mkdir: /builds/slave/test/properties 07:46:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:46:42 INFO - Writing to file /builds/slave/test/properties/build_url 07:46:42 INFO - Contents: 07:46:42 INFO - build_url:https://queue.taskcluster.net/v1/task/UMmLAK4MS9-u7NhJjbWm7w/artifacts/public/build/target.tar.bz2 07:46:42 INFO - Running post-action listener: _resource_record_post_action 07:46:42 INFO - Running post-action listener: find_tests_for_verification 07:46:42 INFO - Running post-action listener: set_extra_try_arguments 07:46:42 INFO - [mozharness: 2017-09-21 14:46:42.288783Z] Finished download-and-extract step (success) 07:46:42 INFO - [mozharness: 2017-09-21 14:46:42.288879Z] Running populate-webroot step. 07:46:42 INFO - Running pre-action listener: _resource_record_pre_action 07:46:42 INFO - Running main action method: populate_webroot 07:46:42 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:46:42 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 07:46:42 INFO - 'tests': ['tresize', 07:46:42 INFO - 'tcanvasmark']}, 07:46:42 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:46:42 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 07:46:42 INFO - 'tests': ['dromaeo_css', 07:46:42 INFO - 'kraken']}, 07:46:42 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 07:46:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:46:42 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 07:46:42 INFO - 'talos_options': ['--disable-stylo'], 07:46:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:46:42 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 07:46:42 INFO - 'tests': ['damp', 'tps']}, 07:46:42 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 07:46:42 INFO - 'talos_options': ['--disable-stylo'], 07:46:42 INFO - 'tests': ['damp', 'tps']}, 07:46:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:46:42 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 07:46:42 INFO - 'tests': ['dromaeo_dom']}, 07:46:42 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 07:46:42 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 07:46:42 INFO - 'tests': ['basic_compositor_video', 07:46:42 INFO - 'glvideo']}, 07:46:42 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 07:46:42 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 07:46:42 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 07:46:42 INFO - 'talos_options': ['--disable-stylo'], 07:46:42 INFO - 'tests': ['ts_paint_webext', 07:46:42 INFO - 'tp5o_webext']}, 07:46:42 INFO - 'other-e10s': {'tests': ['a11yr', 07:46:42 INFO - 'ts_paint', 07:46:42 INFO - 'tpaint', 07:46:42 INFO - 'sessionrestore', 07:46:42 INFO - 'sessionrestore_many_windows', 07:46:42 INFO - 'sessionrestore_no_auto_restore', 07:46:42 INFO - 'tabpaint']}, 07:46:42 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 07:46:42 INFO - 'tests': ['a11yr', 07:46:42 INFO - 'ts_paint', 07:46:42 INFO - 'tpaint', 07:46:42 INFO - 'sessionrestore', 07:46:42 INFO - 'sessionrestore_many_windows', 07:46:42 INFO - 'sessionrestore_no_auto_restore', 07:46:42 INFO - 'tabpaint']}, 07:46:42 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 07:46:42 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 07:46:42 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 07:46:42 INFO - 'tests': ['perf_reftest_singletons']}, 07:46:42 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 07:46:42 INFO - 'tests': ['bloom_basic']}, 07:46:42 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:46:42 INFO - 'tsvgr_opacity', 07:46:42 INFO - 'tart', 07:46:42 INFO - 'tscrollx', 07:46:42 INFO - 'tsvg_static']}, 07:46:42 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 07:46:42 INFO - 'tests': ['tsvgx', 07:46:42 INFO - 'tsvgr_opacity', 07:46:42 INFO - 'tart', 07:46:42 INFO - 'tscrollx', 07:46:42 INFO - 'tsvg_static']}, 07:46:42 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 07:46:42 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 07:46:42 INFO - 'talos_options': ['--disable-stylo'], 07:46:42 INFO - 'tests': ['tp5o']}, 07:46:42 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 07:46:42 INFO - 'talos_options': ['--mitmproxy', 07:46:42 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 07:46:42 INFO - '--firstNonBlankPaint'], 07:46:42 INFO - 'tests': ['tp6_google', 07:46:42 INFO - 'tp6_youtube', 07:46:42 INFO - 'tp6_amazon', 07:46:42 INFO - 'tp6_facebook']}, 07:46:42 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 07:46:42 INFO - 'talos_options': ['--disable-stylo', 07:46:42 INFO - '--mitmproxy', 07:46:42 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 07:46:42 INFO - '--firstNonBlankPaint'], 07:46:42 INFO - 'tests': ['tp6_google', 07:46:42 INFO - 'tp6_youtube', 07:46:42 INFO - 'tp6_amazon', 07:46:42 INFO - 'tp6_facebook']}, 07:46:42 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 07:46:42 INFO - 'talos_options': ['--stylo-threads=1', 07:46:42 INFO - '--mitmproxy', 07:46:42 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 07:46:42 INFO - '--firstNonBlankPaint'], 07:46:42 INFO - 'tests': ['tp6_google', 07:46:42 INFO - 'tp6_youtube', 07:46:42 INFO - 'tp6_amazon', 07:46:42 INFO - 'tp6_facebook']}, 07:46:42 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 07:46:42 INFO - 'talos_options': ['--xperf_path', 07:46:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:46:42 INFO - 'tests': ['tp5n']}, 07:46:42 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 07:46:42 INFO - 'talos_options': ['--disable-stylo', 07:46:42 INFO - '--xperf_path', 07:46:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:46:42 INFO - 'tests': ['tp5n']}}} 07:46:42 INFO - Running post-action listener: _resource_record_post_action 07:46:42 INFO - [mozharness: 2017-09-21 14:46:42.304010Z] Finished populate-webroot step (success) 07:46:42 INFO - [mozharness: 2017-09-21 14:46:42.304100Z] Running create-virtualenv step. 07:46:42 INFO - Running pre-action listener: _resource_record_pre_action 07:46:42 INFO - Running main action method: create_virtualenv 07:46:42 INFO - Creating virtualenv /builds/slave/test/build/venv 07:46:42 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 07:46:42 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 07:46:42 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 07:46:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:46:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:46:42 INFO - Installing distribute.............................................................................................................................................................................................done. 07:46:43 INFO - Installing pip...............done. 07:46:43 INFO - Return code: 0 07:46:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:46:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:46:43 INFO - Reading from file tmpfile_stdout 07:46:43 INFO - Output received: 07:46:43 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 07:46:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:46: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')]} 07:46:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:46: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')]} 07:46:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:46: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13e11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15aaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x174da60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1751090>, '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 0x1751d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x174bf90>, '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': '836cfdc75598d54cb747368e000001a9-1506004283.846174-877056714', '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 07:46: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', 'pip>=1.5'] in /builds/slave/test/build 07:46: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 pip>=1.5 07:46:43 INFO - Using env: {'DISPLAY': ':0', 07:46:43 INFO - 'HOME': '/home/cltbld', 07:46:43 INFO - 'LANG': 'en_US.UTF-8', 07:46:43 INFO - 'LANGUAGE': 'en_US:en', 07:46:43 INFO - 'LOGNAME': 'cltbld', 07:46:43 INFO - 'MAIL': '/var/mail/cltbld', 07:46:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:46:43 INFO - 'MOZ_NO_REMOTE': '1', 07:46:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:46:43 INFO - 'NO_EM_RESTART': '1', 07:46:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:46:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:46:43 INFO - 'PWD': '/builds/slave/test', 07:46:43 INFO - 'SHELL': '/bin/bash', 07:46:43 INFO - 'SHLVL': '1', 07:46:43 INFO - 'TERM': 'linux', 07:46:43 INFO - 'TMOUT': '86400', 07:46:43 INFO - 'USER': 'cltbld', 07:46:43 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1506004283.846174-877056714', 07:46:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:46:43 INFO - '_': '/tools/buildbot/bin/python'} 07:46:44 INFO - Ignoring indexes: http://pypi.python.org/simple/ 07:46:44 INFO - Downloading/unpacking pip>=1.5 07:46:44 INFO - Running setup.py egg_info for package pip 07:46:44 INFO - warning: no files found matching 'pip/cacert.pem' 07:46:44 INFO - warning: no files found matching '*.html' under directory 'docs' 07:46:44 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 07:46:44 INFO - no previously-included directories found matching 'docs/_build/_sources' 07:46:44 INFO - Installing collected packages: pip 07:46:44 INFO - Found existing installation: pip 1.1 07:46:44 INFO - Uninstalling pip: 07:46:44 INFO - Successfully uninstalled pip 07:46:44 INFO - Running setup.py install for pip 07:46:44 INFO - warning: no files found matching 'pip/cacert.pem' 07:46:44 INFO - warning: no files found matching '*.html' under directory 'docs' 07:46:44 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 07:46:44 INFO - no previously-included directories found matching 'docs/_build/_sources' 07:46:44 INFO - Installing pip script to /builds/slave/test/build/venv/bin 07:46:44 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 07:46:44 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 07:46:44 INFO - Successfully installed pip 07:46:44 INFO - Cleaning up... 07:46:44 INFO - Return code: 0 07:46:44 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:46:44 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')]} 07:46:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:46:44 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')]} 07:46:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:46:44 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 0x13e11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15aaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x174da60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1751090>, '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 0x1751d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x174bf90>, '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': '836cfdc75598d54cb747368e000001a9-1506004283.846174-877056714', '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 07:46:44 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 07:46:44 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 07:46:44 INFO - Using env: {'DISPLAY': ':0', 07:46:44 INFO - 'HOME': '/home/cltbld', 07:46:44 INFO - 'LANG': 'en_US.UTF-8', 07:46:44 INFO - 'LANGUAGE': 'en_US:en', 07:46:44 INFO - 'LOGNAME': 'cltbld', 07:46:44 INFO - 'MAIL': '/var/mail/cltbld', 07:46:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:46:44 INFO - 'MOZ_NO_REMOTE': '1', 07:46:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:46:44 INFO - 'NO_EM_RESTART': '1', 07:46:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:46:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:46:44 INFO - 'PWD': '/builds/slave/test', 07:46:44 INFO - 'SHELL': '/bin/bash', 07:46:44 INFO - 'SHLVL': '1', 07:46:44 INFO - 'TERM': 'linux', 07:46:44 INFO - 'TMOUT': '86400', 07:46:44 INFO - 'USER': 'cltbld', 07:46:44 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1506004283.846174-877056714', 07:46:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:46:44 INFO - '_': '/tools/buildbot/bin/python'} 07:46:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:46:44 INFO - Downloading/unpacking psutil>=3.1.1 07:46:44 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 07:46:44 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 07:46:44 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 07:46:44 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 07:46:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:46:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:46:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:46:46 INFO - Installing collected packages: psutil 07:46:46 INFO - Running setup.py install for psutil 07:46:46 INFO - building 'psutil._psutil_linux' extension 07:46:46 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 07:46:46 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 07:46:46 INFO - building 'psutil._psutil_posix' extension 07:46:46 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 07:46:46 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 07:46:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:46:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:46:47 INFO - Successfully installed psutil 07:46:47 INFO - Cleaning up... 07:46:48 INFO - Return code: 0 07:46:48 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:46:48 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')]} 07:46:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:46:48 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')]} 07:46:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:46:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x13e11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15aaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x174da60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1751090>, '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 0x1751d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x174bf90>, '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': '836cfdc75598d54cb747368e000001a9-1506004283.846174-877056714', '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 07:46:48 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 07:46:48 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 07:46:48 INFO - Using env: {'DISPLAY': ':0', 07:46:48 INFO - 'HOME': '/home/cltbld', 07:46:48 INFO - 'LANG': 'en_US.UTF-8', 07:46:48 INFO - 'LANGUAGE': 'en_US:en', 07:46:48 INFO - 'LOGNAME': 'cltbld', 07:46:48 INFO - 'MAIL': '/var/mail/cltbld', 07:46:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:46:48 INFO - 'MOZ_NO_REMOTE': '1', 07:46:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:46:48 INFO - 'NO_EM_RESTART': '1', 07:46:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:46:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:46:48 INFO - 'PWD': '/builds/slave/test', 07:46:48 INFO - 'SHELL': '/bin/bash', 07:46:48 INFO - 'SHLVL': '1', 07:46:48 INFO - 'TERM': 'linux', 07:46:48 INFO - 'TMOUT': '86400', 07:46:48 INFO - 'USER': 'cltbld', 07:46:48 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1506004283.846174-877056714', 07:46:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:46:48 INFO - '_': '/tools/buildbot/bin/python'} 07:46:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:46:48 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:46:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:46:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:46:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:46:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:46:50 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:46:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:46:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:46:50 INFO - Installing collected packages: mozsystemmonitor 07:46:50 INFO - Running setup.py install for mozsystemmonitor 07:46:50 INFO - Successfully installed mozsystemmonitor 07:46:50 INFO - Cleaning up... 07:46:50 INFO - Return code: 0 07:46:50 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:46:50 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')]} 07:46:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:46:50 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')]} 07:46:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:46:50 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 0x13e11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15aaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x174da60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1751090>, '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 0x1751d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x174bf90>, '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': '836cfdc75598d54cb747368e000001a9-1506004283.846174-877056714', '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 07:46:50 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 07:46:50 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 07:46:50 INFO - Using env: {'DISPLAY': ':0', 07:46:50 INFO - 'HOME': '/home/cltbld', 07:46:50 INFO - 'LANG': 'en_US.UTF-8', 07:46:50 INFO - 'LANGUAGE': 'en_US:en', 07:46:50 INFO - 'LOGNAME': 'cltbld', 07:46:50 INFO - 'MAIL': '/var/mail/cltbld', 07:46:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:46:50 INFO - 'MOZ_NO_REMOTE': '1', 07:46:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:46:50 INFO - 'NO_EM_RESTART': '1', 07:46:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:46:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:46:50 INFO - 'PWD': '/builds/slave/test', 07:46:50 INFO - 'SHELL': '/bin/bash', 07:46:50 INFO - 'SHLVL': '1', 07:46:50 INFO - 'TERM': 'linux', 07:46:50 INFO - 'TMOUT': '86400', 07:46:50 INFO - 'USER': 'cltbld', 07:46:50 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1506004283.846174-877056714', 07:46:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:46:50 INFO - '_': '/tools/buildbot/bin/python'} 07:46:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:46:50 INFO - Downloading/unpacking jsonschema==2.5.1 07:46:50 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 07:46:50 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 07:46:50 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 07:46:50 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 07:46:52 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:46:52 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:46:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:46:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:46:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:46:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:46:53 INFO - Downloading functools32-3.2.3-2.tar.gz 07:46:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:46:53 INFO - warning: no files found matching '*.txt' 07:46:53 INFO - no previously-included directories found matching 'build' 07:46:53 INFO - no previously-included directories found matching 'dist' 07:46:53 INFO - no previously-included directories found matching '.git*' 07:46:53 INFO - Installing collected packages: jsonschema, functools32 07:46:53 INFO - Running setup.py install for functools32 07:46:53 INFO - warning: no files found matching '*.txt' 07:46:53 INFO - no previously-included directories found matching 'build' 07:46:53 INFO - no previously-included directories found matching 'dist' 07:46:53 INFO - no previously-included directories found matching '.git*' 07:46:53 INFO - Successfully installed jsonschema functools32 07:46:53 INFO - Cleaning up... 07:46:53 INFO - Return code: 0 07:46:53 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:46:53 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')]} 07:46:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:46:53 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')]} 07:46:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:46:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x13e11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15aaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x174da60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1751090>, '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 0x1751d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x174bf90>, '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': '836cfdc75598d54cb747368e000001a9-1506004283.846174-877056714', '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 07:46:53 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 07:46:53 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 07:46:53 INFO - Using env: {'DISPLAY': ':0', 07:46:53 INFO - 'HOME': '/home/cltbld', 07:46:53 INFO - 'LANG': 'en_US.UTF-8', 07:46:53 INFO - 'LANGUAGE': 'en_US:en', 07:46:53 INFO - 'LOGNAME': 'cltbld', 07:46:53 INFO - 'MAIL': '/var/mail/cltbld', 07:46:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:46:53 INFO - 'MOZ_NO_REMOTE': '1', 07:46:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:46:53 INFO - 'NO_EM_RESTART': '1', 07:46:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:46:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:46:53 INFO - 'PWD': '/builds/slave/test', 07:46:53 INFO - 'SHELL': '/bin/bash', 07:46:53 INFO - 'SHLVL': '1', 07:46:53 INFO - 'TERM': 'linux', 07:46:53 INFO - 'TMOUT': '86400', 07:46:53 INFO - 'USER': 'cltbld', 07:46:53 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1506004283.846174-877056714', 07:46:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:46:53 INFO - '_': '/tools/buildbot/bin/python'} 07:46:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:46:53 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:46:53 INFO - Cleaning up... 07:46:53 INFO - Return code: 0 07:46:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:46:53 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')]} 07:46:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:46:53 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')]} 07:46:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:46:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x13e11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15aaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x174da60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1751090>, '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 0x1751d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x174bf90>, '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': '836cfdc75598d54cb747368e000001a9-1506004283.846174-877056714', '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 07:46:53 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 07:46:53 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 07:46:53 INFO - Using env: {'DISPLAY': ':0', 07:46:53 INFO - 'HOME': '/home/cltbld', 07:46:53 INFO - 'LANG': 'en_US.UTF-8', 07:46:53 INFO - 'LANGUAGE': 'en_US:en', 07:46:53 INFO - 'LOGNAME': 'cltbld', 07:46:53 INFO - 'MAIL': '/var/mail/cltbld', 07:46:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:46:53 INFO - 'MOZ_NO_REMOTE': '1', 07:46:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:46:53 INFO - 'NO_EM_RESTART': '1', 07:46:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:46:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:46:53 INFO - 'PWD': '/builds/slave/test', 07:46:53 INFO - 'SHELL': '/bin/bash', 07:46:53 INFO - 'SHLVL': '1', 07:46:53 INFO - 'TERM': 'linux', 07:46:53 INFO - 'TMOUT': '86400', 07:46:53 INFO - 'USER': 'cltbld', 07:46:53 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1506004283.846174-877056714', 07:46:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:46:53 INFO - '_': '/tools/buildbot/bin/python'} 07:46:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:46:53 INFO - Downloading/unpacking blobuploader==1.2.4 07:46:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:46:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:46:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:46:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:46:54 INFO - Downloading blobuploader-1.2.4.tar.gz 07:46:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:46:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:46:54 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 07:46:54 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 07:46:54 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 07:46:54 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 07:46:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:46:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:46:55 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 07:46:55 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 07:46:55 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 07:46:55 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 07:46:55 INFO - Downloading docopt-0.6.1.tar.gz 07:46:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:46:55 INFO - Installing collected packages: blobuploader, requests, docopt 07:46:55 INFO - Running setup.py install for blobuploader 07:46:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:46:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:46:55 INFO - Running setup.py install for requests 07:46:55 INFO - Running setup.py install for docopt 07:46:55 INFO - Successfully installed blobuploader requests docopt 07:46:55 INFO - Cleaning up... 07:46:56 INFO - Return code: 0 07:46:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:46:56 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')]} 07:46:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:46:56 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')]} 07:46:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:46:56 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 0x13e11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15aaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x174da60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1751090>, '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 0x1751d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x174bf90>, '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': '836cfdc75598d54cb747368e000001a9-1506004283.846174-877056714', '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 07:46:56 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 07:46:56 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 07:46:56 INFO - Using env: {'DISPLAY': ':0', 07:46:56 INFO - 'HOME': '/home/cltbld', 07:46:56 INFO - 'LANG': 'en_US.UTF-8', 07:46:56 INFO - 'LANGUAGE': 'en_US:en', 07:46:56 INFO - 'LOGNAME': 'cltbld', 07:46:56 INFO - 'MAIL': '/var/mail/cltbld', 07:46:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:46:56 INFO - 'MOZ_NO_REMOTE': '1', 07:46:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:46:56 INFO - 'NO_EM_RESTART': '1', 07:46:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:46:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:46:56 INFO - 'PWD': '/builds/slave/test', 07:46:56 INFO - 'SHELL': '/bin/bash', 07:46:56 INFO - 'SHLVL': '1', 07:46:56 INFO - 'TERM': 'linux', 07:46:56 INFO - 'TMOUT': '86400', 07:46:56 INFO - 'USER': 'cltbld', 07:46:56 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1506004283.846174-877056714', 07:46:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:46:56 INFO - '_': '/tools/buildbot/bin/python'} 07:46:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:46:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:46:56 INFO - Running setup.py (path:/tmp/pip-dWiPAQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:46:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:46:56 INFO - Running setup.py (path:/tmp/pip-i6h2t3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:46:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:46:56 INFO - Running setup.py (path:/tmp/pip-0pGFs8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:46:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:46:56 INFO - Running setup.py (path:/tmp/pip-iu5pUY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:46:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:46:56 INFO - Running setup.py (path:/tmp/pip-xLeZks-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:46:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:46:56 INFO - Running setup.py (path:/tmp/pip-0F6bnh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:46:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:46:56 INFO - Running setup.py (path:/tmp/pip-SYenfA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:46:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:46:56 INFO - Running setup.py (path:/tmp/pip-VtZ4kW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:46:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:46:56 INFO - Running setup.py (path:/tmp/pip-4hmqx5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:46:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:46:56 INFO - Running setup.py (path:/tmp/pip-nhflN_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:46:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:46:56 INFO - Running setup.py (path:/tmp/pip-DZX9uc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:46:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:46:57 INFO - Running setup.py (path:/tmp/pip-KbGr0L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:46:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:46:57 INFO - Running setup.py (path:/tmp/pip-ieOvoW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:46:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:46:57 INFO - Running setup.py (path:/tmp/pip-q9z0vd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:46:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:46:57 INFO - Running setup.py (path:/tmp/pip-YjpQld-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:46:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:46:57 INFO - Running setup.py (path:/tmp/pip-nfJ4jG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:46:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:46:57 INFO - Running setup.py (path:/tmp/pip-wYw1Bz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:46:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:46:57 INFO - Running setup.py install for manifestparser 07:46:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:46:57 INFO - Running setup.py install for mozcrash 07:46:57 INFO - Running setup.py install for mozdebug 07:46:57 INFO - Running setup.py install for mozdevice 07:46:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:46:57 INFO - Running setup.py install for mozfile 07:46:57 INFO - Running setup.py install for mozhttpd 07:46:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:46:58 INFO - Running setup.py install for mozinfo 07:46:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:46:58 INFO - Running setup.py install for mozInstall 07:46:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:46:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:46:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:46:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:46:58 INFO - Running setup.py install for mozleak 07:46:58 INFO - Running setup.py install for mozlog 07:46:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:46:58 INFO - Running setup.py install for moznetwork 07:46:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:46:58 INFO - Running setup.py install for mozprocess 07:46:58 INFO - Running setup.py install for mozprofile 07:46:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:46:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:46:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:46:58 INFO - Running setup.py install for mozrunner 07:46:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:46:58 INFO - Running setup.py install for mozscreenshot 07:46:58 INFO - Running setup.py install for moztest 07:46:59 INFO - Running setup.py install for mozversion 07:46:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:46:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:46:59 INFO - Cleaning up... 07:46:59 INFO - Return code: 0 07:46:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:46:59 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')]} 07:46:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:46:59 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')]} 07:46:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:46:59 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 0x13e11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15aaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x174da60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1751090>, '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 0x1751d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x174bf90>, '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': '836cfdc75598d54cb747368e000001a9-1506004283.846174-877056714', '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 07:46:59 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 07:46:59 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 07:46:59 INFO - Using env: {'DISPLAY': ':0', 07:46:59 INFO - 'HOME': '/home/cltbld', 07:46:59 INFO - 'LANG': 'en_US.UTF-8', 07:46:59 INFO - 'LANGUAGE': 'en_US:en', 07:46:59 INFO - 'LOGNAME': 'cltbld', 07:46:59 INFO - 'MAIL': '/var/mail/cltbld', 07:46:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:46:59 INFO - 'MOZ_NO_REMOTE': '1', 07:46:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:46:59 INFO - 'NO_EM_RESTART': '1', 07:46:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:46:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:46:59 INFO - 'PWD': '/builds/slave/test', 07:46:59 INFO - 'SHELL': '/bin/bash', 07:46:59 INFO - 'SHLVL': '1', 07:46:59 INFO - 'TERM': 'linux', 07:46:59 INFO - 'TMOUT': '86400', 07:46:59 INFO - 'USER': 'cltbld', 07:46:59 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1506004283.846174-877056714', 07:46:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:46:59 INFO - '_': '/tools/buildbot/bin/python'} 07:46:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:46:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:46:59 INFO - Running setup.py (path:/tmp/pip-baGqKl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:46:59 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)) 07:46:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:46:59 INFO - Running setup.py (path:/tmp/pip-0D2Uv5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:46:59 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)) 07:46:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:46:59 INFO - Running setup.py (path:/tmp/pip-X0HsBe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:46:59 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)) 07:46:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:46:59 INFO - Running setup.py (path:/tmp/pip-TI10FZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:46:59 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)) 07:46:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:46:59 INFO - Running setup.py (path:/tmp/pip-rj_omZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:46:59 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)) 07:46:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:46:59 INFO - Running setup.py (path:/tmp/pip-TN7svw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:46:59 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)) 07:46:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:46:59 INFO - Running setup.py (path:/tmp/pip-1tzYXR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:46:59 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)) 07:46:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:46:59 INFO - Running setup.py (path:/tmp/pip-OFVwm0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:47:00 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)) 07:47:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:47:00 INFO - Running setup.py (path:/tmp/pip-jk2md0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:47:00 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)) 07:47:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:47:00 INFO - Running setup.py (path:/tmp/pip-RyrmgS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:47:00 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)) 07:47:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:47:00 INFO - Running setup.py (path:/tmp/pip-u9X8Tf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:47:00 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)) 07:47:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:47:00 INFO - Running setup.py (path:/tmp/pip-teMAGk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:47:00 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)) 07:47:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:47:00 INFO - Running setup.py (path:/tmp/pip-JXp99J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:47:00 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)) 07:47:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:47:00 INFO - Running setup.py (path:/tmp/pip-ApD8sJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:47:00 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)) 07:47:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:47:00 INFO - Running setup.py (path:/tmp/pip-IXF7uW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:47:00 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)) 07:47:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:47:00 INFO - Running setup.py (path:/tmp/pip-ZGgWU1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:47:00 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)) 07:47:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:47:00 INFO - Running setup.py (path:/tmp/pip-88FDM9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:47:00 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)) 07:47:00 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)) 07:47:00 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)) 07:47:00 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)) 07:47:00 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)) 07:47:00 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)) 07:47:00 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)) 07:47:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:47:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:47:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:47:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:47:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:47:01 INFO - Downloading blessings-1.6.tar.gz 07:47:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:47:01 INFO - Installing collected packages: blessings 07:47:01 INFO - Running setup.py install for blessings 07:47:01 INFO - Successfully installed blessings 07:47:01 INFO - Cleaning up... 07:47:01 INFO - Return code: 0 07:47:01 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:47:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:47:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:47:02 INFO - Reading from file tmpfile_stdout 07:47:02 INFO - Current package versions: 07:47:02 INFO - argparse == 1.2.1 07:47:02 INFO - blessings == 1.6 07:47:02 INFO - blobuploader == 1.2.4 07:47:02 INFO - docopt == 0.6.1 07:47:02 INFO - functools32 == 3.2.3-2 07:47:02 INFO - jsonschema == 2.5.1 07:47:02 INFO - manifestparser == 1.1 07:47:02 INFO - mozInstall == 1.13 07:47:02 INFO - mozcrash == 1.0 07:47:02 INFO - mozdebug == 0.1 07:47:02 INFO - mozdevice == 0.51 07:47:02 INFO - mozfile == 1.2 07:47:02 INFO - mozhttpd == 0.7 07:47:02 INFO - mozinfo == 0.10 07:47:02 INFO - mozleak == 0.1 07:47:02 INFO - mozlog == 3.5 07:47:02 INFO - moznetwork == 0.27 07:47:02 INFO - mozprocess == 0.25 07:47:02 INFO - mozprofile == 0.28 07:47:02 INFO - mozrunner == 6.13 07:47:02 INFO - mozscreenshot == 0.1 07:47:02 INFO - mozsystemmonitor == 0.3 07:47:02 INFO - moztest == 0.8 07:47:02 INFO - mozversion == 1.4 07:47:02 INFO - psutil == 3.1.1 07:47:02 INFO - requests == 1.2.3 07:47:02 INFO - wsgiref == 0.1.2 07:47:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:47:02 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')]} 07:47:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:47:02 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')]} 07:47:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:47:02 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 0x13e11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15aaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x174da60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1751090>, '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 0x1751d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x174bf90>, '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': '836cfdc75598d54cb747368e000001a9-1506004283.846174-877056714', '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 07:47:02 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 07:47:02 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 07:47:02 INFO - Using env: {'DISPLAY': ':0', 07:47:02 INFO - 'HOME': '/home/cltbld', 07:47:02 INFO - 'LANG': 'en_US.UTF-8', 07:47:02 INFO - 'LANGUAGE': 'en_US:en', 07:47:02 INFO - 'LOGNAME': 'cltbld', 07:47:02 INFO - 'MAIL': '/var/mail/cltbld', 07:47:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:47:02 INFO - 'MOZ_NO_REMOTE': '1', 07:47:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:47:02 INFO - 'NO_EM_RESTART': '1', 07:47:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:47:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:47:02 INFO - 'PWD': '/builds/slave/test', 07:47:02 INFO - 'SHELL': '/bin/bash', 07:47:02 INFO - 'SHLVL': '1', 07:47:02 INFO - 'TERM': 'linux', 07:47:02 INFO - 'TMOUT': '86400', 07:47:02 INFO - 'USER': 'cltbld', 07:47:02 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1506004283.846174-877056714', 07:47:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:47:02 INFO - '_': '/tools/buildbot/bin/python'} 07:47:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:47:02 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)) 07:47:02 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)) 07:47:02 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)) 07:47:02 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)) 07:47:02 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)) 07:47:02 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)) 07:47:02 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)) 07:47:02 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)) 07:47:02 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)) 07:47:02 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 07:47:02 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 07:47:02 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 07:47:02 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 07:47:02 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 07:47:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 07:47:10 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)) 07:47:10 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)) 07:47:10 INFO - Installing collected packages: simplejson 07:47:10 INFO - Running setup.py install for simplejson 07:47:10 INFO - building 'simplejson._speedups' extension 07:47:10 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 07:47:11 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 07:47:11 INFO - Successfully installed simplejson 07:47:11 INFO - Cleaning up... 07:47:11 INFO - Return code: 0 07:47:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:47:11 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')]} 07:47:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:47:11 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')]} 07:47:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:47:11 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 0x13e11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15aaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x174da60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1751090>, '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 0x1751d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x174bf90>, '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': '836cfdc75598d54cb747368e000001a9-1506004283.846174-877056714', '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 07:47:11 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 07:47:11 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 07:47:11 INFO - Using env: {'DISPLAY': ':0', 07:47:11 INFO - 'HOME': '/home/cltbld', 07:47:11 INFO - 'LANG': 'en_US.UTF-8', 07:47:11 INFO - 'LANGUAGE': 'en_US:en', 07:47:11 INFO - 'LOGNAME': 'cltbld', 07:47:11 INFO - 'MAIL': '/var/mail/cltbld', 07:47:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:47:11 INFO - 'MOZ_NO_REMOTE': '1', 07:47:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:47:11 INFO - 'NO_EM_RESTART': '1', 07:47:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:47:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:47:11 INFO - 'PWD': '/builds/slave/test', 07:47:11 INFO - 'SHELL': '/bin/bash', 07:47:11 INFO - 'SHLVL': '1', 07:47:11 INFO - 'TERM': 'linux', 07:47:11 INFO - 'TMOUT': '86400', 07:47:11 INFO - 'USER': 'cltbld', 07:47:11 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1506004283.846174-877056714', 07:47:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:47:11 INFO - '_': '/tools/buildbot/bin/python'} 07:47:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:47:11 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:47:11 INFO - Cleaning up... 07:47:11 INFO - Return code: 0 07:47:11 INFO - Running post-action listener: _resource_record_post_action 07:47:11 INFO - Running post-action listener: _start_resource_monitoring 07:47:11 INFO - Starting resource monitoring. 07:47:11 INFO - [mozharness: 2017-09-21 14:47:11.917411Z] Finished create-virtualenv step (success) 07:47:11 INFO - [mozharness: 2017-09-21 14:47:11.917926Z] Running install step. 07:47:11 INFO - Running pre-action listener: _resource_record_pre_action 07:47:11 INFO - Running main action method: install 07:47:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:47:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:47:12 INFO - Reading from file tmpfile_stdout 07:47:12 INFO - Detecting whether we're running mozinstall >=1.0... 07:47:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:47:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:47:12 INFO - Reading from file tmpfile_stdout 07:47:12 INFO - Output received: 07:47:12 INFO - Usage: mozinstall [options] installer 07:47:12 INFO - Options: 07:47:12 INFO - -h, --help show this help message and exit 07:47:12 INFO - -d DEST, --destination=DEST 07:47:12 INFO - Directory to install application into. [default: 07:47:12 INFO - "/builds/slave/test"] 07:47:12 INFO - --app=APP Application being installed. [default: firefox] 07:47:12 INFO - mkdir: /builds/slave/test/build/application 07:47:12 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'] 07:47:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 07:47:29 INFO - Reading from file tmpfile_stdout 07:47:29 INFO - Output received: 07:47:29 INFO - /builds/slave/test/build/application/firefox/firefox 07:47:29 INFO - Running post-action listener: _resource_record_post_action 07:47:29 INFO - [mozharness: 2017-09-21 14:47:29.870460Z] Finished install step (success) 07:47:29 INFO - [mozharness: 2017-09-21 14:47:29.870621Z] Running setup-mitmproxy step. 07:47:29 INFO - Running pre-action listener: _resource_record_pre_action 07:47:29 INFO - Running main action method: setup_mitmproxy 07:47:29 INFO - Skipping: mitmproxy is not required 07:47:29 INFO - Running post-action listener: _resource_record_post_action 07:47:29 INFO - [mozharness: 2017-09-21 14:47:29.871742Z] Finished setup-mitmproxy step (success) 07:47:29 INFO - [mozharness: 2017-09-21 14:47:29.871962Z] Running run-tests step. 07:47:29 INFO - Running pre-action listener: _resource_record_pre_action 07:47:29 INFO - Running pre-action listener: _set_gcov_prefix 07:47:29 INFO - Running main action method: run_tests 07:47:29 WARNING - Try message not found. 07:47:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:47:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:47:29 INFO - Python 2.7.3 07:47:29 INFO - Return code: 0 07:47:29 INFO - grabbing minidump binary from tooltool 07:47: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')]} 07:47:29 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--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 0x1751090>, '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 0x1751d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x174bf90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:47:29 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--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 07:47:29 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 07:47:29 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--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 07:47:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:47:30 INFO - Return code: 0 07:47:30 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:47:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:47:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:47:30 INFO - ENV: RUST_BACKTRACE is now full 07:47:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:47:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:47:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UMmLAK4MS9-u7NhJjbWm7w/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] in /builds/slave/test/build 07:47:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-stylo-disabled-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/UMmLAK4MS9-u7NhJjbWm7w/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-028 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log 07:47:30 INFO - Using env: {'DISPLAY': ':0', 07:47:30 INFO - 'HOME': '/home/cltbld', 07:47:30 INFO - 'LANG': 'en_US.UTF-8', 07:47:30 INFO - 'LANGUAGE': 'en_US:en', 07:47:30 INFO - 'LOGNAME': 'cltbld', 07:47:30 INFO - 'MAIL': '/var/mail/cltbld', 07:47:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:47:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:47:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:47:30 INFO - 'MOZ_NO_REMOTE': '1', 07:47:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:47:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:47:30 INFO - 'NO_EM_RESTART': '1', 07:47:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:47:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:47:30 INFO - 'PWD': '/builds/slave/test', 07:47:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:47:30 INFO - 'RUST_BACKTRACE': 'full', 07:47:30 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 07:47:30 INFO - 'SHELL': '/bin/bash', 07:47:30 INFO - 'SHLVL': '1', 07:47:30 INFO - 'TERM': 'linux', 07:47:30 INFO - 'TMOUT': '86400', 07:47:30 INFO - 'USER': 'cltbld', 07:47:30 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1506004283.846174-877056714', 07:47:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:47:30 INFO - '_': '/tools/buildbot/bin/python'} 07:47:30 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UMmLAK4MS9-u7NhJjbWm7w/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] with output_timeout 3600 07:47:30 INFO - mozversion application_buildid: 20170921132403 07:47:30 INFO - mozversion application_changeset: f7e9777221a34f9f23c2e4933307eb38b621b679 07:47:30 INFO - mozversion application_display_name: Nightly 07:47:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:47:30 INFO - mozversion application_name: Firefox 07:47:30 INFO - mozversion application_remotingname: firefox 07:47:30 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:47:30 INFO - mozversion application_vendor: Mozilla 07:47:30 INFO - mozversion application_version: 57.0a1 07:47:30 INFO - mozversion platform_buildid: 20170921132403 07:47:30 INFO - mozversion platform_changeset: f7e9777221a34f9f23c2e4933307eb38b621b679 07:47:30 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:47:30 INFO - mozversion platform_version: 57.0a1 07:47:30 INFO - using testdate: 1506005250 07:47:30 INFO - actual date: 1506005250 07:47:30 INFO - starting webserver on 'localhost:43847' 07:47:30 INFO - SUITE-START | Running 2 tests 07:47:30 INFO - TEST-START | dromaeo_css 07:47:30 INFO - Initialising browser for dromaeo_css test... 07:47:30 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:43847/getInfo.html -profile /tmp/tmp8YVVvm/profile 07:47:30 INFO - TEST-INFO | started process 5926 (/builds/slave/test/build/application/firefox/firefox http://localhost:43847/getInfo.html) 07:47:35 INFO - TEST-INFO | 5926: exit 0 07:47:35 INFO - Browser initialized. 07:47:35 INFO - Running cycle 1/1 for dromaeo_css test... 07:47:35 INFO - Using env: {'DISPLAY': ':0', 07:47:35 INFO - 'HOME': '/home/cltbld', 07:47:35 INFO - 'JSGC_DISABLE_POISONING': '1', 07:47:35 INFO - 'LANG': 'en_US.UTF-8', 07:47:35 INFO - 'LANGUAGE': 'en_US:en', 07:47:35 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 07:47:35 INFO - 'LOGNAME': 'cltbld', 07:47:35 INFO - 'MAIL': '/var/mail/cltbld', 07:47:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:47:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:47:35 INFO - 'MOZ_CRASHREPORTER': '1', 07:47:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:47:35 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 07:47:35 INFO - 'MOZ_NO_REMOTE': '1', 07:47:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:47:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:47:35 INFO - 'NO_EM_RESTART': '1', 07:47:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:47:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:47:35 INFO - 'PWD': '/builds/slave/test', 07:47:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:47:35 INFO - 'RUST_BACKTRACE': 'full', 07:47:35 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 07:47:35 INFO - 'SHELL': '/bin/bash', 07:47:35 INFO - 'SHLVL': '1', 07:47:35 INFO - 'STYLO_FORCE_DISABLED': '1', 07:47:35 INFO - 'TERM': 'linux', 07:47:35 INFO - 'TMOUT': '86400', 07:47:35 INFO - 'USER': 'cltbld', 07:47:35 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1506004283.846174-877056714', 07:47:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:47:35 INFO - '_': '/tools/buildbot/bin/python'} 07:47:35 INFO - TEST-INFO | started process 6163 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8YVVvm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 07:47:36 INFO - PID 6163 | 07:47:36 INFO - PID 6163 | (/builds/slave/test/build/application/firefox/firefox:6214): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 07:47:36 INFO - PID 6163 | 07:47:46 INFO - PID 6163 | RSS: Main: 148422656 07:47:46 INFO - PID 6163 | 07:50:44 INFO - PID 6163 | Cycle 1(1): loaded http://localhost:43847/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43847/tests/dromaeo/cssquery-ext.html) 07:50:45 INFO - PID 6163 | RSS: Main: 149041152 07:50:45 INFO - PID 6163 | 07:53:47 INFO - PID 6163 | Cycle 1(1): loaded http://localhost:43847/tests/dromaeo/cssquery-ext.html (next: http://localhost:43847/tests/dromaeo/cssquery-jquery.html) 07:53:48 INFO - PID 6163 | RSS: Main: 149307392 07:53:48 INFO - PID 6163 | 07:56:49 INFO - PID 6163 | Cycle 1(1): loaded http://localhost:43847/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43847/tests/dromaeo/cssquery-mootools.html) 07:56:50 INFO - PID 6163 | RSS: Main: 151457792 07:56:50 INFO - PID 6163 | 07:59:51 INFO - PID 6163 | Cycle 1(1): loaded http://localhost:43847/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43847/tests/dromaeo/cssquery-prototype.html) 07:59:52 INFO - PID 6163 | RSS: Main: 149573632 07:59:52 INFO - PID 6163 | 08:02:55 INFO - PID 6163 | Cycle 1(1): loaded http://localhost:43847/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43847/tests/dromaeo/cssquery-yui.html) 08:02:56 INFO - PID 6163 | RSS: Main: 150908928 08:02:56 INFO - PID 6163 | 08:05:57 INFO - PID 6163 | Cycle 1(1): loaded http://localhost:43847/tests/dromaeo/cssquery-yui.html (next: http://localhost:43847/tests/dromaeo/cssquery-dojo.html) 08:05:57 INFO - PID 6163 | RSS: Main: 151941120 08:05:57 INFO - PID 6163 | 08:05:57 INFO - PID 6163 | __start_tp_report 08:05:57 INFO - PID 6163 | _x_x_mozilla_page_load 08:05:57 INFO - PID 6163 | _x_x_mozilla_page_load_details 08:05:57 INFO - PID 6163 | |i|pagename|runs| 08:05:57 INFO - PID 6163 | |0;dojo.html;3783.205526839363;3818.4463252828323;3851.7881516516595;3861.9227615447694;3893.240818040483;6253.7498500060055;6278.30938596754;6280.089387038883;6299.905501417483;6362.650054247015;6218;6295.338989406115;6334.968325158379;6386.552941294111;6423.8394040148905;5603.691796951166;5617.494425501704;5628.605997580171;5682;5696.544276457894;5658.886822263552;5668.376478587352;5724.7996320128805;5735.684537350444;5750.942490575083;5593.2449119368775;5610.382857885609;5647.37878833328;5690.829275121753;5753.252077229975;5645.237892884449;5654.180143879155;5658.971705141489;5667.5749318800845;5676.063449530822;5718.7426565804635;5749.8275051748515;5778.5377169826315;5784.537237021071;5787.942120578782;6246.469050130744;6257.687115644199;6320.810375688737;6365.045243213509;6380.266269378988;6717.563358381738;6731;6780.220274668427;6803.863922721518;6898.310168983112;6718.05947167397;6810.353016463428;6815.216250131249;6819.488538359593;6834.589924604539;6322.304546499881;6327.177466929315;6330.113784070234;6386.712597933104;6395.936040639581;6983.511154219257;7070.186928503185;7082.3979961703835;7090.326418990187;7104.254053324326;6710.496712746563;6712;6745.325467453314;6789.626570538569;6799.11611490503;6727.159105111861;6840.55536390143;6847.726090956306;6851.3491218334175;6854.0404343391965;6705.350749401277;6732.461403087741;6798.728050878009;6809.5233333666165;6844.794656160323;6793.286704896013;6843.657817109125;6886.139232595926;6891.965540172368;6903.516753827284;4972.477889821589;4974.054929563371;5009.874753131128;5029.974850125726;5044.192929131322;4423.093265880487;4515.796789144496;4534.841280555164;4536.909261814745;4554.043650833362;6327.367263273636;6356.713947872357;6368.331325210879;6372.840678983062;6378.6810659467765;6704.7988560343265;6821.658917054127;6884.105066341343;6897.275786042494;6908.3091690830515;6232.532560058014;6286.18279623646;6286.214223222098;6347.206599175103;6366.745330186741;5555.138953462219;5582;5582.469665381782;5582.525485333792;5598.776048958078;6937.653117344113;7022.192447868459;7025.789226323219;7040.119985001875;7195.064641596559;6752.291009444134;6812.693428795816;6816.693248803915;6920.619365934922;6922.930770692228;6947.201071876799;7046.189688185924;7051.647417628996;7129.465290103367;7185.209626940928;6766.7969960901255;6781.932180678327;6833.384995350442;6837.418819400406;6841.350071743176;6742.764003259862;6756.932430675827;6830.453563714792;6906.896396553955;6931.7227310907;6565.606063636197;6599.373059559334;6602.7689030883685;6604.108445360007;6618.437432818072;6554.279029306867;6565.934340656532;6587.2753997061245;6602.306757790363;6631.568948018364;6558.1802274715665;6566.080748695282;6630.701618427279;6640.667966601747;6650.866982660416;6552.6723663815665;6656.301088385843;6673.798716231125;6757.93242067573;6761.898571521529;6397.520185986163;6416.7754128605275;6422.710978006095;6460.12788273577;6540.934590654033 08:05:57 INFO - PID 6163 | |1;ext.html;962.8122516109358;984.9064338887807;990.3067852503245;995.377888819488;1005.6329439754492;43526;44246.33630495541;44346;44397;44540.109197816026;42581.78709106458;42663;42732.572674273324;42781.57218427815;42890.356644650354;7366.410687145016;7473.738419155304;7484.214157513465;7501.437392195608;7529.849403011936;7552.9622351888165;7611.124720657112;7630.084389873223;7658.234176582325;7665.310122089011;7725.768226953172;8336.583170841464;8551.486910785341;8559.871601925975;8572.657093716243;8467.449615774955;8472.618732157038;8480.533570653612;8540.914590854074;8545.060043395222;8122.147174546706;8170.754877353689;8177.100518942912;8181.427300088996;8183.508989460652;40538;40793;40801.79599102015;40837.183256335;40866.59133408657;3655.6161603031564;3689.335919534483;3690.4279836625096;3690.464882592036;3696.242270334575;32940;32960.505592415895;32965.83517082423;32977.01068967935;33147.83426082854;5414.3232095988005;5475.67145971243;5501.367342755594;5520.806771763009;5592.748326325284;205726;206189;207057;207124.9999999985;207706;44400.555994439645;45523;51021.48978510167;52233.47766522362;52412;55604.44395556074;55613;55644.44355556393;55722.72138639281;55794;17017.064061476736;17031.14844257807;17138.14309284531;17204.569885752957;17226.827731722773;14074.859251407559;14185.219812910389;14188;14189.503367382298;14197.78703319451;14531.854681453262;14612;14655.92672036633;14756.188409637358;14877.925610371878;5629.577781666391;5658.97170514153;5813.505852002542;5822.126680997884;5861.618994765412;1083.8049151152868;1096.8628921384827;1104.2546281260118;1118.8769235384102;1128.6444769897455;25429.364265893502;25497.490050198892;25703;25764;25877.611835822478;1183.46743965216;1203.7592481503734;1208.4018410886492;1215.2222577550374;1230.5877531027027;13149.53976610814;13270.668233294246;13613.591592252249;13646.931765341309;13649.249291288876;260547;260789;261797;262090;262147;57997.42002580005;58104.70947645235;58270;58321;58730.412695872496;1500.6323450754635;1577.7081239970412;1579.336678594993;1585.4213212177704;1585.5639699082844;25284.367890802878;25296.87351563304;25348.366290842878;25443.236702898943;25650.358741031625;42076.158476830904;42131.57868421276;42194.57805421906;42203.57796422119;42208.788956055025;231321;231692;232537;232934;233937;35667.821660892565;36688.449673255454;39271.01822454461;39518.802405987786;39617.40573891452;50113.24830127624;50692;50944.981100377045;51394.74302628463;51688.224676630634;36346.18940760777;36431.27137457183;36736.26527469489;37091.629083708816;37245;36383.090422739646;36444;36744.63255367412;37272.44091338578;37643.623563765104;42901.570984289756;43248.56751432571;43798;43895;44023.89940251391;33227.83386083054;33394.16514587155;33688.3049356046;34111.65888341085;34228.48657270193;26686.799094040427;27126.593101103106;27140.45719085647;27170;27180 08:05:57 INFO - PID 6163 | |2;jquery.html;590.9556783241258;591.6154499575275;616.4944745308843;626.7336382037635;630.9085182648516;22249.2212772553;23357;23370;23392.766072339273;23423.4144146396;25372.619410708856;27210.72789272107;27343.45313093737;27351.316217094583;27355.589666155025;6504.089427480157;6682.6658667066695;6684.364985326386;6692.464602831762;6700.530962832604;6573.342665733412;6576;6693.73225070999;6699.966500167492;6877.862442751142;6830.556013859108;6839.794806155824;6840.931590684104;6842.6920788564385;6847.897281540781;6751.56114852533;6802.761903333359;6812.1144251247515;6833.521653484258;6835.487338449587;6337.33457986914;6378.5216108791565;6378.681065946684;6386.3613638636225;6418.807435776934;29744;30677;31304;31595.21011974696;31664.841675791704;2271.454850835804;2295.8163346932206;2297.1959814065112;2298.0463107810237;2306.8731219782903;20201;20988.16047358104;21030.684539731916;21056.894715526323;21107.894460527754;2440.4996975620134;2511.3847107458605;2555.629433732117;2577.355661084729;2578.626099215603;137387;142521.2873935634;151521;153899.23050384788;161209;15750.842491575168;16235.675286494205;16419.58951026234;16589.336426542803;16968.74546881798;26187.476250474883;26210.73789262121;26386.472270554867;26393.208203753533;26410.86794566015;10310.484475776182;10384.584616615251;10401.115905148146;10557.260991730505;10582.259241853151;9513.571889264862;9535.570899309549;9617.27870409722;9701;9701.563429645683;9565.713028609152;9783.608655653694;9805.509724513746;10078.3952962821;10171.69484915439;2846.51609226432;2858.099698594936;2875.180573536532;2880.3807181456086;2920.2115428834095;1017.8829434614966;1039.0856046679025;1042.1818872185297;1052.1950707708609;1061.0768631290825;21325.146994120372;21532.4616884576;21712.674309885366;21962.670559941613;22037.449063773533;1089.4389389464432;1095.895889890459;1098.5111625326813;1108.490094556513;1115.520326259716;11777.882221177679;11904.107191960638;11981.46083426248;12068.275903445821;12096.516139354328;580572;592934;610156;619187;620668;127978;130071;130861.34569327092;132540;132635;1103.674416047268;1147.718808891827;1151.3207207747469;1165.9825102623297;1227.3188380448757;22703.318900433012;22808.429789255402;23169.536609268056;23222.883885580464;23370.883145584845;62655.06017409834;63497.36502634914;63671.36328636654;65199.34800652123;65343.67328163329;82122;82257.17742822734;82672.58663706643;83114.58442707748;84135.15864841273;15927.203639817732;16239.837601623833;16297.266623001757;16365.509034728977;16421.835781642032;24391.26826195217;24553.386165345295;24759;24879.253622391356;24918;20108.39674809758;20133.295334663217;20345.084471199127;20615.072321745258;20637;17543.561410964827;17568.2094305754;17693.734593980844;17768.378106766202;17964.91017544904;20570;20756.584868302853;20787.792122078587;20817.89591052035;20955.26656567013;15916.76124858105;15955.840441595436;16119.597010074373;16136.838631614004;16168.838311617204;19564;19719.211231550576;20011;20186.192552297744;20353.389398318075 08:05:57 INFO - PID 6163 | |3;mootools.html;1407.387786312954;1486.2642991719101;1494;1521.1481570320614;1533.0495093042316;16677.24952377143;17371.565710857234;17381;17396.304147834104;17401.825981740178;16796.832031679678;17000.489985300428;17007.82992170078;17026.48920532383;17035.403760868372;2325.511642555057;2348.424635964187;2370.466645004877;2372.5847976604027;2372.7627237276306;2318.8724620145886;2321.187584345474;2324.39565712915;2326.430024643956;2327.662488939103;2185.639369504038;2276.7837055479704;2278.54429114177;2279.623862062758;2282.988585057081;2328.848624839397;2333.230034088747;2361.633946738258;2362.031567057507;2362.4566349739484;2253.4028482452163;2271.5456908618344;2279.259240746764;2281.6121259385945;2320.454693147109;16572.088535130562;16650.50048498547;16683.83316166835;16692.165391730367;16776.32894684211;8217.712380066729;8467.32261419085;8467.407281490297;8468.534230617313;8473.322134229309;4984.850454486371;5189.729382080869;5278.656887302313;5294.814681486129;5311.521963023347;2125.6811478278228;2162.1135334512933;2180.367693368921;2208.591410589046;2214.0590249144047;27141.592876106875;28034.158975230574;30121.849390753126;30974.380512389853;31159.844200779076;6906.205786334535;6927.09947706805;7090.503664743522;7104.502684812117;7120.394766444807;19789;19798.40604781859;19925.501862453555;19936.10287537064;19956;8242.835143297101;8318.875216871751;8371.790705232417;8372.372072094617;8380.20388063133;7070.71717131309;7565.6973721051645;7583.4691571590565;7674.30931216182;7680.4623676343235;5611.859703507445;5677.77288908439;5689.630174038674;5697.601167918288;5728.51307638847;1604.478544473051;1605.4461210882228;1644.638179600486;1656.1967445788782;1666.691662042526;961.6393852305386;965.9034096590285;973.1484950668165;984.6159997600942;988.649029594498;8628.69799557025;8669.826603467895;8735.606897689619;8763.430377025601;8793.736187914374;783.4515838912783;794.257369359639;795.2365728900205;802.4423025996992;809.6194788449419;5317.813876514303;5434.266374039454;5626.493615574536;5670;5748.396418376094;24784.50430991406;26057.478850422885;26243.95024199049;26250.343741406235;26267.080652177465;24053.759462405502;25426.745732542808;25452.363690907507;25508.107216247714;25548.48903021929;10200.38797672142;10513.57945682164;11696.532138714527;11833.822492662617;11888.94055529734;10078.092971632588;10108.696739097839;10127.898721012696;10304.227182961458;10620.256582039183;20114.798852011292;20185.79814201898;20351.389458316273;20631.58736825225;20781.480462988548;21642.134314627237;22277.554448911254;22299.554008919407;22674.65988010148;22949.54100917939;11718.414079296172;11836.112291577994;11848.822267665819;11890.583829565923;11890.583829565923;15229.847701522844;15285.465008725087;15402;15415.306311216247;15553.533393998197;10839.132869370274;10872.565097396331;11148.554057837595;11267.380294083576;11361.829572556584;10420.32267902584;10669.46652667379;10705.9464702676;10774.676759696908;10936.890631093587;10960.890391095987;10976.560937562408;11137.276077054965;11145.164112691742;11150.163737719542;8307.916920830956;8352.916470835215;8361.665533378597;8377.162283771575;8422.157784221528;8326.042505111747;8510.659573616986;8553.74338769838;8562.57187140653;8698.782530436789 08:05:57 INFO - PID 6163 | |4;prototype.html;546.5190632243628;570.9172170035345;572.5591294703079;575.8186171356023;585.5579037826441;5804.825855224345;6243.594166379182;6263.467605253559;6272.153259309997;6319.589226700267;6141.662208578527;6151.723172457239;6203.968980155093;6224.937750622493;6267.091271765591;4913.705177689332;4989.478209146209;5049.444561098286;5051.7623182320385;5057.367829021372;5069.112905241586;5070.72111033893;5074;5085.313482679846;5089.592832573404;4954.7522623868845;4960.305557221992;4964.205727083668;5006.144040280922;5039.54790968188;4995.550400463958;5014.799408023675;5026.2711906773675;5038.773255203525;5061.215511595708;4592.724436533786;4595.954040459619;4605.457171847435;4621.907561848778;4624.1445332613575;6138.539609529258;6152.907706384408;6156.353582873823;6291.653959032252;6294.496440284766;5806.361300256968;5817.418258174191;5850.882982340372;5863.882722345572;5886.529077673776;6634.5355825092265;6645.60126392418;6667.466242891275;6703.1285932828905;6726.899096513556;4854.150523658345;4987.62592805541;5095.821646242363;5112.897742045138;5123.666961647481;6801.251862295144;6871.518993670495;6889.552179108342;6900.516963812535;7003.754868579626;5157.716325602053;5177.58579313654;5241.13521268994;5245.554127899095;5282.603804714662;5260.368755749335;5274.815381461707;5285.942811437651;5288.312519372457;5292.7353632319;5822.475977162076;5848.415158484203;5853.736581853742;5891.23413956183;5923.437273459014;6730.899036514456;6743.426808721216;6747.763828265987;6764.864702706017;6800.761973330909;1806.5122416947352;1814.7912990006055;1820.517562845847;1831.8717689761854;1849.3897013985352;1241.2986662535818;1289.6131160651955;1314.7583370353716;1316.967075823093;1329.454923481368;6129.601575897553;6185.5876208278805;6232.283287421914;6254;6258.342873998165;6647.734090636417;6697.162854643169;6700.564463309869;6715;6759;6103.389661033861;6173.59871608344;6218.782342618078;6226.85173615102;6304.369563043659;3519.6832285094465;3527.664871837171;3549.432090865449;3554.608993010767;3567.340042092221;6995.160580730345;7048.647567621599;7048.718051277994;7081.46888983318;7094.396976257076;6785.253622101565;6796.422304104207;6875.931240687529;6891.207511136284;6895.482838787111;6853.965730171317;6879.007631680135;6929;6937.445004399636;6947.548409353477;6682.766103186365;6713.731450741916;6730.427913627396;6755.459563235027;6770.119884414995;6684.298148694317;6698.626781509876;6732.124823772878;6762.323767623198;6774.8645027100165;6932.410745086724;6956.234814170539;6968.233494315723;7000.299970003162;7044.542104763174;5153.587712982878;5160.291620892899;5173.508516690908;5194.194899790538;5226.398964119175;6606.075149478981;6760.391564759196;6760.425363843931;6773.762918297836;6790;6072.453479186895;6513.088167656627;6517.152770139852;6521.184851893513;6541.542092053511;6395;6432.260290066515;6526.140050085703;6560.40956313934;6568.507361947969;6460.3862633049785;6470.6117632940295;6501.577397469149;6502.902456463063;6526.0095670818955;6355.237371515448;6508.576942498722;6552.08270842092;6621.404073633396;6650.501212408992;6325.513504326387;6384.201974753156;6436.710348034256;6443.96778016107;6455.9677201613695 08:05:57 INFO - PID 6163 | |5;yui.html;888.9511076890772;909.6497848328391;916.9174774270315;925.3615005646104;931.4830269200593;18170.45551128154;19105;19210.519737006583;19220.615587688237;19222.423327300185;16037;16100.194990250498;17400.912995435006;17636.118194090308;17797.110144492788;1026.1482969135636;1041.3491567770143;1047.7223535763028;1048.0567489259688;1048.4757621189406;1037.1858091398253;1051.0225490294024;1060.194252368198;1061.3843970497094;1072.1369297715337;1106.8948449897248;1107.5071593141056;1108.7117349489151;1111.1000089927186;1111.9833202501968;1110.0952723530297;1110.4836251143176;1110.8944650258213;1111.0112000319723;1113.9164562657793;790.4308897593723;808.6522795198122;809.554744890308;809.7732634862248;825.8885050518163;16240.269187886455;16495.587610309718;16502.75245871313;16530.66938661232;16556;22085.227017054487;22509.54980900373;22895.54208915829;22970.310890673307;22983.54032919332;17772.733408998876;18117.36589219371;18219.635607287913;18269.99515026673;18360;3923.4114882767526;3945.4279129526344;3950.4074388841905;3950.6839452843706;3957.1887763008804;149804;151972.2401387997;160849.19575402164;161060;161066;15121.16833574142;15548.611284717972;15596.766048509282;15644;15646.608834779221;24801.25596232116;24864.627030594555;24865.751342486343;24891.50216995686;25427.74572254254;8677.435966662148;8707.216350528483;8764.956175219211;8783.604737786814;8815.823683526422;4161.854335098317;4310.741355518616;4318.222719910384;4362.040351122748;4362.520122786491;6044.304904935901;6137.386261373917;6137.5703700741415;6161.137440758297;6165.136880836686;1015.5633077776627;1034.332855308322;1041.3075304922293;1062.436908438529;1063.2769716592636;684.5481981891927;712.3659942651045;712.508369225233;716.5020310883885;717.046328383249;10888.891111088946;10937.179711521667;11225.382603956861;12014.459349329301;12784.169029013085;681.931806819324;683.1938312790855;692.1071817355555;706.9363757261871;707.3598393453932;5495.148252020943;5515.062439385314;5581.134924086773;5594.776208951678;5666.801661941812;147762;148341.25829370786;149211;151044;151595;100937.49531252444;127133.36433317774;127284.18147455591;130996;134766.65233347737;113222.43388783168;114064.42967785108;115392.84607153988;116476.41761791137;116755;13283.800742989057;13410.463581456632;13504.72990540164;13525;13556.389962451516;52801;53082.73458632682;53597.73201133969;54377.184342234104;54956.450435495135;66940.33059669341;67335.66332168503;67448.32551674421;67579.66210168917;69685.65157174182;17078.74381884248;17472.213750381517;17504.387346442814;17529.298828047245;17669.911650441667;20518.69221961642;20560.38318850377;20565.38303850887;20623;20730.378088657366;17606.64786704233;17728.82271177272;17736.733948991034;17874.910625447308;17890.642187156445;17359.3924212657;17372.305107795546;17553.473395798148;17573.209205586034;17672.381466648607;16752.41366552165;16984.49046528606;17002.149892505076;17044.829551704323;17049.31802727877;12276.938615306866;12516.687082822638;12706.428210730355;12791.168574042658;12881.677958051123;14105.153690778587;14163.433462661791;14217.146971181763;14301.356438960063;14364.928175359475 08:05:57 INFO - PID 6163 | __end_tp_report 08:05:57 INFO - PID 6163 | __start_cc_report 08:05:57 INFO - PID 6163 | _x_x_mozilla_cycle_collect,270 08:05:57 INFO - PID 6163 | __end_cc_report 08:05:57 INFO - PID 6163 | __startTimestamp1506006357938__endTimestamp 08:05:57 INFO - PID 6163 | 08:05:57 INFO - PID 6163 | ------- Summary: start ------- 08:05:57 INFO - PID 6163 | Number of tests: 6 08:05:57 INFO - PID 6163 | 08:05:57 INFO - PID 6163 | [#0] dojo.html Cycles:165 Average:6290.27 Median:6558.18 stddev:745.37 (11.4%) stddev-sans-first:721.24 08:05:57 INFO - PID 6163 | Values: 3783.2 3818.4 3851.8 3861.9 3893.2 6253.7 6278.3 6280.1 6299.9 6362.7 6218.0 6295.3 6335.0 6386.6 6423.8 5603.7 5617.5 5628.6 5682.0 5696.5 5658.9 5668.4 5724.8 5735.7 5750.9 5593.2 5610.4 5647.4 5690.8 5753.3 5645.2 5654.2 5659.0 5667.6 5676.1 5718.7 5749.8 5778.5 5784.5 5787.9 6246.5 6257.7 6320.8 6365.0 6380.3 6717.6 6731.0 6780.2 6803.9 6898.3 6718.1 6810.4 6815.2 6819.5 6834.6 6322.3 6327.2 6330.1 6386.7 6395.9 6983.5 7070.2 7082.4 7090.3 7104.3 6710.5 6712.0 6745.3 6789.6 6799.1 6727.2 6840.6 6847.7 6851.3 6854.0 6705.4 6732.5 6798.7 6809.5 6844.8 6793.3 6843.7 6886.1 6892.0 6903.5 4972.5 4974.1 5009.9 5030.0 5044.2 4423.1 4515.8 4534.8 4536.9 4554.0 6327.4 6356.7 6368.3 6372.8 6378.7 6704.8 6821.7 6884.1 6897.3 6908.3 6232.5 6286.2 6286.2 6347.2 6366.7 5555.1 5582.0 5582.5 5582.5 5598.8 6937.7 7022.2 7025.8 7040.1 7195.1 6752.3 6812.7 6816.7 6920.6 6922.9 6947.2 7046.2 7051.6 7129.5 7185.2 6766.8 6781.9 6833.4 6837.4 6841.4 6742.8 6756.9 6830.5 6906.9 6931.7 6565.6 6599.4 6602.8 6604.1 6618.4 6554.3 6565.9 6587.3 6602.3 6631.6 6558.2 6566.1 6630.7 6640.7 6650.9 6552.7 6656.3 6673.8 6757.9 6761.9 6397.5 6416.8 6422.7 6460.1 6540.9 08:05:57 INFO - PID 6163 | 08:05:57 INFO - PID 6163 | [#1] ext.html Cycles:180 Average:41784.54 Median:37258.72 stddev:60879.34 (163.4%) stddev-sans-first:60972.96 08:05:57 INFO - PID 6163 | Values: 962.8 984.9 990.3 995.4 1005.6 43526.0 44246.3 44346.0 44397.0 44540.1 42581.8 42663.0 42732.6 42781.6 42890.4 7366.4 7473.7 7484.2 7501.4 7529.8 7553.0 7611.1 7630.1 7658.2 7665.3 7725.8 8336.6 8551.5 8559.9 8572.7 8467.4 8472.6 8480.5 8540.9 8545.1 8122.1 8170.8 8177.1 8181.4 8183.5 40538.0 40793.0 40801.8 40837.2 40866.6 3655.6 3689.3 3690.4 3690.5 3696.2 32940.0 32960.5 32965.8 32977.0 33147.8 5414.3 5475.7 5501.4 5520.8 5592.7 205726.0 206189.0 207057.0 207125.0 207706.0 44400.6 45523.0 51021.5 52233.5 52412.0 55604.4 55613.0 55644.4 55722.7 55794.0 17017.1 17031.1 17138.1 17204.6 17226.8 14074.9 14185.2 14188.0 14189.5 14197.8 14531.9 14612.0 14655.9 14756.2 14877.9 5629.6 5659.0 5813.5 5822.1 5861.6 1083.8 1096.9 1104.3 1118.9 1128.6 25429.4 25497.5 25703.0 25764.0 25877.6 1183.5 1203.8 1208.4 1215.2 1230.6 13149.5 13270.7 13613.6 13646.9 13649.2 260547.0 260789.0 261797.0 262090.0 262147.0 57997.4 58104.7 58270.0 58321.0 58730.4 1500.6 1577.7 1579.3 1585.4 1585.6 25284.4 25296.9 25348.4 25443.2 25650.4 42076.2 42131.6 42194.6 42203.6 42208.8 231321.0 231692.0 232537.0 232934.0 233937.0 35667.8 36688.4 39271.0 39518.8 39617.4 50113.2 50692.0 50945.0 51394.7 51688.2 36346.2 36431.3 36736.3 37091.6 37245.0 36383.1 36444.0 36744.6 37272.4 37643.6 42901.6 43248.6 43798.0 43895.0 44023.9 33227.8 33394.2 33688.3 34111.7 34228.5 26686.8 27126.6 27140.5 27170.0 27180.0 08:05:57 INFO - PID 6163 | 08:05:57 INFO - PID 6163 | [#2] jquery.html Cycles:180 Average:40108.88 Median:23196.21 stddev:101173.64 (436.2%) stddev-sans-first:101413.95 08:05:57 INFO - PID 6163 | Values: 591.0 591.6 616.5 626.7 630.9 22249.2 23357.0 23370.0 23392.8 23423.4 25372.6 27210.7 27343.5 27351.3 27355.6 6504.1 6682.7 6684.4 6692.5 6700.5 6573.3 6576.0 6693.7 6700.0 6877.9 6830.6 6839.8 6840.9 6842.7 6847.9 6751.6 6802.8 6812.1 6833.5 6835.5 6337.3 6378.5 6378.7 6386.4 6418.8 29744.0 30677.0 31304.0 31595.2 31664.8 2271.5 2295.8 2297.2 2298.0 2306.9 20201.0 20988.2 21030.7 21056.9 21107.9 2440.5 2511.4 2555.6 2577.4 2578.6 137387.0 142521.3 151521.0 153899.2 161209.0 15750.8 16235.7 16419.6 16589.3 16968.7 26187.5 26210.7 26386.5 26393.2 26410.9 10310.5 10384.6 10401.1 10557.3 10582.3 9513.6 9535.6 9617.3 9701.0 9701.6 9565.7 9783.6 9805.5 10078.4 10171.7 2846.5 2858.1 2875.2 2880.4 2920.2 1017.9 1039.1 1042.2 1052.2 1061.1 21325.1 21532.5 21712.7 21962.7 22037.4 1089.4 1095.9 1098.5 1108.5 1115.5 11777.9 11904.1 11981.5 12068.3 12096.5 580572.0 592934.0 610156.0 619187.0 620668.0 127978.0 130071.0 130861.3 132540.0 132635.0 1103.7 1147.7 1151.3 1166.0 1227.3 22703.3 22808.4 23169.5 23222.9 23370.9 62655.1 63497.4 63671.4 65199.3 65343.7 82122.0 82257.2 82672.6 83114.6 84135.2 15927.2 16239.8 16297.3 16365.5 16421.8 24391.3 24553.4 24759.0 24879.3 24918.0 20108.4 20133.3 20345.1 20615.1 20637.0 17543.6 17568.2 17693.7 17768.4 17964.9 20570.0 20756.6 20787.8 20817.9 20955.3 15916.8 15955.8 16119.6 16136.8 16168.8 19564.0 19719.2 20011.0 20186.2 20353.4 08:05:57 INFO - PID 6163 | 08:05:57 INFO - PID 6163 | [#3] mootools.html Cycles:180 Average:10214.91 Median:2320.82 stddev:7770.21 (334.8%) stddev-sans-first:7763.83 08:05:57 INFO - PID 6163 | Values: 1407.4 1486.3 1494.0 1521.1 1533.0 16677.2 17371.6 17381.0 17396.3 17401.8 16796.8 17000.5 17007.8 17026.5 17035.4 2325.5 2348.4 2370.5 2372.6 2372.8 2318.9 2321.2 2324.4 2326.4 2327.7 2185.6 2276.8 2278.5 2279.6 2283.0 2328.8 2333.2 2361.6 2362.0 2362.5 2253.4 2271.5 2279.3 2281.6 2320.5 16572.1 16650.5 16683.8 16692.2 16776.3 8217.7 8467.3 8467.4 8468.5 8473.3 4984.9 5189.7 5278.7 5294.8 5311.5 2125.7 2162.1 2180.4 2208.6 2214.1 27141.6 28034.2 30121.8 30974.4 31159.8 6906.2 6927.1 7090.5 7104.5 7120.4 19789.0 19798.4 19925.5 19936.1 19956.0 8242.8 8318.9 8371.8 8372.4 8380.2 7070.7 7565.7 7583.5 7674.3 7680.5 5611.9 5677.8 5689.6 5697.6 5728.5 1604.5 1605.4 1644.6 1656.2 1666.7 961.6 965.9 973.1 984.6 988.6 8628.7 8669.8 8735.6 8763.4 8793.7 783.5 794.3 795.2 802.4 809.6 5317.8 5434.3 5626.5 5670.0 5748.4 24784.5 26057.5 26244.0 26250.3 26267.1 24053.8 25426.7 25452.4 25508.1 25548.5 10200.4 10513.6 11696.5 11833.8 11888.9 10078.1 10108.7 10127.9 10304.2 10620.3 20114.8 20185.8 20351.4 20631.6 20781.5 21642.1 22277.6 22299.6 22674.7 22949.5 11718.4 11836.1 11848.8 11890.6 11890.6 15229.8 15285.5 15402.0 15415.3 15553.5 10839.1 10872.6 11148.6 11267.4 11361.8 10420.3 10669.5 10705.9 10774.7 10936.9 10960.9 10976.6 11137.3 11145.2 11150.2 8307.9 8352.9 8361.7 8377.2 8422.2 8326.0 8510.7 8553.7 8562.6 8698.8 08:05:57 INFO - PID 6163 | 08:05:57 INFO - PID 6163 | [#4] prototype.html Cycles:180 Average:5632.53 Median:6237.94 stddev:1565.45 (25.1%) stddev-sans-first:1522.59 08:05:57 INFO - PID 6163 | Values: 546.5 570.9 572.6 575.8 585.6 5804.8 6243.6 6263.5 6272.2 6319.6 6141.7 6151.7 6204.0 6224.9 6267.1 4913.7 4989.5 5049.4 5051.8 5057.4 5069.1 5070.7 5074.0 5085.3 5089.6 4954.8 4960.3 4964.2 5006.1 5039.5 4995.6 5014.8 5026.3 5038.8 5061.2 4592.7 4596.0 4605.5 4621.9 4624.1 6138.5 6152.9 6156.4 6291.7 6294.5 5806.4 5817.4 5850.9 5863.9 5886.5 6634.5 6645.6 6667.5 6703.1 6726.9 4854.2 4987.6 5095.8 5112.9 5123.7 6801.3 6871.5 6889.6 6900.5 7003.8 5157.7 5177.6 5241.1 5245.6 5282.6 5260.4 5274.8 5285.9 5288.3 5292.7 5822.5 5848.4 5853.7 5891.2 5923.4 6730.9 6743.4 6747.8 6764.9 6800.8 1806.5 1814.8 1820.5 1831.9 1849.4 1241.3 1289.6 1314.8 1317.0 1329.5 6129.6 6185.6 6232.3 6254.0 6258.3 6647.7 6697.2 6700.6 6715.0 6759.0 6103.4 6173.6 6218.8 6226.9 6304.4 3519.7 3527.7 3549.4 3554.6 3567.3 6995.2 7048.6 7048.7 7081.5 7094.4 6785.3 6796.4 6875.9 6891.2 6895.5 6854.0 6879.0 6929.0 6937.4 6947.5 6682.8 6713.7 6730.4 6755.5 6770.1 6684.3 6698.6 6732.1 6762.3 6774.9 6932.4 6956.2 6968.2 7000.3 7044.5 5153.6 5160.3 5173.5 5194.2 5226.4 6606.1 6760.4 6760.4 6773.8 6790.0 6072.5 6513.1 6517.2 6521.2 6541.5 6395.0 6432.3 6526.1 6560.4 6568.5 6460.4 6470.6 6501.6 6502.9 6526.0 6355.2 6508.6 6552.1 6621.4 6650.5 6325.5 6384.2 6436.7 6444.0 6456.0 08:05:57 INFO - PID 6163 | 08:05:57 INFO - PID 6163 | [#5] yui.html Cycles:180 Average:27240.00 Median:17589.93 stddev:41545.36 (236.2%) stddev-sans-first:41614.79 08:05:57 INFO - PID 6163 | Values: 889.0 909.6 916.9 925.4 931.5 18170.5 19105.0 19210.5 19220.6 19222.4 16037.0 16100.2 17400.9 17636.1 17797.1 1026.1 1041.3 1047.7 1048.1 1048.5 1037.2 1051.0 1060.2 1061.4 1072.1 1106.9 1107.5 1108.7 1111.1 1112.0 1110.1 1110.5 1110.9 1111.0 1113.9 790.4 808.7 809.6 809.8 825.9 16240.3 16495.6 16502.8 16530.7 16556.0 22085.2 22509.5 22895.5 22970.3 22983.5 17772.7 18117.4 18219.6 18270.0 18360.0 3923.4 3945.4 3950.4 3950.7 3957.2 149804.0 151972.2 160849.2 161060.0 161066.0 15121.2 15548.6 15596.8 15644.0 15646.6 24801.3 24864.6 24865.8 24891.5 25427.7 8677.4 8707.2 8765.0 8783.6 8815.8 4161.9 4310.7 4318.2 4362.0 4362.5 6044.3 6137.4 6137.6 6161.1 6165.1 1015.6 1034.3 1041.3 1062.4 1063.3 684.5 712.4 712.5 716.5 717.0 10888.9 10937.2 11225.4 12014.5 12784.2 681.9 683.2 692.1 706.9 707.4 5495.1 5515.1 5581.1 5594.8 5666.8 147762.0 148341.3 149211.0 151044.0 151595.0 100937.5 127133.4 127284.2 130996.0 134766.7 113222.4 114064.4 115392.8 116476.4 116755.0 13283.8 13410.5 13504.7 13525.0 13556.4 52801.0 53082.7 53597.7 54377.2 54956.5 66940.3 67335.7 67448.3 67579.7 69685.7 17078.7 17472.2 17504.4 17529.3 17669.9 20518.7 20560.4 20565.4 20623.0 20730.4 17606.6 17728.8 17736.7 17874.9 17890.6 17359.4 17372.3 17553.5 17573.2 17672.4 16752.4 16984.5 17002.1 17044.8 17049.3 12276.9 12516.7 12706.4 12791.2 12881.7 14105.2 14163.4 14217.1 14301.4 14364.9 08:05:57 INFO - PID 6163 | -------- Summary: end -------- 08:05:57 INFO - PID 6163 | 08:05:58 INFO - TEST-INFO | 6163: exit 0 08:05:58 INFO - TEST-OK | dromaeo_css | took 1108384ms 08:05:58 INFO - TEST-START | kraken 08:05:58 INFO - Initialising browser for kraken test... 08:05:58 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:43847/getInfo.html -profile /tmp/tmplDZX1M/profile 08:05:58 INFO - TEST-INFO | started process 6531 (/builds/slave/test/build/application/firefox/firefox http://localhost:43847/getInfo.html) 08:06:03 INFO - TEST-INFO | 6531: exit 0 08:06:04 INFO - Browser initialized. 08:06:04 INFO - Running cycle 1/1 for kraken test... 08:06:04 INFO - Using env: {'DISPLAY': ':0', 08:06:04 INFO - 'HOME': '/home/cltbld', 08:06:04 INFO - 'JSGC_DISABLE_POISONING': '1', 08:06:04 INFO - 'LANG': 'en_US.UTF-8', 08:06:04 INFO - 'LANGUAGE': 'en_US:en', 08:06:04 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 08:06:04 INFO - 'LOGNAME': 'cltbld', 08:06:04 INFO - 'MAIL': '/var/mail/cltbld', 08:06:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:06:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:06:04 INFO - 'MOZ_CRASHREPORTER': '1', 08:06:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:06:04 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 08:06:04 INFO - 'MOZ_NO_REMOTE': '1', 08:06:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:06:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:06:04 INFO - 'NO_EM_RESTART': '1', 08:06:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:06:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:06:04 INFO - 'PWD': '/builds/slave/test', 08:06:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:06:04 INFO - 'RUST_BACKTRACE': 'full', 08:06:04 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 08:06:04 INFO - 'SHELL': '/bin/bash', 08:06:04 INFO - 'SHLVL': '1', 08:06:04 INFO - 'STYLO_FORCE_DISABLED': '1', 08:06:04 INFO - 'TERM': 'linux', 08:06:04 INFO - 'TMOUT': '86400', 08:06:04 INFO - 'USER': 'cltbld', 08:06:04 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1506004283.846174-877056714', 08:06:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:06:04 INFO - '_': '/tools/buildbot/bin/python'} 08:06:04 INFO - TEST-INFO | started process 6769 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplDZX1M/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 08:06:04 INFO - PID 6769 | 08:06:04 INFO - PID 6769 | (/builds/slave/test/build/application/firefox/firefox:6818): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 08:06:04 INFO - PID 6769 | 08:06:15 INFO - PID 6769 | RSS: Main: 148451328 08:06:15 INFO - PID 6769 | 08:06:17 INFO - PID 6769 | Cycle 1(1): loaded http://localhost:43847/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43847/tests/kraken/driver.html?testName=audio-beat-detection) 08:06:18 INFO - PID 6769 | RSS: Main: 153219072 08:06:18 INFO - PID 6769 | 08:06:21 INFO - PID 6769 | Cycle 1(1): loaded http://localhost:43847/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43847/tests/kraken/driver.html?testName=audio-dft) 08:06:21 INFO - PID 6769 | RSS: Main: 153681920 08:06:21 INFO - PID 6769 | 08:06:24 INFO - PID 6769 | Cycle 1(1): loaded http://localhost:43847/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43847/tests/kraken/driver.html?testName=audio-fft) 08:06:25 INFO - PID 6769 | RSS: Main: 150130688 08:06:25 INFO - PID 6769 | 08:06:27 INFO - PID 6769 | Cycle 1(1): loaded http://localhost:43847/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43847/tests/kraken/driver.html?testName=audio-oscillator) 08:06:27 INFO - PID 6769 | RSS: Main: 151298048 08:06:27 INFO - PID 6769 | 08:06:29 INFO - PID 6769 | Cycle 1(1): loaded http://localhost:43847/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43847/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:06:30 INFO - PID 6769 | RSS: Main: 150867968 08:06:30 INFO - PID 6769 | 08:06:33 INFO - PID 6769 | Cycle 1(1): loaded http://localhost:43847/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43847/tests/kraken/driver.html?testName=imaging-darkroom) 08:06:34 INFO - PID 6769 | RSS: Main: 151355392 08:06:34 INFO - PID 6769 | 08:06:37 INFO - PID 6769 | Cycle 1(1): loaded http://localhost:43847/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43847/tests/kraken/driver.html?testName=imaging-desaturate) 08:06:38 INFO - PID 6769 | RSS: Main: 152666112 08:06:38 INFO - PID 6769 | 08:06:41 INFO - PID 6769 | Cycle 1(1): loaded http://localhost:43847/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43847/tests/kraken/driver.html?testName=json-parse-financial) 08:06:41 INFO - PID 6769 | RSS: Main: 154685440 08:06:41 INFO - PID 6769 | 08:06:43 INFO - PID 6769 | Cycle 1(1): loaded http://localhost:43847/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43847/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:06:43 INFO - PID 6769 | RSS: Main: 153853952 08:06:43 INFO - PID 6769 | 08:06:45 INFO - PID 6769 | Cycle 1(1): loaded http://localhost:43847/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43847/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:06:46 INFO - PID 6769 | RSS: Main: 153706496 08:06:46 INFO - PID 6769 | 08:06:48 INFO - PID 6769 | Cycle 1(1): loaded http://localhost:43847/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43847/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:06:48 INFO - PID 6769 | RSS: Main: 150577152 08:06:48 INFO - PID 6769 | 08:06:51 INFO - PID 6769 | Cycle 1(1): loaded http://localhost:43847/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43847/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:06:51 INFO - PID 6769 | RSS: Main: 150777856 08:06:51 INFO - PID 6769 | 08:06:54 INFO - PID 6769 | Cycle 1(1): loaded http://localhost:43847/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43847/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:06:55 INFO - PID 6769 | RSS: Main: 152145920 08:06:55 INFO - PID 6769 | 08:06:56 INFO - PID 6769 | Cycle 1(1): loaded http://localhost:43847/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43847/tests/kraken/driver.html?testName=ai-astar) 08:06:57 INFO - PID 6769 | RSS: Main: 153657344 08:06:57 INFO - PID 6769 | 08:06:57 INFO - PID 6769 | __start_tp_report 08:06:57 INFO - PID 6769 | _x_x_mozilla_page_load 08:06:57 INFO - PID 6769 | _x_x_mozilla_page_load_details 08:06:57 INFO - PID 6769 | |i|pagename|runs| 08:06:57 INFO - PID 6769 | |0;ai-astar;105;107;108;105;106;106;107;105;106;105 08:06:57 INFO - PID 6769 | |1;audio-beat-detection;113;111;111;112;111;111;114;111;111;112 08:06:57 INFO - PID 6769 | |2;audio-dft;162;162;162;161;161;162;163;163;163;164 08:06:57 INFO - PID 6769 | |3;audio-fft;73;72;72;73;72;73;73;72;73;72 08:06:57 INFO - PID 6769 | |4;audio-oscillator;79;79;78;78;77;77;77;83;78;78 08:06:57 INFO - PID 6769 | |5;imaging-gaussian-blur;114;114;114;113;114;118;114;113;114;110 08:06:57 INFO - PID 6769 | |6;imaging-darkroom;149;150;150;151;149;149;152;149;151;150 08:06:57 INFO - PID 6769 | |7;imaging-desaturate;99;94;93;94;94;94;95;95;94;97 08:06:57 INFO - PID 6769 | |8;json-parse-financial;45;43;45;46;47;47;45;45;43;43 08:06:57 INFO - PID 6769 | |9;json-stringify-tinderbox;37;37;36;37;37;37;37;36;37;36 08:06:57 INFO - PID 6769 | |10;stanford-crypto-aes;70;70;70;70;70;71;76;70;70;70 08:06:57 INFO - PID 6769 | |11;stanford-crypto-ccm;107;101;111;110;103;110;106;106;103;114 08:06:57 INFO - PID 6769 | |12;stanford-crypto-pbkdf2;161;163;156;153;157;157;157;160;152;152 08:06:57 INFO - PID 6769 | |13;stanford-crypto-sha256-iterative;59;61;61;58;61;58;61;61;61;61 08:06:57 INFO - PID 6769 | __end_tp_report 08:06:57 INFO - PID 6769 | __start_cc_report 08:06:57 INFO - PID 6769 | _x_x_mozilla_cycle_collect,729 08:06:57 INFO - PID 6769 | __end_cc_report 08:06:57 INFO - PID 6769 | __startTimestamp1506006417048__endTimestamp 08:06:57 INFO - PID 6769 | 08:06:57 INFO - PID 6769 | ------- Summary: start ------- 08:06:57 INFO - PID 6769 | Number of tests: 14 08:06:57 INFO - PID 6769 | 08:06:57 INFO - PID 6769 | [#0] ai-astar Cycles:10 Average:106.00 Median:106.00 stddev:1.05 (1.0%) stddev-sans-first:1.05 08:06:57 INFO - PID 6769 | Values: 105.0 107.0 108.0 105.0 106.0 106.0 107.0 105.0 106.0 105.0 08:06:57 INFO - PID 6769 | 08:06:57 INFO - PID 6769 | [#1] audio-beat-detection Cycles:10 Average:111.70 Median:111.50 stddev:1.06 (1.0%) stddev-sans-first:1.01 08:06:57 INFO - PID 6769 | Values: 113.0 111.0 111.0 112.0 111.0 111.0 114.0 111.0 111.0 112.0 08:06:57 INFO - PID 6769 | 08:06:57 INFO - PID 6769 | [#2] audio-dft Cycles:10 Average:162.30 Median:162.50 stddev:0.95 (0.6%) stddev-sans-first:1.00 08:06:57 INFO - PID 6769 | Values: 162.0 162.0 162.0 161.0 161.0 162.0 163.0 163.0 163.0 164.0 08:06:57 INFO - PID 6769 | 08:06:57 INFO - PID 6769 | [#3] audio-fft Cycles:10 Average:72.50 Median:73.00 stddev:0.53 (0.7%) stddev-sans-first:0.53 08:06:57 INFO - PID 6769 | Values: 73.0 72.0 72.0 73.0 72.0 73.0 73.0 72.0 73.0 72.0 08:06:57 INFO - PID 6769 | 08:06:57 INFO - PID 6769 | [#4] audio-oscillator Cycles:10 Average:78.40 Median:78.00 stddev:1.78 (2.3%) stddev-sans-first:1.87 08:06:57 INFO - PID 6769 | Values: 79.0 79.0 78.0 78.0 77.0 77.0 77.0 83.0 78.0 78.0 08:06:57 INFO - PID 6769 | 08:06:57 INFO - PID 6769 | [#5] imaging-gaussian-blur Cycles:10 Average:113.80 Median:114.00 stddev:1.93 (1.7%) stddev-sans-first:2.05 08:06:57 INFO - PID 6769 | Values: 114.0 114.0 114.0 113.0 114.0 118.0 114.0 113.0 114.0 110.0 08:06:57 INFO - PID 6769 | 08:06:57 INFO - PID 6769 | [#6] imaging-darkroom Cycles:10 Average:150.00 Median:150.00 stddev:1.05 (0.7%) stddev-sans-first:1.05 08:06:57 INFO - PID 6769 | Values: 149.0 150.0 150.0 151.0 149.0 149.0 152.0 149.0 151.0 150.0 08:06:57 INFO - PID 6769 | 08:06:57 INFO - PID 6769 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:94.50 stddev:1.79 (1.9%) stddev-sans-first:1.13 08:06:57 INFO - PID 6769 | Values: 99.0 94.0 93.0 94.0 94.0 94.0 95.0 95.0 94.0 97.0 08:06:57 INFO - PID 6769 | 08:06:57 INFO - PID 6769 | [#8] json-parse-financial Cycles:10 Average:44.90 Median:45.00 stddev:1.52 (3.4%) stddev-sans-first:1.62 08:06:57 INFO - PID 6769 | Values: 45.0 43.0 45.0 46.0 47.0 47.0 45.0 45.0 43.0 43.0 08:06:57 INFO - PID 6769 | 08:06:57 INFO - PID 6769 | [#9] json-stringify-tinderbox Cycles:10 Average:36.70 Median:37.00 stddev:0.48 (1.3%) stddev-sans-first:0.50 08:06:57 INFO - PID 6769 | Values: 37.0 37.0 36.0 37.0 37.0 37.0 37.0 36.0 37.0 36.0 08:06:57 INFO - PID 6769 | 08:06:57 INFO - PID 6769 | [#10] stanford-crypto-aes Cycles:10 Average:70.70 Median:70.00 stddev:1.89 (2.7%) stddev-sans-first:1.99 08:06:57 INFO - PID 6769 | Values: 70.0 70.0 70.0 70.0 70.0 71.0 76.0 70.0 70.0 70.0 08:06:57 INFO - PID 6769 | 08:06:57 INFO - PID 6769 | [#11] stanford-crypto-ccm Cycles:10 Average:107.10 Median:108.50 stddev:4.12 (3.8%) stddev-sans-first:4.37 08:06:57 INFO - PID 6769 | Values: 107.0 101.0 111.0 110.0 103.0 110.0 106.0 106.0 103.0 114.0 08:06:57 INFO - PID 6769 | 08:06:57 INFO - PID 6769 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.80 Median:157.00 stddev:3.77 (2.4%) stddev-sans-first:3.67 08:06:57 INFO - PID 6769 | Values: 161.0 163.0 156.0 153.0 157.0 157.0 157.0 160.0 152.0 152.0 08:06:57 INFO - PID 6769 | 08:06:57 INFO - PID 6769 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:60.20 Median:61.00 stddev:1.32 (2.2%) stddev-sans-first:1.32 08:06:57 INFO - PID 6769 | Values: 59.0 61.0 61.0 58.0 61.0 58.0 61.0 61.0 61.0 61.0 08:06:57 INFO - PID 6769 | -------- Summary: end -------- 08:06:57 INFO - PID 6769 | 08:06:57 INFO - PID 6769 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 08:06:57 INFO - TEST-INFO | 6769: exit 0 08:06:57 INFO - TEST-OK | kraken | took 59034ms 08:06:57 INFO - SUITE-END | took 1167s 08:06:57 INFO - Completed test suite (00:19:27) 08:06:57 INFO - javascript benchmark 08:06:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8961.118986383024, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3783.205526839363, 3818.4463252828323, 3851.7881516516595, 3861.9227615447694, 3893.240818040483, 6253.7498500060055, 6278.30938596754, 6280.089387038883, 6299.905501417483, 6362.650054247015, 6218.0, 6295.338989406115, 6334.968325158379, 6386.552941294111, 6423.8394040148905, 5603.691796951166, 5617.494425501704, 5628.605997580171, 5682.0, 5696.544276457894, 5658.886822263552, 5668.376478587352, 5724.7996320128805, 5735.684537350444, 5750.942490575083, 5593.2449119368775, 5610.382857885609, 5647.37878833328, 5690.829275121753, 5753.252077229975, 5645.237892884449, 5654.180143879155, 5658.971705141489, 5667.5749318800845, 5676.063449530822, 5718.7426565804635, 5749.8275051748515, 5778.5377169826315, 5784.537237021071, 5787.942120578782, 6246.469050130744, 6257.687115644199, 6320.810375688737, 6365.045243213509, 6380.266269378988, 6717.563358381738, 6731.0, 6780.220274668427, 6803.863922721518, 6898.310168983112, 6718.05947167397, 6810.353016463428, 6815.216250131249, 6819.488538359593, 6834.589924604539, 6322.304546499881, 6327.177466929315, 6330.113784070234, 6386.712597933104, 6395.936040639581, 6983.511154219257, 7070.186928503185, 7082.3979961703835, 7090.326418990187, 7104.254053324326, 6710.496712746563, 6712.0, 6745.325467453314, 6789.626570538569, 6799.11611490503, 6727.159105111861, 6840.55536390143, 6847.726090956306, 6851.3491218334175, 6854.0404343391965, 6705.350749401277, 6732.461403087741, 6798.728050878009, 6809.5233333666165, 6844.794656160323, 6793.286704896013, 6843.657817109125, 6886.139232595926, 6891.965540172368, 6903.516753827284, 4972.477889821589, 4974.054929563371, 5009.874753131128, 5029.974850125726, 5044.192929131322, 4423.093265880487, 4515.796789144496, 4534.841280555164, 4536.909261814745, 4554.043650833362, 6327.367263273636, 6356.713947872357, 6368.331325210879, 6372.840678983062, 6378.6810659467765, 6704.7988560343265, 6821.658917054127, 6884.105066341343, 6897.275786042494, 6908.3091690830515, 6232.532560058014, 6286.18279623646, 6286.214223222098, 6347.206599175103, 6366.745330186741, 5555.138953462219, 5582.0, 5582.469665381782, 5582.525485333792, 5598.776048958078, 6937.653117344113, 7022.192447868459, 7025.789226323219, 7040.119985001875, 7195.064641596559, 6752.291009444134, 6812.693428795816, 6816.693248803915, 6920.619365934922, 6922.930770692228, 6947.201071876799, 7046.189688185924, 7051.647417628996, 7129.465290103367, 7185.209626940928, 6766.7969960901255, 6781.932180678327, 6833.384995350442, 6837.418819400406, 6841.350071743176, 6742.764003259862, 6756.932430675827, 6830.453563714792, 6906.896396553955, 6931.7227310907, 6565.606063636197, 6599.373059559334, 6602.7689030883685, 6604.108445360007, 6618.437432818072, 6554.279029306867, 6565.934340656532, 6587.2753997061245, 6602.306757790363, 6631.568948018364, 6558.1802274715665, 6566.080748695282, 6630.701618427279, 6640.667966601747, 6650.866982660416, 6552.6723663815665, 6656.301088385843, 6673.798716231125, 6757.93242067573, 6761.898571521529, 6397.520185986163, 6416.7754128605275, 6422.710978006095, 6460.12788273577, 6540.934590654033], "value": 6239.271739063126, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [962.8122516109358, 984.9064338887807, 990.3067852503245, 995.377888819488, 1005.6329439754492, 43526.0, 44246.33630495541, 44346.0, 44397.0, 44540.109197816026, 42581.78709106458, 42663.0, 42732.572674273324, 42781.57218427815, 42890.356644650354, 7366.410687145016, 7473.738419155304, 7484.214157513465, 7501.437392195608, 7529.849403011936, 7552.9622351888165, 7611.124720657112, 7630.084389873223, 7658.234176582325, 7665.310122089011, 7725.768226953172, 8336.583170841464, 8551.486910785341, 8559.871601925975, 8572.657093716243, 8467.449615774955, 8472.618732157038, 8480.533570653612, 8540.914590854074, 8545.060043395222, 8122.147174546706, 8170.754877353689, 8177.100518942912, 8181.427300088996, 8183.508989460652, 40538.0, 40793.0, 40801.79599102015, 40837.183256335, 40866.59133408657, 3655.6161603031564, 3689.335919534483, 3690.4279836625096, 3690.464882592036, 3696.242270334575, 32940.0, 32960.505592415895, 32965.83517082423, 32977.01068967935, 33147.83426082854, 5414.3232095988005, 5475.67145971243, 5501.367342755594, 5520.806771763009, 5592.748326325284, 205726.0, 206189.0, 207057.0, 207124.9999999985, 207706.0, 44400.555994439645, 45523.0, 51021.48978510167, 52233.47766522362, 52412.0, 55604.44395556074, 55613.0, 55644.44355556393, 55722.72138639281, 55794.0, 17017.064061476736, 17031.14844257807, 17138.14309284531, 17204.569885752957, 17226.827731722773, 14074.859251407559, 14185.219812910389, 14188.0, 14189.503367382298, 14197.78703319451, 14531.854681453262, 14612.0, 14655.92672036633, 14756.188409637358, 14877.925610371878, 5629.577781666391, 5658.97170514153, 5813.505852002542, 5822.126680997884, 5861.618994765412, 1083.8049151152868, 1096.8628921384827, 1104.2546281260118, 1118.8769235384102, 1128.6444769897455, 25429.364265893502, 25497.490050198892, 25703.0, 25764.0, 25877.611835822478, 1183.46743965216, 1203.7592481503734, 1208.4018410886492, 1215.2222577550374, 1230.5877531027027, 13149.53976610814, 13270.668233294246, 13613.591592252249, 13646.931765341309, 13649.249291288876, 260547.0, 260789.0, 261797.0, 262090.0, 262147.0, 57997.42002580005, 58104.70947645235, 58270.0, 58321.0, 58730.412695872496, 1500.6323450754635, 1577.7081239970412, 1579.336678594993, 1585.4213212177704, 1585.5639699082844, 25284.367890802878, 25296.87351563304, 25348.366290842878, 25443.236702898943, 25650.358741031625, 42076.158476830904, 42131.57868421276, 42194.57805421906, 42203.57796422119, 42208.788956055025, 231321.0, 231692.0, 232537.0, 232934.0, 233937.0, 35667.821660892565, 36688.449673255454, 39271.01822454461, 39518.802405987786, 39617.40573891452, 50113.24830127624, 50692.0, 50944.981100377045, 51394.74302628463, 51688.224676630634, 36346.18940760777, 36431.27137457183, 36736.26527469489, 37091.629083708816, 37245.0, 36383.090422739646, 36444.0, 36744.63255367412, 37272.44091338578, 37643.623563765104, 42901.570984289756, 43248.56751432571, 43798.0, 43895.0, 44023.89940251391, 33227.83386083054, 33394.16514587155, 33688.3049356046, 34111.65888341085, 34228.48657270193, 26686.799094040427, 27126.593101103106, 27140.45719085647, 27170.0, 27180.0], "value": 18657.23163724241, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [590.9556783241258, 591.6154499575275, 616.4944745308843, 626.7336382037635, 630.9085182648516, 22249.2212772553, 23357.0, 23370.0, 23392.766072339273, 23423.4144146396, 25372.619410708856, 27210.72789272107, 27343.45313093737, 27351.316217094583, 27355.589666155025, 6504.089427480157, 6682.6658667066695, 6684.364985326386, 6692.464602831762, 6700.530962832604, 6573.342665733412, 6576.0, 6693.73225070999, 6699.966500167492, 6877.862442751142, 6830.556013859108, 6839.794806155824, 6840.931590684104, 6842.6920788564385, 6847.897281540781, 6751.56114852533, 6802.761903333359, 6812.1144251247515, 6833.521653484258, 6835.487338449587, 6337.33457986914, 6378.5216108791565, 6378.681065946684, 6386.3613638636225, 6418.807435776934, 29744.0, 30677.0, 31304.0, 31595.21011974696, 31664.841675791704, 2271.454850835804, 2295.8163346932206, 2297.1959814065112, 2298.0463107810237, 2306.8731219782903, 20201.0, 20988.16047358104, 21030.684539731916, 21056.894715526323, 21107.894460527754, 2440.4996975620134, 2511.3847107458605, 2555.629433732117, 2577.355661084729, 2578.626099215603, 137387.0, 142521.2873935634, 151521.0, 153899.23050384788, 161209.0, 15750.842491575168, 16235.675286494205, 16419.58951026234, 16589.336426542803, 16968.74546881798, 26187.476250474883, 26210.73789262121, 26386.472270554867, 26393.208203753533, 26410.86794566015, 10310.484475776182, 10384.584616615251, 10401.115905148146, 10557.260991730505, 10582.259241853151, 9513.571889264862, 9535.570899309549, 9617.27870409722, 9701.0, 9701.563429645683, 9565.713028609152, 9783.608655653694, 9805.509724513746, 10078.3952962821, 10171.69484915439, 2846.51609226432, 2858.099698594936, 2875.180573536532, 2880.3807181456086, 2920.2115428834095, 1017.8829434614966, 1039.0856046679025, 1042.1818872185297, 1052.1950707708609, 1061.0768631290825, 21325.146994120372, 21532.4616884576, 21712.674309885366, 21962.670559941613, 22037.449063773533, 1089.4389389464432, 1095.895889890459, 1098.5111625326813, 1108.490094556513, 1115.520326259716, 11777.882221177679, 11904.107191960638, 11981.46083426248, 12068.275903445821, 12096.516139354328, 580572.0, 592934.0, 610156.0, 619187.0, 620668.0, 127978.0, 130071.0, 130861.34569327092, 132540.0, 132635.0, 1103.674416047268, 1147.718808891827, 1151.3207207747469, 1165.9825102623297, 1227.3188380448757, 22703.318900433012, 22808.429789255402, 23169.536609268056, 23222.883885580464, 23370.883145584845, 62655.06017409834, 63497.36502634914, 63671.36328636654, 65199.34800652123, 65343.67328163329, 82122.0, 82257.17742822734, 82672.58663706643, 83114.58442707748, 84135.15864841273, 15927.203639817732, 16239.837601623833, 16297.266623001757, 16365.509034728977, 16421.835781642032, 24391.26826195217, 24553.386165345295, 24759.0, 24879.253622391356, 24918.0, 20108.39674809758, 20133.295334663217, 20345.084471199127, 20615.072321745258, 20637.0, 17543.561410964827, 17568.2094305754, 17693.734593980844, 17768.378106766202, 17964.91017544904, 20570.0, 20756.584868302853, 20787.792122078587, 20817.89591052035, 20955.26656567013, 15916.76124858105, 15955.840441595436, 16119.597010074373, 16136.838631614004, 16168.838311617204, 19564.0, 19719.211231550576, 20011.0, 20186.192552297744, 20353.389398318075], "value": 12959.312763379894, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1407.387786312954, 1486.2642991719101, 1494.0, 1521.1481570320614, 1533.0495093042316, 16677.24952377143, 17371.565710857234, 17381.0, 17396.304147834104, 17401.825981740178, 16796.832031679678, 17000.489985300428, 17007.82992170078, 17026.48920532383, 17035.403760868372, 2325.511642555057, 2348.424635964187, 2370.466645004877, 2372.5847976604027, 2372.7627237276306, 2318.8724620145886, 2321.187584345474, 2324.39565712915, 2326.430024643956, 2327.662488939103, 2185.639369504038, 2276.7837055479704, 2278.54429114177, 2279.623862062758, 2282.988585057081, 2328.848624839397, 2333.230034088747, 2361.633946738258, 2362.031567057507, 2362.4566349739484, 2253.4028482452163, 2271.5456908618344, 2279.259240746764, 2281.6121259385945, 2320.454693147109, 16572.088535130562, 16650.50048498547, 16683.83316166835, 16692.165391730367, 16776.32894684211, 8217.712380066729, 8467.32261419085, 8467.407281490297, 8468.534230617313, 8473.322134229309, 4984.850454486371, 5189.729382080869, 5278.656887302313, 5294.814681486129, 5311.521963023347, 2125.6811478278228, 2162.1135334512933, 2180.367693368921, 2208.591410589046, 2214.0590249144047, 27141.592876106875, 28034.158975230574, 30121.849390753126, 30974.380512389853, 31159.844200779076, 6906.205786334535, 6927.09947706805, 7090.503664743522, 7104.502684812117, 7120.394766444807, 19789.0, 19798.40604781859, 19925.501862453555, 19936.10287537064, 19956.0, 8242.835143297101, 8318.875216871751, 8371.790705232417, 8372.372072094617, 8380.20388063133, 7070.71717131309, 7565.6973721051645, 7583.4691571590565, 7674.30931216182, 7680.4623676343235, 5611.859703507445, 5677.77288908439, 5689.630174038674, 5697.601167918288, 5728.51307638847, 1604.478544473051, 1605.4461210882228, 1644.638179600486, 1656.1967445788782, 1666.691662042526, 961.6393852305386, 965.9034096590285, 973.1484950668165, 984.6159997600942, 988.649029594498, 8628.69799557025, 8669.826603467895, 8735.606897689619, 8763.430377025601, 8793.736187914374, 783.4515838912783, 794.257369359639, 795.2365728900205, 802.4423025996992, 809.6194788449419, 5317.813876514303, 5434.266374039454, 5626.493615574536, 5670.0, 5748.396418376094, 24784.50430991406, 26057.478850422885, 26243.95024199049, 26250.343741406235, 26267.080652177465, 24053.759462405502, 25426.745732542808, 25452.363690907507, 25508.107216247714, 25548.48903021929, 10200.38797672142, 10513.57945682164, 11696.532138714527, 11833.822492662617, 11888.94055529734, 10078.092971632588, 10108.696739097839, 10127.898721012696, 10304.227182961458, 10620.256582039183, 20114.798852011292, 20185.79814201898, 20351.389458316273, 20631.58736825225, 20781.480462988548, 21642.134314627237, 22277.554448911254, 22299.554008919407, 22674.65988010148, 22949.54100917939, 11718.414079296172, 11836.112291577994, 11848.822267665819, 11890.583829565923, 11890.583829565923, 15229.847701522844, 15285.465008725087, 15402.0, 15415.306311216247, 15553.533393998197, 10839.132869370274, 10872.565097396331, 11148.554057837595, 11267.380294083576, 11361.829572556584, 10420.32267902584, 10669.46652667379, 10705.9464702676, 10774.676759696908, 10936.890631093587, 10960.890391095987, 10976.560937562408, 11137.276077054965, 11145.164112691742, 11150.163737719542, 8307.916920830956, 8352.916470835215, 8361.665533378597, 8377.162283771575, 8422.157784221528, 8326.042505111747, 8510.659573616986, 8553.74338769838, 8562.57187140653, 8698.782530436789], "value": 6984.562622878199, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [546.5190632243628, 570.9172170035345, 572.5591294703079, 575.8186171356023, 585.5579037826441, 5804.825855224345, 6243.594166379182, 6263.467605253559, 6272.153259309997, 6319.589226700267, 6141.662208578527, 6151.723172457239, 6203.968980155093, 6224.937750622493, 6267.091271765591, 4913.705177689332, 4989.478209146209, 5049.444561098286, 5051.7623182320385, 5057.367829021372, 5069.112905241586, 5070.72111033893, 5074.0, 5085.313482679846, 5089.592832573404, 4954.7522623868845, 4960.305557221992, 4964.205727083668, 5006.144040280922, 5039.54790968188, 4995.550400463958, 5014.799408023675, 5026.2711906773675, 5038.773255203525, 5061.215511595708, 4592.724436533786, 4595.954040459619, 4605.457171847435, 4621.907561848778, 4624.1445332613575, 6138.539609529258, 6152.907706384408, 6156.353582873823, 6291.653959032252, 6294.496440284766, 5806.361300256968, 5817.418258174191, 5850.882982340372, 5863.882722345572, 5886.529077673776, 6634.5355825092265, 6645.60126392418, 6667.466242891275, 6703.1285932828905, 6726.899096513556, 4854.150523658345, 4987.62592805541, 5095.821646242363, 5112.897742045138, 5123.666961647481, 6801.251862295144, 6871.518993670495, 6889.552179108342, 6900.516963812535, 7003.754868579626, 5157.716325602053, 5177.58579313654, 5241.13521268994, 5245.554127899095, 5282.603804714662, 5260.368755749335, 5274.815381461707, 5285.942811437651, 5288.312519372457, 5292.7353632319, 5822.475977162076, 5848.415158484203, 5853.736581853742, 5891.23413956183, 5923.437273459014, 6730.899036514456, 6743.426808721216, 6747.763828265987, 6764.864702706017, 6800.761973330909, 1806.5122416947352, 1814.7912990006055, 1820.517562845847, 1831.8717689761854, 1849.3897013985352, 1241.2986662535818, 1289.6131160651955, 1314.7583370353716, 1316.967075823093, 1329.454923481368, 6129.601575897553, 6185.5876208278805, 6232.283287421914, 6254.0, 6258.342873998165, 6647.734090636417, 6697.162854643169, 6700.564463309869, 6715.0, 6759.0, 6103.389661033861, 6173.59871608344, 6218.782342618078, 6226.85173615102, 6304.369563043659, 3519.6832285094465, 3527.664871837171, 3549.432090865449, 3554.608993010767, 3567.340042092221, 6995.160580730345, 7048.647567621599, 7048.718051277994, 7081.46888983318, 7094.396976257076, 6785.253622101565, 6796.422304104207, 6875.931240687529, 6891.207511136284, 6895.482838787111, 6853.965730171317, 6879.007631680135, 6929.0, 6937.445004399636, 6947.548409353477, 6682.766103186365, 6713.731450741916, 6730.427913627396, 6755.459563235027, 6770.119884414995, 6684.298148694317, 6698.626781509876, 6732.124823772878, 6762.323767623198, 6774.8645027100165, 6932.410745086724, 6956.234814170539, 6968.233494315723, 7000.299970003162, 7044.542104763174, 5153.587712982878, 5160.291620892899, 5173.508516690908, 5194.194899790538, 5226.398964119175, 6606.075149478981, 6760.391564759196, 6760.425363843931, 6773.762918297836, 6790.0, 6072.453479186895, 6513.088167656627, 6517.152770139852, 6521.184851893513, 6541.542092053511, 6395.0, 6432.260290066515, 6526.140050085703, 6560.40956313934, 6568.507361947969, 6460.3862633049785, 6470.6117632940295, 6501.577397469149, 6502.902456463063, 6526.0095670818955, 6355.237371515448, 6508.576942498722, 6552.08270842092, 6621.404073633396, 6650.501212408992, 6325.513504326387, 6384.201974753156, 6436.710348034256, 6443.96778016107, 6455.9677201613695], "value": 5184.723557575119, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [888.9511076890772, 909.6497848328391, 916.9174774270315, 925.3615005646104, 931.4830269200593, 18170.45551128154, 19105.0, 19210.519737006583, 19220.615587688237, 19222.423327300185, 16037.0, 16100.194990250498, 17400.912995435006, 17636.118194090308, 17797.110144492788, 1026.1482969135636, 1041.3491567770143, 1047.7223535763028, 1048.0567489259688, 1048.4757621189406, 1037.1858091398253, 1051.0225490294024, 1060.194252368198, 1061.3843970497094, 1072.1369297715337, 1106.8948449897248, 1107.5071593141056, 1108.7117349489151, 1111.1000089927186, 1111.9833202501968, 1110.0952723530297, 1110.4836251143176, 1110.8944650258213, 1111.0112000319723, 1113.9164562657793, 790.4308897593723, 808.6522795198122, 809.554744890308, 809.7732634862248, 825.8885050518163, 16240.269187886455, 16495.587610309718, 16502.75245871313, 16530.66938661232, 16556.0, 22085.227017054487, 22509.54980900373, 22895.54208915829, 22970.310890673307, 22983.54032919332, 17772.733408998876, 18117.36589219371, 18219.635607287913, 18269.99515026673, 18360.0, 3923.4114882767526, 3945.4279129526344, 3950.4074388841905, 3950.6839452843706, 3957.1887763008804, 149804.0, 151972.2401387997, 160849.19575402164, 161060.0, 161066.0, 15121.16833574142, 15548.611284717972, 15596.766048509282, 15644.0, 15646.608834779221, 24801.25596232116, 24864.627030594555, 24865.751342486343, 24891.50216995686, 25427.74572254254, 8677.435966662148, 8707.216350528483, 8764.956175219211, 8783.604737786814, 8815.823683526422, 4161.854335098317, 4310.741355518616, 4318.222719910384, 4362.040351122748, 4362.520122786491, 6044.304904935901, 6137.386261373917, 6137.5703700741415, 6161.137440758297, 6165.136880836686, 1015.5633077776627, 1034.332855308322, 1041.3075304922293, 1062.436908438529, 1063.2769716592636, 684.5481981891927, 712.3659942651045, 712.508369225233, 716.5020310883885, 717.046328383249, 10888.891111088946, 10937.179711521667, 11225.382603956861, 12014.459349329301, 12784.169029013085, 681.931806819324, 683.1938312790855, 692.1071817355555, 706.9363757261871, 707.3598393453932, 5495.148252020943, 5515.062439385314, 5581.134924086773, 5594.776208951678, 5666.801661941812, 147762.0, 148341.25829370786, 149211.0, 151044.0, 151595.0, 100937.49531252444, 127133.36433317774, 127284.18147455591, 130996.0, 134766.65233347737, 113222.43388783168, 114064.42967785108, 115392.84607153988, 116476.41761791137, 116755.0, 13283.800742989057, 13410.463581456632, 13504.72990540164, 13525.0, 13556.389962451516, 52801.0, 53082.73458632682, 53597.73201133969, 54377.184342234104, 54956.450435495135, 66940.33059669341, 67335.66332168503, 67448.32551674421, 67579.66210168917, 69685.65157174182, 17078.74381884248, 17472.213750381517, 17504.387346442814, 17529.298828047245, 17669.911650441667, 20518.69221961642, 20560.38318850377, 20565.38303850887, 20623.0, 20730.378088657366, 17606.64786704233, 17728.82271177272, 17736.733948991034, 17874.910625447308, 17890.642187156445, 17359.3924212657, 17372.305107795546, 17553.473395798148, 17573.209205586034, 17672.381466648607, 16752.41366552165, 16984.49046528606, 17002.149892505076, 17044.829551704323, 17049.31802727877, 12276.938615306866, 12516.687082822638, 12706.428210730355, 12791.168574042658, 12881.677958051123, 14105.153690778587, 14163.433462661791, 14217.146971181763, 14301.356438960063, 14364.928175359475], "value": 9478.032603182653, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1365.9999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 107.0, 108.0, 105.0, 106.0, 106.0, 107.0, 105.0, 106.0, 105.0], "value": 106.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 111.0, 111.0, 112.0, 111.0, 111.0, 114.0, 111.0, 111.0, 112.0], "value": 111.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 162.0, 161.0, 161.0, 162.0, 163.0, 163.0, 163.0, 164.0], "value": 162.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 72.0, 72.0, 73.0, 72.0, 73.0, 73.0, 72.0, 73.0, 72.0], "value": 72.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 78.0, 78.0, 77.0, 77.0, 77.0, 83.0, 78.0, 78.0], "value": 78.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 113.0, 114.0, 118.0, 114.0, 113.0, 114.0, 110.0], "value": 113.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 150.0, 150.0, 151.0, 149.0, 149.0, 152.0, 149.0, 151.0, 150.0], "value": 150.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 94.0, 93.0, 94.0, 94.0, 94.0, 95.0, 95.0, 94.0, 97.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [45.0, 43.0, 45.0, 46.0, 47.0, 47.0, 45.0, 45.0, 43.0, 43.0], "value": 44.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [37.0, 37.0, 36.0, 37.0, 37.0, 37.0, 37.0, 36.0, 37.0, 36.0], "value": 36.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 70.0, 70.0, 70.0, 70.0, 71.0, 76.0, 70.0, 70.0, 70.0], "value": 70.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 101.0, 111.0, 110.0, 103.0, 110.0, 106.0, 106.0, 103.0, 114.0], "value": 107.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 163.0, 156.0, 153.0, 157.0, 157.0, 157.0, 160.0, 152.0, 152.0], "value": 156.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 61.0, 61.0, 58.0, 61.0, 58.0, 61.0, 61.0, 61.0, 61.0], "value": 60.2, "unit": "score"}]}]} 08:06:57 INFO - Return code: 0 08:06:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:06:57 INFO - # TBPL SUCCESS # 08:06:57 INFO - Running post-action listener: _package_coverage_data 08:06:57 INFO - Running post-action listener: _resource_record_post_action 08:06:57 INFO - [mozharness: 2017-09-21 15:06:57.859117Z] Finished run-tests step (success) 08:06:57 INFO - Running post-run listener: _resource_record_post_run 08:06:57 INFO - Total resource usage - Wall time: 1185s; CPU: 13.0%; Read bytes: 8192; Write bytes: 320655360; Read time: 528; Write time: 435744 08:06:57 INFO - TinderboxPrint: CPU usage
13.1% 08:06:57 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 528 08:06:57 INFO - TinderboxPrint: I/O write bytes / time
320,655,360 / 435,744 08:06:57 INFO - TinderboxPrint: CPU idle
8,211.5 (86.9%) 08:06:57 INFO - TinderboxPrint: CPU user
1,185.9 (12.6%) 08:06:57 INFO - TinderboxPrint: Swap in / out
0 / 0 08:06:57 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 15134720; Read time: 0; Write time: 9760 08:06:57 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 08:06:57 INFO - run-tests - Wall time: 1168s; CPU: 13.0%; Read bytes: 8192; Write bytes: 300400640; Read time: 528; Write time: 425352 08:06:58 INFO - Running post-run listener: _upload_blobber_files 08:06:58 INFO - Blob upload gear active. 08:06:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:06:58 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 08:06:58 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'] 08:06:58 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 08:06:58 INFO - (blobuploader) - INFO - Open directory for files ... 08:06:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 08:06:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:06:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:07:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 08:07:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:07:00 INFO - (blobuploader) - INFO - Done attempting. 08:07:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 08:07:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:07:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:07:01 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 08:07:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:07:01 INFO - (blobuploader) - INFO - Done attempting. 08:07:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:07:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:07:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:07:08 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:07:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:07:08 INFO - (blobuploader) - INFO - Done attempting. 08:07:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 08:07:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:07:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:07:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 08:07:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:07:09 INFO - (blobuploader) - INFO - Done attempting. 08:07:09 INFO - (blobuploader) - INFO - Iteration through files over. 08:07:09 INFO - Return code: 0 08:07:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:07:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:07:09 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9dfae4c971272b165b2ee2ebe617c07a14a6b21aaa2b982881ef5a0a86ccdb2fb41ceba3a9865253dc0f88c21bc34727a691ed3182a623ce2844a7b6a7f51645", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/91371c9e7ba8f89d2851d9b929978ebc2215b91bdd3d39832cf5286982573a7fb800b3ae30691b4a3c195c2802a8e985f93810224b97b15d2e74a889e3a85388", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c2c6fd8e5280884050cc8ab5faf6f26d6a17abbbb639b90a3cab6e601f4390a610c4083469f21004700816998ea338d00f12e70f91d53d33a6632ae3fc04573a", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e82ed5f7187087c9028c9bd21e4f3f8f4726d7629208e8e0ff4ef34487f187ef2083703a15df20ce1826a2027cdfd724f919fcfad7a7404f55858b22b5047471"} 08:07:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:07:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:07:09 INFO - Contents: 08:07:09 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9dfae4c971272b165b2ee2ebe617c07a14a6b21aaa2b982881ef5a0a86ccdb2fb41ceba3a9865253dc0f88c21bc34727a691ed3182a623ce2844a7b6a7f51645", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/91371c9e7ba8f89d2851d9b929978ebc2215b91bdd3d39832cf5286982573a7fb800b3ae30691b4a3c195c2802a8e985f93810224b97b15d2e74a889e3a85388", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c2c6fd8e5280884050cc8ab5faf6f26d6a17abbbb639b90a3cab6e601f4390a610c4083469f21004700816998ea338d00f12e70f91d53d33a6632ae3fc04573a", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e82ed5f7187087c9028c9bd21e4f3f8f4726d7629208e8e0ff4ef34487f187ef2083703a15df20ce1826a2027cdfd724f919fcfad7a7404f55858b22b5047471"} 08:07:09 INFO - Running post-run listener: copy_logs_to_upload_dir 08:07:09 INFO - Copying logs to upload dir... 08:07:09 INFO - mkdir: /builds/slave/test/build/upload/logs 08:07:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.492035 ========= master_lag: 0.83 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2017-09-21 08:07:09.951366) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-21 08:07:09.959950) ========= 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=836cfdc75598d54cb747368e000001a9-1506004283.846174-877056714 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9dfae4c971272b165b2ee2ebe617c07a14a6b21aaa2b982881ef5a0a86ccdb2fb41ceba3a9865253dc0f88c21bc34727a691ed3182a623ce2844a7b6a7f51645", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/91371c9e7ba8f89d2851d9b929978ebc2215b91bdd3d39832cf5286982573a7fb800b3ae30691b4a3c195c2802a8e985f93810224b97b15d2e74a889e3a85388", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c2c6fd8e5280884050cc8ab5faf6f26d6a17abbbb639b90a3cab6e601f4390a610c4083469f21004700816998ea338d00f12e70f91d53d33a6632ae3fc04573a", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e82ed5f7187087c9028c9bd21e4f3f8f4726d7629208e8e0ff4ef34487f187ef2083703a15df20ce1826a2027cdfd724f919fcfad7a7404f55858b22b5047471"} build_url:https://queue.taskcluster.net/v1/task/UMmLAK4MS9-u7NhJjbWm7w/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011425 build_url: 'https://queue.taskcluster.net/v1/task/UMmLAK4MS9-u7NhJjbWm7w/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9dfae4c971272b165b2ee2ebe617c07a14a6b21aaa2b982881ef5a0a86ccdb2fb41ceba3a9865253dc0f88c21bc34727a691ed3182a623ce2844a7b6a7f51645", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/91371c9e7ba8f89d2851d9b929978ebc2215b91bdd3d39832cf5286982573a7fb800b3ae30691b4a3c195c2802a8e985f93810224b97b15d2e74a889e3a85388", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c2c6fd8e5280884050cc8ab5faf6f26d6a17abbbb639b90a3cab6e601f4390a610c4083469f21004700816998ea338d00f12e70f91d53d33a6632ae3fc04573a", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e82ed5f7187087c9028c9bd21e4f3f8f4726d7629208e8e0ff4ef34487f187ef2083703a15df20ce1826a2027cdfd724f919fcfad7a7404f55858b22b5047471"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-21 08:07:09.988057) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-21 08:07:09.988409) ========= 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=836cfdc75598d54cb747368e000001a9-1506004283.846174-877056714 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004710 ========= master_lag: 0.22 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-21 08:07:10.215511) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-21 08:07:10.215853) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-21 08:07:10.216177) ========= ========= Total master_lag: 1.18 =========