builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-023 starttime: 1505760685.01 results: success (0) revision: 42151fcd6cfc216d147730d0f2c6a2acd52d22fd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-18 11:51:25.008158) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-18 11:51:25.008617) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-18 11:51:25.008885) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-18 11:51:25.052788) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-18 11:51:25.053174) ========= 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=6d15e502d8e29d5d2676d664000001c3-1505760485.880801-1588600159 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-18 11:51:25-- 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% 106M=0s 2017-09-18 11:51:25 (106 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.186916 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-18 11:51:25.271910) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-18 11:51:25.272227) ========= 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=6d15e502d8e29d5d2676d664000001c3-1505760485.880801-1588600159 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019159 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-18 11:51:25.321414) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-18 11:51:25.324760) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 42151fcd6cfc216d147730d0f2c6a2acd52d22fd --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 42151fcd6cfc216d147730d0f2c6a2acd52d22fd --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=6d15e502d8e29d5d2676d664000001c3-1505760485.880801-1588600159 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-18 11:51:25,461 truncating revision to first 12 chars 2017-09-18 11:51:25,461 Setting DEBUG logging. 2017-09-18 11:51:25,461 attempt 1/10 2017-09-18 11:51:25,461 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/42151fcd6cfc?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-18 11:51:25,815 unpacking tar archive at: mozilla-central-42151fcd6cfc/testing/mozharness/ program finished with exit code 0 elapsedTime=0.638219 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-18 11:51:25.973997) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-18 11:51:25.974297) ========= script_repo_revision: 42151fcd6cfc216d147730d0f2c6a2acd52d22fd ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-18 11:51:25.977679) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-18 11:51:25.977945) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-18 11:51:25.990205) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2017-09-18 11:51:25.990523) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6d15e502d8e29d5d2676d664000001c3-1505760485.880801-1588600159 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:51:26 INFO - MultiFileLogger online at 20170918 11:51:26 in /builds/slave/test 11:51:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 11:51:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:51:26 INFO - {'append_to_log': False, 11:51:26 INFO - 'base_work_dir': '/builds/slave/test', 11:51:26 INFO - 'blob_upload_branch': 'Firefox', 11:51:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:51:26 INFO - 'branch': 'Firefox', 11:51:26 INFO - 'buildbot_json_path': 'buildprops.json', 11:51:26 INFO - 'code_coverage': False, 11:51:26 INFO - 'config_files': ('talos/linux_config.py',), 11:51:26 INFO - 'default_actions': ('clobber', 11:51:26 INFO - 'read-buildbot-config', 11:51:26 INFO - 'download-and-extract', 11:51:26 INFO - 'populate-webroot', 11:51:26 INFO - 'create-virtualenv', 11:51:26 INFO - 'install', 11:51:26 INFO - 'setup-mitmproxy', 11:51:26 INFO - 'run-tests'), 11:51:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:51:26 INFO - 'disable_ccov_upload': False, 11:51:26 INFO - 'disable_stylo': False, 11:51:26 INFO - 'download_minidump_stackwalk': True, 11:51:26 INFO - 'download_symbols': 'ondemand', 11:51:26 INFO - 'enable_stylo': False, 11:51:26 INFO - 'enable_webrender': False, 11:51:26 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 11:51:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:51:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:51:26 INFO - 'gecko_profile': False, 11:51:26 INFO - 'gecko_profile_interval': 0, 11:51:26 INFO - 'installer_path': 'installer.exe', 11:51:26 INFO - 'log_level': 'info', 11:51:26 INFO - 'log_name': 'talos', 11:51:26 INFO - 'log_to_console': True, 11:51:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:51:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:51:26 INFO - 'opt_config_files': (), 11:51:26 INFO - 'pip_index': False, 11:51:26 INFO - 'suite': 'dromaeojs-e10s', 11:51:26 INFO - 'system_bits': '32', 11:51:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:51:26 INFO - 'title': 'talos-linux64-ix-023', 11:51:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:51:26 INFO - 'use_talos_json': True, 11:51:26 INFO - 'verify': 'False', 11:51:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:51:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:51:26 INFO - 'work_dir': 'build'} 11:51:26 INFO - [mozharness: 2017-09-18 18:51:26.325551Z] Running clobber step. 11:51:26 INFO - Running pre-action listener: _resource_record_pre_action 11:51:26 INFO - Running main action method: clobber 11:51:26 INFO - rmtree: /builds/slave/test/build 11:51:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:51:27 INFO - Running post-action listener: _resource_record_post_action 11:51:27 INFO - [mozharness: 2017-09-18 18:51:27.278646Z] Finished clobber step (success) 11:51:27 INFO - [mozharness: 2017-09-18 18:51:27.278743Z] Running read-buildbot-config step. 11:51:27 INFO - Running pre-action listener: _resource_record_pre_action 11:51:27 INFO - Running main action method: read_buildbot_config 11:51:27 INFO - Using buildbot properties: 11:51:27 INFO - { 11:51:27 INFO - "project": "", 11:51:27 INFO - "product": "firefox", 11:51:27 INFO - "who": "ffxbld@noreply.mozilla.org", 11:51:27 INFO - "installer_path": "public/build/target.tar.bz2", 11:51:27 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 11:51:27 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 11:51:27 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 11:51:27 INFO - "stage_platform": "linux64-pgo", 11:51:27 INFO - "basedir": "/builds/slave/test", 11:51:27 INFO - "buildnumber": 178, 11:51:27 INFO - "platform": "ubuntu64_hw", 11:51:27 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 11:51:27 INFO - "slavebuilddir": "test", 11:51:27 INFO - "taskId": "Bi8nWg7IQrG6T6LyHJ2MNQ", 11:51:27 INFO - "branch": "mozilla-central", 11:51:27 INFO - "script_repo_revision": "production", 11:51:27 INFO - "revision": "42151fcd6cfc216d147730d0f2c6a2acd52d22fd", 11:51:27 INFO - "slavename": "talos-linux64-ix-023", 11:51:27 INFO - "repo_path": "mozilla-central" 11:51:27 INFO - } 11:51:27 INFO - Finding installer, test and symbols from parent task. 11:51:27 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Bi8nWg7IQrG6T6LyHJ2MNQ'}, attempt #1 11:51:27 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Bi8nWg7IQrG6T6LyHJ2MNQ'}, attempt #1 11:51:28 INFO - Task dependencies: SCsIEorPRfqct5c1S2alwA 11:51:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SCsIEorPRfqct5c1S2alwA'}, attempt #1 11:51:28 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/SCsIEorPRfqct5c1S2alwA/artifacts/public/build/target.tar.bz2 11:51:28 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/SCsIEorPRfqct5c1S2alwA/artifacts/public/build/target.test_packages.json 11:51:28 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/SCsIEorPRfqct5c1S2alwA/artifacts/public/build/target.crashreporter-symbols.zip 11:51:28 INFO - Running post-action listener: _resource_record_post_action 11:51:28 INFO - [mozharness: 2017-09-18 18:51:28.720300Z] Finished read-buildbot-config step (success) 11:51:28 INFO - [mozharness: 2017-09-18 18:51:28.720518Z] Running download-and-extract step. 11:51:28 INFO - Running pre-action listener: _resource_record_pre_action 11:51:28 INFO - Running main action method: download_and_extract 11:51:28 INFO - mkdir: /builds/slave/test/build/tests 11:51:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:51:28 INFO - trying https://queue.taskcluster.net/v1/task/SCsIEorPRfqct5c1S2alwA/artifacts/public/build/target.test_packages.json 11:51:28 INFO - Downloading https://queue.taskcluster.net/v1/task/SCsIEorPRfqct5c1S2alwA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 11:51:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SCsIEorPRfqct5c1S2alwA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 11:51:29 INFO - Downloaded 989 bytes. 11:51:29 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 11:51:29 INFO - Using the following test package requirements: 11:51:29 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 11:51:29 INFO - u'common': [u'target.common.tests.zip'], 11:51:29 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 11:51:29 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 11:51:29 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 11:51:29 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 11:51:29 INFO - u'mozbase': [u'target.common.tests.zip'], 11:51:29 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 11:51:29 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 11:51:29 INFO - u'web-platform': [u'target.common.tests.zip', 11:51:29 INFO - u'target.web-platform.tests.tar.gz'], 11:51:29 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 11:51:29 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 11:51:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SCsIEorPRfqct5c1S2alwA/artifacts/public/build/target.common.tests.zip 11:51:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SCsIEorPRfqct5c1S2alwA/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:51:29 INFO - Fetch https://queue.taskcluster.net/v1/task/SCsIEorPRfqct5c1S2alwA/artifacts/public/build/target.common.tests.zip into memory 11:51:31 INFO - Content-Length response header: 55323859 11:51:31 INFO - Bytes received: 55323859 11:51:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SCsIEorPRfqct5c1S2alwA/artifacts/public/build/target.talos.tests.zip 11:51:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SCsIEorPRfqct5c1S2alwA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 11:51:42 INFO - Fetch https://queue.taskcluster.net/v1/task/SCsIEorPRfqct5c1S2alwA/artifacts/public/build/target.talos.tests.zip into memory 11:51:44 INFO - Content-Length response header: 14508748 11:51:44 INFO - Bytes received: 14508748 11:51:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:51:44 INFO - trying https://queue.taskcluster.net/v1/task/SCsIEorPRfqct5c1S2alwA/artifacts/public/build/target.tar.bz2 11:51:44 INFO - Downloading https://queue.taskcluster.net/v1/task/SCsIEorPRfqct5c1S2alwA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 11:51:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SCsIEorPRfqct5c1S2alwA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 11:51:47 INFO - Downloaded 62162901 bytes. 11:51:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SCsIEorPRfqct5c1S2alwA/artifacts/public/build/target.tar.bz2 11:51:47 INFO - mkdir: /builds/slave/test/properties 11:51:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:51:47 INFO - Writing to file /builds/slave/test/properties/build_url 11:51:47 INFO - Contents: 11:51:47 INFO - build_url:https://queue.taskcluster.net/v1/task/SCsIEorPRfqct5c1S2alwA/artifacts/public/build/target.tar.bz2 11:51:47 INFO - Running post-action listener: _resource_record_post_action 11:51:47 INFO - Running post-action listener: find_tests_for_verification 11:51:47 INFO - Running post-action listener: set_extra_try_arguments 11:51:47 INFO - [mozharness: 2017-09-18 18:51:47.371604Z] Finished download-and-extract step (success) 11:51:47 INFO - [mozharness: 2017-09-18 18:51:47.371836Z] Running populate-webroot step. 11:51:47 INFO - Running pre-action listener: _resource_record_pre_action 11:51:47 INFO - Running main action method: populate_webroot 11:51:47 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:51:47 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:51:47 INFO - 'tests': ['tresize', 11:51:47 INFO - 'tcanvasmark']}, 11:51:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:51:47 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:51:47 INFO - 'tests': ['dromaeo_css', 11:51:47 INFO - 'kraken']}, 11:51:47 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:51:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:51:47 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:51:47 INFO - 'talos_options': ['--disable-stylo'], 11:51:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:51:47 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:51:47 INFO - 'tests': ['damp', 'tps']}, 11:51:47 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:51:47 INFO - 'talos_options': ['--disable-stylo'], 11:51:47 INFO - 'tests': ['damp', 'tps']}, 11:51:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:51:47 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:51:47 INFO - 'tests': ['dromaeo_dom']}, 11:51:47 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 11:51:47 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:51:47 INFO - 'tests': ['basic_compositor_video', 11:51:47 INFO - 'glvideo']}, 11:51:47 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 11:51:47 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 11:51:47 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:51:47 INFO - 'talos_options': ['--disable-stylo'], 11:51:47 INFO - 'tests': ['ts_paint_webext', 11:51:47 INFO - 'tp5o_webext']}, 11:51:47 INFO - 'other-e10s': {'tests': ['a11yr', 11:51:47 INFO - 'ts_paint', 11:51:47 INFO - 'tpaint', 11:51:47 INFO - 'sessionrestore', 11:51:47 INFO - 'sessionrestore_many_windows', 11:51:47 INFO - 'sessionrestore_no_auto_restore', 11:51:47 INFO - 'tabpaint']}, 11:51:47 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:51:47 INFO - 'tests': ['a11yr', 11:51:47 INFO - 'ts_paint', 11:51:47 INFO - 'tpaint', 11:51:47 INFO - 'sessionrestore', 11:51:47 INFO - 'sessionrestore_many_windows', 11:51:47 INFO - 'sessionrestore_no_auto_restore', 11:51:47 INFO - 'tabpaint']}, 11:51:47 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 11:51:47 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 11:51:47 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:51:47 INFO - 'tests': ['perf_reftest_singletons']}, 11:51:47 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:51:47 INFO - 'tests': ['bloom_basic']}, 11:51:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:51:47 INFO - 'tsvgr_opacity', 11:51:47 INFO - 'tart', 11:51:47 INFO - 'tscrollx', 11:51:47 INFO - 'tsvg_static']}, 11:51:47 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:51:47 INFO - 'tests': ['tsvgx', 11:51:47 INFO - 'tsvgr_opacity', 11:51:47 INFO - 'tart', 11:51:47 INFO - 'tscrollx', 11:51:47 INFO - 'tsvg_static']}, 11:51:47 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:51:47 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:51:47 INFO - 'talos_options': ['--disable-stylo'], 11:51:47 INFO - 'tests': ['tp5o']}, 11:51:47 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:51:47 INFO - 'talos_options': ['--mitmproxy', 11:51:47 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:51:47 INFO - '--firstNonBlankPaint'], 11:51:47 INFO - 'tests': ['tp6_google', 11:51:47 INFO - 'tp6_youtube', 11:51:47 INFO - 'tp6_amazon', 11:51:47 INFO - 'tp6_facebook']}, 11:51:47 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:51:47 INFO - 'talos_options': ['--disable-stylo', 11:51:47 INFO - '--mitmproxy', 11:51:47 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:51:47 INFO - '--firstNonBlankPaint'], 11:51:47 INFO - 'tests': ['tp6_google', 11:51:47 INFO - 'tp6_youtube', 11:51:47 INFO - 'tp6_amazon', 11:51:47 INFO - 'tp6_facebook']}, 11:51:47 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:51:47 INFO - 'talos_options': ['--stylo-threads=1', 11:51:47 INFO - '--mitmproxy', 11:51:47 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:51:47 INFO - '--firstNonBlankPaint'], 11:51:47 INFO - 'tests': ['tp6_google', 11:51:47 INFO - 'tp6_youtube', 11:51:47 INFO - 'tp6_amazon', 11:51:47 INFO - 'tp6_facebook']}, 11:51:47 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:51:47 INFO - 'talos_options': ['--xperf_path', 11:51:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:51:47 INFO - 'tests': ['tp5n']}, 11:51:47 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:51:47 INFO - 'talos_options': ['--disable-stylo', 11:51:47 INFO - '--xperf_path', 11:51:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:51:47 INFO - 'tests': ['tp5n']}}} 11:51:47 INFO - Running post-action listener: _resource_record_post_action 11:51:47 INFO - [mozharness: 2017-09-18 18:51:47.390265Z] Finished populate-webroot step (success) 11:51:47 INFO - [mozharness: 2017-09-18 18:51:47.390354Z] Running create-virtualenv step. 11:51:47 INFO - Running pre-action listener: _resource_record_pre_action 11:51:47 INFO - Running main action method: create_virtualenv 11:51:47 INFO - Creating virtualenv /builds/slave/test/build/venv 11:51:47 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:51:47 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 11:51:47 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 11:51:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:51:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:51:48 INFO - Installing distribute.............................................................................................................................................................................................done. 11:51:48 INFO - Installing pip...............done. 11:51:48 INFO - Return code: 0 11:51:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:51:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:51:48 INFO - Reading from file tmpfile_stdout 11:51:48 INFO - Output received: 11:51:48 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 11:51:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:51: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')]} 11:51:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:51: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')]} 11:51:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:51:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x111c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12e5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1488a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x148c090>, '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 0x148cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1486f90>, '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': '6d15e502d8e29d5d2676d664000001c3-1505760485.880801-1588600159', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:51:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:51:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:51:48 INFO - Using env: {'DISPLAY': ':0', 11:51:48 INFO - 'HOME': '/home/cltbld', 11:51:48 INFO - 'LANG': 'en_US.UTF-8', 11:51:48 INFO - 'LANGUAGE': 'en_US:en', 11:51:48 INFO - 'LOGNAME': 'cltbld', 11:51:48 INFO - 'MAIL': '/var/mail/cltbld', 11:51:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:51:48 INFO - 'MOZ_NO_REMOTE': '1', 11:51:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:51:48 INFO - 'NO_EM_RESTART': '1', 11:51:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:51:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:51:48 INFO - 'PWD': '/builds/slave/test', 11:51:48 INFO - 'SHELL': '/bin/bash', 11:51:48 INFO - 'SHLVL': '1', 11:51:48 INFO - 'TERM': 'linux', 11:51:48 INFO - 'TMOUT': '86400', 11:51:48 INFO - 'USER': 'cltbld', 11:51:48 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1505760485.880801-1588600159', 11:51:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:51:48 INFO - '_': '/tools/buildbot/bin/python'} 11:51:50 INFO - Ignoring indexes: http://pypi.python.org/simple/ 11:51:50 INFO - Downloading/unpacking pip>=1.5 11:51:50 INFO - Running setup.py egg_info for package pip 11:51:50 INFO - warning: no files found matching 'pip/cacert.pem' 11:51:50 INFO - warning: no files found matching '*.html' under directory 'docs' 11:51:50 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 11:51:50 INFO - no previously-included directories found matching 'docs/_build/_sources' 11:51:50 INFO - Installing collected packages: pip 11:51:50 INFO - Found existing installation: pip 1.1 11:51:50 INFO - Uninstalling pip: 11:51:50 INFO - Successfully uninstalled pip 11:51:50 INFO - Running setup.py install for pip 11:51:50 INFO - warning: no files found matching 'pip/cacert.pem' 11:51:50 INFO - warning: no files found matching '*.html' under directory 'docs' 11:51:50 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 11:51:50 INFO - no previously-included directories found matching 'docs/_build/_sources' 11:51:50 INFO - Installing pip script to /builds/slave/test/build/venv/bin 11:51:50 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 11:51:50 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 11:51:50 INFO - Successfully installed pip 11:51:50 INFO - Cleaning up... 11:51:50 INFO - Return code: 0 11:51:50 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:51: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')]} 11:51:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:51: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')]} 11:51:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:51: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', '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 0x111c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12e5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1488a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x148c090>, '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 0x148cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1486f90>, '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': '6d15e502d8e29d5d2676d664000001c3-1505760485.880801-1588600159', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:51: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', 'psutil>=3.1.1'] in /builds/slave/test/build 11:51: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 psutil>=3.1.1 11:51:50 INFO - Using env: {'DISPLAY': ':0', 11:51:50 INFO - 'HOME': '/home/cltbld', 11:51:50 INFO - 'LANG': 'en_US.UTF-8', 11:51:50 INFO - 'LANGUAGE': 'en_US:en', 11:51:50 INFO - 'LOGNAME': 'cltbld', 11:51:50 INFO - 'MAIL': '/var/mail/cltbld', 11:51:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:51:50 INFO - 'MOZ_NO_REMOTE': '1', 11:51:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:51:50 INFO - 'NO_EM_RESTART': '1', 11:51:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:51:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:51:50 INFO - 'PWD': '/builds/slave/test', 11:51:50 INFO - 'SHELL': '/bin/bash', 11:51:50 INFO - 'SHLVL': '1', 11:51:50 INFO - 'TERM': 'linux', 11:51:50 INFO - 'TMOUT': '86400', 11:51:50 INFO - 'USER': 'cltbld', 11:51:50 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1505760485.880801-1588600159', 11:51:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:51:50 INFO - '_': '/tools/buildbot/bin/python'} 11:51:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:51:50 INFO - Downloading/unpacking psutil>=3.1.1 11:51:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:51:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:51:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:51:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:51:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:51:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:51:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:51:53 INFO - Installing collected packages: psutil 11:51:53 INFO - Running setup.py install for psutil 11:51:53 INFO - building 'psutil._psutil_linux' extension 11:51: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 11:51:54 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 11:51:54 INFO - building 'psutil._psutil_posix' extension 11:51:54 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 11:51:54 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 11:51:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:51:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:51:54 INFO - Successfully installed psutil 11:51:54 INFO - Cleaning up... 11:51:54 INFO - Return code: 0 11:51:54 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:51:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:51:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:51:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:51:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:51:54 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 0x111c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12e5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1488a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x148c090>, '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 0x148cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1486f90>, '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': '6d15e502d8e29d5d2676d664000001c3-1505760485.880801-1588600159', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:51:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:51:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 11:51:54 INFO - Using env: {'DISPLAY': ':0', 11:51:54 INFO - 'HOME': '/home/cltbld', 11:51:54 INFO - 'LANG': 'en_US.UTF-8', 11:51:54 INFO - 'LANGUAGE': 'en_US:en', 11:51:54 INFO - 'LOGNAME': 'cltbld', 11:51:54 INFO - 'MAIL': '/var/mail/cltbld', 11:51:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:51:54 INFO - 'MOZ_NO_REMOTE': '1', 11:51:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:51:54 INFO - 'NO_EM_RESTART': '1', 11:51:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:51:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:51:54 INFO - 'PWD': '/builds/slave/test', 11:51:54 INFO - 'SHELL': '/bin/bash', 11:51:54 INFO - 'SHLVL': '1', 11:51:54 INFO - 'TERM': 'linux', 11:51:54 INFO - 'TMOUT': '86400', 11:51:54 INFO - 'USER': 'cltbld', 11:51:54 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1505760485.880801-1588600159', 11:51:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:51:54 INFO - '_': '/tools/buildbot/bin/python'} 11:51:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:51:54 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:51:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:51:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:51:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:51:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:51:55 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:51:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:51:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:51:55 INFO - Installing collected packages: mozsystemmonitor 11:51:55 INFO - Running setup.py install for mozsystemmonitor 11:51:55 INFO - Successfully installed mozsystemmonitor 11:51:55 INFO - Cleaning up... 11:51:55 INFO - Return code: 0 11:51:55 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:51:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:51:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:51:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:51:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:51: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 0x111c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12e5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1488a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x148c090>, '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 0x148cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1486f90>, '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': '6d15e502d8e29d5d2676d664000001c3-1505760485.880801-1588600159', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:51: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 11:51: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 11:51:55 INFO - Using env: {'DISPLAY': ':0', 11:51:55 INFO - 'HOME': '/home/cltbld', 11:51:55 INFO - 'LANG': 'en_US.UTF-8', 11:51:55 INFO - 'LANGUAGE': 'en_US:en', 11:51:55 INFO - 'LOGNAME': 'cltbld', 11:51:55 INFO - 'MAIL': '/var/mail/cltbld', 11:51:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:51:55 INFO - 'MOZ_NO_REMOTE': '1', 11:51:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:51:55 INFO - 'NO_EM_RESTART': '1', 11:51:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:51:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:51:55 INFO - 'PWD': '/builds/slave/test', 11:51:55 INFO - 'SHELL': '/bin/bash', 11:51:55 INFO - 'SHLVL': '1', 11:51:55 INFO - 'TERM': 'linux', 11:51:55 INFO - 'TMOUT': '86400', 11:51:55 INFO - 'USER': 'cltbld', 11:51:55 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1505760485.880801-1588600159', 11:51:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:51:55 INFO - '_': '/tools/buildbot/bin/python'} 11:51:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:51:56 INFO - Downloading/unpacking jsonschema==2.5.1 11:51: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 11:51: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 11:51: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 11:51: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 11:51:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:51:57 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:51:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:51:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:51:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:51:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:51:57 INFO - Downloading functools32-3.2.3-2.tar.gz 11:51:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:51:57 INFO - warning: no files found matching '*.txt' 11:51:57 INFO - no previously-included directories found matching 'build' 11:51:57 INFO - no previously-included directories found matching 'dist' 11:51:57 INFO - no previously-included directories found matching '.git*' 11:51:57 INFO - Installing collected packages: jsonschema, functools32 11:51:57 INFO - Running setup.py install for functools32 11:51:57 INFO - warning: no files found matching '*.txt' 11:51:57 INFO - no previously-included directories found matching 'build' 11:51:57 INFO - no previously-included directories found matching 'dist' 11:51:57 INFO - no previously-included directories found matching '.git*' 11:51:57 INFO - Successfully installed jsonschema functools32 11:51:57 INFO - Cleaning up... 11:51:57 INFO - Return code: 0 11:51:57 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:51:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:51:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:51:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:51:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:51:57 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 0x111c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12e5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1488a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x148c090>, '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 0x148cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1486f90>, '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': '6d15e502d8e29d5d2676d664000001c3-1505760485.880801-1588600159', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:51:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 11:51:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 11:51:57 INFO - Using env: {'DISPLAY': ':0', 11:51:57 INFO - 'HOME': '/home/cltbld', 11:51:57 INFO - 'LANG': 'en_US.UTF-8', 11:51:57 INFO - 'LANGUAGE': 'en_US:en', 11:51:57 INFO - 'LOGNAME': 'cltbld', 11:51:57 INFO - 'MAIL': '/var/mail/cltbld', 11:51:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:51:57 INFO - 'MOZ_NO_REMOTE': '1', 11:51:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:51:57 INFO - 'NO_EM_RESTART': '1', 11:51:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:51:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:51:57 INFO - 'PWD': '/builds/slave/test', 11:51:57 INFO - 'SHELL': '/bin/bash', 11:51:57 INFO - 'SHLVL': '1', 11:51:57 INFO - 'TERM': 'linux', 11:51:57 INFO - 'TMOUT': '86400', 11:51:57 INFO - 'USER': 'cltbld', 11:51:57 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1505760485.880801-1588600159', 11:51:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:51:57 INFO - '_': '/tools/buildbot/bin/python'} 11:51:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:51:57 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:51:57 INFO - Cleaning up... 11:51:57 INFO - Return code: 0 11:51:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:51:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:51:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:51:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:51:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:51:57 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 0x111c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12e5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1488a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x148c090>, '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 0x148cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1486f90>, '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': '6d15e502d8e29d5d2676d664000001c3-1505760485.880801-1588600159', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:51:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:51:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:51:57 INFO - Using env: {'DISPLAY': ':0', 11:51:57 INFO - 'HOME': '/home/cltbld', 11:51:57 INFO - 'LANG': 'en_US.UTF-8', 11:51:57 INFO - 'LANGUAGE': 'en_US:en', 11:51:57 INFO - 'LOGNAME': 'cltbld', 11:51:57 INFO - 'MAIL': '/var/mail/cltbld', 11:51:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:51:57 INFO - 'MOZ_NO_REMOTE': '1', 11:51:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:51:57 INFO - 'NO_EM_RESTART': '1', 11:51:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:51:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:51:57 INFO - 'PWD': '/builds/slave/test', 11:51:57 INFO - 'SHELL': '/bin/bash', 11:51:57 INFO - 'SHLVL': '1', 11:51:57 INFO - 'TERM': 'linux', 11:51:57 INFO - 'TMOUT': '86400', 11:51:57 INFO - 'USER': 'cltbld', 11:51:57 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1505760485.880801-1588600159', 11:51:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:51:57 INFO - '_': '/tools/buildbot/bin/python'} 11:51:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:51:58 INFO - Downloading/unpacking blobuploader==1.2.4 11:51: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 11:51: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 11:51: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 11:51: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 11:51:59 INFO - Downloading blobuploader-1.2.4.tar.gz 11:51:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:51:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:51: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 11:51: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 11:51: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 11:51: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 11:51:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:51:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:51: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 11:51: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 11:51: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 11:51: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 11:51:59 INFO - Downloading docopt-0.6.1.tar.gz 11:51:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:51:59 INFO - Installing collected packages: blobuploader, requests, docopt 11:51:59 INFO - Running setup.py install for blobuploader 11:51:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:51:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:51:59 INFO - Running setup.py install for requests 11:52:00 INFO - Running setup.py install for docopt 11:52:00 INFO - Successfully installed blobuploader requests docopt 11:52:00 INFO - Cleaning up... 11:52:00 INFO - Return code: 0 11:52:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:52: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')]} 11:52:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:52: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')]} 11:52:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:52: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 0x111c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12e5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1488a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x148c090>, '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 0x148cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1486f90>, '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': '6d15e502d8e29d5d2676d664000001c3-1505760485.880801-1588600159', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:52: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 11:52: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 11:52:00 INFO - Using env: {'DISPLAY': ':0', 11:52:00 INFO - 'HOME': '/home/cltbld', 11:52:00 INFO - 'LANG': 'en_US.UTF-8', 11:52:00 INFO - 'LANGUAGE': 'en_US:en', 11:52:00 INFO - 'LOGNAME': 'cltbld', 11:52:00 INFO - 'MAIL': '/var/mail/cltbld', 11:52:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:52:00 INFO - 'MOZ_NO_REMOTE': '1', 11:52:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:52:00 INFO - 'NO_EM_RESTART': '1', 11:52:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:52:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:52:00 INFO - 'PWD': '/builds/slave/test', 11:52:00 INFO - 'SHELL': '/bin/bash', 11:52:00 INFO - 'SHLVL': '1', 11:52:00 INFO - 'TERM': 'linux', 11:52:00 INFO - 'TMOUT': '86400', 11:52:00 INFO - 'USER': 'cltbld', 11:52:00 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1505760485.880801-1588600159', 11:52:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:52:00 INFO - '_': '/tools/buildbot/bin/python'} 11:52:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:52:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:52:00 INFO - Running setup.py (path:/tmp/pip-8qstM9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:52:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:52:00 INFO - Running setup.py (path:/tmp/pip-26O_En-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:52:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:52:00 INFO - Running setup.py (path:/tmp/pip-5n7M2j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:52:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:52:00 INFO - Running setup.py (path:/tmp/pip-_dlStc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:52:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:52:00 INFO - Running setup.py (path:/tmp/pip-5u3AuN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:52:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:52:00 INFO - Running setup.py (path:/tmp/pip-Be08KP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:52:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:52:01 INFO - Running setup.py (path:/tmp/pip-fm35Hu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:52:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:52:01 INFO - Running setup.py (path:/tmp/pip-Wzj52A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:52:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:52:01 INFO - Running setup.py (path:/tmp/pip-2hRDsu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:52:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:52:01 INFO - Running setup.py (path:/tmp/pip-ew091x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:52:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:52:01 INFO - Running setup.py (path:/tmp/pip-DQedAy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:52:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:52:01 INFO - Running setup.py (path:/tmp/pip-fLIBOV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:52:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:52:01 INFO - Running setup.py (path:/tmp/pip-Ewjasi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:52:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:52:01 INFO - Running setup.py (path:/tmp/pip-xPMIaP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:52:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:52:01 INFO - Running setup.py (path:/tmp/pip-s2hICX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:52:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:52:01 INFO - Running setup.py (path:/tmp/pip-Erk0vL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:52:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:52:01 INFO - Running setup.py (path:/tmp/pip-QXkiD5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:52:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:52:01 INFO - Running setup.py install for manifestparser 11:52:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:52:01 INFO - Running setup.py install for mozcrash 11:52:01 INFO - Running setup.py install for mozdebug 11:52:02 INFO - Running setup.py install for mozdevice 11:52:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:52:02 INFO - Running setup.py install for mozfile 11:52:02 INFO - Running setup.py install for mozhttpd 11:52:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:52:02 INFO - Running setup.py install for mozinfo 11:52:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:52:02 INFO - Running setup.py install for mozInstall 11:52:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:52:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:52:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:52:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:52:02 INFO - Running setup.py install for mozleak 11:52:02 INFO - Running setup.py install for mozlog 11:52:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:52:02 INFO - Running setup.py install for moznetwork 11:52:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:52:02 INFO - Running setup.py install for mozprocess 11:52:03 INFO - Running setup.py install for mozprofile 11:52:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:52:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:52:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:52:03 INFO - Running setup.py install for mozrunner 11:52:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:52:03 INFO - Running setup.py install for mozscreenshot 11:52:03 INFO - Running setup.py install for moztest 11:52:03 INFO - Running setup.py install for mozversion 11:52:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:52:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:52:03 INFO - Cleaning up... 11:52:03 INFO - Return code: 0 11:52:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:52:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:52:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:52:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:52:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:52:03 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 0x111c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12e5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1488a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x148c090>, '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 0x148cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1486f90>, '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': '6d15e502d8e29d5d2676d664000001c3-1505760485.880801-1588600159', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:52:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:52:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:52:03 INFO - Using env: {'DISPLAY': ':0', 11:52:03 INFO - 'HOME': '/home/cltbld', 11:52:03 INFO - 'LANG': 'en_US.UTF-8', 11:52:03 INFO - 'LANGUAGE': 'en_US:en', 11:52:03 INFO - 'LOGNAME': 'cltbld', 11:52:03 INFO - 'MAIL': '/var/mail/cltbld', 11:52:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:52:03 INFO - 'MOZ_NO_REMOTE': '1', 11:52:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:52:03 INFO - 'NO_EM_RESTART': '1', 11:52:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:52:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:52:03 INFO - 'PWD': '/builds/slave/test', 11:52:03 INFO - 'SHELL': '/bin/bash', 11:52:03 INFO - 'SHLVL': '1', 11:52:03 INFO - 'TERM': 'linux', 11:52:03 INFO - 'TMOUT': '86400', 11:52:03 INFO - 'USER': 'cltbld', 11:52:03 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1505760485.880801-1588600159', 11:52:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:52:03 INFO - '_': '/tools/buildbot/bin/python'} 11:52:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:52:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:52:03 INFO - Running setup.py (path:/tmp/pip-Uto2RC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:52:03 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 11:52:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:52:03 INFO - Running setup.py (path:/tmp/pip-PFQe8t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:52:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:52:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:52:03 INFO - Running setup.py (path:/tmp/pip-6Nc1iC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:52: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)) 11:52:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:52:04 INFO - Running setup.py (path:/tmp/pip-FNgGj0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:52: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)) 11:52:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:52:04 INFO - Running setup.py (path:/tmp/pip-MIH3AD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:52: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)) 11:52:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:52:04 INFO - Running setup.py (path:/tmp/pip-Y7RSG6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:52: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)) 11:52:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:52:04 INFO - Running setup.py (path:/tmp/pip-DhMirt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:52: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)) 11:52:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:52:04 INFO - Running setup.py (path:/tmp/pip-wfdjwc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:52: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)) 11:52:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:52:04 INFO - Running setup.py (path:/tmp/pip-QNd2tG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:52: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)) 11:52:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:52:04 INFO - Running setup.py (path:/tmp/pip-s7fj3k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:52:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:52:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:52:04 INFO - Running setup.py (path:/tmp/pip-qYiNhT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:52:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 11:52:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:52:04 INFO - Running setup.py (path:/tmp/pip-EYzRXV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:52:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 11:52:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:52:04 INFO - Running setup.py (path:/tmp/pip-kU4hIo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:52:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 11:52:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:52:04 INFO - Running setup.py (path:/tmp/pip-NQzW2H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:52:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 11:52:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:52:04 INFO - Running setup.py (path:/tmp/pip-XLtDy8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:52:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 11:52:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:52:04 INFO - Running setup.py (path:/tmp/pip-5KG6FY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:52:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 11:52:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:52:04 INFO - Running setup.py (path:/tmp/pip-RwbPuG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:52: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)) 11:52: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)) 11:52: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)) 11:52: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)) 11:52: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)) 11:52: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)) 11:52: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)) 11:52:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:52: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 11:52: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 11:52: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 11:52: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 11:52:06 INFO - Downloading blessings-1.6.tar.gz 11:52:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:52:06 INFO - Installing collected packages: blessings 11:52:06 INFO - Running setup.py install for blessings 11:52:06 INFO - Successfully installed blessings 11:52:06 INFO - Cleaning up... 11:52:06 INFO - Return code: 0 11:52:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:52:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:52:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:52:06 INFO - Reading from file tmpfile_stdout 11:52:06 INFO - Current package versions: 11:52:06 INFO - argparse == 1.2.1 11:52:06 INFO - blessings == 1.6 11:52:06 INFO - blobuploader == 1.2.4 11:52:06 INFO - docopt == 0.6.1 11:52:06 INFO - functools32 == 3.2.3-2 11:52:06 INFO - jsonschema == 2.5.1 11:52:06 INFO - manifestparser == 1.1 11:52:06 INFO - mozInstall == 1.13 11:52:06 INFO - mozcrash == 1.0 11:52:06 INFO - mozdebug == 0.1 11:52:06 INFO - mozdevice == 0.51 11:52:06 INFO - mozfile == 1.2 11:52:06 INFO - mozhttpd == 0.7 11:52:06 INFO - mozinfo == 0.10 11:52:06 INFO - mozleak == 0.1 11:52:06 INFO - mozlog == 3.5 11:52:06 INFO - moznetwork == 0.27 11:52:06 INFO - mozprocess == 0.25 11:52:06 INFO - mozprofile == 0.28 11:52:06 INFO - mozrunner == 6.13 11:52:06 INFO - mozscreenshot == 0.1 11:52:06 INFO - mozsystemmonitor == 0.3 11:52:06 INFO - moztest == 0.8 11:52:06 INFO - mozversion == 1.4 11:52:06 INFO - psutil == 3.1.1 11:52:06 INFO - requests == 1.2.3 11:52:06 INFO - wsgiref == 0.1.2 11:52:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:52:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:52:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:52:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:52:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:52:06 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 0x111c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12e5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1488a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x148c090>, '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 0x148cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1486f90>, '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': '6d15e502d8e29d5d2676d664000001c3-1505760485.880801-1588600159', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:52:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 11:52:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:52:06 INFO - Using env: {'DISPLAY': ':0', 11:52:06 INFO - 'HOME': '/home/cltbld', 11:52:06 INFO - 'LANG': 'en_US.UTF-8', 11:52:06 INFO - 'LANGUAGE': 'en_US:en', 11:52:06 INFO - 'LOGNAME': 'cltbld', 11:52:06 INFO - 'MAIL': '/var/mail/cltbld', 11:52:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:52:06 INFO - 'MOZ_NO_REMOTE': '1', 11:52:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:52:06 INFO - 'NO_EM_RESTART': '1', 11:52:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:52:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:52:06 INFO - 'PWD': '/builds/slave/test', 11:52:06 INFO - 'SHELL': '/bin/bash', 11:52:06 INFO - 'SHLVL': '1', 11:52:06 INFO - 'TERM': 'linux', 11:52:06 INFO - 'TMOUT': '86400', 11:52:06 INFO - 'USER': 'cltbld', 11:52:06 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1505760485.880801-1588600159', 11:52:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:52:06 INFO - '_': '/tools/buildbot/bin/python'} 11:52:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:52:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:52:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 11:52:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 11:52:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:52:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 11:52:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 11:52:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 11:52:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 11:52:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 11:52:06 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 11:52:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:52:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:52:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:52:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:52:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 11:52: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)) 11:52: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)) 11:52:08 INFO - Installing collected packages: simplejson 11:52:08 INFO - Running setup.py install for simplejson 11:52:08 INFO - building 'simplejson._speedups' extension 11:52: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 11:52:08 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 11:52:09 INFO - Successfully installed simplejson 11:52:09 INFO - Cleaning up... 11:52:09 INFO - Return code: 0 11:52:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:52: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')]} 11:52:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:52: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')]} 11:52:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:52: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 0x111c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12e5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1488a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x148c090>, '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 0x148cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1486f90>, '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': '6d15e502d8e29d5d2676d664000001c3-1505760485.880801-1588600159', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:52: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 11:52: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 11:52:09 INFO - Using env: {'DISPLAY': ':0', 11:52:09 INFO - 'HOME': '/home/cltbld', 11:52:09 INFO - 'LANG': 'en_US.UTF-8', 11:52:09 INFO - 'LANGUAGE': 'en_US:en', 11:52:09 INFO - 'LOGNAME': 'cltbld', 11:52:09 INFO - 'MAIL': '/var/mail/cltbld', 11:52:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:52:09 INFO - 'MOZ_NO_REMOTE': '1', 11:52:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:52:09 INFO - 'NO_EM_RESTART': '1', 11:52:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:52:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:52:09 INFO - 'PWD': '/builds/slave/test', 11:52:09 INFO - 'SHELL': '/bin/bash', 11:52:09 INFO - 'SHLVL': '1', 11:52:09 INFO - 'TERM': 'linux', 11:52:09 INFO - 'TMOUT': '86400', 11:52:09 INFO - 'USER': 'cltbld', 11:52:09 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1505760485.880801-1588600159', 11:52:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:52:09 INFO - '_': '/tools/buildbot/bin/python'} 11:52:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:52:09 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:52:09 INFO - Cleaning up... 11:52:09 INFO - Return code: 0 11:52:09 INFO - Running post-action listener: _resource_record_post_action 11:52:09 INFO - Running post-action listener: _start_resource_monitoring 11:52:09 INFO - Starting resource monitoring. 11:52:09 INFO - [mozharness: 2017-09-18 18:52:09.362403Z] Finished create-virtualenv step (success) 11:52:09 INFO - [mozharness: 2017-09-18 18:52:09.363427Z] Running install step. 11:52:09 INFO - Running pre-action listener: _resource_record_pre_action 11:52:09 INFO - Running main action method: install 11:52:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:52:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:52:09 INFO - Reading from file tmpfile_stdout 11:52:09 INFO - Detecting whether we're running mozinstall >=1.0... 11:52:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:52:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:52:09 INFO - Reading from file tmpfile_stdout 11:52:09 INFO - Output received: 11:52:09 INFO - Usage: mozinstall [options] installer 11:52:09 INFO - Options: 11:52:09 INFO - -h, --help show this help message and exit 11:52:09 INFO - -d DEST, --destination=DEST 11:52:09 INFO - Directory to install application into. [default: 11:52:09 INFO - "/builds/slave/test"] 11:52:09 INFO - --app=APP Application being installed. [default: firefox] 11:52:09 INFO - mkdir: /builds/slave/test/build/application 11:52:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:52:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 11:52:27 INFO - Reading from file tmpfile_stdout 11:52:27 INFO - Output received: 11:52:27 INFO - /builds/slave/test/build/application/firefox/firefox 11:52:27 INFO - Running post-action listener: _resource_record_post_action 11:52:27 INFO - [mozharness: 2017-09-18 18:52:27.360119Z] Finished install step (success) 11:52:27 INFO - [mozharness: 2017-09-18 18:52:27.360371Z] Running setup-mitmproxy step. 11:52:27 INFO - Running pre-action listener: _resource_record_pre_action 11:52:27 INFO - Running main action method: setup_mitmproxy 11:52:27 INFO - Skipping: mitmproxy is not required 11:52:27 INFO - Running post-action listener: _resource_record_post_action 11:52:27 INFO - [mozharness: 2017-09-18 18:52:27.361585Z] Finished setup-mitmproxy step (success) 11:52:27 INFO - [mozharness: 2017-09-18 18:52:27.361805Z] Running run-tests step. 11:52:27 INFO - Running pre-action listener: _resource_record_pre_action 11:52:27 INFO - Running pre-action listener: _set_gcov_prefix 11:52:27 INFO - Running main action method: run_tests 11:52:27 WARNING - Try message not found. 11:52:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:52:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:52:27 INFO - Python 2.7.3 11:52:27 INFO - Return code: 0 11:52:27 INFO - grabbing minidump binary from tooltool 11:52: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')]} 11:52: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 0x148c090>, '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 0x148cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1486f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:52: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 11:52: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 11:52: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 11:52:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:52:27 INFO - Return code: 0 11:52:27 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:52:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:52:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:52:27 INFO - ENV: RUST_BACKTRACE is now full 11:52:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:52:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:52: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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SCsIEorPRfqct5c1S2alwA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 11:52: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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/SCsIEorPRfqct5c1S2alwA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-023 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 11:52:27 INFO - Using env: {'DISPLAY': ':0', 11:52:27 INFO - 'HOME': '/home/cltbld', 11:52:27 INFO - 'LANG': 'en_US.UTF-8', 11:52:27 INFO - 'LANGUAGE': 'en_US:en', 11:52:27 INFO - 'LOGNAME': 'cltbld', 11:52:27 INFO - 'MAIL': '/var/mail/cltbld', 11:52:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:52:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:52:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:52:27 INFO - 'MOZ_NO_REMOTE': '1', 11:52:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:52:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:52:27 INFO - 'NO_EM_RESTART': '1', 11:52:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:52:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:52:27 INFO - 'PWD': '/builds/slave/test', 11:52:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:52:27 INFO - 'RUST_BACKTRACE': 'full', 11:52:27 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:52:27 INFO - 'SHELL': '/bin/bash', 11:52:27 INFO - 'SHLVL': '1', 11:52:27 INFO - 'TERM': 'linux', 11:52:27 INFO - 'TMOUT': '86400', 11:52:27 INFO - 'USER': 'cltbld', 11:52:27 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1505760485.880801-1588600159', 11:52:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:52:27 INFO - '_': '/tools/buildbot/bin/python'} 11:52:27 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SCsIEorPRfqct5c1S2alwA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 11:52:28 INFO - mozversion application_buildid: 20170918173522 11:52:28 INFO - mozversion application_changeset: 42151fcd6cfc216d147730d0f2c6a2acd52d22fd 11:52:28 INFO - mozversion application_display_name: Nightly 11:52:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:52:28 INFO - mozversion application_name: Firefox 11:52:28 INFO - mozversion application_remotingname: firefox 11:52:28 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 11:52:28 INFO - mozversion application_vendor: Mozilla 11:52:28 INFO - mozversion application_version: 57.0a1 11:52:28 INFO - mozversion platform_buildid: 20170918173522 11:52:28 INFO - mozversion platform_changeset: 42151fcd6cfc216d147730d0f2c6a2acd52d22fd 11:52:28 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 11:52:28 INFO - mozversion platform_version: 57.0a1 11:52:28 INFO - using testdate: 1505760748 11:52:28 INFO - actual date: 1505760748 11:52:28 INFO - starting webserver on 'localhost:46949' 11:52:28 INFO - SUITE-START | Running 2 tests 11:52:28 INFO - TEST-START | dromaeo_css 11:52:28 INFO - Initialising browser for dromaeo_css test... 11:52:28 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:46949/getInfo.html -profile /tmp/tmpLMyKL3/profile 11:52:28 INFO - TEST-INFO | started process 3583 (/builds/slave/test/build/application/firefox/firefox http://localhost:46949/getInfo.html) 11:52:35 INFO - TEST-INFO | 3583: exit 0 11:52:35 INFO - Browser initialized. 11:52:35 INFO - Running cycle 1/1 for dromaeo_css test... 11:52:35 INFO - Using env: {'DISPLAY': ':0', 11:52:35 INFO - 'HOME': '/home/cltbld', 11:52:35 INFO - 'JSGC_DISABLE_POISONING': '1', 11:52:35 INFO - 'LANG': 'en_US.UTF-8', 11:52:35 INFO - 'LANGUAGE': 'en_US:en', 11:52:35 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 11:52:35 INFO - 'LOGNAME': 'cltbld', 11:52:35 INFO - 'MAIL': '/var/mail/cltbld', 11:52:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:52:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:52:35 INFO - 'MOZ_CRASHREPORTER': '1', 11:52:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:52:35 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 11:52:35 INFO - 'MOZ_NO_REMOTE': '1', 11:52:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:52:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:52:35 INFO - 'NO_EM_RESTART': '1', 11:52:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:52:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:52:35 INFO - 'PWD': '/builds/slave/test', 11:52:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:52:35 INFO - 'RUST_BACKTRACE': 'full', 11:52:35 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:52:35 INFO - 'SHELL': '/bin/bash', 11:52:35 INFO - 'SHLVL': '1', 11:52:35 INFO - 'TERM': 'linux', 11:52:35 INFO - 'TMOUT': '86400', 11:52:35 INFO - 'USER': 'cltbld', 11:52:35 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1505760485.880801-1588600159', 11:52:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:52:35 INFO - '_': '/tools/buildbot/bin/python'} 11:52:35 INFO - TEST-INFO | started process 3822 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLMyKL3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:52:36 INFO - PID 3822 | 11:52:36 INFO - PID 3822 | (/builds/slave/test/build/application/firefox/firefox:3871): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:52:36 INFO - PID 3822 | 11:52:47 INFO - PID 3822 | RSS: Main: 147816448 11:52:47 INFO - PID 3822 | 11:55:44 INFO - PID 3822 | Cycle 1(1): loaded http://localhost:46949/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46949/tests/dromaeo/cssquery-ext.html) 11:55:45 INFO - PID 3822 | RSS: Main: 148549632 11:55:45 INFO - PID 3822 | 11:58:47 INFO - PID 3822 | Cycle 1(1): loaded http://localhost:46949/tests/dromaeo/cssquery-ext.html (next: http://localhost:46949/tests/dromaeo/cssquery-jquery.html) 11:58:48 INFO - PID 3822 | RSS: Main: 148627456 11:58:48 INFO - PID 3822 | 12:01:49 INFO - PID 3822 | Cycle 1(1): loaded http://localhost:46949/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46949/tests/dromaeo/cssquery-mootools.html) 12:01:50 INFO - PID 3822 | RSS: Main: 150945792 12:01:50 INFO - PID 3822 | 12:04:51 INFO - PID 3822 | Cycle 1(1): loaded http://localhost:46949/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46949/tests/dromaeo/cssquery-prototype.html) 12:04:52 INFO - PID 3822 | RSS: Main: 149487616 12:04:52 INFO - PID 3822 | 12:07:55 INFO - PID 3822 | Cycle 1(1): loaded http://localhost:46949/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46949/tests/dromaeo/cssquery-yui.html) 12:07:56 INFO - PID 3822 | RSS: Main: 150355968 12:07:56 INFO - PID 3822 | 12:10:57 INFO - PID 3822 | Cycle 1(1): loaded http://localhost:46949/tests/dromaeo/cssquery-yui.html (next: http://localhost:46949/tests/dromaeo/cssquery-dojo.html) 12:10:57 INFO - PID 3822 | RSS: Main: 153133056 12:10:57 INFO - PID 3822 | 12:10:57 INFO - PID 3822 | __start_tp_report 12:10:57 INFO - PID 3822 | _x_x_mozilla_page_load 12:10:57 INFO - PID 3822 | _x_x_mozilla_page_load_details 12:10:57 INFO - PID 3822 | |i|pagename|runs| 12:10:57 INFO - PID 3822 | |0;dojo.html;3848.5381754189493;3855.8264878080486;3858.1512067345175;3878.0692633767885;3887.105965627907;6143.139960405541;6150.354212807658;6197.1324014637985;6224.097505861648;6289.685515724218;6221.377862213776;6224.066390041496;6289.842753931142;6317.715702793374;6325.304216536178;5596.384397716269;5602.299712535933;5645.774169033254;5679.886402271952;5722.141678748179;5534.778608855661;5620.662760234379;5648.830535083954;5662.490375866171;5692.971535142318;5527.55779537636;5542.4457554244655;5580.63725857822;5618.915716264239;5623.662580245178;5547.750351234164;5572.331320241597;5615.9157612635845;5618.073017952033;5620.803271885465;5550.69471179085;5573.554115670737;5579.6652200868075;5627.774889004435;5648.8870222595315;6149.5080393568405;6223.190985171898;6230.719617617173;6313.368663133696;6315.115883776275;6715.160604924385;6717.899231511531;6745.1905771307265;6761.0196521504595;6878.793636190922;6784.151981002375;6850.349216824394;6868.965655171693;6891.689873955684;6900.068490753734;6249.781257656005;6264.279607845065;6287.559870808999;6348.269948955883;6349.714262858229;6923.099997000358;6973.058637083929;7008.894866577006;7023.964880175567;7042.190148132928;6654;6655.6339401332425;6658.86682266352;6731.360520750521;6755.966220168966;6654.800355989328;6710.664466776641;6777.9661101695165;6787.932120678829;6840.144981877265;6725.428338591177;6736.360045795642;6769.424598909148;6823.454123670094;6823.727050917908;6740.258571557125;6758.83102922421;6827.795166145023;6838.965805170942;6839.829004274833;4800.66395352329;4843.055604157226;4856.757162141949;4864.756762161877;4928.162212423897;4413.558644135561;4418.116376724668;4425.203463376559;4440.134173836135;4476.529964353761;6144.477719393813;6214.37856214384;6226.283977342573;6227.595206311576;6234.781782637586;6557.934420655828;6719.361660642231;6740.123783908159;6748.055272261888;6749.831254218684;6069.757209711651;6180;6226.377362263828;6227.972384556588;6262.060690896402;5444.50999410055;5463.262459567987;5463.3717122530625;5465.152901300305;5465.59008074396;6974;6992.1259842519685;6993.195782484978;7077.858442831114;7079.89380159298;6765.594064356154;6787.457003439614;6795.422389096784;6800.047993280945;6806.319368063154;6948.583085014915;6980.720771169096;6980.755673551402;7085.326893945067;7087.043249161297;6530.608163510205;6696.19645642526;6704.698288577123;6717.596944183169;6791.93208067913;6863.691133898887;6868.107146070979;6870.519063665495;6876.587404755531;6883.8967415487805;6606.9008964866525;6614.140161778938;6619.966900165468;6621.33786621334;6626.436752875867;6544.6727663617585;6612.173478315211;6630.801075967729;6632.767853125118;6657.600543967377;6485.124508191334;6485.416312531895;6491.675416229265;6577.835554111186;6585.111010013587;6566.737330506726;6598.736050558116;6605.768798092236;6620.5034622402545;6626.701798418986;6393.680315984275;6448.613083215022;6457.806265812033;6466.256380516301;6468.8059358219325 12:10:57 INFO - PID 3822 | |1;ext.html;938.6292414496274;942.5569982108415;976.1166144639101;999.2855108597352;1003.1924300937746;41365.37951930724;42057.7897110514;42227;42308.57691423085;42397.36403953943;42167.36748948768;42281.36577951333;42860.35709464361;42865;42883.78558107213;7967.880481792778;8066.798330041766;8135.308498777581;8138.226868447488;8139.145389734052;7982.2017798220295;8046.155153708864;8097.716579919704;8098.473599216032;8101.6354264058255;8106.351491880665;8114.594270286491;8115.75652730419;8124.6750129994725;8141.674333026672;8056.436049476539;8072.071711753165;8098.676052957874;8100.270975612194;8106.270435660819;7978.6409611567615;8008.159143289929;8012.8397432051615;8033.156518565584;8074.273315401642;39683.60316396857;39780;39809.203815923516;39839.40240896389;39927;3746.4193050077283;3755.0800053986677;3757.0231739747865;3786.7917264550438;3793.6965042796787;32340.35319293601;32628.184295392566;32685.6731432685;32715.6728432715;32760.83619581887;5294.549963253128;5369.0604144274985;5467.6719396835915;5507.972460137714;5595.860103497404;207616;209960;211115;211779;212084;49053.75473122683;49098.263526047136;49148.75425622921;49413;52277.7386113067;56108.43891561032;56303.43696562982;56329.155062674094;56360.15459768107;56387.718061410254;15430.691386172213;15533.533993980198;15566;15809.841901580838;16062.43781467643;12629.305388203737;12778.680532986564;12787;12787.232766033881;12799.744005120032;15277.159756213516;15395;15413.383464661289;15472.5358239253;15532.223388830513;6017.2779266488305;6051.848703782441;6075.726592303268;6151.72317245716;6209.348018458088;1083.9024487796137;1096.0957210301533;1102.5204036244259;1108.2353176308322;1126.4480404601686;25174.24477265685;25175.370615734388;25177.496450070896;25403.74596254014;25434.491310173693;1207.1851500237306;1207.927524348542;1208.4501551793912;1209.401346333553;1209.8608660004213;13034;13233.669158271121;13237.536686216128;13616.046876718534;13692.794608080887;282405;284597;286423;286488;286608;47012;47220.5277947223;47288.763556182;47443.28835067477;53874.7306263474;1526.6870291590196;1526.8778497720157;1535.117307548142;1551.8680912122595;1558.2987655554819;29698.257543561584;29832.85083574568;30428;30545.694543054284;30747;38749;38760.418593720555;38911;38955;39044.6095539041;217571;217849;219913;220231;220347;35181.82409087938;36121.277574447835;36455.27089458249;36714.265714685025;36730;43101.7844910786;44698.77650611726;44750.3287450695;44994;45111.54888451073;32992.67007329896;33106.66893331036;33595.83202084072;33606.32787344288;33621.49567756535;32161.839190803898;32617.34765304728;33054.17364565905;33179;33552.664473354955;38366.616333836304;38587.6141238584;38820.80589597034;38875.222495549366;39047.80476097601;31885.68114318827;32139;32217.51673724849;32294.83852580722;32692.83653581717;24549;24588.508229834944;24788;25170.874145629154;25308.49383012366 12:10:57 INFO - PID 3822 | |2;jquery.html;595.9481515125802;602.7829981206762;608.1668114682885;609.2719200555335;631.5168895794718;22833.08667653294;23702.76297237027;23740.88129559352;23835.046598136054;23841.880790596024;23750.64374034391;25547.872260638716;25776;25804.225873223833;25810;6567.474602031838;6685.565438246523;6693.129893113888;6712.228093769206;6728.966355168217;6372.713227904732;6615.768448104317;6665.266820649725;6677.966610166966;6679.198496180441;6566.63883486408;6610.173728283965;6615.702293396808;6619.735210591571;6625.46996240302;6576.868462630745;6612.14042174519;6617.404433600975;6625.701843417058;6626;6167.259928808572;6167.938320616781;6168.8766224675255;6197.690115494207;6211;28798.280042998882;29171.416571668447;29743.851280743675;29759;29768.40463190746;2194.3965409512352;2212.269950916194;2212.4800671842104;2213.247495851402;2213.9778602213933;20006.69989950152;20479.69280460794;20517;20533.178672853068;20536.486587835276;2515.1825656661476;2517.9874100629563;2586.6120081987665;2592.857392843393;2606.9869650651626;132583;137722;137753.31123344318;144428;151204.2439787805;15484.922575387276;15971.440999565191;16081.195940202942;16165.515034548982;16307.673846523241;24659.383515412257;24901.5019699605;24990.250292491255;25011;25015.124470643805;10352.585896564204;10358.482075896174;10532.684019479428;10615.337708490713;10616.25686201974;9369.484678342757;9419.764505887271;9430.90569094314;9523.57143928525;9639.228861691048;9427.62289508412;9661.661841835503;9714.708558743248;9723;9987.250956178315;2728.5361488546996;2749.845065072674;2827.3073097091346;2855.7858160638034;2942.1614839770564;1051.8527406163143;1074.5272080284649;1076.574752972587;1081.1404933078222;1082.3884505254664;20723;20973.161073556887;21235.575288494143;21239.89380053121;21740.56518869614;1087.5921529426464;1117.5473933057124;1120.8823073577157;1131.1516362727955;1147.1167201254987;11640.301581905112;11779.175457718049;11921.691339508645;11975.263586780042;11976.53267235683;563839;571468;577120;582665;582726;126574.36712816377;131899;134409.3279533596;134572;135191;1203.0375699440413;1230.4585982167996;1231.8337024501757;1243.3161761031577;1248.3134276148264;18768.812311876707;18944.79018269932;18962.905185473985;19068.523286917938;19191.712124317866;61642.69178654078;62095.379046210764;62411;63175;64075.038874417856;80343.59828200821;80698.5965070171;81273.59363203382;81490.18509814826;81647.59176204081;15201.163935983626;15297.158656273567;15409.306581204097;15494.612634684223;15512.922435388202;23633.172838951243;23918.162864299666;24075.638865416684;24129.87935060384;24322.148724794548;19701.40895773129;19727.704084439032;19857.900710496357;19941.60116797685;19978.1009854554;15614.609634758768;16294.185290735653;16818.243179057215;17688.204030818903;17866.464006079837;19125;19477.51306217356;19610.313639022566;19614.705779413605;19629.11668974928;14868.553943381716;15064.548063558112;15078;15111.093334399971;15117.395304187708;19103.52241193981;19311.420657380302;19451.3192038278;19569.315073972342;19642.214311427382 12:10:57 INFO - PID 3822 | |3;mootools.html;1380.3926272440126;1420.7584710599203;1436.5187662133185;1442.7403067447863;1455.6579203887088;16083.83916160838;16761.83238167618;16772.496825095237;16788.58028549287;16800.663986720272;16582.917085414556;16613;16674.916625416856;16726.916365418187;16734.246958886848;2689.1260340389354;2811.05829547102;2812.4375124974986;2817.0703667789685;2817.8027538072342;2697.9190624281205;2761.9585706214425;2771.6119743235963;2777.4306267215175;2783.6242107315556;2770.1827960751625;2945.4698154332214;2950.985245073782;2951.74910132639;2951.970480295191;2826.6184065151147;2857.04289063162;2860.5423132298943;2873.870675819593;2898.2029941765973;2783.248522898826;2803.1170181392795;2813.9296517587018;2817.2534278416238;2832.3344014156655;15962.76055859163;15997.920010399874;16219.756703649455;16231.51305460838;16275.755863662054;8022.277994980422;8256.215659512336;8278.71024514139;8287.792805179859;8309.750707478785;5173.870653233662;5284.5772338212855;5322.547583455411;5449.237106805051;5560.86097847553;2054.5685406064745;2084.468460542552;2087.8747275163537;2089.4149638101358;2127.3936927975606;29803.403931921457;30056.098317050524;30171.69828301733;30190.54714179289;30229.244268893235;6771.119754431892;6795.864082718417;6894;6938.063361446241;6950.270221626757;18712.53218669544;18789.62420751577;18882;18885.43343699691;19031.904840475985;8014.118446970829;8235.094139644634;8248.54632995179;8253.422260441712;8256.545889976109;7208.315210055036;7262.527935684269;7315.378192853561;7323.267673232741;7329.560226386434;5354.170103633943;5428.9185662215095;5457.508824205841;5457.563394928476;5520.558355331564;1465.6116129225763;1509.2680050175657;1537.3696784318377;1611.6937781821416;1634.3707672546154;921.7925966657449;933.7618907178626;941.924646028316;942.7737343037621;945.385499425379;7867.443205616683;7980.920190798134;8051.758447246592;8056.677732890736;8063.919360806434;1051.1958351860833;1059.0786016165985;1062.044160255776;1064.435849000031;1066.7706443114769;4776.498467660915;4828.686135401258;4866.464688884291;4879.243717223836;4942.5304596063315;24191.516169676506;24416.755832441802;24895;25200.621990670155;25231.24306270815;25043.37391565189;25049.99800008016;25142.748572514407;25227.369315767253;25290.620640690406;11929.403529823649;12588.181768185223;12639.557615483414;12690.682732931751;12698.238105713872;8839.51382673959;8867.600957957036;8949.686760963335;8978.86531702038;8998.325125615474;20983.265585705038;20992.895035524725;21074.894625527388;21170.153193872688;21261.255856045584;21586.38102142314;21694.674579880997;21725.239616613344;21767.891160544095;22350.329490115324;12240.755184896074;12358.81461778092;12389.75220495603;12429;12461.065420093348;14247.501337453139;14395.856041439452;14403.207823569805;14421.855781442471;14424.06243594163;11535.826962595736;11537;11723.941380293043;11992.340421276913;12074.27554346742;12105.455254513745;12125.454354554242;12261.632151035483;12393.62819115428;12402.5659101931;11001.339919604849;11021.118310535297;11180.385078820744;11196.160287978597;11201.103911687209;7274.4907856449545;7294.562326260441;7334.193238743841;7361.006264154271;7372.889406659012;7632.542047477169;7693.307602315818;7705.768826935201;7732.420068494773;7829.921700782919 12:10:57 INFO - PID 3822 | |4;prototype.html;551.4457969740411;554.4095538251762;569.7607005057876;578.1876463568688;583.737318206807;6007.759689612416;6090.939090609093;6112.083187521868;6127.4791642710425;6237.875242495153;6049.788257410992;6092.147099406086;6112.327643959161;6140.692965351737;6205.379462053792;4901.65688401812;4945.109880221558;4956.7360323117555;4977.825776097838;4991.226359914201;4861.927071093936;4911;4923.82766603169;4955.702657840541;4998.175301075318;4934.185859333205;4951.55436010759;4979.45226025137;4983.526564976321;5009.223570346602;4914.459409464974;4920.360353154103;4955.653104282702;4957.752112394366;4966.081274964125;4474.2729306487745;4529.184746745585;4537.0925814837165;4572.588467037983;4591.1965406053805;6174.938250617526;6184.443400094013;6192.442680158762;6197.628142311431;6234.3453937336835;5797.710114494258;5837.482254613788;5851.824445266606;5879.617824841414;5890.499307558863;6488.870222595521;6529.771457998947;6601.405873471363;6622;6624.768133115366;4789.976050119762;4952.529509696573;4974.403071631427;5007.824726134604;5014.824481143179;6740.797776066725;6787.524873258873;6803.965980170117;6852.383285504278;6870.793876183722;5080.974595127001;5153;5167.6641018333685;5170.45710200431;5188.351456067991;5163.561097306771;5220.269162317279;5233.267342572043;5249.737513124329;5275.4724527547705;5758.856028599319;5773.769049238067;5815.9709201453725;5818.359980402152;5862.8534286642325;6595.670216489252;6619.437347825393;6674.699638516278;6700.698468568926;6705.597664140069;1790.97313540297;1804.7727545269342;1822.571695651521;1827.4426299978634;1830.158127261448;1205.8703038773854;1244.6079484962388;1275.4005617359826;1279.5969269680022;1281.8333616629966;6054.182685337423;6101.725422356005;6107.572469927062;6113.908291375633;6180.351063138396;6536.607803531803;6661.966690166615;6714.093597364391;6726;6736.46108311334;5941.792037278675;6056.909146362808;6133.699862551543;6156.846078847975;6198.6280823149855;3434.1414646338417;3464.263232046705;3513.4202856528386;3519.542459480251;3529.8235088245483;6875.656217189121;6907.240203577602;6932.410745086724;6947.930520694829;7004.2645522220455;6768.593884366954;6804.897926531106;6852;6870.793876183722;6909.239983601799;6912.412444942136;6918.169819621678;6919.619420931796;6996.475264355296;7014.473914456538;6630.336966303331;6663.233728121328;6664.266930637723;6680.9331906682255;6704.99425086241;6369.87260254783;6522.184726909137;6529.608223506605;6537.346265373615;6623.370779775913;6860;6898.827529311808;6948.652567371712;6951.7914462566205;6971.442284617117;5133.640645154804;5138.588912886886;5165.483451654804;5179.896402072013;5193.506616871391;6466.191726034246;6500.219973603198;6538.411542961157;6738.6967586459705;6751.797446076625;5958.046712525975;6474.741010359721;6526.608403495806;6528.510361722985;6532.150820393508;6351.555391122762;6455.48356131499;6482.855814929661;6499.38255865692;6516;6303.621782693053;6318.462930650946;6352.968235158794;6405.51958603116;6430.710618022294;6443.96778016107;6467.967660161858;6493.92850179734;6538.705758240795;6563.704633291418;6365.458935990493;6373.673609132726;6414.486841052798;6429.22849258092;6435.22777266731 12:10:57 INFO - PID 3822 | |5;yui.html;961.1253759079231;988.4069558265041;997.3816233934966;997.6907158780779;1028.336722813785;19058.90470547647;19320.903395483037;19545.315913943014;19567.510812229702;19568.21727130915;17424.30302787887;17662.558436039075;17895.463136105936;18101.547461313472;18256.452306430794;944.1974321826427;944.4710961861346;944.5324564340661;945.2060269373725;967.3470407474962;1036.595727666207;1046.0324200114862;1061.4162210784077;1064.8668916385452;1075.510642657589;1142.605800998654;1148.9885101148966;1151.2804497189256;1151.3667482884423;1151.3725019864194;1139.4986206069345;1144.6222746493638;1147.0078382199379;1147.2485521983115;1147.6270212181075;801;819.9467034642729;835.5863847395517;836.5942517878824;840.5083026429546;19932.900335498376;20372.796272037238;20473.18107275722;20511.2821051264;20519.48701282465;22703.318900433012;22838.086476540917;22972.4256893579;23236.53526929452;23291.417714557272;17690.646187076316;17732.20205090774;18023.27906883723;18040.548986275317;18182.727259091123;3963.128111815396;3980.323345031323;3989.840406383741;3993.3610622300293;4012.3580227163516;160643;162225;164821.3517864818;165049;165904;15429;15630.374785008473;16230.918845405933;16402.507924762278;17127.143642818057;28523.572146417406;28523.57214641782;28538.42923141567;28553;28573.28566785847;8764.605592748341;9051.502167380857;9072.319576031692;9079.636814527477;9080.545972701339;4243.2998555238655;4348.391225228471;4364.018095928391;4368.60682538573;4372.475302963665;5977.701114944235;6009.278886533644;6012;6048.334683184846;6072.51419886408;1132.0886686217673;1164.8485696859354;1173.2491205628405;1183.6863231243726;1184.8755880632582;674.9595024298558;690.5614934516618;695.857349243414;699.1679900917892;702.7891632510226;12422.875771242352;12821.166624169398;13278.004149688619;13825.585232443043;13842.82336001431;660.9768658096943;670.4033410264868;675.9864802703919;677.2178134254943;686;6225.564210505312;6277.52918531112;6304.306526282106;6314.968425157845;6327.019312006646;147024;147217;148301;149782;157085.21457392868;131775.3411232957;131955;132725;133114;141838;111984;114971.85028149778;115490;116724.41637791926;118257.40871295761;13016.15394999322;13047.478100876238;13286;13416.865831341953;13527.797083043566;53259.46740532545;53995.190072148165;54747;54904.450955489934;55263;69097.65451172712;79199.60400197962;92565.5371723137;95538.65614703452;99368;17321.220545075754;18227.726584101514;19021.23915043438;19265.13306901165;19298.7105193425;20027;20141.597168056265;20481.795182048583;21318.253861114787;22106.33680989573;19180.71228931595;19342.32301869428;20395.8980205098;20603.381898543066;20817.687734684296;17721.911390442965;17771.555711107325;17774.377896773552;18423.815761842747;19418.126184321456;17398.565035874206;17945;17956.19197136106;18502.259909604003;18533.351332703292;12290.446929887998;12695;13410.262435566137;13568.728625427239;13616.523421680193;14202.360893759598;14460.421583136978;14751.704965900837;14778;14826.1104333736 12:10:57 INFO - PID 3822 | __end_tp_report 12:10:57 INFO - PID 3822 | __start_cc_report 12:10:57 INFO - PID 3822 | _x_x_mozilla_cycle_collect,281 12:10:57 INFO - PID 3822 | __end_cc_report 12:10:57 INFO - PID 3822 | __startTimestamp1505761857798__endTimestamp 12:10:57 INFO - PID 3822 | 12:10:57 INFO - PID 3822 | ------- Summary: start ------- 12:10:57 INFO - PID 3822 | Number of tests: 6 12:10:57 INFO - PID 3822 | 12:10:57 INFO - PID 3822 | [#0] dojo.html Cycles:165 Average:6231.48 Median:6491.68 stddev:753.98 (11.6%) stddev-sans-first:732.75 12:10:57 INFO - PID 3822 | Values: 3848.5 3855.8 3858.2 3878.1 3887.1 6143.1 6150.4 6197.1 6224.1 6289.7 6221.4 6224.1 6289.8 6317.7 6325.3 5596.4 5602.3 5645.8 5679.9 5722.1 5534.8 5620.7 5648.8 5662.5 5693.0 5527.6 5542.4 5580.6 5618.9 5623.7 5547.8 5572.3 5615.9 5618.1 5620.8 5550.7 5573.6 5579.7 5627.8 5648.9 6149.5 6223.2 6230.7 6313.4 6315.1 6715.2 6717.9 6745.2 6761.0 6878.8 6784.2 6850.3 6869.0 6891.7 6900.1 6249.8 6264.3 6287.6 6348.3 6349.7 6923.1 6973.1 7008.9 7024.0 7042.2 6654.0 6655.6 6658.9 6731.4 6756.0 6654.8 6710.7 6778.0 6787.9 6840.1 6725.4 6736.4 6769.4 6823.5 6823.7 6740.3 6758.8 6827.8 6839.0 6839.8 4800.7 4843.1 4856.8 4864.8 4928.2 4413.6 4418.1 4425.2 4440.1 4476.5 6144.5 6214.4 6226.3 6227.6 6234.8 6557.9 6719.4 6740.1 6748.1 6749.8 6069.8 6180.0 6226.4 6228.0 6262.1 5444.5 5463.3 5463.4 5465.2 5465.6 6974.0 6992.1 6993.2 7077.9 7079.9 6765.6 6787.5 6795.4 6800.0 6806.3 6948.6 6980.7 6980.8 7085.3 7087.0 6530.6 6696.2 6704.7 6717.6 6791.9 6863.7 6868.1 6870.5 6876.6 6883.9 6606.9 6614.1 6620.0 6621.3 6626.4 6544.7 6612.2 6630.8 6632.8 6657.6 6485.1 6485.4 6491.7 6577.8 6585.1 6566.7 6598.7 6605.8 6620.5 6626.7 6393.7 6448.6 6457.8 6466.3 6468.8 12:10:57 INFO - PID 3822 | 12:10:57 INFO - PID 3822 | [#1] ext.html Cycles:180 Average:41162.84 Median:20238.21 stddev:62529.23 (309.0%) stddev-sans-first:62631.70 12:10:57 INFO - PID 3822 | Values: 938.6 942.6 976.1 999.3 1003.2 41365.4 42057.8 42227.0 42308.6 42397.4 42167.4 42281.4 42860.4 42865.0 42883.8 7967.9 8066.8 8135.3 8138.2 8139.1 7982.2 8046.2 8097.7 8098.5 8101.6 8106.4 8114.6 8115.8 8124.7 8141.7 8056.4 8072.1 8098.7 8100.3 8106.3 7978.6 8008.2 8012.8 8033.2 8074.3 39683.6 39780.0 39809.2 39839.4 39927.0 3746.4 3755.1 3757.0 3786.8 3793.7 32340.4 32628.2 32685.7 32715.7 32760.8 5294.5 5369.1 5467.7 5508.0 5595.9 207616.0 209960.0 211115.0 211779.0 212084.0 49053.8 49098.3 49148.8 49413.0 52277.7 56108.4 56303.4 56329.2 56360.2 56387.7 15430.7 15533.5 15566.0 15809.8 16062.4 12629.3 12778.7 12787.0 12787.2 12799.7 15277.2 15395.0 15413.4 15472.5 15532.2 6017.3 6051.8 6075.7 6151.7 6209.3 1083.9 1096.1 1102.5 1108.2 1126.4 25174.2 25175.4 25177.5 25403.7 25434.5 1207.2 1207.9 1208.5 1209.4 1209.9 13034.0 13233.7 13237.5 13616.0 13692.8 282405.0 284597.0 286423.0 286488.0 286608.0 47012.0 47220.5 47288.8 47443.3 53874.7 1526.7 1526.9 1535.1 1551.9 1558.3 29698.3 29832.9 30428.0 30545.7 30747.0 38749.0 38760.4 38911.0 38955.0 39044.6 217571.0 217849.0 219913.0 220231.0 220347.0 35181.8 36121.3 36455.3 36714.3 36730.0 43101.8 44698.8 44750.3 44994.0 45111.5 32992.7 33106.7 33595.8 33606.3 33621.5 32161.8 32617.3 33054.2 33179.0 33552.7 38366.6 38587.6 38820.8 38875.2 39047.8 31885.7 32139.0 32217.5 32294.8 32692.8 24549.0 24588.5 24788.0 25170.9 25308.5 12:10:57 INFO - PID 3822 | 12:10:57 INFO - PID 3822 | [#2] jquery.html Cycles:180 Average:38565.97 Median:23233.13 stddev:96449.09 (415.1%) stddev-sans-first:96677.52 12:10:57 INFO - PID 3822 | Values: 595.9 602.8 608.2 609.3 631.5 22833.1 23702.8 23740.9 23835.0 23841.9 23750.6 25547.9 25776.0 25804.2 25810.0 6567.5 6685.6 6693.1 6712.2 6729.0 6372.7 6615.8 6665.3 6678.0 6679.2 6566.6 6610.2 6615.7 6619.7 6625.5 6576.9 6612.1 6617.4 6625.7 6626.0 6167.3 6167.9 6168.9 6197.7 6211.0 28798.3 29171.4 29743.9 29759.0 29768.4 2194.4 2212.3 2212.5 2213.2 2214.0 20006.7 20479.7 20517.0 20533.2 20536.5 2515.2 2518.0 2586.6 2592.9 2607.0 132583.0 137722.0 137753.3 144428.0 151204.2 15484.9 15971.4 16081.2 16165.5 16307.7 24659.4 24901.5 24990.3 25011.0 25015.1 10352.6 10358.5 10532.7 10615.3 10616.3 9369.5 9419.8 9430.9 9523.6 9639.2 9427.6 9661.7 9714.7 9723.0 9987.3 2728.5 2749.8 2827.3 2855.8 2942.2 1051.9 1074.5 1076.6 1081.1 1082.4 20723.0 20973.2 21235.6 21239.9 21740.6 1087.6 1117.5 1120.9 1131.2 1147.1 11640.3 11779.2 11921.7 11975.3 11976.5 563839.0 571468.0 577120.0 582665.0 582726.0 126574.4 131899.0 134409.3 134572.0 135191.0 1203.0 1230.5 1231.8 1243.3 1248.3 18768.8 18944.8 18962.9 19068.5 19191.7 61642.7 62095.4 62411.0 63175.0 64075.0 80343.6 80698.6 81273.6 81490.2 81647.6 15201.2 15297.2 15409.3 15494.6 15512.9 23633.2 23918.2 24075.6 24129.9 24322.1 19701.4 19727.7 19857.9 19941.6 19978.1 15614.6 16294.2 16818.2 17688.2 17866.5 19125.0 19477.5 19610.3 19614.7 19629.1 14868.6 15064.5 15078.0 15111.1 15117.4 19103.5 19311.4 19451.3 19569.3 19642.2 12:10:57 INFO - PID 3822 | 12:10:57 INFO - PID 3822 | [#3] mootools.html Cycles:180 Average:10141.61 Median:2693.52 stddev:7652.64 (284.1%) stddev-sans-first:7645.80 12:10:57 INFO - PID 3822 | Values: 1380.4 1420.8 1436.5 1442.7 1455.7 16083.8 16761.8 16772.5 16788.6 16800.7 16582.9 16613.0 16674.9 16726.9 16734.2 2689.1 2811.1 2812.4 2817.1 2817.8 2697.9 2762.0 2771.6 2777.4 2783.6 2770.2 2945.5 2951.0 2951.7 2952.0 2826.6 2857.0 2860.5 2873.9 2898.2 2783.2 2803.1 2813.9 2817.3 2832.3 15962.8 15997.9 16219.8 16231.5 16275.8 8022.3 8256.2 8278.7 8287.8 8309.8 5173.9 5284.6 5322.5 5449.2 5560.9 2054.6 2084.5 2087.9 2089.4 2127.4 29803.4 30056.1 30171.7 30190.5 30229.2 6771.1 6795.9 6894.0 6938.1 6950.3 18712.5 18789.6 18882.0 18885.4 19031.9 8014.1 8235.1 8248.5 8253.4 8256.5 7208.3 7262.5 7315.4 7323.3 7329.6 5354.2 5428.9 5457.5 5457.6 5520.6 1465.6 1509.3 1537.4 1611.7 1634.4 921.8 933.8 941.9 942.8 945.4 7867.4 7980.9 8051.8 8056.7 8063.9 1051.2 1059.1 1062.0 1064.4 1066.8 4776.5 4828.7 4866.5 4879.2 4942.5 24191.5 24416.8 24895.0 25200.6 25231.2 25043.4 25050.0 25142.7 25227.4 25290.6 11929.4 12588.2 12639.6 12690.7 12698.2 8839.5 8867.6 8949.7 8978.9 8998.3 20983.3 20992.9 21074.9 21170.2 21261.3 21586.4 21694.7 21725.2 21767.9 22350.3 12240.8 12358.8 12389.8 12429.0 12461.1 14247.5 14395.9 14403.2 14421.9 14424.1 11535.8 11537.0 11723.9 11992.3 12074.3 12105.5 12125.5 12261.6 12393.6 12402.6 11001.3 11021.1 11180.4 11196.2 11201.1 7274.5 7294.6 7334.2 7361.0 7372.9 7632.5 7693.3 7705.8 7732.4 7829.9 12:10:57 INFO - PID 3822 | 12:10:57 INFO - PID 3822 | [#4] prototype.html Cycles:180 Average:5570.84 Median:6148.77 stddev:1553.00 (25.3%) stddev-sans-first:1510.97 12:10:57 INFO - PID 3822 | Values: 551.4 554.4 569.8 578.2 583.7 6007.8 6090.9 6112.1 6127.5 6237.9 6049.8 6092.1 6112.3 6140.7 6205.4 4901.7 4945.1 4956.7 4977.8 4991.2 4861.9 4911.0 4923.8 4955.7 4998.2 4934.2 4951.6 4979.5 4983.5 5009.2 4914.5 4920.4 4955.7 4957.8 4966.1 4474.3 4529.2 4537.1 4572.6 4591.2 6174.9 6184.4 6192.4 6197.6 6234.3 5797.7 5837.5 5851.8 5879.6 5890.5 6488.9 6529.8 6601.4 6622.0 6624.8 4790.0 4952.5 4974.4 5007.8 5014.8 6740.8 6787.5 6804.0 6852.4 6870.8 5081.0 5153.0 5167.7 5170.5 5188.4 5163.6 5220.3 5233.3 5249.7 5275.5 5758.9 5773.8 5816.0 5818.4 5862.9 6595.7 6619.4 6674.7 6700.7 6705.6 1791.0 1804.8 1822.6 1827.4 1830.2 1205.9 1244.6 1275.4 1279.6 1281.8 6054.2 6101.7 6107.6 6113.9 6180.4 6536.6 6662.0 6714.1 6726.0 6736.5 5941.8 6056.9 6133.7 6156.8 6198.6 3434.1 3464.3 3513.4 3519.5 3529.8 6875.7 6907.2 6932.4 6947.9 7004.3 6768.6 6804.9 6852.0 6870.8 6909.2 6912.4 6918.2 6919.6 6996.5 7014.5 6630.3 6663.2 6664.3 6680.9 6705.0 6369.9 6522.2 6529.6 6537.3 6623.4 6860.0 6898.8 6948.7 6951.8 6971.4 5133.6 5138.6 5165.5 5179.9 5193.5 6466.2 6500.2 6538.4 6738.7 6751.8 5958.0 6474.7 6526.6 6528.5 6532.2 6351.6 6455.5 6482.9 6499.4 6516.0 6303.6 6318.5 6353.0 6405.5 6430.7 6444.0 6468.0 6493.9 6538.7 6563.7 6365.5 6373.7 6414.5 6429.2 6435.2 12:10:57 INFO - PID 3822 | 12:10:57 INFO - PID 3822 | [#5] yui.html Cycles:180 Average:28793.85 Median:19281.92 stddev:43369.26 (224.9%) stddev-sans-first:43440.57 12:10:57 INFO - PID 3822 | Values: 961.1 988.4 997.4 997.7 1028.3 19058.9 19320.9 19545.3 19567.5 19568.2 17424.3 17662.6 17895.5 18101.5 18256.5 944.2 944.5 944.5 945.2 967.3 1036.6 1046.0 1061.4 1064.9 1075.5 1142.6 1149.0 1151.3 1151.4 1151.4 1139.5 1144.6 1147.0 1147.2 1147.6 801.0 819.9 835.6 836.6 840.5 19932.9 20372.8 20473.2 20511.3 20519.5 22703.3 22838.1 22972.4 23236.5 23291.4 17690.6 17732.2 18023.3 18040.5 18182.7 3963.1 3980.3 3989.8 3993.4 4012.4 160643.0 162225.0 164821.4 165049.0 165904.0 15429.0 15630.4 16230.9 16402.5 17127.1 28523.6 28523.6 28538.4 28553.0 28573.3 8764.6 9051.5 9072.3 9079.6 9080.5 4243.3 4348.4 4364.0 4368.6 4372.5 5977.7 6009.3 6012.0 6048.3 6072.5 1132.1 1164.8 1173.2 1183.7 1184.9 675.0 690.6 695.9 699.2 702.8 12422.9 12821.2 13278.0 13825.6 13842.8 661.0 670.4 676.0 677.2 686.0 6225.6 6277.5 6304.3 6315.0 6327.0 147024.0 147217.0 148301.0 149782.0 157085.2 131775.3 131955.0 132725.0 133114.0 141838.0 111984.0 114971.9 115490.0 116724.4 118257.4 13016.2 13047.5 13286.0 13416.9 13527.8 53259.5 53995.2 54747.0 54904.5 55263.0 69097.7 79199.6 92565.5 95538.7 99368.0 17321.2 18227.7 19021.2 19265.1 19298.7 20027.0 20141.6 20481.8 21318.3 22106.3 19180.7 19342.3 20395.9 20603.4 20817.7 17721.9 17771.6 17774.4 18423.8 19418.1 17398.6 17945.0 17956.2 18502.3 18533.4 12290.4 12695.0 13410.3 13568.7 13616.5 14202.4 14460.4 14751.7 14778.0 14826.1 12:10:57 INFO - PID 3822 | -------- Summary: end -------- 12:10:57 INFO - PID 3822 | 12:10:58 INFO - TEST-INFO | 3822: exit 0 12:10:58 INFO - TEST-OK | dromaeo_css | took 1110561ms 12:10:58 INFO - TEST-START | kraken 12:10:58 INFO - Initialising browser for kraken test... 12:10:58 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:46949/getInfo.html -profile /tmp/tmpccaa0q/profile 12:10:58 INFO - TEST-INFO | started process 4197 (/builds/slave/test/build/application/firefox/firefox http://localhost:46949/getInfo.html) 12:11:03 INFO - TEST-INFO | 4197: exit 0 12:11:03 INFO - Browser initialized. 12:11:03 INFO - Running cycle 1/1 for kraken test... 12:11:03 INFO - Using env: {'DISPLAY': ':0', 12:11:03 INFO - 'HOME': '/home/cltbld', 12:11:03 INFO - 'JSGC_DISABLE_POISONING': '1', 12:11:03 INFO - 'LANG': 'en_US.UTF-8', 12:11:03 INFO - 'LANGUAGE': 'en_US:en', 12:11:03 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 12:11:03 INFO - 'LOGNAME': 'cltbld', 12:11:03 INFO - 'MAIL': '/var/mail/cltbld', 12:11:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:11:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:11:03 INFO - 'MOZ_CRASHREPORTER': '1', 12:11:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:11:03 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 12:11:03 INFO - 'MOZ_NO_REMOTE': '1', 12:11:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:11:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:11:03 INFO - 'NO_EM_RESTART': '1', 12:11:03 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:11:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:11:03 INFO - 'PWD': '/builds/slave/test', 12:11:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:11:03 INFO - 'RUST_BACKTRACE': 'full', 12:11:03 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 12:11:03 INFO - 'SHELL': '/bin/bash', 12:11:03 INFO - 'SHLVL': '1', 12:11:03 INFO - 'TERM': 'linux', 12:11:03 INFO - 'TMOUT': '86400', 12:11:03 INFO - 'USER': 'cltbld', 12:11:03 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1505760485.880801-1588600159', 12:11:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:11:03 INFO - '_': '/tools/buildbot/bin/python'} 12:11:03 INFO - TEST-INFO | started process 4433 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpccaa0q/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 12:11:04 INFO - PID 4433 | 12:11:04 INFO - PID 4433 | (/builds/slave/test/build/application/firefox/firefox:4482): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 12:11:04 INFO - PID 4433 | 12:11:14 INFO - PID 4433 | RSS: Main: 148078592 12:11:14 INFO - PID 4433 | 12:11:17 INFO - PID 4433 | Cycle 1(1): loaded http://localhost:46949/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46949/tests/kraken/driver.html?testName=audio-beat-detection) 12:11:18 INFO - PID 4433 | RSS: Main: 153272320 12:11:18 INFO - PID 4433 | 12:11:20 INFO - PID 4433 | Cycle 1(1): loaded http://localhost:46949/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46949/tests/kraken/driver.html?testName=audio-dft) 12:11:21 INFO - PID 4433 | RSS: Main: 153866240 12:11:21 INFO - PID 4433 | 12:11:24 INFO - PID 4433 | Cycle 1(1): loaded http://localhost:46949/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46949/tests/kraken/driver.html?testName=audio-fft) 12:11:25 INFO - PID 4433 | RSS: Main: 149901312 12:11:25 INFO - PID 4433 | 12:11:27 INFO - PID 4433 | Cycle 1(1): loaded http://localhost:46949/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46949/tests/kraken/driver.html?testName=audio-oscillator) 12:11:27 INFO - PID 4433 | RSS: Main: 150556672 12:11:27 INFO - PID 4433 | 12:11:29 INFO - PID 4433 | Cycle 1(1): loaded http://localhost:46949/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46949/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:11:30 INFO - PID 4433 | RSS: Main: 150642688 12:11:30 INFO - PID 4433 | 12:11:33 INFO - PID 4433 | Cycle 1(1): loaded http://localhost:46949/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46949/tests/kraken/driver.html?testName=imaging-darkroom) 12:11:34 INFO - PID 4433 | RSS: Main: 152113152 12:11:34 INFO - PID 4433 | 12:11:37 INFO - PID 4433 | Cycle 1(1): loaded http://localhost:46949/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46949/tests/kraken/driver.html?testName=imaging-desaturate) 12:11:38 INFO - PID 4433 | RSS: Main: 154103808 12:11:38 INFO - PID 4433 | 12:11:41 INFO - PID 4433 | Cycle 1(1): loaded http://localhost:46949/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46949/tests/kraken/driver.html?testName=json-parse-financial) 12:11:41 INFO - PID 4433 | RSS: Main: 153874432 12:11:41 INFO - PID 4433 | 12:11:43 INFO - PID 4433 | Cycle 1(1): loaded http://localhost:46949/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46949/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:11:43 INFO - PID 4433 | RSS: Main: 153440256 12:11:43 INFO - PID 4433 | 12:11:45 INFO - PID 4433 | Cycle 1(1): loaded http://localhost:46949/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46949/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:11:46 INFO - PID 4433 | RSS: Main: 153600000 12:11:46 INFO - PID 4433 | 12:11:48 INFO - PID 4433 | Cycle 1(1): loaded http://localhost:46949/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46949/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:11:48 INFO - PID 4433 | RSS: Main: 150642688 12:11:48 INFO - PID 4433 | 12:11:51 INFO - PID 4433 | Cycle 1(1): loaded http://localhost:46949/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46949/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:11:51 INFO - PID 4433 | RSS: Main: 150630400 12:11:51 INFO - PID 4433 | 12:11:54 INFO - PID 4433 | Cycle 1(1): loaded http://localhost:46949/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46949/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:11:55 INFO - PID 4433 | RSS: Main: 151072768 12:11:55 INFO - PID 4433 | 12:11:56 INFO - PID 4433 | Cycle 1(1): loaded http://localhost:46949/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46949/tests/kraken/driver.html?testName=ai-astar) 12:11:57 INFO - PID 4433 | RSS: Main: 152969216 12:11:57 INFO - PID 4433 | 12:11:57 INFO - PID 4433 | __start_tp_report 12:11:57 INFO - PID 4433 | _x_x_mozilla_page_load 12:11:57 INFO - PID 4433 | _x_x_mozilla_page_load_details 12:11:57 INFO - PID 4433 | |i|pagename|runs| 12:11:57 INFO - PID 4433 | |0;ai-astar;106;105;104;105;116;105;108;105;105;104 12:11:57 INFO - PID 4433 | |1;audio-beat-detection;118;114;113;124;113;114;116;116;114;115 12:11:57 INFO - PID 4433 | |2;audio-dft;162;163;165;162;162;161;161;162;168;166 12:11:57 INFO - PID 4433 | |3;audio-fft;74;73;73;72;73;73;73;74;77;76 12:11:57 INFO - PID 4433 | |4;audio-oscillator;79;79;84;77;78;77;78;78;79;77 12:11:57 INFO - PID 4433 | |5;imaging-gaussian-blur;111;114;114;113;114;114;113;111;113;114 12:11:57 INFO - PID 4433 | |6;imaging-darkroom;150;150;150;149;149;149;150;151;149;150 12:11:57 INFO - PID 4433 | |7;imaging-desaturate;96;94;94;93;94;94;95;94;94;94 12:11:57 INFO - PID 4433 | |8;json-parse-financial;43;46;47;45;45;44;45;44;46;44 12:11:57 INFO - PID 4433 | |9;json-stringify-tinderbox;37;38;37;37;37;44;37;37;38;37 12:11:57 INFO - PID 4433 | |10;stanford-crypto-aes;75;72;72;70;70;71;76;70;70;70 12:11:57 INFO - PID 4433 | |11;stanford-crypto-ccm;107;106;107;104;111;101;106;109;106;105 12:11:57 INFO - PID 4433 | |12;stanford-crypto-pbkdf2;154;159;152;153;148;159;157;151;158;154 12:11:57 INFO - PID 4433 | |13;stanford-crypto-sha256-iterative;61;60;59;59;61;59;60;61;62;59 12:11:57 INFO - PID 4433 | __end_tp_report 12:11:57 INFO - PID 4433 | __start_cc_report 12:11:57 INFO - PID 4433 | _x_x_mozilla_cycle_collect,736 12:11:57 INFO - PID 4433 | __end_cc_report 12:11:57 INFO - PID 4433 | __startTimestamp1505761917097__endTimestamp 12:11:57 INFO - PID 4433 | 12:11:57 INFO - PID 4433 | ------- Summary: start ------- 12:11:57 INFO - PID 4433 | Number of tests: 14 12:11:57 INFO - PID 4433 | 12:11:57 INFO - PID 4433 | [#0] ai-astar Cycles:10 Average:106.30 Median:105.00 stddev:3.59 (3.4%) stddev-sans-first:3.81 12:11:57 INFO - PID 4433 | Values: 106.0 105.0 104.0 105.0 116.0 105.0 108.0 105.0 105.0 104.0 12:11:57 INFO - PID 4433 | 12:11:57 INFO - PID 4433 | [#1] audio-beat-detection Cycles:10 Average:115.70 Median:115.50 stddev:3.30 (2.9%) stddev-sans-first:3.40 12:11:57 INFO - PID 4433 | Values: 118.0 114.0 113.0 124.0 113.0 114.0 116.0 116.0 114.0 115.0 12:11:57 INFO - PID 4433 | 12:11:57 INFO - PID 4433 | [#2] audio-dft Cycles:10 Average:163.20 Median:162.50 stddev:2.35 (1.4%) stddev-sans-first:2.45 12:11:57 INFO - PID 4433 | Values: 162.0 163.0 165.0 162.0 162.0 161.0 161.0 162.0 168.0 166.0 12:11:57 INFO - PID 4433 | 12:11:57 INFO - PID 4433 | [#3] audio-fft Cycles:10 Average:73.80 Median:73.50 stddev:1.55 (2.1%) stddev-sans-first:1.64 12:11:57 INFO - PID 4433 | Values: 74.0 73.0 73.0 72.0 73.0 73.0 73.0 74.0 77.0 76.0 12:11:57 INFO - PID 4433 | 12:11:57 INFO - PID 4433 | [#4] audio-oscillator Cycles:10 Average:78.60 Median:78.50 stddev:2.07 (2.6%) stddev-sans-first:2.19 12:11:57 INFO - PID 4433 | Values: 79.0 79.0 84.0 77.0 78.0 77.0 78.0 78.0 79.0 77.0 12:11:57 INFO - PID 4433 | 12:11:57 INFO - PID 4433 | [#5] imaging-gaussian-blur Cycles:10 Average:113.10 Median:114.00 stddev:1.20 (1.1%) stddev-sans-first:1.00 12:11:57 INFO - PID 4433 | Values: 111.0 114.0 114.0 113.0 114.0 114.0 113.0 111.0 113.0 114.0 12:11:57 INFO - PID 4433 | 12:11:57 INFO - PID 4433 | [#6] imaging-darkroom Cycles:10 Average:149.70 Median:150.00 stddev:0.67 (0.4%) stddev-sans-first:0.71 12:11:57 INFO - PID 4433 | Values: 150.0 150.0 150.0 149.0 149.0 149.0 150.0 151.0 149.0 150.0 12:11:57 INFO - PID 4433 | 12:11:57 INFO - PID 4433 | [#7] imaging-desaturate Cycles:10 Average:94.20 Median:94.00 stddev:0.79 (0.8%) stddev-sans-first:0.50 12:11:57 INFO - PID 4433 | Values: 96.0 94.0 94.0 93.0 94.0 94.0 95.0 94.0 94.0 94.0 12:11:57 INFO - PID 4433 | 12:11:57 INFO - PID 4433 | [#8] json-parse-financial Cycles:10 Average:44.90 Median:45.00 stddev:1.20 (2.7%) stddev-sans-first:1.05 12:11:57 INFO - PID 4433 | Values: 43.0 46.0 47.0 45.0 45.0 44.0 45.0 44.0 46.0 44.0 12:11:57 INFO - PID 4433 | 12:11:57 INFO - PID 4433 | [#9] json-stringify-tinderbox Cycles:10 Average:37.90 Median:37.00 stddev:2.18 (5.9%) stddev-sans-first:2.29 12:11:57 INFO - PID 4433 | Values: 37.0 38.0 37.0 37.0 37.0 44.0 37.0 37.0 38.0 37.0 12:11:57 INFO - PID 4433 | 12:11:57 INFO - PID 4433 | [#10] stanford-crypto-aes Cycles:10 Average:71.60 Median:71.50 stddev:2.22 (3.1%) stddev-sans-first:1.99 12:11:57 INFO - PID 4433 | Values: 75.0 72.0 72.0 70.0 70.0 71.0 76.0 70.0 70.0 70.0 12:11:57 INFO - PID 4433 | 12:11:57 INFO - PID 4433 | [#11] stanford-crypto-ccm Cycles:10 Average:106.20 Median:106.50 stddev:2.70 (2.5%) stddev-sans-first:2.85 12:11:57 INFO - PID 4433 | Values: 107.0 106.0 107.0 104.0 111.0 101.0 106.0 109.0 106.0 105.0 12:11:57 INFO - PID 4433 | 12:11:57 INFO - PID 4433 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.50 Median:155.50 stddev:3.69 (2.4%) stddev-sans-first:3.91 12:11:57 INFO - PID 4433 | Values: 154.0 159.0 152.0 153.0 148.0 159.0 157.0 151.0 158.0 154.0 12:11:57 INFO - PID 4433 | 12:11:57 INFO - PID 4433 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:60.10 Median:60.50 stddev:1.10 (1.8%) stddev-sans-first:1.12 12:11:57 INFO - PID 4433 | Values: 61.0 60.0 59.0 59.0 61.0 59.0 60.0 61.0 62.0 59.0 12:11:57 INFO - PID 4433 | -------- Summary: end -------- 12:11:57 INFO - PID 4433 | 12:11:57 INFO - PID 4433 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 12:11:57 INFO - TEST-INFO | 4433: exit 0 12:11:57 INFO - TEST-OK | kraken | took 59143ms 12:11:57 INFO - SUITE-END | took 1169s 12:11:57 INFO - Completed test suite (00:19:29) 12:11:57 INFO - javascript benchmark 12:11:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8945.107725667065, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3848.5381754189493, 3855.8264878080486, 3858.1512067345175, 3878.0692633767885, 3887.105965627907, 6143.139960405541, 6150.354212807658, 6197.1324014637985, 6224.097505861648, 6289.685515724218, 6221.377862213776, 6224.066390041496, 6289.842753931142, 6317.715702793374, 6325.304216536178, 5596.384397716269, 5602.299712535933, 5645.774169033254, 5679.886402271952, 5722.141678748179, 5534.778608855661, 5620.662760234379, 5648.830535083954, 5662.490375866171, 5692.971535142318, 5527.55779537636, 5542.4457554244655, 5580.63725857822, 5618.915716264239, 5623.662580245178, 5547.750351234164, 5572.331320241597, 5615.9157612635845, 5618.073017952033, 5620.803271885465, 5550.69471179085, 5573.554115670737, 5579.6652200868075, 5627.774889004435, 5648.8870222595315, 6149.5080393568405, 6223.190985171898, 6230.719617617173, 6313.368663133696, 6315.115883776275, 6715.160604924385, 6717.899231511531, 6745.1905771307265, 6761.0196521504595, 6878.793636190922, 6784.151981002375, 6850.349216824394, 6868.965655171693, 6891.689873955684, 6900.068490753734, 6249.781257656005, 6264.279607845065, 6287.559870808999, 6348.269948955883, 6349.714262858229, 6923.099997000358, 6973.058637083929, 7008.894866577006, 7023.964880175567, 7042.190148132928, 6654.0, 6655.6339401332425, 6658.86682266352, 6731.360520750521, 6755.966220168966, 6654.800355989328, 6710.664466776641, 6777.9661101695165, 6787.932120678829, 6840.144981877265, 6725.428338591177, 6736.360045795642, 6769.424598909148, 6823.454123670094, 6823.727050917908, 6740.258571557125, 6758.83102922421, 6827.795166145023, 6838.965805170942, 6839.829004274833, 4800.66395352329, 4843.055604157226, 4856.757162141949, 4864.756762161877, 4928.162212423897, 4413.558644135561, 4418.116376724668, 4425.203463376559, 4440.134173836135, 4476.529964353761, 6144.477719393813, 6214.37856214384, 6226.283977342573, 6227.595206311576, 6234.781782637586, 6557.934420655828, 6719.361660642231, 6740.123783908159, 6748.055272261888, 6749.831254218684, 6069.757209711651, 6180.0, 6226.377362263828, 6227.972384556588, 6262.060690896402, 5444.50999410055, 5463.262459567987, 5463.3717122530625, 5465.152901300305, 5465.59008074396, 6974.0, 6992.1259842519685, 6993.195782484978, 7077.858442831114, 7079.89380159298, 6765.594064356154, 6787.457003439614, 6795.422389096784, 6800.047993280945, 6806.319368063154, 6948.583085014915, 6980.720771169096, 6980.755673551402, 7085.326893945067, 7087.043249161297, 6530.608163510205, 6696.19645642526, 6704.698288577123, 6717.596944183169, 6791.93208067913, 6863.691133898887, 6868.107146070979, 6870.519063665495, 6876.587404755531, 6883.8967415487805, 6606.9008964866525, 6614.140161778938, 6619.966900165468, 6621.33786621334, 6626.436752875867, 6544.6727663617585, 6612.173478315211, 6630.801075967729, 6632.767853125118, 6657.600543967377, 6485.124508191334, 6485.416312531895, 6491.675416229265, 6577.835554111186, 6585.111010013587, 6566.737330506726, 6598.736050558116, 6605.768798092236, 6620.5034622402545, 6626.701798418986, 6393.680315984275, 6448.613083215022, 6457.806265812033, 6466.256380516301, 6468.8059358219325], "value": 6179.243926088361, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [938.6292414496274, 942.5569982108415, 976.1166144639101, 999.2855108597352, 1003.1924300937746, 41365.37951930724, 42057.7897110514, 42227.0, 42308.57691423085, 42397.36403953943, 42167.36748948768, 42281.36577951333, 42860.35709464361, 42865.0, 42883.78558107213, 7967.880481792778, 8066.798330041766, 8135.308498777581, 8138.226868447488, 8139.145389734052, 7982.2017798220295, 8046.155153708864, 8097.716579919704, 8098.473599216032, 8101.6354264058255, 8106.351491880665, 8114.594270286491, 8115.75652730419, 8124.6750129994725, 8141.674333026672, 8056.436049476539, 8072.071711753165, 8098.676052957874, 8100.270975612194, 8106.270435660819, 7978.6409611567615, 8008.159143289929, 8012.8397432051615, 8033.156518565584, 8074.273315401642, 39683.60316396857, 39780.0, 39809.203815923516, 39839.40240896389, 39927.0, 3746.4193050077283, 3755.0800053986677, 3757.0231739747865, 3786.7917264550438, 3793.6965042796787, 32340.35319293601, 32628.184295392566, 32685.6731432685, 32715.6728432715, 32760.83619581887, 5294.549963253128, 5369.0604144274985, 5467.6719396835915, 5507.972460137714, 5595.860103497404, 207616.0, 209960.0, 211115.0, 211779.0, 212084.0, 49053.75473122683, 49098.263526047136, 49148.75425622921, 49413.0, 52277.7386113067, 56108.43891561032, 56303.43696562982, 56329.155062674094, 56360.15459768107, 56387.718061410254, 15430.691386172213, 15533.533993980198, 15566.0, 15809.841901580838, 16062.43781467643, 12629.305388203737, 12778.680532986564, 12787.0, 12787.232766033881, 12799.744005120032, 15277.159756213516, 15395.0, 15413.383464661289, 15472.5358239253, 15532.223388830513, 6017.2779266488305, 6051.848703782441, 6075.726592303268, 6151.72317245716, 6209.348018458088, 1083.9024487796137, 1096.0957210301533, 1102.5204036244259, 1108.2353176308322, 1126.4480404601686, 25174.24477265685, 25175.370615734388, 25177.496450070896, 25403.74596254014, 25434.491310173693, 1207.1851500237306, 1207.927524348542, 1208.4501551793912, 1209.401346333553, 1209.8608660004213, 13034.0, 13233.669158271121, 13237.536686216128, 13616.046876718534, 13692.794608080887, 282405.0, 284597.0, 286423.0, 286488.0, 286608.0, 47012.0, 47220.5277947223, 47288.763556182, 47443.28835067477, 53874.7306263474, 1526.6870291590196, 1526.8778497720157, 1535.117307548142, 1551.8680912122595, 1558.2987655554819, 29698.257543561584, 29832.85083574568, 30428.0, 30545.694543054284, 30747.0, 38749.0, 38760.418593720555, 38911.0, 38955.0, 39044.6095539041, 217571.0, 217849.0, 219913.0, 220231.0, 220347.0, 35181.82409087938, 36121.277574447835, 36455.27089458249, 36714.265714685025, 36730.0, 43101.7844910786, 44698.77650611726, 44750.3287450695, 44994.0, 45111.54888451073, 32992.67007329896, 33106.66893331036, 33595.83202084072, 33606.32787344288, 33621.49567756535, 32161.839190803898, 32617.34765304728, 33054.17364565905, 33179.0, 33552.664473354955, 38366.616333836304, 38587.6141238584, 38820.80589597034, 38875.222495549366, 39047.80476097601, 31885.68114318827, 32139.0, 32217.51673724849, 32294.83852580722, 32692.83653581717, 24549.0, 24588.508229834944, 24788.0, 25170.874145629154, 25308.49383012366], "value": 18226.5476806083, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [595.9481515125802, 602.7829981206762, 608.1668114682885, 609.2719200555335, 631.5168895794718, 22833.08667653294, 23702.76297237027, 23740.88129559352, 23835.046598136054, 23841.880790596024, 23750.64374034391, 25547.872260638716, 25776.0, 25804.225873223833, 25810.0, 6567.474602031838, 6685.565438246523, 6693.129893113888, 6712.228093769206, 6728.966355168217, 6372.713227904732, 6615.768448104317, 6665.266820649725, 6677.966610166966, 6679.198496180441, 6566.63883486408, 6610.173728283965, 6615.702293396808, 6619.735210591571, 6625.46996240302, 6576.868462630745, 6612.14042174519, 6617.404433600975, 6625.701843417058, 6626.0, 6167.259928808572, 6167.938320616781, 6168.8766224675255, 6197.690115494207, 6211.0, 28798.280042998882, 29171.416571668447, 29743.851280743675, 29759.0, 29768.40463190746, 2194.3965409512352, 2212.269950916194, 2212.4800671842104, 2213.247495851402, 2213.9778602213933, 20006.69989950152, 20479.69280460794, 20517.0, 20533.178672853068, 20536.486587835276, 2515.1825656661476, 2517.9874100629563, 2586.6120081987665, 2592.857392843393, 2606.9869650651626, 132583.0, 137722.0, 137753.31123344318, 144428.0, 151204.2439787805, 15484.922575387276, 15971.440999565191, 16081.195940202942, 16165.515034548982, 16307.673846523241, 24659.383515412257, 24901.5019699605, 24990.250292491255, 25011.0, 25015.124470643805, 10352.585896564204, 10358.482075896174, 10532.684019479428, 10615.337708490713, 10616.25686201974, 9369.484678342757, 9419.764505887271, 9430.90569094314, 9523.57143928525, 9639.228861691048, 9427.62289508412, 9661.661841835503, 9714.708558743248, 9723.0, 9987.250956178315, 2728.5361488546996, 2749.845065072674, 2827.3073097091346, 2855.7858160638034, 2942.1614839770564, 1051.8527406163143, 1074.5272080284649, 1076.574752972587, 1081.1404933078222, 1082.3884505254664, 20723.0, 20973.161073556887, 21235.575288494143, 21239.89380053121, 21740.56518869614, 1087.5921529426464, 1117.5473933057124, 1120.8823073577157, 1131.1516362727955, 1147.1167201254987, 11640.301581905112, 11779.175457718049, 11921.691339508645, 11975.263586780042, 11976.53267235683, 563839.0, 571468.0, 577120.0, 582665.0, 582726.0, 126574.36712816377, 131899.0, 134409.3279533596, 134572.0, 135191.0, 1203.0375699440413, 1230.4585982167996, 1231.8337024501757, 1243.3161761031577, 1248.3134276148264, 18768.812311876707, 18944.79018269932, 18962.905185473985, 19068.523286917938, 19191.712124317866, 61642.69178654078, 62095.379046210764, 62411.0, 63175.0, 64075.038874417856, 80343.59828200821, 80698.5965070171, 81273.59363203382, 81490.18509814826, 81647.59176204081, 15201.163935983626, 15297.158656273567, 15409.306581204097, 15494.612634684223, 15512.922435388202, 23633.172838951243, 23918.162864299666, 24075.638865416684, 24129.87935060384, 24322.148724794548, 19701.40895773129, 19727.704084439032, 19857.900710496357, 19941.60116797685, 19978.1009854554, 15614.609634758768, 16294.185290735653, 16818.243179057215, 17688.204030818903, 17866.464006079837, 19125.0, 19477.51306217356, 19610.313639022566, 19614.705779413605, 19629.11668974928, 14868.553943381716, 15064.548063558112, 15078.0, 15111.093334399971, 15117.395304187708, 19103.52241193981, 19311.420657380302, 19451.3192038278, 19569.315073972342, 19642.214311427382], "value": 12621.832231811535, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1380.3926272440126, 1420.7584710599203, 1436.5187662133185, 1442.7403067447863, 1455.6579203887088, 16083.83916160838, 16761.83238167618, 16772.496825095237, 16788.58028549287, 16800.663986720272, 16582.917085414556, 16613.0, 16674.916625416856, 16726.916365418187, 16734.246958886848, 2689.1260340389354, 2811.05829547102, 2812.4375124974986, 2817.0703667789685, 2817.8027538072342, 2697.9190624281205, 2761.9585706214425, 2771.6119743235963, 2777.4306267215175, 2783.6242107315556, 2770.1827960751625, 2945.4698154332214, 2950.985245073782, 2951.74910132639, 2951.970480295191, 2826.6184065151147, 2857.04289063162, 2860.5423132298943, 2873.870675819593, 2898.2029941765973, 2783.248522898826, 2803.1170181392795, 2813.9296517587018, 2817.2534278416238, 2832.3344014156655, 15962.76055859163, 15997.920010399874, 16219.756703649455, 16231.51305460838, 16275.755863662054, 8022.277994980422, 8256.215659512336, 8278.71024514139, 8287.792805179859, 8309.750707478785, 5173.870653233662, 5284.5772338212855, 5322.547583455411, 5449.237106805051, 5560.86097847553, 2054.5685406064745, 2084.468460542552, 2087.8747275163537, 2089.4149638101358, 2127.3936927975606, 29803.403931921457, 30056.098317050524, 30171.69828301733, 30190.54714179289, 30229.244268893235, 6771.119754431892, 6795.864082718417, 6894.0, 6938.063361446241, 6950.270221626757, 18712.53218669544, 18789.62420751577, 18882.0, 18885.43343699691, 19031.904840475985, 8014.118446970829, 8235.094139644634, 8248.54632995179, 8253.422260441712, 8256.545889976109, 7208.315210055036, 7262.527935684269, 7315.378192853561, 7323.267673232741, 7329.560226386434, 5354.170103633943, 5428.9185662215095, 5457.508824205841, 5457.563394928476, 5520.558355331564, 1465.6116129225763, 1509.2680050175657, 1537.3696784318377, 1611.6937781821416, 1634.3707672546154, 921.7925966657449, 933.7618907178626, 941.924646028316, 942.7737343037621, 945.385499425379, 7867.443205616683, 7980.920190798134, 8051.758447246592, 8056.677732890736, 8063.919360806434, 1051.1958351860833, 1059.0786016165985, 1062.044160255776, 1064.435849000031, 1066.7706443114769, 4776.498467660915, 4828.686135401258, 4866.464688884291, 4879.243717223836, 4942.5304596063315, 24191.516169676506, 24416.755832441802, 24895.0, 25200.621990670155, 25231.24306270815, 25043.37391565189, 25049.99800008016, 25142.748572514407, 25227.369315767253, 25290.620640690406, 11929.403529823649, 12588.181768185223, 12639.557615483414, 12690.682732931751, 12698.238105713872, 8839.51382673959, 8867.600957957036, 8949.686760963335, 8978.86531702038, 8998.325125615474, 20983.265585705038, 20992.895035524725, 21074.894625527388, 21170.153193872688, 21261.255856045584, 21586.38102142314, 21694.674579880997, 21725.239616613344, 21767.891160544095, 22350.329490115324, 12240.755184896074, 12358.81461778092, 12389.75220495603, 12429.0, 12461.065420093348, 14247.501337453139, 14395.856041439452, 14403.207823569805, 14421.855781442471, 14424.06243594163, 11535.826962595736, 11537.0, 11723.941380293043, 11992.340421276913, 12074.27554346742, 12105.455254513745, 12125.454354554242, 12261.632151035483, 12393.62819115428, 12402.5659101931, 11001.339919604849, 11021.118310535297, 11180.385078820744, 11196.160287978597, 11201.103911687209, 7274.4907856449545, 7294.562326260441, 7334.193238743841, 7361.006264154271, 7372.889406659012, 7632.542047477169, 7693.307602315818, 7705.768826935201, 7732.420068494773, 7829.921700782919], "value": 7089.739687504884, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [551.4457969740411, 554.4095538251762, 569.7607005057876, 578.1876463568688, 583.737318206807, 6007.759689612416, 6090.939090609093, 6112.083187521868, 6127.4791642710425, 6237.875242495153, 6049.788257410992, 6092.147099406086, 6112.327643959161, 6140.692965351737, 6205.379462053792, 4901.65688401812, 4945.109880221558, 4956.7360323117555, 4977.825776097838, 4991.226359914201, 4861.927071093936, 4911.0, 4923.82766603169, 4955.702657840541, 4998.175301075318, 4934.185859333205, 4951.55436010759, 4979.45226025137, 4983.526564976321, 5009.223570346602, 4914.459409464974, 4920.360353154103, 4955.653104282702, 4957.752112394366, 4966.081274964125, 4474.2729306487745, 4529.184746745585, 4537.0925814837165, 4572.588467037983, 4591.1965406053805, 6174.938250617526, 6184.443400094013, 6192.442680158762, 6197.628142311431, 6234.3453937336835, 5797.710114494258, 5837.482254613788, 5851.824445266606, 5879.617824841414, 5890.499307558863, 6488.870222595521, 6529.771457998947, 6601.405873471363, 6622.0, 6624.768133115366, 4789.976050119762, 4952.529509696573, 4974.403071631427, 5007.824726134604, 5014.824481143179, 6740.797776066725, 6787.524873258873, 6803.965980170117, 6852.383285504278, 6870.793876183722, 5080.974595127001, 5153.0, 5167.6641018333685, 5170.45710200431, 5188.351456067991, 5163.561097306771, 5220.269162317279, 5233.267342572043, 5249.737513124329, 5275.4724527547705, 5758.856028599319, 5773.769049238067, 5815.9709201453725, 5818.359980402152, 5862.8534286642325, 6595.670216489252, 6619.437347825393, 6674.699638516278, 6700.698468568926, 6705.597664140069, 1790.97313540297, 1804.7727545269342, 1822.571695651521, 1827.4426299978634, 1830.158127261448, 1205.8703038773854, 1244.6079484962388, 1275.4005617359826, 1279.5969269680022, 1281.8333616629966, 6054.182685337423, 6101.725422356005, 6107.572469927062, 6113.908291375633, 6180.351063138396, 6536.607803531803, 6661.966690166615, 6714.093597364391, 6726.0, 6736.46108311334, 5941.792037278675, 6056.909146362808, 6133.699862551543, 6156.846078847975, 6198.6280823149855, 3434.1414646338417, 3464.263232046705, 3513.4202856528386, 3519.542459480251, 3529.8235088245483, 6875.656217189121, 6907.240203577602, 6932.410745086724, 6947.930520694829, 7004.2645522220455, 6768.593884366954, 6804.897926531106, 6852.0, 6870.793876183722, 6909.239983601799, 6912.412444942136, 6918.169819621678, 6919.619420931796, 6996.475264355296, 7014.473914456538, 6630.336966303331, 6663.233728121328, 6664.266930637723, 6680.9331906682255, 6704.99425086241, 6369.87260254783, 6522.184726909137, 6529.608223506605, 6537.346265373615, 6623.370779775913, 6860.0, 6898.827529311808, 6948.652567371712, 6951.7914462566205, 6971.442284617117, 5133.640645154804, 5138.588912886886, 5165.483451654804, 5179.896402072013, 5193.506616871391, 6466.191726034246, 6500.219973603198, 6538.411542961157, 6738.6967586459705, 6751.797446076625, 5958.046712525975, 6474.741010359721, 6526.608403495806, 6528.510361722985, 6532.150820393508, 6351.555391122762, 6455.48356131499, 6482.855814929661, 6499.38255865692, 6516.0, 6303.621782693053, 6318.462930650946, 6352.968235158794, 6405.51958603116, 6430.710618022294, 6443.96778016107, 6467.967660161858, 6493.92850179734, 6538.705758240795, 6563.704633291418, 6365.458935990493, 6373.673609132726, 6414.486841052798, 6429.22849258092, 6435.22777266731], "value": 5126.005621349061, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [961.1253759079231, 988.4069558265041, 997.3816233934966, 997.6907158780779, 1028.336722813785, 19058.90470547647, 19320.903395483037, 19545.315913943014, 19567.510812229702, 19568.21727130915, 17424.30302787887, 17662.558436039075, 17895.463136105936, 18101.547461313472, 18256.452306430794, 944.1974321826427, 944.4710961861346, 944.5324564340661, 945.2060269373725, 967.3470407474962, 1036.595727666207, 1046.0324200114862, 1061.4162210784077, 1064.8668916385452, 1075.510642657589, 1142.605800998654, 1148.9885101148966, 1151.2804497189256, 1151.3667482884423, 1151.3725019864194, 1139.4986206069345, 1144.6222746493638, 1147.0078382199379, 1147.2485521983115, 1147.6270212181075, 801.0, 819.9467034642729, 835.5863847395517, 836.5942517878824, 840.5083026429546, 19932.900335498376, 20372.796272037238, 20473.18107275722, 20511.2821051264, 20519.48701282465, 22703.318900433012, 22838.086476540917, 22972.4256893579, 23236.53526929452, 23291.417714557272, 17690.646187076316, 17732.20205090774, 18023.27906883723, 18040.548986275317, 18182.727259091123, 3963.128111815396, 3980.323345031323, 3989.840406383741, 3993.3610622300293, 4012.3580227163516, 160643.0, 162225.0, 164821.3517864818, 165049.0, 165904.0, 15429.0, 15630.374785008473, 16230.918845405933, 16402.507924762278, 17127.143642818057, 28523.572146417406, 28523.57214641782, 28538.42923141567, 28553.0, 28573.28566785847, 8764.605592748341, 9051.502167380857, 9072.319576031692, 9079.636814527477, 9080.545972701339, 4243.2998555238655, 4348.391225228471, 4364.018095928391, 4368.60682538573, 4372.475302963665, 5977.701114944235, 6009.278886533644, 6012.0, 6048.334683184846, 6072.51419886408, 1132.0886686217673, 1164.8485696859354, 1173.2491205628405, 1183.6863231243726, 1184.8755880632582, 674.9595024298558, 690.5614934516618, 695.857349243414, 699.1679900917892, 702.7891632510226, 12422.875771242352, 12821.166624169398, 13278.004149688619, 13825.585232443043, 13842.82336001431, 660.9768658096943, 670.4033410264868, 675.9864802703919, 677.2178134254943, 686.0, 6225.564210505312, 6277.52918531112, 6304.306526282106, 6314.968425157845, 6327.019312006646, 147024.0, 147217.0, 148301.0, 149782.0, 157085.21457392868, 131775.3411232957, 131955.0, 132725.0, 133114.0, 141838.0, 111984.0, 114971.85028149778, 115490.0, 116724.41637791926, 118257.40871295761, 13016.15394999322, 13047.478100876238, 13286.0, 13416.865831341953, 13527.797083043566, 53259.46740532545, 53995.190072148165, 54747.0, 54904.450955489934, 55263.0, 69097.65451172712, 79199.60400197962, 92565.5371723137, 95538.65614703452, 99368.0, 17321.220545075754, 18227.726584101514, 19021.23915043438, 19265.13306901165, 19298.7105193425, 20027.0, 20141.597168056265, 20481.795182048583, 21318.253861114787, 22106.33680989573, 19180.71228931595, 19342.32301869428, 20395.8980205098, 20603.381898543066, 20817.687734684296, 17721.911390442965, 17771.555711107325, 17774.377896773552, 18423.815761842747, 19418.126184321456, 17398.565035874206, 17945.0, 17956.19197136106, 18502.259909604003, 18533.351332703292, 12290.446929887998, 12695.0, 13410.262435566137, 13568.728625427239, 13616.523421680193, 14202.360893759598, 14460.421583136978, 14751.704965900837, 14778.0, 14826.1104333736], "value": 9915.507295426249, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1369.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 105.0, 104.0, 105.0, 116.0, 105.0, 108.0, 105.0, 105.0, 104.0], "value": 106.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 114.0, 113.0, 124.0, 113.0, 114.0, 116.0, 116.0, 114.0, 115.0], "value": 115.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 165.0, 162.0, 162.0, 161.0, 161.0, 162.0, 168.0, 166.0], "value": 163.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 73.0, 72.0, 73.0, 73.0, 73.0, 74.0, 77.0, 76.0], "value": 73.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 84.0, 77.0, 78.0, 77.0, 78.0, 78.0, 79.0, 77.0], "value": 78.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 114.0, 114.0, 113.0, 114.0, 114.0, 113.0, 111.0, 113.0, 114.0], "value": 113.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 150.0, 150.0, 149.0, 149.0, 149.0, 150.0, 151.0, 149.0, 150.0], "value": 149.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 94.0, 94.0, 93.0, 94.0, 94.0, 95.0, 94.0, 94.0, 94.0], "value": 94.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [43.0, 46.0, 47.0, 45.0, 45.0, 44.0, 45.0, 44.0, 46.0, 44.0], "value": 44.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [37.0, 38.0, 37.0, 37.0, 37.0, 44.0, 37.0, 37.0, 38.0, 37.0], "value": 37.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 72.0, 72.0, 70.0, 70.0, 71.0, 76.0, 70.0, 70.0, 70.0], "value": 71.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 106.0, 107.0, 104.0, 111.0, 101.0, 106.0, 109.0, 106.0, 105.0], "value": 106.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 159.0, 152.0, 153.0, 148.0, 159.0, 157.0, 151.0, 158.0, 154.0], "value": 154.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 60.0, 59.0, 59.0, 61.0, 59.0, 60.0, 61.0, 62.0, 59.0], "value": 60.1, "unit": "score"}]}]} 12:11:57 INFO - Return code: 0 12:11:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:11:57 INFO - # TBPL SUCCESS # 12:11:57 INFO - Running post-action listener: _package_coverage_data 12:11:57 INFO - Running post-action listener: _resource_record_post_action 12:11:57 INFO - [mozharness: 2017-09-18 19:11:57.894871Z] Finished run-tests step (success) 12:11:57 INFO - Running post-run listener: _resource_record_post_run 12:11:57 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 8957952; Write bytes: 459714560; Read time: 2876; Write time: 488920 12:11:57 INFO - TinderboxPrint: CPU usage
13.1% 12:11:57 INFO - TinderboxPrint: I/O read bytes / time
8,957,952 / 2,876 12:11:57 INFO - TinderboxPrint: I/O write bytes / time
459,714,560 / 488,920 12:11:57 INFO - TinderboxPrint: CPU idle
8,232.1 (86.9%) 12:11:57 INFO - TinderboxPrint: CPU user
1,186.1 (12.5%) 12:11:57 INFO - TinderboxPrint: Swap in / out
0 / 0 12:11:57 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 12660736; Read time: 0; Write time: 1128 12:11:57 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 12:11:58 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 8957952; Write bytes: 410419200; Read time: 2876; Write time: 476672 12:11:58 INFO - Running post-run listener: _upload_blobber_files 12:11:58 INFO - Blob upload gear active. 12:11:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:11:58 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 12:11:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:11:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:11:58 INFO - (blobuploader) - INFO - Open directory for files ... 12:11:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 12:11:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:11:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:11:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 12:11:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:11:59 INFO - (blobuploader) - INFO - Done attempting. 12:11:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 12:11:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:11:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:12:01 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 12:12:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:12:01 INFO - (blobuploader) - INFO - Done attempting. 12:12:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 12:12:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:12:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:12:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 12:12:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:12:02 INFO - (blobuploader) - INFO - Done attempting. 12:12:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:12:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:12:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:12:08 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:12:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:12:08 INFO - (blobuploader) - INFO - Done attempting. 12:12:08 INFO - (blobuploader) - INFO - Iteration through files over. 12:12:08 INFO - Return code: 0 12:12:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:12:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:12:08 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/13489976221958a91c11e1b14c247a88949c3dc22b0a0a9ae4cc345e0145587aa656ffb87e85c53ca96ae782222e92b9a71e98d326f802894833fef88db3b289", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0aa08c47f1a1b8a726245acfe711327da5bd27535141db9315b12636e55162b5a9d4e5155aa6ca057de4da7d075fa7df2aeb8168dce73785e3a70b860592c470", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1e61e818d5884e3ff2c4cbba387abf83d5cc10dbadba5ff4de05de0ede74e65862f6e55a549108d7cc26fb275e25d532cd8e01cba11d93243f1ae84b4bde09b2", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ea27a22dbdc3ef99f4b3721f731775d1c04b8b7f14d0fe239a23113bd61bafd8dfba97de64a1895ca10c8937490b91cc8f34cb69fa157677496c579cacf58e8b"} 12:12:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:12:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:12:08 INFO - Contents: 12:12:08 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/13489976221958a91c11e1b14c247a88949c3dc22b0a0a9ae4cc345e0145587aa656ffb87e85c53ca96ae782222e92b9a71e98d326f802894833fef88db3b289", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0aa08c47f1a1b8a726245acfe711327da5bd27535141db9315b12636e55162b5a9d4e5155aa6ca057de4da7d075fa7df2aeb8168dce73785e3a70b860592c470", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1e61e818d5884e3ff2c4cbba387abf83d5cc10dbadba5ff4de05de0ede74e65862f6e55a549108d7cc26fb275e25d532cd8e01cba11d93243f1ae84b4bde09b2", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ea27a22dbdc3ef99f4b3721f731775d1c04b8b7f14d0fe239a23113bd61bafd8dfba97de64a1895ca10c8937490b91cc8f34cb69fa157677496c579cacf58e8b"} 12:12:08 INFO - Running post-run listener: copy_logs_to_upload_dir 12:12:08 INFO - Copying logs to upload dir... 12:12:08 INFO - mkdir: /builds/slave/test/build/upload/logs 12:12:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.146980 ========= master_lag: 0.15 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2017-09-18 12:12:08.285185) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-18 12:12:08.289945) ========= 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=6d15e502d8e29d5d2676d664000001c3-1505760485.880801-1588600159 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/13489976221958a91c11e1b14c247a88949c3dc22b0a0a9ae4cc345e0145587aa656ffb87e85c53ca96ae782222e92b9a71e98d326f802894833fef88db3b289", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0aa08c47f1a1b8a726245acfe711327da5bd27535141db9315b12636e55162b5a9d4e5155aa6ca057de4da7d075fa7df2aeb8168dce73785e3a70b860592c470", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1e61e818d5884e3ff2c4cbba387abf83d5cc10dbadba5ff4de05de0ede74e65862f6e55a549108d7cc26fb275e25d532cd8e01cba11d93243f1ae84b4bde09b2", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ea27a22dbdc3ef99f4b3721f731775d1c04b8b7f14d0fe239a23113bd61bafd8dfba97de64a1895ca10c8937490b91cc8f34cb69fa157677496c579cacf58e8b"} build_url:https://queue.taskcluster.net/v1/task/SCsIEorPRfqct5c1S2alwA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011336 build_url: 'https://queue.taskcluster.net/v1/task/SCsIEorPRfqct5c1S2alwA/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/13489976221958a91c11e1b14c247a88949c3dc22b0a0a9ae4cc345e0145587aa656ffb87e85c53ca96ae782222e92b9a71e98d326f802894833fef88db3b289", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0aa08c47f1a1b8a726245acfe711327da5bd27535141db9315b12636e55162b5a9d4e5155aa6ca057de4da7d075fa7df2aeb8168dce73785e3a70b860592c470", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1e61e818d5884e3ff2c4cbba387abf83d5cc10dbadba5ff4de05de0ede74e65862f6e55a549108d7cc26fb275e25d532cd8e01cba11d93243f1ae84b4bde09b2", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ea27a22dbdc3ef99f4b3721f731775d1c04b8b7f14d0fe239a23113bd61bafd8dfba97de64a1895ca10c8937490b91cc8f34cb69fa157677496c579cacf58e8b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-18 12:12:08.320907) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-18 12:12:08.321248) ========= 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=6d15e502d8e29d5d2676d664000001c3-1505760485.880801-1588600159 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004557 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-18 12:12:08.403425) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-18 12:12:08.403737) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-18 12:12:08.404051) ========= ========= Total master_lag: 0.32 =========