builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s-pgo slave: talos-linux64-ix-059 starttime: 1505299650.47 results: success (0) revision: 9873269746359dbcccbd5b44f0e82c0225289945 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-13 03:47:30.468084) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-13 03:47:30.468468) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-13 03:47:30.468743) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-13 03:47:30.486990) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-13 03:47:30.487251) ========= 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=3a3620fb28aea1604ab609ef000001d2-1505298909.362317-1699111048 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-13 03:47:30-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 19.9M=0.001s 2017-09-13 03:47:30 (19.9 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.183539 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-13 03:47:30.689618) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-13 03:47:30.690189) ========= 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=3a3620fb28aea1604ab609ef000001d2-1505298909.362317-1699111048 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020160 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-13 03:47:30.743720) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-13 03:47:30.744332) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 9873269746359dbcccbd5b44f0e82c0225289945 --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 9873269746359dbcccbd5b44f0e82c0225289945 --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=3a3620fb28aea1604ab609ef000001d2-1505298909.362317-1699111048 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-13 03:47:30,791 truncating revision to first 12 chars 2017-09-13 03:47:30,791 Setting DEBUG logging. 2017-09-13 03:47:30,791 attempt 1/10 2017-09-13 03:47:30,791 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/987326974635?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-13 03:47:31,295 unpacking tar archive at: mozilla-central-987326974635/testing/mozharness/ program finished with exit code 0 elapsedTime=0.811778 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-13 03:47:31.572744) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-13 03:47:31.573016) ========= script_repo_revision: 9873269746359dbcccbd5b44f0e82c0225289945 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-13 03:47:31.573375) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-13 03:47:31.573628) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-13 03:47:31.588707) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2017-09-13 03:47:31.588980) ========= /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=3a3620fb28aea1604ab609ef000001d2-1505298909.362317-1699111048 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:47:31 INFO - MultiFileLogger online at 20170913 03:47:31 in /builds/slave/test 03:47:31 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 03:47:31 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:47:31 INFO - {'append_to_log': False, 03:47:31 INFO - 'base_work_dir': '/builds/slave/test', 03:47:31 INFO - 'blob_upload_branch': 'Firefox', 03:47:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:47:31 INFO - 'branch': 'Firefox', 03:47:31 INFO - 'buildbot_json_path': 'buildprops.json', 03:47:31 INFO - 'code_coverage': False, 03:47:31 INFO - 'config_files': ('talos/linux_config.py',), 03:47:31 INFO - 'default_actions': ('clobber', 03:47:31 INFO - 'read-buildbot-config', 03:47:31 INFO - 'download-and-extract', 03:47:31 INFO - 'populate-webroot', 03:47:31 INFO - 'create-virtualenv', 03:47:31 INFO - 'install', 03:47:31 INFO - 'setup-mitmproxy', 03:47:31 INFO - 'run-tests'), 03:47:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:47:31 INFO - 'disable_ccov_upload': False, 03:47:31 INFO - 'disable_stylo': False, 03:47:31 INFO - 'download_minidump_stackwalk': True, 03:47:31 INFO - 'download_symbols': 'ondemand', 03:47:31 INFO - 'enable_stylo': False, 03:47:31 INFO - 'enable_webrender': False, 03:47:31 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 03:47:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:47:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:47:31 INFO - 'gecko_profile': False, 03:47:31 INFO - 'gecko_profile_interval': 0, 03:47:31 INFO - 'installer_path': 'installer.exe', 03:47:31 INFO - 'log_level': 'info', 03:47:31 INFO - 'log_name': 'talos', 03:47:31 INFO - 'log_to_console': True, 03:47:31 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:47:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:47:31 INFO - 'opt_config_files': (), 03:47:31 INFO - 'pip_index': False, 03:47:31 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 03:47:31 INFO - 'system_bits': '32', 03:47:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:47:31 INFO - 'title': 'talos-linux64-ix-059', 03:47:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:47:31 INFO - 'use_talos_json': True, 03:47:31 INFO - 'verify': 'False', 03:47:31 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:47:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:47:31 INFO - 'work_dir': 'build'} 03:47:31 INFO - [mozharness: 2017-09-13 10:47:31.775469Z] Running clobber step. 03:47:31 INFO - Running pre-action listener: _resource_record_pre_action 03:47:31 INFO - Running main action method: clobber 03:47:31 INFO - rmtree: /builds/slave/test/build 03:47:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:47:33 INFO - Running post-action listener: _resource_record_post_action 03:47:33 INFO - [mozharness: 2017-09-13 10:47:33.316133Z] Finished clobber step (success) 03:47:33 INFO - [mozharness: 2017-09-13 10:47:33.316231Z] Running read-buildbot-config step. 03:47:33 INFO - Running pre-action listener: _resource_record_pre_action 03:47:33 INFO - Running main action method: read_buildbot_config 03:47:33 INFO - Using buildbot properties: 03:47:33 INFO - { 03:47:33 INFO - "project": "", 03:47:33 INFO - "product": "firefox", 03:47:33 INFO - "who": "archaeopteryx@coole-files.de", 03:47:33 INFO - "installer_path": "public/build/target.tar.bz2", 03:47:33 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 03:47:33 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 03:47:33 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-stylo-disabled-e10s", 03:47:33 INFO - "stage_platform": "linux64-pgo", 03:47:33 INFO - "basedir": "/builds/slave/test", 03:47:33 INFO - "buildnumber": 11, 03:47:33 INFO - "platform": "ubuntu64_hw", 03:47:33 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:47:33 INFO - "slavebuilddir": "test", 03:47:33 INFO - "taskId": "YNaR586uQF6lncYZT1eXyQ", 03:47:33 INFO - "branch": "mozilla-central", 03:47:33 INFO - "script_repo_revision": "production", 03:47:33 INFO - "revision": "9873269746359dbcccbd5b44f0e82c0225289945", 03:47:33 INFO - "slavename": "talos-linux64-ix-059", 03:47:33 INFO - "repo_path": "mozilla-central" 03:47:33 INFO - } 03:47:33 INFO - Finding installer, test and symbols from parent task. 03:47:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YNaR586uQF6lncYZT1eXyQ'}, attempt #1 03:47:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YNaR586uQF6lncYZT1eXyQ'}, attempt #1 03:47:34 INFO - Task dependencies: YIkFlt9lTBKLLWKJyRiPbA 03:47:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YIkFlt9lTBKLLWKJyRiPbA'}, attempt #1 03:47:34 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/YIkFlt9lTBKLLWKJyRiPbA/artifacts/public/build/target.tar.bz2 03:47:34 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/YIkFlt9lTBKLLWKJyRiPbA/artifacts/public/build/target.test_packages.json 03:47:34 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/YIkFlt9lTBKLLWKJyRiPbA/artifacts/public/build/target.crashreporter-symbols.zip 03:47:34 INFO - Running post-action listener: _resource_record_post_action 03:47:34 INFO - [mozharness: 2017-09-13 10:47:34.738760Z] Finished read-buildbot-config step (success) 03:47:34 INFO - [mozharness: 2017-09-13 10:47:34.738979Z] Running download-and-extract step. 03:47:34 INFO - Running pre-action listener: _resource_record_pre_action 03:47:34 INFO - Running main action method: download_and_extract 03:47:34 INFO - mkdir: /builds/slave/test/build/tests 03:47:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:47:34 INFO - trying https://queue.taskcluster.net/v1/task/YIkFlt9lTBKLLWKJyRiPbA/artifacts/public/build/target.test_packages.json 03:47:34 INFO - Downloading https://queue.taskcluster.net/v1/task/YIkFlt9lTBKLLWKJyRiPbA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 03:47:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YIkFlt9lTBKLLWKJyRiPbA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 03:47:35 INFO - Downloaded 989 bytes. 03:47:35 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 03:47:35 INFO - Using the following test package requirements: 03:47:35 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 03:47:35 INFO - u'common': [u'target.common.tests.zip'], 03:47:35 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 03:47:35 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 03:47:35 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 03:47:35 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 03:47:35 INFO - u'mozbase': [u'target.common.tests.zip'], 03:47:35 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 03:47:35 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 03:47:35 INFO - u'web-platform': [u'target.common.tests.zip', 03:47:35 INFO - u'target.web-platform.tests.tar.gz'], 03:47:35 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 03:47:35 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 03:47:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YIkFlt9lTBKLLWKJyRiPbA/artifacts/public/build/target.common.tests.zip 03:47:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YIkFlt9lTBKLLWKJyRiPbA/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:47:35 INFO - Fetch https://queue.taskcluster.net/v1/task/YIkFlt9lTBKLLWKJyRiPbA/artifacts/public/build/target.common.tests.zip into memory 03:47:36 INFO - Content-Length response header: 55153312 03:47:36 INFO - Bytes received: 55153312 03:47:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YIkFlt9lTBKLLWKJyRiPbA/artifacts/public/build/target.talos.tests.zip 03:47:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YIkFlt9lTBKLLWKJyRiPbA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 03:47:47 INFO - Fetch https://queue.taskcluster.net/v1/task/YIkFlt9lTBKLLWKJyRiPbA/artifacts/public/build/target.talos.tests.zip into memory 03:47:47 INFO - Content-Length response header: 14499226 03:47:47 INFO - Bytes received: 14499226 03:47: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')]} 03:47:48 INFO - trying https://queue.taskcluster.net/v1/task/YIkFlt9lTBKLLWKJyRiPbA/artifacts/public/build/target.tar.bz2 03:47:48 INFO - Downloading https://queue.taskcluster.net/v1/task/YIkFlt9lTBKLLWKJyRiPbA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 03:47:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YIkFlt9lTBKLLWKJyRiPbA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 03:47:49 INFO - Downloaded 62316435 bytes. 03:47:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YIkFlt9lTBKLLWKJyRiPbA/artifacts/public/build/target.tar.bz2 03:47:49 INFO - mkdir: /builds/slave/test/properties 03:47:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:47:49 INFO - Writing to file /builds/slave/test/properties/build_url 03:47:49 INFO - Contents: 03:47:49 INFO - build_url:https://queue.taskcluster.net/v1/task/YIkFlt9lTBKLLWKJyRiPbA/artifacts/public/build/target.tar.bz2 03:47:49 INFO - Running post-action listener: _resource_record_post_action 03:47:49 INFO - Running post-action listener: find_tests_for_verification 03:47:49 INFO - Running post-action listener: set_extra_try_arguments 03:47:49 INFO - [mozharness: 2017-09-13 10:47:49.246237Z] Finished download-and-extract step (success) 03:47:49 INFO - [mozharness: 2017-09-13 10:47:49.246347Z] Running populate-webroot step. 03:47:49 INFO - Running pre-action listener: _resource_record_pre_action 03:47:49 INFO - Running main action method: populate_webroot 03:47:49 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:47:49 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:47:49 INFO - 'tests': ['tresize', 03:47:49 INFO - 'tcanvasmark']}, 03:47:49 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:47:49 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:47:49 INFO - 'tests': ['dromaeo_css', 03:47:49 INFO - 'kraken']}, 03:47:49 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:47:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:47:49 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:47:49 INFO - 'talos_options': ['--disable-stylo'], 03:47:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:47:49 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:47:49 INFO - 'tests': ['damp', 'tps']}, 03:47:49 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:47:49 INFO - 'talos_options': ['--disable-stylo'], 03:47:49 INFO - 'tests': ['damp', 'tps']}, 03:47:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:47:49 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:47:49 INFO - 'tests': ['dromaeo_dom']}, 03:47:49 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:47:49 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:47:49 INFO - 'tests': ['basic_compositor_video', 03:47:49 INFO - 'glvideo']}, 03:47:49 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 03:47:49 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 03:47:49 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:47:49 INFO - 'talos_options': ['--disable-stylo'], 03:47:49 INFO - 'tests': ['ts_paint_webext', 03:47:49 INFO - 'tp5o_webext']}, 03:47:49 INFO - 'other-e10s': {'tests': ['a11yr', 03:47:49 INFO - 'ts_paint', 03:47:49 INFO - 'tpaint', 03:47:49 INFO - 'sessionrestore', 03:47:49 INFO - 'sessionrestore_many_windows', 03:47:49 INFO - 'sessionrestore_no_auto_restore', 03:47:49 INFO - 'tabpaint']}, 03:47:49 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:47:49 INFO - 'tests': ['a11yr', 03:47:49 INFO - 'ts_paint', 03:47:49 INFO - 'tpaint', 03:47:49 INFO - 'sessionrestore', 03:47:49 INFO - 'sessionrestore_many_windows', 03:47:49 INFO - 'sessionrestore_no_auto_restore', 03:47:49 INFO - 'tabpaint']}, 03:47:49 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 03:47:49 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 03:47:49 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:47:49 INFO - 'tests': ['bloom_basic_singleton']}, 03:47:49 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:47:49 INFO - 'tests': ['bloom_basic']}, 03:47:49 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:47:49 INFO - 'tsvgr_opacity', 03:47:49 INFO - 'tart', 03:47:49 INFO - 'tscrollx', 03:47:49 INFO - 'tsvg_static']}, 03:47:49 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:47:49 INFO - 'tests': ['tsvgx', 03:47:49 INFO - 'tsvgr_opacity', 03:47:49 INFO - 'tart', 03:47:49 INFO - 'tscrollx', 03:47:49 INFO - 'tsvg_static']}, 03:47:49 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:47:49 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:47:49 INFO - 'talos_options': ['--disable-stylo'], 03:47:49 INFO - 'tests': ['tp5o']}, 03:47:49 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:47:49 INFO - 'talos_options': ['--mitmproxy', 03:47:49 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:47:49 INFO - '--firstNonBlankPaint'], 03:47:49 INFO - 'tests': ['tp6_google', 03:47:49 INFO - 'tp6_youtube', 03:47:49 INFO - 'tp6_amazon', 03:47:49 INFO - 'tp6_facebook']}, 03:47:49 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:47:49 INFO - 'talos_options': ['--disable-stylo', 03:47:49 INFO - '--mitmproxy', 03:47:49 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:47:49 INFO - '--firstNonBlankPaint'], 03:47:49 INFO - 'tests': ['tp6_google', 03:47:49 INFO - 'tp6_youtube', 03:47:49 INFO - 'tp6_amazon', 03:47:49 INFO - 'tp6_facebook']}, 03:47:49 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:47:49 INFO - 'talos_options': ['--stylo-threads=1', 03:47:49 INFO - '--mitmproxy', 03:47:49 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:47:49 INFO - '--firstNonBlankPaint'], 03:47:49 INFO - 'tests': ['tp6_google', 03:47:49 INFO - 'tp6_youtube', 03:47:49 INFO - 'tp6_amazon', 03:47:49 INFO - 'tp6_facebook']}, 03:47:49 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:47:49 INFO - 'talos_options': ['--xperf_path', 03:47:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:47:49 INFO - 'tests': ['tp5n']}, 03:47:49 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:47:49 INFO - 'talos_options': ['--disable-stylo', 03:47:49 INFO - '--xperf_path', 03:47:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:47:49 INFO - 'tests': ['tp5n']}}} 03:47:49 INFO - Running post-action listener: _resource_record_post_action 03:47:49 INFO - [mozharness: 2017-09-13 10:47:49.262524Z] Finished populate-webroot step (success) 03:47:49 INFO - [mozharness: 2017-09-13 10:47:49.262633Z] Running create-virtualenv step. 03:47:49 INFO - Running pre-action listener: _resource_record_pre_action 03:47:49 INFO - Running main action method: create_virtualenv 03:47:49 INFO - Creating virtualenv /builds/slave/test/build/venv 03:47:49 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:47:49 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 03:47:49 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 03:47:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:47:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:47:49 INFO - Installing distribute.............................................................................................................................................................................................done. 03:47:50 INFO - Installing pip...............done. 03:47:50 INFO - Return code: 0 03:47:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:47:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:47:50 INFO - Reading from file tmpfile_stdout 03:47:50 INFO - Output received: 03:47:50 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 03:47:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:47: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')]} 03:47:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:47: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')]} 03:47:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:47: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x211a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22e3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2486a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x248a090>, '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 0x248ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2484f90>, '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': '3a3620fb28aea1604ab609ef000001d2-1505298909.362317-1699111048', '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 03:47: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', 'pip>=1.5'] in /builds/slave/test/build 03:47: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 pip>=1.5 03:47:50 INFO - Using env: {'DISPLAY': ':0', 03:47:50 INFO - 'HOME': '/home/cltbld', 03:47:50 INFO - 'LANG': 'en_US.UTF-8', 03:47:50 INFO - 'LANGUAGE': 'en_US:en', 03:47:50 INFO - 'LOGNAME': 'cltbld', 03:47:50 INFO - 'MAIL': '/var/mail/cltbld', 03:47:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:47:50 INFO - 'MOZ_NO_REMOTE': '1', 03:47:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:47:50 INFO - 'NO_EM_RESTART': '1', 03:47:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:47:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:47:50 INFO - 'PWD': '/builds/slave/test', 03:47:50 INFO - 'SHELL': '/bin/bash', 03:47:50 INFO - 'SHLVL': '1', 03:47:50 INFO - 'TERM': 'linux', 03:47:50 INFO - 'TMOUT': '86400', 03:47:50 INFO - 'USER': 'cltbld', 03:47:50 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1505298909.362317-1699111048', 03:47:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:47:50 INFO - '_': '/tools/buildbot/bin/python'} 03:47:51 INFO - Ignoring indexes: http://pypi.python.org/simple/ 03:47:51 INFO - Downloading/unpacking pip>=1.5 03:47:51 INFO - Running setup.py egg_info for package pip 03:47:51 INFO - warning: no files found matching 'pip/cacert.pem' 03:47:51 INFO - warning: no files found matching '*.html' under directory 'docs' 03:47:51 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 03:47:51 INFO - no previously-included directories found matching 'docs/_build/_sources' 03:47:51 INFO - Installing collected packages: pip 03:47:51 INFO - Found existing installation: pip 1.1 03:47:51 INFO - Uninstalling pip: 03:47:51 INFO - Successfully uninstalled pip 03:47:51 INFO - Running setup.py install for pip 03:47:51 INFO - warning: no files found matching 'pip/cacert.pem' 03:47:51 INFO - warning: no files found matching '*.html' under directory 'docs' 03:47:51 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 03:47:51 INFO - no previously-included directories found matching 'docs/_build/_sources' 03:47:51 INFO - Installing pip script to /builds/slave/test/build/venv/bin 03:47:51 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 03:47:51 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 03:47:51 INFO - Successfully installed pip 03:47:51 INFO - Cleaning up... 03:47:51 INFO - Return code: 0 03:47:51 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:47:51 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')]} 03:47:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:47:51 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')]} 03:47:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:47:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x211a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22e3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2486a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x248a090>, '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 0x248ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2484f90>, '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': '3a3620fb28aea1604ab609ef000001d2-1505298909.362317-1699111048', '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 03:47:51 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 03:47:51 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 03:47:51 INFO - Using env: {'DISPLAY': ':0', 03:47:51 INFO - 'HOME': '/home/cltbld', 03:47:51 INFO - 'LANG': 'en_US.UTF-8', 03:47:51 INFO - 'LANGUAGE': 'en_US:en', 03:47:51 INFO - 'LOGNAME': 'cltbld', 03:47:51 INFO - 'MAIL': '/var/mail/cltbld', 03:47:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:47:51 INFO - 'MOZ_NO_REMOTE': '1', 03:47:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:47:51 INFO - 'NO_EM_RESTART': '1', 03:47:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:47:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:47:51 INFO - 'PWD': '/builds/slave/test', 03:47:51 INFO - 'SHELL': '/bin/bash', 03:47:51 INFO - 'SHLVL': '1', 03:47:51 INFO - 'TERM': 'linux', 03:47:51 INFO - 'TMOUT': '86400', 03:47:51 INFO - 'USER': 'cltbld', 03:47:51 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1505298909.362317-1699111048', 03:47:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:47:51 INFO - '_': '/tools/buildbot/bin/python'} 03:47:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:47:51 INFO - Downloading/unpacking psutil>=3.1.1 03:47:51 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 03:47:51 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 03:47:51 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 03:47:51 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 03:47:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:47:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:47:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:47:52 INFO - Installing collected packages: psutil 03:47:52 INFO - Running setup.py install for psutil 03:47:53 INFO - building 'psutil._psutil_linux' extension 03:47:53 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 03:47:53 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 03:47:53 INFO - building 'psutil._psutil_posix' extension 03:47:53 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 03:47:53 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 03:47:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:47:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:47:53 INFO - Successfully installed psutil 03:47:53 INFO - Cleaning up... 03:47:53 INFO - Return code: 0 03:47:53 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:47: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')]} 03:47:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:47: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')]} 03:47:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:47: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x211a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22e3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2486a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x248a090>, '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 0x248ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2484f90>, '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': '3a3620fb28aea1604ab609ef000001d2-1505298909.362317-1699111048', '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 03:47: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:47: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 mozsystemmonitor==0.3 03:47:53 INFO - Using env: {'DISPLAY': ':0', 03:47:53 INFO - 'HOME': '/home/cltbld', 03:47:53 INFO - 'LANG': 'en_US.UTF-8', 03:47:53 INFO - 'LANGUAGE': 'en_US:en', 03:47:53 INFO - 'LOGNAME': 'cltbld', 03:47:53 INFO - 'MAIL': '/var/mail/cltbld', 03:47:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:47:53 INFO - 'MOZ_NO_REMOTE': '1', 03:47:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:47:53 INFO - 'NO_EM_RESTART': '1', 03:47:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:47:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:47:53 INFO - 'PWD': '/builds/slave/test', 03:47:53 INFO - 'SHELL': '/bin/bash', 03:47:53 INFO - 'SHLVL': '1', 03:47:53 INFO - 'TERM': 'linux', 03:47:53 INFO - 'TMOUT': '86400', 03:47:53 INFO - 'USER': 'cltbld', 03:47:53 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1505298909.362317-1699111048', 03:47:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:47:53 INFO - '_': '/tools/buildbot/bin/python'} 03:47:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:47:53 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:47: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 03:47: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 03:47: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 03:47: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 03:47:54 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:47:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:47:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:47:54 INFO - Installing collected packages: mozsystemmonitor 03:47:54 INFO - Running setup.py install for mozsystemmonitor 03:47:54 INFO - Successfully installed mozsystemmonitor 03:47:54 INFO - Cleaning up... 03:47:55 INFO - Return code: 0 03:47:55 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:47:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:47:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:47:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:47:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:47:55 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 0x211a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22e3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2486a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x248a090>, '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 0x248ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2484f90>, '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': '3a3620fb28aea1604ab609ef000001d2-1505298909.362317-1699111048', '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 03:47:55 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 03:47:55 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 03:47:55 INFO - Using env: {'DISPLAY': ':0', 03:47:55 INFO - 'HOME': '/home/cltbld', 03:47:55 INFO - 'LANG': 'en_US.UTF-8', 03:47:55 INFO - 'LANGUAGE': 'en_US:en', 03:47:55 INFO - 'LOGNAME': 'cltbld', 03:47:55 INFO - 'MAIL': '/var/mail/cltbld', 03:47:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:47:55 INFO - 'MOZ_NO_REMOTE': '1', 03:47:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:47:55 INFO - 'NO_EM_RESTART': '1', 03:47:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:47:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:47:55 INFO - 'PWD': '/builds/slave/test', 03:47:55 INFO - 'SHELL': '/bin/bash', 03:47:55 INFO - 'SHLVL': '1', 03:47:55 INFO - 'TERM': 'linux', 03:47:55 INFO - 'TMOUT': '86400', 03:47:55 INFO - 'USER': 'cltbld', 03:47:55 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1505298909.362317-1699111048', 03:47:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:47:55 INFO - '_': '/tools/buildbot/bin/python'} 03:47:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:47:55 INFO - Downloading/unpacking jsonschema==2.5.1 03:47: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 03:47: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 03:47: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 03:47: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 03:47:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:47:56 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:47:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:47:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:47:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:47:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:47:57 INFO - Downloading functools32-3.2.3-2.tar.gz 03:47:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:47:57 INFO - warning: no files found matching '*.txt' 03:47:57 INFO - no previously-included directories found matching 'build' 03:47:57 INFO - no previously-included directories found matching 'dist' 03:47:57 INFO - no previously-included directories found matching '.git*' 03:47:57 INFO - Installing collected packages: jsonschema, functools32 03:47:58 INFO - Running setup.py install for functools32 03:47:58 INFO - warning: no files found matching '*.txt' 03:47:58 INFO - no previously-included directories found matching 'build' 03:47:58 INFO - no previously-included directories found matching 'dist' 03:47:58 INFO - no previously-included directories found matching '.git*' 03:47:58 INFO - Successfully installed jsonschema functools32 03:47:58 INFO - Cleaning up... 03:47:58 INFO - Return code: 0 03:47:58 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:47:58 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')]} 03:47:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:47:58 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')]} 03:47:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:47:58 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 0x211a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22e3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2486a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x248a090>, '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 0x248ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2484f90>, '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': '3a3620fb28aea1604ab609ef000001d2-1505298909.362317-1699111048', '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 03:47:58 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 03:47:58 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 03:47:58 INFO - Using env: {'DISPLAY': ':0', 03:47:58 INFO - 'HOME': '/home/cltbld', 03:47:58 INFO - 'LANG': 'en_US.UTF-8', 03:47:58 INFO - 'LANGUAGE': 'en_US:en', 03:47:58 INFO - 'LOGNAME': 'cltbld', 03:47:58 INFO - 'MAIL': '/var/mail/cltbld', 03:47:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:47:58 INFO - 'MOZ_NO_REMOTE': '1', 03:47:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:47:58 INFO - 'NO_EM_RESTART': '1', 03:47:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:47:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:47:58 INFO - 'PWD': '/builds/slave/test', 03:47:58 INFO - 'SHELL': '/bin/bash', 03:47:58 INFO - 'SHLVL': '1', 03:47:58 INFO - 'TERM': 'linux', 03:47:58 INFO - 'TMOUT': '86400', 03:47:58 INFO - 'USER': 'cltbld', 03:47:58 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1505298909.362317-1699111048', 03:47:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:47:58 INFO - '_': '/tools/buildbot/bin/python'} 03:47:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:47:58 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:47:58 INFO - Cleaning up... 03:47:58 INFO - Return code: 0 03:47:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:47:58 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')]} 03:47:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:47:58 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')]} 03:47:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:47:58 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 0x211a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22e3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2486a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x248a090>, '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 0x248ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2484f90>, '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': '3a3620fb28aea1604ab609ef000001d2-1505298909.362317-1699111048', '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 03:47:58 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 03:47:58 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 03:47:58 INFO - Using env: {'DISPLAY': ':0', 03:47:58 INFO - 'HOME': '/home/cltbld', 03:47:58 INFO - 'LANG': 'en_US.UTF-8', 03:47:58 INFO - 'LANGUAGE': 'en_US:en', 03:47:58 INFO - 'LOGNAME': 'cltbld', 03:47:58 INFO - 'MAIL': '/var/mail/cltbld', 03:47:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:47:58 INFO - 'MOZ_NO_REMOTE': '1', 03:47:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:47:58 INFO - 'NO_EM_RESTART': '1', 03:47:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:47:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:47:58 INFO - 'PWD': '/builds/slave/test', 03:47:58 INFO - 'SHELL': '/bin/bash', 03:47:58 INFO - 'SHLVL': '1', 03:47:58 INFO - 'TERM': 'linux', 03:47:58 INFO - 'TMOUT': '86400', 03:47:58 INFO - 'USER': 'cltbld', 03:47:58 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1505298909.362317-1699111048', 03:47:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:47:58 INFO - '_': '/tools/buildbot/bin/python'} 03:47:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:47:58 INFO - Downloading/unpacking blobuploader==1.2.4 03:47:58 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 03:47:58 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 03:47:58 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 03:47:58 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 03:47:59 INFO - Downloading blobuploader-1.2.4.tar.gz 03:47:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:47:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:47:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:47:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:47:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:47:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:48:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:48:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:48: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 03:48: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 03:48: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 03:48: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 03:48:00 INFO - Downloading docopt-0.6.1.tar.gz 03:48:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:48:00 INFO - Installing collected packages: blobuploader, requests, docopt 03:48:00 INFO - Running setup.py install for blobuploader 03:48:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:48:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:48:00 INFO - Running setup.py install for requests 03:48:00 INFO - Running setup.py install for docopt 03:48:00 INFO - Successfully installed blobuploader requests docopt 03:48:00 INFO - Cleaning up... 03:48:00 INFO - Return code: 0 03:48:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:48:00 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')]} 03:48:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:48:00 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')]} 03:48:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:48:00 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 0x211a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22e3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2486a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x248a090>, '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 0x248ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2484f90>, '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': '3a3620fb28aea1604ab609ef000001d2-1505298909.362317-1699111048', '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 03:48:00 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 03:48:00 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 03:48:00 INFO - Using env: {'DISPLAY': ':0', 03:48:00 INFO - 'HOME': '/home/cltbld', 03:48:00 INFO - 'LANG': 'en_US.UTF-8', 03:48:00 INFO - 'LANGUAGE': 'en_US:en', 03:48:00 INFO - 'LOGNAME': 'cltbld', 03:48:00 INFO - 'MAIL': '/var/mail/cltbld', 03:48:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:48:00 INFO - 'MOZ_NO_REMOTE': '1', 03:48:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:48:00 INFO - 'NO_EM_RESTART': '1', 03:48:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:48:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:48:00 INFO - 'PWD': '/builds/slave/test', 03:48:00 INFO - 'SHELL': '/bin/bash', 03:48:00 INFO - 'SHLVL': '1', 03:48:00 INFO - 'TERM': 'linux', 03:48:00 INFO - 'TMOUT': '86400', 03:48:00 INFO - 'USER': 'cltbld', 03:48:00 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1505298909.362317-1699111048', 03:48:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:48:00 INFO - '_': '/tools/buildbot/bin/python'} 03:48:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:48:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:48:01 INFO - Running setup.py (path:/tmp/pip-8LXdaU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:48:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:48:01 INFO - Running setup.py (path:/tmp/pip-1tFCVf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:48:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:48:01 INFO - Running setup.py (path:/tmp/pip-T_pO39-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:48:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:48:01 INFO - Running setup.py (path:/tmp/pip-Qb1JrH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:48:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:48:01 INFO - Running setup.py (path:/tmp/pip-qtX5F3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:48:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:48:01 INFO - Running setup.py (path:/tmp/pip-LUz41_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:48:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:48:01 INFO - Running setup.py (path:/tmp/pip-6NgA0Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:48:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:48:01 INFO - Running setup.py (path:/tmp/pip-nzwG_4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:48:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:48:01 INFO - Running setup.py (path:/tmp/pip-Et_Kny-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:48:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:48:01 INFO - Running setup.py (path:/tmp/pip-HaO_qI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:48:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:48:01 INFO - Running setup.py (path:/tmp/pip-mPcwh_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:48:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:48:01 INFO - Running setup.py (path:/tmp/pip-IVJrPH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:48:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:48:02 INFO - Running setup.py (path:/tmp/pip-Arb6EE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:48:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:48:02 INFO - Running setup.py (path:/tmp/pip-3Urtb8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:48:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:48:02 INFO - Running setup.py (path:/tmp/pip-D7fIBk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:48:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:48:02 INFO - Running setup.py (path:/tmp/pip-ae4UUQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:48:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:48:02 INFO - Running setup.py (path:/tmp/pip-s_c2Ze-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:48:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:48:02 INFO - Running setup.py install for manifestparser 03:48:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:48:02 INFO - Running setup.py install for mozcrash 03:48:02 INFO - Running setup.py install for mozdebug 03:48:02 INFO - Running setup.py install for mozdevice 03:48:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:48:02 INFO - Running setup.py install for mozfile 03:48:02 INFO - Running setup.py install for mozhttpd 03:48:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:48:02 INFO - Running setup.py install for mozinfo 03:48:03 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:48:03 INFO - Running setup.py install for mozInstall 03:48:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:48:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:48:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:48:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:48:03 INFO - Running setup.py install for mozleak 03:48:03 INFO - Running setup.py install for mozlog 03:48:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:48:03 INFO - Running setup.py install for moznetwork 03:48:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:48:03 INFO - Running setup.py install for mozprocess 03:48:03 INFO - Running setup.py install for mozprofile 03:48:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:48:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:48:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:48:03 INFO - Running setup.py install for mozrunner 03:48:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:48:03 INFO - Running setup.py install for mozscreenshot 03:48:03 INFO - Running setup.py install for moztest 03:48:03 INFO - Running setup.py install for mozversion 03:48:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:48:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:48:04 INFO - Cleaning up... 03:48:04 INFO - Return code: 0 03:48:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:48:04 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')]} 03:48:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:48:04 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')]} 03:48:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:48:04 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 0x211a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22e3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2486a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x248a090>, '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 0x248ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2484f90>, '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': '3a3620fb28aea1604ab609ef000001d2-1505298909.362317-1699111048', '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 03:48:04 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 03:48:04 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 03:48:04 INFO - Using env: {'DISPLAY': ':0', 03:48:04 INFO - 'HOME': '/home/cltbld', 03:48:04 INFO - 'LANG': 'en_US.UTF-8', 03:48:04 INFO - 'LANGUAGE': 'en_US:en', 03:48:04 INFO - 'LOGNAME': 'cltbld', 03:48:04 INFO - 'MAIL': '/var/mail/cltbld', 03:48:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:48:04 INFO - 'MOZ_NO_REMOTE': '1', 03:48:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:48:04 INFO - 'NO_EM_RESTART': '1', 03:48:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:48:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:48:04 INFO - 'PWD': '/builds/slave/test', 03:48:04 INFO - 'SHELL': '/bin/bash', 03:48:04 INFO - 'SHLVL': '1', 03:48:04 INFO - 'TERM': 'linux', 03:48:04 INFO - 'TMOUT': '86400', 03:48:04 INFO - 'USER': 'cltbld', 03:48:04 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1505298909.362317-1699111048', 03:48:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:48:04 INFO - '_': '/tools/buildbot/bin/python'} 03:48:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:48:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:48:04 INFO - Running setup.py (path:/tmp/pip-XuSQzO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:48:04 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)) 03:48:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:48:04 INFO - Running setup.py (path:/tmp/pip-c0UsOl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:48:04 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)) 03:48:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:48:04 INFO - Running setup.py (path:/tmp/pip-YrHo9r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:48:04 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)) 03:48:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:48:04 INFO - Running setup.py (path:/tmp/pip-_M20Av-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:48:04 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)) 03:48:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:48:04 INFO - Running setup.py (path:/tmp/pip-YVcQem-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:48:04 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)) 03:48:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:48:04 INFO - Running setup.py (path:/tmp/pip-T_cvpp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:48:04 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)) 03:48:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:48:04 INFO - Running setup.py (path:/tmp/pip-9206HP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:48:04 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)) 03:48:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:48:04 INFO - Running setup.py (path:/tmp/pip-460Vs6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:48:04 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)) 03:48:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:48:04 INFO - Running setup.py (path:/tmp/pip-o671Ti-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:48:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 03:48:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:48:04 INFO - Running setup.py (path:/tmp/pip-pZD52C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:48:05 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)) 03:48:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:48:05 INFO - Running setup.py (path:/tmp/pip-fIMePh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:48:05 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)) 03:48:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:48:05 INFO - Running setup.py (path:/tmp/pip-5ercU0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:48:05 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)) 03:48:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:48:05 INFO - Running setup.py (path:/tmp/pip-TrfE_E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:48:05 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)) 03:48:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:48:05 INFO - Running setup.py (path:/tmp/pip-2Jpp9D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:48:05 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)) 03:48:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:48:05 INFO - Running setup.py (path:/tmp/pip-otpnVA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:48:05 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)) 03:48:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:48:05 INFO - Running setup.py (path:/tmp/pip-sRDXNs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:48:05 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)) 03:48:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:48:05 INFO - Running setup.py (path:/tmp/pip-eGqFp2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:48:05 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)) 03:48:05 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)) 03:48:05 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)) 03:48:05 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)) 03:48:05 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)) 03:48:05 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)) 03:48:05 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)) 03:48:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:48:05 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 03:48:05 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 03:48:05 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 03:48:05 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 03:48:06 INFO - Downloading blessings-1.6.tar.gz 03:48:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:48:06 INFO - Installing collected packages: blessings 03:48:06 INFO - Running setup.py install for blessings 03:48:06 INFO - Successfully installed blessings 03:48:06 INFO - Cleaning up... 03:48:06 INFO - Return code: 0 03:48:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:48:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:48:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:48:07 INFO - Reading from file tmpfile_stdout 03:48:07 INFO - Current package versions: 03:48:07 INFO - argparse == 1.2.1 03:48:07 INFO - blessings == 1.6 03:48:07 INFO - blobuploader == 1.2.4 03:48:07 INFO - docopt == 0.6.1 03:48:07 INFO - functools32 == 3.2.3-2 03:48:07 INFO - jsonschema == 2.5.1 03:48:07 INFO - manifestparser == 1.1 03:48:07 INFO - mozInstall == 1.13 03:48:07 INFO - mozcrash == 1.0 03:48:07 INFO - mozdebug == 0.1 03:48:07 INFO - mozdevice == 0.51 03:48:07 INFO - mozfile == 1.2 03:48:07 INFO - mozhttpd == 0.7 03:48:07 INFO - mozinfo == 0.10 03:48:07 INFO - mozleak == 0.1 03:48:07 INFO - mozlog == 3.5 03:48:07 INFO - moznetwork == 0.27 03:48:07 INFO - mozprocess == 0.25 03:48:07 INFO - mozprofile == 0.28 03:48:07 INFO - mozrunner == 6.13 03:48:07 INFO - mozscreenshot == 0.1 03:48:07 INFO - mozsystemmonitor == 0.3 03:48:07 INFO - moztest == 0.8 03:48:07 INFO - mozversion == 1.4 03:48:07 INFO - psutil == 3.1.1 03:48:07 INFO - requests == 1.2.3 03:48:07 INFO - wsgiref == 0.1.2 03:48:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:48:07 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')]} 03:48:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:48:07 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')]} 03:48:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:48:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x211a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22e3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2486a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x248a090>, '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 0x248ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2484f90>, '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': '3a3620fb28aea1604ab609ef000001d2-1505298909.362317-1699111048', '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 03:48:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 03:48:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:48:07 INFO - Using env: {'DISPLAY': ':0', 03:48:07 INFO - 'HOME': '/home/cltbld', 03:48:07 INFO - 'LANG': 'en_US.UTF-8', 03:48:07 INFO - 'LANGUAGE': 'en_US:en', 03:48:07 INFO - 'LOGNAME': 'cltbld', 03:48:07 INFO - 'MAIL': '/var/mail/cltbld', 03:48:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:48:07 INFO - 'MOZ_NO_REMOTE': '1', 03:48:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:48:07 INFO - 'NO_EM_RESTART': '1', 03:48:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:48:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:48:07 INFO - 'PWD': '/builds/slave/test', 03:48:07 INFO - 'SHELL': '/bin/bash', 03:48:07 INFO - 'SHLVL': '1', 03:48:07 INFO - 'TERM': 'linux', 03:48:07 INFO - 'TMOUT': '86400', 03:48:07 INFO - 'USER': 'cltbld', 03:48:07 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1505298909.362317-1699111048', 03:48:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:48:07 INFO - '_': '/tools/buildbot/bin/python'} 03:48:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:48:07 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)) 03:48:07 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)) 03:48:07 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)) 03:48:07 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)) 03:48:07 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)) 03:48:07 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)) 03:48:07 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)) 03:48:07 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)) 03:48:07 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)) 03:48:07 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:48:07 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 03:48:07 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 03:48:07 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 03:48:07 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 03:48:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 03:48:08 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:48:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:48:08 INFO - Installing collected packages: simplejson 03:48:08 INFO - Running setup.py install for simplejson 03:48:08 INFO - building 'simplejson._speedups' extension 03:48:08 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 03:48:09 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 03:48:09 INFO - Successfully installed simplejson 03:48:09 INFO - Cleaning up... 03:48:09 INFO - Return code: 0 03:48:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:48:09 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')]} 03:48:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:48:09 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')]} 03:48:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:48:09 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 0x211a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22e3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2486a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x248a090>, '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 0x248ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2484f90>, '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': '3a3620fb28aea1604ab609ef000001d2-1505298909.362317-1699111048', '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 03:48:09 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 03:48:09 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 03:48:09 INFO - Using env: {'DISPLAY': ':0', 03:48:09 INFO - 'HOME': '/home/cltbld', 03:48:09 INFO - 'LANG': 'en_US.UTF-8', 03:48:09 INFO - 'LANGUAGE': 'en_US:en', 03:48:09 INFO - 'LOGNAME': 'cltbld', 03:48:09 INFO - 'MAIL': '/var/mail/cltbld', 03:48:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:48:09 INFO - 'MOZ_NO_REMOTE': '1', 03:48:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:48:09 INFO - 'NO_EM_RESTART': '1', 03:48:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:48:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:48:09 INFO - 'PWD': '/builds/slave/test', 03:48:09 INFO - 'SHELL': '/bin/bash', 03:48:09 INFO - 'SHLVL': '1', 03:48:09 INFO - 'TERM': 'linux', 03:48:09 INFO - 'TMOUT': '86400', 03:48:09 INFO - 'USER': 'cltbld', 03:48:09 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1505298909.362317-1699111048', 03:48:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:48:09 INFO - '_': '/tools/buildbot/bin/python'} 03:48:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:48:09 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:48:09 INFO - Cleaning up... 03:48:09 INFO - Return code: 0 03:48:09 INFO - Running post-action listener: _resource_record_post_action 03:48:09 INFO - Running post-action listener: _start_resource_monitoring 03:48:09 INFO - Starting resource monitoring. 03:48:09 INFO - [mozharness: 2017-09-13 10:48:09.817316Z] Finished create-virtualenv step (success) 03:48:09 INFO - [mozharness: 2017-09-13 10:48:09.817833Z] Running install step. 03:48:09 INFO - Running pre-action listener: _resource_record_pre_action 03:48:09 INFO - Running main action method: install 03:48:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:48:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:48:10 INFO - Reading from file tmpfile_stdout 03:48:10 INFO - Detecting whether we're running mozinstall >=1.0... 03:48:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:48:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:48:10 INFO - Reading from file tmpfile_stdout 03:48:10 INFO - Output received: 03:48:10 INFO - Usage: mozinstall [options] installer 03:48:10 INFO - Options: 03:48:10 INFO - -h, --help show this help message and exit 03:48:10 INFO - -d DEST, --destination=DEST 03:48:10 INFO - Directory to install application into. [default: 03:48:10 INFO - "/builds/slave/test"] 03:48:10 INFO - --app=APP Application being installed. [default: firefox] 03:48:10 INFO - mkdir: /builds/slave/test/build/application 03:48:10 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'] 03:48:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 03:48:27 INFO - Reading from file tmpfile_stdout 03:48:27 INFO - Output received: 03:48:27 INFO - /builds/slave/test/build/application/firefox/firefox 03:48:27 INFO - Running post-action listener: _resource_record_post_action 03:48:27 INFO - [mozharness: 2017-09-13 10:48:27.788713Z] Finished install step (success) 03:48:27 INFO - [mozharness: 2017-09-13 10:48:27.788966Z] Running setup-mitmproxy step. 03:48:27 INFO - Running pre-action listener: _resource_record_pre_action 03:48:27 INFO - Running main action method: setup_mitmproxy 03:48:27 INFO - Skipping: mitmproxy is not required 03:48:27 INFO - Running post-action listener: _resource_record_post_action 03:48:27 INFO - [mozharness: 2017-09-13 10:48:27.790105Z] Finished setup-mitmproxy step (success) 03:48:27 INFO - [mozharness: 2017-09-13 10:48:27.790326Z] Running run-tests step. 03:48:27 INFO - Running pre-action listener: _resource_record_pre_action 03:48:27 INFO - Running pre-action listener: _set_gcov_prefix 03:48:27 INFO - Running main action method: run_tests 03:48:27 WARNING - Try message not found. 03:48:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:48:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:48:27 INFO - Python 2.7.3 03:48:27 INFO - Return code: 0 03:48:27 INFO - grabbing minidump binary from tooltool 03:48:27 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')]} 03:48:27 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 0x248a090>, '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 0x248ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2484f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:48:27 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 03:48:27 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 03:48:27 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 03:48:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:48:27 INFO - Return code: 0 03:48:27 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:48:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:48:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:48:27 INFO - ENV: RUST_BACKTRACE is now full 03:48:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:48:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:48:27 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/YIkFlt9lTBKLLWKJyRiPbA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--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 03:48:27 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/YIkFlt9lTBKLLWKJyRiPbA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-059 --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 03:48:27 INFO - Using env: {'DISPLAY': ':0', 03:48:27 INFO - 'HOME': '/home/cltbld', 03:48:27 INFO - 'LANG': 'en_US.UTF-8', 03:48:27 INFO - 'LANGUAGE': 'en_US:en', 03:48:27 INFO - 'LOGNAME': 'cltbld', 03:48:27 INFO - 'MAIL': '/var/mail/cltbld', 03:48:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:48:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:48:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:48:27 INFO - 'MOZ_NO_REMOTE': '1', 03:48:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:48:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:48:27 INFO - 'NO_EM_RESTART': '1', 03:48:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:48:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:48:27 INFO - 'PWD': '/builds/slave/test', 03:48:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:48:27 INFO - 'RUST_BACKTRACE': 'full', 03:48:27 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:48:27 INFO - 'SHELL': '/bin/bash', 03:48:27 INFO - 'SHLVL': '1', 03:48:27 INFO - 'TERM': 'linux', 03:48:27 INFO - 'TMOUT': '86400', 03:48:27 INFO - 'USER': 'cltbld', 03:48:27 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1505298909.362317-1699111048', 03:48:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:48:27 INFO - '_': '/tools/buildbot/bin/python'} 03:48:27 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/YIkFlt9lTBKLLWKJyRiPbA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--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 03:48:28 INFO - mozversion application_buildid: 20170913092825 03:48:28 INFO - mozversion application_changeset: 9873269746359dbcccbd5b44f0e82c0225289945 03:48:28 INFO - mozversion application_display_name: Nightly 03:48:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:48:28 INFO - mozversion application_name: Firefox 03:48:28 INFO - mozversion application_remotingname: firefox 03:48:28 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:48:28 INFO - mozversion application_vendor: Mozilla 03:48:28 INFO - mozversion application_version: 57.0a1 03:48:28 INFO - mozversion platform_buildid: 20170913092825 03:48:28 INFO - mozversion platform_changeset: 9873269746359dbcccbd5b44f0e82c0225289945 03:48:28 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:48:28 INFO - mozversion platform_version: 57.0a1 03:48:28 INFO - using testdate: 1505299708 03:48:28 INFO - actual date: 1505299708 03:48:28 INFO - starting webserver on 'localhost:34202' 03:48:28 INFO - SUITE-START | Running 2 tests 03:48:28 INFO - TEST-START | dromaeo_css 03:48:28 INFO - Initialising browser for dromaeo_css test... 03:48:28 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:34202/getInfo.html -profile /tmp/tmpz_p0aW/profile 03:48:28 INFO - TEST-INFO | started process 23008 (/builds/slave/test/build/application/firefox/firefox http://localhost:34202/getInfo.html) 03:48:33 INFO - TEST-INFO | 23008: exit 0 03:48:33 INFO - Browser initialized. 03:48:33 INFO - Running cycle 1/1 for dromaeo_css test... 03:48:33 INFO - Using env: {'DISPLAY': ':0', 03:48:33 INFO - 'HOME': '/home/cltbld', 03:48:33 INFO - 'JSGC_DISABLE_POISONING': '1', 03:48:33 INFO - 'LANG': 'en_US.UTF-8', 03:48:33 INFO - 'LANGUAGE': 'en_US:en', 03:48:33 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 03:48:33 INFO - 'LOGNAME': 'cltbld', 03:48:33 INFO - 'MAIL': '/var/mail/cltbld', 03:48:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:48:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:48:33 INFO - 'MOZ_CRASHREPORTER': '1', 03:48:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:48:33 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 03:48:33 INFO - 'MOZ_NO_REMOTE': '1', 03:48:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:48:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:48:33 INFO - 'NO_EM_RESTART': '1', 03:48:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:48:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:48:33 INFO - 'PWD': '/builds/slave/test', 03:48:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:48:33 INFO - 'RUST_BACKTRACE': 'full', 03:48:33 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:48:33 INFO - 'SHELL': '/bin/bash', 03:48:33 INFO - 'SHLVL': '1', 03:48:33 INFO - 'STYLO_FORCE_DISABLED': '1', 03:48:33 INFO - 'TERM': 'linux', 03:48:33 INFO - 'TMOUT': '86400', 03:48:33 INFO - 'USER': 'cltbld', 03:48:33 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1505298909.362317-1699111048', 03:48:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:48:33 INFO - '_': '/tools/buildbot/bin/python'} 03:48:33 INFO - TEST-INFO | started process 23197 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpz_p0aW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:48:34 INFO - PID 23197 | 03:48:34 INFO - PID 23197 | (/builds/slave/test/build/application/firefox/firefox:23247): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:48:34 INFO - PID 23197 | 03:48:44 INFO - PID 23197 | RSS: Main: 167538688 03:48:44 INFO - PID 23197 | 03:51:40 INFO - PID 23197 | Cycle 1(1): loaded http://localhost:34202/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34202/tests/dromaeo/cssquery-ext.html) 03:51:42 INFO - PID 23197 | RSS: Main: 169766912 03:51:42 INFO - PID 23197 | 03:54:43 INFO - PID 23197 | Cycle 1(1): loaded http://localhost:34202/tests/dromaeo/cssquery-ext.html (next: http://localhost:34202/tests/dromaeo/cssquery-jquery.html) 03:54:44 INFO - PID 23197 | RSS: Main: 165457920 03:54:44 INFO - PID 23197 | 03:57:45 INFO - PID 23197 | Cycle 1(1): loaded http://localhost:34202/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34202/tests/dromaeo/cssquery-mootools.html) 03:57:46 INFO - PID 23197 | RSS: Main: 168345600 03:57:46 INFO - PID 23197 | 04:00:48 INFO - PID 23197 | Cycle 1(1): loaded http://localhost:34202/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34202/tests/dromaeo/cssquery-prototype.html) 04:00:48 INFO - PID 23197 | RSS: Main: 165527552 04:00:48 INFO - PID 23197 | 04:03:51 INFO - PID 23197 | Cycle 1(1): loaded http://localhost:34202/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34202/tests/dromaeo/cssquery-yui.html) 04:03:52 INFO - PID 23197 | RSS: Main: 168816640 04:03:52 INFO - PID 23197 | 04:06:53 INFO - PID 23197 | Cycle 1(1): loaded http://localhost:34202/tests/dromaeo/cssquery-yui.html (next: http://localhost:34202/tests/dromaeo/cssquery-dojo.html) 04:06:54 INFO - PID 23197 | RSS: Main: 171421696 04:06:54 INFO - PID 23197 | 04:06:54 INFO - PID 23197 | __start_tp_report 04:06:54 INFO - PID 23197 | _x_x_mozilla_page_load 04:06:54 INFO - PID 23197 | _x_x_mozilla_page_load_details 04:06:54 INFO - PID 23197 | |i|pagename|runs| 04:06:54 INFO - PID 23197 | |0;dojo.html;3732.7200459965475;3751.4747935289065;3760.52993375828;3774.1508160663852;3776.6789822865053;6164.81505554833;6207;6229.7508099676015;6240.62556246625;6300.149479820235;6280.905786413207;6289.245290565127;6308.40070193332;6404.935950640493;6412.198475190601;5639.15412688096;5652.434756524335;5657.943420565783;5669.376368599451;5708.543316534688;223.15972384934054;5590.972045139769;5746.7413966371405;5760.107183386561;5783.681897495636;5616.971915140419;5651.519620832234;5680.602357834953;5701.315842098954;5726.570507211955;5577.581681373873;5640.943590564083;5663.5186009189265;5700.144978253254;5707.3721890592005;5608.158776183605;5614.326280846324;5689.6017278790505;5691.686957217351;5698.857528561778;6256.562040657156;6265.7493700251935;6299.748010079591;6384.680765961683;6400.647964361959;6640.833979150511;6748.4938629602975;6769.932300676979;6829.112215411965;6934;6825.385715285648;6893.241743408221;6912.343327383891;6935.826604334932;6948.478864085163;6244.594101383395;6312.810615681537;6330.8100756977365;6374.84062898422;6381.872362552723;6988.056612357267;7041.718331266692;7076.504644674823;7088.362047415757;7097.609631470319;6700.162479690039;6712.295209003082;6771;6799.524033317719;6803.761868334684;6672.766453174116;6741.629210393377;6745.3591908768585;6755.966220168868;6776.356246156607;6734.989751537309;6747.831304217434;6772.864542709118;6798.422134118557;6810.8637827244165;6723.5293529452465;6866.107406037183;6900.551464154814;6907.447404207652;6915.204751453547;4970.353853998957;4972.552470277692;5040.672356296829;5043.067032598908;5043.243513472935;4466.0398014427055;4501.707389019703;4557.270836666184;4560.908781824345;4565.931511027337;6095.6952152392205;6118.418750218722;6148.1392605035335;6151.815445536641;6155.753769849245;6808.285130061272;6846.349596788297;6849.554778939353;6855;6858.897116543256;6094.695265236809;6107.450329470369;6108.144859719643;6183.907241391383;6202.0696895465135;5426.538744206708;5479.780808767605;5501.752421141058;5544.750486228048;5554.833354999357;6942.375186233263;6959.826004349932;6967.268436814163;6982.895256571155;7005.649717514104;6673.933260667525;6748.392644662004;6769.289224631343;6846.520743547904;6884.449244060464;6796.116504854337;6863.347981941708;6885.621290829053;6973.267806880204;7012.298770122947;6735.4274886635185;6800.149981252343;6809.829754256183;6818.147731533559;6825.931740682529;6612.4710023198995;6817.5909445433435;6853.451723862178;6941.583504989717;6952.374286314256;6536.379043990813;6557.082008518906;6561.179852518435;6573.1454910861285;6598.67006649656;6522.641254731036;6536.248331441945;6541.672916354068;6548.050532672641;6555.573887697285;6516.185476815398;6577.736890524326;6588.670566471561;6590.7693230736695;6591.209054913441;6541.934580654132;6601.141851559267;6640.335966403514;6641.867162656817;6709.261981181969;6335.366463353628;6425.935740642533;6456.451201647913;6547.148870646785;6550.279469258282 04:06:54 INFO - PID 23197 | |1;ext.html;958.0898146760579;964.9179819715324;986.5461887531736;1008.6268080810099;1016.7356487313301;45029.77485112578;45234.77382613086;45504;46058.078838423215;46105.53894461055;45411.63765087053;45415.77292113543;45840;45904.3114353285;46079.308810367875;8280.585970701472;8393;8414.410991230585;8439.535825529594;8451;8271.214234647729;8272.462289951163;8283.213094756018;8293.58532073397;8301.128381519913;8307.667693292262;8335.124811894755;8339.83320333593;8343.290820280283;8345.499270043787;8239.423240373177;8306.626201820873;8401.53791541468;8401.747947561553;8405.033421156522;8182.590870456454;8237.588120593946;8276.751697449086;8289;8299.253067223919;40926.795366023274;41323;41328.793356033326;41462;41506.1698766026;3744.7753134811996;3753.512043434336;3791.658750712449;3793.962060379416;3795.5065841440714;33254;33652.663473365195;34071.82964085189;34174;34188;5498.037843377433;5501.092319767234;5532.059549876531;5549.833504994856;5557.666540007613;204608;205147;205672;205683;207241;50328;50336.24495632568;53433.465665343625;53532;53582;56340.718296409075;56563.71718141383;56613.71693141508;56634.43365566374;56638.7168064157;14690.192039437934;14715.92642036783;14716.411343546353;14817.851821481647;15282.631192165232;11525.193236473535;11532.481038353126;11560.537578496935;11672.066234701204;11701.356425396685;15909.52271431859;15932.840671593367;15944.840551594336;15986.36054557828;16020.75968860468;6209.813705588839;6249;6289.622622642656;6326.43062124411;6349.2698339690605;1095.901368876805;1114.5764609448358;1123.3484578944356;1124.7131981344705;1129.1926272715048;25763.227103186935;26112.477750444883;26205.60691589628;26215.344616384362;26314.342141446235;1191.600813727411;1214.8542174938887;1217.1175897474436;1237.4678888078213;1237.962861114168;13701.45194192221;13960.930195348958;13961.930190349187;13962.93018534921;14067.2966351682;301984;304796;305913;309458;312591;63929.68035159794;64451.67774161193;64747.67626161933;64805.35194648088;64904.35095649077;1506.4275575281322;1523.2764436892387;1528.5949223455793;1531.663034132489;1534.3325653340833;30624.387512250076;30877.94027637439;30898.073057808302;31003.534946975364;31602;43210.56789432065;43423.782881086656;43432;43553;43660.12679746451;247526;248645;249062;249988;250027;37180;38188.809055954545;38396;38485.807570961966;38915.41626875543;46957.765211173726;48894.26658600195;49112.508874910796;49664.75167624139;49694;34839;34944;35336.11659708528;35369.64630353663;35761.28477430489;34236.48645270273;34681.47977780285;34730;34817;35160.64839351574;40264.396034058926;41540.1691966165;41542;41594.79202604089;41861.23248907613;34223;34495.482567762;34517.309653807286;34631.82684086564;34687.13282167966;25381.365465863502;25435.491290173723;25789.742102579483;25985.019213184132;26040.73959260383 04:06:54 INFO - PID 23197 | |2;jquery.html;598.4972622996681;600.2976517474556;608.4554323880125;614.8678034222642;615.9384061593842;22868.313950581487;23531.647025294635;23547.76452235479;23554.293371198848;23618.173363932223;23672.526549469;24132.75867241327;24208;24238.636420453662;24488.632670509913;6513.77201797936;6604.108445359863;6605.471562275006;6617.669116544153;6696.0290757840085;6411.166548348731;6500.544961852672;6607.207135143765;6719.126513553231;6723.630200338979;6670;6672.132622759059;6672.532922695414;6686.83282917926;6690.063391125246;6387.712552935129;6604.075429439882;6620.966895165518;6628.4697224221945;6689.197296324448;6111.602745821552;6132.7240274187325;6171.598846075036;6179.536534759911;6188.381161883775;28684.71315286841;29038.41923161525;29112;29175.854120729473;29197;2208.4258092895802;2241.6525438556887;2242.0471299697724;2245.202952951695;2246.640537514006;18658.44024679262;19591.11839967205;19670.508237294038;19723.90138049315;19740.70388944167;2464.1006032798077;2515.5849284867977;2517.697876254843;2580.238829545289;2586.689597248342;137711;140234;140891.29554352266;140894.29552852272;141052.29473852564;15651.37394504207;15936.521904342888;16030.75953860693;16112.274947627386;16285.592860178353;24246;24256.272311830675;24392.634110488358;24418.511629767305;24448.511029779303;9357.812843743088;9978.550965206583;10062.496875156214;10136.54385552652;10168.898311016796;8802;8811.427257228259;8824.382293239412;8883.777905552413;8905.73282801517;9230.630774769068;9495.810083798286;9582.089701478348;9726;10067.899321006842;2947.4252520758246;2991.8952836651047;2997.5953246311906;3021.8942337018098;3045.8477076146105;1002.6290272599185;1035.440861934547;1056.4031322302874;1061.135174832509;1070.106461104986;20920.79079209219;20959.37121886346;21348.679769803464;21569.56860862774;21701.240456583942;1057.4976885979252;1061.75048863517;1088.1838621034224;1100.983485247722;1105.5190991918541;11604;11617.6514704559;11706.94146529279;11817.468213930393;11849.881501185051;555475;586983;593625;602483;615007;128386;130585;131371.34314328368;131935;132997.33501332626;1213.1326101837228;1216.9817452738216;1238.4736486993172;1248.7627350803318;1255.2029461292145;18632.720509192644;18952.715709264095;19267.614647706687;19422.708659369837;19478.415647530597;60757.39242607694;61672.38327616666;62278;63351;63664;77162;79486;80857;80984.19015809767;81736.59131704542;15035.248237588296;15100.924495377452;15198;15366;15370.615734606725;23577.29268121959;23781.881090594437;23958;23962.88018559896;24216.757832421452;19389.321373751853;19728.408147755592;19874.304399345954;19885.60228795445;19900.402987910387;16146.677066458371;16191.919040404722;16673.583160421087;16968.745468818226;18046.2781488739;19380;19753.40739777809;19800.405987820388;19858.801411985696;19957.301494447624;15063.322150503473;15096.773548396563;15099.094054356774;15139.318730656927;15144.924275378553;18633;18769.249230030648;18772.96748678836;18797.812021879607;18820.623587528447 04:06:54 INFO - PID 23197 | |3;mootools.html;1270.688681273088;1282.3139620303139;1282.903782216334;1283.3070142123254;1289.825873507077;16111.838881611195;16763.49709508717;16766.91616541917;16783.91608041961;16800.999999999985;16321.428749993724;16430.7535386969;16467.34130634773;16491.257893394795;16494.34022639096;2875.899343522972;2877.553979133227;2935.5890175375466;2938.941980886879;2941.3087924337765;2846.3595690969573;2889.6821349651523;2909.5781111738784;2911.2576293045245;2918.1829087855435;2589.702184248807;2806.3825958289244;2816.6479190101236;2882.971170288302;2883.1206482022976;2927.1803894909353;2931.824090554552;2961.511350627133;2961.718636729507;2963.1406892001296;2755.5591105423237;2837.8439185844773;2857.371378296792;2863.627728395316;2867.5411934090444;16533;16618;16680.249388777534;16687.91656041724;16701;8507.404481686284;8822.338324625614;8824.735257942208;8825;8828.117188281185;5685.8009969651275;5731.541476681856;5781.421857814227;5877.706114694248;5887.793927212527;2081.8341728632013;2094.706741056253;2113.1019316790303;2118.2268472007604;2156.202205184092;29401.41197176066;29606.111816645534;29660.8516957416;29667.554986675215;29706.40587188244;7205.747798827016;7225.747098851515;7268.0914885639295;7395.297446742551;7401.703931842773;19378.224871005285;19419.4174174775;19424;19449.12478938451;19504.51238719015;8480.618372173267;8568.571571421404;8573.356998225157;8578.528180949983;8583.313334933191;7519.624018799038;7640.617969101522;7682.846343073107;7688.730894418669;7735.381169506426;5527.143292789624;5586.966411213938;5662.122371032497;5722.313322401338;5879.588428809942;1631.208863701104;1632.3796957156442;1658.3200887636012;1662.3101412913506;1679.7312430011139;960.5341409416427;963.7952559300874;975.5027130545825;987.6493844685177;991.2367477042637;8568.143185681507;8589.484630922165;8706.390552661253;9540.522973851419;9689.370190937567;741.4661443760484;755.7808235611722;763.3892885691424;785.6268272570484;786.8347646994196;5042.067217564762;5312.4219569451925;5736.483716465538;5843.2695913010875;5855.180274761537;23341.066357345855;24701;24729.1344802931;24748.22437168135;24927.750722492543;24306.27081187567;24570.508589828103;24798.38004049913;24808.751912481006;24872.37819054538;12367.62897113088;12375.504979800888;12452.190607610477;12540.122191446511;12681.682957926125;9214.308926830381;9406.200472959876;9484.478353690612;9526.333156679244;9586.712398627773;20406;20740.170393184708;21037;21038.89480552649;21299;21471.570568588228;21643.13427462884;21740.673889891346;21893.67159492577;21997.780022199575;12185.451654675384;12457.937710311753;12469.376531173224;12475.376231188222;12476.563320284109;15151.621209469851;15222.847771522143;15265.3893844245;15354.616134596725;15404.691906162037;11475.254108482923;11709.355985420883;11840.230385024946;11951.462184201906;12072.939635301767;11522.711932201762;11608.825867612162;11791.174617776673;11796.174267801514;11917.880821191677;10111.090001899864;10299.433531155859;10304.381737095799;10310.587576496857;10336.431496267778;8001.199880011952;8007.959960200395;8017.919820801717;8088.433809633269;8138.796530086795;7702.768916932501;7728.4203684725;7789.922100778919;7856.489328193649;7884.802879927818 04:06:54 INFO - PID 23197 | |4;prototype.html;538.5825984861732;548.687248268487;570.3526497425421;576.4293349583913;579.2730123694765;6264.467520260778;6285.560010799246;6313.368663133684;6398.7120579573975;6404.07140964561;6280.371962803717;6332.588381755183;6347.682615869211;6363.554551181419;6405.167328247321;5186.8703282417955;5224.242484839696;5227.73861306935;5238.764255608507;5243.842684719464;5088.643794934337;5099.107656160176;5192.71440070796;5211.583073354142;5228.607854410915;5156.484351564851;5157.174852023677;5157.73059853665;5183.974080129613;5221.947780522184;5142.1772516397195;5145.691258524463;5146.819861304855;5149.613778966593;5161.690298582097;4842.927356089662;4864.951350486485;4867.294242334877;4876.244182151737;4897.118518666639;6215.81352559424;6338.334474880117;6380.744770209186;6389.4568961638315;6429.871402571969;6120.20437343147;6126.284640300723;6147.508199344086;6155.383462403198;6170.259568851721;6739.932600673979;6782.220044694874;6789.796306110775;6808.795736127924;6835.248122706498;5386.811461598825;5413.729313534308;5426.403095659474;5434.940186663603;5477.890442191174;7001.894971575431;7017.754378596725;7078.221395646475;7127.2160062393095;7139.428845692332;5624.409437009137;5661.235733176051;5690.829275121753;5698.401667824819;5701.144828275709;5740.397258287903;5746.597738158289;5756.856078597984;5773.942260577341;5803.564732645069;6058.878822423615;6100.969495152584;6101.901657701567;6129.816105516842;6157.9384206158265;6446.323136070739;6453.257875344396;6689;6741.898871516931;6789.219239787389;1923.9615207695767;1951.8438524917972;1952.8828270303827;1958.667026605452;1977.1004193092108;1461.663817322022;1481.8811797093126;1487.8809695224356;1488;1494.8729358004691;5898.76404943806;5939.316978547522;5983.850403739854;6054.485368743706;6133.723982420802;6784.219814721271;6809.523333366716;6822.590644561342;6842.7605033823575;6858.588484690935;6067.118118893491;6073.726682299307;6121.296050954108;6139.539534534839;6142.754289828446;3560.608333083359;3602.8018458985007;3613.0786649404236;3620.4931309616672;3628.129248980226;6947.166340039126;7017.649087555726;7039;7039.436845052383;7045.154581450156;6952.756653517103;7017.649117544204;7033.859322813618;7065.611391373421;7067.151941767021;6959.130108736408;7017.89473157903;7027.297270272932;7046.295370462913;7058.223595404502;6661.134052573135;6738.831529211809;6788.626625535643;6817.3182681733415;6819.659017049227;6813.4208592270215;6836.28219036994;6866;6870.519063665695;6887.7244910203035;6874.003269525991;6942;6944.965275173794;6956.5478243913985;6969.038158782396;5107.668001579886;5165.302684137593;5196.428392876856;5199.532042116228;5221.138512145453;6944.93055069463;6952.30476952321;6957.1651401832105;6982.965085174542;6987.755428559976;6661.16735408074;6663.933360666525;6688.866222675617;6706.832329191614;6710.429613482908;6548.1814773153355;6557.901631475627;6571.474282057328;6631.171103612049;6631.816727970505;6485.286618472059;6500.414962653384;6509.707063182073;6513.5114866384265;6517.055027021151;6121.326654068138;6548.410643042149;6623.900641490285;6651.102101216274;6698.866022679616;6320.209973753281;6326.58364483174;6407.16706828128;6487.9026814598765;6537.738490460329 04:06:54 INFO - PID 23197 | |5;yui.html;963.4941655630793;982.965596204133;985.0248254228314;1009.9799202805165;1014.8528463372809;16901.999999999985;17430.564235894108;17580.736288955675;17584.208710608036;17590.73613895791;16219.351225950977;16453.25960331785;16458.588535286624;16459.506214813544;16485.258163382645;1059.4279089291774;1081.0270756319296;1081.0486771640944;1081.5727787523924;1082.080231802965;1077.6443773554709;1077.709018564987;1078.412265315405;1078.557791305565;1080.773037662088;1104.8895110488927;1109.995454114028;1144.4735421706025;1147.2772153543256;1148.8793676663956;1136.6419577832955;1137.2835113878205;1137.9886201138006;1138.7950168969583;1140.1334985411106;796.2276591706036;815.1725998111921;820.9876851847227;821.6959724901765;822.2188920525525;17230.396936107176;17317.13414329291;17320;17335.739963900553;17373.95756254629;20716.48208794777;21057.473563161042;21075.156993720233;21488.89255553712;21669.241576544744;15246.466373676869;15269.465568705153;15401.152936588483;15518;15531.689366212726;3662.047867554428;3738.3084129436143;3770.3967365221433;3771.377722675755;3778.5843557208686;120070;138561;144409;145305.27347363302;147636.26181869023;17315.30738770435;17976;17980.1009949502;18056.548586285448;18062.729059064124;34466.483002754976;35216.295674086374;35256.471152932725;35261;35285;8299.6680132794;8559.74320770378;8679;8704.04255531891;8715.564221788885;4522.140793249272;4530.682852200381;4598.563136502027;4618.168729628632;4618.468876079227;5454.372747134131;5629.352624448241;5690.118031705092;5702.6293290935955;5749.9425005750245;1161.3670549550516;1174.9530018799153;1187.5131196209513;1189.0547015122997;1192.028496775143;712.9500934934608;725.3834240895302;725.764126658838;737.9704811807468;751.1587022534796;11550.249233799776;11567.305961642329;11698.70753231176;11911.821322680167;11933.582324618597;677.8271540757075;696.7352406085756;699.4369532526365;707.9646017699095;709.6203531110934;5452.154915988028;5455.1544510600925;5574.163875418639;5579.9163012554845;5639.041362968223;147094;149228;151068.244658776;151632;151978;103145;125822.7088645564;130147;132493.33753331171;137223;113717.43141284406;114608;115836;117435;120351.39824300997;11625.88374116248;12179.330136842558;12195;12251;12676.936615316865;52166.73916630392;53240;55673;55699.16451253153;56402.43597564136;90614;91101;91690;97337.51331243581;98738.50630746801;19826;21066.683999740322;21742.347729568137;21749.782502174774;21767.891160544095;20916.267930622354;20966.266180683604;21159.576808463436;21353.572928541653;21363;16688.249028793976;16694.4156954506;17223.31106755716;17377.04426256568;17894.642107158044;17928.820711792716;18052.909735451238;18114.728279076087;18317.725234121233;18397.448076557725;17021;17185;17453.912730436266;17670.734938976184;17968.460946171635;15212.315445805187;15297;15381.461648842236;15506.612334691723;15776.290066946785;13948.302584870919;14265.928670356581;14346.426142954166;14436.821467896541;14512.927435362755 04:06:54 INFO - PID 23197 | __end_tp_report 04:06:54 INFO - PID 23197 | __start_cc_report 04:06:54 INFO - PID 23197 | _x_x_mozilla_cycle_collect,359 04:06:54 INFO - PID 23197 | __end_cc_report 04:06:54 INFO - PID 23197 | __startTimestamp1505300814141__endTimestamp 04:06:54 INFO - PID 23197 | 04:06:54 INFO - PID 23197 | ------- Summary: start ------- 04:06:54 INFO - PID 23197 | Number of tests: 6 04:06:54 INFO - PID 23197 | 04:06:54 INFO - PID 23197 | [#0] dojo.html Cycles:165 Average:6223.09 Median:6541.67 stddev:880.67 (13.5%) stddev-sans-first:861.43 04:06:54 INFO - PID 23197 | Values: 3732.7 3751.5 3760.5 3774.2 3776.7 6164.8 6207.0 6229.8 6240.6 6300.1 6280.9 6289.2 6308.4 6404.9 6412.2 5639.2 5652.4 5657.9 5669.4 5708.5 223.2 5591.0 5746.7 5760.1 5783.7 5617.0 5651.5 5680.6 5701.3 5726.6 5577.6 5640.9 5663.5 5700.1 5707.4 5608.2 5614.3 5689.6 5691.7 5698.9 6256.6 6265.7 6299.7 6384.7 6400.6 6640.8 6748.5 6769.9 6829.1 6934.0 6825.4 6893.2 6912.3 6935.8 6948.5 6244.6 6312.8 6330.8 6374.8 6381.9 6988.1 7041.7 7076.5 7088.4 7097.6 6700.2 6712.3 6771.0 6799.5 6803.8 6672.8 6741.6 6745.4 6756.0 6776.4 6735.0 6747.8 6772.9 6798.4 6810.9 6723.5 6866.1 6900.6 6907.4 6915.2 4970.4 4972.6 5040.7 5043.1 5043.2 4466.0 4501.7 4557.3 4560.9 4565.9 6095.7 6118.4 6148.1 6151.8 6155.8 6808.3 6846.3 6849.6 6855.0 6858.9 6094.7 6107.5 6108.1 6183.9 6202.1 5426.5 5479.8 5501.8 5544.8 5554.8 6942.4 6959.8 6967.3 6982.9 7005.6 6673.9 6748.4 6769.3 6846.5 6884.4 6796.1 6863.3 6885.6 6973.3 7012.3 6735.4 6800.1 6809.8 6818.1 6825.9 6612.5 6817.6 6853.5 6941.6 6952.4 6536.4 6557.1 6561.2 6573.1 6598.7 6522.6 6536.2 6541.7 6548.1 6555.6 6516.2 6577.7 6588.7 6590.8 6591.2 6541.9 6601.1 6640.3 6641.9 6709.3 6335.4 6425.9 6456.5 6547.1 6550.3 04:06:54 INFO - PID 23197 | 04:06:54 INFO - PID 23197 | [#1] ext.html Cycles:180 Average:43865.93 Median:3792.81 stddev:67070.73 (1768.4%) stddev-sans-first:67181.50 04:06:54 INFO - PID 23197 | Values: 958.1 964.9 986.5 1008.6 1016.7 45029.8 45234.8 45504.0 46058.1 46105.5 45411.6 45415.8 45840.0 45904.3 46079.3 8280.6 8393.0 8414.4 8439.5 8451.0 8271.2 8272.5 8283.2 8293.6 8301.1 8307.7 8335.1 8339.8 8343.3 8345.5 8239.4 8306.6 8401.5 8401.7 8405.0 8182.6 8237.6 8276.8 8289.0 8299.3 40926.8 41323.0 41328.8 41462.0 41506.2 3744.8 3753.5 3791.7 3794.0 3795.5 33254.0 33652.7 34071.8 34174.0 34188.0 5498.0 5501.1 5532.1 5549.8 5557.7 204608.0 205147.0 205672.0 205683.0 207241.0 50328.0 50336.2 53433.5 53532.0 53582.0 56340.7 56563.7 56613.7 56634.4 56638.7 14690.2 14715.9 14716.4 14817.9 15282.6 11525.2 11532.5 11560.5 11672.1 11701.4 15909.5 15932.8 15944.8 15986.4 16020.8 6209.8 6249.0 6289.6 6326.4 6349.3 1095.9 1114.6 1123.3 1124.7 1129.2 25763.2 26112.5 26205.6 26215.3 26314.3 1191.6 1214.9 1217.1 1237.5 1238.0 13701.5 13960.9 13961.9 13962.9 14067.3 301984.0 304796.0 305913.0 309458.0 312591.0 63929.7 64451.7 64747.7 64805.4 64904.4 1506.4 1523.3 1528.6 1531.7 1534.3 30624.4 30877.9 30898.1 31003.5 31602.0 43210.6 43423.8 43432.0 43553.0 43660.1 247526.0 248645.0 249062.0 249988.0 250027.0 37180.0 38188.8 38396.0 38485.8 38915.4 46957.8 48894.3 49112.5 49664.8 49694.0 34839.0 34944.0 35336.1 35369.6 35761.3 34236.5 34681.5 34730.0 34817.0 35160.6 40264.4 41540.2 41542.0 41594.8 41861.2 34223.0 34495.5 34517.3 34631.8 34687.1 25381.4 25435.5 25789.7 25985.0 26040.7 04:06:54 INFO - PID 23197 | 04:06:54 INFO - PID 23197 | [#2] jquery.html Cycles:180 Average:38749.79 Median:23539.71 stddev:98809.03 (419.8%) stddev-sans-first:99044.69 04:06:54 INFO - PID 23197 | Values: 598.5 600.3 608.5 614.9 615.9 22868.3 23531.6 23547.8 23554.3 23618.2 23672.5 24132.8 24208.0 24238.6 24488.6 6513.8 6604.1 6605.5 6617.7 6696.0 6411.2 6500.5 6607.2 6719.1 6723.6 6670.0 6672.1 6672.5 6686.8 6690.1 6387.7 6604.1 6621.0 6628.5 6689.2 6111.6 6132.7 6171.6 6179.5 6188.4 28684.7 29038.4 29112.0 29175.9 29197.0 2208.4 2241.7 2242.0 2245.2 2246.6 18658.4 19591.1 19670.5 19723.9 19740.7 2464.1 2515.6 2517.7 2580.2 2586.7 137711.0 140234.0 140891.3 140894.3 141052.3 15651.4 15936.5 16030.8 16112.3 16285.6 24246.0 24256.3 24392.6 24418.5 24448.5 9357.8 9978.6 10062.5 10136.5 10168.9 8802.0 8811.4 8824.4 8883.8 8905.7 9230.6 9495.8 9582.1 9726.0 10067.9 2947.4 2991.9 2997.6 3021.9 3045.8 1002.6 1035.4 1056.4 1061.1 1070.1 20920.8 20959.4 21348.7 21569.6 21701.2 1057.5 1061.8 1088.2 1101.0 1105.5 11604.0 11617.7 11706.9 11817.5 11849.9 555475.0 586983.0 593625.0 602483.0 615007.0 128386.0 130585.0 131371.3 131935.0 132997.3 1213.1 1217.0 1238.5 1248.8 1255.2 18632.7 18952.7 19267.6 19422.7 19478.4 60757.4 61672.4 62278.0 63351.0 63664.0 77162.0 79486.0 80857.0 80984.2 81736.6 15035.2 15100.9 15198.0 15366.0 15370.6 23577.3 23781.9 23958.0 23962.9 24216.8 19389.3 19728.4 19874.3 19885.6 19900.4 16146.7 16191.9 16673.6 16968.7 18046.3 19380.0 19753.4 19800.4 19858.8 19957.3 15063.3 15096.8 15099.1 15139.3 15144.9 18633.0 18769.2 18773.0 18797.8 18820.6 04:06:54 INFO - PID 23197 | 04:06:54 INFO - PID 23197 | [#3] mootools.html Cycles:180 Average:10259.92 Median:2851.87 stddev:7550.68 (264.8%) stddev-sans-first:7541.66 04:06:54 INFO - PID 23197 | Values: 1270.7 1282.3 1282.9 1283.3 1289.8 16111.8 16763.5 16766.9 16783.9 16801.0 16321.4 16430.8 16467.3 16491.3 16494.3 2875.9 2877.6 2935.6 2938.9 2941.3 2846.4 2889.7 2909.6 2911.3 2918.2 2589.7 2806.4 2816.6 2883.0 2883.1 2927.2 2931.8 2961.5 2961.7 2963.1 2755.6 2837.8 2857.4 2863.6 2867.5 16533.0 16618.0 16680.2 16687.9 16701.0 8507.4 8822.3 8824.7 8825.0 8828.1 5685.8 5731.5 5781.4 5877.7 5887.8 2081.8 2094.7 2113.1 2118.2 2156.2 29401.4 29606.1 29660.9 29667.6 29706.4 7205.7 7225.7 7268.1 7395.3 7401.7 19378.2 19419.4 19424.0 19449.1 19504.5 8480.6 8568.6 8573.4 8578.5 8583.3 7519.6 7640.6 7682.8 7688.7 7735.4 5527.1 5587.0 5662.1 5722.3 5879.6 1631.2 1632.4 1658.3 1662.3 1679.7 960.5 963.8 975.5 987.6 991.2 8568.1 8589.5 8706.4 9540.5 9689.4 741.5 755.8 763.4 785.6 786.8 5042.1 5312.4 5736.5 5843.3 5855.2 23341.1 24701.0 24729.1 24748.2 24927.8 24306.3 24570.5 24798.4 24808.8 24872.4 12367.6 12375.5 12452.2 12540.1 12681.7 9214.3 9406.2 9484.5 9526.3 9586.7 20406.0 20740.2 21037.0 21038.9 21299.0 21471.6 21643.1 21740.7 21893.7 21997.8 12185.5 12457.9 12469.4 12475.4 12476.6 15151.6 15222.8 15265.4 15354.6 15404.7 11475.3 11709.4 11840.2 11951.5 12072.9 11522.7 11608.8 11791.2 11796.2 11917.9 10111.1 10299.4 10304.4 10310.6 10336.4 8001.2 8008.0 8017.9 8088.4 8138.8 7702.8 7728.4 7789.9 7856.5 7884.8 04:06:54 INFO - PID 23197 | 04:06:54 INFO - PID 23197 | [#4] prototype.html Cycles:180 Average:5756.98 Median:6316.79 stddev:1552.18 (24.6%) stddev-sans-first:1506.30 04:06:54 INFO - PID 23197 | Values: 538.6 548.7 570.4 576.4 579.3 6264.5 6285.6 6313.4 6398.7 6404.1 6280.4 6332.6 6347.7 6363.6 6405.2 5186.9 5224.2 5227.7 5238.8 5243.8 5088.6 5099.1 5192.7 5211.6 5228.6 5156.5 5157.2 5157.7 5184.0 5221.9 5142.2 5145.7 5146.8 5149.6 5161.7 4842.9 4865.0 4867.3 4876.2 4897.1 6215.8 6338.3 6380.7 6389.5 6429.9 6120.2 6126.3 6147.5 6155.4 6170.3 6739.9 6782.2 6789.8 6808.8 6835.2 5386.8 5413.7 5426.4 5434.9 5477.9 7001.9 7017.8 7078.2 7127.2 7139.4 5624.4 5661.2 5690.8 5698.4 5701.1 5740.4 5746.6 5756.9 5773.9 5803.6 6058.9 6101.0 6101.9 6129.8 6157.9 6446.3 6453.3 6689.0 6741.9 6789.2 1924.0 1951.8 1952.9 1958.7 1977.1 1461.7 1481.9 1487.9 1488.0 1494.9 5898.8 5939.3 5983.9 6054.5 6133.7 6784.2 6809.5 6822.6 6842.8 6858.6 6067.1 6073.7 6121.3 6139.5 6142.8 3560.6 3602.8 3613.1 3620.5 3628.1 6947.2 7017.6 7039.0 7039.4 7045.2 6952.8 7017.6 7033.9 7065.6 7067.2 6959.1 7017.9 7027.3 7046.3 7058.2 6661.1 6738.8 6788.6 6817.3 6819.7 6813.4 6836.3 6866.0 6870.5 6887.7 6874.0 6942.0 6945.0 6956.5 6969.0 5107.7 5165.3 5196.4 5199.5 5221.1 6944.9 6952.3 6957.2 6983.0 6987.8 6661.2 6663.9 6688.9 6706.8 6710.4 6548.2 6557.9 6571.5 6631.2 6631.8 6485.3 6500.4 6509.7 6513.5 6517.1 6121.3 6548.4 6623.9 6651.1 6698.9 6320.2 6326.6 6407.2 6487.9 6537.7 04:06:54 INFO - PID 23197 | 04:06:54 INFO - PID 23197 | [#5] yui.html Cycles:180 Average:27960.49 Median:17442.24 stddev:41302.42 (236.8%) stddev-sans-first:41368.54 04:06:54 INFO - PID 23197 | Values: 963.5 983.0 985.0 1010.0 1014.9 16902.0 17430.6 17580.7 17584.2 17590.7 16219.4 16453.3 16458.6 16459.5 16485.3 1059.4 1081.0 1081.0 1081.6 1082.1 1077.6 1077.7 1078.4 1078.6 1080.8 1104.9 1110.0 1144.5 1147.3 1148.9 1136.6 1137.3 1138.0 1138.8 1140.1 796.2 815.2 821.0 821.7 822.2 17230.4 17317.1 17320.0 17335.7 17374.0 20716.5 21057.5 21075.2 21488.9 21669.2 15246.5 15269.5 15401.2 15518.0 15531.7 3662.0 3738.3 3770.4 3771.4 3778.6 120070.0 138561.0 144409.0 145305.3 147636.3 17315.3 17976.0 17980.1 18056.5 18062.7 34466.5 35216.3 35256.5 35261.0 35285.0 8299.7 8559.7 8679.0 8704.0 8715.6 4522.1 4530.7 4598.6 4618.2 4618.5 5454.4 5629.4 5690.1 5702.6 5749.9 1161.4 1175.0 1187.5 1189.1 1192.0 713.0 725.4 725.8 738.0 751.2 11550.2 11567.3 11698.7 11911.8 11933.6 677.8 696.7 699.4 708.0 709.6 5452.2 5455.2 5574.2 5579.9 5639.0 147094.0 149228.0 151068.2 151632.0 151978.0 103145.0 125822.7 130147.0 132493.3 137223.0 113717.4 114608.0 115836.0 117435.0 120351.4 11625.9 12179.3 12195.0 12251.0 12676.9 52166.7 53240.0 55673.0 55699.2 56402.4 90614.0 91101.0 91690.0 97337.5 98738.5 19826.0 21066.7 21742.3 21749.8 21767.9 20916.3 20966.3 21159.6 21353.6 21363.0 16688.2 16694.4 17223.3 17377.0 17894.6 17928.8 18052.9 18114.7 18317.7 18397.4 17021.0 17185.0 17453.9 17670.7 17968.5 15212.3 15297.0 15381.5 15506.6 15776.3 13948.3 14265.9 14346.4 14436.8 14512.9 04:06:54 INFO - PID 23197 | -------- Summary: end -------- 04:06:54 INFO - PID 23197 | 04:06:54 INFO - PID 23197 | 04:06:54 INFO - PID 23197 | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost 04:06:54 INFO - PID 23197 | 04:06:54 INFO - TEST-INFO | 23197: exit 0 04:06:54 INFO - TEST-OK | dromaeo_css | took 1106659ms 04:06:54 INFO - TEST-START | kraken 04:06:54 INFO - Initialising browser for kraken test... 04:06:54 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:34202/getInfo.html -profile /tmp/tmpeVSYtr/profile 04:06:54 INFO - TEST-INFO | started process 23563 (/builds/slave/test/build/application/firefox/firefox http://localhost:34202/getInfo.html) 04:06:59 INFO - TEST-INFO | 23563: exit 0 04:06:59 INFO - Browser initialized. 04:06:59 INFO - Running cycle 1/1 for kraken test... 04:06:59 INFO - Using env: {'DISPLAY': ':0', 04:06:59 INFO - 'HOME': '/home/cltbld', 04:06:59 INFO - 'JSGC_DISABLE_POISONING': '1', 04:06:59 INFO - 'LANG': 'en_US.UTF-8', 04:06:59 INFO - 'LANGUAGE': 'en_US:en', 04:06:59 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 04:06:59 INFO - 'LOGNAME': 'cltbld', 04:06:59 INFO - 'MAIL': '/var/mail/cltbld', 04:06:59 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:06:59 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:06:59 INFO - 'MOZ_CRASHREPORTER': '1', 04:06:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:59 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 04:06:59 INFO - 'MOZ_NO_REMOTE': '1', 04:06:59 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:06:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:06:59 INFO - 'NO_EM_RESTART': '1', 04:06:59 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:06:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:59 INFO - 'PWD': '/builds/slave/test', 04:06:59 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:06:59 INFO - 'RUST_BACKTRACE': 'full', 04:06:59 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 04:06:59 INFO - 'SHELL': '/bin/bash', 04:06:59 INFO - 'SHLVL': '1', 04:06:59 INFO - 'STYLO_FORCE_DISABLED': '1', 04:06:59 INFO - 'TERM': 'linux', 04:06:59 INFO - 'TMOUT': '86400', 04:06:59 INFO - 'USER': 'cltbld', 04:06:59 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1505298909.362317-1699111048', 04:06:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:59 INFO - '_': '/tools/buildbot/bin/python'} 04:06:59 INFO - TEST-INFO | started process 23753 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeVSYtr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 04:07:00 INFO - PID 23753 | 04:07:00 INFO - PID 23753 | (/builds/slave/test/build/application/firefox/firefox:23802): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 04:07:00 INFO - PID 23753 | 04:07:10 INFO - PID 23753 | RSS: Main: 167006208 04:07:10 INFO - PID 23753 | 04:07:13 INFO - PID 23753 | Cycle 1(1): loaded http://localhost:34202/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34202/tests/kraken/driver.html?testName=audio-beat-detection) 04:07:14 INFO - PID 23753 | RSS: Main: 171638784 04:07:14 INFO - PID 23753 | 04:07:16 INFO - PID 23753 | Cycle 1(1): loaded http://localhost:34202/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34202/tests/kraken/driver.html?testName=audio-dft) 04:07:17 INFO - PID 23753 | RSS: Main: 172294144 04:07:17 INFO - PID 23753 | 04:07:20 INFO - PID 23753 | Cycle 1(1): loaded http://localhost:34202/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34202/tests/kraken/driver.html?testName=audio-fft) 04:07:20 INFO - PID 23753 | RSS: Main: 167157760 04:07:20 INFO - PID 23753 | 04:07:22 INFO - PID 23753 | Cycle 1(1): loaded http://localhost:34202/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34202/tests/kraken/driver.html?testName=audio-oscillator) 04:07:23 INFO - PID 23753 | RSS: Main: 168816640 04:07:23 INFO - PID 23753 | 04:07:25 INFO - PID 23753 | Cycle 1(1): loaded http://localhost:34202/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34202/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:07:26 INFO - PID 23753 | RSS: Main: 169033728 04:07:26 INFO - PID 23753 | 04:07:29 INFO - PID 23753 | Cycle 1(1): loaded http://localhost:34202/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34202/tests/kraken/driver.html?testName=imaging-darkroom) 04:07:29 INFO - PID 23753 | RSS: Main: 168906752 04:07:29 INFO - PID 23753 | 04:07:33 INFO - PID 23753 | Cycle 1(1): loaded http://localhost:34202/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34202/tests/kraken/driver.html?testName=imaging-desaturate) 04:07:34 INFO - PID 23753 | RSS: Main: 171413504 04:07:34 INFO - PID 23753 | 04:07:37 INFO - PID 23753 | Cycle 1(1): loaded http://localhost:34202/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34202/tests/kraken/driver.html?testName=json-parse-financial) 04:07:37 INFO - PID 23753 | RSS: Main: 171429888 04:07:37 INFO - PID 23753 | 04:07:39 INFO - PID 23753 | Cycle 1(1): loaded http://localhost:34202/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34202/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:07:39 INFO - PID 23753 | RSS: Main: 172101632 04:07:39 INFO - PID 23753 | 04:07:41 INFO - PID 23753 | Cycle 1(1): loaded http://localhost:34202/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34202/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:07:42 INFO - PID 23753 | RSS: Main: 171376640 04:07:42 INFO - PID 23753 | 04:07:44 INFO - PID 23753 | Cycle 1(1): loaded http://localhost:34202/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34202/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:07:44 INFO - PID 23753 | RSS: Main: 168448000 04:07:44 INFO - PID 23753 | 04:07:47 INFO - PID 23753 | Cycle 1(1): loaded http://localhost:34202/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34202/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:07:47 INFO - PID 23753 | RSS: Main: 168517632 04:07:47 INFO - PID 23753 | 04:07:50 INFO - PID 23753 | Cycle 1(1): loaded http://localhost:34202/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34202/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:07:51 INFO - PID 23753 | RSS: Main: 169619456 04:07:51 INFO - PID 23753 | 04:07:52 INFO - PID 23753 | Cycle 1(1): loaded http://localhost:34202/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34202/tests/kraken/driver.html?testName=ai-astar) 04:07:53 INFO - PID 23753 | RSS: Main: 170835968 04:07:53 INFO - PID 23753 | 04:07:53 INFO - PID 23753 | __start_tp_report 04:07:53 INFO - PID 23753 | _x_x_mozilla_page_load 04:07:53 INFO - PID 23753 | _x_x_mozilla_page_load_details 04:07:53 INFO - PID 23753 | |i|pagename|runs| 04:07:53 INFO - PID 23753 | |0;ai-astar;108;106;107;106;105;109;106;105;104;106 04:07:53 INFO - PID 23753 | |1;audio-beat-detection;113;111;112;112;113;114;115;135;115;114 04:07:53 INFO - PID 23753 | |2;audio-dft;163;164;164;163;164;161;168;163;167;166 04:07:53 INFO - PID 23753 | |3;audio-fft;75;72;74;73;74;74;73;74;75;74 04:07:53 INFO - PID 23753 | |4;audio-oscillator;77;78;78;78;78;79;78;82;77;77 04:07:53 INFO - PID 23753 | |5;imaging-gaussian-blur;117;114;109;114;111;115;113;115;115;114 04:07:53 INFO - PID 23753 | |6;imaging-darkroom;150;149;149;149;150;148;150;149;151;149 04:07:53 INFO - PID 23753 | |7;imaging-desaturate;96;93;93;94;94;94;100;99;96;94 04:07:53 INFO - PID 23753 | |8;json-parse-financial;45;44;45;44;45;47;45;52;44;44 04:07:53 INFO - PID 23753 | |9;json-stringify-tinderbox;39;39;40;41;39;39;39;39;42;39 04:07:53 INFO - PID 23753 | |10;stanford-crypto-aes;76;72;71;71;73;74;74;72;71;71 04:07:53 INFO - PID 23753 | |11;stanford-crypto-ccm;106;105;107;110;102;107;108;107;128;104 04:07:53 INFO - PID 23753 | |12;stanford-crypto-pbkdf2;168;164;155;157;154;150;157;151;156;160 04:07:53 INFO - PID 23753 | |13;stanford-crypto-sha256-iterative;61;59;62;62;63;64;72;58;59;58 04:07:53 INFO - PID 23753 | __end_tp_report 04:07:53 INFO - PID 23753 | __start_cc_report 04:07:53 INFO - PID 23753 | _x_x_mozilla_cycle_collect,915 04:07:53 INFO - PID 23753 | __end_cc_report 04:07:53 INFO - PID 23753 | __startTimestamp1505300873186__endTimestamp 04:07:53 INFO - PID 23753 | 04:07:53 INFO - PID 23753 | ------- Summary: start ------- 04:07:53 INFO - PID 23753 | Number of tests: 14 04:07:53 INFO - PID 23753 | 04:07:53 INFO - PID 23753 | [#0] ai-astar Cycles:10 Average:106.20 Median:106.00 stddev:1.48 (1.4%) stddev-sans-first:1.41 04:07:53 INFO - PID 23753 | Values: 108.0 106.0 107.0 106.0 105.0 109.0 106.0 105.0 104.0 106.0 04:07:53 INFO - PID 23753 | 04:07:53 INFO - PID 23753 | [#1] audio-beat-detection Cycles:10 Average:115.40 Median:114.00 stddev:7.01 (6.2%) stddev-sans-first:7.38 04:07:53 INFO - PID 23753 | Values: 113.0 111.0 112.0 112.0 113.0 114.0 115.0 135.0 115.0 114.0 04:07:53 INFO - PID 23753 | 04:07:53 INFO - PID 23753 | [#2] audio-dft Cycles:10 Average:164.30 Median:164.00 stddev:2.11 (1.3%) stddev-sans-first:2.19 04:07:53 INFO - PID 23753 | Values: 163.0 164.0 164.0 163.0 164.0 161.0 168.0 163.0 167.0 166.0 04:07:53 INFO - PID 23753 | 04:07:53 INFO - PID 23753 | [#3] audio-fft Cycles:10 Average:73.80 Median:74.00 stddev:0.92 (1.2%) stddev-sans-first:0.87 04:07:53 INFO - PID 23753 | Values: 75.0 72.0 74.0 73.0 74.0 74.0 73.0 74.0 75.0 74.0 04:07:53 INFO - PID 23753 | 04:07:53 INFO - PID 23753 | [#4] audio-oscillator Cycles:10 Average:78.20 Median:78.00 stddev:1.48 (1.9%) stddev-sans-first:1.50 04:07:53 INFO - PID 23753 | Values: 77.0 78.0 78.0 78.0 78.0 79.0 78.0 82.0 77.0 77.0 04:07:53 INFO - PID 23753 | 04:07:53 INFO - PID 23753 | [#5] imaging-gaussian-blur Cycles:10 Average:113.70 Median:114.50 stddev:2.26 (2.0%) stddev-sans-first:2.06 04:07:53 INFO - PID 23753 | Values: 117.0 114.0 109.0 114.0 111.0 115.0 113.0 115.0 115.0 114.0 04:07:53 INFO - PID 23753 | 04:07:53 INFO - PID 23753 | [#6] imaging-darkroom Cycles:10 Average:149.40 Median:149.50 stddev:0.84 (0.6%) stddev-sans-first:0.87 04:07:53 INFO - PID 23753 | Values: 150.0 149.0 149.0 149.0 150.0 148.0 150.0 149.0 151.0 149.0 04:07:53 INFO - PID 23753 | 04:07:53 INFO - PID 23753 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:94.00 stddev:2.45 (2.6%) stddev-sans-first:2.59 04:07:53 INFO - PID 23753 | Values: 96.0 93.0 93.0 94.0 94.0 94.0 100.0 99.0 96.0 94.0 04:07:53 INFO - PID 23753 | 04:07:53 INFO - PID 23753 | [#8] json-parse-financial Cycles:10 Average:45.50 Median:45.00 stddev:2.46 (5.5%) stddev-sans-first:2.60 04:07:53 INFO - PID 23753 | Values: 45.0 44.0 45.0 44.0 45.0 47.0 45.0 52.0 44.0 44.0 04:07:53 INFO - PID 23753 | 04:07:53 INFO - PID 23753 | [#9] json-stringify-tinderbox Cycles:10 Average:39.60 Median:39.00 stddev:1.07 (2.8%) stddev-sans-first:1.12 04:07:53 INFO - PID 23753 | Values: 39.0 39.0 40.0 41.0 39.0 39.0 39.0 39.0 42.0 39.0 04:07:53 INFO - PID 23753 | 04:07:53 INFO - PID 23753 | [#10] stanford-crypto-aes Cycles:10 Average:72.50 Median:72.50 stddev:1.72 (2.4%) stddev-sans-first:1.27 04:07:53 INFO - PID 23753 | Values: 76.0 72.0 71.0 71.0 73.0 74.0 74.0 72.0 71.0 71.0 04:07:53 INFO - PID 23753 | 04:07:53 INFO - PID 23753 | [#11] stanford-crypto-ccm Cycles:10 Average:108.40 Median:107.00 stddev:7.23 (6.8%) stddev-sans-first:7.62 04:07:53 INFO - PID 23753 | Values: 106.0 105.0 107.0 110.0 102.0 107.0 108.0 107.0 128.0 104.0 04:07:53 INFO - PID 23753 | 04:07:53 INFO - PID 23753 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.20 Median:157.00 stddev:5.55 (3.5%) stddev-sans-first:4.30 04:07:53 INFO - PID 23753 | Values: 168.0 164.0 155.0 157.0 154.0 150.0 157.0 151.0 156.0 160.0 04:07:53 INFO - PID 23753 | 04:07:53 INFO - PID 23753 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.80 Median:62.00 stddev:4.16 (6.7%) stddev-sans-first:4.40 04:07:53 INFO - PID 23753 | Values: 61.0 59.0 62.0 62.0 63.0 64.0 72.0 58.0 59.0 58.0 04:07:53 INFO - PID 23753 | -------- Summary: end -------- 04:07:53 INFO - PID 23753 | 04:07:53 INFO - PID 23753 | 04:07:53 INFO - PID 23753 | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost 04:07:53 INFO - PID 23753 | 04:07:53 INFO - PID 23753 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 04:07:53 INFO - TEST-INFO | 23753: exit 0 04:07:53 INFO - TEST-OK | kraken | took 59099ms 04:07:53 INFO - SUITE-END | took 1165s 04:07:54 INFO - Completed test suite (00:19:26) 04:07:54 INFO - javascript benchmark 04:07:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9039.868682288372, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3732.7200459965475, 3751.4747935289065, 3760.52993375828, 3774.1508160663852, 3776.6789822865053, 6164.81505554833, 6207.0, 6229.7508099676015, 6240.62556246625, 6300.149479820235, 6280.905786413207, 6289.245290565127, 6308.40070193332, 6404.935950640493, 6412.198475190601, 5639.15412688096, 5652.434756524335, 5657.943420565783, 5669.376368599451, 5708.543316534688, 223.15972384934054, 5590.972045139769, 5746.7413966371405, 5760.107183386561, 5783.681897495636, 5616.971915140419, 5651.519620832234, 5680.602357834953, 5701.315842098954, 5726.570507211955, 5577.581681373873, 5640.943590564083, 5663.5186009189265, 5700.144978253254, 5707.3721890592005, 5608.158776183605, 5614.326280846324, 5689.6017278790505, 5691.686957217351, 5698.857528561778, 6256.562040657156, 6265.7493700251935, 6299.748010079591, 6384.680765961683, 6400.647964361959, 6640.833979150511, 6748.4938629602975, 6769.932300676979, 6829.112215411965, 6934.0, 6825.385715285648, 6893.241743408221, 6912.343327383891, 6935.826604334932, 6948.478864085163, 6244.594101383395, 6312.810615681537, 6330.8100756977365, 6374.84062898422, 6381.872362552723, 6988.056612357267, 7041.718331266692, 7076.504644674823, 7088.362047415757, 7097.609631470319, 6700.162479690039, 6712.295209003082, 6771.0, 6799.524033317719, 6803.761868334684, 6672.766453174116, 6741.629210393377, 6745.3591908768585, 6755.966220168868, 6776.356246156607, 6734.989751537309, 6747.831304217434, 6772.864542709118, 6798.422134118557, 6810.8637827244165, 6723.5293529452465, 6866.107406037183, 6900.551464154814, 6907.447404207652, 6915.204751453547, 4970.353853998957, 4972.552470277692, 5040.672356296829, 5043.067032598908, 5043.243513472935, 4466.0398014427055, 4501.707389019703, 4557.270836666184, 4560.908781824345, 4565.931511027337, 6095.6952152392205, 6118.418750218722, 6148.1392605035335, 6151.815445536641, 6155.753769849245, 6808.285130061272, 6846.349596788297, 6849.554778939353, 6855.0, 6858.897116543256, 6094.695265236809, 6107.450329470369, 6108.144859719643, 6183.907241391383, 6202.0696895465135, 5426.538744206708, 5479.780808767605, 5501.752421141058, 5544.750486228048, 5554.833354999357, 6942.375186233263, 6959.826004349932, 6967.268436814163, 6982.895256571155, 7005.649717514104, 6673.933260667525, 6748.392644662004, 6769.289224631343, 6846.520743547904, 6884.449244060464, 6796.116504854337, 6863.347981941708, 6885.621290829053, 6973.267806880204, 7012.298770122947, 6735.4274886635185, 6800.149981252343, 6809.829754256183, 6818.147731533559, 6825.931740682529, 6612.4710023198995, 6817.5909445433435, 6853.451723862178, 6941.583504989717, 6952.374286314256, 6536.379043990813, 6557.082008518906, 6561.179852518435, 6573.1454910861285, 6598.67006649656, 6522.641254731036, 6536.248331441945, 6541.672916354068, 6548.050532672641, 6555.573887697285, 6516.185476815398, 6577.736890524326, 6588.670566471561, 6590.7693230736695, 6591.209054913441, 6541.934580654132, 6601.141851559267, 6640.335966403514, 6641.867162656817, 6709.261981181969, 6335.366463353628, 6425.935740642533, 6456.451201647913, 6547.148870646785, 6550.279469258282], "value": 6164.911561408199, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [958.0898146760579, 964.9179819715324, 986.5461887531736, 1008.6268080810099, 1016.7356487313301, 45029.77485112578, 45234.77382613086, 45504.0, 46058.078838423215, 46105.53894461055, 45411.63765087053, 45415.77292113543, 45840.0, 45904.3114353285, 46079.308810367875, 8280.585970701472, 8393.0, 8414.410991230585, 8439.535825529594, 8451.0, 8271.214234647729, 8272.462289951163, 8283.213094756018, 8293.58532073397, 8301.128381519913, 8307.667693292262, 8335.124811894755, 8339.83320333593, 8343.290820280283, 8345.499270043787, 8239.423240373177, 8306.626201820873, 8401.53791541468, 8401.747947561553, 8405.033421156522, 8182.590870456454, 8237.588120593946, 8276.751697449086, 8289.0, 8299.253067223919, 40926.795366023274, 41323.0, 41328.793356033326, 41462.0, 41506.1698766026, 3744.7753134811996, 3753.512043434336, 3791.658750712449, 3793.962060379416, 3795.5065841440714, 33254.0, 33652.663473365195, 34071.82964085189, 34174.0, 34188.0, 5498.037843377433, 5501.092319767234, 5532.059549876531, 5549.833504994856, 5557.666540007613, 204608.0, 205147.0, 205672.0, 205683.0, 207241.0, 50328.0, 50336.24495632568, 53433.465665343625, 53532.0, 53582.0, 56340.718296409075, 56563.71718141383, 56613.71693141508, 56634.43365566374, 56638.7168064157, 14690.192039437934, 14715.92642036783, 14716.411343546353, 14817.851821481647, 15282.631192165232, 11525.193236473535, 11532.481038353126, 11560.537578496935, 11672.066234701204, 11701.356425396685, 15909.52271431859, 15932.840671593367, 15944.840551594336, 15986.36054557828, 16020.75968860468, 6209.813705588839, 6249.0, 6289.622622642656, 6326.43062124411, 6349.2698339690605, 1095.901368876805, 1114.5764609448358, 1123.3484578944356, 1124.7131981344705, 1129.1926272715048, 25763.227103186935, 26112.477750444883, 26205.60691589628, 26215.344616384362, 26314.342141446235, 1191.600813727411, 1214.8542174938887, 1217.1175897474436, 1237.4678888078213, 1237.962861114168, 13701.45194192221, 13960.930195348958, 13961.930190349187, 13962.93018534921, 14067.2966351682, 301984.0, 304796.0, 305913.0, 309458.0, 312591.0, 63929.68035159794, 64451.67774161193, 64747.67626161933, 64805.35194648088, 64904.35095649077, 1506.4275575281322, 1523.2764436892387, 1528.5949223455793, 1531.663034132489, 1534.3325653340833, 30624.387512250076, 30877.94027637439, 30898.073057808302, 31003.534946975364, 31602.0, 43210.56789432065, 43423.782881086656, 43432.0, 43553.0, 43660.12679746451, 247526.0, 248645.0, 249062.0, 249988.0, 250027.0, 37180.0, 38188.809055954545, 38396.0, 38485.807570961966, 38915.41626875543, 46957.765211173726, 48894.26658600195, 49112.508874910796, 49664.75167624139, 49694.0, 34839.0, 34944.0, 35336.11659708528, 35369.64630353663, 35761.28477430489, 34236.48645270273, 34681.47977780285, 34730.0, 34817.0, 35160.64839351574, 40264.396034058926, 41540.1691966165, 41542.0, 41594.79202604089, 41861.23248907613, 34223.0, 34495.482567762, 34517.309653807286, 34631.82684086564, 34687.13282167966, 25381.365465863502, 25435.491290173723, 25789.742102579483, 25985.019213184132, 26040.73959260383], "value": 18992.140289735526, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [598.4972622996681, 600.2976517474556, 608.4554323880125, 614.8678034222642, 615.9384061593842, 22868.313950581487, 23531.647025294635, 23547.76452235479, 23554.293371198848, 23618.173363932223, 23672.526549469, 24132.75867241327, 24208.0, 24238.636420453662, 24488.632670509913, 6513.77201797936, 6604.108445359863, 6605.471562275006, 6617.669116544153, 6696.0290757840085, 6411.166548348731, 6500.544961852672, 6607.207135143765, 6719.126513553231, 6723.630200338979, 6670.0, 6672.132622759059, 6672.532922695414, 6686.83282917926, 6690.063391125246, 6387.712552935129, 6604.075429439882, 6620.966895165518, 6628.4697224221945, 6689.197296324448, 6111.602745821552, 6132.7240274187325, 6171.598846075036, 6179.536534759911, 6188.381161883775, 28684.71315286841, 29038.41923161525, 29112.0, 29175.854120729473, 29197.0, 2208.4258092895802, 2241.6525438556887, 2242.0471299697724, 2245.202952951695, 2246.640537514006, 18658.44024679262, 19591.11839967205, 19670.508237294038, 19723.90138049315, 19740.70388944167, 2464.1006032798077, 2515.5849284867977, 2517.697876254843, 2580.238829545289, 2586.689597248342, 137711.0, 140234.0, 140891.29554352266, 140894.29552852272, 141052.29473852564, 15651.37394504207, 15936.521904342888, 16030.75953860693, 16112.274947627386, 16285.592860178353, 24246.0, 24256.272311830675, 24392.634110488358, 24418.511629767305, 24448.511029779303, 9357.812843743088, 9978.550965206583, 10062.496875156214, 10136.54385552652, 10168.898311016796, 8802.0, 8811.427257228259, 8824.382293239412, 8883.777905552413, 8905.73282801517, 9230.630774769068, 9495.810083798286, 9582.089701478348, 9726.0, 10067.899321006842, 2947.4252520758246, 2991.8952836651047, 2997.5953246311906, 3021.8942337018098, 3045.8477076146105, 1002.6290272599185, 1035.440861934547, 1056.4031322302874, 1061.135174832509, 1070.106461104986, 20920.79079209219, 20959.37121886346, 21348.679769803464, 21569.56860862774, 21701.240456583942, 1057.4976885979252, 1061.75048863517, 1088.1838621034224, 1100.983485247722, 1105.5190991918541, 11604.0, 11617.6514704559, 11706.94146529279, 11817.468213930393, 11849.881501185051, 555475.0, 586983.0, 593625.0, 602483.0, 615007.0, 128386.0, 130585.0, 131371.34314328368, 131935.0, 132997.33501332626, 1213.1326101837228, 1216.9817452738216, 1238.4736486993172, 1248.7627350803318, 1255.2029461292145, 18632.720509192644, 18952.715709264095, 19267.614647706687, 19422.708659369837, 19478.415647530597, 60757.39242607694, 61672.38327616666, 62278.0, 63351.0, 63664.0, 77162.0, 79486.0, 80857.0, 80984.19015809767, 81736.59131704542, 15035.248237588296, 15100.924495377452, 15198.0, 15366.0, 15370.615734606725, 23577.29268121959, 23781.881090594437, 23958.0, 23962.88018559896, 24216.757832421452, 19389.321373751853, 19728.408147755592, 19874.304399345954, 19885.60228795445, 19900.402987910387, 16146.677066458371, 16191.919040404722, 16673.583160421087, 16968.745468818226, 18046.2781488739, 19380.0, 19753.40739777809, 19800.405987820388, 19858.801411985696, 19957.301494447624, 15063.322150503473, 15096.773548396563, 15099.094054356774, 15139.318730656927, 15144.924275378553, 18633.0, 18769.249230030648, 18772.96748678836, 18797.812021879607, 18820.623587528447], "value": 12508.223300860678, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1270.688681273088, 1282.3139620303139, 1282.903782216334, 1283.3070142123254, 1289.825873507077, 16111.838881611195, 16763.49709508717, 16766.91616541917, 16783.91608041961, 16800.999999999985, 16321.428749993724, 16430.7535386969, 16467.34130634773, 16491.257893394795, 16494.34022639096, 2875.899343522972, 2877.553979133227, 2935.5890175375466, 2938.941980886879, 2941.3087924337765, 2846.3595690969573, 2889.6821349651523, 2909.5781111738784, 2911.2576293045245, 2918.1829087855435, 2589.702184248807, 2806.3825958289244, 2816.6479190101236, 2882.971170288302, 2883.1206482022976, 2927.1803894909353, 2931.824090554552, 2961.511350627133, 2961.718636729507, 2963.1406892001296, 2755.5591105423237, 2837.8439185844773, 2857.371378296792, 2863.627728395316, 2867.5411934090444, 16533.0, 16618.0, 16680.249388777534, 16687.91656041724, 16701.0, 8507.404481686284, 8822.338324625614, 8824.735257942208, 8825.0, 8828.117188281185, 5685.8009969651275, 5731.541476681856, 5781.421857814227, 5877.706114694248, 5887.793927212527, 2081.8341728632013, 2094.706741056253, 2113.1019316790303, 2118.2268472007604, 2156.202205184092, 29401.41197176066, 29606.111816645534, 29660.8516957416, 29667.554986675215, 29706.40587188244, 7205.747798827016, 7225.747098851515, 7268.0914885639295, 7395.297446742551, 7401.703931842773, 19378.224871005285, 19419.4174174775, 19424.0, 19449.12478938451, 19504.51238719015, 8480.618372173267, 8568.571571421404, 8573.356998225157, 8578.528180949983, 8583.313334933191, 7519.624018799038, 7640.617969101522, 7682.846343073107, 7688.730894418669, 7735.381169506426, 5527.143292789624, 5586.966411213938, 5662.122371032497, 5722.313322401338, 5879.588428809942, 1631.208863701104, 1632.3796957156442, 1658.3200887636012, 1662.3101412913506, 1679.7312430011139, 960.5341409416427, 963.7952559300874, 975.5027130545825, 987.6493844685177, 991.2367477042637, 8568.143185681507, 8589.484630922165, 8706.390552661253, 9540.522973851419, 9689.370190937567, 741.4661443760484, 755.7808235611722, 763.3892885691424, 785.6268272570484, 786.8347646994196, 5042.067217564762, 5312.4219569451925, 5736.483716465538, 5843.2695913010875, 5855.180274761537, 23341.066357345855, 24701.0, 24729.1344802931, 24748.22437168135, 24927.750722492543, 24306.27081187567, 24570.508589828103, 24798.38004049913, 24808.751912481006, 24872.37819054538, 12367.62897113088, 12375.504979800888, 12452.190607610477, 12540.122191446511, 12681.682957926125, 9214.308926830381, 9406.200472959876, 9484.478353690612, 9526.333156679244, 9586.712398627773, 20406.0, 20740.170393184708, 21037.0, 21038.89480552649, 21299.0, 21471.570568588228, 21643.13427462884, 21740.673889891346, 21893.67159492577, 21997.780022199575, 12185.451654675384, 12457.937710311753, 12469.376531173224, 12475.376231188222, 12476.563320284109, 15151.621209469851, 15222.847771522143, 15265.3893844245, 15354.616134596725, 15404.691906162037, 11475.254108482923, 11709.355985420883, 11840.230385024946, 11951.462184201906, 12072.939635301767, 11522.711932201762, 11608.825867612162, 11791.174617776673, 11796.174267801514, 11917.880821191677, 10111.090001899864, 10299.433531155859, 10304.381737095799, 10310.587576496857, 10336.431496267778, 8001.199880011952, 8007.959960200395, 8017.919820801717, 8088.433809633269, 8138.796530086795, 7702.768916932501, 7728.4203684725, 7789.922100778919, 7856.489328193649, 7884.802879927818], "value": 7178.755709362383, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [538.5825984861732, 548.687248268487, 570.3526497425421, 576.4293349583913, 579.2730123694765, 6264.467520260778, 6285.560010799246, 6313.368663133684, 6398.7120579573975, 6404.07140964561, 6280.371962803717, 6332.588381755183, 6347.682615869211, 6363.554551181419, 6405.167328247321, 5186.8703282417955, 5224.242484839696, 5227.73861306935, 5238.764255608507, 5243.842684719464, 5088.643794934337, 5099.107656160176, 5192.71440070796, 5211.583073354142, 5228.607854410915, 5156.484351564851, 5157.174852023677, 5157.73059853665, 5183.974080129613, 5221.947780522184, 5142.1772516397195, 5145.691258524463, 5146.819861304855, 5149.613778966593, 5161.690298582097, 4842.927356089662, 4864.951350486485, 4867.294242334877, 4876.244182151737, 4897.118518666639, 6215.81352559424, 6338.334474880117, 6380.744770209186, 6389.4568961638315, 6429.871402571969, 6120.20437343147, 6126.284640300723, 6147.508199344086, 6155.383462403198, 6170.259568851721, 6739.932600673979, 6782.220044694874, 6789.796306110775, 6808.795736127924, 6835.248122706498, 5386.811461598825, 5413.729313534308, 5426.403095659474, 5434.940186663603, 5477.890442191174, 7001.894971575431, 7017.754378596725, 7078.221395646475, 7127.2160062393095, 7139.428845692332, 5624.409437009137, 5661.235733176051, 5690.829275121753, 5698.401667824819, 5701.144828275709, 5740.397258287903, 5746.597738158289, 5756.856078597984, 5773.942260577341, 5803.564732645069, 6058.878822423615, 6100.969495152584, 6101.901657701567, 6129.816105516842, 6157.9384206158265, 6446.323136070739, 6453.257875344396, 6689.0, 6741.898871516931, 6789.219239787389, 1923.9615207695767, 1951.8438524917972, 1952.8828270303827, 1958.667026605452, 1977.1004193092108, 1461.663817322022, 1481.8811797093126, 1487.8809695224356, 1488.0, 1494.8729358004691, 5898.76404943806, 5939.316978547522, 5983.850403739854, 6054.485368743706, 6133.723982420802, 6784.219814721271, 6809.523333366716, 6822.590644561342, 6842.7605033823575, 6858.588484690935, 6067.118118893491, 6073.726682299307, 6121.296050954108, 6139.539534534839, 6142.754289828446, 3560.608333083359, 3602.8018458985007, 3613.0786649404236, 3620.4931309616672, 3628.129248980226, 6947.166340039126, 7017.649087555726, 7039.0, 7039.436845052383, 7045.154581450156, 6952.756653517103, 7017.649117544204, 7033.859322813618, 7065.611391373421, 7067.151941767021, 6959.130108736408, 7017.89473157903, 7027.297270272932, 7046.295370462913, 7058.223595404502, 6661.134052573135, 6738.831529211809, 6788.626625535643, 6817.3182681733415, 6819.659017049227, 6813.4208592270215, 6836.28219036994, 6866.0, 6870.519063665695, 6887.7244910203035, 6874.003269525991, 6942.0, 6944.965275173794, 6956.5478243913985, 6969.038158782396, 5107.668001579886, 5165.302684137593, 5196.428392876856, 5199.532042116228, 5221.138512145453, 6944.93055069463, 6952.30476952321, 6957.1651401832105, 6982.965085174542, 6987.755428559976, 6661.16735408074, 6663.933360666525, 6688.866222675617, 6706.832329191614, 6710.429613482908, 6548.1814773153355, 6557.901631475627, 6571.474282057328, 6631.171103612049, 6631.816727970505, 6485.286618472059, 6500.414962653384, 6509.707063182073, 6513.5114866384265, 6517.055027021151, 6121.326654068138, 6548.410643042149, 6623.900641490285, 6651.102101216274, 6698.866022679616, 6320.209973753281, 6326.58364483174, 6407.16706828128, 6487.9026814598765, 6537.738490460329], "value": 5318.655843040205, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [963.4941655630793, 982.965596204133, 985.0248254228314, 1009.9799202805165, 1014.8528463372809, 16901.999999999985, 17430.564235894108, 17580.736288955675, 17584.208710608036, 17590.73613895791, 16219.351225950977, 16453.25960331785, 16458.588535286624, 16459.506214813544, 16485.258163382645, 1059.4279089291774, 1081.0270756319296, 1081.0486771640944, 1081.5727787523924, 1082.080231802965, 1077.6443773554709, 1077.709018564987, 1078.412265315405, 1078.557791305565, 1080.773037662088, 1104.8895110488927, 1109.995454114028, 1144.4735421706025, 1147.2772153543256, 1148.8793676663956, 1136.6419577832955, 1137.2835113878205, 1137.9886201138006, 1138.7950168969583, 1140.1334985411106, 796.2276591706036, 815.1725998111921, 820.9876851847227, 821.6959724901765, 822.2188920525525, 17230.396936107176, 17317.13414329291, 17320.0, 17335.739963900553, 17373.95756254629, 20716.48208794777, 21057.473563161042, 21075.156993720233, 21488.89255553712, 21669.241576544744, 15246.466373676869, 15269.465568705153, 15401.152936588483, 15518.0, 15531.689366212726, 3662.047867554428, 3738.3084129436143, 3770.3967365221433, 3771.377722675755, 3778.5843557208686, 120070.0, 138561.0, 144409.0, 145305.27347363302, 147636.26181869023, 17315.30738770435, 17976.0, 17980.1009949502, 18056.548586285448, 18062.729059064124, 34466.483002754976, 35216.295674086374, 35256.471152932725, 35261.0, 35285.0, 8299.6680132794, 8559.74320770378, 8679.0, 8704.04255531891, 8715.564221788885, 4522.140793249272, 4530.682852200381, 4598.563136502027, 4618.168729628632, 4618.468876079227, 5454.372747134131, 5629.352624448241, 5690.118031705092, 5702.6293290935955, 5749.9425005750245, 1161.3670549550516, 1174.9530018799153, 1187.5131196209513, 1189.0547015122997, 1192.028496775143, 712.9500934934608, 725.3834240895302, 725.764126658838, 737.9704811807468, 751.1587022534796, 11550.249233799776, 11567.305961642329, 11698.70753231176, 11911.821322680167, 11933.582324618597, 677.8271540757075, 696.7352406085756, 699.4369532526365, 707.9646017699095, 709.6203531110934, 5452.154915988028, 5455.1544510600925, 5574.163875418639, 5579.9163012554845, 5639.041362968223, 147094.0, 149228.0, 151068.244658776, 151632.0, 151978.0, 103145.0, 125822.7088645564, 130147.0, 132493.33753331171, 137223.0, 113717.43141284406, 114608.0, 115836.0, 117435.0, 120351.39824300997, 11625.88374116248, 12179.330136842558, 12195.0, 12251.0, 12676.936615316865, 52166.73916630392, 53240.0, 55673.0, 55699.16451253153, 56402.43597564136, 90614.0, 91101.0, 91690.0, 97337.51331243581, 98738.50630746801, 19826.0, 21066.683999740322, 21742.347729568137, 21749.782502174774, 21767.891160544095, 20916.267930622354, 20966.266180683604, 21159.576808463436, 21353.572928541653, 21363.0, 16688.249028793976, 16694.4156954506, 17223.31106755716, 17377.04426256568, 17894.642107158044, 17928.820711792716, 18052.909735451238, 18114.728279076087, 18317.725234121233, 18397.448076557725, 17021.0, 17185.0, 17453.912730436266, 17670.734938976184, 17968.460946171635, 15212.315445805187, 15297.0, 15381.461648842236, 15506.612334691723, 15776.290066946785, 13948.302584870919, 14265.928670356581, 14346.426142954166, 14436.821467896541, 14512.927435362755], "value": 9758.854667077858, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1381.3000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 106.0, 107.0, 106.0, 105.0, 109.0, 106.0, 105.0, 104.0, 106.0], "value": 106.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 111.0, 112.0, 112.0, 113.0, 114.0, 115.0, 135.0, 115.0, 114.0], "value": 115.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 164.0, 163.0, 164.0, 161.0, 168.0, 163.0, 167.0, 166.0], "value": 164.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 72.0, 74.0, 73.0, 74.0, 74.0, 73.0, 74.0, 75.0, 74.0], "value": 73.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 78.0, 78.0, 78.0, 78.0, 79.0, 78.0, 82.0, 77.0, 77.0], "value": 78.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 114.0, 109.0, 114.0, 111.0, 115.0, 113.0, 115.0, 115.0, 114.0], "value": 113.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 149.0, 149.0, 149.0, 150.0, 148.0, 150.0, 149.0, 151.0, 149.0], "value": 149.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 93.0, 93.0, 94.0, 94.0, 94.0, 100.0, 99.0, 96.0, 94.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [45.0, 44.0, 45.0, 44.0, 45.0, 47.0, 45.0, 52.0, 44.0, 44.0], "value": 45.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [39.0, 39.0, 40.0, 41.0, 39.0, 39.0, 39.0, 39.0, 42.0, 39.0], "value": 39.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 72.0, 71.0, 71.0, 73.0, 74.0, 74.0, 72.0, 71.0, 71.0], "value": 72.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 105.0, 107.0, 110.0, 102.0, 107.0, 108.0, 107.0, 128.0, 104.0], "value": 108.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 164.0, 155.0, 157.0, 154.0, 150.0, 157.0, 151.0, 156.0, 160.0], "value": 157.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 59.0, 62.0, 62.0, 63.0, 64.0, 72.0, 58.0, 59.0, 58.0], "value": 61.8, "unit": "score"}]}]} 04:07:54 INFO - Return code: 0 04:07:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:07:54 INFO - # TBPL SUCCESS # 04:07:54 INFO - Running post-action listener: _package_coverage_data 04:07:54 INFO - Running post-action listener: _resource_record_post_action 04:07:54 INFO - [mozharness: 2017-09-13 11:07:54.485577Z] Finished run-tests step (success) 04:07:54 INFO - Running post-run listener: _resource_record_post_run 04:07:54 INFO - Total resource usage - Wall time: 1184s; CPU: 13.0%; Read bytes: 4096; Write bytes: 326078464; Read time: 8; Write time: 219124 04:07:54 INFO - TinderboxPrint: CPU usage
13.1% 04:07:54 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 04:07:54 INFO - TinderboxPrint: I/O write bytes / time
326,078,464 / 219,124 04:07:54 INFO - TinderboxPrint: CPU idle
8,206.8 (86.9%) 04:07:54 INFO - TinderboxPrint: CPU user
1,186.2 (12.6%) 04:07:54 INFO - TinderboxPrint: Swap in / out
0 / 0 04:07:54 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 12718080; Read time: 0; Write time: 2204 04:07:54 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 04:07:54 INFO - run-tests - Wall time: 1167s; CPU: 13.0%; Read bytes: 4096; Write bytes: 312745984; Read time: 8; Write time: 216920 04:07:55 INFO - Running post-run listener: _upload_blobber_files 04:07:55 INFO - Blob upload gear active. 04:07:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:07:55 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:07:55 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'] 04:07:55 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 04:07:55 INFO - (blobuploader) - INFO - Open directory for files ... 04:07:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 04:07:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:07:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:07:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 04:07:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:07:56 INFO - (blobuploader) - INFO - Done attempting. 04:07:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:07:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:07:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:08:03 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:08:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:08:03 INFO - (blobuploader) - INFO - Done attempting. 04:08:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 04:08:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:08:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:08:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 04:08:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:08:04 INFO - (blobuploader) - INFO - Done attempting. 04:08:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:08:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:08:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:08:05 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:08:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:08:05 INFO - (blobuploader) - INFO - Done attempting. 04:08:05 INFO - (blobuploader) - INFO - Iteration through files over. 04:08:05 INFO - Return code: 0 04:08:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:08:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:08:05 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9be413d8f51609c9306d3846161554e863cc69c2ed383b18fabb25afa1d5b9f6cdfa259af60004911e153a737296f9534bdeac108195b08f86fcad1a69918018", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0b26e0f66b47f871d78ce2a9e4bf4772e00a4c0c2a3dd26a32f58300d5305da18fa5cd473db520faf4bb11c660796a4cefcc76f007cda377b1f5d7ba69c794a5", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9d028bee015617d1ab8c7a1ed78de5f4bcaae926fbdaea90e1732bad1a88eaf5405f0193ad8de285b29d0a81d9fac51fa6a38300e275c0a59b8e1820cc891d85", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7875780141cf2e182305531271b82e09504a4d39c07fc4db76d72740eead099d2d510f5501e8bb61bdec02d9ec3a3fc1d81a578f72141d5514a8ce212e53c16c"} 04:08:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:08:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:08:05 INFO - Contents: 04:08:05 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9be413d8f51609c9306d3846161554e863cc69c2ed383b18fabb25afa1d5b9f6cdfa259af60004911e153a737296f9534bdeac108195b08f86fcad1a69918018", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0b26e0f66b47f871d78ce2a9e4bf4772e00a4c0c2a3dd26a32f58300d5305da18fa5cd473db520faf4bb11c660796a4cefcc76f007cda377b1f5d7ba69c794a5", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9d028bee015617d1ab8c7a1ed78de5f4bcaae926fbdaea90e1732bad1a88eaf5405f0193ad8de285b29d0a81d9fac51fa6a38300e275c0a59b8e1820cc891d85", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7875780141cf2e182305531271b82e09504a4d39c07fc4db76d72740eead099d2d510f5501e8bb61bdec02d9ec3a3fc1d81a578f72141d5514a8ce212e53c16c"} 04:08:05 INFO - Running post-run listener: copy_logs_to_upload_dir 04:08:05 INFO - Copying logs to upload dir... 04:08:05 INFO - mkdir: /builds/slave/test/build/upload/logs 04:08:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.580931 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2017-09-13 04:08:05.218821) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-13 04:08:05.222934) ========= 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=3a3620fb28aea1604ab609ef000001d2-1505298909.362317-1699111048 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/9be413d8f51609c9306d3846161554e863cc69c2ed383b18fabb25afa1d5b9f6cdfa259af60004911e153a737296f9534bdeac108195b08f86fcad1a69918018", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0b26e0f66b47f871d78ce2a9e4bf4772e00a4c0c2a3dd26a32f58300d5305da18fa5cd473db520faf4bb11c660796a4cefcc76f007cda377b1f5d7ba69c794a5", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9d028bee015617d1ab8c7a1ed78de5f4bcaae926fbdaea90e1732bad1a88eaf5405f0193ad8de285b29d0a81d9fac51fa6a38300e275c0a59b8e1820cc891d85", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7875780141cf2e182305531271b82e09504a4d39c07fc4db76d72740eead099d2d510f5501e8bb61bdec02d9ec3a3fc1d81a578f72141d5514a8ce212e53c16c"} build_url:https://queue.taskcluster.net/v1/task/YIkFlt9lTBKLLWKJyRiPbA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011341 build_url: 'https://queue.taskcluster.net/v1/task/YIkFlt9lTBKLLWKJyRiPbA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9be413d8f51609c9306d3846161554e863cc69c2ed383b18fabb25afa1d5b9f6cdfa259af60004911e153a737296f9534bdeac108195b08f86fcad1a69918018", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0b26e0f66b47f871d78ce2a9e4bf4772e00a4c0c2a3dd26a32f58300d5305da18fa5cd473db520faf4bb11c660796a4cefcc76f007cda377b1f5d7ba69c794a5", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9d028bee015617d1ab8c7a1ed78de5f4bcaae926fbdaea90e1732bad1a88eaf5405f0193ad8de285b29d0a81d9fac51fa6a38300e275c0a59b8e1820cc891d85", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7875780141cf2e182305531271b82e09504a4d39c07fc4db76d72740eead099d2d510f5501e8bb61bdec02d9ec3a3fc1d81a578f72141d5514a8ce212e53c16c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-13 04:08:05.258719) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-13 04:08:05.259340) ========= 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=3a3620fb28aea1604ab609ef000001d2-1505298909.362317-1699111048 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004546 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-13 04:08:05.343946) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-13 04:08:05.344502) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-13 04:08:05.345072) ========= ========= Total master_lag: 0.22 =========