builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-017 starttime: 1505915070.53 results: success (0) revision: 0c49ebf4195ce51072b24aacf01eaaffdcff9be6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-20 06:44:30.532508) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-20 06:44:30.533021) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-20 06:44:30.533428) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-20 06:44:30.552522) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-20 06:44:30.553032) ========= 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=0333a256a5e4f052382dd180000001b1-1505911076.696222-1964767027 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-20 06:44:30-- 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% 373K=0.03s 2017-09-20 06:44:30 (373 KB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.148130 ========= master_lag: 0.07 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-20 06:44:30.769946) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-20 06:44:30.770299) ========= 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=0333a256a5e4f052382dd180000001b1-1505911076.696222-1964767027 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022034 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-20 06:44:30.808172) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-20 06:44:30.808511) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 0c49ebf4195ce51072b24aacf01eaaffdcff9be6 --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 0c49ebf4195ce51072b24aacf01eaaffdcff9be6 --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=0333a256a5e4f052382dd180000001b1-1505911076.696222-1964767027 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-20 06:44:30,855 truncating revision to first 12 chars 2017-09-20 06:44:30,855 Setting DEBUG logging. 2017-09-20 06:44:30,855 attempt 1/10 2017-09-20 06:44:30,855 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/0c49ebf4195c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-20 06:44:31,114 unpacking tar archive at: mozilla-central-0c49ebf4195c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.546806 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-20 06:44:31.372143) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-20 06:44:31.372502) ========= script_repo_revision: 0c49ebf4195ce51072b24aacf01eaaffdcff9be6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-20 06:44:31.372928) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-20 06:44:31.373193) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-20 06:44:31.386368) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2017-09-20 06:44:31.386796) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-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-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=0333a256a5e4f052382dd180000001b1-1505911076.696222-1964767027 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:44:31 INFO - MultiFileLogger online at 20170920 06:44:31 in /builds/slave/test 06:44:31 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-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 06:44:31 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:44:31 INFO - {'append_to_log': False, 06:44:31 INFO - 'base_work_dir': '/builds/slave/test', 06:44:31 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 06:44:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:44:31 INFO - 'branch': 'Firefox-Non-PGO', 06:44:31 INFO - 'buildbot_json_path': 'buildprops.json', 06:44:31 INFO - 'code_coverage': False, 06:44:31 INFO - 'config_files': ('talos/linux_config.py',), 06:44:31 INFO - 'default_actions': ('clobber', 06:44:31 INFO - 'read-buildbot-config', 06:44:31 INFO - 'download-and-extract', 06:44:31 INFO - 'populate-webroot', 06:44:31 INFO - 'create-virtualenv', 06:44:31 INFO - 'install', 06:44:31 INFO - 'setup-mitmproxy', 06:44:31 INFO - 'run-tests'), 06:44:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:44:31 INFO - 'disable_ccov_upload': False, 06:44:31 INFO - 'disable_stylo': False, 06:44:31 INFO - 'download_minidump_stackwalk': True, 06:44:31 INFO - 'download_symbols': 'ondemand', 06:44:31 INFO - 'enable_stylo': False, 06:44:31 INFO - 'enable_webrender': False, 06:44:31 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 06:44:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:44:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:44:31 INFO - 'gecko_profile': False, 06:44:31 INFO - 'gecko_profile_interval': 0, 06:44:31 INFO - 'installer_path': 'installer.exe', 06:44:31 INFO - 'log_level': 'info', 06:44:31 INFO - 'log_name': 'talos', 06:44:31 INFO - 'log_to_console': True, 06:44:31 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:44:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:44:31 INFO - 'opt_config_files': (), 06:44:31 INFO - 'pip_index': False, 06:44:31 INFO - 'suite': 'dromaeojs-e10s', 06:44:31 INFO - 'system_bits': '32', 06:44:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:44:31 INFO - 'title': 'talos-linux64-ix-017', 06:44:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:44:31 INFO - 'use_talos_json': True, 06:44:31 INFO - 'verify': 'False', 06:44:31 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:44:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:44:31 INFO - 'work_dir': 'build'} 06:44:31 INFO - [mozharness: 2017-09-20 13:44:31.579235Z] Running clobber step. 06:44:31 INFO - Running pre-action listener: _resource_record_pre_action 06:44:31 INFO - Running main action method: clobber 06:44:31 INFO - rmtree: /builds/slave/test/build 06:44:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:44:33 INFO - Running post-action listener: _resource_record_post_action 06:44:33 INFO - [mozharness: 2017-09-20 13:44:33.081481Z] Finished clobber step (success) 06:44:33 INFO - [mozharness: 2017-09-20 13:44:33.081579Z] Running read-buildbot-config step. 06:44:33 INFO - Running pre-action listener: _resource_record_pre_action 06:44:33 INFO - Running main action method: read_buildbot_config 06:44:33 INFO - Using buildbot properties: 06:44:33 INFO - { 06:44:33 INFO - "project": "", 06:44:33 INFO - "product": "firefox", 06:44:33 INFO - "who": "archaeopteryx@coole-files.de", 06:44:33 INFO - "installer_path": "public/build/target.tar.bz2", 06:44:33 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 06:44:33 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 06:44:33 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 06:44:33 INFO - "stage_platform": "linux64", 06:44:33 INFO - "basedir": "/builds/slave/test", 06:44:33 INFO - "buildnumber": 1163, 06:44:33 INFO - "platform": "ubuntu64_hw", 06:44:33 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 06:44:33 INFO - "slavebuilddir": "test", 06:44:33 INFO - "taskId": "YNZmHT-DSpWGJGwYOqyM7A", 06:44:33 INFO - "branch": "mozilla-central", 06:44:33 INFO - "script_repo_revision": "production", 06:44:33 INFO - "revision": "0c49ebf4195ce51072b24aacf01eaaffdcff9be6", 06:44:33 INFO - "slavename": "talos-linux64-ix-017", 06:44:33 INFO - "repo_path": "mozilla-central" 06:44:33 INFO - } 06:44:33 INFO - Finding installer, test and symbols from parent task. 06:44:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YNZmHT-DSpWGJGwYOqyM7A'}, attempt #1 06:44:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YNZmHT-DSpWGJGwYOqyM7A'}, attempt #1 06:44:33 INFO - Task dependencies: VjX7h9b1Rg6WbANrHaKj3g 06:44:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VjX7h9b1Rg6WbANrHaKj3g'}, attempt #1 06:44:34 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/VjX7h9b1Rg6WbANrHaKj3g/artifacts/public/build/target.tar.bz2 06:44:34 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/VjX7h9b1Rg6WbANrHaKj3g/artifacts/public/build/target.test_packages.json 06:44:34 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/VjX7h9b1Rg6WbANrHaKj3g/artifacts/public/build/target.crashreporter-symbols.zip 06:44:34 INFO - Running post-action listener: _resource_record_post_action 06:44:34 INFO - [mozharness: 2017-09-20 13:44:34.518840Z] Finished read-buildbot-config step (success) 06:44:34 INFO - [mozharness: 2017-09-20 13:44:34.519057Z] Running download-and-extract step. 06:44:34 INFO - Running pre-action listener: _resource_record_pre_action 06:44:34 INFO - Running main action method: download_and_extract 06:44:34 INFO - mkdir: /builds/slave/test/build/tests 06:44:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:44:34 INFO - trying https://queue.taskcluster.net/v1/task/VjX7h9b1Rg6WbANrHaKj3g/artifacts/public/build/target.test_packages.json 06:44:34 INFO - Downloading https://queue.taskcluster.net/v1/task/VjX7h9b1Rg6WbANrHaKj3g/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 06:44:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VjX7h9b1Rg6WbANrHaKj3g/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 06:44:35 INFO - Downloaded 989 bytes. 06:44:35 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 06:44:35 INFO - Using the following test package requirements: 06:44:35 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 06:44:35 INFO - u'common': [u'target.common.tests.zip'], 06:44:35 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 06:44:35 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 06:44:35 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 06:44:35 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 06:44:35 INFO - u'mozbase': [u'target.common.tests.zip'], 06:44:35 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 06:44:35 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 06:44:35 INFO - u'web-platform': [u'target.common.tests.zip', 06:44:35 INFO - u'target.web-platform.tests.tar.gz'], 06:44:35 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 06:44:35 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 06:44:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VjX7h9b1Rg6WbANrHaKj3g/artifacts/public/build/target.common.tests.zip 06:44:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VjX7h9b1Rg6WbANrHaKj3g/artifacts/public/build/target.common.tests.zip'}, attempt #1 06:44:35 INFO - Fetch https://queue.taskcluster.net/v1/task/VjX7h9b1Rg6WbANrHaKj3g/artifacts/public/build/target.common.tests.zip into memory 06:44:36 INFO - Content-Length response header: 54731862 06:44:36 INFO - Bytes received: 54731862 06:44:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VjX7h9b1Rg6WbANrHaKj3g/artifacts/public/build/target.talos.tests.zip 06:44:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VjX7h9b1Rg6WbANrHaKj3g/artifacts/public/build/target.talos.tests.zip'}, attempt #1 06:44:47 INFO - Fetch https://queue.taskcluster.net/v1/task/VjX7h9b1Rg6WbANrHaKj3g/artifacts/public/build/target.talos.tests.zip into memory 06:44:47 INFO - Content-Length response header: 14508893 06:44:47 INFO - Bytes received: 14508893 06:44:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:44:48 INFO - trying https://queue.taskcluster.net/v1/task/VjX7h9b1Rg6WbANrHaKj3g/artifacts/public/build/target.tar.bz2 06:44:48 INFO - Downloading https://queue.taskcluster.net/v1/task/VjX7h9b1Rg6WbANrHaKj3g/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 06:44:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VjX7h9b1Rg6WbANrHaKj3g/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 06:44:49 INFO - Downloaded 61637786 bytes. 06:44:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VjX7h9b1Rg6WbANrHaKj3g/artifacts/public/build/target.tar.bz2 06:44:50 INFO - mkdir: /builds/slave/test/properties 06:44:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:44:50 INFO - Writing to file /builds/slave/test/properties/build_url 06:44:50 INFO - Contents: 06:44:50 INFO - build_url:https://queue.taskcluster.net/v1/task/VjX7h9b1Rg6WbANrHaKj3g/artifacts/public/build/target.tar.bz2 06:44:50 INFO - Running post-action listener: _resource_record_post_action 06:44:50 INFO - Running post-action listener: find_tests_for_verification 06:44:50 INFO - Running post-action listener: set_extra_try_arguments 06:44:50 INFO - [mozharness: 2017-09-20 13:44:50.352365Z] Finished download-and-extract step (success) 06:44:50 INFO - [mozharness: 2017-09-20 13:44:50.352466Z] Running populate-webroot step. 06:44:50 INFO - Running pre-action listener: _resource_record_pre_action 06:44:50 INFO - Running main action method: populate_webroot 06:44:50 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:44:50 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 06:44:50 INFO - 'tests': ['tresize', 06:44:50 INFO - 'tcanvasmark']}, 06:44:50 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:44:50 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 06:44:50 INFO - 'tests': ['dromaeo_css', 06:44:50 INFO - 'kraken']}, 06:44:50 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 06:44:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:44:50 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 06:44:50 INFO - 'talos_options': ['--disable-stylo'], 06:44:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:44:50 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 06:44:50 INFO - 'tests': ['damp', 'tps']}, 06:44:50 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 06:44:50 INFO - 'talos_options': ['--disable-stylo'], 06:44:50 INFO - 'tests': ['damp', 'tps']}, 06:44:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:44:50 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 06:44:50 INFO - 'tests': ['dromaeo_dom']}, 06:44:50 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 06:44:50 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 06:44:50 INFO - 'tests': ['basic_compositor_video', 06:44:50 INFO - 'glvideo']}, 06:44:50 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 06:44:50 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 06:44:50 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 06:44:50 INFO - 'talos_options': ['--disable-stylo'], 06:44:50 INFO - 'tests': ['ts_paint_webext', 06:44:50 INFO - 'tp5o_webext']}, 06:44:50 INFO - 'other-e10s': {'tests': ['a11yr', 06:44:50 INFO - 'ts_paint', 06:44:50 INFO - 'tpaint', 06:44:50 INFO - 'sessionrestore', 06:44:50 INFO - 'sessionrestore_many_windows', 06:44:50 INFO - 'sessionrestore_no_auto_restore', 06:44:50 INFO - 'tabpaint']}, 06:44:50 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 06:44:50 INFO - 'tests': ['a11yr', 06:44:50 INFO - 'ts_paint', 06:44:50 INFO - 'tpaint', 06:44:50 INFO - 'sessionrestore', 06:44:50 INFO - 'sessionrestore_many_windows', 06:44:50 INFO - 'sessionrestore_no_auto_restore', 06:44:50 INFO - 'tabpaint']}, 06:44:50 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 06:44:50 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 06:44:50 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 06:44:50 INFO - 'tests': ['perf_reftest_singletons']}, 06:44:50 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 06:44:50 INFO - 'tests': ['bloom_basic']}, 06:44:50 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:44:50 INFO - 'tsvgr_opacity', 06:44:50 INFO - 'tart', 06:44:50 INFO - 'tscrollx', 06:44:50 INFO - 'tsvg_static']}, 06:44:50 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 06:44:50 INFO - 'tests': ['tsvgx', 06:44:50 INFO - 'tsvgr_opacity', 06:44:50 INFO - 'tart', 06:44:50 INFO - 'tscrollx', 06:44:50 INFO - 'tsvg_static']}, 06:44:50 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 06:44:50 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 06:44:50 INFO - 'talos_options': ['--disable-stylo'], 06:44:50 INFO - 'tests': ['tp5o']}, 06:44:50 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 06:44:50 INFO - 'talos_options': ['--mitmproxy', 06:44:50 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 06:44:50 INFO - '--firstNonBlankPaint'], 06:44:50 INFO - 'tests': ['tp6_google', 06:44:50 INFO - 'tp6_youtube', 06:44:50 INFO - 'tp6_amazon', 06:44:50 INFO - 'tp6_facebook']}, 06:44:50 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 06:44:50 INFO - 'talos_options': ['--disable-stylo', 06:44:50 INFO - '--mitmproxy', 06:44:50 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 06:44:50 INFO - '--firstNonBlankPaint'], 06:44:50 INFO - 'tests': ['tp6_google', 06:44:50 INFO - 'tp6_youtube', 06:44:50 INFO - 'tp6_amazon', 06:44:50 INFO - 'tp6_facebook']}, 06:44:50 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 06:44:50 INFO - 'talos_options': ['--stylo-threads=1', 06:44:50 INFO - '--mitmproxy', 06:44:50 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 06:44:50 INFO - '--firstNonBlankPaint'], 06:44:50 INFO - 'tests': ['tp6_google', 06:44:50 INFO - 'tp6_youtube', 06:44:50 INFO - 'tp6_amazon', 06:44:50 INFO - 'tp6_facebook']}, 06:44:50 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 06:44:50 INFO - 'talos_options': ['--xperf_path', 06:44:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:44:50 INFO - 'tests': ['tp5n']}, 06:44:50 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 06:44:50 INFO - 'talos_options': ['--disable-stylo', 06:44:50 INFO - '--xperf_path', 06:44:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:44:50 INFO - 'tests': ['tp5n']}}} 06:44:50 INFO - Running post-action listener: _resource_record_post_action 06:44:50 INFO - [mozharness: 2017-09-20 13:44:50.375768Z] Finished populate-webroot step (success) 06:44:50 INFO - [mozharness: 2017-09-20 13:44:50.375858Z] Running create-virtualenv step. 06:44:50 INFO - Running pre-action listener: _resource_record_pre_action 06:44:50 INFO - Running main action method: create_virtualenv 06:44:50 INFO - Creating virtualenv /builds/slave/test/build/venv 06:44:50 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 06:44:50 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 06:44:50 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 06:44:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:44:50 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:44:50 INFO - Installing distribute.............................................................................................................................................................................................done. 06:44:51 INFO - Installing pip...............done. 06:44:51 INFO - Return code: 0 06:44:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 06:44:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 06:44:51 INFO - Reading from file tmpfile_stdout 06:44:51 INFO - Output received: 06:44:51 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 06:44:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:44: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')]} 06:44:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:44: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')]} 06:44:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:44:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a121f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bdba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d7ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d82090>, '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 0x1d82d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d7cf90>, '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': '0333a256a5e4f052382dd180000001b1-1505911076.696222-1964767027', '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 06:44:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 06:44:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 06:44:51 INFO - Using env: {'DISPLAY': ':0', 06:44:51 INFO - 'HOME': '/home/cltbld', 06:44:51 INFO - 'LANG': 'en_US.UTF-8', 06:44:51 INFO - 'LANGUAGE': 'en_US:en', 06:44:51 INFO - 'LOGNAME': 'cltbld', 06:44:51 INFO - 'MAIL': '/var/mail/cltbld', 06:44:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:44:51 INFO - 'MOZ_NO_REMOTE': '1', 06:44:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:44:51 INFO - 'NO_EM_RESTART': '1', 06:44:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:44:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:44:51 INFO - 'PWD': '/builds/slave/test', 06:44:51 INFO - 'SHELL': '/bin/bash', 06:44:51 INFO - 'SHLVL': '1', 06:44:51 INFO - 'TERM': 'linux', 06:44:51 INFO - 'TMOUT': '86400', 06:44:51 INFO - 'USER': 'cltbld', 06:44:51 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1505911076.696222-1964767027', 06:44:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:44:51 INFO - '_': '/tools/buildbot/bin/python'} 06:44:52 INFO - Ignoring indexes: http://pypi.python.org/simple/ 06:44:52 INFO - Downloading/unpacking pip>=1.5 06:44:52 INFO - Running setup.py egg_info for package pip 06:44:52 INFO - warning: no files found matching 'pip/cacert.pem' 06:44:52 INFO - warning: no files found matching '*.html' under directory 'docs' 06:44:52 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 06:44:52 INFO - no previously-included directories found matching 'docs/_build/_sources' 06:44:52 INFO - Installing collected packages: pip 06:44:52 INFO - Found existing installation: pip 1.1 06:44:52 INFO - Uninstalling pip: 06:44:52 INFO - Successfully uninstalled pip 06:44:52 INFO - Running setup.py install for pip 06:44:52 INFO - warning: no files found matching 'pip/cacert.pem' 06:44:52 INFO - warning: no files found matching '*.html' under directory 'docs' 06:44:52 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 06:44:52 INFO - no previously-included directories found matching 'docs/_build/_sources' 06:44:52 INFO - Installing pip script to /builds/slave/test/build/venv/bin 06:44:52 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 06:44:52 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 06:44:52 INFO - Successfully installed pip 06:44:52 INFO - Cleaning up... 06:44:52 INFO - Return code: 0 06:44:52 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:44:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:44:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:44:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:44:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:44:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a121f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bdba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d7ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d82090>, '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 0x1d82d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d7cf90>, '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': '0333a256a5e4f052382dd180000001b1-1505911076.696222-1964767027', '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 06:44:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 06:44:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 06:44:52 INFO - Using env: {'DISPLAY': ':0', 06:44:52 INFO - 'HOME': '/home/cltbld', 06:44:52 INFO - 'LANG': 'en_US.UTF-8', 06:44:52 INFO - 'LANGUAGE': 'en_US:en', 06:44:52 INFO - 'LOGNAME': 'cltbld', 06:44:52 INFO - 'MAIL': '/var/mail/cltbld', 06:44:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:44:52 INFO - 'MOZ_NO_REMOTE': '1', 06:44:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:44:52 INFO - 'NO_EM_RESTART': '1', 06:44:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:44:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:44:52 INFO - 'PWD': '/builds/slave/test', 06:44:52 INFO - 'SHELL': '/bin/bash', 06:44:52 INFO - 'SHLVL': '1', 06:44:52 INFO - 'TERM': 'linux', 06:44:52 INFO - 'TMOUT': '86400', 06:44:52 INFO - 'USER': 'cltbld', 06:44:52 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1505911076.696222-1964767027', 06:44:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:44:52 INFO - '_': '/tools/buildbot/bin/python'} 06:44:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:44:52 INFO - Downloading/unpacking psutil>=3.1.1 06:44:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:44:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:44:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:44:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:44:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:44:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:44:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:44:54 INFO - Installing collected packages: psutil 06:44:54 INFO - Running setup.py install for psutil 06:44:54 INFO - building 'psutil._psutil_linux' extension 06:44:54 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 06:44:54 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 06:44:54 INFO - building 'psutil._psutil_posix' extension 06:44:54 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 06:44:54 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 06:44:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:44:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:44:54 INFO - Successfully installed psutil 06:44:54 INFO - Cleaning up... 06:44:54 INFO - Return code: 0 06:44:54 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:44:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:44:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:44:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:44:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:44:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a121f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bdba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d7ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d82090>, '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 0x1d82d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d7cf90>, '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': '0333a256a5e4f052382dd180000001b1-1505911076.696222-1964767027', '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 06:44:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 06:44:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 06:44:54 INFO - Using env: {'DISPLAY': ':0', 06:44:54 INFO - 'HOME': '/home/cltbld', 06:44:54 INFO - 'LANG': 'en_US.UTF-8', 06:44:54 INFO - 'LANGUAGE': 'en_US:en', 06:44:54 INFO - 'LOGNAME': 'cltbld', 06:44:54 INFO - 'MAIL': '/var/mail/cltbld', 06:44:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:44:54 INFO - 'MOZ_NO_REMOTE': '1', 06:44:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:44:54 INFO - 'NO_EM_RESTART': '1', 06:44:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:44:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:44:54 INFO - 'PWD': '/builds/slave/test', 06:44:54 INFO - 'SHELL': '/bin/bash', 06:44:54 INFO - 'SHLVL': '1', 06:44:54 INFO - 'TERM': 'linux', 06:44:54 INFO - 'TMOUT': '86400', 06:44:54 INFO - 'USER': 'cltbld', 06:44:54 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1505911076.696222-1964767027', 06:44:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:44:54 INFO - '_': '/tools/buildbot/bin/python'} 06:44:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:44:54 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:44:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:44:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:44:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:44:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:44:55 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:44:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:44:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:44:55 INFO - Installing collected packages: mozsystemmonitor 06:44:55 INFO - Running setup.py install for mozsystemmonitor 06:44:56 INFO - Successfully installed mozsystemmonitor 06:44:56 INFO - Cleaning up... 06:44:57 INFO - Return code: 0 06:44:57 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:44:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:44:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:44:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:44:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:44:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1a121f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bdba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d7ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d82090>, '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 0x1d82d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d7cf90>, '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': '0333a256a5e4f052382dd180000001b1-1505911076.696222-1964767027', '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 06:44:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 06:44:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 06:44:57 INFO - Using env: {'DISPLAY': ':0', 06:44:57 INFO - 'HOME': '/home/cltbld', 06:44:57 INFO - 'LANG': 'en_US.UTF-8', 06:44:57 INFO - 'LANGUAGE': 'en_US:en', 06:44:57 INFO - 'LOGNAME': 'cltbld', 06:44:57 INFO - 'MAIL': '/var/mail/cltbld', 06:44:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:44:57 INFO - 'MOZ_NO_REMOTE': '1', 06:44:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:44:57 INFO - 'NO_EM_RESTART': '1', 06:44:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:44:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:44:57 INFO - 'PWD': '/builds/slave/test', 06:44:57 INFO - 'SHELL': '/bin/bash', 06:44:57 INFO - 'SHLVL': '1', 06:44:57 INFO - 'TERM': 'linux', 06:44:57 INFO - 'TMOUT': '86400', 06:44:57 INFO - 'USER': 'cltbld', 06:44:57 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1505911076.696222-1964767027', 06:44:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:44:57 INFO - '_': '/tools/buildbot/bin/python'} 06:44:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:44:57 INFO - Downloading/unpacking jsonschema==2.5.1 06:44:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:44:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:44:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:44:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:44:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:44:58 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:44:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:44:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:44:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:44:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:44:58 INFO - Downloading functools32-3.2.3-2.tar.gz 06:44:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:44:58 INFO - warning: no files found matching '*.txt' 06:44:58 INFO - no previously-included directories found matching 'build' 06:44:58 INFO - no previously-included directories found matching 'dist' 06:44:58 INFO - no previously-included directories found matching '.git*' 06:44:58 INFO - Installing collected packages: jsonschema, functools32 06:44:58 INFO - Running setup.py install for functools32 06:44:58 INFO - warning: no files found matching '*.txt' 06:44:58 INFO - no previously-included directories found matching 'build' 06:44:58 INFO - no previously-included directories found matching 'dist' 06:44:58 INFO - no previously-included directories found matching '.git*' 06:44:58 INFO - Successfully installed jsonschema functools32 06:44:58 INFO - Cleaning up... 06:44:58 INFO - Return code: 0 06:44:58 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:44:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:44:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:44:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:44:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:44:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a121f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bdba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d7ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d82090>, '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 0x1d82d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d7cf90>, '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': '0333a256a5e4f052382dd180000001b1-1505911076.696222-1964767027', '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 06:44:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 06:44:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 06:44:58 INFO - Using env: {'DISPLAY': ':0', 06:44:58 INFO - 'HOME': '/home/cltbld', 06:44:58 INFO - 'LANG': 'en_US.UTF-8', 06:44:58 INFO - 'LANGUAGE': 'en_US:en', 06:44:58 INFO - 'LOGNAME': 'cltbld', 06:44:58 INFO - 'MAIL': '/var/mail/cltbld', 06:44:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:44:58 INFO - 'MOZ_NO_REMOTE': '1', 06:44:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:44:58 INFO - 'NO_EM_RESTART': '1', 06:44:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:44:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:44:58 INFO - 'PWD': '/builds/slave/test', 06:44:58 INFO - 'SHELL': '/bin/bash', 06:44:58 INFO - 'SHLVL': '1', 06:44:58 INFO - 'TERM': 'linux', 06:44:58 INFO - 'TMOUT': '86400', 06:44:58 INFO - 'USER': 'cltbld', 06:44:58 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1505911076.696222-1964767027', 06:44:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:44:58 INFO - '_': '/tools/buildbot/bin/python'} 06:44:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:44:59 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:44:59 INFO - Cleaning up... 06:44:59 INFO - Return code: 0 06:44:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:44:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:44:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:44:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:44:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:44:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a121f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bdba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d7ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d82090>, '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 0x1d82d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d7cf90>, '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': '0333a256a5e4f052382dd180000001b1-1505911076.696222-1964767027', '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 06:44:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:44:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:44:59 INFO - Using env: {'DISPLAY': ':0', 06:44:59 INFO - 'HOME': '/home/cltbld', 06:44:59 INFO - 'LANG': 'en_US.UTF-8', 06:44:59 INFO - 'LANGUAGE': 'en_US:en', 06:44:59 INFO - 'LOGNAME': 'cltbld', 06:44:59 INFO - 'MAIL': '/var/mail/cltbld', 06:44:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:44:59 INFO - 'MOZ_NO_REMOTE': '1', 06:44:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:44:59 INFO - 'NO_EM_RESTART': '1', 06:44:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:44:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:44:59 INFO - 'PWD': '/builds/slave/test', 06:44:59 INFO - 'SHELL': '/bin/bash', 06:44:59 INFO - 'SHLVL': '1', 06:44:59 INFO - 'TERM': 'linux', 06:44:59 INFO - 'TMOUT': '86400', 06:44:59 INFO - 'USER': 'cltbld', 06:44:59 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1505911076.696222-1964767027', 06:44:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:44:59 INFO - '_': '/tools/buildbot/bin/python'} 06:44:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:44:59 INFO - Downloading/unpacking blobuploader==1.2.4 06:44:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:44:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:44:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:44:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:45:00 INFO - Downloading blobuploader-1.2.4.tar.gz 06:45:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:45:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:45:00 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 06:45:00 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 06:45:00 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 06:45:00 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 06:45:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:45:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:45:00 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 06:45:00 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 06:45:00 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 06:45:00 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 06:45:00 INFO - Downloading docopt-0.6.1.tar.gz 06:45:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:45:01 INFO - Installing collected packages: blobuploader, requests, docopt 06:45:01 INFO - Running setup.py install for blobuploader 06:45:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:45:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:45:01 INFO - Running setup.py install for requests 06:45:01 INFO - Running setup.py install for docopt 06:45:01 INFO - Successfully installed blobuploader requests docopt 06:45:01 INFO - Cleaning up... 06:45:01 INFO - Return code: 0 06:45:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:45:01 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')]} 06:45:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:45:01 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')]} 06:45:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:45:01 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 0x1a121f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bdba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d7ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d82090>, '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 0x1d82d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d7cf90>, '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': '0333a256a5e4f052382dd180000001b1-1505911076.696222-1964767027', '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 06:45:01 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 06:45:01 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 06:45:01 INFO - Using env: {'DISPLAY': ':0', 06:45:01 INFO - 'HOME': '/home/cltbld', 06:45:01 INFO - 'LANG': 'en_US.UTF-8', 06:45:01 INFO - 'LANGUAGE': 'en_US:en', 06:45:01 INFO - 'LOGNAME': 'cltbld', 06:45:01 INFO - 'MAIL': '/var/mail/cltbld', 06:45:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:45:01 INFO - 'MOZ_NO_REMOTE': '1', 06:45:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:45:01 INFO - 'NO_EM_RESTART': '1', 06:45:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:45:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:45:01 INFO - 'PWD': '/builds/slave/test', 06:45:01 INFO - 'SHELL': '/bin/bash', 06:45:01 INFO - 'SHLVL': '1', 06:45:01 INFO - 'TERM': 'linux', 06:45:01 INFO - 'TMOUT': '86400', 06:45:01 INFO - 'USER': 'cltbld', 06:45:01 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1505911076.696222-1964767027', 06:45:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:45:01 INFO - '_': '/tools/buildbot/bin/python'} 06:45:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:45:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:45:01 INFO - Running setup.py (path:/tmp/pip-8T7vGw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:45:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:45:01 INFO - Running setup.py (path:/tmp/pip-pxJSVL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:45:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:45:01 INFO - Running setup.py (path:/tmp/pip-tWXcUn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:45:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:45:02 INFO - Running setup.py (path:/tmp/pip-y5QzML-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:45:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:45:02 INFO - Running setup.py (path:/tmp/pip-tjzcf0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:45:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:45:02 INFO - Running setup.py (path:/tmp/pip-yXPUUZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:45:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:45:02 INFO - Running setup.py (path:/tmp/pip-BhpY6x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:45:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:45:02 INFO - Running setup.py (path:/tmp/pip-j6_LDD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:45:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:45:02 INFO - Running setup.py (path:/tmp/pip-R8bEUo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:45:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:45:02 INFO - Running setup.py (path:/tmp/pip-jsRJww-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:45:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:45:02 INFO - Running setup.py (path:/tmp/pip-DMvIl9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:45:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:45:02 INFO - Running setup.py (path:/tmp/pip-v8znGK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:45:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:45:02 INFO - Running setup.py (path:/tmp/pip-3vJHZK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:45:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:45:02 INFO - Running setup.py (path:/tmp/pip-abOQAt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:45:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:45:02 INFO - Running setup.py (path:/tmp/pip-UeTjMy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:45:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:45:02 INFO - Running setup.py (path:/tmp/pip-1jZl8s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:45:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:45:02 INFO - Running setup.py (path:/tmp/pip-S697vz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:45:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:45:02 INFO - Running setup.py install for manifestparser 06:45:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:45:03 INFO - Running setup.py install for mozcrash 06:45:03 INFO - Running setup.py install for mozdebug 06:45:03 INFO - Running setup.py install for mozdevice 06:45:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:45:03 INFO - Running setup.py install for mozfile 06:45:03 INFO - Running setup.py install for mozhttpd 06:45:03 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:45:03 INFO - Running setup.py install for mozinfo 06:45:03 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:45:03 INFO - Running setup.py install for mozInstall 06:45:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:45:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:45:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:45:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:45:03 INFO - Running setup.py install for mozleak 06:45:03 INFO - Running setup.py install for mozlog 06:45:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:45:03 INFO - Running setup.py install for moznetwork 06:45:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:45:04 INFO - Running setup.py install for mozprocess 06:45:04 INFO - Running setup.py install for mozprofile 06:45:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:45:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:45:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:45:04 INFO - Running setup.py install for mozrunner 06:45:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:45:04 INFO - Running setup.py install for mozscreenshot 06:45:04 INFO - Running setup.py install for moztest 06:45:04 INFO - Running setup.py install for mozversion 06:45:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:45:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:45:04 INFO - Cleaning up... 06:45:04 INFO - Return code: 0 06:45:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:45: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')]} 06:45:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:45: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')]} 06:45:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:45:04 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 0x1a121f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bdba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d7ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d82090>, '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 0x1d82d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d7cf90>, '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': '0333a256a5e4f052382dd180000001b1-1505911076.696222-1964767027', '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 06:45:04 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 06:45:04 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 06:45:04 INFO - Using env: {'DISPLAY': ':0', 06:45:04 INFO - 'HOME': '/home/cltbld', 06:45:04 INFO - 'LANG': 'en_US.UTF-8', 06:45:04 INFO - 'LANGUAGE': 'en_US:en', 06:45:04 INFO - 'LOGNAME': 'cltbld', 06:45:04 INFO - 'MAIL': '/var/mail/cltbld', 06:45:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:45:04 INFO - 'MOZ_NO_REMOTE': '1', 06:45:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:45:04 INFO - 'NO_EM_RESTART': '1', 06:45:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:45:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:45:04 INFO - 'PWD': '/builds/slave/test', 06:45:04 INFO - 'SHELL': '/bin/bash', 06:45:04 INFO - 'SHLVL': '1', 06:45:04 INFO - 'TERM': 'linux', 06:45:04 INFO - 'TMOUT': '86400', 06:45:04 INFO - 'USER': 'cltbld', 06:45:04 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1505911076.696222-1964767027', 06:45:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:45:04 INFO - '_': '/tools/buildbot/bin/python'} 06:45:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:45:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:45:05 INFO - Running setup.py (path:/tmp/pip-Kz2Fp9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:45:05 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 06:45:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:45:05 INFO - Running setup.py (path:/tmp/pip-9IQrqb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:45:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:45:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:45:05 INFO - Running setup.py (path:/tmp/pip-I2dWoM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:45:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:45:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:45:05 INFO - Running setup.py (path:/tmp/pip-JOymuw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:45:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:45:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:45:05 INFO - Running setup.py (path:/tmp/pip-wxo2IB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:45:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 06:45:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:45:05 INFO - Running setup.py (path:/tmp/pip-Kx1lo9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:45:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 06:45:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:45:05 INFO - Running setup.py (path:/tmp/pip-IKtupt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:45:05 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)) 06:45:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:45:05 INFO - Running setup.py (path:/tmp/pip-6adqFu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:45:05 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)) 06:45:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:45:05 INFO - Running setup.py (path:/tmp/pip-E77vwg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:45:05 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)) 06:45:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:45:05 INFO - Running setup.py (path:/tmp/pip-US8S4B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:45:05 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)) 06:45:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:45:05 INFO - Running setup.py (path:/tmp/pip-yFToKx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:45:05 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)) 06:45:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:45:05 INFO - Running setup.py (path:/tmp/pip-HrYY7X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:45:05 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)) 06:45:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:45:05 INFO - Running setup.py (path:/tmp/pip-XdQ1ot-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:45:05 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)) 06:45:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:45:05 INFO - Running setup.py (path:/tmp/pip-JeNlt6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:45:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 06:45:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:45:06 INFO - Running setup.py (path:/tmp/pip-JqWpAs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:45:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 06:45:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:45:06 INFO - Running setup.py (path:/tmp/pip-h276cG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:45:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 06:45:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:45:06 INFO - Running setup.py (path:/tmp/pip-m4dZwC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:45:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 06:45:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:45:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:45:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:45:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:45:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:45:06 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 06:45:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:45:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:45:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:45:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:45:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:45:07 INFO - Downloading blessings-1.6.tar.gz 06:45:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:45:07 INFO - Installing collected packages: blessings 06:45:07 INFO - Running setup.py install for blessings 06:45:07 INFO - Successfully installed blessings 06:45:07 INFO - Cleaning up... 06:45:07 INFO - Return code: 0 06:45:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:45:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:45:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:45:07 INFO - Reading from file tmpfile_stdout 06:45:07 INFO - Current package versions: 06:45:07 INFO - argparse == 1.2.1 06:45:07 INFO - blessings == 1.6 06:45:07 INFO - blobuploader == 1.2.4 06:45:07 INFO - docopt == 0.6.1 06:45:07 INFO - functools32 == 3.2.3-2 06:45:07 INFO - jsonschema == 2.5.1 06:45:07 INFO - manifestparser == 1.1 06:45:07 INFO - mozInstall == 1.13 06:45:07 INFO - mozcrash == 1.0 06:45:07 INFO - mozdebug == 0.1 06:45:07 INFO - mozdevice == 0.51 06:45:07 INFO - mozfile == 1.2 06:45:07 INFO - mozhttpd == 0.7 06:45:07 INFO - mozinfo == 0.10 06:45:07 INFO - mozleak == 0.1 06:45:07 INFO - mozlog == 3.5 06:45:07 INFO - moznetwork == 0.27 06:45:07 INFO - mozprocess == 0.25 06:45:07 INFO - mozprofile == 0.28 06:45:07 INFO - mozrunner == 6.13 06:45:07 INFO - mozscreenshot == 0.1 06:45:07 INFO - mozsystemmonitor == 0.3 06:45:07 INFO - moztest == 0.8 06:45:07 INFO - mozversion == 1.4 06:45:07 INFO - psutil == 3.1.1 06:45:07 INFO - requests == 1.2.3 06:45:07 INFO - wsgiref == 0.1.2 06:45:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:45:07 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')]} 06:45:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:45:07 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')]} 06:45:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:45:07 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 0x1a121f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bdba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d7ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d82090>, '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 0x1d82d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d7cf90>, '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': '0333a256a5e4f052382dd180000001b1-1505911076.696222-1964767027', '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 06:45:07 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 06:45:07 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 06:45:07 INFO - Using env: {'DISPLAY': ':0', 06:45:07 INFO - 'HOME': '/home/cltbld', 06:45:07 INFO - 'LANG': 'en_US.UTF-8', 06:45:07 INFO - 'LANGUAGE': 'en_US:en', 06:45:07 INFO - 'LOGNAME': 'cltbld', 06:45:07 INFO - 'MAIL': '/var/mail/cltbld', 06:45:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:45:07 INFO - 'MOZ_NO_REMOTE': '1', 06:45:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:45:07 INFO - 'NO_EM_RESTART': '1', 06:45:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:45:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:45:07 INFO - 'PWD': '/builds/slave/test', 06:45:07 INFO - 'SHELL': '/bin/bash', 06:45:07 INFO - 'SHLVL': '1', 06:45:07 INFO - 'TERM': 'linux', 06:45:07 INFO - 'TMOUT': '86400', 06:45:07 INFO - 'USER': 'cltbld', 06:45:07 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1505911076.696222-1964767027', 06:45:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:45:07 INFO - '_': '/tools/buildbot/bin/python'} 06:45:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:45:07 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)) 06:45:07 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)) 06:45:07 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)) 06:45:07 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)) 06:45:07 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)) 06:45:07 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)) 06:45:07 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)) 06:45:07 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)) 06:45:07 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)) 06:45:08 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 06:45:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:45:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:45:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:45:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:45:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 06:45:09 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 06:45:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 06:45:09 INFO - Installing collected packages: simplejson 06:45:09 INFO - Running setup.py install for simplejson 06:45:09 INFO - building 'simplejson._speedups' extension 06:45:09 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 06:45:10 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 06:45:10 INFO - Successfully installed simplejson 06:45:10 INFO - Cleaning up... 06:45:10 INFO - Return code: 0 06:45:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:45:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:45:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:45:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:45:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:45:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a121f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bdba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d7ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d82090>, '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 0x1d82d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d7cf90>, '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': '0333a256a5e4f052382dd180000001b1-1505911076.696222-1964767027', '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 06:45:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 06:45:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 06:45:10 INFO - Using env: {'DISPLAY': ':0', 06:45:10 INFO - 'HOME': '/home/cltbld', 06:45:10 INFO - 'LANG': 'en_US.UTF-8', 06:45:10 INFO - 'LANGUAGE': 'en_US:en', 06:45:10 INFO - 'LOGNAME': 'cltbld', 06:45:10 INFO - 'MAIL': '/var/mail/cltbld', 06:45:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:45:10 INFO - 'MOZ_NO_REMOTE': '1', 06:45:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:45:10 INFO - 'NO_EM_RESTART': '1', 06:45:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:45:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:45:10 INFO - 'PWD': '/builds/slave/test', 06:45:10 INFO - 'SHELL': '/bin/bash', 06:45:10 INFO - 'SHLVL': '1', 06:45:10 INFO - 'TERM': 'linux', 06:45:10 INFO - 'TMOUT': '86400', 06:45:10 INFO - 'USER': 'cltbld', 06:45:10 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1505911076.696222-1964767027', 06:45:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:45:10 INFO - '_': '/tools/buildbot/bin/python'} 06:45:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:45:10 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:45:10 INFO - Cleaning up... 06:45:10 INFO - Return code: 0 06:45:10 INFO - Running post-action listener: _resource_record_post_action 06:45:10 INFO - Running post-action listener: _start_resource_monitoring 06:45:10 INFO - Starting resource monitoring. 06:45:10 INFO - [mozharness: 2017-09-20 13:45:10.516618Z] Finished create-virtualenv step (success) 06:45:10 INFO - [mozharness: 2017-09-20 13:45:10.517152Z] Running install step. 06:45:10 INFO - Running pre-action listener: _resource_record_pre_action 06:45:10 INFO - Running main action method: install 06:45:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:45:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:45:10 INFO - Reading from file tmpfile_stdout 06:45:10 INFO - Detecting whether we're running mozinstall >=1.0... 06:45:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:45:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:45:10 INFO - Reading from file tmpfile_stdout 06:45:10 INFO - Output received: 06:45:10 INFO - Usage: mozinstall [options] installer 06:45:10 INFO - Options: 06:45:10 INFO - -h, --help show this help message and exit 06:45:10 INFO - -d DEST, --destination=DEST 06:45:10 INFO - Directory to install application into. [default: 06:45:10 INFO - "/builds/slave/test"] 06:45:10 INFO - --app=APP Application being installed. [default: firefox] 06:45:10 INFO - mkdir: /builds/slave/test/build/application 06:45:10 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'] 06:45:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 06:45:28 INFO - Reading from file tmpfile_stdout 06:45:28 INFO - Output received: 06:45:28 INFO - /builds/slave/test/build/application/firefox/firefox 06:45:28 INFO - Running post-action listener: _resource_record_post_action 06:45:28 INFO - [mozharness: 2017-09-20 13:45:28.679455Z] Finished install step (success) 06:45:28 INFO - [mozharness: 2017-09-20 13:45:28.679601Z] Running setup-mitmproxy step. 06:45:28 INFO - Running pre-action listener: _resource_record_pre_action 06:45:28 INFO - Running main action method: setup_mitmproxy 06:45:28 INFO - Skipping: mitmproxy is not required 06:45:28 INFO - Running post-action listener: _resource_record_post_action 06:45:28 INFO - [mozharness: 2017-09-20 13:45:28.680133Z] Finished setup-mitmproxy step (success) 06:45:28 INFO - [mozharness: 2017-09-20 13:45:28.680239Z] Running run-tests step. 06:45:28 INFO - Running pre-action listener: _resource_record_pre_action 06:45:28 INFO - Running pre-action listener: _set_gcov_prefix 06:45:28 INFO - Running main action method: run_tests 06:45:28 WARNING - Try message not found. 06:45:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:45:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:45:28 INFO - Python 2.7.3 06:45:28 INFO - Return code: 0 06:45:28 INFO - grabbing minidump binary from tooltool 06:45: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')]} 06:45:28 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 0x1d82090>, '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 0x1d82d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d7cf90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:45:28 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 06:45:28 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 06:45:28 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 06:45:28 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:45:28 INFO - Return code: 0 06:45:28 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:45:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:45:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:45:28 INFO - ENV: RUST_BACKTRACE is now full 06:45:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:45:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:45:28 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VjX7h9b1Rg6WbANrHaKj3g/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 06:45:28 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/VjX7h9b1Rg6WbANrHaKj3g/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-017 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 06:45:28 INFO - Using env: {'DISPLAY': ':0', 06:45:28 INFO - 'HOME': '/home/cltbld', 06:45:28 INFO - 'LANG': 'en_US.UTF-8', 06:45:28 INFO - 'LANGUAGE': 'en_US:en', 06:45:28 INFO - 'LOGNAME': 'cltbld', 06:45:28 INFO - 'MAIL': '/var/mail/cltbld', 06:45:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:45:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:45:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:45:28 INFO - 'MOZ_NO_REMOTE': '1', 06:45:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:45:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:45:28 INFO - 'NO_EM_RESTART': '1', 06:45:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:45:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:45:28 INFO - 'PWD': '/builds/slave/test', 06:45:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:45:28 INFO - 'RUST_BACKTRACE': 'full', 06:45:28 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 06:45:28 INFO - 'SHELL': '/bin/bash', 06:45:28 INFO - 'SHLVL': '1', 06:45:28 INFO - 'TERM': 'linux', 06:45:28 INFO - 'TMOUT': '86400', 06:45:28 INFO - 'USER': 'cltbld', 06:45:28 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1505911076.696222-1964767027', 06:45:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:45:28 INFO - '_': '/tools/buildbot/bin/python'} 06:45:28 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VjX7h9b1Rg6WbANrHaKj3g/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 06:45:29 INFO - mozversion application_buildid: 20170920125558 06:45:29 INFO - mozversion application_changeset: 0c49ebf4195ce51072b24aacf01eaaffdcff9be6 06:45:29 INFO - mozversion application_display_name: Nightly 06:45:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:45:29 INFO - mozversion application_name: Firefox 06:45:29 INFO - mozversion application_remotingname: firefox 06:45:29 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 06:45:29 INFO - mozversion application_vendor: Mozilla 06:45:29 INFO - mozversion application_version: 57.0a1 06:45:29 INFO - mozversion platform_buildid: 20170920125558 06:45:29 INFO - mozversion platform_changeset: 0c49ebf4195ce51072b24aacf01eaaffdcff9be6 06:45:29 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 06:45:29 INFO - mozversion platform_version: 57.0a1 06:45:29 INFO - using testdate: 1505915129 06:45:29 INFO - actual date: 1505915129 06:45:29 INFO - starting webserver on 'localhost:53006' 06:45:29 INFO - SUITE-START | Running 2 tests 06:45:29 INFO - TEST-START | dromaeo_css 06:45:29 INFO - Initialising browser for dromaeo_css test... 06:45:29 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:53006/getInfo.html -profile /tmp/tmppjF4cv/profile 06:45:29 INFO - TEST-INFO | started process 18913 (/builds/slave/test/build/application/firefox/firefox http://localhost:53006/getInfo.html) 06:45:33 INFO - TEST-INFO | 18913: exit 0 06:45:34 INFO - Browser initialized. 06:45:34 INFO - Running cycle 1/1 for dromaeo_css test... 06:45:34 INFO - Using env: {'DISPLAY': ':0', 06:45:34 INFO - 'HOME': '/home/cltbld', 06:45:34 INFO - 'JSGC_DISABLE_POISONING': '1', 06:45:34 INFO - 'LANG': 'en_US.UTF-8', 06:45:34 INFO - 'LANGUAGE': 'en_US:en', 06:45:34 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 06:45:34 INFO - 'LOGNAME': 'cltbld', 06:45:34 INFO - 'MAIL': '/var/mail/cltbld', 06:45:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:45:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:45:34 INFO - 'MOZ_CRASHREPORTER': '1', 06:45:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:45:34 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 06:45:34 INFO - 'MOZ_NO_REMOTE': '1', 06:45:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:45:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:45:34 INFO - 'NO_EM_RESTART': '1', 06:45:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:45:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:45:34 INFO - 'PWD': '/builds/slave/test', 06:45:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:45:34 INFO - 'RUST_BACKTRACE': 'full', 06:45:34 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 06:45:34 INFO - 'SHELL': '/bin/bash', 06:45:34 INFO - 'SHLVL': '1', 06:45:34 INFO - 'TERM': 'linux', 06:45:34 INFO - 'TMOUT': '86400', 06:45:34 INFO - 'USER': 'cltbld', 06:45:34 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1505911076.696222-1964767027', 06:45:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:45:34 INFO - '_': '/tools/buildbot/bin/python'} 06:45:34 INFO - TEST-INFO | started process 19142 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppjF4cv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 06:45:34 INFO - PID 19142 | 06:45:34 INFO - PID 19142 | (/builds/slave/test/build/application/firefox/firefox:19191): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 06:45:34 INFO - PID 19142 | 06:45:45 INFO - PID 19142 | RSS: Main: 155783168 06:45:45 INFO - PID 19142 | 06:48:43 INFO - PID 19142 | Cycle 1(1): loaded http://localhost:53006/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53006/tests/dromaeo/cssquery-ext.html) 06:48:44 INFO - PID 19142 | RSS: Main: 155697152 06:48:44 INFO - PID 19142 | 06:51:46 INFO - PID 19142 | Cycle 1(1): loaded http://localhost:53006/tests/dromaeo/cssquery-ext.html (next: http://localhost:53006/tests/dromaeo/cssquery-jquery.html) 06:51:46 INFO - PID 19142 | RSS: Main: 156168192 06:51:46 INFO - PID 19142 | 06:54:48 INFO - PID 19142 | Cycle 1(1): loaded http://localhost:53006/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53006/tests/dromaeo/cssquery-mootools.html) 06:54:49 INFO - PID 19142 | RSS: Main: 158093312 06:54:49 INFO - PID 19142 | 06:57:50 INFO - PID 19142 | Cycle 1(1): loaded http://localhost:53006/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53006/tests/dromaeo/cssquery-prototype.html) 06:57:51 INFO - PID 19142 | RSS: Main: 156688384 06:57:51 INFO - PID 19142 | 07:00:54 INFO - PID 19142 | Cycle 1(1): loaded http://localhost:53006/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53006/tests/dromaeo/cssquery-yui.html) 07:00:55 INFO - PID 19142 | RSS: Main: 158064640 07:00:55 INFO - PID 19142 | 07:03:56 INFO - PID 19142 | Cycle 1(1): loaded http://localhost:53006/tests/dromaeo/cssquery-yui.html (next: http://localhost:53006/tests/dromaeo/cssquery-dojo.html) 07:03:57 INFO - PID 19142 | RSS: Main: 160714752 07:03:57 INFO - PID 19142 | 07:03:57 INFO - PID 19142 | __start_tp_report 07:03:57 INFO - PID 19142 | _x_x_mozilla_page_load 07:03:57 INFO - PID 19142 | _x_x_mozilla_page_load_details 07:03:57 INFO - PID 19142 | |i|pagename|runs| 07:03:57 INFO - PID 19142 | |0;dojo.html;3139.7645176611754;3158.052584224732;3159.210197450637;3164.1614972032417;3170.064830874892;6227.252729672435;6298.968505157468;6340.746370145194;6360.713767880445;6407.935920640793;6278.748850045993;6356.237251529811;6432.7105280262385;6472.967635161817;6486.805395838121;5755.654660720349;5786.768529258825;5813.709314534278;5874.9412505874825;5880.26496687914;5819.476247137757;5849.912251316234;5896.380880007602;5909.556783241253;5919.348871624118;5723.170140329649;5793.855153621151;5795.641914240287;5809.448102430262;5871.823845284648;5751.539876809845;5831.679257640828;5834.883302333972;5843.18195452637;5855.648661080349;5739.426057394227;5792.478676919098;5816.243888294494;5826.708664566755;5837.124431335334;6171.783987560459;6199.969000155015;6282.026285925689;6295.2760432550385;6361.713722882481;6647.501437392167;6659.134312539387;6683.331666833326;6683.4987375947;6692.531522793406;6672.165979252593;6710.127683401175;6753.290904455011;6823.761168359133;6823.863522729517;6050.21347224858;6249.843753906189;6252.937470625281;6336.271328797156;6345.87308253837;6869.896951545731;7008.684609192598;7013.824654383681;7057.576545407189;7076.433885289164;6631.469482441489;6658.5671931324305;6669.63317017559;6736.7642132525125;6747.190337159573;6521.673916304166;6674.833129171712;6682.3317668232785;6698.966505167443;6702.899456508157;6650.70071846768;6657.7669781557415;6662.0006998949575;6672.366125218194;6684.465242780566;6685.39831415175;6704.564203326768;6712.160979877515;6716.664166791641;6718.563293385914;5179.300794392784;5265.21021846726;5274.683518988873;5327.094393953037;5337.359516858002;4593.081383723269;4640.164770341304;4676.368690226844;4720.33915251865;4729.527047295243;5769.769209231667;5773.018586840247;5850.64896106235;5852.122181672698;5856.355800861902;6598.7030583623855;6729.528932974645;6729.5625784323865;6747.662616869137;6751.088603038527;5786.363500014995;5795.681237531892;5879.147523609138;5886.175935369051;5886.381929897299;5842.328132264759;5861.648301101947;5911.113332999998;5920.111983202554;5930.911036334458;6452;6465.644389558525;6543.1166792483355;6546.639934803537;6625.4037136657935;6679.365460281266;6769.966150169218;6802.217744959393;6810.965945170342;6893.655317234218;6559.508036897157;6601.141851559459;6607.7356905725155;6608.50436217276;6614.140161778938;6691.46468282546;6724.991251312343;6835.179778426422;6848.931510685029;6849.931500684929;6842.93157068423;6867.931320686729;6911.205211400753;6985.5808651481075;6986.056882321025;6483.902741458787;6581.638009909501;6611.272759996493;6705.161854768154;6709.194896612243;6549.869002619826;6554.868902622016;6557.082008518716;6567.179102612174;6631.469482441489;6527.738890444329;6616.206055273398;6633.734650613921;6657.567258128206;6668.29982851813;6674.799756007327;6676;6697.162854643169;6756.290589488033;6781.38967492928;6374.713137908712;6431.48548116159;6435.51733619971;6443;6541 07:03:57 INFO - PID 19142 | |1;ext.html;840.7645859159437;870.7561882672852;898.8337157625836;903.6972614174249;903.986440203397;39850;41498;41537.584624153715;41603.37594936079;41620.16759664813;37690.62309376912;37924.62075379246;37931.24137517248;37961.81019094901;37987.810060949654;7039.366457018855;7088.85822283554;7137.571745695275;7152.141742990849;7174.6412679366085;7052.294770522933;7120.359167674908;7138.214796372395;7139.714411423537;7157.89263161053;7801.960990195041;7998.920010799905;8002.759917202493;8004.599770011476;8005.5997200140055;7878.803029924269;7935.841283174333;7939.761807145795;7944.563049032301;7950;7763.301302882711;7801;7879.645415956295;7901.96049019757;7965.044194696674;37705.24589508222;37710.81144594287;37925.62074379248;38142.23715525702;38206;3165.1770539659624;3207.4868021116745;3207.5990501187352;3216.7748257621975;3217.276112874608;31068;31232.37535249282;31396.529052064237;31489.21276968071;31538.211544711336;5024.673396229234;5034.597232221414;5084.339035925343;5211.9218211726475;5288.338957630296;183323;183984;185251;185468;186202.99999999863;47219;47876.521234787906;47962.520374796506;48022.5197748018;48031.519684802704;50579;50660.49339506632;50675;50693.23960140601;50791.23813142806;14567.125972441687;14843.257837108102;14897.627559311104;14898.627534311729;14903.627409314853;11978.520859165536;11983.700407489883;11994.280343179436;11996.40017999114;11999.940000300117;13848.653783655489;13927.651808704863;13952;13989.510367137102;14095.71808563823;5912.526997840162;5930.377310382434;5967.254093238345;5983.252093488314;6032.4570788629235;1003.4280460137652;1014.7716763728102;1018.1701912940929;1023.4268809466722;1031.510032734445;22602.127223768337;22848.428789280402;23173.188938387077;23251.88374058153;23260.534789304118;1099.7290594921622;1110.7334239782394;1116.9944150279196;1118.2507719827736;1119.6249256499002;12283.366981829891;12310.692232694255;12352.147177923383;12371.319577423148;12418.049362619959;212424;215725;223045;223319;223991;43751.78124109423;44991;50686;53010.73494632502;53199;1452;1462.9487967921284;1462.9853701463062;1476.0553245922617;1477.5788900163402;27629;27669.584956226074;27675;28240.576391354556;28271.15186544407;37343.81328093342;37593.060173495884;37678.62321376751;37706.8114659425;37737.245255095295;198548;201719;202612;202741;203936;33200.1699957503;33572;33627.32745345031;34163.14592135117;34245.31509369848;40369.192616146924;41976.79011605045;42011.36982945197;42742.14515709731;42787.57212427836;31044.534331984585;31598.684013159575;31735.52396714005;31874.6812531881;32183.839080805385;30282.697173027987;31907.36185276235;32019.839900800347;32183.35633287368;32287.838560807046;34291.314173716884;35645.46531802077;35688.464673030445;35703.464448032784;35717.28565428729;31269;31417.528737068504;31435.685643144192;31735.52396714005;31907.36185276328;23385.88307058454;23659.290221293388;23680.644790328504;24031.63952540748;24437.877810610833 07:03:57 INFO - PID 19142 | |2;jquery.html;569.4618585436762;576.5906206593319;578.4995978478614;587.8383444552749;613.6839527643264;22035.449113772145;22691.886540567295;22729.772702272992;22742.20402285916;22802.65796013061;23147.42131446715;24237.878810605966;24339.878300608518;24387.146449874257;24655.630165547533;6511.479081673467;6671.266160722341;6690.096836927026;6698.531102822804;6706.798796036127;6320.5891617044745;6504.284528701839;6619;6622.403983641471;6629.8342541436605;6557;6576.112224849656;6590.209174898995;6598.901016484757;6605.207375114969;6599.967000164993;6602.537822352438;6608.735650573972;6610.471162307004;6614.768483103068;5910.586258961875;6117.908231376533;6125.418085281891;6144.170536977495;6147.44672979434;27923.162305130674;28588.14235572936;28601.71398286032;28614.427711445864;28635.85682071597;1960.5882764619448;1971.7732460766908;1982;1996.0518753592073;1998.7901270366547;18374.540636484195;18830.811691883042;19092.23631054756;19210.135543900557;19256.422307330802;2428.3686241577316;2464.581021226396;2486.962695559568;2515.72327044025;2516.622506624021;122998;128844;134311;135421;142570;14211.50259740904;14659.706805864036;14675.486357977634;14874.181919994504;15002.774958375632;22650.093996239964;22714.43213919665;22885.771142288362;22912.541749165255;22970.540589188124;9683.564239609235;9882.950585247172;9898.554565044591;9950.35322704022;10023;9110.36227464071;9159.267258619295;9200.539973001458;9278.304127190488;9288.674896378594;8902.42134261271;8953.820923581492;9090.36367454285;9105.726828195166;9284.164425201765;2606.6090086486797;2652.58884872845;2690.56950887857;2727.1682136948025;2738.52075886719;946.1266691949977;960.1694534227983;974.0697633759884;978.6623614852864;990.8216521026285;18392.448226553224;18677.813221867607;18990.810091898904;18994.810051899305;19147;1011.5599714124232;1024.6106479537877;1031.1132426113536;1048.5072016152396;1051.332403923514;10232.334898231591;10464.21518386124;10480.004399582027;10490.370577765358;10504.842427363596;501115;513413;522074;533262;550359;117531;117781;117798;118805;121018;1044.3003187863997;1142.4173671427632;1177.9823302650468;1214.5688280660415;1217.0811037666329;18983.71524427162;19579.51051223731;19765.11057002467;19811.702824457934;19875.801241987396;55483;58241;58434.707826460595;59322.70338648279;59447.70276148592;70134.64932675305;71683;73696.26303737109;74193.62903185449;74759.62620187082;13612.183269003892;13740.725185496434;13845.861541384456;13935.860641393456;14049.789253161414;21862;21920.45198870041;22202.333929982127;22235;22610.208642697427;17597;17781.377651782124;17927.462176134737;17933.551661208574;17942.37201697934;15388.230588470755;15855;16230.594235144215;16237;16654.41709540209;18078.90960545189;18104.366347177787;18119.275228990693;18337.358192463733;18468.630627387647;13819.516316929261;13896.791548126988;13965.092269002482;13975.30123493801;13999.930000349934;17422.21600028027;17654;17817.198226080116;17825.643487130445;17968.371107011193 07:03:57 INFO - PID 19142 | |3;mootools.html;1273.3887733887734;1317;1340.4236178443266;1342.4227582139679;1348.2112963916109;14713.411463541446;15407.537773866788;15433.84566154338;15434;15448.22758862058;14753.852461475382;14909;14956.775648365256;14968.775468367956;14999.1750453725;2773.4314465534617;2818.2109009477326;2867.3835125448027;2868.1108856254523;2869.411770587025;2592.753688399599;2594.558924982748;2605.674290713661;2605.7654811067;2634.025410598081;2723.700392956773;2828;2851.4297140571866;2851.786116041295;2858.7284208000206;2640.0627777139125;2640.656714627096;2650.3374156460886;2666.560017597094;2680.798940079502;2633.0521012435506;2639.8416095034167;2837.9716202837913;2840.2047426720346;2844.857757112136;15143.772843407358;15285.847141528664;15286.923565382102;15287.617809554738;15287.770683439758;7880.80297992549;8157.306628936548;8206.138355472709;8210.30212431944;8222.83554328916;5351.518363347317;5447.264619276387;5490.149026900836;5581.776728930838;5586.525145362649;1914.58836350184;1926.7880533141342;1932.2464238946823;1967.616314818611;1990.9004549772453;25896;26295.605565916525;26330.6050409244;26576.46847063048;26773.59839602388;6591.340865913467;6707.1616047994;6846.520743547904;6873.759418420332;6932.202796678345;16903.577410564834;16954.491365259062;16994.660106797794;17009.319627214772;17042.659146816994;7767.961160194162;7892.723754668674;7910.129885712567;7918.920810791818;7921.32668723165;7160.641967901584;7186.784396468114;7201.3878820299815;7226.096737907762;7226.494145409771;5191.299174611455;5270.235815806686;5303.071962406563;5308.30991971049;5385.27298814655;1563.6169138560897;1573.8268790433272;1589.7774311596386;1597.4888035828424;1599.3202888772225;834.0866750907746;841.2554888923224;861.5218553702755;866.4887716247445;867.2238346679686;7321.084864391951;7349.63251837406;7375.852482950311;7405.33351998312;7429.554226746304;696.982575435608;699.7515881861967;712.3232928717636;718.619131860115;721.7798571435658;5288.81489147878;5312.2297266896085;5317.574594032468;5463.836084917459;5563.777448902079;20066;21014.78985210159;21129.260475883577;21348.679769803464;21357.46606334823;20522.486937826376;20728.067236974373;21078.78921210799;21084.578308433745;21388.251411200534;10963.287386319864;11013.889861101286;11488.425578721197;11510.82733759011;11530.077593792477;8680.392372533863;9024.729258122266;9027;9199.724008279762;9309.022552632146;18564.071796410397;18598.349057782914;18604.627907441503;18708.532286692396;18767.906160469658;18907.243710251434;19037.14332854997;19568.11943462519;19580.706289405385;19630.705539416635;12135.453904574139;12229.816552751538;12236.082293828176;12256.75486490283;12377.319247441477;13723.725525489634;13772.724545508834;13917.58247252584;13936.024478286423;13993.510227142002;10820.4048777318;10863.619773307897;10932.453377331261;10961.50673219723;10989.285696429706;10612.840807387742;10665.41340226264;10720.892791071989;10879.401632909949;11015.724606884893;9709.951450242987;9805.558749856416;9887.209023278265;9901;9915;7347.228541003117;7356.558606483628;7382.114146302478;7390.556566606021;7493.213212612597;7576.507527010726;7682.078150621961;7688.231176882491;7743.109542402696;7746.65140068687 07:03:57 INFO - PID 19142 | |4;prototype.html;500;524.3026774390062;530.5437323901444;530.9362876454825;536.5332161019912;6310.876116322415;6360.872782544347;6418.871622567546;6430.935690643092;6438.291787903327;6285.465735412484;6285.811425657238;6288.748450062003;6304.590201636902;6323.20959880015;5209.942072881219;5250.65870718402;5263.210518422248;5276.366835979668;5278.604104692164;5271.710055946941;5292.894142117156;5299.33758280215;5307.575393968493;5318.734063296839;5131.255967884655;5159.922601160967;5223.52988231061;5273.973630131844;5299.364076310848;5209.374875015003;5252.450527094478;5305.549028332577;5323.254744335796;5329.53437804603;4865.9026819463415;4919.581835543983;4930.137225985474;4938.506149385069;4942.752862356868;6107.511399088063;6270.46701030413;6283.717232724538;6284.780032698879;6292.748290068392;5978.581499295051;6036;6075.969620151871;6090.817275481742;6104;6726.3609957054005;6734.46124310054;6742.52802303839;6744.6627668616375;6804.605055963516;5335.893282134374;5341.172118321666;5420.3738878336735;5433.945660543423;5452.154915988028;6653.833654158636;6947.756828510978;7009.228984811667;7040.401565866908;7106.2183159852375;5541.778328866881;5546.639468434539;5575.8884822304135;5590.413006634326;5607.186957891165;5544.362398324163;5589.916151257735;5600.803971860965;5658.632188907708;5673.432656734376;5969.492593129633;5983.132445795335;5983.700814959322;6034.758609655652;6045.848853778691;6695.263521012685;6718.361755633305;6743.224529179109;6757.932420675828;6823.761168359084;1959.4219705187004;1959.6570600144917;1962.7644682638174;1964.5088727818045;1974.9506262343268;1390.5133203378737;1439.4817865568386;1441.935112919921;1451.898367114292;1476.4463326252655;5762.250907382014;5767.682777447197;5781.335146458211;5786.623869448473;5796.420357964254;6749.392554670103;6808.353206445379;6810.28492008332;6810.318968103249;6833.180018397824;5766.913496297559;5777.364489906107;5812.534997200214;5831.562632802556;5866.765329386777;3605.351036813346;3617.276544691072;3621.7464777465325;3646.124930016777;3666.431703086026;6518.185226846645;6541.345865413516;6567.113439685581;6568.113304703804;6589.7364105435245;6813.727450902007;6828.760993365208;6903.309669033057;6956.234814170437;7005.684744186524;6338.271098823602;6415.1981002374705;6418.133551970611;6434.2600600930555;6519.892467745291;6599.7360105595235;6728.629925354153;6777.966110169417;6785.457163427012;6843.315668433316;6673.299303573249;6766.932330676827;6783.491238157257;6789.321067893368;6799.490038247251;6305.558610897193;6495.188101487314;6537.771178008747;6552.3775241352;6593.835154121185;5559.16612508127;5567.860803479945;5572.328301509612;5577.609567330248;5586.748596313095;6473.935260647333;6511.967440162769;6608.273089960197;6789.321067893368;6837.965810171117;6201.224846894138;6524.641144737085;6540.1518178185415;6563;6598.241202261801;6510.21877374718;6553.803385898431;6586.637734924625;6608.207015158019;6626.933730662631;6381.3937675920715;6399.8720025598295;6455.677216139268;6487.156669632917;6509.934900650933;6378.681065946591;6433.710483028369;6439.388258115471;6579.671016449254;6589.868202636017;6213.502919766317;6248.843778905563;6345.333739957238;6359.809205723651;6370.4903607712195 07:03:57 INFO - PID 19142 | |5;yui.html;889.2930120554158;907.7140700679286;914.2822884036033;925.4308600210873;946.1957336264177;19515.02424878756;20335.28826491073;20491.282805101826;20504.38486845397;20527.589448211027;18359.724604130948;18462.353817616386;18653.81346186538;18833.340833070844;18974.146163422643;964.4068897627943;974.4348277998744;975.8633791269228;975.9414435133915;979.9167070798991;969.4764826993415;991.3110388280148;994.2741798487109;995.0546980368642;995.2535598301274;1042.9739256518571;1058.957641694335;1059.332620449116;1059.3749687684265;1059.7562560611063;1049.3284298049255;1050.03921411908;1050.2333296693419;1051.127564121781;1054.4200689620677;728.9453291003143;743.3087228877142;750.4596690382915;752.0749478141917;774.446270916292;20401.591968160552;20692.482687932923;20701.89649051745;20767.792322076737;20802.79197208024;22005.11979520833;22068.88965555178;22808.77191228083;22891.42771430711;23111.422214444607;17622.823771762247;17785.110744462854;18094.63810723791;18204.726929096076;18270.908645456686;3784.7161462890117;3802.2205447883116;3812;3812.2184952085036;3819.0643292393543;136493.999999999;136615.95076073866;138941.3052934739;140869;141955.29022354822;16568;16979.23593438298;17019.659606807796;17044;17087.31650733957;30860.691393086232;31009.68990310113;31913.680863191534;32175.195620109684;32207.51688724671;9172.816543669089;9278.48968306736;9300.302477314228;9326.207272381924;9333.626654933862;4381;4475.1049790042125;4509.368688383629;4521.751303678264;4599.126166028444;5326.627136100436;5387.461253874581;5393.8112166074;5402.621816472888;5421.159720243369;1007.536533194724;1027.9155490956962;1049.0348879031158;1051.8527406163143;1053.4258828938248;697.7139372857105;715.4312321704258;726.4878260826105;729.0959210578844;736.4623824608066;12225.755484890253;12267.754644907052;12543.498260069677;12692.17500862441;12859;704.1901812915188;709.8083517450259;714.5926821711679;725.2493669052611;730.6748496918821;5577.944220557823;5614.1859430382365;5745.052066408995;5748.310202775694;5787.421257874263;125924.37037814752;126093;127169;128067;129934;80693;80853;90607.54696226609;105302;112674;94852;95709;96240;96407;100829.48755768669;12079.51681932748;12740.044496662602;13024.218546887218;13107.803382949072;13151;41028.1794364117;42062.78968605137;43023.56976430196;43733.56266437422;44924.77537612422;75846;81080;82915.5854220725;84790.57604711936;86952.13047869693;18370.081495925417;18456.907715461337;18556.257749689863;18572.907135464236;18585.25658973626;19110.522236944187;19384.127714253176;19425.0287485628;19563.706544402132;19587.412377628694;18292;18436.539086522946;18510.444686658884;18771.812281877552;18837.811621883604;17259.654806904044;17412.95522268668;17426.651466970845;17489.912550437166;17523.56191095233;16148.757768633244;16174.433894814096;16220;16347.836521634632;16367;12843.293618851052;13015.154014988995;13326;13376.665583360495;13452.058355914993;12598;12785.808212877;12857;12971.740565188455;13029.674258143243 07:03:57 INFO - PID 19142 | __end_tp_report 07:03:57 INFO - PID 19142 | __start_cc_report 07:03:57 INFO - PID 19142 | _x_x_mozilla_cycle_collect,306 07:03:57 INFO - PID 19142 | __end_cc_report 07:03:57 INFO - PID 19142 | __startTimestamp1505916237086__endTimestamp 07:03:57 INFO - PID 19142 | 07:03:57 INFO - PID 19142 | ------- Summary: start ------- 07:03:57 INFO - PID 19142 | Number of tests: 6 07:03:57 INFO - PID 19142 | 07:03:57 INFO - PID 19142 | [#0] dojo.html Cycles:165 Average:6227.19 Median:6521.67 stddev:747.12 (11.5%) stddev-sans-first:709.07 07:03:57 INFO - PID 19142 | Values: 3139.8 3158.1 3159.2 3164.2 3170.1 6227.3 6299.0 6340.7 6360.7 6407.9 6278.7 6356.2 6432.7 6473.0 6486.8 5755.7 5786.8 5813.7 5874.9 5880.3 5819.5 5849.9 5896.4 5909.6 5919.3 5723.2 5793.9 5795.6 5809.4 5871.8 5751.5 5831.7 5834.9 5843.2 5855.6 5739.4 5792.5 5816.2 5826.7 5837.1 6171.8 6200.0 6282.0 6295.3 6361.7 6647.5 6659.1 6683.3 6683.5 6692.5 6672.2 6710.1 6753.3 6823.8 6823.9 6050.2 6249.8 6252.9 6336.3 6345.9 6869.9 7008.7 7013.8 7057.6 7076.4 6631.5 6658.6 6669.6 6736.8 6747.2 6521.7 6674.8 6682.3 6699.0 6702.9 6650.7 6657.8 6662.0 6672.4 6684.5 6685.4 6704.6 6712.2 6716.7 6718.6 5179.3 5265.2 5274.7 5327.1 5337.4 4593.1 4640.2 4676.4 4720.3 4729.5 5769.8 5773.0 5850.6 5852.1 5856.4 6598.7 6729.5 6729.6 6747.7 6751.1 5786.4 5795.7 5879.1 5886.2 5886.4 5842.3 5861.6 5911.1 5920.1 5930.9 6452.0 6465.6 6543.1 6546.6 6625.4 6679.4 6770.0 6802.2 6811.0 6893.7 6559.5 6601.1 6607.7 6608.5 6614.1 6691.5 6725.0 6835.2 6848.9 6849.9 6842.9 6867.9 6911.2 6985.6 6986.1 6483.9 6581.6 6611.3 6705.2 6709.2 6549.9 6554.9 6557.1 6567.2 6631.5 6527.7 6616.2 6633.7 6657.6 6668.3 6674.8 6676.0 6697.2 6756.3 6781.4 6374.7 6431.5 6435.5 6443.0 6541.0 07:03:57 INFO - PID 19142 | 07:03:57 INFO - PID 19142 | [#1] ext.html Cycles:180 Average:36969.09 Median:33386.08 stddev:52428.91 (157.0%) stddev-sans-first:52505.81 07:03:57 INFO - PID 19142 | Values: 840.8 870.8 898.8 903.7 904.0 39850.0 41498.0 41537.6 41603.4 41620.2 37690.6 37924.6 37931.2 37961.8 37987.8 7039.4 7088.9 7137.6 7152.1 7174.6 7052.3 7120.4 7138.2 7139.7 7157.9 7802.0 7998.9 8002.8 8004.6 8005.6 7878.8 7935.8 7939.8 7944.6 7950.0 7763.3 7801.0 7879.6 7902.0 7965.0 37705.2 37710.8 37925.6 38142.2 38206.0 3165.2 3207.5 3207.6 3216.8 3217.3 31068.0 31232.4 31396.5 31489.2 31538.2 5024.7 5034.6 5084.3 5211.9 5288.3 183323.0 183984.0 185251.0 185468.0 186203.0 47219.0 47876.5 47962.5 48022.5 48031.5 50579.0 50660.5 50675.0 50693.2 50791.2 14567.1 14843.3 14897.6 14898.6 14903.6 11978.5 11983.7 11994.3 11996.4 11999.9 13848.7 13927.7 13952.0 13989.5 14095.7 5912.5 5930.4 5967.3 5983.3 6032.5 1003.4 1014.8 1018.2 1023.4 1031.5 22602.1 22848.4 23173.2 23251.9 23260.5 1099.7 1110.7 1117.0 1118.3 1119.6 12283.4 12310.7 12352.1 12371.3 12418.0 212424.0 215725.0 223045.0 223319.0 223991.0 43751.8 44991.0 50686.0 53010.7 53199.0 1452.0 1462.9 1463.0 1476.1 1477.6 27629.0 27669.6 27675.0 28240.6 28271.2 37343.8 37593.1 37678.6 37706.8 37737.2 198548.0 201719.0 202612.0 202741.0 203936.0 33200.2 33572.0 33627.3 34163.1 34245.3 40369.2 41976.8 42011.4 42742.1 42787.6 31044.5 31598.7 31735.5 31874.7 32183.8 30282.7 31907.4 32019.8 32183.4 32287.8 34291.3 35645.5 35688.5 35703.5 35717.3 31269.0 31417.5 31435.7 31735.5 31907.4 23385.9 23659.3 23680.6 24031.6 24437.9 07:03:57 INFO - PID 19142 | 07:03:57 INFO - PID 19142 | [#2] jquery.html Cycles:180 Average:35512.37 Median:22735.99 stddev:87868.69 (386.5%) stddev-sans-first:88076.02 07:03:57 INFO - PID 19142 | Values: 569.5 576.6 578.5 587.8 613.7 22035.4 22691.9 22729.8 22742.2 22802.7 23147.4 24237.9 24339.9 24387.1 24655.6 6511.5 6671.3 6690.1 6698.5 6706.8 6320.6 6504.3 6619.0 6622.4 6629.8 6557.0 6576.1 6590.2 6598.9 6605.2 6600.0 6602.5 6608.7 6610.5 6614.8 5910.6 6117.9 6125.4 6144.2 6147.4 27923.2 28588.1 28601.7 28614.4 28635.9 1960.6 1971.8 1982.0 1996.1 1998.8 18374.5 18830.8 19092.2 19210.1 19256.4 2428.4 2464.6 2487.0 2515.7 2516.6 122998.0 128844.0 134311.0 135421.0 142570.0 14211.5 14659.7 14675.5 14874.2 15002.8 22650.1 22714.4 22885.8 22912.5 22970.5 9683.6 9883.0 9898.6 9950.4 10023.0 9110.4 9159.3 9200.5 9278.3 9288.7 8902.4 8953.8 9090.4 9105.7 9284.2 2606.6 2652.6 2690.6 2727.2 2738.5 946.1 960.2 974.1 978.7 990.8 18392.4 18677.8 18990.8 18994.8 19147.0 1011.6 1024.6 1031.1 1048.5 1051.3 10232.3 10464.2 10480.0 10490.4 10504.8 501115.0 513413.0 522074.0 533262.0 550359.0 117531.0 117781.0 117798.0 118805.0 121018.0 1044.3 1142.4 1178.0 1214.6 1217.1 18983.7 19579.5 19765.1 19811.7 19875.8 55483.0 58241.0 58434.7 59322.7 59447.7 70134.6 71683.0 73696.3 74193.6 74759.6 13612.2 13740.7 13845.9 13935.9 14049.8 21862.0 21920.5 22202.3 22235.0 22610.2 17597.0 17781.4 17927.5 17933.6 17942.4 15388.2 15855.0 16230.6 16237.0 16654.4 18078.9 18104.4 18119.3 18337.4 18468.6 13819.5 13896.8 13965.1 13975.3 13999.9 17422.2 17654.0 17817.2 17825.6 17968.4 07:03:57 INFO - PID 19142 | 07:03:57 INFO - PID 19142 | [#3] mootools.html Cycles:180 Average:9319.39 Median:2640.36 stddev:6604.09 (250.1%) stddev-sans-first:6594.95 07:03:57 INFO - PID 19142 | Values: 1273.4 1317.0 1340.4 1342.4 1348.2 14713.4 15407.5 15433.8 15434.0 15448.2 14753.9 14909.0 14956.8 14968.8 14999.2 2773.4 2818.2 2867.4 2868.1 2869.4 2592.8 2594.6 2605.7 2605.8 2634.0 2723.7 2828.0 2851.4 2851.8 2858.7 2640.1 2640.7 2650.3 2666.6 2680.8 2633.1 2639.8 2838.0 2840.2 2844.9 15143.8 15285.8 15286.9 15287.6 15287.8 7880.8 8157.3 8206.1 8210.3 8222.8 5351.5 5447.3 5490.1 5581.8 5586.5 1914.6 1926.8 1932.2 1967.6 1990.9 25896.0 26295.6 26330.6 26576.5 26773.6 6591.3 6707.2 6846.5 6873.8 6932.2 16903.6 16954.5 16994.7 17009.3 17042.7 7768.0 7892.7 7910.1 7918.9 7921.3 7160.6 7186.8 7201.4 7226.1 7226.5 5191.3 5270.2 5303.1 5308.3 5385.3 1563.6 1573.8 1589.8 1597.5 1599.3 834.1 841.3 861.5 866.5 867.2 7321.1 7349.6 7375.9 7405.3 7429.6 697.0 699.8 712.3 718.6 721.8 5288.8 5312.2 5317.6 5463.8 5563.8 20066.0 21014.8 21129.3 21348.7 21357.5 20522.5 20728.1 21078.8 21084.6 21388.3 10963.3 11013.9 11488.4 11510.8 11530.1 8680.4 9024.7 9027.0 9199.7 9309.0 18564.1 18598.3 18604.6 18708.5 18767.9 18907.2 19037.1 19568.1 19580.7 19630.7 12135.5 12229.8 12236.1 12256.8 12377.3 13723.7 13772.7 13917.6 13936.0 13993.5 10820.4 10863.6 10932.5 10961.5 10989.3 10612.8 10665.4 10720.9 10879.4 11015.7 9710.0 9805.6 9887.2 9901.0 9915.0 7347.2 7356.6 7382.1 7390.6 7493.2 7576.5 7682.1 7688.2 7743.1 7746.7 07:03:57 INFO - PID 19142 | 07:03:57 INFO - PID 19142 | [#4] prototype.html Cycles:180 Average:5676.82 Median:6284.25 stddev:1499.87 (23.9%) stddev-sans-first:1452.88 07:03:57 INFO - PID 19142 | Values: 500.0 524.3 530.5 530.9 536.5 6310.9 6360.9 6418.9 6430.9 6438.3 6285.5 6285.8 6288.7 6304.6 6323.2 5209.9 5250.7 5263.2 5276.4 5278.6 5271.7 5292.9 5299.3 5307.6 5318.7 5131.3 5159.9 5223.5 5274.0 5299.4 5209.4 5252.5 5305.5 5323.3 5329.5 4865.9 4919.6 4930.1 4938.5 4942.8 6107.5 6270.5 6283.7 6284.8 6292.7 5978.6 6036.0 6076.0 6090.8 6104.0 6726.4 6734.5 6742.5 6744.7 6804.6 5335.9 5341.2 5420.4 5433.9 5452.2 6653.8 6947.8 7009.2 7040.4 7106.2 5541.8 5546.6 5575.9 5590.4 5607.2 5544.4 5589.9 5600.8 5658.6 5673.4 5969.5 5983.1 5983.7 6034.8 6045.8 6695.3 6718.4 6743.2 6757.9 6823.8 1959.4 1959.7 1962.8 1964.5 1975.0 1390.5 1439.5 1441.9 1451.9 1476.4 5762.3 5767.7 5781.3 5786.6 5796.4 6749.4 6808.4 6810.3 6810.3 6833.2 5766.9 5777.4 5812.5 5831.6 5866.8 3605.4 3617.3 3621.7 3646.1 3666.4 6518.2 6541.3 6567.1 6568.1 6589.7 6813.7 6828.8 6903.3 6956.2 7005.7 6338.3 6415.2 6418.1 6434.3 6519.9 6599.7 6728.6 6778.0 6785.5 6843.3 6673.3 6766.9 6783.5 6789.3 6799.5 6305.6 6495.2 6537.8 6552.4 6593.8 5559.2 5567.9 5572.3 5577.6 5586.7 6473.9 6512.0 6608.3 6789.3 6838.0 6201.2 6524.6 6540.2 6563.0 6598.2 6510.2 6553.8 6586.6 6608.2 6626.9 6381.4 6399.9 6455.7 6487.2 6509.9 6378.7 6433.7 6439.4 6579.7 6589.9 6213.5 6248.8 6345.3 6359.8 6370.5 07:03:57 INFO - PID 19142 | 07:03:57 INFO - PID 19142 | [#5] yui.html Cycles:180 Average:25269.52 Median:20446.44 stddev:35605.97 (174.1%) stddev-sans-first:35658.80 07:03:57 INFO - PID 19142 | Values: 889.3 907.7 914.3 925.4 946.2 19515.0 20335.3 20491.3 20504.4 20527.6 18359.7 18462.4 18653.8 18833.3 18974.1 964.4 974.4 975.9 975.9 979.9 969.5 991.3 994.3 995.1 995.3 1043.0 1059.0 1059.3 1059.4 1059.8 1049.3 1050.0 1050.2 1051.1 1054.4 728.9 743.3 750.5 752.1 774.4 20401.6 20692.5 20701.9 20767.8 20802.8 22005.1 22068.9 22808.8 22891.4 23111.4 17622.8 17785.1 18094.6 18204.7 18270.9 3784.7 3802.2 3812.0 3812.2 3819.1 136494.0 136616.0 138941.3 140869.0 141955.3 16568.0 16979.2 17019.7 17044.0 17087.3 30860.7 31009.7 31913.7 32175.2 32207.5 9172.8 9278.5 9300.3 9326.2 9333.6 4381.0 4475.1 4509.4 4521.8 4599.1 5326.6 5387.5 5393.8 5402.6 5421.2 1007.5 1027.9 1049.0 1051.9 1053.4 697.7 715.4 726.5 729.1 736.5 12225.8 12267.8 12543.5 12692.2 12859.0 704.2 709.8 714.6 725.2 730.7 5577.9 5614.2 5745.1 5748.3 5787.4 125924.4 126093.0 127169.0 128067.0 129934.0 80693.0 80853.0 90607.5 105302.0 112674.0 94852.0 95709.0 96240.0 96407.0 100829.5 12079.5 12740.0 13024.2 13107.8 13151.0 41028.2 42062.8 43023.6 43733.6 44924.8 75846.0 81080.0 82915.6 84790.6 86952.1 18370.1 18456.9 18556.3 18572.9 18585.3 19110.5 19384.1 19425.0 19563.7 19587.4 18292.0 18436.5 18510.4 18771.8 18837.8 17259.7 17413.0 17426.7 17489.9 17523.6 16148.8 16174.4 16220.0 16347.8 16367.0 12843.3 13015.2 13326.0 13376.7 13452.1 12598.0 12785.8 12857.0 12971.7 13029.7 07:03:57 INFO - PID 19142 | -------- Summary: end -------- 07:03:57 INFO - PID 19142 | 07:03:57 INFO - TEST-INFO | 19142: exit 0 07:03:57 INFO - TEST-OK | dromaeo_css | took 1108744ms 07:03:57 INFO - TEST-START | kraken 07:03:57 INFO - Initialising browser for kraken test... 07:03:57 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:53006/getInfo.html -profile /tmp/tmpXVLrdR/profile 07:03:57 INFO - TEST-INFO | started process 19510 (/builds/slave/test/build/application/firefox/firefox http://localhost:53006/getInfo.html) 07:04:02 INFO - TEST-INFO | 19510: exit 0 07:04:02 INFO - Browser initialized. 07:04:02 INFO - Running cycle 1/1 for kraken test... 07:04:02 INFO - Using env: {'DISPLAY': ':0', 07:04:02 INFO - 'HOME': '/home/cltbld', 07:04:02 INFO - 'JSGC_DISABLE_POISONING': '1', 07:04:02 INFO - 'LANG': 'en_US.UTF-8', 07:04:02 INFO - 'LANGUAGE': 'en_US:en', 07:04:02 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 07:04:02 INFO - 'LOGNAME': 'cltbld', 07:04:02 INFO - 'MAIL': '/var/mail/cltbld', 07:04:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:04:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:04:02 INFO - 'MOZ_CRASHREPORTER': '1', 07:04:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:04:02 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 07:04:02 INFO - 'MOZ_NO_REMOTE': '1', 07:04:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:04:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:04:02 INFO - 'NO_EM_RESTART': '1', 07:04:02 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:04:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:04:02 INFO - 'PWD': '/builds/slave/test', 07:04:02 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:04:02 INFO - 'RUST_BACKTRACE': 'full', 07:04:02 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 07:04:02 INFO - 'SHELL': '/bin/bash', 07:04:02 INFO - 'SHLVL': '1', 07:04:02 INFO - 'TERM': 'linux', 07:04:02 INFO - 'TMOUT': '86400', 07:04:02 INFO - 'USER': 'cltbld', 07:04:02 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1505911076.696222-1964767027', 07:04:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:04:02 INFO - '_': '/tools/buildbot/bin/python'} 07:04:02 INFO - TEST-INFO | started process 19754 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXVLrdR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 07:04:03 INFO - PID 19754 | 07:04:03 INFO - PID 19754 | (/builds/slave/test/build/application/firefox/firefox:19803): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 07:04:03 INFO - PID 19754 | 07:04:13 INFO - PID 19754 | RSS: Main: 154390528 07:04:13 INFO - PID 19754 | 07:04:16 INFO - PID 19754 | Cycle 1(1): loaded http://localhost:53006/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53006/tests/kraken/driver.html?testName=audio-beat-detection) 07:04:17 INFO - PID 19754 | RSS: Main: 161017856 07:04:17 INFO - PID 19754 | 07:04:20 INFO - PID 19754 | Cycle 1(1): loaded http://localhost:53006/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53006/tests/kraken/driver.html?testName=audio-dft) 07:04:20 INFO - PID 19754 | RSS: Main: 161325056 07:04:20 INFO - PID 19754 | 07:04:23 INFO - PID 19754 | Cycle 1(1): loaded http://localhost:53006/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53006/tests/kraken/driver.html?testName=audio-fft) 07:04:24 INFO - PID 19754 | RSS: Main: 157032448 07:04:24 INFO - PID 19754 | 07:04:26 INFO - PID 19754 | Cycle 1(1): loaded http://localhost:53006/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53006/tests/kraken/driver.html?testName=audio-oscillator) 07:04:27 INFO - PID 19754 | RSS: Main: 157491200 07:04:27 INFO - PID 19754 | 07:04:29 INFO - PID 19754 | Cycle 1(1): loaded http://localhost:53006/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53006/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:04:29 INFO - PID 19754 | RSS: Main: 157409280 07:04:29 INFO - PID 19754 | 07:04:33 INFO - PID 19754 | Cycle 1(1): loaded http://localhost:53006/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53006/tests/kraken/driver.html?testName=imaging-darkroom) 07:04:33 INFO - PID 19754 | RSS: Main: 159440896 07:04:33 INFO - PID 19754 | 07:04:37 INFO - PID 19754 | Cycle 1(1): loaded http://localhost:53006/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53006/tests/kraken/driver.html?testName=imaging-desaturate) 07:04:37 INFO - PID 19754 | RSS: Main: 159776768 07:04:37 INFO - PID 19754 | 07:04:40 INFO - PID 19754 | Cycle 1(1): loaded http://localhost:53006/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53006/tests/kraken/driver.html?testName=json-parse-financial) 07:04:41 INFO - PID 19754 | RSS: Main: 160178176 07:04:41 INFO - PID 19754 | 07:04:43 INFO - PID 19754 | Cycle 1(1): loaded http://localhost:53006/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53006/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:04:43 INFO - PID 19754 | RSS: Main: 160260096 07:04:43 INFO - PID 19754 | 07:04:45 INFO - PID 19754 | Cycle 1(1): loaded http://localhost:53006/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53006/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:04:45 INFO - PID 19754 | RSS: Main: 157724672 07:04:45 INFO - PID 19754 | 07:04:48 INFO - PID 19754 | Cycle 1(1): loaded http://localhost:53006/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53006/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:04:48 INFO - PID 19754 | RSS: Main: 157491200 07:04:48 INFO - PID 19754 | 07:04:51 INFO - PID 19754 | Cycle 1(1): loaded http://localhost:53006/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53006/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:04:51 INFO - PID 19754 | RSS: Main: 157921280 07:04:51 INFO - PID 19754 | 07:04:54 INFO - PID 19754 | Cycle 1(1): loaded http://localhost:53006/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53006/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:04:55 INFO - PID 19754 | RSS: Main: 157855744 07:04:55 INFO - PID 19754 | 07:04:57 INFO - PID 19754 | Cycle 1(1): loaded http://localhost:53006/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53006/tests/kraken/driver.html?testName=ai-astar) 07:04:57 INFO - PID 19754 | RSS: Main: 159133696 07:04:57 INFO - PID 19754 | 07:04:57 INFO - PID 19754 | __start_tp_report 07:04:57 INFO - PID 19754 | _x_x_mozilla_page_load 07:04:57 INFO - PID 19754 | _x_x_mozilla_page_load_details 07:04:57 INFO - PID 19754 | |i|pagename|runs| 07:04:57 INFO - PID 19754 | |0;ai-astar;109;108;107;107;106;108;108;108;106;109 07:04:57 INFO - PID 19754 | |1;audio-beat-detection;119;120;117;114;116;115;120;115;138;116 07:04:57 INFO - PID 19754 | |2;audio-dft;166;163;164;163;163;162;163;164;169;164 07:04:57 INFO - PID 19754 | |3;audio-fft;74;77;74;73;73;78;75;75;73;78 07:04:57 INFO - PID 19754 | |4;audio-oscillator;81;80;81;83;80;79;78;79;79;78 07:04:57 INFO - PID 19754 | |5;imaging-gaussian-blur;113;113;113;114;115;113;114;114;114;114 07:04:57 INFO - PID 19754 | |6;imaging-darkroom;149;149;147;148;146;148;148;150;147;149 07:04:57 INFO - PID 19754 | |7;imaging-desaturate;99;94;94;94;94;95;94;99;95;94 07:04:57 INFO - PID 19754 | |8;json-parse-financial;54;54;54;54;54;55;53;55;56;53 07:04:57 INFO - PID 19754 | |9;json-stringify-tinderbox;39;38;38;38;39;38;38;39;38;38 07:04:57 INFO - PID 19754 | |10;stanford-crypto-aes;72;76;75;73;72;72;79;77;76;74 07:04:57 INFO - PID 19754 | |11;stanford-crypto-ccm;112;109;121;112;113;114;112;116;114;116 07:04:57 INFO - PID 19754 | |12;stanford-crypto-pbkdf2;175;168;171;168;173;174;174;175;177;169 07:04:57 INFO - PID 19754 | |13;stanford-crypto-sha256-iterative;69;67;65;67;65;72;67;65;65;64 07:04:57 INFO - PID 19754 | __end_tp_report 07:04:57 INFO - PID 19754 | __start_cc_report 07:04:57 INFO - PID 19754 | _x_x_mozilla_cycle_collect,759 07:04:57 INFO - PID 19754 | __end_cc_report 07:04:57 INFO - PID 19754 | __startTimestamp1505916297539__endTimestamp 07:04:57 INFO - PID 19754 | 07:04:57 INFO - PID 19754 | ------- Summary: start ------- 07:04:57 INFO - PID 19754 | Number of tests: 14 07:04:57 INFO - PID 19754 | 07:04:57 INFO - PID 19754 | [#0] ai-astar Cycles:10 Average:107.60 Median:108.00 stddev:1.07 (1.0%) stddev-sans-first:1.01 07:04:57 INFO - PID 19754 | Values: 109.0 108.0 107.0 107.0 106.0 108.0 108.0 108.0 106.0 109.0 07:04:57 INFO - PID 19754 | 07:04:57 INFO - PID 19754 | [#1] audio-beat-detection Cycles:10 Average:119.00 Median:118.00 stddev:7.01 (5.9%) stddev-sans-first:7.43 07:04:57 INFO - PID 19754 | Values: 119.0 120.0 117.0 114.0 116.0 115.0 120.0 115.0 138.0 116.0 07:04:57 INFO - PID 19754 | 07:04:57 INFO - PID 19754 | [#2] audio-dft Cycles:10 Average:164.10 Median:164.00 stddev:2.02 (1.2%) stddev-sans-first:2.03 07:04:57 INFO - PID 19754 | Values: 166.0 163.0 164.0 163.0 163.0 162.0 163.0 164.0 169.0 164.0 07:04:57 INFO - PID 19754 | 07:04:57 INFO - PID 19754 | [#3] audio-fft Cycles:10 Average:75.00 Median:75.00 stddev:2.00 (2.7%) stddev-sans-first:2.09 07:04:57 INFO - PID 19754 | Values: 74.0 77.0 74.0 73.0 73.0 78.0 75.0 75.0 73.0 78.0 07:04:57 INFO - PID 19754 | 07:04:57 INFO - PID 19754 | [#4] audio-oscillator Cycles:10 Average:79.80 Median:80.00 stddev:1.55 (1.9%) stddev-sans-first:1.58 07:04:57 INFO - PID 19754 | Values: 81.0 80.0 81.0 83.0 80.0 79.0 78.0 79.0 79.0 78.0 07:04:57 INFO - PID 19754 | 07:04:57 INFO - PID 19754 | [#5] imaging-gaussian-blur Cycles:10 Average:113.70 Median:114.00 stddev:0.67 (0.6%) stddev-sans-first:0.67 07:04:57 INFO - PID 19754 | Values: 113.0 113.0 113.0 114.0 115.0 113.0 114.0 114.0 114.0 114.0 07:04:57 INFO - PID 19754 | 07:04:57 INFO - PID 19754 | [#6] imaging-darkroom Cycles:10 Average:148.10 Median:148.50 stddev:1.20 (0.8%) stddev-sans-first:1.22 07:04:57 INFO - PID 19754 | Values: 149.0 149.0 147.0 148.0 146.0 148.0 148.0 150.0 147.0 149.0 07:04:57 INFO - PID 19754 | 07:04:57 INFO - PID 19754 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:94.50 stddev:2.04 (2.2%) stddev-sans-first:1.64 07:04:57 INFO - PID 19754 | Values: 99.0 94.0 94.0 94.0 94.0 95.0 94.0 99.0 95.0 94.0 07:04:57 INFO - PID 19754 | 07:04:57 INFO - PID 19754 | [#8] json-parse-financial Cycles:10 Average:54.20 Median:54.00 stddev:0.92 (1.7%) stddev-sans-first:0.97 07:04:57 INFO - PID 19754 | Values: 54.0 54.0 54.0 54.0 54.0 55.0 53.0 55.0 56.0 53.0 07:04:57 INFO - PID 19754 | 07:04:57 INFO - PID 19754 | [#9] json-stringify-tinderbox Cycles:10 Average:38.30 Median:38.00 stddev:0.48 (1.3%) stddev-sans-first:0.44 07:04:57 INFO - PID 19754 | Values: 39.0 38.0 38.0 38.0 39.0 38.0 38.0 39.0 38.0 38.0 07:04:57 INFO - PID 19754 | 07:04:57 INFO - PID 19754 | [#10] stanford-crypto-aes Cycles:10 Average:74.60 Median:75.50 stddev:2.41 (3.2%) stddev-sans-first:2.37 07:04:57 INFO - PID 19754 | Values: 72.0 76.0 75.0 73.0 72.0 72.0 79.0 77.0 76.0 74.0 07:04:57 INFO - PID 19754 | 07:04:57 INFO - PID 19754 | [#11] stanford-crypto-ccm Cycles:10 Average:113.90 Median:114.00 stddev:3.25 (2.8%) stddev-sans-first:3.37 07:04:57 INFO - PID 19754 | Values: 112.0 109.0 121.0 112.0 113.0 114.0 112.0 116.0 114.0 116.0 07:04:57 INFO - PID 19754 | 07:04:57 INFO - PID 19754 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.40 Median:174.00 stddev:3.20 (1.8%) stddev-sans-first:3.26 07:04:57 INFO - PID 19754 | Values: 175.0 168.0 171.0 168.0 173.0 174.0 174.0 175.0 177.0 169.0 07:04:57 INFO - PID 19754 | 07:04:57 INFO - PID 19754 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.60 Median:67.00 stddev:2.41 (3.6%) stddev-sans-first:2.40 07:04:57 INFO - PID 19754 | Values: 69.0 67.0 65.0 67.0 65.0 72.0 67.0 65.0 65.0 64.0 07:04:57 INFO - PID 19754 | -------- Summary: end -------- 07:04:57 INFO - PID 19754 | 07:04:57 INFO - PID 19754 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 07:04:58 INFO - TEST-INFO | 19754: exit 0 07:04:58 INFO - TEST-OK | kraken | took 60384ms 07:04:58 INFO - SUITE-END | took 1169s 07:04:58 INFO - Completed test suite (00:19:29) 07:04:58 INFO - javascript benchmark 07:04:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8601.034665029661, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3139.7645176611754, 3158.052584224732, 3159.210197450637, 3164.1614972032417, 3170.064830874892, 6227.252729672435, 6298.968505157468, 6340.746370145194, 6360.713767880445, 6407.935920640793, 6278.748850045993, 6356.237251529811, 6432.7105280262385, 6472.967635161817, 6486.805395838121, 5755.654660720349, 5786.768529258825, 5813.709314534278, 5874.9412505874825, 5880.26496687914, 5819.476247137757, 5849.912251316234, 5896.380880007602, 5909.556783241253, 5919.348871624118, 5723.170140329649, 5793.855153621151, 5795.641914240287, 5809.448102430262, 5871.823845284648, 5751.539876809845, 5831.679257640828, 5834.883302333972, 5843.18195452637, 5855.648661080349, 5739.426057394227, 5792.478676919098, 5816.243888294494, 5826.708664566755, 5837.124431335334, 6171.783987560459, 6199.969000155015, 6282.026285925689, 6295.2760432550385, 6361.713722882481, 6647.501437392167, 6659.134312539387, 6683.331666833326, 6683.4987375947, 6692.531522793406, 6672.165979252593, 6710.127683401175, 6753.290904455011, 6823.761168359133, 6823.863522729517, 6050.21347224858, 6249.843753906189, 6252.937470625281, 6336.271328797156, 6345.87308253837, 6869.896951545731, 7008.684609192598, 7013.824654383681, 7057.576545407189, 7076.433885289164, 6631.469482441489, 6658.5671931324305, 6669.63317017559, 6736.7642132525125, 6747.190337159573, 6521.673916304166, 6674.833129171712, 6682.3317668232785, 6698.966505167443, 6702.899456508157, 6650.70071846768, 6657.7669781557415, 6662.0006998949575, 6672.366125218194, 6684.465242780566, 6685.39831415175, 6704.564203326768, 6712.160979877515, 6716.664166791641, 6718.563293385914, 5179.300794392784, 5265.21021846726, 5274.683518988873, 5327.094393953037, 5337.359516858002, 4593.081383723269, 4640.164770341304, 4676.368690226844, 4720.33915251865, 4729.527047295243, 5769.769209231667, 5773.018586840247, 5850.64896106235, 5852.122181672698, 5856.355800861902, 6598.7030583623855, 6729.528932974645, 6729.5625784323865, 6747.662616869137, 6751.088603038527, 5786.363500014995, 5795.681237531892, 5879.147523609138, 5886.175935369051, 5886.381929897299, 5842.328132264759, 5861.648301101947, 5911.113332999998, 5920.111983202554, 5930.911036334458, 6452.0, 6465.644389558525, 6543.1166792483355, 6546.639934803537, 6625.4037136657935, 6679.365460281266, 6769.966150169218, 6802.217744959393, 6810.965945170342, 6893.655317234218, 6559.508036897157, 6601.141851559459, 6607.7356905725155, 6608.50436217276, 6614.140161778938, 6691.46468282546, 6724.991251312343, 6835.179778426422, 6848.931510685029, 6849.931500684929, 6842.93157068423, 6867.931320686729, 6911.205211400753, 6985.5808651481075, 6986.056882321025, 6483.902741458787, 6581.638009909501, 6611.272759996493, 6705.161854768154, 6709.194896612243, 6549.869002619826, 6554.868902622016, 6557.082008518716, 6567.179102612174, 6631.469482441489, 6527.738890444329, 6616.206055273398, 6633.734650613921, 6657.567258128206, 6668.29982851813, 6674.799756007327, 6676.0, 6697.162854643169, 6756.290589488033, 6781.38967492928, 6374.713137908712, 6431.48548116159, 6435.51733619971, 6443.0, 6541.0], "value": 6169.910007425394, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [840.7645859159437, 870.7561882672852, 898.8337157625836, 903.6972614174249, 903.986440203397, 39850.0, 41498.0, 41537.584624153715, 41603.37594936079, 41620.16759664813, 37690.62309376912, 37924.62075379246, 37931.24137517248, 37961.81019094901, 37987.810060949654, 7039.366457018855, 7088.85822283554, 7137.571745695275, 7152.141742990849, 7174.6412679366085, 7052.294770522933, 7120.359167674908, 7138.214796372395, 7139.714411423537, 7157.89263161053, 7801.960990195041, 7998.920010799905, 8002.759917202493, 8004.599770011476, 8005.5997200140055, 7878.803029924269, 7935.841283174333, 7939.761807145795, 7944.563049032301, 7950.0, 7763.301302882711, 7801.0, 7879.645415956295, 7901.96049019757, 7965.044194696674, 37705.24589508222, 37710.81144594287, 37925.62074379248, 38142.23715525702, 38206.0, 3165.1770539659624, 3207.4868021116745, 3207.5990501187352, 3216.7748257621975, 3217.276112874608, 31068.0, 31232.37535249282, 31396.529052064237, 31489.21276968071, 31538.211544711336, 5024.673396229234, 5034.597232221414, 5084.339035925343, 5211.9218211726475, 5288.338957630296, 183323.0, 183984.0, 185251.0, 185468.0, 186202.99999999863, 47219.0, 47876.521234787906, 47962.520374796506, 48022.5197748018, 48031.519684802704, 50579.0, 50660.49339506632, 50675.0, 50693.23960140601, 50791.23813142806, 14567.125972441687, 14843.257837108102, 14897.627559311104, 14898.627534311729, 14903.627409314853, 11978.520859165536, 11983.700407489883, 11994.280343179436, 11996.40017999114, 11999.940000300117, 13848.653783655489, 13927.651808704863, 13952.0, 13989.510367137102, 14095.71808563823, 5912.526997840162, 5930.377310382434, 5967.254093238345, 5983.252093488314, 6032.4570788629235, 1003.4280460137652, 1014.7716763728102, 1018.1701912940929, 1023.4268809466722, 1031.510032734445, 22602.127223768337, 22848.428789280402, 23173.188938387077, 23251.88374058153, 23260.534789304118, 1099.7290594921622, 1110.7334239782394, 1116.9944150279196, 1118.2507719827736, 1119.6249256499002, 12283.366981829891, 12310.692232694255, 12352.147177923383, 12371.319577423148, 12418.049362619959, 212424.0, 215725.0, 223045.0, 223319.0, 223991.0, 43751.78124109423, 44991.0, 50686.0, 53010.73494632502, 53199.0, 1452.0, 1462.9487967921284, 1462.9853701463062, 1476.0553245922617, 1477.5788900163402, 27629.0, 27669.584956226074, 27675.0, 28240.576391354556, 28271.15186544407, 37343.81328093342, 37593.060173495884, 37678.62321376751, 37706.8114659425, 37737.245255095295, 198548.0, 201719.0, 202612.0, 202741.0, 203936.0, 33200.1699957503, 33572.0, 33627.32745345031, 34163.14592135117, 34245.31509369848, 40369.192616146924, 41976.79011605045, 42011.36982945197, 42742.14515709731, 42787.57212427836, 31044.534331984585, 31598.684013159575, 31735.52396714005, 31874.6812531881, 32183.839080805385, 30282.697173027987, 31907.36185276235, 32019.839900800347, 32183.35633287368, 32287.838560807046, 34291.314173716884, 35645.46531802077, 35688.464673030445, 35703.464448032784, 35717.28565428729, 31269.0, 31417.528737068504, 31435.685643144192, 31735.52396714005, 31907.36185276328, 23385.88307058454, 23659.290221293388, 23680.644790328504, 24031.63952540748, 24437.877810610833], "value": 16969.219975336036, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [569.4618585436762, 576.5906206593319, 578.4995978478614, 587.8383444552749, 613.6839527643264, 22035.449113772145, 22691.886540567295, 22729.772702272992, 22742.20402285916, 22802.65796013061, 23147.42131446715, 24237.878810605966, 24339.878300608518, 24387.146449874257, 24655.630165547533, 6511.479081673467, 6671.266160722341, 6690.096836927026, 6698.531102822804, 6706.798796036127, 6320.5891617044745, 6504.284528701839, 6619.0, 6622.403983641471, 6629.8342541436605, 6557.0, 6576.112224849656, 6590.209174898995, 6598.901016484757, 6605.207375114969, 6599.967000164993, 6602.537822352438, 6608.735650573972, 6610.471162307004, 6614.768483103068, 5910.586258961875, 6117.908231376533, 6125.418085281891, 6144.170536977495, 6147.44672979434, 27923.162305130674, 28588.14235572936, 28601.71398286032, 28614.427711445864, 28635.85682071597, 1960.5882764619448, 1971.7732460766908, 1982.0, 1996.0518753592073, 1998.7901270366547, 18374.540636484195, 18830.811691883042, 19092.23631054756, 19210.135543900557, 19256.422307330802, 2428.3686241577316, 2464.581021226396, 2486.962695559568, 2515.72327044025, 2516.622506624021, 122998.0, 128844.0, 134311.0, 135421.0, 142570.0, 14211.50259740904, 14659.706805864036, 14675.486357977634, 14874.181919994504, 15002.774958375632, 22650.093996239964, 22714.43213919665, 22885.771142288362, 22912.541749165255, 22970.540589188124, 9683.564239609235, 9882.950585247172, 9898.554565044591, 9950.35322704022, 10023.0, 9110.36227464071, 9159.267258619295, 9200.539973001458, 9278.304127190488, 9288.674896378594, 8902.42134261271, 8953.820923581492, 9090.36367454285, 9105.726828195166, 9284.164425201765, 2606.6090086486797, 2652.58884872845, 2690.56950887857, 2727.1682136948025, 2738.52075886719, 946.1266691949977, 960.1694534227983, 974.0697633759884, 978.6623614852864, 990.8216521026285, 18392.448226553224, 18677.813221867607, 18990.810091898904, 18994.810051899305, 19147.0, 1011.5599714124232, 1024.6106479537877, 1031.1132426113536, 1048.5072016152396, 1051.332403923514, 10232.334898231591, 10464.21518386124, 10480.004399582027, 10490.370577765358, 10504.842427363596, 501115.0, 513413.0, 522074.0, 533262.0, 550359.0, 117531.0, 117781.0, 117798.0, 118805.0, 121018.0, 1044.3003187863997, 1142.4173671427632, 1177.9823302650468, 1214.5688280660415, 1217.0811037666329, 18983.71524427162, 19579.51051223731, 19765.11057002467, 19811.702824457934, 19875.801241987396, 55483.0, 58241.0, 58434.707826460595, 59322.70338648279, 59447.70276148592, 70134.64932675305, 71683.0, 73696.26303737109, 74193.62903185449, 74759.62620187082, 13612.183269003892, 13740.725185496434, 13845.861541384456, 13935.860641393456, 14049.789253161414, 21862.0, 21920.45198870041, 22202.333929982127, 22235.0, 22610.208642697427, 17597.0, 17781.377651782124, 17927.462176134737, 17933.551661208574, 17942.37201697934, 15388.230588470755, 15855.0, 16230.594235144215, 16237.0, 16654.41709540209, 18078.90960545189, 18104.366347177787, 18119.275228990693, 18337.358192463733, 18468.630627387647, 13819.516316929261, 13896.791548126988, 13965.092269002482, 13975.30123493801, 13999.930000349934, 17422.21600028027, 17654.0, 17817.198226080116, 17825.643487130445, 17968.371107011193], "value": 11851.637561959662, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1273.3887733887734, 1317.0, 1340.4236178443266, 1342.4227582139679, 1348.2112963916109, 14713.411463541446, 15407.537773866788, 15433.84566154338, 15434.0, 15448.22758862058, 14753.852461475382, 14909.0, 14956.775648365256, 14968.775468367956, 14999.1750453725, 2773.4314465534617, 2818.2109009477326, 2867.3835125448027, 2868.1108856254523, 2869.411770587025, 2592.753688399599, 2594.558924982748, 2605.674290713661, 2605.7654811067, 2634.025410598081, 2723.700392956773, 2828.0, 2851.4297140571866, 2851.786116041295, 2858.7284208000206, 2640.0627777139125, 2640.656714627096, 2650.3374156460886, 2666.560017597094, 2680.798940079502, 2633.0521012435506, 2639.8416095034167, 2837.9716202837913, 2840.2047426720346, 2844.857757112136, 15143.772843407358, 15285.847141528664, 15286.923565382102, 15287.617809554738, 15287.770683439758, 7880.80297992549, 8157.306628936548, 8206.138355472709, 8210.30212431944, 8222.83554328916, 5351.518363347317, 5447.264619276387, 5490.149026900836, 5581.776728930838, 5586.525145362649, 1914.58836350184, 1926.7880533141342, 1932.2464238946823, 1967.616314818611, 1990.9004549772453, 25896.0, 26295.605565916525, 26330.6050409244, 26576.46847063048, 26773.59839602388, 6591.340865913467, 6707.1616047994, 6846.520743547904, 6873.759418420332, 6932.202796678345, 16903.577410564834, 16954.491365259062, 16994.660106797794, 17009.319627214772, 17042.659146816994, 7767.961160194162, 7892.723754668674, 7910.129885712567, 7918.920810791818, 7921.32668723165, 7160.641967901584, 7186.784396468114, 7201.3878820299815, 7226.096737907762, 7226.494145409771, 5191.299174611455, 5270.235815806686, 5303.071962406563, 5308.30991971049, 5385.27298814655, 1563.6169138560897, 1573.8268790433272, 1589.7774311596386, 1597.4888035828424, 1599.3202888772225, 834.0866750907746, 841.2554888923224, 861.5218553702755, 866.4887716247445, 867.2238346679686, 7321.084864391951, 7349.63251837406, 7375.852482950311, 7405.33351998312, 7429.554226746304, 696.982575435608, 699.7515881861967, 712.3232928717636, 718.619131860115, 721.7798571435658, 5288.81489147878, 5312.2297266896085, 5317.574594032468, 5463.836084917459, 5563.777448902079, 20066.0, 21014.78985210159, 21129.260475883577, 21348.679769803464, 21357.46606334823, 20522.486937826376, 20728.067236974373, 21078.78921210799, 21084.578308433745, 21388.251411200534, 10963.287386319864, 11013.889861101286, 11488.425578721197, 11510.82733759011, 11530.077593792477, 8680.392372533863, 9024.729258122266, 9027.0, 9199.724008279762, 9309.022552632146, 18564.071796410397, 18598.349057782914, 18604.627907441503, 18708.532286692396, 18767.906160469658, 18907.243710251434, 19037.14332854997, 19568.11943462519, 19580.706289405385, 19630.705539416635, 12135.453904574139, 12229.816552751538, 12236.082293828176, 12256.75486490283, 12377.319247441477, 13723.725525489634, 13772.724545508834, 13917.58247252584, 13936.024478286423, 13993.510227142002, 10820.4048777318, 10863.619773307897, 10932.453377331261, 10961.50673219723, 10989.285696429706, 10612.840807387742, 10665.41340226264, 10720.892791071989, 10879.401632909949, 11015.724606884893, 9709.951450242987, 9805.558749856416, 9887.209023278265, 9901.0, 9915.0, 7347.228541003117, 7356.558606483628, 7382.114146302478, 7390.556566606021, 7493.213212612597, 7576.507527010726, 7682.078150621961, 7688.231176882491, 7743.109542402696, 7746.65140068687], "value": 6636.800307013706, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [500.0, 524.3026774390062, 530.5437323901444, 530.9362876454825, 536.5332161019912, 6310.876116322415, 6360.872782544347, 6418.871622567546, 6430.935690643092, 6438.291787903327, 6285.465735412484, 6285.811425657238, 6288.748450062003, 6304.590201636902, 6323.20959880015, 5209.942072881219, 5250.65870718402, 5263.210518422248, 5276.366835979668, 5278.604104692164, 5271.710055946941, 5292.894142117156, 5299.33758280215, 5307.575393968493, 5318.734063296839, 5131.255967884655, 5159.922601160967, 5223.52988231061, 5273.973630131844, 5299.364076310848, 5209.374875015003, 5252.450527094478, 5305.549028332577, 5323.254744335796, 5329.53437804603, 4865.9026819463415, 4919.581835543983, 4930.137225985474, 4938.506149385069, 4942.752862356868, 6107.511399088063, 6270.46701030413, 6283.717232724538, 6284.780032698879, 6292.748290068392, 5978.581499295051, 6036.0, 6075.969620151871, 6090.817275481742, 6104.0, 6726.3609957054005, 6734.46124310054, 6742.52802303839, 6744.6627668616375, 6804.605055963516, 5335.893282134374, 5341.172118321666, 5420.3738878336735, 5433.945660543423, 5452.154915988028, 6653.833654158636, 6947.756828510978, 7009.228984811667, 7040.401565866908, 7106.2183159852375, 5541.778328866881, 5546.639468434539, 5575.8884822304135, 5590.413006634326, 5607.186957891165, 5544.362398324163, 5589.916151257735, 5600.803971860965, 5658.632188907708, 5673.432656734376, 5969.492593129633, 5983.132445795335, 5983.700814959322, 6034.758609655652, 6045.848853778691, 6695.263521012685, 6718.361755633305, 6743.224529179109, 6757.932420675828, 6823.761168359084, 1959.4219705187004, 1959.6570600144917, 1962.7644682638174, 1964.5088727818045, 1974.9506262343268, 1390.5133203378737, 1439.4817865568386, 1441.935112919921, 1451.898367114292, 1476.4463326252655, 5762.250907382014, 5767.682777447197, 5781.335146458211, 5786.623869448473, 5796.420357964254, 6749.392554670103, 6808.353206445379, 6810.28492008332, 6810.318968103249, 6833.180018397824, 5766.913496297559, 5777.364489906107, 5812.534997200214, 5831.562632802556, 5866.765329386777, 3605.351036813346, 3617.276544691072, 3621.7464777465325, 3646.124930016777, 3666.431703086026, 6518.185226846645, 6541.345865413516, 6567.113439685581, 6568.113304703804, 6589.7364105435245, 6813.727450902007, 6828.760993365208, 6903.309669033057, 6956.234814170437, 7005.684744186524, 6338.271098823602, 6415.1981002374705, 6418.133551970611, 6434.2600600930555, 6519.892467745291, 6599.7360105595235, 6728.629925354153, 6777.966110169417, 6785.457163427012, 6843.315668433316, 6673.299303573249, 6766.932330676827, 6783.491238157257, 6789.321067893368, 6799.490038247251, 6305.558610897193, 6495.188101487314, 6537.771178008747, 6552.3775241352, 6593.835154121185, 5559.16612508127, 5567.860803479945, 5572.328301509612, 5577.609567330248, 5586.748596313095, 6473.935260647333, 6511.967440162769, 6608.273089960197, 6789.321067893368, 6837.965810171117, 6201.224846894138, 6524.641144737085, 6540.1518178185415, 6563.0, 6598.241202261801, 6510.21877374718, 6553.803385898431, 6586.637734924625, 6608.207015158019, 6626.933730662631, 6381.3937675920715, 6399.8720025598295, 6455.677216139268, 6487.156669632917, 6509.934900650933, 6378.681065946591, 6433.710483028369, 6439.388258115471, 6579.671016449254, 6589.868202636017, 6213.502919766317, 6248.843778905563, 6345.333739957238, 6359.809205723651, 6370.4903607712195], "value": 5245.4484860101675, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [889.2930120554158, 907.7140700679286, 914.2822884036033, 925.4308600210873, 946.1957336264177, 19515.02424878756, 20335.28826491073, 20491.282805101826, 20504.38486845397, 20527.589448211027, 18359.724604130948, 18462.353817616386, 18653.81346186538, 18833.340833070844, 18974.146163422643, 964.4068897627943, 974.4348277998744, 975.8633791269228, 975.9414435133915, 979.9167070798991, 969.4764826993415, 991.3110388280148, 994.2741798487109, 995.0546980368642, 995.2535598301274, 1042.9739256518571, 1058.957641694335, 1059.332620449116, 1059.3749687684265, 1059.7562560611063, 1049.3284298049255, 1050.03921411908, 1050.2333296693419, 1051.127564121781, 1054.4200689620677, 728.9453291003143, 743.3087228877142, 750.4596690382915, 752.0749478141917, 774.446270916292, 20401.591968160552, 20692.482687932923, 20701.89649051745, 20767.792322076737, 20802.79197208024, 22005.11979520833, 22068.88965555178, 22808.77191228083, 22891.42771430711, 23111.422214444607, 17622.823771762247, 17785.110744462854, 18094.63810723791, 18204.726929096076, 18270.908645456686, 3784.7161462890117, 3802.2205447883116, 3812.0, 3812.2184952085036, 3819.0643292393543, 136493.999999999, 136615.95076073866, 138941.3052934739, 140869.0, 141955.29022354822, 16568.0, 16979.23593438298, 17019.659606807796, 17044.0, 17087.31650733957, 30860.691393086232, 31009.68990310113, 31913.680863191534, 32175.195620109684, 32207.51688724671, 9172.816543669089, 9278.48968306736, 9300.302477314228, 9326.207272381924, 9333.626654933862, 4381.0, 4475.1049790042125, 4509.368688383629, 4521.751303678264, 4599.126166028444, 5326.627136100436, 5387.461253874581, 5393.8112166074, 5402.621816472888, 5421.159720243369, 1007.536533194724, 1027.9155490956962, 1049.0348879031158, 1051.8527406163143, 1053.4258828938248, 697.7139372857105, 715.4312321704258, 726.4878260826105, 729.0959210578844, 736.4623824608066, 12225.755484890253, 12267.754644907052, 12543.498260069677, 12692.17500862441, 12859.0, 704.1901812915188, 709.8083517450259, 714.5926821711679, 725.2493669052611, 730.6748496918821, 5577.944220557823, 5614.1859430382365, 5745.052066408995, 5748.310202775694, 5787.421257874263, 125924.37037814752, 126093.0, 127169.0, 128067.0, 129934.0, 80693.0, 80853.0, 90607.54696226609, 105302.0, 112674.0, 94852.0, 95709.0, 96240.0, 96407.0, 100829.48755768669, 12079.51681932748, 12740.044496662602, 13024.218546887218, 13107.803382949072, 13151.0, 41028.1794364117, 42062.78968605137, 43023.56976430196, 43733.56266437422, 44924.77537612422, 75846.0, 81080.0, 82915.5854220725, 84790.57604711936, 86952.13047869693, 18370.081495925417, 18456.907715461337, 18556.257749689863, 18572.907135464236, 18585.25658973626, 19110.522236944187, 19384.127714253176, 19425.0287485628, 19563.706544402132, 19587.412377628694, 18292.0, 18436.539086522946, 18510.444686658884, 18771.812281877552, 18837.811621883604, 17259.654806904044, 17412.95522268668, 17426.651466970845, 17489.912550437166, 17523.56191095233, 16148.757768633244, 16174.433894814096, 16220.0, 16347.836521634632, 16367.0, 12843.293618851052, 13015.154014988995, 13326.0, 13376.665583360495, 13452.058355914993, 12598.0, 12785.808212877, 12857.0, 12971.740565188455, 13029.674258143243], "value": 9371.7243584643, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1422.5000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 108.0, 107.0, 107.0, 106.0, 108.0, 108.0, 108.0, 106.0, 109.0], "value": 107.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 120.0, 117.0, 114.0, 116.0, 115.0, 120.0, 115.0, 138.0, 116.0], "value": 119.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 163.0, 164.0, 163.0, 163.0, 162.0, 163.0, 164.0, 169.0, 164.0], "value": 164.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 77.0, 74.0, 73.0, 73.0, 78.0, 75.0, 75.0, 73.0, 78.0], "value": 75.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 80.0, 81.0, 83.0, 80.0, 79.0, 78.0, 79.0, 79.0, 78.0], "value": 79.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 113.0, 114.0, 115.0, 113.0, 114.0, 114.0, 114.0, 114.0], "value": 113.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 149.0, 147.0, 148.0, 146.0, 148.0, 148.0, 150.0, 147.0, 149.0], "value": 148.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 94.0, 94.0, 94.0, 94.0, 95.0, 94.0, 99.0, 95.0, 94.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 54.0, 54.0, 54.0, 55.0, 53.0, 55.0, 56.0, 53.0], "value": 54.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [39.0, 38.0, 38.0, 38.0, 39.0, 38.0, 38.0, 39.0, 38.0, 38.0], "value": 38.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 76.0, 75.0, 73.0, 72.0, 72.0, 79.0, 77.0, 76.0, 74.0], "value": 74.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 109.0, 121.0, 112.0, 113.0, 114.0, 112.0, 116.0, 114.0, 116.0], "value": 113.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 168.0, 171.0, 168.0, 173.0, 174.0, 174.0, 175.0, 177.0, 169.0], "value": 172.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 67.0, 65.0, 67.0, 65.0, 72.0, 67.0, 65.0, 65.0, 64.0], "value": 66.6, "unit": "score"}]}]} 07:04:58 INFO - Return code: 0 07:04:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:04:58 INFO - # TBPL SUCCESS # 07:04:58 INFO - Running post-action listener: _package_coverage_data 07:04:58 INFO - Running post-action listener: _resource_record_post_action 07:04:58 INFO - [mozharness: 2017-09-20 14:04:58.317392Z] Finished run-tests step (success) 07:04:58 INFO - Running post-run listener: _resource_record_post_run 07:04:58 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 12288; Write bytes: 339505152; Read time: 24; Write time: 215804 07:04:58 INFO - TinderboxPrint: CPU usage
13.1% 07:04:58 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 24 07:04:58 INFO - TinderboxPrint: I/O write bytes / time
339,505,152 / 215,804 07:04:58 INFO - TinderboxPrint: CPU idle
8,223.7 (86.9%) 07:04:58 INFO - TinderboxPrint: CPU user
1,192.8 (12.6%) 07:04:58 INFO - TinderboxPrint: Swap in / out
0 / 0 07:04:58 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 13340672; Read time: 0; Write time: 988 07:04:58 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 07:04:58 INFO - run-tests - Wall time: 1170s; CPU: 13.0%; Read bytes: 8192; Write bytes: 326164480; Read time: 12; Write time: 214816 07:04:58 INFO - Running post-run listener: _upload_blobber_files 07:04:58 INFO - Blob upload gear active. 07:04:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:04:58 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 07:04:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:04:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:04:59 INFO - (blobuploader) - INFO - Open directory for files ... 07:04:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:04:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:04:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:05:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:05:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:05:00 INFO - (blobuploader) - INFO - Done attempting. 07:05:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:05:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:05:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:05:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:05:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:05:01 INFO - (blobuploader) - INFO - Done attempting. 07:05:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 07:05:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:05:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:05:02 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 07:05:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:05:02 INFO - (blobuploader) - INFO - Done attempting. 07:05:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:05:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:05:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:05:08 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:05:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:05:08 INFO - (blobuploader) - INFO - Done attempting. 07:05:08 INFO - (blobuploader) - INFO - Iteration through files over. 07:05:08 INFO - Return code: 0 07:05:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:05:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:05:08 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/db07651d629fd3f6efe8a1a6e39707e710d8c4af62d05d31c11593571ef686b061f8593a807ab0907f8f54781a202b7a76c7dede75a8c802ab97f8cee3f01647", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7e06ca2750f9772347a83c9226c053654be612300d09629d560236cdd414d77e233d2b3d02f16382d7a6ecba06f985578686a9384ef995a0199d085bcd7f9ca4", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/623602b2909b21881bd51d6e9117bc24bf5288825d97fb8f2e48eb23d405ab2084e581baaedd1fb0e2d67f72710308f5f326bf6d195de82d754d2b67cc9784a3", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/dea4c44327d9d062c6326345e0de458ae103bf6bf0485ea2c4727f3645e38e19d2674fc9fe214fdc7a1a3b831f3dddab379319865a5b661488fa1e6cfc764c08"} 07:05:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:05:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:05:08 INFO - Contents: 07:05:08 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/db07651d629fd3f6efe8a1a6e39707e710d8c4af62d05d31c11593571ef686b061f8593a807ab0907f8f54781a202b7a76c7dede75a8c802ab97f8cee3f01647", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7e06ca2750f9772347a83c9226c053654be612300d09629d560236cdd414d77e233d2b3d02f16382d7a6ecba06f985578686a9384ef995a0199d085bcd7f9ca4", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/623602b2909b21881bd51d6e9117bc24bf5288825d97fb8f2e48eb23d405ab2084e581baaedd1fb0e2d67f72710308f5f326bf6d195de82d754d2b67cc9784a3", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/dea4c44327d9d062c6326345e0de458ae103bf6bf0485ea2c4727f3645e38e19d2674fc9fe214fdc7a1a3b831f3dddab379319865a5b661488fa1e6cfc764c08"} 07:05:08 INFO - Running post-run listener: copy_logs_to_upload_dir 07:05:08 INFO - Copying logs to upload dir... 07:05:08 INFO - mkdir: /builds/slave/test/build/upload/logs 07:05:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.608047 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2017-09-20 07:05:09.031506) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-20 07:05:09.035297) ========= 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=0333a256a5e4f052382dd180000001b1-1505911076.696222-1964767027 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/db07651d629fd3f6efe8a1a6e39707e710d8c4af62d05d31c11593571ef686b061f8593a807ab0907f8f54781a202b7a76c7dede75a8c802ab97f8cee3f01647", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7e06ca2750f9772347a83c9226c053654be612300d09629d560236cdd414d77e233d2b3d02f16382d7a6ecba06f985578686a9384ef995a0199d085bcd7f9ca4", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/623602b2909b21881bd51d6e9117bc24bf5288825d97fb8f2e48eb23d405ab2084e581baaedd1fb0e2d67f72710308f5f326bf6d195de82d754d2b67cc9784a3", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/dea4c44327d9d062c6326345e0de458ae103bf6bf0485ea2c4727f3645e38e19d2674fc9fe214fdc7a1a3b831f3dddab379319865a5b661488fa1e6cfc764c08"} build_url:https://queue.taskcluster.net/v1/task/VjX7h9b1Rg6WbANrHaKj3g/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011397 build_url: 'https://queue.taskcluster.net/v1/task/VjX7h9b1Rg6WbANrHaKj3g/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/db07651d629fd3f6efe8a1a6e39707e710d8c4af62d05d31c11593571ef686b061f8593a807ab0907f8f54781a202b7a76c7dede75a8c802ab97f8cee3f01647", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7e06ca2750f9772347a83c9226c053654be612300d09629d560236cdd414d77e233d2b3d02f16382d7a6ecba06f985578686a9384ef995a0199d085bcd7f9ca4", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/623602b2909b21881bd51d6e9117bc24bf5288825d97fb8f2e48eb23d405ab2084e581baaedd1fb0e2d67f72710308f5f326bf6d195de82d754d2b67cc9784a3", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/dea4c44327d9d062c6326345e0de458ae103bf6bf0485ea2c4727f3645e38e19d2674fc9fe214fdc7a1a3b831f3dddab379319865a5b661488fa1e6cfc764c08"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-20 07:05:09.065602) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-20 07:05:09.065953) ========= 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=0333a256a5e4f052382dd180000001b1-1505911076.696222-1964767027 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004449 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-20 07:05:09.149646) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-20 07:05:09.150044) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-20 07:05:09.150457) ========= ========= Total master_lag: 0.24 =========