builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s-pgo slave: talos-linux64-ix-084 starttime: 1506425093.22 results: success (0) revision: 6fb1f5fae37168c824b988733aac0d46499b6c11 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-26 04:24:53.221520) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-26 04:24:53.222001) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-26 04:24:53.222605) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-26 04:24:53.321014) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 04:24:53.321300) ========= 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=ea65d483da93c827905c2090000001f5-1506419941.308983-46057260 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-26 04:24:53-- 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% 228M=0s 2017-09-26 04:24:53 (228 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.140519 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 04:24:53.486847) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 04:24:53.487178) ========= 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=ea65d483da93c827905c2090000001f5-1506419941.308983-46057260 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019495 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 04:24:53.540480) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 04:24:53.540828) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 6fb1f5fae37168c824b988733aac0d46499b6c11 --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 6fb1f5fae37168c824b988733aac0d46499b6c11 --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=ea65d483da93c827905c2090000001f5-1506419941.308983-46057260 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-26 04:24:53,589 truncating revision to first 12 chars 2017-09-26 04:24:53,589 Setting DEBUG logging. 2017-09-26 04:24:53,589 attempt 1/10 2017-09-26 04:24:53,589 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/6fb1f5fae371?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-26 04:24:54,029 unpacking tar archive at: mozilla-central-6fb1f5fae371/testing/mozharness/ program finished with exit code 0 elapsedTime=0.776410 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 04:24:54.334526) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-26 04:24:54.334853) ========= script_repo_revision: 6fb1f5fae37168c824b988733aac0d46499b6c11 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-26 04:24:54.335255) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-26 04:24:54.335518) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-26 04:24:54.348599) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2017-09-26 04:24:54.348877) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-stylo-disabled-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=ea65d483da93c827905c2090000001f5-1506419941.308983-46057260 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:24:54 INFO - MultiFileLogger online at 20170926 04:24:54 in /builds/slave/test 04:24:54 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 04:24:54 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:24:54 INFO - {'append_to_log': False, 04:24:54 INFO - 'base_work_dir': '/builds/slave/test', 04:24:54 INFO - 'blob_upload_branch': 'Firefox', 04:24:54 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:24:54 INFO - 'branch': 'Firefox', 04:24:54 INFO - 'buildbot_json_path': 'buildprops.json', 04:24:54 INFO - 'code_coverage': False, 04:24:54 INFO - 'config_files': ('talos/linux_config.py',), 04:24:54 INFO - 'default_actions': ('clobber', 04:24:54 INFO - 'read-buildbot-config', 04:24:54 INFO - 'download-and-extract', 04:24:54 INFO - 'populate-webroot', 04:24:54 INFO - 'create-virtualenv', 04:24:54 INFO - 'install', 04:24:54 INFO - 'setup-mitmproxy', 04:24:54 INFO - 'run-tests'), 04:24:54 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:24:54 INFO - 'disable_ccov_upload': False, 04:24:54 INFO - 'disable_stylo': False, 04:24:54 INFO - 'download_minidump_stackwalk': True, 04:24:54 INFO - 'download_symbols': 'ondemand', 04:24:54 INFO - 'enable_stylo': False, 04:24:54 INFO - 'enable_webrender': False, 04:24:54 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 04:24:54 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:24:54 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:24:54 INFO - 'gecko_profile': False, 04:24:54 INFO - 'gecko_profile_interval': 0, 04:24:54 INFO - 'installer_path': 'installer.exe', 04:24:54 INFO - 'log_level': 'info', 04:24:54 INFO - 'log_name': 'talos', 04:24:54 INFO - 'log_to_console': True, 04:24:54 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:24:54 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:24:54 INFO - 'opt_config_files': (), 04:24:54 INFO - 'pip_index': False, 04:24:54 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 04:24:54 INFO - 'system_bits': '32', 04:24:54 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:24:54 INFO - 'title': 'talos-linux64-ix-084', 04:24:54 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:24:54 INFO - 'use_talos_json': True, 04:24:54 INFO - 'verify': 'False', 04:24:54 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:24:54 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:24:54 INFO - 'work_dir': 'build'} 04:24:54 INFO - [mozharness: 2017-09-26 11:24:54.539688Z] Running clobber step. 04:24:54 INFO - Running pre-action listener: _resource_record_pre_action 04:24:54 INFO - Running main action method: clobber 04:24:54 INFO - rmtree: /builds/slave/test/build 04:24:54 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:24:55 INFO - Running post-action listener: _resource_record_post_action 04:24:55 INFO - [mozharness: 2017-09-26 11:24:55.538111Z] Finished clobber step (success) 04:24:55 INFO - [mozharness: 2017-09-26 11:24:55.538207Z] Running read-buildbot-config step. 04:24:55 INFO - Running pre-action listener: _resource_record_pre_action 04:24:55 INFO - Running main action method: read_buildbot_config 04:24:55 INFO - Using buildbot properties: 04:24:55 INFO - { 04:24:55 INFO - "project": "", 04:24:55 INFO - "product": "firefox", 04:24:55 INFO - "who": "archaeopteryx@coole-files.de", 04:24:55 INFO - "installer_path": "public/build/target.tar.bz2", 04:24:55 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 04:24:55 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 04:24:55 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-stylo-disabled-e10s", 04:24:55 INFO - "stage_platform": "linux64-pgo", 04:24:55 INFO - "basedir": "/builds/slave/test", 04:24:55 INFO - "buildnumber": 41, 04:24:55 INFO - "platform": "ubuntu64_hw", 04:24:55 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 04:24:55 INFO - "slavebuilddir": "test", 04:24:55 INFO - "taskId": "FRPiG5g9RUOLpYWSjKY3xA", 04:24:55 INFO - "branch": "mozilla-central", 04:24:55 INFO - "script_repo_revision": "production", 04:24:55 INFO - "revision": "6fb1f5fae37168c824b988733aac0d46499b6c11", 04:24:55 INFO - "slavename": "talos-linux64-ix-084", 04:24:55 INFO - "repo_path": "mozilla-central" 04:24:55 INFO - } 04:24:55 INFO - Finding installer, test and symbols from parent task. 04:24:55 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FRPiG5g9RUOLpYWSjKY3xA'}, attempt #1 04:24:56 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FRPiG5g9RUOLpYWSjKY3xA'}, attempt #1 04:24:56 INFO - Task dependencies: XpubHF4YRmq2bSLzKMvNAg 04:24:56 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XpubHF4YRmq2bSLzKMvNAg'}, attempt #1 04:24:56 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/XpubHF4YRmq2bSLzKMvNAg/artifacts/public/build/target.tar.bz2 04:24:56 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/XpubHF4YRmq2bSLzKMvNAg/artifacts/public/build/target.test_packages.json 04:24:56 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/XpubHF4YRmq2bSLzKMvNAg/artifacts/public/build/target.crashreporter-symbols.zip 04:24:56 INFO - Running post-action listener: _resource_record_post_action 04:24:56 INFO - [mozharness: 2017-09-26 11:24:56.898984Z] Finished read-buildbot-config step (success) 04:24:56 INFO - [mozharness: 2017-09-26 11:24:56.899242Z] Running download-and-extract step. 04:24:56 INFO - Running pre-action listener: _resource_record_pre_action 04:24:56 INFO - Running main action method: download_and_extract 04:24:56 INFO - mkdir: /builds/slave/test/build/tests 04:24:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:24:56 INFO - trying https://queue.taskcluster.net/v1/task/XpubHF4YRmq2bSLzKMvNAg/artifacts/public/build/target.test_packages.json 04:24:56 INFO - Downloading https://queue.taskcluster.net/v1/task/XpubHF4YRmq2bSLzKMvNAg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 04:24:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XpubHF4YRmq2bSLzKMvNAg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 04:24:57 INFO - Downloaded 989 bytes. 04:24:57 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 04:24:57 INFO - Using the following test package requirements: 04:24:57 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 04:24:57 INFO - u'common': [u'target.common.tests.zip'], 04:24:57 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 04:24:57 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 04:24:57 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 04:24:57 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 04:24:57 INFO - u'mozbase': [u'target.common.tests.zip'], 04:24:57 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 04:24:57 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 04:24:57 INFO - u'web-platform': [u'target.common.tests.zip', 04:24:57 INFO - u'target.web-platform.tests.tar.gz'], 04:24:57 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 04:24:57 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 04:24:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XpubHF4YRmq2bSLzKMvNAg/artifacts/public/build/target.common.tests.zip 04:24:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XpubHF4YRmq2bSLzKMvNAg/artifacts/public/build/target.common.tests.zip'}, attempt #1 04:24:57 INFO - Fetch https://queue.taskcluster.net/v1/task/XpubHF4YRmq2bSLzKMvNAg/artifacts/public/build/target.common.tests.zip into memory 04:24:58 INFO - Content-Length response header: 55341886 04:24:58 INFO - Bytes received: 55341886 04:25:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XpubHF4YRmq2bSLzKMvNAg/artifacts/public/build/target.talos.tests.zip 04:25:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XpubHF4YRmq2bSLzKMvNAg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 04:25:09 INFO - Fetch https://queue.taskcluster.net/v1/task/XpubHF4YRmq2bSLzKMvNAg/artifacts/public/build/target.talos.tests.zip into memory 04:25:09 INFO - Content-Length response header: 14513823 04:25:09 INFO - Bytes received: 14513823 04:25:10 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')]} 04:25:10 INFO - trying https://queue.taskcluster.net/v1/task/XpubHF4YRmq2bSLzKMvNAg/artifacts/public/build/target.tar.bz2 04:25:10 INFO - Downloading https://queue.taskcluster.net/v1/task/XpubHF4YRmq2bSLzKMvNAg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 04:25:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XpubHF4YRmq2bSLzKMvNAg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 04:25:11 INFO - Downloaded 62395847 bytes. 04:25:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XpubHF4YRmq2bSLzKMvNAg/artifacts/public/build/target.tar.bz2 04:25:11 INFO - mkdir: /builds/slave/test/properties 04:25:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:25:11 INFO - Writing to file /builds/slave/test/properties/build_url 04:25:11 INFO - Contents: 04:25:11 INFO - build_url:https://queue.taskcluster.net/v1/task/XpubHF4YRmq2bSLzKMvNAg/artifacts/public/build/target.tar.bz2 04:25:11 INFO - Running post-action listener: _resource_record_post_action 04:25:11 INFO - Running post-action listener: find_tests_for_verification 04:25:11 INFO - Running post-action listener: set_extra_try_arguments 04:25:11 INFO - [mozharness: 2017-09-26 11:25:11.590383Z] Finished download-and-extract step (success) 04:25:11 INFO - [mozharness: 2017-09-26 11:25:11.590481Z] Running populate-webroot step. 04:25:11 INFO - Running pre-action listener: _resource_record_pre_action 04:25:11 INFO - Running main action method: populate_webroot 04:25:11 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:25:11 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:25:11 INFO - 'tests': ['tresize', 04:25:11 INFO - 'tcanvasmark']}, 04:25:11 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:25:11 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:25:11 INFO - 'tests': ['dromaeo_css', 04:25:11 INFO - 'kraken']}, 04:25:11 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:25:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:25:11 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 04:25:11 INFO - 'talos_options': ['--disable-stylo'], 04:25:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:25:11 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:25:11 INFO - 'tests': ['damp', 'tps']}, 04:25:11 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 04:25:11 INFO - 'talos_options': ['--disable-stylo'], 04:25:11 INFO - 'tests': ['damp', 'tps']}, 04:25:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:25:11 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:25:11 INFO - 'tests': ['dromaeo_dom']}, 04:25:11 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 04:25:11 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:25:11 INFO - 'tests': ['basic_compositor_video', 04:25:11 INFO - 'glvideo']}, 04:25:11 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 04:25:11 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 04:25:11 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 04:25:11 INFO - 'talos_options': ['--disable-stylo'], 04:25:11 INFO - 'tests': ['ts_paint_webext', 04:25:11 INFO - 'tp5o_webext']}, 04:25:11 INFO - 'other-e10s': {'tests': ['a11yr', 04:25:11 INFO - 'ts_paint', 04:25:11 INFO - 'tpaint', 04:25:11 INFO - 'sessionrestore', 04:25:11 INFO - 'sessionrestore_many_windows', 04:25:11 INFO - 'sessionrestore_no_auto_restore', 04:25:11 INFO - 'tabpaint']}, 04:25:11 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:25:11 INFO - 'tests': ['a11yr', 04:25:11 INFO - 'ts_paint', 04:25:11 INFO - 'tpaint', 04:25:11 INFO - 'sessionrestore', 04:25:11 INFO - 'sessionrestore_many_windows', 04:25:11 INFO - 'sessionrestore_no_auto_restore', 04:25:11 INFO - 'tabpaint']}, 04:25:11 INFO - 'perf-reftest-e10s': {'tests': ['perf_reftest']}, 04:25:11 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 04:25:11 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:25:11 INFO - 'tests': ['perf_reftest_singletons']}, 04:25:11 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:25:11 INFO - 'tests': ['perf_reftest']}, 04:25:11 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:25:11 INFO - 'tsvgr_opacity', 04:25:11 INFO - 'tart', 04:25:11 INFO - 'tscrollx', 04:25:11 INFO - 'tsvg_static']}, 04:25:11 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:25:11 INFO - 'tests': ['tsvgx', 04:25:11 INFO - 'tsvgr_opacity', 04:25:11 INFO - 'tart', 04:25:11 INFO - 'tscrollx', 04:25:11 INFO - 'tsvg_static']}, 04:25:11 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:25:11 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 04:25:11 INFO - 'talos_options': ['--disable-stylo'], 04:25:11 INFO - 'tests': ['tp5o']}, 04:25:11 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 04:25:11 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 04:25:11 INFO - 'talos_options': ['--mitmproxy', 04:25:11 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 04:25:11 INFO - '--firstNonBlankPaint'], 04:25:11 INFO - 'tests': ['tp6_google', 04:25:11 INFO - 'tp6_youtube', 04:25:11 INFO - 'tp6_amazon', 04:25:11 INFO - 'tp6_facebook']}, 04:25:11 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 04:25:11 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 04:25:11 INFO - 'talos_options': ['--disable-stylo', 04:25:11 INFO - '--mitmproxy', 04:25:11 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 04:25:11 INFO - '--firstNonBlankPaint'], 04:25:11 INFO - 'tests': ['tp6_google', 04:25:11 INFO - 'tp6_youtube', 04:25:11 INFO - 'tp6_amazon', 04:25:11 INFO - 'tp6_facebook']}, 04:25:11 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 04:25:11 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 04:25:11 INFO - 'talos_options': ['--stylo-threads=1', 04:25:11 INFO - '--mitmproxy', 04:25:11 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 04:25:11 INFO - '--firstNonBlankPaint'], 04:25:11 INFO - 'tests': ['tp6_google', 04:25:11 INFO - 'tp6_youtube', 04:25:11 INFO - 'tp6_amazon', 04:25:11 INFO - 'tp6_facebook']}, 04:25:11 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:25:11 INFO - 'talos_options': ['--xperf_path', 04:25:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:25:11 INFO - 'tests': ['tp5n']}, 04:25:11 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 04:25:11 INFO - 'talos_options': ['--disable-stylo', 04:25:11 INFO - '--xperf_path', 04:25:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:25:11 INFO - 'tests': ['tp5n']}}} 04:25:11 INFO - Running post-action listener: _resource_record_post_action 04:25:11 INFO - [mozharness: 2017-09-26 11:25:11.606507Z] Finished populate-webroot step (success) 04:25:11 INFO - [mozharness: 2017-09-26 11:25:11.606613Z] Running create-virtualenv step. 04:25:11 INFO - Running pre-action listener: _resource_record_pre_action 04:25:11 INFO - Running main action method: create_virtualenv 04:25:11 INFO - Creating virtualenv /builds/slave/test/build/venv 04:25:11 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:25:11 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 04:25:11 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 04:25:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:25:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:25:12 INFO - Installing distribute.............................................................................................................................................................................................done. 04:25:12 INFO - Installing pip...............done. 04:25:12 INFO - Return code: 0 04:25:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:25:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:25:12 INFO - Reading from file tmpfile_stdout 04:25:12 INFO - Output received: 04:25:12 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 04:25:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:25:12 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')]} 04:25:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:25:12 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')]} 04:25:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:25:12 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 0x122b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f3b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1596df0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x159a440>, '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 0x159b130>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1595320>, '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': 'ea65d483da93c827905c2090000001f5-1506419941.308983-46057260', '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 04:25:12 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 04:25:12 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 04:25:12 INFO - Using env: {'DISPLAY': ':0', 04:25:12 INFO - 'HOME': '/home/cltbld', 04:25:12 INFO - 'LANG': 'en_US.UTF-8', 04:25:12 INFO - 'LANGUAGE': 'en_US:en', 04:25:12 INFO - 'LOGNAME': 'cltbld', 04:25:12 INFO - 'MAIL': '/var/mail/cltbld', 04:25:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:25:12 INFO - 'MOZ_NO_REMOTE': '1', 04:25:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:25:12 INFO - 'NO_EM_RESTART': '1', 04:25:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:25:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:25:12 INFO - 'PWD': '/builds/slave/test', 04:25:12 INFO - 'SHELL': '/bin/bash', 04:25:12 INFO - 'SHLVL': '1', 04:25:12 INFO - 'TERM': 'linux', 04:25:12 INFO - 'TMOUT': '86400', 04:25:12 INFO - 'USER': 'cltbld', 04:25:12 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1506419941.308983-46057260', 04:25:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:25:12 INFO - '_': '/tools/buildbot/bin/python'} 04:25:13 INFO - Ignoring indexes: http://pypi.python.org/simple/ 04:25:13 INFO - Downloading/unpacking pip>=1.5 04:25:13 INFO - Running setup.py egg_info for package pip 04:25:13 INFO - warning: no files found matching 'pip/cacert.pem' 04:25:13 INFO - warning: no files found matching '*.html' under directory 'docs' 04:25:13 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 04:25:13 INFO - no previously-included directories found matching 'docs/_build/_sources' 04:25:13 INFO - Installing collected packages: pip 04:25:13 INFO - Found existing installation: pip 1.1 04:25:13 INFO - Uninstalling pip: 04:25:13 INFO - Successfully uninstalled pip 04:25:13 INFO - Running setup.py install for pip 04:25:13 INFO - warning: no files found matching 'pip/cacert.pem' 04:25:13 INFO - warning: no files found matching '*.html' under directory 'docs' 04:25:13 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 04:25:13 INFO - no previously-included directories found matching 'docs/_build/_sources' 04:25:13 INFO - Installing pip script to /builds/slave/test/build/venv/bin 04:25:13 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 04:25:13 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 04:25:13 INFO - Successfully installed pip 04:25:13 INFO - Cleaning up... 04:25:13 INFO - Return code: 0 04:25:13 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:25:13 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')]} 04:25:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:25:13 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')]} 04:25:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:25:13 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 0x122b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f3b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1596df0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x159a440>, '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 0x159b130>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1595320>, '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': 'ea65d483da93c827905c2090000001f5-1506419941.308983-46057260', '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 04:25:13 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 04:25:13 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 04:25:13 INFO - Using env: {'DISPLAY': ':0', 04:25:13 INFO - 'HOME': '/home/cltbld', 04:25:13 INFO - 'LANG': 'en_US.UTF-8', 04:25:13 INFO - 'LANGUAGE': 'en_US:en', 04:25:13 INFO - 'LOGNAME': 'cltbld', 04:25:13 INFO - 'MAIL': '/var/mail/cltbld', 04:25:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:25:13 INFO - 'MOZ_NO_REMOTE': '1', 04:25:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:25:13 INFO - 'NO_EM_RESTART': '1', 04:25:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:25:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:25:13 INFO - 'PWD': '/builds/slave/test', 04:25:13 INFO - 'SHELL': '/bin/bash', 04:25:13 INFO - 'SHLVL': '1', 04:25:13 INFO - 'TERM': 'linux', 04:25:13 INFO - 'TMOUT': '86400', 04:25:13 INFO - 'USER': 'cltbld', 04:25:13 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1506419941.308983-46057260', 04:25:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:25:13 INFO - '_': '/tools/buildbot/bin/python'} 04:25:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:25:14 INFO - Downloading/unpacking psutil>=3.1.1 04:25:14 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 04:25:14 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 04:25:14 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 04:25:14 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 04:25:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:25:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:25:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:25:15 INFO - Installing collected packages: psutil 04:25:15 INFO - Running setup.py install for psutil 04:25:15 INFO - building 'psutil._psutil_linux' extension 04:25:15 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 04:25:15 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 04:25:15 INFO - building 'psutil._psutil_posix' extension 04:25:15 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 04:25:15 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 04:25:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:25:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:25:15 INFO - Successfully installed psutil 04:25:15 INFO - Cleaning up... 04:25:15 INFO - Return code: 0 04:25:15 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:25:15 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')]} 04:25:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:25:15 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')]} 04:25:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:25:15 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 0x122b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f3b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1596df0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x159a440>, '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 0x159b130>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1595320>, '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': 'ea65d483da93c827905c2090000001f5-1506419941.308983-46057260', '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 04:25:15 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 04:25:15 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 04:25:15 INFO - Using env: {'DISPLAY': ':0', 04:25:15 INFO - 'HOME': '/home/cltbld', 04:25:15 INFO - 'LANG': 'en_US.UTF-8', 04:25:15 INFO - 'LANGUAGE': 'en_US:en', 04:25:15 INFO - 'LOGNAME': 'cltbld', 04:25:15 INFO - 'MAIL': '/var/mail/cltbld', 04:25:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:25:15 INFO - 'MOZ_NO_REMOTE': '1', 04:25:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:25:15 INFO - 'NO_EM_RESTART': '1', 04:25:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:25:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:25:15 INFO - 'PWD': '/builds/slave/test', 04:25:15 INFO - 'SHELL': '/bin/bash', 04:25:15 INFO - 'SHLVL': '1', 04:25:15 INFO - 'TERM': 'linux', 04:25:15 INFO - 'TMOUT': '86400', 04:25:15 INFO - 'USER': 'cltbld', 04:25:15 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1506419941.308983-46057260', 04:25:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:25:15 INFO - '_': '/tools/buildbot/bin/python'} 04:25:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:25:16 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:25:16 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 04:25:16 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 04:25:16 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 04:25:16 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 04:25:17 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:25:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:25:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:25:17 INFO - Installing collected packages: mozsystemmonitor 04:25:17 INFO - Running setup.py install for mozsystemmonitor 04:25:17 INFO - Successfully installed mozsystemmonitor 04:25:17 INFO - Cleaning up... 04:25:18 INFO - Return code: 0 04:25:18 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:25:18 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')]} 04:25:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:25:18 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')]} 04:25:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:25:18 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 0x122b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f3b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1596df0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x159a440>, '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 0x159b130>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1595320>, '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': 'ea65d483da93c827905c2090000001f5-1506419941.308983-46057260', '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 04:25:18 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 04:25:18 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 04:25:18 INFO - Using env: {'DISPLAY': ':0', 04:25:18 INFO - 'HOME': '/home/cltbld', 04:25:18 INFO - 'LANG': 'en_US.UTF-8', 04:25:18 INFO - 'LANGUAGE': 'en_US:en', 04:25:18 INFO - 'LOGNAME': 'cltbld', 04:25:18 INFO - 'MAIL': '/var/mail/cltbld', 04:25:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:25:18 INFO - 'MOZ_NO_REMOTE': '1', 04:25:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:25:18 INFO - 'NO_EM_RESTART': '1', 04:25:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:25:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:25:18 INFO - 'PWD': '/builds/slave/test', 04:25:18 INFO - 'SHELL': '/bin/bash', 04:25:18 INFO - 'SHLVL': '1', 04:25:18 INFO - 'TERM': 'linux', 04:25:18 INFO - 'TMOUT': '86400', 04:25:18 INFO - 'USER': 'cltbld', 04:25:18 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1506419941.308983-46057260', 04:25:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:25:18 INFO - '_': '/tools/buildbot/bin/python'} 04:25:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:25:18 INFO - Downloading/unpacking jsonschema==2.5.1 04:25:18 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 04:25:18 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 04:25:18 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 04:25:18 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 04:25:19 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:25:19 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:25:19 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 04:25:19 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 04:25:19 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 04:25:19 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 04:25:19 INFO - Downloading functools32-3.2.3-2.tar.gz 04:25:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:25:19 INFO - warning: no files found matching '*.txt' 04:25:19 INFO - no previously-included directories found matching 'build' 04:25:19 INFO - no previously-included directories found matching 'dist' 04:25:19 INFO - no previously-included directories found matching '.git*' 04:25:19 INFO - Installing collected packages: jsonschema, functools32 04:25:20 INFO - Running setup.py install for functools32 04:25:21 INFO - warning: no files found matching '*.txt' 04:25:21 INFO - no previously-included directories found matching 'build' 04:25:21 INFO - no previously-included directories found matching 'dist' 04:25:21 INFO - no previously-included directories found matching '.git*' 04:25:21 INFO - Successfully installed jsonschema functools32 04:25:21 INFO - Cleaning up... 04:25:21 INFO - Return code: 0 04:25:21 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:25:21 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')]} 04:25:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:25:21 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')]} 04:25:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:25:21 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 0x122b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f3b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1596df0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x159a440>, '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 0x159b130>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1595320>, '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': 'ea65d483da93c827905c2090000001f5-1506419941.308983-46057260', '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 04:25:21 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 04:25:21 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 04:25:21 INFO - Using env: {'DISPLAY': ':0', 04:25:21 INFO - 'HOME': '/home/cltbld', 04:25:21 INFO - 'LANG': 'en_US.UTF-8', 04:25:21 INFO - 'LANGUAGE': 'en_US:en', 04:25:21 INFO - 'LOGNAME': 'cltbld', 04:25:21 INFO - 'MAIL': '/var/mail/cltbld', 04:25:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:25:21 INFO - 'MOZ_NO_REMOTE': '1', 04:25:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:25:21 INFO - 'NO_EM_RESTART': '1', 04:25:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:25:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:25:21 INFO - 'PWD': '/builds/slave/test', 04:25:21 INFO - 'SHELL': '/bin/bash', 04:25:21 INFO - 'SHLVL': '1', 04:25:21 INFO - 'TERM': 'linux', 04:25:21 INFO - 'TMOUT': '86400', 04:25:21 INFO - 'USER': 'cltbld', 04:25:21 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1506419941.308983-46057260', 04:25:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:25:21 INFO - '_': '/tools/buildbot/bin/python'} 04:25:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:25:21 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:25:21 INFO - Cleaning up... 04:25:21 INFO - Return code: 0 04:25:21 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:25:21 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')]} 04:25:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:25:21 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')]} 04:25:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:25:21 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 0x122b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f3b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1596df0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x159a440>, '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 0x159b130>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1595320>, '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': 'ea65d483da93c827905c2090000001f5-1506419941.308983-46057260', '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 04:25:21 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 04:25:21 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 04:25:21 INFO - Using env: {'DISPLAY': ':0', 04:25:21 INFO - 'HOME': '/home/cltbld', 04:25:21 INFO - 'LANG': 'en_US.UTF-8', 04:25:21 INFO - 'LANGUAGE': 'en_US:en', 04:25:21 INFO - 'LOGNAME': 'cltbld', 04:25:21 INFO - 'MAIL': '/var/mail/cltbld', 04:25:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:25:21 INFO - 'MOZ_NO_REMOTE': '1', 04:25:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:25:21 INFO - 'NO_EM_RESTART': '1', 04:25:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:25:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:25:21 INFO - 'PWD': '/builds/slave/test', 04:25:21 INFO - 'SHELL': '/bin/bash', 04:25:21 INFO - 'SHLVL': '1', 04:25:21 INFO - 'TERM': 'linux', 04:25:21 INFO - 'TMOUT': '86400', 04:25:21 INFO - 'USER': 'cltbld', 04:25:21 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1506419941.308983-46057260', 04:25:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:25:21 INFO - '_': '/tools/buildbot/bin/python'} 04:25:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:25:21 INFO - Downloading/unpacking blobuploader==1.2.4 04:25:21 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 04:25:21 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 04:25:21 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 04:25:21 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 04:25:23 INFO - Downloading blobuploader-1.2.4.tar.gz 04:25:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:25:23 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:25:23 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 04:25:23 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 04:25:23 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 04:25:23 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 04:25:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:25:23 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:25:23 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 04:25:23 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 04:25:23 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 04:25:23 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 04:25:23 INFO - Downloading docopt-0.6.1.tar.gz 04:25:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:25:23 INFO - Installing collected packages: blobuploader, requests, docopt 04:25:23 INFO - Running setup.py install for blobuploader 04:25:23 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:25:23 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:25:23 INFO - Running setup.py install for requests 04:25:24 INFO - Running setup.py install for docopt 04:25:24 INFO - Successfully installed blobuploader requests docopt 04:25:24 INFO - Cleaning up... 04:25:24 INFO - Return code: 0 04:25:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:25: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')]} 04:25:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:25: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')]} 04:25:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:25:24 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 0x122b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f3b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1596df0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x159a440>, '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 0x159b130>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1595320>, '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': 'ea65d483da93c827905c2090000001f5-1506419941.308983-46057260', '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 04:25:24 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 04:25:24 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 04:25:24 INFO - Using env: {'DISPLAY': ':0', 04:25:24 INFO - 'HOME': '/home/cltbld', 04:25:24 INFO - 'LANG': 'en_US.UTF-8', 04:25:24 INFO - 'LANGUAGE': 'en_US:en', 04:25:24 INFO - 'LOGNAME': 'cltbld', 04:25:24 INFO - 'MAIL': '/var/mail/cltbld', 04:25:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:25:24 INFO - 'MOZ_NO_REMOTE': '1', 04:25:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:25:24 INFO - 'NO_EM_RESTART': '1', 04:25:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:25:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:25:24 INFO - 'PWD': '/builds/slave/test', 04:25:24 INFO - 'SHELL': '/bin/bash', 04:25:24 INFO - 'SHLVL': '1', 04:25:24 INFO - 'TERM': 'linux', 04:25:24 INFO - 'TMOUT': '86400', 04:25:24 INFO - 'USER': 'cltbld', 04:25:24 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1506419941.308983-46057260', 04:25:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:25:24 INFO - '_': '/tools/buildbot/bin/python'} 04:25:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:25:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:25:24 INFO - Running setup.py (path:/tmp/pip-bs8BIr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:25:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:25:24 INFO - Running setup.py (path:/tmp/pip-sJh1bG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:25:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:25:24 INFO - Running setup.py (path:/tmp/pip-0w1VMi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:25:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:25:24 INFO - Running setup.py (path:/tmp/pip-YZsgWg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:25:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:25:24 INFO - Running setup.py (path:/tmp/pip-T_g1NX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:25:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:25:24 INFO - Running setup.py (path:/tmp/pip-iWKlgn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:25:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:25:24 INFO - Running setup.py (path:/tmp/pip-xBM7tI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:25:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:25:25 INFO - Running setup.py (path:/tmp/pip-B2Fe7o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:25:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:25:25 INFO - Running setup.py (path:/tmp/pip-X19UPy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:25:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:25:25 INFO - Running setup.py (path:/tmp/pip-uNsgV5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:25:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:25:25 INFO - Running setup.py (path:/tmp/pip-nzms_A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:25:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:25:25 INFO - Running setup.py (path:/tmp/pip-ACK5wt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:25:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:25:25 INFO - Running setup.py (path:/tmp/pip-jP_MBU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:25:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:25:25 INFO - Running setup.py (path:/tmp/pip-pbYU8V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:25:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:25:25 INFO - Running setup.py (path:/tmp/pip-26XJoM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:25:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:25:25 INFO - Running setup.py (path:/tmp/pip-Ul518U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:25:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:25:25 INFO - Running setup.py (path:/tmp/pip-hFvu3S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:25:25 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:25:25 INFO - Running setup.py install for manifestparser 04:25:25 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:25:25 INFO - Running setup.py install for mozcrash 04:25:25 INFO - Running setup.py install for mozdebug 04:25:26 INFO - Running setup.py install for mozdevice 04:25:26 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:25:26 INFO - Running setup.py install for mozfile 04:25:26 INFO - Running setup.py install for mozhttpd 04:25:26 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:25:26 INFO - Running setup.py install for mozinfo 04:25:26 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:25:26 INFO - Running setup.py install for mozInstall 04:25:26 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:25:26 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:25:26 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:25:26 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:25:26 INFO - Running setup.py install for mozleak 04:25:26 INFO - Running setup.py install for mozlog 04:25:26 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:25:26 INFO - Running setup.py install for moznetwork 04:25:26 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:25:26 INFO - Running setup.py install for mozprocess 04:25:26 INFO - Running setup.py install for mozprofile 04:25:27 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:25:27 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:25:27 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:25:27 INFO - Running setup.py install for mozrunner 04:25:27 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:25:27 INFO - Running setup.py install for mozscreenshot 04:25:27 INFO - Running setup.py install for moztest 04:25:27 INFO - Running setup.py install for mozversion 04:25:27 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:25:27 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:25:27 INFO - Cleaning up... 04:25:27 INFO - Return code: 0 04:25:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:25: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')]} 04:25:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:25: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')]} 04:25:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:25:27 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 0x122b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f3b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1596df0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x159a440>, '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 0x159b130>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1595320>, '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': 'ea65d483da93c827905c2090000001f5-1506419941.308983-46057260', '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 04:25:27 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 04:25:27 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 04:25:27 INFO - Using env: {'DISPLAY': ':0', 04:25:27 INFO - 'HOME': '/home/cltbld', 04:25:27 INFO - 'LANG': 'en_US.UTF-8', 04:25:27 INFO - 'LANGUAGE': 'en_US:en', 04:25:27 INFO - 'LOGNAME': 'cltbld', 04:25:27 INFO - 'MAIL': '/var/mail/cltbld', 04:25:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:25:27 INFO - 'MOZ_NO_REMOTE': '1', 04:25:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:25:27 INFO - 'NO_EM_RESTART': '1', 04:25:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:25:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:25:27 INFO - 'PWD': '/builds/slave/test', 04:25:27 INFO - 'SHELL': '/bin/bash', 04:25:27 INFO - 'SHLVL': '1', 04:25:27 INFO - 'TERM': 'linux', 04:25:27 INFO - 'TMOUT': '86400', 04:25:27 INFO - 'USER': 'cltbld', 04:25:27 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1506419941.308983-46057260', 04:25:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:25:27 INFO - '_': '/tools/buildbot/bin/python'} 04:25:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:25:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:25:27 INFO - Running setup.py (path:/tmp/pip-5OeO18-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:25:27 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)) 04:25:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:25:27 INFO - Running setup.py (path:/tmp/pip-O_AF_W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:25:27 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)) 04:25:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:25:27 INFO - Running setup.py (path:/tmp/pip-rFo2Zv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:25:27 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)) 04:25:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:25:27 INFO - Running setup.py (path:/tmp/pip-KlORHU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:25:27 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)) 04:25:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:25:27 INFO - Running setup.py (path:/tmp/pip-VGR41E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:25:28 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)) 04:25:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:25:28 INFO - Running setup.py (path:/tmp/pip-xqDL2Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:25:28 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)) 04:25:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:25:28 INFO - Running setup.py (path:/tmp/pip-egbfe3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:25:28 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)) 04:25:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:25:28 INFO - Running setup.py (path:/tmp/pip-wGlRZ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:25:28 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)) 04:25:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:25:28 INFO - Running setup.py (path:/tmp/pip-8MX8nD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:25:28 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)) 04:25:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:25:28 INFO - Running setup.py (path:/tmp/pip-2fl5Ec-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:25:28 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)) 04:25:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:25:28 INFO - Running setup.py (path:/tmp/pip-Y9fW8y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:25:28 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)) 04:25:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:25:28 INFO - Running setup.py (path:/tmp/pip-hZKvly-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:25:28 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)) 04:25:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:25:28 INFO - Running setup.py (path:/tmp/pip-dqSHdT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:25:28 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)) 04:25:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:25:28 INFO - Running setup.py (path:/tmp/pip-1vklIp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:25:28 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)) 04:25:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:25:28 INFO - Running setup.py (path:/tmp/pip-8pbLy2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:25:28 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)) 04:25:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:25:28 INFO - Running setup.py (path:/tmp/pip-Q2Sco9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:25:28 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)) 04:25:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:25:28 INFO - Running setup.py (path:/tmp/pip-aipu6c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:25:28 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)) 04:25:28 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)) 04:25:28 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)) 04:25:28 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)) 04:25:28 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)) 04:25:28 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)) 04:25:28 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)) 04:25:28 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:25: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 04:25: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 04:25: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 04:25: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 04:25:29 INFO - Downloading blessings-1.6.tar.gz 04:25:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:25:30 INFO - Installing collected packages: blessings 04:25:30 INFO - Running setup.py install for blessings 04:25:30 INFO - Successfully installed blessings 04:25:30 INFO - Cleaning up... 04:25:30 INFO - Return code: 0 04:25:30 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:25:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:25:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:25:30 INFO - Reading from file tmpfile_stdout 04:25:30 INFO - Current package versions: 04:25:30 INFO - argparse == 1.2.1 04:25:30 INFO - blessings == 1.6 04:25:30 INFO - blobuploader == 1.2.4 04:25:30 INFO - docopt == 0.6.1 04:25:30 INFO - functools32 == 3.2.3-2 04:25:30 INFO - jsonschema == 2.5.1 04:25:30 INFO - manifestparser == 1.1 04:25:30 INFO - mozInstall == 1.13 04:25:30 INFO - mozcrash == 1.0 04:25:30 INFO - mozdebug == 0.1 04:25:30 INFO - mozdevice == 0.51 04:25:30 INFO - mozfile == 1.2 04:25:30 INFO - mozhttpd == 0.7 04:25:30 INFO - mozinfo == 0.10 04:25:30 INFO - mozleak == 0.1 04:25:30 INFO - mozlog == 3.5 04:25:30 INFO - moznetwork == 0.27 04:25:30 INFO - mozprocess == 0.25 04:25:30 INFO - mozprofile == 0.28 04:25:30 INFO - mozrunner == 6.13 04:25:30 INFO - mozscreenshot == 0.1 04:25:30 INFO - mozsystemmonitor == 0.3 04:25:30 INFO - moztest == 0.8 04:25:30 INFO - mozversion == 1.4 04:25:30 INFO - psutil == 3.1.1 04:25:30 INFO - requests == 1.2.3 04:25:30 INFO - wsgiref == 0.1.2 04:25:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:25: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')]} 04:25:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:25: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')]} 04:25:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:25:30 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 0x122b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f3b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1596df0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x159a440>, '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 0x159b130>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1595320>, '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': 'ea65d483da93c827905c2090000001f5-1506419941.308983-46057260', '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 04:25:30 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 04:25:30 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 04:25:30 INFO - Using env: {'DISPLAY': ':0', 04:25:30 INFO - 'HOME': '/home/cltbld', 04:25:30 INFO - 'LANG': 'en_US.UTF-8', 04:25:30 INFO - 'LANGUAGE': 'en_US:en', 04:25:30 INFO - 'LOGNAME': 'cltbld', 04:25:30 INFO - 'MAIL': '/var/mail/cltbld', 04:25:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:25:30 INFO - 'MOZ_NO_REMOTE': '1', 04:25:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:25:30 INFO - 'NO_EM_RESTART': '1', 04:25:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:25:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:25:30 INFO - 'PWD': '/builds/slave/test', 04:25:30 INFO - 'SHELL': '/bin/bash', 04:25:30 INFO - 'SHLVL': '1', 04:25:30 INFO - 'TERM': 'linux', 04:25:30 INFO - 'TMOUT': '86400', 04:25:30 INFO - 'USER': 'cltbld', 04:25:30 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1506419941.308983-46057260', 04:25:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:25:30 INFO - '_': '/tools/buildbot/bin/python'} 04:25:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:25:30 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)) 04:25:30 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)) 04:25:30 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)) 04:25:30 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)) 04:25:30 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)) 04:25:30 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)) 04:25:30 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)) 04:25:30 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)) 04:25:30 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)) 04:25:30 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 04:25: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 04:25: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 04:25: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 04:25: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 04:25:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 04:25:31 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)) 04:25:31 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)) 04:25:31 INFO - Installing collected packages: simplejson 04:25:31 INFO - Running setup.py install for simplejson 04:25:31 INFO - building 'simplejson._speedups' extension 04:25:31 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 04:25:32 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 04:25:32 INFO - Successfully installed simplejson 04:25:32 INFO - Cleaning up... 04:25:32 INFO - Return code: 0 04:25:32 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:25: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')]} 04:25:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:25: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')]} 04:25:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:25: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']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x122b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f3b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1596df0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x159a440>, '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 0x159b130>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1595320>, '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': 'ea65d483da93c827905c2090000001f5-1506419941.308983-46057260', '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 04:25: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'] in /builds/slave/test/build 04:25: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 04:25:32 INFO - Using env: {'DISPLAY': ':0', 04:25:32 INFO - 'HOME': '/home/cltbld', 04:25:32 INFO - 'LANG': 'en_US.UTF-8', 04:25:32 INFO - 'LANGUAGE': 'en_US:en', 04:25:32 INFO - 'LOGNAME': 'cltbld', 04:25:32 INFO - 'MAIL': '/var/mail/cltbld', 04:25:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:25:32 INFO - 'MOZ_NO_REMOTE': '1', 04:25:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:25:32 INFO - 'NO_EM_RESTART': '1', 04:25:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:25:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:25:32 INFO - 'PWD': '/builds/slave/test', 04:25:32 INFO - 'SHELL': '/bin/bash', 04:25:32 INFO - 'SHLVL': '1', 04:25:32 INFO - 'TERM': 'linux', 04:25:32 INFO - 'TMOUT': '86400', 04:25:32 INFO - 'USER': 'cltbld', 04:25:32 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1506419941.308983-46057260', 04:25:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:25:32 INFO - '_': '/tools/buildbot/bin/python'} 04:25:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:25:33 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:25:33 INFO - Cleaning up... 04:25:33 INFO - Return code: 0 04:25:33 INFO - Running post-action listener: _resource_record_post_action 04:25:33 INFO - Running post-action listener: _start_resource_monitoring 04:25:33 INFO - Starting resource monitoring. 04:25:33 INFO - [mozharness: 2017-09-26 11:25:33.170981Z] Finished create-virtualenv step (success) 04:25:33 INFO - [mozharness: 2017-09-26 11:25:33.171521Z] Running install step. 04:25:33 INFO - Running pre-action listener: _resource_record_pre_action 04:25:33 INFO - Running main action method: install 04:25:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:25:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:25:33 INFO - Reading from file tmpfile_stdout 04:25:33 INFO - Detecting whether we're running mozinstall >=1.0... 04:25:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:25:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:25:33 INFO - Reading from file tmpfile_stdout 04:25:33 INFO - Output received: 04:25:33 INFO - Usage: mozinstall [options] installer 04:25:33 INFO - Options: 04:25:33 INFO - -h, --help show this help message and exit 04:25:33 INFO - -d DEST, --destination=DEST 04:25:33 INFO - Directory to install application into. [default: 04:25:33 INFO - "/builds/slave/test"] 04:25:33 INFO - --app=APP Application being installed. [default: firefox] 04:25:33 INFO - mkdir: /builds/slave/test/build/application 04:25:33 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'] 04:25:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 04:25:51 INFO - Reading from file tmpfile_stdout 04:25:51 INFO - Output received: 04:25:51 INFO - /builds/slave/test/build/application/firefox/firefox 04:25:51 INFO - Running post-action listener: _resource_record_post_action 04:25:51 INFO - [mozharness: 2017-09-26 11:25:51.145482Z] Finished install step (success) 04:25:51 INFO - [mozharness: 2017-09-26 11:25:51.145734Z] Running setup-mitmproxy step. 04:25:51 INFO - Running pre-action listener: _resource_record_pre_action 04:25:51 INFO - Running main action method: setup_mitmproxy 04:25:51 INFO - Skipping: mitmproxy is not required 04:25:51 INFO - Running post-action listener: _resource_record_post_action 04:25:51 INFO - [mozharness: 2017-09-26 11:25:51.146864Z] Finished setup-mitmproxy step (success) 04:25:51 INFO - [mozharness: 2017-09-26 11:25:51.147150Z] Running run-tests step. 04:25:51 INFO - Running pre-action listener: _resource_record_pre_action 04:25:51 INFO - Running pre-action listener: _set_gcov_prefix 04:25:51 INFO - Running main action method: run_tests 04:25:51 WARNING - Try message not found. 04:25:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:25:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:25:51 INFO - Python 2.7.3 04:25:51 INFO - Return code: 0 04:25:51 INFO - grabbing minidump binary from tooltool 04:25:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:25:51 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 0x159a440>, '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 0x159b130>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1595320>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:25:51 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 04:25:51 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 04:25:51 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 04:25:51 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:25:51 INFO - Return code: 0 04:25:51 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:25:51 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:25:51 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:25:51 INFO - ENV: RUST_BACKTRACE is now full 04:25:51 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:25:51 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:25:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XpubHF4YRmq2bSLzKMvNAg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-084', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] in /builds/slave/test/build 04:25:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-stylo-disabled-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/XpubHF4YRmq2bSLzKMvNAg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-084 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log 04:25:51 INFO - Using env: {'DISPLAY': ':0', 04:25:51 INFO - 'HOME': '/home/cltbld', 04:25:51 INFO - 'LANG': 'en_US.UTF-8', 04:25:51 INFO - 'LANGUAGE': 'en_US:en', 04:25:51 INFO - 'LOGNAME': 'cltbld', 04:25:51 INFO - 'MAIL': '/var/mail/cltbld', 04:25:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:25:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:25:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:25:51 INFO - 'MOZ_NO_REMOTE': '1', 04:25:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:25:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:25:51 INFO - 'NO_EM_RESTART': '1', 04:25:51 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:25:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:25:51 INFO - 'PWD': '/builds/slave/test', 04:25:51 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:25:51 INFO - 'RUST_BACKTRACE': 'full', 04:25:51 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 04:25:51 INFO - 'SHELL': '/bin/bash', 04:25:51 INFO - 'SHLVL': '1', 04:25:51 INFO - 'TERM': 'linux', 04:25:51 INFO - 'TMOUT': '86400', 04:25:51 INFO - 'USER': 'cltbld', 04:25:51 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1506419941.308983-46057260', 04:25:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:25:51 INFO - '_': '/tools/buildbot/bin/python'} 04:25:51 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XpubHF4YRmq2bSLzKMvNAg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-084', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] with output_timeout 3600 04:25:51 INFO - mozversion application_buildid: 20170926095221 04:25:51 INFO - mozversion application_changeset: 6fb1f5fae37168c824b988733aac0d46499b6c11 04:25:51 INFO - mozversion application_display_name: Nightly 04:25:51 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:25:51 INFO - mozversion application_name: Firefox 04:25:51 INFO - mozversion application_remotingname: firefox 04:25:51 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:25:51 INFO - mozversion application_vendor: Mozilla 04:25:51 INFO - mozversion application_version: 58.0a1 04:25:51 INFO - mozversion platform_buildid: 20170926095221 04:25:51 INFO - mozversion platform_changeset: 6fb1f5fae37168c824b988733aac0d46499b6c11 04:25:51 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:25:51 INFO - mozversion platform_version: 58.0a1 04:25:51 INFO - using testdate: 1506425151 04:25:51 INFO - actual date: 1506425151 04:25:51 INFO - starting webserver on 'localhost:38340' 04:25:51 INFO - SUITE-START | Running 2 tests 04:25:51 INFO - TEST-START | dromaeo_css 04:25:51 INFO - Initialising browser for dromaeo_css test... 04:25:51 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:38340/getInfo.html -profile /tmp/tmplHhGst/profile 04:25:51 INFO - TEST-INFO | started process 15630 (/builds/slave/test/build/application/firefox/firefox http://localhost:38340/getInfo.html) 04:25:57 INFO - TEST-INFO | 15630: exit 0 04:25:57 INFO - Browser initialized. 04:25:57 INFO - Running cycle 1/1 for dromaeo_css test... 04:25:57 INFO - Using env: {'DISPLAY': ':0', 04:25:57 INFO - 'HOME': '/home/cltbld', 04:25:57 INFO - 'JSGC_DISABLE_POISONING': '1', 04:25:57 INFO - 'LANG': 'en_US.UTF-8', 04:25:57 INFO - 'LANGUAGE': 'en_US:en', 04:25:57 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 04:25:57 INFO - 'LOGNAME': 'cltbld', 04:25:57 INFO - 'MAIL': '/var/mail/cltbld', 04:25:57 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:25:57 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:25:57 INFO - 'MOZ_CRASHREPORTER': '1', 04:25:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:25:57 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 04:25:57 INFO - 'MOZ_NO_REMOTE': '1', 04:25:57 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:25:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:25:57 INFO - 'NO_EM_RESTART': '1', 04:25:57 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:25:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:25:57 INFO - 'PWD': '/builds/slave/test', 04:25:57 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:25:57 INFO - 'RUST_BACKTRACE': 'full', 04:25:57 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 04:25:57 INFO - 'SHELL': '/bin/bash', 04:25:57 INFO - 'SHLVL': '1', 04:25:57 INFO - 'STYLO_FORCE_DISABLED': '1', 04:25:57 INFO - 'TERM': 'linux', 04:25:57 INFO - 'TMOUT': '86400', 04:25:57 INFO - 'USER': 'cltbld', 04:25:57 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1506419941.308983-46057260', 04:25:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:25:57 INFO - '_': '/tools/buildbot/bin/python'} 04:25:57 INFO - TEST-INFO | started process 15869 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplHhGst/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 04:25:58 INFO - PID 15869 | 04:25:58 INFO - PID 15869 | (/builds/slave/test/build/application/firefox/firefox:15920): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 04:25:58 INFO - PID 15869 | 04:26:09 INFO - PID 15869 | RSS: Main: 144818176 04:26:09 INFO - PID 15869 | 04:29:05 INFO - PID 15869 | Cycle 1(1): loaded http://localhost:38340/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38340/tests/dromaeo/cssquery-ext.html) 04:29:06 INFO - PID 15869 | RSS: Main: 146542592 04:29:06 INFO - PID 15869 | 04:32:08 INFO - PID 15869 | Cycle 1(1): loaded http://localhost:38340/tests/dromaeo/cssquery-ext.html (next: http://localhost:38340/tests/dromaeo/cssquery-jquery.html) 04:32:09 INFO - PID 15869 | RSS: Main: 146378752 04:32:09 INFO - PID 15869 | 04:35:10 INFO - PID 15869 | Cycle 1(1): loaded http://localhost:38340/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38340/tests/dromaeo/cssquery-mootools.html) 04:35:11 INFO - PID 15869 | RSS: Main: 148688896 04:35:11 INFO - PID 15869 | 04:38:12 INFO - PID 15869 | Cycle 1(1): loaded http://localhost:38340/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38340/tests/dromaeo/cssquery-prototype.html) 04:38:13 INFO - PID 15869 | RSS: Main: 146812928 04:38:13 INFO - PID 15869 | 04:41:16 INFO - PID 15869 | Cycle 1(1): loaded http://localhost:38340/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38340/tests/dromaeo/cssquery-yui.html) 04:41:17 INFO - PID 15869 | RSS: Main: 148463616 04:41:17 INFO - PID 15869 | 04:44:18 INFO - PID 15869 | Cycle 1(1): loaded http://localhost:38340/tests/dromaeo/cssquery-yui.html (next: http://localhost:38340/tests/dromaeo/cssquery-dojo.html) 04:44:18 INFO - PID 15869 | RSS: Main: 150462464 04:44:18 INFO - PID 15869 | 04:44:18 INFO - PID 15869 | __start_tp_report 04:44:18 INFO - PID 15869 | _x_x_mozilla_page_load 04:44:18 INFO - PID 15869 | _x_x_mozilla_page_load_details 04:44:18 INFO - PID 15869 | |i|pagename|runs| 04:44:18 INFO - PID 15869 | |0;dojo.html;3823.1971286029934;3846.8076596170185;3851.422286657001;3852.0562462196767;3857.980710096449;6263.029230469285;6266.216722909637;6312.5581209315305;6316.431521163095;6415.6471394073305;6347.36526347365;6356.3325850785695;6374.298827129012;6378.553501254914;6385.776497822577;5567.972160139194;5596.384397716248;5635.971820140893;5641.435856414346;5698.401667824881;5704.258446401983;5760.711964401784;5763.481286684198;5770.740316685759;5794.913076303858;150.36491863508377;5603.579731520112;5608.270924779753;5760.855978600547;5764.221830052931;5650.6892120933335;5660.60375773696;5721.856953576153;5731.914021289684;5735.254416925814;5657.519110875581;5660.8867822643315;5710.914336284959;5730.828075157752;5736.770529178828;6144.0783882417545;6211.409916057967;6335.3981371769605;6389.808305750788;6414.294427612959;6864.656767161672;6886.896696549556;6965.129358830146;6972.163340399134;6973.930260697379;6854.3145685431555;6882.931170688279;6944.756933507353;6954.582725036514;6961.26906674802;6376.26672932614;6416.615003099829;6441.871162576722;6443.903341449882;6453.612783233068;7022.157341118997;7032;7038.6480675965995;7108.857822843514;7115.324044215791;6615.834604134839;6712.765053223114;6712.95949127886;6714.227863795629;6814.386705196556;6808;6812.0122582226295;6814.897776533356;6853.965730171317;6939.340762627542;6809.080774095433;6862.210845752703;6881.10545629075;6884.827879303058;6897.137857767779;6777.559458635173;6794.66026698673;6806.8298292542095;6867.690953907087;6875.140607424072;4993.101241776515;5021.949780502148;5039.571636410873;5063.569596584258;5069.366329208849;4563.95436045642;4570.154521413549;4586.793594288265;4597.103564804831;4600.493945665974;6111.388861113853;6274.811755647338;6292.779752708725;6298.559100862895;6304.684765761694;6837.692303846339;6852.383285504328;6893.827654308582;6959.652017399109;6968.372846443743;6135.294441139326;6181.412765787243;6188.81433556985;6188.845278868064;6239.188905442264;5486.615936884459;5534.52956498694;5558.221848941152;5560.138178582326;5596.3284405871555;6900.2409734929115;7031.578105313698;7066.187388450291;7075.540089894141;7080.468964827659;6831.658417079226;6859.485538584527;6937.583744975318;6939.028536004862;6943.305669433016;6853.280405557544;6946.201186863374;6961.512694111364;6964.09466769337;6976.965115174392;6764.695588698422;6771.45828333742;6803.693833777591;6808.523403361915;6812.420944219599;6791.966040169767;6953.096097507291;6962.477814164059;6969.1985421677155;6980.685869135799;6554.180727409074;6644.368784965421;6649;6658.234303055211;6666.366695163952;6558.573692709959;6561.901571476527;6601.273859875314;6640.667966601747;6646.933530664632;6426.710798014007;6532.8366790830605;6548.3124271950755;6556.98366753154;6561.835954101186;6674.532782705164;6675.065490831191;6681.2984636612455;6775.55958862692;6803.829904252433;6525.967370163119;6529.085927969993;6615.272320044887;6621.503387246072;6628.701708423229 04:44:18 INFO - PID 15869 | |1;ext.html;830.2901019628222;837.3468694418352;876.2902049340033;892.1435421994888;900.5362238447201;42041.789791051044;42723.57276427239;42818;42824.357634635504;42840.78579607105;43746.781266093625;43872.3419148713;43940;43968.56031439685;44005.11989760203;8263.834723305545;8401.159884011611;8407.70573029944;8419.410641255115;8453.239208471236;8250.669973201095;8276.586170691471;8280.503169809801;8368.623411946477;8371.623276952521;8308.501489910625;8368.079511253758;8405.369597280198;8408.495490270572;8418.831623367529;8335;8346.66613335472;8354.832903341929;8366.53984030878;8401.41190116692;8223.301019413357;8275.875861862078;8310.792230194233;8312.54281014544;8316.209960053786;39525;39720.404193937116;39851.8007409964;39909;39944.400833987514;3735.8132093395493;3743.625637436262;3766.0584853786554;3771.4531392948143;3773.490578771858;31484.37031259362;32144.678553214635;32260.677393226;32285;32319.51520727191;5223.817166399158;5383.138697808371;5410.134378499461;5422.43064478232;5438.619296649236;210196;210243;210384;210844;211222;49885.750571246914;49987.25019124716;50046.24930626043;50306;50461.49538504568;52745;52787;53022.46977530175;53083.73458132685;53167.734161328946;16527.421540246032;16901.070441125856;16912.408065717642;16931.66136677284;17066.573335666708;13766.380512876945;13795.586132416043;13796;13894.166350019032;13894.374753136133;13295.268760218281;13666.453341866214;13758.174509529461;13840.446382144803;13927.373268202955;5598.384177740445;5652.63257888236;5653.095504719307;5683.863227354545;5686.772529098873;1084.6420681175193;1090.5310716391868;1095.5617752898745;1099.1591432554103;1100.8899110089087;25649.230523084338;25722.35694107662;25748.3562910925;25872.8706356467;25878.353041174123;1195.802692555736;1200.9939950300193;1216.355331674214;1220.0605533738972;1231.1443546735113;13521;13596.456141754417;13674;13719.451221951209;13834.031617786659;255202;255983;256658;257677;257994;56092.71953640206;56578;60563;60650.39349606536;60724;1513.17531945088;1540.530138307827;1540.99229503854;1541.3757428241581;1543.398074750848;30496.237594060327;30616.693833061385;30695.539566906962;30844;30902.381952361276;40328.59671403366;40371.394429083;40441.59558404378;40498;40545.1890962185;229886;232200;232404;232491;232669;34139.65860341365;35026.299474009866;35210.29579408346;35433.82283088568;35471.29057418889;44683.55316446924;44890.10219795651;45322.32016519689;45451;45655;33757;33895.32209355848;34023;34344.82827585846;34452.82773586116;34043.14892127716;34080;34135.65864341325;34184;34791;39174;39592;40301.79849100736;40575.18849622932;40579.59420405876;33028.50457243095;33050.33899322048;33085.83457082699;33620.66379336175;33773.662263378035;25476.363090922874;25618.871905640353;25665;25762.103110269076;26142.73857261479 04:44:18 INFO - PID 15869 | |2;jquery.html;606.3724045612792;608.8934436473619;616.2912650451982;639.1467391032971;649.3117295666596;22810.885945570248;23157.421064473398;23932.282031539038;23950.88024559879;24009;24933.127340543084;25789;25934.740652593468;25954.091606793765;26005.739942600616;6558.311377305386;6625.436837868787;6677.4991875609285;6692.364225398579;6710.5302628816;6523.7064332105165;6531.934680653204;6603.3396660334065;6769.898451523231;6798.116244888158;6752.696128674222;6758.357955994173;6758.932410675904;6759.425448836855;6774.796756097325;6398.776042838478;6673.49948753843;6693.531452798306;6741.191057073133;6746.325367463239;6264.718087686019;6269.686515674243;6275.6862156891975;6296.968515157395;6302.086197501382;29816.850915745283;30246.395072098654;30269.24326891823;30299.242518936982;30323.241918952204;2262.9773702262933;2283.897224624879;2286.7255929288426;2287.4395773035544;2289.0843662534953;20600.175992960263;20905.686414703792;20958.371248862557;20968.370948871558;21013.5797284055;2279.806216471602;2307.1348244408346;2353.364591560286;2359.28041947206;2377.4413012941945;129276.35361823224;133230.33384833013;150468;157608;164070;15548;15650.37398504047;15748.370065197263;15989.241183469809;16475.83524164743;25006.87496562542;25014;25099.87450062738;25150;25171.748282517307;10358.637447689294;10590.947045264878;10648.467576621139;10684.412357320267;10835.729106772236;9702.611895524242;9731.464769437607;9735.951320243354;9777.902220977841;9820.852687209697;9596.078098556673;9618.567164477616;9656.565454554562;9878.110970012733;9990.600375985025;2809.676887157962;2935.060780550246;2969.242843075002;3000.294930691286;3019.6597636831193;1014.4978235773192;1034.9534270957824;1038.1279725030859;1041.8176819056634;1051.2220956492295;20288.492787680425;20868.686969695467;21247;21484.892575537335;21533.13867445316;1108.6673997800629;1109.417555783204;1109.6005438042298;1109.7225693576606;1114.1309778372881;11395.373254471084;11432.599859004895;11481.483333250024;11565.537378504765;11609.30344179352;582405;598242;604546;611483;637384;120381.39809300897;121734;125934.37032814778;127001.36499317629;128737.35631321784;1115.2082021764477;1150.4880328254014;1165.3998190931677;1229.1027549888631;1285.0298024991073;21454.570908582053;21583.568328633653;21734.67397989063;22228.666570001787;22369.44076398103;63891.680541596994;64130;65079.02381464187;65462;67191.32808671851;79597.60201198957;79986;80020.19979800127;80499.59750201211;81606.18393816223;14632.561023169323;15007.77488337654;15302.540923772305;15306.540803775904;15391;23314.65028024547;23571.29286121419;23627.40931476727;23663;24195.63706544368;18616.16227269749;18826.24695012239;18852.434426967215;19097.522561936064;19187.232510699974;16570.751438728188;16974.660506790042;17090.316387344865;17535.210915509087;17786;17942.282308707505;17951.730724038887;18013.72979405336;19220.519487012938;19487.51281217924;14171;14197.361118749475;14296.285185740464;14317.284135793378;14326.426942922166;16195.352185912432;16322.67354652924;16441.91779041145;18106.547336316697;18560.443186704422 04:44:18 INFO - PID 15869 | |3;mootools.html;1426.7075249573838;1467.0684115586598;1467.5377256164306;1474.6018574984755;1479.866811986921;16337.673246535078;16884.493465196065;16918.154092295383;16999.57501062471;17005.234764435583;16549.751753723674;16693.49919502414;16731.581710457245;16731.83268167318;16836.83163168368;2538.1497198438547;2693.205504376204;2694.649695539577;2694.932626684329;2695.1644990053146;2696.824706394088;2849.7292757188034;2859.642544681915;2865.0258911969927;2866.054202113298;2792.5392310268885;2876.395956849064;2881.884724611013;2890.7542858857023;2893.0742162508004;2815.366542527925;2823.421198654271;2855.8714857831446;2858.642669666281;2859.785516086302;2800.2019424464133;2893.9276518087004;2904.302967287857;2904.651441826973;2922;16429.6714065718;16504.587385315343;16604.916975415166;16623.83376166247;16633.66732665352;8478.236958673688;8790.912090879074;8809.075047120088;8820.603072861737;8824.426412283181;5753.482186603184;5942.257217847769;6028.065649824284;6095.08573713942;6101.0848372744;2105.589410065038;2126.564054368866;2129.4676330917273;2130.7975742304457;2174.608570457317;30104.849475752482;30211.69788302111;30319.545206821917;30329.545056824165;30383.24041898948;7892.250236227549;7908.84182316362;8161.959190204011;8213.917860821435;8221.588920553948;19530.414087577396;19694.803051969582;19701.60596788056;19714.605707885763;19718.309859155146;8697.173768491983;8798.252148567444;8828;8836.072212417732;8840.33697472692;7890.684372625145;7929.603519823986;8054.879176812353;8143.674253029931;8151.470154440061;5601.8599535011135;5631.267935168402;5639.210510528529;5656.971715141398;5692.089265717465;1706.402759034328;1718.5445856847946;1718.5961299094702;1745.6595963787195;1751.6584266068248;1000.4797505297205;1016.8983101689772;1020.6070662794878;1022.2741853284103;1040.5629635553087;8817.250533704579;8825.470471771714;8843.425177363579;8951.597178127;8955.194032537103;794.8211652378284;796.2555011064674;796.7251298302076;797.4338219863962;807.0758980966878;5728.169415434739;6216.689165541705;6233.252009758768;6315.400036996478;6341.017142342944;24162.75837241605;24503.754962450505;24687.38281542976;24776.876115619667;24853;24167.516649666908;24292.63561046586;24330.14844480435;24379;24433.633495497583;11851.170418070824;12861.356932153354;13008.154469959421;13013.544525941546;13051.216926984222;9336.673216437664;9648.934951615809;9758.60965561398;9785.021497850157;9825.263105266991;20689.58620827605;20936.267230647463;21739.565208696054;21841.563168736855;22086.779132209114;21937.34187974363;22072.33782986513;22166.224182153546;22208.77791222067;22291;12336.75326493483;12568.937155314165;12583.496660133858;12585.119041666996;12597.74804503923;15479.226038698245;15627.374905003673;15634.374625014872;15668.608284792515;15719.921400392925;12477.376131193585;12533.686657833627;12807.167534110253;12887.16233444823;12921.353932303535;11838.881611183779;11854.762904742029;11884.405779710807;12117.454714537691;12343.938280308541;11063.391513466837;11180.105591552494;11337.26307789991;11342.149338799789;11342.829857552308;8432;8627;8724.65101395937;8774.21032107088;8781.20969112783;8313.750587482386;8359.623816928131;8407.915920840958;8485.236328730443;8504.659813607386 04:44:18 INFO - PID 15869 | |4;prototype.html;566.1790403914323;567.7445149682641;584.0859055578022;591.8905002574525;594.8066878264565;6228.314885362613;6266.436020758131;6376.936230637698;6426.453751431122;6430.485561155108;6099.57302988791;6229.1902052733085;6250.374962503759;6286.52851036173;6299.086632438305;4892.14387482191;5018.573421259197;5138;5167.896642067157;5197.974010129944;4964.528369804862;4976.4525902150735;5008.223725322581;5024.196128619422;5037.722925239111;4933.383327084114;4948.2824990376375;4957.752112394384;4979.2655508368725;5007.89826238227;4931.731403554387;4960.975195124001;4965.577925876305;4976.02967421353;4988.775505102279;4478.955210447886;4500.09998000398;4527.954720452786;4534.841280555198;4546.47715512717;6036.671932174914;6104.908426373608;6245.313015568284;6291.1192433059405;6291.62250264981;5784.88430231393;5808.651480911117;5816.854578635568;5830.854228644275;5836.649801011953;6616.834579135512;6629.535932484728;6649.700763465656;6667.699953502056;6696.45088103306;4828.517148285178;4979.7261150636705;5001.149804533238;5007.272490990603;5013.816226696038;6598.538102332838;6717.328267173292;6870.560950862472;6872.587644741331;6899.482538809559;5179.922301165486;5197.66215196011;5198.818041368534;5236.29310043147;5244.0145489428305;5239.371275446894;5269.736513174326;5284.101702710548;5295.867603309948;5331.4401987790725;5935.970320148458;5956.736440152714;5958.612690175125;5973.923429433845;5978.581499295007;6711.6979735912;6714.194296684332;6789.524733268624;6789.524733268624;6854.2117656469145;1823.1977929710886;1825.6805059114602;1836.2838492987746;1839.8344149026652;1841.1438681013392;1246.569933372985;1305.849827269857;1312.9409176587076;1313.875181857722;1314.572763851752;6071.301800292935;6097.69511524422;6102.206713127265;6102.816915492543;6151.554384719588;6626.105475760711;6704.631245281556;6706.161729783777;6709.966450167718;6759.898601520981;6044.486218671374;6080.513558915276;6104.664243466652;6111.449969502677;6182;3565.607783143852;3582.229820588586;3607.4408466687705;3615.7107431405425;3616.367135751233;6910.239873613898;6915.377616014483;6921.988934813372;6947.40947019509;6969.860602787916;6677.966610166918;6715.925451927668;6804.965975170093;6807.897881531781;6864.485163612749;6818.749812561843;6908.723651053901;6914.409685772301;6944.756933507303;6947.3747362737595;6739.460843132636;6805.455563555002;6807.795766127024;6813.829654258683;6840.521163518506;6595.769148079794;6630.83422914431;6643.30245324234;6649.301823308483;6732.461403087644;6597.4392176663605;6683.565568238049;6761.695723692544;6839.8700974269295;6883.414909732729;5168.457311982188;5200.60995425337;5209.453007434165;5225.752926241753;5230.633855630222;6568.310327415744;6781.6270105144695;6825.522213445011;6831.701976624426;6900.171979362509;6409.615423074631;6551.181102362205;6594.901076483952;6607.735690572324;6682.799516014527;6575.967120164369;6594.703238354382;6602.3397660233595;6613.404793568602;6627.966860165669;6490.643014634241;6494.253160886558;6521.543491955517;6526.347365263436;6541.313162117909;6585.904624826324;6604.966975165094;6629.171353580802;6640.568363056579;6709.52390474095;6360.522960778053;6402.455791257796;6415.390537898892;6429.306606177423;6456.418922297016 04:44:18 INFO - PID 15869 | |5;yui.html;941.7127776028317;957.1672644799024;971.4414211828196;979.6130528441266;982.6020461713007;19991.500212494677;20483.692744608823;20486.692699609517;20487.59024819503;20491.692624610605;19673.50816229595;19826.603467930632;19839.801601983974;20470.385888423334;20624;1084.614961688601;1096.857408536893;1099.6096385783053;1100.2518287564453;1100.257326304745;1068.6046162919731;1086.7174534620976;1087.9456027198607;1089.1504626391427;1091.497910960959;1168.1647621950303;1176.1355403778216;1176.4176732517417;1177.2583272538288;1177.264209868832;1098.3794156301665;1147.3689470791073;1164.0338519029228;1165.6561314412183;1177.6349331707156;832.4547421438967;839.1524560194187;839.9034111077243;840.8192238668715;842.2377748137945;20650.173993040262;20904.47738806527;21089.15643374263;21103.366898993056;21108.894455527778;19462;20824.47938801542;20986.370408887604;20997.68503472449;21333.786662133334;17084.40204592846;17175.656486870317;17190.312387504484;17381.826181738146;17415.56461088483;3991.960080399188;4012.8996775080564;4023.8994025149314;4025.174839157995;4025.9194816103513;158496;160780.19609901993;163456;163986.9999999988;166194;16983.575410614587;17215.741763873553;17299.394521191698;17474.47576572705;17703.645927081387;32888.835555822065;33264.3347133056;33265.168370790925;33324.66675333216;33463;9019.233365164035;9158.633654653739;9187.173154416134;9262.861057084148;9318.394304370195;4600.2869555218995;4612.654050946193;4620.237660786;4672.6261899047995;4684.391029166187;5984.8803023940145;5991.221141251609;6057.8485537861025;6101.084837274356;6139.539534534928;1125.386664267976;1151.7063148897146;1157.3287493253893;1160.14729174057;1164.790337739198;741.7737590034983;753.8906858505486;771.965261563231;772.644583491589;777.3470284960547;13026;13926.51257205993;14077.507287244896;14156.929215353857;14164.291785410689;748.1545853185866;759.400073941591;760.2701406649678;764.0029761161626;765.223298352173;6388.520860935449;6518.73925042993;6523.608583484911;6559.901601475982;6566;140673;143808;144971;144996;147389;121035;121570.99999999822;123797;124954.37522812327;125921.37039314744;110491.44754276337;111333.44333278443;111453;112669.4366528162;113917.86082139239;12088.551851796661;12301.507939682313;12356.938215308866;12411.875881241072;12508.687282817638;53053.7347313261;53384.1992370107;54374.7281263607;54475.72762136164;55690;69294;70216.29783702097;70454.29545704683;70524;70947;17248.310067597155;17333.13334333253;17425.912870435568;17534.649307014042;17794.37719679805;19192.232310707415;19473.90263048676;19520.90239548793;19567.119479623736;19825.30611428593;16946.322147113977;17030.57423564371;17115.315387384366;17159;17210.655786884443;16903.66192676164;16995.40516081931;17404.12979351053;17420.47738567845;17479.300827967247;17938.730919035963;18134.81865181331;18174.5456363592;18297;18349.449516514527;13147.211167329991;13183.868161318647;13186.538471153464;13244.20534767917;13372.598822035354;11968.581099661471;12095.334756588472;12256.325902075472;12395.442205100611;12398.752024959631 04:44:18 INFO - PID 15869 | __end_tp_report 04:44:18 INFO - PID 15869 | __start_cc_report 04:44:18 INFO - PID 15869 | _x_x_mozilla_cycle_collect,254 04:44:18 INFO - PID 15869 | __end_cc_report 04:44:18 INFO - PID 15869 | __startTimestamp1506426258858__endTimestamp 04:44:18 INFO - PID 15869 | 04:44:18 INFO - PID 15869 | ------- Summary: start ------- 04:44:18 INFO - PID 15869 | Number of tests: 6 04:44:18 INFO - PID 15869 | 04:44:18 INFO - PID 15869 | [#0] dojo.html Cycles:165 Average:6271.64 Median:6558.57 stddev:886.90 (13.5%) stddev-sans-first:868.57 04:44:18 INFO - PID 15869 | Values: 3823.2 3846.8 3851.4 3852.1 3858.0 6263.0 6266.2 6312.6 6316.4 6415.6 6347.4 6356.3 6374.3 6378.6 6385.8 5568.0 5596.4 5636.0 5641.4 5698.4 5704.3 5760.7 5763.5 5770.7 5794.9 150.4 5603.6 5608.3 5760.9 5764.2 5650.7 5660.6 5721.9 5731.9 5735.3 5657.5 5660.9 5710.9 5730.8 5736.8 6144.1 6211.4 6335.4 6389.8 6414.3 6864.7 6886.9 6965.1 6972.2 6973.9 6854.3 6882.9 6944.8 6954.6 6961.3 6376.3 6416.6 6441.9 6443.9 6453.6 7022.2 7032.0 7038.6 7108.9 7115.3 6615.8 6712.8 6713.0 6714.2 6814.4 6808.0 6812.0 6814.9 6854.0 6939.3 6809.1 6862.2 6881.1 6884.8 6897.1 6777.6 6794.7 6806.8 6867.7 6875.1 4993.1 5021.9 5039.6 5063.6 5069.4 4564.0 4570.2 4586.8 4597.1 4600.5 6111.4 6274.8 6292.8 6298.6 6304.7 6837.7 6852.4 6893.8 6959.7 6968.4 6135.3 6181.4 6188.8 6188.8 6239.2 5486.6 5534.5 5558.2 5560.1 5596.3 6900.2 7031.6 7066.2 7075.5 7080.5 6831.7 6859.5 6937.6 6939.0 6943.3 6853.3 6946.2 6961.5 6964.1 6977.0 6764.7 6771.5 6803.7 6808.5 6812.4 6792.0 6953.1 6962.5 6969.2 6980.7 6554.2 6644.4 6649.0 6658.2 6666.4 6558.6 6561.9 6601.3 6640.7 6646.9 6426.7 6532.8 6548.3 6557.0 6561.8 6674.5 6675.1 6681.3 6775.6 6803.8 6526.0 6529.1 6615.3 6621.5 6628.7 04:44:18 INFO - PID 15869 | 04:44:18 INFO - PID 15869 | [#1] ext.html Cycles:180 Average:41210.48 Median:3739.72 stddev:60619.60 (1621.0%) stddev-sans-first:60713.83 04:44:18 INFO - PID 15869 | Values: 830.3 837.3 876.3 892.1 900.5 42041.8 42723.6 42818.0 42824.4 42840.8 43746.8 43872.3 43940.0 43968.6 44005.1 8263.8 8401.2 8407.7 8419.4 8453.2 8250.7 8276.6 8280.5 8368.6 8371.6 8308.5 8368.1 8405.4 8408.5 8418.8 8335.0 8346.7 8354.8 8366.5 8401.4 8223.3 8275.9 8310.8 8312.5 8316.2 39525.0 39720.4 39851.8 39909.0 39944.4 3735.8 3743.6 3766.1 3771.5 3773.5 31484.4 32144.7 32260.7 32285.0 32319.5 5223.8 5383.1 5410.1 5422.4 5438.6 210196.0 210243.0 210384.0 210844.0 211222.0 49885.8 49987.3 50046.2 50306.0 50461.5 52745.0 52787.0 53022.5 53083.7 53167.7 16527.4 16901.1 16912.4 16931.7 17066.6 13766.4 13795.6 13796.0 13894.2 13894.4 13295.3 13666.5 13758.2 13840.4 13927.4 5598.4 5652.6 5653.1 5683.9 5686.8 1084.6 1090.5 1095.6 1099.2 1100.9 25649.2 25722.4 25748.4 25872.9 25878.4 1195.8 1201.0 1216.4 1220.1 1231.1 13521.0 13596.5 13674.0 13719.5 13834.0 255202.0 255983.0 256658.0 257677.0 257994.0 56092.7 56578.0 60563.0 60650.4 60724.0 1513.2 1540.5 1541.0 1541.4 1543.4 30496.2 30616.7 30695.5 30844.0 30902.4 40328.6 40371.4 40441.6 40498.0 40545.2 229886.0 232200.0 232404.0 232491.0 232669.0 34139.7 35026.3 35210.3 35433.8 35471.3 44683.6 44890.1 45322.3 45451.0 45655.0 33757.0 33895.3 34023.0 34344.8 34452.8 34043.1 34080.0 34135.7 34184.0 34791.0 39174.0 39592.0 40301.8 40575.2 40579.6 33028.5 33050.3 33085.8 33620.7 33773.7 25476.4 25618.9 25665.0 25762.1 26142.7 04:44:18 INFO - PID 15869 | 04:44:18 INFO - PID 15869 | [#2] jquery.html Cycles:180 Average:39423.77 Median:2288.26 stddev:101383.54 (4430.6%) stddev-sans-first:101626.06 04:44:18 INFO - PID 15869 | Values: 606.4 608.9 616.3 639.1 649.3 22810.9 23157.4 23932.3 23950.9 24009.0 24933.1 25789.0 25934.7 25954.1 26005.7 6558.3 6625.4 6677.5 6692.4 6710.5 6523.7 6531.9 6603.3 6769.9 6798.1 6752.7 6758.4 6758.9 6759.4 6774.8 6398.8 6673.5 6693.5 6741.2 6746.3 6264.7 6269.7 6275.7 6297.0 6302.1 29816.9 30246.4 30269.2 30299.2 30323.2 2263.0 2283.9 2286.7 2287.4 2289.1 20600.2 20905.7 20958.4 20968.4 21013.6 2279.8 2307.1 2353.4 2359.3 2377.4 129276.4 133230.3 150468.0 157608.0 164070.0 15548.0 15650.4 15748.4 15989.2 16475.8 25006.9 25014.0 25099.9 25150.0 25171.7 10358.6 10590.9 10648.5 10684.4 10835.7 9702.6 9731.5 9736.0 9777.9 9820.9 9596.1 9618.6 9656.6 9878.1 9990.6 2809.7 2935.1 2969.2 3000.3 3019.7 1014.5 1035.0 1038.1 1041.8 1051.2 20288.5 20868.7 21247.0 21484.9 21533.1 1108.7 1109.4 1109.6 1109.7 1114.1 11395.4 11432.6 11481.5 11565.5 11609.3 582405.0 598242.0 604546.0 611483.0 637384.0 120381.4 121734.0 125934.4 127001.4 128737.4 1115.2 1150.5 1165.4 1229.1 1285.0 21454.6 21583.6 21734.7 22228.7 22369.4 63891.7 64130.0 65079.0 65462.0 67191.3 79597.6 79986.0 80020.2 80499.6 81606.2 14632.6 15007.8 15302.5 15306.5 15391.0 23314.7 23571.3 23627.4 23663.0 24195.6 18616.2 18826.2 18852.4 19097.5 19187.2 16570.8 16974.7 17090.3 17535.2 17786.0 17942.3 17951.7 18013.7 19220.5 19487.5 14171.0 14197.4 14296.3 14317.3 14326.4 16195.4 16322.7 16441.9 18106.5 18560.4 04:44:18 INFO - PID 15869 | 04:44:18 INFO - PID 15869 | [#3] mootools.html Cycles:180 Average:10493.54 Median:2615.68 stddev:7620.93 (291.4%) stddev-sans-first:7611.86 04:44:18 INFO - PID 15869 | Values: 1426.7 1467.1 1467.5 1474.6 1479.9 16337.7 16884.5 16918.2 16999.6 17005.2 16549.8 16693.5 16731.6 16731.8 16836.8 2538.1 2693.2 2694.6 2694.9 2695.2 2696.8 2849.7 2859.6 2865.0 2866.1 2792.5 2876.4 2881.9 2890.8 2893.1 2815.4 2823.4 2855.9 2858.6 2859.8 2800.2 2893.9 2904.3 2904.7 2922.0 16429.7 16504.6 16604.9 16623.8 16633.7 8478.2 8790.9 8809.1 8820.6 8824.4 5753.5 5942.3 6028.1 6095.1 6101.1 2105.6 2126.6 2129.5 2130.8 2174.6 30104.8 30211.7 30319.5 30329.5 30383.2 7892.3 7908.8 8162.0 8213.9 8221.6 19530.4 19694.8 19701.6 19714.6 19718.3 8697.2 8798.3 8828.0 8836.1 8840.3 7890.7 7929.6 8054.9 8143.7 8151.5 5601.9 5631.3 5639.2 5657.0 5692.1 1706.4 1718.5 1718.6 1745.7 1751.7 1000.5 1016.9 1020.6 1022.3 1040.6 8817.3 8825.5 8843.4 8951.6 8955.2 794.8 796.3 796.7 797.4 807.1 5728.2 6216.7 6233.3 6315.4 6341.0 24162.8 24503.8 24687.4 24776.9 24853.0 24167.5 24292.6 24330.1 24379.0 24433.6 11851.2 12861.4 13008.2 13013.5 13051.2 9336.7 9648.9 9758.6 9785.0 9825.3 20689.6 20936.3 21739.6 21841.6 22086.8 21937.3 22072.3 22166.2 22208.8 22291.0 12336.8 12568.9 12583.5 12585.1 12597.7 15479.2 15627.4 15634.4 15668.6 15719.9 12477.4 12533.7 12807.2 12887.2 12921.4 11838.9 11854.8 11884.4 12117.5 12343.9 11063.4 11180.1 11337.3 11342.1 11342.8 8432.0 8627.0 8724.7 8774.2 8781.2 8313.8 8359.6 8407.9 8485.2 8504.7 04:44:18 INFO - PID 15869 | 04:44:18 INFO - PID 15869 | [#4] prototype.html Cycles:180 Average:5625.60 Median:6247.84 stddev:1560.22 (25.0%) stddev-sans-first:1517.68 04:44:18 INFO - PID 15869 | Values: 566.2 567.7 584.1 591.9 594.8 6228.3 6266.4 6376.9 6426.5 6430.5 6099.6 6229.2 6250.4 6286.5 6299.1 4892.1 5018.6 5138.0 5167.9 5198.0 4964.5 4976.5 5008.2 5024.2 5037.7 4933.4 4948.3 4957.8 4979.3 5007.9 4931.7 4961.0 4965.6 4976.0 4988.8 4479.0 4500.1 4528.0 4534.8 4546.5 6036.7 6104.9 6245.3 6291.1 6291.6 5784.9 5808.7 5816.9 5830.9 5836.6 6616.8 6629.5 6649.7 6667.7 6696.5 4828.5 4979.7 5001.1 5007.3 5013.8 6598.5 6717.3 6870.6 6872.6 6899.5 5179.9 5197.7 5198.8 5236.3 5244.0 5239.4 5269.7 5284.1 5295.9 5331.4 5936.0 5956.7 5958.6 5973.9 5978.6 6711.7 6714.2 6789.5 6789.5 6854.2 1823.2 1825.7 1836.3 1839.8 1841.1 1246.6 1305.8 1312.9 1313.9 1314.6 6071.3 6097.7 6102.2 6102.8 6151.6 6626.1 6704.6 6706.2 6710.0 6759.9 6044.5 6080.5 6104.7 6111.4 6182.0 3565.6 3582.2 3607.4 3615.7 3616.4 6910.2 6915.4 6922.0 6947.4 6969.9 6678.0 6715.9 6805.0 6807.9 6864.5 6818.7 6908.7 6914.4 6944.8 6947.4 6739.5 6805.5 6807.8 6813.8 6840.5 6595.8 6630.8 6643.3 6649.3 6732.5 6597.4 6683.6 6761.7 6839.9 6883.4 5168.5 5200.6 5209.5 5225.8 5230.6 6568.3 6781.6 6825.5 6831.7 6900.2 6409.6 6551.2 6594.9 6607.7 6682.8 6576.0 6594.7 6602.3 6613.4 6628.0 6490.6 6494.3 6521.5 6526.3 6541.3 6585.9 6605.0 6629.2 6640.6 6709.5 6360.5 6402.5 6415.4 6429.3 6456.4 04:44:18 INFO - PID 15869 | 04:44:18 INFO - PID 15869 | [#5] yui.html Cycles:180 Average:27705.56 Median:18036.77 stddev:41344.01 (229.2%) stddev-sans-first:41411.15 04:44:18 INFO - PID 15869 | Values: 941.7 957.2 971.4 979.6 982.6 19991.5 20483.7 20486.7 20487.6 20491.7 19673.5 19826.6 19839.8 20470.4 20624.0 1084.6 1096.9 1099.6 1100.3 1100.3 1068.6 1086.7 1087.9 1089.2 1091.5 1168.2 1176.1 1176.4 1177.3 1177.3 1098.4 1147.4 1164.0 1165.7 1177.6 832.5 839.2 839.9 840.8 842.2 20650.2 20904.5 21089.2 21103.4 21108.9 19462.0 20824.5 20986.4 20997.7 21333.8 17084.4 17175.7 17190.3 17381.8 17415.6 3992.0 4012.9 4023.9 4025.2 4025.9 158496.0 160780.2 163456.0 163987.0 166194.0 16983.6 17215.7 17299.4 17474.5 17703.6 32888.8 33264.3 33265.2 33324.7 33463.0 9019.2 9158.6 9187.2 9262.9 9318.4 4600.3 4612.7 4620.2 4672.6 4684.4 5984.9 5991.2 6057.8 6101.1 6139.5 1125.4 1151.7 1157.3 1160.1 1164.8 741.8 753.9 772.0 772.6 777.3 13026.0 13926.5 14077.5 14156.9 14164.3 748.2 759.4 760.3 764.0 765.2 6388.5 6518.7 6523.6 6559.9 6566.0 140673.0 143808.0 144971.0 144996.0 147389.0 121035.0 121571.0 123797.0 124954.4 125921.4 110491.4 111333.4 111453.0 112669.4 113917.9 12088.6 12301.5 12356.9 12411.9 12508.7 53053.7 53384.2 54374.7 54475.7 55690.0 69294.0 70216.3 70454.3 70524.0 70947.0 17248.3 17333.1 17425.9 17534.6 17794.4 19192.2 19473.9 19520.9 19567.1 19825.3 16946.3 17030.6 17115.3 17159.0 17210.7 16903.7 16995.4 17404.1 17420.5 17479.3 17938.7 18134.8 18174.5 18297.0 18349.4 13147.2 13183.9 13186.5 13244.2 13372.6 11968.6 12095.3 12256.3 12395.4 12398.8 04:44:18 INFO - PID 15869 | -------- Summary: end -------- 04:44:18 INFO - PID 15869 | 04:44:19 INFO - TEST-INFO | 15869: exit 0 04:44:19 INFO - TEST-OK | dromaeo_css | took 1108009ms 04:44:19 INFO - TEST-START | kraken 04:44:19 INFO - Initialising browser for kraken test... 04:44:19 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:38340/getInfo.html -profile /tmp/tmpVPKLPY/profile 04:44:19 INFO - TEST-INFO | started process 16236 (/builds/slave/test/build/application/firefox/firefox http://localhost:38340/getInfo.html) 04:44:25 INFO - TEST-INFO | 16236: exit 0 04:44:25 INFO - Browser initialized. 04:44:25 INFO - Running cycle 1/1 for kraken test... 04:44:25 INFO - Using env: {'DISPLAY': ':0', 04:44:25 INFO - 'HOME': '/home/cltbld', 04:44:25 INFO - 'JSGC_DISABLE_POISONING': '1', 04:44:25 INFO - 'LANG': 'en_US.UTF-8', 04:44:25 INFO - 'LANGUAGE': 'en_US:en', 04:44:25 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 04:44:25 INFO - 'LOGNAME': 'cltbld', 04:44:25 INFO - 'MAIL': '/var/mail/cltbld', 04:44:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:44:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:44:25 INFO - 'MOZ_CRASHREPORTER': '1', 04:44:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:44:25 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 04:44:25 INFO - 'MOZ_NO_REMOTE': '1', 04:44:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:44:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:44:25 INFO - 'NO_EM_RESTART': '1', 04:44:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:44:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:44:25 INFO - 'PWD': '/builds/slave/test', 04:44:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:44:25 INFO - 'RUST_BACKTRACE': 'full', 04:44:25 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 04:44:25 INFO - 'SHELL': '/bin/bash', 04:44:25 INFO - 'SHLVL': '1', 04:44:25 INFO - 'STYLO_FORCE_DISABLED': '1', 04:44:25 INFO - 'TERM': 'linux', 04:44:25 INFO - 'TMOUT': '86400', 04:44:25 INFO - 'USER': 'cltbld', 04:44:25 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1506419941.308983-46057260', 04:44:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:44:25 INFO - '_': '/tools/buildbot/bin/python'} 04:44:25 INFO - TEST-INFO | started process 16472 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVPKLPY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 04:44:26 INFO - PID 16472 | 04:44:26 INFO - PID 16472 | (/builds/slave/test/build/application/firefox/firefox:16522): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 04:44:26 INFO - PID 16472 | 04:44:36 INFO - PID 16472 | RSS: Main: 144797696 04:44:36 INFO - PID 16472 | 04:44:39 INFO - PID 16472 | Cycle 1(1): loaded http://localhost:38340/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38340/tests/kraken/driver.html?testName=audio-beat-detection) 04:44:40 INFO - PID 16472 | RSS: Main: 150495232 04:44:40 INFO - PID 16472 | 04:44:42 INFO - PID 16472 | Cycle 1(1): loaded http://localhost:38340/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38340/tests/kraken/driver.html?testName=audio-dft) 04:44:43 INFO - PID 16472 | RSS: Main: 151232512 04:44:43 INFO - PID 16472 | 04:44:46 INFO - PID 16472 | Cycle 1(1): loaded http://localhost:38340/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38340/tests/kraken/driver.html?testName=audio-fft) 04:44:46 INFO - PID 16472 | RSS: Main: 147263488 04:44:46 INFO - PID 16472 | 04:44:48 INFO - PID 16472 | Cycle 1(1): loaded http://localhost:38340/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38340/tests/kraken/driver.html?testName=audio-oscillator) 04:44:49 INFO - PID 16472 | RSS: Main: 148660224 04:44:49 INFO - PID 16472 | 04:44:51 INFO - PID 16472 | Cycle 1(1): loaded http://localhost:38340/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38340/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:44:52 INFO - PID 16472 | RSS: Main: 148770816 04:44:52 INFO - PID 16472 | 04:44:55 INFO - PID 16472 | Cycle 1(1): loaded http://localhost:38340/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38340/tests/kraken/driver.html?testName=imaging-darkroom) 04:44:55 INFO - PID 16472 | RSS: Main: 148783104 04:44:55 INFO - PID 16472 | 04:44:59 INFO - PID 16472 | Cycle 1(1): loaded http://localhost:38340/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38340/tests/kraken/driver.html?testName=imaging-desaturate) 04:45:00 INFO - PID 16472 | RSS: Main: 149479424 04:45:00 INFO - PID 16472 | 04:45:02 INFO - PID 16472 | Cycle 1(1): loaded http://localhost:38340/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38340/tests/kraken/driver.html?testName=json-parse-financial) 04:45:03 INFO - PID 16472 | RSS: Main: 151547904 04:45:03 INFO - PID 16472 | 04:45:04 INFO - PID 16472 | Cycle 1(1): loaded http://localhost:38340/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38340/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:45:05 INFO - PID 16472 | RSS: Main: 151248896 04:45:05 INFO - PID 16472 | 04:45:07 INFO - PID 16472 | Cycle 1(1): loaded http://localhost:38340/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38340/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:45:07 INFO - PID 16472 | RSS: Main: 151359488 04:45:07 INFO - PID 16472 | 04:45:09 INFO - PID 16472 | Cycle 1(1): loaded http://localhost:38340/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38340/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:45:10 INFO - PID 16472 | RSS: Main: 148643840 04:45:10 INFO - PID 16472 | 04:45:12 INFO - PID 16472 | Cycle 1(1): loaded http://localhost:38340/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38340/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:45:13 INFO - PID 16472 | RSS: Main: 148512768 04:45:13 INFO - PID 16472 | 04:45:16 INFO - PID 16472 | Cycle 1(1): loaded http://localhost:38340/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38340/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:45:16 INFO - PID 16472 | RSS: Main: 148717568 04:45:16 INFO - PID 16472 | 04:45:18 INFO - PID 16472 | Cycle 1(1): loaded http://localhost:38340/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38340/tests/kraken/driver.html?testName=ai-astar) 04:45:18 INFO - PID 16472 | RSS: Main: 150536192 04:45:18 INFO - PID 16472 | 04:45:18 INFO - PID 16472 | __start_tp_report 04:45:18 INFO - PID 16472 | _x_x_mozilla_page_load 04:45:18 INFO - PID 16472 | _x_x_mozilla_page_load_details 04:45:18 INFO - PID 16472 | |i|pagename|runs| 04:45:18 INFO - PID 16472 | |0;ai-astar;111;105;104;105;105;105;107;108;106;107 04:45:18 INFO - PID 16472 | |1;audio-beat-detection;114;112;112;114;113;113;114;112;113;113 04:45:18 INFO - PID 16472 | |2;audio-dft;162;162;163;166;164;163;162;163;166;168 04:45:18 INFO - PID 16472 | |3;audio-fft;73;73;73;73;74;73;74;79;74;73 04:45:18 INFO - PID 16472 | |4;audio-oscillator;79;78;77;78;78;77;78;84;78;79 04:45:18 INFO - PID 16472 | |5;imaging-gaussian-blur;117;113;111;113;114;110;113;114;114;115 04:45:18 INFO - PID 16472 | |6;imaging-darkroom;149;155;161;148;149;148;150;150;152;150 04:45:18 INFO - PID 16472 | |7;imaging-desaturate;96;95;99;93;94;94;95;93;95;95 04:45:18 INFO - PID 16472 | |8;json-parse-financial;44;45;45;45;45;46;46;44;45;45 04:45:18 INFO - PID 16472 | |9;json-stringify-tinderbox;39;39;38;38;38;39;38;39;43;38 04:45:18 INFO - PID 16472 | |10;stanford-crypto-aes;77;76;72;84;71;73;74;72;70;71 04:45:18 INFO - PID 16472 | |11;stanford-crypto-ccm;106;105;105;110;104;116;105;118;113;112 04:45:18 INFO - PID 16472 | |12;stanford-crypto-pbkdf2;156;155;161;157;153;152;153;155;151;159 04:45:18 INFO - PID 16472 | |13;stanford-crypto-sha256-iterative;61;60;61;63;60;59;61;61;59;59 04:45:18 INFO - PID 16472 | __end_tp_report 04:45:18 INFO - PID 16472 | __start_cc_report 04:45:18 INFO - PID 16472 | _x_x_mozilla_cycle_collect,714 04:45:18 INFO - PID 16472 | __end_cc_report 04:45:18 INFO - PID 16472 | __startTimestamp1506426318842__endTimestamp 04:45:18 INFO - PID 16472 | 04:45:18 INFO - PID 16472 | ------- Summary: start ------- 04:45:18 INFO - PID 16472 | Number of tests: 14 04:45:18 INFO - PID 16472 | 04:45:18 INFO - PID 16472 | [#0] ai-astar Cycles:10 Average:106.30 Median:106.50 stddev:2.06 (1.9%) stddev-sans-first:1.30 04:45:18 INFO - PID 16472 | Values: 111.0 105.0 104.0 105.0 105.0 105.0 107.0 108.0 106.0 107.0 04:45:18 INFO - PID 16472 | 04:45:18 INFO - PID 16472 | [#1] audio-beat-detection Cycles:10 Average:113.00 Median:113.00 stddev:0.82 (0.7%) stddev-sans-first:0.78 04:45:18 INFO - PID 16472 | Values: 114.0 112.0 112.0 114.0 113.0 113.0 114.0 112.0 113.0 113.0 04:45:18 INFO - PID 16472 | 04:45:18 INFO - PID 16472 | [#2] audio-dft Cycles:10 Average:163.90 Median:163.50 stddev:2.08 (1.3%) stddev-sans-first:2.09 04:45:18 INFO - PID 16472 | Values: 162.0 162.0 163.0 166.0 164.0 163.0 162.0 163.0 166.0 168.0 04:45:18 INFO - PID 16472 | 04:45:18 INFO - PID 16472 | [#3] audio-fft Cycles:10 Average:73.90 Median:73.50 stddev:1.85 (2.5%) stddev-sans-first:1.94 04:45:18 INFO - PID 16472 | Values: 73.0 73.0 73.0 73.0 74.0 73.0 74.0 79.0 74.0 73.0 04:45:18 INFO - PID 16472 | 04:45:18 INFO - PID 16472 | [#4] audio-oscillator Cycles:10 Average:78.60 Median:78.00 stddev:2.01 (2.6%) stddev-sans-first:2.13 04:45:18 INFO - PID 16472 | Values: 79.0 78.0 77.0 78.0 78.0 77.0 78.0 84.0 78.0 79.0 04:45:18 INFO - PID 16472 | 04:45:18 INFO - PID 16472 | [#5] imaging-gaussian-blur Cycles:10 Average:113.40 Median:114.00 stddev:1.96 (1.7%) stddev-sans-first:1.58 04:45:18 INFO - PID 16472 | Values: 117.0 113.0 111.0 113.0 114.0 110.0 113.0 114.0 114.0 115.0 04:45:18 INFO - PID 16472 | 04:45:18 INFO - PID 16472 | [#6] imaging-darkroom Cycles:10 Average:151.20 Median:150.00 stddev:4.02 (2.7%) stddev-sans-first:4.19 04:45:18 INFO - PID 16472 | Values: 149.0 155.0 161.0 148.0 149.0 148.0 150.0 150.0 152.0 150.0 04:45:18 INFO - PID 16472 | 04:45:18 INFO - PID 16472 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:1.73 (1.8%) stddev-sans-first:1.79 04:45:18 INFO - PID 16472 | Values: 96.0 95.0 99.0 93.0 94.0 94.0 95.0 93.0 95.0 95.0 04:45:18 INFO - PID 16472 | 04:45:18 INFO - PID 16472 | [#8] json-parse-financial Cycles:10 Average:45.00 Median:45.00 stddev:0.67 (1.5%) stddev-sans-first:0.60 04:45:18 INFO - PID 16472 | Values: 44.0 45.0 45.0 45.0 45.0 46.0 46.0 44.0 45.0 45.0 04:45:18 INFO - PID 16472 | 04:45:18 INFO - PID 16472 | [#9] json-stringify-tinderbox Cycles:10 Average:38.90 Median:39.00 stddev:1.52 (3.9%) stddev-sans-first:1.62 04:45:18 INFO - PID 16472 | Values: 39.0 39.0 38.0 38.0 38.0 39.0 38.0 39.0 43.0 38.0 04:45:18 INFO - PID 16472 | 04:45:18 INFO - PID 16472 | [#10] stanford-crypto-aes Cycles:10 Average:74.00 Median:73.50 stddev:4.16 (5.7%) stddev-sans-first:4.27 04:45:18 INFO - PID 16472 | Values: 77.0 76.0 72.0 84.0 71.0 73.0 74.0 72.0 70.0 71.0 04:45:18 INFO - PID 16472 | 04:45:18 INFO - PID 16472 | [#11] stanford-crypto-ccm Cycles:10 Average:109.40 Median:111.00 stddev:5.13 (4.6%) stddev-sans-first:5.29 04:45:18 INFO - PID 16472 | Values: 106.0 105.0 105.0 110.0 104.0 116.0 105.0 118.0 113.0 112.0 04:45:18 INFO - PID 16472 | 04:45:18 INFO - PID 16472 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.20 Median:155.50 stddev:3.16 (2.0%) stddev-sans-first:3.33 04:45:18 INFO - PID 16472 | Values: 156.0 155.0 161.0 157.0 153.0 152.0 153.0 155.0 151.0 159.0 04:45:18 INFO - PID 16472 | 04:45:18 INFO - PID 16472 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:60.40 Median:61.00 stddev:1.26 (2.1%) stddev-sans-first:1.32 04:45:18 INFO - PID 16472 | Values: 61.0 60.0 61.0 63.0 60.0 59.0 61.0 61.0 59.0 59.0 04:45:18 INFO - PID 16472 | -------- Summary: end -------- 04:45:18 INFO - PID 16472 | 04:45:19 INFO - PID 16472 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 04:45:19 INFO - TEST-INFO | 16472: exit 0 04:45:19 INFO - TEST-OK | kraken | took 60043ms 04:45:19 INFO - SUITE-END | took 1168s 04:45:20 INFO - Completed test suite (00:19:28) 04:45:20 INFO - javascript benchmark 04:45:20 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9036.053365189677, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3823.1971286029934, 3846.8076596170185, 3851.422286657001, 3852.0562462196767, 3857.980710096449, 6263.029230469285, 6266.216722909637, 6312.5581209315305, 6316.431521163095, 6415.6471394073305, 6347.36526347365, 6356.3325850785695, 6374.298827129012, 6378.553501254914, 6385.776497822577, 5567.972160139194, 5596.384397716248, 5635.971820140893, 5641.435856414346, 5698.401667824881, 5704.258446401983, 5760.711964401784, 5763.481286684198, 5770.740316685759, 5794.913076303858, 150.36491863508377, 5603.579731520112, 5608.270924779753, 5760.855978600547, 5764.221830052931, 5650.6892120933335, 5660.60375773696, 5721.856953576153, 5731.914021289684, 5735.254416925814, 5657.519110875581, 5660.8867822643315, 5710.914336284959, 5730.828075157752, 5736.770529178828, 6144.0783882417545, 6211.409916057967, 6335.3981371769605, 6389.808305750788, 6414.294427612959, 6864.656767161672, 6886.896696549556, 6965.129358830146, 6972.163340399134, 6973.930260697379, 6854.3145685431555, 6882.931170688279, 6944.756933507353, 6954.582725036514, 6961.26906674802, 6376.26672932614, 6416.615003099829, 6441.871162576722, 6443.903341449882, 6453.612783233068, 7022.157341118997, 7032.0, 7038.6480675965995, 7108.857822843514, 7115.324044215791, 6615.834604134839, 6712.765053223114, 6712.95949127886, 6714.227863795629, 6814.386705196556, 6808.0, 6812.0122582226295, 6814.897776533356, 6853.965730171317, 6939.340762627542, 6809.080774095433, 6862.210845752703, 6881.10545629075, 6884.827879303058, 6897.137857767779, 6777.559458635173, 6794.66026698673, 6806.8298292542095, 6867.690953907087, 6875.140607424072, 4993.101241776515, 5021.949780502148, 5039.571636410873, 5063.569596584258, 5069.366329208849, 4563.95436045642, 4570.154521413549, 4586.793594288265, 4597.103564804831, 4600.493945665974, 6111.388861113853, 6274.811755647338, 6292.779752708725, 6298.559100862895, 6304.684765761694, 6837.692303846339, 6852.383285504328, 6893.827654308582, 6959.652017399109, 6968.372846443743, 6135.294441139326, 6181.412765787243, 6188.81433556985, 6188.845278868064, 6239.188905442264, 5486.615936884459, 5534.52956498694, 5558.221848941152, 5560.138178582326, 5596.3284405871555, 6900.2409734929115, 7031.578105313698, 7066.187388450291, 7075.540089894141, 7080.468964827659, 6831.658417079226, 6859.485538584527, 6937.583744975318, 6939.028536004862, 6943.305669433016, 6853.280405557544, 6946.201186863374, 6961.512694111364, 6964.09466769337, 6976.965115174392, 6764.695588698422, 6771.45828333742, 6803.693833777591, 6808.523403361915, 6812.420944219599, 6791.966040169767, 6953.096097507291, 6962.477814164059, 6969.1985421677155, 6980.685869135799, 6554.180727409074, 6644.368784965421, 6649.0, 6658.234303055211, 6666.366695163952, 6558.573692709959, 6561.901571476527, 6601.273859875314, 6640.667966601747, 6646.933530664632, 6426.710798014007, 6532.8366790830605, 6548.3124271950755, 6556.98366753154, 6561.835954101186, 6674.532782705164, 6675.065490831191, 6681.2984636612455, 6775.55958862692, 6803.829904252433, 6525.967370163119, 6529.085927969993, 6615.272320044887, 6621.503387246072, 6628.701708423229], "value": 6213.24373484089, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [830.2901019628222, 837.3468694418352, 876.2902049340033, 892.1435421994888, 900.5362238447201, 42041.789791051044, 42723.57276427239, 42818.0, 42824.357634635504, 42840.78579607105, 43746.781266093625, 43872.3419148713, 43940.0, 43968.56031439685, 44005.11989760203, 8263.834723305545, 8401.159884011611, 8407.70573029944, 8419.410641255115, 8453.239208471236, 8250.669973201095, 8276.586170691471, 8280.503169809801, 8368.623411946477, 8371.623276952521, 8308.501489910625, 8368.079511253758, 8405.369597280198, 8408.495490270572, 8418.831623367529, 8335.0, 8346.66613335472, 8354.832903341929, 8366.53984030878, 8401.41190116692, 8223.301019413357, 8275.875861862078, 8310.792230194233, 8312.54281014544, 8316.209960053786, 39525.0, 39720.404193937116, 39851.8007409964, 39909.0, 39944.400833987514, 3735.8132093395493, 3743.625637436262, 3766.0584853786554, 3771.4531392948143, 3773.490578771858, 31484.37031259362, 32144.678553214635, 32260.677393226, 32285.0, 32319.51520727191, 5223.817166399158, 5383.138697808371, 5410.134378499461, 5422.43064478232, 5438.619296649236, 210196.0, 210243.0, 210384.0, 210844.0, 211222.0, 49885.750571246914, 49987.25019124716, 50046.24930626043, 50306.0, 50461.49538504568, 52745.0, 52787.0, 53022.46977530175, 53083.73458132685, 53167.734161328946, 16527.421540246032, 16901.070441125856, 16912.408065717642, 16931.66136677284, 17066.573335666708, 13766.380512876945, 13795.586132416043, 13796.0, 13894.166350019032, 13894.374753136133, 13295.268760218281, 13666.453341866214, 13758.174509529461, 13840.446382144803, 13927.373268202955, 5598.384177740445, 5652.63257888236, 5653.095504719307, 5683.863227354545, 5686.772529098873, 1084.6420681175193, 1090.5310716391868, 1095.5617752898745, 1099.1591432554103, 1100.8899110089087, 25649.230523084338, 25722.35694107662, 25748.3562910925, 25872.8706356467, 25878.353041174123, 1195.802692555736, 1200.9939950300193, 1216.355331674214, 1220.0605533738972, 1231.1443546735113, 13521.0, 13596.456141754417, 13674.0, 13719.451221951209, 13834.031617786659, 255202.0, 255983.0, 256658.0, 257677.0, 257994.0, 56092.71953640206, 56578.0, 60563.0, 60650.39349606536, 60724.0, 1513.17531945088, 1540.530138307827, 1540.99229503854, 1541.3757428241581, 1543.398074750848, 30496.237594060327, 30616.693833061385, 30695.539566906962, 30844.0, 30902.381952361276, 40328.59671403366, 40371.394429083, 40441.59558404378, 40498.0, 40545.1890962185, 229886.0, 232200.0, 232404.0, 232491.0, 232669.0, 34139.65860341365, 35026.299474009866, 35210.29579408346, 35433.82283088568, 35471.29057418889, 44683.55316446924, 44890.10219795651, 45322.32016519689, 45451.0, 45655.0, 33757.0, 33895.32209355848, 34023.0, 34344.82827585846, 34452.82773586116, 34043.14892127716, 34080.0, 34135.65864341325, 34184.0, 34791.0, 39174.0, 39592.0, 40301.79849100736, 40575.18849622932, 40579.59420405876, 33028.50457243095, 33050.33899322048, 33085.83457082699, 33620.66379336175, 33773.662263378035, 25476.363090922874, 25618.871905640353, 25665.0, 25762.103110269076, 26142.73857261479], "value": 18400.39238835765, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [606.3724045612792, 608.8934436473619, 616.2912650451982, 639.1467391032971, 649.3117295666596, 22810.885945570248, 23157.421064473398, 23932.282031539038, 23950.88024559879, 24009.0, 24933.127340543084, 25789.0, 25934.740652593468, 25954.091606793765, 26005.739942600616, 6558.311377305386, 6625.436837868787, 6677.4991875609285, 6692.364225398579, 6710.5302628816, 6523.7064332105165, 6531.934680653204, 6603.3396660334065, 6769.898451523231, 6798.116244888158, 6752.696128674222, 6758.357955994173, 6758.932410675904, 6759.425448836855, 6774.796756097325, 6398.776042838478, 6673.49948753843, 6693.531452798306, 6741.191057073133, 6746.325367463239, 6264.718087686019, 6269.686515674243, 6275.6862156891975, 6296.968515157395, 6302.086197501382, 29816.850915745283, 30246.395072098654, 30269.24326891823, 30299.242518936982, 30323.241918952204, 2262.9773702262933, 2283.897224624879, 2286.7255929288426, 2287.4395773035544, 2289.0843662534953, 20600.175992960263, 20905.686414703792, 20958.371248862557, 20968.370948871558, 21013.5797284055, 2279.806216471602, 2307.1348244408346, 2353.364591560286, 2359.28041947206, 2377.4413012941945, 129276.35361823224, 133230.33384833013, 150468.0, 157608.0, 164070.0, 15548.0, 15650.37398504047, 15748.370065197263, 15989.241183469809, 16475.83524164743, 25006.87496562542, 25014.0, 25099.87450062738, 25150.0, 25171.748282517307, 10358.637447689294, 10590.947045264878, 10648.467576621139, 10684.412357320267, 10835.729106772236, 9702.611895524242, 9731.464769437607, 9735.951320243354, 9777.902220977841, 9820.852687209697, 9596.078098556673, 9618.567164477616, 9656.565454554562, 9878.110970012733, 9990.600375985025, 2809.676887157962, 2935.060780550246, 2969.242843075002, 3000.294930691286, 3019.6597636831193, 1014.4978235773192, 1034.9534270957824, 1038.1279725030859, 1041.8176819056634, 1051.2220956492295, 20288.492787680425, 20868.686969695467, 21247.0, 21484.892575537335, 21533.13867445316, 1108.6673997800629, 1109.417555783204, 1109.6005438042298, 1109.7225693576606, 1114.1309778372881, 11395.373254471084, 11432.599859004895, 11481.483333250024, 11565.537378504765, 11609.30344179352, 582405.0, 598242.0, 604546.0, 611483.0, 637384.0, 120381.39809300897, 121734.0, 125934.37032814778, 127001.36499317629, 128737.35631321784, 1115.2082021764477, 1150.4880328254014, 1165.3998190931677, 1229.1027549888631, 1285.0298024991073, 21454.570908582053, 21583.568328633653, 21734.67397989063, 22228.666570001787, 22369.44076398103, 63891.680541596994, 64130.0, 65079.02381464187, 65462.0, 67191.32808671851, 79597.60201198957, 79986.0, 80020.19979800127, 80499.59750201211, 81606.18393816223, 14632.561023169323, 15007.77488337654, 15302.540923772305, 15306.540803775904, 15391.0, 23314.65028024547, 23571.29286121419, 23627.40931476727, 23663.0, 24195.63706544368, 18616.16227269749, 18826.24695012239, 18852.434426967215, 19097.522561936064, 19187.232510699974, 16570.751438728188, 16974.660506790042, 17090.316387344865, 17535.210915509087, 17786.0, 17942.282308707505, 17951.730724038887, 18013.72979405336, 19220.519487012938, 19487.51281217924, 14171.0, 14197.361118749475, 14296.285185740464, 14317.284135793378, 14326.426942922166, 16195.352185912432, 16322.67354652924, 16441.91779041145, 18106.547336316697, 18560.443186704422], "value": 12608.85441086533, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1426.7075249573838, 1467.0684115586598, 1467.5377256164306, 1474.6018574984755, 1479.866811986921, 16337.673246535078, 16884.493465196065, 16918.154092295383, 16999.57501062471, 17005.234764435583, 16549.751753723674, 16693.49919502414, 16731.581710457245, 16731.83268167318, 16836.83163168368, 2538.1497198438547, 2693.205504376204, 2694.649695539577, 2694.932626684329, 2695.1644990053146, 2696.824706394088, 2849.7292757188034, 2859.642544681915, 2865.0258911969927, 2866.054202113298, 2792.5392310268885, 2876.395956849064, 2881.884724611013, 2890.7542858857023, 2893.0742162508004, 2815.366542527925, 2823.421198654271, 2855.8714857831446, 2858.642669666281, 2859.785516086302, 2800.2019424464133, 2893.9276518087004, 2904.302967287857, 2904.651441826973, 2922.0, 16429.6714065718, 16504.587385315343, 16604.916975415166, 16623.83376166247, 16633.66732665352, 8478.236958673688, 8790.912090879074, 8809.075047120088, 8820.603072861737, 8824.426412283181, 5753.482186603184, 5942.257217847769, 6028.065649824284, 6095.08573713942, 6101.0848372744, 2105.589410065038, 2126.564054368866, 2129.4676330917273, 2130.7975742304457, 2174.608570457317, 30104.849475752482, 30211.69788302111, 30319.545206821917, 30329.545056824165, 30383.24041898948, 7892.250236227549, 7908.84182316362, 8161.959190204011, 8213.917860821435, 8221.588920553948, 19530.414087577396, 19694.803051969582, 19701.60596788056, 19714.605707885763, 19718.309859155146, 8697.173768491983, 8798.252148567444, 8828.0, 8836.072212417732, 8840.33697472692, 7890.684372625145, 7929.603519823986, 8054.879176812353, 8143.674253029931, 8151.470154440061, 5601.8599535011135, 5631.267935168402, 5639.210510528529, 5656.971715141398, 5692.089265717465, 1706.402759034328, 1718.5445856847946, 1718.5961299094702, 1745.6595963787195, 1751.6584266068248, 1000.4797505297205, 1016.8983101689772, 1020.6070662794878, 1022.2741853284103, 1040.5629635553087, 8817.250533704579, 8825.470471771714, 8843.425177363579, 8951.597178127, 8955.194032537103, 794.8211652378284, 796.2555011064674, 796.7251298302076, 797.4338219863962, 807.0758980966878, 5728.169415434739, 6216.689165541705, 6233.252009758768, 6315.400036996478, 6341.017142342944, 24162.75837241605, 24503.754962450505, 24687.38281542976, 24776.876115619667, 24853.0, 24167.516649666908, 24292.63561046586, 24330.14844480435, 24379.0, 24433.633495497583, 11851.170418070824, 12861.356932153354, 13008.154469959421, 13013.544525941546, 13051.216926984222, 9336.673216437664, 9648.934951615809, 9758.60965561398, 9785.021497850157, 9825.263105266991, 20689.58620827605, 20936.267230647463, 21739.565208696054, 21841.563168736855, 22086.779132209114, 21937.34187974363, 22072.33782986513, 22166.224182153546, 22208.77791222067, 22291.0, 12336.75326493483, 12568.937155314165, 12583.496660133858, 12585.119041666996, 12597.74804503923, 15479.226038698245, 15627.374905003673, 15634.374625014872, 15668.608284792515, 15719.921400392925, 12477.376131193585, 12533.686657833627, 12807.167534110253, 12887.16233444823, 12921.353932303535, 11838.881611183779, 11854.762904742029, 11884.405779710807, 12117.454714537691, 12343.938280308541, 11063.391513466837, 11180.105591552494, 11337.26307789991, 11342.149338799789, 11342.829857552308, 8432.0, 8627.0, 8724.65101395937, 8774.21032107088, 8781.20969112783, 8313.750587482386, 8359.623816928131, 8407.915920840958, 8485.236328730443, 8504.659813607386], "value": 7373.314296810736, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [566.1790403914323, 567.7445149682641, 584.0859055578022, 591.8905002574525, 594.8066878264565, 6228.314885362613, 6266.436020758131, 6376.936230637698, 6426.453751431122, 6430.485561155108, 6099.57302988791, 6229.1902052733085, 6250.374962503759, 6286.52851036173, 6299.086632438305, 4892.14387482191, 5018.573421259197, 5138.0, 5167.896642067157, 5197.974010129944, 4964.528369804862, 4976.4525902150735, 5008.223725322581, 5024.196128619422, 5037.722925239111, 4933.383327084114, 4948.2824990376375, 4957.752112394384, 4979.2655508368725, 5007.89826238227, 4931.731403554387, 4960.975195124001, 4965.577925876305, 4976.02967421353, 4988.775505102279, 4478.955210447886, 4500.09998000398, 4527.954720452786, 4534.841280555198, 4546.47715512717, 6036.671932174914, 6104.908426373608, 6245.313015568284, 6291.1192433059405, 6291.62250264981, 5784.88430231393, 5808.651480911117, 5816.854578635568, 5830.854228644275, 5836.649801011953, 6616.834579135512, 6629.535932484728, 6649.700763465656, 6667.699953502056, 6696.45088103306, 4828.517148285178, 4979.7261150636705, 5001.149804533238, 5007.272490990603, 5013.816226696038, 6598.538102332838, 6717.328267173292, 6870.560950862472, 6872.587644741331, 6899.482538809559, 5179.922301165486, 5197.66215196011, 5198.818041368534, 5236.29310043147, 5244.0145489428305, 5239.371275446894, 5269.736513174326, 5284.101702710548, 5295.867603309948, 5331.4401987790725, 5935.970320148458, 5956.736440152714, 5958.612690175125, 5973.923429433845, 5978.581499295007, 6711.6979735912, 6714.194296684332, 6789.524733268624, 6789.524733268624, 6854.2117656469145, 1823.1977929710886, 1825.6805059114602, 1836.2838492987746, 1839.8344149026652, 1841.1438681013392, 1246.569933372985, 1305.849827269857, 1312.9409176587076, 1313.875181857722, 1314.572763851752, 6071.301800292935, 6097.69511524422, 6102.206713127265, 6102.816915492543, 6151.554384719588, 6626.105475760711, 6704.631245281556, 6706.161729783777, 6709.966450167718, 6759.898601520981, 6044.486218671374, 6080.513558915276, 6104.664243466652, 6111.449969502677, 6182.0, 3565.607783143852, 3582.229820588586, 3607.4408466687705, 3615.7107431405425, 3616.367135751233, 6910.239873613898, 6915.377616014483, 6921.988934813372, 6947.40947019509, 6969.860602787916, 6677.966610166918, 6715.925451927668, 6804.965975170093, 6807.897881531781, 6864.485163612749, 6818.749812561843, 6908.723651053901, 6914.409685772301, 6944.756933507303, 6947.3747362737595, 6739.460843132636, 6805.455563555002, 6807.795766127024, 6813.829654258683, 6840.521163518506, 6595.769148079794, 6630.83422914431, 6643.30245324234, 6649.301823308483, 6732.461403087644, 6597.4392176663605, 6683.565568238049, 6761.695723692544, 6839.8700974269295, 6883.414909732729, 5168.457311982188, 5200.60995425337, 5209.453007434165, 5225.752926241753, 5230.633855630222, 6568.310327415744, 6781.6270105144695, 6825.522213445011, 6831.701976624426, 6900.171979362509, 6409.615423074631, 6551.181102362205, 6594.901076483952, 6607.735690572324, 6682.799516014527, 6575.967120164369, 6594.703238354382, 6602.3397660233595, 6613.404793568602, 6627.966860165669, 6490.643014634241, 6494.253160886558, 6521.543491955517, 6526.347365263436, 6541.313162117909, 6585.904624826324, 6604.966975165094, 6629.171353580802, 6640.568363056579, 6709.52390474095, 6360.522960778053, 6402.455791257796, 6415.390537898892, 6429.306606177423, 6456.418922297016], "value": 5181.917869586466, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [941.7127776028317, 957.1672644799024, 971.4414211828196, 979.6130528441266, 982.6020461713007, 19991.500212494677, 20483.692744608823, 20486.692699609517, 20487.59024819503, 20491.692624610605, 19673.50816229595, 19826.603467930632, 19839.801601983974, 20470.385888423334, 20624.0, 1084.614961688601, 1096.857408536893, 1099.6096385783053, 1100.2518287564453, 1100.257326304745, 1068.6046162919731, 1086.7174534620976, 1087.9456027198607, 1089.1504626391427, 1091.497910960959, 1168.1647621950303, 1176.1355403778216, 1176.4176732517417, 1177.2583272538288, 1177.264209868832, 1098.3794156301665, 1147.3689470791073, 1164.0338519029228, 1165.6561314412183, 1177.6349331707156, 832.4547421438967, 839.1524560194187, 839.9034111077243, 840.8192238668715, 842.2377748137945, 20650.173993040262, 20904.47738806527, 21089.15643374263, 21103.366898993056, 21108.894455527778, 19462.0, 20824.47938801542, 20986.370408887604, 20997.68503472449, 21333.786662133334, 17084.40204592846, 17175.656486870317, 17190.312387504484, 17381.826181738146, 17415.56461088483, 3991.960080399188, 4012.8996775080564, 4023.8994025149314, 4025.174839157995, 4025.9194816103513, 158496.0, 160780.19609901993, 163456.0, 163986.9999999988, 166194.0, 16983.575410614587, 17215.741763873553, 17299.394521191698, 17474.47576572705, 17703.645927081387, 32888.835555822065, 33264.3347133056, 33265.168370790925, 33324.66675333216, 33463.0, 9019.233365164035, 9158.633654653739, 9187.173154416134, 9262.861057084148, 9318.394304370195, 4600.2869555218995, 4612.654050946193, 4620.237660786, 4672.6261899047995, 4684.391029166187, 5984.8803023940145, 5991.221141251609, 6057.8485537861025, 6101.084837274356, 6139.539534534928, 1125.386664267976, 1151.7063148897146, 1157.3287493253893, 1160.14729174057, 1164.790337739198, 741.7737590034983, 753.8906858505486, 771.965261563231, 772.644583491589, 777.3470284960547, 13026.0, 13926.51257205993, 14077.507287244896, 14156.929215353857, 14164.291785410689, 748.1545853185866, 759.400073941591, 760.2701406649678, 764.0029761161626, 765.223298352173, 6388.520860935449, 6518.73925042993, 6523.608583484911, 6559.901601475982, 6566.0, 140673.0, 143808.0, 144971.0, 144996.0, 147389.0, 121035.0, 121570.99999999822, 123797.0, 124954.37522812327, 125921.37039314744, 110491.44754276337, 111333.44333278443, 111453.0, 112669.4366528162, 113917.86082139239, 12088.551851796661, 12301.507939682313, 12356.938215308866, 12411.875881241072, 12508.687282817638, 53053.7347313261, 53384.1992370107, 54374.7281263607, 54475.72762136164, 55690.0, 69294.0, 70216.29783702097, 70454.29545704683, 70524.0, 70947.0, 17248.310067597155, 17333.13334333253, 17425.912870435568, 17534.649307014042, 17794.37719679805, 19192.232310707415, 19473.90263048676, 19520.90239548793, 19567.119479623736, 19825.30611428593, 16946.322147113977, 17030.57423564371, 17115.315387384366, 17159.0, 17210.655786884443, 16903.66192676164, 16995.40516081931, 17404.12979351053, 17420.47738567845, 17479.300827967247, 17938.730919035963, 18134.81865181331, 18174.5456363592, 18297.0, 18349.449516514527, 13147.211167329991, 13183.868161318647, 13186.538471153464, 13244.20534767917, 13372.598822035354, 11968.581099661471, 12095.334756588472, 12256.325902075472, 12395.442205100611, 12398.752024959631], "value": 9882.620670598924, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1378.1000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 105.0, 104.0, 105.0, 105.0, 105.0, 107.0, 108.0, 106.0, 107.0], "value": 106.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 112.0, 112.0, 114.0, 113.0, 113.0, 114.0, 112.0, 113.0, 113.0], "value": 113.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 163.0, 166.0, 164.0, 163.0, 162.0, 163.0, 166.0, 168.0], "value": 163.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 73.0, 73.0, 74.0, 73.0, 74.0, 79.0, 74.0, 73.0], "value": 73.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 77.0, 78.0, 78.0, 77.0, 78.0, 84.0, 78.0, 79.0], "value": 78.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 113.0, 111.0, 113.0, 114.0, 110.0, 113.0, 114.0, 114.0, 115.0], "value": 113.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 155.0, 161.0, 148.0, 149.0, 148.0, 150.0, 150.0, 152.0, 150.0], "value": 151.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 99.0, 93.0, 94.0, 94.0, 95.0, 93.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [44.0, 45.0, 45.0, 45.0, 45.0, 46.0, 46.0, 44.0, 45.0, 45.0], "value": 45.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [39.0, 39.0, 38.0, 38.0, 38.0, 39.0, 38.0, 39.0, 43.0, 38.0], "value": 38.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 72.0, 84.0, 71.0, 73.0, 74.0, 72.0, 70.0, 71.0], "value": 74.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 105.0, 105.0, 110.0, 104.0, 116.0, 105.0, 118.0, 113.0, 112.0], "value": 109.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 155.0, 161.0, 157.0, 153.0, 152.0, 153.0, 155.0, 151.0, 159.0], "value": 155.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 60.0, 61.0, 63.0, 60.0, 59.0, 61.0, 61.0, 59.0, 59.0], "value": 60.4, "unit": "score"}]}]} 04:45:20 INFO - Return code: 0 04:45:20 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:45:20 INFO - # TBPL SUCCESS # 04:45:20 INFO - Running post-action listener: _package_coverage_data 04:45:20 INFO - Running post-action listener: _resource_record_post_action 04:45:20 INFO - [mozharness: 2017-09-26 11:45:20.140932Z] Finished run-tests step (success) 04:45:20 INFO - Running post-run listener: _resource_record_post_run 04:45:20 INFO - Total resource usage - Wall time: 1186s; CPU: 13.0%; Read bytes: 4096; Write bytes: 333594624; Read time: 16; Write time: 372344 04:45:20 INFO - TinderboxPrint: CPU usage
13.1% 04:45:20 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 04:45:20 INFO - TinderboxPrint: I/O write bytes / time
333,594,624 / 372,344 04:45:20 INFO - TinderboxPrint: CPU idle
8,218.5 (86.9%) 04:45:20 INFO - TinderboxPrint: CPU user
1,186.6 (12.5%) 04:45:20 INFO - TinderboxPrint: Swap in / out
0 / 0 04:45:20 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 13365248; Read time: 0; Write time: 3664 04:45:20 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 04:45:20 INFO - run-tests - Wall time: 1169s; CPU: 13.0%; Read bytes: 4096; Write bytes: 320229376; Read time: 16; Write time: 368680 04:45:20 INFO - Running post-run listener: _upload_blobber_files 04:45:20 INFO - Blob upload gear active. 04:45:20 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:45:20 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:45:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:45:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:45:21 INFO - (blobuploader) - INFO - Open directory for files ... 04:45:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:45:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:45:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:45:27 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:45:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:45:27 INFO - (blobuploader) - INFO - Done attempting. 04:45:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 04:45:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:45:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:45:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 04:45:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:45:27 INFO - (blobuploader) - INFO - Done attempting. 04:45:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:45:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:45:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:45:28 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:45:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:45:28 INFO - (blobuploader) - INFO - Done attempting. 04:45:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 04:45:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:45:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:45:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 04:45:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:45:29 INFO - (blobuploader) - INFO - Done attempting. 04:45:29 INFO - (blobuploader) - INFO - Iteration through files over. 04:45:29 INFO - Return code: 0 04:45:29 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:45:29 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:45:29 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/660d0129347a60a557ff0d0049c922eec9c1627dc9d3fe0ecff06be9111b60398c9b24f5d65d00d1e1b3f2ec80c49d450491f3da663822f101358177183db258", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7adb029d085b0640c157bab03c2c3e3c2c9982b1daf52cefa7ef138d39818b41c5bbeb8afc23d9215f1a85d1416bf4cdabb7eba329a9cbc33ba6711d970df997", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cef976d9298a057299c0fca8afb1dfd2c266614020016b87f9db058b7ef47d608ea7c99b001fe054fa80e77dbdea77202eeee9406b753b86e742f618c88dadf7", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/311e6884469712a5b3ec871ef8af91e8090d6c1b8629d65f970890ad43ab97cc00715c5a40a140dacd7e3b337a65dff8ed409294fea79bfbdf339ebaa30b2876"} 04:45:29 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:45:29 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:45:29 INFO - Contents: 04:45:29 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/660d0129347a60a557ff0d0049c922eec9c1627dc9d3fe0ecff06be9111b60398c9b24f5d65d00d1e1b3f2ec80c49d450491f3da663822f101358177183db258", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7adb029d085b0640c157bab03c2c3e3c2c9982b1daf52cefa7ef138d39818b41c5bbeb8afc23d9215f1a85d1416bf4cdabb7eba329a9cbc33ba6711d970df997", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cef976d9298a057299c0fca8afb1dfd2c266614020016b87f9db058b7ef47d608ea7c99b001fe054fa80e77dbdea77202eeee9406b753b86e742f618c88dadf7", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/311e6884469712a5b3ec871ef8af91e8090d6c1b8629d65f970890ad43ab97cc00715c5a40a140dacd7e3b337a65dff8ed409294fea79bfbdf339ebaa30b2876"} 04:45:29 INFO - Running post-run listener: copy_logs_to_upload_dir 04:45:29 INFO - Copying logs to upload dir... 04:45:29 INFO - mkdir: /builds/slave/test/build/upload/logs 04:45:29 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.673159 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2017-09-26 04:45:30.049657) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-26 04:45:30.052961) ========= 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=ea65d483da93c827905c2090000001f5-1506419941.308983-46057260 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/660d0129347a60a557ff0d0049c922eec9c1627dc9d3fe0ecff06be9111b60398c9b24f5d65d00d1e1b3f2ec80c49d450491f3da663822f101358177183db258", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7adb029d085b0640c157bab03c2c3e3c2c9982b1daf52cefa7ef138d39818b41c5bbeb8afc23d9215f1a85d1416bf4cdabb7eba329a9cbc33ba6711d970df997", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cef976d9298a057299c0fca8afb1dfd2c266614020016b87f9db058b7ef47d608ea7c99b001fe054fa80e77dbdea77202eeee9406b753b86e742f618c88dadf7", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/311e6884469712a5b3ec871ef8af91e8090d6c1b8629d65f970890ad43ab97cc00715c5a40a140dacd7e3b337a65dff8ed409294fea79bfbdf339ebaa30b2876"} build_url:https://queue.taskcluster.net/v1/task/XpubHF4YRmq2bSLzKMvNAg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011462 build_url: 'https://queue.taskcluster.net/v1/task/XpubHF4YRmq2bSLzKMvNAg/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/660d0129347a60a557ff0d0049c922eec9c1627dc9d3fe0ecff06be9111b60398c9b24f5d65d00d1e1b3f2ec80c49d450491f3da663822f101358177183db258", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7adb029d085b0640c157bab03c2c3e3c2c9982b1daf52cefa7ef138d39818b41c5bbeb8afc23d9215f1a85d1416bf4cdabb7eba329a9cbc33ba6711d970df997", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cef976d9298a057299c0fca8afb1dfd2c266614020016b87f9db058b7ef47d608ea7c99b001fe054fa80e77dbdea77202eeee9406b753b86e742f618c88dadf7", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/311e6884469712a5b3ec871ef8af91e8090d6c1b8629d65f970890ad43ab97cc00715c5a40a140dacd7e3b337a65dff8ed409294fea79bfbdf339ebaa30b2876"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-26 04:45:30.081640) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 04:45:30.081959) ========= 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=ea65d483da93c827905c2090000001f5-1506419941.308983-46057260 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004494 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 04:45:30.166702) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-26 04:45:30.167044) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-26 04:45:30.167430) ========= ========= Total master_lag: 0.20 =========