builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s-pgo slave: talos-linux64-ix-009 starttime: 1506164731.14 results: success (0) revision: 8c3a1558322331c1fab9d1d2d7a94ef69f2a9212 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-23 04:05:31.139548) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-23 04:05:31.140045) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-23 04:05:31.140337) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-23 04:05:31.161559) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-23 04:05:31.162068) ========= 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=17051fcd5208b27b50bedfeb000001dd-1506164729.903602-221357998 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-23 04:05:31-- 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% 109M=0s 2017-09-23 04:05:31 (109 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.135929 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-23 04:05:31.313495) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-23 04:05:31.313832) ========= 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=17051fcd5208b27b50bedfeb000001dd-1506164729.903602-221357998 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021209 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-23 04:05:31.363295) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-23 04:05:31.363648) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 8c3a1558322331c1fab9d1d2d7a94ef69f2a9212 --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 8c3a1558322331c1fab9d1d2d7a94ef69f2a9212 --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=17051fcd5208b27b50bedfeb000001dd-1506164729.903602-221357998 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-23 04:05:31,413 truncating revision to first 12 chars 2017-09-23 04:05:31,413 Setting DEBUG logging. 2017-09-23 04:05:31,413 attempt 1/10 2017-09-23 04:05:31,413 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/8c3a15583223?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-23 04:05:31,840 unpacking tar archive at: mozilla-central-8c3a15583223/testing/mozharness/ program finished with exit code 0 elapsedTime=0.754854 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-23 04:05:32.134336) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-23 04:05:32.134658) ========= script_repo_revision: 8c3a1558322331c1fab9d1d2d7a94ef69f2a9212 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-23 04:05:32.135100) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-23 04:05:32.135382) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-23 04:05:32.148512) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2017-09-23 04:05:32.148793) ========= /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=17051fcd5208b27b50bedfeb000001dd-1506164729.903602-221357998 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:05:32 INFO - MultiFileLogger online at 20170923 04:05:32 in /builds/slave/test 04:05:32 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:05:32 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:05:32 INFO - {'append_to_log': False, 04:05:32 INFO - 'base_work_dir': '/builds/slave/test', 04:05:32 INFO - 'blob_upload_branch': 'Firefox', 04:05:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:05:32 INFO - 'branch': 'Firefox', 04:05:32 INFO - 'buildbot_json_path': 'buildprops.json', 04:05:32 INFO - 'code_coverage': False, 04:05:32 INFO - 'config_files': ('talos/linux_config.py',), 04:05:32 INFO - 'default_actions': ('clobber', 04:05:32 INFO - 'read-buildbot-config', 04:05:32 INFO - 'download-and-extract', 04:05:32 INFO - 'populate-webroot', 04:05:32 INFO - 'create-virtualenv', 04:05:32 INFO - 'install', 04:05:32 INFO - 'setup-mitmproxy', 04:05:32 INFO - 'run-tests'), 04:05:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:05:32 INFO - 'disable_ccov_upload': False, 04:05:32 INFO - 'disable_stylo': False, 04:05:32 INFO - 'download_minidump_stackwalk': True, 04:05:32 INFO - 'download_symbols': 'ondemand', 04:05:32 INFO - 'enable_stylo': False, 04:05:32 INFO - 'enable_webrender': False, 04:05:32 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 04:05:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:05:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:05:32 INFO - 'gecko_profile': False, 04:05:32 INFO - 'gecko_profile_interval': 0, 04:05:32 INFO - 'installer_path': 'installer.exe', 04:05:32 INFO - 'log_level': 'info', 04:05:32 INFO - 'log_name': 'talos', 04:05:32 INFO - 'log_to_console': True, 04:05:32 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:05:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:05:32 INFO - 'opt_config_files': (), 04:05:32 INFO - 'pip_index': False, 04:05:32 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 04:05:32 INFO - 'system_bits': '32', 04:05:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:05:32 INFO - 'title': 'talos-linux64-ix-009', 04:05:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:05:32 INFO - 'use_talos_json': True, 04:05:32 INFO - 'verify': 'False', 04:05:32 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:05:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:05:32 INFO - 'work_dir': 'build'} 04:05:32 INFO - [mozharness: 2017-09-23 11:05:32.343941Z] Running clobber step. 04:05:32 INFO - Running pre-action listener: _resource_record_pre_action 04:05:32 INFO - Running main action method: clobber 04:05:32 INFO - rmtree: /builds/slave/test/build 04:05:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:05:33 INFO - Running post-action listener: _resource_record_post_action 04:05:33 INFO - [mozharness: 2017-09-23 11:05:33.940632Z] Finished clobber step (success) 04:05:33 INFO - [mozharness: 2017-09-23 11:05:33.940730Z] Running read-buildbot-config step. 04:05:33 INFO - Running pre-action listener: _resource_record_pre_action 04:05:33 INFO - Running main action method: read_buildbot_config 04:05:33 INFO - Using buildbot properties: 04:05:33 INFO - { 04:05:33 INFO - "project": "", 04:05:33 INFO - "product": "firefox", 04:05:33 INFO - "who": "archaeopteryx@coole-files.de", 04:05:33 INFO - "installer_path": "public/build/target.tar.bz2", 04:05:33 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 04:05:33 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 04:05:33 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-stylo-disabled-e10s", 04:05:33 INFO - "stage_platform": "linux64-pgo", 04:05:33 INFO - "basedir": "/builds/slave/test", 04:05:33 INFO - "buildnumber": 36, 04:05:33 INFO - "platform": "ubuntu64_hw", 04:05:33 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 04:05:33 INFO - "slavebuilddir": "test", 04:05:33 INFO - "taskId": "Qg47spFmRZ6drcbbz5CyJA", 04:05:33 INFO - "branch": "mozilla-central", 04:05:33 INFO - "script_repo_revision": "production", 04:05:33 INFO - "revision": "8c3a1558322331c1fab9d1d2d7a94ef69f2a9212", 04:05:33 INFO - "slavename": "talos-linux64-ix-009", 04:05:33 INFO - "repo_path": "mozilla-central" 04:05:33 INFO - } 04:05:33 INFO - Finding installer, test and symbols from parent task. 04:05:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Qg47spFmRZ6drcbbz5CyJA'}, attempt #1 04:05:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Qg47spFmRZ6drcbbz5CyJA'}, attempt #1 04:05:34 INFO - Task dependencies: YK2hyMrlSTiJS-ZWTXWUag 04:05:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YK2hyMrlSTiJS-ZWTXWUag'}, attempt #1 04:05:35 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/YK2hyMrlSTiJS-ZWTXWUag/artifacts/public/build/target.tar.bz2 04:05:35 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/YK2hyMrlSTiJS-ZWTXWUag/artifacts/public/build/target.test_packages.json 04:05:35 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/YK2hyMrlSTiJS-ZWTXWUag/artifacts/public/build/target.crashreporter-symbols.zip 04:05:35 INFO - Running post-action listener: _resource_record_post_action 04:05:35 INFO - [mozharness: 2017-09-23 11:05:35.269108Z] Finished read-buildbot-config step (success) 04:05:35 INFO - [mozharness: 2017-09-23 11:05:35.269325Z] Running download-and-extract step. 04:05:35 INFO - Running pre-action listener: _resource_record_pre_action 04:05:35 INFO - Running main action method: download_and_extract 04:05:35 INFO - mkdir: /builds/slave/test/build/tests 04:05:35 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:05:35 INFO - trying https://queue.taskcluster.net/v1/task/YK2hyMrlSTiJS-ZWTXWUag/artifacts/public/build/target.test_packages.json 04:05:35 INFO - Downloading https://queue.taskcluster.net/v1/task/YK2hyMrlSTiJS-ZWTXWUag/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 04:05:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YK2hyMrlSTiJS-ZWTXWUag/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 04:05:35 INFO - Downloaded 989 bytes. 04:05:35 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 04:05:35 INFO - Using the following test package requirements: 04:05:35 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 04:05:35 INFO - u'common': [u'target.common.tests.zip'], 04:05:35 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 04:05:35 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 04:05:35 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 04:05:35 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 04:05:35 INFO - u'mozbase': [u'target.common.tests.zip'], 04:05:35 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 04:05:35 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 04:05:35 INFO - u'web-platform': [u'target.common.tests.zip', 04:05:35 INFO - u'target.web-platform.tests.tar.gz'], 04:05:35 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 04:05:35 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 04:05:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YK2hyMrlSTiJS-ZWTXWUag/artifacts/public/build/target.common.tests.zip 04:05:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YK2hyMrlSTiJS-ZWTXWUag/artifacts/public/build/target.common.tests.zip'}, attempt #1 04:05:35 INFO - Fetch https://queue.taskcluster.net/v1/task/YK2hyMrlSTiJS-ZWTXWUag/artifacts/public/build/target.common.tests.zip into memory 04:05:36 INFO - Content-Length response header: 55347541 04:05:36 INFO - Bytes received: 55347541 04:05:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YK2hyMrlSTiJS-ZWTXWUag/artifacts/public/build/target.talos.tests.zip 04:05:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YK2hyMrlSTiJS-ZWTXWUag/artifacts/public/build/target.talos.tests.zip'}, attempt #1 04:05:47 INFO - Fetch https://queue.taskcluster.net/v1/task/YK2hyMrlSTiJS-ZWTXWUag/artifacts/public/build/target.talos.tests.zip into memory 04:05:48 INFO - Content-Length response header: 14513823 04:05:48 INFO - Bytes received: 14513823 04:05:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:05:48 INFO - trying https://queue.taskcluster.net/v1/task/YK2hyMrlSTiJS-ZWTXWUag/artifacts/public/build/target.tar.bz2 04:05:48 INFO - Downloading https://queue.taskcluster.net/v1/task/YK2hyMrlSTiJS-ZWTXWUag/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 04:05:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YK2hyMrlSTiJS-ZWTXWUag/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 04:05:49 INFO - Downloaded 62503122 bytes. 04:05:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YK2hyMrlSTiJS-ZWTXWUag/artifacts/public/build/target.tar.bz2 04:05:50 INFO - mkdir: /builds/slave/test/properties 04:05:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:05:50 INFO - Writing to file /builds/slave/test/properties/build_url 04:05:50 INFO - Contents: 04:05:50 INFO - build_url:https://queue.taskcluster.net/v1/task/YK2hyMrlSTiJS-ZWTXWUag/artifacts/public/build/target.tar.bz2 04:05:50 INFO - Running post-action listener: _resource_record_post_action 04:05:50 INFO - Running post-action listener: find_tests_for_verification 04:05:50 INFO - Running post-action listener: set_extra_try_arguments 04:05:50 INFO - [mozharness: 2017-09-23 11:05:50.146436Z] Finished download-and-extract step (success) 04:05:50 INFO - [mozharness: 2017-09-23 11:05:50.146589Z] Running populate-webroot step. 04:05:50 INFO - Running pre-action listener: _resource_record_pre_action 04:05:50 INFO - Running main action method: populate_webroot 04:05:50 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:05:50 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:05:50 INFO - 'tests': ['tresize', 04:05:50 INFO - 'tcanvasmark']}, 04:05:50 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:05:50 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:05:50 INFO - 'tests': ['dromaeo_css', 04:05:50 INFO - 'kraken']}, 04:05:50 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:05:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:05:50 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 04:05:50 INFO - 'talos_options': ['--disable-stylo'], 04:05:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:05:50 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:05:50 INFO - 'tests': ['damp', 'tps']}, 04:05:50 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 04:05:50 INFO - 'talos_options': ['--disable-stylo'], 04:05:50 INFO - 'tests': ['damp', 'tps']}, 04:05:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:05:50 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:05:50 INFO - 'tests': ['dromaeo_dom']}, 04:05:50 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 04:05:50 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:05:50 INFO - 'tests': ['basic_compositor_video', 04:05:50 INFO - 'glvideo']}, 04:05:50 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 04:05:50 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 04:05:50 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 04:05:50 INFO - 'talos_options': ['--disable-stylo'], 04:05:50 INFO - 'tests': ['ts_paint_webext', 04:05:50 INFO - 'tp5o_webext']}, 04:05:50 INFO - 'other-e10s': {'tests': ['a11yr', 04:05:50 INFO - 'ts_paint', 04:05:50 INFO - 'tpaint', 04:05:50 INFO - 'sessionrestore', 04:05:50 INFO - 'sessionrestore_many_windows', 04:05:50 INFO - 'sessionrestore_no_auto_restore', 04:05:50 INFO - 'tabpaint']}, 04:05:50 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:05:50 INFO - 'tests': ['a11yr', 04:05:50 INFO - 'ts_paint', 04:05:50 INFO - 'tpaint', 04:05:50 INFO - 'sessionrestore', 04:05:50 INFO - 'sessionrestore_many_windows', 04:05:50 INFO - 'sessionrestore_no_auto_restore', 04:05:50 INFO - 'tabpaint']}, 04:05:50 INFO - 'perf-reftest-e10s': {'tests': ['perf_reftest']}, 04:05:50 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 04:05:50 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:05:50 INFO - 'tests': ['perf_reftest_singletons']}, 04:05:50 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:05:50 INFO - 'tests': ['perf_reftest']}, 04:05:50 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:05:50 INFO - 'tsvgr_opacity', 04:05:50 INFO - 'tart', 04:05:50 INFO - 'tscrollx', 04:05:50 INFO - 'tsvg_static']}, 04:05:50 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:05:50 INFO - 'tests': ['tsvgx', 04:05:50 INFO - 'tsvgr_opacity', 04:05:50 INFO - 'tart', 04:05:50 INFO - 'tscrollx', 04:05:50 INFO - 'tsvg_static']}, 04:05:50 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:05:50 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 04:05:50 INFO - 'talos_options': ['--disable-stylo'], 04:05:50 INFO - 'tests': ['tp5o']}, 04:05:50 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 04:05:50 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 04:05:50 INFO - 'talos_options': ['--mitmproxy', 04:05:50 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 04:05:50 INFO - '--firstNonBlankPaint'], 04:05:50 INFO - 'tests': ['tp6_google', 04:05:50 INFO - 'tp6_youtube', 04:05:50 INFO - 'tp6_amazon', 04:05:50 INFO - 'tp6_facebook']}, 04:05:50 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 04:05:50 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 04:05:50 INFO - 'talos_options': ['--disable-stylo', 04:05:50 INFO - '--mitmproxy', 04:05:50 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 04:05:50 INFO - '--firstNonBlankPaint'], 04:05:50 INFO - 'tests': ['tp6_google', 04:05:50 INFO - 'tp6_youtube', 04:05:50 INFO - 'tp6_amazon', 04:05:50 INFO - 'tp6_facebook']}, 04:05:50 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 04:05:50 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 04:05:50 INFO - 'talos_options': ['--stylo-threads=1', 04:05:50 INFO - '--mitmproxy', 04:05:50 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 04:05:50 INFO - '--firstNonBlankPaint'], 04:05:50 INFO - 'tests': ['tp6_google', 04:05:50 INFO - 'tp6_youtube', 04:05:50 INFO - 'tp6_amazon', 04:05:50 INFO - 'tp6_facebook']}, 04:05:50 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:05:50 INFO - 'talos_options': ['--xperf_path', 04:05:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:05:50 INFO - 'tests': ['tp5n']}, 04:05:50 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 04:05:50 INFO - 'talos_options': ['--disable-stylo', 04:05:50 INFO - '--xperf_path', 04:05:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:05:50 INFO - 'tests': ['tp5n']}}} 04:05:50 INFO - Running post-action listener: _resource_record_post_action 04:05:50 INFO - [mozharness: 2017-09-23 11:05:50.167412Z] Finished populate-webroot step (success) 04:05:50 INFO - [mozharness: 2017-09-23 11:05:50.167506Z] Running create-virtualenv step. 04:05:50 INFO - Running pre-action listener: _resource_record_pre_action 04:05:50 INFO - Running main action method: create_virtualenv 04:05:50 INFO - Creating virtualenv /builds/slave/test/build/venv 04:05:50 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:05:50 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 04:05:50 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 04:05:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:05:50 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:05:50 INFO - Installing distribute.............................................................................................................................................................................................done. 04:05:51 INFO - Installing pip...............done. 04:05:51 INFO - Return code: 0 04:05:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:05:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:05:51 INFO - Reading from file tmpfile_stdout 04:05:51 INFO - Output received: 04:05:51 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:05:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:05: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:05:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:05: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:05:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:05:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23981f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2560b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27059c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2702d60>, '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 0x2703a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2703ef0>, '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': '17051fcd5208b27b50bedfeb000001dd-1506164729.903602-221357998', '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:05:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:05:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:05:51 INFO - Using env: {'DISPLAY': ':0', 04:05:51 INFO - 'HOME': '/home/cltbld', 04:05:51 INFO - 'LANG': 'en_US.UTF-8', 04:05:51 INFO - 'LANGUAGE': 'en_US:en', 04:05:51 INFO - 'LOGNAME': 'cltbld', 04:05:51 INFO - 'MAIL': '/var/mail/cltbld', 04:05:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:05:51 INFO - 'MOZ_NO_REMOTE': '1', 04:05:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:05:51 INFO - 'NO_EM_RESTART': '1', 04:05:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:05:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:05:51 INFO - 'PWD': '/builds/slave/test', 04:05:51 INFO - 'SHELL': '/bin/bash', 04:05:51 INFO - 'SHLVL': '1', 04:05:51 INFO - 'TERM': 'linux', 04:05:51 INFO - 'TMOUT': '86400', 04:05:51 INFO - 'USER': 'cltbld', 04:05:51 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1506164729.903602-221357998', 04:05:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:05:51 INFO - '_': '/tools/buildbot/bin/python'} 04:05:52 INFO - Ignoring indexes: http://pypi.python.org/simple/ 04:05:52 INFO - Downloading/unpacking pip>=1.5 04:05:52 INFO - Running setup.py egg_info for package pip 04:05:52 INFO - warning: no files found matching 'pip/cacert.pem' 04:05:52 INFO - warning: no files found matching '*.html' under directory 'docs' 04:05:52 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 04:05:52 INFO - no previously-included directories found matching 'docs/_build/_sources' 04:05:52 INFO - Installing collected packages: pip 04:05:52 INFO - Found existing installation: pip 1.1 04:05:52 INFO - Uninstalling pip: 04:05:52 INFO - Successfully uninstalled pip 04:05:52 INFO - Running setup.py install for pip 04:05:52 INFO - warning: no files found matching 'pip/cacert.pem' 04:05:52 INFO - warning: no files found matching '*.html' under directory 'docs' 04:05:52 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 04:05:52 INFO - no previously-included directories found matching 'docs/_build/_sources' 04:05:52 INFO - Installing pip script to /builds/slave/test/build/venv/bin 04:05:52 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 04:05:52 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 04:05:52 INFO - Successfully installed pip 04:05:52 INFO - Cleaning up... 04:05:52 INFO - Return code: 0 04:05:52 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:05:52 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:05:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:05:52 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:05:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:05:52 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 0x23981f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2560b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27059c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2702d60>, '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 0x2703a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2703ef0>, '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': '17051fcd5208b27b50bedfeb000001dd-1506164729.903602-221357998', '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:05:52 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:05:52 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:05:52 INFO - Using env: {'DISPLAY': ':0', 04:05:52 INFO - 'HOME': '/home/cltbld', 04:05:52 INFO - 'LANG': 'en_US.UTF-8', 04:05:52 INFO - 'LANGUAGE': 'en_US:en', 04:05:52 INFO - 'LOGNAME': 'cltbld', 04:05:52 INFO - 'MAIL': '/var/mail/cltbld', 04:05:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:05:52 INFO - 'MOZ_NO_REMOTE': '1', 04:05:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:05:52 INFO - 'NO_EM_RESTART': '1', 04:05:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:05:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:05:52 INFO - 'PWD': '/builds/slave/test', 04:05:52 INFO - 'SHELL': '/bin/bash', 04:05:52 INFO - 'SHLVL': '1', 04:05:52 INFO - 'TERM': 'linux', 04:05:52 INFO - 'TMOUT': '86400', 04:05:52 INFO - 'USER': 'cltbld', 04:05:52 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1506164729.903602-221357998', 04:05:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:05:52 INFO - '_': '/tools/buildbot/bin/python'} 04:05:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:05:52 INFO - Downloading/unpacking psutil>=3.1.1 04:05:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:05:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:05:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:05:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:05:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:05:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:05:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:05:53 INFO - Installing collected packages: psutil 04:05:53 INFO - Running setup.py install for psutil 04:05:53 INFO - building 'psutil._psutil_linux' extension 04:05:53 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 04:05:54 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 04:05:54 INFO - building 'psutil._psutil_posix' extension 04:05:54 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 04:05:54 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 04:05:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:05:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:05:54 INFO - Successfully installed psutil 04:05:54 INFO - Cleaning up... 04:05:54 INFO - Return code: 0 04:05:54 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:05:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:05:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:05:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:05:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:05:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23981f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2560b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27059c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2702d60>, '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 0x2703a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2703ef0>, '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': '17051fcd5208b27b50bedfeb000001dd-1506164729.903602-221357998', '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:05:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:05:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:05:54 INFO - Using env: {'DISPLAY': ':0', 04:05:54 INFO - 'HOME': '/home/cltbld', 04:05:54 INFO - 'LANG': 'en_US.UTF-8', 04:05:54 INFO - 'LANGUAGE': 'en_US:en', 04:05:54 INFO - 'LOGNAME': 'cltbld', 04:05:54 INFO - 'MAIL': '/var/mail/cltbld', 04:05:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:05:54 INFO - 'MOZ_NO_REMOTE': '1', 04:05:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:05:54 INFO - 'NO_EM_RESTART': '1', 04:05:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:05:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:05:54 INFO - 'PWD': '/builds/slave/test', 04:05:54 INFO - 'SHELL': '/bin/bash', 04:05:54 INFO - 'SHLVL': '1', 04:05:54 INFO - 'TERM': 'linux', 04:05:54 INFO - 'TMOUT': '86400', 04:05:54 INFO - 'USER': 'cltbld', 04:05:54 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1506164729.903602-221357998', 04:05:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:05:54 INFO - '_': '/tools/buildbot/bin/python'} 04:05:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:05:54 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:05:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:05:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:05:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:05:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:05:55 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:05:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:05:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:05:55 INFO - Installing collected packages: mozsystemmonitor 04:05:55 INFO - Running setup.py install for mozsystemmonitor 04:05:55 INFO - Successfully installed mozsystemmonitor 04:05:55 INFO - Cleaning up... 04:05:56 INFO - Return code: 0 04:05:56 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:05: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:05:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:05: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:05:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:05:56 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 0x23981f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2560b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27059c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2702d60>, '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 0x2703a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2703ef0>, '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': '17051fcd5208b27b50bedfeb000001dd-1506164729.903602-221357998', '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:05:56 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:05:56 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:05:56 INFO - Using env: {'DISPLAY': ':0', 04:05:56 INFO - 'HOME': '/home/cltbld', 04:05:56 INFO - 'LANG': 'en_US.UTF-8', 04:05:56 INFO - 'LANGUAGE': 'en_US:en', 04:05:56 INFO - 'LOGNAME': 'cltbld', 04:05:56 INFO - 'MAIL': '/var/mail/cltbld', 04:05:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:05:56 INFO - 'MOZ_NO_REMOTE': '1', 04:05:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:05:56 INFO - 'NO_EM_RESTART': '1', 04:05:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:05:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:05:56 INFO - 'PWD': '/builds/slave/test', 04:05:56 INFO - 'SHELL': '/bin/bash', 04:05:56 INFO - 'SHLVL': '1', 04:05:56 INFO - 'TERM': 'linux', 04:05:56 INFO - 'TMOUT': '86400', 04:05:56 INFO - 'USER': 'cltbld', 04:05:56 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1506164729.903602-221357998', 04:05:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:05:56 INFO - '_': '/tools/buildbot/bin/python'} 04:05:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:05:57 INFO - Downloading/unpacking jsonschema==2.5.1 04:05:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:05:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:05:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:05:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:05:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:05:58 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:05:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:05:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:05:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:05:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:05:58 INFO - Downloading functools32-3.2.3-2.tar.gz 04:05:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:05:58 INFO - warning: no files found matching '*.txt' 04:05:58 INFO - no previously-included directories found matching 'build' 04:05:58 INFO - no previously-included directories found matching 'dist' 04:05:58 INFO - no previously-included directories found matching '.git*' 04:05:58 INFO - Installing collected packages: jsonschema, functools32 04:05:58 INFO - Running setup.py install for functools32 04:05:58 INFO - warning: no files found matching '*.txt' 04:05:58 INFO - no previously-included directories found matching 'build' 04:05:58 INFO - no previously-included directories found matching 'dist' 04:05:58 INFO - no previously-included directories found matching '.git*' 04:05:58 INFO - Successfully installed jsonschema functools32 04:05:58 INFO - Cleaning up... 04:05:58 INFO - Return code: 0 04:05:58 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:05:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:05:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:05:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:05:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:05:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23981f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2560b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27059c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2702d60>, '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 0x2703a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2703ef0>, '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': '17051fcd5208b27b50bedfeb000001dd-1506164729.903602-221357998', '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:05:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 04:05:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 04:05:58 INFO - Using env: {'DISPLAY': ':0', 04:05:58 INFO - 'HOME': '/home/cltbld', 04:05:58 INFO - 'LANG': 'en_US.UTF-8', 04:05:58 INFO - 'LANGUAGE': 'en_US:en', 04:05:58 INFO - 'LOGNAME': 'cltbld', 04:05:58 INFO - 'MAIL': '/var/mail/cltbld', 04:05:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:05:58 INFO - 'MOZ_NO_REMOTE': '1', 04:05:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:05:58 INFO - 'NO_EM_RESTART': '1', 04:05:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:05:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:05:58 INFO - 'PWD': '/builds/slave/test', 04:05:58 INFO - 'SHELL': '/bin/bash', 04:05:58 INFO - 'SHLVL': '1', 04:05:58 INFO - 'TERM': 'linux', 04:05:58 INFO - 'TMOUT': '86400', 04:05:58 INFO - 'USER': 'cltbld', 04:05:58 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1506164729.903602-221357998', 04:05:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:05:58 INFO - '_': '/tools/buildbot/bin/python'} 04:05:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:05:59 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:05:59 INFO - Cleaning up... 04:05:59 INFO - Return code: 0 04:05:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:05:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:05:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:05:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:05:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:05:59 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 0x23981f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2560b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27059c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2702d60>, '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 0x2703a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2703ef0>, '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': '17051fcd5208b27b50bedfeb000001dd-1506164729.903602-221357998', '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:05:59 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:05:59 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:05:59 INFO - Using env: {'DISPLAY': ':0', 04:05:59 INFO - 'HOME': '/home/cltbld', 04:05:59 INFO - 'LANG': 'en_US.UTF-8', 04:05:59 INFO - 'LANGUAGE': 'en_US:en', 04:05:59 INFO - 'LOGNAME': 'cltbld', 04:05:59 INFO - 'MAIL': '/var/mail/cltbld', 04:05:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:05:59 INFO - 'MOZ_NO_REMOTE': '1', 04:05:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:05:59 INFO - 'NO_EM_RESTART': '1', 04:05:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:05:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:05:59 INFO - 'PWD': '/builds/slave/test', 04:05:59 INFO - 'SHELL': '/bin/bash', 04:05:59 INFO - 'SHLVL': '1', 04:05:59 INFO - 'TERM': 'linux', 04:05:59 INFO - 'TMOUT': '86400', 04:05:59 INFO - 'USER': 'cltbld', 04:05:59 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1506164729.903602-221357998', 04:05:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:05:59 INFO - '_': '/tools/buildbot/bin/python'} 04:05:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:05:59 INFO - Downloading/unpacking blobuploader==1.2.4 04:05:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:05:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:05:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:05:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:00 INFO - Downloading blobuploader-1.2.4.tar.gz 04:06:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:06:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:06:01 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:06:01 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:06:01 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:06:01 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:06:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:06:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:06:01 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:06:01 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:06:01 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:06:01 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:06:01 INFO - Downloading docopt-0.6.1.tar.gz 04:06:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:06:01 INFO - Installing collected packages: blobuploader, requests, docopt 04:06:01 INFO - Running setup.py install for blobuploader 04:06:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:06:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:06:01 INFO - Running setup.py install for requests 04:06:02 INFO - Running setup.py install for docopt 04:06:02 INFO - Successfully installed blobuploader requests docopt 04:06:02 INFO - Cleaning up... 04:06:02 INFO - Return code: 0 04:06:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:06:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:06:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:06:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:06:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:06:02 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 0x23981f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2560b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27059c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2702d60>, '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 0x2703a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2703ef0>, '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': '17051fcd5208b27b50bedfeb000001dd-1506164729.903602-221357998', '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:06:02 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:06:02 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:06:02 INFO - Using env: {'DISPLAY': ':0', 04:06:02 INFO - 'HOME': '/home/cltbld', 04:06:02 INFO - 'LANG': 'en_US.UTF-8', 04:06:02 INFO - 'LANGUAGE': 'en_US:en', 04:06:02 INFO - 'LOGNAME': 'cltbld', 04:06:02 INFO - 'MAIL': '/var/mail/cltbld', 04:06:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:02 INFO - 'MOZ_NO_REMOTE': '1', 04:06:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:06:02 INFO - 'NO_EM_RESTART': '1', 04:06:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:06:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:02 INFO - 'PWD': '/builds/slave/test', 04:06:02 INFO - 'SHELL': '/bin/bash', 04:06:02 INFO - 'SHLVL': '1', 04:06:02 INFO - 'TERM': 'linux', 04:06:02 INFO - 'TMOUT': '86400', 04:06:02 INFO - 'USER': 'cltbld', 04:06:02 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1506164729.903602-221357998', 04:06:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:02 INFO - '_': '/tools/buildbot/bin/python'} 04:06:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:06:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:06:02 INFO - Running setup.py (path:/tmp/pip-cM6iag-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:06:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:06:02 INFO - Running setup.py (path:/tmp/pip-13uwvz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:06:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:06:02 INFO - Running setup.py (path:/tmp/pip-RFNewg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:06:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:06:02 INFO - Running setup.py (path:/tmp/pip-qQBrBS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:06:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:06:02 INFO - Running setup.py (path:/tmp/pip-xQm2Zg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:06:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:06:02 INFO - Running setup.py (path:/tmp/pip-g49Hnp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:06:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:06:02 INFO - Running setup.py (path:/tmp/pip-_4Mgzn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:06:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:06:02 INFO - Running setup.py (path:/tmp/pip-F32wav-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:06:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:06:02 INFO - Running setup.py (path:/tmp/pip-pcmI8u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:06:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:06:02 INFO - Running setup.py (path:/tmp/pip-h4wYXX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:06:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:06:03 INFO - Running setup.py (path:/tmp/pip-SG0xEp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:06:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:06:03 INFO - Running setup.py (path:/tmp/pip-v5jmIp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:06:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:06:03 INFO - Running setup.py (path:/tmp/pip-dMUjru-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:06:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:06:03 INFO - Running setup.py (path:/tmp/pip-G2FFnU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:06:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:06:03 INFO - Running setup.py (path:/tmp/pip-2Z_bOy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:06:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:06:03 INFO - Running setup.py (path:/tmp/pip-gGLFzV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:06:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:06:03 INFO - Running setup.py (path:/tmp/pip-HN2oym-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:06:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:06:03 INFO - Running setup.py install for manifestparser 04:06:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:06:03 INFO - Running setup.py install for mozcrash 04:06:03 INFO - Running setup.py install for mozdebug 04:06:03 INFO - Running setup.py install for mozdevice 04:06:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:06:03 INFO - Running setup.py install for mozfile 04:06:04 INFO - Running setup.py install for mozhttpd 04:06:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:06:04 INFO - Running setup.py install for mozinfo 04:06:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:06:04 INFO - Running setup.py install for mozInstall 04:06:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:06:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:06:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:06:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:06:04 INFO - Running setup.py install for mozleak 04:06:04 INFO - Running setup.py install for mozlog 04:06:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:06:04 INFO - Running setup.py install for moznetwork 04:06:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:06:04 INFO - Running setup.py install for mozprocess 04:06:04 INFO - Running setup.py install for mozprofile 04:06:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:06:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:06:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:06:04 INFO - Running setup.py install for mozrunner 04:06:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:06:04 INFO - Running setup.py install for mozscreenshot 04:06:05 INFO - Running setup.py install for moztest 04:06:05 INFO - Running setup.py install for mozversion 04:06:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:06:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:06:05 INFO - Cleaning up... 04:06:05 INFO - Return code: 0 04:06:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:06:05 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:06:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:06:05 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:06:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:06:05 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 0x23981f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2560b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27059c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2702d60>, '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 0x2703a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2703ef0>, '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': '17051fcd5208b27b50bedfeb000001dd-1506164729.903602-221357998', '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:06:05 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:06:05 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:06:05 INFO - Using env: {'DISPLAY': ':0', 04:06:05 INFO - 'HOME': '/home/cltbld', 04:06:05 INFO - 'LANG': 'en_US.UTF-8', 04:06:05 INFO - 'LANGUAGE': 'en_US:en', 04:06:05 INFO - 'LOGNAME': 'cltbld', 04:06:05 INFO - 'MAIL': '/var/mail/cltbld', 04:06:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:05 INFO - 'MOZ_NO_REMOTE': '1', 04:06:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:06:05 INFO - 'NO_EM_RESTART': '1', 04:06:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:06:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:05 INFO - 'PWD': '/builds/slave/test', 04:06:05 INFO - 'SHELL': '/bin/bash', 04:06:05 INFO - 'SHLVL': '1', 04:06:05 INFO - 'TERM': 'linux', 04:06:05 INFO - 'TMOUT': '86400', 04:06:05 INFO - 'USER': 'cltbld', 04:06:05 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1506164729.903602-221357998', 04:06:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:05 INFO - '_': '/tools/buildbot/bin/python'} 04:06:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:06:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:06:05 INFO - Running setup.py (path:/tmp/pip-BBHZO5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:06:05 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:06:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:06:05 INFO - Running setup.py (path:/tmp/pip-irXFB5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:06:05 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:06:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:06:05 INFO - Running setup.py (path:/tmp/pip-eKRuwz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:06:05 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:06:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:06:05 INFO - Running setup.py (path:/tmp/pip-z9BIV2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:06:05 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:06:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:06:05 INFO - Running setup.py (path:/tmp/pip-jSyUCi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:06:05 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:06:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:06:05 INFO - Running setup.py (path:/tmp/pip-jo2SvV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:06:05 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:06:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:06:05 INFO - Running setup.py (path:/tmp/pip-5HrhKw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:06:06 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:06:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:06:06 INFO - Running setup.py (path:/tmp/pip-R2KClI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:06:06 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:06:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:06:06 INFO - Running setup.py (path:/tmp/pip-_vk891-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:06:06 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:06:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:06:06 INFO - Running setup.py (path:/tmp/pip-nGhlNa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:06:06 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:06:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:06:06 INFO - Running setup.py (path:/tmp/pip-u2Avc7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:06:06 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:06:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:06:06 INFO - Running setup.py (path:/tmp/pip-LviVcL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:06:06 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:06:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:06:06 INFO - Running setup.py (path:/tmp/pip-sRo3lq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:06:06 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:06:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:06:06 INFO - Running setup.py (path:/tmp/pip-mvnC7M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:06:06 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:06:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:06:06 INFO - Running setup.py (path:/tmp/pip-gCAOfQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:06:06 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:06:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:06:06 INFO - Running setup.py (path:/tmp/pip-JVE6_b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:06:06 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:06:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:06:06 INFO - Running setup.py (path:/tmp/pip-jSHhl3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:06:06 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:06:06 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:06:06 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:06:06 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:06:06 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:06:06 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:06:06 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:06:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:06:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:07 INFO - Downloading blessings-1.6.tar.gz 04:06:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:06:07 INFO - Installing collected packages: blessings 04:06:07 INFO - Running setup.py install for blessings 04:06:08 INFO - Successfully installed blessings 04:06:08 INFO - Cleaning up... 04:06:08 INFO - Return code: 0 04:06:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:06:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:06:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:06:08 INFO - Reading from file tmpfile_stdout 04:06:08 INFO - Current package versions: 04:06:08 INFO - argparse == 1.2.1 04:06:08 INFO - blessings == 1.6 04:06:08 INFO - blobuploader == 1.2.4 04:06:08 INFO - docopt == 0.6.1 04:06:08 INFO - functools32 == 3.2.3-2 04:06:08 INFO - jsonschema == 2.5.1 04:06:08 INFO - manifestparser == 1.1 04:06:08 INFO - mozInstall == 1.13 04:06:08 INFO - mozcrash == 1.0 04:06:08 INFO - mozdebug == 0.1 04:06:08 INFO - mozdevice == 0.51 04:06:08 INFO - mozfile == 1.2 04:06:08 INFO - mozhttpd == 0.7 04:06:08 INFO - mozinfo == 0.10 04:06:08 INFO - mozleak == 0.1 04:06:08 INFO - mozlog == 3.5 04:06:08 INFO - moznetwork == 0.27 04:06:08 INFO - mozprocess == 0.25 04:06:08 INFO - mozprofile == 0.28 04:06:08 INFO - mozrunner == 6.13 04:06:08 INFO - mozscreenshot == 0.1 04:06:08 INFO - mozsystemmonitor == 0.3 04:06:08 INFO - moztest == 0.8 04:06:08 INFO - mozversion == 1.4 04:06:08 INFO - psutil == 3.1.1 04:06:08 INFO - requests == 1.2.3 04:06:08 INFO - wsgiref == 0.1.2 04:06:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:06:08 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:06:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:06:08 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:06:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:06:08 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 0x23981f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2560b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27059c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2702d60>, '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 0x2703a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2703ef0>, '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': '17051fcd5208b27b50bedfeb000001dd-1506164729.903602-221357998', '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:06:08 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:06:08 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:06:08 INFO - Using env: {'DISPLAY': ':0', 04:06:08 INFO - 'HOME': '/home/cltbld', 04:06:08 INFO - 'LANG': 'en_US.UTF-8', 04:06:08 INFO - 'LANGUAGE': 'en_US:en', 04:06:08 INFO - 'LOGNAME': 'cltbld', 04:06:08 INFO - 'MAIL': '/var/mail/cltbld', 04:06:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:08 INFO - 'MOZ_NO_REMOTE': '1', 04:06:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:06:08 INFO - 'NO_EM_RESTART': '1', 04:06:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:06:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:08 INFO - 'PWD': '/builds/slave/test', 04:06:08 INFO - 'SHELL': '/bin/bash', 04:06:08 INFO - 'SHLVL': '1', 04:06:08 INFO - 'TERM': 'linux', 04:06:08 INFO - 'TMOUT': '86400', 04:06:08 INFO - 'USER': 'cltbld', 04:06:08 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1506164729.903602-221357998', 04:06:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:08 INFO - '_': '/tools/buildbot/bin/python'} 04:06:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:06:08 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:06:08 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:06:08 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:06:08 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:06:08 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:06:08 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:06:08 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:06:08 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:06:08 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:06:08 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 04:06:08 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:06:08 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:06:08 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:06:08 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:06:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 04:06:09 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:06:09 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:06:09 INFO - Installing collected packages: simplejson 04:06:09 INFO - Running setup.py install for simplejson 04:06:09 INFO - building 'simplejson._speedups' extension 04:06:09 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:06:10 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:06:10 INFO - Successfully installed simplejson 04:06:10 INFO - Cleaning up... 04:06:10 INFO - Return code: 0 04:06:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:06: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:06:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:06: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:06:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:06:10 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 0x23981f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2560b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27059c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2702d60>, '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 0x2703a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2703ef0>, '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': '17051fcd5208b27b50bedfeb000001dd-1506164729.903602-221357998', '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:06:10 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:06:10 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:06:10 INFO - Using env: {'DISPLAY': ':0', 04:06:10 INFO - 'HOME': '/home/cltbld', 04:06:10 INFO - 'LANG': 'en_US.UTF-8', 04:06:10 INFO - 'LANGUAGE': 'en_US:en', 04:06:10 INFO - 'LOGNAME': 'cltbld', 04:06:10 INFO - 'MAIL': '/var/mail/cltbld', 04:06:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:10 INFO - 'MOZ_NO_REMOTE': '1', 04:06:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:06:10 INFO - 'NO_EM_RESTART': '1', 04:06:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:06:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:10 INFO - 'PWD': '/builds/slave/test', 04:06:10 INFO - 'SHELL': '/bin/bash', 04:06:10 INFO - 'SHLVL': '1', 04:06:10 INFO - 'TERM': 'linux', 04:06:10 INFO - 'TMOUT': '86400', 04:06:10 INFO - 'USER': 'cltbld', 04:06:10 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1506164729.903602-221357998', 04:06:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:10 INFO - '_': '/tools/buildbot/bin/python'} 04:06:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:06:10 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:06:10 INFO - Cleaning up... 04:06:10 INFO - Return code: 0 04:06:11 INFO - Running post-action listener: _resource_record_post_action 04:06:11 INFO - Running post-action listener: _start_resource_monitoring 04:06:11 INFO - Starting resource monitoring. 04:06:11 INFO - [mozharness: 2017-09-23 11:06:11.029993Z] Finished create-virtualenv step (success) 04:06:11 INFO - [mozharness: 2017-09-23 11:06:11.030580Z] Running install step. 04:06:11 INFO - Running pre-action listener: _resource_record_pre_action 04:06:11 INFO - Running main action method: install 04:06:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:06:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:06:11 INFO - Reading from file tmpfile_stdout 04:06:11 INFO - Detecting whether we're running mozinstall >=1.0... 04:06:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:06:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:06:11 INFO - Reading from file tmpfile_stdout 04:06:11 INFO - Output received: 04:06:11 INFO - Usage: mozinstall [options] installer 04:06:11 INFO - Options: 04:06:11 INFO - -h, --help show this help message and exit 04:06:11 INFO - -d DEST, --destination=DEST 04:06:11 INFO - Directory to install application into. [default: 04:06:11 INFO - "/builds/slave/test"] 04:06:11 INFO - --app=APP Application being installed. [default: firefox] 04:06:11 INFO - mkdir: /builds/slave/test/build/application 04:06:11 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:06:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 04:06:28 INFO - Reading from file tmpfile_stdout 04:06:28 INFO - Output received: 04:06:28 INFO - /builds/slave/test/build/application/firefox/firefox 04:06:28 INFO - Running post-action listener: _resource_record_post_action 04:06:28 INFO - [mozharness: 2017-09-23 11:06:28.991360Z] Finished install step (success) 04:06:28 INFO - [mozharness: 2017-09-23 11:06:28.991612Z] Running setup-mitmproxy step. 04:06:28 INFO - Running pre-action listener: _resource_record_pre_action 04:06:28 INFO - Running main action method: setup_mitmproxy 04:06:28 INFO - Skipping: mitmproxy is not required 04:06:28 INFO - Running post-action listener: _resource_record_post_action 04:06:28 INFO - [mozharness: 2017-09-23 11:06:28.992740Z] Finished setup-mitmproxy step (success) 04:06:28 INFO - [mozharness: 2017-09-23 11:06:28.992960Z] Running run-tests step. 04:06:28 INFO - Running pre-action listener: _resource_record_pre_action 04:06:28 INFO - Running pre-action listener: _set_gcov_prefix 04:06:28 INFO - Running main action method: run_tests 04:06:28 WARNING - Try message not found. 04:06:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:06:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:06:29 INFO - Python 2.7.3 04:06:29 INFO - Return code: 0 04:06:29 INFO - grabbing minidump binary from tooltool 04:06:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:06:29 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2702d60>, '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 0x2703a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2703ef0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:06:29 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:06:29 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 04:06:29 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 04:06:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:06:29 INFO - Return code: 0 04:06:29 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:06:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:06:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:06:29 INFO - ENV: RUST_BACKTRACE is now full 04:06:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:06:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:06:29 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/YK2hyMrlSTiJS-ZWTXWUag/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--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:06:29 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/YK2hyMrlSTiJS-ZWTXWUag/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-009 --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:06:29 INFO - Using env: {'DISPLAY': ':0', 04:06:29 INFO - 'HOME': '/home/cltbld', 04:06:29 INFO - 'LANG': 'en_US.UTF-8', 04:06:29 INFO - 'LANGUAGE': 'en_US:en', 04:06:29 INFO - 'LOGNAME': 'cltbld', 04:06:29 INFO - 'MAIL': '/var/mail/cltbld', 04:06:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:06:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:06:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:29 INFO - 'MOZ_NO_REMOTE': '1', 04:06:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:06:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:06:29 INFO - 'NO_EM_RESTART': '1', 04:06:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:06:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:29 INFO - 'PWD': '/builds/slave/test', 04:06:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:06:29 INFO - 'RUST_BACKTRACE': 'full', 04:06:29 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 04:06:29 INFO - 'SHELL': '/bin/bash', 04:06:29 INFO - 'SHLVL': '1', 04:06:29 INFO - 'TERM': 'linux', 04:06:29 INFO - 'TMOUT': '86400', 04:06:29 INFO - 'USER': 'cltbld', 04:06:29 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1506164729.903602-221357998', 04:06:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:29 INFO - '_': '/tools/buildbot/bin/python'} 04:06:29 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/YK2hyMrlSTiJS-ZWTXWUag/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--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:06:29 INFO - mozversion application_buildid: 20170923093626 04:06:29 INFO - mozversion application_changeset: 8c3a1558322331c1fab9d1d2d7a94ef69f2a9212 04:06:29 INFO - mozversion application_display_name: Nightly 04:06:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:06:29 INFO - mozversion application_name: Firefox 04:06:29 INFO - mozversion application_remotingname: firefox 04:06:29 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:06:29 INFO - mozversion application_vendor: Mozilla 04:06:29 INFO - mozversion application_version: 58.0a1 04:06:29 INFO - mozversion platform_buildid: 20170923093626 04:06:29 INFO - mozversion platform_changeset: 8c3a1558322331c1fab9d1d2d7a94ef69f2a9212 04:06:29 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:06:29 INFO - mozversion platform_version: 58.0a1 04:06:29 INFO - using testdate: 1506164789 04:06:29 INFO - actual date: 1506164789 04:06:29 INFO - starting webserver on 'localhost:36610' 04:06:29 INFO - SUITE-START | Running 2 tests 04:06:29 INFO - TEST-START | dromaeo_css 04:06:29 INFO - Initialising browser for dromaeo_css test... 04:06:29 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:36610/getInfo.html -profile /tmp/tmp_5Ic65/profile 04:06:29 INFO - TEST-INFO | started process 24676 (/builds/slave/test/build/application/firefox/firefox http://localhost:36610/getInfo.html) 04:06:35 INFO - TEST-INFO | 24676: exit 0 04:06:35 INFO - Browser initialized. 04:06:35 INFO - Running cycle 1/1 for dromaeo_css test... 04:06:35 INFO - Using env: {'DISPLAY': ':0', 04:06:35 INFO - 'HOME': '/home/cltbld', 04:06:35 INFO - 'JSGC_DISABLE_POISONING': '1', 04:06:35 INFO - 'LANG': 'en_US.UTF-8', 04:06:35 INFO - 'LANGUAGE': 'en_US:en', 04:06:35 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 04:06:35 INFO - 'LOGNAME': 'cltbld', 04:06:35 INFO - 'MAIL': '/var/mail/cltbld', 04:06:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:06:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:06:35 INFO - 'MOZ_CRASHREPORTER': '1', 04:06:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:35 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 04:06:35 INFO - 'MOZ_NO_REMOTE': '1', 04:06:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:06:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:06:35 INFO - 'NO_EM_RESTART': '1', 04:06:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:06:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:35 INFO - 'PWD': '/builds/slave/test', 04:06:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:06:35 INFO - 'RUST_BACKTRACE': 'full', 04:06:35 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 04:06:35 INFO - 'SHELL': '/bin/bash', 04:06:35 INFO - 'SHLVL': '1', 04:06:35 INFO - 'STYLO_FORCE_DISABLED': '1', 04:06:35 INFO - 'TERM': 'linux', 04:06:35 INFO - 'TMOUT': '86400', 04:06:35 INFO - 'USER': 'cltbld', 04:06:35 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1506164729.903602-221357998', 04:06:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:35 INFO - '_': '/tools/buildbot/bin/python'} 04:06:35 INFO - TEST-INFO | started process 24917 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_5Ic65/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 04:06:36 INFO - PID 24917 | 04:06:36 INFO - PID 24917 | (/builds/slave/test/build/application/firefox/firefox:24966): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 04:06:36 INFO - PID 24917 | 04:06:46 INFO - PID 24917 | RSS: Main: 144801792 04:06:46 INFO - PID 24917 | 04:09:45 INFO - PID 24917 | Cycle 1(1): loaded http://localhost:36610/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36610/tests/dromaeo/cssquery-ext.html) 04:09:46 INFO - PID 24917 | RSS: Main: 148471808 04:09:46 INFO - PID 24917 | 04:12:48 INFO - PID 24917 | Cycle 1(1): loaded http://localhost:36610/tests/dromaeo/cssquery-ext.html (next: http://localhost:36610/tests/dromaeo/cssquery-jquery.html) 04:12:48 INFO - PID 24917 | RSS: Main: 146518016 04:12:48 INFO - PID 24917 | 04:15:50 INFO - PID 24917 | Cycle 1(1): loaded http://localhost:36610/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36610/tests/dromaeo/cssquery-mootools.html) 04:15:50 INFO - PID 24917 | RSS: Main: 148516864 04:15:50 INFO - PID 24917 | 04:18:52 INFO - PID 24917 | Cycle 1(1): loaded http://localhost:36610/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36610/tests/dromaeo/cssquery-prototype.html) 04:18:53 INFO - PID 24917 | RSS: Main: 145354752 04:18:53 INFO - PID 24917 | 04:21:56 INFO - PID 24917 | Cycle 1(1): loaded http://localhost:36610/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36610/tests/dromaeo/cssquery-yui.html) 04:21:56 INFO - PID 24917 | RSS: Main: 148316160 04:21:56 INFO - PID 24917 | 04:24:58 INFO - PID 24917 | Cycle 1(1): loaded http://localhost:36610/tests/dromaeo/cssquery-yui.html (next: http://localhost:36610/tests/dromaeo/cssquery-dojo.html) 04:24:58 INFO - PID 24917 | RSS: Main: 150900736 04:24:58 INFO - PID 24917 | 04:24:58 INFO - PID 24917 | __start_tp_report 04:24:58 INFO - PID 24917 | _x_x_mozilla_page_load 04:24:58 INFO - PID 24917 | _x_x_mozilla_page_load_details 04:24:58 INFO - PID 24917 | |i|pagename|runs| 04:24:58 INFO - PID 24917 | |0;dojo.html;3831.214601006794;3853.980730096349;3880.6119388061197;3881.243157584271;3919.0398352403668;6200.751969921198;6240.032794916795;6282.3717628237155;6307.526935479835;6346.80959571213;6348.269948955872;6371.108044873721;6375.968120159404;6403.967980160092;6409.967950160254;5692.0608099663505;5728.283964504437;5750.223719797837;5787.536997040227;5809.738561764731;5651.660900345993;5688.744006519696;5741.397153298906;5777.740001699913;5784.739686714108;5502.367227768817;5590.049691552405;5606.747696353674;5678.858028549299;5762.135679648065;5666.150077488369;5746.281714785652;5751.137329400582;5758.481736643722;5763.991301522216;5682.6306290091015;5686.601937864351;5727.341355744059;5744.798932037359;5764.8847023059725;6228.719707613168;6232;6255.718492667841;6258.436740693314;6275.466585340251;6839.829004274883;6870.106886104824;6878.3465570770695;6943;6947.40947019504;6897.793066208022;6910.412614927737;6920.065791118185;6935.3411425914455;6963.8607227855155;6370.71331790066;6379.87240255197;6416.550841441148;6452.161219041494;6472.093906853044;6887.896681549781;6891.3797758202;6998.825029374205;7052;7128.928710712827;6742.954841999498;6757.594544327356;6780.525363224626;6795.490338224653;6807.183138023469;6926.376626103674;6967.407770339578;6971.442284617218;6974.163100427981;6980.825479362955;6822.044913712084;6826.214985276757;6828.419584335387;6912.758053468105;6917.861642767117;6718.529702920749;6824.3516865898655;6836.350546698056;6868.862622747517;6927.757528486479;5010.699358038456;5031.723255220924;5037.3955125384455;5055.545000949932;5085.949140508622;4517.322401639781;4638.304254361873;4647.883802904955;4675.509071547506;4692.41344831896;6342.556021078481;6344.777932772423;6431.453326467303;6443.614622856108;6471.255805582324;6742.662866856637;6867.07294515244;6902.551334163364;6910.48171387148;6960.408365288906;6246.593971391845;6329.7468101275435;6331.68341582919;6332.271788744261;6342;5542.445755424506;5551.3893471718075;5577.553795696334;5579.609427340048;5606.103023516218;7102.325279098477;7112.715491380391;7124;7207.423406127497;7220.422366210691;6868.141482314711;6874.209465911485;6931.0643063187845;6934.341237582422;6939.444844412435;6903.861922761416;7008;7126.35862772353;7217;7231.023811785552;6798.422134118655;6853.520253582401;6868.450523958171;6898.206706228848;6901.861962760817;6849.794506164823;6863.970404439175;6865.347791959756;6993.125859267591;7014.018037474656;6561.3438656134;6655.101561289164;6677.933220667731;6752.831179220362;6769.526133170631;6487.708053137714;6607.405333520006;6649.46804255668;6661.600303981777;6663.433608143168;6488.221413430419;6632.403083722488;6646.833829154117;6658.334166583303;6674.733010679713;6581.80254592363;6640.933590664032;6676.6995485202315;6701.597904125768;6707.530472867048;6250.749970001149;6330.3669633036325;6427.971524556048;6441.6135031896365;6560.507961902781 04:24:58 INFO - PID 24917 | |1;ext.html;927.5547737086198;967.5404183013075;979.8726165598473;1020.2908978260108;1024.5696807340917;43693;44677;44769;45035;45078.0984380313;42574.57425425745;42691.57308426915;42704.78647606765;42808.785956070176;42867.14265714684;7714.34428073613;7837.568933708644;7854.7250846220395;7868.370530357586;7903.881441778378;7607.277308655669;7651.311381975621;7676.2323767623075;7678.0786305643405;7678.5392876427595;8430.409871309012;8662.047174810798;8671.653133874637;8674.739757807276;8678.262347700453;8560.743177704679;8621.827563448727;8624.18070283322;8624.482531048157;8629.180227878342;8280.378971577156;8337;8345.457545259538;8493.193146651058;8521.446106003152;40909.79545102255;41308.79345603283;41395;41426.58573414288;41499.792501037606;3668.6881615062753;3694.11341278094;3695.2978934002454;3700.204456041964;3706.8517259309597;34598.82700586506;34725.305493890235;34751;34799.82600087009;34991.65008349935;5404;5424.701641409721;5427.213054107132;5462.754176062087;5469.316335458067;213531;214841;219825;222195;225956;53662;53887.19169212465;53891.19163212555;54228.18657720138;54456;56268.718656406454;56299.43700562942;56407.43592564104;56433.435665643636;56506;15844.128572928368;15910.76133857993;16021.839781602268;16087.115208663401;16132;12641.178323408949;12748.745025099632;12859.357032148355;12885.806712899313;13067.542636007884;15196.468123615621;15311.770323445156;15519.5344139676;15558.766618500731;15628;5904.793332233351;6093.817185484354;6112.724927378279;6132.846678832976;6243.157173781572;1076.6554702495127;1077.165196972337;1101.4217535793612;1104.5857803323754;1107.2526044919648;24853.378665533146;24910;25022.874885625457;25125.87437062803;25243.747562524506;1148.9270535950077;1191.195942738648;1197.9580714674944;1207.2454715802623;1211.4851188245136;13077.542286019943;13236.801447978289;13246.20522768637;13325.400356983959;13325.73348533024;245916;263818;265087;265327;266950;59676.70161649164;59785;60107.09839352413;60280;60419.69790151109;1500.5873384819263;1511.5918701950632;1526.9312880920386;1529.4341093795367;1544.9459268925534;24136.275911722678;24763.251446381546;24854.37864053413;24865.751342486343;24887.626685599367;34440.655593444746;34772;37926.051848704;37931.62068379391;38043.80978095092;223365;225789;225979;226386;226514;35000.12499687528;35800.82099589486;36679.08302292464;37844;38211.23577528489;48459.75770121127;48762.5123748758;48814;49178.262326064425;49188.50811491839;36054.27891442209;36138.09654758547;36698.26603467862;36710.08224794402;36985;35848.82075589606;36198.27603447969;36218.818905905304;36382.454263185544;36398.8180059098;40241.1951760969;42466;42590;42874.356884646135;43016.56983430251;34444.65555344414;34900.47649285314;35000;35200;35441.82279088588;25351.492970140862;26168.476630466903;26182;26293.34266643349;26386.736132639195 04:24:58 INFO - PID 24917 | |2;jquery.html;599.4365296621173;604.4227762486826;610.7679081948861;631.3717850738516;643.398422474986;23027.424314392127;23207.883960580217;23480.295591132293;23721.76278237217;23735;22573.322800315975;23134.537309253807;23167.652485212737;23233.303000909957;23268.41828954277;6452.838679033015;6600.240972288177;6636.668166591675;6637.070810086591;6667.266600673922;6471.773487927923;6531.118299029617;6544.2801291858095;6817.318268173192;6819.454443644497;6708.295628958962;6716.93283067168;6762;6764.797056088325;6771.559848609824;6346.11154438379;6565.93434065658;6626.403623673844;6782.660866956632;6789.355011273921;6167.105769663419;6173.1048997895505;6188.9690551546955;6191.1332413461705;6198.101275315099;29781.702182978326;30002.84998575015;30059.248518786986;30062;30259.243518911982;2225;2254.402583315423;2254.6167151584104;2256.9322920312416;2264.218844498662;18584.163712632962;19333.709994350094;19349.903250483658;19461.416157515298;19480.70778938317;2488.8382255153356;2494.837835540702;2542.5042116787235;2544.058698281629;2562.090457887442;142937;148785.25607372003;149422.25288873594;155048.99999999886;163004.18497907434;15622.687546249012;15939.44211952576;16262.430814921421;16367.42714005004;16375.362463753767;25830;25893.870530647604;25925.740742592334;26020.609690854653;26025;10304.793904121876;10348.172146228284;10417.635382761719;10491.68524944253;10545.420001899816;9352.625894964262;9356.391834530734;9462.858057129148;9463.952680236554;9538.332316737762;9436.517654114241;9608.471534065553;9658.565364558612;9664.226861851035;9850.21198304134;2784.6305969776795;2863.1696807925887;2898.202994176618;2980.1804503761205;3005.8797648093832;1017.9898201018043;1042.7288904884633;1045.6549338718205;1051.0540513537876;1053.5680371047986;20545.98346381653;20714.792852071587;20848.687269690967;20962.38057324865;21158.259460918795;1078;1094.1465656787718;1101.658485869367;1105.972350691223;1109.3343993603935;11217.326960382403;11424.257423267461;11524.308541487537;11541.942290288494;11607.30356178632;571983;589653;594777;595893;600202;123354.38322808329;124084;126250;129914;130105;1109.4064675398622;1126.1272513801705;1162.1922763679163;1213.9271643701406;1224.3205021213312;21562.460938476037;21701.457463563536;22029.889850551284;22094.116235351048;22113.55772884501;63585;65086.67456662686;66531.33468665251;66616.66691666511;67020.66489667716;80950;81038;81572.18427815646;82948;85142;14964.775528366865;15205.695886082438;15307.387704492141;15352.616184595474;15417.922910385376;24042.759572404753;24130.155444559357;24196.39509012289;24438.389040274134;24471.143509977064;19875.105620246835;19883.30408435698;20011.399658010283;20096;20321.593568128257;17488.73766893523;17625.82374176242;17676;18200.089995500435;18283.634327313644;20109.597808043465;20202.393928182177;20476.283330083377;20511.38465846027;20628.27801026957;15080.849191507945;15217;15353.462628807938;15369.1546964918;15410.69178616399;18725.157367918204;18879.339223127125;19164.137613807692;19450.805491945466;19477.902610486857 04:24:58 INFO - PID 24917 | |3;mootools.html;1400.3418393355123;1444.7688369860819;1467.699121680055;1469.7207530569185;1471.8380978092407;16954;17742.73385899211;17746.378876739316;17747.201375938115;17791.466256012325;17219.655606887856;17349.7397539037;17369.7394539082;17470;17518;2820.1398573435094;2928.1069273871462;2931.915191379182;2933.0320994071903;2934.4864648686503;2746.5056289867816;2813.788965827561;2872.5260332045186;2873.310405502685;2881;2880.6399200099986;2894.305366711995;2909.796314257992;2911.1703164598093;2911.4904891643982;2733.685626152998;2784.3456787654886;2795.3570678744004;2799.174243598143;2802.2153796936686;2659.521286168489;2838.162741991097;2851.586519954595;2852.1728698677357;2858.3854471288564;17148.657026859393;17256.309747610205;17302.91348543249;17305.913470432693;17307.221175047154;8049.235322644339;8327.625256863455;8343.95828020856;8357.206065423776;8367;5197.324347834758;5214.243934629495;5353.197020446925;5412.83761487156;5432.809851655213;2152.1283880028614;2162.697222388867;2174.086883508914;2222.9666555001686;2247.9775202247934;31273;31510.212244693837;31530.369392612018;31594.210144746336;31596.210094747585;7011.6143612100805;7034.753783617549;7038.768215562256;7188.748393806296;7288.890666640004;20628.896855515628;20681.586368272852;20737.688934665992;20759.481012974797;20770;7698.615069246627;7784.2215778421705;7794.610269486503;7803.648835802403;7806.4925779824125;7070.328318809705;7166.677499512534;7181.712731490787;7365.300296471826;7450.0687414073245;5727.942720572824;5865.090910908816;5934.516370907273;6000.609960352563;6045.486133678686;1705.5139285303876;1738.9217485213196;1768.4252617899235;1768.522498925283;1797.4427927342565;954.4798085043668;968.6416026070399;977.7273315610685;994.855745916838;1000.4897502273893;8696.521691306913;8723.127687231226;8732.650693972297;8810.515421651871;8856.202941735275;779.6062988190927;804.2640983500149;804.5856383962264;812.1310198088107;816.4568964656803;5326.493983071602;5705.2012718219485;5849.502792262705;6017.247844019497;6024.638521688713;24822.37944051413;24872;26413.07554235631;26431.20706378812;26436.206913792616;25064.744173024515;25171.62242566363;25552.48895022089;25860.353491162496;25901.870490647427;12608.432620531914;12694.42875070624;12923.935380323039;12942.67643308906;12974.935125324502;9444.85832712496;9455.763605909908;9459.195968342769;9472.857907131536;9615.471149086867;21034.47413814667;21327.7867221332;21357.572848543252;21565.35303940884;21861;22354.21760238384;22586.322410327717;22783.31650050501;22809.88595057014;22828.201012964466;12534.686632834251;12726.363681816058;12840.807387889003;12847.807282890952;12878.67803304925;15848.762268566212;16146.354145834035;16159;16163.838361616234;16192.02847829134;12156.635300940987;12268.263904165779;12385.071119665881;12393.442295096922;12740.554080607135;11268.211225214156;11307.321560706385;11384.316940983568;11468.139889508153;11729.237599556001;11104.888951110386;11228.326300422;11258.718532036764;11319.264247823865;11393.544258229578;8579.184977427134;8615.181557752003;8627;8644.524551149496;8686.174813392718;8525.87211191845;8549.529775862387;8666.826663466822;8680.218780309802;8717.433366831136 04:24:58 INFO - PID 24917 | |4;prototype.html;558.2296430925325;570.3042288408142;571.3886141828245;574.6322353693636;586.4926838284882;5802.709864506774;6226.377362263771;6248.84377890553;6263.498920086394;6331.398517140864;6118.724657390417;6181.28915174755;6201.875962480748;6242.719077641517;6250.218722659668;4977.825776097838;4996.500349965011;5064.265681476184;5074.264231686403;5087.643864929457;5108.64239503235;5195.7398531638855;5240.1353776627;5248.186531087687;5252.52727254547;5204.100503316281;5227.18978558324;5259.263703081571;5263.763130659129;5287.180487024498;5214.217867319894;5222;5230.110881150214;5232.372115346145;5244.895102097975;4952.653314268003;4970.179920313144;4979.008396641336;4996.375453068366;4999.700017998895;6203.348648391899;6213.720382582795;6215.7513699451965;6300.27546832111;6356.110144579762;6174.598651087665;6211.161493198406;6219.160413344186;6239.407256310688;6248.187735594389;6684.2647308795995;6708.295628958937;6717.832054198635;6751.088603038576;6775.491838112112;5243.973780131113;5483.533899618537;5512.834614961557;5542.418046105141;5581.2186293918885;6637.933620663828;6842.057915096507;6930.27232140623;6956.617386043715;6973.012691383033;5642.463965923231;5645.661260324394;5696.1455781633085;5697.259356283656;5710.571707121982;5745.798897038583;5758.74085666146;5802;5805.187273781674;5830.096335068071;6079.574429789961;6126.479249263773;6153.353897840751;6163.9383606163365;6178.7219575119225;6680.265170831205;6722.697478613474;6731.129600479646;6761.053452516651;6767.424768894601;1992.9701054484194;2012.195121951202;2023.736914201174;2037.4498885301182;2042.1423002339054;1409.2595644379182;1496.1546726099937;1520.0803513873948;1551.9689606207812;1554.9533513994597;6170.938290617126;6178.845528861814;6203.720832562545;6254.593451425642;6256.906146407808;6718.462522998148;6752.797416077526;6757.182192061469;6805.081314022544;6813.829654258584;6156.753729850756;6164.383561643889;6172.382761723792;6190.535709821691;6229.844253893598;3559.252556963015;3566.1262990567475;3594.6045934947133;3598.2803439312243;3623.601403845575;7033.191183014019;7033.678885967618;7064.470164737665;7068.611226382495;7073.823154421078;6911.790436673663;6955.1653801543125;6972.337627925339;6979.82550436233;7011.127266549699;7022.578645281299;7029.156501219784;7040.683169257396;7047.260037696071;7069.893951590833;6606.8678626426245;6667.19993600771;6673.599584024974;6687.498437617295;6697.598144111369;6610.8016759497295;6668.866622667617;6685.231198412051;6714.9519396582555;6817.147856517935;6938.653067346713;6951.965240173767;6996.3269283626505;7023.648817558999;7045;5579.944200557942;5597.412271711574;5611.915821262603;5612.214289999485;5624.718764061862;6343.5876668016435;6552.803415897531;6701.597904125768;6741.932580674326;6742.393184613212;6526.053722210348;6539.11721917535;6588.637624930675;6601.900971485527;6605.603663779996;6400.807975760735;6483.481321494363;6505.145369167598;6508.153939987771;6542.705578248895;6332.0501924709815;6408.743650254124;6430.64631445275;6437.360682120308;6490.825573432764;6566.343365663395;6579.828656543234;6612.272650008399;6641.900371494335;6644.501662375244;6337.493000560036;6407.743690252338;6425.58233714807;6440.969444888795;6454.709538070892 04:24:58 INFO - PID 24917 | |5;yui.html;940.6472572785206;972.5963725054102;981.5975450065474;991.0832479956039;1013.3869009249402;18699.252029918804;19134.904325478386;19182.712259316122;19227.80772192276;19305;17185.398511052117;17728.113594320264;17738.20178091986;18298;18489.07554622267;1007.4056306779017;1019.8725159355081;1020.795840831833;1021.2442792333657;1021.9744506387362;1032.447640512326;1039.3815679670583;1046.3198920701566;1047.4867315015626;1047.8009178256145;1082.3830416662506;1120.803859324619;1122.820348744197;1122.9213955023151;1123.775244951009;1117.2961034548223;1119.5409881948444;1119.5857532712907;1121.1479275750448;1123.5056575106926;784.1922819495871;802.0936341933636;812.4637739092229;812.8374325134938;813.4021494201756;19542.902285488624;19595.41213763575;19636.901815490975;19703.310384136486;19789.505262368413;22533.887330563408;22588.77411225883;23009.194678186184;23090.307290781304;23267.4183145421;18819.90590047055;18870.528236794053;18963.33628323002;19089.42731718037;19157.425277241706;4024.3561030235023;4038.45480860086;4056.371262454324;4074;4079.16377142688;163951;163952;166348.16825915792;168713.15643421828;170216;17372.565685857953;17391.47825565235;17478;17488.737668934977;17604.823951760318;33834;34050.31899361999;34069.829650851585;34080.48879266813;34384.484232736526;8614.18165274298;8617.35369847264;8635.093315201939;8675.305975521944;8681.348898832613;4651.279051746985;4701.929471057937;4716.622670186377;4722.409698787652;4740.905181896412;5991.2510936132985;6104;6147.907781383283;6160.168377269101;6180;1071.6195750508614;1097.9451027448595;1114.8439218509416;1117.5027112934665;1120.9271397359146;736.6721808795141;751.9812004699817;755.1429127939718;764.9388048956071;773.2267732267733;13002.804957925639;13061.804072938914;13510.176126222834;14239;14474.421023158955;738.7672883041824;741.8516296740673;749.1272667342594;752.0223709178047;752.0711920777835;6250.874982500324;6304.275008374004;6418.19772528434;6425.710843012076;6492;145330;145646;149279.25360373128;149560;152405;122249;125494;126019;128059.35970320088;133008;102990.97009029964;105350;109858;109965.45017274862;110932.99999999838;14284.500042498878;15217.163056032025;15228.8210346905;15236.085834849944;15278.618034549225;52270.73864630653;52494.47505524896;52546.73726631342;52884.47115528795;53689;65994;66175;66294.33705662882;67007;68810.31189688039;20558.38324850257;21050.68423973611;21148.47128821792;21172.576548468638;21209.151633935086;22846.200382986517;22893;23077.307680769605;23156.76843231546;23196.072157113525;21379.46551336167;21911.233106841184;21945.341639750834;22141;22232.777672223718;17251.3962011329;17702.734458983385;17883.642327153124;17909;17912.641747165246;16822.915885420494;16913.830861691225;17044.659106817548;17099.914500427418;17138.571535711708;13249.403776830259;13453.260070696206;13649.727005460034;13699.726005480034;13931.860681393056;14951.953363264467;15158.848411515744;15166.165860877758;15370.538883833502;15392.615184620474 04:24:58 INFO - PID 24917 | __end_tp_report 04:24:58 INFO - PID 24917 | __start_cc_report 04:24:58 INFO - PID 24917 | _x_x_mozilla_cycle_collect,283 04:24:58 INFO - PID 24917 | __end_cc_report 04:24:58 INFO - PID 24917 | __startTimestamp1506165898621__endTimestamp 04:24:58 INFO - PID 24917 | 04:24:58 INFO - PID 24917 | ------- Summary: start ------- 04:24:58 INFO - PID 24917 | Number of tests: 6 04:24:58 INFO - PID 24917 | 04:24:58 INFO - PID 24917 | [#0] dojo.html Cycles:165 Average:6326.99 Median:6561.34 stddev:748.34 (11.4%) stddev-sans-first:724.57 04:24:58 INFO - PID 24917 | Values: 3831.2 3854.0 3880.6 3881.2 3919.0 6200.8 6240.0 6282.4 6307.5 6346.8 6348.3 6371.1 6376.0 6404.0 6410.0 5692.1 5728.3 5750.2 5787.5 5809.7 5651.7 5688.7 5741.4 5777.7 5784.7 5502.4 5590.0 5606.7 5678.9 5762.1 5666.2 5746.3 5751.1 5758.5 5764.0 5682.6 5686.6 5727.3 5744.8 5764.9 6228.7 6232.0 6255.7 6258.4 6275.5 6839.8 6870.1 6878.3 6943.0 6947.4 6897.8 6910.4 6920.1 6935.3 6963.9 6370.7 6379.9 6416.6 6452.2 6472.1 6887.9 6891.4 6998.8 7052.0 7128.9 6743.0 6757.6 6780.5 6795.5 6807.2 6926.4 6967.4 6971.4 6974.2 6980.8 6822.0 6826.2 6828.4 6912.8 6917.9 6718.5 6824.4 6836.4 6868.9 6927.8 5010.7 5031.7 5037.4 5055.5 5085.9 4517.3 4638.3 4647.9 4675.5 4692.4 6342.6 6344.8 6431.5 6443.6 6471.3 6742.7 6867.1 6902.6 6910.5 6960.4 6246.6 6329.7 6331.7 6332.3 6342.0 5542.4 5551.4 5577.6 5579.6 5606.1 7102.3 7112.7 7124.0 7207.4 7220.4 6868.1 6874.2 6931.1 6934.3 6939.4 6903.9 7008.0 7126.4 7217.0 7231.0 6798.4 6853.5 6868.5 6898.2 6901.9 6849.8 6864.0 6865.3 6993.1 7014.0 6561.3 6655.1 6677.9 6752.8 6769.5 6487.7 6607.4 6649.5 6661.6 6663.4 6488.2 6632.4 6646.8 6658.3 6674.7 6581.8 6640.9 6676.7 6701.6 6707.5 6250.7 6330.4 6428.0 6441.6 6560.5 04:24:58 INFO - PID 24917 | 04:24:58 INFO - PID 24917 | [#1] ext.html Cycles:180 Average:41857.48 Median:36704.17 stddev:61335.54 (167.1%) stddev-sans-first:61430.61 04:24:58 INFO - PID 24917 | Values: 927.6 967.5 979.9 1020.3 1024.6 43693.0 44677.0 44769.0 45035.0 45078.1 42574.6 42691.6 42704.8 42808.8 42867.1 7714.3 7837.6 7854.7 7868.4 7903.9 7607.3 7651.3 7676.2 7678.1 7678.5 8430.4 8662.0 8671.7 8674.7 8678.3 8560.7 8621.8 8624.2 8624.5 8629.2 8280.4 8337.0 8345.5 8493.2 8521.4 40909.8 41308.8 41395.0 41426.6 41499.8 3668.7 3694.1 3695.3 3700.2 3706.9 34598.8 34725.3 34751.0 34799.8 34991.7 5404.0 5424.7 5427.2 5462.8 5469.3 213531.0 214841.0 219825.0 222195.0 225956.0 53662.0 53887.2 53891.2 54228.2 54456.0 56268.7 56299.4 56407.4 56433.4 56506.0 15844.1 15910.8 16021.8 16087.1 16132.0 12641.2 12748.7 12859.4 12885.8 13067.5 15196.5 15311.8 15519.5 15558.8 15628.0 5904.8 6093.8 6112.7 6132.8 6243.2 1076.7 1077.2 1101.4 1104.6 1107.3 24853.4 24910.0 25022.9 25125.9 25243.7 1148.9 1191.2 1198.0 1207.2 1211.5 13077.5 13236.8 13246.2 13325.4 13325.7 245916.0 263818.0 265087.0 265327.0 266950.0 59676.7 59785.0 60107.1 60280.0 60419.7 1500.6 1511.6 1526.9 1529.4 1544.9 24136.3 24763.3 24854.4 24865.8 24887.6 34440.7 34772.0 37926.1 37931.6 38043.8 223365.0 225789.0 225979.0 226386.0 226514.0 35000.1 35800.8 36679.1 37844.0 38211.2 48459.8 48762.5 48814.0 49178.3 49188.5 36054.3 36138.1 36698.3 36710.1 36985.0 35848.8 36198.3 36218.8 36382.5 36398.8 40241.2 42466.0 42590.0 42874.4 43016.6 34444.7 34900.5 35000.0 35200.0 35441.8 25351.5 26168.5 26182.0 26293.3 26386.7 04:24:58 INFO - PID 24917 | 04:24:58 INFO - PID 24917 | [#2] jquery.html Cycles:180 Average:39314.77 Median:12645.82 stddev:98995.71 (782.8%) stddev-sans-first:99230.74 04:24:58 INFO - PID 24917 | Values: 599.4 604.4 610.8 631.4 643.4 23027.4 23207.9 23480.3 23721.8 23735.0 22573.3 23134.5 23167.7 23233.3 23268.4 6452.8 6600.2 6636.7 6637.1 6667.3 6471.8 6531.1 6544.3 6817.3 6819.5 6708.3 6716.9 6762.0 6764.8 6771.6 6346.1 6565.9 6626.4 6782.7 6789.4 6167.1 6173.1 6189.0 6191.1 6198.1 29781.7 30002.8 30059.2 30062.0 30259.2 2225.0 2254.4 2254.6 2256.9 2264.2 18584.2 19333.7 19349.9 19461.4 19480.7 2488.8 2494.8 2542.5 2544.1 2562.1 142937.0 148785.3 149422.3 155049.0 163004.2 15622.7 15939.4 16262.4 16367.4 16375.4 25830.0 25893.9 25925.7 26020.6 26025.0 10304.8 10348.2 10417.6 10491.7 10545.4 9352.6 9356.4 9462.9 9464.0 9538.3 9436.5 9608.5 9658.6 9664.2 9850.2 2784.6 2863.2 2898.2 2980.2 3005.9 1018.0 1042.7 1045.7 1051.1 1053.6 20546.0 20714.8 20848.7 20962.4 21158.3 1078.0 1094.1 1101.7 1106.0 1109.3 11217.3 11424.3 11524.3 11541.9 11607.3 571983.0 589653.0 594777.0 595893.0 600202.0 123354.4 124084.0 126250.0 129914.0 130105.0 1109.4 1126.1 1162.2 1213.9 1224.3 21562.5 21701.5 22029.9 22094.1 22113.6 63585.0 65086.7 66531.3 66616.7 67020.7 80950.0 81038.0 81572.2 82948.0 85142.0 14964.8 15205.7 15307.4 15352.6 15417.9 24042.8 24130.2 24196.4 24438.4 24471.1 19875.1 19883.3 20011.4 20096.0 20321.6 17488.7 17625.8 17676.0 18200.1 18283.6 20109.6 20202.4 20476.3 20511.4 20628.3 15080.8 15217.0 15353.5 15369.2 15410.7 18725.2 18879.3 19164.1 19450.8 19477.9 04:24:58 INFO - PID 24917 | 04:24:58 INFO - PID 24917 | [#3] mootools.html Cycles:180 Average:10584.18 Median:2797.27 stddev:7987.34 (285.5%) stddev-sans-first:7979.95 04:24:58 INFO - PID 24917 | Values: 1400.3 1444.8 1467.7 1469.7 1471.8 16954.0 17742.7 17746.4 17747.2 17791.5 17219.7 17349.7 17369.7 17470.0 17518.0 2820.1 2928.1 2931.9 2933.0 2934.5 2746.5 2813.8 2872.5 2873.3 2881.0 2880.6 2894.3 2909.8 2911.2 2911.5 2733.7 2784.3 2795.4 2799.2 2802.2 2659.5 2838.2 2851.6 2852.2 2858.4 17148.7 17256.3 17302.9 17305.9 17307.2 8049.2 8327.6 8344.0 8357.2 8367.0 5197.3 5214.2 5353.2 5412.8 5432.8 2152.1 2162.7 2174.1 2223.0 2248.0 31273.0 31510.2 31530.4 31594.2 31596.2 7011.6 7034.8 7038.8 7188.7 7288.9 20628.9 20681.6 20737.7 20759.5 20770.0 7698.6 7784.2 7794.6 7803.6 7806.5 7070.3 7166.7 7181.7 7365.3 7450.1 5727.9 5865.1 5934.5 6000.6 6045.5 1705.5 1738.9 1768.4 1768.5 1797.4 954.5 968.6 977.7 994.9 1000.5 8696.5 8723.1 8732.7 8810.5 8856.2 779.6 804.3 804.6 812.1 816.5 5326.5 5705.2 5849.5 6017.2 6024.6 24822.4 24872.0 26413.1 26431.2 26436.2 25064.7 25171.6 25552.5 25860.4 25901.9 12608.4 12694.4 12923.9 12942.7 12974.9 9444.9 9455.8 9459.2 9472.9 9615.5 21034.5 21327.8 21357.6 21565.4 21861.0 22354.2 22586.3 22783.3 22809.9 22828.2 12534.7 12726.4 12840.8 12847.8 12878.7 15848.8 16146.4 16159.0 16163.8 16192.0 12156.6 12268.3 12385.1 12393.4 12740.6 11268.2 11307.3 11384.3 11468.1 11729.2 11104.9 11228.3 11258.7 11319.3 11393.5 8579.2 8615.2 8627.0 8644.5 8686.2 8525.9 8549.5 8666.8 8680.2 8717.4 04:24:58 INFO - PID 24917 | 04:24:58 INFO - PID 24917 | [#4] prototype.html Cycles:180 Average:5748.93 Median:6245.45 stddev:1521.65 (24.4%) stddev-sans-first:1475.20 04:24:58 INFO - PID 24917 | Values: 558.2 570.3 571.4 574.6 586.5 5802.7 6226.4 6248.8 6263.5 6331.4 6118.7 6181.3 6201.9 6242.7 6250.2 4977.8 4996.5 5064.3 5074.3 5087.6 5108.6 5195.7 5240.1 5248.2 5252.5 5204.1 5227.2 5259.3 5263.8 5287.2 5214.2 5222.0 5230.1 5232.4 5244.9 4952.7 4970.2 4979.0 4996.4 4999.7 6203.3 6213.7 6215.8 6300.3 6356.1 6174.6 6211.2 6219.2 6239.4 6248.2 6684.3 6708.3 6717.8 6751.1 6775.5 5244.0 5483.5 5512.8 5542.4 5581.2 6637.9 6842.1 6930.3 6956.6 6973.0 5642.5 5645.7 5696.1 5697.3 5710.6 5745.8 5758.7 5802.0 5805.2 5830.1 6079.6 6126.5 6153.4 6163.9 6178.7 6680.3 6722.7 6731.1 6761.1 6767.4 1993.0 2012.2 2023.7 2037.4 2042.1 1409.3 1496.2 1520.1 1552.0 1555.0 6170.9 6178.8 6203.7 6254.6 6256.9 6718.5 6752.8 6757.2 6805.1 6813.8 6156.8 6164.4 6172.4 6190.5 6229.8 3559.3 3566.1 3594.6 3598.3 3623.6 7033.2 7033.7 7064.5 7068.6 7073.8 6911.8 6955.2 6972.3 6979.8 7011.1 7022.6 7029.2 7040.7 7047.3 7069.9 6606.9 6667.2 6673.6 6687.5 6697.6 6610.8 6668.9 6685.2 6715.0 6817.1 6938.7 6952.0 6996.3 7023.6 7045.0 5579.9 5597.4 5611.9 5612.2 5624.7 6343.6 6552.8 6701.6 6741.9 6742.4 6526.1 6539.1 6588.6 6601.9 6605.6 6400.8 6483.5 6505.1 6508.2 6542.7 6332.1 6408.7 6430.6 6437.4 6490.8 6566.3 6579.8 6612.3 6641.9 6644.5 6337.5 6407.7 6425.6 6441.0 6454.7 04:24:58 INFO - PID 24917 | 04:24:58 INFO - PID 24917 | [#5] yui.html Cycles:180 Average:28233.30 Median:19112.17 stddev:41834.46 (218.9%) stddev-sans-first:41901.62 04:24:58 INFO - PID 24917 | Values: 940.6 972.6 981.6 991.1 1013.4 18699.3 19134.9 19182.7 19227.8 19305.0 17185.4 17728.1 17738.2 18298.0 18489.1 1007.4 1019.9 1020.8 1021.2 1022.0 1032.4 1039.4 1046.3 1047.5 1047.8 1082.4 1120.8 1122.8 1122.9 1123.8 1117.3 1119.5 1119.6 1121.1 1123.5 784.2 802.1 812.5 812.8 813.4 19542.9 19595.4 19636.9 19703.3 19789.5 22533.9 22588.8 23009.2 23090.3 23267.4 18819.9 18870.5 18963.3 19089.4 19157.4 4024.4 4038.5 4056.4 4074.0 4079.2 163951.0 163952.0 166348.2 168713.2 170216.0 17372.6 17391.5 17478.0 17488.7 17604.8 33834.0 34050.3 34069.8 34080.5 34384.5 8614.2 8617.4 8635.1 8675.3 8681.3 4651.3 4701.9 4716.6 4722.4 4740.9 5991.3 6104.0 6147.9 6160.2 6180.0 1071.6 1097.9 1114.8 1117.5 1120.9 736.7 752.0 755.1 764.9 773.2 13002.8 13061.8 13510.2 14239.0 14474.4 738.8 741.9 749.1 752.0 752.1 6250.9 6304.3 6418.2 6425.7 6492.0 145330.0 145646.0 149279.3 149560.0 152405.0 122249.0 125494.0 126019.0 128059.4 133008.0 102991.0 105350.0 109858.0 109965.5 110933.0 14284.5 15217.2 15228.8 15236.1 15278.6 52270.7 52494.5 52546.7 52884.5 53689.0 65994.0 66175.0 66294.3 67007.0 68810.3 20558.4 21050.7 21148.5 21172.6 21209.2 22846.2 22893.0 23077.3 23156.8 23196.1 21379.5 21911.2 21945.3 22141.0 22232.8 17251.4 17702.7 17883.6 17909.0 17912.6 16822.9 16913.8 17044.7 17099.9 17138.6 13249.4 13453.3 13649.7 13699.7 13931.9 14952.0 15158.8 15166.2 15370.5 15392.6 04:24:58 INFO - PID 24917 | -------- Summary: end -------- 04:24:58 INFO - PID 24917 | 04:24:59 INFO - TEST-INFO | 24917: exit 0 04:24:59 INFO - TEST-OK | dromaeo_css | took 1109928ms 04:24:59 INFO - TEST-START | kraken 04:24:59 INFO - Initialising browser for kraken test... 04:24:59 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:36610/getInfo.html -profile /tmp/tmpz5zBaS/profile 04:24:59 INFO - TEST-INFO | started process 25291 (/builds/slave/test/build/application/firefox/firefox http://localhost:36610/getInfo.html) 04:25:04 INFO - TEST-INFO | 25291: exit 0 04:25:05 INFO - Browser initialized. 04:25:05 INFO - Running cycle 1/1 for kraken test... 04:25:05 INFO - Using env: {'DISPLAY': ':0', 04:25:05 INFO - 'HOME': '/home/cltbld', 04:25:05 INFO - 'JSGC_DISABLE_POISONING': '1', 04:25:05 INFO - 'LANG': 'en_US.UTF-8', 04:25:05 INFO - 'LANGUAGE': 'en_US:en', 04:25:05 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 04:25:05 INFO - 'LOGNAME': 'cltbld', 04:25:05 INFO - 'MAIL': '/var/mail/cltbld', 04:25:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:25:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:25:05 INFO - 'MOZ_CRASHREPORTER': '1', 04:25:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:25:05 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 04:25:05 INFO - 'MOZ_NO_REMOTE': '1', 04:25:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:25:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:25:05 INFO - 'NO_EM_RESTART': '1', 04:25:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:25:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:25:05 INFO - 'PWD': '/builds/slave/test', 04:25:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:25:05 INFO - 'RUST_BACKTRACE': 'full', 04:25:05 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 04:25:05 INFO - 'SHELL': '/bin/bash', 04:25:05 INFO - 'SHLVL': '1', 04:25:05 INFO - 'STYLO_FORCE_DISABLED': '1', 04:25:05 INFO - 'TERM': 'linux', 04:25:05 INFO - 'TMOUT': '86400', 04:25:05 INFO - 'USER': 'cltbld', 04:25:05 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1506164729.903602-221357998', 04:25:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:25:05 INFO - '_': '/tools/buildbot/bin/python'} 04:25:05 INFO - TEST-INFO | started process 25526 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpz5zBaS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 04:25:05 INFO - PID 25526 | 04:25:05 INFO - PID 25526 | (/builds/slave/test/build/application/firefox/firefox:25575): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 04:25:05 INFO - PID 25526 | 04:25:16 INFO - PID 25526 | RSS: Main: 140709888 04:25:16 INFO - PID 25526 | 04:25:18 INFO - PID 25526 | Cycle 1(1): loaded http://localhost:36610/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36610/tests/kraken/driver.html?testName=audio-beat-detection) 04:25:19 INFO - PID 25526 | RSS: Main: 148336640 04:25:19 INFO - PID 25526 | 04:25:22 INFO - PID 25526 | Cycle 1(1): loaded http://localhost:36610/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36610/tests/kraken/driver.html?testName=audio-dft) 04:25:22 INFO - PID 25526 | RSS: Main: 148525056 04:25:22 INFO - PID 25526 | 04:25:25 INFO - PID 25526 | Cycle 1(1): loaded http://localhost:36610/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36610/tests/kraken/driver.html?testName=audio-fft) 04:25:26 INFO - PID 25526 | RSS: Main: 143478784 04:25:26 INFO - PID 25526 | 04:25:28 INFO - PID 25526 | Cycle 1(1): loaded http://localhost:36610/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36610/tests/kraken/driver.html?testName=audio-oscillator) 04:25:28 INFO - PID 25526 | RSS: Main: 145272832 04:25:28 INFO - PID 25526 | 04:25:31 INFO - PID 25526 | Cycle 1(1): loaded http://localhost:36610/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36610/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:25:31 INFO - PID 25526 | RSS: Main: 145362944 04:25:31 INFO - PID 25526 | 04:25:34 INFO - PID 25526 | Cycle 1(1): loaded http://localhost:36610/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36610/tests/kraken/driver.html?testName=imaging-darkroom) 04:25:35 INFO - PID 25526 | RSS: Main: 145035264 04:25:35 INFO - PID 25526 | 04:25:38 INFO - PID 25526 | Cycle 1(1): loaded http://localhost:36610/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36610/tests/kraken/driver.html?testName=imaging-desaturate) 04:25:39 INFO - PID 25526 | RSS: Main: 146444288 04:25:39 INFO - PID 25526 | 04:25:42 INFO - PID 25526 | Cycle 1(1): loaded http://localhost:36610/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36610/tests/kraken/driver.html?testName=json-parse-financial) 04:25:42 INFO - PID 25526 | RSS: Main: 147582976 04:25:42 INFO - PID 25526 | 04:25:44 INFO - PID 25526 | Cycle 1(1): loaded http://localhost:36610/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36610/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:25:45 INFO - PID 25526 | RSS: Main: 148086784 04:25:45 INFO - PID 25526 | 04:25:46 INFO - PID 25526 | Cycle 1(1): loaded http://localhost:36610/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36610/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:25:47 INFO - PID 25526 | RSS: Main: 149028864 04:25:47 INFO - PID 25526 | 04:25:49 INFO - PID 25526 | Cycle 1(1): loaded http://localhost:36610/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36610/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:25:49 INFO - PID 25526 | RSS: Main: 147681280 04:25:49 INFO - PID 25526 | 04:25:52 INFO - PID 25526 | Cycle 1(1): loaded http://localhost:36610/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36610/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:25:52 INFO - PID 25526 | RSS: Main: 148353024 04:25:52 INFO - PID 25526 | 04:25:55 INFO - PID 25526 | Cycle 1(1): loaded http://localhost:36610/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36610/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:25:56 INFO - PID 25526 | RSS: Main: 147939328 04:25:56 INFO - PID 25526 | 04:25:57 INFO - PID 25526 | Cycle 1(1): loaded http://localhost:36610/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36610/tests/kraken/driver.html?testName=ai-astar) 04:25:58 INFO - PID 25526 | RSS: Main: 150355968 04:25:58 INFO - PID 25526 | 04:25:58 INFO - PID 25526 | __start_tp_report 04:25:58 INFO - PID 25526 | _x_x_mozilla_page_load 04:25:58 INFO - PID 25526 | _x_x_mozilla_page_load_details 04:25:58 INFO - PID 25526 | |i|pagename|runs| 04:25:58 INFO - PID 25526 | |0;ai-astar;105;105;105;107;105;107;104;105;106;105 04:25:58 INFO - PID 25526 | |1;audio-beat-detection;120;117;113;137;112;113;122;112;115;114 04:25:58 INFO - PID 25526 | |2;audio-dft;164;163;162;163;164;161;164;165;163;165 04:25:58 INFO - PID 25526 | |3;audio-fft;74;76;76;75;73;73;73;73;73;73 04:25:58 INFO - PID 25526 | |4;audio-oscillator;82;79;79;81;81;78;78;78;78;78 04:25:58 INFO - PID 25526 | |5;imaging-gaussian-blur;116;118;118;115;114;113;111;114;114;114 04:25:58 INFO - PID 25526 | |6;imaging-darkroom;149;151;149;152;151;150;150;153;151;152 04:25:58 INFO - PID 25526 | |7;imaging-desaturate;94;94;95;94;94;94;94;96;98;95 04:25:58 INFO - PID 25526 | |8;json-parse-financial;44;44;43;44;45;46;43;42;43;47 04:25:58 INFO - PID 25526 | |9;json-stringify-tinderbox;38;37;38;37;37;37;38;37;37;37 04:25:58 INFO - PID 25526 | |10;stanford-crypto-aes;77;73;70;71;71;71;71;70;72;72 04:25:58 INFO - PID 25526 | |11;stanford-crypto-ccm;107;105;111;104;109;108;105;109;113;107 04:25:58 INFO - PID 25526 | |12;stanford-crypto-pbkdf2;148;150;152;151;160;157;150;151;151;155 04:25:58 INFO - PID 25526 | |13;stanford-crypto-sha256-iterative;60;59;61;61;62;60;62;62;70;59 04:25:58 INFO - PID 25526 | __end_tp_report 04:25:58 INFO - PID 25526 | __start_cc_report 04:25:58 INFO - PID 25526 | _x_x_mozilla_cycle_collect,709 04:25:58 INFO - PID 25526 | __end_cc_report 04:25:58 INFO - PID 25526 | __startTimestamp1506165958054__endTimestamp 04:25:58 INFO - PID 25526 | 04:25:58 INFO - PID 25526 | ------- Summary: start ------- 04:25:58 INFO - PID 25526 | Number of tests: 14 04:25:58 INFO - PID 25526 | 04:25:58 INFO - PID 25526 | [#0] ai-astar Cycles:10 Average:105.40 Median:105.00 stddev:0.97 (0.9%) stddev-sans-first:1.01 04:25:58 INFO - PID 25526 | Values: 105.0 105.0 105.0 107.0 105.0 107.0 104.0 105.0 106.0 105.0 04:25:58 INFO - PID 25526 | 04:25:58 INFO - PID 25526 | [#1] audio-beat-detection Cycles:10 Average:117.50 Median:116.00 stddev:7.65 (6.6%) stddev-sans-first:8.06 04:25:58 INFO - PID 25526 | Values: 120.0 117.0 113.0 137.0 112.0 113.0 122.0 112.0 115.0 114.0 04:25:58 INFO - PID 25526 | 04:25:58 INFO - PID 25526 | [#2] audio-dft Cycles:10 Average:163.40 Median:164.00 stddev:1.26 (0.8%) stddev-sans-first:1.32 04:25:58 INFO - PID 25526 | Values: 164.0 163.0 162.0 163.0 164.0 161.0 164.0 165.0 163.0 165.0 04:25:58 INFO - PID 25526 | 04:25:58 INFO - PID 25526 | [#3] audio-fft Cycles:10 Average:73.90 Median:73.50 stddev:1.29 (1.8%) stddev-sans-first:1.36 04:25:58 INFO - PID 25526 | Values: 74.0 76.0 76.0 75.0 73.0 73.0 73.0 73.0 73.0 73.0 04:25:58 INFO - PID 25526 | 04:25:58 INFO - PID 25526 | [#4] audio-oscillator Cycles:10 Average:79.20 Median:79.00 stddev:1.55 (2.0%) stddev-sans-first:1.27 04:25:58 INFO - PID 25526 | Values: 82.0 79.0 79.0 81.0 81.0 78.0 78.0 78.0 78.0 78.0 04:25:58 INFO - PID 25526 | 04:25:58 INFO - PID 25526 | [#5] imaging-gaussian-blur Cycles:10 Average:114.70 Median:114.50 stddev:2.16 (1.9%) stddev-sans-first:2.24 04:25:58 INFO - PID 25526 | Values: 116.0 118.0 118.0 115.0 114.0 113.0 111.0 114.0 114.0 114.0 04:25:58 INFO - PID 25526 | 04:25:58 INFO - PID 25526 | [#6] imaging-darkroom Cycles:10 Average:150.80 Median:151.00 stddev:1.32 (0.9%) stddev-sans-first:1.22 04:25:58 INFO - PID 25526 | Values: 149.0 151.0 149.0 152.0 151.0 150.0 150.0 153.0 151.0 152.0 04:25:58 INFO - PID 25526 | 04:25:58 INFO - PID 25526 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:94.50 stddev:1.32 (1.4%) stddev-sans-first:1.36 04:25:58 INFO - PID 25526 | Values: 94.0 94.0 95.0 94.0 94.0 94.0 94.0 96.0 98.0 95.0 04:25:58 INFO - PID 25526 | 04:25:58 INFO - PID 25526 | [#8] json-parse-financial Cycles:10 Average:44.10 Median:44.00 stddev:1.52 (3.5%) stddev-sans-first:1.62 04:25:58 INFO - PID 25526 | Values: 44.0 44.0 43.0 44.0 45.0 46.0 43.0 42.0 43.0 47.0 04:25:58 INFO - PID 25526 | 04:25:58 INFO - PID 25526 | [#9] json-stringify-tinderbox Cycles:10 Average:37.30 Median:37.00 stddev:0.48 (1.3%) stddev-sans-first:0.44 04:25:58 INFO - PID 25526 | Values: 38.0 37.0 38.0 37.0 37.0 37.0 38.0 37.0 37.0 37.0 04:25:58 INFO - PID 25526 | 04:25:58 INFO - PID 25526 | [#10] stanford-crypto-aes Cycles:10 Average:71.80 Median:71.50 stddev:2.04 (2.9%) stddev-sans-first:0.97 04:25:58 INFO - PID 25526 | Values: 77.0 73.0 70.0 71.0 71.0 71.0 71.0 70.0 72.0 72.0 04:25:58 INFO - PID 25526 | 04:25:58 INFO - PID 25526 | [#11] stanford-crypto-ccm Cycles:10 Average:107.80 Median:108.50 stddev:2.82 (2.6%) stddev-sans-first:2.98 04:25:58 INFO - PID 25526 | Values: 107.0 105.0 111.0 104.0 109.0 108.0 105.0 109.0 113.0 107.0 04:25:58 INFO - PID 25526 | 04:25:58 INFO - PID 25526 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:152.50 Median:151.50 stddev:3.69 (2.4%) stddev-sans-first:3.54 04:25:58 INFO - PID 25526 | Values: 148.0 150.0 152.0 151.0 160.0 157.0 150.0 151.0 151.0 155.0 04:25:58 INFO - PID 25526 | 04:25:58 INFO - PID 25526 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.60 Median:61.50 stddev:3.17 (5.2%) stddev-sans-first:3.31 04:25:58 INFO - PID 25526 | Values: 60.0 59.0 61.0 61.0 62.0 60.0 62.0 62.0 70.0 59.0 04:25:58 INFO - PID 25526 | -------- Summary: end -------- 04:25:58 INFO - PID 25526 | 04:25:58 INFO - PID 25526 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 04:25:58 INFO - TEST-INFO | 25526: exit 0 04:25:58 INFO - TEST-OK | kraken | took 59409ms 04:25:58 INFO - SUITE-END | took 1169s 04:25:58 INFO - Completed test suite (00:19:29) 04:25:58 INFO - javascript benchmark 04:25:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9135.428477388561, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3831.214601006794, 3853.980730096349, 3880.6119388061197, 3881.243157584271, 3919.0398352403668, 6200.751969921198, 6240.032794916795, 6282.3717628237155, 6307.526935479835, 6346.80959571213, 6348.269948955872, 6371.108044873721, 6375.968120159404, 6403.967980160092, 6409.967950160254, 5692.0608099663505, 5728.283964504437, 5750.223719797837, 5787.536997040227, 5809.738561764731, 5651.660900345993, 5688.744006519696, 5741.397153298906, 5777.740001699913, 5784.739686714108, 5502.367227768817, 5590.049691552405, 5606.747696353674, 5678.858028549299, 5762.135679648065, 5666.150077488369, 5746.281714785652, 5751.137329400582, 5758.481736643722, 5763.991301522216, 5682.6306290091015, 5686.601937864351, 5727.341355744059, 5744.798932037359, 5764.8847023059725, 6228.719707613168, 6232.0, 6255.718492667841, 6258.436740693314, 6275.466585340251, 6839.829004274883, 6870.106886104824, 6878.3465570770695, 6943.0, 6947.40947019504, 6897.793066208022, 6910.412614927737, 6920.065791118185, 6935.3411425914455, 6963.8607227855155, 6370.71331790066, 6379.87240255197, 6416.550841441148, 6452.161219041494, 6472.093906853044, 6887.896681549781, 6891.3797758202, 6998.825029374205, 7052.0, 7128.928710712827, 6742.954841999498, 6757.594544327356, 6780.525363224626, 6795.490338224653, 6807.183138023469, 6926.376626103674, 6967.407770339578, 6971.442284617218, 6974.163100427981, 6980.825479362955, 6822.044913712084, 6826.214985276757, 6828.419584335387, 6912.758053468105, 6917.861642767117, 6718.529702920749, 6824.3516865898655, 6836.350546698056, 6868.862622747517, 6927.757528486479, 5010.699358038456, 5031.723255220924, 5037.3955125384455, 5055.545000949932, 5085.949140508622, 4517.322401639781, 4638.304254361873, 4647.883802904955, 4675.509071547506, 4692.41344831896, 6342.556021078481, 6344.777932772423, 6431.453326467303, 6443.614622856108, 6471.255805582324, 6742.662866856637, 6867.07294515244, 6902.551334163364, 6910.48171387148, 6960.408365288906, 6246.593971391845, 6329.7468101275435, 6331.68341582919, 6332.271788744261, 6342.0, 5542.445755424506, 5551.3893471718075, 5577.553795696334, 5579.609427340048, 5606.103023516218, 7102.325279098477, 7112.715491380391, 7124.0, 7207.423406127497, 7220.422366210691, 6868.141482314711, 6874.209465911485, 6931.0643063187845, 6934.341237582422, 6939.444844412435, 6903.861922761416, 7008.0, 7126.35862772353, 7217.0, 7231.023811785552, 6798.422134118655, 6853.520253582401, 6868.450523958171, 6898.206706228848, 6901.861962760817, 6849.794506164823, 6863.970404439175, 6865.347791959756, 6993.125859267591, 7014.018037474656, 6561.3438656134, 6655.101561289164, 6677.933220667731, 6752.831179220362, 6769.526133170631, 6487.708053137714, 6607.405333520006, 6649.46804255668, 6661.600303981777, 6663.433608143168, 6488.221413430419, 6632.403083722488, 6646.833829154117, 6658.334166583303, 6674.733010679713, 6581.80254592363, 6640.933590664032, 6676.6995485202315, 6701.597904125768, 6707.530472867048, 6250.749970001149, 6330.3669633036325, 6427.971524556048, 6441.6135031896365, 6560.507961902781], "value": 6276.310063591452, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [927.5547737086198, 967.5404183013075, 979.8726165598473, 1020.2908978260108, 1024.5696807340917, 43693.0, 44677.0, 44769.0, 45035.0, 45078.0984380313, 42574.57425425745, 42691.57308426915, 42704.78647606765, 42808.785956070176, 42867.14265714684, 7714.34428073613, 7837.568933708644, 7854.7250846220395, 7868.370530357586, 7903.881441778378, 7607.277308655669, 7651.311381975621, 7676.2323767623075, 7678.0786305643405, 7678.5392876427595, 8430.409871309012, 8662.047174810798, 8671.653133874637, 8674.739757807276, 8678.262347700453, 8560.743177704679, 8621.827563448727, 8624.18070283322, 8624.482531048157, 8629.180227878342, 8280.378971577156, 8337.0, 8345.457545259538, 8493.193146651058, 8521.446106003152, 40909.79545102255, 41308.79345603283, 41395.0, 41426.58573414288, 41499.792501037606, 3668.6881615062753, 3694.11341278094, 3695.2978934002454, 3700.204456041964, 3706.8517259309597, 34598.82700586506, 34725.305493890235, 34751.0, 34799.82600087009, 34991.65008349935, 5404.0, 5424.701641409721, 5427.213054107132, 5462.754176062087, 5469.316335458067, 213531.0, 214841.0, 219825.0, 222195.0, 225956.0, 53662.0, 53887.19169212465, 53891.19163212555, 54228.18657720138, 54456.0, 56268.718656406454, 56299.43700562942, 56407.43592564104, 56433.435665643636, 56506.0, 15844.128572928368, 15910.76133857993, 16021.839781602268, 16087.115208663401, 16132.0, 12641.178323408949, 12748.745025099632, 12859.357032148355, 12885.806712899313, 13067.542636007884, 15196.468123615621, 15311.770323445156, 15519.5344139676, 15558.766618500731, 15628.0, 5904.793332233351, 6093.817185484354, 6112.724927378279, 6132.846678832976, 6243.157173781572, 1076.6554702495127, 1077.165196972337, 1101.4217535793612, 1104.5857803323754, 1107.2526044919648, 24853.378665533146, 24910.0, 25022.874885625457, 25125.87437062803, 25243.747562524506, 1148.9270535950077, 1191.195942738648, 1197.9580714674944, 1207.2454715802623, 1211.4851188245136, 13077.542286019943, 13236.801447978289, 13246.20522768637, 13325.400356983959, 13325.73348533024, 245916.0, 263818.0, 265087.0, 265327.0, 266950.0, 59676.70161649164, 59785.0, 60107.09839352413, 60280.0, 60419.69790151109, 1500.5873384819263, 1511.5918701950632, 1526.9312880920386, 1529.4341093795367, 1544.9459268925534, 24136.275911722678, 24763.251446381546, 24854.37864053413, 24865.751342486343, 24887.626685599367, 34440.655593444746, 34772.0, 37926.051848704, 37931.62068379391, 38043.80978095092, 223365.0, 225789.0, 225979.0, 226386.0, 226514.0, 35000.12499687528, 35800.82099589486, 36679.08302292464, 37844.0, 38211.23577528489, 48459.75770121127, 48762.5123748758, 48814.0, 49178.262326064425, 49188.50811491839, 36054.27891442209, 36138.09654758547, 36698.26603467862, 36710.08224794402, 36985.0, 35848.82075589606, 36198.27603447969, 36218.818905905304, 36382.454263185544, 36398.8180059098, 40241.1951760969, 42466.0, 42590.0, 42874.356884646135, 43016.56983430251, 34444.65555344414, 34900.47649285314, 35000.0, 35200.0, 35441.82279088588, 25351.492970140862, 26168.476630466903, 26182.0, 26293.34266643349, 26386.736132639195], "value": 18602.081123234762, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [599.4365296621173, 604.4227762486826, 610.7679081948861, 631.3717850738516, 643.398422474986, 23027.424314392127, 23207.883960580217, 23480.295591132293, 23721.76278237217, 23735.0, 22573.322800315975, 23134.537309253807, 23167.652485212737, 23233.303000909957, 23268.41828954277, 6452.838679033015, 6600.240972288177, 6636.668166591675, 6637.070810086591, 6667.266600673922, 6471.773487927923, 6531.118299029617, 6544.2801291858095, 6817.318268173192, 6819.454443644497, 6708.295628958962, 6716.93283067168, 6762.0, 6764.797056088325, 6771.559848609824, 6346.11154438379, 6565.93434065658, 6626.403623673844, 6782.660866956632, 6789.355011273921, 6167.105769663419, 6173.1048997895505, 6188.9690551546955, 6191.1332413461705, 6198.101275315099, 29781.702182978326, 30002.84998575015, 30059.248518786986, 30062.0, 30259.243518911982, 2225.0, 2254.402583315423, 2254.6167151584104, 2256.9322920312416, 2264.218844498662, 18584.163712632962, 19333.709994350094, 19349.903250483658, 19461.416157515298, 19480.70778938317, 2488.8382255153356, 2494.837835540702, 2542.5042116787235, 2544.058698281629, 2562.090457887442, 142937.0, 148785.25607372003, 149422.25288873594, 155048.99999999886, 163004.18497907434, 15622.687546249012, 15939.44211952576, 16262.430814921421, 16367.42714005004, 16375.362463753767, 25830.0, 25893.870530647604, 25925.740742592334, 26020.609690854653, 26025.0, 10304.793904121876, 10348.172146228284, 10417.635382761719, 10491.68524944253, 10545.420001899816, 9352.625894964262, 9356.391834530734, 9462.858057129148, 9463.952680236554, 9538.332316737762, 9436.517654114241, 9608.471534065553, 9658.565364558612, 9664.226861851035, 9850.21198304134, 2784.6305969776795, 2863.1696807925887, 2898.202994176618, 2980.1804503761205, 3005.8797648093832, 1017.9898201018043, 1042.7288904884633, 1045.6549338718205, 1051.0540513537876, 1053.5680371047986, 20545.98346381653, 20714.792852071587, 20848.687269690967, 20962.38057324865, 21158.259460918795, 1078.0, 1094.1465656787718, 1101.658485869367, 1105.972350691223, 1109.3343993603935, 11217.326960382403, 11424.257423267461, 11524.308541487537, 11541.942290288494, 11607.30356178632, 571983.0, 589653.0, 594777.0, 595893.0, 600202.0, 123354.38322808329, 124084.0, 126250.0, 129914.0, 130105.0, 1109.4064675398622, 1126.1272513801705, 1162.1922763679163, 1213.9271643701406, 1224.3205021213312, 21562.460938476037, 21701.457463563536, 22029.889850551284, 22094.116235351048, 22113.55772884501, 63585.0, 65086.67456662686, 66531.33468665251, 66616.66691666511, 67020.66489667716, 80950.0, 81038.0, 81572.18427815646, 82948.0, 85142.0, 14964.775528366865, 15205.695886082438, 15307.387704492141, 15352.616184595474, 15417.922910385376, 24042.759572404753, 24130.155444559357, 24196.39509012289, 24438.389040274134, 24471.143509977064, 19875.105620246835, 19883.30408435698, 20011.399658010283, 20096.0, 20321.593568128257, 17488.73766893523, 17625.82374176242, 17676.0, 18200.089995500435, 18283.634327313644, 20109.597808043465, 20202.393928182177, 20476.283330083377, 20511.38465846027, 20628.27801026957, 15080.849191507945, 15217.0, 15353.462628807938, 15369.1546964918, 15410.69178616399, 18725.157367918204, 18879.339223127125, 19164.137613807692, 19450.805491945466, 19477.902610486857], "value": 12684.164249564901, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1400.3418393355123, 1444.7688369860819, 1467.699121680055, 1469.7207530569185, 1471.8380978092407, 16954.0, 17742.73385899211, 17746.378876739316, 17747.201375938115, 17791.466256012325, 17219.655606887856, 17349.7397539037, 17369.7394539082, 17470.0, 17518.0, 2820.1398573435094, 2928.1069273871462, 2931.915191379182, 2933.0320994071903, 2934.4864648686503, 2746.5056289867816, 2813.788965827561, 2872.5260332045186, 2873.310405502685, 2881.0, 2880.6399200099986, 2894.305366711995, 2909.796314257992, 2911.1703164598093, 2911.4904891643982, 2733.685626152998, 2784.3456787654886, 2795.3570678744004, 2799.174243598143, 2802.2153796936686, 2659.521286168489, 2838.162741991097, 2851.586519954595, 2852.1728698677357, 2858.3854471288564, 17148.657026859393, 17256.309747610205, 17302.91348543249, 17305.913470432693, 17307.221175047154, 8049.235322644339, 8327.625256863455, 8343.95828020856, 8357.206065423776, 8367.0, 5197.324347834758, 5214.243934629495, 5353.197020446925, 5412.83761487156, 5432.809851655213, 2152.1283880028614, 2162.697222388867, 2174.086883508914, 2222.9666555001686, 2247.9775202247934, 31273.0, 31510.212244693837, 31530.369392612018, 31594.210144746336, 31596.210094747585, 7011.6143612100805, 7034.753783617549, 7038.768215562256, 7188.748393806296, 7288.890666640004, 20628.896855515628, 20681.586368272852, 20737.688934665992, 20759.481012974797, 20770.0, 7698.615069246627, 7784.2215778421705, 7794.610269486503, 7803.648835802403, 7806.4925779824125, 7070.328318809705, 7166.677499512534, 7181.712731490787, 7365.300296471826, 7450.0687414073245, 5727.942720572824, 5865.090910908816, 5934.516370907273, 6000.609960352563, 6045.486133678686, 1705.5139285303876, 1738.9217485213196, 1768.4252617899235, 1768.522498925283, 1797.4427927342565, 954.4798085043668, 968.6416026070399, 977.7273315610685, 994.855745916838, 1000.4897502273893, 8696.521691306913, 8723.127687231226, 8732.650693972297, 8810.515421651871, 8856.202941735275, 779.6062988190927, 804.2640983500149, 804.5856383962264, 812.1310198088107, 816.4568964656803, 5326.493983071602, 5705.2012718219485, 5849.502792262705, 6017.247844019497, 6024.638521688713, 24822.37944051413, 24872.0, 26413.07554235631, 26431.20706378812, 26436.206913792616, 25064.744173024515, 25171.62242566363, 25552.48895022089, 25860.353491162496, 25901.870490647427, 12608.432620531914, 12694.42875070624, 12923.935380323039, 12942.67643308906, 12974.935125324502, 9444.85832712496, 9455.763605909908, 9459.195968342769, 9472.857907131536, 9615.471149086867, 21034.47413814667, 21327.7867221332, 21357.572848543252, 21565.35303940884, 21861.0, 22354.21760238384, 22586.322410327717, 22783.31650050501, 22809.88595057014, 22828.201012964466, 12534.686632834251, 12726.363681816058, 12840.807387889003, 12847.807282890952, 12878.67803304925, 15848.762268566212, 16146.354145834035, 16159.0, 16163.838361616234, 16192.02847829134, 12156.635300940987, 12268.263904165779, 12385.071119665881, 12393.442295096922, 12740.554080607135, 11268.211225214156, 11307.321560706385, 11384.316940983568, 11468.139889508153, 11729.237599556001, 11104.888951110386, 11228.326300422, 11258.718532036764, 11319.264247823865, 11393.544258229578, 8579.184977427134, 8615.181557752003, 8627.0, 8644.524551149496, 8686.174813392718, 8525.87211191845, 8549.529775862387, 8666.826663466822, 8680.218780309802, 8717.433366831136], "value": 7336.066345083383, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [558.2296430925325, 570.3042288408142, 571.3886141828245, 574.6322353693636, 586.4926838284882, 5802.709864506774, 6226.377362263771, 6248.84377890553, 6263.498920086394, 6331.398517140864, 6118.724657390417, 6181.28915174755, 6201.875962480748, 6242.719077641517, 6250.218722659668, 4977.825776097838, 4996.500349965011, 5064.265681476184, 5074.264231686403, 5087.643864929457, 5108.64239503235, 5195.7398531638855, 5240.1353776627, 5248.186531087687, 5252.52727254547, 5204.100503316281, 5227.18978558324, 5259.263703081571, 5263.763130659129, 5287.180487024498, 5214.217867319894, 5222.0, 5230.110881150214, 5232.372115346145, 5244.895102097975, 4952.653314268003, 4970.179920313144, 4979.008396641336, 4996.375453068366, 4999.700017998895, 6203.348648391899, 6213.720382582795, 6215.7513699451965, 6300.27546832111, 6356.110144579762, 6174.598651087665, 6211.161493198406, 6219.160413344186, 6239.407256310688, 6248.187735594389, 6684.2647308795995, 6708.295628958937, 6717.832054198635, 6751.088603038576, 6775.491838112112, 5243.973780131113, 5483.533899618537, 5512.834614961557, 5542.418046105141, 5581.2186293918885, 6637.933620663828, 6842.057915096507, 6930.27232140623, 6956.617386043715, 6973.012691383033, 5642.463965923231, 5645.661260324394, 5696.1455781633085, 5697.259356283656, 5710.571707121982, 5745.798897038583, 5758.74085666146, 5802.0, 5805.187273781674, 5830.096335068071, 6079.574429789961, 6126.479249263773, 6153.353897840751, 6163.9383606163365, 6178.7219575119225, 6680.265170831205, 6722.697478613474, 6731.129600479646, 6761.053452516651, 6767.424768894601, 1992.9701054484194, 2012.195121951202, 2023.736914201174, 2037.4498885301182, 2042.1423002339054, 1409.2595644379182, 1496.1546726099937, 1520.0803513873948, 1551.9689606207812, 1554.9533513994597, 6170.938290617126, 6178.845528861814, 6203.720832562545, 6254.593451425642, 6256.906146407808, 6718.462522998148, 6752.797416077526, 6757.182192061469, 6805.081314022544, 6813.829654258584, 6156.753729850756, 6164.383561643889, 6172.382761723792, 6190.535709821691, 6229.844253893598, 3559.252556963015, 3566.1262990567475, 3594.6045934947133, 3598.2803439312243, 3623.601403845575, 7033.191183014019, 7033.678885967618, 7064.470164737665, 7068.611226382495, 7073.823154421078, 6911.790436673663, 6955.1653801543125, 6972.337627925339, 6979.82550436233, 7011.127266549699, 7022.578645281299, 7029.156501219784, 7040.683169257396, 7047.260037696071, 7069.893951590833, 6606.8678626426245, 6667.19993600771, 6673.599584024974, 6687.498437617295, 6697.598144111369, 6610.8016759497295, 6668.866622667617, 6685.231198412051, 6714.9519396582555, 6817.147856517935, 6938.653067346713, 6951.965240173767, 6996.3269283626505, 7023.648817558999, 7045.0, 5579.944200557942, 5597.412271711574, 5611.915821262603, 5612.214289999485, 5624.718764061862, 6343.5876668016435, 6552.803415897531, 6701.597904125768, 6741.932580674326, 6742.393184613212, 6526.053722210348, 6539.11721917535, 6588.637624930675, 6601.900971485527, 6605.603663779996, 6400.807975760735, 6483.481321494363, 6505.145369167598, 6508.153939987771, 6542.705578248895, 6332.0501924709815, 6408.743650254124, 6430.64631445275, 6437.360682120308, 6490.825573432764, 6566.343365663395, 6579.828656543234, 6612.272650008399, 6641.900371494335, 6644.501662375244, 6337.493000560036, 6407.743690252338, 6425.58233714807, 6440.969444888795, 6454.709538070892], "value": 5323.532278158435, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [940.6472572785206, 972.5963725054102, 981.5975450065474, 991.0832479956039, 1013.3869009249402, 18699.252029918804, 19134.904325478386, 19182.712259316122, 19227.80772192276, 19305.0, 17185.398511052117, 17728.113594320264, 17738.20178091986, 18298.0, 18489.07554622267, 1007.4056306779017, 1019.8725159355081, 1020.795840831833, 1021.2442792333657, 1021.9744506387362, 1032.447640512326, 1039.3815679670583, 1046.3198920701566, 1047.4867315015626, 1047.8009178256145, 1082.3830416662506, 1120.803859324619, 1122.820348744197, 1122.9213955023151, 1123.775244951009, 1117.2961034548223, 1119.5409881948444, 1119.5857532712907, 1121.1479275750448, 1123.5056575106926, 784.1922819495871, 802.0936341933636, 812.4637739092229, 812.8374325134938, 813.4021494201756, 19542.902285488624, 19595.41213763575, 19636.901815490975, 19703.310384136486, 19789.505262368413, 22533.887330563408, 22588.77411225883, 23009.194678186184, 23090.307290781304, 23267.4183145421, 18819.90590047055, 18870.528236794053, 18963.33628323002, 19089.42731718037, 19157.425277241706, 4024.3561030235023, 4038.45480860086, 4056.371262454324, 4074.0, 4079.16377142688, 163951.0, 163952.0, 166348.16825915792, 168713.15643421828, 170216.0, 17372.565685857953, 17391.47825565235, 17478.0, 17488.737668934977, 17604.823951760318, 33834.0, 34050.31899361999, 34069.829650851585, 34080.48879266813, 34384.484232736526, 8614.18165274298, 8617.35369847264, 8635.093315201939, 8675.305975521944, 8681.348898832613, 4651.279051746985, 4701.929471057937, 4716.622670186377, 4722.409698787652, 4740.905181896412, 5991.2510936132985, 6104.0, 6147.907781383283, 6160.168377269101, 6180.0, 1071.6195750508614, 1097.9451027448595, 1114.8439218509416, 1117.5027112934665, 1120.9271397359146, 736.6721808795141, 751.9812004699817, 755.1429127939718, 764.9388048956071, 773.2267732267733, 13002.804957925639, 13061.804072938914, 13510.176126222834, 14239.0, 14474.421023158955, 738.7672883041824, 741.8516296740673, 749.1272667342594, 752.0223709178047, 752.0711920777835, 6250.874982500324, 6304.275008374004, 6418.19772528434, 6425.710843012076, 6492.0, 145330.0, 145646.0, 149279.25360373128, 149560.0, 152405.0, 122249.0, 125494.0, 126019.0, 128059.35970320088, 133008.0, 102990.97009029964, 105350.0, 109858.0, 109965.45017274862, 110932.99999999838, 14284.500042498878, 15217.163056032025, 15228.8210346905, 15236.085834849944, 15278.618034549225, 52270.73864630653, 52494.47505524896, 52546.73726631342, 52884.47115528795, 53689.0, 65994.0, 66175.0, 66294.33705662882, 67007.0, 68810.31189688039, 20558.38324850257, 21050.68423973611, 21148.47128821792, 21172.576548468638, 21209.151633935086, 22846.200382986517, 22893.0, 23077.307680769605, 23156.76843231546, 23196.072157113525, 21379.46551336167, 21911.233106841184, 21945.341639750834, 22141.0, 22232.777672223718, 17251.3962011329, 17702.734458983385, 17883.642327153124, 17909.0, 17912.641747165246, 16822.915885420494, 16913.830861691225, 17044.659106817548, 17099.914500427418, 17138.571535711708, 13249.403776830259, 13453.260070696206, 13649.727005460034, 13699.726005480034, 13931.860681393056, 14951.953363264467, 15158.848411515744, 15166.165860877758, 15370.538883833502, 15392.615184620474], "value": 10049.792030068937, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1374.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 105.0, 105.0, 107.0, 105.0, 107.0, 104.0, 105.0, 106.0, 105.0], "value": 105.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 117.0, 113.0, 137.0, 112.0, 113.0, 122.0, 112.0, 115.0, 114.0], "value": 117.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 162.0, 163.0, 164.0, 161.0, 164.0, 165.0, 163.0, 165.0], "value": 163.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 76.0, 75.0, 73.0, 73.0, 73.0, 73.0, 73.0, 73.0], "value": 73.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 79.0, 79.0, 81.0, 81.0, 78.0, 78.0, 78.0, 78.0, 78.0], "value": 79.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 118.0, 118.0, 115.0, 114.0, 113.0, 111.0, 114.0, 114.0, 114.0], "value": 114.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 151.0, 149.0, 152.0, 151.0, 150.0, 150.0, 153.0, 151.0, 152.0], "value": 150.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 94.0, 94.0, 94.0, 94.0, 96.0, 98.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [44.0, 44.0, 43.0, 44.0, 45.0, 46.0, 43.0, 42.0, 43.0, 47.0], "value": 44.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 37.0, 38.0, 37.0, 37.0, 37.0, 38.0, 37.0, 37.0, 37.0], "value": 37.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 73.0, 70.0, 71.0, 71.0, 71.0, 71.0, 70.0, 72.0, 72.0], "value": 71.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 105.0, 111.0, 104.0, 109.0, 108.0, 105.0, 109.0, 113.0, 107.0], "value": 107.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 150.0, 152.0, 151.0, 160.0, 157.0, 150.0, 151.0, 151.0, 155.0], "value": 152.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 59.0, 61.0, 61.0, 62.0, 60.0, 62.0, 62.0, 70.0, 59.0], "value": 61.6, "unit": "score"}]}]} 04:25:58 INFO - Return code: 0 04:25:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:25:58 INFO - # TBPL SUCCESS # 04:25:58 INFO - Running post-action listener: _package_coverage_data 04:25:58 INFO - Running post-action listener: _resource_record_post_action 04:25:58 INFO - [mozharness: 2017-09-23 11:25:58.838328Z] Finished run-tests step (success) 04:25:58 INFO - Running post-run listener: _resource_record_post_run 04:25:58 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 49152; Write bytes: 335466496; Read time: 384; Write time: 379832 04:25:58 INFO - TinderboxPrint: CPU usage
13.1% 04:25:58 INFO - TinderboxPrint: I/O read bytes / time
49,152 / 384 04:25:58 INFO - TinderboxPrint: I/O write bytes / time
335,466,496 / 379,832 04:25:58 INFO - TinderboxPrint: CPU idle
8,223.8 (86.9%) 04:25:58 INFO - TinderboxPrint: CPU user
1,189.2 (12.6%) 04:25:58 INFO - TinderboxPrint: Swap in / out
0 / 0 04:25:58 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 13164544; Read time: 0; Write time: 1712 04:25:58 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 04:25:58 INFO - run-tests - Wall time: 1170s; CPU: 13.0%; Read bytes: 49152; Write bytes: 322301952; Read time: 384; Write time: 378120 04:25:59 INFO - Running post-run listener: _upload_blobber_files 04:25:59 INFO - Blob upload gear active. 04:25:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:25:59 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:25:59 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:25:59 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:25:59 INFO - (blobuploader) - INFO - Open directory for files ... 04:25:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:25:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:25:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:26:00 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:26:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:26:01 INFO - (blobuploader) - INFO - Done attempting. 04:26:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:26:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:26:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:26:07 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:26:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:26:07 INFO - (blobuploader) - INFO - Done attempting. 04:26:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 04:26:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:26:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:26:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 04:26:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:26:08 INFO - (blobuploader) - INFO - Done attempting. 04:26:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 04:26:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:26:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:26:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 04:26:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:26:09 INFO - (blobuploader) - INFO - Done attempting. 04:26:09 INFO - (blobuploader) - INFO - Iteration through files over. 04:26:09 INFO - Return code: 0 04:26:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:26:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:26:09 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/807486ab8807dc3189463746b1f5126db545203f3bd15673fdbcb99aa55732cdb18740d287daf29106ec6429ab386ba9b3fcd928a49e7fb2fda9aac9a970c729", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/88f3d317a7eaf1a296652b289084a3be9c629588e02509c82b94302f38c8396c553b9c8864ab46e5cbeacbecb899a241e734e10108302abf2054850069307ad4", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a7726f8619df51ddb65ae6f481d9e002192a2f7789e0b983af63b511f67e1be417989b10c1e12baba6b491b78f87878956c149ef3acd691e5a8a8860a8599e17", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a6aa72082d9b83957f6a418aabceae4b5a00b0a199ef1a6ac6b162b3f5c264d8e3211dadb255332af60516af074ed4845fa8a453ab536dbb93cf06126c5d65b9"} 04:26:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:26:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:26:09 INFO - Contents: 04:26:09 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/807486ab8807dc3189463746b1f5126db545203f3bd15673fdbcb99aa55732cdb18740d287daf29106ec6429ab386ba9b3fcd928a49e7fb2fda9aac9a970c729", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/88f3d317a7eaf1a296652b289084a3be9c629588e02509c82b94302f38c8396c553b9c8864ab46e5cbeacbecb899a241e734e10108302abf2054850069307ad4", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a7726f8619df51ddb65ae6f481d9e002192a2f7789e0b983af63b511f67e1be417989b10c1e12baba6b491b78f87878956c149ef3acd691e5a8a8860a8599e17", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a6aa72082d9b83957f6a418aabceae4b5a00b0a199ef1a6ac6b162b3f5c264d8e3211dadb255332af60516af074ed4845fa8a453ab536dbb93cf06126c5d65b9"} 04:26:09 INFO - Running post-run listener: copy_logs_to_upload_dir 04:26:09 INFO - Copying logs to upload dir... 04:26:09 INFO - mkdir: /builds/slave/test/build/upload/logs 04:26:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.581807 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2017-09-23 04:26:09.770018) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-23 04:26:09.774087) ========= 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=17051fcd5208b27b50bedfeb000001dd-1506164729.903602-221357998 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/807486ab8807dc3189463746b1f5126db545203f3bd15673fdbcb99aa55732cdb18740d287daf29106ec6429ab386ba9b3fcd928a49e7fb2fda9aac9a970c729", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/88f3d317a7eaf1a296652b289084a3be9c629588e02509c82b94302f38c8396c553b9c8864ab46e5cbeacbecb899a241e734e10108302abf2054850069307ad4", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a7726f8619df51ddb65ae6f481d9e002192a2f7789e0b983af63b511f67e1be417989b10c1e12baba6b491b78f87878956c149ef3acd691e5a8a8860a8599e17", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a6aa72082d9b83957f6a418aabceae4b5a00b0a199ef1a6ac6b162b3f5c264d8e3211dadb255332af60516af074ed4845fa8a453ab536dbb93cf06126c5d65b9"} build_url:https://queue.taskcluster.net/v1/task/YK2hyMrlSTiJS-ZWTXWUag/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011697 build_url: 'https://queue.taskcluster.net/v1/task/YK2hyMrlSTiJS-ZWTXWUag/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/807486ab8807dc3189463746b1f5126db545203f3bd15673fdbcb99aa55732cdb18740d287daf29106ec6429ab386ba9b3fcd928a49e7fb2fda9aac9a970c729", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/88f3d317a7eaf1a296652b289084a3be9c629588e02509c82b94302f38c8396c553b9c8864ab46e5cbeacbecb899a241e734e10108302abf2054850069307ad4", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a7726f8619df51ddb65ae6f481d9e002192a2f7789e0b983af63b511f67e1be417989b10c1e12baba6b491b78f87878956c149ef3acd691e5a8a8860a8599e17", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a6aa72082d9b83957f6a418aabceae4b5a00b0a199ef1a6ac6b162b3f5c264d8e3211dadb255332af60516af074ed4845fa8a453ab536dbb93cf06126c5d65b9"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-23 04:26:09.808736) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-23 04:26:09.809214) ========= 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=17051fcd5208b27b50bedfeb000001dd-1506164729.903602-221357998 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004451 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-23 04:26:09.890941) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-23 04:26:09.891607) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-23 04:26:09.892139) ========= ========= Total master_lag: 0.20 =========