builder: mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s slave: talos-linux64-ix-041 starttime: 1505557627.56 results: success (0) revision: 27e7b4261e4b5a016e09adb5332a181e43ab520e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-16 03:27:07.555735) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-16 03:27:07.556183) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-16 03:27:07.556453) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-16 03:27:07.574550) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 03:27:07.574926) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1505557626.386648-895086720 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-16 03:27:07-- 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% 219M=0s 2017-09-16 03:27:07 (219 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.121639 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 03:27:07.712286) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 03:27:07.712609) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1505557626.386648-895086720 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014336 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 03:27:07.761833) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 03:27:07.765194) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 27e7b4261e4b5a016e09adb5332a181e43ab520e --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 27e7b4261e4b5a016e09adb5332a181e43ab520e --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=8c6b6742ce8f6f39ef4ce27d000001f1-1505557626.386648-895086720 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-16 03:27:07,731 truncating revision to first 12 chars 2017-09-16 03:27:07,731 Setting DEBUG logging. 2017-09-16 03:27:07,731 attempt 1/10 2017-09-16 03:27:07,731 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/27e7b4261e4b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-16 03:27:08,166 unpacking tar archive at: mozilla-central-27e7b4261e4b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.738160 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 03:27:08.520406) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-16 03:27:08.520817) ========= script_repo_revision: 27e7b4261e4b5a016e09adb5332a181e43ab520e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-16 03:27:08.521256) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-16 03:27:08.521524) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-16 03:27:08.534804) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2017-09-16 03:27:08.535253) ========= /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=8c6b6742ce8f6f39ef4ce27d000001f1-1505557626.386648-895086720 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:27:08 INFO - MultiFileLogger online at 20170916 03:27:08 in /builds/slave/test 03:27:08 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 03:27:08 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:27:08 INFO - {'append_to_log': False, 03:27:08 INFO - 'base_work_dir': '/builds/slave/test', 03:27:08 INFO - 'blob_upload_branch': 'Firefox', 03:27:08 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:27:08 INFO - 'branch': 'Firefox', 03:27:08 INFO - 'buildbot_json_path': 'buildprops.json', 03:27:08 INFO - 'code_coverage': False, 03:27:08 INFO - 'config_files': ('talos/linux_config.py',), 03:27:08 INFO - 'default_actions': ('clobber', 03:27:08 INFO - 'read-buildbot-config', 03:27:08 INFO - 'download-and-extract', 03:27:08 INFO - 'populate-webroot', 03:27:08 INFO - 'create-virtualenv', 03:27:08 INFO - 'install', 03:27:08 INFO - 'setup-mitmproxy', 03:27:08 INFO - 'run-tests'), 03:27:08 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:27:08 INFO - 'disable_ccov_upload': False, 03:27:08 INFO - 'disable_stylo': False, 03:27:08 INFO - 'download_minidump_stackwalk': True, 03:27:08 INFO - 'download_symbols': 'ondemand', 03:27:08 INFO - 'enable_stylo': False, 03:27:08 INFO - 'enable_webrender': False, 03:27:08 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 03:27:08 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:27:08 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:27:08 INFO - 'gecko_profile': False, 03:27:08 INFO - 'gecko_profile_interval': 0, 03:27:08 INFO - 'installer_path': 'installer.exe', 03:27:08 INFO - 'log_level': 'info', 03:27:08 INFO - 'log_name': 'talos', 03:27:08 INFO - 'log_to_console': True, 03:27:08 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:27:08 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:27:08 INFO - 'opt_config_files': (), 03:27:08 INFO - 'pip_index': False, 03:27:08 INFO - 'suite': 'dromaeojs-e10s', 03:27:08 INFO - 'system_bits': '32', 03:27:08 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:27:08 INFO - 'title': 'talos-linux64-ix-041', 03:27:08 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:27:08 INFO - 'use_talos_json': True, 03:27:08 INFO - 'verify': 'False', 03:27:08 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:27:08 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:27:08 INFO - 'work_dir': 'build'} 03:27:08 INFO - [mozharness: 2017-09-16 10:27:08.648189Z] Running clobber step. 03:27:08 INFO - Running pre-action listener: _resource_record_pre_action 03:27:08 INFO - Running main action method: clobber 03:27:08 INFO - rmtree: /builds/slave/test/build 03:27:08 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:27:10 INFO - Running post-action listener: _resource_record_post_action 03:27:10 INFO - [mozharness: 2017-09-16 10:27:10.273421Z] Finished clobber step (success) 03:27:10 INFO - [mozharness: 2017-09-16 10:27:10.273519Z] Running read-buildbot-config step. 03:27:10 INFO - Running pre-action listener: _resource_record_pre_action 03:27:10 INFO - Running main action method: read_buildbot_config 03:27:10 INFO - Using buildbot properties: 03:27:10 INFO - { 03:27:10 INFO - "project": "", 03:27:10 INFO - "product": "firefox", 03:27:10 INFO - "who": "archaeopteryx@coole-files.de", 03:27:10 INFO - "installer_path": "public/build/target.tar.bz2", 03:27:10 INFO - "builddir": "mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s", 03:27:10 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 03:27:10 INFO - "buildername": "Ubuntu HW 12.04 x64 qr mozilla-central talos dromaeojs-e10s", 03:27:10 INFO - "stage_platform": "linux64-qr", 03:27:10 INFO - "basedir": "/builds/slave/test", 03:27:10 INFO - "buildnumber": 63, 03:27:10 INFO - "platform": "ubuntu64_hw_qr", 03:27:10 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:27:10 INFO - "slavebuilddir": "test", 03:27:10 INFO - "taskId": "HqCqwIn3S0iIrcum7NZHfg", 03:27:10 INFO - "branch": "mozilla-central", 03:27:10 INFO - "script_repo_revision": "production", 03:27:10 INFO - "revision": "27e7b4261e4b5a016e09adb5332a181e43ab520e", 03:27:10 INFO - "slavename": "talos-linux64-ix-041", 03:27:10 INFO - "repo_path": "mozilla-central" 03:27:10 INFO - } 03:27:10 INFO - Finding installer, test and symbols from parent task. 03:27:10 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HqCqwIn3S0iIrcum7NZHfg'}, attempt #1 03:27:10 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HqCqwIn3S0iIrcum7NZHfg'}, attempt #1 03:27:11 INFO - Task dependencies: QKXeurjvQniffQGOJwEu5g 03:27:11 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QKXeurjvQniffQGOJwEu5g'}, attempt #1 03:27:11 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/QKXeurjvQniffQGOJwEu5g/artifacts/public/build/target.tar.bz2 03:27:11 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/QKXeurjvQniffQGOJwEu5g/artifacts/public/build/target.test_packages.json 03:27:11 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/QKXeurjvQniffQGOJwEu5g/artifacts/public/build/target.crashreporter-symbols.zip 03:27:11 INFO - Running post-action listener: _resource_record_post_action 03:27:11 INFO - [mozharness: 2017-09-16 10:27:11.615841Z] Finished read-buildbot-config step (success) 03:27:11 INFO - [mozharness: 2017-09-16 10:27:11.616061Z] Running download-and-extract step. 03:27:11 INFO - Running pre-action listener: _resource_record_pre_action 03:27:11 INFO - Running main action method: download_and_extract 03:27:11 INFO - mkdir: /builds/slave/test/build/tests 03:27:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:27:11 INFO - trying https://queue.taskcluster.net/v1/task/QKXeurjvQniffQGOJwEu5g/artifacts/public/build/target.test_packages.json 03:27:11 INFO - Downloading https://queue.taskcluster.net/v1/task/QKXeurjvQniffQGOJwEu5g/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 03:27:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QKXeurjvQniffQGOJwEu5g/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 03:27:12 INFO - Downloaded 989 bytes. 03:27:12 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 03:27:12 INFO - Using the following test package requirements: 03:27:12 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 03:27:12 INFO - u'common': [u'target.common.tests.zip'], 03:27:12 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 03:27:12 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 03:27:12 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 03:27:12 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 03:27:12 INFO - u'mozbase': [u'target.common.tests.zip'], 03:27:12 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 03:27:12 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 03:27:12 INFO - u'web-platform': [u'target.common.tests.zip', 03:27:12 INFO - u'target.web-platform.tests.tar.gz'], 03:27:12 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 03:27:12 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 03:27:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QKXeurjvQniffQGOJwEu5g/artifacts/public/build/target.common.tests.zip 03:27:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QKXeurjvQniffQGOJwEu5g/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:27:12 INFO - Fetch https://queue.taskcluster.net/v1/task/QKXeurjvQniffQGOJwEu5g/artifacts/public/build/target.common.tests.zip into memory 03:27:13 INFO - Content-Length response header: 54731147 03:27:13 INFO - Bytes received: 54731147 03:27:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QKXeurjvQniffQGOJwEu5g/artifacts/public/build/target.talos.tests.zip 03:27:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QKXeurjvQniffQGOJwEu5g/artifacts/public/build/target.talos.tests.zip'}, attempt #1 03:27:24 INFO - Fetch https://queue.taskcluster.net/v1/task/QKXeurjvQniffQGOJwEu5g/artifacts/public/build/target.talos.tests.zip into memory 03:27:24 INFO - Content-Length response header: 14508748 03:27:24 INFO - Bytes received: 14508748 03:27:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:27:24 INFO - trying https://queue.taskcluster.net/v1/task/QKXeurjvQniffQGOJwEu5g/artifacts/public/build/target.tar.bz2 03:27:24 INFO - Downloading https://queue.taskcluster.net/v1/task/QKXeurjvQniffQGOJwEu5g/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 03:27:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QKXeurjvQniffQGOJwEu5g/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 03:27:26 INFO - Downloaded 61630448 bytes. 03:27:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QKXeurjvQniffQGOJwEu5g/artifacts/public/build/target.tar.bz2 03:27:26 INFO - mkdir: /builds/slave/test/properties 03:27:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:27:26 INFO - Writing to file /builds/slave/test/properties/build_url 03:27:26 INFO - Contents: 03:27:26 INFO - build_url:https://queue.taskcluster.net/v1/task/QKXeurjvQniffQGOJwEu5g/artifacts/public/build/target.tar.bz2 03:27:26 INFO - Running post-action listener: _resource_record_post_action 03:27:26 INFO - Running post-action listener: find_tests_for_verification 03:27:26 INFO - Running post-action listener: set_extra_try_arguments 03:27:26 INFO - [mozharness: 2017-09-16 10:27:26.469413Z] Finished download-and-extract step (success) 03:27:26 INFO - [mozharness: 2017-09-16 10:27:26.469513Z] Running populate-webroot step. 03:27:26 INFO - Running pre-action listener: _resource_record_pre_action 03:27:26 INFO - Running main action method: populate_webroot 03:27:26 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:27:26 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:27:26 INFO - 'tests': ['tresize', 03:27:26 INFO - 'tcanvasmark']}, 03:27:26 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:27:26 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:27:26 INFO - 'tests': ['dromaeo_css', 03:27:26 INFO - 'kraken']}, 03:27:26 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:27:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:27:26 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:27:26 INFO - 'talos_options': ['--disable-stylo'], 03:27:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:27:26 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:27:26 INFO - 'tests': ['damp', 'tps']}, 03:27:26 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:27:26 INFO - 'talos_options': ['--disable-stylo'], 03:27:26 INFO - 'tests': ['damp', 'tps']}, 03:27:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:27:26 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:27:26 INFO - 'tests': ['dromaeo_dom']}, 03:27:26 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:27:26 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:27:26 INFO - 'tests': ['basic_compositor_video', 03:27:26 INFO - 'glvideo']}, 03:27:26 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 03:27:26 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 03:27:26 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:27:26 INFO - 'talos_options': ['--disable-stylo'], 03:27:26 INFO - 'tests': ['ts_paint_webext', 03:27:26 INFO - 'tp5o_webext']}, 03:27:26 INFO - 'other-e10s': {'tests': ['a11yr', 03:27:26 INFO - 'ts_paint', 03:27:26 INFO - 'tpaint', 03:27:26 INFO - 'sessionrestore', 03:27:26 INFO - 'sessionrestore_many_windows', 03:27:26 INFO - 'sessionrestore_no_auto_restore', 03:27:26 INFO - 'tabpaint']}, 03:27:26 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:27:26 INFO - 'tests': ['a11yr', 03:27:26 INFO - 'ts_paint', 03:27:26 INFO - 'tpaint', 03:27:26 INFO - 'sessionrestore', 03:27:26 INFO - 'sessionrestore_many_windows', 03:27:26 INFO - 'sessionrestore_no_auto_restore', 03:27:26 INFO - 'tabpaint']}, 03:27:26 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 03:27:26 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 03:27:26 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:27:26 INFO - 'tests': ['perf_reftest_singletons']}, 03:27:26 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:27:26 INFO - 'tests': ['bloom_basic']}, 03:27:26 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:27:26 INFO - 'tsvgr_opacity', 03:27:26 INFO - 'tart', 03:27:26 INFO - 'tscrollx', 03:27:26 INFO - 'tsvg_static']}, 03:27:26 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:27:26 INFO - 'tests': ['tsvgx', 03:27:26 INFO - 'tsvgr_opacity', 03:27:26 INFO - 'tart', 03:27:26 INFO - 'tscrollx', 03:27:26 INFO - 'tsvg_static']}, 03:27:26 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:27:26 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:27:26 INFO - 'talos_options': ['--disable-stylo'], 03:27:26 INFO - 'tests': ['tp5o']}, 03:27:26 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:27:26 INFO - 'talos_options': ['--mitmproxy', 03:27:26 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:27:26 INFO - '--firstNonBlankPaint'], 03:27:26 INFO - 'tests': ['tp6_google', 03:27:26 INFO - 'tp6_youtube', 03:27:26 INFO - 'tp6_amazon', 03:27:26 INFO - 'tp6_facebook']}, 03:27:26 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:27:26 INFO - 'talos_options': ['--disable-stylo', 03:27:26 INFO - '--mitmproxy', 03:27:26 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:27:26 INFO - '--firstNonBlankPaint'], 03:27:26 INFO - 'tests': ['tp6_google', 03:27:26 INFO - 'tp6_youtube', 03:27:26 INFO - 'tp6_amazon', 03:27:26 INFO - 'tp6_facebook']}, 03:27:26 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:27:26 INFO - 'talos_options': ['--stylo-threads=1', 03:27:26 INFO - '--mitmproxy', 03:27:26 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:27:26 INFO - '--firstNonBlankPaint'], 03:27:26 INFO - 'tests': ['tp6_google', 03:27:26 INFO - 'tp6_youtube', 03:27:26 INFO - 'tp6_amazon', 03:27:26 INFO - 'tp6_facebook']}, 03:27:26 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:27:26 INFO - 'talos_options': ['--xperf_path', 03:27:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:27:26 INFO - 'tests': ['tp5n']}, 03:27:26 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:27:26 INFO - 'talos_options': ['--disable-stylo', 03:27:26 INFO - '--xperf_path', 03:27:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:27:26 INFO - 'tests': ['tp5n']}}} 03:27:26 INFO - Running post-action listener: _resource_record_post_action 03:27:26 INFO - [mozharness: 2017-09-16 10:27:26.487924Z] Finished populate-webroot step (success) 03:27:26 INFO - [mozharness: 2017-09-16 10:27:26.488013Z] Running create-virtualenv step. 03:27:26 INFO - Running pre-action listener: _resource_record_pre_action 03:27:26 INFO - Running main action method: create_virtualenv 03:27:26 INFO - Creating virtualenv /builds/slave/test/build/venv 03:27:26 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:27:26 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 03:27:26 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 03:27:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:27:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:27:27 INFO - Installing distribute.............................................................................................................................................................................................done. 03:27:27 INFO - Installing pip...............done. 03:27:27 INFO - Return code: 0 03:27:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:27:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:27:27 INFO - Reading from file tmpfile_stdout 03:27:27 INFO - Output received: 03:27:27 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 03:27:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:27:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:27:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:27:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:27:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:27:27 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 0xb0b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcd4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe77a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe7b090>, '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 0xe7bd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe75f90>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1505557626.386648-895086720', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:27:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:27:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:27:27 INFO - Using env: {'DISPLAY': ':0', 03:27:27 INFO - 'HOME': '/home/cltbld', 03:27:27 INFO - 'LANG': 'en_US.UTF-8', 03:27:27 INFO - 'LANGUAGE': 'en_US:en', 03:27:27 INFO - 'LOGNAME': 'cltbld', 03:27:27 INFO - 'MAIL': '/var/mail/cltbld', 03:27:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:27:27 INFO - 'MOZ_NO_REMOTE': '1', 03:27:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:27:27 INFO - 'NO_EM_RESTART': '1', 03:27:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:27:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:27:27 INFO - 'PWD': '/builds/slave/test', 03:27:27 INFO - 'SHELL': '/bin/bash', 03:27:27 INFO - 'SHLVL': '1', 03:27:27 INFO - 'TERM': 'linux', 03:27:27 INFO - 'TMOUT': '86400', 03:27:27 INFO - 'USER': 'cltbld', 03:27:27 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1505557626.386648-895086720', 03:27:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:27:27 INFO - '_': '/tools/buildbot/bin/python'} 03:27:28 INFO - Ignoring indexes: http://pypi.python.org/simple/ 03:27:28 INFO - Downloading/unpacking pip>=1.5 03:27:28 INFO - Running setup.py egg_info for package pip 03:27:28 INFO - warning: no files found matching 'pip/cacert.pem' 03:27:28 INFO - warning: no files found matching '*.html' under directory 'docs' 03:27:28 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 03:27:28 INFO - no previously-included directories found matching 'docs/_build/_sources' 03:27:28 INFO - Installing collected packages: pip 03:27:28 INFO - Found existing installation: pip 1.1 03:27:28 INFO - Uninstalling pip: 03:27:28 INFO - Successfully uninstalled pip 03:27:28 INFO - Running setup.py install for pip 03:27:28 INFO - warning: no files found matching 'pip/cacert.pem' 03:27:28 INFO - warning: no files found matching '*.html' under directory 'docs' 03:27:28 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 03:27:28 INFO - no previously-included directories found matching 'docs/_build/_sources' 03:27:28 INFO - Installing pip script to /builds/slave/test/build/venv/bin 03:27:28 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 03:27:28 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 03:27:28 INFO - Successfully installed pip 03:27:28 INFO - Cleaning up... 03:27:28 INFO - Return code: 0 03:27:28 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:27: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')]} 03:27:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:27: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')]} 03:27:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:27:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xb0b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcd4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe77a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe7b090>, '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 0xe7bd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe75f90>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1505557626.386648-895086720', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:27:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:27:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:27:28 INFO - Using env: {'DISPLAY': ':0', 03:27:28 INFO - 'HOME': '/home/cltbld', 03:27:28 INFO - 'LANG': 'en_US.UTF-8', 03:27:28 INFO - 'LANGUAGE': 'en_US:en', 03:27:28 INFO - 'LOGNAME': 'cltbld', 03:27:28 INFO - 'MAIL': '/var/mail/cltbld', 03:27:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:27:28 INFO - 'MOZ_NO_REMOTE': '1', 03:27:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:27:28 INFO - 'NO_EM_RESTART': '1', 03:27:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:27:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:27:28 INFO - 'PWD': '/builds/slave/test', 03:27:28 INFO - 'SHELL': '/bin/bash', 03:27:28 INFO - 'SHLVL': '1', 03:27:28 INFO - 'TERM': 'linux', 03:27:28 INFO - 'TMOUT': '86400', 03:27:28 INFO - 'USER': 'cltbld', 03:27:28 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1505557626.386648-895086720', 03:27:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:27:28 INFO - '_': '/tools/buildbot/bin/python'} 03:27:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:27:28 INFO - Downloading/unpacking psutil>=3.1.1 03:27:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:27:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:27:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:27:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:27:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:27:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:27:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:27:30 INFO - Installing collected packages: psutil 03:27:30 INFO - Running setup.py install for psutil 03:27:30 INFO - building 'psutil._psutil_linux' extension 03:27:30 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 03:27:30 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 03:27:30 INFO - building 'psutil._psutil_posix' extension 03:27:30 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 03:27:30 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 03:27:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:27:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:27:30 INFO - Successfully installed psutil 03:27:30 INFO - Cleaning up... 03:27:30 INFO - Return code: 0 03:27:30 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:27:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:27:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:27:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:27:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:27:30 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 0xb0b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcd4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe77a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe7b090>, '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 0xe7bd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe75f90>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1505557626.386648-895086720', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:27:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:27:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:27:30 INFO - Using env: {'DISPLAY': ':0', 03:27:30 INFO - 'HOME': '/home/cltbld', 03:27:30 INFO - 'LANG': 'en_US.UTF-8', 03:27:30 INFO - 'LANGUAGE': 'en_US:en', 03:27:30 INFO - 'LOGNAME': 'cltbld', 03:27:30 INFO - 'MAIL': '/var/mail/cltbld', 03:27:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:27:30 INFO - 'MOZ_NO_REMOTE': '1', 03:27:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:27:30 INFO - 'NO_EM_RESTART': '1', 03:27:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:27:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:27:30 INFO - 'PWD': '/builds/slave/test', 03:27:30 INFO - 'SHELL': '/bin/bash', 03:27:30 INFO - 'SHLVL': '1', 03:27:30 INFO - 'TERM': 'linux', 03:27:30 INFO - 'TMOUT': '86400', 03:27:30 INFO - 'USER': 'cltbld', 03:27:30 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1505557626.386648-895086720', 03:27:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:27:30 INFO - '_': '/tools/buildbot/bin/python'} 03:27:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:27:30 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:27:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:27:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:27:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:27:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:27:32 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:27:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:27:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:27:32 INFO - Installing collected packages: mozsystemmonitor 03:27:32 INFO - Running setup.py install for mozsystemmonitor 03:27:32 INFO - Successfully installed mozsystemmonitor 03:27:32 INFO - Cleaning up... 03:27:32 INFO - Return code: 0 03:27:32 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:27:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:27:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:27:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:27:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:27:32 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 0xb0b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcd4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe77a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe7b090>, '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 0xe7bd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe75f90>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1505557626.386648-895086720', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:27:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:27:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:27:32 INFO - Using env: {'DISPLAY': ':0', 03:27:32 INFO - 'HOME': '/home/cltbld', 03:27:32 INFO - 'LANG': 'en_US.UTF-8', 03:27:32 INFO - 'LANGUAGE': 'en_US:en', 03:27:32 INFO - 'LOGNAME': 'cltbld', 03:27:32 INFO - 'MAIL': '/var/mail/cltbld', 03:27:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:27:32 INFO - 'MOZ_NO_REMOTE': '1', 03:27:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:27:32 INFO - 'NO_EM_RESTART': '1', 03:27:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:27:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:27:32 INFO - 'PWD': '/builds/slave/test', 03:27:32 INFO - 'SHELL': '/bin/bash', 03:27:32 INFO - 'SHLVL': '1', 03:27:32 INFO - 'TERM': 'linux', 03:27:32 INFO - 'TMOUT': '86400', 03:27:32 INFO - 'USER': 'cltbld', 03:27:32 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1505557626.386648-895086720', 03:27:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:27:32 INFO - '_': '/tools/buildbot/bin/python'} 03:27:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:27:32 INFO - Downloading/unpacking jsonschema==2.5.1 03:27:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:27:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:27:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:27:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:27:34 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:27:34 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:27:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:27:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:27:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:27:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:27:34 INFO - Downloading functools32-3.2.3-2.tar.gz 03:27:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:27:34 INFO - warning: no files found matching '*.txt' 03:27:34 INFO - no previously-included directories found matching 'build' 03:27:34 INFO - no previously-included directories found matching 'dist' 03:27:34 INFO - no previously-included directories found matching '.git*' 03:27:34 INFO - Installing collected packages: jsonschema, functools32 03:27:34 INFO - Running setup.py install for functools32 03:27:34 INFO - warning: no files found matching '*.txt' 03:27:34 INFO - no previously-included directories found matching 'build' 03:27:34 INFO - no previously-included directories found matching 'dist' 03:27:34 INFO - no previously-included directories found matching '.git*' 03:27:34 INFO - Successfully installed jsonschema functools32 03:27:34 INFO - Cleaning up... 03:27:34 INFO - Return code: 0 03:27:34 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:27:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:27:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:27:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:27:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:27:34 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 0xb0b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcd4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe77a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe7b090>, '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 0xe7bd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe75f90>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1505557626.386648-895086720', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:27:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:27:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 03:27:34 INFO - Using env: {'DISPLAY': ':0', 03:27:34 INFO - 'HOME': '/home/cltbld', 03:27:34 INFO - 'LANG': 'en_US.UTF-8', 03:27:34 INFO - 'LANGUAGE': 'en_US:en', 03:27:34 INFO - 'LOGNAME': 'cltbld', 03:27:34 INFO - 'MAIL': '/var/mail/cltbld', 03:27:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:27:34 INFO - 'MOZ_NO_REMOTE': '1', 03:27:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:27:34 INFO - 'NO_EM_RESTART': '1', 03:27:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:27:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:27:34 INFO - 'PWD': '/builds/slave/test', 03:27:34 INFO - 'SHELL': '/bin/bash', 03:27:34 INFO - 'SHLVL': '1', 03:27:34 INFO - 'TERM': 'linux', 03:27:34 INFO - 'TMOUT': '86400', 03:27:34 INFO - 'USER': 'cltbld', 03:27:34 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1505557626.386648-895086720', 03:27:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:27:34 INFO - '_': '/tools/buildbot/bin/python'} 03:27:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:27:34 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:27:34 INFO - Cleaning up... 03:27:34 INFO - Return code: 0 03:27:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:27:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:27:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:27:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:27:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:27:34 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 0xb0b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcd4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe77a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe7b090>, '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 0xe7bd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe75f90>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1505557626.386648-895086720', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:27:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:27:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:27:34 INFO - Using env: {'DISPLAY': ':0', 03:27:34 INFO - 'HOME': '/home/cltbld', 03:27:34 INFO - 'LANG': 'en_US.UTF-8', 03:27:34 INFO - 'LANGUAGE': 'en_US:en', 03:27:34 INFO - 'LOGNAME': 'cltbld', 03:27:34 INFO - 'MAIL': '/var/mail/cltbld', 03:27:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:27:34 INFO - 'MOZ_NO_REMOTE': '1', 03:27:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:27:34 INFO - 'NO_EM_RESTART': '1', 03:27:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:27:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:27:34 INFO - 'PWD': '/builds/slave/test', 03:27:34 INFO - 'SHELL': '/bin/bash', 03:27:34 INFO - 'SHLVL': '1', 03:27:34 INFO - 'TERM': 'linux', 03:27:34 INFO - 'TMOUT': '86400', 03:27:34 INFO - 'USER': 'cltbld', 03:27:34 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1505557626.386648-895086720', 03:27:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:27:34 INFO - '_': '/tools/buildbot/bin/python'} 03:27:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:27:34 INFO - Downloading/unpacking blobuploader==1.2.4 03:27:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:27:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:27:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:27:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:27:35 INFO - Downloading blobuploader-1.2.4.tar.gz 03:27:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:27:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:27:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:27:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:27:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:27:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:27:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:27:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:27:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:27:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:27:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:27:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:27:36 INFO - Downloading docopt-0.6.1.tar.gz 03:27:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:27:36 INFO - Installing collected packages: blobuploader, requests, docopt 03:27:36 INFO - Running setup.py install for blobuploader 03:27:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:27:36 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:27:36 INFO - Running setup.py install for requests 03:27:37 INFO - Running setup.py install for docopt 03:27:37 INFO - Successfully installed blobuploader requests docopt 03:27:37 INFO - Cleaning up... 03:27:37 INFO - Return code: 0 03:27:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:27:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:27:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:27:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:27:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:27:37 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 0xb0b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcd4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe77a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe7b090>, '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 0xe7bd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe75f90>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1505557626.386648-895086720', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:27:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:27:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:27:37 INFO - Using env: {'DISPLAY': ':0', 03:27:37 INFO - 'HOME': '/home/cltbld', 03:27:37 INFO - 'LANG': 'en_US.UTF-8', 03:27:37 INFO - 'LANGUAGE': 'en_US:en', 03:27:37 INFO - 'LOGNAME': 'cltbld', 03:27:37 INFO - 'MAIL': '/var/mail/cltbld', 03:27:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:27:37 INFO - 'MOZ_NO_REMOTE': '1', 03:27:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:27:37 INFO - 'NO_EM_RESTART': '1', 03:27:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:27:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:27:37 INFO - 'PWD': '/builds/slave/test', 03:27:37 INFO - 'SHELL': '/bin/bash', 03:27:37 INFO - 'SHLVL': '1', 03:27:37 INFO - 'TERM': 'linux', 03:27:37 INFO - 'TMOUT': '86400', 03:27:37 INFO - 'USER': 'cltbld', 03:27:37 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1505557626.386648-895086720', 03:27:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:27:37 INFO - '_': '/tools/buildbot/bin/python'} 03:27:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:27:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:27:37 INFO - Running setup.py (path:/tmp/pip-bwKBWz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:27:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:27:37 INFO - Running setup.py (path:/tmp/pip-mMHouL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:27:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:27:37 INFO - Running setup.py (path:/tmp/pip-74cC3W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:27:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:27:37 INFO - Running setup.py (path:/tmp/pip-CqVT43-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:27:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:27:37 INFO - Running setup.py (path:/tmp/pip-BDP_w7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:27:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:27:37 INFO - Running setup.py (path:/tmp/pip-pny8gI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:27:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:27:37 INFO - Running setup.py (path:/tmp/pip-rCt7Jv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:27:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:27:37 INFO - Running setup.py (path:/tmp/pip-nmAJzv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:27:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:27:37 INFO - Running setup.py (path:/tmp/pip-HYdvuj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:27:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:27:38 INFO - Running setup.py (path:/tmp/pip-azDA7O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:27:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:27:38 INFO - Running setup.py (path:/tmp/pip-VjZlEq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:27:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:27:38 INFO - Running setup.py (path:/tmp/pip-qQa4UA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:27:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:27:38 INFO - Running setup.py (path:/tmp/pip-GHt_jN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:27:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:27:38 INFO - Running setup.py (path:/tmp/pip-KrJBmi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:27:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:27:38 INFO - Running setup.py (path:/tmp/pip-DMsSEw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:27:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:27:38 INFO - Running setup.py (path:/tmp/pip-6dnWXP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:27:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:27:38 INFO - Running setup.py (path:/tmp/pip-y9N_FN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:27:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:27:38 INFO - Running setup.py install for manifestparser 03:27:38 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:27:38 INFO - Running setup.py install for mozcrash 03:27:38 INFO - Running setup.py install for mozdebug 03:27:38 INFO - Running setup.py install for mozdevice 03:27:38 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:27:38 INFO - Running setup.py install for mozfile 03:27:39 INFO - Running setup.py install for mozhttpd 03:27:39 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:27:39 INFO - Running setup.py install for mozinfo 03:27:39 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:27:39 INFO - Running setup.py install for mozInstall 03:27:39 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:27:39 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:27:39 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:27:39 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:27:39 INFO - Running setup.py install for mozleak 03:27:39 INFO - Running setup.py install for mozlog 03:27:39 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:27:39 INFO - Running setup.py install for moznetwork 03:27:39 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:27:39 INFO - Running setup.py install for mozprocess 03:27:39 INFO - Running setup.py install for mozprofile 03:27:39 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:27:39 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:27:39 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:27:39 INFO - Running setup.py install for mozrunner 03:27:39 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:27:39 INFO - Running setup.py install for mozscreenshot 03:27:40 INFO - Running setup.py install for moztest 03:27:40 INFO - Running setup.py install for mozversion 03:27:40 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:27:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:27:40 INFO - Cleaning up... 03:27:40 INFO - Return code: 0 03:27:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:27:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:27:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:27:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:27:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:27:40 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 0xb0b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcd4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe77a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe7b090>, '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 0xe7bd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe75f90>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1505557626.386648-895086720', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:27:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:27:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:27:40 INFO - Using env: {'DISPLAY': ':0', 03:27:40 INFO - 'HOME': '/home/cltbld', 03:27:40 INFO - 'LANG': 'en_US.UTF-8', 03:27:40 INFO - 'LANGUAGE': 'en_US:en', 03:27:40 INFO - 'LOGNAME': 'cltbld', 03:27:40 INFO - 'MAIL': '/var/mail/cltbld', 03:27:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:27:40 INFO - 'MOZ_NO_REMOTE': '1', 03:27:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:27:40 INFO - 'NO_EM_RESTART': '1', 03:27:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:27:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:27:40 INFO - 'PWD': '/builds/slave/test', 03:27:40 INFO - 'SHELL': '/bin/bash', 03:27:40 INFO - 'SHLVL': '1', 03:27:40 INFO - 'TERM': 'linux', 03:27:40 INFO - 'TMOUT': '86400', 03:27:40 INFO - 'USER': 'cltbld', 03:27:40 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1505557626.386648-895086720', 03:27:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:27:40 INFO - '_': '/tools/buildbot/bin/python'} 03:27:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:27:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:27:40 INFO - Running setup.py (path:/tmp/pip-b3kjAX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:27:40 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 03:27:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:27:40 INFO - Running setup.py (path:/tmp/pip-WBKpGA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:27:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:27:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:27:40 INFO - Running setup.py (path:/tmp/pip-XqVnKx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:27:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:27:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:27:40 INFO - Running setup.py (path:/tmp/pip-F58kkZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:27:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:27:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:27:40 INFO - Running setup.py (path:/tmp/pip-Pn23PL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:27:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 03:27:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:27:40 INFO - Running setup.py (path:/tmp/pip-3j_zE3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:27:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 03:27:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:27:40 INFO - Running setup.py (path:/tmp/pip-L3kT1_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:27:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 03:27:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:27:41 INFO - Running setup.py (path:/tmp/pip-15jx5V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:27:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:27:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:27:41 INFO - Running setup.py (path:/tmp/pip-LJEJGA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:27:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 03:27:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:27:41 INFO - Running setup.py (path:/tmp/pip-mvBaF0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:27:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:27:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:27:41 INFO - Running setup.py (path:/tmp/pip-9uauFy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:27:41 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 03:27:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:27:41 INFO - Running setup.py (path:/tmp/pip-NJcpkb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:27:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 03:27:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:27:41 INFO - Running setup.py (path:/tmp/pip-obBNhf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:27:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 03:27:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:27:41 INFO - Running setup.py (path:/tmp/pip-ZQ1TVa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:27:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:27:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:27:41 INFO - Running setup.py (path:/tmp/pip-QCSYdn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:27:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 03:27:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:27:41 INFO - Running setup.py (path:/tmp/pip-8h9p9u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:27:41 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:27:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:27:41 INFO - Running setup.py (path:/tmp/pip-VZdx8r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:27:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:27:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:27:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:27:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:27:41 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:27:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:27:41 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:27:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:27:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:27:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:27:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:27:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:27:42 INFO - Downloading blessings-1.6.tar.gz 03:27:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:27:42 INFO - Installing collected packages: blessings 03:27:42 INFO - Running setup.py install for blessings 03:27:43 INFO - Successfully installed blessings 03:27:43 INFO - Cleaning up... 03:27:43 INFO - Return code: 0 03:27:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:27:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:27:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:27:43 INFO - Reading from file tmpfile_stdout 03:27:43 INFO - Current package versions: 03:27:43 INFO - argparse == 1.2.1 03:27:43 INFO - blessings == 1.6 03:27:43 INFO - blobuploader == 1.2.4 03:27:43 INFO - docopt == 0.6.1 03:27:43 INFO - functools32 == 3.2.3-2 03:27:43 INFO - jsonschema == 2.5.1 03:27:43 INFO - manifestparser == 1.1 03:27:43 INFO - mozInstall == 1.13 03:27:43 INFO - mozcrash == 1.0 03:27:43 INFO - mozdebug == 0.1 03:27:43 INFO - mozdevice == 0.51 03:27:43 INFO - mozfile == 1.2 03:27:43 INFO - mozhttpd == 0.7 03:27:43 INFO - mozinfo == 0.10 03:27:43 INFO - mozleak == 0.1 03:27:43 INFO - mozlog == 3.5 03:27:43 INFO - moznetwork == 0.27 03:27:43 INFO - mozprocess == 0.25 03:27:43 INFO - mozprofile == 0.28 03:27:43 INFO - mozrunner == 6.13 03:27:43 INFO - mozscreenshot == 0.1 03:27:43 INFO - mozsystemmonitor == 0.3 03:27:43 INFO - moztest == 0.8 03:27:43 INFO - mozversion == 1.4 03:27:43 INFO - psutil == 3.1.1 03:27:43 INFO - requests == 1.2.3 03:27:43 INFO - wsgiref == 0.1.2 03:27:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:27:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:27:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:27:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:27:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:27:43 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 0xb0b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcd4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe77a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe7b090>, '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 0xe7bd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe75f90>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1505557626.386648-895086720', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:27:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 03:27:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:27:43 INFO - Using env: {'DISPLAY': ':0', 03:27:43 INFO - 'HOME': '/home/cltbld', 03:27:43 INFO - 'LANG': 'en_US.UTF-8', 03:27:43 INFO - 'LANGUAGE': 'en_US:en', 03:27:43 INFO - 'LOGNAME': 'cltbld', 03:27:43 INFO - 'MAIL': '/var/mail/cltbld', 03:27:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:27:43 INFO - 'MOZ_NO_REMOTE': '1', 03:27:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:27:43 INFO - 'NO_EM_RESTART': '1', 03:27:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:27:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:27:43 INFO - 'PWD': '/builds/slave/test', 03:27:43 INFO - 'SHELL': '/bin/bash', 03:27:43 INFO - 'SHLVL': '1', 03:27:43 INFO - 'TERM': 'linux', 03:27:43 INFO - 'TMOUT': '86400', 03:27:43 INFO - 'USER': 'cltbld', 03:27:43 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1505557626.386648-895086720', 03:27:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:27:43 INFO - '_': '/tools/buildbot/bin/python'} 03:27:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:27:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:27:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 03:27:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:27:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:27:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 03:27:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 03:27:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 03:27:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 03:27:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 03:27:43 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:27:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:27:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:27:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:27:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:27:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 03:27:44 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:27:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:27:44 INFO - Installing collected packages: simplejson 03:27:44 INFO - Running setup.py install for simplejson 03:27:44 INFO - building 'simplejson._speedups' extension 03:27:44 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 03:27:45 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 03:27:45 INFO - Successfully installed simplejson 03:27:45 INFO - Cleaning up... 03:27:45 INFO - Return code: 0 03:27:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:27:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:27:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:27:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:27:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:27:45 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 0xb0b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcd4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe77a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe7b090>, '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 0xe7bd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe75f90>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1505557626.386648-895086720', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:27:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:27:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:27:45 INFO - Using env: {'DISPLAY': ':0', 03:27:45 INFO - 'HOME': '/home/cltbld', 03:27:45 INFO - 'LANG': 'en_US.UTF-8', 03:27:45 INFO - 'LANGUAGE': 'en_US:en', 03:27:45 INFO - 'LOGNAME': 'cltbld', 03:27:45 INFO - 'MAIL': '/var/mail/cltbld', 03:27:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:27:45 INFO - 'MOZ_NO_REMOTE': '1', 03:27:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:27:45 INFO - 'NO_EM_RESTART': '1', 03:27:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:27:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:27:45 INFO - 'PWD': '/builds/slave/test', 03:27:45 INFO - 'SHELL': '/bin/bash', 03:27:45 INFO - 'SHLVL': '1', 03:27:45 INFO - 'TERM': 'linux', 03:27:45 INFO - 'TMOUT': '86400', 03:27:45 INFO - 'USER': 'cltbld', 03:27:45 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1505557626.386648-895086720', 03:27:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:27:45 INFO - '_': '/tools/buildbot/bin/python'} 03:27:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:27:46 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:27:46 INFO - Cleaning up... 03:27:46 INFO - Return code: 0 03:27:46 INFO - Running post-action listener: _resource_record_post_action 03:27:46 INFO - Running post-action listener: _start_resource_monitoring 03:27:46 INFO - Starting resource monitoring. 03:27:46 INFO - [mozharness: 2017-09-16 10:27:46.049395Z] Finished create-virtualenv step (success) 03:27:46 INFO - [mozharness: 2017-09-16 10:27:46.049903Z] Running install step. 03:27:46 INFO - Running pre-action listener: _resource_record_pre_action 03:27:46 INFO - Running main action method: install 03:27:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:27:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:27:46 INFO - Reading from file tmpfile_stdout 03:27:46 INFO - Detecting whether we're running mozinstall >=1.0... 03:27:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:27:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:27:46 INFO - Reading from file tmpfile_stdout 03:27:46 INFO - Output received: 03:27:46 INFO - Usage: mozinstall [options] installer 03:27:46 INFO - Options: 03:27:46 INFO - -h, --help show this help message and exit 03:27:46 INFO - -d DEST, --destination=DEST 03:27:46 INFO - Directory to install application into. [default: 03:27:46 INFO - "/builds/slave/test"] 03:27:46 INFO - --app=APP Application being installed. [default: firefox] 03:27:46 INFO - mkdir: /builds/slave/test/build/application 03:27:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:27:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 03:28:04 INFO - Reading from file tmpfile_stdout 03:28:04 INFO - Output received: 03:28:04 INFO - /builds/slave/test/build/application/firefox/firefox 03:28:04 INFO - Running post-action listener: _resource_record_post_action 03:28:04 INFO - [mozharness: 2017-09-16 10:28:04.282132Z] Finished install step (success) 03:28:04 INFO - [mozharness: 2017-09-16 10:28:04.282280Z] Running setup-mitmproxy step. 03:28:04 INFO - Running pre-action listener: _resource_record_pre_action 03:28:04 INFO - Running main action method: setup_mitmproxy 03:28:04 INFO - Skipping: mitmproxy is not required 03:28:04 INFO - Running post-action listener: _resource_record_post_action 03:28:04 INFO - [mozharness: 2017-09-16 10:28:04.282805Z] Finished setup-mitmproxy step (success) 03:28:04 INFO - [mozharness: 2017-09-16 10:28:04.282908Z] Running run-tests step. 03:28:04 INFO - Running pre-action listener: _resource_record_pre_action 03:28:04 INFO - Running pre-action listener: _set_gcov_prefix 03:28:04 INFO - Running main action method: run_tests 03:28:04 WARNING - Try message not found. 03:28:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:28:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:28:04 INFO - Python 2.7.3 03:28:04 INFO - Return code: 0 03:28:04 INFO - grabbing minidump binary from tooltool 03:28:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:28:04 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 0xe7b090>, '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 0xe7bd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe75f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:28:04 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 03:28:04 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 03:28:04 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 03:28:04 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:28:04 INFO - Return code: 0 03:28:04 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:28:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:28:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:28:04 INFO - ENV: RUST_BACKTRACE is now full 03:28:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:28:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:28:04 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/QKXeurjvQniffQGOJwEu5g/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--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 03:28:04 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/QKXeurjvQniffQGOJwEu5g/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-041 --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 03:28:04 INFO - Using env: {'DISPLAY': ':0', 03:28:04 INFO - 'HOME': '/home/cltbld', 03:28:04 INFO - 'LANG': 'en_US.UTF-8', 03:28:04 INFO - 'LANGUAGE': 'en_US:en', 03:28:04 INFO - 'LOGNAME': 'cltbld', 03:28:04 INFO - 'MAIL': '/var/mail/cltbld', 03:28:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:28:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:28:04 INFO - 'MOZ_ACCELERATED': '1', 03:28:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:04 INFO - 'MOZ_NO_REMOTE': '1', 03:28:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:28:04 INFO - 'MOZ_WEBRENDER': '1', 03:28:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:28:04 INFO - 'NO_EM_RESTART': '1', 03:28:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:28:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:04 INFO - 'PWD': '/builds/slave/test', 03:28:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:28:04 INFO - 'RUST_BACKTRACE': 'full', 03:28:04 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:28:04 INFO - 'SHELL': '/bin/bash', 03:28:04 INFO - 'SHLVL': '1', 03:28:04 INFO - 'TERM': 'linux', 03:28:04 INFO - 'TMOUT': '86400', 03:28:04 INFO - 'USER': 'cltbld', 03:28:04 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1505557626.386648-895086720', 03:28:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:04 INFO - '_': '/tools/buildbot/bin/python'} 03:28:04 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/QKXeurjvQniffQGOJwEu5g/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--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 03:28:04 INFO - mozversion application_buildid: 20170916093526 03:28:04 INFO - mozversion application_changeset: 27e7b4261e4b5a016e09adb5332a181e43ab520e 03:28:04 INFO - mozversion application_display_name: Nightly 03:28:04 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:28:04 INFO - mozversion application_name: Firefox 03:28:04 INFO - mozversion application_remotingname: firefox 03:28:04 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:28:04 INFO - mozversion application_vendor: Mozilla 03:28:04 INFO - mozversion application_version: 57.0a1 03:28:04 INFO - mozversion platform_buildid: 20170916093526 03:28:04 INFO - mozversion platform_changeset: 27e7b4261e4b5a016e09adb5332a181e43ab520e 03:28:04 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:28:04 INFO - mozversion platform_version: 57.0a1 03:28:04 INFO - using testdate: 1505557684 03:28:04 INFO - actual date: 1505557684 03:28:04 INFO - starting webserver on 'localhost:50682' 03:28:04 INFO - SUITE-START | Running 2 tests 03:28:04 INFO - TEST-START | dromaeo_css 03:28:04 INFO - Initialising browser for dromaeo_css test... 03:28:04 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:50682/getInfo.html -profile /tmp/tmpQDLlX_/profile 03:28:04 INFO - TEST-INFO | started process 17683 (/builds/slave/test/build/application/firefox/firefox http://localhost:50682/getInfo.html) 03:28:11 INFO - TEST-INFO | 17683: exit 0 03:28:11 INFO - Browser initialized. 03:28:11 INFO - Running cycle 1/1 for dromaeo_css test... 03:28:11 INFO - Using env: {'DISPLAY': ':0', 03:28:11 INFO - 'HOME': '/home/cltbld', 03:28:11 INFO - 'JSGC_DISABLE_POISONING': '1', 03:28:11 INFO - 'LANG': 'en_US.UTF-8', 03:28:11 INFO - 'LANGUAGE': 'en_US:en', 03:28:11 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 03:28:11 INFO - 'LOGNAME': 'cltbld', 03:28:11 INFO - 'MAIL': '/var/mail/cltbld', 03:28:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:28:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:28:11 INFO - 'MOZ_ACCELERATED': '1', 03:28:11 INFO - 'MOZ_CRASHREPORTER': '1', 03:28:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:11 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 03:28:11 INFO - 'MOZ_NO_REMOTE': '1', 03:28:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:28:11 INFO - 'MOZ_WEBRENDER': '1', 03:28:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:28:11 INFO - 'NO_EM_RESTART': '1', 03:28:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:28:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:11 INFO - 'PWD': '/builds/slave/test', 03:28:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:28:11 INFO - 'RUST_BACKTRACE': 'full', 03:28:11 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:28:11 INFO - 'SHELL': '/bin/bash', 03:28:11 INFO - 'SHLVL': '1', 03:28:11 INFO - 'TERM': 'linux', 03:28:11 INFO - 'TMOUT': '86400', 03:28:11 INFO - 'USER': 'cltbld', 03:28:11 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1505557626.386648-895086720', 03:28:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:11 INFO - '_': '/tools/buildbot/bin/python'} 03:28:11 INFO - TEST-INFO | started process 17926 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQDLlX_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:28:12 INFO - PID 17926 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 03:28:12 INFO - PID 17926 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 03:28:12 INFO - PID 17926 | 03:28:12 INFO - PID 17926 | (/builds/slave/test/build/application/firefox/firefox:17985): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:28:12 INFO - PID 17926 | 03:28:23 INFO - PID 17926 | RSS: Main: 184561664 03:28:23 INFO - PID 17926 | 03:31:19 INFO - PID 17926 | Cycle 1(1): loaded http://localhost:50682/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50682/tests/dromaeo/cssquery-ext.html) 03:31:21 INFO - PID 17926 | RSS: Main: 192077824 03:31:21 INFO - PID 17926 | 03:34:23 INFO - PID 17926 | Cycle 1(1): loaded http://localhost:50682/tests/dromaeo/cssquery-ext.html (next: http://localhost:50682/tests/dromaeo/cssquery-jquery.html) 03:34:24 INFO - PID 17926 | RSS: Main: 190545920 03:34:24 INFO - PID 17926 | 03:37:26 INFO - PID 17926 | Cycle 1(1): loaded http://localhost:50682/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50682/tests/dromaeo/cssquery-mootools.html) 03:37:26 INFO - PID 17926 | RSS: Main: 191655936 03:37:26 INFO - PID 17926 | 03:40:28 INFO - PID 17926 | Cycle 1(1): loaded http://localhost:50682/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50682/tests/dromaeo/cssquery-prototype.html) 03:40:29 INFO - PID 17926 | RSS: Main: 190095360 03:40:29 INFO - PID 17926 | 03:43:33 INFO - PID 17926 | Cycle 1(1): loaded http://localhost:50682/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50682/tests/dromaeo/cssquery-yui.html) 03:43:34 INFO - PID 17926 | RSS: Main: 191791104 03:43:34 INFO - PID 17926 | 03:46:36 INFO - PID 17926 | Cycle 1(1): loaded http://localhost:50682/tests/dromaeo/cssquery-yui.html (next: http://localhost:50682/tests/dromaeo/cssquery-dojo.html) 03:46:36 INFO - PID 17926 | RSS: Main: 194211840 03:46:36 INFO - PID 17926 | 03:46:36 INFO - PID 17926 | __start_tp_report 03:46:36 INFO - PID 17926 | _x_x_mozilla_page_load 03:46:36 INFO - PID 17926 | _x_x_mozilla_page_load_details 03:46:36 INFO - PID 17926 | |i|pagename|runs| 03:46:36 INFO - PID 17926 | |0;dojo.html;3080.8151510909347;3087.6912308769124;3100.8759649614017;3102.286474110953;3118.6881311868815;6123.938760612393;6194.969025154874;6195.845103872405;6200.844978875531;6286.245650521943;6119.847003824907;6182.907256391158;6225.754849030201;6241.251049874021;6251.2498500180045;5707.457791509821;5719.742611582478;5758.712064396785;5813.30240371156;5843.766249350021;5775.653460792366;5777.740001699934;5795.565332600051;5813.244278243822;5875.559333050017;161.67677955384977;5612.849365879984;5709.514691251248;5739.253896993385;5788.450097240777;5226.216067589854;5631.774729010835;5637.3235211774845;5710.571707121982;5718.971405142947;5669.319681638189;5714.542836573064;5718.399568045378;5724.542036637101;5745.224394706703;6149.046897730859;6199.814005579839;6218.31598524162;6231.345708700566;6279.811605651792;6565;6607.207135143765;6645;6672.099266599044;6752.561083529604;6658.5671931324305;6685.5320127591085;6764.661766911635;6783.830404239884;6786.355296246848;6060.2424696912885;6120.44915957566;6121.938780612181;6126.050462178369;6168.25980882297;6748.392644662004;6751.088603038527;6778.593284402951;6804.727810887608;6805.251422343489;6458.741650333934;6503.544751867324;6507.121538592324;6595.472362211011;6606.405423511811;6631.834204144935;6648.4681225501845;6657.434118100015;6681.064650948871;6723;6610.7686230982645;6645.833854153685;6735.663216839236;6737.6968036438475;6742.932570674328;6504.414602685686;6639.734410623521;6655.134832471845;6673.232578253466;6762.019507171432;5177.171652535576;5230;5243.711595862264;5250.947490525045;5270.7628156733035;4576.794044268016;4615.723056616614;4619.5611416915335;4678.274867395559;4692.835750748775;5641.605087643826;5730.169125476866;5732.885342293131;5807.738651760681;5822.243108395966;6548.934510654833;6612.933870661328;6683.465322774166;6696.330366963362;6703.631300278434;5594.608377413623;5704.4295570443455;5712.542996560265;5718.142278658234;5767.250257466502;5649.604527683105;5667.773289068391;5676.460736230051;5680.6307590007345;5698.287714035746;6357.904631430532;6422.614643121427;6463.224413070461;6494.935050649433;6505.186851643544;6469.77355792545;6553.442957348583;6639.966800165968;6641.767538136335;6642.468602511787;6268.623882567061;6334.398232167937;6405.263394709668;6415.967920160369;6423.454006409507;6377.7767778127545;6515.609063456208;6531.771388001397;6532.542722009413;6535.379138981789;6570.507211959218;6600.702968366531;6629;6636.236832764101;6663.5002374821115;6404.231492220963;6451.838704032437;6468.967655161694;6490.188726409199;6497.5126865484335;6450.612963222034;6458.515611329263;6501.089847421459;6524.804255872142;6567.934320656732;6231.158793562992;6363.809085727436;6368.808935731936;6382.904256436064;6445.4199122079235;6462.1599192106605;6492.415682588589;6494.6103233806125;6507.902381464187;6514.088027676224;6278.686065696788;6296.401841825019;6328.683565821782;6370.74517019314;6398.360163983564 03:46:36 INFO - PID 17926 | |1;ext.html;795.8845967334736;810.2667086286913;811.7524155132684;814.7718638781143;817.5135794202447;40074;43533.56466435335;43670;44029.11941761167;44059.55940440603;40005.599944000554;40056;40332.19335613286;40411.797941010256;40449.19101617966;6975.372216500501;7100.85798284034;7119.928800712004;7144;7178.461615378841;7022.403095736843;7038.788836334893;7085.04351912493;7127.10911136108;7134.250903655119;7030.367266945974;7084.64576771162;7087.503874728771;7088.822779430504;7612.7716168515035;7725.72959946402;7786.221377862168;7788.649510772028;7797.844043119106;7877.291043806085;7603;7636.885446718304;7651.387888968925;7675.769726908202;7688.5386876787015;39079.8046009771;39516.20967580661;39741.80129099365;39785;39848.60151398478;3586.444101164324;3625.492431059654;3629.691476224524;3631;3631.6005239423644;32659.18352041194;32992.340153196805;33029;33063.3387332252;33068;5195.298634684307;5198.090334191501;5244.8688782780355;5257.237700533401;5289.86775330616;182707;182876.08561957238;184610.07694961573;185180;185398;43609;44725.55274447279;50623.49376506188;50702.239466408035;50755.49244507581;46357.30464042975;52699.209511857356;53635.19547206795;53860.73069634627;54005.45994540004;16622.33510659584;16766.916165419094;16878.915605421895;16927.153642317833;16942.915285423493;13612.251326176956;13670.589882303348;13708.65728356799;13711.245881476416;13722.931385343009;14490.927545362205;14582.343794529272;14628.926855365655;14638.341274642667;14648.707025859423;5749.913751293734;5799.797007104731;5888.381719919433;5896.351401345849;5979.9402005980255;998.960041598328;1003.508280942333;1029.1252435429824;1031.159604921986;1038.3199004651815;23335.766642333358;23489.765102349098;23529.882350588137;23745.287641370785;23819.642705359434;1109.2845114900845;1133.5352505472717;1133.5749094089717;1143.5940241214416;1145.7479354541988;12490.75018499625;12562.623121306375;12618.873811261954;12715.364231788373;12763.680907977376;227976;228501;228855;229460;230077;53077.73461132747;53114.734426327625;53499.32503374816;53534.464655353724;53754;1439.0789894467548;1450.8766754825747;1465.9120452772868;1466.8826493880465;1467.1343907094865;23038.539229214988;23234;23319.39466348082;23536.88231558831;23607.881960590086;38128.61871381251;38182.23635527329;38232;38241;38336.61663383442;193781;194284.02857985618;194491;194755;194795;34007.82996085004;34588.30823383468;34796;34884.30231395409;35192.64807351894;42952;43706.34440483459;43821.561784381745;44321.77839110784;44425.33361999508;31535;31918;32011.519827203076;32126.678733212368;32774.67225327811;31316.37367252688;31475.37049259048;31503.36993260168;31642;31865;34937;35879;36003;36261.63738362583;36294.27411451809;31808.6819131815;31844.5223321655;32033.359332813678;32253.838730806197;32323.676763232066;23333.883330583238;23420.531589368456;23547.646785297893;23746.762532374454;23867 03:46:36 INFO - PID 17926 | |2;jquery.html;555.5056000159858;561.6489693941287;569.3480964295882;572.2789285500271;582.8222392170387;21571.13715451382;22159.44601384966;22423.215187468442;22428.66357004646;22429.214977475793;22627.660585091195;24343.75656243437;24906.252812415612;24940.376490587743;25066.749332506668;6338.6513741744075;6572.638504882229;6602.768903088393;6608.7686930957425;6614.107095542113;6472.805815825533;6493.448056915145;6502.5448218624715;6505.4145126938565;6556.147700798913;6397.872042559146;6532.412082912537;6547.116139321179;6644;6652.201735791712;6586.769463068794;6596.736130554772;6643.302453242437;6643.56816806906;6647.534672572921;5925.466707996301;6073.18012068374;6114.908276375858;6119.694015299217;6155.907661385083;27873;28462.146135615963;28486.572701409495;28518.144455666363;28528.572071418945;2017.1830408684507;2021.1309137071053;2045.5602045560126;2046.549759053006;2046.9897650511653;18866.528336791554;19609.509762255915;19973.400797976083;20059.498512537157;20060.69908951367;2363.4564050268364;2397.916072937456;2419.52819200256;2426.8301218914685;2427.5873101572774;125946;132011;135881;146038;146826.53173468236;14399.200207789161;14472.204028778307;14603.342849571794;14672.972891897678;15005.774913376308;22747.545049098924;22764.4308892279;22784.658230126563;22790.31629051131;22809.83306585872;9942.552585133542;10037.297389182688;10144.49277536135;10186.286959912735;10215.23385746072;9368.2973776967;9561.569729362196;9576.23390128788;9678.56446459911;9718.757031074138;8771.122887711306;8879.378443509022;8934.4192627479;9178.816423671622;9292.72121836346;2707.9323016924736;2712.4303896181627;2726.6591676040493;2732.9590056149173;2769.7368749969123;940.3041749105613;945.0832692288469;948.1463738391428;963.8698775665196;987.1855719031828;18817.15322810477;19132.808671913383;19230.423087307405;19323.903380483007;19674.213031478866;1031.3554028732042;1037.4553359486179;1044.7440377107657;1054.4306074719718;1057.2652006855315;10761.677149685522;10783.56865725378;10799.514021869034;10822.242443028912;10865.348079115278;430935;440502;440632;447520;449317;109300;112730;112993.43503282432;113471;113756;1131.7170707323169;1159.0379984612919;1159.5535718748342;1169.2867350915935;1170.5727409495644;17039.82960170432;17290.221940012478;17661.558461038578;17665.470035898943;17812.55468613295;53377.19934201068;54498.727506362215;54705.17942230949;55574;56088.43911560995;70483.29516704768;70805.64597176982;71159;71944.64027679828;72004.63997680187;13719.176849389069;13968.30158492051;14026.859731402963;14150.50473233473;14235.786463203267;21637;21793.455163621038;21850.01674924664;22003.669944950518;22080;16472.0940348282;16560.751588725936;16575.83424165743;16870.240839162514;17686.734698979784;15721.764173537178;15790.526284211492;16201.59496012609;16341.918290408947;16407.17964101766;16087.436939707053;16270;16280.837191627932;16335;16356.100414477318;13740.725185496034;13841.792373114613;13905.930470347988;13966.441342346192;13989.510367137102;15281.6179595511;17106.65786684284;17410.303587856342;17482.125893705008;17526.912365438602 03:46:36 INFO - PID 17926 | |3;mootools.html;1325.0989327257464;1365.644932317597;1379.6343968848257;1389.5275606293858;1395.4836710417146;14935.850641493582;15626.531204063882;15723.764143537828;15787.605309867246;15801.762973555376;15504.767428488582;15641.374345026214;15664.451744188955;15667.92166039171;15671.373145074213;2759.351552385188;2779.4163225722623;2800.061979236958;2810.9718902810914;2830.943381132376;2670.906518271861;2753.8623068846578;2759.862006899657;2769.3076730817297;2777.375090604618;2647.576387777956;2652.986735066322;2686;2745.437185377003;2746.5880117982265;2779.555271156615;2781.2629653141935;2788.6196332815184;2794.147784925597;2798.776097912162;2614.1242683700984;2655.960160597573;2657.2958166086005;2657.6810782706007;2675.5852842809395;14940.95413321068;15022;15199.468018619405;15685.05889646625;15782;8128.227818357246;8378.371622128365;8387.622556984888;8388.035375931784;8406.369522285853;5511.614187006911;5642.520385767215;5716.256886604757;5780.421957804228;5831.212786273841;1922.7692676878864;1932.159510612888;1942.8348590369835;1965.4398496428448;1968.517713160285;26556.203313900613;26734.33164170892;26807.329816754347;26821.32946676329;26831.73168268312;6784.626845523445;6917.965410172917;6931.480138989596;7030.753923612751;7103.218645948941;17341.306347746202;17457.21442535089;17504.21231044606;17510.562235943948;17562.29750809979;7643.464957452925;8491.320694344438;8515.148485151436;8532.616032278562;8540.530270835165;7447.627618619047;7494;7576.924230757621;7618.352440042659;7672;5068.873278168002;5167.560757335594;5183.870403239874;5319.973400132974;5354.571634269249;1511.6523199664139;1514.3498876965311;1524.4283393727353;1528.8394718554614;1533.6472611299241;906.7642412972675;916.1800188831093;925.2181906289175;925.8379783537854;931.3434029009532;7600.50596711212;7789.104253010976;7822.139564647884;7831.412644051605;7892.171322011106;690.892911598703;692.9757458488929;698.1866125963297;702.8594281143792;714.257172540552;4535.909281814345;4664.300354946785;5385.488378604026;5462.508374246337;5561.054620714407;20721.481962951046;21817.127314907542;21917.561648766936;22049.559008820055;22117.894105294672;20670.896645516976;21194.682079768816;21741.456463588536;21774;22105.44736381571;10094.141997930112;10104.393736375841;10490.632827851141;10541.736456588647;10614.991575800286;8520.786980325542;8667.653293868427;8687.29713045386;8771.166739160024;8829.072947340694;18420.35528756487;18733.90633046826;18957.336493222672;19144.521386965436;19187.61624767469;19189.712154317418;19673.21307147698;19993.400197994084;20168.49578760543;20471.59056818885;10955.616553420592;10962.342259464458;11098.2786118902;11103.278286911325;11107.444627768418;14090.718185636435;14313.928430357782;14355.066920650124;14361.425542978164;14362.569122926328;11121.332720036824;11246.775064498828;11360.772784544428;11415.714607134889;11552.191346605992;10914.836277455686;10944.835827462435;10954.452277386259;11060.336379817236;11192.160587955774;9857.507124643882;10197.388156710622;10222.488875556044;10222.948885255824;10319.48402579883;7082.610456424946;7134.215236324104;7200.99186113934;7218.169910460154;7332.046833911771;7247.166575843846;7332.96333518329;7376.7049318026675;7380.003699500713;7432.888506672512 03:46:36 INFO - PID 17926 | |4;prototype.html;464.3313628375137;496.8410108765194;499.90217178634316;500.0548962460949;515.8400895722325;6118.296395914465;6136;6188.5358598105095;6239.407256310649;6276.937230627704;6030.1256317833995;6097.451229389354;6114.755409783604;6135.601185922912;6155.6306621602735;5005.624578156644;5057.216131499624;5067.163917953533;5068.8225912093085;5095;5070.8732281693065;5102.821401250957;5108.8978220435565;5111.718855462948;5142.614303927202;4748.762561871893;4886;4894.755262236892;4936.259561065851;5032.949670503303;4868.707877527359;4873.853784386474;4911.484294149116;4931.630127740415;4951.257311403282;4403.669724770655;4427.977860110711;4430.645548356124;4431.357453169305;4439.889002774924;5951.613145145551;5970.850728731773;6003.879922401527;6045.244344456943;6113.602615829956;5611.494965453088;5640.351359593658;5641.351244606882;5662.8301150965535;5670.404607516192;6467.579607325556;6483.643399613019;6484.546081774278;6532.608043517404;6551.102094253912;4538.591526762607;4703.482616912137;4808.980228304121;4819.638377195149;4839.854804355875;6546.44355229806;6547.738090476375;6623.43700785429;6668.93331066688;6765.797026089225;4872.537108974641;4889.217725163957;4906.754662266943;4929.556339929423;4930.852074437773;4953;4981.8329026873425;5000.1249781288125;5000.574951129122;5025.673331233531;5509.724513774296;5516.862078447991;5530.640508367023;5534.335879694462;5641.407652196543;6432.35676432353;6495.64273964927;6538.215414150332;6539.411452969255;6595.307492713292;1725.767021452113;1745.1623220853808;1746.6943284925342;1754.298280687735;1758.7449819776061;1145.5417832866754;1200.9519619215134;1201.9338936358583;1215.343714394235;1223.730779228586;5583.134614134816;5621.662700237999;5639.577031722637;5662.801801936913;5675.432456754292;6472.805815825533;6494.532077810496;6545.509086818508;6580.170526673481;6594.604323740591;5602.775888964477;5606.60753747242;5608.85977850557;5642.830715078554;5675.687837168913;3308.966910330914;3418.5555877735737;3428.6228514863346;3469.9826500867334;3498.8600455981477;6213.378662133841;6241.531885108635;6290.21372328459;6291.748330066837;6326.525510586633;6625.469962402996;6660.6336651484635;6710.228323742735;6728;6738.831529211711;6126.571140020245;6222.471089957405;6314.8737025258315;6318.589291696025;6322;6496.447801936888;6655.434288085373;6663.666816659051;6670.733170673118;6671.633060181736;6378.48972082223;6421.518386121153;6430.935690643221;6452.548321617442;6599.60402375859;6310.810675679737;6358.682065896779;6359.523035772243;6371.904421433589;6411.839704007437;4903.705777653352;4905.3623029006;4946.925796113133;4974.950250497449;4988.5260900214425;6290.968545157245;6529.967350163219;6546.869062618816;6619.60988192485;6683.832904177434;6193.411625895533;6293.653849038347;6362.904556431565;6398.264199617103;6493.480521558169;6350.142730731292;6443.291237963726;6464.41820236181;6466.838329041623;6533.8693226136165;6248.281447633581;6269;6273.215848018997;6318.399752023551;6380.202474690664;6429.38920802523;6441.615052763678;6518.282988871126;6553.377429144223;6558.901616475852;6283.5287353449585;6290.811275661737;6295.52055267021;6332.841678957879;6372.681365931778 03:46:36 INFO - PID 17926 | |5;yui.html;898.3621628643663;900.8738776571281;921.424109931293;925.31064357054;938.6620816506058;19037.904810475946;20287.08708108135;20310.898445507788;20317.796822031774;20412.59174816503;18613.813861861378;18752.531186720338;18756.71864922027;18784.436466906016;18872.811271887276;922.9815403691939;939.3002213351064;944.1266828183902;945.6973768394116;948.3882895532378;952.6189524190345;952.8904176019777;954.2127744610689;954.7947191353858;955.5174636808437;995.437577768562;998.1366118307648;1007.7631756537207;1037.3620223562493;1046.2937517175915;1046.7226185060965;1047.0419566097012;1047.6280920273307;1048.7745134796055;1049.0820532034509;746.123305116486;752.2740555364045;752.2778132992333;752.7252552818182;753.3182469864781;18354.90822545892;19306.80693193064;19386.80613193878;19504.609907801765;19532.511687207792;21430.89284553583;21981.34055978323;22446.88776556123;22788.886055569783;22799.88600056989;17498.47504574852;17528.912355438268;17570.472885813448;17587;17631.823681763148;3750.456183853326;3756.0609847538117;3800.8289626966575;3802.6007269236884;3808.5810560838286;128182.35908820489;141923;141982;143907.28046359806;143956;17878.821211787978;17900.55248618795;18342.266309347742;18575.81424185768;18626.44120676382;31548;31962;32103.678963210536;32112.83943580267;32184.678153218636;8884.156005179497;8971.327150463741;9094.454332739924;9130.680426185052;9149.268058555299;4260.573942605714;4381.9342709859375;4411.316245981878;4419.005723712139;4420.160169567772;5401.783928642811;5466.9179962300595;5539.390667026624;5542.63972841764;5582.944170558242;1071.796358691846;1108.5233349659725;1111.3554138599593;1115.7433790228292;1116.6482557994207;667.9599224046573;677.576514678326;701.2216439751871;703.0754557756534;704.844934114494;12179.87820121805;12200.389980500939;12333.828286312786;12436.067294952914;13043.28261945602;688.5730846874969;691.2603514239715;704.1690804850224;716.6846587501483;717.8384863405796;5561.277033985556;5583.8883222336135;5599.552035837123;5699.116636921284;5715.885682286331;130968.3451582736;131000;131765;132956;133044.33477832744;108630;111161;111574;113191;113657;93652.53173734088;93675.53162234146;96756.51621741986;97852;99997.50001249947;10581.735456613646;10734.946325268324;10741.46292685347;10789.244752867224;10985.780284394426;46007.30989035234;46233.30650040185;47289;47915.281270780266;48354;59285;60729.69635151973;60997.39002609917;61149;61431.38568614257;15679.216039198223;16021.439249626674;16040.518784436486;16054.67890642204;16150.838491614933;17039.40362087321;17098.572535686708;17994.820051799314;18126.637467250846;18187.909060454615;15288.694226115193;15565.76651350208;15586.766198506804;15655.530334089995;15709.214539272762;15914;16003.679926401639;16050;16075.678486430439;16342.754858676892;15783.210839457752;16067.11630860314;16069;16199.109049002418;16457.341706331612;12704.74590508203;12761.61715148547;12942.288174150512;13162.670933226746;13308.268045257604;12408.379581021094;12435.316057616918;12599.622011339308;12745.745085098431;12797.97616190721 03:46:36 INFO - PID 17926 | __end_tp_report 03:46:36 INFO - PID 17926 | __start_cc_report 03:46:36 INFO - PID 17926 | _x_x_mozilla_cycle_collect,297 03:46:36 INFO - PID 17926 | __end_cc_report 03:46:36 INFO - PID 17926 | __startTimestamp1505558796304__endTimestamp 03:46:36 INFO - PID 17926 | 03:46:36 INFO - PID 17926 | ------- Summary: start ------- 03:46:36 INFO - PID 17926 | Number of tests: 6 03:46:36 INFO - PID 17926 | 03:46:36 INFO - PID 17926 | [#0] dojo.html Cycles:165 Average:6070.89 Median:6363.81 stddev:861.27 (13.5%) stddev-sans-first:831.36 03:46:36 INFO - PID 17926 | Values: 3080.8 3087.7 3100.9 3102.3 3118.7 6123.9 6195.0 6195.8 6200.8 6286.2 6119.8 6182.9 6225.8 6241.3 6251.2 5707.5 5719.7 5758.7 5813.3 5843.8 5775.7 5777.7 5795.6 5813.2 5875.6 161.7 5612.8 5709.5 5739.3 5788.5 5226.2 5631.8 5637.3 5710.6 5719.0 5669.3 5714.5 5718.4 5724.5 5745.2 6149.0 6199.8 6218.3 6231.3 6279.8 6565.0 6607.2 6645.0 6672.1 6752.6 6658.6 6685.5 6764.7 6783.8 6786.4 6060.2 6120.4 6121.9 6126.1 6168.3 6748.4 6751.1 6778.6 6804.7 6805.3 6458.7 6503.5 6507.1 6595.5 6606.4 6631.8 6648.5 6657.4 6681.1 6723.0 6610.8 6645.8 6735.7 6737.7 6742.9 6504.4 6639.7 6655.1 6673.2 6762.0 5177.2 5230.0 5243.7 5250.9 5270.8 4576.8 4615.7 4619.6 4678.3 4692.8 5641.6 5730.2 5732.9 5807.7 5822.2 6548.9 6612.9 6683.5 6696.3 6703.6 5594.6 5704.4 5712.5 5718.1 5767.3 5649.6 5667.8 5676.5 5680.6 5698.3 6357.9 6422.6 6463.2 6494.9 6505.2 6469.8 6553.4 6640.0 6641.8 6642.5 6268.6 6334.4 6405.3 6416.0 6423.5 6377.8 6515.6 6531.8 6532.5 6535.4 6570.5 6600.7 6629.0 6636.2 6663.5 6404.2 6451.8 6469.0 6490.2 6497.5 6450.6 6458.5 6501.1 6524.8 6567.9 6231.2 6363.8 6368.8 6382.9 6445.4 6462.2 6492.4 6494.6 6507.9 6514.1 6278.7 6296.4 6328.7 6370.7 6398.4 03:46:36 INFO - PID 17926 | 03:46:36 INFO - PID 17926 | [#1] ext.html Cycles:180 Average:37487.65 Median:19732.72 stddev:52682.49 (267.0%) stddev-sans-first:52758.23 03:46:36 INFO - PID 17926 | Values: 795.9 810.3 811.8 814.8 817.5 40074.0 43533.6 43670.0 44029.1 44059.6 40005.6 40056.0 40332.2 40411.8 40449.2 6975.4 7100.9 7119.9 7144.0 7178.5 7022.4 7038.8 7085.0 7127.1 7134.3 7030.4 7084.6 7087.5 7088.8 7612.8 7725.7 7786.2 7788.6 7797.8 7877.3 7603.0 7636.9 7651.4 7675.8 7688.5 39079.8 39516.2 39741.8 39785.0 39848.6 3586.4 3625.5 3629.7 3631.0 3631.6 32659.2 32992.3 33029.0 33063.3 33068.0 5195.3 5198.1 5244.9 5257.2 5289.9 182707.0 182876.1 184610.1 185180.0 185398.0 43609.0 44725.6 50623.5 50702.2 50755.5 46357.3 52699.2 53635.2 53860.7 54005.5 16622.3 16766.9 16878.9 16927.2 16942.9 13612.3 13670.6 13708.7 13711.2 13722.9 14490.9 14582.3 14628.9 14638.3 14648.7 5749.9 5799.8 5888.4 5896.4 5979.9 999.0 1003.5 1029.1 1031.2 1038.3 23335.8 23489.8 23529.9 23745.3 23819.6 1109.3 1133.5 1133.6 1143.6 1145.7 12490.8 12562.6 12618.9 12715.4 12763.7 227976.0 228501.0 228855.0 229460.0 230077.0 53077.7 53114.7 53499.3 53534.5 53754.0 1439.1 1450.9 1465.9 1466.9 1467.1 23038.5 23234.0 23319.4 23536.9 23607.9 38128.6 38182.2 38232.0 38241.0 38336.6 193781.0 194284.0 194491.0 194755.0 194795.0 34007.8 34588.3 34796.0 34884.3 35192.6 42952.0 43706.3 43821.6 44321.8 44425.3 31535.0 31918.0 32011.5 32126.7 32774.7 31316.4 31475.4 31503.4 31642.0 31865.0 34937.0 35879.0 36003.0 36261.6 36294.3 31808.7 31844.5 32033.4 32253.8 32323.7 23333.9 23420.5 23547.6 23746.8 23867.0 03:46:36 INFO - PID 17926 | 03:46:36 INFO - PID 17926 | [#2] jquery.html Cycles:180 Average:32920.99 Median:22291.33 stddev:75142.08 (337.1%) stddev-sans-first:75313.58 03:46:36 INFO - PID 17926 | Values: 555.5 561.6 569.3 572.3 582.8 21571.1 22159.4 22423.2 22428.7 22429.2 22627.7 24343.8 24906.3 24940.4 25066.7 6338.7 6572.6 6602.8 6608.8 6614.1 6472.8 6493.4 6502.5 6505.4 6556.1 6397.9 6532.4 6547.1 6644.0 6652.2 6586.8 6596.7 6643.3 6643.6 6647.5 5925.5 6073.2 6114.9 6119.7 6155.9 27873.0 28462.1 28486.6 28518.1 28528.6 2017.2 2021.1 2045.6 2046.5 2047.0 18866.5 19609.5 19973.4 20059.5 20060.7 2363.5 2397.9 2419.5 2426.8 2427.6 125946.0 132011.0 135881.0 146038.0 146826.5 14399.2 14472.2 14603.3 14673.0 15005.8 22747.5 22764.4 22784.7 22790.3 22809.8 9942.6 10037.3 10144.5 10186.3 10215.2 9368.3 9561.6 9576.2 9678.6 9718.8 8771.1 8879.4 8934.4 9178.8 9292.7 2707.9 2712.4 2726.7 2733.0 2769.7 940.3 945.1 948.1 963.9 987.2 18817.2 19132.8 19230.4 19323.9 19674.2 1031.4 1037.5 1044.7 1054.4 1057.3 10761.7 10783.6 10799.5 10822.2 10865.3 430935.0 440502.0 440632.0 447520.0 449317.0 109300.0 112730.0 112993.4 113471.0 113756.0 1131.7 1159.0 1159.6 1169.3 1170.6 17039.8 17290.2 17661.6 17665.5 17812.6 53377.2 54498.7 54705.2 55574.0 56088.4 70483.3 70805.6 71159.0 71944.6 72004.6 13719.2 13968.3 14026.9 14150.5 14235.8 21637.0 21793.5 21850.0 22003.7 22080.0 16472.1 16560.8 16575.8 16870.2 17686.7 15721.8 15790.5 16201.6 16341.9 16407.2 16087.4 16270.0 16280.8 16335.0 16356.1 13740.7 13841.8 13905.9 13966.4 13989.5 15281.6 17106.7 17410.3 17482.1 17526.9 03:46:36 INFO - PID 17926 | 03:46:36 INFO - PID 17926 | [#3] mootools.html Cycles:180 Average:9427.74 Median:2664.29 stddev:6764.00 (253.9%) stddev-sans-first:6755.58 03:46:36 INFO - PID 17926 | Values: 1325.1 1365.6 1379.6 1389.5 1395.5 14935.9 15626.5 15723.8 15787.6 15801.8 15504.8 15641.4 15664.5 15667.9 15671.4 2759.4 2779.4 2800.1 2811.0 2830.9 2670.9 2753.9 2759.9 2769.3 2777.4 2647.6 2653.0 2686.0 2745.4 2746.6 2779.6 2781.3 2788.6 2794.1 2798.8 2614.1 2656.0 2657.3 2657.7 2675.6 14941.0 15022.0 15199.5 15685.1 15782.0 8128.2 8378.4 8387.6 8388.0 8406.4 5511.6 5642.5 5716.3 5780.4 5831.2 1922.8 1932.2 1942.8 1965.4 1968.5 26556.2 26734.3 26807.3 26821.3 26831.7 6784.6 6918.0 6931.5 7030.8 7103.2 17341.3 17457.2 17504.2 17510.6 17562.3 7643.5 8491.3 8515.1 8532.6 8540.5 7447.6 7494.0 7576.9 7618.4 7672.0 5068.9 5167.6 5183.9 5320.0 5354.6 1511.7 1514.3 1524.4 1528.8 1533.6 906.8 916.2 925.2 925.8 931.3 7600.5 7789.1 7822.1 7831.4 7892.2 690.9 693.0 698.2 702.9 714.3 4535.9 4664.3 5385.5 5462.5 5561.1 20721.5 21817.1 21917.6 22049.6 22117.9 20670.9 21194.7 21741.5 21774.0 22105.4 10094.1 10104.4 10490.6 10541.7 10615.0 8520.8 8667.7 8687.3 8771.2 8829.1 18420.4 18733.9 18957.3 19144.5 19187.6 19189.7 19673.2 19993.4 20168.5 20471.6 10955.6 10962.3 11098.3 11103.3 11107.4 14090.7 14313.9 14355.1 14361.4 14362.6 11121.3 11246.8 11360.8 11415.7 11552.2 10914.8 10944.8 10954.5 11060.3 11192.2 9857.5 10197.4 10222.5 10222.9 10319.5 7082.6 7134.2 7201.0 7218.2 7332.0 7247.2 7333.0 7376.7 7380.0 7432.9 03:46:36 INFO - PID 17926 | 03:46:36 INFO - PID 17926 | [#4] prototype.html Cycles:180 Average:5414.89 Median:6105.53 stddev:1509.99 (24.7%) stddev-sans-first:1467.80 03:46:36 INFO - PID 17926 | Values: 464.3 496.8 499.9 500.1 515.8 6118.3 6136.0 6188.5 6239.4 6276.9 6030.1 6097.5 6114.8 6135.6 6155.6 5005.6 5057.2 5067.2 5068.8 5095.0 5070.9 5102.8 5108.9 5111.7 5142.6 4748.8 4886.0 4894.8 4936.3 5032.9 4868.7 4873.9 4911.5 4931.6 4951.3 4403.7 4428.0 4430.6 4431.4 4439.9 5951.6 5970.9 6003.9 6045.2 6113.6 5611.5 5640.4 5641.4 5662.8 5670.4 6467.6 6483.6 6484.5 6532.6 6551.1 4538.6 4703.5 4809.0 4819.6 4839.9 6546.4 6547.7 6623.4 6668.9 6765.8 4872.5 4889.2 4906.8 4929.6 4930.9 4953.0 4981.8 5000.1 5000.6 5025.7 5509.7 5516.9 5530.6 5534.3 5641.4 6432.4 6495.6 6538.2 6539.4 6595.3 1725.8 1745.2 1746.7 1754.3 1758.7 1145.5 1201.0 1201.9 1215.3 1223.7 5583.1 5621.7 5639.6 5662.8 5675.4 6472.8 6494.5 6545.5 6580.2 6594.6 5602.8 5606.6 5608.9 5642.8 5675.7 3309.0 3418.6 3428.6 3470.0 3498.9 6213.4 6241.5 6290.2 6291.7 6326.5 6625.5 6660.6 6710.2 6728.0 6738.8 6126.6 6222.5 6314.9 6318.6 6322.0 6496.4 6655.4 6663.7 6670.7 6671.6 6378.5 6421.5 6430.9 6452.5 6599.6 6310.8 6358.7 6359.5 6371.9 6411.8 4903.7 4905.4 4946.9 4975.0 4988.5 6291.0 6530.0 6546.9 6619.6 6683.8 6193.4 6293.7 6362.9 6398.3 6493.5 6350.1 6443.3 6464.4 6466.8 6533.9 6248.3 6269.0 6273.2 6318.4 6380.2 6429.4 6441.6 6518.3 6553.4 6558.9 6283.5 6290.8 6295.5 6332.8 6372.7 03:46:36 INFO - PID 17926 | 03:46:36 INFO - PID 17926 | [#5] yui.html Cycles:180 Average:25074.32 Median:19346.81 stddev:36419.46 (188.2%) stddev-sans-first:36476.38 03:46:36 INFO - PID 17926 | Values: 898.4 900.9 921.4 925.3 938.7 19037.9 20287.1 20310.9 20317.8 20412.6 18613.8 18752.5 18756.7 18784.4 18872.8 923.0 939.3 944.1 945.7 948.4 952.6 952.9 954.2 954.8 955.5 995.4 998.1 1007.8 1037.4 1046.3 1046.7 1047.0 1047.6 1048.8 1049.1 746.1 752.3 752.3 752.7 753.3 18354.9 19306.8 19386.8 19504.6 19532.5 21430.9 21981.3 22446.9 22788.9 22799.9 17498.5 17528.9 17570.5 17587.0 17631.8 3750.5 3756.1 3800.8 3802.6 3808.6 128182.4 141923.0 141982.0 143907.3 143956.0 17878.8 17900.6 18342.3 18575.8 18626.4 31548.0 31962.0 32103.7 32112.8 32184.7 8884.2 8971.3 9094.5 9130.7 9149.3 4260.6 4381.9 4411.3 4419.0 4420.2 5401.8 5466.9 5539.4 5542.6 5582.9 1071.8 1108.5 1111.4 1115.7 1116.6 668.0 677.6 701.2 703.1 704.8 12179.9 12200.4 12333.8 12436.1 13043.3 688.6 691.3 704.2 716.7 717.8 5561.3 5583.9 5599.6 5699.1 5715.9 130968.3 131000.0 131765.0 132956.0 133044.3 108630.0 111161.0 111574.0 113191.0 113657.0 93652.5 93675.5 96756.5 97852.0 99997.5 10581.7 10734.9 10741.5 10789.2 10985.8 46007.3 46233.3 47289.0 47915.3 48354.0 59285.0 60729.7 60997.4 61149.0 61431.4 15679.2 16021.4 16040.5 16054.7 16150.8 17039.4 17098.6 17994.8 18126.6 18187.9 15288.7 15565.8 15586.8 15655.5 15709.2 15914.0 16003.7 16050.0 16075.7 16342.8 15783.2 16067.1 16069.0 16199.1 16457.3 12704.7 12761.6 12942.3 13162.7 13308.3 12408.4 12435.3 12599.6 12745.7 12798.0 03:46:36 INFO - PID 17926 | -------- Summary: end -------- 03:46:36 INFO - PID 17926 | 03:46:37 INFO - TEST-INFO | 17926: exit 0 03:46:37 INFO - TEST-OK | dromaeo_css | took 1112579ms 03:46:37 INFO - TEST-START | kraken 03:46:37 INFO - Initialising browser for kraken test... 03:46:37 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:50682/getInfo.html -profile /tmp/tmpvdZUfk/profile 03:46:37 INFO - TEST-INFO | started process 18312 (/builds/slave/test/build/application/firefox/firefox http://localhost:50682/getInfo.html) 03:46:43 INFO - TEST-INFO | 18312: exit 0 03:46:43 INFO - Browser initialized. 03:46:43 INFO - Running cycle 1/1 for kraken test... 03:46:43 INFO - Using env: {'DISPLAY': ':0', 03:46:43 INFO - 'HOME': '/home/cltbld', 03:46:43 INFO - 'JSGC_DISABLE_POISONING': '1', 03:46:43 INFO - 'LANG': 'en_US.UTF-8', 03:46:43 INFO - 'LANGUAGE': 'en_US:en', 03:46:43 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 03:46:43 INFO - 'LOGNAME': 'cltbld', 03:46:43 INFO - 'MAIL': '/var/mail/cltbld', 03:46:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:46:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:46:43 INFO - 'MOZ_ACCELERATED': '1', 03:46:43 INFO - 'MOZ_CRASHREPORTER': '1', 03:46:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:46:43 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 03:46:43 INFO - 'MOZ_NO_REMOTE': '1', 03:46:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:46:43 INFO - 'MOZ_WEBRENDER': '1', 03:46:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:46:43 INFO - 'NO_EM_RESTART': '1', 03:46:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:46:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:46:43 INFO - 'PWD': '/builds/slave/test', 03:46:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:46:43 INFO - 'RUST_BACKTRACE': 'full', 03:46:43 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:46:43 INFO - 'SHELL': '/bin/bash', 03:46:43 INFO - 'SHLVL': '1', 03:46:43 INFO - 'TERM': 'linux', 03:46:43 INFO - 'TMOUT': '86400', 03:46:43 INFO - 'USER': 'cltbld', 03:46:43 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1505557626.386648-895086720', 03:46:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:46:43 INFO - '_': '/tools/buildbot/bin/python'} 03:46:43 INFO - TEST-INFO | started process 18556 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvdZUfk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:46:44 INFO - PID 18556 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 03:46:44 INFO - PID 18556 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 03:46:44 INFO - PID 18556 | 03:46:44 INFO - PID 18556 | (/builds/slave/test/build/application/firefox/firefox:18615): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:46:44 INFO - PID 18556 | 03:46:54 INFO - PID 18556 | RSS: Main: 192032768 03:46:54 INFO - PID 18556 | 03:46:57 INFO - PID 18556 | Cycle 1(1): loaded http://localhost:50682/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50682/tests/kraken/driver.html?testName=audio-beat-detection) 03:46:58 INFO - PID 18556 | RSS: Main: 190513152 03:46:58 INFO - PID 18556 | 03:47:01 INFO - PID 18556 | Cycle 1(1): loaded http://localhost:50682/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50682/tests/kraken/driver.html?testName=audio-dft) 03:47:01 INFO - PID 18556 | RSS: Main: 190550016 03:47:01 INFO - PID 18556 | 03:47:04 INFO - PID 18556 | Cycle 1(1): loaded http://localhost:50682/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50682/tests/kraken/driver.html?testName=audio-fft) 03:47:05 INFO - PID 18556 | RSS: Main: 185602048 03:47:05 INFO - PID 18556 | 03:47:07 INFO - PID 18556 | Cycle 1(1): loaded http://localhost:50682/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50682/tests/kraken/driver.html?testName=audio-oscillator) 03:47:08 INFO - PID 18556 | RSS: Main: 187711488 03:47:08 INFO - PID 18556 | 03:47:10 INFO - PID 18556 | Cycle 1(1): loaded http://localhost:50682/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50682/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:47:11 INFO - PID 18556 | RSS: Main: 188112896 03:47:11 INFO - PID 18556 | 03:47:14 INFO - PID 18556 | Cycle 1(1): loaded http://localhost:50682/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50682/tests/kraken/driver.html?testName=imaging-darkroom) 03:47:14 INFO - PID 18556 | RSS: Main: 190525440 03:47:14 INFO - PID 18556 | 03:47:18 INFO - PID 18556 | Cycle 1(1): loaded http://localhost:50682/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50682/tests/kraken/driver.html?testName=imaging-desaturate) 03:47:19 INFO - PID 18556 | RSS: Main: 188248064 03:47:19 INFO - PID 18556 | 03:47:22 INFO - PID 18556 | Cycle 1(1): loaded http://localhost:50682/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50682/tests/kraken/driver.html?testName=json-parse-financial) 03:47:22 INFO - PID 18556 | RSS: Main: 190373888 03:47:22 INFO - PID 18556 | 03:47:24 INFO - PID 18556 | Cycle 1(1): loaded http://localhost:50682/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50682/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:47:25 INFO - PID 18556 | RSS: Main: 190238720 03:47:25 INFO - PID 18556 | 03:47:26 INFO - PID 18556 | Cycle 1(1): loaded http://localhost:50682/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50682/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:47:27 INFO - PID 18556 | RSS: Main: 187150336 03:47:27 INFO - PID 18556 | 03:47:29 INFO - PID 18556 | Cycle 1(1): loaded http://localhost:50682/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50682/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:47:30 INFO - PID 18556 | RSS: Main: 186802176 03:47:30 INFO - PID 18556 | 03:47:32 INFO - PID 18556 | Cycle 1(1): loaded http://localhost:50682/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50682/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:47:33 INFO - PID 18556 | RSS: Main: 186368000 03:47:33 INFO - PID 18556 | 03:47:36 INFO - PID 18556 | Cycle 1(1): loaded http://localhost:50682/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50682/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:47:37 INFO - PID 18556 | RSS: Main: 186179584 03:47:37 INFO - PID 18556 | 03:47:38 INFO - PID 18556 | Cycle 1(1): loaded http://localhost:50682/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50682/tests/kraken/driver.html?testName=ai-astar) 03:47:39 INFO - PID 18556 | RSS: Main: 188895232 03:47:39 INFO - PID 18556 | 03:47:39 INFO - PID 18556 | __start_tp_report 03:47:39 INFO - PID 18556 | _x_x_mozilla_page_load 03:47:39 INFO - PID 18556 | _x_x_mozilla_page_load_details 03:47:39 INFO - PID 18556 | |i|pagename|runs| 03:47:39 INFO - PID 18556 | |0;ai-astar;114;112;119;114;108;116;114;113;121;110 03:47:39 INFO - PID 18556 | |1;audio-beat-detection;120;118;126;117;124;117;124;127;117;124 03:47:39 INFO - PID 18556 | |2;audio-dft;162;170;167;166;174;165;167;165;171;171 03:47:39 INFO - PID 18556 | |3;audio-fft;82;77;75;75;78;85;75;82;75;74 03:47:39 INFO - PID 18556 | |4;audio-oscillator;83;85;81;85;79;87;83;84;85;81 03:47:39 INFO - PID 18556 | |5;imaging-gaussian-blur;112;116;116;115;115;114;119;116;120;116 03:47:39 INFO - PID 18556 | |6;imaging-darkroom;152;150;148;148;150;149;162;151;148;158 03:47:39 INFO - PID 18556 | |7;imaging-desaturate;95;94;94;94;94;95;94;95;100;96 03:47:39 INFO - PID 18556 | |8;json-parse-financial;55;56;56;55;56;58;54;55;55;54 03:47:39 INFO - PID 18556 | |9;json-stringify-tinderbox;45;38;38;46;38;49;47;38;37;39 03:47:39 INFO - PID 18556 | |10;stanford-crypto-aes;78;79;79;86;77;80;82;74;74;74 03:47:39 INFO - PID 18556 | |11;stanford-crypto-ccm;117;126;114;118;116;113;110;126;115;120 03:47:39 INFO - PID 18556 | |12;stanford-crypto-pbkdf2;171;170;176;175;175;170;176;173;175;175 03:47:39 INFO - PID 18556 | |13;stanford-crypto-sha256-iterative;72;64;67;78;64;64;73;64;64;69 03:47:39 INFO - PID 18556 | __end_tp_report 03:47:39 INFO - PID 18556 | __start_cc_report 03:47:39 INFO - PID 18556 | _x_x_mozilla_cycle_collect,727 03:47:39 INFO - PID 18556 | __end_cc_report 03:47:39 INFO - PID 18556 | __startTimestamp1505558859203__endTimestamp 03:47:39 INFO - PID 18556 | 03:47:39 INFO - PID 18556 | ------- Summary: start ------- 03:47:39 INFO - PID 18556 | Number of tests: 14 03:47:39 INFO - PID 18556 | 03:47:39 INFO - PID 18556 | [#0] ai-astar Cycles:10 Average:114.10 Median:114.00 stddev:3.87 (3.4%) stddev-sans-first:4.11 03:47:39 INFO - PID 18556 | Values: 114.0 112.0 119.0 114.0 108.0 116.0 114.0 113.0 121.0 110.0 03:47:39 INFO - PID 18556 | 03:47:39 INFO - PID 18556 | [#1] audio-beat-detection Cycles:10 Average:121.40 Median:124.00 stddev:4.01 (3.2%) stddev-sans-first:4.22 03:47:39 INFO - PID 18556 | Values: 120.0 118.0 126.0 117.0 124.0 117.0 124.0 127.0 117.0 124.0 03:47:39 INFO - PID 18556 | 03:47:39 INFO - PID 18556 | [#2] audio-dft Cycles:10 Average:167.80 Median:168.50 stddev:3.61 (2.1%) stddev-sans-first:3.17 03:47:39 INFO - PID 18556 | Values: 162.0 170.0 167.0 166.0 174.0 165.0 167.0 165.0 171.0 171.0 03:47:39 INFO - PID 18556 | 03:47:39 INFO - PID 18556 | [#3] audio-fft Cycles:10 Average:77.80 Median:77.50 stddev:3.85 (5.0%) stddev-sans-first:3.77 03:47:39 INFO - PID 18556 | Values: 82.0 77.0 75.0 75.0 78.0 85.0 75.0 82.0 75.0 74.0 03:47:39 INFO - PID 18556 | 03:47:39 INFO - PID 18556 | [#4] audio-oscillator Cycles:10 Average:83.30 Median:84.50 stddev:2.41 (2.8%) stddev-sans-first:2.55 03:47:39 INFO - PID 18556 | Values: 83.0 85.0 81.0 85.0 79.0 87.0 83.0 84.0 85.0 81.0 03:47:39 INFO - PID 18556 | 03:47:39 INFO - PID 18556 | [#5] imaging-gaussian-blur Cycles:10 Average:115.90 Median:116.00 stddev:2.28 (2.0%) stddev-sans-first:1.94 03:47:39 INFO - PID 18556 | Values: 112.0 116.0 116.0 115.0 115.0 114.0 119.0 116.0 120.0 116.0 03:47:39 INFO - PID 18556 | 03:47:39 INFO - PID 18556 | [#6] imaging-darkroom Cycles:10 Average:151.60 Median:150.50 stddev:4.72 (3.1%) stddev-sans-first:5.00 03:47:39 INFO - PID 18556 | Values: 152.0 150.0 148.0 148.0 150.0 149.0 162.0 151.0 148.0 158.0 03:47:39 INFO - PID 18556 | 03:47:39 INFO - PID 18556 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:94.50 stddev:1.85 (2.0%) stddev-sans-first:1.96 03:47:39 INFO - PID 18556 | Values: 95.0 94.0 94.0 94.0 94.0 95.0 94.0 95.0 100.0 96.0 03:47:39 INFO - PID 18556 | 03:47:39 INFO - PID 18556 | [#8] json-parse-financial Cycles:10 Average:55.40 Median:55.50 stddev:1.17 (2.1%) stddev-sans-first:1.24 03:47:39 INFO - PID 18556 | Values: 55.0 56.0 56.0 55.0 56.0 58.0 54.0 55.0 55.0 54.0 03:47:39 INFO - PID 18556 | 03:47:39 INFO - PID 18556 | [#9] json-stringify-tinderbox Cycles:10 Average:41.50 Median:42.00 stddev:4.65 (11.1%) stddev-sans-first:4.76 03:47:39 INFO - PID 18556 | Values: 45.0 38.0 38.0 46.0 38.0 49.0 47.0 38.0 37.0 39.0 03:47:39 INFO - PID 18556 | 03:47:39 INFO - PID 18556 | [#10] stanford-crypto-aes Cycles:10 Average:78.30 Median:79.00 stddev:3.86 (4.9%) stddev-sans-first:4.09 03:47:39 INFO - PID 18556 | Values: 78.0 79.0 79.0 86.0 77.0 80.0 82.0 74.0 74.0 74.0 03:47:39 INFO - PID 18556 | 03:47:39 INFO - PID 18556 | [#11] stanford-crypto-ccm Cycles:10 Average:117.50 Median:117.50 stddev:5.25 (4.5%) stddev-sans-first:5.57 03:47:39 INFO - PID 18556 | Values: 117.0 126.0 114.0 118.0 116.0 113.0 110.0 126.0 115.0 120.0 03:47:39 INFO - PID 18556 | 03:47:39 INFO - PID 18556 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.60 Median:175.00 stddev:2.41 (1.4%) stddev-sans-first:2.37 03:47:39 INFO - PID 18556 | Values: 171.0 170.0 176.0 175.0 175.0 170.0 176.0 173.0 175.0 175.0 03:47:39 INFO - PID 18556 | 03:47:39 INFO - PID 18556 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.90 Median:68.00 stddev:4.98 (7.3%) stddev-sans-first:5.05 03:47:39 INFO - PID 18556 | Values: 72.0 64.0 67.0 78.0 64.0 64.0 73.0 64.0 64.0 69.0 03:47:39 INFO - PID 18556 | -------- Summary: end -------- 03:47:39 INFO - PID 18556 | 03:47:39 INFO - PID 18556 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 03:47:40 INFO - TEST-INFO | 18556: exit 0 03:47:40 INFO - TEST-OK | kraken | took 62866ms 03:47:40 INFO - SUITE-END | took 1175s 03:47:40 INFO - Completed test suite (00:19:35) 03:47:40 INFO - javascript benchmark 03:47:40 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8460.37332310892, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3080.8151510909347, 3087.6912308769124, 3100.8759649614017, 3102.286474110953, 3118.6881311868815, 6123.938760612393, 6194.969025154874, 6195.845103872405, 6200.844978875531, 6286.245650521943, 6119.847003824907, 6182.907256391158, 6225.754849030201, 6241.251049874021, 6251.2498500180045, 5707.457791509821, 5719.742611582478, 5758.712064396785, 5813.30240371156, 5843.766249350021, 5775.653460792366, 5777.740001699934, 5795.565332600051, 5813.244278243822, 5875.559333050017, 161.67677955384977, 5612.849365879984, 5709.514691251248, 5739.253896993385, 5788.450097240777, 5226.216067589854, 5631.774729010835, 5637.3235211774845, 5710.571707121982, 5718.971405142947, 5669.319681638189, 5714.542836573064, 5718.399568045378, 5724.542036637101, 5745.224394706703, 6149.046897730859, 6199.814005579839, 6218.31598524162, 6231.345708700566, 6279.811605651792, 6565.0, 6607.207135143765, 6645.0, 6672.099266599044, 6752.561083529604, 6658.5671931324305, 6685.5320127591085, 6764.661766911635, 6783.830404239884, 6786.355296246848, 6060.2424696912885, 6120.44915957566, 6121.938780612181, 6126.050462178369, 6168.25980882297, 6748.392644662004, 6751.088603038527, 6778.593284402951, 6804.727810887608, 6805.251422343489, 6458.741650333934, 6503.544751867324, 6507.121538592324, 6595.472362211011, 6606.405423511811, 6631.834204144935, 6648.4681225501845, 6657.434118100015, 6681.064650948871, 6723.0, 6610.7686230982645, 6645.833854153685, 6735.663216839236, 6737.6968036438475, 6742.932570674328, 6504.414602685686, 6639.734410623521, 6655.134832471845, 6673.232578253466, 6762.019507171432, 5177.171652535576, 5230.0, 5243.711595862264, 5250.947490525045, 5270.7628156733035, 4576.794044268016, 4615.723056616614, 4619.5611416915335, 4678.274867395559, 4692.835750748775, 5641.605087643826, 5730.169125476866, 5732.885342293131, 5807.738651760681, 5822.243108395966, 6548.934510654833, 6612.933870661328, 6683.465322774166, 6696.330366963362, 6703.631300278434, 5594.608377413623, 5704.4295570443455, 5712.542996560265, 5718.142278658234, 5767.250257466502, 5649.604527683105, 5667.773289068391, 5676.460736230051, 5680.6307590007345, 5698.287714035746, 6357.904631430532, 6422.614643121427, 6463.224413070461, 6494.935050649433, 6505.186851643544, 6469.77355792545, 6553.442957348583, 6639.966800165968, 6641.767538136335, 6642.468602511787, 6268.623882567061, 6334.398232167937, 6405.263394709668, 6415.967920160369, 6423.454006409507, 6377.7767778127545, 6515.609063456208, 6531.771388001397, 6532.542722009413, 6535.379138981789, 6570.507211959218, 6600.702968366531, 6629.0, 6636.236832764101, 6663.5002374821115, 6404.231492220963, 6451.838704032437, 6468.967655161694, 6490.188726409199, 6497.5126865484335, 6450.612963222034, 6458.515611329263, 6501.089847421459, 6524.804255872142, 6567.934320656732, 6231.158793562992, 6363.809085727436, 6368.808935731936, 6382.904256436064, 6445.4199122079235, 6462.1599192106605, 6492.415682588589, 6494.6103233806125, 6507.902381464187, 6514.088027676224, 6278.686065696788, 6296.401841825019, 6328.683565821782, 6370.74517019314, 6398.360163983564], "value": 6009.765589396169, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [795.8845967334736, 810.2667086286913, 811.7524155132684, 814.7718638781143, 817.5135794202447, 40074.0, 43533.56466435335, 43670.0, 44029.11941761167, 44059.55940440603, 40005.599944000554, 40056.0, 40332.19335613286, 40411.797941010256, 40449.19101617966, 6975.372216500501, 7100.85798284034, 7119.928800712004, 7144.0, 7178.461615378841, 7022.403095736843, 7038.788836334893, 7085.04351912493, 7127.10911136108, 7134.250903655119, 7030.367266945974, 7084.64576771162, 7087.503874728771, 7088.822779430504, 7612.7716168515035, 7725.72959946402, 7786.221377862168, 7788.649510772028, 7797.844043119106, 7877.291043806085, 7603.0, 7636.885446718304, 7651.387888968925, 7675.769726908202, 7688.5386876787015, 39079.8046009771, 39516.20967580661, 39741.80129099365, 39785.0, 39848.60151398478, 3586.444101164324, 3625.492431059654, 3629.691476224524, 3631.0, 3631.6005239423644, 32659.18352041194, 32992.340153196805, 33029.0, 33063.3387332252, 33068.0, 5195.298634684307, 5198.090334191501, 5244.8688782780355, 5257.237700533401, 5289.86775330616, 182707.0, 182876.08561957238, 184610.07694961573, 185180.0, 185398.0, 43609.0, 44725.55274447279, 50623.49376506188, 50702.239466408035, 50755.49244507581, 46357.30464042975, 52699.209511857356, 53635.19547206795, 53860.73069634627, 54005.45994540004, 16622.33510659584, 16766.916165419094, 16878.915605421895, 16927.153642317833, 16942.915285423493, 13612.251326176956, 13670.589882303348, 13708.65728356799, 13711.245881476416, 13722.931385343009, 14490.927545362205, 14582.343794529272, 14628.926855365655, 14638.341274642667, 14648.707025859423, 5749.913751293734, 5799.797007104731, 5888.381719919433, 5896.351401345849, 5979.9402005980255, 998.960041598328, 1003.508280942333, 1029.1252435429824, 1031.159604921986, 1038.3199004651815, 23335.766642333358, 23489.765102349098, 23529.882350588137, 23745.287641370785, 23819.642705359434, 1109.2845114900845, 1133.5352505472717, 1133.5749094089717, 1143.5940241214416, 1145.7479354541988, 12490.75018499625, 12562.623121306375, 12618.873811261954, 12715.364231788373, 12763.680907977376, 227976.0, 228501.0, 228855.0, 229460.0, 230077.0, 53077.73461132747, 53114.734426327625, 53499.32503374816, 53534.464655353724, 53754.0, 1439.0789894467548, 1450.8766754825747, 1465.9120452772868, 1466.8826493880465, 1467.1343907094865, 23038.539229214988, 23234.0, 23319.39466348082, 23536.88231558831, 23607.881960590086, 38128.61871381251, 38182.23635527329, 38232.0, 38241.0, 38336.61663383442, 193781.0, 194284.02857985618, 194491.0, 194755.0, 194795.0, 34007.82996085004, 34588.30823383468, 34796.0, 34884.30231395409, 35192.64807351894, 42952.0, 43706.34440483459, 43821.561784381745, 44321.77839110784, 44425.33361999508, 31535.0, 31918.0, 32011.519827203076, 32126.678733212368, 32774.67225327811, 31316.37367252688, 31475.37049259048, 31503.36993260168, 31642.0, 31865.0, 34937.0, 35879.0, 36003.0, 36261.63738362583, 36294.27411451809, 31808.6819131815, 31844.5223321655, 32033.359332813678, 32253.838730806197, 32323.676763232066, 23333.883330583238, 23420.531589368456, 23547.646785297893, 23746.762532374454, 23867.0], "value": 17204.25984857079, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [555.5056000159858, 561.6489693941287, 569.3480964295882, 572.2789285500271, 582.8222392170387, 21571.13715451382, 22159.44601384966, 22423.215187468442, 22428.66357004646, 22429.214977475793, 22627.660585091195, 24343.75656243437, 24906.252812415612, 24940.376490587743, 25066.749332506668, 6338.6513741744075, 6572.638504882229, 6602.768903088393, 6608.7686930957425, 6614.107095542113, 6472.805815825533, 6493.448056915145, 6502.5448218624715, 6505.4145126938565, 6556.147700798913, 6397.872042559146, 6532.412082912537, 6547.116139321179, 6644.0, 6652.201735791712, 6586.769463068794, 6596.736130554772, 6643.302453242437, 6643.56816806906, 6647.534672572921, 5925.466707996301, 6073.18012068374, 6114.908276375858, 6119.694015299217, 6155.907661385083, 27873.0, 28462.146135615963, 28486.572701409495, 28518.144455666363, 28528.572071418945, 2017.1830408684507, 2021.1309137071053, 2045.5602045560126, 2046.549759053006, 2046.9897650511653, 18866.528336791554, 19609.509762255915, 19973.400797976083, 20059.498512537157, 20060.69908951367, 2363.4564050268364, 2397.916072937456, 2419.52819200256, 2426.8301218914685, 2427.5873101572774, 125946.0, 132011.0, 135881.0, 146038.0, 146826.53173468236, 14399.200207789161, 14472.204028778307, 14603.342849571794, 14672.972891897678, 15005.774913376308, 22747.545049098924, 22764.4308892279, 22784.658230126563, 22790.31629051131, 22809.83306585872, 9942.552585133542, 10037.297389182688, 10144.49277536135, 10186.286959912735, 10215.23385746072, 9368.2973776967, 9561.569729362196, 9576.23390128788, 9678.56446459911, 9718.757031074138, 8771.122887711306, 8879.378443509022, 8934.4192627479, 9178.816423671622, 9292.72121836346, 2707.9323016924736, 2712.4303896181627, 2726.6591676040493, 2732.9590056149173, 2769.7368749969123, 940.3041749105613, 945.0832692288469, 948.1463738391428, 963.8698775665196, 987.1855719031828, 18817.15322810477, 19132.808671913383, 19230.423087307405, 19323.903380483007, 19674.213031478866, 1031.3554028732042, 1037.4553359486179, 1044.7440377107657, 1054.4306074719718, 1057.2652006855315, 10761.677149685522, 10783.56865725378, 10799.514021869034, 10822.242443028912, 10865.348079115278, 430935.0, 440502.0, 440632.0, 447520.0, 449317.0, 109300.0, 112730.0, 112993.43503282432, 113471.0, 113756.0, 1131.7170707323169, 1159.0379984612919, 1159.5535718748342, 1169.2867350915935, 1170.5727409495644, 17039.82960170432, 17290.221940012478, 17661.558461038578, 17665.470035898943, 17812.55468613295, 53377.19934201068, 54498.727506362215, 54705.17942230949, 55574.0, 56088.43911560995, 70483.29516704768, 70805.64597176982, 71159.0, 71944.64027679828, 72004.63997680187, 13719.176849389069, 13968.30158492051, 14026.859731402963, 14150.50473233473, 14235.786463203267, 21637.0, 21793.455163621038, 21850.01674924664, 22003.669944950518, 22080.0, 16472.0940348282, 16560.751588725936, 16575.83424165743, 16870.240839162514, 17686.734698979784, 15721.764173537178, 15790.526284211492, 16201.59496012609, 16341.918290408947, 16407.17964101766, 16087.436939707053, 16270.0, 16280.837191627932, 16335.0, 16356.100414477318, 13740.725185496034, 13841.792373114613, 13905.930470347988, 13966.441342346192, 13989.510367137102, 15281.6179595511, 17106.65786684284, 17410.303587856342, 17482.125893705008, 17526.912365438602], "value": 11682.857359195272, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1325.0989327257464, 1365.644932317597, 1379.6343968848257, 1389.5275606293858, 1395.4836710417146, 14935.850641493582, 15626.531204063882, 15723.764143537828, 15787.605309867246, 15801.762973555376, 15504.767428488582, 15641.374345026214, 15664.451744188955, 15667.92166039171, 15671.373145074213, 2759.351552385188, 2779.4163225722623, 2800.061979236958, 2810.9718902810914, 2830.943381132376, 2670.906518271861, 2753.8623068846578, 2759.862006899657, 2769.3076730817297, 2777.375090604618, 2647.576387777956, 2652.986735066322, 2686.0, 2745.437185377003, 2746.5880117982265, 2779.555271156615, 2781.2629653141935, 2788.6196332815184, 2794.147784925597, 2798.776097912162, 2614.1242683700984, 2655.960160597573, 2657.2958166086005, 2657.6810782706007, 2675.5852842809395, 14940.95413321068, 15022.0, 15199.468018619405, 15685.05889646625, 15782.0, 8128.227818357246, 8378.371622128365, 8387.622556984888, 8388.035375931784, 8406.369522285853, 5511.614187006911, 5642.520385767215, 5716.256886604757, 5780.421957804228, 5831.212786273841, 1922.7692676878864, 1932.159510612888, 1942.8348590369835, 1965.4398496428448, 1968.517713160285, 26556.203313900613, 26734.33164170892, 26807.329816754347, 26821.32946676329, 26831.73168268312, 6784.626845523445, 6917.965410172917, 6931.480138989596, 7030.753923612751, 7103.218645948941, 17341.306347746202, 17457.21442535089, 17504.21231044606, 17510.562235943948, 17562.29750809979, 7643.464957452925, 8491.320694344438, 8515.148485151436, 8532.616032278562, 8540.530270835165, 7447.627618619047, 7494.0, 7576.924230757621, 7618.352440042659, 7672.0, 5068.873278168002, 5167.560757335594, 5183.870403239874, 5319.973400132974, 5354.571634269249, 1511.6523199664139, 1514.3498876965311, 1524.4283393727353, 1528.8394718554614, 1533.6472611299241, 906.7642412972675, 916.1800188831093, 925.2181906289175, 925.8379783537854, 931.3434029009532, 7600.50596711212, 7789.104253010976, 7822.139564647884, 7831.412644051605, 7892.171322011106, 690.892911598703, 692.9757458488929, 698.1866125963297, 702.8594281143792, 714.257172540552, 4535.909281814345, 4664.300354946785, 5385.488378604026, 5462.508374246337, 5561.054620714407, 20721.481962951046, 21817.127314907542, 21917.561648766936, 22049.559008820055, 22117.894105294672, 20670.896645516976, 21194.682079768816, 21741.456463588536, 21774.0, 22105.44736381571, 10094.141997930112, 10104.393736375841, 10490.632827851141, 10541.736456588647, 10614.991575800286, 8520.786980325542, 8667.653293868427, 8687.29713045386, 8771.166739160024, 8829.072947340694, 18420.35528756487, 18733.90633046826, 18957.336493222672, 19144.521386965436, 19187.61624767469, 19189.712154317418, 19673.21307147698, 19993.400197994084, 20168.49578760543, 20471.59056818885, 10955.616553420592, 10962.342259464458, 11098.2786118902, 11103.278286911325, 11107.444627768418, 14090.718185636435, 14313.928430357782, 14355.066920650124, 14361.425542978164, 14362.569122926328, 11121.332720036824, 11246.775064498828, 11360.772784544428, 11415.714607134889, 11552.191346605992, 10914.836277455686, 10944.835827462435, 10954.452277386259, 11060.336379817236, 11192.160587955774, 9857.507124643882, 10197.388156710622, 10222.488875556044, 10222.948885255824, 10319.48402579883, 7082.610456424946, 7134.215236324104, 7200.99186113934, 7218.169910460154, 7332.046833911771, 7247.166575843846, 7332.96333518329, 7376.7049318026675, 7380.003699500713, 7432.888506672512], "value": 6686.984118869059, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [464.3313628375137, 496.8410108765194, 499.90217178634316, 500.0548962460949, 515.8400895722325, 6118.296395914465, 6136.0, 6188.5358598105095, 6239.407256310649, 6276.937230627704, 6030.1256317833995, 6097.451229389354, 6114.755409783604, 6135.601185922912, 6155.6306621602735, 5005.624578156644, 5057.216131499624, 5067.163917953533, 5068.8225912093085, 5095.0, 5070.8732281693065, 5102.821401250957, 5108.8978220435565, 5111.718855462948, 5142.614303927202, 4748.762561871893, 4886.0, 4894.755262236892, 4936.259561065851, 5032.949670503303, 4868.707877527359, 4873.853784386474, 4911.484294149116, 4931.630127740415, 4951.257311403282, 4403.669724770655, 4427.977860110711, 4430.645548356124, 4431.357453169305, 4439.889002774924, 5951.613145145551, 5970.850728731773, 6003.879922401527, 6045.244344456943, 6113.602615829956, 5611.494965453088, 5640.351359593658, 5641.351244606882, 5662.8301150965535, 5670.404607516192, 6467.579607325556, 6483.643399613019, 6484.546081774278, 6532.608043517404, 6551.102094253912, 4538.591526762607, 4703.482616912137, 4808.980228304121, 4819.638377195149, 4839.854804355875, 6546.44355229806, 6547.738090476375, 6623.43700785429, 6668.93331066688, 6765.797026089225, 4872.537108974641, 4889.217725163957, 4906.754662266943, 4929.556339929423, 4930.852074437773, 4953.0, 4981.8329026873425, 5000.1249781288125, 5000.574951129122, 5025.673331233531, 5509.724513774296, 5516.862078447991, 5530.640508367023, 5534.335879694462, 5641.407652196543, 6432.35676432353, 6495.64273964927, 6538.215414150332, 6539.411452969255, 6595.307492713292, 1725.767021452113, 1745.1623220853808, 1746.6943284925342, 1754.298280687735, 1758.7449819776061, 1145.5417832866754, 1200.9519619215134, 1201.9338936358583, 1215.343714394235, 1223.730779228586, 5583.134614134816, 5621.662700237999, 5639.577031722637, 5662.801801936913, 5675.432456754292, 6472.805815825533, 6494.532077810496, 6545.509086818508, 6580.170526673481, 6594.604323740591, 5602.775888964477, 5606.60753747242, 5608.85977850557, 5642.830715078554, 5675.687837168913, 3308.966910330914, 3418.5555877735737, 3428.6228514863346, 3469.9826500867334, 3498.8600455981477, 6213.378662133841, 6241.531885108635, 6290.21372328459, 6291.748330066837, 6326.525510586633, 6625.469962402996, 6660.6336651484635, 6710.228323742735, 6728.0, 6738.831529211711, 6126.571140020245, 6222.471089957405, 6314.8737025258315, 6318.589291696025, 6322.0, 6496.447801936888, 6655.434288085373, 6663.666816659051, 6670.733170673118, 6671.633060181736, 6378.48972082223, 6421.518386121153, 6430.935690643221, 6452.548321617442, 6599.60402375859, 6310.810675679737, 6358.682065896779, 6359.523035772243, 6371.904421433589, 6411.839704007437, 4903.705777653352, 4905.3623029006, 4946.925796113133, 4974.950250497449, 4988.5260900214425, 6290.968545157245, 6529.967350163219, 6546.869062618816, 6619.60988192485, 6683.832904177434, 6193.411625895533, 6293.653849038347, 6362.904556431565, 6398.264199617103, 6493.480521558169, 6350.142730731292, 6443.291237963726, 6464.41820236181, 6466.838329041623, 6533.8693226136165, 6248.281447633581, 6269.0, 6273.215848018997, 6318.399752023551, 6380.202474690664, 6429.38920802523, 6441.615052763678, 6518.282988871126, 6553.377429144223, 6558.901616475852, 6283.5287353449585, 6290.811275661737, 6295.52055267021, 6332.841678957879, 6372.681365931778], "value": 4968.028640856692, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [898.3621628643663, 900.8738776571281, 921.424109931293, 925.31064357054, 938.6620816506058, 19037.904810475946, 20287.08708108135, 20310.898445507788, 20317.796822031774, 20412.59174816503, 18613.813861861378, 18752.531186720338, 18756.71864922027, 18784.436466906016, 18872.811271887276, 922.9815403691939, 939.3002213351064, 944.1266828183902, 945.6973768394116, 948.3882895532378, 952.6189524190345, 952.8904176019777, 954.2127744610689, 954.7947191353858, 955.5174636808437, 995.437577768562, 998.1366118307648, 1007.7631756537207, 1037.3620223562493, 1046.2937517175915, 1046.7226185060965, 1047.0419566097012, 1047.6280920273307, 1048.7745134796055, 1049.0820532034509, 746.123305116486, 752.2740555364045, 752.2778132992333, 752.7252552818182, 753.3182469864781, 18354.90822545892, 19306.80693193064, 19386.80613193878, 19504.609907801765, 19532.511687207792, 21430.89284553583, 21981.34055978323, 22446.88776556123, 22788.886055569783, 22799.88600056989, 17498.47504574852, 17528.912355438268, 17570.472885813448, 17587.0, 17631.823681763148, 3750.456183853326, 3756.0609847538117, 3800.8289626966575, 3802.6007269236884, 3808.5810560838286, 128182.35908820489, 141923.0, 141982.0, 143907.28046359806, 143956.0, 17878.821211787978, 17900.55248618795, 18342.266309347742, 18575.81424185768, 18626.44120676382, 31548.0, 31962.0, 32103.678963210536, 32112.83943580267, 32184.678153218636, 8884.156005179497, 8971.327150463741, 9094.454332739924, 9130.680426185052, 9149.268058555299, 4260.573942605714, 4381.9342709859375, 4411.316245981878, 4419.005723712139, 4420.160169567772, 5401.783928642811, 5466.9179962300595, 5539.390667026624, 5542.63972841764, 5582.944170558242, 1071.796358691846, 1108.5233349659725, 1111.3554138599593, 1115.7433790228292, 1116.6482557994207, 667.9599224046573, 677.576514678326, 701.2216439751871, 703.0754557756534, 704.844934114494, 12179.87820121805, 12200.389980500939, 12333.828286312786, 12436.067294952914, 13043.28261945602, 688.5730846874969, 691.2603514239715, 704.1690804850224, 716.6846587501483, 717.8384863405796, 5561.277033985556, 5583.8883222336135, 5599.552035837123, 5699.116636921284, 5715.885682286331, 130968.3451582736, 131000.0, 131765.0, 132956.0, 133044.33477832744, 108630.0, 111161.0, 111574.0, 113191.0, 113657.0, 93652.53173734088, 93675.53162234146, 96756.51621741986, 97852.0, 99997.50001249947, 10581.735456613646, 10734.946325268324, 10741.46292685347, 10789.244752867224, 10985.780284394426, 46007.30989035234, 46233.30650040185, 47289.0, 47915.281270780266, 48354.0, 59285.0, 60729.69635151973, 60997.39002609917, 61149.0, 61431.38568614257, 15679.216039198223, 16021.439249626674, 16040.518784436486, 16054.67890642204, 16150.838491614933, 17039.40362087321, 17098.572535686708, 17994.820051799314, 18126.637467250846, 18187.909060454615, 15288.694226115193, 15565.76651350208, 15586.766198506804, 15655.530334089995, 15709.214539272762, 15914.0, 16003.679926401639, 16050.0, 16075.678486430439, 16342.754858676892, 15783.210839457752, 16067.11630860314, 16069.0, 16199.109049002418, 16457.341706331612, 12704.74590508203, 12761.61715148547, 12942.288174150512, 13162.670933226746, 13308.268045257604, 12408.379581021094, 12435.316057616918, 12599.622011339308, 12745.745085098431, 12797.97616190721], "value": 9138.05170735112, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1461.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 112.0, 119.0, 114.0, 108.0, 116.0, 114.0, 113.0, 121.0, 110.0], "value": 114.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 118.0, 126.0, 117.0, 124.0, 117.0, 124.0, 127.0, 117.0, 124.0], "value": 121.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 170.0, 167.0, 166.0, 174.0, 165.0, 167.0, 165.0, 171.0, 171.0], "value": 167.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 77.0, 75.0, 75.0, 78.0, 85.0, 75.0, 82.0, 75.0, 74.0], "value": 77.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 85.0, 81.0, 85.0, 79.0, 87.0, 83.0, 84.0, 85.0, 81.0], "value": 83.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 116.0, 116.0, 115.0, 115.0, 114.0, 119.0, 116.0, 120.0, 116.0], "value": 115.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 150.0, 148.0, 148.0, 150.0, 149.0, 162.0, 151.0, 148.0, 158.0], "value": 151.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 94.0, 94.0, 94.0, 95.0, 94.0, 95.0, 100.0, 96.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 56.0, 55.0, 56.0, 58.0, 54.0, 55.0, 55.0, 54.0], "value": 55.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [45.0, 38.0, 38.0, 46.0, 38.0, 49.0, 47.0, 38.0, 37.0, 39.0], "value": 41.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 79.0, 79.0, 86.0, 77.0, 80.0, 82.0, 74.0, 74.0, 74.0], "value": 78.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 126.0, 114.0, 118.0, 116.0, 113.0, 110.0, 126.0, 115.0, 120.0], "value": 117.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 170.0, 176.0, 175.0, 175.0, 170.0, 176.0, 173.0, 175.0, 175.0], "value": 173.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 64.0, 67.0, 78.0, 64.0, 64.0, 73.0, 64.0, 64.0, 69.0], "value": 67.9, "unit": "score"}]}]} 03:47:40 INFO - Return code: 0 03:47:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:47:40 INFO - # TBPL SUCCESS # 03:47:40 INFO - Running post-action listener: _package_coverage_data 03:47:40 INFO - Running post-action listener: _resource_record_post_action 03:47:40 INFO - [mozharness: 2017-09-16 10:47:40.473838Z] Finished run-tests step (success) 03:47:40 INFO - Running post-run listener: _resource_record_post_run 03:47:40 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 1597440; Write bytes: 344379392; Read time: 1680; Write time: 183624 03:47:40 INFO - TinderboxPrint: CPU usage
13.3% 03:47:40 INFO - TinderboxPrint: I/O read bytes / time
1,597,440 / 1,680 03:47:40 INFO - TinderboxPrint: I/O write bytes / time
344,379,392 / 183,624 03:47:40 INFO - TinderboxPrint: CPU idle
8,253.1 (86.7%) 03:47:40 INFO - TinderboxPrint: CPU user
1,200.6 (12.6%) 03:47:40 INFO - TinderboxPrint: Swap in / out
0 / 0 03:47:40 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 13070336; Read time: 0; Write time: 968 03:47:40 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 03:47:40 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 1593344; Write bytes: 331309056; Read time: 1672; Write time: 182656 03:47:41 INFO - Running post-run listener: _upload_blobber_files 03:47:41 INFO - Blob upload gear active. 03:47:41 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:47:41 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 03:47:41 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'] 03:47:41 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 03:47:41 INFO - (blobuploader) - INFO - Open directory for files ... 03:47:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:47:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:47:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:47:48 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:47:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:47:48 INFO - (blobuploader) - INFO - Done attempting. 03:47:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:47:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:47:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:47:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:47:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:47:49 INFO - (blobuploader) - INFO - Done attempting. 03:47:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:47:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:47:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:47:50 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:47:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:47:50 INFO - (blobuploader) - INFO - Done attempting. 03:47:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:47:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:47:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:47:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:47:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:47:51 INFO - (blobuploader) - INFO - Done attempting. 03:47:51 INFO - (blobuploader) - INFO - Iteration through files over. 03:47:51 INFO - Return code: 0 03:47:51 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:47:51 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:47:51 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eff825c45b1f4330adb36b39b56cefbf5a6cb27c8648ab60d2499917d8bf8f01cd518549e70892cfef2ccfabd2a736b356f4f4506dcb3b7c816faf14dc7ee293", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/39e99dc6571e5a2508aa7a9a40de4531aae088b0f8595eed831097424f879309b8fefbe74d34a34a1fdaf77188542f17cfc321f5ed3b77443be43173d11e2523", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3912d8172bda818182485eb2f5bb865a2b6beef3a4449648c7768a8c8ea700ebbde3b2368f62b11d6bc256e9ee87a443db55d71fe0a43cc53c331172e6fb6c44", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bd6dc3e560e17305fdb0ba518ba6276f45f0d3234743373462366a8c019a53ec5afd5af8a91540703c1da6de71775b1d844287c8126e19c77d3ace4d8de6a473"} 03:47:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:47:51 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:47:51 INFO - Contents: 03:47:51 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eff825c45b1f4330adb36b39b56cefbf5a6cb27c8648ab60d2499917d8bf8f01cd518549e70892cfef2ccfabd2a736b356f4f4506dcb3b7c816faf14dc7ee293", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/39e99dc6571e5a2508aa7a9a40de4531aae088b0f8595eed831097424f879309b8fefbe74d34a34a1fdaf77188542f17cfc321f5ed3b77443be43173d11e2523", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3912d8172bda818182485eb2f5bb865a2b6beef3a4449648c7768a8c8ea700ebbde3b2368f62b11d6bc256e9ee87a443db55d71fe0a43cc53c331172e6fb6c44", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bd6dc3e560e17305fdb0ba518ba6276f45f0d3234743373462366a8c019a53ec5afd5af8a91540703c1da6de71775b1d844287c8126e19c77d3ace4d8de6a473"} 03:47:51 INFO - Running post-run listener: copy_logs_to_upload_dir 03:47:51 INFO - Copying logs to upload dir... 03:47:51 INFO - mkdir: /builds/slave/test/build/upload/logs 03:47:51 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.968806 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2017-09-16 03:47:51.565465) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-16 03:47:51.573375) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1505557626.386648-895086720 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/eff825c45b1f4330adb36b39b56cefbf5a6cb27c8648ab60d2499917d8bf8f01cd518549e70892cfef2ccfabd2a736b356f4f4506dcb3b7c816faf14dc7ee293", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/39e99dc6571e5a2508aa7a9a40de4531aae088b0f8595eed831097424f879309b8fefbe74d34a34a1fdaf77188542f17cfc321f5ed3b77443be43173d11e2523", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3912d8172bda818182485eb2f5bb865a2b6beef3a4449648c7768a8c8ea700ebbde3b2368f62b11d6bc256e9ee87a443db55d71fe0a43cc53c331172e6fb6c44", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bd6dc3e560e17305fdb0ba518ba6276f45f0d3234743373462366a8c019a53ec5afd5af8a91540703c1da6de71775b1d844287c8126e19c77d3ace4d8de6a473"} build_url:https://queue.taskcluster.net/v1/task/QKXeurjvQniffQGOJwEu5g/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011457 build_url: 'https://queue.taskcluster.net/v1/task/QKXeurjvQniffQGOJwEu5g/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eff825c45b1f4330adb36b39b56cefbf5a6cb27c8648ab60d2499917d8bf8f01cd518549e70892cfef2ccfabd2a736b356f4f4506dcb3b7c816faf14dc7ee293", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/39e99dc6571e5a2508aa7a9a40de4531aae088b0f8595eed831097424f879309b8fefbe74d34a34a1fdaf77188542f17cfc321f5ed3b77443be43173d11e2523", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3912d8172bda818182485eb2f5bb865a2b6beef3a4449648c7768a8c8ea700ebbde3b2368f62b11d6bc256e9ee87a443db55d71fe0a43cc53c331172e6fb6c44", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bd6dc3e560e17305fdb0ba518ba6276f45f0d3234743373462366a8c019a53ec5afd5af8a91540703c1da6de71775b1d844287c8126e19c77d3ace4d8de6a473"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-16 03:47:51.605006) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 03:47:51.605439) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1505557626.386648-895086720 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004545 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 03:47:51.687882) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-16 03:47:51.691292) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-16 03:47:51.691614) ========= ========= Total master_lag: 0.23 =========