builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s slave: talos-linux64-ix-039 starttime: 1506054887.54 results: success (0) revision: 97282b0c985aa1778ced171514d1ae61945c634c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-21 21:34:47.535951) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-21 21:34:47.537085) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-21 21:34:47.537371) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-21 21:34:47.586011) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-21 21:34:47.586263) ========= 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=5bd038846534b2fdfa68eeae000001e2-1506053532.50547-1962975423 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-21 21:34:47-- 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% 220M=0s 2017-09-21 21:34:47 (220 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.127606 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-21 21:34:47.748177) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-21 21:34:47.748451) ========= 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=5bd038846534b2fdfa68eeae000001e2-1506053532.50547-1962975423 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020895 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-21 21:34:47.801575) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-21 21:34:47.801893) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 97282b0c985aa1778ced171514d1ae61945c634c --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 97282b0c985aa1778ced171514d1ae61945c634c --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=5bd038846534b2fdfa68eeae000001e2-1506053532.50547-1962975423 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-21 21:34:47,873 truncating revision to first 12 chars 2017-09-21 21:34:47,873 Setting DEBUG logging. 2017-09-21 21:34:47,873 attempt 1/10 2017-09-21 21:34:47,873 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/97282b0c985a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-21 21:34:48,653 unpacking tar archive at: mozilla-central-97282b0c985a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.101458 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-21 21:34:48.922691) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-21 21:34:48.926013) ========= script_repo_revision: 97282b0c985aa1778ced171514d1ae61945c634c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-21 21:34:48.926382) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-21 21:34:48.926638) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-21 21:34:48.947108) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2017-09-21 21:34:48.947412) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 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-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] 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=5bd038846534b2fdfa68eeae000001e2-1506053532.50547-1962975423 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:34:49 INFO - MultiFileLogger online at 20170921 21:34:49 in /builds/slave/test 21:34:49 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 21:34:49 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:34:49 INFO - {'append_to_log': False, 21:34:49 INFO - 'base_work_dir': '/builds/slave/test', 21:34:49 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 21:34:49 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:34:49 INFO - 'branch': 'Firefox-Non-PGO', 21:34:49 INFO - 'buildbot_json_path': 'buildprops.json', 21:34:49 INFO - 'code_coverage': False, 21:34:49 INFO - 'config_files': ('talos/linux_config.py',), 21:34:49 INFO - 'default_actions': ('clobber', 21:34:49 INFO - 'read-buildbot-config', 21:34:49 INFO - 'download-and-extract', 21:34:49 INFO - 'populate-webroot', 21:34:49 INFO - 'create-virtualenv', 21:34:49 INFO - 'install', 21:34:49 INFO - 'setup-mitmproxy', 21:34:49 INFO - 'run-tests'), 21:34:49 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:34:49 INFO - 'disable_ccov_upload': False, 21:34:49 INFO - 'disable_stylo': False, 21:34:49 INFO - 'download_minidump_stackwalk': True, 21:34:49 INFO - 'download_symbols': 'ondemand', 21:34:49 INFO - 'enable_stylo': False, 21:34:49 INFO - 'enable_webrender': False, 21:34:49 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 21:34:49 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:34:49 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:34:49 INFO - 'gecko_profile': False, 21:34:49 INFO - 'gecko_profile_interval': 0, 21:34:49 INFO - 'installer_path': 'installer.exe', 21:34:49 INFO - 'log_level': 'info', 21:34:49 INFO - 'log_name': 'talos', 21:34:49 INFO - 'log_to_console': True, 21:34:49 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:34:49 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:34:49 INFO - 'opt_config_files': (), 21:34:49 INFO - 'pip_index': False, 21:34:49 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 21:34:49 INFO - 'system_bits': '32', 21:34:49 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:34:49 INFO - 'title': 'talos-linux64-ix-039', 21:34:49 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:34:49 INFO - 'use_talos_json': True, 21:34:49 INFO - 'verify': 'False', 21:34:49 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:34:49 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:34:49 INFO - 'work_dir': 'build'} 21:34:49 INFO - [mozharness: 2017-09-22 04:34:49.162015Z] Running clobber step. 21:34:49 INFO - Running pre-action listener: _resource_record_pre_action 21:34:49 INFO - Running main action method: clobber 21:34:49 INFO - rmtree: /builds/slave/test/build 21:34:49 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:34:50 INFO - Running post-action listener: _resource_record_post_action 21:34:50 INFO - [mozharness: 2017-09-22 04:34:50.153661Z] Finished clobber step (success) 21:34:50 INFO - [mozharness: 2017-09-22 04:34:50.153758Z] Running read-buildbot-config step. 21:34:50 INFO - Running pre-action listener: _resource_record_pre_action 21:34:50 INFO - Running main action method: read_buildbot_config 21:34:50 INFO - Using buildbot properties: 21:34:50 INFO - { 21:34:50 INFO - "project": "", 21:34:50 INFO - "product": "firefox", 21:34:50 INFO - "who": "philringnalda@gmail.com", 21:34:50 INFO - "installer_path": "public/build/target.tar.bz2", 21:34:50 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 21:34:50 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 21:34:50 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-stylo-disabled-e10s", 21:34:50 INFO - "stage_platform": "linux64", 21:34:50 INFO - "basedir": "/builds/slave/test", 21:34:50 INFO - "buildnumber": 57, 21:34:50 INFO - "platform": "ubuntu64_hw", 21:34:50 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 21:34:50 INFO - "slavebuilddir": "test", 21:34:50 INFO - "taskId": "K5bA5vEnQV2d8avkoBs7uw", 21:34:50 INFO - "branch": "mozilla-central", 21:34:50 INFO - "script_repo_revision": "production", 21:34:50 INFO - "revision": "97282b0c985aa1778ced171514d1ae61945c634c", 21:34:50 INFO - "slavename": "talos-linux64-ix-039", 21:34:50 INFO - "repo_path": "mozilla-central" 21:34:50 INFO - } 21:34:50 INFO - Finding installer, test and symbols from parent task. 21:34:50 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/K5bA5vEnQV2d8avkoBs7uw'}, attempt #1 21:34:50 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/K5bA5vEnQV2d8avkoBs7uw'}, attempt #1 21:34:51 INFO - Task dependencies: Qc4qapSdREq4to_uIRkeSw 21:34:51 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Qc4qapSdREq4to_uIRkeSw'}, attempt #1 21:34:51 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Qc4qapSdREq4to_uIRkeSw/artifacts/public/build/target.tar.bz2 21:34:51 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/Qc4qapSdREq4to_uIRkeSw/artifacts/public/build/target.test_packages.json 21:34:51 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Qc4qapSdREq4to_uIRkeSw/artifacts/public/build/target.crashreporter-symbols.zip 21:34:51 INFO - Running post-action listener: _resource_record_post_action 21:34:51 INFO - [mozharness: 2017-09-22 04:34:51.542464Z] Finished read-buildbot-config step (success) 21:34:51 INFO - [mozharness: 2017-09-22 04:34:51.542681Z] Running download-and-extract step. 21:34:51 INFO - Running pre-action listener: _resource_record_pre_action 21:34:51 INFO - Running main action method: download_and_extract 21:34:51 INFO - mkdir: /builds/slave/test/build/tests 21:34: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')]} 21:34:51 INFO - trying https://queue.taskcluster.net/v1/task/Qc4qapSdREq4to_uIRkeSw/artifacts/public/build/target.test_packages.json 21:34:51 INFO - Downloading https://queue.taskcluster.net/v1/task/Qc4qapSdREq4to_uIRkeSw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 21:34:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Qc4qapSdREq4to_uIRkeSw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 21:34:52 INFO - Downloaded 989 bytes. 21:34:52 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 21:34:52 INFO - Using the following test package requirements: 21:34:52 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 21:34:52 INFO - u'common': [u'target.common.tests.zip'], 21:34:52 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 21:34:52 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 21:34:52 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 21:34:52 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 21:34:52 INFO - u'mozbase': [u'target.common.tests.zip'], 21:34:52 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 21:34:52 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 21:34:52 INFO - u'web-platform': [u'target.common.tests.zip', 21:34:52 INFO - u'target.web-platform.tests.tar.gz'], 21:34:52 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 21:34:52 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 21:34:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Qc4qapSdREq4to_uIRkeSw/artifacts/public/build/target.common.tests.zip 21:34:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Qc4qapSdREq4to_uIRkeSw/artifacts/public/build/target.common.tests.zip'}, attempt #1 21:34:52 INFO - Fetch https://queue.taskcluster.net/v1/task/Qc4qapSdREq4to_uIRkeSw/artifacts/public/build/target.common.tests.zip into memory 21:34:53 INFO - Content-Length response header: 54739760 21:34:53 INFO - Bytes received: 54739760 21:35:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Qc4qapSdREq4to_uIRkeSw/artifacts/public/build/target.talos.tests.zip 21:35:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Qc4qapSdREq4to_uIRkeSw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 21:35:03 INFO - Fetch https://queue.taskcluster.net/v1/task/Qc4qapSdREq4to_uIRkeSw/artifacts/public/build/target.talos.tests.zip into memory 21:35:04 INFO - Content-Length response header: 14513414 21:35:04 INFO - Bytes received: 14513414 21:35:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:35:04 INFO - trying https://queue.taskcluster.net/v1/task/Qc4qapSdREq4to_uIRkeSw/artifacts/public/build/target.tar.bz2 21:35:04 INFO - Downloading https://queue.taskcluster.net/v1/task/Qc4qapSdREq4to_uIRkeSw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 21:35:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Qc4qapSdREq4to_uIRkeSw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 21:35:06 INFO - Downloaded 61709000 bytes. 21:35:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Qc4qapSdREq4to_uIRkeSw/artifacts/public/build/target.tar.bz2 21:35:06 INFO - mkdir: /builds/slave/test/properties 21:35:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:35:06 INFO - Writing to file /builds/slave/test/properties/build_url 21:35:06 INFO - Contents: 21:35:06 INFO - build_url:https://queue.taskcluster.net/v1/task/Qc4qapSdREq4to_uIRkeSw/artifacts/public/build/target.tar.bz2 21:35:06 INFO - Running post-action listener: _resource_record_post_action 21:35:06 INFO - Running post-action listener: find_tests_for_verification 21:35:06 INFO - Running post-action listener: set_extra_try_arguments 21:35:06 INFO - [mozharness: 2017-09-22 04:35:06.060567Z] Finished download-and-extract step (success) 21:35:06 INFO - [mozharness: 2017-09-22 04:35:06.060663Z] Running populate-webroot step. 21:35:06 INFO - Running pre-action listener: _resource_record_pre_action 21:35:06 INFO - Running main action method: populate_webroot 21:35:06 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:35:06 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 21:35:06 INFO - 'tests': ['tresize', 21:35:06 INFO - 'tcanvasmark']}, 21:35:06 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:35:06 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 21:35:06 INFO - 'tests': ['dromaeo_css', 21:35:06 INFO - 'kraken']}, 21:35:06 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 21:35:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:35:06 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 21:35:06 INFO - 'talos_options': ['--disable-stylo'], 21:35:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:35:06 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 21:35:06 INFO - 'tests': ['damp', 'tps']}, 21:35:06 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 21:35:06 INFO - 'talos_options': ['--disable-stylo'], 21:35:06 INFO - 'tests': ['damp', 'tps']}, 21:35:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:35:06 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 21:35:06 INFO - 'tests': ['dromaeo_dom']}, 21:35:06 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 21:35:06 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 21:35:06 INFO - 'tests': ['basic_compositor_video', 21:35:06 INFO - 'glvideo']}, 21:35:06 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 21:35:06 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 21:35:06 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 21:35:06 INFO - 'talos_options': ['--disable-stylo'], 21:35:06 INFO - 'tests': ['ts_paint_webext', 21:35:06 INFO - 'tp5o_webext']}, 21:35:06 INFO - 'other-e10s': {'tests': ['a11yr', 21:35:06 INFO - 'ts_paint', 21:35:06 INFO - 'tpaint', 21:35:06 INFO - 'sessionrestore', 21:35:06 INFO - 'sessionrestore_many_windows', 21:35:06 INFO - 'sessionrestore_no_auto_restore', 21:35:06 INFO - 'tabpaint']}, 21:35:06 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 21:35:06 INFO - 'tests': ['a11yr', 21:35:06 INFO - 'ts_paint', 21:35:06 INFO - 'tpaint', 21:35:06 INFO - 'sessionrestore', 21:35:06 INFO - 'sessionrestore_many_windows', 21:35:06 INFO - 'sessionrestore_no_auto_restore', 21:35:06 INFO - 'tabpaint']}, 21:35:06 INFO - 'perf-reftest-e10s': {'tests': ['perf_reftest']}, 21:35:06 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 21:35:06 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 21:35:06 INFO - 'tests': ['perf_reftest_singletons']}, 21:35:06 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 21:35:06 INFO - 'tests': ['perf_reftest']}, 21:35:06 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:35:06 INFO - 'tsvgr_opacity', 21:35:06 INFO - 'tart', 21:35:06 INFO - 'tscrollx', 21:35:06 INFO - 'tsvg_static']}, 21:35:06 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 21:35:06 INFO - 'tests': ['tsvgx', 21:35:06 INFO - 'tsvgr_opacity', 21:35:06 INFO - 'tart', 21:35:06 INFO - 'tscrollx', 21:35:06 INFO - 'tsvg_static']}, 21:35:06 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 21:35:06 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 21:35:06 INFO - 'talos_options': ['--disable-stylo'], 21:35:06 INFO - 'tests': ['tp5o']}, 21:35:06 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 21:35:06 INFO - 'talos_options': ['--mitmproxy', 21:35:06 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 21:35:06 INFO - '--firstNonBlankPaint'], 21:35:06 INFO - 'tests': ['tp6_google', 21:35:06 INFO - 'tp6_youtube', 21:35:06 INFO - 'tp6_amazon', 21:35:06 INFO - 'tp6_facebook']}, 21:35:06 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 21:35:06 INFO - 'talos_options': ['--disable-stylo', 21:35:06 INFO - '--mitmproxy', 21:35:06 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 21:35:06 INFO - '--firstNonBlankPaint'], 21:35:06 INFO - 'tests': ['tp6_google', 21:35:06 INFO - 'tp6_youtube', 21:35:06 INFO - 'tp6_amazon', 21:35:06 INFO - 'tp6_facebook']}, 21:35:06 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 21:35:06 INFO - 'talos_options': ['--stylo-threads=1', 21:35:06 INFO - '--mitmproxy', 21:35:06 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 21:35:06 INFO - '--firstNonBlankPaint'], 21:35:06 INFO - 'tests': ['tp6_google', 21:35:06 INFO - 'tp6_youtube', 21:35:06 INFO - 'tp6_amazon', 21:35:06 INFO - 'tp6_facebook']}, 21:35:06 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 21:35:06 INFO - 'talos_options': ['--xperf_path', 21:35:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:35:06 INFO - 'tests': ['tp5n']}, 21:35:06 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 21:35:06 INFO - 'talos_options': ['--disable-stylo', 21:35:06 INFO - '--xperf_path', 21:35:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:35:06 INFO - 'tests': ['tp5n']}}} 21:35:06 INFO - Running post-action listener: _resource_record_post_action 21:35:06 INFO - [mozharness: 2017-09-22 04:35:06.075628Z] Finished populate-webroot step (success) 21:35:06 INFO - [mozharness: 2017-09-22 04:35:06.075717Z] Running create-virtualenv step. 21:35:06 INFO - Running pre-action listener: _resource_record_pre_action 21:35:06 INFO - Running main action method: create_virtualenv 21:35:06 INFO - Creating virtualenv /builds/slave/test/build/venv 21:35:06 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 21:35:06 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 21:35:06 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 21:35:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:35:06 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:35:07 INFO - Installing distribute.............................................................................................................................................................................................done. 21:35:07 INFO - Installing pip...............done. 21:35:07 INFO - Return code: 0 21:35:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 21:35:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 21:35:08 INFO - Reading from file tmpfile_stdout 21:35:08 INFO - Output received: 21:35:08 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 21:35:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:35: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')]} 21:35:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:35: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')]} 21:35:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:35:08 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 0xc291f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf95a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf99090>, '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 0xf99d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf93f90>, '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': '5bd038846534b2fdfa68eeae000001e2-1506053532.50547-1962975423', '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 21:35:08 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 21:35:08 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 21:35:08 INFO - Using env: {'DISPLAY': ':0', 21:35:08 INFO - 'HOME': '/home/cltbld', 21:35:08 INFO - 'LANG': 'en_US.UTF-8', 21:35:08 INFO - 'LANGUAGE': 'en_US:en', 21:35:08 INFO - 'LOGNAME': 'cltbld', 21:35:08 INFO - 'MAIL': '/var/mail/cltbld', 21:35:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:35:08 INFO - 'MOZ_NO_REMOTE': '1', 21:35:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:35:08 INFO - 'NO_EM_RESTART': '1', 21:35:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:35:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:35:08 INFO - 'PWD': '/builds/slave/test', 21:35:08 INFO - 'SHELL': '/bin/bash', 21:35:08 INFO - 'SHLVL': '1', 21:35:08 INFO - 'TERM': 'linux', 21:35:08 INFO - 'TMOUT': '86400', 21:35:08 INFO - 'USER': 'cltbld', 21:35:08 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1506053532.50547-1962975423', 21:35:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:35:08 INFO - '_': '/tools/buildbot/bin/python'} 21:35:09 INFO - Ignoring indexes: http://pypi.python.org/simple/ 21:35:09 INFO - Downloading/unpacking pip>=1.5 21:35:09 INFO - Running setup.py egg_info for package pip 21:35:09 INFO - warning: no files found matching 'pip/cacert.pem' 21:35:09 INFO - warning: no files found matching '*.html' under directory 'docs' 21:35:09 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 21:35:09 INFO - no previously-included directories found matching 'docs/_build/_sources' 21:35:09 INFO - Installing collected packages: pip 21:35:09 INFO - Found existing installation: pip 1.1 21:35:09 INFO - Uninstalling pip: 21:35:09 INFO - Successfully uninstalled pip 21:35:09 INFO - Running setup.py install for pip 21:35:09 INFO - warning: no files found matching 'pip/cacert.pem' 21:35:09 INFO - warning: no files found matching '*.html' under directory 'docs' 21:35:09 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 21:35:09 INFO - no previously-included directories found matching 'docs/_build/_sources' 21:35:09 INFO - Installing pip script to /builds/slave/test/build/venv/bin 21:35:09 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 21:35:09 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 21:35:09 INFO - Successfully installed pip 21:35:09 INFO - Cleaning up... 21:35:09 INFO - Return code: 0 21:35:09 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:35:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:35:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:35:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:35:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:35:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xc291f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf95a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf99090>, '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 0xf99d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf93f90>, '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': '5bd038846534b2fdfa68eeae000001e2-1506053532.50547-1962975423', '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 21:35:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 21:35:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 21:35:09 INFO - Using env: {'DISPLAY': ':0', 21:35:09 INFO - 'HOME': '/home/cltbld', 21:35:09 INFO - 'LANG': 'en_US.UTF-8', 21:35:09 INFO - 'LANGUAGE': 'en_US:en', 21:35:09 INFO - 'LOGNAME': 'cltbld', 21:35:09 INFO - 'MAIL': '/var/mail/cltbld', 21:35:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:35:09 INFO - 'MOZ_NO_REMOTE': '1', 21:35:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:35:09 INFO - 'NO_EM_RESTART': '1', 21:35:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:35:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:35:09 INFO - 'PWD': '/builds/slave/test', 21:35:09 INFO - 'SHELL': '/bin/bash', 21:35:09 INFO - 'SHLVL': '1', 21:35:09 INFO - 'TERM': 'linux', 21:35:09 INFO - 'TMOUT': '86400', 21:35:09 INFO - 'USER': 'cltbld', 21:35:09 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1506053532.50547-1962975423', 21:35:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:35:09 INFO - '_': '/tools/buildbot/bin/python'} 21:35:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:35:09 INFO - Downloading/unpacking psutil>=3.1.1 21:35:09 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 21:35:09 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 21:35:09 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 21:35:09 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 21:35:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:35:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:35:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:35:10 INFO - Installing collected packages: psutil 21:35:10 INFO - Running setup.py install for psutil 21:35:10 INFO - building 'psutil._psutil_linux' extension 21:35:10 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 21:35:11 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 21:35:11 INFO - building 'psutil._psutil_posix' extension 21:35:11 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 21:35:11 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 21:35:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:35:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:35:11 INFO - Successfully installed psutil 21:35:11 INFO - Cleaning up... 21:35:11 INFO - Return code: 0 21:35:11 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:35:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:35:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:35:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:35:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:35:11 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 0xc291f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf95a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf99090>, '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 0xf99d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf93f90>, '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': '5bd038846534b2fdfa68eeae000001e2-1506053532.50547-1962975423', '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 21:35:11 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 21:35:11 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 21:35:11 INFO - Using env: {'DISPLAY': ':0', 21:35:11 INFO - 'HOME': '/home/cltbld', 21:35:11 INFO - 'LANG': 'en_US.UTF-8', 21:35:11 INFO - 'LANGUAGE': 'en_US:en', 21:35:11 INFO - 'LOGNAME': 'cltbld', 21:35:11 INFO - 'MAIL': '/var/mail/cltbld', 21:35:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:35:11 INFO - 'MOZ_NO_REMOTE': '1', 21:35:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:35:11 INFO - 'NO_EM_RESTART': '1', 21:35:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:35:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:35:11 INFO - 'PWD': '/builds/slave/test', 21:35:11 INFO - 'SHELL': '/bin/bash', 21:35:11 INFO - 'SHLVL': '1', 21:35:11 INFO - 'TERM': 'linux', 21:35:11 INFO - 'TMOUT': '86400', 21:35:11 INFO - 'USER': 'cltbld', 21:35:11 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1506053532.50547-1962975423', 21:35:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:35:11 INFO - '_': '/tools/buildbot/bin/python'} 21:35:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:35:11 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:35:11 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 21:35:11 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 21:35:11 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 21:35:11 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 21:35:12 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:35:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:35:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:35:12 INFO - Installing collected packages: mozsystemmonitor 21:35:12 INFO - Running setup.py install for mozsystemmonitor 21:35:13 INFO - Successfully installed mozsystemmonitor 21:35:13 INFO - Cleaning up... 21:35:13 INFO - Return code: 0 21:35:13 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:35:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:35:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:35:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:35:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:35:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xc291f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf95a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf99090>, '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 0xf99d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf93f90>, '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': '5bd038846534b2fdfa68eeae000001e2-1506053532.50547-1962975423', '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 21:35:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 21:35:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 21:35:13 INFO - Using env: {'DISPLAY': ':0', 21:35:13 INFO - 'HOME': '/home/cltbld', 21:35:13 INFO - 'LANG': 'en_US.UTF-8', 21:35:13 INFO - 'LANGUAGE': 'en_US:en', 21:35:13 INFO - 'LOGNAME': 'cltbld', 21:35:13 INFO - 'MAIL': '/var/mail/cltbld', 21:35:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:35:13 INFO - 'MOZ_NO_REMOTE': '1', 21:35:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:35:13 INFO - 'NO_EM_RESTART': '1', 21:35:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:35:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:35:13 INFO - 'PWD': '/builds/slave/test', 21:35:13 INFO - 'SHELL': '/bin/bash', 21:35:13 INFO - 'SHLVL': '1', 21:35:13 INFO - 'TERM': 'linux', 21:35:13 INFO - 'TMOUT': '86400', 21:35:13 INFO - 'USER': 'cltbld', 21:35:13 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1506053532.50547-1962975423', 21:35:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:35:13 INFO - '_': '/tools/buildbot/bin/python'} 21:35:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:35:15 INFO - Downloading/unpacking jsonschema==2.5.1 21:35:15 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 21:35:15 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 21:35:15 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 21:35:15 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 21:35:16 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:35:17 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:35:17 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 21:35:17 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 21:35:17 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 21:35:17 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 21:35:17 INFO - Downloading functools32-3.2.3-2.tar.gz 21:35:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:35:17 INFO - warning: no files found matching '*.txt' 21:35:17 INFO - no previously-included directories found matching 'build' 21:35:17 INFO - no previously-included directories found matching 'dist' 21:35:17 INFO - no previously-included directories found matching '.git*' 21:35:17 INFO - Installing collected packages: jsonschema, functools32 21:35:17 INFO - Running setup.py install for functools32 21:35:17 INFO - warning: no files found matching '*.txt' 21:35:17 INFO - no previously-included directories found matching 'build' 21:35:17 INFO - no previously-included directories found matching 'dist' 21:35:17 INFO - no previously-included directories found matching '.git*' 21:35:17 INFO - Successfully installed jsonschema functools32 21:35:17 INFO - Cleaning up... 21:35:17 INFO - Return code: 0 21:35:17 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:35:17 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')]} 21:35:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:35:17 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')]} 21:35:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:35:17 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 0xc291f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf95a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf99090>, '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 0xf99d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf93f90>, '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': '5bd038846534b2fdfa68eeae000001e2-1506053532.50547-1962975423', '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 21:35:17 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 21:35:17 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 21:35:17 INFO - Using env: {'DISPLAY': ':0', 21:35:17 INFO - 'HOME': '/home/cltbld', 21:35:17 INFO - 'LANG': 'en_US.UTF-8', 21:35:17 INFO - 'LANGUAGE': 'en_US:en', 21:35:17 INFO - 'LOGNAME': 'cltbld', 21:35:17 INFO - 'MAIL': '/var/mail/cltbld', 21:35:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:35:17 INFO - 'MOZ_NO_REMOTE': '1', 21:35:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:35:17 INFO - 'NO_EM_RESTART': '1', 21:35:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:35:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:35:17 INFO - 'PWD': '/builds/slave/test', 21:35:17 INFO - 'SHELL': '/bin/bash', 21:35:17 INFO - 'SHLVL': '1', 21:35:17 INFO - 'TERM': 'linux', 21:35:17 INFO - 'TMOUT': '86400', 21:35:17 INFO - 'USER': 'cltbld', 21:35:17 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1506053532.50547-1962975423', 21:35:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:35:17 INFO - '_': '/tools/buildbot/bin/python'} 21:35:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:35:17 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:35:17 INFO - Cleaning up... 21:35:17 INFO - Return code: 0 21:35:17 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:35:17 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')]} 21:35:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:35:17 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')]} 21:35:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:35:17 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 0xc291f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf95a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf99090>, '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 0xf99d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf93f90>, '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': '5bd038846534b2fdfa68eeae000001e2-1506053532.50547-1962975423', '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 21:35:17 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 21:35:17 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 21:35:17 INFO - Using env: {'DISPLAY': ':0', 21:35:17 INFO - 'HOME': '/home/cltbld', 21:35:17 INFO - 'LANG': 'en_US.UTF-8', 21:35:17 INFO - 'LANGUAGE': 'en_US:en', 21:35:17 INFO - 'LOGNAME': 'cltbld', 21:35:17 INFO - 'MAIL': '/var/mail/cltbld', 21:35:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:35:17 INFO - 'MOZ_NO_REMOTE': '1', 21:35:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:35:17 INFO - 'NO_EM_RESTART': '1', 21:35:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:35:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:35:17 INFO - 'PWD': '/builds/slave/test', 21:35:17 INFO - 'SHELL': '/bin/bash', 21:35:17 INFO - 'SHLVL': '1', 21:35:17 INFO - 'TERM': 'linux', 21:35:17 INFO - 'TMOUT': '86400', 21:35:17 INFO - 'USER': 'cltbld', 21:35:17 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1506053532.50547-1962975423', 21:35:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:35:17 INFO - '_': '/tools/buildbot/bin/python'} 21:35:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:35:17 INFO - Downloading/unpacking blobuploader==1.2.4 21:35:17 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 21:35:17 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 21:35:17 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 21:35:17 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 21:35:18 INFO - Downloading blobuploader-1.2.4.tar.gz 21:35:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:35:18 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:35:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:35:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:35:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:35:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:35:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:35:19 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:35:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:35:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:35:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:35:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:35:19 INFO - Downloading docopt-0.6.1.tar.gz 21:35:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:35:19 INFO - Installing collected packages: blobuploader, requests, docopt 21:35:19 INFO - Running setup.py install for blobuploader 21:35:19 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:35:19 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:35:19 INFO - Running setup.py install for requests 21:35:19 INFO - Running setup.py install for docopt 21:35:20 INFO - Successfully installed blobuploader requests docopt 21:35:20 INFO - Cleaning up... 21:35:20 INFO - Return code: 0 21:35:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:35:20 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')]} 21:35:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:35:20 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')]} 21:35:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:35:20 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 0xc291f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf95a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf99090>, '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 0xf99d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf93f90>, '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': '5bd038846534b2fdfa68eeae000001e2-1506053532.50547-1962975423', '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 21:35:20 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 21:35:20 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 21:35:20 INFO - Using env: {'DISPLAY': ':0', 21:35:20 INFO - 'HOME': '/home/cltbld', 21:35:20 INFO - 'LANG': 'en_US.UTF-8', 21:35:20 INFO - 'LANGUAGE': 'en_US:en', 21:35:20 INFO - 'LOGNAME': 'cltbld', 21:35:20 INFO - 'MAIL': '/var/mail/cltbld', 21:35:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:35:20 INFO - 'MOZ_NO_REMOTE': '1', 21:35:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:35:20 INFO - 'NO_EM_RESTART': '1', 21:35:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:35:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:35:20 INFO - 'PWD': '/builds/slave/test', 21:35:20 INFO - 'SHELL': '/bin/bash', 21:35:20 INFO - 'SHLVL': '1', 21:35:20 INFO - 'TERM': 'linux', 21:35:20 INFO - 'TMOUT': '86400', 21:35:20 INFO - 'USER': 'cltbld', 21:35:20 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1506053532.50547-1962975423', 21:35:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:35:20 INFO - '_': '/tools/buildbot/bin/python'} 21:35:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:35:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:35:20 INFO - Running setup.py (path:/tmp/pip-aFq47M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:35:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:35:20 INFO - Running setup.py (path:/tmp/pip-GwitcP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:35:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:35:20 INFO - Running setup.py (path:/tmp/pip-6S2YND-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:35:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:35:20 INFO - Running setup.py (path:/tmp/pip-OlJfiM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:35:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:35:20 INFO - Running setup.py (path:/tmp/pip-tQkwK1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:35:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:35:20 INFO - Running setup.py (path:/tmp/pip-vqAPpD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:35:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:35:20 INFO - Running setup.py (path:/tmp/pip-BSy3I4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:35:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:35:20 INFO - Running setup.py (path:/tmp/pip-WixjTk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:35:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:35:20 INFO - Running setup.py (path:/tmp/pip-EQWles-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:35:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:35:20 INFO - Running setup.py (path:/tmp/pip-AB3s_Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:35:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:35:20 INFO - Running setup.py (path:/tmp/pip-NRt5dq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:35:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:35:21 INFO - Running setup.py (path:/tmp/pip-5JZc0D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:35:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:35:21 INFO - Running setup.py (path:/tmp/pip-_yt3Oa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:35:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:35:21 INFO - Running setup.py (path:/tmp/pip-Q68jjk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:35:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:35:21 INFO - Running setup.py (path:/tmp/pip-1ZfMLt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:35:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:35:21 INFO - Running setup.py (path:/tmp/pip-kTs3a_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:35:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:35:21 INFO - Running setup.py (path:/tmp/pip-AJbmaN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:35:21 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:35:21 INFO - Running setup.py install for manifestparser 21:35:21 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:35:21 INFO - Running setup.py install for mozcrash 21:35:21 INFO - Running setup.py install for mozdebug 21:35:21 INFO - Running setup.py install for mozdevice 21:35:21 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:35:21 INFO - Running setup.py install for mozfile 21:35:21 INFO - Running setup.py install for mozhttpd 21:35:22 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:35:22 INFO - Running setup.py install for mozinfo 21:35:22 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:35:22 INFO - Running setup.py install for mozInstall 21:35:22 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:35:22 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:35:22 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:35:22 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:35:22 INFO - Running setup.py install for mozleak 21:35:22 INFO - Running setup.py install for mozlog 21:35:22 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:35:22 INFO - Running setup.py install for moznetwork 21:35:22 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:35:22 INFO - Running setup.py install for mozprocess 21:35:22 INFO - Running setup.py install for mozprofile 21:35:22 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:35:22 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:35:22 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:35:22 INFO - Running setup.py install for mozrunner 21:35:22 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:35:22 INFO - Running setup.py install for mozscreenshot 21:35:23 INFO - Running setup.py install for moztest 21:35:23 INFO - Running setup.py install for mozversion 21:35:23 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:35:23 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:35:23 INFO - Cleaning up... 21:35:23 INFO - Return code: 0 21:35:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:35:23 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')]} 21:35:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:35:23 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')]} 21:35:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:35:23 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 0xc291f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf95a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf99090>, '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 0xf99d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf93f90>, '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': '5bd038846534b2fdfa68eeae000001e2-1506053532.50547-1962975423', '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 21:35:23 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 21:35:23 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 21:35:23 INFO - Using env: {'DISPLAY': ':0', 21:35:23 INFO - 'HOME': '/home/cltbld', 21:35:23 INFO - 'LANG': 'en_US.UTF-8', 21:35:23 INFO - 'LANGUAGE': 'en_US:en', 21:35:23 INFO - 'LOGNAME': 'cltbld', 21:35:23 INFO - 'MAIL': '/var/mail/cltbld', 21:35:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:35:23 INFO - 'MOZ_NO_REMOTE': '1', 21:35:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:35:23 INFO - 'NO_EM_RESTART': '1', 21:35:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:35:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:35:23 INFO - 'PWD': '/builds/slave/test', 21:35:23 INFO - 'SHELL': '/bin/bash', 21:35:23 INFO - 'SHLVL': '1', 21:35:23 INFO - 'TERM': 'linux', 21:35:23 INFO - 'TMOUT': '86400', 21:35:23 INFO - 'USER': 'cltbld', 21:35:23 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1506053532.50547-1962975423', 21:35:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:35:23 INFO - '_': '/tools/buildbot/bin/python'} 21:35:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:35:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:35:23 INFO - Running setup.py (path:/tmp/pip-3jvFET-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:35:23 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)) 21:35:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:35:23 INFO - Running setup.py (path:/tmp/pip-Xe5xGk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:35:23 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)) 21:35:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:35:23 INFO - Running setup.py (path:/tmp/pip-dXNWQ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:35:23 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)) 21:35:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:35:23 INFO - Running setup.py (path:/tmp/pip-hfY_LB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:35:23 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)) 21:35:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:35:23 INFO - Running setup.py (path:/tmp/pip-mXlkww-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:35:23 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)) 21:35:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:35:23 INFO - Running setup.py (path:/tmp/pip-genHEs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:35:23 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)) 21:35:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:35:23 INFO - Running setup.py (path:/tmp/pip-6p7Rcp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:35:23 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)) 21:35:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:35:23 INFO - Running setup.py (path:/tmp/pip-RO2cgg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:35:24 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)) 21:35:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:35:24 INFO - Running setup.py (path:/tmp/pip-rWVIIp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:35:24 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)) 21:35:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:35:24 INFO - Running setup.py (path:/tmp/pip-Qm9nxN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:35:24 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)) 21:35:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:35:24 INFO - Running setup.py (path:/tmp/pip-GPPgvS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:35:24 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)) 21:35:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:35:24 INFO - Running setup.py (path:/tmp/pip-6PpfGI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:35:24 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)) 21:35:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:35:24 INFO - Running setup.py (path:/tmp/pip-rEF6_X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:35:24 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)) 21:35:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:35:24 INFO - Running setup.py (path:/tmp/pip-KTuTum-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:35:24 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)) 21:35:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:35:24 INFO - Running setup.py (path:/tmp/pip-kbeLjc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:35:24 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)) 21:35:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:35:24 INFO - Running setup.py (path:/tmp/pip-RuNVUO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:35:24 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)) 21:35:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:35:24 INFO - Running setup.py (path:/tmp/pip-6mX781-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:35:24 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)) 21:35:24 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)) 21:35:24 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)) 21:35:24 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)) 21:35:24 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)) 21:35:24 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)) 21:35:24 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)) 21:35:24 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:35:24 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 21:35:24 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 21:35:24 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 21:35:24 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 21:35:25 INFO - Downloading blessings-1.6.tar.gz 21:35:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:35:25 INFO - Installing collected packages: blessings 21:35:25 INFO - Running setup.py install for blessings 21:35:25 INFO - Successfully installed blessings 21:35:25 INFO - Cleaning up... 21:35:26 INFO - Return code: 0 21:35:26 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:35:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:35:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:35:26 INFO - Reading from file tmpfile_stdout 21:35:26 INFO - Current package versions: 21:35:26 INFO - argparse == 1.2.1 21:35:26 INFO - blessings == 1.6 21:35:26 INFO - blobuploader == 1.2.4 21:35:26 INFO - docopt == 0.6.1 21:35:26 INFO - functools32 == 3.2.3-2 21:35:26 INFO - jsonschema == 2.5.1 21:35:26 INFO - manifestparser == 1.1 21:35:26 INFO - mozInstall == 1.13 21:35:26 INFO - mozcrash == 1.0 21:35:26 INFO - mozdebug == 0.1 21:35:26 INFO - mozdevice == 0.51 21:35:26 INFO - mozfile == 1.2 21:35:26 INFO - mozhttpd == 0.7 21:35:26 INFO - mozinfo == 0.10 21:35:26 INFO - mozleak == 0.1 21:35:26 INFO - mozlog == 3.5 21:35:26 INFO - moznetwork == 0.27 21:35:26 INFO - mozprocess == 0.25 21:35:26 INFO - mozprofile == 0.28 21:35:26 INFO - mozrunner == 6.13 21:35:26 INFO - mozscreenshot == 0.1 21:35:26 INFO - mozsystemmonitor == 0.3 21:35:26 INFO - moztest == 0.8 21:35:26 INFO - mozversion == 1.4 21:35:26 INFO - psutil == 3.1.1 21:35:26 INFO - requests == 1.2.3 21:35:26 INFO - wsgiref == 0.1.2 21:35:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:35:26 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')]} 21:35:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:35:26 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')]} 21:35:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:35:26 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 0xc291f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf95a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf99090>, '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 0xf99d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf93f90>, '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': '5bd038846534b2fdfa68eeae000001e2-1506053532.50547-1962975423', '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 21:35:26 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 21:35:26 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 21:35:26 INFO - Using env: {'DISPLAY': ':0', 21:35:26 INFO - 'HOME': '/home/cltbld', 21:35:26 INFO - 'LANG': 'en_US.UTF-8', 21:35:26 INFO - 'LANGUAGE': 'en_US:en', 21:35:26 INFO - 'LOGNAME': 'cltbld', 21:35:26 INFO - 'MAIL': '/var/mail/cltbld', 21:35:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:35:26 INFO - 'MOZ_NO_REMOTE': '1', 21:35:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:35:26 INFO - 'NO_EM_RESTART': '1', 21:35:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:35:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:35:26 INFO - 'PWD': '/builds/slave/test', 21:35:26 INFO - 'SHELL': '/bin/bash', 21:35:26 INFO - 'SHLVL': '1', 21:35:26 INFO - 'TERM': 'linux', 21:35:26 INFO - 'TMOUT': '86400', 21:35:26 INFO - 'USER': 'cltbld', 21:35:26 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1506053532.50547-1962975423', 21:35:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:35:26 INFO - '_': '/tools/buildbot/bin/python'} 21:35:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:35:26 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)) 21:35:26 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)) 21:35:26 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)) 21:35:26 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)) 21:35:26 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)) 21:35:26 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)) 21:35:26 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)) 21:35:26 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)) 21:35:26 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)) 21:35:26 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 21:35:26 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 21:35:26 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 21:35:26 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 21:35:26 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 21:35:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 21:35:27 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)) 21:35:27 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)) 21:35:27 INFO - Installing collected packages: simplejson 21:35:27 INFO - Running setup.py install for simplejson 21:35:27 INFO - building 'simplejson._speedups' extension 21:35:27 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 21:35:28 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 21:35:28 INFO - Successfully installed simplejson 21:35:28 INFO - Cleaning up... 21:35:28 INFO - Return code: 0 21:35:28 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:35:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:35:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:35:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:35:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:35:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xc291f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf95a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf99090>, '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 0xf99d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf93f90>, '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': '5bd038846534b2fdfa68eeae000001e2-1506053532.50547-1962975423', '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 21:35:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 21:35:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 21:35:28 INFO - Using env: {'DISPLAY': ':0', 21:35:28 INFO - 'HOME': '/home/cltbld', 21:35:28 INFO - 'LANG': 'en_US.UTF-8', 21:35:28 INFO - 'LANGUAGE': 'en_US:en', 21:35:28 INFO - 'LOGNAME': 'cltbld', 21:35:28 INFO - 'MAIL': '/var/mail/cltbld', 21:35:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:35:28 INFO - 'MOZ_NO_REMOTE': '1', 21:35:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:35:28 INFO - 'NO_EM_RESTART': '1', 21:35:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:35:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:35:28 INFO - 'PWD': '/builds/slave/test', 21:35:28 INFO - 'SHELL': '/bin/bash', 21:35:28 INFO - 'SHLVL': '1', 21:35:28 INFO - 'TERM': 'linux', 21:35:28 INFO - 'TMOUT': '86400', 21:35:28 INFO - 'USER': 'cltbld', 21:35:28 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1506053532.50547-1962975423', 21:35:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:35:28 INFO - '_': '/tools/buildbot/bin/python'} 21:35:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:35:28 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:35:28 INFO - Cleaning up... 21:35:28 INFO - Return code: 0 21:35:28 INFO - Running post-action listener: _resource_record_post_action 21:35:28 INFO - Running post-action listener: _start_resource_monitoring 21:35:28 INFO - Starting resource monitoring. 21:35:28 INFO - [mozharness: 2017-09-22 04:35:28.952484Z] Finished create-virtualenv step (success) 21:35:28 INFO - [mozharness: 2017-09-22 04:35:28.952946Z] Running install step. 21:35:28 INFO - Running pre-action listener: _resource_record_pre_action 21:35:28 INFO - Running main action method: install 21:35:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:35:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:35:29 INFO - Reading from file tmpfile_stdout 21:35:29 INFO - Detecting whether we're running mozinstall >=1.0... 21:35:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:35:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:35:29 INFO - Reading from file tmpfile_stdout 21:35:29 INFO - Output received: 21:35:29 INFO - Usage: mozinstall [options] installer 21:35:29 INFO - Options: 21:35:29 INFO - -h, --help show this help message and exit 21:35:29 INFO - -d DEST, --destination=DEST 21:35:29 INFO - Directory to install application into. [default: 21:35:29 INFO - "/builds/slave/test"] 21:35:29 INFO - --app=APP Application being installed. [default: firefox] 21:35:29 INFO - mkdir: /builds/slave/test/build/application 21:35:29 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'] 21:35:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 21:35:47 INFO - Reading from file tmpfile_stdout 21:35:47 INFO - Output received: 21:35:47 INFO - /builds/slave/test/build/application/firefox/firefox 21:35:47 INFO - Running post-action listener: _resource_record_post_action 21:35:47 INFO - [mozharness: 2017-09-22 04:35:47.088532Z] Finished install step (success) 21:35:47 INFO - [mozharness: 2017-09-22 04:35:47.088783Z] Running setup-mitmproxy step. 21:35:47 INFO - Running pre-action listener: _resource_record_pre_action 21:35:47 INFO - Running main action method: setup_mitmproxy 21:35:47 INFO - Skipping: mitmproxy is not required 21:35:47 INFO - Running post-action listener: _resource_record_post_action 21:35:47 INFO - [mozharness: 2017-09-22 04:35:47.089972Z] Finished setup-mitmproxy step (success) 21:35:47 INFO - [mozharness: 2017-09-22 04:35:47.090192Z] Running run-tests step. 21:35:47 INFO - Running pre-action listener: _resource_record_pre_action 21:35:47 INFO - Running pre-action listener: _set_gcov_prefix 21:35:47 INFO - Running main action method: run_tests 21:35:47 WARNING - Try message not found. 21:35:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:35:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:35:47 INFO - Python 2.7.3 21:35:47 INFO - Return code: 0 21:35:47 INFO - grabbing minidump binary from tooltool 21:35:47 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')]} 21:35:47 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 0xf99090>, '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 0xf99d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf93f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:35:47 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 21:35:47 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 21:35:47 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 21:35:47 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:35:47 INFO - Return code: 0 21:35:47 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 21:35:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:35:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:35:47 INFO - ENV: RUST_BACKTRACE is now full 21:35:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 21:35:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:35:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Qc4qapSdREq4to_uIRkeSw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--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 21:35:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-stylo-disabled-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Qc4qapSdREq4to_uIRkeSw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-039 --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 21:35:47 INFO - Using env: {'DISPLAY': ':0', 21:35:47 INFO - 'HOME': '/home/cltbld', 21:35:47 INFO - 'LANG': 'en_US.UTF-8', 21:35:47 INFO - 'LANGUAGE': 'en_US:en', 21:35:47 INFO - 'LOGNAME': 'cltbld', 21:35:47 INFO - 'MAIL': '/var/mail/cltbld', 21:35:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:35:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:35:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:35:47 INFO - 'MOZ_NO_REMOTE': '1', 21:35:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:35:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:35:47 INFO - 'NO_EM_RESTART': '1', 21:35:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:35:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:35:47 INFO - 'PWD': '/builds/slave/test', 21:35:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:35:47 INFO - 'RUST_BACKTRACE': 'full', 21:35:47 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 21:35:47 INFO - 'SHELL': '/bin/bash', 21:35:47 INFO - 'SHLVL': '1', 21:35:47 INFO - 'TERM': 'linux', 21:35:47 INFO - 'TMOUT': '86400', 21:35:47 INFO - 'USER': 'cltbld', 21:35:47 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1506053532.50547-1962975423', 21:35:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:35:47 INFO - '_': '/tools/buildbot/bin/python'} 21:35:47 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Qc4qapSdREq4to_uIRkeSw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--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 21:35:47 INFO - mozversion application_buildid: 20170922034016 21:35:47 INFO - mozversion application_changeset: 97282b0c985aa1778ced171514d1ae61945c634c 21:35:47 INFO - mozversion application_display_name: Nightly 21:35:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:35:47 INFO - mozversion application_name: Firefox 21:35:47 INFO - mozversion application_remotingname: firefox 21:35:47 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 21:35:47 INFO - mozversion application_vendor: Mozilla 21:35:47 INFO - mozversion application_version: 58.0a1 21:35:47 INFO - mozversion platform_buildid: 20170922034016 21:35:47 INFO - mozversion platform_changeset: 97282b0c985aa1778ced171514d1ae61945c634c 21:35:47 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 21:35:47 INFO - mozversion platform_version: 58.0a1 21:35:47 INFO - using testdate: 1506054947 21:35:47 INFO - actual date: 1506054947 21:35:47 INFO - starting webserver on 'localhost:33960' 21:35:47 INFO - SUITE-START | Running 2 tests 21:35:47 INFO - TEST-START | dromaeo_css 21:35:47 INFO - Initialising browser for dromaeo_css test... 21:35:47 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:33960/getInfo.html -profile /tmp/tmpI7HyOe/profile 21:35:47 INFO - TEST-INFO | started process 6616 (/builds/slave/test/build/application/firefox/firefox http://localhost:33960/getInfo.html) 21:35:54 INFO - TEST-INFO | 6616: exit 0 21:35:54 INFO - Browser initialized. 21:35:54 INFO - Running cycle 1/1 for dromaeo_css test... 21:35:54 INFO - Using env: {'DISPLAY': ':0', 21:35:54 INFO - 'HOME': '/home/cltbld', 21:35:54 INFO - 'JSGC_DISABLE_POISONING': '1', 21:35:54 INFO - 'LANG': 'en_US.UTF-8', 21:35:54 INFO - 'LANGUAGE': 'en_US:en', 21:35:54 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 21:35:54 INFO - 'LOGNAME': 'cltbld', 21:35:54 INFO - 'MAIL': '/var/mail/cltbld', 21:35:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:35:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:35:54 INFO - 'MOZ_CRASHREPORTER': '1', 21:35:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:35:54 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 21:35:54 INFO - 'MOZ_NO_REMOTE': '1', 21:35:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:35:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:35:54 INFO - 'NO_EM_RESTART': '1', 21:35:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:35:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:35:54 INFO - 'PWD': '/builds/slave/test', 21:35:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:35:54 INFO - 'RUST_BACKTRACE': 'full', 21:35:54 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 21:35:54 INFO - 'SHELL': '/bin/bash', 21:35:54 INFO - 'SHLVL': '1', 21:35:54 INFO - 'STYLO_FORCE_DISABLED': '1', 21:35:54 INFO - 'TERM': 'linux', 21:35:54 INFO - 'TMOUT': '86400', 21:35:54 INFO - 'USER': 'cltbld', 21:35:54 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1506053532.50547-1962975423', 21:35:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:35:54 INFO - '_': '/tools/buildbot/bin/python'} 21:35:54 INFO - TEST-INFO | started process 6852 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpI7HyOe/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 21:35:55 INFO - PID 6852 | 21:35:55 INFO - PID 6852 | (/builds/slave/test/build/application/firefox/firefox:6900): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 21:35:55 INFO - PID 6852 | 21:36:05 INFO - PID 6852 | RSS: Main: 150855680 21:36:05 INFO - PID 6852 | 21:39:02 INFO - PID 6852 | Cycle 1(1): loaded http://localhost:33960/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33960/tests/dromaeo/cssquery-ext.html) 21:39:03 INFO - PID 6852 | RSS: Main: 155148288 21:39:03 INFO - PID 6852 | 21:42:05 INFO - PID 6852 | Cycle 1(1): loaded http://localhost:33960/tests/dromaeo/cssquery-ext.html (next: http://localhost:33960/tests/dromaeo/cssquery-jquery.html) 21:42:05 INFO - PID 6852 | RSS: Main: 155381760 21:42:05 INFO - PID 6852 | 21:45:07 INFO - PID 6852 | Cycle 1(1): loaded http://localhost:33960/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33960/tests/dromaeo/cssquery-mootools.html) 21:45:08 INFO - PID 6852 | RSS: Main: 155643904 21:45:08 INFO - PID 6852 | 21:48:09 INFO - PID 6852 | Cycle 1(1): loaded http://localhost:33960/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33960/tests/dromaeo/cssquery-prototype.html) 21:48:10 INFO - PID 6852 | RSS: Main: 155439104 21:48:10 INFO - PID 6852 | 21:51:13 INFO - PID 6852 | Cycle 1(1): loaded http://localhost:33960/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33960/tests/dromaeo/cssquery-yui.html) 21:51:14 INFO - PID 6852 | RSS: Main: 156291072 21:51:14 INFO - PID 6852 | 21:54:16 INFO - PID 6852 | Cycle 1(1): loaded http://localhost:33960/tests/dromaeo/cssquery-yui.html (next: http://localhost:33960/tests/dromaeo/cssquery-dojo.html) 21:54:16 INFO - PID 6852 | RSS: Main: 157696000 21:54:16 INFO - PID 6852 | 21:54:16 INFO - PID 6852 | __start_tp_report 21:54:16 INFO - PID 6852 | _x_x_mozilla_page_load 21:54:16 INFO - PID 6852 | _x_x_mozilla_page_load_details 21:54:16 INFO - PID 6852 | |i|pagename|runs| 21:54:16 INFO - PID 6852 | |0;dojo.html;3158.731507821835;3159.09965659787;3182.395344884472;3185.0285662872816;3207.118042538303;6170.228721409824;6307.495400367971;6312.526560507963;6351.079093531441;6394.9448341023735;6240.812775616728;6281.528885333595;6288.622682639033;6299.685015749217;6303.810885673437;5733.569982251337;5763.798267060653;5860.09168578871;5891.381404952483;5957.821265362046;5799.362070172298;5872.618279811799;5911.704414779244;5912.88174236515;5935.9703201483935;815.0218952874583;5645;5810.15752715856;5881.088431293135;5888;5284.0679531331125;5643.1535269709875;5767.913481297784;5842.766289348421;5853.882922341572;5756.913646295309;5766.654000759926;5830;5840.678762668052;5845.2401187845735;6215.28524219716;6244.281907580641;6367.07677386781;6378.4578310843635;6385;6693.732250710014;6732.966335168293;6744.190697116328;6807.455403567703;6819.215790184143;6651.86696266072;6780.186377634666;6804.08144900437;6859.965700171517;6879.793606191773;6167;6169;6175.66033868137;6176.4441200292185;6181.3509581493745;6730.427913627299;6813.080234168324;6813.182418109858;6817.352351526597;6831.863362732717;6176.505879529627;6453.515986301046;6461.709223084972;6531.216254049449;6713.932860671331;6833.794986150423;6850.760223392257;6929.965350173217;6934.583924964418;6939.757108501179;6774.491913106537;6797.898031529531;6846.760363387258;6854.451643868479;6880.071190389333;6595.241547222035;6595.571287866273;6670.633115178614;6681.365270299314;6806.149231346082;5360.222767698662;5371.919421208685;5381.515663590296;5385.596080293915;5387.218853266333;4590.265557510782;4628.190066738307;4670.089332580114;4695.741734204583;4710.764461776897;5765.538756899438;5782;5842.737076831468;5846.152307915413;5854.063349864001;6589.703463344065;6643.40209381158;6643.7674681385915;6654.334566543307;6755.256921738604;5693.914591281134;5701.828945131652;5721.370649228582;5727.4845263926445;5736.856578585569;5680.062789639664;5741.253637027244;5742.196092546963;5748.741306641211;5753.798617048467;6459.09572659828;6488.902666459912;6644.335566443317;6656.500762442836;6688.565243259172;6754.6622668865375;6769.086173366532;6831.385175334244;6851.931480685129;6856.314368563104;6566.376194261537;6586.769463068769;6644.90032649501;6653.933460665331;6659.966700166468;6549.574277671936;6614.6361950093205;6644.667766611747;6692.196936367667;6705.396514313735;6858.142732158481;6873.243943166148;6883.414909732529;6897.206821215625;6904.102466679299;6557.737690492327;6571.145751052524;6632.403083722488;6639.933600664125;6652.501062420241;6339.334369891095;6436.8390790230615;6460.160179176865;6570.868582628416;6632.668366581748;6418.743250269937;6440.066190402272;6448.871022579616;6452.354764523698;6483.189601299838;6682.064510968566;6706.966465167839;6712.49656275791;6716.798496045127;6729.024291477806;6379.4896408286295;6424.229092508929;6490.837729056811;6494.967525162344;6495.317991611002 21:54:16 INFO - PID 6852 | |1;ext.html;850.2432834777047;878.6441491196068;879.2043200903183;880.1946219209419;881.8192270584527;39152.60847391525;43181;43264.78367608158;43311.350329745;43364.349534757006;38958.80520597393;39328.60671393285;39408;39429.211415771664;39446;7237.782866514;7368.300011498899;8026.598670066503;8184.672613095469;8207.671693132268;7961.60191990401;8072.152423995454;8080.474769139987;8095.150009249032;8095.554744489051;8026.558539280337;8137.877931831027;8148.6333115009675;8149.185081491863;8152.103268640445;8075.152109028556;8114.391420643446;8118.797030074236;8129.837403251961;8145.266925976632;8077.717279895234;8107.797305067362;8118.188181181894;8120.796980075486;8123.512589244605;38089.80955095235;38133.427998580046;38204.80897595522;38232;38247.4262886057;3524.7708898921746;3530.4174811156126;3533.3639944809925;3534.169470174507;3534.3814832404228;31351.05946821599;31477.84261078703;31487.685123148705;31520.211994700087;31553.684463155303;5152.407473140599;5164.2770012198325;5180.792768289264;5194.065068287707;5210.76551555181;190202.04898975554;190625;190783.0460847701;190825;191118;43332.13335733268;44080.338794918105;50324.74837625862;50429.74785126051;50475;51962.740186298826;52924.47075529272;53223.467765322624;53348.73325633347;53361.7331913338;16137.112458814878;16225.756613650805;16271.918640406722;16275.267612957208;16301.266443009856;13083.476660933457;13170.078094533483;13174.802377964339;13211.66970825737;13223;14538.27308634564;14552.199629020506;14747.55757327282;14797.408103675947;14865.628359291104;5875.529957603381;5964.135200395918;6019.969900150471;6048.183495228088;6054.122152287893;994.3188915592842;1006.3961623026125;1008.1430783833682;1009.6314845081492;1014.0974532665933;22929.88535057314;23296.534069318517;23522.64716029261;23564.528709425715;23711.407214819767;1091.5088210305394;1114.0641860836774;1121.243160866412;1125.5497800879714;1133.7959167349957;12224.205426647239;12310.630681079581;12365.690857728448;12380.876191238152;12433.254004759743;235734;236853;237053;237464;237541;53770;54177.45822541724;54330.185047224324;54377.72811135998;54657.72671136619;1422.7652437347722;1444.530527578541;1448.7971683964254;1455.8325792533994;1456.4829485532696;22292.554148917254;22346.441338966655;22687.092516299163;22752.886235568716;23190.88404558034;36949.261014780095;37249.255014899005;37252.813735931144;37293.254134916606;37418.62581374151;194013;194328;194499;194517;196272;34746.13134671653;36230;36795;36884;36998.260034798615;46926.53073469221;47230.05539889114;47741.52258477371;47757.76121119372;48062.27906581334;34134.487982679784;34504.65495345015;34811.65188348084;34841.651583484854;35062.82468587641;33633.83183084069;33970.66029339675;34404.655953440146;34435.827820861734;34924.30151397009;39252.214955700154;39470.80264598659;39520.40719389154;39639.40540891947;39643.405348920365;32950;33204.66795332112;33326;33666.49500257547;34020.65979340175;24483;24494;24689.06218756292;25268.74731252664;25380.873095634404 21:54:16 INFO - PID 6852 | |2;jquery.html;567.9549628683222;568.5139205978888;579.1168468086169;589.8525368657836;607.5625549604284;21905.342839714813;22758.658620120692;22846.428839279026;22854.65718014229;22997.655035174485;23092.65361019586;23362.41593960152;24351;24515;24559.754402456016;6555.999999999988;6657.3675500827585;6750.426213771835;6755.1556055493065;6758.087658166159;6520.347965203466;6645.33546645334;6726.260111387744;6757.7972660820005;6761.154855643044;6776.932230677679;6783.287754785751;6783.830404239909;6786.219584747743;6786.660666966632;6752;6756.729730810786;6759.5606285591775;6764.289749576297;6766.357196066366;6094.634321940698;6302.747890084391;6311.52663550231;6337.683115844189;6340.936590634081;28016.579751303747;28467.430651386858;28545.28636784097;28553.428931421255;28576;1976.8023197680118;1999.57009243012;2001.629698505781;2005.6490114230098;2008.648486514854;18515.907420462947;18932.810671893243;18976.43070707881;19139;19358.903205484025;2471.4192164841247;2471.6910386201725;2500.7874330681734;2551.8979240830345;2557.271177714361;115341;120505.99999999913;128720;141809;144989;20843.791562084185;21501.78498215029;21900.576462530204;22018.339449816533;22082.779172208393;41881.79059104746;42061.94845128835;42079.158416831495;42122.36816447756;42620.3606945896;10926.617568385227;11098.334099954029;11115.722106947229;11293.774124517628;11400.885991139983;9355.391899526508;9361.953190234142;9406.1064198901;9425.151736343762;9504.524773761284;11262.549498020151;11308.434578271053;11452.713682157846;11456;11605.59380421698;3749.7937613430977;4008.8797336079965;4239.491261048694;4393.406890069864;4565.132624801344;951.9286053545874;955.1499165742495;962.2206013129388;972.1493693018608;978.4471773447979;18748.906255468635;18824.43449764226;18935.242590296508;19012.429627111207;19541.706874396896;1014.8680671512656;1025.3898930136556;1029.063552167524;1029.3103620574234;1045.2526443592867;10327.896721032694;10542.47287635615;10644.520996555173;10762.139028877671;10764.838527422095;495663;496060;511643;517815;523858;114905;115533;116994.41502792432;117331;118277.40861295638;1136.8749437561862;1147.2886810177743;1170.7424366639325;1173.2491205628405;1173.9119566032412;16911.661766764842;16926.746098808282;17112.743308850626;17119.48641540756;17209.311627534757;57736.71131644483;58465.70767146137;59468.405315946286;59687.40312596992;60151.39848601458;75160;75598;75678.24321756932;76104.61947690225;76451;19180.712289315394;19373;19483.12325945364;19528.21887124556;19676.60646787085;22056.779432205472;22108.88945555262;22118.33644990653;22121.225757098426;22456.775432246122;17662.91168544149;17764.378246761302;17842.5539361517;17945.820541794415;18234;15073.773893391388;16295.18524073768;16470.176491175152;16475.917620411823;16745.079020653982;17673.46979590563;17836.108194590477;17914.5521361967;17987.910060450136;18003.90998045054;18753.6249275011;18781.718274225623;18805.90597047061;18871.716924246422;18972.051397429797;17122.143892805558;17292;17374.39189628357;17546.91226543859;17566.297348105934 21:54:16 INFO - PID 6852 | |3;mootools.html;1334.8998825088117;1381.8618138186182;1387.694707164424;1390.8331000279968;1391.7773156294982;15134.318955646995;15797.36810527579;15816.604584885383;15837.445689400873;15838.524844254662;15534.300956456958;15629.765553516678;15692.13693246871;15708.293126809293;15767.053976761403;2767.5433553463654;2821.3228825081987;2857;2862.127051249368;2877.510823160068;2793.092245020366;2828.660560732715;2849.8860045598153;2867.6988916163814;2867.9283017924613;2776.6390369251967;2833.135893552466;2846.331112188634;2890.2774306423394;2896.681365049843;2822.139247529503;2874.6981566935483;2876.122782551321;2877.8129421587737;2882.6829048804616;2708.769754570864;2719.728027197284;2723.087765598527;2780.8748606312765;2789.135368035895;14801.185934773583;15041.247937603186;15064.774028389584;15101.622459438491;15112.39550417982;7906.288434040906;8312.792180195484;8325.125861784485;8328.417010809246;8329.08380078191;5424.487939877863;5446.21029950655;5554.416786237427;5613.635113717595;5614.887702245973;2016.052455345985;2020.919163233469;2036.8879711615855;2079.6984437256665;2081.552466219755;26406;27483.725162748317;27511;27547.724522754917;27563.862180688968;6658.267590565034;6960.12998375193;7230.56616602995;7482;7592.8861067084035;20850.270240541508;20860.26989055406;20881.26915557948;20909.163633454795;20917;8223.21879421454;8233.8353232935;8242.629081691339;8255.669773209125;8261.586920653943;7259.346658800733;7285.198628150899;7370.96314518424;7412.110546734426;7421.703131874772;5940.732667029994;5948.672822994777;5992.550558708114;6161.075838624242;6213.65824879636;1857.489190472604;1877.3147801052792;1880.3794747733216;1881.67070762616;1912.8289391540422;945.9858102128474;946.7396465971913;957.6025949231131;959.2613687460616;965.0783501755807;8139.715109971241;8153.551554664432;8270.545120018456;8540.572971351408;8548;731.2066407947331;734.9154847192534;739.9704011839574;740.2005833699592;756.9697212111454;5431.619786614978;5505.2564256305295;5550.500454959073;5590.748416321276;5645.125005624052;21127;21202.78797212039;22132;22156.113755449926;22157.66763498549;21101;21303;21303.36089917305;21370.145194192057;21389.35831925045;10499.267620842627;10797;10935.179861510418;11064;11070.612528561462;8360.74917752444;8559.828803424021;8579.957100214458;8600.053994060523;8645.4812711235;16981.405650802164;18220.635587287914;18230.544236393667;18284;18398.356057537923;16398.426055088014;17529.912350438168;18380.172892219616;19084.80915190886;19117.522061948006;12090.697732556757;12323.322217278135;12323.69190770238;12326.445309961253;12327.260364378166;13739.24434156091;13772.517961871286;13819.516316928859;13836.723265534834;13879;11231.887681123411;11521.366324852213;11573.942130289295;11658.358790266617;11782;10702.197335199735;10910.945445272722;10940.726481838017;10985.450727463434;11086.279391839505;10124.59501619927;10134.949325253327;10170;10215.080642742189;10260.076593106656;7375.225601311785;7402.555846649218;7489.026426564729;7524;7682.8079298018;7498.887516687145;7511.06111736033;7512.661930213044;7592.240775922363;7655.617219139132 21:54:16 INFO - PID 6852 | |4;prototype.html;508.3188527373319;536.0913252037795;539.0943215398132;540.1870185371016;544.1728572569693;6313.463355614773;6354.936450635492;6359.65021923794;6360.204974378203;6384.585001974869;6216.502679785618;6236.875262494747;6243.968780156104;6266.373362663743;6290.050084473816;4945.208766597345;5083.288339632436;5102.16322124035;5228.006678731048;5248.5276325130735;5069.391672999227;5075.746212689369;5112.207607820794;5114.43741188469;5117.411497677777;4964.975175124119;5022.472640372763;5065.468125846788;5089.440161582223;5109.233614957749;5002.323756790136;5009.549140577347;5044.805509603334;5093.261477085802;5113.386393632751;4600.677952543323;4616.930746038812;4628.560286772751;4629.328747331651;4641.396618439581;6215.906761398583;6221.035739460391;6261.154744109533;6312.621242725451;6337.144485494491;5728.169415434739;5750.281214848144;5760.53915686744;5796.420357964212;5796.97101514494;6561.3438656134485;6606.141201643755;6632.9336706633285;6640.203175618908;6644.202695676501;4951.282064100686;4963.156263435225;4980.103581355354;4980.601551875841;4981.808004478018;6572.605643661395;6653.800385988477;6811.489138314646;6875.384284693093;6906.827329316757;5008.924866127011;5031.647784655039;5042.42012168598;5064.265681476165;5077.822276220389;5103.897922041612;5123.874436593675;5124.256982737482;5127.333446651912;5154.355705536808;5670.659760414388;5704.486596206361;5736.852629474039;5754.6547207167705;5758.90580789657;6610.30591787865;6611.86776264472;6628;6654.26803051664;6707.463402927851;1786.5176402371287;1786.8213178682029;1792.6773180827577;1793.7668103146507;1795.1383335998532;1186.175607952482;1236.1347057060093;1238.5541205166132;1239.578543295266;1257.6101408563193;5746.626469279484;5768.500189950643;5787.421257874263;5792.8124734430185;5814.505767009767;6766.49251306154;6768.323167683291;6768.763093291711;6804.3195680432555;6812.386885180357;5736.110902810071;5744.167095771089;5748.275517344863;5749.13762935563;5750.884982300414;3542.929141417209;3564.7504674672523;3570.6786389225094;3571.3750093733493;3615.891523254254;6252.874942501216;6541.345865413516;6579.407853293226;6591.868162636721;6618.7021584028835;6761.898571521431;6791.777480053638;6815.352541508549;6841.110655614738;6911;6488.31872653374;6508.446782023581;6519.119918810995;6580.341965803382;6601.966990165019;6678.532502724763;6700.448762156065;6710.899336509859;6723.596584204964;6738.225104113089;6602.306757790363;6608.372204640552;6617.2721000688925;6628.83427914306;6764.594124352555;6552.508561857784;6589.80230593083;6591.242007169237;6599.769008084886;6624.138861947916;5123.231515272739;5138.405105421738;5146.176611742103;5152.716600587004;5152.819651312336;6521.478281737544;6708.832279192864;6718.630475323904;6795.626240556817;6847.315268473312;6482.384173503509;6541.182352205974;6560.147180866647;6564.6389448578875;6581.473482121323;6381.649009304533;6549.559096998652;6575.572587781779;6587.835304117435;6611.30581288977;6383.329750376143;6396.744130234739;6436.13112229843;6456.192975878015;6576.473882089517;6574.027791662577;6633.336666333328;6658.83352916181;6671.132752742113;6748.527603067738;6358.1734374531015;6379;6434.517411194086;6440.194975628046;6444.194475690539 21:54:16 INFO - PID 6852 | |5;yui.html;913.9223166030887;924.2975338742556;928.0441145620014;940.5767404667902;952.3333666433494;19562.608747825052;20320.491987700316;20344.287949921738;20401.387958361254;20423.795762042377;18710.906445467786;18744.718829217574;18774.155163017662;18783.812161878377;18914.337998170067;963.9421634701905;970.1268858027761;972.7373609125532;973.1290495006964;973.6738192705452;963.9373440726365;968.6270785747503;971.7910649210419;972.1202311907699;973.4986481961795;1007.4106647611156;1025.5436330832783;1034.7413146713322;1043.3166276089137;1046.6127532812832;1034.4930983817912;1035.3322107240788;1035.3425574760045;1035.3684252605904;1036.0364860679565;757.9772606821804;758.2909979169494;758.4577027425362;758.666186877772;758.9506682065648;19396.612067758564;19844.305449309206;19914.601707965903;19932.103055362542;20539.897300513552;22003;22068;22380.88809555958;22484.662730059063;22635.207767728214;17352.739708904377;17753.644927101384;17834.19746111428;17887.195076221473;17890.91054544732;3766.7174961877968;3801;3802.790846503441;3808.333541630231;3819.5607505136986;106399.46800265949;125883;142244;143138.56861431355;144859;17302.134893255537;17884.821151788576;17891.37380191687;17920.28318867257;17962.281508739765;31103.844480777905;31454.842725786224;31715;31743.365132697218;31846.840765796485;9071.501067441353;9236.26109911219;9282.071792820663;9352;9353.064693530729;4301.5698430156735;4370.409994650745;4377.715448495837;4386.342048692722;4386.385905973167;5385.246065550826;5490.368607610096;5491.615586908958;5495.752691128909;5513.807016754395;959.8512230604267;963.2823546457934;1102.9962733912103;1141.5947338694643;1149.9942500287445;679.6329981809866;688.0642326436043;696.1785093589613;699.3356311504092;700.989485157723;10981.835272470918;11132.276402033842;11441.599544015919;11480.425978701198;11687.649370518899;698.1203683359004;699.6396855619361;700.7897630710767;711.3739908880152;718.5114122396716;5230.267762513251;5240.554552863049;5283.841484755463;5284.656497327662;5298.152295632757;118401;120188;122537;125605.37197314137;126585.3670731659;107079.46460267804;107815;110287;110422;113978.43010784894;97992.51003744936;98333;98382;101403;101901.49049254855;11437.542498300307;11924.761504769682;11988.76022479563;12010.699732506757;12160.635180944586;46010.30984535302;46046.53953460423;46569;46673;46879;59376.40623593709;59778.70110649593;60077;60079;61941;18261.90869045646;18688.065596720382;18725.90637046806;18774.624507510045;18932.810671893105;20132.89933550323;20321.89839050795;20322.59354812925;20346.59306813885;20469.181232750525;16380.836191638407;16422.917885410974;16569.751453727964;16661.583460413585;16685.249163787415;17588;18378.356757513422;18479.72280415768;18515.722264166317;18563.25746970106;16578.253978570752;16743.24655390535;16789.496315110566;16855.24151413165;16949.152542373078;12806.743865122831;13001.089923705249;13079.673008174872;13215.66960825987;13516;13068.98181546797;13071.869281307065;13119.147255428366;13235.536756213487;13252.138610990254 21:54:16 INFO - PID 6852 | __end_tp_report 21:54:16 INFO - PID 6852 | __start_cc_report 21:54:16 INFO - PID 6852 | _x_x_mozilla_cycle_collect,259 21:54:16 INFO - PID 6852 | __end_cc_report 21:54:16 INFO - PID 6852 | __startTimestamp1506056056448__endTimestamp 21:54:16 INFO - PID 6852 | 21:54:16 INFO - PID 6852 | ------- Summary: start ------- 21:54:16 INFO - PID 6852 | Number of tests: 6 21:54:16 INFO - PID 6852 | 21:54:16 INFO - PID 6852 | [#0] dojo.html Cycles:165 Average:6173.52 Median:6452.35 stddev:854.44 (13.2%) stddev-sans-first:823.68 21:54:16 INFO - PID 6852 | Values: 3158.7 3159.1 3182.4 3185.0 3207.1 6170.2 6307.5 6312.5 6351.1 6394.9 6240.8 6281.5 6288.6 6299.7 6303.8 5733.6 5763.8 5860.1 5891.4 5957.8 5799.4 5872.6 5911.7 5912.9 5936.0 815.0 5645.0 5810.2 5881.1 5888.0 5284.1 5643.2 5767.9 5842.8 5853.9 5756.9 5766.7 5830.0 5840.7 5845.2 6215.3 6244.3 6367.1 6378.5 6385.0 6693.7 6733.0 6744.2 6807.5 6819.2 6651.9 6780.2 6804.1 6860.0 6879.8 6167.0 6169.0 6175.7 6176.4 6181.4 6730.4 6813.1 6813.2 6817.4 6831.9 6176.5 6453.5 6461.7 6531.2 6713.9 6833.8 6850.8 6930.0 6934.6 6939.8 6774.5 6797.9 6846.8 6854.5 6880.1 6595.2 6595.6 6670.6 6681.4 6806.1 5360.2 5371.9 5381.5 5385.6 5387.2 4590.3 4628.2 4670.1 4695.7 4710.8 5765.5 5782.0 5842.7 5846.2 5854.1 6589.7 6643.4 6643.8 6654.3 6755.3 5693.9 5701.8 5721.4 5727.5 5736.9 5680.1 5741.3 5742.2 5748.7 5753.8 6459.1 6488.9 6644.3 6656.5 6688.6 6754.7 6769.1 6831.4 6851.9 6856.3 6566.4 6586.8 6644.9 6653.9 6660.0 6549.6 6614.6 6644.7 6692.2 6705.4 6858.1 6873.2 6883.4 6897.2 6904.1 6557.7 6571.1 6632.4 6639.9 6652.5 6339.3 6436.8 6460.2 6570.9 6632.7 6418.7 6440.1 6448.9 6452.4 6483.2 6682.1 6707.0 6712.5 6716.8 6729.0 6379.5 6424.2 6490.8 6495.0 6495.3 21:54:16 INFO - PID 6852 | 21:54:16 INFO - PID 6852 | [#1] ext.html Cycles:180 Average:38291.19 Median:36512.50 stddev:53999.86 (147.9%) stddev-sans-first:54078.16 21:54:16 INFO - PID 6852 | Values: 850.2 878.6 879.2 880.2 881.8 39152.6 43181.0 43264.8 43311.4 43364.3 38958.8 39328.6 39408.0 39429.2 39446.0 7237.8 7368.3 8026.6 8184.7 8207.7 7961.6 8072.2 8080.5 8095.2 8095.6 8026.6 8137.9 8148.6 8149.2 8152.1 8075.2 8114.4 8118.8 8129.8 8145.3 8077.7 8107.8 8118.2 8120.8 8123.5 38089.8 38133.4 38204.8 38232.0 38247.4 3524.8 3530.4 3533.4 3534.2 3534.4 31351.1 31477.8 31487.7 31520.2 31553.7 5152.4 5164.3 5180.8 5194.1 5210.8 190202.0 190625.0 190783.0 190825.0 191118.0 43332.1 44080.3 50324.7 50429.7 50475.0 51962.7 52924.5 53223.5 53348.7 53361.7 16137.1 16225.8 16271.9 16275.3 16301.3 13083.5 13170.1 13174.8 13211.7 13223.0 14538.3 14552.2 14747.6 14797.4 14865.6 5875.5 5964.1 6020.0 6048.2 6054.1 994.3 1006.4 1008.1 1009.6 1014.1 22929.9 23296.5 23522.6 23564.5 23711.4 1091.5 1114.1 1121.2 1125.5 1133.8 12224.2 12310.6 12365.7 12380.9 12433.3 235734.0 236853.0 237053.0 237464.0 237541.0 53770.0 54177.5 54330.2 54377.7 54657.7 1422.8 1444.5 1448.8 1455.8 1456.5 22292.6 22346.4 22687.1 22752.9 23190.9 36949.3 37249.3 37252.8 37293.3 37418.6 194013.0 194328.0 194499.0 194517.0 196272.0 34746.1 36230.0 36795.0 36884.0 36998.3 46926.5 47230.1 47741.5 47757.8 48062.3 34134.5 34504.7 34811.7 34841.7 35062.8 33633.8 33970.7 34404.7 34435.8 34924.3 39252.2 39470.8 39520.4 39639.4 39643.4 32950.0 33204.7 33326.0 33666.5 34020.7 24483.0 24494.0 24689.1 25268.7 25380.9 21:54:16 INFO - PID 6852 | 21:54:16 INFO - PID 6852 | [#2] jquery.html Cycles:180 Average:36189.06 Median:22069.78 stddev:85271.70 (386.4%) stddev-sans-first:85468.96 21:54:16 INFO - PID 6852 | Values: 568.0 568.5 579.1 589.9 607.6 21905.3 22758.7 22846.4 22854.7 22997.7 23092.7 23362.4 24351.0 24515.0 24559.8 6556.0 6657.4 6750.4 6755.2 6758.1 6520.3 6645.3 6726.3 6757.8 6761.2 6776.9 6783.3 6783.8 6786.2 6786.7 6752.0 6756.7 6759.6 6764.3 6766.4 6094.6 6302.7 6311.5 6337.7 6340.9 28016.6 28467.4 28545.3 28553.4 28576.0 1976.8 1999.6 2001.6 2005.6 2008.6 18515.9 18932.8 18976.4 19139.0 19358.9 2471.4 2471.7 2500.8 2551.9 2557.3 115341.0 120506.0 128720.0 141809.0 144989.0 20843.8 21501.8 21900.6 22018.3 22082.8 41881.8 42061.9 42079.2 42122.4 42620.4 10926.6 11098.3 11115.7 11293.8 11400.9 9355.4 9362.0 9406.1 9425.2 9504.5 11262.5 11308.4 11452.7 11456.0 11605.6 3749.8 4008.9 4239.5 4393.4 4565.1 951.9 955.1 962.2 972.1 978.4 18748.9 18824.4 18935.2 19012.4 19541.7 1014.9 1025.4 1029.1 1029.3 1045.3 10327.9 10542.5 10644.5 10762.1 10764.8 495663.0 496060.0 511643.0 517815.0 523858.0 114905.0 115533.0 116994.4 117331.0 118277.4 1136.9 1147.3 1170.7 1173.2 1173.9 16911.7 16926.7 17112.7 17119.5 17209.3 57736.7 58465.7 59468.4 59687.4 60151.4 75160.0 75598.0 75678.2 76104.6 76451.0 19180.7 19373.0 19483.1 19528.2 19676.6 22056.8 22108.9 22118.3 22121.2 22456.8 17662.9 17764.4 17842.6 17945.8 18234.0 15073.8 16295.2 16470.2 16475.9 16745.1 17673.5 17836.1 17914.6 17987.9 18003.9 18753.6 18781.7 18805.9 18871.7 18972.1 17122.1 17292.0 17374.4 17546.9 17566.3 21:54:16 INFO - PID 6852 | 21:54:16 INFO - PID 6852 | [#3] mootools.html Cycles:180 Average:9571.37 Median:27529.36 stddev:6777.76 (24.6%) stddev-sans-first:6768.52 21:54:16 INFO - PID 6852 | Values: 1334.9 1381.9 1387.7 1390.8 1391.8 15134.3 15797.4 15816.6 15837.4 15838.5 15534.3 15629.8 15692.1 15708.3 15767.1 2767.5 2821.3 2857.0 2862.1 2877.5 2793.1 2828.7 2849.9 2867.7 2867.9 2776.6 2833.1 2846.3 2890.3 2896.7 2822.1 2874.7 2876.1 2877.8 2882.7 2708.8 2719.7 2723.1 2780.9 2789.1 14801.2 15041.2 15064.8 15101.6 15112.4 7906.3 8312.8 8325.1 8328.4 8329.1 5424.5 5446.2 5554.4 5613.6 5614.9 2016.1 2020.9 2036.9 2079.7 2081.6 26406.0 27483.7 27511.0 27547.7 27563.9 6658.3 6960.1 7230.6 7482.0 7592.9 20850.3 20860.3 20881.3 20909.2 20917.0 8223.2 8233.8 8242.6 8255.7 8261.6 7259.3 7285.2 7371.0 7412.1 7421.7 5940.7 5948.7 5992.6 6161.1 6213.7 1857.5 1877.3 1880.4 1881.7 1912.8 946.0 946.7 957.6 959.3 965.1 8139.7 8153.6 8270.5 8540.6 8548.0 731.2 734.9 740.0 740.2 757.0 5431.6 5505.3 5550.5 5590.7 5645.1 21127.0 21202.8 22132.0 22156.1 22157.7 21101.0 21303.0 21303.4 21370.1 21389.4 10499.3 10797.0 10935.2 11064.0 11070.6 8360.7 8559.8 8580.0 8600.1 8645.5 16981.4 18220.6 18230.5 18284.0 18398.4 16398.4 17529.9 18380.2 19084.8 19117.5 12090.7 12323.3 12323.7 12326.4 12327.3 13739.2 13772.5 13819.5 13836.7 13879.0 11231.9 11521.4 11573.9 11658.4 11782.0 10702.2 10910.9 10940.7 10985.5 11086.3 10124.6 10134.9 10170.0 10215.1 10260.1 7375.2 7402.6 7489.0 7524.0 7682.8 7498.9 7511.1 7512.7 7592.2 7655.6 21:54:16 INFO - PID 6852 | 21:54:16 INFO - PID 6852 | [#4] prototype.html Cycles:180 Average:5561.47 Median:6257.01 stddev:1541.46 (24.6%) stddev-sans-first:1498.39 21:54:16 INFO - PID 6852 | Values: 508.3 536.1 539.1 540.2 544.2 6313.5 6354.9 6359.7 6360.2 6384.6 6216.5 6236.9 6244.0 6266.4 6290.1 4945.2 5083.3 5102.2 5228.0 5248.5 5069.4 5075.7 5112.2 5114.4 5117.4 4965.0 5022.5 5065.5 5089.4 5109.2 5002.3 5009.5 5044.8 5093.3 5113.4 4600.7 4616.9 4628.6 4629.3 4641.4 6215.9 6221.0 6261.2 6312.6 6337.1 5728.2 5750.3 5760.5 5796.4 5797.0 6561.3 6606.1 6632.9 6640.2 6644.2 4951.3 4963.2 4980.1 4980.6 4981.8 6572.6 6653.8 6811.5 6875.4 6906.8 5008.9 5031.6 5042.4 5064.3 5077.8 5103.9 5123.9 5124.3 5127.3 5154.4 5670.7 5704.5 5736.9 5754.7 5758.9 6610.3 6611.9 6628.0 6654.3 6707.5 1786.5 1786.8 1792.7 1793.8 1795.1 1186.2 1236.1 1238.6 1239.6 1257.6 5746.6 5768.5 5787.4 5792.8 5814.5 6766.5 6768.3 6768.8 6804.3 6812.4 5736.1 5744.2 5748.3 5749.1 5750.9 3542.9 3564.8 3570.7 3571.4 3615.9 6252.9 6541.3 6579.4 6591.9 6618.7 6761.9 6791.8 6815.4 6841.1 6911.0 6488.3 6508.4 6519.1 6580.3 6602.0 6678.5 6700.4 6710.9 6723.6 6738.2 6602.3 6608.4 6617.3 6628.8 6764.6 6552.5 6589.8 6591.2 6599.8 6624.1 5123.2 5138.4 5146.2 5152.7 5152.8 6521.5 6708.8 6718.6 6795.6 6847.3 6482.4 6541.2 6560.1 6564.6 6581.5 6381.6 6549.6 6575.6 6587.8 6611.3 6383.3 6396.7 6436.1 6456.2 6576.5 6574.0 6633.3 6658.8 6671.1 6748.5 6358.2 6379.0 6434.5 6440.2 6444.2 21:54:16 INFO - PID 6852 | 21:54:16 INFO - PID 6852 | [#5] yui.html Cycles:180 Average:24894.27 Median:20226.70 stddev:35080.31 (173.4%) stddev-sans-first:35132.51 21:54:16 INFO - PID 6852 | Values: 913.9 924.3 928.0 940.6 952.3 19562.6 20320.5 20344.3 20401.4 20423.8 18710.9 18744.7 18774.2 18783.8 18914.3 963.9 970.1 972.7 973.1 973.7 963.9 968.6 971.8 972.1 973.5 1007.4 1025.5 1034.7 1043.3 1046.6 1034.5 1035.3 1035.3 1035.4 1036.0 758.0 758.3 758.5 758.7 759.0 19396.6 19844.3 19914.6 19932.1 20539.9 22003.0 22068.0 22380.9 22484.7 22635.2 17352.7 17753.6 17834.2 17887.2 17890.9 3766.7 3801.0 3802.8 3808.3 3819.6 106399.5 125883.0 142244.0 143138.6 144859.0 17302.1 17884.8 17891.4 17920.3 17962.3 31103.8 31454.8 31715.0 31743.4 31846.8 9071.5 9236.3 9282.1 9352.0 9353.1 4301.6 4370.4 4377.7 4386.3 4386.4 5385.2 5490.4 5491.6 5495.8 5513.8 959.9 963.3 1103.0 1141.6 1150.0 679.6 688.1 696.2 699.3 701.0 10981.8 11132.3 11441.6 11480.4 11687.6 698.1 699.6 700.8 711.4 718.5 5230.3 5240.6 5283.8 5284.7 5298.2 118401.0 120188.0 122537.0 125605.4 126585.4 107079.5 107815.0 110287.0 110422.0 113978.4 97992.5 98333.0 98382.0 101403.0 101901.5 11437.5 11924.8 11988.8 12010.7 12160.6 46010.3 46046.5 46569.0 46673.0 46879.0 59376.4 59778.7 60077.0 60079.0 61941.0 18261.9 18688.1 18725.9 18774.6 18932.8 20132.9 20321.9 20322.6 20346.6 20469.2 16380.8 16422.9 16569.8 16661.6 16685.2 17588.0 18378.4 18479.7 18515.7 18563.3 16578.3 16743.2 16789.5 16855.2 16949.2 12806.7 13001.1 13079.7 13215.7 13516.0 13069.0 13071.9 13119.1 13235.5 13252.1 21:54:16 INFO - PID 6852 | -------- Summary: end -------- 21:54:16 INFO - PID 6852 | 21:54:17 INFO - TEST-INFO | 6852: exit 0 21:54:17 INFO - TEST-OK | dromaeo_css | took 1109712ms 21:54:17 INFO - TEST-START | kraken 21:54:17 INFO - Initialising browser for kraken test... 21:54:17 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:33960/getInfo.html -profile /tmp/tmpwK5ZBy/profile 21:54:17 INFO - TEST-INFO | started process 7215 (/builds/slave/test/build/application/firefox/firefox http://localhost:33960/getInfo.html) 21:54:23 INFO - TEST-INFO | 7215: exit 0 21:54:23 INFO - Browser initialized. 21:54:23 INFO - Running cycle 1/1 for kraken test... 21:54:23 INFO - Using env: {'DISPLAY': ':0', 21:54:23 INFO - 'HOME': '/home/cltbld', 21:54:23 INFO - 'JSGC_DISABLE_POISONING': '1', 21:54:23 INFO - 'LANG': 'en_US.UTF-8', 21:54:23 INFO - 'LANGUAGE': 'en_US:en', 21:54:23 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 21:54:23 INFO - 'LOGNAME': 'cltbld', 21:54:23 INFO - 'MAIL': '/var/mail/cltbld', 21:54:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:54:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:54:23 INFO - 'MOZ_CRASHREPORTER': '1', 21:54:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:54:23 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 21:54:23 INFO - 'MOZ_NO_REMOTE': '1', 21:54:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:54:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:54:23 INFO - 'NO_EM_RESTART': '1', 21:54:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:54:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:54:23 INFO - 'PWD': '/builds/slave/test', 21:54:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:54:23 INFO - 'RUST_BACKTRACE': 'full', 21:54:23 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 21:54:23 INFO - 'SHELL': '/bin/bash', 21:54:23 INFO - 'SHLVL': '1', 21:54:23 INFO - 'STYLO_FORCE_DISABLED': '1', 21:54:23 INFO - 'TERM': 'linux', 21:54:23 INFO - 'TMOUT': '86400', 21:54:23 INFO - 'USER': 'cltbld', 21:54:23 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1506053532.50547-1962975423', 21:54:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:54:23 INFO - '_': '/tools/buildbot/bin/python'} 21:54:23 INFO - TEST-INFO | started process 7449 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwK5ZBy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 21:54:24 INFO - PID 7449 | 21:54:24 INFO - PID 7449 | (/builds/slave/test/build/application/firefox/firefox:7498): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 21:54:24 INFO - PID 7449 | 21:54:34 INFO - PID 7449 | RSS: Main: 154931200 21:54:34 INFO - PID 7449 | 21:54:37 INFO - PID 7449 | Cycle 1(1): loaded http://localhost:33960/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33960/tests/kraken/driver.html?testName=audio-beat-detection) 21:54:37 INFO - PID 7449 | RSS: Main: 160927744 21:54:37 INFO - PID 7449 | 21:54:40 INFO - PID 7449 | Cycle 1(1): loaded http://localhost:33960/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33960/tests/kraken/driver.html?testName=audio-dft) 21:54:41 INFO - PID 7449 | RSS: Main: 161513472 21:54:41 INFO - PID 7449 | 21:54:44 INFO - PID 7449 | Cycle 1(1): loaded http://localhost:33960/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33960/tests/kraken/driver.html?testName=audio-fft) 21:54:44 INFO - PID 7449 | RSS: Main: 157585408 21:54:44 INFO - PID 7449 | 21:54:46 INFO - PID 7449 | Cycle 1(1): loaded http://localhost:33960/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33960/tests/kraken/driver.html?testName=audio-oscillator) 21:54:47 INFO - PID 7449 | RSS: Main: 158126080 21:54:47 INFO - PID 7449 | 21:54:49 INFO - PID 7449 | Cycle 1(1): loaded http://localhost:33960/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33960/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:54:50 INFO - PID 7449 | RSS: Main: 158248960 21:54:50 INFO - PID 7449 | 21:54:53 INFO - PID 7449 | Cycle 1(1): loaded http://localhost:33960/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33960/tests/kraken/driver.html?testName=imaging-darkroom) 21:54:53 INFO - PID 7449 | RSS: Main: 160567296 21:54:53 INFO - PID 7449 | 21:54:57 INFO - PID 7449 | Cycle 1(1): loaded http://localhost:33960/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33960/tests/kraken/driver.html?testName=imaging-desaturate) 21:54:58 INFO - PID 7449 | RSS: Main: 160641024 21:54:58 INFO - PID 7449 | 21:55:01 INFO - PID 7449 | Cycle 1(1): loaded http://localhost:33960/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33960/tests/kraken/driver.html?testName=json-parse-financial) 21:55:01 INFO - PID 7449 | RSS: Main: 160698368 21:55:01 INFO - PID 7449 | 21:55:03 INFO - PID 7449 | Cycle 1(1): loaded http://localhost:33960/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33960/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:55:04 INFO - PID 7449 | RSS: Main: 160669696 21:55:04 INFO - PID 7449 | 21:55:05 INFO - PID 7449 | Cycle 1(1): loaded http://localhost:33960/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33960/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:55:06 INFO - PID 7449 | RSS: Main: 160776192 21:55:06 INFO - PID 7449 | 21:55:08 INFO - PID 7449 | Cycle 1(1): loaded http://localhost:33960/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33960/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:55:09 INFO - PID 7449 | RSS: Main: 157642752 21:55:09 INFO - PID 7449 | 21:55:11 INFO - PID 7449 | Cycle 1(1): loaded http://localhost:33960/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33960/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:55:12 INFO - PID 7449 | RSS: Main: 157982720 21:55:12 INFO - PID 7449 | 21:55:15 INFO - PID 7449 | Cycle 1(1): loaded http://localhost:33960/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33960/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:55:15 INFO - PID 7449 | RSS: Main: 157601792 21:55:15 INFO - PID 7449 | 21:55:17 INFO - PID 7449 | Cycle 1(1): loaded http://localhost:33960/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33960/tests/kraken/driver.html?testName=ai-astar) 21:55:17 INFO - PID 7449 | RSS: Main: 159674368 21:55:17 INFO - PID 7449 | 21:55:17 INFO - PID 7449 | __start_tp_report 21:55:17 INFO - PID 7449 | _x_x_mozilla_page_load 21:55:17 INFO - PID 7449 | _x_x_mozilla_page_load_details 21:55:17 INFO - PID 7449 | |i|pagename|runs| 21:55:17 INFO - PID 7449 | |0;ai-astar;105;105;105;108;106;110;107;106;106;106 21:55:17 INFO - PID 7449 | |1;audio-beat-detection;116;125;116;117;118;119;120;116;117;140 21:55:17 INFO - PID 7449 | |2;audio-dft;163;161;162;163;163;163;166;165;164;170 21:55:17 INFO - PID 7449 | |3;audio-fft;82;74;73;74;74;74;75;81;74;75 21:55:17 INFO - PID 7449 | |4;audio-oscillator;80;78;77;77;79;78;79;78;78;78 21:55:17 INFO - PID 7449 | |5;imaging-gaussian-blur;114;113;113;113;114;114;115;110;114;114 21:55:17 INFO - PID 7449 | |6;imaging-darkroom;155;148;148;148;148;156;149;149;151;149 21:55:17 INFO - PID 7449 | |7;imaging-desaturate;101;94;95;100;99;94;94;93;94;93 21:55:17 INFO - PID 7449 | |8;json-parse-financial;52;52;53;53;54;52;54;53;57;53 21:55:17 INFO - PID 7449 | |9;json-stringify-tinderbox;38;38;38;38;38;38;38;38;39;38 21:55:17 INFO - PID 7449 | |10;stanford-crypto-aes;73;75;73;80;74;74;72;73;71;71 21:55:17 INFO - PID 7449 | |11;stanford-crypto-ccm;110;117;113;108;121;114;120;110;118;111 21:55:17 INFO - PID 7449 | |12;stanford-crypto-pbkdf2;172;178;176;164;166;174;170;169;172;174 21:55:17 INFO - PID 7449 | |13;stanford-crypto-sha256-iterative;65;65;64;64;62;65;66;64;65;63 21:55:17 INFO - PID 7449 | __end_tp_report 21:55:17 INFO - PID 7449 | __start_cc_report 21:55:17 INFO - PID 7449 | _x_x_mozilla_cycle_collect,722 21:55:17 INFO - PID 7449 | __end_cc_report 21:55:17 INFO - PID 7449 | __startTimestamp1506056117863__endTimestamp 21:55:17 INFO - PID 7449 | 21:55:17 INFO - PID 7449 | ------- Summary: start ------- 21:55:17 INFO - PID 7449 | Number of tests: 14 21:55:17 INFO - PID 7449 | 21:55:17 INFO - PID 7449 | [#0] ai-astar Cycles:10 Average:106.40 Median:106.00 stddev:1.58 (1.5%) stddev-sans-first:1.59 21:55:17 INFO - PID 7449 | Values: 105.0 105.0 105.0 108.0 106.0 110.0 107.0 106.0 106.0 106.0 21:55:17 INFO - PID 7449 | 21:55:17 INFO - PID 7449 | [#1] audio-beat-detection Cycles:10 Average:120.40 Median:118.50 stddev:7.41 (6.3%) stddev-sans-first:7.69 21:55:17 INFO - PID 7449 | Values: 116.0 125.0 116.0 117.0 118.0 119.0 120.0 116.0 117.0 140.0 21:55:17 INFO - PID 7449 | 21:55:17 INFO - PID 7449 | [#2] audio-dft Cycles:10 Average:164.00 Median:163.50 stddev:2.54 (1.6%) stddev-sans-first:2.67 21:55:17 INFO - PID 7449 | Values: 163.0 161.0 162.0 163.0 163.0 163.0 166.0 165.0 164.0 170.0 21:55:17 INFO - PID 7449 | 21:55:17 INFO - PID 7449 | [#3] audio-fft Cycles:10 Average:75.60 Median:74.50 stddev:3.17 (4.3%) stddev-sans-first:2.37 21:55:17 INFO - PID 7449 | Values: 82.0 74.0 73.0 74.0 74.0 74.0 75.0 81.0 74.0 75.0 21:55:17 INFO - PID 7449 | 21:55:17 INFO - PID 7449 | [#4] audio-oscillator Cycles:10 Average:78.20 Median:78.00 stddev:0.92 (1.2%) stddev-sans-first:0.71 21:55:17 INFO - PID 7449 | Values: 80.0 78.0 77.0 77.0 79.0 78.0 79.0 78.0 78.0 78.0 21:55:17 INFO - PID 7449 | 21:55:17 INFO - PID 7449 | [#5] imaging-gaussian-blur Cycles:10 Average:113.40 Median:114.00 stddev:1.35 (1.2%) stddev-sans-first:1.41 21:55:17 INFO - PID 7449 | Values: 114.0 113.0 113.0 113.0 114.0 114.0 115.0 110.0 114.0 114.0 21:55:17 INFO - PID 7449 | 21:55:17 INFO - PID 7449 | [#6] imaging-darkroom Cycles:10 Average:150.10 Median:149.00 stddev:3.00 (2.0%) stddev-sans-first:2.60 21:55:17 INFO - PID 7449 | Values: 155.0 148.0 148.0 148.0 148.0 156.0 149.0 149.0 151.0 149.0 21:55:17 INFO - PID 7449 | 21:55:17 INFO - PID 7449 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:94.00 stddev:3.06 (3.3%) stddev-sans-first:2.57 21:55:17 INFO - PID 7449 | Values: 101.0 94.0 95.0 100.0 99.0 94.0 94.0 93.0 94.0 93.0 21:55:17 INFO - PID 7449 | 21:55:17 INFO - PID 7449 | [#8] json-parse-financial Cycles:10 Average:53.30 Median:53.00 stddev:1.49 (2.8%) stddev-sans-first:1.51 21:55:17 INFO - PID 7449 | Values: 52.0 52.0 53.0 53.0 54.0 52.0 54.0 53.0 57.0 53.0 21:55:17 INFO - PID 7449 | 21:55:17 INFO - PID 7449 | [#9] json-stringify-tinderbox Cycles:10 Average:38.10 Median:38.00 stddev:0.32 (0.8%) stddev-sans-first:0.33 21:55:17 INFO - PID 7449 | Values: 38.0 38.0 38.0 38.0 38.0 38.0 38.0 38.0 39.0 38.0 21:55:17 INFO - PID 7449 | 21:55:17 INFO - PID 7449 | [#10] stanford-crypto-aes Cycles:10 Average:73.60 Median:73.50 stddev:2.59 (3.5%) stddev-sans-first:2.74 21:55:17 INFO - PID 7449 | Values: 73.0 75.0 73.0 80.0 74.0 74.0 72.0 73.0 71.0 71.0 21:55:17 INFO - PID 7449 | 21:55:17 INFO - PID 7449 | [#11] stanford-crypto-ccm Cycles:10 Average:114.20 Median:115.50 stddev:4.57 (4.0%) stddev-sans-first:4.58 21:55:17 INFO - PID 7449 | Values: 110.0 117.0 113.0 108.0 121.0 114.0 120.0 110.0 118.0 111.0 21:55:17 INFO - PID 7449 | 21:55:17 INFO - PID 7449 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.50 Median:173.00 stddev:4.35 (2.5%) stddev-sans-first:4.61 21:55:17 INFO - PID 7449 | Values: 172.0 178.0 176.0 164.0 166.0 174.0 170.0 169.0 172.0 174.0 21:55:17 INFO - PID 7449 | 21:55:17 INFO - PID 7449 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.30 Median:65.00 stddev:1.16 (1.8%) stddev-sans-first:1.20 21:55:17 INFO - PID 7449 | Values: 65.0 65.0 64.0 64.0 62.0 65.0 66.0 64.0 65.0 63.0 21:55:17 INFO - PID 7449 | -------- Summary: end -------- 21:55:17 INFO - PID 7449 | 21:55:18 INFO - PID 7449 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 21:55:18 INFO - TEST-INFO | 7449: exit 0 21:55:18 INFO - TEST-OK | kraken | took 61426ms 21:55:18 INFO - SUITE-END | took 1171s 21:55:19 INFO - Completed test suite (00:19:31) 21:55:19 INFO - javascript benchmark 21:55:19 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8730.899512910159, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3158.731507821835, 3159.09965659787, 3182.395344884472, 3185.0285662872816, 3207.118042538303, 6170.228721409824, 6307.495400367971, 6312.526560507963, 6351.079093531441, 6394.9448341023735, 6240.812775616728, 6281.528885333595, 6288.622682639033, 6299.685015749217, 6303.810885673437, 5733.569982251337, 5763.798267060653, 5860.09168578871, 5891.381404952483, 5957.821265362046, 5799.362070172298, 5872.618279811799, 5911.704414779244, 5912.88174236515, 5935.9703201483935, 815.0218952874583, 5645.0, 5810.15752715856, 5881.088431293135, 5888.0, 5284.0679531331125, 5643.1535269709875, 5767.913481297784, 5842.766289348421, 5853.882922341572, 5756.913646295309, 5766.654000759926, 5830.0, 5840.678762668052, 5845.2401187845735, 6215.28524219716, 6244.281907580641, 6367.07677386781, 6378.4578310843635, 6385.0, 6693.732250710014, 6732.966335168293, 6744.190697116328, 6807.455403567703, 6819.215790184143, 6651.86696266072, 6780.186377634666, 6804.08144900437, 6859.965700171517, 6879.793606191773, 6167.0, 6169.0, 6175.66033868137, 6176.4441200292185, 6181.3509581493745, 6730.427913627299, 6813.080234168324, 6813.182418109858, 6817.352351526597, 6831.863362732717, 6176.505879529627, 6453.515986301046, 6461.709223084972, 6531.216254049449, 6713.932860671331, 6833.794986150423, 6850.760223392257, 6929.965350173217, 6934.583924964418, 6939.757108501179, 6774.491913106537, 6797.898031529531, 6846.760363387258, 6854.451643868479, 6880.071190389333, 6595.241547222035, 6595.571287866273, 6670.633115178614, 6681.365270299314, 6806.149231346082, 5360.222767698662, 5371.919421208685, 5381.515663590296, 5385.596080293915, 5387.218853266333, 4590.265557510782, 4628.190066738307, 4670.089332580114, 4695.741734204583, 4710.764461776897, 5765.538756899438, 5782.0, 5842.737076831468, 5846.152307915413, 5854.063349864001, 6589.703463344065, 6643.40209381158, 6643.7674681385915, 6654.334566543307, 6755.256921738604, 5693.914591281134, 5701.828945131652, 5721.370649228582, 5727.4845263926445, 5736.856578585569, 5680.062789639664, 5741.253637027244, 5742.196092546963, 5748.741306641211, 5753.798617048467, 6459.09572659828, 6488.902666459912, 6644.335566443317, 6656.500762442836, 6688.565243259172, 6754.6622668865375, 6769.086173366532, 6831.385175334244, 6851.931480685129, 6856.314368563104, 6566.376194261537, 6586.769463068769, 6644.90032649501, 6653.933460665331, 6659.966700166468, 6549.574277671936, 6614.6361950093205, 6644.667766611747, 6692.196936367667, 6705.396514313735, 6858.142732158481, 6873.243943166148, 6883.414909732529, 6897.206821215625, 6904.102466679299, 6557.737690492327, 6571.145751052524, 6632.403083722488, 6639.933600664125, 6652.501062420241, 6339.334369891095, 6436.8390790230615, 6460.160179176865, 6570.868582628416, 6632.668366581748, 6418.743250269937, 6440.066190402272, 6448.871022579616, 6452.354764523698, 6483.189601299838, 6682.064510968566, 6706.966465167839, 6712.49656275791, 6716.798496045127, 6729.024291477806, 6379.4896408286295, 6424.229092508929, 6490.837729056811, 6494.967525162344, 6495.317991611002], "value": 6112.302086819424, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [850.2432834777047, 878.6441491196068, 879.2043200903183, 880.1946219209419, 881.8192270584527, 39152.60847391525, 43181.0, 43264.78367608158, 43311.350329745, 43364.349534757006, 38958.80520597393, 39328.60671393285, 39408.0, 39429.211415771664, 39446.0, 7237.782866514, 7368.300011498899, 8026.598670066503, 8184.672613095469, 8207.671693132268, 7961.60191990401, 8072.152423995454, 8080.474769139987, 8095.150009249032, 8095.554744489051, 8026.558539280337, 8137.877931831027, 8148.6333115009675, 8149.185081491863, 8152.103268640445, 8075.152109028556, 8114.391420643446, 8118.797030074236, 8129.837403251961, 8145.266925976632, 8077.717279895234, 8107.797305067362, 8118.188181181894, 8120.796980075486, 8123.512589244605, 38089.80955095235, 38133.427998580046, 38204.80897595522, 38232.0, 38247.4262886057, 3524.7708898921746, 3530.4174811156126, 3533.3639944809925, 3534.169470174507, 3534.3814832404228, 31351.05946821599, 31477.84261078703, 31487.685123148705, 31520.211994700087, 31553.684463155303, 5152.407473140599, 5164.2770012198325, 5180.792768289264, 5194.065068287707, 5210.76551555181, 190202.04898975554, 190625.0, 190783.0460847701, 190825.0, 191118.0, 43332.13335733268, 44080.338794918105, 50324.74837625862, 50429.74785126051, 50475.0, 51962.740186298826, 52924.47075529272, 53223.467765322624, 53348.73325633347, 53361.7331913338, 16137.112458814878, 16225.756613650805, 16271.918640406722, 16275.267612957208, 16301.266443009856, 13083.476660933457, 13170.078094533483, 13174.802377964339, 13211.66970825737, 13223.0, 14538.27308634564, 14552.199629020506, 14747.55757327282, 14797.408103675947, 14865.628359291104, 5875.529957603381, 5964.135200395918, 6019.969900150471, 6048.183495228088, 6054.122152287893, 994.3188915592842, 1006.3961623026125, 1008.1430783833682, 1009.6314845081492, 1014.0974532665933, 22929.88535057314, 23296.534069318517, 23522.64716029261, 23564.528709425715, 23711.407214819767, 1091.5088210305394, 1114.0641860836774, 1121.243160866412, 1125.5497800879714, 1133.7959167349957, 12224.205426647239, 12310.630681079581, 12365.690857728448, 12380.876191238152, 12433.254004759743, 235734.0, 236853.0, 237053.0, 237464.0, 237541.0, 53770.0, 54177.45822541724, 54330.185047224324, 54377.72811135998, 54657.72671136619, 1422.7652437347722, 1444.530527578541, 1448.7971683964254, 1455.8325792533994, 1456.4829485532696, 22292.554148917254, 22346.441338966655, 22687.092516299163, 22752.886235568716, 23190.88404558034, 36949.261014780095, 37249.255014899005, 37252.813735931144, 37293.254134916606, 37418.62581374151, 194013.0, 194328.0, 194499.0, 194517.0, 196272.0, 34746.13134671653, 36230.0, 36795.0, 36884.0, 36998.260034798615, 46926.53073469221, 47230.05539889114, 47741.52258477371, 47757.76121119372, 48062.27906581334, 34134.487982679784, 34504.65495345015, 34811.65188348084, 34841.651583484854, 35062.82468587641, 33633.83183084069, 33970.66029339675, 34404.655953440146, 34435.827820861734, 34924.30151397009, 39252.214955700154, 39470.80264598659, 39520.40719389154, 39639.40540891947, 39643.405348920365, 32950.0, 33204.66795332112, 33326.0, 33666.49500257547, 34020.65979340175, 24483.0, 24494.0, 24689.06218756292, 25268.74731252664, 25380.873095634404], "value": 17577.08087246636, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [567.9549628683222, 568.5139205978888, 579.1168468086169, 589.8525368657836, 607.5625549604284, 21905.342839714813, 22758.658620120692, 22846.428839279026, 22854.65718014229, 22997.655035174485, 23092.65361019586, 23362.41593960152, 24351.0, 24515.0, 24559.754402456016, 6555.999999999988, 6657.3675500827585, 6750.426213771835, 6755.1556055493065, 6758.087658166159, 6520.347965203466, 6645.33546645334, 6726.260111387744, 6757.7972660820005, 6761.154855643044, 6776.932230677679, 6783.287754785751, 6783.830404239909, 6786.219584747743, 6786.660666966632, 6752.0, 6756.729730810786, 6759.5606285591775, 6764.289749576297, 6766.357196066366, 6094.634321940698, 6302.747890084391, 6311.52663550231, 6337.683115844189, 6340.936590634081, 28016.579751303747, 28467.430651386858, 28545.28636784097, 28553.428931421255, 28576.0, 1976.8023197680118, 1999.57009243012, 2001.629698505781, 2005.6490114230098, 2008.648486514854, 18515.907420462947, 18932.810671893243, 18976.43070707881, 19139.0, 19358.903205484025, 2471.4192164841247, 2471.6910386201725, 2500.7874330681734, 2551.8979240830345, 2557.271177714361, 115341.0, 120505.99999999913, 128720.0, 141809.0, 144989.0, 20843.791562084185, 21501.78498215029, 21900.576462530204, 22018.339449816533, 22082.779172208393, 41881.79059104746, 42061.94845128835, 42079.158416831495, 42122.36816447756, 42620.3606945896, 10926.617568385227, 11098.334099954029, 11115.722106947229, 11293.774124517628, 11400.885991139983, 9355.391899526508, 9361.953190234142, 9406.1064198901, 9425.151736343762, 9504.524773761284, 11262.549498020151, 11308.434578271053, 11452.713682157846, 11456.0, 11605.59380421698, 3749.7937613430977, 4008.8797336079965, 4239.491261048694, 4393.406890069864, 4565.132624801344, 951.9286053545874, 955.1499165742495, 962.2206013129388, 972.1493693018608, 978.4471773447979, 18748.906255468635, 18824.43449764226, 18935.242590296508, 19012.429627111207, 19541.706874396896, 1014.8680671512656, 1025.3898930136556, 1029.063552167524, 1029.3103620574234, 1045.2526443592867, 10327.896721032694, 10542.47287635615, 10644.520996555173, 10762.139028877671, 10764.838527422095, 495663.0, 496060.0, 511643.0, 517815.0, 523858.0, 114905.0, 115533.0, 116994.41502792432, 117331.0, 118277.40861295638, 1136.8749437561862, 1147.2886810177743, 1170.7424366639325, 1173.2491205628405, 1173.9119566032412, 16911.661766764842, 16926.746098808282, 17112.743308850626, 17119.48641540756, 17209.311627534757, 57736.71131644483, 58465.70767146137, 59468.405315946286, 59687.40312596992, 60151.39848601458, 75160.0, 75598.0, 75678.24321756932, 76104.61947690225, 76451.0, 19180.712289315394, 19373.0, 19483.12325945364, 19528.21887124556, 19676.60646787085, 22056.779432205472, 22108.88945555262, 22118.33644990653, 22121.225757098426, 22456.775432246122, 17662.91168544149, 17764.378246761302, 17842.5539361517, 17945.820541794415, 18234.0, 15073.773893391388, 16295.18524073768, 16470.176491175152, 16475.917620411823, 16745.079020653982, 17673.46979590563, 17836.108194590477, 17914.5521361967, 17987.910060450136, 18003.90998045054, 18753.6249275011, 18781.718274225623, 18805.90597047061, 18871.716924246422, 18972.051397429797, 17122.143892805558, 17292.0, 17374.39189628357, 17546.91226543859, 17566.297348105934], "value": 12677.501551067939, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1334.8998825088117, 1381.8618138186182, 1387.694707164424, 1390.8331000279968, 1391.7773156294982, 15134.318955646995, 15797.36810527579, 15816.604584885383, 15837.445689400873, 15838.524844254662, 15534.300956456958, 15629.765553516678, 15692.13693246871, 15708.293126809293, 15767.053976761403, 2767.5433553463654, 2821.3228825081987, 2857.0, 2862.127051249368, 2877.510823160068, 2793.092245020366, 2828.660560732715, 2849.8860045598153, 2867.6988916163814, 2867.9283017924613, 2776.6390369251967, 2833.135893552466, 2846.331112188634, 2890.2774306423394, 2896.681365049843, 2822.139247529503, 2874.6981566935483, 2876.122782551321, 2877.8129421587737, 2882.6829048804616, 2708.769754570864, 2719.728027197284, 2723.087765598527, 2780.8748606312765, 2789.135368035895, 14801.185934773583, 15041.247937603186, 15064.774028389584, 15101.622459438491, 15112.39550417982, 7906.288434040906, 8312.792180195484, 8325.125861784485, 8328.417010809246, 8329.08380078191, 5424.487939877863, 5446.21029950655, 5554.416786237427, 5613.635113717595, 5614.887702245973, 2016.052455345985, 2020.919163233469, 2036.8879711615855, 2079.6984437256665, 2081.552466219755, 26406.0, 27483.725162748317, 27511.0, 27547.724522754917, 27563.862180688968, 6658.267590565034, 6960.12998375193, 7230.56616602995, 7482.0, 7592.8861067084035, 20850.270240541508, 20860.26989055406, 20881.26915557948, 20909.163633454795, 20917.0, 8223.21879421454, 8233.8353232935, 8242.629081691339, 8255.669773209125, 8261.586920653943, 7259.346658800733, 7285.198628150899, 7370.96314518424, 7412.110546734426, 7421.703131874772, 5940.732667029994, 5948.672822994777, 5992.550558708114, 6161.075838624242, 6213.65824879636, 1857.489190472604, 1877.3147801052792, 1880.3794747733216, 1881.67070762616, 1912.8289391540422, 945.9858102128474, 946.7396465971913, 957.6025949231131, 959.2613687460616, 965.0783501755807, 8139.715109971241, 8153.551554664432, 8270.545120018456, 8540.572971351408, 8548.0, 731.2066407947331, 734.9154847192534, 739.9704011839574, 740.2005833699592, 756.9697212111454, 5431.619786614978, 5505.2564256305295, 5550.500454959073, 5590.748416321276, 5645.125005624052, 21127.0, 21202.78797212039, 22132.0, 22156.113755449926, 22157.66763498549, 21101.0, 21303.0, 21303.36089917305, 21370.145194192057, 21389.35831925045, 10499.267620842627, 10797.0, 10935.179861510418, 11064.0, 11070.612528561462, 8360.74917752444, 8559.828803424021, 8579.957100214458, 8600.053994060523, 8645.4812711235, 16981.405650802164, 18220.635587287914, 18230.544236393667, 18284.0, 18398.356057537923, 16398.426055088014, 17529.912350438168, 18380.172892219616, 19084.80915190886, 19117.522061948006, 12090.697732556757, 12323.322217278135, 12323.69190770238, 12326.445309961253, 12327.260364378166, 13739.24434156091, 13772.517961871286, 13819.516316928859, 13836.723265534834, 13879.0, 11231.887681123411, 11521.366324852213, 11573.942130289295, 11658.358790266617, 11782.0, 10702.197335199735, 10910.945445272722, 10940.726481838017, 10985.450727463434, 11086.279391839505, 10124.59501619927, 10134.949325253327, 10170.0, 10215.080642742189, 10260.076593106656, 7375.225601311785, 7402.555846649218, 7489.026426564729, 7524.0, 7682.8079298018, 7498.887516687145, 7511.06111736033, 7512.661930213044, 7592.240775922363, 7655.617219139132], "value": 6873.601868502711, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [508.3188527373319, 536.0913252037795, 539.0943215398132, 540.1870185371016, 544.1728572569693, 6313.463355614773, 6354.936450635492, 6359.65021923794, 6360.204974378203, 6384.585001974869, 6216.502679785618, 6236.875262494747, 6243.968780156104, 6266.373362663743, 6290.050084473816, 4945.208766597345, 5083.288339632436, 5102.16322124035, 5228.006678731048, 5248.5276325130735, 5069.391672999227, 5075.746212689369, 5112.207607820794, 5114.43741188469, 5117.411497677777, 4964.975175124119, 5022.472640372763, 5065.468125846788, 5089.440161582223, 5109.233614957749, 5002.323756790136, 5009.549140577347, 5044.805509603334, 5093.261477085802, 5113.386393632751, 4600.677952543323, 4616.930746038812, 4628.560286772751, 4629.328747331651, 4641.396618439581, 6215.906761398583, 6221.035739460391, 6261.154744109533, 6312.621242725451, 6337.144485494491, 5728.169415434739, 5750.281214848144, 5760.53915686744, 5796.420357964212, 5796.97101514494, 6561.3438656134485, 6606.141201643755, 6632.9336706633285, 6640.203175618908, 6644.202695676501, 4951.282064100686, 4963.156263435225, 4980.103581355354, 4980.601551875841, 4981.808004478018, 6572.605643661395, 6653.800385988477, 6811.489138314646, 6875.384284693093, 6906.827329316757, 5008.924866127011, 5031.647784655039, 5042.42012168598, 5064.265681476165, 5077.822276220389, 5103.897922041612, 5123.874436593675, 5124.256982737482, 5127.333446651912, 5154.355705536808, 5670.659760414388, 5704.486596206361, 5736.852629474039, 5754.6547207167705, 5758.90580789657, 6610.30591787865, 6611.86776264472, 6628.0, 6654.26803051664, 6707.463402927851, 1786.5176402371287, 1786.8213178682029, 1792.6773180827577, 1793.7668103146507, 1795.1383335998532, 1186.175607952482, 1236.1347057060093, 1238.5541205166132, 1239.578543295266, 1257.6101408563193, 5746.626469279484, 5768.500189950643, 5787.421257874263, 5792.8124734430185, 5814.505767009767, 6766.49251306154, 6768.323167683291, 6768.763093291711, 6804.3195680432555, 6812.386885180357, 5736.110902810071, 5744.167095771089, 5748.275517344863, 5749.13762935563, 5750.884982300414, 3542.929141417209, 3564.7504674672523, 3570.6786389225094, 3571.3750093733493, 3615.891523254254, 6252.874942501216, 6541.345865413516, 6579.407853293226, 6591.868162636721, 6618.7021584028835, 6761.898571521431, 6791.777480053638, 6815.352541508549, 6841.110655614738, 6911.0, 6488.31872653374, 6508.446782023581, 6519.119918810995, 6580.341965803382, 6601.966990165019, 6678.532502724763, 6700.448762156065, 6710.899336509859, 6723.596584204964, 6738.225104113089, 6602.306757790363, 6608.372204640552, 6617.2721000688925, 6628.83427914306, 6764.594124352555, 6552.508561857784, 6589.80230593083, 6591.242007169237, 6599.769008084886, 6624.138861947916, 5123.231515272739, 5138.405105421738, 5146.176611742103, 5152.716600587004, 5152.819651312336, 6521.478281737544, 6708.832279192864, 6718.630475323904, 6795.626240556817, 6847.315268473312, 6482.384173503509, 6541.182352205974, 6560.147180866647, 6564.6389448578875, 6581.473482121323, 6381.649009304533, 6549.559096998652, 6575.572587781779, 6587.835304117435, 6611.30581288977, 6383.329750376143, 6396.744130234739, 6436.13112229843, 6456.192975878015, 6576.473882089517, 6574.027791662577, 6633.336666333328, 6658.83352916181, 6671.132752742113, 6748.527603067738, 6358.1734374531015, 6379.0, 6434.517411194086, 6440.194975628046, 6444.194475690539], "value": 5110.636485014763, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [913.9223166030887, 924.2975338742556, 928.0441145620014, 940.5767404667902, 952.3333666433494, 19562.608747825052, 20320.491987700316, 20344.287949921738, 20401.387958361254, 20423.795762042377, 18710.906445467786, 18744.718829217574, 18774.155163017662, 18783.812161878377, 18914.337998170067, 963.9421634701905, 970.1268858027761, 972.7373609125532, 973.1290495006964, 973.6738192705452, 963.9373440726365, 968.6270785747503, 971.7910649210419, 972.1202311907699, 973.4986481961795, 1007.4106647611156, 1025.5436330832783, 1034.7413146713322, 1043.3166276089137, 1046.6127532812832, 1034.4930983817912, 1035.3322107240788, 1035.3425574760045, 1035.3684252605904, 1036.0364860679565, 757.9772606821804, 758.2909979169494, 758.4577027425362, 758.666186877772, 758.9506682065648, 19396.612067758564, 19844.305449309206, 19914.601707965903, 19932.103055362542, 20539.897300513552, 22003.0, 22068.0, 22380.88809555958, 22484.662730059063, 22635.207767728214, 17352.739708904377, 17753.644927101384, 17834.19746111428, 17887.195076221473, 17890.91054544732, 3766.7174961877968, 3801.0, 3802.790846503441, 3808.333541630231, 3819.5607505136986, 106399.46800265949, 125883.0, 142244.0, 143138.56861431355, 144859.0, 17302.134893255537, 17884.821151788576, 17891.37380191687, 17920.28318867257, 17962.281508739765, 31103.844480777905, 31454.842725786224, 31715.0, 31743.365132697218, 31846.840765796485, 9071.501067441353, 9236.26109911219, 9282.071792820663, 9352.0, 9353.064693530729, 4301.5698430156735, 4370.409994650745, 4377.715448495837, 4386.342048692722, 4386.385905973167, 5385.246065550826, 5490.368607610096, 5491.615586908958, 5495.752691128909, 5513.807016754395, 959.8512230604267, 963.2823546457934, 1102.9962733912103, 1141.5947338694643, 1149.9942500287445, 679.6329981809866, 688.0642326436043, 696.1785093589613, 699.3356311504092, 700.989485157723, 10981.835272470918, 11132.276402033842, 11441.599544015919, 11480.425978701198, 11687.649370518899, 698.1203683359004, 699.6396855619361, 700.7897630710767, 711.3739908880152, 718.5114122396716, 5230.267762513251, 5240.554552863049, 5283.841484755463, 5284.656497327662, 5298.152295632757, 118401.0, 120188.0, 122537.0, 125605.37197314137, 126585.3670731659, 107079.46460267804, 107815.0, 110287.0, 110422.0, 113978.43010784894, 97992.51003744936, 98333.0, 98382.0, 101403.0, 101901.49049254855, 11437.542498300307, 11924.761504769682, 11988.76022479563, 12010.699732506757, 12160.635180944586, 46010.30984535302, 46046.53953460423, 46569.0, 46673.0, 46879.0, 59376.40623593709, 59778.70110649593, 60077.0, 60079.0, 61941.0, 18261.90869045646, 18688.065596720382, 18725.90637046806, 18774.624507510045, 18932.810671893105, 20132.89933550323, 20321.89839050795, 20322.59354812925, 20346.59306813885, 20469.181232750525, 16380.836191638407, 16422.917885410974, 16569.751453727964, 16661.583460413585, 16685.249163787415, 17588.0, 18378.356757513422, 18479.72280415768, 18515.722264166317, 18563.25746970106, 16578.253978570752, 16743.24655390535, 16789.496315110566, 16855.24151413165, 16949.152542373078, 12806.743865122831, 13001.089923705249, 13079.673008174872, 13215.66960825987, 13516.0, 13068.98181546797, 13071.869281307065, 13119.147255428366, 13235.536756213487, 13252.138610990254], "value": 9257.265242913141, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1418.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 105.0, 105.0, 108.0, 106.0, 110.0, 107.0, 106.0, 106.0, 106.0], "value": 106.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 125.0, 116.0, 117.0, 118.0, 119.0, 120.0, 116.0, 117.0, 140.0], "value": 120.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 162.0, 163.0, 163.0, 163.0, 166.0, 165.0, 164.0, 170.0], "value": 164.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 74.0, 73.0, 74.0, 74.0, 74.0, 75.0, 81.0, 74.0, 75.0], "value": 75.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 78.0, 77.0, 77.0, 79.0, 78.0, 79.0, 78.0, 78.0, 78.0], "value": 78.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 113.0, 113.0, 114.0, 114.0, 115.0, 110.0, 114.0, 114.0], "value": 113.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 148.0, 148.0, 148.0, 148.0, 156.0, 149.0, 149.0, 151.0, 149.0], "value": 150.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 94.0, 95.0, 100.0, 99.0, 94.0, 94.0, 93.0, 94.0, 93.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 52.0, 53.0, 53.0, 54.0, 52.0, 54.0, 53.0, 57.0, 53.0], "value": 53.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 38.0, 38.0, 38.0, 38.0, 38.0, 38.0, 38.0, 39.0, 38.0], "value": 38.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 75.0, 73.0, 80.0, 74.0, 74.0, 72.0, 73.0, 71.0, 71.0], "value": 73.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 117.0, 113.0, 108.0, 121.0, 114.0, 120.0, 110.0, 118.0, 111.0], "value": 114.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 178.0, 176.0, 164.0, 166.0, 174.0, 170.0, 169.0, 172.0, 174.0], "value": 171.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 64.0, 64.0, 62.0, 65.0, 66.0, 64.0, 65.0, 63.0], "value": 64.3, "unit": "score"}]}]} 21:55:19 INFO - Return code: 0 21:55:19 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:55:19 INFO - # TBPL SUCCESS # 21:55:19 INFO - Running post-action listener: _package_coverage_data 21:55:19 INFO - Running post-action listener: _resource_record_post_action 21:55:19 INFO - [mozharness: 2017-09-22 04:55:19.138977Z] Finished run-tests step (success) 21:55:19 INFO - Running post-run listener: _resource_record_post_run 21:55:19 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 425984; Write bytes: 339124224; Read time: 60; Write time: 273192 21:55:19 INFO - TinderboxPrint: CPU usage
13.1% 21:55:19 INFO - TinderboxPrint: I/O read bytes / time
425,984 / 60 21:55:19 INFO - TinderboxPrint: I/O write bytes / time
339,124,224 / 273,192 21:55:19 INFO - TinderboxPrint: CPU idle
8,242.8 (86.9%) 21:55:19 INFO - TinderboxPrint: CPU user
1,193.3 (12.6%) 21:55:19 INFO - TinderboxPrint: Swap in / out
0 / 0 21:55:19 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 9965568; Read time: 0; Write time: 1304 21:55:19 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 21:55:19 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 421888; Write bytes: 329158656; Read time: 52; Write time: 271864 21:55:19 INFO - Running post-run listener: _upload_blobber_files 21:55:19 INFO - Blob upload gear active. 21:55:19 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:55:19 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 21:55:19 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 21:55:19 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 21:55:20 INFO - (blobuploader) - INFO - Open directory for files ... 21:55:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 21:55:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:55:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:55:21 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 21:55:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:55:21 INFO - (blobuploader) - INFO - Done attempting. 21:55:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:55:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:55:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:55:24 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:55:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:55:24 INFO - (blobuploader) - INFO - Done attempting. 21:55:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 21:55:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:55:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:55:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 21:55:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:55:25 INFO - (blobuploader) - INFO - Done attempting. 21:55:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 21:55:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:55:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:55:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 21:55:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:55:26 INFO - (blobuploader) - INFO - Done attempting. 21:55:26 INFO - (blobuploader) - INFO - Iteration through files over. 21:55:26 INFO - Return code: 0 21:55:26 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:55:26 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:55:26 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a68b0992b797878c424a1985698507ead2c56c418541373365f62d39eb2072530dd3e4aedacc9692032d2458994cddc7736ec1c5ea55d2057f5ef797630b8442", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5b32148bbe0f2bd167715707e3919f8d27461cbb1f7481b0e62906b13f23a147255c36950505ee241b468775995c5a7b6d2409a3a547681b62460e3365b912a5", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2de6214c91ac296e39a09f31f4a1222076f0f5831679f5e2b0cd73e39ef948128beb75f2f5b2a510999c35b49f9416a5cf38aeaf235e10d4528deaa88b040470", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ca894bbd48ea0ac14d8fed1ca4f44217da59080a7fb406593457fff47f88f476ce8104141d90e749cae7d0fee2cc2d1d50bc5b94e536d6b3fd43c0268c67c806"} 21:55:26 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:55:26 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:55:26 INFO - Contents: 21:55:26 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a68b0992b797878c424a1985698507ead2c56c418541373365f62d39eb2072530dd3e4aedacc9692032d2458994cddc7736ec1c5ea55d2057f5ef797630b8442", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5b32148bbe0f2bd167715707e3919f8d27461cbb1f7481b0e62906b13f23a147255c36950505ee241b468775995c5a7b6d2409a3a547681b62460e3365b912a5", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2de6214c91ac296e39a09f31f4a1222076f0f5831679f5e2b0cd73e39ef948128beb75f2f5b2a510999c35b49f9416a5cf38aeaf235e10d4528deaa88b040470", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ca894bbd48ea0ac14d8fed1ca4f44217da59080a7fb406593457fff47f88f476ce8104141d90e749cae7d0fee2cc2d1d50bc5b94e536d6b3fd43c0268c67c806"} 21:55:26 INFO - Running post-run listener: copy_logs_to_upload_dir 21:55:26 INFO - Copying logs to upload dir... 21:55:26 INFO - mkdir: /builds/slave/test/build/upload/logs 21:55:26 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.977008 ========= master_lag: 0.11 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2017-09-21 21:55:27.031455) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-21 21:55:27.039827) ========= 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=5bd038846534b2fdfa68eeae000001e2-1506053532.50547-1962975423 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-Non-PGO/sha512/a68b0992b797878c424a1985698507ead2c56c418541373365f62d39eb2072530dd3e4aedacc9692032d2458994cddc7736ec1c5ea55d2057f5ef797630b8442", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5b32148bbe0f2bd167715707e3919f8d27461cbb1f7481b0e62906b13f23a147255c36950505ee241b468775995c5a7b6d2409a3a547681b62460e3365b912a5", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2de6214c91ac296e39a09f31f4a1222076f0f5831679f5e2b0cd73e39ef948128beb75f2f5b2a510999c35b49f9416a5cf38aeaf235e10d4528deaa88b040470", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ca894bbd48ea0ac14d8fed1ca4f44217da59080a7fb406593457fff47f88f476ce8104141d90e749cae7d0fee2cc2d1d50bc5b94e536d6b3fd43c0268c67c806"} build_url:https://queue.taskcluster.net/v1/task/Qc4qapSdREq4to_uIRkeSw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011255 build_url: 'https://queue.taskcluster.net/v1/task/Qc4qapSdREq4to_uIRkeSw/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a68b0992b797878c424a1985698507ead2c56c418541373365f62d39eb2072530dd3e4aedacc9692032d2458994cddc7736ec1c5ea55d2057f5ef797630b8442", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5b32148bbe0f2bd167715707e3919f8d27461cbb1f7481b0e62906b13f23a147255c36950505ee241b468775995c5a7b6d2409a3a547681b62460e3365b912a5", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2de6214c91ac296e39a09f31f4a1222076f0f5831679f5e2b0cd73e39ef948128beb75f2f5b2a510999c35b49f9416a5cf38aeaf235e10d4528deaa88b040470", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ca894bbd48ea0ac14d8fed1ca4f44217da59080a7fb406593457fff47f88f476ce8104141d90e749cae7d0fee2cc2d1d50bc5b94e536d6b3fd43c0268c67c806"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-21 21:55:27.078246) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-21 21:55:27.078664) ========= 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=5bd038846534b2fdfa68eeae000001e2-1506053532.50547-1962975423 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004522 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-21 21:55:27.156958) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-21 21:55:27.157275) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-21 21:55:27.157601) ========= ========= Total master_lag: 0.29 =========