builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-043 starttime: 1504140909.83 results: success (0) revision: d9b405d82cffb07343a5f2fd941e029298c7f6c4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-30 17:55:09.825714) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-30 17:55:09.826165) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-30 17:55:09.826454) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-30 17:55:09.843770) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-30 17:55:09.844147) ========= 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=d2a8c569965ab8367867b893000001a1-1504140908.557164-1212356442 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-30 17:55:09-- 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.2M=0s 2017-08-30 17:55:10 (46.2 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.241686 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-30 17:55:10.117126) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-30 17:55:10.117451) ========= 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=d2a8c569965ab8367867b893000001a1-1504140908.557164-1212356442 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016066 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-30 17:55:10.166403) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-30 17:55:10.166742) ========= 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=d2a8c569965ab8367867b893000001a1-1504140908.557164-1212356442 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-30 17:55:10,198 truncating revision to first 12 chars 2017-08-30 17:55:10,198 Setting DEBUG logging. 2017-08-30 17:55:10,198 attempt 1/10 2017-08-30 17:55:10,198 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:55:10,737 unpacking tar archive at: mozilla-central-d9b405d82cff/testing/mozharness/ program finished with exit code 0 elapsedTime=0.873549 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-30 17:55:11.054457) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-30 17:55:11.054778) ========= script_repo_revision: d9b405d82cffb07343a5f2fd941e029298c7f6c4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-30 17:55:11.055150) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-30 17:55:11.055573) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-30 17:55:11.067681) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-08-30 17:55:11.068077) ========= /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=d2a8c569965ab8367867b893000001a1-1504140908.557164-1212356442 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:55:11 INFO - MultiFileLogger online at 20170830 17:55:11 in /builds/slave/test 17:55:11 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:55:11 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:55:11 INFO - {'append_to_log': False, 17:55:11 INFO - 'base_work_dir': '/builds/slave/test', 17:55:11 INFO - 'blob_upload_branch': 'Firefox', 17:55:11 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:55:11 INFO - 'branch': 'Firefox', 17:55:11 INFO - 'buildbot_json_path': 'buildprops.json', 17:55:11 INFO - 'code_coverage': False, 17:55:11 INFO - 'config_files': ('talos/linux_config.py',), 17:55:11 INFO - 'default_actions': ('clobber', 17:55:11 INFO - 'read-buildbot-config', 17:55:11 INFO - 'download-and-extract', 17:55:11 INFO - 'populate-webroot', 17:55:11 INFO - 'create-virtualenv', 17:55:11 INFO - 'install', 17:55:11 INFO - 'setup-mitmproxy', 17:55:11 INFO - 'run-tests'), 17:55:11 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:55:11 INFO - 'disable_ccov_upload': False, 17:55:11 INFO - 'disable_stylo': False, 17:55:11 INFO - 'download_minidump_stackwalk': True, 17:55:11 INFO - 'download_symbols': 'ondemand', 17:55:11 INFO - 'enable_stylo': False, 17:55:11 INFO - 'enable_webrender': False, 17:55:11 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 17:55:11 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:55:11 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:55:11 INFO - 'gecko_profile': False, 17:55:11 INFO - 'gecko_profile_interval': 0, 17:55:11 INFO - 'installer_path': 'installer.exe', 17:55:11 INFO - 'log_level': 'info', 17:55:11 INFO - 'log_name': 'talos', 17:55:11 INFO - 'log_to_console': True, 17:55:11 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:55:11 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:55:11 INFO - 'opt_config_files': (), 17:55:11 INFO - 'pip_index': False, 17:55:11 INFO - 'suite': 'dromaeojs-e10s', 17:55:11 INFO - 'system_bits': '32', 17:55:11 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:55:11 INFO - 'title': 'talos-linux64-ix-043', 17:55:11 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:55:11 INFO - 'use_talos_json': True, 17:55:11 INFO - 'verify': 'False', 17:55:11 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:55:11 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:55:11 INFO - 'work_dir': 'build'} 17:55:11 INFO - [mozharness: 2017-08-31 00:55:11.315648Z] Running clobber step. 17:55:11 INFO - Running pre-action listener: _resource_record_pre_action 17:55:11 INFO - Running main action method: clobber 17:55:11 INFO - rmtree: /builds/slave/test/build 17:55:11 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:55:12 INFO - Running post-action listener: _resource_record_post_action 17:55:12 INFO - [mozharness: 2017-08-31 00:55:12.286675Z] Finished clobber step (success) 17:55:12 INFO - [mozharness: 2017-08-31 00:55:12.286832Z] Running read-buildbot-config step. 17:55:12 INFO - Running pre-action listener: _resource_record_pre_action 17:55:12 INFO - Running main action method: read_buildbot_config 17:55:12 INFO - Using buildbot properties: 17:55:12 INFO - { 17:55:12 INFO - "project": "", 17:55:12 INFO - "product": "firefox", 17:55:12 INFO - "who": "kwierso@gmail.com", 17:55:12 INFO - "installer_path": "public/build/target.tar.bz2", 17:55:12 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 17:55:12 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 17:55:12 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 17:55:12 INFO - "stage_platform": "linux64-stylo", 17:55:12 INFO - "basedir": "/builds/slave/test", 17:55:12 INFO - "buildnumber": 287, 17:55:12 INFO - "platform": "ubuntu64_hw_stylo", 17:55:12 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 17:55:12 INFO - "slavebuilddir": "test", 17:55:12 INFO - "taskId": "MCA_7RwVTmikghBixlfrMQ", 17:55:12 INFO - "branch": "mozilla-central", 17:55:12 INFO - "script_repo_revision": "production", 17:55:12 INFO - "revision": "d9b405d82cffb07343a5f2fd941e029298c7f6c4", 17:55:12 INFO - "slavename": "talos-linux64-ix-043", 17:55:12 INFO - "repo_path": "mozilla-central" 17:55:12 INFO - } 17:55:12 INFO - Finding installer, test and symbols from parent task. 17:55:12 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MCA_7RwVTmikghBixlfrMQ'}, attempt #1 17:55:12 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MCA_7RwVTmikghBixlfrMQ'}, attempt #1 17:55:13 INFO - Task dependencies: JjWT5fwtQZy7VNboNo6e0g 17:55:13 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JjWT5fwtQZy7VNboNo6e0g'}, attempt #1 17:55:13 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/JjWT5fwtQZy7VNboNo6e0g/artifacts/public/build/target.tar.bz2 17:55:13 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/JjWT5fwtQZy7VNboNo6e0g/artifacts/public/build/target.test_packages.json 17:55:13 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/JjWT5fwtQZy7VNboNo6e0g/artifacts/public/build/target.crashreporter-symbols.zip 17:55:13 INFO - Running post-action listener: _resource_record_post_action 17:55:13 INFO - [mozharness: 2017-08-31 00:55:13.701900Z] Finished read-buildbot-config step (success) 17:55:13 INFO - [mozharness: 2017-08-31 00:55:13.702115Z] Running download-and-extract step. 17:55:13 INFO - Running pre-action listener: _resource_record_pre_action 17:55:13 INFO - Running main action method: download_and_extract 17:55:13 INFO - mkdir: /builds/slave/test/build/tests 17:55:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:55:13 INFO - trying https://queue.taskcluster.net/v1/task/JjWT5fwtQZy7VNboNo6e0g/artifacts/public/build/target.test_packages.json 17:55:13 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:55:13 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:55:14 INFO - Downloaded 989 bytes. 17:55:14 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 17:55:14 INFO - Using the following test package requirements: 17:55:14 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 17:55:14 INFO - u'common': [u'target.common.tests.zip'], 17:55:14 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 17:55:14 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 17:55:14 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 17:55:14 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 17:55:14 INFO - u'mozbase': [u'target.common.tests.zip'], 17:55:14 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 17:55:14 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 17:55:14 INFO - u'web-platform': [u'target.common.tests.zip', 17:55:14 INFO - u'target.web-platform.tests.tar.gz'], 17:55:14 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 17:55:14 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 17:55:14 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:55:14 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:55:14 INFO - Fetch https://queue.taskcluster.net/v1/task/JjWT5fwtQZy7VNboNo6e0g/artifacts/public/build/target.common.tests.zip into memory 17:55:15 INFO - Content-Length response header: 54962746 17:55:15 INFO - Bytes received: 54962746 17:55:26 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 17:55:26 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:55:26 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:55:26 INFO - Fetch https://queue.taskcluster.net/v1/task/JjWT5fwtQZy7VNboNo6e0g/artifacts/public/build/target.common.tests.zip into memory 17:55:27 INFO - Content-Length response header: 54962746 17:55:27 INFO - Bytes received: 54962746 17:55:40 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:55:40 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:55:40 INFO - Fetch https://queue.taskcluster.net/v1/task/JjWT5fwtQZy7VNboNo6e0g/artifacts/public/build/target.talos.tests.zip into memory 17:55:40 INFO - Content-Length response header: 14496650 17:55:40 INFO - Bytes received: 14496650 17:55:41 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:55:41 INFO - trying https://queue.taskcluster.net/v1/task/JjWT5fwtQZy7VNboNo6e0g/artifacts/public/build/target.tar.bz2 17:55:41 INFO - Downloading https://queue.taskcluster.net/v1/task/JjWT5fwtQZy7VNboNo6e0g/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 17:55:41 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:55:42 INFO - Downloaded 62519587 bytes. 17:55:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JjWT5fwtQZy7VNboNo6e0g/artifacts/public/build/target.tar.bz2 17:55:42 INFO - mkdir: /builds/slave/test/properties 17:55:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:55:42 INFO - Writing to file /builds/slave/test/properties/build_url 17:55:42 INFO - Contents: 17:55:42 INFO - build_url:https://queue.taskcluster.net/v1/task/JjWT5fwtQZy7VNboNo6e0g/artifacts/public/build/target.tar.bz2 17:55:42 INFO - Running post-action listener: _resource_record_post_action 17:55:42 INFO - Running post-action listener: find_tests_for_verification 17:55:42 INFO - Running post-action listener: set_extra_try_arguments 17:55:42 INFO - [mozharness: 2017-08-31 00:55:42.336056Z] Finished download-and-extract step (success) 17:55:42 INFO - [mozharness: 2017-08-31 00:55:42.336163Z] Running populate-webroot step. 17:55:42 INFO - Running pre-action listener: _resource_record_pre_action 17:55:42 INFO - Running main action method: populate_webroot 17:55:42 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:55:42 INFO - 'chromez-stylo-e10s': {'talos_options': ['--enable-stylo'], 17:55:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:55:42 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:55:42 INFO - 'dromaeojs-stylo-e10s': {'talos_options': ['--enable-stylo'], 17:55:42 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:55:42 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 17:55:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:55:42 INFO - 'g1-stylo-e10s': {'pagesets_name': 'tp5n.zip', 17:55:42 INFO - 'talos_options': ['--enable-stylo'], 17:55:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:55:42 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 17:55:42 INFO - 'tests': ['damp', 'tps']}, 17:55:42 INFO - 'g2-stylo-e10s': {'pagesets_name': 'tp5n.zip', 17:55:42 INFO - 'talos_options': ['--enable-stylo'], 17:55:42 INFO - 'tests': ['damp', 'tps']}, 17:55:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:55:42 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 17:55:42 INFO - 'g4-stylo-e10s': {'talos_options': ['--enable-stylo'], 17:55:42 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 17:55:42 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 17:55:42 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 17:55:42 INFO - 'g5-stylo-e10s': {'pagesets_name': 'tp5n.zip', 17:55:42 INFO - 'talos_options': ['--enable-stylo'], 17:55:42 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 17:55:42 INFO - 'other-e10s': {'tests': ['a11yr', 17:55:42 INFO - 'ts_paint', 17:55:42 INFO - 'tpaint', 17:55:42 INFO - 'sessionrestore', 17:55:42 INFO - 'sessionrestore_many_windows', 17:55:42 INFO - 'sessionrestore_no_auto_restore', 17:55:42 INFO - 'tabpaint']}, 17:55:42 INFO - 'other-stylo-e10s': {'talos_options': ['--enable-stylo'], 17:55:42 INFO - 'tests': ['a11yr', 17:55:42 INFO - 'ts_paint', 17:55:42 INFO - 'tpaint', 17:55:42 INFO - 'sessionrestore', 17:55:42 INFO - 'sessionrestore_many_windows', 17:55:42 INFO - 'sessionrestore_no_auto_restore', 17:55:42 INFO - 'tabpaint']}, 17:55:42 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 17:55:42 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 17:55:42 INFO - 'perf-reftest-singletons-stylo-e10s': {'talos_options': ['--enable-stylo'], 17:55:42 INFO - 'tests': ['bloom_basic_singleton']}, 17:55:42 INFO - 'perf-reftest-stylo-e10s': {'talos_options': ['--enable-stylo'], 17:55:42 INFO - 'tests': ['bloom_basic']}, 17:55:42 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:55:42 INFO - 'tsvgr_opacity', 17:55:42 INFO - 'tart', 17:55:42 INFO - 'tscrollx', 17:55:42 INFO - 'tsvg_static']}, 17:55:42 INFO - 'svgr-stylo-e10s': {'talos_options': ['--enable-stylo'], 17:55:42 INFO - 'tests': ['tsvgx', 17:55:42 INFO - 'tsvgr_opacity', 17:55:42 INFO - 'tart', 17:55:42 INFO - 'tscrollx', 17:55:42 INFO - 'tsvg_static']}, 17:55:42 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 17:55:42 INFO - 'tp5o-stylo-e10s': {'pagesets_name': 'tp5n.zip', 17:55:42 INFO - 'talos_options': ['--enable-stylo'], 17:55:42 INFO - 'tests': ['tp5o']}, 17:55:42 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:55:42 INFO - 'talos_options': ['--mitmproxy', 17:55:42 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:55:42 INFO - '--firstNonBlankPaint'], 17:55:42 INFO - 'tests': ['tp6_google', 17:55:42 INFO - 'tp6_youtube', 17:55:42 INFO - 'tp6_amazon', 17:55:42 INFO - 'tp6_facebook']}, 17:55:42 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:55:42 INFO - 'talos_options': ['--enable-stylo', 17:55:42 INFO - '--mitmproxy', 17:55:42 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:55:42 INFO - '--firstNonBlankPaint'], 17:55:42 INFO - 'tests': ['tp6_google', 17:55:42 INFO - 'tp6_youtube', 17:55:42 INFO - 'tp6_amazon', 17:55:42 INFO - 'tp6_facebook']}, 17:55:42 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:55:42 INFO - 'talos_options': ['--enable-stylo', 17:55:42 INFO - '--stylo-threads=1', 17:55:42 INFO - '--mitmproxy', 17:55:42 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:55:42 INFO - '--firstNonBlankPaint'], 17:55:42 INFO - 'tests': ['tp6_google', 17:55:42 INFO - 'tp6_youtube', 17:55:42 INFO - 'tp6_amazon', 17:55:42 INFO - 'tp6_facebook']}, 17:55:42 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 17:55:42 INFO - 'talos_options': ['--xperf_path', 17:55:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:55:42 INFO - 'tests': ['tp5n']}, 17:55:42 INFO - 'xperf-stylo-e10s': {'pagesets_name': 'tp5n.zip', 17:55:42 INFO - 'talos_options': ['--enable-stylo', 17:55:42 INFO - '--xperf_path', 17:55:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:55:42 INFO - 'tests': ['tp5n']}}} 17:55:42 INFO - Running post-action listener: _resource_record_post_action 17:55:42 INFO - [mozharness: 2017-08-31 00:55:42.351692Z] Finished populate-webroot step (success) 17:55:42 INFO - [mozharness: 2017-08-31 00:55:42.351791Z] Running create-virtualenv step. 17:55:42 INFO - Running pre-action listener: _resource_record_pre_action 17:55:42 INFO - Running main action method: create_virtualenv 17:55:42 INFO - Creating virtualenv /builds/slave/test/build/venv 17:55:42 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 17:55:42 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 17:55:42 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 17:55:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:55:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:55:44 INFO - Installing distribute.............................................................................................................................................................................................done. 17:55:44 INFO - Installing pip...............done. 17:55:44 INFO - Return code: 0 17:55:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 17:55:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 17:55:44 INFO - Reading from file tmpfile_stdout 17:55:44 INFO - Output received: 17:55:44 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:55:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:55:44 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:55:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:55:44 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:55:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:55:44 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 0x101d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x138cb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1389580>, '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 0x138a480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x138a910>, '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': 'd2a8c569965ab8367867b893000001a1-1504140908.557164-1212356442', '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:55:44 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:55:44 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:55:44 INFO - Using env: {'DISPLAY': ':0', 17:55:44 INFO - 'HOME': '/home/cltbld', 17:55:44 INFO - 'LANG': 'en_US.UTF-8', 17:55:44 INFO - 'LANGUAGE': 'en_US:en', 17:55:44 INFO - 'LOGNAME': 'cltbld', 17:55:44 INFO - 'MAIL': '/var/mail/cltbld', 17:55:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:55:44 INFO - 'MOZ_NO_REMOTE': '1', 17:55:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:55:44 INFO - 'NO_EM_RESTART': '1', 17:55:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:55:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:55:44 INFO - 'PWD': '/builds/slave/test', 17:55:44 INFO - 'SHELL': '/bin/bash', 17:55:44 INFO - 'SHLVL': '1', 17:55:44 INFO - 'TERM': 'linux', 17:55:44 INFO - 'TMOUT': '86400', 17:55:44 INFO - 'USER': 'cltbld', 17:55:44 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1504140908.557164-1212356442', 17:55:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:55:44 INFO - '_': '/tools/buildbot/bin/python'} 17:55:45 INFO - Ignoring indexes: http://pypi.python.org/simple/ 17:55:45 INFO - Downloading/unpacking pip>=1.5 17:55:45 INFO - Running setup.py egg_info for package pip 17:55:45 INFO - warning: no files found matching 'pip/cacert.pem' 17:55:45 INFO - warning: no files found matching '*.html' under directory 'docs' 17:55:45 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 17:55:45 INFO - no previously-included directories found matching 'docs/_build/_sources' 17:55:45 INFO - Installing collected packages: pip 17:55:45 INFO - Found existing installation: pip 1.1 17:55:45 INFO - Uninstalling pip: 17:55:45 INFO - Successfully uninstalled pip 17:55:45 INFO - Running setup.py install for pip 17:55:45 INFO - warning: no files found matching 'pip/cacert.pem' 17:55:45 INFO - warning: no files found matching '*.html' under directory 'docs' 17:55:45 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 17:55:45 INFO - no previously-included directories found matching 'docs/_build/_sources' 17:55:45 INFO - Installing pip script to /builds/slave/test/build/venv/bin 17:55:45 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 17:55:45 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 17:55:45 INFO - Successfully installed pip 17:55:45 INFO - Cleaning up... 17:55:45 INFO - Return code: 0 17:55:45 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:55:45 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:55:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:55:45 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:55:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:55:45 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 0x101d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x138cb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1389580>, '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 0x138a480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x138a910>, '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': 'd2a8c569965ab8367867b893000001a1-1504140908.557164-1212356442', '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:55:45 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:55:45 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:55:45 INFO - Using env: {'DISPLAY': ':0', 17:55:45 INFO - 'HOME': '/home/cltbld', 17:55:45 INFO - 'LANG': 'en_US.UTF-8', 17:55:45 INFO - 'LANGUAGE': 'en_US:en', 17:55:45 INFO - 'LOGNAME': 'cltbld', 17:55:45 INFO - 'MAIL': '/var/mail/cltbld', 17:55:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:55:45 INFO - 'MOZ_NO_REMOTE': '1', 17:55:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:55:45 INFO - 'NO_EM_RESTART': '1', 17:55:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:55:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:55:45 INFO - 'PWD': '/builds/slave/test', 17:55:45 INFO - 'SHELL': '/bin/bash', 17:55:45 INFO - 'SHLVL': '1', 17:55:45 INFO - 'TERM': 'linux', 17:55:45 INFO - 'TMOUT': '86400', 17:55:45 INFO - 'USER': 'cltbld', 17:55:45 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1504140908.557164-1212356442', 17:55:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:55:45 INFO - '_': '/tools/buildbot/bin/python'} 17:55:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:55:46 INFO - Downloading/unpacking psutil>=3.1.1 17:55:46 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:55:46 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:55:46 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:55:46 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:55:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:55:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:55:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:55:47 INFO - Installing collected packages: psutil 17:55:47 INFO - Running setup.py install for psutil 17:55:47 INFO - building 'psutil._psutil_linux' extension 17:55:47 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:55:48 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:55:48 INFO - building 'psutil._psutil_posix' extension 17:55:48 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:55:48 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:55:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:55:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:55:48 INFO - Successfully installed psutil 17:55:48 INFO - Cleaning up... 17:55:48 INFO - Return code: 0 17:55:48 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:55:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:55:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:55:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:55:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:55:48 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 0x101d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x138cb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1389580>, '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 0x138a480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x138a910>, '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': 'd2a8c569965ab8367867b893000001a1-1504140908.557164-1212356442', '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:55:48 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:55:48 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:55:48 INFO - Using env: {'DISPLAY': ':0', 17:55:48 INFO - 'HOME': '/home/cltbld', 17:55:48 INFO - 'LANG': 'en_US.UTF-8', 17:55:48 INFO - 'LANGUAGE': 'en_US:en', 17:55:48 INFO - 'LOGNAME': 'cltbld', 17:55:48 INFO - 'MAIL': '/var/mail/cltbld', 17:55:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:55:48 INFO - 'MOZ_NO_REMOTE': '1', 17:55:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:55:48 INFO - 'NO_EM_RESTART': '1', 17:55:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:55:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:55:48 INFO - 'PWD': '/builds/slave/test', 17:55:48 INFO - 'SHELL': '/bin/bash', 17:55:48 INFO - 'SHLVL': '1', 17:55:48 INFO - 'TERM': 'linux', 17:55:48 INFO - 'TMOUT': '86400', 17:55:48 INFO - 'USER': 'cltbld', 17:55:48 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1504140908.557164-1212356442', 17:55:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:55:48 INFO - '_': '/tools/buildbot/bin/python'} 17:55:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:55:49 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:55:49 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:55:49 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:55:49 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:55:49 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:55:50 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:55:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:55:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:55:50 INFO - Installing collected packages: mozsystemmonitor 17:55:50 INFO - Running setup.py install for mozsystemmonitor 17:55:50 INFO - Successfully installed mozsystemmonitor 17:55:50 INFO - Cleaning up... 17:55:50 INFO - Return code: 0 17:55:50 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:55:50 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:55:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:55:50 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:55:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:55:50 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 0x101d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x138cb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1389580>, '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 0x138a480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x138a910>, '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': 'd2a8c569965ab8367867b893000001a1-1504140908.557164-1212356442', '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:55:50 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:55:50 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:55:50 INFO - Using env: {'DISPLAY': ':0', 17:55:50 INFO - 'HOME': '/home/cltbld', 17:55:50 INFO - 'LANG': 'en_US.UTF-8', 17:55:50 INFO - 'LANGUAGE': 'en_US:en', 17:55:50 INFO - 'LOGNAME': 'cltbld', 17:55:50 INFO - 'MAIL': '/var/mail/cltbld', 17:55:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:55:50 INFO - 'MOZ_NO_REMOTE': '1', 17:55:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:55:50 INFO - 'NO_EM_RESTART': '1', 17:55:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:55:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:55:50 INFO - 'PWD': '/builds/slave/test', 17:55:50 INFO - 'SHELL': '/bin/bash', 17:55:50 INFO - 'SHLVL': '1', 17:55:50 INFO - 'TERM': 'linux', 17:55:50 INFO - 'TMOUT': '86400', 17:55:50 INFO - 'USER': 'cltbld', 17:55:50 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1504140908.557164-1212356442', 17:55:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:55:50 INFO - '_': '/tools/buildbot/bin/python'} 17:55:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:55:50 INFO - Downloading/unpacking jsonschema==2.5.1 17:55:50 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:55:50 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:55:50 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:55:50 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:55:51 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:55:51 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:55:51 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:55:51 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:55:51 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:55:51 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:55:51 INFO - Downloading functools32-3.2.3-2.tar.gz 17:55:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:55:51 INFO - warning: no files found matching '*.txt' 17:55:51 INFO - no previously-included directories found matching 'build' 17:55:51 INFO - no previously-included directories found matching 'dist' 17:55:51 INFO - no previously-included directories found matching '.git*' 17:55:51 INFO - Installing collected packages: jsonschema, functools32 17:55:51 INFO - Running setup.py install for functools32 17:55:51 INFO - warning: no files found matching '*.txt' 17:55:51 INFO - no previously-included directories found matching 'build' 17:55:51 INFO - no previously-included directories found matching 'dist' 17:55:51 INFO - no previously-included directories found matching '.git*' 17:55:51 INFO - Successfully installed jsonschema functools32 17:55:51 INFO - Cleaning up... 17:55:51 INFO - Return code: 0 17:55:51 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:55:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:55:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:55:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:55:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:55:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x101d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x138cb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1389580>, '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 0x138a480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x138a910>, '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': 'd2a8c569965ab8367867b893000001a1-1504140908.557164-1212356442', '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:55:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 17:55:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 17:55:52 INFO - Using env: {'DISPLAY': ':0', 17:55:52 INFO - 'HOME': '/home/cltbld', 17:55:52 INFO - 'LANG': 'en_US.UTF-8', 17:55:52 INFO - 'LANGUAGE': 'en_US:en', 17:55:52 INFO - 'LOGNAME': 'cltbld', 17:55:52 INFO - 'MAIL': '/var/mail/cltbld', 17:55:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:55:52 INFO - 'MOZ_NO_REMOTE': '1', 17:55:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:55:52 INFO - 'NO_EM_RESTART': '1', 17:55:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:55:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:55:52 INFO - 'PWD': '/builds/slave/test', 17:55:52 INFO - 'SHELL': '/bin/bash', 17:55:52 INFO - 'SHLVL': '1', 17:55:52 INFO - 'TERM': 'linux', 17:55:52 INFO - 'TMOUT': '86400', 17:55:52 INFO - 'USER': 'cltbld', 17:55:52 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1504140908.557164-1212356442', 17:55:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:55:52 INFO - '_': '/tools/buildbot/bin/python'} 17:55:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:55:52 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:55:52 INFO - Cleaning up... 17:55:52 INFO - Return code: 0 17:55:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:55:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:55:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:55:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:55:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:55:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x101d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x138cb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1389580>, '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 0x138a480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x138a910>, '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': 'd2a8c569965ab8367867b893000001a1-1504140908.557164-1212356442', '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:55:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:55:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:55:52 INFO - Using env: {'DISPLAY': ':0', 17:55:52 INFO - 'HOME': '/home/cltbld', 17:55:52 INFO - 'LANG': 'en_US.UTF-8', 17:55:52 INFO - 'LANGUAGE': 'en_US:en', 17:55:52 INFO - 'LOGNAME': 'cltbld', 17:55:52 INFO - 'MAIL': '/var/mail/cltbld', 17:55:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:55:52 INFO - 'MOZ_NO_REMOTE': '1', 17:55:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:55:52 INFO - 'NO_EM_RESTART': '1', 17:55:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:55:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:55:52 INFO - 'PWD': '/builds/slave/test', 17:55:52 INFO - 'SHELL': '/bin/bash', 17:55:52 INFO - 'SHLVL': '1', 17:55:52 INFO - 'TERM': 'linux', 17:55:52 INFO - 'TMOUT': '86400', 17:55:52 INFO - 'USER': 'cltbld', 17:55:52 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1504140908.557164-1212356442', 17:55:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:55:52 INFO - '_': '/tools/buildbot/bin/python'} 17:55:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:55:52 INFO - Downloading/unpacking blobuploader==1.2.4 17:55:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:55:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:55:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:55:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:55:53 INFO - Downloading blobuploader-1.2.4.tar.gz 17:55:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:55:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:55:53 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:55:53 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:55:53 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:55:53 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:55:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:55:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:55:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:55:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:55:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:55:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:55:54 INFO - Downloading docopt-0.6.1.tar.gz 17:55:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:55:54 INFO - Installing collected packages: blobuploader, requests, docopt 17:55:54 INFO - Running setup.py install for blobuploader 17:55:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:55:54 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:55:54 INFO - Running setup.py install for requests 17:55:54 INFO - Running setup.py install for docopt 17:55:54 INFO - Successfully installed blobuploader requests docopt 17:55:54 INFO - Cleaning up... 17:55:54 INFO - Return code: 0 17:55:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:55:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:55:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:55:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:55:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:55:54 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 0x101d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x138cb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1389580>, '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 0x138a480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x138a910>, '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': 'd2a8c569965ab8367867b893000001a1-1504140908.557164-1212356442', '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:55:54 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:55:54 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:55:54 INFO - Using env: {'DISPLAY': ':0', 17:55:54 INFO - 'HOME': '/home/cltbld', 17:55:54 INFO - 'LANG': 'en_US.UTF-8', 17:55:54 INFO - 'LANGUAGE': 'en_US:en', 17:55:54 INFO - 'LOGNAME': 'cltbld', 17:55:54 INFO - 'MAIL': '/var/mail/cltbld', 17:55:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:55:54 INFO - 'MOZ_NO_REMOTE': '1', 17:55:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:55:54 INFO - 'NO_EM_RESTART': '1', 17:55:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:55:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:55:54 INFO - 'PWD': '/builds/slave/test', 17:55:54 INFO - 'SHELL': '/bin/bash', 17:55:54 INFO - 'SHLVL': '1', 17:55:54 INFO - 'TERM': 'linux', 17:55:54 INFO - 'TMOUT': '86400', 17:55:54 INFO - 'USER': 'cltbld', 17:55:54 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1504140908.557164-1212356442', 17:55:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:55:54 INFO - '_': '/tools/buildbot/bin/python'} 17:55:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:55:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:55:55 INFO - Running setup.py (path:/tmp/pip-_BDT_v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:55:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:55:55 INFO - Running setup.py (path:/tmp/pip-gLf2Ab-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:55:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:55:55 INFO - Running setup.py (path:/tmp/pip-x75T5d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:55:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:55:55 INFO - Running setup.py (path:/tmp/pip-QMX2Pr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:55:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:55:55 INFO - Running setup.py (path:/tmp/pip-sLeq8n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:55:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:55:55 INFO - Running setup.py (path:/tmp/pip-nA9QzX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:55:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:55:55 INFO - Running setup.py (path:/tmp/pip-umZ7JZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:55:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:55:55 INFO - Running setup.py (path:/tmp/pip-eZZ3nu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:55:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:55:55 INFO - Running setup.py (path:/tmp/pip-Yw7zks-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:55:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:55:55 INFO - Running setup.py (path:/tmp/pip-kIZuSG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:55:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:55:55 INFO - Running setup.py (path:/tmp/pip-gqD52Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:55:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:55:55 INFO - Running setup.py (path:/tmp/pip-e1uksk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:55:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:55:55 INFO - Running setup.py (path:/tmp/pip-YCmqdl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:55:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:55:56 INFO - Running setup.py (path:/tmp/pip-B49TGS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:55:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:55:56 INFO - Running setup.py (path:/tmp/pip-hfu2EW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:55:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:55:56 INFO - Running setup.py (path:/tmp/pip-Hlmz2y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:55:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:55:56 INFO - Running setup.py (path:/tmp/pip-CC1_T1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:55:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:55:56 INFO - Running setup.py install for manifestparser 17:55:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:55:56 INFO - Running setup.py install for mozcrash 17:55:56 INFO - Running setup.py install for mozdebug 17:55:56 INFO - Running setup.py install for mozdevice 17:55:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:55:56 INFO - Running setup.py install for mozfile 17:55:56 INFO - Running setup.py install for mozhttpd 17:55:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:55:56 INFO - Running setup.py install for mozinfo 17:55:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:55:57 INFO - Running setup.py install for mozInstall 17:55:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:55:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:55:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:55:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:55:57 INFO - Running setup.py install for mozleak 17:55:57 INFO - Running setup.py install for mozlog 17:55:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:55:57 INFO - Running setup.py install for moznetwork 17:55:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:55:57 INFO - Running setup.py install for mozprocess 17:55:57 INFO - Running setup.py install for mozprofile 17:55:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:55:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:55:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:55:57 INFO - Running setup.py install for mozrunner 17:55:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:55:57 INFO - Running setup.py install for mozscreenshot 17:55:57 INFO - Running setup.py install for moztest 17:55:57 INFO - Running setup.py install for mozversion 17:55:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:55:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:55:58 INFO - Cleaning up... 17:55:58 INFO - Return code: 0 17:55:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:55:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:55:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:55:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:55:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:55:58 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 0x101d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x138cb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1389580>, '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 0x138a480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x138a910>, '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': 'd2a8c569965ab8367867b893000001a1-1504140908.557164-1212356442', '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:55:58 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:55:58 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:55:58 INFO - Using env: {'DISPLAY': ':0', 17:55:58 INFO - 'HOME': '/home/cltbld', 17:55:58 INFO - 'LANG': 'en_US.UTF-8', 17:55:58 INFO - 'LANGUAGE': 'en_US:en', 17:55:58 INFO - 'LOGNAME': 'cltbld', 17:55:58 INFO - 'MAIL': '/var/mail/cltbld', 17:55:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:55:58 INFO - 'MOZ_NO_REMOTE': '1', 17:55:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:55:58 INFO - 'NO_EM_RESTART': '1', 17:55:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:55:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:55:58 INFO - 'PWD': '/builds/slave/test', 17:55:58 INFO - 'SHELL': '/bin/bash', 17:55:58 INFO - 'SHLVL': '1', 17:55:58 INFO - 'TERM': 'linux', 17:55:58 INFO - 'TMOUT': '86400', 17:55:58 INFO - 'USER': 'cltbld', 17:55:58 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1504140908.557164-1212356442', 17:55:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:55:58 INFO - '_': '/tools/buildbot/bin/python'} 17:55:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:55:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:55:58 INFO - Running setup.py (path:/tmp/pip-DrrZrW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:55:58 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:55:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:55:58 INFO - Running setup.py (path:/tmp/pip-HQgIbU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:55:58 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:55:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:55:58 INFO - Running setup.py (path:/tmp/pip-ubL7IH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:55:58 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:55:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:55:58 INFO - Running setup.py (path:/tmp/pip-9okOC0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:55:58 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:55:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:55:58 INFO - Running setup.py (path:/tmp/pip-NFhdyd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:55:58 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:55:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:55:58 INFO - Running setup.py (path:/tmp/pip-UOq4Nf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:55:58 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:55:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:55:58 INFO - Running setup.py (path:/tmp/pip-itNGuz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:55:58 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:55:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:55:58 INFO - Running setup.py (path:/tmp/pip-laGMwW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:55:58 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:55:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:55:58 INFO - Running setup.py (path:/tmp/pip-gE7wY8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:55:58 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:55:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:55:58 INFO - Running setup.py (path:/tmp/pip-CSZxfI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:55:58 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:55:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:55:58 INFO - Running setup.py (path:/tmp/pip-4w_Zh9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:55:59 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:55:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:55:59 INFO - Running setup.py (path:/tmp/pip-W5DY9m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:55:59 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:55:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:55:59 INFO - Running setup.py (path:/tmp/pip-TLPYT5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:55:59 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:55:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:55:59 INFO - Running setup.py (path:/tmp/pip-CBNk7Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:55:59 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:55:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:55:59 INFO - Running setup.py (path:/tmp/pip-oVykLV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:55:59 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:55:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:55:59 INFO - Running setup.py (path:/tmp/pip-vrx7UV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:55:59 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:55:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:55:59 INFO - Running setup.py (path:/tmp/pip-6bSOT5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:55:59 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:55:59 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:55:59 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:55:59 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:55:59 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:55:59 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:55:59 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:55:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:55:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:55:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:55:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:55:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:56:00 INFO - Downloading blessings-1.6.tar.gz 17:56:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:56:00 INFO - Installing collected packages: blessings 17:56:00 INFO - Running setup.py install for blessings 17:56:00 INFO - Successfully installed blessings 17:56:00 INFO - Cleaning up... 17:56:00 INFO - Return code: 0 17:56:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:56:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:56:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:56:01 INFO - Reading from file tmpfile_stdout 17:56:01 INFO - Current package versions: 17:56:01 INFO - argparse == 1.2.1 17:56:01 INFO - blessings == 1.6 17:56:01 INFO - blobuploader == 1.2.4 17:56:01 INFO - docopt == 0.6.1 17:56:01 INFO - functools32 == 3.2.3-2 17:56:01 INFO - jsonschema == 2.5.1 17:56:01 INFO - manifestparser == 1.1 17:56:01 INFO - mozInstall == 1.13 17:56:01 INFO - mozcrash == 1.0 17:56:01 INFO - mozdebug == 0.1 17:56:01 INFO - mozdevice == 0.51 17:56:01 INFO - mozfile == 1.2 17:56:01 INFO - mozhttpd == 0.7 17:56:01 INFO - mozinfo == 0.10 17:56:01 INFO - mozleak == 0.1 17:56:01 INFO - mozlog == 3.5 17:56:01 INFO - moznetwork == 0.27 17:56:01 INFO - mozprocess == 0.25 17:56:01 INFO - mozprofile == 0.28 17:56:01 INFO - mozrunner == 6.13 17:56:01 INFO - mozscreenshot == 0.1 17:56:01 INFO - mozsystemmonitor == 0.3 17:56:01 INFO - moztest == 0.8 17:56:01 INFO - mozversion == 1.4 17:56:01 INFO - psutil == 3.1.1 17:56:01 INFO - requests == 1.2.3 17:56:01 INFO - wsgiref == 0.1.2 17:56:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:56:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:56:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:56:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:56:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:56:01 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 0x101d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x138cb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1389580>, '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 0x138a480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x138a910>, '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': 'd2a8c569965ab8367867b893000001a1-1504140908.557164-1212356442', '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:56:01 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:56:01 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:56:01 INFO - Using env: {'DISPLAY': ':0', 17:56:01 INFO - 'HOME': '/home/cltbld', 17:56:01 INFO - 'LANG': 'en_US.UTF-8', 17:56:01 INFO - 'LANGUAGE': 'en_US:en', 17:56:01 INFO - 'LOGNAME': 'cltbld', 17:56:01 INFO - 'MAIL': '/var/mail/cltbld', 17:56:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:56:01 INFO - 'MOZ_NO_REMOTE': '1', 17:56:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:56:01 INFO - 'NO_EM_RESTART': '1', 17:56:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:56:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:56:01 INFO - 'PWD': '/builds/slave/test', 17:56:01 INFO - 'SHELL': '/bin/bash', 17:56:01 INFO - 'SHLVL': '1', 17:56:01 INFO - 'TERM': 'linux', 17:56:01 INFO - 'TMOUT': '86400', 17:56:01 INFO - 'USER': 'cltbld', 17:56:01 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1504140908.557164-1212356442', 17:56:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:56:01 INFO - '_': '/tools/buildbot/bin/python'} 17:56:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:56:01 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:56:01 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:56:01 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:56:01 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:56:01 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:56:01 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:56:01 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:56:01 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:56:01 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:56:01 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 17:56:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:56:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:56:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:56:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:56:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 17:56:02 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:56:02 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:56:02 INFO - Installing collected packages: simplejson 17:56:02 INFO - Running setup.py install for simplejson 17:56:02 INFO - building 'simplejson._speedups' extension 17:56:02 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:56:03 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:56:03 INFO - Successfully installed simplejson 17:56:03 INFO - Cleaning up... 17:56:03 INFO - Return code: 0 17:56:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:56:03 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:56:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:56:03 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:56:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:56:03 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 0x101d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x138cb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1389580>, '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 0x138a480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x138a910>, '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': 'd2a8c569965ab8367867b893000001a1-1504140908.557164-1212356442', '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:56:03 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:56:03 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:56:03 INFO - Using env: {'DISPLAY': ':0', 17:56:03 INFO - 'HOME': '/home/cltbld', 17:56:03 INFO - 'LANG': 'en_US.UTF-8', 17:56:03 INFO - 'LANGUAGE': 'en_US:en', 17:56:03 INFO - 'LOGNAME': 'cltbld', 17:56:03 INFO - 'MAIL': '/var/mail/cltbld', 17:56:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:56:03 INFO - 'MOZ_NO_REMOTE': '1', 17:56:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:56:03 INFO - 'NO_EM_RESTART': '1', 17:56:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:56:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:56:03 INFO - 'PWD': '/builds/slave/test', 17:56:03 INFO - 'SHELL': '/bin/bash', 17:56:03 INFO - 'SHLVL': '1', 17:56:03 INFO - 'TERM': 'linux', 17:56:03 INFO - 'TMOUT': '86400', 17:56:03 INFO - 'USER': 'cltbld', 17:56:03 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1504140908.557164-1212356442', 17:56:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:56:03 INFO - '_': '/tools/buildbot/bin/python'} 17:56:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:56:03 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:56:03 INFO - Cleaning up... 17:56:03 INFO - Return code: 0 17:56:03 INFO - Running post-action listener: _resource_record_post_action 17:56:03 INFO - Running post-action listener: _start_resource_monitoring 17:56:03 INFO - Starting resource monitoring. 17:56:03 INFO - [mozharness: 2017-08-31 00:56:03.750237Z] Finished create-virtualenv step (success) 17:56:03 INFO - [mozharness: 2017-08-31 00:56:03.751214Z] Running install step. 17:56:03 INFO - Running pre-action listener: _resource_record_pre_action 17:56:03 INFO - Running main action method: install 17:56:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:56:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:56:03 INFO - Reading from file tmpfile_stdout 17:56:03 INFO - Detecting whether we're running mozinstall >=1.0... 17:56:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:56:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:56:04 INFO - Reading from file tmpfile_stdout 17:56:04 INFO - Output received: 17:56:04 INFO - Usage: mozinstall [options] installer 17:56:04 INFO - Options: 17:56:04 INFO - -h, --help show this help message and exit 17:56:04 INFO - -d DEST, --destination=DEST 17:56:04 INFO - Directory to install application into. [default: 17:56:04 INFO - "/builds/slave/test"] 17:56:04 INFO - --app=APP Application being installed. [default: firefox] 17:56:04 INFO - mkdir: /builds/slave/test/build/application 17:56:04 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:56:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 17:56:20 INFO - Reading from file tmpfile_stdout 17:56:20 INFO - Output received: 17:56:20 INFO - /builds/slave/test/build/application/firefox/firefox 17:56:20 INFO - Running post-action listener: _resource_record_post_action 17:56:20 INFO - [mozharness: 2017-08-31 00:56:20.577537Z] Finished install step (success) 17:56:20 INFO - [mozharness: 2017-08-31 00:56:20.577889Z] Running setup-mitmproxy step. 17:56:20 INFO - Running pre-action listener: _resource_record_pre_action 17:56:20 INFO - Running main action method: setup_mitmproxy 17:56:20 INFO - Skipping: mitmproxy is not required 17:56:20 INFO - Running post-action listener: _resource_record_post_action 17:56:20 INFO - [mozharness: 2017-08-31 00:56:20.579493Z] Finished setup-mitmproxy step (success) 17:56:20 INFO - [mozharness: 2017-08-31 00:56:20.579803Z] Running run-tests step. 17:56:20 INFO - Running pre-action listener: _resource_record_pre_action 17:56:20 INFO - Running pre-action listener: _set_gcov_prefix 17:56:20 INFO - Running main action method: run_tests 17:56:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:56:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:56:20 INFO - Python 2.7.3 17:56:20 INFO - Return code: 0 17:56:20 INFO - grabbing minidump binary from tooltool 17:56: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:56:20 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 0x1389580>, '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 0x138a480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x138a910>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:56:20 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:56:20 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:56:20 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:56:20 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:56:20 INFO - Return code: 0 17:56:20 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:56:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:56:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:56:20 INFO - ENV: RUST_BACKTRACE is now full 17:56:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:56:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:56:20 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-043', '--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:56:20 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-043 --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:56:20 INFO - Using env: {'DISPLAY': ':0', 17:56:20 INFO - 'HOME': '/home/cltbld', 17:56:20 INFO - 'LANG': 'en_US.UTF-8', 17:56:20 INFO - 'LANGUAGE': 'en_US:en', 17:56:20 INFO - 'LOGNAME': 'cltbld', 17:56:20 INFO - 'MAIL': '/var/mail/cltbld', 17:56:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:56:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:56:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:56:20 INFO - 'MOZ_NO_REMOTE': '1', 17:56:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:56:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:56:20 INFO - 'NO_EM_RESTART': '1', 17:56:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:56:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:56:20 INFO - 'PWD': '/builds/slave/test', 17:56:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:56:20 INFO - 'RUST_BACKTRACE': 'full', 17:56:20 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 17:56:20 INFO - 'SHELL': '/bin/bash', 17:56:20 INFO - 'SHLVL': '1', 17:56:20 INFO - 'STYLO_FORCE_ENABLED': '1', 17:56:20 INFO - 'TERM': 'linux', 17:56:20 INFO - 'TMOUT': '86400', 17:56:20 INFO - 'USER': 'cltbld', 17:56:20 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1504140908.557164-1212356442', 17:56:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:56:20 INFO - '_': '/tools/buildbot/bin/python'} 17:56:20 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-043', '--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:56:21 INFO - mozversion application_buildid: 20170831001019 17:56:21 INFO - mozversion application_changeset: d9b405d82cffb07343a5f2fd941e029298c7f6c4 17:56:21 INFO - mozversion application_display_name: Nightly 17:56:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:56:21 INFO - mozversion application_name: Firefox 17:56:21 INFO - mozversion application_remotingname: firefox 17:56:21 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 17:56:21 INFO - mozversion application_vendor: Mozilla 17:56:21 INFO - mozversion application_version: 57.0a1 17:56:21 INFO - mozversion platform_buildid: 20170831001019 17:56:21 INFO - mozversion platform_changeset: d9b405d82cffb07343a5f2fd941e029298c7f6c4 17:56:21 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 17:56:21 INFO - mozversion platform_version: 57.0a1 17:56:21 INFO - using testdate: 1504140981 17:56:21 INFO - actual date: 1504140981 17:56:21 INFO - starting webserver on 'localhost:37532' 17:56:21 INFO - SUITE-START | Running 2 tests 17:56:21 INFO - TEST-START | dromaeo_css 17:56:21 INFO - Initialising browser for dromaeo_css test... 17:56:21 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:37532/getInfo.html -profile /tmp/tmpYRoKu0/profile 17:56:21 INFO - TEST-INFO | started process 3450 (/builds/slave/test/build/application/firefox/firefox http://localhost:37532/getInfo.html) 17:56:28 INFO - TEST-INFO | 3450: exit 0 17:56:28 INFO - Browser initialized. 17:56:28 INFO - Running cycle 1/1 for dromaeo_css test... 17:56:28 INFO - Using env: {'DISPLAY': ':0', 17:56:28 INFO - 'HOME': '/home/cltbld', 17:56:28 INFO - 'JSGC_DISABLE_POISONING': '1', 17:56:28 INFO - 'LANG': 'en_US.UTF-8', 17:56:28 INFO - 'LANGUAGE': 'en_US:en', 17:56:28 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 17:56:28 INFO - 'LOGNAME': 'cltbld', 17:56:28 INFO - 'MAIL': '/var/mail/cltbld', 17:56:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:56:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:56:28 INFO - 'MOZ_CRASHREPORTER': '1', 17:56:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:56:28 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 17:56:28 INFO - 'MOZ_NO_REMOTE': '1', 17:56:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:56:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:56:28 INFO - 'NO_EM_RESTART': '1', 17:56:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:56:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:56:28 INFO - 'PWD': '/builds/slave/test', 17:56:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:56:28 INFO - 'RUST_BACKTRACE': 'full', 17:56:28 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 17:56:28 INFO - 'SHELL': '/bin/bash', 17:56:28 INFO - 'SHLVL': '1', 17:56:28 INFO - 'STYLO_FORCE_ENABLED': '1', 17:56:28 INFO - 'TERM': 'linux', 17:56:28 INFO - 'TMOUT': '86400', 17:56:28 INFO - 'USER': 'cltbld', 17:56:28 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1504140908.557164-1212356442', 17:56:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:56:28 INFO - '_': '/tools/buildbot/bin/python'} 17:56:28 INFO - TEST-INFO | started process 3647 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYRoKu0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 17:56:29 INFO - PID 3647 | 17:56:29 INFO - PID 3647 | (/builds/slave/test/build/application/firefox/firefox:3699): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 17:56:29 INFO - PID 3647 | 17:56:40 INFO - PID 3647 | RSS: Main: 171397120 17:56:40 INFO - PID 3647 | 17:59:38 INFO - PID 3647 | Cycle 1(1): loaded http://localhost:37532/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37532/tests/dromaeo/cssquery-ext.html) 17:59:40 INFO - PID 3647 | RSS: Main: 172224512 17:59:40 INFO - PID 3647 | 18:02:42 INFO - PID 3647 | Cycle 1(1): loaded http://localhost:37532/tests/dromaeo/cssquery-ext.html (next: http://localhost:37532/tests/dromaeo/cssquery-jquery.html) 18:02:42 INFO - PID 3647 | RSS: Main: 170614784 18:02:42 INFO - PID 3647 | 18:05:44 INFO - PID 3647 | Cycle 1(1): loaded http://localhost:37532/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37532/tests/dromaeo/cssquery-mootools.html) 18:05:45 INFO - PID 3647 | RSS: Main: 172740608 18:05:45 INFO - PID 3647 | 18:08:46 INFO - PID 3647 | Cycle 1(1): loaded http://localhost:37532/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37532/tests/dromaeo/cssquery-prototype.html) 18:08:47 INFO - PID 3647 | RSS: Main: 171544576 18:08:47 INFO - PID 3647 | 18:11:51 INFO - PID 3647 | Cycle 1(1): loaded http://localhost:37532/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37532/tests/dromaeo/cssquery-yui.html) 18:11:51 INFO - PID 3647 | RSS: Main: 175333376 18:11:51 INFO - PID 3647 | 18:14:53 INFO - PID 3647 | Cycle 1(1): loaded http://localhost:37532/tests/dromaeo/cssquery-yui.html (next: http://localhost:37532/tests/dromaeo/cssquery-dojo.html) 18:14:53 INFO - PID 3647 | RSS: Main: 176566272 18:14:53 INFO - PID 3647 | 18:14:53 INFO - PID 3647 | __start_tp_report 18:14:53 INFO - PID 3647 | _x_x_mozilla_page_load 18:14:53 INFO - PID 3647 | _x_x_mozilla_page_load_details 18:14:53 INFO - PID 3647 | |i|pagename|runs| 18:14:53 INFO - PID 3647 | |0;dojo.html;3302.0919247207016;3334.266461378496;3343.765936384453;3362.2434952135764;3399.84700688469;6160.691965401728;6192.50459963203;6235.688215589219;6240.188775459184;6251.53113516487;6233.875322493547;6306.463950564196;6425.518086143535;6437.45281651059;6477.54657173998;5817.476427121558;5838.854028649275;5890.3226128995175;5930;5965.194698715662;5727.856803579923;5775.3358363788075;5787.681677507735;5869.706514674249;5904.2324497815225;5869.853253668671;5870.970645146768;5878.353381128072;5887.146363777271;5892.086726557391;5790.507806836424;5831.9416805831825;5849.093390524476;5866.384029676865;5885.47030767233;5665.716714164317;5683.147527870811;5714.200011998323;5773.1051686988585;5844.795432159896;6300;6340.556161068727;6369.745210191587;6370.171877655921;6381.840453988641;6770.661466926634;6771.052052712575;6858.51990360675;6861.897071543931;6871.622060786654;6832.760853370109;6840.384365407088;6911.723531058751;6923.9653801730665;6932.168139823203;6220.968895155541;6296.275928268262;6301.1493448384335;6366.236051673829;6384.648844313608;6979.162500499871;6981.092457980531;7046.823829404306;7069.081019467436;7070;6534.934650653433;6591.901121483085;6610;6687.899681504781;6765.05289259504;6718.49611279156;6720.327967203339;6732.596044237263;6734.730610775612;6740.662966851638;6658.067870498134;6663.766768163091;6664.8000559983275;6676.098726671934;6679.899801502981;6605.273419923805;6670;6672.633005184664;6672.666366681647;6672.9332706673285;5199.090159222121;5216.4522725114075;5227.790888364499;5230.34620672416;5230.660007099526;4692.812287508462;4695.5539223773685;4708.788104535304;4711.363965864564;4719.480857105716;5942.940570594239;5966.642001479925;5974.253218347707;5974.492168165754;6011.639301641828;6802.14973128359;6806.897896531556;6884.0018197361105;6885.1049363582415;6887.380135787803;5843.824685259449;5909.409059094142;5955.791547295824;6040.275166979991;6052.182955301066;5805.854853628609;5852.678102704393;5855.151003104526;5868.794592189253;5872.530197584183;6548.476121910236;6628.668566571652;6633.071370008202;6637.46900247979;6644.734210631617;6734.0572319875255;6750.122484077038;6760.053592496956;6830.521863469509;6832.624205668736;6443.259025212161;6519.8044058678315;6605;6648.434883034996;6678.298778628174;6693.933060669331;6695.966520167368;6710.731570737116;6731.730730770714;6738.663066846736;6694.564853284521;6813.148356455443;6816.182058153054;6887.414569761627;6887.483438742214;6563.967180164069;6569.146011018537;6657.866842663023;6665.766698165541;6666.533342665967;6523.64119973387;6545.901811472927;6640.07039014548;6647.235567909753;6660.700268487833;6356.491480681442;6471.158749362553;6477.222733272038;6487.1566696331065;6564.916788729806;6487.091807146909;6602.306757790555;6616.66916654175;6622.8344291393105;6643.136392268974;6363.649999250086;6371.076193951943;6384.457321127757;6389.456896163878;6397.26431460388 18:14:53 INFO - PID 3647 | |1;ext.html;786.6538722961897;817.4645607127334;841.2008591837755;862.5557837713578;864.2869632553145;41506.79246603767;42111.78944105283;42185;42245.78877105618;42364.57635423645;38135.23729525415;38269.234615307745;38339.424908626395;38437.807810960905;38517.614823851756;6917.896231556518;7055.082839230919;7060.470464715141;7079.85840283194;7080.929190708079;6975;7721.961390193069;7931.801704957365;7936.6825326986855;7937.4840635358805;7903.446758726892;7915.722949696762;7946.920530794705;7953.681852725913;7959.3632509399395;7729.884051739228;7990;7990.64042118106;7995.120536740954;8001.799955001114;7737.613119344067;7816.765497035098;7821.452498325119;7823.374130069581;7823.569703666296;38452.42321365182;38738.61261387378;38807.223855523014;38831;38861.22277554433;3529.32942740881;3560.1989552350774;3568.3041806847673;3569.5181150544604;3575.1598374382;32161.839190803898;32203.51694724581;32212.516812247835;32281.677183228338;32298;5139.229115632685;5226.242194881721;5277.02375060615;5340.172273297645;5418.187271909245;185896.99999999866;187549;188279;189018;202680;48884.51115488871;49043.509564904605;49049.75475122601;49208.26187607189;49214.50785492171;51244.231336529985;51277.23084153741;51285.23072153921;51311;51331;14813;14848.480303189337;14915.850841491663;14950.850491494946;14958.850411495745;12022.218555793845;12026.218295810919;12026.4588093536;12029.578964736193;12031.518739250507;13968.720625587432;14019;14032.438702451991;14091.506797262047;14165.645858853612;5487.204355368529;5514.365847927459;5552.305961754781;5640.717964101778;5686.715664216773;1023.3808545829814;1031.7059638003134;1039.3140527251978;1040.3510435958938;1045.843123531461;22925.88537057304;23414.414639634146;23494.177703780628;29840.850795745882;30326.393472130432;1121.7363919478917;1127.703141387411;1129.6159305836056;1134.9319040857574;1151.9424028798526;15915.602109947113;16343.673126537402;16394.83605163933;16525.504234872973;16742.162891855358;230924;233081;234596;235440;235594;57641.13538296929;57678;58156.41843581595;58221;58295.41704582985;1468.7356275870231;1487.6429656882488;1492.4552538323435;1520.9163496007604;1536.6619343744358;27570.656494198218;27673;27862.860685696443;28468.715312846605;28533.714662853105;39471;39729.205415890945;39777.20445591014;39799;39844.80077599594;208162;209176;209382;210315;210438;34103.48844767281;34597.65402346045;34706.305873882884;38099.80950095343;39558.2088358237;48163.27755083747;48257.75871120622;48537.757311213216;48583;48860.26709599288;34626.82686586551;34843;34984;35112.297754045285;35374;35071.47392789161;35079.47380789239;35290.647093528736;35476;36040.8197959019;38230.42654360242;40389.394159088224;40429.39355909605;40609.59390406058;41057.1788564233;33574;34362.65637343695;34509.654903450646;34574.82712586421;35427.468587971714;24265.272041838773;25029.624555631315;25445.745542544337;25851.353716157246;26099.869500652374 18:14:53 INFO - PID 3647 | |2;jquery.html;568.3946596874329;568.8009196781125;570.8316046766204;581.4098689829821;585.5520526797001;22281.777182228172;22494.43763905899;23081.538369232607;23139.19012834549;23222.419439514022;23749.64375534364;25422.36444088899;25573;25600.359991000234;25613.35966600836;6547.738090476387;6677.732890684367;6679.532432729687;6694.0962969999155;6695.866082678343;6099.085137229406;6389.329120442357;6712.0938673279215;6714.093597364366;6717.596944183365;6670.23292321382;6678.131842860445;6683.799486015403;6685.197776266855;6704.564203326792;6683.465322774166;6693.83265418366;6696.861533539286;6710.42961348286;6717.529772915897;6206.534509911775;6219.782307619257;6222.284437289724;6230.875382492325;6233.5948163369685;27929.301767455774;28124.437511249864;29327.706722932926;29465;29493.852530737207;2031.4007367826528;2086.384516567616;2086.478380404899;2086.8539202255847;2092.299079808266;19674.114664840115;20152.596948060956;20248.898755506274;20252.291169808985;20297.89851050735;2403;2424.830261881669;2491.1281051631963;2496.875156242199;2501.249625112459;129798;133292.33353833266;133683.33158334147;134257;134843;14092.929535352258;14590.133614592141;14613.926930365493;14955.925220373829;15074.321655525528;22284.55430891373;22332.77667223307;22362.776372236396;22374.776252237596;22401.551968960528;9969.40183588987;10051.246156538142;10174.389536627827;10337.9483102584;10387.272890897564;8059.395545334123;9481.478518681539;9540.761480962892;9577.952110239543;9676.612935482643;7889.250521200477;9054.728358149267;9098.363114582047;9215.815683686289;9353.485558294358;2728.7953403494816;2744.8078634495396;2758.3931535062256;2817.873195706198;2874.2814296425895;967.1827305926481;970.3789574672215;984.3060642247199;985.7141428985657;1009.2128140050772;18854.71717924232;19167.424977250706;19427.32004379868;19563.51091222731;19588.608227835364;1033.1012019542895;1052.9578816847393;1059.5443959097508;1060.3849767135043;1061.5276202089997;10800.24398292112;10871.45642717861;10906.291091079054;10959.397233152253;11062.79613746771;467919;469905;486316;487130;488644;106025;108205;109895;110183.44908275407;110276.4486177564;1171.7832201042834;1178.3636836108576;1196.6230637349206;1198.9820152697716;1203.1998720850536;17517.737233941756;17542.21060052275;17749.645007100044;17785.911070444567;18050.007249601396;54262.45737542574;54987.72506137604;56768.71615641895;57589.42410575841;58297.4170258292;67087.66456167688;68022.3197768016;68113;68456.31543684698;69325.30674693189;14516.346764395415;14898.478553251018;14919.776203357176;15030.473933412715;15036;23520.647190291817;23557.882210588836;23620.8818955911;23680.644790328504;23765.16821911225;15364.615884602974;15447.304871280594;15566.688666226839;15580.454684086002;18665.720014199527;16811.663766724352;17107.65784684324;17243.84451943507;17292.654146917244;17714.73427898557;18468.799528030635;19246.326378576683;19413.12640931133;19450.513737156685;19496.122674479968;14653.706925861636;14681.48614798477;14716.117032977627;14753.114813111248;14783.113013219241;18582.535436614195;18631.906840465712;18643.627127457647;18778.342758003404;18941.90529047346 18:14:53 INFO - PID 3647 | |3;mootools.html;1335.646053795744;1382.0532934939567;1415.7451658701436;1420.8366037905637;1421.0478979084012;12554;14961.775573366409;15646.217689115527;15673.843261567396;15681.764773528392;12706.17409868358;15098.622534436645;15467;15522.456714015012;15561.766573501407;2791.1626512046455;2851.130405226405;2854.24362543925;2858.4568931902977;2861.8998335058277;2692.1519721287827;2790.6093146959442;2854.8287102773797;2863.9856800715966;2887.927801804951;2872.6983666714905;2904.2739315171207;2904.5062339402352;2904.622399088116;2904.6804851466322;2695.2992222022317;2719.3473566344032;2740.0409856550345;2740.767034802024;2743.711910249415;2739.876705548255;2767.4741799058115;2768.764655004327;2771.3071732066983;2773.500769861424;14930.850691493055;15238.161901095435;15240.314185861664;15242.085474871543;15265.38938442461;8053.1946805319585;8370.623321950527;8381.790455238606;8383.455075420079;8398.538080405575;5259.817175872008;5432.6468779529205;5499.312585926759;5579.8605034874045;5676.829695109153;1904.64764018657;1910.6656335141295;1942.9611407771765;1961.0880940362658;1989.1446677928484;27077.187684369303;27315.590266146024;27358;27406.5889011665;27433.45133097327;6679.395035935989;6839.247682754893;6943.201531823804;7057.6118313492225;7185;17525.824741752418;17600.823991760175;17614.823851761575;17620.823791762174;17624;7836.412269079728;7957.681692732342;7958.482698624571;7984.321332686786;7997.800054998672;7192.856142877114;7261.41908647307;7319.670614822346;7327.010853534811;7354.889676654854;5106.591472682177;5321.760520776575;5356.035913535523;5402.6758394496455;5409.756560954766;1399.1605036977935;1475.8229012518566;1541.514422956765;1557.540525544967;1591.2362066208284;844.4468872888268;855.1192271959891;871.8561437362764;876.8640860666607;891.7191084808264;7244.492885497964;7257;7283.7450689225625;7292.3801476874;7318.487705860645;970.5341436110706;992.2012779712401;1003.894591067942;1005.0703099632957;1010.0909181736496;4441.422615060022;4494.988627558773;4518.43519560055;4555.861034741315;4610.585047345688;21351.359459216248;21880.671789923163;21908.342749717533;22071.558568828532;22248.443788905406;20995.47511312199;21641.45896352572;21748;21993;22051.779482205293;11333.829992550118;11481.770364592661;11551.480183391935;11670.70823229426;11685.240459370114;8559.62308080484;8898.86651700238;9040.050794666728;9095.045020272775;9138.68014619485;18249.270029198684;18320;18640.720389193903;18756.062196889827;19068.618627627646;18876.33932812345;19261.614767704286;19328.61342773165;19501.804981949997;19707.40877773669;13556.254406007763;13836.23900685472;13884.930575347058;13897.722045559234;13900.582982510541;14046;14068.437262509386;14152.292385380895;14181.14913105217;14194.219317937612;11187.944060279646;11291.548338066714;11573.305601663928;11591.420428978348;11692.123090768056;10874.075703565286;11061.723456913642;11085.22403431752;11182.161337899528;11184.496697648789;9455.905440945502;9994.250431217833;10065.144462720751;10081.344712593658;10089.697309080739;7361.785305424545;7370.410367170506;7376.151742549676;7416.7774966751085;7536.24637536242;7723.304902558797;7751.263629955145;7760.611969401621;7770.14528401864;7828.373730101464 18:14:53 INFO - PID 3647 | |4;prototype.html;509.6941834899061;510.8135530531355;528.2920886012743;533.9065663508885;541.7453796715545;6346.904796428052;6380.968095159524;6397.200349956255;6402.135711678922;6471.96133218036;6035.336113027563;6081.726322315495;6304.464120549747;6304.747810087591;6309.179806625132;5272.736363181844;5327.520523152915;5340.67955922644;5342.2253773202865;5347.037533244004;5268.209768534732;5272.683638981654;5278.313819203518;5296.999999999981;5313.495217954288;5056.595472362221;5216.426193118754;5237.816676416326;5245.344331958505;5247.317848679666;5208.890399388254;5218.6346955712925;5223.425423203445;5224.059669259532;5242.344706911636;4821.975890120562;4859.902801943941;4865.34317867087;4892.6575139740235;4931.506849315076;6142.249458904235;6150.630962142286;6186.288576813634;6213.5029197664535;6235.906461403082;5989.191459153002;6007.189029481052;6072.119542666333;6073.301570319426;6113.877722445526;6659.533832631718;6686.765963191265;6692.966535167342;6695.732170713166;6736.865262694719;5272.314599102092;5287.35632183908;5290;5316;5344.679319240858;6945.89581156283;6975.162980442379;6984.266652001517;7020.297970202939;7066.999999999948;5472.753726082336;5521.171824226318;5532.6680399176175;5548.306461692288;5591.245181900392;5523.309586301712;5530.834074977757;5552.91670624941;5555.972220138954;5605.010221371436;6033.637981721111;6049.304330002018;6082.513398928075;6094.451499365078;6104.542159338067;6627.095948997803;6700.865982680319;6759.695813688396;6806.217285012188;6821.21556021054;1910.617876424693;1914.2438736698925;1921.2996498099283;1940.1366391955444;1951.8926459044606;1316.374722007039;1335.2055526961442;1336.6057013181135;1346.6902612399008;1418.0924208506565;5828.5337173026055;5886.499647530008;5898.734556944948;5907.818436312668;5956.583039187302;6555.901661475082;6591.901121483182;6631.403173714389;6650.674662668665;6677.699503522354;5792.623479473821;5795.884082318415;5843.620164689281;5901.734421950937;5919.6744179070565;3551.7691350062164;3564.287142571496;3584.623614520438;3634.800085995296;3655.94516082259;6509.153810004669;6553.148090748172;6662.600243985279;6700.497462690318;6709.664516774142;6888.621125838127;6914.585124892523;6954.826129346706;7014.719411223494;7060.399866011447;6461.935380646321;6582.967085164543;6685.933140668531;6727.226368967534;6728.596284222962;6637.435817955527;6655.005247638679;6718.395344419026;6750.966245168939;6849.349311815369;6690.866182676222;6709;6738.797836064926;6800.183977922681;6820.658967051529;6548.377904099103;6555.770548030796;6604.8348791280605;6682.431993280626;6712.697928593323;4995.350604421402;5000.699958002531;5001.4998500149695;5051.974740126276;5074.528386767944;6811.9659401702675;6812.727490900506;6817.693203805939;6883;6924.619145947021;6561.114249576246;6571.934280657132;6611.371919667624;6632.933670663231;6647.700853461509;6457.0951569286235;6563.7702680405955;6580.967095164494;6602.801915942529;6644.83387915306;6200.3179650237535;6340.619562826245;6378.457831084224;6525.771597994048;6538.6517965552375;6343.52423568225;6451.3226111257645;6474.255460622088;6528.575642583217;6658.500612453989;6248.343923888108;6276.278228003838;6277.937220627918;6289.496840252677;6469.4824414045825 18:14:53 INFO - PID 3647 | |5;yui.html;903.7830920579058;910.3127139010046;918.5269586163125;924.8751418558497;926.1433174313759;18091.72862407065;18594.721079183808;18726.34457793974;18754.156062977163;19904.402867913985;20496.590068198664;21376.679349809765;21513.46216344588;21556.137754489842;21618.459538511506;996.526649841325;1007.1791489935679;1011.9089281964622;1012.2863381316155;1012.9594816207343;941.1341565759518;976.7997560500116;980.5832521178471;1005.607812952949;1008.4503945349802;1046.9371837689764;1048.2190767877942;1048.3185929146039;1049.8057859296016;1049.9055085042344;1048.612013554982;1049.1449468683;1050.3120456101267;1051.106559424487;1051.9053285204368;763.2672634271106;770.8766597344454;770.9884351734728;771.1401787007502;771.9536827790295;19065;19089;19296.1316740747;19361.32235371755;19982.70025949612;21082.894585527127;21486.462838429165;21920.561588768294;21924.232651857266;22031.228906988177;17021.914890425593;17197.91401042999;17407.56481087983;17458.912705436393;17619.383321583682;3694.501242332278;3723.6090210527777;3724.5344331958504;3725.3666876631037;3727.683146932514;122644;122929;123815.38092309481;125386.37306813408;125774;16485.670286594202;16868.831311686972;17333.47999560015;17393.739093913602;17497.912510437367;29597.852010739807;29959.550606740915;30075;30252.84873575618;30592;7624.961875190588;8047.235512626291;8623.741287761377;8762.474251544927;8853.026167121612;4280.72175308604;4361;4374.759388233614;4379.802908869108;4396.626286765597;5262.500062494057;5317.707526086102;5348.438413966555;5356.1697936819855;5387.649802762808;1080.1412876762993;1087.2389327470803;1102.2614848051824;1104.6023431564631;1107.534835369147;681.6285124607101;691.8235849858254;700.6636814329048;705.6295444891473;709.021550260637;11536.826947595793;11725.882741172649;11775;11932.22440541362;12062.215955962834;677.6814896998403;694.6630884021246;698.8951657251453;699.6921354603958;705.0376236437227;5574.219609254707;5600.747966341524;5921.289445266596;5966.970165149233;6208.099825525273;103230.48384758028;105048.47475762572;105096;108238.45880770545;109462.45268773605;94857.05142948483;95812.52093739486;95836.52081739546;97045;100263;83320.58339708262;85249;85629.71555426673;86189;86881.56559217164;12339.197952133083;12340.382980850742;12409.193402428813;12466.626001219978;12581.119321647397;38426.23147536978;39655.40516892191;39799.80100099481;39848.402273966494;40015.398999064964;51855;52265.47734522606;52574.73712631565;53667.46332536625;54330.72834635802;17428.82571174272;17610.82389176092;18065.09674516295;18121.36575219861;18213.90893045526;16341.918290408472;18572.535686607403;18829.058547072866;18939.33712320062;18980.620387592448;17566.91216543909;17643.823561764733;17721.02534360571;17734.91132544329;17789;17783.110844457984;17917.014564199093;18015.639687206443;18027.819721802614;18035;16035.118068506345;16181.514554563382;16241;16346.918265409073;16368.017918924903;13760.17438953666;14115.929420353243;14137.646558836112;14379.496717614833;14425.20661363635;13417.530386436429;13540.864591354355;13592.116512427056;13629.863701363256;13634.386452609855 18:14:53 INFO - PID 3647 | __end_tp_report 18:14:53 INFO - PID 3647 | __start_cc_report 18:14:53 INFO - PID 3647 | _x_x_mozilla_cycle_collect,365 18:14:53 INFO - PID 3647 | __end_cc_report 18:14:53 INFO - PID 3647 | __startTimestamp1504142093636__endTimestamp 18:14:53 INFO - PID 3647 | 18:14:53 INFO - PID 3647 | ------- Summary: start ------- 18:14:53 INFO - PID 3647 | Number of tests: 6 18:14:53 INFO - PID 3647 | 18:14:53 INFO - PID 3647 | [#0] dojo.html Cycles:165 Average:6241.23 Median:6477.22 stddev:722.62 (11.2%) stddev-sans-first:687.06 18:14:53 INFO - PID 3647 | Values: 3302.1 3334.3 3343.8 3362.2 3399.8 6160.7 6192.5 6235.7 6240.2 6251.5 6233.9 6306.5 6425.5 6437.5 6477.5 5817.5 5838.9 5890.3 5930.0 5965.2 5727.9 5775.3 5787.7 5869.7 5904.2 5869.9 5871.0 5878.4 5887.1 5892.1 5790.5 5831.9 5849.1 5866.4 5885.5 5665.7 5683.1 5714.2 5773.1 5844.8 6300.0 6340.6 6369.7 6370.2 6381.8 6770.7 6771.1 6858.5 6861.9 6871.6 6832.8 6840.4 6911.7 6924.0 6932.2 6221.0 6296.3 6301.1 6366.2 6384.6 6979.2 6981.1 7046.8 7069.1 7070.0 6534.9 6591.9 6610.0 6687.9 6765.1 6718.5 6720.3 6732.6 6734.7 6740.7 6658.1 6663.8 6664.8 6676.1 6679.9 6605.3 6670.0 6672.6 6672.7 6672.9 5199.1 5216.5 5227.8 5230.3 5230.7 4692.8 4695.6 4708.8 4711.4 4719.5 5942.9 5966.6 5974.3 5974.5 6011.6 6802.1 6806.9 6884.0 6885.1 6887.4 5843.8 5909.4 5955.8 6040.3 6052.2 5805.9 5852.7 5855.2 5868.8 5872.5 6548.5 6628.7 6633.1 6637.5 6644.7 6734.1 6750.1 6760.1 6830.5 6832.6 6443.3 6519.8 6605.0 6648.4 6678.3 6693.9 6696.0 6710.7 6731.7 6738.7 6694.6 6813.1 6816.2 6887.4 6887.5 6564.0 6569.1 6657.9 6665.8 6666.5 6523.6 6545.9 6640.1 6647.2 6660.7 6356.5 6471.2 6477.2 6487.2 6564.9 6487.1 6602.3 6616.7 6622.8 6643.1 6363.6 6371.1 6384.5 6389.5 6397.3 18:14:53 INFO - PID 3647 | 18:14:53 INFO - PID 3647 | [#1] ext.html Cycles:180 Average:39093.48 Median:3572.34 stddev:54930.36 (1537.7%) stddev-sans-first:55009.14 18:14:53 INFO - PID 3647 | Values: 786.7 817.5 841.2 862.6 864.3 41506.8 42111.8 42185.0 42245.8 42364.6 38135.2 38269.2 38339.4 38437.8 38517.6 6917.9 7055.1 7060.5 7079.9 7080.9 6975.0 7722.0 7931.8 7936.7 7937.5 7903.4 7915.7 7946.9 7953.7 7959.4 7729.9 7990.0 7990.6 7995.1 8001.8 7737.6 7816.8 7821.5 7823.4 7823.6 38452.4 38738.6 38807.2 38831.0 38861.2 3529.3 3560.2 3568.3 3569.5 3575.2 32161.8 32203.5 32212.5 32281.7 32298.0 5139.2 5226.2 5277.0 5340.2 5418.2 185897.0 187549.0 188279.0 189018.0 202680.0 48884.5 49043.5 49049.8 49208.3 49214.5 51244.2 51277.2 51285.2 51311.0 51331.0 14813.0 14848.5 14915.9 14950.9 14958.9 12022.2 12026.2 12026.5 12029.6 12031.5 13968.7 14019.0 14032.4 14091.5 14165.6 5487.2 5514.4 5552.3 5640.7 5686.7 1023.4 1031.7 1039.3 1040.4 1045.8 22925.9 23414.4 23494.2 29840.9 30326.4 1121.7 1127.7 1129.6 1134.9 1151.9 15915.6 16343.7 16394.8 16525.5 16742.2 230924.0 233081.0 234596.0 235440.0 235594.0 57641.1 57678.0 58156.4 58221.0 58295.4 1468.7 1487.6 1492.5 1520.9 1536.7 27570.7 27673.0 27862.9 28468.7 28533.7 39471.0 39729.2 39777.2 39799.0 39844.8 208162.0 209176.0 209382.0 210315.0 210438.0 34103.5 34597.7 34706.3 38099.8 39558.2 48163.3 48257.8 48537.8 48583.0 48860.3 34626.8 34843.0 34984.0 35112.3 35374.0 35071.5 35079.5 35290.6 35476.0 36040.8 38230.4 40389.4 40429.4 40609.6 41057.2 33574.0 34362.7 34509.7 34574.8 35427.5 24265.3 25029.6 25445.7 25851.4 26099.9 18:14:53 INFO - PID 3647 | 18:14:53 INFO - PID 3647 | [#2] jquery.html Cycles:180 Average:34041.14 Median:22447.99 stddev:80654.86 (359.3%) stddev-sans-first:80841.96 18:14:53 INFO - PID 3647 | Values: 568.4 568.8 570.8 581.4 585.6 22281.8 22494.4 23081.5 23139.2 23222.4 23749.6 25422.4 25573.0 25600.4 25613.4 6547.7 6677.7 6679.5 6694.1 6695.9 6099.1 6389.3 6712.1 6714.1 6717.6 6670.2 6678.1 6683.8 6685.2 6704.6 6683.5 6693.8 6696.9 6710.4 6717.5 6206.5 6219.8 6222.3 6230.9 6233.6 27929.3 28124.4 29327.7 29465.0 29493.9 2031.4 2086.4 2086.5 2086.9 2092.3 19674.1 20152.6 20248.9 20252.3 20297.9 2403.0 2424.8 2491.1 2496.9 2501.2 129798.0 133292.3 133683.3 134257.0 134843.0 14092.9 14590.1 14613.9 14955.9 15074.3 22284.6 22332.8 22362.8 22374.8 22401.6 9969.4 10051.2 10174.4 10337.9 10387.3 8059.4 9481.5 9540.8 9578.0 9676.6 7889.3 9054.7 9098.4 9215.8 9353.5 2728.8 2744.8 2758.4 2817.9 2874.3 967.2 970.4 984.3 985.7 1009.2 18854.7 19167.4 19427.3 19563.5 19588.6 1033.1 1053.0 1059.5 1060.4 1061.5 10800.2 10871.5 10906.3 10959.4 11062.8 467919.0 469905.0 486316.0 487130.0 488644.0 106025.0 108205.0 109895.0 110183.4 110276.4 1171.8 1178.4 1196.6 1199.0 1203.2 17517.7 17542.2 17749.6 17785.9 18050.0 54262.5 54987.7 56768.7 57589.4 58297.4 67087.7 68022.3 68113.0 68456.3 69325.3 14516.3 14898.5 14919.8 15030.5 15036.0 23520.6 23557.9 23620.9 23680.6 23765.2 15364.6 15447.3 15566.7 15580.5 18665.7 16811.7 17107.7 17243.8 17292.7 17714.7 18468.8 19246.3 19413.1 19450.5 19496.1 14653.7 14681.5 14716.1 14753.1 14783.1 18582.5 18631.9 18643.6 18778.3 18941.9 18:14:53 INFO - PID 3647 | 18:14:53 INFO - PID 3647 | [#3] mootools.html Cycles:180 Average:9482.33 Median:27336.80 stddev:6794.36 (24.9%) stddev-sans-first:6785.84 18:14:53 INFO - PID 3647 | Values: 1335.6 1382.1 1415.7 1420.8 1421.0 12554.0 14961.8 15646.2 15673.8 15681.8 12706.2 15098.6 15467.0 15522.5 15561.8 2791.2 2851.1 2854.2 2858.5 2861.9 2692.2 2790.6 2854.8 2864.0 2887.9 2872.7 2904.3 2904.5 2904.6 2904.7 2695.3 2719.3 2740.0 2740.8 2743.7 2739.9 2767.5 2768.8 2771.3 2773.5 14930.9 15238.2 15240.3 15242.1 15265.4 8053.2 8370.6 8381.8 8383.5 8398.5 5259.8 5432.6 5499.3 5579.9 5676.8 1904.6 1910.7 1943.0 1961.1 1989.1 27077.2 27315.6 27358.0 27406.6 27433.5 6679.4 6839.2 6943.2 7057.6 7185.0 17525.8 17600.8 17614.8 17620.8 17624.0 7836.4 7957.7 7958.5 7984.3 7997.8 7192.9 7261.4 7319.7 7327.0 7354.9 5106.6 5321.8 5356.0 5402.7 5409.8 1399.2 1475.8 1541.5 1557.5 1591.2 844.4 855.1 871.9 876.9 891.7 7244.5 7257.0 7283.7 7292.4 7318.5 970.5 992.2 1003.9 1005.1 1010.1 4441.4 4495.0 4518.4 4555.9 4610.6 21351.4 21880.7 21908.3 22071.6 22248.4 20995.5 21641.5 21748.0 21993.0 22051.8 11333.8 11481.8 11551.5 11670.7 11685.2 8559.6 8898.9 9040.1 9095.0 9138.7 18249.3 18320.0 18640.7 18756.1 19068.6 18876.3 19261.6 19328.6 19501.8 19707.4 13556.3 13836.2 13884.9 13897.7 13900.6 14046.0 14068.4 14152.3 14181.1 14194.2 11187.9 11291.5 11573.3 11591.4 11692.1 10874.1 11061.7 11085.2 11182.2 11184.5 9455.9 9994.3 10065.1 10081.3 10089.7 7361.8 7370.4 7376.2 7416.8 7536.2 7723.3 7751.3 7760.6 7770.1 7828.4 18:14:53 INFO - PID 3647 | 18:14:53 INFO - PID 3647 | [#4] prototype.html Cycles:180 Average:5666.59 Median:6206.91 stddev:1524.54 (24.6%) stddev-sans-first:1478.87 18:14:53 INFO - PID 3647 | Values: 509.7 510.8 528.3 533.9 541.7 6346.9 6381.0 6397.2 6402.1 6472.0 6035.3 6081.7 6304.5 6304.7 6309.2 5272.7 5327.5 5340.7 5342.2 5347.0 5268.2 5272.7 5278.3 5297.0 5313.5 5056.6 5216.4 5237.8 5245.3 5247.3 5208.9 5218.6 5223.4 5224.1 5242.3 4822.0 4859.9 4865.3 4892.7 4931.5 6142.2 6150.6 6186.3 6213.5 6235.9 5989.2 6007.2 6072.1 6073.3 6113.9 6659.5 6686.8 6693.0 6695.7 6736.9 5272.3 5287.4 5290.0 5316.0 5344.7 6945.9 6975.2 6984.3 7020.3 7067.0 5472.8 5521.2 5532.7 5548.3 5591.2 5523.3 5530.8 5552.9 5556.0 5605.0 6033.6 6049.3 6082.5 6094.5 6104.5 6627.1 6700.9 6759.7 6806.2 6821.2 1910.6 1914.2 1921.3 1940.1 1951.9 1316.4 1335.2 1336.6 1346.7 1418.1 5828.5 5886.5 5898.7 5907.8 5956.6 6555.9 6591.9 6631.4 6650.7 6677.7 5792.6 5795.9 5843.6 5901.7 5919.7 3551.8 3564.3 3584.6 3634.8 3655.9 6509.2 6553.1 6662.6 6700.5 6709.7 6888.6 6914.6 6954.8 7014.7 7060.4 6461.9 6583.0 6685.9 6727.2 6728.6 6637.4 6655.0 6718.4 6751.0 6849.3 6690.9 6709.0 6738.8 6800.2 6820.7 6548.4 6555.8 6604.8 6682.4 6712.7 4995.4 5000.7 5001.5 5052.0 5074.5 6812.0 6812.7 6817.7 6883.0 6924.6 6561.1 6571.9 6611.4 6632.9 6647.7 6457.1 6563.8 6581.0 6602.8 6644.8 6200.3 6340.6 6378.5 6525.8 6538.7 6343.5 6451.3 6474.3 6528.6 6658.5 6248.3 6276.3 6277.9 6289.5 6469.5 18:14:53 INFO - PID 3647 | 18:14:53 INFO - PID 3647 | [#5] yui.html Cycles:180 Average:22964.80 Median:19022.81 stddev:30956.16 (162.7%) stddev-sans-first:30998.68 18:14:53 INFO - PID 3647 | Values: 903.8 910.3 918.5 924.9 926.1 18091.7 18594.7 18726.3 18754.2 19904.4 20496.6 21376.7 21513.5 21556.1 21618.5 996.5 1007.2 1011.9 1012.3 1013.0 941.1 976.8 980.6 1005.6 1008.5 1046.9 1048.2 1048.3 1049.8 1049.9 1048.6 1049.1 1050.3 1051.1 1051.9 763.3 770.9 771.0 771.1 772.0 19065.0 19089.0 19296.1 19361.3 19982.7 21082.9 21486.5 21920.6 21924.2 22031.2 17021.9 17197.9 17407.6 17458.9 17619.4 3694.5 3723.6 3724.5 3725.4 3727.7 122644.0 122929.0 123815.4 125386.4 125774.0 16485.7 16868.8 17333.5 17393.7 17497.9 29597.9 29959.6 30075.0 30252.8 30592.0 7625.0 8047.2 8623.7 8762.5 8853.0 4280.7 4361.0 4374.8 4379.8 4396.6 5262.5 5317.7 5348.4 5356.2 5387.6 1080.1 1087.2 1102.3 1104.6 1107.5 681.6 691.8 700.7 705.6 709.0 11536.8 11725.9 11775.0 11932.2 12062.2 677.7 694.7 698.9 699.7 705.0 5574.2 5600.7 5921.3 5967.0 6208.1 103230.5 105048.5 105096.0 108238.5 109462.5 94857.1 95812.5 95836.5 97045.0 100263.0 83320.6 85249.0 85629.7 86189.0 86881.6 12339.2 12340.4 12409.2 12466.6 12581.1 38426.2 39655.4 39799.8 39848.4 40015.4 51855.0 52265.5 52574.7 53667.5 54330.7 17428.8 17610.8 18065.1 18121.4 18213.9 16341.9 18572.5 18829.1 18939.3 18980.6 17566.9 17643.8 17721.0 17734.9 17789.0 17783.1 17917.0 18015.6 18027.8 18035.0 16035.1 16181.5 16241.0 16346.9 16368.0 13760.2 14115.9 14137.6 14379.5 14425.2 13417.5 13540.9 13592.1 13629.9 13634.4 18:14:53 INFO - PID 3647 | -------- Summary: end -------- 18:14:53 INFO - PID 3647 | 18:14:54 INFO - TEST-INFO | 3647: exit 0 18:14:54 INFO - TEST-OK | dromaeo_css | took 1113348ms 18:14:54 INFO - TEST-START | kraken 18:14:54 INFO - Initialising browser for kraken test... 18:14:54 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:37532/getInfo.html -profile /tmp/tmp9cjHHm/profile 18:14:54 INFO - TEST-INFO | started process 4028 (/builds/slave/test/build/application/firefox/firefox http://localhost:37532/getInfo.html) 18:14:59 INFO - TEST-INFO | 4028: exit 0 18:14:59 INFO - Browser initialized. 18:14:59 INFO - Running cycle 1/1 for kraken test... 18:14:59 INFO - Using env: {'DISPLAY': ':0', 18:14:59 INFO - 'HOME': '/home/cltbld', 18:14:59 INFO - 'JSGC_DISABLE_POISONING': '1', 18:14:59 INFO - 'LANG': 'en_US.UTF-8', 18:14:59 INFO - 'LANGUAGE': 'en_US:en', 18:14:59 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 18:14:59 INFO - 'LOGNAME': 'cltbld', 18:14:59 INFO - 'MAIL': '/var/mail/cltbld', 18:14:59 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:14:59 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:14:59 INFO - 'MOZ_CRASHREPORTER': '1', 18:14:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:14:59 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 18:14:59 INFO - 'MOZ_NO_REMOTE': '1', 18:14:59 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:14:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:14:59 INFO - 'NO_EM_RESTART': '1', 18:14:59 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:14:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:14:59 INFO - 'PWD': '/builds/slave/test', 18:14:59 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:14:59 INFO - 'RUST_BACKTRACE': 'full', 18:14:59 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 18:14:59 INFO - 'SHELL': '/bin/bash', 18:14:59 INFO - 'SHLVL': '1', 18:14:59 INFO - 'STYLO_FORCE_ENABLED': '1', 18:14:59 INFO - 'TERM': 'linux', 18:14:59 INFO - 'TMOUT': '86400', 18:14:59 INFO - 'USER': 'cltbld', 18:14:59 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1504140908.557164-1212356442', 18:14:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:14:59 INFO - '_': '/tools/buildbot/bin/python'} 18:14:59 INFO - TEST-INFO | started process 4224 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9cjHHm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 18:15:00 INFO - PID 4224 | 18:15:00 INFO - PID 4224 | (/builds/slave/test/build/application/firefox/firefox:4275): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 18:15:00 INFO - PID 4224 | 18:15:10 INFO - PID 4224 | RSS: Main: 172855296 18:15:10 INFO - PID 4224 | 18:15:13 INFO - PID 4224 | Cycle 1(1): loaded http://localhost:37532/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37532/tests/kraken/driver.html?testName=audio-beat-detection) 18:15:14 INFO - PID 4224 | RSS: Main: 177340416 18:15:14 INFO - PID 4224 | 18:15:17 INFO - PID 4224 | Cycle 1(1): loaded http://localhost:37532/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37532/tests/kraken/driver.html?testName=audio-dft) 18:15:17 INFO - PID 4224 | RSS: Main: 181747712 18:15:17 INFO - PID 4224 | 18:15:20 INFO - PID 4224 | Cycle 1(1): loaded http://localhost:37532/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37532/tests/kraken/driver.html?testName=audio-fft) 18:15:21 INFO - PID 4224 | RSS: Main: 174792704 18:15:21 INFO - PID 4224 | 18:15:23 INFO - PID 4224 | Cycle 1(1): loaded http://localhost:37532/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37532/tests/kraken/driver.html?testName=audio-oscillator) 18:15:24 INFO - PID 4224 | RSS: Main: 175296512 18:15:24 INFO - PID 4224 | 18:15:26 INFO - PID 4224 | Cycle 1(1): loaded http://localhost:37532/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37532/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:15:27 INFO - PID 4224 | RSS: Main: 175423488 18:15:27 INFO - PID 4224 | 18:15:30 INFO - PID 4224 | Cycle 1(1): loaded http://localhost:37532/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37532/tests/kraken/driver.html?testName=imaging-darkroom) 18:15:30 INFO - PID 4224 | RSS: Main: 176381952 18:15:30 INFO - PID 4224 | 18:15:34 INFO - PID 4224 | Cycle 1(1): loaded http://localhost:37532/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37532/tests/kraken/driver.html?testName=imaging-desaturate) 18:15:34 INFO - PID 4224 | RSS: Main: 176566272 18:15:34 INFO - PID 4224 | 18:15:37 INFO - PID 4224 | Cycle 1(1): loaded http://localhost:37532/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37532/tests/kraken/driver.html?testName=json-parse-financial) 18:15:38 INFO - PID 4224 | RSS: Main: 176586752 18:15:38 INFO - PID 4224 | 18:15:40 INFO - PID 4224 | Cycle 1(1): loaded http://localhost:37532/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37532/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:15:40 INFO - PID 4224 | RSS: Main: 176480256 18:15:40 INFO - PID 4224 | 18:15:42 INFO - PID 4224 | Cycle 1(1): loaded http://localhost:37532/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37532/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:15:42 INFO - PID 4224 | RSS: Main: 176730112 18:15:42 INFO - PID 4224 | 18:15:45 INFO - PID 4224 | Cycle 1(1): loaded http://localhost:37532/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37532/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:15:45 INFO - PID 4224 | RSS: Main: 173408256 18:15:45 INFO - PID 4224 | 18:15:48 INFO - PID 4224 | Cycle 1(1): loaded http://localhost:37532/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37532/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:15:49 INFO - PID 4224 | RSS: Main: 173428736 18:15:49 INFO - PID 4224 | 18:15:52 INFO - PID 4224 | Cycle 1(1): loaded http://localhost:37532/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37532/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:15:52 INFO - PID 4224 | RSS: Main: 173981696 18:15:52 INFO - PID 4224 | 18:15:54 INFO - PID 4224 | Cycle 1(1): loaded http://localhost:37532/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37532/tests/kraken/driver.html?testName=ai-astar) 18:15:54 INFO - PID 4224 | RSS: Main: 175669248 18:15:54 INFO - PID 4224 | 18:15:54 INFO - PID 4224 | __start_tp_report 18:15:54 INFO - PID 4224 | _x_x_mozilla_page_load 18:15:54 INFO - PID 4224 | _x_x_mozilla_page_load_details 18:15:54 INFO - PID 4224 | |i|pagename|runs| 18:15:54 INFO - PID 4224 | |0;ai-astar;99;109;101;108;111;112;110;99;109;108 18:15:54 INFO - PID 4224 | |1;audio-beat-detection;145;115;137;205;118;148;140;119;175;118 18:15:54 INFO - PID 4224 | |2;audio-dft;164;163;162;166;163;171;167;165;162;169 18:15:54 INFO - PID 4224 | |3;audio-fft;74;73;74;161;74;78;73;86;106;74 18:15:54 INFO - PID 4224 | |4;audio-oscillator;79;79;129;79;79;80;130;79;78;129 18:15:54 INFO - PID 4224 | |5;imaging-gaussian-blur;117;116;115;114;114;115;115;114;115;115 18:15:54 INFO - PID 4224 | |6;imaging-darkroom;149;148;149;148;148;147;147;148;147;148 18:15:54 INFO - PID 4224 | |7;imaging-desaturate;94;93;94;95;98;99;95;94;95;95 18:15:54 INFO - PID 4224 | |8;json-parse-financial;53;53;58;53;52;54;53;53;55;53 18:15:54 INFO - PID 4224 | |9;json-stringify-tinderbox;38;39;45;38;39;38;39;38;39;39 18:15:54 INFO - PID 4224 | |10;stanford-crypto-aes;73;75;74;73;74;74;74;74;75;75 18:15:54 INFO - PID 4224 | |11;stanford-crypto-ccm;125;132;117;119;125;123;115;132;134;155 18:15:54 INFO - PID 4224 | |12;stanford-crypto-pbkdf2;177;170;172;175;173;179;174;184;180;177 18:15:54 INFO - PID 4224 | |13;stanford-crypto-sha256-iterative;65;66;72;65;63;65;64;82;63;63 18:15:54 INFO - PID 4224 | __end_tp_report 18:15:54 INFO - PID 4224 | __start_cc_report 18:15:54 INFO - PID 4224 | _x_x_mozilla_cycle_collect,950 18:15:54 INFO - PID 4224 | __end_cc_report 18:15:54 INFO - PID 4224 | __startTimestamp1504142154802__endTimestamp 18:15:54 INFO - PID 4224 | 18:15:54 INFO - PID 4224 | ------- Summary: start ------- 18:15:54 INFO - PID 4224 | Number of tests: 14 18:15:54 INFO - PID 4224 | 18:15:54 INFO - PID 4224 | [#0] ai-astar Cycles:10 Average:106.60 Median:110.50 stddev:4.97 (4.5%) stddev-sans-first:4.45 18:15:54 INFO - PID 4224 | Values: 99.0 109.0 101.0 108.0 111.0 112.0 110.0 99.0 109.0 108.0 18:15:54 INFO - PID 4224 | 18:15:54 INFO - PID 4224 | [#1] audio-beat-detection Cycles:10 Average:142.00 Median:142.50 stddev:28.95 (20.3%) stddev-sans-first:30.68 18:15:54 INFO - PID 4224 | Values: 145.0 115.0 137.0 205.0 118.0 148.0 140.0 119.0 175.0 118.0 18:15:54 INFO - PID 4224 | 18:15:54 INFO - PID 4224 | [#2] audio-dft Cycles:10 Average:165.20 Median:165.50 stddev:3.05 (1.8%) stddev-sans-first:3.20 18:15:54 INFO - PID 4224 | Values: 164.0 163.0 162.0 166.0 163.0 171.0 167.0 165.0 162.0 169.0 18:15:54 INFO - PID 4224 | 18:15:54 INFO - PID 4224 | [#3] audio-fft Cycles:10 Average:87.30 Median:74.00 stddev:27.86 (37.6%) stddev-sans-first:29.13 18:15:54 INFO - PID 4224 | Values: 74.0 73.0 74.0 161.0 74.0 78.0 73.0 86.0 106.0 74.0 18:15:54 INFO - PID 4224 | 18:15:54 INFO - PID 4224 | [#4] audio-oscillator Cycles:10 Average:94.10 Median:79.00 stddev:24.32 (30.8%) stddev-sans-first:25.17 18:15:54 INFO - PID 4224 | Values: 79.0 79.0 129.0 79.0 79.0 80.0 130.0 79.0 78.0 129.0 18:15:54 INFO - PID 4224 | 18:15:54 INFO - PID 4224 | [#5] imaging-gaussian-blur Cycles:10 Average:115.00 Median:115.00 stddev:0.94 (0.8%) stddev-sans-first:0.67 18:15:54 INFO - PID 4224 | Values: 117.0 116.0 115.0 114.0 114.0 115.0 115.0 114.0 115.0 115.0 18:15:54 INFO - PID 4224 | 18:15:54 INFO - PID 4224 | [#6] imaging-darkroom Cycles:10 Average:147.90 Median:148.00 stddev:0.74 (0.5%) stddev-sans-first:0.67 18:15:54 INFO - PID 4224 | Values: 149.0 148.0 149.0 148.0 148.0 147.0 147.0 148.0 147.0 148.0 18:15:54 INFO - PID 4224 | 18:15:54 INFO - PID 4224 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:1.87 (2.0%) stddev-sans-first:1.94 18:15:54 INFO - PID 4224 | Values: 94.0 93.0 94.0 95.0 98.0 99.0 95.0 94.0 95.0 95.0 18:15:54 INFO - PID 4224 | 18:15:54 INFO - PID 4224 | [#8] json-parse-financial Cycles:10 Average:53.70 Median:53.00 stddev:1.70 (3.2%) stddev-sans-first:1.79 18:15:54 INFO - PID 4224 | Values: 53.0 53.0 58.0 53.0 52.0 54.0 53.0 53.0 55.0 53.0 18:15:54 INFO - PID 4224 | 18:15:54 INFO - PID 4224 | [#9] json-stringify-tinderbox Cycles:10 Average:39.20 Median:39.00 stddev:2.10 (5.4%) stddev-sans-first:2.18 18:15:54 INFO - PID 4224 | Values: 38.0 39.0 45.0 38.0 39.0 38.0 39.0 38.0 39.0 39.0 18:15:54 INFO - PID 4224 | 18:15:54 INFO - PID 4224 | [#10] stanford-crypto-aes Cycles:10 Average:74.10 Median:74.00 stddev:0.74 (1.0%) stddev-sans-first:0.67 18:15:54 INFO - PID 4224 | Values: 73.0 75.0 74.0 73.0 74.0 74.0 74.0 74.0 75.0 75.0 18:15:54 INFO - PID 4224 | 18:15:54 INFO - PID 4224 | [#11] stanford-crypto-ccm Cycles:10 Average:127.70 Median:128.50 stddev:11.60 (9.0%) stddev-sans-first:12.26 18:15:54 INFO - PID 4224 | Values: 125.0 132.0 117.0 119.0 125.0 123.0 115.0 132.0 134.0 155.0 18:15:54 INFO - PID 4224 | 18:15:54 INFO - PID 4224 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.10 Median:177.00 stddev:4.18 (2.4%) stddev-sans-first:4.42 18:15:54 INFO - PID 4224 | Values: 177.0 170.0 172.0 175.0 173.0 179.0 174.0 184.0 180.0 177.0 18:15:54 INFO - PID 4224 | 18:15:54 INFO - PID 4224 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.80 Median:65.00 stddev:5.96 (9.2%) stddev-sans-first:6.28 18:15:54 INFO - PID 4224 | Values: 65.0 66.0 72.0 65.0 63.0 65.0 64.0 82.0 63.0 63.0 18:15:54 INFO - PID 4224 | -------- Summary: end -------- 18:15:54 INFO - PID 4224 | 18:15:55 INFO - PID 4224 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 18:15:55 INFO - TEST-INFO | 4224: exit 0 18:15:55 INFO - TEST-OK | kraken | took 61129ms 18:15:55 INFO - SUITE-END | took 1174s 18:15:55 INFO - Completed test suite (00:19:34) 18:15:55 INFO - javascript benchmark 18:15:55 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8659.225968344666, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3302.0919247207016, 3334.266461378496, 3343.765936384453, 3362.2434952135764, 3399.84700688469, 6160.691965401728, 6192.50459963203, 6235.688215589219, 6240.188775459184, 6251.53113516487, 6233.875322493547, 6306.463950564196, 6425.518086143535, 6437.45281651059, 6477.54657173998, 5817.476427121558, 5838.854028649275, 5890.3226128995175, 5930.0, 5965.194698715662, 5727.856803579923, 5775.3358363788075, 5787.681677507735, 5869.706514674249, 5904.2324497815225, 5869.853253668671, 5870.970645146768, 5878.353381128072, 5887.146363777271, 5892.086726557391, 5790.507806836424, 5831.9416805831825, 5849.093390524476, 5866.384029676865, 5885.47030767233, 5665.716714164317, 5683.147527870811, 5714.200011998323, 5773.1051686988585, 5844.795432159896, 6300.0, 6340.556161068727, 6369.745210191587, 6370.171877655921, 6381.840453988641, 6770.661466926634, 6771.052052712575, 6858.51990360675, 6861.897071543931, 6871.622060786654, 6832.760853370109, 6840.384365407088, 6911.723531058751, 6923.9653801730665, 6932.168139823203, 6220.968895155541, 6296.275928268262, 6301.1493448384335, 6366.236051673829, 6384.648844313608, 6979.162500499871, 6981.092457980531, 7046.823829404306, 7069.081019467436, 7070.0, 6534.934650653433, 6591.901121483085, 6610.0, 6687.899681504781, 6765.05289259504, 6718.49611279156, 6720.327967203339, 6732.596044237263, 6734.730610775612, 6740.662966851638, 6658.067870498134, 6663.766768163091, 6664.8000559983275, 6676.098726671934, 6679.899801502981, 6605.273419923805, 6670.0, 6672.633005184664, 6672.666366681647, 6672.9332706673285, 5199.090159222121, 5216.4522725114075, 5227.790888364499, 5230.34620672416, 5230.660007099526, 4692.812287508462, 4695.5539223773685, 4708.788104535304, 4711.363965864564, 4719.480857105716, 5942.940570594239, 5966.642001479925, 5974.253218347707, 5974.492168165754, 6011.639301641828, 6802.14973128359, 6806.897896531556, 6884.0018197361105, 6885.1049363582415, 6887.380135787803, 5843.824685259449, 5909.409059094142, 5955.791547295824, 6040.275166979991, 6052.182955301066, 5805.854853628609, 5852.678102704393, 5855.151003104526, 5868.794592189253, 5872.530197584183, 6548.476121910236, 6628.668566571652, 6633.071370008202, 6637.46900247979, 6644.734210631617, 6734.0572319875255, 6750.122484077038, 6760.053592496956, 6830.521863469509, 6832.624205668736, 6443.259025212161, 6519.8044058678315, 6605.0, 6648.434883034996, 6678.298778628174, 6693.933060669331, 6695.966520167368, 6710.731570737116, 6731.730730770714, 6738.663066846736, 6694.564853284521, 6813.148356455443, 6816.182058153054, 6887.414569761627, 6887.483438742214, 6563.967180164069, 6569.146011018537, 6657.866842663023, 6665.766698165541, 6666.533342665967, 6523.64119973387, 6545.901811472927, 6640.07039014548, 6647.235567909753, 6660.700268487833, 6356.491480681442, 6471.158749362553, 6477.222733272038, 6487.1566696331065, 6564.916788729806, 6487.091807146909, 6602.306757790555, 6616.66916654175, 6622.8344291393105, 6643.136392268974, 6363.649999250086, 6371.076193951943, 6384.457321127757, 6389.456896163878, 6397.26431460388], "value": 6189.224172374843, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [786.6538722961897, 817.4645607127334, 841.2008591837755, 862.5557837713578, 864.2869632553145, 41506.79246603767, 42111.78944105283, 42185.0, 42245.78877105618, 42364.57635423645, 38135.23729525415, 38269.234615307745, 38339.424908626395, 38437.807810960905, 38517.614823851756, 6917.896231556518, 7055.082839230919, 7060.470464715141, 7079.85840283194, 7080.929190708079, 6975.0, 7721.961390193069, 7931.801704957365, 7936.6825326986855, 7937.4840635358805, 7903.446758726892, 7915.722949696762, 7946.920530794705, 7953.681852725913, 7959.3632509399395, 7729.884051739228, 7990.0, 7990.64042118106, 7995.120536740954, 8001.799955001114, 7737.613119344067, 7816.765497035098, 7821.452498325119, 7823.374130069581, 7823.569703666296, 38452.42321365182, 38738.61261387378, 38807.223855523014, 38831.0, 38861.22277554433, 3529.32942740881, 3560.1989552350774, 3568.3041806847673, 3569.5181150544604, 3575.1598374382, 32161.839190803898, 32203.51694724581, 32212.516812247835, 32281.677183228338, 32298.0, 5139.229115632685, 5226.242194881721, 5277.02375060615, 5340.172273297645, 5418.187271909245, 185896.99999999866, 187549.0, 188279.0, 189018.0, 202680.0, 48884.51115488871, 49043.509564904605, 49049.75475122601, 49208.26187607189, 49214.50785492171, 51244.231336529985, 51277.23084153741, 51285.23072153921, 51311.0, 51331.0, 14813.0, 14848.480303189337, 14915.850841491663, 14950.850491494946, 14958.850411495745, 12022.218555793845, 12026.218295810919, 12026.4588093536, 12029.578964736193, 12031.518739250507, 13968.720625587432, 14019.0, 14032.438702451991, 14091.506797262047, 14165.645858853612, 5487.204355368529, 5514.365847927459, 5552.305961754781, 5640.717964101778, 5686.715664216773, 1023.3808545829814, 1031.7059638003134, 1039.3140527251978, 1040.3510435958938, 1045.843123531461, 22925.88537057304, 23414.414639634146, 23494.177703780628, 29840.850795745882, 30326.393472130432, 1121.7363919478917, 1127.703141387411, 1129.6159305836056, 1134.9319040857574, 1151.9424028798526, 15915.602109947113, 16343.673126537402, 16394.83605163933, 16525.504234872973, 16742.162891855358, 230924.0, 233081.0, 234596.0, 235440.0, 235594.0, 57641.13538296929, 57678.0, 58156.41843581595, 58221.0, 58295.41704582985, 1468.7356275870231, 1487.6429656882488, 1492.4552538323435, 1520.9163496007604, 1536.6619343744358, 27570.656494198218, 27673.0, 27862.860685696443, 28468.715312846605, 28533.714662853105, 39471.0, 39729.205415890945, 39777.20445591014, 39799.0, 39844.80077599594, 208162.0, 209176.0, 209382.0, 210315.0, 210438.0, 34103.48844767281, 34597.65402346045, 34706.305873882884, 38099.80950095343, 39558.2088358237, 48163.27755083747, 48257.75871120622, 48537.757311213216, 48583.0, 48860.26709599288, 34626.82686586551, 34843.0, 34984.0, 35112.297754045285, 35374.0, 35071.47392789161, 35079.47380789239, 35290.647093528736, 35476.0, 36040.8197959019, 38230.42654360242, 40389.394159088224, 40429.39355909605, 40609.59390406058, 41057.1788564233, 33574.0, 34362.65637343695, 34509.654903450646, 34574.82712586421, 35427.468587971714, 24265.272041838773, 25029.624555631315, 25445.745542544337, 25851.353716157246, 26099.869500652374], "value": 17798.804398001364, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [568.3946596874329, 568.8009196781125, 570.8316046766204, 581.4098689829821, 585.5520526797001, 22281.777182228172, 22494.43763905899, 23081.538369232607, 23139.19012834549, 23222.419439514022, 23749.64375534364, 25422.36444088899, 25573.0, 25600.359991000234, 25613.35966600836, 6547.738090476387, 6677.732890684367, 6679.532432729687, 6694.0962969999155, 6695.866082678343, 6099.085137229406, 6389.329120442357, 6712.0938673279215, 6714.093597364366, 6717.596944183365, 6670.23292321382, 6678.131842860445, 6683.799486015403, 6685.197776266855, 6704.564203326792, 6683.465322774166, 6693.83265418366, 6696.861533539286, 6710.42961348286, 6717.529772915897, 6206.534509911775, 6219.782307619257, 6222.284437289724, 6230.875382492325, 6233.5948163369685, 27929.301767455774, 28124.437511249864, 29327.706722932926, 29465.0, 29493.852530737207, 2031.4007367826528, 2086.384516567616, 2086.478380404899, 2086.8539202255847, 2092.299079808266, 19674.114664840115, 20152.596948060956, 20248.898755506274, 20252.291169808985, 20297.89851050735, 2403.0, 2424.830261881669, 2491.1281051631963, 2496.875156242199, 2501.249625112459, 129798.0, 133292.33353833266, 133683.33158334147, 134257.0, 134843.0, 14092.929535352258, 14590.133614592141, 14613.926930365493, 14955.925220373829, 15074.321655525528, 22284.55430891373, 22332.77667223307, 22362.776372236396, 22374.776252237596, 22401.551968960528, 9969.40183588987, 10051.246156538142, 10174.389536627827, 10337.9483102584, 10387.272890897564, 8059.395545334123, 9481.478518681539, 9540.761480962892, 9577.952110239543, 9676.612935482643, 7889.250521200477, 9054.728358149267, 9098.363114582047, 9215.815683686289, 9353.485558294358, 2728.7953403494816, 2744.8078634495396, 2758.3931535062256, 2817.873195706198, 2874.2814296425895, 967.1827305926481, 970.3789574672215, 984.3060642247199, 985.7141428985657, 1009.2128140050772, 18854.71717924232, 19167.424977250706, 19427.32004379868, 19563.51091222731, 19588.608227835364, 1033.1012019542895, 1052.9578816847393, 1059.5443959097508, 1060.3849767135043, 1061.5276202089997, 10800.24398292112, 10871.45642717861, 10906.291091079054, 10959.397233152253, 11062.79613746771, 467919.0, 469905.0, 486316.0, 487130.0, 488644.0, 106025.0, 108205.0, 109895.0, 110183.44908275407, 110276.4486177564, 1171.7832201042834, 1178.3636836108576, 1196.6230637349206, 1198.9820152697716, 1203.1998720850536, 17517.737233941756, 17542.21060052275, 17749.645007100044, 17785.911070444567, 18050.007249601396, 54262.45737542574, 54987.72506137604, 56768.71615641895, 57589.42410575841, 58297.4170258292, 67087.66456167688, 68022.3197768016, 68113.0, 68456.31543684698, 69325.30674693189, 14516.346764395415, 14898.478553251018, 14919.776203357176, 15030.473933412715, 15036.0, 23520.647190291817, 23557.882210588836, 23620.8818955911, 23680.644790328504, 23765.16821911225, 15364.615884602974, 15447.304871280594, 15566.688666226839, 15580.454684086002, 18665.720014199527, 16811.663766724352, 17107.65784684324, 17243.84451943507, 17292.654146917244, 17714.73427898557, 18468.799528030635, 19246.326378576683, 19413.12640931133, 19450.513737156685, 19496.122674479968, 14653.706925861636, 14681.48614798477, 14716.117032977627, 14753.114813111248, 14783.113013219241, 18582.535436614195, 18631.906840465712, 18643.627127457647, 18778.342758003404, 18941.90529047346], "value": 11937.467658815916, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1335.646053795744, 1382.0532934939567, 1415.7451658701436, 1420.8366037905637, 1421.0478979084012, 12554.0, 14961.775573366409, 15646.217689115527, 15673.843261567396, 15681.764773528392, 12706.17409868358, 15098.622534436645, 15467.0, 15522.456714015012, 15561.766573501407, 2791.1626512046455, 2851.130405226405, 2854.24362543925, 2858.4568931902977, 2861.8998335058277, 2692.1519721287827, 2790.6093146959442, 2854.8287102773797, 2863.9856800715966, 2887.927801804951, 2872.6983666714905, 2904.2739315171207, 2904.5062339402352, 2904.622399088116, 2904.6804851466322, 2695.2992222022317, 2719.3473566344032, 2740.0409856550345, 2740.767034802024, 2743.711910249415, 2739.876705548255, 2767.4741799058115, 2768.764655004327, 2771.3071732066983, 2773.500769861424, 14930.850691493055, 15238.161901095435, 15240.314185861664, 15242.085474871543, 15265.38938442461, 8053.1946805319585, 8370.623321950527, 8381.790455238606, 8383.455075420079, 8398.538080405575, 5259.817175872008, 5432.6468779529205, 5499.312585926759, 5579.8605034874045, 5676.829695109153, 1904.64764018657, 1910.6656335141295, 1942.9611407771765, 1961.0880940362658, 1989.1446677928484, 27077.187684369303, 27315.590266146024, 27358.0, 27406.5889011665, 27433.45133097327, 6679.395035935989, 6839.247682754893, 6943.201531823804, 7057.6118313492225, 7185.0, 17525.824741752418, 17600.823991760175, 17614.823851761575, 17620.823791762174, 17624.0, 7836.412269079728, 7957.681692732342, 7958.482698624571, 7984.321332686786, 7997.800054998672, 7192.856142877114, 7261.41908647307, 7319.670614822346, 7327.010853534811, 7354.889676654854, 5106.591472682177, 5321.760520776575, 5356.035913535523, 5402.6758394496455, 5409.756560954766, 1399.1605036977935, 1475.8229012518566, 1541.514422956765, 1557.540525544967, 1591.2362066208284, 844.4468872888268, 855.1192271959891, 871.8561437362764, 876.8640860666607, 891.7191084808264, 7244.492885497964, 7257.0, 7283.7450689225625, 7292.3801476874, 7318.487705860645, 970.5341436110706, 992.2012779712401, 1003.894591067942, 1005.0703099632957, 1010.0909181736496, 4441.422615060022, 4494.988627558773, 4518.43519560055, 4555.861034741315, 4610.585047345688, 21351.359459216248, 21880.671789923163, 21908.342749717533, 22071.558568828532, 22248.443788905406, 20995.47511312199, 21641.45896352572, 21748.0, 21993.0, 22051.779482205293, 11333.829992550118, 11481.770364592661, 11551.480183391935, 11670.70823229426, 11685.240459370114, 8559.62308080484, 8898.86651700238, 9040.050794666728, 9095.045020272775, 9138.68014619485, 18249.270029198684, 18320.0, 18640.720389193903, 18756.062196889827, 19068.618627627646, 18876.33932812345, 19261.614767704286, 19328.61342773165, 19501.804981949997, 19707.40877773669, 13556.254406007763, 13836.23900685472, 13884.930575347058, 13897.722045559234, 13900.582982510541, 14046.0, 14068.437262509386, 14152.292385380895, 14181.14913105217, 14194.219317937612, 11187.944060279646, 11291.548338066714, 11573.305601663928, 11591.420428978348, 11692.123090768056, 10874.075703565286, 11061.723456913642, 11085.22403431752, 11182.161337899528, 11184.496697648789, 9455.905440945502, 9994.250431217833, 10065.144462720751, 10081.344712593658, 10089.697309080739, 7361.785305424545, 7370.410367170506, 7376.151742549676, 7416.7774966751085, 7536.24637536242, 7723.304902558797, 7751.263629955145, 7760.611969401621, 7770.14528401864, 7828.373730101464], "value": 6773.326375402004, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [509.6941834899061, 510.8135530531355, 528.2920886012743, 533.9065663508885, 541.7453796715545, 6346.904796428052, 6380.968095159524, 6397.200349956255, 6402.135711678922, 6471.96133218036, 6035.336113027563, 6081.726322315495, 6304.464120549747, 6304.747810087591, 6309.179806625132, 5272.736363181844, 5327.520523152915, 5340.67955922644, 5342.2253773202865, 5347.037533244004, 5268.209768534732, 5272.683638981654, 5278.313819203518, 5296.999999999981, 5313.495217954288, 5056.595472362221, 5216.426193118754, 5237.816676416326, 5245.344331958505, 5247.317848679666, 5208.890399388254, 5218.6346955712925, 5223.425423203445, 5224.059669259532, 5242.344706911636, 4821.975890120562, 4859.902801943941, 4865.34317867087, 4892.6575139740235, 4931.506849315076, 6142.249458904235, 6150.630962142286, 6186.288576813634, 6213.5029197664535, 6235.906461403082, 5989.191459153002, 6007.189029481052, 6072.119542666333, 6073.301570319426, 6113.877722445526, 6659.533832631718, 6686.765963191265, 6692.966535167342, 6695.732170713166, 6736.865262694719, 5272.314599102092, 5287.35632183908, 5290.0, 5316.0, 5344.679319240858, 6945.89581156283, 6975.162980442379, 6984.266652001517, 7020.297970202939, 7066.999999999948, 5472.753726082336, 5521.171824226318, 5532.6680399176175, 5548.306461692288, 5591.245181900392, 5523.309586301712, 5530.834074977757, 5552.91670624941, 5555.972220138954, 5605.010221371436, 6033.637981721111, 6049.304330002018, 6082.513398928075, 6094.451499365078, 6104.542159338067, 6627.095948997803, 6700.865982680319, 6759.695813688396, 6806.217285012188, 6821.21556021054, 1910.617876424693, 1914.2438736698925, 1921.2996498099283, 1940.1366391955444, 1951.8926459044606, 1316.374722007039, 1335.2055526961442, 1336.6057013181135, 1346.6902612399008, 1418.0924208506565, 5828.5337173026055, 5886.499647530008, 5898.734556944948, 5907.818436312668, 5956.583039187302, 6555.901661475082, 6591.901121483182, 6631.403173714389, 6650.674662668665, 6677.699503522354, 5792.623479473821, 5795.884082318415, 5843.620164689281, 5901.734421950937, 5919.6744179070565, 3551.7691350062164, 3564.287142571496, 3584.623614520438, 3634.800085995296, 3655.94516082259, 6509.153810004669, 6553.148090748172, 6662.600243985279, 6700.497462690318, 6709.664516774142, 6888.621125838127, 6914.585124892523, 6954.826129346706, 7014.719411223494, 7060.399866011447, 6461.935380646321, 6582.967085164543, 6685.933140668531, 6727.226368967534, 6728.596284222962, 6637.435817955527, 6655.005247638679, 6718.395344419026, 6750.966245168939, 6849.349311815369, 6690.866182676222, 6709.0, 6738.797836064926, 6800.183977922681, 6820.658967051529, 6548.377904099103, 6555.770548030796, 6604.8348791280605, 6682.431993280626, 6712.697928593323, 4995.350604421402, 5000.699958002531, 5001.4998500149695, 5051.974740126276, 5074.528386767944, 6811.9659401702675, 6812.727490900506, 6817.693203805939, 6883.0, 6924.619145947021, 6561.114249576246, 6571.934280657132, 6611.371919667624, 6632.933670663231, 6647.700853461509, 6457.0951569286235, 6563.7702680405955, 6580.967095164494, 6602.801915942529, 6644.83387915306, 6200.3179650237535, 6340.619562826245, 6378.457831084224, 6525.771597994048, 6538.6517965552375, 6343.52423568225, 6451.3226111257645, 6474.255460622088, 6528.575642583217, 6658.500612453989, 6248.343923888108, 6276.278228003838, 6277.937220627918, 6289.496840252677, 6469.4824414045825], "value": 5223.56418817287, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [903.7830920579058, 910.3127139010046, 918.5269586163125, 924.8751418558497, 926.1433174313759, 18091.72862407065, 18594.721079183808, 18726.34457793974, 18754.156062977163, 19904.402867913985, 20496.590068198664, 21376.679349809765, 21513.46216344588, 21556.137754489842, 21618.459538511506, 996.526649841325, 1007.1791489935679, 1011.9089281964622, 1012.2863381316155, 1012.9594816207343, 941.1341565759518, 976.7997560500116, 980.5832521178471, 1005.607812952949, 1008.4503945349802, 1046.9371837689764, 1048.2190767877942, 1048.3185929146039, 1049.8057859296016, 1049.9055085042344, 1048.612013554982, 1049.1449468683, 1050.3120456101267, 1051.106559424487, 1051.9053285204368, 763.2672634271106, 770.8766597344454, 770.9884351734728, 771.1401787007502, 771.9536827790295, 19065.0, 19089.0, 19296.1316740747, 19361.32235371755, 19982.70025949612, 21082.894585527127, 21486.462838429165, 21920.561588768294, 21924.232651857266, 22031.228906988177, 17021.914890425593, 17197.91401042999, 17407.56481087983, 17458.912705436393, 17619.383321583682, 3694.501242332278, 3723.6090210527777, 3724.5344331958504, 3725.3666876631037, 3727.683146932514, 122644.0, 122929.0, 123815.38092309481, 125386.37306813408, 125774.0, 16485.670286594202, 16868.831311686972, 17333.47999560015, 17393.739093913602, 17497.912510437367, 29597.852010739807, 29959.550606740915, 30075.0, 30252.84873575618, 30592.0, 7624.961875190588, 8047.235512626291, 8623.741287761377, 8762.474251544927, 8853.026167121612, 4280.72175308604, 4361.0, 4374.759388233614, 4379.802908869108, 4396.626286765597, 5262.500062494057, 5317.707526086102, 5348.438413966555, 5356.1697936819855, 5387.649802762808, 1080.1412876762993, 1087.2389327470803, 1102.2614848051824, 1104.6023431564631, 1107.534835369147, 681.6285124607101, 691.8235849858254, 700.6636814329048, 705.6295444891473, 709.021550260637, 11536.826947595793, 11725.882741172649, 11775.0, 11932.22440541362, 12062.215955962834, 677.6814896998403, 694.6630884021246, 698.8951657251453, 699.6921354603958, 705.0376236437227, 5574.219609254707, 5600.747966341524, 5921.289445266596, 5966.970165149233, 6208.099825525273, 103230.48384758028, 105048.47475762572, 105096.0, 108238.45880770545, 109462.45268773605, 94857.05142948483, 95812.52093739486, 95836.52081739546, 97045.0, 100263.0, 83320.58339708262, 85249.0, 85629.71555426673, 86189.0, 86881.56559217164, 12339.197952133083, 12340.382980850742, 12409.193402428813, 12466.626001219978, 12581.119321647397, 38426.23147536978, 39655.40516892191, 39799.80100099481, 39848.402273966494, 40015.398999064964, 51855.0, 52265.47734522606, 52574.73712631565, 53667.46332536625, 54330.72834635802, 17428.82571174272, 17610.82389176092, 18065.09674516295, 18121.36575219861, 18213.90893045526, 16341.918290408472, 18572.535686607403, 18829.058547072866, 18939.33712320062, 18980.620387592448, 17566.91216543909, 17643.823561764733, 17721.02534360571, 17734.91132544329, 17789.0, 17783.110844457984, 17917.014564199093, 18015.639687206443, 18027.819721802614, 18035.0, 16035.118068506345, 16181.514554563382, 16241.0, 16346.918265409073, 16368.017918924903, 13760.17438953666, 14115.929420353243, 14137.646558836112, 14379.496717614833, 14425.20661363635, 13417.530386436429, 13540.864591354355, 13592.116512427056, 13629.863701363256, 13634.386452609855], "value": 9060.267778032487, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1490.8999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 109.0, 101.0, 108.0, 111.0, 112.0, 110.0, 99.0, 109.0, 108.0], "value": 106.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 115.0, 137.0, 205.0, 118.0, 148.0, 140.0, 119.0, 175.0, 118.0], "value": 142.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 162.0, 166.0, 163.0, 171.0, 167.0, 165.0, 162.0, 169.0], "value": 165.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 74.0, 161.0, 74.0, 78.0, 73.0, 86.0, 106.0, 74.0], "value": 87.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 129.0, 79.0, 79.0, 80.0, 130.0, 79.0, 78.0, 129.0], "value": 94.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 115.0, 114.0, 114.0, 115.0, 115.0, 114.0, 115.0, 115.0], "value": 115.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 148.0, 149.0, 148.0, 148.0, 147.0, 147.0, 148.0, 147.0, 148.0], "value": 147.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 94.0, 95.0, 98.0, 99.0, 95.0, 94.0, 95.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 58.0, 53.0, 52.0, 54.0, 53.0, 53.0, 55.0, 53.0], "value": 53.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 39.0, 45.0, 38.0, 39.0, 38.0, 39.0, 38.0, 39.0, 39.0], "value": 39.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 75.0, 74.0, 73.0, 74.0, 74.0, 74.0, 74.0, 75.0, 75.0], "value": 74.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 132.0, 117.0, 119.0, 125.0, 123.0, 115.0, 132.0, 134.0, 155.0], "value": 127.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 170.0, 172.0, 175.0, 173.0, 179.0, 174.0, 184.0, 180.0, 177.0], "value": 176.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 72.0, 65.0, 63.0, 65.0, 64.0, 82.0, 63.0, 63.0], "value": 66.8, "unit": "score"}]}]} 18:15:56 INFO - Return code: 0 18:15:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:15:56 INFO - # TBPL SUCCESS # 18:15:56 INFO - Running post-action listener: _package_coverage_data 18:15:56 INFO - Running post-action listener: _resource_record_post_action 18:15:56 INFO - [mozharness: 2017-08-31 01:15:56.116890Z] Finished run-tests step (success) 18:15:56 INFO - Running post-run listener: _resource_record_post_run 18:15:56 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 7462912; Write bytes: 397688832; Read time: 2628; Write time: 301008 18:15:56 INFO - TinderboxPrint: CPU usage
13.1% 18:15:56 INFO - TinderboxPrint: I/O read bytes / time
7,462,912 / 2,628 18:15:56 INFO - TinderboxPrint: I/O write bytes / time
397,688,832 / 301,008 18:15:56 INFO - TinderboxPrint: CPU idle
8,254.7 (86.9%) 18:15:56 INFO - TinderboxPrint: CPU user
1,194.6 (12.6%) 18:15:56 INFO - TinderboxPrint: Swap in / out
0 / 0 18:15:56 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 45056; Write bytes: 112754688; Read time: 184; Write time: 91596 18:15:56 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 18:15:56 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 5672960; Write bytes: 282673152; Read time: 2376; Write time: 209080 18:15:56 INFO - Running post-run listener: _upload_blobber_files 18:15:56 INFO - Blob upload gear active. 18:15:56 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:15:56 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:15:56 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:15:56 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:15:57 INFO - (blobuploader) - INFO - Open directory for files ... 18:15:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 18:15:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:15:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:15:58 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 18:15:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:15:58 INFO - (blobuploader) - INFO - Done attempting. 18:15:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:15:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:15:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:15:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:15:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:15:59 INFO - (blobuploader) - INFO - Done attempting. 18:15:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:15:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:15:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:16:04 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:16:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:16:04 INFO - (blobuploader) - INFO - Done attempting. 18:16:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:16:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:16:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:16:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:16:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:16:05 INFO - (blobuploader) - INFO - Done attempting. 18:16:05 INFO - (blobuploader) - INFO - Iteration through files over. 18:16:05 INFO - Return code: 0 18:16:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:16:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:16:05 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b0a2293f6acfa0ddcebd3a3fc47d0311ce32d58872fd3dff36d3720dd2c55964cd65445faad7fd67bf230fb44cfea7a9ce09747443e95220d176b8e77fec34a7", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e21d43e58811de7b2383941214b1d5718b85e6cd2cd444f916886ecf49e6fc6f5ac993ac095620fe93c7ea7d6ad9eefc11b5e22c37489fd4a0731c96f96497dc", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fe625e02ebb1568fc5bdd2712529f6ec0bd008a984f3de1d48aade5008871afa67b15d7f3a224b7533dc6fd4b980eaf7babdb5317d884349aa42d895c10fc38c", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e937f5e9950af1c8e44fdb90557c22622b2596194bde2a26789fedac8b599e2c5519c0962bbeb5633551c68d0c144d6ed72c3abfe4df1a9698ed9a832730f540"} 18:16:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:16:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:16:05 INFO - Contents: 18:16:05 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b0a2293f6acfa0ddcebd3a3fc47d0311ce32d58872fd3dff36d3720dd2c55964cd65445faad7fd67bf230fb44cfea7a9ce09747443e95220d176b8e77fec34a7", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e21d43e58811de7b2383941214b1d5718b85e6cd2cd444f916886ecf49e6fc6f5ac993ac095620fe93c7ea7d6ad9eefc11b5e22c37489fd4a0731c96f96497dc", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fe625e02ebb1568fc5bdd2712529f6ec0bd008a984f3de1d48aade5008871afa67b15d7f3a224b7533dc6fd4b980eaf7babdb5317d884349aa42d895c10fc38c", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e937f5e9950af1c8e44fdb90557c22622b2596194bde2a26789fedac8b599e2c5519c0962bbeb5633551c68d0c144d6ed72c3abfe4df1a9698ed9a832730f540"} 18:16:05 INFO - Running post-run listener: copy_logs_to_upload_dir 18:16:05 INFO - Copying logs to upload dir... 18:16:05 INFO - mkdir: /builds/slave/test/build/upload/logs 18:16:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1254.783173 ========= master_lag: -0.06 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-08-30 18:16:05.790055) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-30 18:16:05.795889) ========= 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=d2a8c569965ab8367867b893000001a1-1504140908.557164-1212356442 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/b0a2293f6acfa0ddcebd3a3fc47d0311ce32d58872fd3dff36d3720dd2c55964cd65445faad7fd67bf230fb44cfea7a9ce09747443e95220d176b8e77fec34a7", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e21d43e58811de7b2383941214b1d5718b85e6cd2cd444f916886ecf49e6fc6f5ac993ac095620fe93c7ea7d6ad9eefc11b5e22c37489fd4a0731c96f96497dc", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fe625e02ebb1568fc5bdd2712529f6ec0bd008a984f3de1d48aade5008871afa67b15d7f3a224b7533dc6fd4b980eaf7babdb5317d884349aa42d895c10fc38c", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e937f5e9950af1c8e44fdb90557c22622b2596194bde2a26789fedac8b599e2c5519c0962bbeb5633551c68d0c144d6ed72c3abfe4df1a9698ed9a832730f540"} build_url:https://queue.taskcluster.net/v1/task/JjWT5fwtQZy7VNboNo6e0g/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011199 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/b0a2293f6acfa0ddcebd3a3fc47d0311ce32d58872fd3dff36d3720dd2c55964cd65445faad7fd67bf230fb44cfea7a9ce09747443e95220d176b8e77fec34a7", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e21d43e58811de7b2383941214b1d5718b85e6cd2cd444f916886ecf49e6fc6f5ac993ac095620fe93c7ea7d6ad9eefc11b5e22c37489fd4a0731c96f96497dc", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fe625e02ebb1568fc5bdd2712529f6ec0bd008a984f3de1d48aade5008871afa67b15d7f3a224b7533dc6fd4b980eaf7babdb5317d884349aa42d895c10fc38c", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e937f5e9950af1c8e44fdb90557c22622b2596194bde2a26789fedac8b599e2c5519c0962bbeb5633551c68d0c144d6ed72c3abfe4df1a9698ed9a832730f540"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-30 18:16:05.822826) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-30 18:16:05.823180) ========= 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=d2a8c569965ab8367867b893000001a1-1504140908.557164-1212356442 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004405 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-30 18:16:05.908481) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-30 18:16:05.908809) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-30 18:16:05.909116) ========= ========= Total master_lag: 0.11 =========