builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-042 starttime: 1506018831.85 results: success (0) revision: ca7d18dbacbf103d74a3213d8d08a7c3e4def9a2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-21 11:33:51.853135) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-21 11:33:51.854018) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-21 11:33:51.854302) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-21 11:33:51.974435) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-21 11:33:51.974810) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1506018102.688246-295755340 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-21 11:33:51-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 69.2M=0s 2017-09-21 11:33:52 (69.2 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.217127 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-21 11:33:52.234822) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-21 11:33:52.235135) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1506018102.688246-295755340 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014723 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-21 11:33:52.288201) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-21 11:33:52.288538) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev ca7d18dbacbf103d74a3213d8d08a7c3e4def9a2 --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 ca7d18dbacbf103d74a3213d8d08a7c3e4def9a2 --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=74d6aec007b0fa31a864ebd7000001f8-1506018102.688246-295755340 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-21 11:33:52,307 truncating revision to first 12 chars 2017-09-21 11:33:52,307 Setting DEBUG logging. 2017-09-21 11:33:52,307 attempt 1/10 2017-09-21 11:33:52,307 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/ca7d18dbacbf?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-21 11:33:52,558 unpacking tar archive at: mozilla-central-ca7d18dbacbf/testing/mozharness/ program finished with exit code 0 elapsedTime=0.538299 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-21 11:33:52.842825) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-21 11:33:52.843124) ========= script_repo_revision: ca7d18dbacbf103d74a3213d8d08a7c3e4def9a2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-21 11:33:52.846531) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-21 11:33:52.846791) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-21 11:33:52.858851) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2017-09-21 11:33:52.859159) ========= /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=74d6aec007b0fa31a864ebd7000001f8-1506018102.688246-295755340 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:33:53 INFO - MultiFileLogger online at 20170921 11:33:53 in /builds/slave/test 11:33:53 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 11:33:53 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:33:53 INFO - {'append_to_log': False, 11:33:53 INFO - 'base_work_dir': '/builds/slave/test', 11:33:53 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 11:33:53 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:33:53 INFO - 'branch': 'Firefox-Non-PGO', 11:33:53 INFO - 'buildbot_json_path': 'buildprops.json', 11:33:53 INFO - 'code_coverage': False, 11:33:53 INFO - 'config_files': ('talos/linux_config.py',), 11:33:53 INFO - 'default_actions': ('clobber', 11:33:53 INFO - 'read-buildbot-config', 11:33:53 INFO - 'download-and-extract', 11:33:53 INFO - 'populate-webroot', 11:33:53 INFO - 'create-virtualenv', 11:33:53 INFO - 'install', 11:33:53 INFO - 'setup-mitmproxy', 11:33:53 INFO - 'run-tests'), 11:33:53 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:33:53 INFO - 'disable_ccov_upload': False, 11:33:53 INFO - 'disable_stylo': False, 11:33:53 INFO - 'download_minidump_stackwalk': True, 11:33:53 INFO - 'download_symbols': 'ondemand', 11:33:53 INFO - 'enable_stylo': False, 11:33:53 INFO - 'enable_webrender': False, 11:33:53 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 11:33:53 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:33:53 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:33:53 INFO - 'gecko_profile': False, 11:33:53 INFO - 'gecko_profile_interval': 0, 11:33:53 INFO - 'installer_path': 'installer.exe', 11:33:53 INFO - 'log_level': 'info', 11:33:53 INFO - 'log_name': 'talos', 11:33:53 INFO - 'log_to_console': True, 11:33:53 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:33:53 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:33:53 INFO - 'opt_config_files': (), 11:33:53 INFO - 'pip_index': False, 11:33:53 INFO - 'suite': 'dromaeojs-e10s', 11:33:53 INFO - 'system_bits': '32', 11:33:53 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:33:53 INFO - 'title': 'talos-linux64-ix-042', 11:33:53 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:33:53 INFO - 'use_talos_json': True, 11:33:53 INFO - 'verify': 'False', 11:33:53 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:33:53 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:33:53 INFO - 'work_dir': 'build'} 11:33:53 INFO - [mozharness: 2017-09-21 18:33:53.108952Z] Running clobber step. 11:33:53 INFO - Running pre-action listener: _resource_record_pre_action 11:33:53 INFO - Running main action method: clobber 11:33:53 INFO - rmtree: /builds/slave/test/build 11:33:53 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:33:54 INFO - Running post-action listener: _resource_record_post_action 11:33:54 INFO - [mozharness: 2017-09-21 18:33:54.063105Z] Finished clobber step (success) 11:33:54 INFO - [mozharness: 2017-09-21 18:33:54.063201Z] Running read-buildbot-config step. 11:33:54 INFO - Running pre-action listener: _resource_record_pre_action 11:33:54 INFO - Running main action method: read_buildbot_config 11:33:54 INFO - Using buildbot properties: 11:33:54 INFO - { 11:33:54 INFO - "project": "", 11:33:54 INFO - "product": "firefox", 11:33:54 INFO - "who": "ffxbld@noreply.mozilla.org", 11:33:54 INFO - "installer_path": "public/build/target.tar.bz2", 11:33:54 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 11:33:54 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 11:33:54 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 11:33:54 INFO - "stage_platform": "linux64", 11:33:54 INFO - "basedir": "/builds/slave/test", 11:33:54 INFO - "buildnumber": 852, 11:33:54 INFO - "platform": "ubuntu64_hw", 11:33:54 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 11:33:54 INFO - "slavebuilddir": "test", 11:33:54 INFO - "taskId": "cHzNxm8LQtKBhjSgpZ_cKA", 11:33:54 INFO - "branch": "mozilla-central", 11:33:54 INFO - "script_repo_revision": "production", 11:33:54 INFO - "revision": "ca7d18dbacbf103d74a3213d8d08a7c3e4def9a2", 11:33:54 INFO - "slavename": "talos-linux64-ix-042", 11:33:54 INFO - "repo_path": "mozilla-central" 11:33:54 INFO - } 11:33:54 INFO - Finding installer, test and symbols from parent task. 11:33:54 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cHzNxm8LQtKBhjSgpZ_cKA'}, attempt #1 11:33:54 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cHzNxm8LQtKBhjSgpZ_cKA'}, attempt #1 11:33:55 INFO - Task dependencies: TWoC3Z28QNeZ_g1kUharhQ 11:33:55 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TWoC3Z28QNeZ_g1kUharhQ'}, attempt #1 11:33:55 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/TWoC3Z28QNeZ_g1kUharhQ/artifacts/public/build/target.tar.bz2 11:33:55 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/TWoC3Z28QNeZ_g1kUharhQ/artifacts/public/build/target.test_packages.json 11:33:55 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/TWoC3Z28QNeZ_g1kUharhQ/artifacts/public/build/target.crashreporter-symbols.zip 11:33:55 INFO - Running post-action listener: _resource_record_post_action 11:33:55 INFO - [mozharness: 2017-09-21 18:33:55.604830Z] Finished read-buildbot-config step (success) 11:33:55 INFO - [mozharness: 2017-09-21 18:33:55.605045Z] Running download-and-extract step. 11:33:55 INFO - Running pre-action listener: _resource_record_pre_action 11:33:55 INFO - Running main action method: download_and_extract 11:33:55 INFO - mkdir: /builds/slave/test/build/tests 11:33:55 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')]} 11:33:55 INFO - trying https://queue.taskcluster.net/v1/task/TWoC3Z28QNeZ_g1kUharhQ/artifacts/public/build/target.test_packages.json 11:33:55 INFO - Downloading https://queue.taskcluster.net/v1/task/TWoC3Z28QNeZ_g1kUharhQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 11:33:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TWoC3Z28QNeZ_g1kUharhQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 11:33:56 INFO - Downloaded 989 bytes. 11:33:56 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 11:33:56 INFO - Using the following test package requirements: 11:33:56 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 11:33:56 INFO - u'common': [u'target.common.tests.zip'], 11:33:56 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 11:33:56 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 11:33:56 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 11:33:56 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 11:33:56 INFO - u'mozbase': [u'target.common.tests.zip'], 11:33:56 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 11:33:56 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 11:33:56 INFO - u'web-platform': [u'target.common.tests.zip', 11:33:56 INFO - u'target.web-platform.tests.tar.gz'], 11:33:56 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 11:33:56 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 11:33:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TWoC3Z28QNeZ_g1kUharhQ/artifacts/public/build/target.common.tests.zip 11:33:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TWoC3Z28QNeZ_g1kUharhQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:33:56 INFO - Fetch https://queue.taskcluster.net/v1/task/TWoC3Z28QNeZ_g1kUharhQ/artifacts/public/build/target.common.tests.zip into memory 11:33:58 INFO - Content-Length response header: 54741039 11:33:58 INFO - Bytes received: 54741039 11:34:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TWoC3Z28QNeZ_g1kUharhQ/artifacts/public/build/target.talos.tests.zip 11:34:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TWoC3Z28QNeZ_g1kUharhQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 11:34:08 INFO - Fetch https://queue.taskcluster.net/v1/task/TWoC3Z28QNeZ_g1kUharhQ/artifacts/public/build/target.talos.tests.zip into memory 11:34:10 INFO - Content-Length response header: 14509184 11:34:10 INFO - Bytes received: 14509184 11:34: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')]} 11:34:10 INFO - trying https://queue.taskcluster.net/v1/task/TWoC3Z28QNeZ_g1kUharhQ/artifacts/public/build/target.tar.bz2 11:34:10 INFO - Downloading https://queue.taskcluster.net/v1/task/TWoC3Z28QNeZ_g1kUharhQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 11:34:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TWoC3Z28QNeZ_g1kUharhQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 11:34:13 INFO - Downloaded 61492348 bytes. 11:34:13 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TWoC3Z28QNeZ_g1kUharhQ/artifacts/public/build/target.tar.bz2 11:34:13 INFO - mkdir: /builds/slave/test/properties 11:34:13 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:34:13 INFO - Writing to file /builds/slave/test/properties/build_url 11:34:13 INFO - Contents: 11:34:13 INFO - build_url:https://queue.taskcluster.net/v1/task/TWoC3Z28QNeZ_g1kUharhQ/artifacts/public/build/target.tar.bz2 11:34:13 INFO - Running post-action listener: _resource_record_post_action 11:34:13 INFO - Running post-action listener: find_tests_for_verification 11:34:13 INFO - Running post-action listener: set_extra_try_arguments 11:34:13 INFO - [mozharness: 2017-09-21 18:34:13.259658Z] Finished download-and-extract step (success) 11:34:13 INFO - [mozharness: 2017-09-21 18:34:13.259811Z] Running populate-webroot step. 11:34:13 INFO - Running pre-action listener: _resource_record_pre_action 11:34:13 INFO - Running main action method: populate_webroot 11:34:13 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:34:13 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:34:13 INFO - 'tests': ['tresize', 11:34:13 INFO - 'tcanvasmark']}, 11:34:13 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:34:13 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:34:13 INFO - 'tests': ['dromaeo_css', 11:34:13 INFO - 'kraken']}, 11:34:13 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:34:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:34:13 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:34:13 INFO - 'talos_options': ['--disable-stylo'], 11:34:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:34:13 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:34:13 INFO - 'tests': ['damp', 'tps']}, 11:34:13 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:34:13 INFO - 'talos_options': ['--disable-stylo'], 11:34:13 INFO - 'tests': ['damp', 'tps']}, 11:34:13 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:34:13 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:34:13 INFO - 'tests': ['dromaeo_dom']}, 11:34:13 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 11:34:13 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:34:13 INFO - 'tests': ['basic_compositor_video', 11:34:13 INFO - 'glvideo']}, 11:34:13 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 11:34:13 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 11:34:13 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:34:13 INFO - 'talos_options': ['--disable-stylo'], 11:34:13 INFO - 'tests': ['ts_paint_webext', 11:34:13 INFO - 'tp5o_webext']}, 11:34:13 INFO - 'other-e10s': {'tests': ['a11yr', 11:34:13 INFO - 'ts_paint', 11:34:13 INFO - 'tpaint', 11:34:13 INFO - 'sessionrestore', 11:34:13 INFO - 'sessionrestore_many_windows', 11:34:13 INFO - 'sessionrestore_no_auto_restore', 11:34:13 INFO - 'tabpaint']}, 11:34:13 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:34:13 INFO - 'tests': ['a11yr', 11:34:13 INFO - 'ts_paint', 11:34:13 INFO - 'tpaint', 11:34:13 INFO - 'sessionrestore', 11:34:13 INFO - 'sessionrestore_many_windows', 11:34:13 INFO - 'sessionrestore_no_auto_restore', 11:34:13 INFO - 'tabpaint']}, 11:34:13 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 11:34:13 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 11:34:13 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:34:13 INFO - 'tests': ['perf_reftest_singletons']}, 11:34:13 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:34:13 INFO - 'tests': ['bloom_basic']}, 11:34:13 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:34:13 INFO - 'tsvgr_opacity', 11:34:13 INFO - 'tart', 11:34:13 INFO - 'tscrollx', 11:34:13 INFO - 'tsvg_static']}, 11:34:13 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:34:13 INFO - 'tests': ['tsvgx', 11:34:13 INFO - 'tsvgr_opacity', 11:34:13 INFO - 'tart', 11:34:13 INFO - 'tscrollx', 11:34:13 INFO - 'tsvg_static']}, 11:34:13 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:34:13 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:34:13 INFO - 'talos_options': ['--disable-stylo'], 11:34:13 INFO - 'tests': ['tp5o']}, 11:34:13 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:34:13 INFO - 'talos_options': ['--mitmproxy', 11:34:13 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:34:13 INFO - '--firstNonBlankPaint'], 11:34:13 INFO - 'tests': ['tp6_google', 11:34:13 INFO - 'tp6_youtube', 11:34:13 INFO - 'tp6_amazon', 11:34:13 INFO - 'tp6_facebook']}, 11:34:13 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:34:13 INFO - 'talos_options': ['--disable-stylo', 11:34:13 INFO - '--mitmproxy', 11:34:13 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:34:13 INFO - '--firstNonBlankPaint'], 11:34:13 INFO - 'tests': ['tp6_google', 11:34:13 INFO - 'tp6_youtube', 11:34:13 INFO - 'tp6_amazon', 11:34:13 INFO - 'tp6_facebook']}, 11:34:13 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:34:13 INFO - 'talos_options': ['--stylo-threads=1', 11:34:13 INFO - '--mitmproxy', 11:34:13 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:34:13 INFO - '--firstNonBlankPaint'], 11:34:13 INFO - 'tests': ['tp6_google', 11:34:13 INFO - 'tp6_youtube', 11:34:13 INFO - 'tp6_amazon', 11:34:13 INFO - 'tp6_facebook']}, 11:34:13 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:34:13 INFO - 'talos_options': ['--xperf_path', 11:34:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:34:13 INFO - 'tests': ['tp5n']}, 11:34:13 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:34:13 INFO - 'talos_options': ['--disable-stylo', 11:34:13 INFO - '--xperf_path', 11:34:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:34:13 INFO - 'tests': ['tp5n']}}} 11:34:13 INFO - Running post-action listener: _resource_record_post_action 11:34:13 INFO - [mozharness: 2017-09-21 18:34:13.280423Z] Finished populate-webroot step (success) 11:34:13 INFO - [mozharness: 2017-09-21 18:34:13.280512Z] Running create-virtualenv step. 11:34:13 INFO - Running pre-action listener: _resource_record_pre_action 11:34:13 INFO - Running main action method: create_virtualenv 11:34:13 INFO - Creating virtualenv /builds/slave/test/build/venv 11:34:13 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:34:13 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 11:34:13 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 11:34:14 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:34:14 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:34:15 INFO - Installing distribute.............................................................................................................................................................................................done. 11:34:15 INFO - Installing pip...............done. 11:34:15 INFO - Return code: 0 11:34:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:34:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:34:15 INFO - Reading from file tmpfile_stdout 11:34:15 INFO - Output received: 11:34:15 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 11:34:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:34:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:34:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:34:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:34:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:34:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd121f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xedba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1082090>, '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 0x1082d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107cf90>, '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': '74d6aec007b0fa31a864ebd7000001f8-1506018102.688246-295755340', '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 11:34:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:34:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:34:15 INFO - Using env: {'DISPLAY': ':0', 11:34:15 INFO - 'HOME': '/home/cltbld', 11:34:15 INFO - 'LANG': 'en_US.UTF-8', 11:34:15 INFO - 'LANGUAGE': 'en_US:en', 11:34:15 INFO - 'LOGNAME': 'cltbld', 11:34:15 INFO - 'MAIL': '/var/mail/cltbld', 11:34:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:34:15 INFO - 'MOZ_NO_REMOTE': '1', 11:34:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:34:15 INFO - 'NO_EM_RESTART': '1', 11:34:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:34:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:34:15 INFO - 'PWD': '/builds/slave/test', 11:34:15 INFO - 'SHELL': '/bin/bash', 11:34:15 INFO - 'SHLVL': '1', 11:34:15 INFO - 'TERM': 'linux', 11:34:15 INFO - 'TMOUT': '86400', 11:34:15 INFO - 'USER': 'cltbld', 11:34:15 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1506018102.688246-295755340', 11:34:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:34:15 INFO - '_': '/tools/buildbot/bin/python'} 11:34:17 INFO - Ignoring indexes: http://pypi.python.org/simple/ 11:34:17 INFO - Downloading/unpacking pip>=1.5 11:34:17 INFO - Running setup.py egg_info for package pip 11:34:17 INFO - warning: no files found matching 'pip/cacert.pem' 11:34:17 INFO - warning: no files found matching '*.html' under directory 'docs' 11:34:17 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 11:34:17 INFO - no previously-included directories found matching 'docs/_build/_sources' 11:34:17 INFO - Installing collected packages: pip 11:34:17 INFO - Found existing installation: pip 1.1 11:34:17 INFO - Uninstalling pip: 11:34:17 INFO - Successfully uninstalled pip 11:34:17 INFO - Running setup.py install for pip 11:34:17 INFO - warning: no files found matching 'pip/cacert.pem' 11:34:17 INFO - warning: no files found matching '*.html' under directory 'docs' 11:34:17 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 11:34:17 INFO - no previously-included directories found matching 'docs/_build/_sources' 11:34:17 INFO - Installing pip script to /builds/slave/test/build/venv/bin 11:34:17 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 11:34:17 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 11:34:17 INFO - Successfully installed pip 11:34:17 INFO - Cleaning up... 11:34:17 INFO - Return code: 0 11:34:17 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:34:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:34:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:34:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:34:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:34:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xd121f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xedba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1082090>, '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 0x1082d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107cf90>, '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': '74d6aec007b0fa31a864ebd7000001f8-1506018102.688246-295755340', '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 11:34:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 11:34:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 11:34:17 INFO - Using env: {'DISPLAY': ':0', 11:34:17 INFO - 'HOME': '/home/cltbld', 11:34:17 INFO - 'LANG': 'en_US.UTF-8', 11:34:17 INFO - 'LANGUAGE': 'en_US:en', 11:34:17 INFO - 'LOGNAME': 'cltbld', 11:34:17 INFO - 'MAIL': '/var/mail/cltbld', 11:34:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:34:17 INFO - 'MOZ_NO_REMOTE': '1', 11:34:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:34:17 INFO - 'NO_EM_RESTART': '1', 11:34:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:34:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:34:17 INFO - 'PWD': '/builds/slave/test', 11:34:17 INFO - 'SHELL': '/bin/bash', 11:34:17 INFO - 'SHLVL': '1', 11:34:17 INFO - 'TERM': 'linux', 11:34:17 INFO - 'TMOUT': '86400', 11:34:17 INFO - 'USER': 'cltbld', 11:34:17 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1506018102.688246-295755340', 11:34:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:34:17 INFO - '_': '/tools/buildbot/bin/python'} 11:34:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:34:17 INFO - Downloading/unpacking psutil>=3.1.1 11:34:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:34:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:34:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:34:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:34:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:34:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:34:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:34:19 INFO - Installing collected packages: psutil 11:34:19 INFO - Running setup.py install for psutil 11:34:19 INFO - building 'psutil._psutil_linux' extension 11:34:19 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 11:34:20 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 11:34:20 INFO - building 'psutil._psutil_posix' extension 11:34:20 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 11:34:20 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 11:34:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:34:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:34:20 INFO - Successfully installed psutil 11:34:20 INFO - Cleaning up... 11:34:20 INFO - Return code: 0 11:34:20 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:34:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:34:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:34:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:34:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:34:20 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 0xd121f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xedba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1082090>, '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 0x1082d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107cf90>, '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': '74d6aec007b0fa31a864ebd7000001f8-1506018102.688246-295755340', '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 11:34:20 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 11:34:20 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 11:34:20 INFO - Using env: {'DISPLAY': ':0', 11:34:20 INFO - 'HOME': '/home/cltbld', 11:34:20 INFO - 'LANG': 'en_US.UTF-8', 11:34:20 INFO - 'LANGUAGE': 'en_US:en', 11:34:20 INFO - 'LOGNAME': 'cltbld', 11:34:20 INFO - 'MAIL': '/var/mail/cltbld', 11:34:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:34:20 INFO - 'MOZ_NO_REMOTE': '1', 11:34:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:34:20 INFO - 'NO_EM_RESTART': '1', 11:34:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:34:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:34:20 INFO - 'PWD': '/builds/slave/test', 11:34:20 INFO - 'SHELL': '/bin/bash', 11:34:20 INFO - 'SHLVL': '1', 11:34:20 INFO - 'TERM': 'linux', 11:34:20 INFO - 'TMOUT': '86400', 11:34:20 INFO - 'USER': 'cltbld', 11:34:20 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1506018102.688246-295755340', 11:34:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:34:20 INFO - '_': '/tools/buildbot/bin/python'} 11:34:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:34:20 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:34:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:34:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:34:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:34:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:34:22 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:34:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:34:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:34:22 INFO - Installing collected packages: mozsystemmonitor 11:34:22 INFO - Running setup.py install for mozsystemmonitor 11:34:22 INFO - Successfully installed mozsystemmonitor 11:34:22 INFO - Cleaning up... 11:34:22 INFO - Return code: 0 11:34:22 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:34:22 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')]} 11:34:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:34:22 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')]} 11:34:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:34:22 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 0xd121f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xedba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1082090>, '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 0x1082d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107cf90>, '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': '74d6aec007b0fa31a864ebd7000001f8-1506018102.688246-295755340', '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 11:34:22 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 11:34:22 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 11:34:22 INFO - Using env: {'DISPLAY': ':0', 11:34:22 INFO - 'HOME': '/home/cltbld', 11:34:22 INFO - 'LANG': 'en_US.UTF-8', 11:34:22 INFO - 'LANGUAGE': 'en_US:en', 11:34:22 INFO - 'LOGNAME': 'cltbld', 11:34:22 INFO - 'MAIL': '/var/mail/cltbld', 11:34:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:34:22 INFO - 'MOZ_NO_REMOTE': '1', 11:34:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:34:22 INFO - 'NO_EM_RESTART': '1', 11:34:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:34:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:34:22 INFO - 'PWD': '/builds/slave/test', 11:34:22 INFO - 'SHELL': '/bin/bash', 11:34:22 INFO - 'SHLVL': '1', 11:34:22 INFO - 'TERM': 'linux', 11:34:22 INFO - 'TMOUT': '86400', 11:34:22 INFO - 'USER': 'cltbld', 11:34:22 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1506018102.688246-295755340', 11:34:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:34:22 INFO - '_': '/tools/buildbot/bin/python'} 11:34:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:34:22 INFO - Downloading/unpacking jsonschema==2.5.1 11:34:22 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 11:34:22 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 11:34:22 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 11:34:22 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 11:34:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:34:23 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:34:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:34:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:34:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:34:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:34:23 INFO - Downloading functools32-3.2.3-2.tar.gz 11:34:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:34:23 INFO - warning: no files found matching '*.txt' 11:34:23 INFO - no previously-included directories found matching 'build' 11:34:23 INFO - no previously-included directories found matching 'dist' 11:34:23 INFO - no previously-included directories found matching '.git*' 11:34:23 INFO - Installing collected packages: jsonschema, functools32 11:34:23 INFO - Running setup.py install for functools32 11:34:23 INFO - warning: no files found matching '*.txt' 11:34:23 INFO - no previously-included directories found matching 'build' 11:34:23 INFO - no previously-included directories found matching 'dist' 11:34:23 INFO - no previously-included directories found matching '.git*' 11:34:23 INFO - Successfully installed jsonschema functools32 11:34:23 INFO - Cleaning up... 11:34:24 INFO - Return code: 0 11:34:24 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:34:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:34:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:34:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:34:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:34:24 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 0xd121f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xedba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1082090>, '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 0x1082d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107cf90>, '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': '74d6aec007b0fa31a864ebd7000001f8-1506018102.688246-295755340', '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 11:34:24 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 11:34:24 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 11:34:24 INFO - Using env: {'DISPLAY': ':0', 11:34:24 INFO - 'HOME': '/home/cltbld', 11:34:24 INFO - 'LANG': 'en_US.UTF-8', 11:34:24 INFO - 'LANGUAGE': 'en_US:en', 11:34:24 INFO - 'LOGNAME': 'cltbld', 11:34:24 INFO - 'MAIL': '/var/mail/cltbld', 11:34:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:34:24 INFO - 'MOZ_NO_REMOTE': '1', 11:34:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:34:24 INFO - 'NO_EM_RESTART': '1', 11:34:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:34:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:34:24 INFO - 'PWD': '/builds/slave/test', 11:34:24 INFO - 'SHELL': '/bin/bash', 11:34:24 INFO - 'SHLVL': '1', 11:34:24 INFO - 'TERM': 'linux', 11:34:24 INFO - 'TMOUT': '86400', 11:34:24 INFO - 'USER': 'cltbld', 11:34:24 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1506018102.688246-295755340', 11:34:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:34:24 INFO - '_': '/tools/buildbot/bin/python'} 11:34:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:34:24 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:34:24 INFO - Cleaning up... 11:34:24 INFO - Return code: 0 11:34:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:34:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:34:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:34:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:34:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:34:24 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 0xd121f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xedba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1082090>, '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 0x1082d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107cf90>, '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': '74d6aec007b0fa31a864ebd7000001f8-1506018102.688246-295755340', '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 11:34:24 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 11:34:24 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 11:34:24 INFO - Using env: {'DISPLAY': ':0', 11:34:24 INFO - 'HOME': '/home/cltbld', 11:34:24 INFO - 'LANG': 'en_US.UTF-8', 11:34:24 INFO - 'LANGUAGE': 'en_US:en', 11:34:24 INFO - 'LOGNAME': 'cltbld', 11:34:24 INFO - 'MAIL': '/var/mail/cltbld', 11:34:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:34:24 INFO - 'MOZ_NO_REMOTE': '1', 11:34:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:34:24 INFO - 'NO_EM_RESTART': '1', 11:34:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:34:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:34:24 INFO - 'PWD': '/builds/slave/test', 11:34:24 INFO - 'SHELL': '/bin/bash', 11:34:24 INFO - 'SHLVL': '1', 11:34:24 INFO - 'TERM': 'linux', 11:34:24 INFO - 'TMOUT': '86400', 11:34:24 INFO - 'USER': 'cltbld', 11:34:24 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1506018102.688246-295755340', 11:34:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:34:24 INFO - '_': '/tools/buildbot/bin/python'} 11:34:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:34:24 INFO - Downloading/unpacking blobuploader==1.2.4 11:34:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:34:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:34:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:34:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:34:25 INFO - Downloading blobuploader-1.2.4.tar.gz 11:34:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:34:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:34:25 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 11:34:25 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 11:34:25 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 11:34:25 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 11:34:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:34:25 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:34:25 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 11:34:25 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 11:34:25 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 11:34:25 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 11:34:26 INFO - Downloading docopt-0.6.1.tar.gz 11:34:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:34:26 INFO - Installing collected packages: blobuploader, requests, docopt 11:34:26 INFO - Running setup.py install for blobuploader 11:34:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:34:26 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:34:26 INFO - Running setup.py install for requests 11:34:26 INFO - Running setup.py install for docopt 11:34:26 INFO - Successfully installed blobuploader requests docopt 11:34:26 INFO - Cleaning up... 11:34:26 INFO - Return code: 0 11:34:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:34:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:34:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:34:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:34:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:34:26 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 0xd121f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xedba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1082090>, '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 0x1082d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107cf90>, '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': '74d6aec007b0fa31a864ebd7000001f8-1506018102.688246-295755340', '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 11:34:26 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 11:34:26 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 11:34:26 INFO - Using env: {'DISPLAY': ':0', 11:34:26 INFO - 'HOME': '/home/cltbld', 11:34:26 INFO - 'LANG': 'en_US.UTF-8', 11:34:26 INFO - 'LANGUAGE': 'en_US:en', 11:34:26 INFO - 'LOGNAME': 'cltbld', 11:34:26 INFO - 'MAIL': '/var/mail/cltbld', 11:34:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:34:26 INFO - 'MOZ_NO_REMOTE': '1', 11:34:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:34:26 INFO - 'NO_EM_RESTART': '1', 11:34:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:34:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:34:26 INFO - 'PWD': '/builds/slave/test', 11:34:26 INFO - 'SHELL': '/bin/bash', 11:34:26 INFO - 'SHLVL': '1', 11:34:26 INFO - 'TERM': 'linux', 11:34:26 INFO - 'TMOUT': '86400', 11:34:26 INFO - 'USER': 'cltbld', 11:34:26 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1506018102.688246-295755340', 11:34:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:34:26 INFO - '_': '/tools/buildbot/bin/python'} 11:34:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:34:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:34:26 INFO - Running setup.py (path:/tmp/pip-fK1DOZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:34:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:34:26 INFO - Running setup.py (path:/tmp/pip-8bWGcp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:34:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:34:27 INFO - Running setup.py (path:/tmp/pip-0FsvxB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:34:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:34:27 INFO - Running setup.py (path:/tmp/pip-XvQPMO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:34:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:34:27 INFO - Running setup.py (path:/tmp/pip-_z7PnF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:34:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:34:27 INFO - Running setup.py (path:/tmp/pip-E1Y7vd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:34:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:34:27 INFO - Running setup.py (path:/tmp/pip-vDmY8c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:34:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:34:27 INFO - Running setup.py (path:/tmp/pip-enCVIL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:34:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:34:27 INFO - Running setup.py (path:/tmp/pip-Z_p6OW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:34:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:34:27 INFO - Running setup.py (path:/tmp/pip-7cpsSi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:34:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:34:27 INFO - Running setup.py (path:/tmp/pip-CvQhBO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:34:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:34:27 INFO - Running setup.py (path:/tmp/pip-BLwO0k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:34:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:34:27 INFO - Running setup.py (path:/tmp/pip-k_cjHg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:34:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:34:27 INFO - Running setup.py (path:/tmp/pip-3YsiAT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:34:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:34:27 INFO - Running setup.py (path:/tmp/pip-L8d4Vz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:34:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:34:27 INFO - Running setup.py (path:/tmp/pip-_UtGvR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:34:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:34:28 INFO - Running setup.py (path:/tmp/pip-3yG571-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:34:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:34:28 INFO - Running setup.py install for manifestparser 11:34:28 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:34:28 INFO - Running setup.py install for mozcrash 11:34:28 INFO - Running setup.py install for mozdebug 11:34:28 INFO - Running setup.py install for mozdevice 11:34:28 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:34:28 INFO - Running setup.py install for mozfile 11:34:28 INFO - Running setup.py install for mozhttpd 11:34:28 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:34:28 INFO - Running setup.py install for mozinfo 11:34:28 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:34:28 INFO - Running setup.py install for mozInstall 11:34:28 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:34:28 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:34:28 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:34:28 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:34:28 INFO - Running setup.py install for mozleak 11:34:28 INFO - Running setup.py install for mozlog 11:34:29 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:34:29 INFO - Running setup.py install for moznetwork 11:34:29 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:34:29 INFO - Running setup.py install for mozprocess 11:34:29 INFO - Running setup.py install for mozprofile 11:34:29 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:34:29 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:34:29 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:34:29 INFO - Running setup.py install for mozrunner 11:34:29 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:34:29 INFO - Running setup.py install for mozscreenshot 11:34:29 INFO - Running setup.py install for moztest 11:34:29 INFO - Running setup.py install for mozversion 11:34:29 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:34:29 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:34:29 INFO - Cleaning up... 11:34:29 INFO - Return code: 0 11:34:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:34:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:34:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:34:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:34:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:34:29 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 0xd121f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xedba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1082090>, '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 0x1082d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107cf90>, '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': '74d6aec007b0fa31a864ebd7000001f8-1506018102.688246-295755340', '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 11:34:29 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 11:34:29 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 11:34:29 INFO - Using env: {'DISPLAY': ':0', 11:34:29 INFO - 'HOME': '/home/cltbld', 11:34:29 INFO - 'LANG': 'en_US.UTF-8', 11:34:29 INFO - 'LANGUAGE': 'en_US:en', 11:34:29 INFO - 'LOGNAME': 'cltbld', 11:34:29 INFO - 'MAIL': '/var/mail/cltbld', 11:34:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:34:29 INFO - 'MOZ_NO_REMOTE': '1', 11:34:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:34:29 INFO - 'NO_EM_RESTART': '1', 11:34:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:34:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:34:29 INFO - 'PWD': '/builds/slave/test', 11:34:29 INFO - 'SHELL': '/bin/bash', 11:34:29 INFO - 'SHLVL': '1', 11:34:29 INFO - 'TERM': 'linux', 11:34:29 INFO - 'TMOUT': '86400', 11:34:29 INFO - 'USER': 'cltbld', 11:34:29 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1506018102.688246-295755340', 11:34:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:34:29 INFO - '_': '/tools/buildbot/bin/python'} 11:34:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:34:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:34:30 INFO - Running setup.py (path:/tmp/pip-ZoYPBQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:34:30 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)) 11:34:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:34:30 INFO - Running setup.py (path:/tmp/pip-t1mKIq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:34:30 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)) 11:34:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:34:30 INFO - Running setup.py (path:/tmp/pip-XtaGEC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:34:30 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)) 11:34:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:34:30 INFO - Running setup.py (path:/tmp/pip-yOTFyP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:34:30 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)) 11:34:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:34:30 INFO - Running setup.py (path:/tmp/pip-W2SWj3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:34:30 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)) 11:34:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:34:30 INFO - Running setup.py (path:/tmp/pip-uWHklD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:34:30 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)) 11:34:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:34:30 INFO - Running setup.py (path:/tmp/pip-l7TnU1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:34:30 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)) 11:34:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:34:30 INFO - Running setup.py (path:/tmp/pip-BskKcs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:34:30 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)) 11:34:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:34:30 INFO - Running setup.py (path:/tmp/pip-zCWF99-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:34:30 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)) 11:34:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:34:30 INFO - Running setup.py (path:/tmp/pip-6lfofm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:34:30 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)) 11:34:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:34:30 INFO - Running setup.py (path:/tmp/pip-5on_So-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:34:30 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)) 11:34:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:34:30 INFO - Running setup.py (path:/tmp/pip-uoqOm9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:34:30 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)) 11:34:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:34:30 INFO - Running setup.py (path:/tmp/pip-lqshML-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:34:31 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)) 11:34:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:34:31 INFO - Running setup.py (path:/tmp/pip-4GgIHN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:34:31 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)) 11:34:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:34:31 INFO - Running setup.py (path:/tmp/pip-77ex2R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:34:31 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)) 11:34:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:34:31 INFO - Running setup.py (path:/tmp/pip-J9pVDQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:34:31 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)) 11:34:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:34:31 INFO - Running setup.py (path:/tmp/pip-SkU2Nu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:34:31 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)) 11:34:31 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)) 11:34:31 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)) 11:34:31 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)) 11:34:31 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)) 11:34:31 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)) 11:34:31 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)) 11:34:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:34:31 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 11:34:31 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 11:34:31 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 11:34:31 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 11:34:32 INFO - Downloading blessings-1.6.tar.gz 11:34:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:34:32 INFO - Installing collected packages: blessings 11:34:32 INFO - Running setup.py install for blessings 11:34:32 INFO - Successfully installed blessings 11:34:32 INFO - Cleaning up... 11:34:32 INFO - Return code: 0 11:34:32 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:34:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:34:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:34:32 INFO - Reading from file tmpfile_stdout 11:34:32 INFO - Current package versions: 11:34:32 INFO - argparse == 1.2.1 11:34:32 INFO - blessings == 1.6 11:34:32 INFO - blobuploader == 1.2.4 11:34:32 INFO - docopt == 0.6.1 11:34:32 INFO - functools32 == 3.2.3-2 11:34:32 INFO - jsonschema == 2.5.1 11:34:32 INFO - manifestparser == 1.1 11:34:32 INFO - mozInstall == 1.13 11:34:32 INFO - mozcrash == 1.0 11:34:32 INFO - mozdebug == 0.1 11:34:32 INFO - mozdevice == 0.51 11:34:32 INFO - mozfile == 1.2 11:34:32 INFO - mozhttpd == 0.7 11:34:32 INFO - mozinfo == 0.10 11:34:32 INFO - mozleak == 0.1 11:34:32 INFO - mozlog == 3.5 11:34:32 INFO - moznetwork == 0.27 11:34:32 INFO - mozprocess == 0.25 11:34:32 INFO - mozprofile == 0.28 11:34:32 INFO - mozrunner == 6.13 11:34:32 INFO - mozscreenshot == 0.1 11:34:32 INFO - mozsystemmonitor == 0.3 11:34:32 INFO - moztest == 0.8 11:34:32 INFO - mozversion == 1.4 11:34:32 INFO - psutil == 3.1.1 11:34:32 INFO - requests == 1.2.3 11:34:32 INFO - wsgiref == 0.1.2 11:34:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:34:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:34:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:34:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:34:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:34:32 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 0xd121f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xedba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1082090>, '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 0x1082d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107cf90>, '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': '74d6aec007b0fa31a864ebd7000001f8-1506018102.688246-295755340', '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 11:34:32 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 11:34:32 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 11:34:32 INFO - Using env: {'DISPLAY': ':0', 11:34:32 INFO - 'HOME': '/home/cltbld', 11:34:32 INFO - 'LANG': 'en_US.UTF-8', 11:34:32 INFO - 'LANGUAGE': 'en_US:en', 11:34:32 INFO - 'LOGNAME': 'cltbld', 11:34:32 INFO - 'MAIL': '/var/mail/cltbld', 11:34:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:34:32 INFO - 'MOZ_NO_REMOTE': '1', 11:34:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:34:32 INFO - 'NO_EM_RESTART': '1', 11:34:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:34:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:34:32 INFO - 'PWD': '/builds/slave/test', 11:34:32 INFO - 'SHELL': '/bin/bash', 11:34:32 INFO - 'SHLVL': '1', 11:34:32 INFO - 'TERM': 'linux', 11:34:32 INFO - 'TMOUT': '86400', 11:34:32 INFO - 'USER': 'cltbld', 11:34:32 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1506018102.688246-295755340', 11:34:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:34:32 INFO - '_': '/tools/buildbot/bin/python'} 11:34:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:34:33 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)) 11:34:33 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)) 11:34:33 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)) 11:34:33 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)) 11:34:33 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)) 11:34:33 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)) 11:34:33 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)) 11:34:33 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)) 11:34:33 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)) 11:34:33 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 11:34:33 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 11:34:33 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 11:34:33 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 11:34:33 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 11:34:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 11:34:34 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)) 11:34:34 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)) 11:34:34 INFO - Installing collected packages: simplejson 11:34:34 INFO - Running setup.py install for simplejson 11:34:34 INFO - building 'simplejson._speedups' extension 11:34:34 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 11:34:35 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 11:34:35 INFO - Successfully installed simplejson 11:34:35 INFO - Cleaning up... 11:34:35 INFO - Return code: 0 11:34:35 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:34:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:34:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:34:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:34:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:34:35 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 0xd121f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xedba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1082090>, '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 0x1082d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107cf90>, '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': '74d6aec007b0fa31a864ebd7000001f8-1506018102.688246-295755340', '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 11:34:35 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 11:34:35 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 11:34:35 INFO - Using env: {'DISPLAY': ':0', 11:34:35 INFO - 'HOME': '/home/cltbld', 11:34:35 INFO - 'LANG': 'en_US.UTF-8', 11:34:35 INFO - 'LANGUAGE': 'en_US:en', 11:34:35 INFO - 'LOGNAME': 'cltbld', 11:34:35 INFO - 'MAIL': '/var/mail/cltbld', 11:34:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:34:35 INFO - 'MOZ_NO_REMOTE': '1', 11:34:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:34:35 INFO - 'NO_EM_RESTART': '1', 11:34:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:34:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:34:35 INFO - 'PWD': '/builds/slave/test', 11:34:35 INFO - 'SHELL': '/bin/bash', 11:34:35 INFO - 'SHLVL': '1', 11:34:35 INFO - 'TERM': 'linux', 11:34:35 INFO - 'TMOUT': '86400', 11:34:35 INFO - 'USER': 'cltbld', 11:34:35 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1506018102.688246-295755340', 11:34:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:34:35 INFO - '_': '/tools/buildbot/bin/python'} 11:34:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:34:35 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:34:35 INFO - Cleaning up... 11:34:35 INFO - Return code: 0 11:34:35 INFO - Running post-action listener: _resource_record_post_action 11:34:35 INFO - Running post-action listener: _start_resource_monitoring 11:34:35 INFO - Starting resource monitoring. 11:34:35 INFO - [mozharness: 2017-09-21 18:34:35.618269Z] Finished create-virtualenv step (success) 11:34:35 INFO - [mozharness: 2017-09-21 18:34:35.619226Z] Running install step. 11:34:35 INFO - Running pre-action listener: _resource_record_pre_action 11:34:35 INFO - Running main action method: install 11:34:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:34:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:34:35 INFO - Reading from file tmpfile_stdout 11:34:35 INFO - Detecting whether we're running mozinstall >=1.0... 11:34:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:34:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:34:35 INFO - Reading from file tmpfile_stdout 11:34:35 INFO - Output received: 11:34:35 INFO - Usage: mozinstall [options] installer 11:34:35 INFO - Options: 11:34:35 INFO - -h, --help show this help message and exit 11:34:35 INFO - -d DEST, --destination=DEST 11:34:35 INFO - Directory to install application into. [default: 11:34:35 INFO - "/builds/slave/test"] 11:34:35 INFO - --app=APP Application being installed. [default: firefox] 11:34:35 INFO - mkdir: /builds/slave/test/build/application 11:34:35 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'] 11:34:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 11:34:53 INFO - Reading from file tmpfile_stdout 11:34:53 INFO - Output received: 11:34:53 INFO - /builds/slave/test/build/application/firefox/firefox 11:34:53 INFO - Running post-action listener: _resource_record_post_action 11:34:53 INFO - [mozharness: 2017-09-21 18:34:53.746851Z] Finished install step (success) 11:34:53 INFO - [mozharness: 2017-09-21 18:34:53.746999Z] Running setup-mitmproxy step. 11:34:53 INFO - Running pre-action listener: _resource_record_pre_action 11:34:53 INFO - Running main action method: setup_mitmproxy 11:34:53 INFO - Skipping: mitmproxy is not required 11:34:53 INFO - Running post-action listener: _resource_record_post_action 11:34:53 INFO - [mozharness: 2017-09-21 18:34:53.747524Z] Finished setup-mitmproxy step (success) 11:34:53 INFO - [mozharness: 2017-09-21 18:34:53.747624Z] Running run-tests step. 11:34:53 INFO - Running pre-action listener: _resource_record_pre_action 11:34:53 INFO - Running pre-action listener: _set_gcov_prefix 11:34:53 INFO - Running main action method: run_tests 11:34:53 WARNING - Try message not found. 11:34:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:34:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:34:53 INFO - Python 2.7.3 11:34:53 INFO - Return code: 0 11:34:53 INFO - grabbing minidump binary from tooltool 11:34:53 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')]} 11:34:53 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 0x1082090>, '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 0x1082d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107cf90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:34:53 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 11:34:53 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 11:34:53 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 11:34:53 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:34:53 INFO - Return code: 0 11:34:53 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:34:53 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:34:53 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:34:53 INFO - ENV: RUST_BACKTRACE is now full 11:34:53 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:34:53 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:34:53 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/TWoC3Z28QNeZ_g1kUharhQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--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 11:34:53 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/TWoC3Z28QNeZ_g1kUharhQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-042 --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 11:34:53 INFO - Using env: {'DISPLAY': ':0', 11:34:53 INFO - 'HOME': '/home/cltbld', 11:34:53 INFO - 'LANG': 'en_US.UTF-8', 11:34:53 INFO - 'LANGUAGE': 'en_US:en', 11:34:53 INFO - 'LOGNAME': 'cltbld', 11:34:53 INFO - 'MAIL': '/var/mail/cltbld', 11:34:53 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:34:53 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:34:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:34:53 INFO - 'MOZ_NO_REMOTE': '1', 11:34:53 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:34:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:34:53 INFO - 'NO_EM_RESTART': '1', 11:34:53 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:34:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:34:53 INFO - 'PWD': '/builds/slave/test', 11:34:53 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:34:53 INFO - 'RUST_BACKTRACE': 'full', 11:34:53 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:34:53 INFO - 'SHELL': '/bin/bash', 11:34:53 INFO - 'SHLVL': '1', 11:34:53 INFO - 'TERM': 'linux', 11:34:53 INFO - 'TMOUT': '86400', 11:34:53 INFO - 'USER': 'cltbld', 11:34:53 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1506018102.688246-295755340', 11:34:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:34:53 INFO - '_': '/tools/buildbot/bin/python'} 11:34:53 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/TWoC3Z28QNeZ_g1kUharhQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--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 11:34:54 INFO - mozversion application_buildid: 20170921174618 11:34:54 INFO - mozversion application_changeset: ca7d18dbacbf103d74a3213d8d08a7c3e4def9a2 11:34:54 INFO - mozversion application_display_name: Nightly 11:34:54 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:34:54 INFO - mozversion application_name: Firefox 11:34:54 INFO - mozversion application_remotingname: firefox 11:34:54 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 11:34:54 INFO - mozversion application_vendor: Mozilla 11:34:54 INFO - mozversion application_version: 58.0a1 11:34:54 INFO - mozversion platform_buildid: 20170921174618 11:34:54 INFO - mozversion platform_changeset: ca7d18dbacbf103d74a3213d8d08a7c3e4def9a2 11:34:54 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 11:34:54 INFO - mozversion platform_version: 58.0a1 11:34:54 INFO - using testdate: 1506018894 11:34:54 INFO - actual date: 1506018894 11:34:54 INFO - starting webserver on 'localhost:47244' 11:34:54 INFO - SUITE-START | Running 2 tests 11:34:54 INFO - TEST-START | dromaeo_css 11:34:54 INFO - Initialising browser for dromaeo_css test... 11:34:54 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:47244/getInfo.html -profile /tmp/tmppMtVwJ/profile 11:34:54 INFO - TEST-INFO | started process 3567 (/builds/slave/test/build/application/firefox/firefox http://localhost:47244/getInfo.html) 11:35:02 INFO - TEST-INFO | 3567: exit 0 11:35:02 INFO - Browser initialized. 11:35:02 INFO - Running cycle 1/1 for dromaeo_css test... 11:35:02 INFO - Using env: {'DISPLAY': ':0', 11:35:02 INFO - 'HOME': '/home/cltbld', 11:35:02 INFO - 'JSGC_DISABLE_POISONING': '1', 11:35:02 INFO - 'LANG': 'en_US.UTF-8', 11:35:02 INFO - 'LANGUAGE': 'en_US:en', 11:35:02 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 11:35:02 INFO - 'LOGNAME': 'cltbld', 11:35:02 INFO - 'MAIL': '/var/mail/cltbld', 11:35:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:35:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:35:02 INFO - 'MOZ_CRASHREPORTER': '1', 11:35:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:35:02 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 11:35:02 INFO - 'MOZ_NO_REMOTE': '1', 11:35:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:35:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:35:02 INFO - 'NO_EM_RESTART': '1', 11:35:02 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:35:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:35:02 INFO - 'PWD': '/builds/slave/test', 11:35:02 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:35:02 INFO - 'RUST_BACKTRACE': 'full', 11:35:02 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:35:02 INFO - 'SHELL': '/bin/bash', 11:35:02 INFO - 'SHLVL': '1', 11:35:02 INFO - 'TERM': 'linux', 11:35:02 INFO - 'TMOUT': '86400', 11:35:02 INFO - 'USER': 'cltbld', 11:35:02 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1506018102.688246-295755340', 11:35:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:35:02 INFO - '_': '/tools/buildbot/bin/python'} 11:35:02 INFO - TEST-INFO | started process 3803 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppMtVwJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:35:03 INFO - PID 3803 | 11:35:03 INFO - PID 3803 | (/builds/slave/test/build/application/firefox/firefox:3852): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:35:03 INFO - PID 3803 | 11:35:13 INFO - PID 3803 | RSS: Main: 154300416 11:35:13 INFO - PID 3803 | 11:38:11 INFO - PID 3803 | Cycle 1(1): loaded http://localhost:47244/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47244/tests/dromaeo/cssquery-ext.html) 11:38:12 INFO - PID 3803 | RSS: Main: 157392896 11:38:12 INFO - PID 3803 | 11:41:14 INFO - PID 3803 | Cycle 1(1): loaded http://localhost:47244/tests/dromaeo/cssquery-ext.html (next: http://localhost:47244/tests/dromaeo/cssquery-jquery.html) 11:41:14 INFO - PID 3803 | RSS: Main: 155127808 11:41:14 INFO - PID 3803 | 11:44:16 INFO - PID 3803 | Cycle 1(1): loaded http://localhost:47244/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47244/tests/dromaeo/cssquery-mootools.html) 11:44:17 INFO - PID 3803 | RSS: Main: 157020160 11:44:17 INFO - PID 3803 | 11:47:18 INFO - PID 3803 | Cycle 1(1): loaded http://localhost:47244/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47244/tests/dromaeo/cssquery-prototype.html) 11:47:19 INFO - PID 3803 | RSS: Main: 156098560 11:47:19 INFO - PID 3803 | 11:50:22 INFO - PID 3803 | Cycle 1(1): loaded http://localhost:47244/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47244/tests/dromaeo/cssquery-yui.html) 11:50:23 INFO - PID 3803 | RSS: Main: 156880896 11:50:23 INFO - PID 3803 | 11:53:24 INFO - PID 3803 | Cycle 1(1): loaded http://localhost:47244/tests/dromaeo/cssquery-yui.html (next: http://localhost:47244/tests/dromaeo/cssquery-dojo.html) 11:53:25 INFO - PID 3803 | RSS: Main: 159420416 11:53:25 INFO - PID 3803 | 11:53:25 INFO - PID 3803 | __start_tp_report 11:53:25 INFO - PID 3803 | _x_x_mozilla_page_load 11:53:25 INFO - PID 3803 | _x_x_mozilla_page_load_details 11:53:25 INFO - PID 3803 | |i|pagename|runs| 11:53:25 INFO - PID 3803 | |0;dojo.html;3147.1030756234477;3162.8576714047867;3188.76084293678;3209.7753157278985;3211.9197020074494;6322.241331040282;6391.904121438176;6463.192100987377;6539.051837483562;6569.474442044637;6349.936500634993;6380;6382.489400847932;6442.065900444444;6574.605523668583;5938.317093534234;5985.820425387245;6021;6022.126791615213;6051.0318349064155;5911.994960856665;5947.791827286046;5977.073553599199;6078.20983272174;6080;5877.79427720032;5912.290525137011;5954.523638108963;6016.819495415167;6105.725242364082;5888.087346461305;5903.468687818117;5905.4685078343155;5913.645181289094;5935.228420305332;5853.970730146322;5858.472737453607;5913.763449462016;5918.053111502139;5928.021876390433;6362.681865906686;6371.23545174582;6371.96814015927;6445.677716114223;6538.574992625464;6735.427488663469;6811.148606424197;6846.383825455683;6935.202451718066;6947.756828511028;6941.097657304568;7016.087908571853;7027.0513480679965;7027.5080744347915;7031.085958825372;6408.647524386157;6443.194600674962;6481.578697384655;6495.935040649628;6500.609963402211;7008.369246767816;7060.752873649398;7102;7119;7208.855822883513;6769.187697476236;6778.186617605918;6796.830079248059;6800.183977922681;6850.0752398426575;6900.516963812585;6916.861662766716;6970.407515361251;6976.616286104211;6984.720611175496;6671.5997040177745;6821.4542836572955;6836.111305530249;6873.381395674413;6967.512274140761;6770.052192693027;6822.658867056726;6825.1127353443735;6832.624205668637;6837.042814006043;5305.973470132624;5318.760655770499;5322.8935421292135;5354.277172581652;5486;4707.482176960531;4724.055188962221;4837.201861692852;4839.104765618372;4854.393200849894;5904.8780731660845;5909.70451477433;5993.340732519419;5994.430529099728;5997.010493268562;6755.22314933779;6851.862962740717;6861.828454288583;6868.759593414206;6869.587824730532;5790.247267855152;5814.970925145347;5830.096335068071;5849.1226316052935;5959.582829201914;5903.527717782567;6000.369961154103;6005.639661620229;6010.128531363015;6020.909686354708;6689.163854518185;6691.76578819739;6776.322367763283;6783;6783.287754785775;6818.454523638196;6945.93054069463;6959.0605268290155;7042.330978557029;7043.683034263573;6631.303713110247;6644.069830223676;6719.428848547928;6726.125603671491;6726.596404215763;6877.931220687729;6883;6884.759033433806;6890.689918953559;6904.585724856524;6974.442044636316;6984.441244700513;7063.187733410518;7064.576125432491;7072.151341839012;6694.497912656473;6694.59832410057;6708.19501659804;6777.423918966943;6783.966080169567;6698.430633396021;6703.8324041897395;6723.125993620798;6727.966360168168;6729.360710732472;6575.243846957661;6602.966985165043;6649.867002660017;6655.168103987002;6664.766733164316;6687.732490700512;6722.663866806738;6757.594544327356;6810.693518791765;6836.965815170893;6394.71223794921;6506.804795856132;6513.381228783258;6517.348265173634;6519 11:53:25 INFO - PID 3803 | |1;ext.html;877.1053525404087;877.4252864373838;898.505821798011;900.9324300677447;905.9682911098113;38516.229675406474;39157.216855662904;42114.36828447576;42151.789241053826;42155.78922105393;38859;39169.21661566767;39189.80405097971;39200.41199382012;39217.41173882394;7296.306850849161;7408.740694075708;7421;7957.164497727742;8164;7943.324817390529;8033.236842499953;8039.758807235792;8045.316148127416;8047.074586422548;8040.718574849881;8044.356451483867;8047.557384343859;8051.838963220732;8114.918850811505;8011.238932301422;8044.557549334784;8047.436679432442;8059.758207253821;8064.798380040487;7963.8805417918775;8018.398620103458;8051.718189863327;8054.395920306;8061.274485296293;38331.61668383336;38334.80832595847;38379;38409.23181536382;38411;3517.314123745871;3527.1005893496995;3556.199855032597;3559.75081744278;3561.3411518869093;31812.840935795404;31986.680133198603;32072;32082.839585802154;32097.358052838812;5293.444188360205;5312.76092575835;5330.466953304677;5334.093204155303;5419.83740487786;185803;186811;187542;187887;188232;42796.78601607034;48811.755941220064;49255.50744492509;49372.25941610878;49477.75261123671;44899.77550112228;50841;51808.740956294976;51952.74023629933;51962.740186298826;14740.11559306445;14873.776893346609;14876.628084297763;14889.255537223096;14905.478308259158;11806.586769463027;11867.762644747057;11872.40637968098;11895.70260743471;11949.522019119138;14541.563753087425;14659;14689.926550367394;14709.878516624161;14877.702445951021;5538.667679939216;5581.162825576196;5677.545796336366;5713.200151978726;5847.883042339215;1021.3514418344405;1024.3956065920993;1041.4844651897358;1044.7074819050679;1049.454283772434;22909.19817806369;23302.252331075237;23473.295801125994;23535.529289414117;23570.528589428115;1120.624590762104;1126.7352172239516;1128.5316593613559;1131.4342828585707;1141.8801025892328;12406.379681015913;12430.756924307498;12540.561080362144;12548.874511254953;12581.811272830915;219365;229226;230733;231783;232847;52200.21699674508;52551.47448525466;52569;52688.20967685488;52791.208131878055;1422.1893520693106;1454.120257244373;1456.1408768826443;1461.7880407340876;1469.3020815112736;22675.20636777705;22855.77144228603;23154.421139471648;23224.187153449548;23326.300210993697;37108.443373348884;37195.81402092972;37198.81400593088;37237.44143837791;37332.06669833276;196915;197654;198659;198958;199188;31701.524477133324;34296.48555271623;35359.64640353563;35772.821135894155;35780.4632930501;42791.572084278756;42904.78547607242;43191.78404107959;43231.13537729165;43802;31997.68002319947;32119.518207226443;32128.35743285168;32338.676613233565;32582.83708581442;31516.527252091695;32263.677363226067;32369;32766.180845479055;32816;35508.112297192776;35595.110122246115;35795.46306805452;36033.81983090068;36086.45870311895;30858.69141308558;31036.22409439692;31161;31282.68717312889;31440;22972.540549188587;23230.3030909073;24045.27864164078;24073.638895416232;24401.755982439947 11:53:25 INFO - PID 3803 | |2;jquery.html;578.1068249554438;589.687465643209;591.3465620489359;599.8470390050536;603.9365866584009;22015.779842201573;22742.43143921403;22789.860506974648;22806.88596557019;22820.65769013466;23644.290671279847;24350.147744828933;24447;24480.26559203222;24554.877225613847;6418.326075762047;6573.211214654249;6590.406863382294;6590.637514936677;6596.868062638744;6480.805575832733;6520.18497687789;6570.1130347403205;6570.967145164292;6674.532782705212;6980.825479363031;7018.19290781559;7038.366547010768;7049.189343225544;7059.117610298713;7059.752908648198;7060.611666358348;7068.045813815121;7072.717091316367;7073.646317684095;6889.311068893121;6896.586204827676;6896.793096207121;6907.861842763167;6910.723571057151;28697.713022869713;29371.412571748446;29849.70150298491;30338.54492182619;30485.23786905345;2081.3859911326194;2099.4331530486684;2107.0097054384414;2107.57848430313;2110.02938648222;20210.39368818938;20790.89604551983;20798.27206047796;20836.166553337847;20905.477363065893;2433.3916520869784;2549.961750573724;2620.7772339351177;2631.4737052589367;2640.2475294540964;118190.40904795507;123627.38186309101;124706.37646811707;135913;145147.27426362905;19499.44004479638;20005.299814506423;21350.252741153985;21672;21817.23639672604;41399.379009314885;41425.1714965699;41489.377659335136;41610.543630972774;41629;10617.150627949746;10774.461276936121;10793.114478787631;10903.563857445613;10978.231523793258;8791.824163516694;8792.78018049541;8896.243819275305;8958.148975847284;8963.282937364995;10659.200559958033;10735.624253151102;11002.669919902415;11053.392063436428;11590.942045289888;3582.2119133790525;3589.964100359015;3651.744377893522;4216.536181020086;4326;950.3300173377891;967.5500892085214;971.844504879216;980.1717548671504;983.2871168402851;18375.081245937916;18575.72136417955;18701.34545290908;19190;19279.80720192808;1001.6344034427527;1020.8774947006407;1022.4070039377292;1029.624187171692;1040.266612038511;10417.895821041693;10570.116940660353;10752.354858708502;10888.727781805519;11009.174311926477;486803;500750;513961;514019;517508;109235.45382273197;110220;110305;110340;114113;1157.5774842182543;1160.182071639492;1182.1252273317682;1184.9466773995018;1186.5372504723166;16883.986960782393;17078.2314795832;17202.31190752356;17511.562210944827;17793.288268469118;55583.44416555783;55699;56128.71935640459;57106;58005.489478499476;68333;68777.65611171912;68942.3105768936;68959.31040689729;68965.65517172382;18903.338383156522;19370;19446.22215111436;19456.319028833925;19510.707339389635;22028.669569956783;22218.222362217246;22355.77644223602;22498.662520061884;22547.774522255222;17409.21658525344;17567.12164391801;17966.5508362292;17971.37100201487;18044.45866623951;15685;15744.527664170093;15881;16226.269817858461;16280.67438651244;17970.5507362317;18115.456536303933;18251;18292.268309268013;18329.266829326676;17588.38440654571;18607.44177674672;18883;18962.43112706621;18988;17368.82631173672;17856;17879.28482860723;18027.909860450614;18054.5486362842 11:53:25 INFO - PID 3803 | |3;mootools.html;1323.4110820684796;1375.7248550289944;1375.8924066126767;1381.8479967203607;1386.89598280129;15377.615559611015;16580.66838663226;16584.75122873158;16609.086500242498;16609.750853737205;16075.919620401912;16198.947068440573;16268.186590670448;16292.348306067743;16330.265138068786;2744.1767469759093;2809.5504719244923;2844.288927768058;2866.082853486885;2867.16852112887;2865.555838844982;2867.8279303241766;2899.927501812461;2902.970970290302;2902.9854850725715;2772.778177745786;2806.621106150674;2849.943001139976;2850.558163484663;2852.8003039787222;2735.6306898568637;2762.8480433576146;2787.8606069696434;2790.8325500469937;2793.6647602287753;2741.575055866324;2758.1174024312227;2795.8182718123257;2823.9858800705865;2826.590144429046;14806.703865922622;15047.322870470745;15074.924625376912;15101.622459438602;15133.924330378277;8393.244607985249;8662.393632445732;8705.695300664447;8710.869336959951;8737.995130560003;5557.805476808292;5797.971010144965;5841.9415805842245;5884.47039766423;5918.852028699274;1959.5297128689153;1970.4285757130415;1984.7915968823354;2009.7186393904865;2016.2942969960543;27706.72293277082;27784.722152778417;27852.86073569619;27909.581356279672;27934.720652793414;6954.895676564855;7081.327273908971;7125.750598729123;7351.264873512606;7359.374453171434;17826.732599011026;17834.643307133785;17856.19647115883;17863;17864.821351786577;8273.255407013397;8430.072692003874;8671.869921951176;8966.551672416354;8977.506237157018;7804.180561041123;7959.641816118288;7966.681332746741;7979.5611241382285;8024.959875200587;5469.316335458067;5609.657586500998;5617.399041273299;5633.8309850704545;5685.488306052475;1680.0675625027982;1685.7639930409753;1693.3480609965006;1701.7237072195853;1706.709859323918;883.9513826739462;898.3217670658611;899.9910000900038;904.2901322461836;909.2044461096541;7541.811454713676;7560.546367217875;7590;7618.6190690465255;7680.231976802275;734.9338559529668;739.2053542441896;741.573595182772;745.6607243704102;751.6317004667674;4653.674242803039;4677.95322046782;5139.665921715151;5414.566834653218;5488.423715509894;22085.337439876508;22245.777542224372;22269.66595501069;22866.771332286466;22963.655545166836;22212.88893555522;22571.322860314216;22746.545069098855;22971.310860674206;23154.421139471648;11725.472353744102;11840.28958262507;11902;11905.642830715266;11973.563172419366;8132.1461246570625;8176.100628930694;8206.712765053195;8265.752027439186;8302.128276530877;19138.330158444387;19227.807721922603;19280.035998200314;19431.125599348346;19894.50263743418;19613.41159765209;20244;20304.390868273975;20426.89786551058;20527.589448211253;11426.94286528562;11463;11498;11501.82747258775;11518;14201.857981420468;14218.928905355408;14250.501232456814;14368.712625747217;14452;10990.505427255634;11110.50002749862;11265.831012534982;11409.543618255177;11420.428978551205;11064.612738554433;11310.377929213972;11385.601503947653;11544;11683.707907302385;9943.801123977624;9968.50157492108;10024.047715467019;10147.086762191142;10154.441505717257;6926.896096558657;6992.300769922967;6997.1253593300835;7007.929920700728;7056.894146587702;7259.201487836228;7260;7262.455315851438;7292.817679557841;7385.261473852572 11:53:25 INFO - PID 3803 | |4;prototype.html;505.7673470203706;535.2337286953054;536.0779459329951;545.7216819422096;548.9121740521516;6306.148669929569;6314.526410519206;6332;6348.539835837754;6366.840828979278;6220.4712599428985;6226;6244.781432649858;6276.403741644548;6293.874122517547;5240.502152295526;5264.552513036387;5279.894402111955;5281.577473802086;5281.705982034407;4961.603071754251;5206.167013277876;5236.21456781482;5249.86875328116;5264.105102132647;5039.3196918415915;5048.419431765339;5052.9242061369105;5061.759868832141;5063.721495317756;4996.500349964975;5018.239968017612;5020.246962955549;5054.342935418372;5058.266551350052;4455.485135054098;4497.662675299365;4512.255477846152;4517.457905051415;4526.3210518422175;6013.248343957005;6050;6079.20970273866;6128.417800308964;6134.914129196095;5721.084626459747;5729.541636669056;5760.9711951440395;5773.451522105393;5817.156512305734;6524.347565243485;6609.173853268341;6613.966930165367;6621.9006714899315;6643.202815662103;4974.925376119361;4981.9750901245625;4990.226514890198;4997.350344455234;4998.375203099613;6698.459354348478;6824.590524568542;6894.862347712621;6917.51577389583;6987.301269873023;5065.544101030925;5075.2387141929;5077.314562534085;5099.082165210298;5100.821471248489;5166.302549155891;5166.535011848877;5183.481651834786;5192.273081768555;5205.817796377109;5749.3963133871175;5750.5112065474905;5765.308163020464;5785.363610002896;5787.942120578825;6619.404253617197;6672.733090676318;6689.531732778659;6693.732250709917;6711.865762684719;1780.5993651428325;1785.3394244129754;1802.4142153800067;1805.133535902774;1815.9909200454179;1196.7606478704295;1238.6903274181454;1248.656619429664;1251.8310028146084;1257.6855786053486;5725.914111288334;5726.737938514263;5735.283089613798;5771.307443106854;5786.913196302059;6721.5802311167945;6769.950657648073;6776.881814500651;6781.796546103625;6840.179178498513;5740.885182296331;5742.28221472316;5753.769849206069;5784.94215057844;5808.82573522795;3543.450765131357;3577.5868531930264;3594.4608308753373;3613.8915832525067;3628.8004159771467;6273.247210334789;6403.199600049994;6412.551121421549;6572.539922205399;6643.667816609247;6854.3145685432055;6862.416694581017;6958.408535274457;6961.93038069623;6975.488824023348;6496.35036496356;6500.317466666026;6521.282658907611;6554.934450655528;6572.4084832365315;6717.596944183365;6719.731210751515;6734.393904548614;6763.425108865801;6776.390124888783;6657.966710166418;6666.366695163952;6694.330566943267;6706.497012724163;6755.864882702417;6480.611163330027;6561.015847622894;6589.703463344065;6628.867422651423;6652.135222421054;5059.392872855281;5070.391553013662;5074.6194035448225;5086.6925012984375;5104.2343648453025;6446.5165112615805;6464.385883341075;6592.967035164794;6742.662866856539;6749.223839258548;6523.3150519194805;6570.375814297634;6585.287825165396;6595.790410212632;6665.266820649822;6489.837754056186;6558.311377305315;6583.637899915359;6585.473162146921;6609.570377925419;6362.45919096882;6447.3552644735155;6456.450451891418;6465.838354041187;6521.315261897622;6573.474122070318;6632.369924857131;6644.468442524683;6667.133272674715;6681.558997116586;6361.427471527585;6384.361563843579;6463.418292353711;6479.967600161969;6482.35176482348 11:53:25 INFO - PID 3803 | |5;yui.html;896.8699538566908;937.6436953957495;941.9858702119474;944.7826999790049;948.720127562369;19395.515112122204;19669;20238.39284821458;20258.189672413122;20270;19419;19605;19614.41156765296;19616.117274722637;19622.607547849035;973.6251543155865;988.6737376665683;991.9404835709845;992.2359782967111;992.3450522655049;963.2775418436173;997.366672163178;1004.1866088468328;1006.7634105985088;1011.7824667696444;1070.0530030922612;1070.4808168038496;1071;1071.9142468602492;1071.9892801071967;1064.0157853985033;1065.904068633819;1066.7013236293851;1066.9626563070333;1067.092970974673;721.282324087531;742.224375527575;750.1186106325047;751.4514404484702;780.9297163255277;20736.377908662766;20779.792202077937;20898.268560600307;20937.162513499596;20953.476163095893;21997.560048799096;22003.11987520497;22736.317910462712;22888.65667014996;22893;17512;18023.18895649686;18084.367047153286;18197.45407637773;18345.08274586265;3848.288066707668;3874.0314921269683;3874.786886721229;3876.379779235309;3879.9806000969816;141162;141824;144342;145454;145795;16778.664426711643;17348.045857477708;17382;17386.130693465275;17545.210465529082;32304.515432268534;32370.190745231557;32986.83506582452;33136.834315828746;33183.668163318056;8689.956550217208;8889.19997200255;8980.820383592292;8986.415882967585;8993.055729148346;4299.1831552005015;4406.647468202536;4422.84520041797;4425.491068527161;4427.313766366218;5639.802606908738;5746.482816546531;5751.769929202868;5768.423157684282;5783.103618939072;994.0854413939194;1008.4100801031478;1023.6877752285625;1030.618671091701;1031.4481752262504;685.8525417035262;685.8662560800595;699.9020137180798;701.8982247574073;713.2546488918988;11709.355985420712;11840.348780816965;12000.939995300143;12080.093992950387;12165.69585760363;663.465909942501;674.3627272227795;675.3955210086945;677.204284965164;688.1054628982403;5438.864028399322;5467.20725494801;5505.504504594605;5549.278593782863;5607.355154157242;125618.37190814171;127211;128061;128962.4863129786;129711;111688.44155779331;111860;112054.43972780247;115066;115643;96689.51655241678;100739.49630251949;101058;103163;105604.47197764115;11487.36819474937;12068;12241.571544995883;12378.81431778506;12621.087462886535;42748;43541.3468797962;44165.77917110394;44186.75283679307;44367.77816110899;54530.454695452536;55087.173692395445;55571.44428555663;56349.71825140848;57097.42902571087;18780.530486737942;18879.90560047191;18963.810361896205;18974.905125474284;19101;21424.250151244632;21546.461338466663;21574.352769416942;21640.24259150922;21851.67222491632;17469.563260918578;17681.292748289925;17879;18134;18174.636507270046;18885.90557047206;18912.716309255098;19133;19180.904095479433;19332.516687082374;17621.735673964646;17720.468385948443;17787.199576019368;17902.28390864351;18028.54928626795;13286;13405.664858378228;13640.113392629448;13670.384832682354;13821.861781382058;11990.640280791591;12205.511779529075;12286.201396909173;12549.93725031369;12609.432575534307 11:53:25 INFO - PID 3803 | __end_tp_report 11:53:25 INFO - PID 3803 | __start_cc_report 11:53:25 INFO - PID 3803 | _x_x_mozilla_cycle_collect,295 11:53:25 INFO - PID 3803 | __end_cc_report 11:53:25 INFO - PID 3803 | __startTimestamp1506020005096__endTimestamp 11:53:25 INFO - PID 3803 | 11:53:25 INFO - PID 3803 | ------- Summary: start ------- 11:53:25 INFO - PID 3803 | Number of tests: 6 11:53:25 INFO - PID 3803 | 11:53:25 INFO - PID 3803 | [#0] dojo.html Cycles:165 Average:6349.40 Median:6631.30 stddev:767.93 (11.6%) stddev-sans-first:728.03 11:53:25 INFO - PID 3803 | Values: 3147.1 3162.9 3188.8 3209.8 3211.9 6322.2 6391.9 6463.2 6539.1 6569.5 6349.9 6380.0 6382.5 6442.1 6574.6 5938.3 5985.8 6021.0 6022.1 6051.0 5912.0 5947.8 5977.1 6078.2 6080.0 5877.8 5912.3 5954.5 6016.8 6105.7 5888.1 5903.5 5905.5 5913.6 5935.2 5854.0 5858.5 5913.8 5918.1 5928.0 6362.7 6371.2 6372.0 6445.7 6538.6 6735.4 6811.1 6846.4 6935.2 6947.8 6941.1 7016.1 7027.1 7027.5 7031.1 6408.6 6443.2 6481.6 6495.9 6500.6 7008.4 7060.8 7102.0 7119.0 7208.9 6769.2 6778.2 6796.8 6800.2 6850.1 6900.5 6916.9 6970.4 6976.6 6984.7 6671.6 6821.5 6836.1 6873.4 6967.5 6770.1 6822.7 6825.1 6832.6 6837.0 5306.0 5318.8 5322.9 5354.3 5486.0 4707.5 4724.1 4837.2 4839.1 4854.4 5904.9 5909.7 5993.3 5994.4 5997.0 6755.2 6851.9 6861.8 6868.8 6869.6 5790.2 5815.0 5830.1 5849.1 5959.6 5903.5 6000.4 6005.6 6010.1 6020.9 6689.2 6691.8 6776.3 6783.0 6783.3 6818.5 6945.9 6959.1 7042.3 7043.7 6631.3 6644.1 6719.4 6726.1 6726.6 6877.9 6883.0 6884.8 6890.7 6904.6 6974.4 6984.4 7063.2 7064.6 7072.2 6694.5 6694.6 6708.2 6777.4 6784.0 6698.4 6703.8 6723.1 6728.0 6729.4 6575.2 6603.0 6649.9 6655.2 6664.8 6687.7 6722.7 6757.6 6810.7 6837.0 6394.7 6506.8 6513.4 6517.3 6519.0 11:53:25 INFO - PID 3803 | 11:53:25 INFO - PID 3803 | [#1] ext.html Cycles:180 Average:37358.91 Median:19532.16 stddev:53210.27 (272.4%) stddev-sans-first:53289.03 11:53:25 INFO - PID 3803 | Values: 877.1 877.4 898.5 900.9 906.0 38516.2 39157.2 42114.4 42151.8 42155.8 38859.0 39169.2 39189.8 39200.4 39217.4 7296.3 7408.7 7421.0 7957.2 8164.0 7943.3 8033.2 8039.8 8045.3 8047.1 8040.7 8044.4 8047.6 8051.8 8114.9 8011.2 8044.6 8047.4 8059.8 8064.8 7963.9 8018.4 8051.7 8054.4 8061.3 38331.6 38334.8 38379.0 38409.2 38411.0 3517.3 3527.1 3556.2 3559.8 3561.3 31812.8 31986.7 32072.0 32082.8 32097.4 5293.4 5312.8 5330.5 5334.1 5419.8 185803.0 186811.0 187542.0 187887.0 188232.0 42796.8 48811.8 49255.5 49372.3 49477.8 44899.8 50841.0 51808.7 51952.7 51962.7 14740.1 14873.8 14876.6 14889.3 14905.5 11806.6 11867.8 11872.4 11895.7 11949.5 14541.6 14659.0 14689.9 14709.9 14877.7 5538.7 5581.2 5677.5 5713.2 5847.9 1021.4 1024.4 1041.5 1044.7 1049.5 22909.2 23302.3 23473.3 23535.5 23570.5 1120.6 1126.7 1128.5 1131.4 1141.9 12406.4 12430.8 12540.6 12548.9 12581.8 219365.0 229226.0 230733.0 231783.0 232847.0 52200.2 52551.5 52569.0 52688.2 52791.2 1422.2 1454.1 1456.1 1461.8 1469.3 22675.2 22855.8 23154.4 23224.2 23326.3 37108.4 37195.8 37198.8 37237.4 37332.1 196915.0 197654.0 198659.0 198958.0 199188.0 31701.5 34296.5 35359.6 35772.8 35780.5 42791.6 42904.8 43191.8 43231.1 43802.0 31997.7 32119.5 32128.4 32338.7 32582.8 31516.5 32263.7 32369.0 32766.2 32816.0 35508.1 35595.1 35795.5 36033.8 36086.5 30858.7 31036.2 31161.0 31282.7 31440.0 22972.5 23230.3 24045.3 24073.6 24401.8 11:53:25 INFO - PID 3803 | 11:53:25 INFO - PID 3803 | [#2] jquery.html Cycles:180 Average:35723.99 Median:22022.22 stddev:84610.34 (384.2%) stddev-sans-first:84806.55 11:53:25 INFO - PID 3803 | Values: 578.1 589.7 591.3 599.8 603.9 22015.8 22742.4 22789.9 22806.9 22820.7 23644.3 24350.1 24447.0 24480.3 24554.9 6418.3 6573.2 6590.4 6590.6 6596.9 6480.8 6520.2 6570.1 6571.0 6674.5 6980.8 7018.2 7038.4 7049.2 7059.1 7059.8 7060.6 7068.0 7072.7 7073.6 6889.3 6896.6 6896.8 6907.9 6910.7 28697.7 29371.4 29849.7 30338.5 30485.2 2081.4 2099.4 2107.0 2107.6 2110.0 20210.4 20790.9 20798.3 20836.2 20905.5 2433.4 2550.0 2620.8 2631.5 2640.2 118190.4 123627.4 124706.4 135913.0 145147.3 19499.4 20005.3 21350.3 21672.0 21817.2 41399.4 41425.2 41489.4 41610.5 41629.0 10617.2 10774.5 10793.1 10903.6 10978.2 8791.8 8792.8 8896.2 8958.1 8963.3 10659.2 10735.6 11002.7 11053.4 11590.9 3582.2 3590.0 3651.7 4216.5 4326.0 950.3 967.6 971.8 980.2 983.3 18375.1 18575.7 18701.3 19190.0 19279.8 1001.6 1020.9 1022.4 1029.6 1040.3 10417.9 10570.1 10752.4 10888.7 11009.2 486803.0 500750.0 513961.0 514019.0 517508.0 109235.5 110220.0 110305.0 110340.0 114113.0 1157.6 1160.2 1182.1 1184.9 1186.5 16884.0 17078.2 17202.3 17511.6 17793.3 55583.4 55699.0 56128.7 57106.0 58005.5 68333.0 68777.7 68942.3 68959.3 68965.7 18903.3 19370.0 19446.2 19456.3 19510.7 22028.7 22218.2 22355.8 22498.7 22547.8 17409.2 17567.1 17966.6 17971.4 18044.5 15685.0 15744.5 15881.0 16226.3 16280.7 17970.6 18115.5 18251.0 18292.3 18329.3 17588.4 18607.4 18883.0 18962.4 18988.0 17368.8 17856.0 17879.3 18027.9 18054.5 11:53:25 INFO - PID 3803 | 11:53:25 INFO - PID 3803 | [#3] mootools.html Cycles:180 Average:9674.42 Median:27818.79 stddev:7004.14 (25.2%) stddev-sans-first:6995.68 11:53:25 INFO - PID 3803 | Values: 1323.4 1375.7 1375.9 1381.8 1386.9 15377.6 16580.7 16584.8 16609.1 16609.8 16075.9 16198.9 16268.2 16292.3 16330.3 2744.2 2809.6 2844.3 2866.1 2867.2 2865.6 2867.8 2899.9 2903.0 2903.0 2772.8 2806.6 2849.9 2850.6 2852.8 2735.6 2762.8 2787.9 2790.8 2793.7 2741.6 2758.1 2795.8 2824.0 2826.6 14806.7 15047.3 15074.9 15101.6 15133.9 8393.2 8662.4 8705.7 8710.9 8738.0 5557.8 5798.0 5841.9 5884.5 5918.9 1959.5 1970.4 1984.8 2009.7 2016.3 27706.7 27784.7 27852.9 27909.6 27934.7 6954.9 7081.3 7125.8 7351.3 7359.4 17826.7 17834.6 17856.2 17863.0 17864.8 8273.3 8430.1 8671.9 8966.6 8977.5 7804.2 7959.6 7966.7 7979.6 8025.0 5469.3 5609.7 5617.4 5633.8 5685.5 1680.1 1685.8 1693.3 1701.7 1706.7 884.0 898.3 900.0 904.3 909.2 7541.8 7560.5 7590.0 7618.6 7680.2 734.9 739.2 741.6 745.7 751.6 4653.7 4678.0 5139.7 5414.6 5488.4 22085.3 22245.8 22269.7 22866.8 22963.7 22212.9 22571.3 22746.5 22971.3 23154.4 11725.5 11840.3 11902.0 11905.6 11973.6 8132.1 8176.1 8206.7 8265.8 8302.1 19138.3 19227.8 19280.0 19431.1 19894.5 19613.4 20244.0 20304.4 20426.9 20527.6 11426.9 11463.0 11498.0 11501.8 11518.0 14201.9 14218.9 14250.5 14368.7 14452.0 10990.5 11110.5 11265.8 11409.5 11420.4 11064.6 11310.4 11385.6 11544.0 11683.7 9943.8 9968.5 10024.0 10147.1 10154.4 6926.9 6992.3 6997.1 7007.9 7056.9 7259.2 7260.0 7262.5 7292.8 7385.3 11:53:25 INFO - PID 3803 | 11:53:25 INFO - PID 3803 | [#4] prototype.html Cycles:180 Average:5566.07 Median:6223.24 stddev:1541.81 (24.8%) stddev-sans-first:1498.63 11:53:25 INFO - PID 3803 | Values: 505.8 535.2 536.1 545.7 548.9 6306.1 6314.5 6332.0 6348.5 6366.8 6220.5 6226.0 6244.8 6276.4 6293.9 5240.5 5264.6 5279.9 5281.6 5281.7 4961.6 5206.2 5236.2 5249.9 5264.1 5039.3 5048.4 5052.9 5061.8 5063.7 4996.5 5018.2 5020.2 5054.3 5058.3 4455.5 4497.7 4512.3 4517.5 4526.3 6013.2 6050.0 6079.2 6128.4 6134.9 5721.1 5729.5 5761.0 5773.5 5817.2 6524.3 6609.2 6614.0 6621.9 6643.2 4974.9 4982.0 4990.2 4997.4 4998.4 6698.5 6824.6 6894.9 6917.5 6987.3 5065.5 5075.2 5077.3 5099.1 5100.8 5166.3 5166.5 5183.5 5192.3 5205.8 5749.4 5750.5 5765.3 5785.4 5787.9 6619.4 6672.7 6689.5 6693.7 6711.9 1780.6 1785.3 1802.4 1805.1 1816.0 1196.8 1238.7 1248.7 1251.8 1257.7 5725.9 5726.7 5735.3 5771.3 5786.9 6721.6 6770.0 6776.9 6781.8 6840.2 5740.9 5742.3 5753.8 5784.9 5808.8 3543.5 3577.6 3594.5 3613.9 3628.8 6273.2 6403.2 6412.6 6572.5 6643.7 6854.3 6862.4 6958.4 6961.9 6975.5 6496.4 6500.3 6521.3 6554.9 6572.4 6717.6 6719.7 6734.4 6763.4 6776.4 6658.0 6666.4 6694.3 6706.5 6755.9 6480.6 6561.0 6589.7 6628.9 6652.1 5059.4 5070.4 5074.6 5086.7 5104.2 6446.5 6464.4 6593.0 6742.7 6749.2 6523.3 6570.4 6585.3 6595.8 6665.3 6489.8 6558.3 6583.6 6585.5 6609.6 6362.5 6447.4 6456.5 6465.8 6521.3 6573.5 6632.4 6644.5 6667.1 6681.6 6361.4 6384.4 6463.4 6480.0 6482.4 11:53:25 INFO - PID 3803 | 11:53:25 INFO - PID 3803 | [#5] yui.html Cycles:180 Average:25523.44 Median:19619.36 stddev:36536.18 (186.2%) stddev-sans-first:36591.88 11:53:25 INFO - PID 3803 | Values: 896.9 937.6 942.0 944.8 948.7 19395.5 19669.0 20238.4 20258.2 20270.0 19419.0 19605.0 19614.4 19616.1 19622.6 973.6 988.7 991.9 992.2 992.3 963.3 997.4 1004.2 1006.8 1011.8 1070.1 1070.5 1071.0 1071.9 1072.0 1064.0 1065.9 1066.7 1067.0 1067.1 721.3 742.2 750.1 751.5 780.9 20736.4 20779.8 20898.3 20937.2 20953.5 21997.6 22003.1 22736.3 22888.7 22893.0 17512.0 18023.2 18084.4 18197.5 18345.1 3848.3 3874.0 3874.8 3876.4 3880.0 141162.0 141824.0 144342.0 145454.0 145795.0 16778.7 17348.0 17382.0 17386.1 17545.2 32304.5 32370.2 32986.8 33136.8 33183.7 8690.0 8889.2 8980.8 8986.4 8993.1 4299.2 4406.6 4422.8 4425.5 4427.3 5639.8 5746.5 5751.8 5768.4 5783.1 994.1 1008.4 1023.7 1030.6 1031.4 685.9 685.9 699.9 701.9 713.3 11709.4 11840.3 12000.9 12080.1 12165.7 663.5 674.4 675.4 677.2 688.1 5438.9 5467.2 5505.5 5549.3 5607.4 125618.4 127211.0 128061.0 128962.5 129711.0 111688.4 111860.0 112054.4 115066.0 115643.0 96689.5 100739.5 101058.0 103163.0 105604.5 11487.4 12068.0 12241.6 12378.8 12621.1 42748.0 43541.3 44165.8 44186.8 44367.8 54530.5 55087.2 55571.4 56349.7 57097.4 18780.5 18879.9 18963.8 18974.9 19101.0 21424.3 21546.5 21574.4 21640.2 21851.7 17469.6 17681.3 17879.0 18134.0 18174.6 18885.9 18912.7 19133.0 19180.9 19332.5 17621.7 17720.5 17787.2 17902.3 18028.5 13286.0 13405.7 13640.1 13670.4 13821.9 11990.6 12205.5 12286.2 12549.9 12609.4 11:53:25 INFO - PID 3803 | -------- Summary: end -------- 11:53:25 INFO - PID 3803 | 11:53:25 INFO - TEST-INFO | 3803: exit 0 11:53:25 INFO - TEST-OK | dromaeo_css | took 1111446ms 11:53:25 INFO - TEST-START | kraken 11:53:25 INFO - Initialising browser for kraken test... 11:53:25 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:47244/getInfo.html -profile /tmp/tmpS6_QTO/profile 11:53:25 INFO - TEST-INFO | started process 4164 (/builds/slave/test/build/application/firefox/firefox http://localhost:47244/getInfo.html) 11:53:31 INFO - TEST-INFO | 4164: exit 0 11:53:31 INFO - Browser initialized. 11:53:31 INFO - Running cycle 1/1 for kraken test... 11:53:31 INFO - Using env: {'DISPLAY': ':0', 11:53:31 INFO - 'HOME': '/home/cltbld', 11:53:31 INFO - 'JSGC_DISABLE_POISONING': '1', 11:53:31 INFO - 'LANG': 'en_US.UTF-8', 11:53:31 INFO - 'LANGUAGE': 'en_US:en', 11:53:31 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 11:53:31 INFO - 'LOGNAME': 'cltbld', 11:53:31 INFO - 'MAIL': '/var/mail/cltbld', 11:53:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:53:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:53:31 INFO - 'MOZ_CRASHREPORTER': '1', 11:53:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:53:31 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 11:53:31 INFO - 'MOZ_NO_REMOTE': '1', 11:53:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:53:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:53:31 INFO - 'NO_EM_RESTART': '1', 11:53:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:53:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:53:31 INFO - 'PWD': '/builds/slave/test', 11:53:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:53:31 INFO - 'RUST_BACKTRACE': 'full', 11:53:31 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:53:31 INFO - 'SHELL': '/bin/bash', 11:53:31 INFO - 'SHLVL': '1', 11:53:31 INFO - 'TERM': 'linux', 11:53:31 INFO - 'TMOUT': '86400', 11:53:31 INFO - 'USER': 'cltbld', 11:53:31 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1506018102.688246-295755340', 11:53:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:53:31 INFO - '_': '/tools/buildbot/bin/python'} 11:53:31 INFO - TEST-INFO | started process 4399 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpS6_QTO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:53:32 INFO - PID 4399 | 11:53:32 INFO - PID 4399 | (/builds/slave/test/build/application/firefox/firefox:4448): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:53:32 INFO - PID 4399 | 11:53:42 INFO - PID 4399 | RSS: Main: 154431488 11:53:42 INFO - PID 4399 | 11:53:45 INFO - PID 4399 | Cycle 1(1): loaded http://localhost:47244/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47244/tests/kraken/driver.html?testName=audio-beat-detection) 11:53:46 INFO - PID 4399 | RSS: Main: 160116736 11:53:46 INFO - PID 4399 | 11:53:48 INFO - PID 4399 | Cycle 1(1): loaded http://localhost:47244/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47244/tests/kraken/driver.html?testName=audio-dft) 11:53:49 INFO - PID 4399 | RSS: Main: 160636928 11:53:49 INFO - PID 4399 | 11:53:52 INFO - PID 4399 | Cycle 1(1): loaded http://localhost:47244/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47244/tests/kraken/driver.html?testName=audio-fft) 11:53:53 INFO - PID 4399 | RSS: Main: 156872704 11:53:53 INFO - PID 4399 | 11:53:55 INFO - PID 4399 | Cycle 1(1): loaded http://localhost:47244/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47244/tests/kraken/driver.html?testName=audio-oscillator) 11:53:55 INFO - PID 4399 | RSS: Main: 157782016 11:53:55 INFO - PID 4399 | 11:53:57 INFO - PID 4399 | Cycle 1(1): loaded http://localhost:47244/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47244/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:53:58 INFO - PID 4399 | RSS: Main: 157319168 11:53:58 INFO - PID 4399 | 11:54:01 INFO - PID 4399 | Cycle 1(1): loaded http://localhost:47244/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47244/tests/kraken/driver.html?testName=imaging-darkroom) 11:54:02 INFO - PID 4399 | RSS: Main: 159969280 11:54:02 INFO - PID 4399 | 11:54:05 INFO - PID 4399 | Cycle 1(1): loaded http://localhost:47244/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47244/tests/kraken/driver.html?testName=imaging-desaturate) 11:54:06 INFO - PID 4399 | RSS: Main: 159965184 11:54:06 INFO - PID 4399 | 11:54:09 INFO - PID 4399 | Cycle 1(1): loaded http://localhost:47244/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47244/tests/kraken/driver.html?testName=json-parse-financial) 11:54:10 INFO - PID 4399 | RSS: Main: 160481280 11:54:10 INFO - PID 4399 | 11:54:11 INFO - PID 4399 | Cycle 1(1): loaded http://localhost:47244/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47244/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:54:12 INFO - PID 4399 | RSS: Main: 160681984 11:54:12 INFO - PID 4399 | 11:54:13 INFO - PID 4399 | Cycle 1(1): loaded http://localhost:47244/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47244/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:54:14 INFO - PID 4399 | RSS: Main: 160210944 11:54:14 INFO - PID 4399 | 11:54:17 INFO - PID 4399 | Cycle 1(1): loaded http://localhost:47244/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47244/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:54:17 INFO - PID 4399 | RSS: Main: 157806592 11:54:17 INFO - PID 4399 | 11:54:20 INFO - PID 4399 | Cycle 1(1): loaded http://localhost:47244/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47244/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:54:20 INFO - PID 4399 | RSS: Main: 157904896 11:54:20 INFO - PID 4399 | 11:54:24 INFO - PID 4399 | Cycle 1(1): loaded http://localhost:47244/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47244/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:54:24 INFO - PID 4399 | RSS: Main: 157835264 11:54:24 INFO - PID 4399 | 11:54:26 INFO - PID 4399 | Cycle 1(1): loaded http://localhost:47244/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47244/tests/kraken/driver.html?testName=ai-astar) 11:54:26 INFO - PID 4399 | RSS: Main: 159154176 11:54:26 INFO - PID 4399 | 11:54:26 INFO - PID 4399 | __start_tp_report 11:54:26 INFO - PID 4399 | _x_x_mozilla_page_load 11:54:26 INFO - PID 4399 | _x_x_mozilla_page_load_details 11:54:26 INFO - PID 4399 | |i|pagename|runs| 11:54:26 INFO - PID 4399 | |0;ai-astar;106;107;107;106;105;107;106;110;111;108 11:54:26 INFO - PID 4399 | |1;audio-beat-detection;118;117;120;118;116;120;118;119;150;129 11:54:26 INFO - PID 4399 | |2;audio-dft;164;162;161;164;165;163;165;165;163;163 11:54:26 INFO - PID 4399 | |3;audio-fft;74;75;74;73;75;74;75;74;76;74 11:54:26 INFO - PID 4399 | |4;audio-oscillator;80;83;82;79;79;79;79;79;79;79 11:54:26 INFO - PID 4399 | |5;imaging-gaussian-blur;112;114;113;115;113;114;114;115;115;114 11:54:26 INFO - PID 4399 | |6;imaging-darkroom;157;148;150;147;149;150;151;147;150;150 11:54:26 INFO - PID 4399 | |7;imaging-desaturate;94;94;94;94;95;96;95;95;95;95 11:54:26 INFO - PID 4399 | |8;json-parse-financial;54;53;54;54;53;54;53;52;52;53 11:54:26 INFO - PID 4399 | |9;json-stringify-tinderbox;38;39;38;43;39;39;39;38;38;37 11:54:26 INFO - PID 4399 | |10;stanford-crypto-aes;71;73;73;71;74;74;79;72;83;75 11:54:26 INFO - PID 4399 | |11;stanford-crypto-ccm;110;108;116;116;112;118;115;112;114;112 11:54:26 INFO - PID 4399 | |12;stanford-crypto-pbkdf2;175;186;176;171;169;172;166;181;169;173 11:54:26 INFO - PID 4399 | |13;stanford-crypto-sha256-iterative;66;65;65;68;68;66;67;67;70;68 11:54:26 INFO - PID 4399 | __end_tp_report 11:54:26 INFO - PID 4399 | __start_cc_report 11:54:26 INFO - PID 4399 | _x_x_mozilla_cycle_collect,743 11:54:26 INFO - PID 4399 | __end_cc_report 11:54:26 INFO - PID 4399 | __startTimestamp1506020066621__endTimestamp 11:54:26 INFO - PID 4399 | 11:54:26 INFO - PID 4399 | ------- Summary: start ------- 11:54:26 INFO - PID 4399 | Number of tests: 14 11:54:26 INFO - PID 4399 | 11:54:26 INFO - PID 4399 | [#0] ai-astar Cycles:10 Average:107.30 Median:107.00 stddev:1.89 (1.8%) stddev-sans-first:1.94 11:54:26 INFO - PID 4399 | Values: 106.0 107.0 107.0 106.0 105.0 107.0 106.0 110.0 111.0 108.0 11:54:26 INFO - PID 4399 | 11:54:26 INFO - PID 4399 | [#1] audio-beat-detection Cycles:10 Average:122.50 Median:119.50 stddev:10.31 (8.6%) stddev-sans-first:10.81 11:54:26 INFO - PID 4399 | Values: 118.0 117.0 120.0 118.0 116.0 120.0 118.0 119.0 150.0 129.0 11:54:26 INFO - PID 4399 | 11:54:26 INFO - PID 4399 | [#2] audio-dft Cycles:10 Average:163.50 Median:164.00 stddev:1.35 (0.8%) stddev-sans-first:1.42 11:54:26 INFO - PID 4399 | Values: 164.0 162.0 161.0 164.0 165.0 163.0 165.0 165.0 163.0 163.0 11:54:26 INFO - PID 4399 | 11:54:26 INFO - PID 4399 | [#3] audio-fft Cycles:10 Average:74.40 Median:74.50 stddev:0.84 (1.1%) stddev-sans-first:0.88 11:54:26 INFO - PID 4399 | Values: 74.0 75.0 74.0 73.0 75.0 74.0 75.0 74.0 76.0 74.0 11:54:26 INFO - PID 4399 | 11:54:26 INFO - PID 4399 | [#4] audio-oscillator Cycles:10 Average:79.80 Median:79.00 stddev:1.48 (1.9%) stddev-sans-first:1.56 11:54:26 INFO - PID 4399 | Values: 80.0 83.0 82.0 79.0 79.0 79.0 79.0 79.0 79.0 79.0 11:54:26 INFO - PID 4399 | 11:54:26 INFO - PID 4399 | [#5] imaging-gaussian-blur Cycles:10 Average:113.90 Median:114.00 stddev:0.99 (0.9%) stddev-sans-first:0.78 11:54:26 INFO - PID 4399 | Values: 112.0 114.0 113.0 115.0 113.0 114.0 114.0 115.0 115.0 114.0 11:54:26 INFO - PID 4399 | 11:54:26 INFO - PID 4399 | [#6] imaging-darkroom Cycles:10 Average:149.90 Median:150.00 stddev:2.85 (1.9%) stddev-sans-first:1.45 11:54:26 INFO - PID 4399 | Values: 157.0 148.0 150.0 147.0 149.0 150.0 151.0 147.0 150.0 150.0 11:54:26 INFO - PID 4399 | 11:54:26 INFO - PID 4399 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.67 (0.7%) stddev-sans-first:0.67 11:54:26 INFO - PID 4399 | Values: 94.0 94.0 94.0 94.0 95.0 96.0 95.0 95.0 95.0 95.0 11:54:26 INFO - PID 4399 | 11:54:26 INFO - PID 4399 | [#8] json-parse-financial Cycles:10 Average:53.20 Median:53.50 stddev:0.79 (1.5%) stddev-sans-first:0.78 11:54:26 INFO - PID 4399 | Values: 54.0 53.0 54.0 54.0 53.0 54.0 53.0 52.0 52.0 53.0 11:54:26 INFO - PID 4399 | 11:54:26 INFO - PID 4399 | [#9] json-stringify-tinderbox Cycles:10 Average:38.80 Median:39.00 stddev:1.62 (4.2%) stddev-sans-first:1.69 11:54:26 INFO - PID 4399 | Values: 38.0 39.0 38.0 43.0 39.0 39.0 39.0 38.0 38.0 37.0 11:54:26 INFO - PID 4399 | 11:54:26 INFO - PID 4399 | [#10] stanford-crypto-aes Cycles:10 Average:74.50 Median:74.00 stddev:3.78 (5.1%) stddev-sans-first:3.79 11:54:26 INFO - PID 4399 | Values: 71.0 73.0 73.0 71.0 74.0 74.0 79.0 72.0 83.0 75.0 11:54:26 INFO - PID 4399 | 11:54:26 INFO - PID 4399 | [#11] stanford-crypto-ccm Cycles:10 Average:113.30 Median:114.50 stddev:3.06 (2.7%) stddev-sans-first:3.00 11:54:26 INFO - PID 4399 | Values: 110.0 108.0 116.0 116.0 112.0 118.0 115.0 112.0 114.0 112.0 11:54:26 INFO - PID 4399 | 11:54:26 INFO - PID 4399 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.80 Median:174.00 stddev:6.01 (3.5%) stddev-sans-first:6.36 11:54:26 INFO - PID 4399 | Values: 175.0 186.0 176.0 171.0 169.0 172.0 166.0 181.0 169.0 173.0 11:54:26 INFO - PID 4399 | 11:54:26 INFO - PID 4399 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.00 Median:67.50 stddev:1.56 (2.3%) stddev-sans-first:1.62 11:54:26 INFO - PID 4399 | Values: 66.0 65.0 65.0 68.0 68.0 66.0 67.0 67.0 70.0 68.0 11:54:26 INFO - PID 4399 | -------- Summary: end -------- 11:54:26 INFO - PID 4399 | 11:54:27 INFO - PID 4399 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 11:54:27 INFO - TEST-INFO | 4399: exit 0 11:54:27 INFO - TEST-OK | kraken | took 61551ms 11:54:27 INFO - SUITE-END | took 1172s 11:54:27 INFO - Completed test suite (00:19:33) 11:54:27 INFO - javascript benchmark 11:54:27 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8757.022933748069, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3147.1030756234477, 3162.8576714047867, 3188.76084293678, 3209.7753157278985, 3211.9197020074494, 6322.241331040282, 6391.904121438176, 6463.192100987377, 6539.051837483562, 6569.474442044637, 6349.936500634993, 6380.0, 6382.489400847932, 6442.065900444444, 6574.605523668583, 5938.317093534234, 5985.820425387245, 6021.0, 6022.126791615213, 6051.0318349064155, 5911.994960856665, 5947.791827286046, 5977.073553599199, 6078.20983272174, 6080.0, 5877.79427720032, 5912.290525137011, 5954.523638108963, 6016.819495415167, 6105.725242364082, 5888.087346461305, 5903.468687818117, 5905.4685078343155, 5913.645181289094, 5935.228420305332, 5853.970730146322, 5858.472737453607, 5913.763449462016, 5918.053111502139, 5928.021876390433, 6362.681865906686, 6371.23545174582, 6371.96814015927, 6445.677716114223, 6538.574992625464, 6735.427488663469, 6811.148606424197, 6846.383825455683, 6935.202451718066, 6947.756828511028, 6941.097657304568, 7016.087908571853, 7027.0513480679965, 7027.5080744347915, 7031.085958825372, 6408.647524386157, 6443.194600674962, 6481.578697384655, 6495.935040649628, 6500.609963402211, 7008.369246767816, 7060.752873649398, 7102.0, 7119.0, 7208.855822883513, 6769.187697476236, 6778.186617605918, 6796.830079248059, 6800.183977922681, 6850.0752398426575, 6900.516963812585, 6916.861662766716, 6970.407515361251, 6976.616286104211, 6984.720611175496, 6671.5997040177745, 6821.4542836572955, 6836.111305530249, 6873.381395674413, 6967.512274140761, 6770.052192693027, 6822.658867056726, 6825.1127353443735, 6832.624205668637, 6837.042814006043, 5305.973470132624, 5318.760655770499, 5322.8935421292135, 5354.277172581652, 5486.0, 4707.482176960531, 4724.055188962221, 4837.201861692852, 4839.104765618372, 4854.393200849894, 5904.8780731660845, 5909.70451477433, 5993.340732519419, 5994.430529099728, 5997.010493268562, 6755.22314933779, 6851.862962740717, 6861.828454288583, 6868.759593414206, 6869.587824730532, 5790.247267855152, 5814.970925145347, 5830.096335068071, 5849.1226316052935, 5959.582829201914, 5903.527717782567, 6000.369961154103, 6005.639661620229, 6010.128531363015, 6020.909686354708, 6689.163854518185, 6691.76578819739, 6776.322367763283, 6783.0, 6783.287754785775, 6818.454523638196, 6945.93054069463, 6959.0605268290155, 7042.330978557029, 7043.683034263573, 6631.303713110247, 6644.069830223676, 6719.428848547928, 6726.125603671491, 6726.596404215763, 6877.931220687729, 6883.0, 6884.759033433806, 6890.689918953559, 6904.585724856524, 6974.442044636316, 6984.441244700513, 7063.187733410518, 7064.576125432491, 7072.151341839012, 6694.497912656473, 6694.59832410057, 6708.19501659804, 6777.423918966943, 6783.966080169567, 6698.430633396021, 6703.8324041897395, 6723.125993620798, 6727.966360168168, 6729.360710732472, 6575.243846957661, 6602.966985165043, 6649.867002660017, 6655.168103987002, 6664.766733164316, 6687.732490700512, 6722.663866806738, 6757.594544327356, 6810.693518791765, 6836.965815170893, 6394.71223794921, 6506.804795856132, 6513.381228783258, 6517.348265173634, 6519.0], "value": 6289.797980339084, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [877.1053525404087, 877.4252864373838, 898.505821798011, 900.9324300677447, 905.9682911098113, 38516.229675406474, 39157.216855662904, 42114.36828447576, 42151.789241053826, 42155.78922105393, 38859.0, 39169.21661566767, 39189.80405097971, 39200.41199382012, 39217.41173882394, 7296.306850849161, 7408.740694075708, 7421.0, 7957.164497727742, 8164.0, 7943.324817390529, 8033.236842499953, 8039.758807235792, 8045.316148127416, 8047.074586422548, 8040.718574849881, 8044.356451483867, 8047.557384343859, 8051.838963220732, 8114.918850811505, 8011.238932301422, 8044.557549334784, 8047.436679432442, 8059.758207253821, 8064.798380040487, 7963.8805417918775, 8018.398620103458, 8051.718189863327, 8054.395920306, 8061.274485296293, 38331.61668383336, 38334.80832595847, 38379.0, 38409.23181536382, 38411.0, 3517.314123745871, 3527.1005893496995, 3556.199855032597, 3559.75081744278, 3561.3411518869093, 31812.840935795404, 31986.680133198603, 32072.0, 32082.839585802154, 32097.358052838812, 5293.444188360205, 5312.76092575835, 5330.466953304677, 5334.093204155303, 5419.83740487786, 185803.0, 186811.0, 187542.0, 187887.0, 188232.0, 42796.78601607034, 48811.755941220064, 49255.50744492509, 49372.25941610878, 49477.75261123671, 44899.77550112228, 50841.0, 51808.740956294976, 51952.74023629933, 51962.740186298826, 14740.11559306445, 14873.776893346609, 14876.628084297763, 14889.255537223096, 14905.478308259158, 11806.586769463027, 11867.762644747057, 11872.40637968098, 11895.70260743471, 11949.522019119138, 14541.563753087425, 14659.0, 14689.926550367394, 14709.878516624161, 14877.702445951021, 5538.667679939216, 5581.162825576196, 5677.545796336366, 5713.200151978726, 5847.883042339215, 1021.3514418344405, 1024.3956065920993, 1041.4844651897358, 1044.7074819050679, 1049.454283772434, 22909.19817806369, 23302.252331075237, 23473.295801125994, 23535.529289414117, 23570.528589428115, 1120.624590762104, 1126.7352172239516, 1128.5316593613559, 1131.4342828585707, 1141.8801025892328, 12406.379681015913, 12430.756924307498, 12540.561080362144, 12548.874511254953, 12581.811272830915, 219365.0, 229226.0, 230733.0, 231783.0, 232847.0, 52200.21699674508, 52551.47448525466, 52569.0, 52688.20967685488, 52791.208131878055, 1422.1893520693106, 1454.120257244373, 1456.1408768826443, 1461.7880407340876, 1469.3020815112736, 22675.20636777705, 22855.77144228603, 23154.421139471648, 23224.187153449548, 23326.300210993697, 37108.443373348884, 37195.81402092972, 37198.81400593088, 37237.44143837791, 37332.06669833276, 196915.0, 197654.0, 198659.0, 198958.0, 199188.0, 31701.524477133324, 34296.48555271623, 35359.64640353563, 35772.821135894155, 35780.4632930501, 42791.572084278756, 42904.78547607242, 43191.78404107959, 43231.13537729165, 43802.0, 31997.68002319947, 32119.518207226443, 32128.35743285168, 32338.676613233565, 32582.83708581442, 31516.527252091695, 32263.677363226067, 32369.0, 32766.180845479055, 32816.0, 35508.112297192776, 35595.110122246115, 35795.46306805452, 36033.81983090068, 36086.45870311895, 30858.69141308558, 31036.22409439692, 31161.0, 31282.68717312889, 31440.0, 22972.540549188587, 23230.3030909073, 24045.27864164078, 24073.638895416232, 24401.755982439947], "value": 17190.50366716863, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [578.1068249554438, 589.687465643209, 591.3465620489359, 599.8470390050536, 603.9365866584009, 22015.779842201573, 22742.43143921403, 22789.860506974648, 22806.88596557019, 22820.65769013466, 23644.290671279847, 24350.147744828933, 24447.0, 24480.26559203222, 24554.877225613847, 6418.326075762047, 6573.211214654249, 6590.406863382294, 6590.637514936677, 6596.868062638744, 6480.805575832733, 6520.18497687789, 6570.1130347403205, 6570.967145164292, 6674.532782705212, 6980.825479363031, 7018.19290781559, 7038.366547010768, 7049.189343225544, 7059.117610298713, 7059.752908648198, 7060.611666358348, 7068.045813815121, 7072.717091316367, 7073.646317684095, 6889.311068893121, 6896.586204827676, 6896.793096207121, 6907.861842763167, 6910.723571057151, 28697.713022869713, 29371.412571748446, 29849.70150298491, 30338.54492182619, 30485.23786905345, 2081.3859911326194, 2099.4331530486684, 2107.0097054384414, 2107.57848430313, 2110.02938648222, 20210.39368818938, 20790.89604551983, 20798.27206047796, 20836.166553337847, 20905.477363065893, 2433.3916520869784, 2549.961750573724, 2620.7772339351177, 2631.4737052589367, 2640.2475294540964, 118190.40904795507, 123627.38186309101, 124706.37646811707, 135913.0, 145147.27426362905, 19499.44004479638, 20005.299814506423, 21350.252741153985, 21672.0, 21817.23639672604, 41399.379009314885, 41425.1714965699, 41489.377659335136, 41610.543630972774, 41629.0, 10617.150627949746, 10774.461276936121, 10793.114478787631, 10903.563857445613, 10978.231523793258, 8791.824163516694, 8792.78018049541, 8896.243819275305, 8958.148975847284, 8963.282937364995, 10659.200559958033, 10735.624253151102, 11002.669919902415, 11053.392063436428, 11590.942045289888, 3582.2119133790525, 3589.964100359015, 3651.744377893522, 4216.536181020086, 4326.0, 950.3300173377891, 967.5500892085214, 971.844504879216, 980.1717548671504, 983.2871168402851, 18375.081245937916, 18575.72136417955, 18701.34545290908, 19190.0, 19279.80720192808, 1001.6344034427527, 1020.8774947006407, 1022.4070039377292, 1029.624187171692, 1040.266612038511, 10417.895821041693, 10570.116940660353, 10752.354858708502, 10888.727781805519, 11009.174311926477, 486803.0, 500750.0, 513961.0, 514019.0, 517508.0, 109235.45382273197, 110220.0, 110305.0, 110340.0, 114113.0, 1157.5774842182543, 1160.182071639492, 1182.1252273317682, 1184.9466773995018, 1186.5372504723166, 16883.986960782393, 17078.2314795832, 17202.31190752356, 17511.562210944827, 17793.288268469118, 55583.44416555783, 55699.0, 56128.71935640459, 57106.0, 58005.489478499476, 68333.0, 68777.65611171912, 68942.3105768936, 68959.31040689729, 68965.65517172382, 18903.338383156522, 19370.0, 19446.22215111436, 19456.319028833925, 19510.707339389635, 22028.669569956783, 22218.222362217246, 22355.77644223602, 22498.662520061884, 22547.774522255222, 17409.21658525344, 17567.12164391801, 17966.5508362292, 17971.37100201487, 18044.45866623951, 15685.0, 15744.527664170093, 15881.0, 16226.269817858461, 16280.67438651244, 17970.5507362317, 18115.456536303933, 18251.0, 18292.268309268013, 18329.266829326676, 17588.38440654571, 18607.44177674672, 18883.0, 18962.43112706621, 18988.0, 17368.82631173672, 17856.0, 17879.28482860723, 18027.909860450614, 18054.5486362842], "value": 12659.566839126846, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1323.4110820684796, 1375.7248550289944, 1375.8924066126767, 1381.8479967203607, 1386.89598280129, 15377.615559611015, 16580.66838663226, 16584.75122873158, 16609.086500242498, 16609.750853737205, 16075.919620401912, 16198.947068440573, 16268.186590670448, 16292.348306067743, 16330.265138068786, 2744.1767469759093, 2809.5504719244923, 2844.288927768058, 2866.082853486885, 2867.16852112887, 2865.555838844982, 2867.8279303241766, 2899.927501812461, 2902.970970290302, 2902.9854850725715, 2772.778177745786, 2806.621106150674, 2849.943001139976, 2850.558163484663, 2852.8003039787222, 2735.6306898568637, 2762.8480433576146, 2787.8606069696434, 2790.8325500469937, 2793.6647602287753, 2741.575055866324, 2758.1174024312227, 2795.8182718123257, 2823.9858800705865, 2826.590144429046, 14806.703865922622, 15047.322870470745, 15074.924625376912, 15101.622459438602, 15133.924330378277, 8393.244607985249, 8662.393632445732, 8705.695300664447, 8710.869336959951, 8737.995130560003, 5557.805476808292, 5797.971010144965, 5841.9415805842245, 5884.47039766423, 5918.852028699274, 1959.5297128689153, 1970.4285757130415, 1984.7915968823354, 2009.7186393904865, 2016.2942969960543, 27706.72293277082, 27784.722152778417, 27852.86073569619, 27909.581356279672, 27934.720652793414, 6954.895676564855, 7081.327273908971, 7125.750598729123, 7351.264873512606, 7359.374453171434, 17826.732599011026, 17834.643307133785, 17856.19647115883, 17863.0, 17864.821351786577, 8273.255407013397, 8430.072692003874, 8671.869921951176, 8966.551672416354, 8977.506237157018, 7804.180561041123, 7959.641816118288, 7966.681332746741, 7979.5611241382285, 8024.959875200587, 5469.316335458067, 5609.657586500998, 5617.399041273299, 5633.8309850704545, 5685.488306052475, 1680.0675625027982, 1685.7639930409753, 1693.3480609965006, 1701.7237072195853, 1706.709859323918, 883.9513826739462, 898.3217670658611, 899.9910000900038, 904.2901322461836, 909.2044461096541, 7541.811454713676, 7560.546367217875, 7590.0, 7618.6190690465255, 7680.231976802275, 734.9338559529668, 739.2053542441896, 741.573595182772, 745.6607243704102, 751.6317004667674, 4653.674242803039, 4677.95322046782, 5139.665921715151, 5414.566834653218, 5488.423715509894, 22085.337439876508, 22245.777542224372, 22269.66595501069, 22866.771332286466, 22963.655545166836, 22212.88893555522, 22571.322860314216, 22746.545069098855, 22971.310860674206, 23154.421139471648, 11725.472353744102, 11840.28958262507, 11902.0, 11905.642830715266, 11973.563172419366, 8132.1461246570625, 8176.100628930694, 8206.712765053195, 8265.752027439186, 8302.128276530877, 19138.330158444387, 19227.807721922603, 19280.035998200314, 19431.125599348346, 19894.50263743418, 19613.41159765209, 20244.0, 20304.390868273975, 20426.89786551058, 20527.589448211253, 11426.94286528562, 11463.0, 11498.0, 11501.82747258775, 11518.0, 14201.857981420468, 14218.928905355408, 14250.501232456814, 14368.712625747217, 14452.0, 10990.505427255634, 11110.50002749862, 11265.831012534982, 11409.543618255177, 11420.428978551205, 11064.612738554433, 11310.377929213972, 11385.601503947653, 11544.0, 11683.707907302385, 9943.801123977624, 9968.50157492108, 10024.047715467019, 10147.086762191142, 10154.441505717257, 6926.896096558657, 6992.300769922967, 6997.1253593300835, 7007.929920700728, 7056.894146587702, 7259.201487836228, 7260.0, 7262.455315851438, 7292.817679557841, 7385.261473852572], "value": 6852.55234443998, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [505.7673470203706, 535.2337286953054, 536.0779459329951, 545.7216819422096, 548.9121740521516, 6306.148669929569, 6314.526410519206, 6332.0, 6348.539835837754, 6366.840828979278, 6220.4712599428985, 6226.0, 6244.781432649858, 6276.403741644548, 6293.874122517547, 5240.502152295526, 5264.552513036387, 5279.894402111955, 5281.577473802086, 5281.705982034407, 4961.603071754251, 5206.167013277876, 5236.21456781482, 5249.86875328116, 5264.105102132647, 5039.3196918415915, 5048.419431765339, 5052.9242061369105, 5061.759868832141, 5063.721495317756, 4996.500349964975, 5018.239968017612, 5020.246962955549, 5054.342935418372, 5058.266551350052, 4455.485135054098, 4497.662675299365, 4512.255477846152, 4517.457905051415, 4526.3210518422175, 6013.248343957005, 6050.0, 6079.20970273866, 6128.417800308964, 6134.914129196095, 5721.084626459747, 5729.541636669056, 5760.9711951440395, 5773.451522105393, 5817.156512305734, 6524.347565243485, 6609.173853268341, 6613.966930165367, 6621.9006714899315, 6643.202815662103, 4974.925376119361, 4981.9750901245625, 4990.226514890198, 4997.350344455234, 4998.375203099613, 6698.459354348478, 6824.590524568542, 6894.862347712621, 6917.51577389583, 6987.301269873023, 5065.544101030925, 5075.2387141929, 5077.314562534085, 5099.082165210298, 5100.821471248489, 5166.302549155891, 5166.535011848877, 5183.481651834786, 5192.273081768555, 5205.817796377109, 5749.3963133871175, 5750.5112065474905, 5765.308163020464, 5785.363610002896, 5787.942120578825, 6619.404253617197, 6672.733090676318, 6689.531732778659, 6693.732250709917, 6711.865762684719, 1780.5993651428325, 1785.3394244129754, 1802.4142153800067, 1805.133535902774, 1815.9909200454179, 1196.7606478704295, 1238.6903274181454, 1248.656619429664, 1251.8310028146084, 1257.6855786053486, 5725.914111288334, 5726.737938514263, 5735.283089613798, 5771.307443106854, 5786.913196302059, 6721.5802311167945, 6769.950657648073, 6776.881814500651, 6781.796546103625, 6840.179178498513, 5740.885182296331, 5742.28221472316, 5753.769849206069, 5784.94215057844, 5808.82573522795, 3543.450765131357, 3577.5868531930264, 3594.4608308753373, 3613.8915832525067, 3628.8004159771467, 6273.247210334789, 6403.199600049994, 6412.551121421549, 6572.539922205399, 6643.667816609247, 6854.3145685432055, 6862.416694581017, 6958.408535274457, 6961.93038069623, 6975.488824023348, 6496.35036496356, 6500.317466666026, 6521.282658907611, 6554.934450655528, 6572.4084832365315, 6717.596944183365, 6719.731210751515, 6734.393904548614, 6763.425108865801, 6776.390124888783, 6657.966710166418, 6666.366695163952, 6694.330566943267, 6706.497012724163, 6755.864882702417, 6480.611163330027, 6561.015847622894, 6589.703463344065, 6628.867422651423, 6652.135222421054, 5059.392872855281, 5070.391553013662, 5074.6194035448225, 5086.6925012984375, 5104.2343648453025, 6446.5165112615805, 6464.385883341075, 6592.967035164794, 6742.662866856539, 6749.223839258548, 6523.3150519194805, 6570.375814297634, 6585.287825165396, 6595.790410212632, 6665.266820649822, 6489.837754056186, 6558.311377305315, 6583.637899915359, 6585.473162146921, 6609.570377925419, 6362.45919096882, 6447.3552644735155, 6456.450451891418, 6465.838354041187, 6521.315261897622, 6573.474122070318, 6632.369924857131, 6644.468442524683, 6667.133272674715, 6681.558997116586, 6361.427471527585, 6384.361563843579, 6463.418292353711, 6479.967600161969, 6482.35176482348], "value": 5115.814751384539, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [896.8699538566908, 937.6436953957495, 941.9858702119474, 944.7826999790049, 948.720127562369, 19395.515112122204, 19669.0, 20238.39284821458, 20258.189672413122, 20270.0, 19419.0, 19605.0, 19614.41156765296, 19616.117274722637, 19622.607547849035, 973.6251543155865, 988.6737376665683, 991.9404835709845, 992.2359782967111, 992.3450522655049, 963.2775418436173, 997.366672163178, 1004.1866088468328, 1006.7634105985088, 1011.7824667696444, 1070.0530030922612, 1070.4808168038496, 1071.0, 1071.9142468602492, 1071.9892801071967, 1064.0157853985033, 1065.904068633819, 1066.7013236293851, 1066.9626563070333, 1067.092970974673, 721.282324087531, 742.224375527575, 750.1186106325047, 751.4514404484702, 780.9297163255277, 20736.377908662766, 20779.792202077937, 20898.268560600307, 20937.162513499596, 20953.476163095893, 21997.560048799096, 22003.11987520497, 22736.317910462712, 22888.65667014996, 22893.0, 17512.0, 18023.18895649686, 18084.367047153286, 18197.45407637773, 18345.08274586265, 3848.288066707668, 3874.0314921269683, 3874.786886721229, 3876.379779235309, 3879.9806000969816, 141162.0, 141824.0, 144342.0, 145454.0, 145795.0, 16778.664426711643, 17348.045857477708, 17382.0, 17386.130693465275, 17545.210465529082, 32304.515432268534, 32370.190745231557, 32986.83506582452, 33136.834315828746, 33183.668163318056, 8689.956550217208, 8889.19997200255, 8980.820383592292, 8986.415882967585, 8993.055729148346, 4299.1831552005015, 4406.647468202536, 4422.84520041797, 4425.491068527161, 4427.313766366218, 5639.802606908738, 5746.482816546531, 5751.769929202868, 5768.423157684282, 5783.103618939072, 994.0854413939194, 1008.4100801031478, 1023.6877752285625, 1030.618671091701, 1031.4481752262504, 685.8525417035262, 685.8662560800595, 699.9020137180798, 701.8982247574073, 713.2546488918988, 11709.355985420712, 11840.348780816965, 12000.939995300143, 12080.093992950387, 12165.69585760363, 663.465909942501, 674.3627272227795, 675.3955210086945, 677.204284965164, 688.1054628982403, 5438.864028399322, 5467.20725494801, 5505.504504594605, 5549.278593782863, 5607.355154157242, 125618.37190814171, 127211.0, 128061.0, 128962.4863129786, 129711.0, 111688.44155779331, 111860.0, 112054.43972780247, 115066.0, 115643.0, 96689.51655241678, 100739.49630251949, 101058.0, 103163.0, 105604.47197764115, 11487.36819474937, 12068.0, 12241.571544995883, 12378.81431778506, 12621.087462886535, 42748.0, 43541.3468797962, 44165.77917110394, 44186.75283679307, 44367.77816110899, 54530.454695452536, 55087.173692395445, 55571.44428555663, 56349.71825140848, 57097.42902571087, 18780.530486737942, 18879.90560047191, 18963.810361896205, 18974.905125474284, 19101.0, 21424.250151244632, 21546.461338466663, 21574.352769416942, 21640.24259150922, 21851.67222491632, 17469.563260918578, 17681.292748289925, 17879.0, 18134.0, 18174.636507270046, 18885.90557047206, 18912.716309255098, 19133.0, 19180.904095479433, 19332.516687082374, 17621.735673964646, 17720.468385948443, 17787.199576019368, 17902.28390864351, 18028.54928626795, 13286.0, 13405.664858378228, 13640.113392629448, 13670.384832682354, 13821.861781382058, 11990.640280791591, 12205.511779529075, 12286.201396909173, 12549.93725031369, 12609.432575534307], "value": 9397.277997746965, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1426.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 107.0, 107.0, 106.0, 105.0, 107.0, 106.0, 110.0, 111.0, 108.0], "value": 107.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 120.0, 118.0, 116.0, 120.0, 118.0, 119.0, 150.0, 129.0], "value": 122.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 162.0, 161.0, 164.0, 165.0, 163.0, 165.0, 165.0, 163.0, 163.0], "value": 163.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 74.0, 73.0, 75.0, 74.0, 75.0, 74.0, 76.0, 74.0], "value": 74.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 83.0, 82.0, 79.0, 79.0, 79.0, 79.0, 79.0, 79.0, 79.0], "value": 79.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 114.0, 113.0, 115.0, 113.0, 114.0, 114.0, 115.0, 115.0, 114.0], "value": 113.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 148.0, 150.0, 147.0, 149.0, 150.0, 151.0, 147.0, 150.0, 150.0], "value": 149.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 54.0, 54.0, 53.0, 54.0, 53.0, 52.0, 52.0, 53.0], "value": 53.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 39.0, 38.0, 43.0, 39.0, 39.0, 39.0, 38.0, 38.0, 37.0], "value": 38.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 73.0, 73.0, 71.0, 74.0, 74.0, 79.0, 72.0, 83.0, 75.0], "value": 74.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 108.0, 116.0, 116.0, 112.0, 118.0, 115.0, 112.0, 114.0, 112.0], "value": 113.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 186.0, 176.0, 171.0, 169.0, 172.0, 166.0, 181.0, 169.0, 173.0], "value": 173.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 65.0, 68.0, 68.0, 66.0, 67.0, 67.0, 70.0, 68.0], "value": 67.0, "unit": "score"}]}]} 11:54:27 INFO - Return code: 0 11:54:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:54:27 INFO - # TBPL SUCCESS # 11:54:27 INFO - Running post-action listener: _package_coverage_data 11:54:27 INFO - Running post-action listener: _resource_record_post_action 11:54:27 INFO - [mozharness: 2017-09-21 18:54:27.930986Z] Finished run-tests step (success) 11:54:27 INFO - Running post-run listener: _resource_record_post_run 11:54:28 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 11067392; Write bytes: 467390464; Read time: 3024; Write time: 416884 11:54:28 INFO - TinderboxPrint: CPU usage
13.1% 11:54:28 INFO - TinderboxPrint: I/O read bytes / time
11,067,392 / 3,024 11:54:28 INFO - TinderboxPrint: I/O write bytes / time
467,390,464 / 416,884 11:54:28 INFO - TinderboxPrint: CPU idle
8,254.9 (86.9%) 11:54:28 INFO - TinderboxPrint: CPU user
1,192.5 (12.5%) 11:54:28 INFO - TinderboxPrint: Swap in / out
0 / 0 11:54:28 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 17199104; Read time: 0; Write time: 2360 11:54:28 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 11:54:28 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 8822784; Write bytes: 400179200; Read time: 2240; Write time: 356320 11:54:28 INFO - Running post-run listener: _upload_blobber_files 11:54:28 INFO - Blob upload gear active. 11:54:28 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:54:28 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 11:54:28 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'] 11:54:28 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 11:54:28 INFO - (blobuploader) - INFO - Open directory for files ... 11:54:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:54:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:54:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:54:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:54:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:54:30 INFO - (blobuploader) - INFO - Done attempting. 11:54:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 11:54:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:54:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:54:32 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 11:54:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:54:32 INFO - (blobuploader) - INFO - Done attempting. 11:54:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:54:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:54:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:54:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:54:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:54:33 INFO - (blobuploader) - INFO - Done attempting. 11:54:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:54:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:54:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:54:40 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:54:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:54:40 INFO - (blobuploader) - INFO - Done attempting. 11:54:40 INFO - (blobuploader) - INFO - Iteration through files over. 11:54:40 INFO - Return code: 0 11:54:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:54:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:54:40 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/86c43a91f6f8254add36791ef68a849591f28d9f25d571586a1e7cdff643c734582f9e2877cbc0bb308b044a3539378026c05a07feee59e319d1ad44108153ec", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/31b92e3861d1d7843d7c1a8a95923c1c0dfe18667608598e64293210500ae8b1838b8b1f6eb32558b5a95d3554a29d13d7ee47e88ff36b77275c2520a7687481", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5f970cb1eec00c70ad1f3a397020d0797f40dfcc5f9165662a5b7d440681e84d2b2a47437fb02a11c366d662bf75d3cbc43c94790b98f50cb4a205a74140963c", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a4d10b79eb0b8be5fe5673362fb29ceb853ac6610a50c1ccde866553091dd02235410ab9fca4aa9e50186d06b072cb05c7283402d91090f6576338b42484e4b4"} 11:54:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:54:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:54:40 INFO - Contents: 11:54:40 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/86c43a91f6f8254add36791ef68a849591f28d9f25d571586a1e7cdff643c734582f9e2877cbc0bb308b044a3539378026c05a07feee59e319d1ad44108153ec", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/31b92e3861d1d7843d7c1a8a95923c1c0dfe18667608598e64293210500ae8b1838b8b1f6eb32558b5a95d3554a29d13d7ee47e88ff36b77275c2520a7687481", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5f970cb1eec00c70ad1f3a397020d0797f40dfcc5f9165662a5b7d440681e84d2b2a47437fb02a11c366d662bf75d3cbc43c94790b98f50cb4a205a74140963c", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a4d10b79eb0b8be5fe5673362fb29ceb853ac6610a50c1ccde866553091dd02235410ab9fca4aa9e50186d06b072cb05c7283402d91090f6576338b42484e4b4"} 11:54:40 INFO - Running post-run listener: copy_logs_to_upload_dir 11:54:40 INFO - Copying logs to upload dir... 11:54:40 INFO - mkdir: /builds/slave/test/build/upload/logs 11:54:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.790617 ========= master_lag: -0.09 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2017-09-21 11:54:40.555431) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-21 11:54:40.564650) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1506018102.688246-295755340 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/86c43a91f6f8254add36791ef68a849591f28d9f25d571586a1e7cdff643c734582f9e2877cbc0bb308b044a3539378026c05a07feee59e319d1ad44108153ec", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/31b92e3861d1d7843d7c1a8a95923c1c0dfe18667608598e64293210500ae8b1838b8b1f6eb32558b5a95d3554a29d13d7ee47e88ff36b77275c2520a7687481", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5f970cb1eec00c70ad1f3a397020d0797f40dfcc5f9165662a5b7d440681e84d2b2a47437fb02a11c366d662bf75d3cbc43c94790b98f50cb4a205a74140963c", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a4d10b79eb0b8be5fe5673362fb29ceb853ac6610a50c1ccde866553091dd02235410ab9fca4aa9e50186d06b072cb05c7283402d91090f6576338b42484e4b4"} build_url:https://queue.taskcluster.net/v1/task/TWoC3Z28QNeZ_g1kUharhQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011150 build_url: 'https://queue.taskcluster.net/v1/task/TWoC3Z28QNeZ_g1kUharhQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/86c43a91f6f8254add36791ef68a849591f28d9f25d571586a1e7cdff643c734582f9e2877cbc0bb308b044a3539378026c05a07feee59e319d1ad44108153ec", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/31b92e3861d1d7843d7c1a8a95923c1c0dfe18667608598e64293210500ae8b1838b8b1f6eb32558b5a95d3554a29d13d7ee47e88ff36b77275c2520a7687481", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5f970cb1eec00c70ad1f3a397020d0797f40dfcc5f9165662a5b7d440681e84d2b2a47437fb02a11c366d662bf75d3cbc43c94790b98f50cb4a205a74140963c", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a4d10b79eb0b8be5fe5673362fb29ceb853ac6610a50c1ccde866553091dd02235410ab9fca4aa9e50186d06b072cb05c7283402d91090f6576338b42484e4b4"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-21 11:54:40.594206) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-21 11:54:40.594526) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1506018102.688246-295755340 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004465 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-21 11:54:40.677127) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-21 11:54:40.677441) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-21 11:54:40.677752) ========= ========= Total master_lag: 0.10 =========