builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-032 starttime: 1504141102.12 results: success (0) revision: d9b405d82cffb07343a5f2fd941e029298c7f6c4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-30 17:58:22.115752) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-30 17:58:22.116213) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-30 17:58:22.116515) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-30 17:58:22.130388) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-30 17:58:22.130774) ========= 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=745a4373a2a16df560f216e000000264-1504141101.159818-903536102 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-30 17:58:22-- 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% 46.4M=0s 2017-08-30 17:58:22 (46.4 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.088760 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-30 17:58:22.234979) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-30 17:58:22.238303) ========= 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=745a4373a2a16df560f216e000000264-1504141101.159818-903536102 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022631 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-30 17:58:22.288026) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-30 17:58:22.288357) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev d9b405d82cffb07343a5f2fd941e029298c7f6c4 --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 d9b405d82cffb07343a5f2fd941e029298c7f6c4 --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=745a4373a2a16df560f216e000000264-1504141101.159818-903536102 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-30 17:58:22,295 truncating revision to first 12 chars 2017-08-30 17:58:22,295 Setting DEBUG logging. 2017-08-30 17:58:22,296 attempt 1/10 2017-08-30 17:58:22,296 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/d9b405d82cff?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-30 17:58:23,227 unpacking tar archive at: mozilla-central-d9b405d82cff/testing/mozharness/ program finished with exit code 0 elapsedTime=1.234712 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-30 17:58:23.540852) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-30 17:58:23.541192) ========= script_repo_revision: d9b405d82cffb07343a5f2fd941e029298c7f6c4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-30 17:58:23.541581) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-30 17:58:23.541843) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-30 17:58:23.556036) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-08-30 17:58:23.556437) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=745a4373a2a16df560f216e000000264-1504141101.159818-903536102 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:58:23 INFO - MultiFileLogger online at 20170830 17:58:23 in /builds/slave/test 17:58:23 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 17:58:23 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:58:23 INFO - {'append_to_log': False, 17:58:23 INFO - 'base_work_dir': '/builds/slave/test', 17:58:23 INFO - 'blob_upload_branch': 'Firefox', 17:58:23 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:58:23 INFO - 'branch': 'Firefox', 17:58:23 INFO - 'buildbot_json_path': 'buildprops.json', 17:58:23 INFO - 'code_coverage': False, 17:58:23 INFO - 'config_files': ('talos/linux_config.py',), 17:58:23 INFO - 'default_actions': ('clobber', 17:58:23 INFO - 'read-buildbot-config', 17:58:23 INFO - 'download-and-extract', 17:58:23 INFO - 'populate-webroot', 17:58:23 INFO - 'create-virtualenv', 17:58:23 INFO - 'install', 17:58:23 INFO - 'setup-mitmproxy', 17:58:23 INFO - 'run-tests'), 17:58:23 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:58:23 INFO - 'disable_ccov_upload': False, 17:58:23 INFO - 'disable_stylo': False, 17:58:23 INFO - 'download_minidump_stackwalk': True, 17:58:23 INFO - 'download_symbols': 'ondemand', 17:58:23 INFO - 'enable_stylo': False, 17:58:23 INFO - 'enable_webrender': False, 17:58:23 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 17:58:23 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:58:23 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:58:23 INFO - 'gecko_profile': False, 17:58:23 INFO - 'gecko_profile_interval': 0, 17:58:23 INFO - 'installer_path': 'installer.exe', 17:58:23 INFO - 'log_level': 'info', 17:58:23 INFO - 'log_name': 'talos', 17:58:23 INFO - 'log_to_console': True, 17:58:23 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:58:23 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:58:23 INFO - 'opt_config_files': (), 17:58:23 INFO - 'pip_index': False, 17:58:23 INFO - 'suite': 'dromaeojs-e10s', 17:58:23 INFO - 'system_bits': '32', 17:58:23 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:58:23 INFO - 'title': 'talos-linux64-ix-032', 17:58:23 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:58:23 INFO - 'use_talos_json': True, 17:58:23 INFO - 'verify': 'False', 17:58:23 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:58:23 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:58:23 INFO - 'work_dir': 'build'} 17:58:23 INFO - [mozharness: 2017-08-31 00:58:23.705437Z] Running clobber step. 17:58:23 INFO - Running pre-action listener: _resource_record_pre_action 17:58:23 INFO - Running main action method: clobber 17:58:23 INFO - rmtree: /builds/slave/test/build 17:58:23 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:58:25 INFO - Running post-action listener: _resource_record_post_action 17:58:25 INFO - [mozharness: 2017-08-31 00:58:25.232642Z] Finished clobber step (success) 17:58:25 INFO - [mozharness: 2017-08-31 00:58:25.232741Z] Running read-buildbot-config step. 17:58:25 INFO - Running pre-action listener: _resource_record_pre_action 17:58:25 INFO - Running main action method: read_buildbot_config 17:58:25 INFO - Using buildbot properties: 17:58:25 INFO - { 17:58:25 INFO - "project": "", 17:58:25 INFO - "product": "firefox", 17:58:25 INFO - "who": "kwierso@gmail.com", 17:58:25 INFO - "installer_path": "public/build/target.tar.bz2", 17:58:25 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 17:58:25 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 17:58:25 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 17:58:25 INFO - "stage_platform": "linux64-stylosequential", 17:58:25 INFO - "basedir": "/builds/slave/test", 17:58:25 INFO - "buildnumber": 180, 17:58:25 INFO - "platform": "ubuntu64_hw_styloseq", 17:58:25 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 17:58:25 INFO - "slavebuilddir": "test", 17:58:25 INFO - "taskId": "VDp3i9YJQTqvjErjZ25_EA", 17:58:25 INFO - "branch": "mozilla-central", 17:58:25 INFO - "script_repo_revision": "production", 17:58:25 INFO - "revision": "d9b405d82cffb07343a5f2fd941e029298c7f6c4", 17:58:25 INFO - "slavename": "talos-linux64-ix-032", 17:58:25 INFO - "repo_path": "mozilla-central" 17:58:25 INFO - } 17:58:25 INFO - Finding installer, test and symbols from parent task. 17:58:25 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VDp3i9YJQTqvjErjZ25_EA'}, attempt #1 17:58:25 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VDp3i9YJQTqvjErjZ25_EA'}, attempt #1 17:58:33 INFO - Task dependencies: JjWT5fwtQZy7VNboNo6e0g 17:58:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JjWT5fwtQZy7VNboNo6e0g'}, attempt #1 17:58:34 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/JjWT5fwtQZy7VNboNo6e0g/artifacts/public/build/target.tar.bz2 17:58:34 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/JjWT5fwtQZy7VNboNo6e0g/artifacts/public/build/target.test_packages.json 17:58:34 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/JjWT5fwtQZy7VNboNo6e0g/artifacts/public/build/target.crashreporter-symbols.zip 17:58:34 INFO - Running post-action listener: _resource_record_post_action 17:58:34 INFO - [mozharness: 2017-08-31 00:58:34.129462Z] Finished read-buildbot-config step (success) 17:58:34 INFO - [mozharness: 2017-08-31 00:58:34.129681Z] Running download-and-extract step. 17:58:34 INFO - Running pre-action listener: _resource_record_pre_action 17:58:34 INFO - Running main action method: download_and_extract 17:58:34 INFO - mkdir: /builds/slave/test/build/tests 17:58:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:58:34 INFO - trying https://queue.taskcluster.net/v1/task/JjWT5fwtQZy7VNboNo6e0g/artifacts/public/build/target.test_packages.json 17:58:34 INFO - Downloading https://queue.taskcluster.net/v1/task/JjWT5fwtQZy7VNboNo6e0g/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 17:58:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JjWT5fwtQZy7VNboNo6e0g/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 17:58:34 INFO - Downloaded 989 bytes. 17:58:34 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 17:58:34 INFO - Using the following test package requirements: 17:58:34 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 17:58:34 INFO - u'common': [u'target.common.tests.zip'], 17:58:34 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 17:58:34 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 17:58:34 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 17:58:34 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 17:58:34 INFO - u'mozbase': [u'target.common.tests.zip'], 17:58:34 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 17:58:34 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 17:58:34 INFO - u'web-platform': [u'target.common.tests.zip', 17:58:34 INFO - u'target.web-platform.tests.tar.gz'], 17:58:34 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 17:58:34 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 17:58:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JjWT5fwtQZy7VNboNo6e0g/artifacts/public/build/target.common.tests.zip 17:58:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JjWT5fwtQZy7VNboNo6e0g/artifacts/public/build/target.common.tests.zip'}, attempt #1 17:58:34 INFO - Fetch https://queue.taskcluster.net/v1/task/JjWT5fwtQZy7VNboNo6e0g/artifacts/public/build/target.common.tests.zip into memory 17:58:35 INFO - Content-Length response header: 54962746 17:58:35 INFO - Bytes received: 54962746 17:58:46 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 17:58:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JjWT5fwtQZy7VNboNo6e0g/artifacts/public/build/target.common.tests.zip 17:58:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JjWT5fwtQZy7VNboNo6e0g/artifacts/public/build/target.common.tests.zip'}, attempt #1 17:58:46 INFO - Fetch https://queue.taskcluster.net/v1/task/JjWT5fwtQZy7VNboNo6e0g/artifacts/public/build/target.common.tests.zip into memory 17:58:47 INFO - Content-Length response header: 54962746 17:58:47 INFO - Bytes received: 54962746 17:58:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JjWT5fwtQZy7VNboNo6e0g/artifacts/public/build/target.talos.tests.zip 17:58:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JjWT5fwtQZy7VNboNo6e0g/artifacts/public/build/target.talos.tests.zip'}, attempt #1 17:58:59 INFO - Fetch https://queue.taskcluster.net/v1/task/JjWT5fwtQZy7VNboNo6e0g/artifacts/public/build/target.talos.tests.zip into memory 17:59:00 INFO - Content-Length response header: 14496650 17:59:00 INFO - Bytes received: 14496650 17:59:00 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')]} 17:59:00 INFO - trying https://queue.taskcluster.net/v1/task/JjWT5fwtQZy7VNboNo6e0g/artifacts/public/build/target.tar.bz2 17:59:00 INFO - Downloading https://queue.taskcluster.net/v1/task/JjWT5fwtQZy7VNboNo6e0g/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 17:59:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JjWT5fwtQZy7VNboNo6e0g/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 17:59:01 INFO - Downloaded 62519587 bytes. 17:59:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JjWT5fwtQZy7VNboNo6e0g/artifacts/public/build/target.tar.bz2 17:59:01 INFO - mkdir: /builds/slave/test/properties 17:59:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:59:01 INFO - Writing to file /builds/slave/test/properties/build_url 17:59:01 INFO - Contents: 17:59:01 INFO - build_url:https://queue.taskcluster.net/v1/task/JjWT5fwtQZy7VNboNo6e0g/artifacts/public/build/target.tar.bz2 17:59:01 INFO - Running post-action listener: _resource_record_post_action 17:59:01 INFO - Running post-action listener: find_tests_for_verification 17:59:01 INFO - Running post-action listener: set_extra_try_arguments 17:59:01 INFO - [mozharness: 2017-08-31 00:59:01.982520Z] Finished download-and-extract step (success) 17:59:01 INFO - [mozharness: 2017-08-31 00:59:01.982614Z] Running populate-webroot step. 17:59:01 INFO - Running pre-action listener: _resource_record_pre_action 17:59:01 INFO - Running main action method: populate_webroot 17:59:01 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:59:01 INFO - 'chromez-stylo-e10s': {'talos_options': ['--enable-stylo'], 17:59:01 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:59:01 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:59:01 INFO - 'dromaeojs-stylo-e10s': {'talos_options': ['--enable-stylo'], 17:59:01 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:59:01 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 17:59:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:59:01 INFO - 'g1-stylo-e10s': {'pagesets_name': 'tp5n.zip', 17:59:01 INFO - 'talos_options': ['--enable-stylo'], 17:59:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:59:01 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 17:59:01 INFO - 'tests': ['damp', 'tps']}, 17:59:01 INFO - 'g2-stylo-e10s': {'pagesets_name': 'tp5n.zip', 17:59:01 INFO - 'talos_options': ['--enable-stylo'], 17:59:01 INFO - 'tests': ['damp', 'tps']}, 17:59:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:59:01 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 17:59:01 INFO - 'g4-stylo-e10s': {'talos_options': ['--enable-stylo'], 17:59:01 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 17:59:01 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 17:59:01 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 17:59:01 INFO - 'g5-stylo-e10s': {'pagesets_name': 'tp5n.zip', 17:59:01 INFO - 'talos_options': ['--enable-stylo'], 17:59:01 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 17:59:01 INFO - 'other-e10s': {'tests': ['a11yr', 17:59:01 INFO - 'ts_paint', 17:59:01 INFO - 'tpaint', 17:59:01 INFO - 'sessionrestore', 17:59:01 INFO - 'sessionrestore_many_windows', 17:59:01 INFO - 'sessionrestore_no_auto_restore', 17:59:01 INFO - 'tabpaint']}, 17:59:01 INFO - 'other-stylo-e10s': {'talos_options': ['--enable-stylo'], 17:59:01 INFO - 'tests': ['a11yr', 17:59:01 INFO - 'ts_paint', 17:59:01 INFO - 'tpaint', 17:59:01 INFO - 'sessionrestore', 17:59:01 INFO - 'sessionrestore_many_windows', 17:59:01 INFO - 'sessionrestore_no_auto_restore', 17:59:01 INFO - 'tabpaint']}, 17:59:01 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 17:59:01 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 17:59:01 INFO - 'perf-reftest-singletons-stylo-e10s': {'talos_options': ['--enable-stylo'], 17:59:01 INFO - 'tests': ['bloom_basic_singleton']}, 17:59:01 INFO - 'perf-reftest-stylo-e10s': {'talos_options': ['--enable-stylo'], 17:59:01 INFO - 'tests': ['bloom_basic']}, 17:59:01 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:59:01 INFO - 'tsvgr_opacity', 17:59:01 INFO - 'tart', 17:59:01 INFO - 'tscrollx', 17:59:01 INFO - 'tsvg_static']}, 17:59:01 INFO - 'svgr-stylo-e10s': {'talos_options': ['--enable-stylo'], 17:59:01 INFO - 'tests': ['tsvgx', 17:59:01 INFO - 'tsvgr_opacity', 17:59:01 INFO - 'tart', 17:59:01 INFO - 'tscrollx', 17:59:01 INFO - 'tsvg_static']}, 17:59:01 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 17:59:01 INFO - 'tp5o-stylo-e10s': {'pagesets_name': 'tp5n.zip', 17:59:01 INFO - 'talos_options': ['--enable-stylo'], 17:59:01 INFO - 'tests': ['tp5o']}, 17:59:01 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:59:01 INFO - 'talos_options': ['--mitmproxy', 17:59:01 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:59:01 INFO - '--firstNonBlankPaint'], 17:59:01 INFO - 'tests': ['tp6_google', 17:59:01 INFO - 'tp6_youtube', 17:59:01 INFO - 'tp6_amazon', 17:59:01 INFO - 'tp6_facebook']}, 17:59:01 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:59:01 INFO - 'talos_options': ['--enable-stylo', 17:59:01 INFO - '--mitmproxy', 17:59:01 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:59:01 INFO - '--firstNonBlankPaint'], 17:59:01 INFO - 'tests': ['tp6_google', 17:59:01 INFO - 'tp6_youtube', 17:59:01 INFO - 'tp6_amazon', 17:59:01 INFO - 'tp6_facebook']}, 17:59:01 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:59:01 INFO - 'talos_options': ['--enable-stylo', 17:59:01 INFO - '--stylo-threads=1', 17:59:01 INFO - '--mitmproxy', 17:59:01 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:59:01 INFO - '--firstNonBlankPaint'], 17:59:01 INFO - 'tests': ['tp6_google', 17:59:01 INFO - 'tp6_youtube', 17:59:01 INFO - 'tp6_amazon', 17:59:01 INFO - 'tp6_facebook']}, 17:59:01 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 17:59:01 INFO - 'talos_options': ['--xperf_path', 17:59:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:59:01 INFO - 'tests': ['tp5n']}, 17:59:01 INFO - 'xperf-stylo-e10s': {'pagesets_name': 'tp5n.zip', 17:59:01 INFO - 'talos_options': ['--enable-stylo', 17:59:01 INFO - '--xperf_path', 17:59:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:59:01 INFO - 'tests': ['tp5n']}}} 17:59:01 INFO - Running post-action listener: _resource_record_post_action 17:59:01 INFO - [mozharness: 2017-08-31 00:59:01.997020Z] Finished populate-webroot step (success) 17:59:01 INFO - [mozharness: 2017-08-31 00:59:01.997108Z] Running create-virtualenv step. 17:59:01 INFO - Running pre-action listener: _resource_record_pre_action 17:59:01 INFO - Running main action method: create_virtualenv 17:59:01 INFO - Creating virtualenv /builds/slave/test/build/venv 17:59:01 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 17:59:01 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 17:59:01 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 17:59:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:59:02 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:59:02 INFO - Installing distribute.............................................................................................................................................................................................done. 17:59:02 INFO - Installing pip...............done. 17:59:02 INFO - Return code: 0 17:59:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 17:59:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 17:59:02 INFO - Reading from file tmpfile_stdout 17:59:02 INFO - Output received: 17:59:02 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 17:59:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:59:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:59:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:59:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:59:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:59:02 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 0x16271f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17efa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1996b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1993580>, '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 0x1994480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1994910>, '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': '745a4373a2a16df560f216e000000264-1504141101.159818-903536102', '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 17:59:02 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 17:59:02 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 17:59:02 INFO - Using env: {'DISPLAY': ':0', 17:59:02 INFO - 'HOME': '/home/cltbld', 17:59:02 INFO - 'LANG': 'en_US.UTF-8', 17:59:02 INFO - 'LANGUAGE': 'en_US:en', 17:59:02 INFO - 'LOGNAME': 'cltbld', 17:59:02 INFO - 'MAIL': '/var/mail/cltbld', 17:59:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:59:02 INFO - 'MOZ_NO_REMOTE': '1', 17:59:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:59:02 INFO - 'NO_EM_RESTART': '1', 17:59:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:59:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:59:02 INFO - 'PWD': '/builds/slave/test', 17:59:02 INFO - 'SHELL': '/bin/bash', 17:59:02 INFO - 'SHLVL': '1', 17:59:02 INFO - 'TERM': 'linux', 17:59:03 INFO - 'TMOUT': '86400', 17:59:03 INFO - 'USER': 'cltbld', 17:59:03 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1504141101.159818-903536102', 17:59:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:59:03 INFO - '_': '/tools/buildbot/bin/python'} 17:59:04 INFO - Ignoring indexes: http://pypi.python.org/simple/ 17:59:04 INFO - Downloading/unpacking pip>=1.5 17:59:04 INFO - Running setup.py egg_info for package pip 17:59:04 INFO - warning: no files found matching 'pip/cacert.pem' 17:59:04 INFO - warning: no files found matching '*.html' under directory 'docs' 17:59:04 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 17:59:04 INFO - no previously-included directories found matching 'docs/_build/_sources' 17:59:04 INFO - Installing collected packages: pip 17:59:04 INFO - Found existing installation: pip 1.1 17:59:04 INFO - Uninstalling pip: 17:59:04 INFO - Successfully uninstalled pip 17:59:04 INFO - Running setup.py install for pip 17:59:04 INFO - warning: no files found matching 'pip/cacert.pem' 17:59:04 INFO - warning: no files found matching '*.html' under directory 'docs' 17:59:04 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 17:59:04 INFO - no previously-included directories found matching 'docs/_build/_sources' 17:59:04 INFO - Installing pip script to /builds/slave/test/build/venv/bin 17:59:04 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 17:59:04 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 17:59:04 INFO - Successfully installed pip 17:59:04 INFO - Cleaning up... 17:59:04 INFO - Return code: 0 17:59:04 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:59:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:59:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:59:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:59:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:59:04 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 0x16271f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17efa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1996b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1993580>, '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 0x1994480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1994910>, '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': '745a4373a2a16df560f216e000000264-1504141101.159818-903536102', '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 17:59:04 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 17:59:04 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 17:59:04 INFO - Using env: {'DISPLAY': ':0', 17:59:04 INFO - 'HOME': '/home/cltbld', 17:59:04 INFO - 'LANG': 'en_US.UTF-8', 17:59:04 INFO - 'LANGUAGE': 'en_US:en', 17:59:04 INFO - 'LOGNAME': 'cltbld', 17:59:04 INFO - 'MAIL': '/var/mail/cltbld', 17:59:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:59:04 INFO - 'MOZ_NO_REMOTE': '1', 17:59:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:59:04 INFO - 'NO_EM_RESTART': '1', 17:59:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:59:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:59:04 INFO - 'PWD': '/builds/slave/test', 17:59:04 INFO - 'SHELL': '/bin/bash', 17:59:04 INFO - 'SHLVL': '1', 17:59:04 INFO - 'TERM': 'linux', 17:59:04 INFO - 'TMOUT': '86400', 17:59:04 INFO - 'USER': 'cltbld', 17:59:04 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1504141101.159818-903536102', 17:59:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:59:04 INFO - '_': '/tools/buildbot/bin/python'} 17:59:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:59:04 INFO - Downloading/unpacking psutil>=3.1.1 17:59:04 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 17:59:04 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 17:59:04 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 17:59:04 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 17:59:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:59:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:59:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:59:05 INFO - Installing collected packages: psutil 17:59:05 INFO - Running setup.py install for psutil 17:59:05 INFO - building 'psutil._psutil_linux' extension 17:59:05 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 17:59:05 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 17:59:05 INFO - building 'psutil._psutil_posix' extension 17:59:05 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 17:59:06 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 17:59:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:59:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:59:06 INFO - Successfully installed psutil 17:59:06 INFO - Cleaning up... 17:59:06 INFO - Return code: 0 17:59:06 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:59:06 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')]} 17:59:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:59:06 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')]} 17:59:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:59:06 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 0x16271f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17efa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1996b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1993580>, '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 0x1994480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1994910>, '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': '745a4373a2a16df560f216e000000264-1504141101.159818-903536102', '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 17:59:06 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 17:59:06 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 17:59:06 INFO - Using env: {'DISPLAY': ':0', 17:59:06 INFO - 'HOME': '/home/cltbld', 17:59:06 INFO - 'LANG': 'en_US.UTF-8', 17:59:06 INFO - 'LANGUAGE': 'en_US:en', 17:59:06 INFO - 'LOGNAME': 'cltbld', 17:59:06 INFO - 'MAIL': '/var/mail/cltbld', 17:59:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:59:06 INFO - 'MOZ_NO_REMOTE': '1', 17:59:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:59:06 INFO - 'NO_EM_RESTART': '1', 17:59:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:59:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:59:06 INFO - 'PWD': '/builds/slave/test', 17:59:06 INFO - 'SHELL': '/bin/bash', 17:59:06 INFO - 'SHLVL': '1', 17:59:06 INFO - 'TERM': 'linux', 17:59:06 INFO - 'TMOUT': '86400', 17:59:06 INFO - 'USER': 'cltbld', 17:59:06 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1504141101.159818-903536102', 17:59:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:59:06 INFO - '_': '/tools/buildbot/bin/python'} 17:59:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:59:06 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:59:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:59:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:59:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:59:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:59:07 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:59:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:59:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:59:07 INFO - Installing collected packages: mozsystemmonitor 17:59:07 INFO - Running setup.py install for mozsystemmonitor 17:59:07 INFO - Successfully installed mozsystemmonitor 17:59:07 INFO - Cleaning up... 17:59:07 INFO - Return code: 0 17:59:07 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:59:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:59:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:59:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:59:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:59:07 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 0x16271f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17efa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1996b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1993580>, '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 0x1994480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1994910>, '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': '745a4373a2a16df560f216e000000264-1504141101.159818-903536102', '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 17:59:07 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 17:59:07 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 17:59:07 INFO - Using env: {'DISPLAY': ':0', 17:59:07 INFO - 'HOME': '/home/cltbld', 17:59:07 INFO - 'LANG': 'en_US.UTF-8', 17:59:07 INFO - 'LANGUAGE': 'en_US:en', 17:59:07 INFO - 'LOGNAME': 'cltbld', 17:59:07 INFO - 'MAIL': '/var/mail/cltbld', 17:59:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:59:07 INFO - 'MOZ_NO_REMOTE': '1', 17:59:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:59:07 INFO - 'NO_EM_RESTART': '1', 17:59:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:59:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:59:07 INFO - 'PWD': '/builds/slave/test', 17:59:07 INFO - 'SHELL': '/bin/bash', 17:59:07 INFO - 'SHLVL': '1', 17:59:07 INFO - 'TERM': 'linux', 17:59:07 INFO - 'TMOUT': '86400', 17:59:07 INFO - 'USER': 'cltbld', 17:59:07 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1504141101.159818-903536102', 17:59:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:59:07 INFO - '_': '/tools/buildbot/bin/python'} 17:59:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:59:07 INFO - Downloading/unpacking jsonschema==2.5.1 17:59:07 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 17:59:07 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 17:59:07 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 17:59:07 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 17:59:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:59:08 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:59:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:59:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:59:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:59:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:59:09 INFO - Downloading functools32-3.2.3-2.tar.gz 17:59:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:59:09 INFO - warning: no files found matching '*.txt' 17:59:09 INFO - no previously-included directories found matching 'build' 17:59:09 INFO - no previously-included directories found matching 'dist' 17:59:09 INFO - no previously-included directories found matching '.git*' 17:59:09 INFO - Installing collected packages: jsonschema, functools32 17:59:09 INFO - Running setup.py install for functools32 17:59:09 INFO - warning: no files found matching '*.txt' 17:59:09 INFO - no previously-included directories found matching 'build' 17:59:09 INFO - no previously-included directories found matching 'dist' 17:59:09 INFO - no previously-included directories found matching '.git*' 17:59:09 INFO - Successfully installed jsonschema functools32 17:59:09 INFO - Cleaning up... 17:59:09 INFO - Return code: 0 17:59:09 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:59:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:59:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:59:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:59:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:59:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x16271f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17efa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1996b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1993580>, '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 0x1994480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1994910>, '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': '745a4373a2a16df560f216e000000264-1504141101.159818-903536102', '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 17:59:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 17:59:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 17:59:09 INFO - Using env: {'DISPLAY': ':0', 17:59:09 INFO - 'HOME': '/home/cltbld', 17:59:09 INFO - 'LANG': 'en_US.UTF-8', 17:59:09 INFO - 'LANGUAGE': 'en_US:en', 17:59:09 INFO - 'LOGNAME': 'cltbld', 17:59:09 INFO - 'MAIL': '/var/mail/cltbld', 17:59:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:59:09 INFO - 'MOZ_NO_REMOTE': '1', 17:59:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:59:09 INFO - 'NO_EM_RESTART': '1', 17:59:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:59:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:59:09 INFO - 'PWD': '/builds/slave/test', 17:59:09 INFO - 'SHELL': '/bin/bash', 17:59:09 INFO - 'SHLVL': '1', 17:59:09 INFO - 'TERM': 'linux', 17:59:09 INFO - 'TMOUT': '86400', 17:59:09 INFO - 'USER': 'cltbld', 17:59:09 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1504141101.159818-903536102', 17:59:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:59:09 INFO - '_': '/tools/buildbot/bin/python'} 17:59:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:59:09 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:59:09 INFO - Cleaning up... 17:59:09 INFO - Return code: 0 17:59:09 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:59:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:59:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:59:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:59:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:59:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x16271f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17efa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1996b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1993580>, '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 0x1994480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1994910>, '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': '745a4373a2a16df560f216e000000264-1504141101.159818-903536102', '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 17:59:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:59:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:59:09 INFO - Using env: {'DISPLAY': ':0', 17:59:09 INFO - 'HOME': '/home/cltbld', 17:59:09 INFO - 'LANG': 'en_US.UTF-8', 17:59:09 INFO - 'LANGUAGE': 'en_US:en', 17:59:09 INFO - 'LOGNAME': 'cltbld', 17:59:09 INFO - 'MAIL': '/var/mail/cltbld', 17:59:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:59:09 INFO - 'MOZ_NO_REMOTE': '1', 17:59:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:59:09 INFO - 'NO_EM_RESTART': '1', 17:59:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:59:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:59:09 INFO - 'PWD': '/builds/slave/test', 17:59:09 INFO - 'SHELL': '/bin/bash', 17:59:09 INFO - 'SHLVL': '1', 17:59:09 INFO - 'TERM': 'linux', 17:59:09 INFO - 'TMOUT': '86400', 17:59:09 INFO - 'USER': 'cltbld', 17:59:09 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1504141101.159818-903536102', 17:59:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:59:09 INFO - '_': '/tools/buildbot/bin/python'} 17:59:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:59:09 INFO - Downloading/unpacking blobuploader==1.2.4 17:59:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:59:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:59:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:59:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:59:10 INFO - Downloading blobuploader-1.2.4.tar.gz 17:59:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:59:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:59:10 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 17:59:10 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 17:59:10 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 17:59:10 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 17:59:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:59:11 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:59:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:59:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:59:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:59:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:59:11 INFO - Downloading docopt-0.6.1.tar.gz 17:59:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:59:11 INFO - Installing collected packages: blobuploader, requests, docopt 17:59:11 INFO - Running setup.py install for blobuploader 17:59:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:59:11 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:59:11 INFO - Running setup.py install for requests 17:59:11 INFO - Running setup.py install for docopt 17:59:11 INFO - Successfully installed blobuploader requests docopt 17:59:11 INFO - Cleaning up... 17:59:12 INFO - Return code: 0 17:59:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:59:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:59:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:59:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:59:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:59:12 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 0x16271f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17efa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1996b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1993580>, '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 0x1994480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1994910>, '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': '745a4373a2a16df560f216e000000264-1504141101.159818-903536102', '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 17:59:12 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 17:59:12 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 17:59:12 INFO - Using env: {'DISPLAY': ':0', 17:59:12 INFO - 'HOME': '/home/cltbld', 17:59:12 INFO - 'LANG': 'en_US.UTF-8', 17:59:12 INFO - 'LANGUAGE': 'en_US:en', 17:59:12 INFO - 'LOGNAME': 'cltbld', 17:59:12 INFO - 'MAIL': '/var/mail/cltbld', 17:59:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:59:12 INFO - 'MOZ_NO_REMOTE': '1', 17:59:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:59:12 INFO - 'NO_EM_RESTART': '1', 17:59:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:59:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:59:12 INFO - 'PWD': '/builds/slave/test', 17:59:12 INFO - 'SHELL': '/bin/bash', 17:59:12 INFO - 'SHLVL': '1', 17:59:12 INFO - 'TERM': 'linux', 17:59:12 INFO - 'TMOUT': '86400', 17:59:12 INFO - 'USER': 'cltbld', 17:59:12 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1504141101.159818-903536102', 17:59:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:59:12 INFO - '_': '/tools/buildbot/bin/python'} 17:59:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:59:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:59:12 INFO - Running setup.py (path:/tmp/pip-vGQ1nH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:59:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:59:12 INFO - Running setup.py (path:/tmp/pip-jcLzZ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:59:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:59:12 INFO - Running setup.py (path:/tmp/pip-wldQjc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:59:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:59:12 INFO - Running setup.py (path:/tmp/pip-VI5b7Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:59:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:59:12 INFO - Running setup.py (path:/tmp/pip-2cjgCw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:59:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:59:12 INFO - Running setup.py (path:/tmp/pip-qTbsxo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:59:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:59:12 INFO - Running setup.py (path:/tmp/pip-GNiakB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:59:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:59:12 INFO - Running setup.py (path:/tmp/pip-A3VX_a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:59:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:59:12 INFO - Running setup.py (path:/tmp/pip-U1UJYl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:59:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:59:12 INFO - Running setup.py (path:/tmp/pip-3L_X7f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:59:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:59:12 INFO - Running setup.py (path:/tmp/pip-GEbtDY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:59:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:59:12 INFO - Running setup.py (path:/tmp/pip-eogr3Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:59:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:59:13 INFO - Running setup.py (path:/tmp/pip-tdLZIU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:59:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:59:13 INFO - Running setup.py (path:/tmp/pip-882h9R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:59:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:59:13 INFO - Running setup.py (path:/tmp/pip-GdWRGA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:59:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:59:13 INFO - Running setup.py (path:/tmp/pip-HyQjOj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:59:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:59:13 INFO - Running setup.py (path:/tmp/pip-61X0FA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:59:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:59:13 INFO - Running setup.py install for manifestparser 17:59:13 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:59:13 INFO - Running setup.py install for mozcrash 17:59:13 INFO - Running setup.py install for mozdebug 17:59:13 INFO - Running setup.py install for mozdevice 17:59:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:59:13 INFO - Running setup.py install for mozfile 17:59:13 INFO - Running setup.py install for mozhttpd 17:59:14 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:59:14 INFO - Running setup.py install for mozinfo 17:59:14 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:59:14 INFO - Running setup.py install for mozInstall 17:59:14 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:59:14 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:59:14 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:59:14 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:59:14 INFO - Running setup.py install for mozleak 17:59:14 INFO - Running setup.py install for mozlog 17:59:14 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:59:14 INFO - Running setup.py install for moznetwork 17:59:14 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:59:14 INFO - Running setup.py install for mozprocess 17:59:14 INFO - Running setup.py install for mozprofile 17:59:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:59:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:59:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:59:14 INFO - Running setup.py install for mozrunner 17:59:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:59:14 INFO - Running setup.py install for mozscreenshot 17:59:14 INFO - Running setup.py install for moztest 17:59:15 INFO - Running setup.py install for mozversion 17:59:15 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:59:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:59:15 INFO - Cleaning up... 17:59:15 INFO - Return code: 0 17:59:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:59: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')]} 17:59:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:59: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')]} 17:59:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:59:15 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 0x16271f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17efa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1996b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1993580>, '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 0x1994480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1994910>, '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': '745a4373a2a16df560f216e000000264-1504141101.159818-903536102', '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 17:59:15 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 17:59:15 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 17:59:15 INFO - Using env: {'DISPLAY': ':0', 17:59:15 INFO - 'HOME': '/home/cltbld', 17:59:15 INFO - 'LANG': 'en_US.UTF-8', 17:59:15 INFO - 'LANGUAGE': 'en_US:en', 17:59:15 INFO - 'LOGNAME': 'cltbld', 17:59:15 INFO - 'MAIL': '/var/mail/cltbld', 17:59:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:59:15 INFO - 'MOZ_NO_REMOTE': '1', 17:59:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:59:15 INFO - 'NO_EM_RESTART': '1', 17:59:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:59:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:59:15 INFO - 'PWD': '/builds/slave/test', 17:59:15 INFO - 'SHELL': '/bin/bash', 17:59:15 INFO - 'SHLVL': '1', 17:59:15 INFO - 'TERM': 'linux', 17:59:15 INFO - 'TMOUT': '86400', 17:59:15 INFO - 'USER': 'cltbld', 17:59:15 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1504141101.159818-903536102', 17:59:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:59:15 INFO - '_': '/tools/buildbot/bin/python'} 17:59:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:59:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:59:15 INFO - Running setup.py (path:/tmp/pip-WZ0fjk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:59:15 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)) 17:59:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:59:15 INFO - Running setup.py (path:/tmp/pip-HojrXc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:59:15 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)) 17:59:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:59:15 INFO - Running setup.py (path:/tmp/pip-Ok2dim-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:59:15 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)) 17:59:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:59:15 INFO - Running setup.py (path:/tmp/pip-t0egJJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:59:15 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)) 17:59:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:59:15 INFO - Running setup.py (path:/tmp/pip-vAW71Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:59:15 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)) 17:59:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:59:15 INFO - Running setup.py (path:/tmp/pip-1fhadb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:59:15 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)) 17:59:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:59:15 INFO - Running setup.py (path:/tmp/pip-w55rPE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:59:15 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)) 17:59:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:59:15 INFO - Running setup.py (path:/tmp/pip-pQuutG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:59:15 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)) 17:59:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:59:15 INFO - Running setup.py (path:/tmp/pip-bot01G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:59:16 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)) 17:59:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:59:16 INFO - Running setup.py (path:/tmp/pip-AoQZk8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:59:16 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)) 17:59:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:59:16 INFO - Running setup.py (path:/tmp/pip-ZzWgd3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:59:16 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)) 17:59:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:59:16 INFO - Running setup.py (path:/tmp/pip-RrCvJE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:59:16 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)) 17:59:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:59:16 INFO - Running setup.py (path:/tmp/pip-7IG6d_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:59:16 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)) 17:59:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:59:16 INFO - Running setup.py (path:/tmp/pip-k3WzDj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:59:16 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)) 17:59:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:59:16 INFO - Running setup.py (path:/tmp/pip-voTW0k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:59:16 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)) 17:59:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:59:16 INFO - Running setup.py (path:/tmp/pip-VkFiWF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:59:16 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)) 17:59:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:59:16 INFO - Running setup.py (path:/tmp/pip-Tb82TP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:59:16 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)) 17:59:16 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)) 17:59:16 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)) 17:59:16 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)) 17:59:16 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)) 17:59:16 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)) 17:59:16 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)) 17:59:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:59:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:59:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:59:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:59:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:59:17 INFO - Downloading blessings-1.6.tar.gz 17:59:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:59:17 INFO - Installing collected packages: blessings 17:59:17 INFO - Running setup.py install for blessings 17:59:17 INFO - Successfully installed blessings 17:59:17 INFO - Cleaning up... 17:59:17 INFO - Return code: 0 17:59:17 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:59:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:59:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:59:18 INFO - Reading from file tmpfile_stdout 17:59:18 INFO - Current package versions: 17:59:18 INFO - argparse == 1.2.1 17:59:18 INFO - blessings == 1.6 17:59:18 INFO - blobuploader == 1.2.4 17:59:18 INFO - docopt == 0.6.1 17:59:18 INFO - functools32 == 3.2.3-2 17:59:18 INFO - jsonschema == 2.5.1 17:59:18 INFO - manifestparser == 1.1 17:59:18 INFO - mozInstall == 1.13 17:59:18 INFO - mozcrash == 1.0 17:59:18 INFO - mozdebug == 0.1 17:59:18 INFO - mozdevice == 0.51 17:59:18 INFO - mozfile == 1.2 17:59:18 INFO - mozhttpd == 0.7 17:59:18 INFO - mozinfo == 0.10 17:59:18 INFO - mozleak == 0.1 17:59:18 INFO - mozlog == 3.5 17:59:18 INFO - moznetwork == 0.27 17:59:18 INFO - mozprocess == 0.25 17:59:18 INFO - mozprofile == 0.28 17:59:18 INFO - mozrunner == 6.13 17:59:18 INFO - mozscreenshot == 0.1 17:59:18 INFO - mozsystemmonitor == 0.3 17:59:18 INFO - moztest == 0.8 17:59:18 INFO - mozversion == 1.4 17:59:18 INFO - psutil == 3.1.1 17:59:18 INFO - requests == 1.2.3 17:59:18 INFO - wsgiref == 0.1.2 17:59:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:59:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:59:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:59:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:59:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:59:18 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 0x16271f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17efa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1996b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1993580>, '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 0x1994480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1994910>, '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': '745a4373a2a16df560f216e000000264-1504141101.159818-903536102', '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 17:59:18 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 17:59:18 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 17:59:18 INFO - Using env: {'DISPLAY': ':0', 17:59:18 INFO - 'HOME': '/home/cltbld', 17:59:18 INFO - 'LANG': 'en_US.UTF-8', 17:59:18 INFO - 'LANGUAGE': 'en_US:en', 17:59:18 INFO - 'LOGNAME': 'cltbld', 17:59:18 INFO - 'MAIL': '/var/mail/cltbld', 17:59:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:59:18 INFO - 'MOZ_NO_REMOTE': '1', 17:59:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:59:18 INFO - 'NO_EM_RESTART': '1', 17:59:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:59:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:59:18 INFO - 'PWD': '/builds/slave/test', 17:59:18 INFO - 'SHELL': '/bin/bash', 17:59:18 INFO - 'SHLVL': '1', 17:59:18 INFO - 'TERM': 'linux', 17:59:18 INFO - 'TMOUT': '86400', 17:59:18 INFO - 'USER': 'cltbld', 17:59:18 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1504141101.159818-903536102', 17:59:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:59:18 INFO - '_': '/tools/buildbot/bin/python'} 17:59:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:59:18 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)) 17:59:18 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)) 17:59:18 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)) 17:59:18 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)) 17:59:18 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)) 17:59:18 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)) 17:59:18 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)) 17:59:18 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)) 17:59:18 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)) 17:59:18 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 17:59:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:59:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:59:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:59:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:59:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 17:59:19 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)) 17:59:19 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)) 17:59:19 INFO - Installing collected packages: simplejson 17:59:19 INFO - Running setup.py install for simplejson 17:59:19 INFO - building 'simplejson._speedups' extension 17:59:19 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 17:59:20 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 17:59:20 INFO - Successfully installed simplejson 17:59:20 INFO - Cleaning up... 17:59:20 INFO - Return code: 0 17:59:20 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:59: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')]} 17:59:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:59: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')]} 17:59:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:59: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16271f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17efa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1996b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1993580>, '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 0x1994480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1994910>, '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': '745a4373a2a16df560f216e000000264-1504141101.159818-903536102', '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 17:59: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', 'jsonschema'] in /builds/slave/test/build 17:59: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 jsonschema 17:59:20 INFO - Using env: {'DISPLAY': ':0', 17:59:20 INFO - 'HOME': '/home/cltbld', 17:59:20 INFO - 'LANG': 'en_US.UTF-8', 17:59:20 INFO - 'LANGUAGE': 'en_US:en', 17:59:20 INFO - 'LOGNAME': 'cltbld', 17:59:20 INFO - 'MAIL': '/var/mail/cltbld', 17:59:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:59:20 INFO - 'MOZ_NO_REMOTE': '1', 17:59:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:59:20 INFO - 'NO_EM_RESTART': '1', 17:59:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:59:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:59:20 INFO - 'PWD': '/builds/slave/test', 17:59:20 INFO - 'SHELL': '/bin/bash', 17:59:20 INFO - 'SHLVL': '1', 17:59:20 INFO - 'TERM': 'linux', 17:59:20 INFO - 'TMOUT': '86400', 17:59:20 INFO - 'USER': 'cltbld', 17:59:20 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1504141101.159818-903536102', 17:59:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:59:20 INFO - '_': '/tools/buildbot/bin/python'} 17:59:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:59:20 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:59:20 INFO - Cleaning up... 17:59:20 INFO - Return code: 0 17:59:20 INFO - Running post-action listener: _resource_record_post_action 17:59:20 INFO - Running post-action listener: _start_resource_monitoring 17:59:20 INFO - Starting resource monitoring. 17:59:20 INFO - [mozharness: 2017-08-31 00:59:20.868453Z] Finished create-virtualenv step (success) 17:59:20 INFO - [mozharness: 2017-08-31 00:59:20.869127Z] Running install step. 17:59:20 INFO - Running pre-action listener: _resource_record_pre_action 17:59:20 INFO - Running main action method: install 17:59:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:59:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:59:21 INFO - Reading from file tmpfile_stdout 17:59:21 INFO - Detecting whether we're running mozinstall >=1.0... 17:59:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:59:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:59:21 INFO - Reading from file tmpfile_stdout 17:59:21 INFO - Output received: 17:59:21 INFO - Usage: mozinstall [options] installer 17:59:21 INFO - Options: 17:59:21 INFO - -h, --help show this help message and exit 17:59:21 INFO - -d DEST, --destination=DEST 17:59:21 INFO - Directory to install application into. [default: 17:59:21 INFO - "/builds/slave/test"] 17:59:21 INFO - --app=APP Application being installed. [default: firefox] 17:59:21 INFO - mkdir: /builds/slave/test/build/application 17:59:21 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'] 17:59:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 17:59:37 INFO - Reading from file tmpfile_stdout 17:59:37 INFO - Output received: 17:59:37 INFO - /builds/slave/test/build/application/firefox/firefox 17:59:37 INFO - Running post-action listener: _resource_record_post_action 17:59:37 INFO - [mozharness: 2017-08-31 00:59:37.759236Z] Finished install step (success) 17:59:37 INFO - [mozharness: 2017-08-31 00:59:37.759486Z] Running setup-mitmproxy step. 17:59:37 INFO - Running pre-action listener: _resource_record_pre_action 17:59:37 INFO - Running main action method: setup_mitmproxy 17:59:37 INFO - Skipping: mitmproxy is not required 17:59:37 INFO - Running post-action listener: _resource_record_post_action 17:59:37 INFO - [mozharness: 2017-08-31 00:59:37.760612Z] Finished setup-mitmproxy step (success) 17:59:37 INFO - [mozharness: 2017-08-31 00:59:37.760929Z] Running run-tests step. 17:59:37 INFO - Running pre-action listener: _resource_record_pre_action 17:59:37 INFO - Running pre-action listener: _set_gcov_prefix 17:59:37 INFO - Running main action method: run_tests 17:59:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:59:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:59:37 INFO - Python 2.7.3 17:59:37 INFO - Return code: 0 17:59:37 INFO - grabbing minidump binary from tooltool 17:59:37 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')]} 17:59:37 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 0x1993580>, '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 0x1994480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1994910>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:59:37 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 17:59:37 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 17:59:37 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 17:59:37 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:59:37 INFO - Return code: 0 17:59:37 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:59:37 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:59:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:59:37 INFO - ENV: RUST_BACKTRACE is now full 17:59:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:59:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:59:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JjWT5fwtQZy7VNboNo6e0g/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--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 17:59:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/JjWT5fwtQZy7VNboNo6e0g/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-032 --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 17:59:37 INFO - Using env: {'DISPLAY': ':0', 17:59:37 INFO - 'HOME': '/home/cltbld', 17:59:37 INFO - 'LANG': 'en_US.UTF-8', 17:59:37 INFO - 'LANGUAGE': 'en_US:en', 17:59:37 INFO - 'LOGNAME': 'cltbld', 17:59:37 INFO - 'MAIL': '/var/mail/cltbld', 17:59:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:59:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:59:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:59:37 INFO - 'MOZ_NO_REMOTE': '1', 17:59:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:59:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:59:37 INFO - 'NO_EM_RESTART': '1', 17:59:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:59:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:59:37 INFO - 'PWD': '/builds/slave/test', 17:59:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:59:37 INFO - 'RUST_BACKTRACE': 'full', 17:59:37 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 17:59:37 INFO - 'SHELL': '/bin/bash', 17:59:37 INFO - 'SHLVL': '1', 17:59:37 INFO - 'STYLO_FORCE_ENABLED': '1', 17:59:37 INFO - 'STYLO_THREADS': '1', 17:59:37 INFO - 'TERM': 'linux', 17:59:37 INFO - 'TMOUT': '86400', 17:59:37 INFO - 'USER': 'cltbld', 17:59:37 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1504141101.159818-903536102', 17:59:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:59:37 INFO - '_': '/tools/buildbot/bin/python'} 17:59:37 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JjWT5fwtQZy7VNboNo6e0g/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--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 17:59:38 INFO - mozversion application_buildid: 20170831001019 17:59:38 INFO - mozversion application_changeset: d9b405d82cffb07343a5f2fd941e029298c7f6c4 17:59:38 INFO - mozversion application_display_name: Nightly 17:59:38 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:59:38 INFO - mozversion application_name: Firefox 17:59:38 INFO - mozversion application_remotingname: firefox 17:59:38 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 17:59:38 INFO - mozversion application_vendor: Mozilla 17:59:38 INFO - mozversion application_version: 57.0a1 17:59:38 INFO - mozversion platform_buildid: 20170831001019 17:59:38 INFO - mozversion platform_changeset: d9b405d82cffb07343a5f2fd941e029298c7f6c4 17:59:38 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 17:59:38 INFO - mozversion platform_version: 57.0a1 17:59:38 INFO - using testdate: 1504141178 17:59:38 INFO - actual date: 1504141178 17:59:38 INFO - starting webserver on 'localhost:58436' 17:59:38 INFO - SUITE-START | Running 2 tests 17:59:38 INFO - TEST-START | dromaeo_css 17:59:38 INFO - Initialising browser for dromaeo_css test... 17:59:38 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:58436/getInfo.html -profile /tmp/tmpPz1OlY/profile 17:59:38 INFO - TEST-INFO | started process 29644 (/builds/slave/test/build/application/firefox/firefox http://localhost:58436/getInfo.html) 17:59:43 INFO - TEST-INFO | 29644: exit 0 17:59:44 INFO - Browser initialized. 17:59:44 INFO - Running cycle 1/1 for dromaeo_css test... 17:59:44 INFO - Using env: {'DISPLAY': ':0', 17:59:44 INFO - 'HOME': '/home/cltbld', 17:59:44 INFO - 'JSGC_DISABLE_POISONING': '1', 17:59:44 INFO - 'LANG': 'en_US.UTF-8', 17:59:44 INFO - 'LANGUAGE': 'en_US:en', 17:59:44 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 17:59:44 INFO - 'LOGNAME': 'cltbld', 17:59:44 INFO - 'MAIL': '/var/mail/cltbld', 17:59:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:59:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:59:44 INFO - 'MOZ_CRASHREPORTER': '1', 17:59:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:59:44 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 17:59:44 INFO - 'MOZ_NO_REMOTE': '1', 17:59:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:59:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:59:44 INFO - 'NO_EM_RESTART': '1', 17:59:44 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:59:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:59:44 INFO - 'PWD': '/builds/slave/test', 17:59:44 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:59:44 INFO - 'RUST_BACKTRACE': 'full', 17:59:44 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 17:59:44 INFO - 'SHELL': '/bin/bash', 17:59:44 INFO - 'SHLVL': '1', 17:59:44 INFO - 'STYLO_FORCE_ENABLED': '1', 17:59:44 INFO - 'STYLO_THREADS': '1', 17:59:44 INFO - 'TERM': 'linux', 17:59:44 INFO - 'TMOUT': '86400', 17:59:44 INFO - 'USER': 'cltbld', 17:59:44 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1504141101.159818-903536102', 17:59:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:59:44 INFO - '_': '/tools/buildbot/bin/python'} 17:59:44 INFO - TEST-INFO | started process 29829 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPz1OlY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 17:59:45 INFO - PID 29829 | 17:59:45 INFO - PID 29829 | (/builds/slave/test/build/application/firefox/firefox:29881): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 17:59:45 INFO - PID 29829 | 17:59:55 INFO - PID 29829 | RSS: Main: 170680320 17:59:55 INFO - PID 29829 | 18:02:53 INFO - PID 29829 | Cycle 1(1): loaded http://localhost:58436/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58436/tests/dromaeo/cssquery-ext.html) 18:02:55 INFO - PID 29829 | RSS: Main: 174051328 18:02:55 INFO - PID 29829 | 18:05:57 INFO - PID 29829 | Cycle 1(1): loaded http://localhost:58436/tests/dromaeo/cssquery-ext.html (next: http://localhost:58436/tests/dromaeo/cssquery-jquery.html) 18:05:58 INFO - PID 29829 | RSS: Main: 169660416 18:05:58 INFO - PID 29829 | 18:08:59 INFO - PID 29829 | Cycle 1(1): loaded http://localhost:58436/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58436/tests/dromaeo/cssquery-mootools.html) 18:09:00 INFO - PID 29829 | RSS: Main: 172064768 18:09:00 INFO - PID 29829 | 18:12:02 INFO - PID 29829 | Cycle 1(1): loaded http://localhost:58436/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58436/tests/dromaeo/cssquery-prototype.html) 18:12:02 INFO - PID 29829 | RSS: Main: 170864640 18:12:02 INFO - PID 29829 | 18:15:06 INFO - PID 29829 | Cycle 1(1): loaded http://localhost:58436/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58436/tests/dromaeo/cssquery-yui.html) 18:15:07 INFO - PID 29829 | RSS: Main: 172396544 18:15:07 INFO - PID 29829 | 18:18:08 INFO - PID 29829 | Cycle 1(1): loaded http://localhost:58436/tests/dromaeo/cssquery-yui.html (next: http://localhost:58436/tests/dromaeo/cssquery-dojo.html) 18:18:09 INFO - PID 29829 | RSS: Main: 175046656 18:18:09 INFO - PID 29829 | 18:18:09 INFO - PID 29829 | __start_tp_report 18:18:09 INFO - PID 29829 | _x_x_mozilla_page_load 18:18:09 INFO - PID 29829 | _x_x_mozilla_page_load_details 18:18:09 INFO - PID 29829 | |i|pagename|runs| 18:18:09 INFO - PID 29829 | |0;dojo.html;3323.3685599736064;3363.7140843028374;3364.1421437533427;3374.5106959490868;3404.4723067924465;6246.344133865947;6280.780172693957;6334.271558770743;6407.359264073591;6417;6333.366663333676;6369.617822930616;6378.234611846573;6439.323870993549;6488.124103246072;5664.54683625309;5805.867855768127;5859.209006784094;5888.440598143169;5910.645361278315;5734.225879506276;5796.101604251347;5900.793472228473;5902.291724992985;5904.645721256717;5775.3358363788075;5879.559033072515;5880.441358070976;5901.970490147522;5902.173695682608;5776.075827867521;5788.392218817005;5819.79630712923;5829.358770535237;5831.562632802556;5594.692291923942;5679.886402271973;5738.971305143489;5744.971275143597;5749.223854779635;6282.905756413657;6328.588641738318;6349.4602958748565;6352.587081839665;6371.203599550056;6642.5350225484235;6722.798316050526;6827.317268273133;6832.419244364235;6844.555103918229;6562.573432726857;6698.765543205965;6707.463402927754;6790.830229244309;6909.689063992082;6197.1324014637985;6211.472024877846;6222.160008398853;6239.625622462667;6242.625442473466;6775.796726098127;6832.624205668736;6833.965830170818;6845.5550389224545;6875.0718652982205;6548;6548.410643042149;6550.312217217219;6557.803265902031;6574.737010519526;6644.103046088716;6652.667366631746;6655.833604159838;6674.933250667528;6743.730250789913;6750.1224840771365;6778.051072849805;6791.694373753193;6795.864082718417;6806;6745.392914637608;6746.595204287759;6779.898301525481;6830.351116643911;6830.658467076626;5190.117679994334;5237.9476205238225;5247.370315562081;5301.575873930076;5325.254464374991;4676.976615116902;4685.554872287127;4799.544043315879;4828.37231159954;4834.299026641117;5862.560307976833;5893.675847828411;5921.348651648315;5941.376155503696;5950.256217972754;6666.100076489709;6848.075509806212;6929.099217101845;6931;6935.098437203132;5706.572007099484;5718.1136923776885;5722.284714410699;5723.3418156912485;5729.0260655688635;5687.090065589486;5709;5732.369439361667;5807.361190269067;5902.8819423611285;6570.145881035435;6624.205095388488;6626.86746265072;6627.204735431779;6657.933420665829;6722.5966442014615;6731.966340168464;6824.761133360308;6831.760888368884;6839.863202736017;6604.867902642017;6609.239937407067;6613.834654133492;6631.303713110054;6707.3292670732535;6437.549371543947;6627.635480048643;6647.966760166169;6655.700493477708;6713.12729345182;6714.328567143247;6726.192856857208;6732.192136943598;6734.259231484435;6743.865122697617;6420.357964203542;6503.25212600557;6509.674516274073;6515.02274658805;6517.348265173445;5650.3219613646625;6457.838554036187;6487.708053137526;6496.512761542808;6507.316731743288;6579.440747536321;6592.044153597797;6634;6654.5341826073645;6662.966685166543;6597.0764093026055;6678.3989440950545;6767.25560188369;6770.255271920183;6780.355866192704;6219.813405597839;6274.592151510137;6300.0234963580715;6314.084457753692;6314.431701146918 18:18:09 INFO - PID 29829 | |1;ext.html;765.7358211417063;847.8219573889482;883.4964070479828;1124.25798972678;1138.3397629374963;28237.152885413445;39831;40690.18619627606;40828.59171408285;40853.59146408535;40575.18849623006;40951;41062.38406423906;41065.58934410655;41115.58884411155;7279.781606551812;7557.848843023136;7913.129555748863;7924.247196516321;7929.722459713911;7756.534607923514;7842.72550460734;7850.921490785105;7853.921460785405;7856.803579910491;7786.7663970080985;7863.488873223222;7869.134395216522;7880.330171935392;7902.841943161134;7777.611119444034;7881.2118788121015;7882.56645884479;7886.64510097047;7888.2506161914525;7643.273888980538;7710.653020614086;7730.922690773076;7755.573443460607;7766.262205090507;36915;37670.623293766985;37698.24603507942;37714;37735.05662358463;3533.752637315389;3575.6424357564297;3580.2839432113683;3587.6232995535356;3591.28174365128;30518.389632207454;30640.08079757611;30713.846430767702;30743.38513229745;30793.538096928565;4978.775955081994;5137.0496458154985;5163.561097306733;5187.792488300502;5202.661826981234;186105;186886;187920;187929;188654;46539.30191047137;46787;46879.76560117178;46959.765201173774;46982.29526557105;49078.5092149074;49275.75362123166;49313.75343123262;49331.75334123307;49337.50662493401;12940.611781646565;15264.542063738105;15918.9204053979;15927.203639817963;15938.521844344688;10782.08352290064;10871.402072886067;12297.385130743427;12521.123521353418;12563.811542826865;13593.184408935496;13707.657308567366;13753.587392378246;13825.340959084773;13959;5663.546916246691;5724.914126288109;5806.767729290781;5821.825345239649;5836.533077353802;1009.8182327181031;1017.1760873692185;1035.570238351091;1042.3849928542197;1052.5894900988621;22435.439114021952;22962.31113066611;23002.19492317761;23011;23419.10096108289;1140.1562843495753;1141.14414189358;1143.2111842828422;1148.2134737704698;1156.5836298932377;11817.645470635895;12094.879051209375;12146;12179.269243845398;12180.81728774069;229347;229895;230280;230848;231355;51211.487885121416;51378.22932656013;51404.74297628488;51420.48579514232;51492;1439.5969128643997;1468.3465857693225;1477.0325436838887;1479.5931118942162;1482.636753995278;22180.778192217873;22346.21788237404;22489.32532024042;22599.887000565548;23050.07799688061;33619.3276134471;36549.63450365569;36641.267174655826;36654.26691466209;36693.44959825658;202206;202782;202839;203321;203357;29857.85071074631;30346.84826575853;30551.694483055773;32941.67058329482;33144.66855331416;42726.359104612835;42842.57157428386;42949;42961.140777184904;42979.570204298805;31704.841475792473;31842.203944900637;31855.36289274248;31894.840525797223;32549.34901302008;31008.379832403676;31543;31814.363712726077;31846.522302165024;32293.35413291768;35038.82480587581;35308.29383412369;35511.28977420489;35582.11044723903;35943.28113437769;30264.243393915327;30413.543796842623;30456.695433046272;30855;31016.53475197919;23126;23284.3014709559;23465;24122.87938560366;24961 18:18:09 INFO - PID 29829 | |2;jquery.html;565.4543365652147;573.1287346812654;573.7446836157906;576.5186069631857;590.7814108779752;21420.25029123981;22126.88936555319;22347.329580112582;22365.54623949444;22390.776092239073;24822.379440513952;25700.742992570067;25708.357291067685;25753.74246257537;25802.612960805604;6331.050342448647;6474.1907261592305;6474.838129046788;6486.902696459533;6491.156149700556;6365.204349456318;6415.326390728977;6725.966370168142;7060.7881763547175;7066.7173313067415;7044.366007059363;7048.330408611174;7050.259722729116;7054.611996340199;7055.435565154801;6966.79099627012;7033.296670332977;7035.331643493885;7037;7043.788686339418;6890;6897.896531552031;6902.068220790179;6910.827229319257;6947.617881016542;30518.847405763052;30720.53919191214;30960.380792384025;31212;31243.37513249722;2114.3973967419365;2153.6231159547174;2154.084514081525;2156.299202759094;2157.6547752359547;20501.58996820055;21030.474238144016;21089.15643374263;21111.261105861373;21127.683084753586;2415.541047201044;2459.7909177719916;2525.595904655265;2617.973820261811;2625.1599488163797;140759;144035;144273;144585.277073615;144610;19761.604767904562;21599.784002160093;21827.12691492354;21917.23289684885;22468.95558799399;43038.569614304084;43100.78449607732;43183;43194.7840260803;43201.78399108047;11377.943110284396;11441.37072461006;11482.48328825205;11538.826917596243;11634.127440442;9607.13535781769;9645.614175433044;9652.855207171899;9702.563384647709;9795.216382689368;9331.440113593206;10847.837282440769;11511.942440287745;11514.712132196762;11618.186726929034;4380.802863871133;4384.145091707086;4418.270985287456;4489.910201795946;4493.550644935545;979.2019504104132;984.3995162950595;1000.9599616015423;1005.1255407795119;1009.2682804966487;19307.324243651405;20256.392308230777;20324.491887702927;20440.080196391198;20448.693269600968;1055.1400608504046;1056.1128651932413;1061.639042725477;1070.3952266969138;1073.3774410841693;10810.459477026274;11180.93781090795;11391.601293954673;13183.472661093641;13820.170789752647;530033;540156;541114;542013;549490;121328.39335803442;123050;125520.67484448252;125863.370683146;127802.36098819446;1225.3199474291675;1229.2562999385243;1273.3060482037313;1273.541525050981;1284.2037936479255;21225.15099396007;21327.253546125812;21427.89286053622;21617.567648647255;21824.454388639777;59847;61035;61318;61770.073448897405;62356;73314;75172.62413687896;75576.24423755692;75741;76039.61980190064;11745;11943.343116128348;12759.106862519906;14369.209693466542;14622;22883.65674514917;22900.4274893129;23025;23217.3034808956;23287.53424931458;18394.172262247965;18413;18430.81569184291;18593.90703046476;18644.34744783926;16660.833391666412;16687.833121668627;17111.65776684484;17259.827401725823;17397.130143492523;18694.813051869853;18730.625387492448;19076.42770716881;19086.33197838069;19143.138558765168;14304.141751494944;14435;14436.206008669624;14511.927440363153;14533.491327803898;18257.178426971084;18589;18642.906785465984;18706.719399208752;18949.90525047421 18:18:09 INFO - PID 29829 | |3;mootools.html;1330.9933450332746;1384.1971656439266;1395.7487652222599;1397.664560505479;1405.0726520496469;14879;15262.465813696523;15470;15475.922620386897;15514.922425387856;15850.128242946634;16058.27737751801;16064;16089.275982580783;16144.354225830954;2812.3531587734783;2858.8713507892194;2860.4994126027964;2860.8998685046026;2864.341201523651;2630.289821748127;2765.903193388232;2826.1662809471254;2833.504136776056;2835.9291017724518;2829.038127036807;2835.4896118698625;2854.1865568313033;2858.771298296131;2862.041216192578;2688.0591792872438;2717.062613398374;2730;2737.3567211705235;2737.8083534152615;2773.597828314883;2792.8463934483593;2799.3981294021883;2801.7338352856445;2804.383035732136;15072.623184420478;15373;15381.538553843402;15396.615084622863;15405.3837846486;8099.635516401776;8421.536815475147;8427.536485493296;8429.915700842974;8431.28334091603;5359.383670877821;5583.553315734772;5628.493435590816;5644.887102257973;5859.091840764689;1935.341983725526;1937.8062193780509;1939.2630800295938;1971.5071232191951;1989.5424052467868;26635.334116647045;26665.333366665796;26862.059827906123;26909;26932.865335673196;7482.214367491444;7525.586092764841;7687.577183254863;7820.960895195488;7831.6475758591005;17430.302787888595;17539.649207015787;17572.736408953875;17580.47258582219;17581.538584598165;7945.364370850318;8084.636191371403;8088.595570221583;8090.83818323642;8110.594470276463;7420.777376678709;7481.663325150382;7492.887606685904;7556;7564.9243507565325;4555.407796986437;5305.840824775186;5436;5466.207399926989;5504.119340905516;1462.6708990477057;1547.396515359011;1614.5237155039292;1618.7410014397876;1620.7649890765772;881.1056777370974;897.1118592593285;901.4983421006759;913.4793167894236;913.6482454255026;8484.32125429964;8494.575271236414;8516.105808889977;8603.139686031347;8623.655053797904;1001.0540039662449;1002.2683441088046;1006.7885743993697;1013.6350913671073;1022.2639699416409;4858.854234372904;5002.549770520598;5021.49785021495;5036.974815125901;5044.646874718735;20380.184792608427;20735.688964665544;20755;21429.46426339354;22132.33602991913;21197.576048478943;22234.666480002812;22257.66613500799;22264.666030009565;22283.665745013837;10436.843447348296;10845.13238940883;11057.5024123913;11080.778384432428;11082.22424430282;8603.397762156588;8799.692010779849;8863.822723545363;8918.687845925362;8990;17177.227024784166;17798.555036123682;18200.726989095438;18845.811541884406;19133;17352.739708904628;17569.385071522436;18070;18279.36022239215;18342.541436464195;12099.33453660057;12404.751904962031;12405.937970310091;12413.317267550372;12434.751304973668;13746.93126534361;13998.860011399756;14120.858791411954;14122.082064665763;14170.574882753534;10922.399268040333;11200.551977920792;11733.120015998664;11975.341356225492;11995.280283183038;10859.34843909368;10909.454527273763;11020.283681560673;11200.38397888124;11276.210665253353;9501.667441639509;9957.850632240377;10002.44986525748;10211.438370889375;10325.586976521156;7036.155661320674;7119.786406407816;7209.675564599501;7238.6018768966105;7259.092613423322;7153.749618763526;7188.353048225685;7212.386947109554;7226.674799633924;7253.782386528413 18:18:09 INFO - PID 29829 | |4;prototype.html;501.2306110120963;503.90929632666104;529.9152135658294;537.1459379586457;539.5737367479692;6353.269374021989;6385.233771947367;6387.498937749631;6388.520860935437;6392.78537077956;6077.635341879491;6195.597286176396;6204.224471941007;6252.436501034576;6254.405831446017;5048.899022019557;5067.493250674921;5068.695878247298;5071.543561079502;5079.212722028092;4936.925946110811;5000.4749501302385;5007;5052.6210534209895;5067.822626208083;4775.331453596499;4923.507649235065;4931.728754918478;4948.8267910623135;4978.427480839696;4944.66494046609;4966;4972.5276098770555;4997.450790255032;5022.221555658879;4419.381286619876;4448.110377924428;4457.885528617846;4470.955290447087;4472.172648060119;6095.695215239265;6176.660283684396;6179.5056395488255;6180.505559555269;6230.813075607739;5713.685957187346;5733;5743.54051675865;5756.5682573807135;5758.712064396764;6535.673216339164;6544.887369147256;6585.407313341822;6651.93348066518;6662.300458451889;4847.83032593861;4853.524702401801;4868.683535570177;4887.3890763654545;4889.535494128052;6971.651417429108;6987.755428559976;6994.880819068924;6995.790126296169;7034.366906978396;4995.400551933792;5006.874828129326;5048.510689346652;5052.69683818972;5064.442911279756;5066.771995260222;5073.365829271341;5080.374280230365;5090.185570308733;5100.668456550312;5670.092785154356;5684.232628595087;5689.260396148474;5701.800436984686;5730.455606717355;6574.309697481791;6584.7366105356205;6622.2715501294815;6672.766453174116;6714.9664251679405;1621.1407953784512;1683.5370273174974;1707.9060651664029;1739.990805332929;1743.1371471121622;1158.6466127830925;1198.2870192235605;1202.2666173634077;1228.6498347970785;1235.5428491458217;5672.7730890763905;5714.171445140514;5732.828015159552;5788.18965344852;5807.738651760681;6498.54510184292;6626.834329141713;6670;6717.294684058202;6735.42748866342;5769.567282453832;5809.68847756783;5822.883542329215;5832;5841.247625712269;3495;3495.2485215678753;3519.1729943463265;3589.587197472272;3623.438367053111;6461.483081353481;6546.410823025951;6560.179977502812;6594.3735345143095;6608.504362172856;6954.965225173842;6992.545484543489;7004.964975175091;7021.754238601625;7080.220850925604;6591.802245932629;6624.377027628262;6631.403173714389;6678.332166783282;6710.966445167743;6882.931170688229;6884;6900.3444672756;6926.965365173141;6927.203371612329;6753.189617245962;6761.526693131434;6839.965800170968;6847.1783385994;6881.3806757390075;6605.47156227491;6612.636305003271;6642.634655094016;6657.900131497934;6688.6990085445295;5022.924656130088;5027.723475208899;5036.874078148076;5044;5047.545720884991;6815.318468153343;6815.524082717949;6890.139662291253;6890.519413011211;6948.5483443576;6615.768448104293;6638.50211234169;6647.966760166169;6649.933500665125;6652.569697514864;6631.270560238273;6639.170103737033;6645.60126392418;6665.900011499734;6675.299093595103;6224.346443623354;6269.717862696099;6436.195475565554;6447.161868957193;6470.191226096738;6434.356564343529;6500.70746816385;6504.447121994684;6579;6609.4712423005085;6250.562460627712;6306.810795676137;6325.209348831396;6351.237851457855;6376.840578985562 18:18:09 INFO - PID 29829 | |5;yui.html;910.3945875992464;915.039208830728;919.6137622198685;928.2666693312286;930.7114794413732;18437.90781046093;18734.437966860984;19537.511562210933;19567.923764192965;19575.706364404545;20256.493587660316;21153.788462115375;21155.15379384823;21180.364589062352;21352.039158237876;982.4449186209769;1003.9447830369327;1011.7976404719049;1012.0233974214881;1012.7822518158595;889.3418870036159;987.4174237200051;989.717930389839;990.069334825262;998.9450580218086;1054.5939813171947;1059.4702648675661;1059.89930956559;1062.5643486170673;1064.632701717906;1045.2160879340495;1045.984310235347;1048.4495639789095;1051.1853313681959;1054.7995880782664;771.0939645916026;773.4972268025772;775.3719487215317;775.4649291988567;776.6466257852663;19218.519537011547;19306;19640.50898727529;19746.802531974783;20113.39659810208;20642;20648.380548583566;20776.27283045086;21187.15251389958;21209.46976325589;16926.15369231546;17384.304627814872;17616.55958601045;17621.64756704859;17640.647187056315;3781.2248489059953;3807.390817469219;3810.90472738181;3818.198178382543;3822.311983842907;124722.37638811748;127336.36331818374;129747.35126324308;130856.34571827175;131865;16350.672986540441;16369.836301636831;16536.173191340386;16744.581385465463;16768.413105541247;29335;29949.101526954226;30025.249368765955;30202.54696179559;30325.848370758446;7656.310932016146;7995.600219988977;8014.759557213293;8787.912120878837;8791.956040219759;4402.3836662867225;4539.523350048264;4558.8632341029825;4564.908701825945;4567.862964111082;5283.920741188886;5295.761690723926;5332.9466705333225;5354.491323324278;5373.919391209135;1035.6323505155713;1045.72288343589;1054.319963623474;1062.511244827388;1066.317556763672;604.2416766957529;628.277480896963;630.4200135874914;634.6794868591425;648.2059477140559;11492.138089643311;11630.76738465226;11753.764924701458;11881.524739010516;11887.28676279426;677.167084486075;697.3828162076599;697.8534507753428;700.471144286071;710.4458522352573;5487.835364939058;5501.944980550224;5692.459216374521;5859.94140058594;5911.704414779244;101053;101541.49229253807;103293;106819;107382.46308768562;93782;97816.51091744496;98074;99135;100607.49696251472;84389.7805109742;85731.99999999875;89664;90663.54668226617;92534;12174.634760957186;12179.208351457128;12214.206076605347;12249.510019599473;12262.325572093621;40176;42956.14087718166;43326.350104749086;43933;44113.338299924886;65905.68188636296;66337.33662663311;67914;68525.31474685189;68814.65592672005;15521.689566208386;16802.411915582896;17193.91403042977;17406.129693515526;17825.10874456298;17606.471805845846;17708.734368984733;19831.20675172977;20039.29862454807;20613.587728245053;17545;18098.366557170437;18304;18358.908205458887;18486;18569.53576160607;18626.906865465586;19518.414447566596;19745;20365.49086272855;17235.22441490111;17576.472705818847;17846.643067138844;18264;18551.53621159482;13309.733805324033;13483.865161348262;13502.864971350553;13550.93224533871;13619.659508512366;13669.521566745116;13847.65380865446;13975.440982360999;14035.789463158266;14049.438022478986 18:18:09 INFO - PID 29829 | __end_tp_report 18:18:09 INFO - PID 29829 | __start_cc_report 18:18:09 INFO - PID 29829 | _x_x_mozilla_cycle_collect,359 18:18:09 INFO - PID 29829 | __end_cc_report 18:18:09 INFO - PID 29829 | __startTimestamp1504142289080__endTimestamp 18:18:09 INFO - PID 29829 | 18:18:09 INFO - PID 29829 | ------- Summary: start ------- 18:18:09 INFO - PID 29829 | Number of tests: 6 18:18:09 INFO - PID 29829 | 18:18:09 INFO - PID 29829 | [#0] dojo.html Cycles:165 Average:6211.48 Median:6457.84 stddev:714.60 (11.1%) stddev-sans-first:679.93 18:18:09 INFO - PID 29829 | Values: 3323.4 3363.7 3364.1 3374.5 3404.5 6246.3 6280.8 6334.3 6407.4 6417.0 6333.4 6369.6 6378.2 6439.3 6488.1 5664.5 5805.9 5859.2 5888.4 5910.6 5734.2 5796.1 5900.8 5902.3 5904.6 5775.3 5879.6 5880.4 5902.0 5902.2 5776.1 5788.4 5819.8 5829.4 5831.6 5594.7 5679.9 5739.0 5745.0 5749.2 6282.9 6328.6 6349.5 6352.6 6371.2 6642.5 6722.8 6827.3 6832.4 6844.6 6562.6 6698.8 6707.5 6790.8 6909.7 6197.1 6211.5 6222.2 6239.6 6242.6 6775.8 6832.6 6834.0 6845.6 6875.1 6548.0 6548.4 6550.3 6557.8 6574.7 6644.1 6652.7 6655.8 6674.9 6743.7 6750.1 6778.1 6791.7 6795.9 6806.0 6745.4 6746.6 6779.9 6830.4 6830.7 5190.1 5237.9 5247.4 5301.6 5325.3 4677.0 4685.6 4799.5 4828.4 4834.3 5862.6 5893.7 5921.3 5941.4 5950.3 6666.1 6848.1 6929.1 6931.0 6935.1 5706.6 5718.1 5722.3 5723.3 5729.0 5687.1 5709.0 5732.4 5807.4 5902.9 6570.1 6624.2 6626.9 6627.2 6657.9 6722.6 6732.0 6824.8 6831.8 6839.9 6604.9 6609.2 6613.8 6631.3 6707.3 6437.5 6627.6 6648.0 6655.7 6713.1 6714.3 6726.2 6732.2 6734.3 6743.9 6420.4 6503.3 6509.7 6515.0 6517.3 5650.3 6457.8 6487.7 6496.5 6507.3 6579.4 6592.0 6634.0 6654.5 6663.0 6597.1 6678.4 6767.3 6770.3 6780.4 6219.8 6274.6 6300.0 6314.1 6314.4 18:18:09 INFO - PID 29829 | 18:18:09 INFO - PID 29829 | [#1] ext.html Cycles:180 Average:37104.36 Median:32745.51 stddev:53801.40 (164.3%) stddev-sans-first:53883.13 18:18:09 INFO - PID 29829 | Values: 765.7 847.8 883.5 1124.3 1138.3 28237.2 39831.0 40690.2 40828.6 40853.6 40575.2 40951.0 41062.4 41065.6 41115.6 7279.8 7557.8 7913.1 7924.2 7929.7 7756.5 7842.7 7850.9 7853.9 7856.8 7786.8 7863.5 7869.1 7880.3 7902.8 7777.6 7881.2 7882.6 7886.6 7888.3 7643.3 7710.7 7730.9 7755.6 7766.3 36915.0 37670.6 37698.2 37714.0 37735.1 3533.8 3575.6 3580.3 3587.6 3591.3 30518.4 30640.1 30713.8 30743.4 30793.5 4978.8 5137.0 5163.6 5187.8 5202.7 186105.0 186886.0 187920.0 187929.0 188654.0 46539.3 46787.0 46879.8 46959.8 46982.3 49078.5 49275.8 49313.8 49331.8 49337.5 12940.6 15264.5 15918.9 15927.2 15938.5 10782.1 10871.4 12297.4 12521.1 12563.8 13593.2 13707.7 13753.6 13825.3 13959.0 5663.5 5724.9 5806.8 5821.8 5836.5 1009.8 1017.2 1035.6 1042.4 1052.6 22435.4 22962.3 23002.2 23011.0 23419.1 1140.2 1141.1 1143.2 1148.2 1156.6 11817.6 12094.9 12146.0 12179.3 12180.8 229347.0 229895.0 230280.0 230848.0 231355.0 51211.5 51378.2 51404.7 51420.5 51492.0 1439.6 1468.3 1477.0 1479.6 1482.6 22180.8 22346.2 22489.3 22599.9 23050.1 33619.3 36549.6 36641.3 36654.3 36693.4 202206.0 202782.0 202839.0 203321.0 203357.0 29857.9 30346.8 30551.7 32941.7 33144.7 42726.4 42842.6 42949.0 42961.1 42979.6 31704.8 31842.2 31855.4 31894.8 32549.3 31008.4 31543.0 31814.4 31846.5 32293.4 35038.8 35308.3 35511.3 35582.1 35943.3 30264.2 30413.5 30456.7 30855.0 31016.5 23126.0 23284.3 23465.0 24122.9 24961.0 18:18:09 INFO - PID 29829 | 18:18:09 INFO - PID 29829 | [#2] jquery.html Cycles:180 Average:37953.33 Median:21872.18 stddev:90735.31 (414.8%) stddev-sans-first:90946.42 18:18:09 INFO - PID 29829 | Values: 565.5 573.1 573.7 576.5 590.8 21420.3 22126.9 22347.3 22365.5 22390.8 24822.4 25700.7 25708.4 25753.7 25802.6 6331.1 6474.2 6474.8 6486.9 6491.2 6365.2 6415.3 6726.0 7060.8 7066.7 7044.4 7048.3 7050.3 7054.6 7055.4 6966.8 7033.3 7035.3 7037.0 7043.8 6890.0 6897.9 6902.1 6910.8 6947.6 30518.8 30720.5 30960.4 31212.0 31243.4 2114.4 2153.6 2154.1 2156.3 2157.7 20501.6 21030.5 21089.2 21111.3 21127.7 2415.5 2459.8 2525.6 2618.0 2625.2 140759.0 144035.0 144273.0 144585.3 144610.0 19761.6 21599.8 21827.1 21917.2 22469.0 43038.6 43100.8 43183.0 43194.8 43201.8 11377.9 11441.4 11482.5 11538.8 11634.1 9607.1 9645.6 9652.9 9702.6 9795.2 9331.4 10847.8 11511.9 11514.7 11618.2 4380.8 4384.1 4418.3 4489.9 4493.6 979.2 984.4 1001.0 1005.1 1009.3 19307.3 20256.4 20324.5 20440.1 20448.7 1055.1 1056.1 1061.6 1070.4 1073.4 10810.5 11180.9 11391.6 13183.5 13820.2 530033.0 540156.0 541114.0 542013.0 549490.0 121328.4 123050.0 125520.7 125863.4 127802.4 1225.3 1229.3 1273.3 1273.5 1284.2 21225.2 21327.3 21427.9 21617.6 21824.5 59847.0 61035.0 61318.0 61770.1 62356.0 73314.0 75172.6 75576.2 75741.0 76039.6 11745.0 11943.3 12759.1 14369.2 14622.0 22883.7 22900.4 23025.0 23217.3 23287.5 18394.2 18413.0 18430.8 18593.9 18644.3 16660.8 16687.8 17111.7 17259.8 17397.1 18694.8 18730.6 19076.4 19086.3 19143.1 14304.1 14435.0 14436.2 14511.9 14533.5 18257.2 18589.0 18642.9 18706.7 18949.9 18:18:09 INFO - PID 29829 | 18:18:09 INFO - PID 29829 | [#3] mootools.html Cycles:180 Average:9451.50 Median:26763.70 stddev:6654.44 (24.9%) stddev-sans-first:6645.13 18:18:09 INFO - PID 29829 | Values: 1331.0 1384.2 1395.7 1397.7 1405.1 14879.0 15262.5 15470.0 15475.9 15514.9 15850.1 16058.3 16064.0 16089.3 16144.4 2812.4 2858.9 2860.5 2860.9 2864.3 2630.3 2765.9 2826.2 2833.5 2835.9 2829.0 2835.5 2854.2 2858.8 2862.0 2688.1 2717.1 2730.0 2737.4 2737.8 2773.6 2792.8 2799.4 2801.7 2804.4 15072.6 15373.0 15381.5 15396.6 15405.4 8099.6 8421.5 8427.5 8429.9 8431.3 5359.4 5583.6 5628.5 5644.9 5859.1 1935.3 1937.8 1939.3 1971.5 1989.5 26635.3 26665.3 26862.1 26909.0 26932.9 7482.2 7525.6 7687.6 7821.0 7831.6 17430.3 17539.6 17572.7 17580.5 17581.5 7945.4 8084.6 8088.6 8090.8 8110.6 7420.8 7481.7 7492.9 7556.0 7564.9 4555.4 5305.8 5436.0 5466.2 5504.1 1462.7 1547.4 1614.5 1618.7 1620.8 881.1 897.1 901.5 913.5 913.6 8484.3 8494.6 8516.1 8603.1 8623.7 1001.1 1002.3 1006.8 1013.6 1022.3 4858.9 5002.5 5021.5 5037.0 5044.6 20380.2 20735.7 20755.0 21429.5 22132.3 21197.6 22234.7 22257.7 22264.7 22283.7 10436.8 10845.1 11057.5 11080.8 11082.2 8603.4 8799.7 8863.8 8918.7 8990.0 17177.2 17798.6 18200.7 18845.8 19133.0 17352.7 17569.4 18070.0 18279.4 18342.5 12099.3 12404.8 12405.9 12413.3 12434.8 13746.9 13998.9 14120.9 14122.1 14170.6 10922.4 11200.6 11733.1 11975.3 11995.3 10859.3 10909.5 11020.3 11200.4 11276.2 9501.7 9957.9 10002.4 10211.4 10325.6 7036.2 7119.8 7209.7 7238.6 7259.1 7153.7 7188.4 7212.4 7226.7 7253.8 18:18:09 INFO - PID 29829 | 18:18:09 INFO - PID 29829 | [#4] prototype.html Cycles:180 Average:5555.45 Median:6199.91 stddev:1579.60 (25.5%) stddev-sans-first:1537.81 18:18:09 INFO - PID 29829 | Values: 501.2 503.9 529.9 537.1 539.6 6353.3 6385.2 6387.5 6388.5 6392.8 6077.6 6195.6 6204.2 6252.4 6254.4 5048.9 5067.5 5068.7 5071.5 5079.2 4936.9 5000.5 5007.0 5052.6 5067.8 4775.3 4923.5 4931.7 4948.8 4978.4 4944.7 4966.0 4972.5 4997.5 5022.2 4419.4 4448.1 4457.9 4471.0 4472.2 6095.7 6176.7 6179.5 6180.5 6230.8 5713.7 5733.0 5743.5 5756.6 5758.7 6535.7 6544.9 6585.4 6651.9 6662.3 4847.8 4853.5 4868.7 4887.4 4889.5 6971.7 6987.8 6994.9 6995.8 7034.4 4995.4 5006.9 5048.5 5052.7 5064.4 5066.8 5073.4 5080.4 5090.2 5100.7 5670.1 5684.2 5689.3 5701.8 5730.5 6574.3 6584.7 6622.3 6672.8 6715.0 1621.1 1683.5 1707.9 1740.0 1743.1 1158.6 1198.3 1202.3 1228.6 1235.5 5672.8 5714.2 5732.8 5788.2 5807.7 6498.5 6626.8 6670.0 6717.3 6735.4 5769.6 5809.7 5822.9 5832.0 5841.2 3495.0 3495.2 3519.2 3589.6 3623.4 6461.5 6546.4 6560.2 6594.4 6608.5 6955.0 6992.5 7005.0 7021.8 7080.2 6591.8 6624.4 6631.4 6678.3 6711.0 6882.9 6884.0 6900.3 6927.0 6927.2 6753.2 6761.5 6840.0 6847.2 6881.4 6605.5 6612.6 6642.6 6657.9 6688.7 5022.9 5027.7 5036.9 5044.0 5047.5 6815.3 6815.5 6890.1 6890.5 6948.5 6615.8 6638.5 6648.0 6649.9 6652.6 6631.3 6639.2 6645.6 6665.9 6675.3 6224.3 6269.7 6436.2 6447.2 6470.2 6434.4 6500.7 6504.4 6579.0 6609.5 6250.6 6306.8 6325.2 6351.2 6376.8 18:18:09 INFO - PID 29829 | 18:18:09 INFO - PID 29829 | [#5] yui.html Cycles:180 Average:23697.07 Median:19935.25 stddev:32019.04 (160.6%) stddev-sans-first:32063.14 18:18:09 INFO - PID 29829 | Values: 910.4 915.0 919.6 928.3 930.7 18437.9 18734.4 19537.5 19567.9 19575.7 20256.5 21153.8 21155.2 21180.4 21352.0 982.4 1003.9 1011.8 1012.0 1012.8 889.3 987.4 989.7 990.1 998.9 1054.6 1059.5 1059.9 1062.6 1064.6 1045.2 1046.0 1048.4 1051.2 1054.8 771.1 773.5 775.4 775.5 776.6 19218.5 19306.0 19640.5 19746.8 20113.4 20642.0 20648.4 20776.3 21187.2 21209.5 16926.2 17384.3 17616.6 17621.6 17640.6 3781.2 3807.4 3810.9 3818.2 3822.3 124722.4 127336.4 129747.4 130856.3 131865.0 16350.7 16369.8 16536.2 16744.6 16768.4 29335.0 29949.1 30025.2 30202.5 30325.8 7656.3 7995.6 8014.8 8787.9 8792.0 4402.4 4539.5 4558.9 4564.9 4567.9 5283.9 5295.8 5332.9 5354.5 5373.9 1035.6 1045.7 1054.3 1062.5 1066.3 604.2 628.3 630.4 634.7 648.2 11492.1 11630.8 11753.8 11881.5 11887.3 677.2 697.4 697.9 700.5 710.4 5487.8 5501.9 5692.5 5859.9 5911.7 101053.0 101541.5 103293.0 106819.0 107382.5 93782.0 97816.5 98074.0 99135.0 100607.5 84389.8 85732.0 89664.0 90663.5 92534.0 12174.6 12179.2 12214.2 12249.5 12262.3 40176.0 42956.1 43326.4 43933.0 44113.3 65905.7 66337.3 67914.0 68525.3 68814.7 15521.7 16802.4 17193.9 17406.1 17825.1 17606.5 17708.7 19831.2 20039.3 20613.6 17545.0 18098.4 18304.0 18358.9 18486.0 18569.5 18626.9 19518.4 19745.0 20365.5 17235.2 17576.5 17846.6 18264.0 18551.5 13309.7 13483.9 13502.9 13550.9 13619.7 13669.5 13847.7 13975.4 14035.8 14049.4 18:18:09 INFO - PID 29829 | -------- Summary: end -------- 18:18:09 INFO - PID 29829 | 18:18:09 INFO - TEST-INFO | 29829: exit 0 18:18:09 INFO - TEST-OK | dromaeo_css | took 1111676ms 18:18:09 INFO - TEST-START | kraken 18:18:09 INFO - Initialising browser for kraken test... 18:18:09 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:58436/getInfo.html -profile /tmp/tmp47nG7M/profile 18:18:09 INFO - TEST-INFO | started process 30210 (/builds/slave/test/build/application/firefox/firefox http://localhost:58436/getInfo.html) 18:18:15 INFO - TEST-INFO | 30210: exit 0 18:18:15 INFO - Browser initialized. 18:18:15 INFO - Running cycle 1/1 for kraken test... 18:18:15 INFO - Using env: {'DISPLAY': ':0', 18:18:15 INFO - 'HOME': '/home/cltbld', 18:18:15 INFO - 'JSGC_DISABLE_POISONING': '1', 18:18:15 INFO - 'LANG': 'en_US.UTF-8', 18:18:15 INFO - 'LANGUAGE': 'en_US:en', 18:18:15 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 18:18:15 INFO - 'LOGNAME': 'cltbld', 18:18:15 INFO - 'MAIL': '/var/mail/cltbld', 18:18:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:18:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:18:15 INFO - 'MOZ_CRASHREPORTER': '1', 18:18:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:18:15 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 18:18:15 INFO - 'MOZ_NO_REMOTE': '1', 18:18:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:18:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:18:15 INFO - 'NO_EM_RESTART': '1', 18:18:15 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:18:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:18:15 INFO - 'PWD': '/builds/slave/test', 18:18:15 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:18:15 INFO - 'RUST_BACKTRACE': 'full', 18:18:15 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 18:18:15 INFO - 'SHELL': '/bin/bash', 18:18:15 INFO - 'SHLVL': '1', 18:18:15 INFO - 'STYLO_FORCE_ENABLED': '1', 18:18:15 INFO - 'STYLO_THREADS': '1', 18:18:15 INFO - 'TERM': 'linux', 18:18:15 INFO - 'TMOUT': '86400', 18:18:15 INFO - 'USER': 'cltbld', 18:18:15 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1504141101.159818-903536102', 18:18:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:18:15 INFO - '_': '/tools/buildbot/bin/python'} 18:18:15 INFO - TEST-INFO | started process 30398 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp47nG7M/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 18:18:16 INFO - PID 30398 | 18:18:16 INFO - PID 30398 | (/builds/slave/test/build/application/firefox/firefox:30449): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 18:18:16 INFO - PID 30398 | 18:18:27 INFO - PID 30398 | RSS: Main: 167436288 18:18:27 INFO - PID 30398 | 18:18:29 INFO - PID 30398 | Cycle 1(1): loaded http://localhost:58436/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58436/tests/kraken/driver.html?testName=audio-beat-detection) 18:18:30 INFO - PID 30398 | RSS: Main: 172146688 18:18:30 INFO - PID 30398 | 18:18:33 INFO - PID 30398 | Cycle 1(1): loaded http://localhost:58436/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58436/tests/kraken/driver.html?testName=audio-dft) 18:18:34 INFO - PID 30398 | RSS: Main: 172974080 18:18:34 INFO - PID 30398 | 18:18:36 INFO - PID 30398 | Cycle 1(1): loaded http://localhost:58436/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58436/tests/kraken/driver.html?testName=audio-fft) 18:18:37 INFO - PID 30398 | RSS: Main: 167653376 18:18:37 INFO - PID 30398 | 18:18:39 INFO - PID 30398 | Cycle 1(1): loaded http://localhost:58436/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58436/tests/kraken/driver.html?testName=audio-oscillator) 18:18:40 INFO - PID 30398 | RSS: Main: 168415232 18:18:40 INFO - PID 30398 | 18:18:42 INFO - PID 30398 | Cycle 1(1): loaded http://localhost:58436/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58436/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:18:43 INFO - PID 30398 | RSS: Main: 168738816 18:18:43 INFO - PID 30398 | 18:18:46 INFO - PID 30398 | Cycle 1(1): loaded http://localhost:58436/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58436/tests/kraken/driver.html?testName=imaging-darkroom) 18:18:46 INFO - PID 30398 | RSS: Main: 171417600 18:18:46 INFO - PID 30398 | 18:18:50 INFO - PID 30398 | Cycle 1(1): loaded http://localhost:58436/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58436/tests/kraken/driver.html?testName=imaging-desaturate) 18:18:50 INFO - PID 30398 | RSS: Main: 171036672 18:18:50 INFO - PID 30398 | 18:18:53 INFO - PID 30398 | Cycle 1(1): loaded http://localhost:58436/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58436/tests/kraken/driver.html?testName=json-parse-financial) 18:18:54 INFO - PID 30398 | RSS: Main: 171356160 18:18:54 INFO - PID 30398 | 18:18:56 INFO - PID 30398 | Cycle 1(1): loaded http://localhost:58436/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58436/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:18:56 INFO - PID 30398 | RSS: Main: 170950656 18:18:56 INFO - PID 30398 | 18:18:58 INFO - PID 30398 | Cycle 1(1): loaded http://localhost:58436/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58436/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:18:59 INFO - PID 30398 | RSS: Main: 170864640 18:18:59 INFO - PID 30398 | 18:19:01 INFO - PID 30398 | Cycle 1(1): loaded http://localhost:58436/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58436/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:19:01 INFO - PID 30398 | RSS: Main: 171016192 18:19:01 INFO - PID 30398 | 18:19:04 INFO - PID 30398 | Cycle 1(1): loaded http://localhost:58436/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58436/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:19:05 INFO - PID 30398 | RSS: Main: 171601920 18:19:05 INFO - PID 30398 | 18:19:08 INFO - PID 30398 | Cycle 1(1): loaded http://localhost:58436/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58436/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:19:08 INFO - PID 30398 | RSS: Main: 171335680 18:19:08 INFO - PID 30398 | 18:19:10 INFO - PID 30398 | Cycle 1(1): loaded http://localhost:58436/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58436/tests/kraken/driver.html?testName=ai-astar) 18:19:10 INFO - PID 30398 | RSS: Main: 173346816 18:19:10 INFO - PID 30398 | 18:19:10 INFO - PID 30398 | __start_tp_report 18:19:10 INFO - PID 30398 | _x_x_mozilla_page_load 18:19:10 INFO - PID 30398 | _x_x_mozilla_page_load_details 18:19:10 INFO - PID 30398 | |i|pagename|runs| 18:19:10 INFO - PID 30398 | |0;ai-astar;100;108;101;108;109;120;108;99;109;109 18:19:10 INFO - PID 30398 | |1;audio-beat-detection;148;115;139;176;117;147;142;118;176;118 18:19:10 INFO - PID 30398 | |2;audio-dft;164;164;162;164;164;163;165;165;177;165 18:19:10 INFO - PID 30398 | |3;audio-fft;75;73;74;176;76;73;73;86;97;77 18:19:10 INFO - PID 30398 | |4;audio-oscillator;78;79;124;78;78;79;141;79;78;131 18:19:10 INFO - PID 30398 | |5;imaging-gaussian-blur;114;114;114;114;114;115;113;114;113;114 18:19:10 INFO - PID 30398 | |6;imaging-darkroom;149;150;148;148;148;150;149;148;149;148 18:19:10 INFO - PID 30398 | |7;imaging-desaturate;95;94;94;94;95;101;95;94;94;94 18:19:10 INFO - PID 30398 | |8;json-parse-financial;53;52;53;53;54;53;52;52;52;54 18:19:10 INFO - PID 30398 | |9;json-stringify-tinderbox;39;38;38;39;38;38;39;39;39;39 18:19:10 INFO - PID 30398 | |10;stanford-crypto-aes;94;77;75;76;75;78;74;73;77;78 18:19:10 INFO - PID 30398 | |11;stanford-crypto-ccm;130;120;127;124;129;122;129;120;123;166 18:19:10 INFO - PID 30398 | |12;stanford-crypto-pbkdf2;180;173;181;168;174;171;169;167;169;174 18:19:10 INFO - PID 30398 | |13;stanford-crypto-sha256-iterative;67;66;65;65;66;66;64;69;66;66 18:19:10 INFO - PID 30398 | __end_tp_report 18:19:10 INFO - PID 30398 | __start_cc_report 18:19:10 INFO - PID 30398 | _x_x_mozilla_cycle_collect,913 18:19:10 INFO - PID 30398 | __end_cc_report 18:19:10 INFO - PID 30398 | __startTimestamp1504142350814__endTimestamp 18:19:10 INFO - PID 30398 | 18:19:10 INFO - PID 30398 | ------- Summary: start ------- 18:19:10 INFO - PID 30398 | Number of tests: 14 18:19:10 INFO - PID 30398 | 18:19:10 INFO - PID 30398 | [#0] ai-astar Cycles:10 Average:107.10 Median:109.00 stddev:6.08 (5.6%) stddev-sans-first:5.88 18:19:10 INFO - PID 30398 | Values: 100.0 108.0 101.0 108.0 109.0 120.0 108.0 99.0 109.0 109.0 18:19:10 INFO - PID 30398 | 18:19:10 INFO - PID 30398 | [#1] audio-beat-detection Cycles:10 Average:139.60 Median:144.50 stddev:23.17 (16.0%) stddev-sans-first:24.37 18:19:10 INFO - PID 30398 | Values: 148.0 115.0 139.0 176.0 117.0 147.0 142.0 118.0 176.0 118.0 18:19:10 INFO - PID 30398 | 18:19:10 INFO - PID 30398 | [#2] audio-dft Cycles:10 Average:165.30 Median:164.50 stddev:4.22 (2.6%) stddev-sans-first:4.45 18:19:10 INFO - PID 30398 | Values: 164.0 164.0 162.0 164.0 164.0 163.0 165.0 165.0 177.0 165.0 18:19:10 INFO - PID 30398 | 18:19:10 INFO - PID 30398 | [#3] audio-fft Cycles:10 Average:88.00 Median:75.50 stddev:31.86 (42.2%) stddev-sans-first:33.44 18:19:10 INFO - PID 30398 | Values: 75.0 73.0 74.0 176.0 76.0 73.0 73.0 86.0 97.0 77.0 18:19:10 INFO - PID 30398 | 18:19:10 INFO - PID 30398 | [#4] audio-oscillator Cycles:10 Average:94.50 Median:78.00 stddev:26.19 (33.6%) stddev-sans-first:27.09 18:19:10 INFO - PID 30398 | Values: 78.0 79.0 124.0 78.0 78.0 79.0 141.0 79.0 78.0 131.0 18:19:10 INFO - PID 30398 | 18:19:10 INFO - PID 30398 | [#5] imaging-gaussian-blur Cycles:10 Average:113.90 Median:114.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 18:19:10 INFO - PID 30398 | Values: 114.0 114.0 114.0 114.0 114.0 115.0 113.0 114.0 113.0 114.0 18:19:10 INFO - PID 30398 | 18:19:10 INFO - PID 30398 | [#6] imaging-darkroom Cycles:10 Average:148.70 Median:149.00 stddev:0.82 (0.6%) stddev-sans-first:0.87 18:19:10 INFO - PID 30398 | Values: 149.0 150.0 148.0 148.0 148.0 150.0 149.0 148.0 149.0 148.0 18:19:10 INFO - PID 30398 | 18:19:10 INFO - PID 30398 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:94.00 stddev:2.16 (2.3%) stddev-sans-first:2.29 18:19:10 INFO - PID 30398 | Values: 95.0 94.0 94.0 94.0 95.0 101.0 95.0 94.0 94.0 94.0 18:19:10 INFO - PID 30398 | 18:19:10 INFO - PID 30398 | [#8] json-parse-financial Cycles:10 Average:52.80 Median:53.00 stddev:0.79 (1.5%) stddev-sans-first:0.83 18:19:10 INFO - PID 30398 | Values: 53.0 52.0 53.0 53.0 54.0 53.0 52.0 52.0 52.0 54.0 18:19:10 INFO - PID 30398 | 18:19:10 INFO - PID 30398 | [#9] json-stringify-tinderbox Cycles:10 Average:38.60 Median:39.00 stddev:0.52 (1.3%) stddev-sans-first:0.53 18:19:10 INFO - PID 30398 | Values: 39.0 38.0 38.0 39.0 38.0 38.0 39.0 39.0 39.0 39.0 18:19:10 INFO - PID 30398 | 18:19:10 INFO - PID 30398 | [#10] stanford-crypto-aes Cycles:10 Average:77.70 Median:77.00 stddev:5.96 (7.7%) stddev-sans-first:1.76 18:19:10 INFO - PID 30398 | Values: 94.0 77.0 75.0 76.0 75.0 78.0 74.0 73.0 77.0 78.0 18:19:10 INFO - PID 30398 | 18:19:10 INFO - PID 30398 | [#11] stanford-crypto-ccm Cycles:10 Average:129.00 Median:128.00 stddev:13.52 (10.6%) stddev-sans-first:14.34 18:19:10 INFO - PID 30398 | Values: 130.0 120.0 127.0 124.0 129.0 122.0 129.0 120.0 123.0 166.0 18:19:10 INFO - PID 30398 | 18:19:10 INFO - PID 30398 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.60 Median:173.50 stddev:4.84 (2.8%) stddev-sans-first:4.32 18:19:10 INFO - PID 30398 | Values: 180.0 173.0 181.0 168.0 174.0 171.0 169.0 167.0 169.0 174.0 18:19:10 INFO - PID 30398 | 18:19:10 INFO - PID 30398 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.00 Median:66.00 stddev:1.33 (2.0%) stddev-sans-first:1.36 18:19:10 INFO - PID 30398 | Values: 67.0 66.0 65.0 65.0 66.0 66.0 64.0 69.0 66.0 66.0 18:19:10 INFO - PID 30398 | -------- Summary: end -------- 18:19:10 INFO - PID 30398 | 18:19:11 INFO - PID 30398 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 18:19:11 INFO - TEST-INFO | 30398: exit 0 18:19:11 INFO - TEST-OK | kraken | took 61784ms 18:19:11 INFO - SUITE-END | took 1173s 18:19:11 INFO - Completed test suite (00:19:33) 18:19:11 INFO - javascript benchmark 18:19:11 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8691.228529227299, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3323.3685599736064, 3363.7140843028374, 3364.1421437533427, 3374.5106959490868, 3404.4723067924465, 6246.344133865947, 6280.780172693957, 6334.271558770743, 6407.359264073591, 6417.0, 6333.366663333676, 6369.617822930616, 6378.234611846573, 6439.323870993549, 6488.124103246072, 5664.54683625309, 5805.867855768127, 5859.209006784094, 5888.440598143169, 5910.645361278315, 5734.225879506276, 5796.101604251347, 5900.793472228473, 5902.291724992985, 5904.645721256717, 5775.3358363788075, 5879.559033072515, 5880.441358070976, 5901.970490147522, 5902.173695682608, 5776.075827867521, 5788.392218817005, 5819.79630712923, 5829.358770535237, 5831.562632802556, 5594.692291923942, 5679.886402271973, 5738.971305143489, 5744.971275143597, 5749.223854779635, 6282.905756413657, 6328.588641738318, 6349.4602958748565, 6352.587081839665, 6371.203599550056, 6642.5350225484235, 6722.798316050526, 6827.317268273133, 6832.419244364235, 6844.555103918229, 6562.573432726857, 6698.765543205965, 6707.463402927754, 6790.830229244309, 6909.689063992082, 6197.1324014637985, 6211.472024877846, 6222.160008398853, 6239.625622462667, 6242.625442473466, 6775.796726098127, 6832.624205668736, 6833.965830170818, 6845.5550389224545, 6875.0718652982205, 6548.0, 6548.410643042149, 6550.312217217219, 6557.803265902031, 6574.737010519526, 6644.103046088716, 6652.667366631746, 6655.833604159838, 6674.933250667528, 6743.730250789913, 6750.1224840771365, 6778.051072849805, 6791.694373753193, 6795.864082718417, 6806.0, 6745.392914637608, 6746.595204287759, 6779.898301525481, 6830.351116643911, 6830.658467076626, 5190.117679994334, 5237.9476205238225, 5247.370315562081, 5301.575873930076, 5325.254464374991, 4676.976615116902, 4685.554872287127, 4799.544043315879, 4828.37231159954, 4834.299026641117, 5862.560307976833, 5893.675847828411, 5921.348651648315, 5941.376155503696, 5950.256217972754, 6666.100076489709, 6848.075509806212, 6929.099217101845, 6931.0, 6935.098437203132, 5706.572007099484, 5718.1136923776885, 5722.284714410699, 5723.3418156912485, 5729.0260655688635, 5687.090065589486, 5709.0, 5732.369439361667, 5807.361190269067, 5902.8819423611285, 6570.145881035435, 6624.205095388488, 6626.86746265072, 6627.204735431779, 6657.933420665829, 6722.5966442014615, 6731.966340168464, 6824.761133360308, 6831.760888368884, 6839.863202736017, 6604.867902642017, 6609.239937407067, 6613.834654133492, 6631.303713110054, 6707.3292670732535, 6437.549371543947, 6627.635480048643, 6647.966760166169, 6655.700493477708, 6713.12729345182, 6714.328567143247, 6726.192856857208, 6732.192136943598, 6734.259231484435, 6743.865122697617, 6420.357964203542, 6503.25212600557, 6509.674516274073, 6515.02274658805, 6517.348265173445, 5650.3219613646625, 6457.838554036187, 6487.708053137526, 6496.512761542808, 6507.316731743288, 6579.440747536321, 6592.044153597797, 6634.0, 6654.5341826073645, 6662.966685166543, 6597.0764093026055, 6678.3989440950545, 6767.25560188369, 6770.255271920183, 6780.355866192704, 6219.813405597839, 6274.592151510137, 6300.0234963580715, 6314.084457753692, 6314.431701146918], "value": 6161.1559396181865, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [765.7358211417063, 847.8219573889482, 883.4964070479828, 1124.25798972678, 1138.3397629374963, 28237.152885413445, 39831.0, 40690.18619627606, 40828.59171408285, 40853.59146408535, 40575.18849623006, 40951.0, 41062.38406423906, 41065.58934410655, 41115.58884411155, 7279.781606551812, 7557.848843023136, 7913.129555748863, 7924.247196516321, 7929.722459713911, 7756.534607923514, 7842.72550460734, 7850.921490785105, 7853.921460785405, 7856.803579910491, 7786.7663970080985, 7863.488873223222, 7869.134395216522, 7880.330171935392, 7902.841943161134, 7777.611119444034, 7881.2118788121015, 7882.56645884479, 7886.64510097047, 7888.2506161914525, 7643.273888980538, 7710.653020614086, 7730.922690773076, 7755.573443460607, 7766.262205090507, 36915.0, 37670.623293766985, 37698.24603507942, 37714.0, 37735.05662358463, 3533.752637315389, 3575.6424357564297, 3580.2839432113683, 3587.6232995535356, 3591.28174365128, 30518.389632207454, 30640.08079757611, 30713.846430767702, 30743.38513229745, 30793.538096928565, 4978.775955081994, 5137.0496458154985, 5163.561097306733, 5187.792488300502, 5202.661826981234, 186105.0, 186886.0, 187920.0, 187929.0, 188654.0, 46539.30191047137, 46787.0, 46879.76560117178, 46959.765201173774, 46982.29526557105, 49078.5092149074, 49275.75362123166, 49313.75343123262, 49331.75334123307, 49337.50662493401, 12940.611781646565, 15264.542063738105, 15918.9204053979, 15927.203639817963, 15938.521844344688, 10782.08352290064, 10871.402072886067, 12297.385130743427, 12521.123521353418, 12563.811542826865, 13593.184408935496, 13707.657308567366, 13753.587392378246, 13825.340959084773, 13959.0, 5663.546916246691, 5724.914126288109, 5806.767729290781, 5821.825345239649, 5836.533077353802, 1009.8182327181031, 1017.1760873692185, 1035.570238351091, 1042.3849928542197, 1052.5894900988621, 22435.439114021952, 22962.31113066611, 23002.19492317761, 23011.0, 23419.10096108289, 1140.1562843495753, 1141.14414189358, 1143.2111842828422, 1148.2134737704698, 1156.5836298932377, 11817.645470635895, 12094.879051209375, 12146.0, 12179.269243845398, 12180.81728774069, 229347.0, 229895.0, 230280.0, 230848.0, 231355.0, 51211.487885121416, 51378.22932656013, 51404.74297628488, 51420.48579514232, 51492.0, 1439.5969128643997, 1468.3465857693225, 1477.0325436838887, 1479.5931118942162, 1482.636753995278, 22180.778192217873, 22346.21788237404, 22489.32532024042, 22599.887000565548, 23050.07799688061, 33619.3276134471, 36549.63450365569, 36641.267174655826, 36654.26691466209, 36693.44959825658, 202206.0, 202782.0, 202839.0, 203321.0, 203357.0, 29857.85071074631, 30346.84826575853, 30551.694483055773, 32941.67058329482, 33144.66855331416, 42726.359104612835, 42842.57157428386, 42949.0, 42961.140777184904, 42979.570204298805, 31704.841475792473, 31842.203944900637, 31855.36289274248, 31894.840525797223, 32549.34901302008, 31008.379832403676, 31543.0, 31814.363712726077, 31846.522302165024, 32293.35413291768, 35038.82480587581, 35308.29383412369, 35511.28977420489, 35582.11044723903, 35943.28113437769, 30264.243393915327, 30413.543796842623, 30456.695433046272, 30855.0, 31016.53475197919, 23126.0, 23284.3014709559, 23465.0, 24122.87938560366, 24961.0], "value": 16969.9201308978, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [565.4543365652147, 573.1287346812654, 573.7446836157906, 576.5186069631857, 590.7814108779752, 21420.25029123981, 22126.88936555319, 22347.329580112582, 22365.54623949444, 22390.776092239073, 24822.379440513952, 25700.742992570067, 25708.357291067685, 25753.74246257537, 25802.612960805604, 6331.050342448647, 6474.1907261592305, 6474.838129046788, 6486.902696459533, 6491.156149700556, 6365.204349456318, 6415.326390728977, 6725.966370168142, 7060.7881763547175, 7066.7173313067415, 7044.366007059363, 7048.330408611174, 7050.259722729116, 7054.611996340199, 7055.435565154801, 6966.79099627012, 7033.296670332977, 7035.331643493885, 7037.0, 7043.788686339418, 6890.0, 6897.896531552031, 6902.068220790179, 6910.827229319257, 6947.617881016542, 30518.847405763052, 30720.53919191214, 30960.380792384025, 31212.0, 31243.37513249722, 2114.3973967419365, 2153.6231159547174, 2154.084514081525, 2156.299202759094, 2157.6547752359547, 20501.58996820055, 21030.474238144016, 21089.15643374263, 21111.261105861373, 21127.683084753586, 2415.541047201044, 2459.7909177719916, 2525.595904655265, 2617.973820261811, 2625.1599488163797, 140759.0, 144035.0, 144273.0, 144585.277073615, 144610.0, 19761.604767904562, 21599.784002160093, 21827.12691492354, 21917.23289684885, 22468.95558799399, 43038.569614304084, 43100.78449607732, 43183.0, 43194.7840260803, 43201.78399108047, 11377.943110284396, 11441.37072461006, 11482.48328825205, 11538.826917596243, 11634.127440442, 9607.13535781769, 9645.614175433044, 9652.855207171899, 9702.563384647709, 9795.216382689368, 9331.440113593206, 10847.837282440769, 11511.942440287745, 11514.712132196762, 11618.186726929034, 4380.802863871133, 4384.145091707086, 4418.270985287456, 4489.910201795946, 4493.550644935545, 979.2019504104132, 984.3995162950595, 1000.9599616015423, 1005.1255407795119, 1009.2682804966487, 19307.324243651405, 20256.392308230777, 20324.491887702927, 20440.080196391198, 20448.693269600968, 1055.1400608504046, 1056.1128651932413, 1061.639042725477, 1070.3952266969138, 1073.3774410841693, 10810.459477026274, 11180.93781090795, 11391.601293954673, 13183.472661093641, 13820.170789752647, 530033.0, 540156.0, 541114.0, 542013.0, 549490.0, 121328.39335803442, 123050.0, 125520.67484448252, 125863.370683146, 127802.36098819446, 1225.3199474291675, 1229.2562999385243, 1273.3060482037313, 1273.541525050981, 1284.2037936479255, 21225.15099396007, 21327.253546125812, 21427.89286053622, 21617.567648647255, 21824.454388639777, 59847.0, 61035.0, 61318.0, 61770.073448897405, 62356.0, 73314.0, 75172.62413687896, 75576.24423755692, 75741.0, 76039.61980190064, 11745.0, 11943.343116128348, 12759.106862519906, 14369.209693466542, 14622.0, 22883.65674514917, 22900.4274893129, 23025.0, 23217.3034808956, 23287.53424931458, 18394.172262247965, 18413.0, 18430.81569184291, 18593.90703046476, 18644.34744783926, 16660.833391666412, 16687.833121668627, 17111.65776684484, 17259.827401725823, 17397.130143492523, 18694.813051869853, 18730.625387492448, 19076.42770716881, 19086.33197838069, 19143.138558765168, 14304.141751494944, 14435.0, 14436.206008669624, 14511.927440363153, 14533.491327803898, 18257.178426971084, 18589.0, 18642.906785465984, 18706.719399208752, 18949.90525047421], "value": 13007.972530297311, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1330.9933450332746, 1384.1971656439266, 1395.7487652222599, 1397.664560505479, 1405.0726520496469, 14879.0, 15262.465813696523, 15470.0, 15475.922620386897, 15514.922425387856, 15850.128242946634, 16058.27737751801, 16064.0, 16089.275982580783, 16144.354225830954, 2812.3531587734783, 2858.8713507892194, 2860.4994126027964, 2860.8998685046026, 2864.341201523651, 2630.289821748127, 2765.903193388232, 2826.1662809471254, 2833.504136776056, 2835.9291017724518, 2829.038127036807, 2835.4896118698625, 2854.1865568313033, 2858.771298296131, 2862.041216192578, 2688.0591792872438, 2717.062613398374, 2730.0, 2737.3567211705235, 2737.8083534152615, 2773.597828314883, 2792.8463934483593, 2799.3981294021883, 2801.7338352856445, 2804.383035732136, 15072.623184420478, 15373.0, 15381.538553843402, 15396.615084622863, 15405.3837846486, 8099.635516401776, 8421.536815475147, 8427.536485493296, 8429.915700842974, 8431.28334091603, 5359.383670877821, 5583.553315734772, 5628.493435590816, 5644.887102257973, 5859.091840764689, 1935.341983725526, 1937.8062193780509, 1939.2630800295938, 1971.5071232191951, 1989.5424052467868, 26635.334116647045, 26665.333366665796, 26862.059827906123, 26909.0, 26932.865335673196, 7482.214367491444, 7525.586092764841, 7687.577183254863, 7820.960895195488, 7831.6475758591005, 17430.302787888595, 17539.649207015787, 17572.736408953875, 17580.47258582219, 17581.538584598165, 7945.364370850318, 8084.636191371403, 8088.595570221583, 8090.83818323642, 8110.594470276463, 7420.777376678709, 7481.663325150382, 7492.887606685904, 7556.0, 7564.9243507565325, 4555.407796986437, 5305.840824775186, 5436.0, 5466.207399926989, 5504.119340905516, 1462.6708990477057, 1547.396515359011, 1614.5237155039292, 1618.7410014397876, 1620.7649890765772, 881.1056777370974, 897.1118592593285, 901.4983421006759, 913.4793167894236, 913.6482454255026, 8484.32125429964, 8494.575271236414, 8516.105808889977, 8603.139686031347, 8623.655053797904, 1001.0540039662449, 1002.2683441088046, 1006.7885743993697, 1013.6350913671073, 1022.2639699416409, 4858.854234372904, 5002.549770520598, 5021.49785021495, 5036.974815125901, 5044.646874718735, 20380.184792608427, 20735.688964665544, 20755.0, 21429.46426339354, 22132.33602991913, 21197.576048478943, 22234.666480002812, 22257.66613500799, 22264.666030009565, 22283.665745013837, 10436.843447348296, 10845.13238940883, 11057.5024123913, 11080.778384432428, 11082.22424430282, 8603.397762156588, 8799.692010779849, 8863.822723545363, 8918.687845925362, 8990.0, 17177.227024784166, 17798.555036123682, 18200.726989095438, 18845.811541884406, 19133.0, 17352.739708904628, 17569.385071522436, 18070.0, 18279.36022239215, 18342.541436464195, 12099.33453660057, 12404.751904962031, 12405.937970310091, 12413.317267550372, 12434.751304973668, 13746.93126534361, 13998.860011399756, 14120.858791411954, 14122.082064665763, 14170.574882753534, 10922.399268040333, 11200.551977920792, 11733.120015998664, 11975.341356225492, 11995.280283183038, 10859.34843909368, 10909.454527273763, 11020.283681560673, 11200.38397888124, 11276.210665253353, 9501.667441639509, 9957.850632240377, 10002.44986525748, 10211.438370889375, 10325.586976521156, 7036.155661320674, 7119.786406407816, 7209.675564599501, 7238.6018768966105, 7259.092613423322, 7153.749618763526, 7188.353048225685, 7212.386947109554, 7226.674799633924, 7253.782386528413], "value": 6806.070350083105, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [501.2306110120963, 503.90929632666104, 529.9152135658294, 537.1459379586457, 539.5737367479692, 6353.269374021989, 6385.233771947367, 6387.498937749631, 6388.520860935437, 6392.78537077956, 6077.635341879491, 6195.597286176396, 6204.224471941007, 6252.436501034576, 6254.405831446017, 5048.899022019557, 5067.493250674921, 5068.695878247298, 5071.543561079502, 5079.212722028092, 4936.925946110811, 5000.4749501302385, 5007.0, 5052.6210534209895, 5067.822626208083, 4775.331453596499, 4923.507649235065, 4931.728754918478, 4948.8267910623135, 4978.427480839696, 4944.66494046609, 4966.0, 4972.5276098770555, 4997.450790255032, 5022.221555658879, 4419.381286619876, 4448.110377924428, 4457.885528617846, 4470.955290447087, 4472.172648060119, 6095.695215239265, 6176.660283684396, 6179.5056395488255, 6180.505559555269, 6230.813075607739, 5713.685957187346, 5733.0, 5743.54051675865, 5756.5682573807135, 5758.712064396764, 6535.673216339164, 6544.887369147256, 6585.407313341822, 6651.93348066518, 6662.300458451889, 4847.83032593861, 4853.524702401801, 4868.683535570177, 4887.3890763654545, 4889.535494128052, 6971.651417429108, 6987.755428559976, 6994.880819068924, 6995.790126296169, 7034.366906978396, 4995.400551933792, 5006.874828129326, 5048.510689346652, 5052.69683818972, 5064.442911279756, 5066.771995260222, 5073.365829271341, 5080.374280230365, 5090.185570308733, 5100.668456550312, 5670.092785154356, 5684.232628595087, 5689.260396148474, 5701.800436984686, 5730.455606717355, 6574.309697481791, 6584.7366105356205, 6622.2715501294815, 6672.766453174116, 6714.9664251679405, 1621.1407953784512, 1683.5370273174974, 1707.9060651664029, 1739.990805332929, 1743.1371471121622, 1158.6466127830925, 1198.2870192235605, 1202.2666173634077, 1228.6498347970785, 1235.5428491458217, 5672.7730890763905, 5714.171445140514, 5732.828015159552, 5788.18965344852, 5807.738651760681, 6498.54510184292, 6626.834329141713, 6670.0, 6717.294684058202, 6735.42748866342, 5769.567282453832, 5809.68847756783, 5822.883542329215, 5832.0, 5841.247625712269, 3495.0, 3495.2485215678753, 3519.1729943463265, 3589.587197472272, 3623.438367053111, 6461.483081353481, 6546.410823025951, 6560.179977502812, 6594.3735345143095, 6608.504362172856, 6954.965225173842, 6992.545484543489, 7004.964975175091, 7021.754238601625, 7080.220850925604, 6591.802245932629, 6624.377027628262, 6631.403173714389, 6678.332166783282, 6710.966445167743, 6882.931170688229, 6884.0, 6900.3444672756, 6926.965365173141, 6927.203371612329, 6753.189617245962, 6761.526693131434, 6839.965800170968, 6847.1783385994, 6881.3806757390075, 6605.47156227491, 6612.636305003271, 6642.634655094016, 6657.900131497934, 6688.6990085445295, 5022.924656130088, 5027.723475208899, 5036.874078148076, 5044.0, 5047.545720884991, 6815.318468153343, 6815.524082717949, 6890.139662291253, 6890.519413011211, 6948.5483443576, 6615.768448104293, 6638.50211234169, 6647.966760166169, 6649.933500665125, 6652.569697514864, 6631.270560238273, 6639.170103737033, 6645.60126392418, 6665.900011499734, 6675.299093595103, 6224.346443623354, 6269.717862696099, 6436.195475565554, 6447.161868957193, 6470.191226096738, 6434.356564343529, 6500.70746816385, 6504.447121994684, 6579.0, 6609.4712423005085, 6250.562460627712, 6306.810795676137, 6325.209348831396, 6351.237851457855, 6376.840578985562], "value": 5087.857060489002, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [910.3945875992464, 915.039208830728, 919.6137622198685, 928.2666693312286, 930.7114794413732, 18437.90781046093, 18734.437966860984, 19537.511562210933, 19567.923764192965, 19575.706364404545, 20256.493587660316, 21153.788462115375, 21155.15379384823, 21180.364589062352, 21352.039158237876, 982.4449186209769, 1003.9447830369327, 1011.7976404719049, 1012.0233974214881, 1012.7822518158595, 889.3418870036159, 987.4174237200051, 989.717930389839, 990.069334825262, 998.9450580218086, 1054.5939813171947, 1059.4702648675661, 1059.89930956559, 1062.5643486170673, 1064.632701717906, 1045.2160879340495, 1045.984310235347, 1048.4495639789095, 1051.1853313681959, 1054.7995880782664, 771.0939645916026, 773.4972268025772, 775.3719487215317, 775.4649291988567, 776.6466257852663, 19218.519537011547, 19306.0, 19640.50898727529, 19746.802531974783, 20113.39659810208, 20642.0, 20648.380548583566, 20776.27283045086, 21187.15251389958, 21209.46976325589, 16926.15369231546, 17384.304627814872, 17616.55958601045, 17621.64756704859, 17640.647187056315, 3781.2248489059953, 3807.390817469219, 3810.90472738181, 3818.198178382543, 3822.311983842907, 124722.37638811748, 127336.36331818374, 129747.35126324308, 130856.34571827175, 131865.0, 16350.672986540441, 16369.836301636831, 16536.173191340386, 16744.581385465463, 16768.413105541247, 29335.0, 29949.101526954226, 30025.249368765955, 30202.54696179559, 30325.848370758446, 7656.310932016146, 7995.600219988977, 8014.759557213293, 8787.912120878837, 8791.956040219759, 4402.3836662867225, 4539.523350048264, 4558.8632341029825, 4564.908701825945, 4567.862964111082, 5283.920741188886, 5295.761690723926, 5332.9466705333225, 5354.491323324278, 5373.919391209135, 1035.6323505155713, 1045.72288343589, 1054.319963623474, 1062.511244827388, 1066.317556763672, 604.2416766957529, 628.277480896963, 630.4200135874914, 634.6794868591425, 648.2059477140559, 11492.138089643311, 11630.76738465226, 11753.764924701458, 11881.524739010516, 11887.28676279426, 677.167084486075, 697.3828162076599, 697.8534507753428, 700.471144286071, 710.4458522352573, 5487.835364939058, 5501.944980550224, 5692.459216374521, 5859.94140058594, 5911.704414779244, 101053.0, 101541.49229253807, 103293.0, 106819.0, 107382.46308768562, 93782.0, 97816.51091744496, 98074.0, 99135.0, 100607.49696251472, 84389.7805109742, 85731.99999999875, 89664.0, 90663.54668226617, 92534.0, 12174.634760957186, 12179.208351457128, 12214.206076605347, 12249.510019599473, 12262.325572093621, 40176.0, 42956.14087718166, 43326.350104749086, 43933.0, 44113.338299924886, 65905.68188636296, 66337.33662663311, 67914.0, 68525.31474685189, 68814.65592672005, 15521.689566208386, 16802.411915582896, 17193.91403042977, 17406.129693515526, 17825.10874456298, 17606.471805845846, 17708.734368984733, 19831.20675172977, 20039.29862454807, 20613.587728245053, 17545.0, 18098.366557170437, 18304.0, 18358.908205458887, 18486.0, 18569.53576160607, 18626.906865465586, 19518.414447566596, 19745.0, 20365.49086272855, 17235.22441490111, 17576.472705818847, 17846.643067138844, 18264.0, 18551.53621159482, 13309.733805324033, 13483.865161348262, 13502.864971350553, 13550.93224533871, 13619.659508512366, 13669.521566745116, 13847.65380865446, 13975.440982360999, 14035.789463158266, 14049.438022478986], "value": 9151.194766551826, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1488.7999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 108.0, 101.0, 108.0, 109.0, 120.0, 108.0, 99.0, 109.0, 109.0], "value": 107.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 115.0, 139.0, 176.0, 117.0, 147.0, 142.0, 118.0, 176.0, 118.0], "value": 139.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 164.0, 162.0, 164.0, 164.0, 163.0, 165.0, 165.0, 177.0, 165.0], "value": 165.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 73.0, 74.0, 176.0, 76.0, 73.0, 73.0, 86.0, 97.0, 77.0], "value": 88.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 79.0, 124.0, 78.0, 78.0, 79.0, 141.0, 79.0, 78.0, 131.0], "value": 94.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 114.0, 114.0, 115.0, 113.0, 114.0, 113.0, 114.0], "value": 113.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 150.0, 148.0, 148.0, 148.0, 150.0, 149.0, 148.0, 149.0, 148.0], "value": 148.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 94.0, 94.0, 95.0, 101.0, 95.0, 94.0, 94.0, 94.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 52.0, 53.0, 53.0, 54.0, 53.0, 52.0, 52.0, 52.0, 54.0], "value": 52.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [39.0, 38.0, 38.0, 39.0, 38.0, 38.0, 39.0, 39.0, 39.0, 39.0], "value": 38.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 77.0, 75.0, 76.0, 75.0, 78.0, 74.0, 73.0, 77.0, 78.0], "value": 77.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 120.0, 127.0, 124.0, 129.0, 122.0, 129.0, 120.0, 123.0, 166.0], "value": 129.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 173.0, 181.0, 168.0, 174.0, 171.0, 169.0, 167.0, 169.0, 174.0], "value": 172.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 65.0, 65.0, 66.0, 66.0, 64.0, 69.0, 66.0, 66.0], "value": 66.0, "unit": "score"}]}]} 18:19:12 INFO - Return code: 0 18:19:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:19:12 INFO - # TBPL SUCCESS # 18:19:12 INFO - Running post-action listener: _package_coverage_data 18:19:12 INFO - Running post-action listener: _resource_record_post_action 18:19:12 INFO - [mozharness: 2017-08-31 01:19:12.099923Z] Finished run-tests step (success) 18:19:12 INFO - Running post-run listener: _resource_record_post_run 18:19:12 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 12288; Write bytes: 395554816; Read time: 228; Write time: 353844 18:19:12 INFO - TinderboxPrint: CPU usage
13.1% 18:19:12 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 228 18:19:12 INFO - TinderboxPrint: I/O write bytes / time
395,554,816 / 353,844 18:19:12 INFO - TinderboxPrint: CPU idle
8,249.6 (86.9%) 18:19:12 INFO - TinderboxPrint: CPU user
1,193.6 (12.6%) 18:19:12 INFO - TinderboxPrint: Swap in / out
0 / 0 18:19:12 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 111202304; Read time: 0; Write time: 172056 18:19:12 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 18:19:12 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 12288; Write bytes: 284352512; Read time: 228; Write time: 181788 18:19:12 INFO - Running post-run listener: _upload_blobber_files 18:19:12 INFO - Blob upload gear active. 18:19:12 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:19:12 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 18:19:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:19:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:19:13 INFO - (blobuploader) - INFO - Open directory for files ... 18:19:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 18:19:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:19:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:19:14 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 18:19:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:19:14 INFO - (blobuploader) - INFO - Done attempting. 18:19:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:19:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:19:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:19:17 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:19:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:19:18 INFO - (blobuploader) - INFO - Done attempting. 18:19:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:19:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:19:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:19:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:19:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:19:18 INFO - (blobuploader) - INFO - Done attempting. 18:19:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:19:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:19:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:19:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:19:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:19:19 INFO - (blobuploader) - INFO - Done attempting. 18:19:19 INFO - (blobuploader) - INFO - Iteration through files over. 18:19:19 INFO - Return code: 0 18:19:19 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:19:19 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:19:19 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c2509c23d2e35c153830befcd9c858b309f8e4f72f59679edec84d9283a4843d9f8c1a89aa8b4bb92b04183963d2ea4ac285e5fab2612cf12842a8123d626620", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/09f787c96e55123312e1fe63416d53e5c166a2629f1ee1dcc48bca0517b4030c057296409f8c69358d0320fce4f0895f3a55de63d4bc905c6ef4bc85a810387b", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2f1376ecf51c2a33eb24bd376360766a5e5444e29f0107fb6b46c287a06b5dee866ae4764a910255cf2eacc89ca5edcca8d735e1658bc7269b8dc2eec643bef9", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3f43de703e5be4eb15469857acecf36a0b3cc7c19d278e66550e39170f5465dbdf364fff18934e6b39c46653b15be39390cafda2348d8757e8023e81dbf0a5ce"} 18:19:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:19:19 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:19:19 INFO - Contents: 18:19:19 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c2509c23d2e35c153830befcd9c858b309f8e4f72f59679edec84d9283a4843d9f8c1a89aa8b4bb92b04183963d2ea4ac285e5fab2612cf12842a8123d626620", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/09f787c96e55123312e1fe63416d53e5c166a2629f1ee1dcc48bca0517b4030c057296409f8c69358d0320fce4f0895f3a55de63d4bc905c6ef4bc85a810387b", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2f1376ecf51c2a33eb24bd376360766a5e5444e29f0107fb6b46c287a06b5dee866ae4764a910255cf2eacc89ca5edcca8d735e1658bc7269b8dc2eec643bef9", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3f43de703e5be4eb15469857acecf36a0b3cc7c19d278e66550e39170f5465dbdf364fff18934e6b39c46653b15be39390cafda2348d8757e8023e81dbf0a5ce"} 18:19:19 INFO - Running post-run listener: copy_logs_to_upload_dir 18:19:19 INFO - Copying logs to upload dir... 18:19:19 INFO - mkdir: /builds/slave/test/build/upload/logs 18:19:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1256.442312 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-08-30 18:19:20.036726) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-30 18:19:20.044428) ========= 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=745a4373a2a16df560f216e000000264-1504141101.159818-903536102 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c2509c23d2e35c153830befcd9c858b309f8e4f72f59679edec84d9283a4843d9f8c1a89aa8b4bb92b04183963d2ea4ac285e5fab2612cf12842a8123d626620", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/09f787c96e55123312e1fe63416d53e5c166a2629f1ee1dcc48bca0517b4030c057296409f8c69358d0320fce4f0895f3a55de63d4bc905c6ef4bc85a810387b", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2f1376ecf51c2a33eb24bd376360766a5e5444e29f0107fb6b46c287a06b5dee866ae4764a910255cf2eacc89ca5edcca8d735e1658bc7269b8dc2eec643bef9", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3f43de703e5be4eb15469857acecf36a0b3cc7c19d278e66550e39170f5465dbdf364fff18934e6b39c46653b15be39390cafda2348d8757e8023e81dbf0a5ce"} build_url:https://queue.taskcluster.net/v1/task/JjWT5fwtQZy7VNboNo6e0g/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011371 build_url: 'https://queue.taskcluster.net/v1/task/JjWT5fwtQZy7VNboNo6e0g/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c2509c23d2e35c153830befcd9c858b309f8e4f72f59679edec84d9283a4843d9f8c1a89aa8b4bb92b04183963d2ea4ac285e5fab2612cf12842a8123d626620", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/09f787c96e55123312e1fe63416d53e5c166a2629f1ee1dcc48bca0517b4030c057296409f8c69358d0320fce4f0895f3a55de63d4bc905c6ef4bc85a810387b", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2f1376ecf51c2a33eb24bd376360766a5e5444e29f0107fb6b46c287a06b5dee866ae4764a910255cf2eacc89ca5edcca8d735e1658bc7269b8dc2eec643bef9", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3f43de703e5be4eb15469857acecf36a0b3cc7c19d278e66550e39170f5465dbdf364fff18934e6b39c46653b15be39390cafda2348d8757e8023e81dbf0a5ce"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-30 18:19:20.073876) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-30 18:19:20.074214) ========= 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=745a4373a2a16df560f216e000000264-1504141101.159818-903536102 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004450 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-30 18:19:20.154076) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-30 18:19:20.154388) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-30 18:19:20.154689) ========= ========= Total master_lag: 0.19 =========