builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-073 starttime: 1505958736.4 results: success (0) revision: efff4f307675a2226d4ef5867d64b6499bde39e3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-20 18:52:16.405266) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-20 18:52:16.405747) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-20 18:52:16.406019) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-20 18:52:16.431543) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-20 18:52:16.434878) ========= 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=9531f05ccb2eabcb9acf5f1b000001c0-1505958554.210787-323026496 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-20 18:52:16-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.4M=0s 2017-09-20 18:52:16 (46.4 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.129278 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-20 18:52:16.588951) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-20 18:52:16.589246) ========= 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=9531f05ccb2eabcb9acf5f1b000001c0-1505958554.210787-323026496 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015742 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-20 18:52:16.642624) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-20 18:52:16.646171) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev efff4f307675a2226d4ef5867d64b6499bde39e3 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev efff4f307675a2226d4ef5867d64b6499bde39e3 --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=9531f05ccb2eabcb9acf5f1b000001c0-1505958554.210787-323026496 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-20 18:52:16,576 truncating revision to first 12 chars 2017-09-20 18:52:16,576 Setting DEBUG logging. 2017-09-20 18:52:16,576 attempt 1/10 2017-09-20 18:52:16,576 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/efff4f307675?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-20 18:52:17,030 unpacking tar archive at: mozilla-beta-efff4f307675/testing/mozharness/ program finished with exit code 0 elapsedTime=0.812346 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-20 18:52:17.476138) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-20 18:52:17.476444) ========= script_repo_revision: efff4f307675a2226d4ef5867d64b6499bde39e3 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-20 18:52:17.476825) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-20 18:52:17.477120) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-20 18:52:17.493124) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2017-09-20 18:52:17.493501) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9531f05ccb2eabcb9acf5f1b000001c0-1505958554.210787-323026496 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:52:17 INFO - MultiFileLogger online at 20170920 18:52:17 in /builds/slave/test 18:52:17 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta-Non-PGO 18:52:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:52:17 INFO - {'append_to_log': False, 18:52:17 INFO - 'base_work_dir': '/builds/slave/test', 18:52:17 INFO - 'blob_upload_branch': 'Mozilla-Beta-Non-PGO', 18:52:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:52:17 INFO - 'branch': 'Mozilla-Beta-Non-PGO', 18:52:17 INFO - 'buildbot_json_path': 'buildprops.json', 18:52:17 INFO - 'code_coverage': False, 18:52:17 INFO - 'config_files': ('talos/linux_config.py',), 18:52:17 INFO - 'default_actions': ('clobber', 18:52:17 INFO - 'read-buildbot-config', 18:52:17 INFO - 'download-and-extract', 18:52:17 INFO - 'populate-webroot', 18:52:17 INFO - 'create-virtualenv', 18:52:17 INFO - 'install', 18:52:17 INFO - 'setup-mitmproxy', 18:52:17 INFO - 'run-tests'), 18:52:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:52:17 INFO - 'disable_ccov_upload': False, 18:52:17 INFO - 'disable_stylo': False, 18:52:17 INFO - 'download_minidump_stackwalk': True, 18:52:17 INFO - 'download_symbols': 'ondemand', 18:52:17 INFO - 'enable_stylo': False, 18:52:17 INFO - 'enable_webrender': False, 18:52:17 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 18:52:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:52:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:52:17 INFO - 'gecko_profile': False, 18:52:17 INFO - 'gecko_profile_interval': 0, 18:52:17 INFO - 'installer_path': 'installer.exe', 18:52:17 INFO - 'log_level': 'info', 18:52:17 INFO - 'log_name': 'talos', 18:52:17 INFO - 'log_to_console': True, 18:52:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:52:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:52:17 INFO - 'opt_config_files': (), 18:52:17 INFO - 'pip_index': False, 18:52:17 INFO - 'suite': 'dromaeojs-e10s', 18:52:17 INFO - 'system_bits': '32', 18:52:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:52:17 INFO - 'title': 'talos-linux64-ix-073', 18:52:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:52:17 INFO - 'use_talos_json': True, 18:52:17 INFO - 'verify': 'False', 18:52:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:52:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:52:17 INFO - 'work_dir': 'build'} 18:52:17 INFO - [mozharness: 2017-09-21 01:52:17.566501Z] Running clobber step. 18:52:17 INFO - Running pre-action listener: _resource_record_pre_action 18:52:17 INFO - Running main action method: clobber 18:52:17 INFO - rmtree: /builds/slave/test/build 18:52:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:52:19 INFO - Running post-action listener: _resource_record_post_action 18:52:19 INFO - [mozharness: 2017-09-21 01:52:19.084467Z] Finished clobber step (success) 18:52:19 INFO - [mozharness: 2017-09-21 01:52:19.084564Z] Running read-buildbot-config step. 18:52:19 INFO - Running pre-action listener: _resource_record_pre_action 18:52:19 INFO - Running main action method: read_buildbot_config 18:52:19 INFO - Using buildbot properties: 18:52:19 INFO - { 18:52:19 INFO - "project": "", 18:52:19 INFO - "product": "firefox", 18:52:19 INFO - "who": "ryanvm@gmail.com", 18:52:19 INFO - "installer_path": "public/build/target.tar.bz2", 18:52:19 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 18:52:19 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-beta", 18:52:19 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta talos dromaeojs-e10s", 18:52:19 INFO - "stage_platform": "linux64", 18:52:19 INFO - "basedir": "/builds/slave/test", 18:52:19 INFO - "buildnumber": 100, 18:52:19 INFO - "platform": "ubuntu64_hw", 18:52:19 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 18:52:19 INFO - "slavebuilddir": "test", 18:52:19 INFO - "taskId": "AGof_pHAQyCuMw6gw0aOBQ", 18:52:19 INFO - "branch": "mozilla-beta", 18:52:19 INFO - "script_repo_revision": "production", 18:52:19 INFO - "revision": "efff4f307675a2226d4ef5867d64b6499bde39e3", 18:52:19 INFO - "slavename": "talos-linux64-ix-073", 18:52:19 INFO - "repo_path": "releases/mozilla-beta" 18:52:19 INFO - } 18:52:19 INFO - Finding installer, test and symbols from parent task. 18:52:19 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AGof_pHAQyCuMw6gw0aOBQ'}, attempt #1 18:52:19 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AGof_pHAQyCuMw6gw0aOBQ'}, attempt #1 18:52:20 INFO - Task dependencies: b1aUbkquTmWwX3uTXEMXyA 18:52:20 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/b1aUbkquTmWwX3uTXEMXyA'}, attempt #1 18:52:20 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/b1aUbkquTmWwX3uTXEMXyA/artifacts/public/build/target.tar.bz2 18:52:20 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/b1aUbkquTmWwX3uTXEMXyA/artifacts/public/build/target.test_packages.json 18:52:20 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/b1aUbkquTmWwX3uTXEMXyA/artifacts/public/build/target.crashreporter-symbols.zip 18:52:20 INFO - Running post-action listener: _resource_record_post_action 18:52:20 INFO - [mozharness: 2017-09-21 01:52:20.451738Z] Finished read-buildbot-config step (success) 18:52:20 INFO - [mozharness: 2017-09-21 01:52:20.451954Z] Running download-and-extract step. 18:52:20 INFO - Running pre-action listener: _resource_record_pre_action 18:52:20 INFO - Running main action method: download_and_extract 18:52:20 INFO - mkdir: /builds/slave/test/build/tests 18:52: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')]} 18:52:20 INFO - trying https://queue.taskcluster.net/v1/task/b1aUbkquTmWwX3uTXEMXyA/artifacts/public/build/target.test_packages.json 18:52:20 INFO - Downloading https://queue.taskcluster.net/v1/task/b1aUbkquTmWwX3uTXEMXyA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 18:52:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/b1aUbkquTmWwX3uTXEMXyA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 18:52:20 INFO - Downloaded 989 bytes. 18:52:20 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 18:52:21 INFO - Using the following test package requirements: 18:52:21 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 18:52:21 INFO - u'common': [u'target.common.tests.zip'], 18:52:21 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 18:52:21 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 18:52:21 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 18:52:21 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 18:52:21 INFO - u'mozbase': [u'target.common.tests.zip'], 18:52:21 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 18:52:21 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 18:52:21 INFO - u'web-platform': [u'target.common.tests.zip', 18:52:21 INFO - u'target.web-platform.tests.tar.gz'], 18:52:21 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 18:52:21 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 18:52:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/b1aUbkquTmWwX3uTXEMXyA/artifacts/public/build/target.common.tests.zip 18:52:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/b1aUbkquTmWwX3uTXEMXyA/artifacts/public/build/target.common.tests.zip'}, attempt #1 18:52:21 INFO - Fetch https://queue.taskcluster.net/v1/task/b1aUbkquTmWwX3uTXEMXyA/artifacts/public/build/target.common.tests.zip into memory 18:52:22 INFO - Content-Length response header: 55168129 18:52:22 INFO - Bytes received: 55168129 18:52:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/b1aUbkquTmWwX3uTXEMXyA/artifacts/public/build/target.talos.tests.zip 18:52:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/b1aUbkquTmWwX3uTXEMXyA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 18:52:33 INFO - Fetch https://queue.taskcluster.net/v1/task/b1aUbkquTmWwX3uTXEMXyA/artifacts/public/build/target.talos.tests.zip into memory 18:52:35 INFO - Content-Length response header: 14512509 18:52:35 INFO - Bytes received: 14512509 18:52:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:52:35 INFO - trying https://queue.taskcluster.net/v1/task/b1aUbkquTmWwX3uTXEMXyA/artifacts/public/build/target.tar.bz2 18:52:35 INFO - Downloading https://queue.taskcluster.net/v1/task/b1aUbkquTmWwX3uTXEMXyA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 18:52:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/b1aUbkquTmWwX3uTXEMXyA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 18:52:37 INFO - Downloaded 53557508 bytes. 18:52:37 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/b1aUbkquTmWwX3uTXEMXyA/artifacts/public/build/target.tar.bz2 18:52:37 INFO - mkdir: /builds/slave/test/properties 18:52:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:52:37 INFO - Writing to file /builds/slave/test/properties/build_url 18:52:37 INFO - Contents: 18:52:37 INFO - build_url:https://queue.taskcluster.net/v1/task/b1aUbkquTmWwX3uTXEMXyA/artifacts/public/build/target.tar.bz2 18:52:37 INFO - Running post-action listener: _resource_record_post_action 18:52:37 INFO - Running post-action listener: find_tests_for_verification 18:52:37 INFO - Running post-action listener: set_extra_try_arguments 18:52:37 INFO - [mozharness: 2017-09-21 01:52:37.922776Z] Finished download-and-extract step (success) 18:52:37 INFO - [mozharness: 2017-09-21 01:52:37.922874Z] Running populate-webroot step. 18:52:37 INFO - Running pre-action listener: _resource_record_pre_action 18:52:37 INFO - Running main action method: populate_webroot 18:52:37 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:52:37 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 18:52:37 INFO - 'tests': ['tresize', 18:52:37 INFO - 'tcanvasmark']}, 18:52:37 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:52:37 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 18:52:37 INFO - 'tests': ['dromaeo_css', 18:52:37 INFO - 'kraken']}, 18:52:37 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 18:52:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:52:37 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 18:52:37 INFO - 'talos_options': ['--disable-stylo'], 18:52:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:52:37 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 18:52:37 INFO - 'tests': ['damp', 'tps']}, 18:52:37 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 18:52:37 INFO - 'talos_options': ['--disable-stylo'], 18:52:37 INFO - 'tests': ['damp', 'tps']}, 18:52:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:52:37 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 18:52:37 INFO - 'tests': ['dromaeo_dom']}, 18:52:37 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 18:52:37 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 18:52:37 INFO - 'tests': ['basic_compositor_video', 18:52:37 INFO - 'glvideo']}, 18:52:37 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 18:52:37 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 18:52:37 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 18:52:37 INFO - 'talos_options': ['--disable-stylo'], 18:52:37 INFO - 'tests': ['ts_paint_webext', 18:52:37 INFO - 'tp5o_webext']}, 18:52:37 INFO - 'other-e10s': {'tests': ['a11yr', 18:52:37 INFO - 'ts_paint', 18:52:37 INFO - 'tpaint', 18:52:37 INFO - 'sessionrestore', 18:52:37 INFO - 'sessionrestore_many_windows', 18:52:37 INFO - 'sessionrestore_no_auto_restore', 18:52:37 INFO - 'tabpaint']}, 18:52:37 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 18:52:37 INFO - 'tests': ['a11yr', 18:52:37 INFO - 'ts_paint', 18:52:37 INFO - 'tpaint', 18:52:37 INFO - 'sessionrestore', 18:52:37 INFO - 'sessionrestore_many_windows', 18:52:37 INFO - 'sessionrestore_no_auto_restore', 18:52:37 INFO - 'tabpaint']}, 18:52:37 INFO - 'perf-reftest-e10s': {'tests': ['perf_reftest']}, 18:52:37 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 18:52:37 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 18:52:37 INFO - 'tests': ['perf_reftest_singletons']}, 18:52:37 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 18:52:37 INFO - 'tests': ['bloom_basic']}, 18:52:37 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:52:37 INFO - 'tsvgr_opacity', 18:52:37 INFO - 'tart', 18:52:37 INFO - 'tscrollx', 18:52:37 INFO - 'tsvg_static']}, 18:52:37 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 18:52:37 INFO - 'tests': ['tsvgx', 18:52:37 INFO - 'tsvgr_opacity', 18:52:37 INFO - 'tart', 18:52:37 INFO - 'tscrollx', 18:52:37 INFO - 'tsvg_static']}, 18:52:37 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 18:52:37 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 18:52:37 INFO - 'talos_options': ['--disable-stylo'], 18:52:37 INFO - 'tests': ['tp5o']}, 18:52:37 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 18:52:37 INFO - 'talos_options': ['--mitmproxy', 18:52:37 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 18:52:37 INFO - '--firstNonBlankPaint'], 18:52:37 INFO - 'tests': ['tp6_google', 18:52:37 INFO - 'tp6_youtube', 18:52:37 INFO - 'tp6_amazon', 18:52:37 INFO - 'tp6_facebook']}, 18:52:37 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 18:52:37 INFO - 'talos_options': ['--disable-stylo', 18:52:37 INFO - '--mitmproxy', 18:52:37 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 18:52:37 INFO - '--firstNonBlankPaint'], 18:52:37 INFO - 'tests': ['tp6_google', 18:52:37 INFO - 'tp6_youtube', 18:52:37 INFO - 'tp6_amazon', 18:52:37 INFO - 'tp6_facebook']}, 18:52:37 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 18:52:37 INFO - 'talos_options': ['--stylo-threads=1', 18:52:37 INFO - '--mitmproxy', 18:52:37 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 18:52:37 INFO - '--firstNonBlankPaint'], 18:52:37 INFO - 'tests': ['tp6_google', 18:52:37 INFO - 'tp6_youtube', 18:52:37 INFO - 'tp6_amazon', 18:52:37 INFO - 'tp6_facebook']}, 18:52:37 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 18:52:37 INFO - 'talos_options': ['--xperf_path', 18:52:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:52:37 INFO - 'tests': ['tp5n']}, 18:52:37 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 18:52:37 INFO - 'talos_options': ['--disable-stylo', 18:52:37 INFO - '--xperf_path', 18:52:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:52:37 INFO - 'tests': ['tp5n']}}} 18:52:37 INFO - Running post-action listener: _resource_record_post_action 18:52:37 INFO - [mozharness: 2017-09-21 01:52:37.940253Z] Finished populate-webroot step (success) 18:52:37 INFO - [mozharness: 2017-09-21 01:52:37.940343Z] Running create-virtualenv step. 18:52:37 INFO - Running pre-action listener: _resource_record_pre_action 18:52:37 INFO - Running main action method: create_virtualenv 18:52:37 INFO - Creating virtualenv /builds/slave/test/build/venv 18:52:37 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 18:52:37 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 18:52:37 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 18:52:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:52:38 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:52:38 INFO - Installing distribute.............................................................................................................................................................................................done. 18:52:38 INFO - Installing pip...............done. 18:52:38 INFO - Return code: 0 18:52:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 18:52:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 18:52:38 INFO - Reading from file tmpfile_stdout 18:52:38 INFO - Output received: 18:52:38 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 18:52:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:52:38 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')]} 18:52:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:52:38 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')]} 18:52:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:52:38 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 0x1a0a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bd2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d75a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d79090>, '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 0x1d79d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d73f90>, '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': '9531f05ccb2eabcb9acf5f1b000001c0-1505958554.210787-323026496', '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 18:52:38 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 18:52:38 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 18:52:38 INFO - Using env: {'DISPLAY': ':0', 18:52:38 INFO - 'HOME': '/home/cltbld', 18:52:38 INFO - 'LANG': 'en_US.UTF-8', 18:52:38 INFO - 'LANGUAGE': 'en_US:en', 18:52:38 INFO - 'LOGNAME': 'cltbld', 18:52:38 INFO - 'MAIL': '/var/mail/cltbld', 18:52:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:52:38 INFO - 'MOZ_NO_REMOTE': '1', 18:52:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:52:38 INFO - 'NO_EM_RESTART': '1', 18:52:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:52:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:52:38 INFO - 'PWD': '/builds/slave/test', 18:52:38 INFO - 'SHELL': '/bin/bash', 18:52:38 INFO - 'SHLVL': '1', 18:52:38 INFO - 'TERM': 'linux', 18:52:38 INFO - 'TMOUT': '86400', 18:52:38 INFO - 'USER': 'cltbld', 18:52:38 INFO - 'XDG_SESSION_COOKIE': '9531f05ccb2eabcb9acf5f1b000001c0-1505958554.210787-323026496', 18:52:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:52:38 INFO - '_': '/tools/buildbot/bin/python'} 18:52:40 INFO - Ignoring indexes: http://pypi.python.org/simple/ 18:52:40 INFO - Downloading/unpacking pip>=1.5 18:52:40 INFO - Running setup.py egg_info for package pip 18:52:40 INFO - warning: no files found matching 'pip/cacert.pem' 18:52:40 INFO - warning: no files found matching '*.html' under directory 'docs' 18:52:40 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 18:52:40 INFO - no previously-included directories found matching 'docs/_build/_sources' 18:52:40 INFO - Installing collected packages: pip 18:52:40 INFO - Found existing installation: pip 1.1 18:52:40 INFO - Uninstalling pip: 18:52:40 INFO - Successfully uninstalled pip 18:52:40 INFO - Running setup.py install for pip 18:52:40 INFO - warning: no files found matching 'pip/cacert.pem' 18:52:40 INFO - warning: no files found matching '*.html' under directory 'docs' 18:52:40 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 18:52:40 INFO - no previously-included directories found matching 'docs/_build/_sources' 18:52:40 INFO - Installing pip script to /builds/slave/test/build/venv/bin 18:52:40 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 18:52:40 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 18:52:40 INFO - Successfully installed pip 18:52:40 INFO - Cleaning up... 18:52:40 INFO - Return code: 0 18:52:40 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:52:40 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')]} 18:52:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:52:40 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')]} 18:52:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:52:40 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 0x1a0a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bd2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d75a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d79090>, '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 0x1d79d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d73f90>, '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': '9531f05ccb2eabcb9acf5f1b000001c0-1505958554.210787-323026496', '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 18:52:40 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 18:52:40 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 18:52:40 INFO - Using env: {'DISPLAY': ':0', 18:52:40 INFO - 'HOME': '/home/cltbld', 18:52:40 INFO - 'LANG': 'en_US.UTF-8', 18:52:40 INFO - 'LANGUAGE': 'en_US:en', 18:52:40 INFO - 'LOGNAME': 'cltbld', 18:52:40 INFO - 'MAIL': '/var/mail/cltbld', 18:52:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:52:40 INFO - 'MOZ_NO_REMOTE': '1', 18:52:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:52:40 INFO - 'NO_EM_RESTART': '1', 18:52:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:52:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:52:40 INFO - 'PWD': '/builds/slave/test', 18:52:40 INFO - 'SHELL': '/bin/bash', 18:52:40 INFO - 'SHLVL': '1', 18:52:40 INFO - 'TERM': 'linux', 18:52:40 INFO - 'TMOUT': '86400', 18:52:40 INFO - 'USER': 'cltbld', 18:52:40 INFO - 'XDG_SESSION_COOKIE': '9531f05ccb2eabcb9acf5f1b000001c0-1505958554.210787-323026496', 18:52:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:52:40 INFO - '_': '/tools/buildbot/bin/python'} 18:52:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:52:40 INFO - Downloading/unpacking psutil>=3.1.1 18:52:40 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 18:52:40 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 18:52:40 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 18:52:40 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 18:52:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:52:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:52:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:52:41 INFO - Installing collected packages: psutil 18:52:41 INFO - Running setup.py install for psutil 18:52:41 INFO - building 'psutil._psutil_linux' extension 18:52:41 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 18:52:41 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 18:52:41 INFO - building 'psutil._psutil_posix' extension 18:52:41 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 18:52:42 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 18:52:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:52:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:52:42 INFO - Successfully installed psutil 18:52:42 INFO - Cleaning up... 18:52:42 INFO - Return code: 0 18:52:42 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:52:42 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')]} 18:52:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:52:42 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')]} 18:52:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:52:42 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 0x1a0a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bd2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d75a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d79090>, '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 0x1d79d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d73f90>, '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': '9531f05ccb2eabcb9acf5f1b000001c0-1505958554.210787-323026496', '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 18:52:42 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 18:52:42 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 18:52:42 INFO - Using env: {'DISPLAY': ':0', 18:52:42 INFO - 'HOME': '/home/cltbld', 18:52:42 INFO - 'LANG': 'en_US.UTF-8', 18:52:42 INFO - 'LANGUAGE': 'en_US:en', 18:52:42 INFO - 'LOGNAME': 'cltbld', 18:52:42 INFO - 'MAIL': '/var/mail/cltbld', 18:52:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:52:42 INFO - 'MOZ_NO_REMOTE': '1', 18:52:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:52:42 INFO - 'NO_EM_RESTART': '1', 18:52:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:52:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:52:42 INFO - 'PWD': '/builds/slave/test', 18:52:42 INFO - 'SHELL': '/bin/bash', 18:52:42 INFO - 'SHLVL': '1', 18:52:42 INFO - 'TERM': 'linux', 18:52:42 INFO - 'TMOUT': '86400', 18:52:42 INFO - 'USER': 'cltbld', 18:52:42 INFO - 'XDG_SESSION_COOKIE': '9531f05ccb2eabcb9acf5f1b000001c0-1505958554.210787-323026496', 18:52:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:52:42 INFO - '_': '/tools/buildbot/bin/python'} 18:52:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:52:42 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:52:42 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 18:52:42 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 18:52:42 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 18:52:42 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 18:52:43 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:52:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:52:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:52:43 INFO - Installing collected packages: mozsystemmonitor 18:52:43 INFO - Running setup.py install for mozsystemmonitor 18:52:43 INFO - Successfully installed mozsystemmonitor 18:52:43 INFO - Cleaning up... 18:52:44 INFO - Return code: 0 18:52:44 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:52: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')]} 18:52:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:52: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')]} 18:52:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:52: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', '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 0x1a0a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bd2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d75a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d79090>, '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 0x1d79d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d73f90>, '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': '9531f05ccb2eabcb9acf5f1b000001c0-1505958554.210787-323026496', '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 18:52: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 18:52: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 jsonschema==2.5.1 18:52:44 INFO - Using env: {'DISPLAY': ':0', 18:52:44 INFO - 'HOME': '/home/cltbld', 18:52:44 INFO - 'LANG': 'en_US.UTF-8', 18:52:44 INFO - 'LANGUAGE': 'en_US:en', 18:52:44 INFO - 'LOGNAME': 'cltbld', 18:52:44 INFO - 'MAIL': '/var/mail/cltbld', 18:52:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:52:44 INFO - 'MOZ_NO_REMOTE': '1', 18:52:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:52:44 INFO - 'NO_EM_RESTART': '1', 18:52:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:52:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:52:44 INFO - 'PWD': '/builds/slave/test', 18:52:44 INFO - 'SHELL': '/bin/bash', 18:52:44 INFO - 'SHLVL': '1', 18:52:44 INFO - 'TERM': 'linux', 18:52:44 INFO - 'TMOUT': '86400', 18:52:44 INFO - 'USER': 'cltbld', 18:52:44 INFO - 'XDG_SESSION_COOKIE': '9531f05ccb2eabcb9acf5f1b000001c0-1505958554.210787-323026496', 18:52:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:52:44 INFO - '_': '/tools/buildbot/bin/python'} 18:52:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:52:44 INFO - Downloading/unpacking jsonschema==2.5.1 18:52:44 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 18:52:44 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 18:52:44 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 18:52:44 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 18:52:45 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:52:45 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:52:45 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 18:52:45 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 18:52:45 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 18:52:45 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 18:52:46 INFO - Downloading functools32-3.2.3-2.tar.gz 18:52:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:52:46 INFO - warning: no files found matching '*.txt' 18:52:46 INFO - no previously-included directories found matching 'build' 18:52:46 INFO - no previously-included directories found matching 'dist' 18:52:46 INFO - no previously-included directories found matching '.git*' 18:52:46 INFO - Installing collected packages: jsonschema, functools32 18:52:46 INFO - Running setup.py install for functools32 18:52:46 INFO - warning: no files found matching '*.txt' 18:52:46 INFO - no previously-included directories found matching 'build' 18:52:46 INFO - no previously-included directories found matching 'dist' 18:52:46 INFO - no previously-included directories found matching '.git*' 18:52:46 INFO - Successfully installed jsonschema functools32 18:52:46 INFO - Cleaning up... 18:52:46 INFO - Return code: 0 18:52:46 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:52:46 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')]} 18:52:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:52:46 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')]} 18:52:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:52:46 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 0x1a0a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bd2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d75a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d79090>, '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 0x1d79d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d73f90>, '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': '9531f05ccb2eabcb9acf5f1b000001c0-1505958554.210787-323026496', '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 18:52:46 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 18:52:46 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 18:52:46 INFO - Using env: {'DISPLAY': ':0', 18:52:46 INFO - 'HOME': '/home/cltbld', 18:52:46 INFO - 'LANG': 'en_US.UTF-8', 18:52:46 INFO - 'LANGUAGE': 'en_US:en', 18:52:46 INFO - 'LOGNAME': 'cltbld', 18:52:46 INFO - 'MAIL': '/var/mail/cltbld', 18:52:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:52:46 INFO - 'MOZ_NO_REMOTE': '1', 18:52:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:52:46 INFO - 'NO_EM_RESTART': '1', 18:52:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:52:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:52:46 INFO - 'PWD': '/builds/slave/test', 18:52:46 INFO - 'SHELL': '/bin/bash', 18:52:46 INFO - 'SHLVL': '1', 18:52:46 INFO - 'TERM': 'linux', 18:52:46 INFO - 'TMOUT': '86400', 18:52:46 INFO - 'USER': 'cltbld', 18:52:46 INFO - 'XDG_SESSION_COOKIE': '9531f05ccb2eabcb9acf5f1b000001c0-1505958554.210787-323026496', 18:52:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:52:46 INFO - '_': '/tools/buildbot/bin/python'} 18:52:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:52:46 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:52:46 INFO - Cleaning up... 18:52:46 INFO - Return code: 0 18:52:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:52:46 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')]} 18:52:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:52:46 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')]} 18:52:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:52:46 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 0x1a0a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bd2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d75a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d79090>, '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 0x1d79d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d73f90>, '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': '9531f05ccb2eabcb9acf5f1b000001c0-1505958554.210787-323026496', '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 18:52:46 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 18:52:46 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 18:52:46 INFO - Using env: {'DISPLAY': ':0', 18:52:46 INFO - 'HOME': '/home/cltbld', 18:52:46 INFO - 'LANG': 'en_US.UTF-8', 18:52:46 INFO - 'LANGUAGE': 'en_US:en', 18:52:46 INFO - 'LOGNAME': 'cltbld', 18:52:46 INFO - 'MAIL': '/var/mail/cltbld', 18:52:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:52:46 INFO - 'MOZ_NO_REMOTE': '1', 18:52:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:52:46 INFO - 'NO_EM_RESTART': '1', 18:52:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:52:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:52:46 INFO - 'PWD': '/builds/slave/test', 18:52:46 INFO - 'SHELL': '/bin/bash', 18:52:46 INFO - 'SHLVL': '1', 18:52:46 INFO - 'TERM': 'linux', 18:52:46 INFO - 'TMOUT': '86400', 18:52:46 INFO - 'USER': 'cltbld', 18:52:46 INFO - 'XDG_SESSION_COOKIE': '9531f05ccb2eabcb9acf5f1b000001c0-1505958554.210787-323026496', 18:52:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:52:46 INFO - '_': '/tools/buildbot/bin/python'} 18:52:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:52:46 INFO - Downloading/unpacking blobuploader==1.2.4 18:52: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 18:52: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 18:52: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 18:52: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 18:52:47 INFO - Downloading blobuploader-1.2.4.tar.gz 18:52:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:52:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:52:47 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 18:52:47 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 18:52:47 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 18:52:47 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 18:52:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:52:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:52:48 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 18:52:48 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 18:52:48 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 18:52:48 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 18:52:48 INFO - Downloading docopt-0.6.1.tar.gz 18:52:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:52:48 INFO - Installing collected packages: blobuploader, requests, docopt 18:52:48 INFO - Running setup.py install for blobuploader 18:52:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:52:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:52:48 INFO - Running setup.py install for requests 18:52:48 INFO - Running setup.py install for docopt 18:52:49 INFO - Successfully installed blobuploader requests docopt 18:52:49 INFO - Cleaning up... 18:52:49 INFO - Return code: 0 18:52:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:52:49 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')]} 18:52:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:52:49 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')]} 18:52:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:52:49 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 0x1a0a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bd2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d75a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d79090>, '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 0x1d79d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d73f90>, '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': '9531f05ccb2eabcb9acf5f1b000001c0-1505958554.210787-323026496', '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 18:52:49 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 18:52:49 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 18:52:49 INFO - Using env: {'DISPLAY': ':0', 18:52:49 INFO - 'HOME': '/home/cltbld', 18:52:49 INFO - 'LANG': 'en_US.UTF-8', 18:52:49 INFO - 'LANGUAGE': 'en_US:en', 18:52:49 INFO - 'LOGNAME': 'cltbld', 18:52:49 INFO - 'MAIL': '/var/mail/cltbld', 18:52:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:52:49 INFO - 'MOZ_NO_REMOTE': '1', 18:52:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:52:49 INFO - 'NO_EM_RESTART': '1', 18:52:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:52:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:52:49 INFO - 'PWD': '/builds/slave/test', 18:52:49 INFO - 'SHELL': '/bin/bash', 18:52:49 INFO - 'SHLVL': '1', 18:52:49 INFO - 'TERM': 'linux', 18:52:49 INFO - 'TMOUT': '86400', 18:52:49 INFO - 'USER': 'cltbld', 18:52:49 INFO - 'XDG_SESSION_COOKIE': '9531f05ccb2eabcb9acf5f1b000001c0-1505958554.210787-323026496', 18:52:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:52:49 INFO - '_': '/tools/buildbot/bin/python'} 18:52:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:52:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:52:49 INFO - Running setup.py (path:/tmp/pip-szAmPE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:52:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:52:49 INFO - Running setup.py (path:/tmp/pip-bqo2dh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:52:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:52:49 INFO - Running setup.py (path:/tmp/pip-pKFsCH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:52:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:52:49 INFO - Running setup.py (path:/tmp/pip-u_XsrE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:52:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:52:49 INFO - Running setup.py (path:/tmp/pip-jpXhWM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:52:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:52:49 INFO - Running setup.py (path:/tmp/pip-d5_pej-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:52:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:52:49 INFO - Running setup.py (path:/tmp/pip-4ScWvs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:52:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:52:49 INFO - Running setup.py (path:/tmp/pip-GZvtA7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:52:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:52:49 INFO - Running setup.py (path:/tmp/pip-bErcXQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:52:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:52:49 INFO - Running setup.py (path:/tmp/pip-eSspuH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:52:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:52:50 INFO - Running setup.py (path:/tmp/pip-3q115z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:52:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:52:50 INFO - Running setup.py (path:/tmp/pip-3E11nw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:52:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:52:50 INFO - Running setup.py (path:/tmp/pip-XZtZoS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:52:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:52:50 INFO - Running setup.py (path:/tmp/pip-Y81lGY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:52:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:52:50 INFO - Running setup.py (path:/tmp/pip-nrj8Gs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:52:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:52:50 INFO - Running setup.py (path:/tmp/pip-f0Uruk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:52:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:52:50 INFO - Running setup.py (path:/tmp/pip-InfrGU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:52:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:52:50 INFO - Running setup.py install for manifestparser 18:52:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:52:50 INFO - Running setup.py install for mozcrash 18:52:50 INFO - Running setup.py install for mozdebug 18:52:50 INFO - Running setup.py install for mozdevice 18:52:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:52:50 INFO - Running setup.py install for mozfile 18:52:50 INFO - Running setup.py install for mozhttpd 18:52:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:52:51 INFO - Running setup.py install for mozinfo 18:52:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:52:51 INFO - Running setup.py install for mozInstall 18:52:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:52:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:52:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:52:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:52:51 INFO - Running setup.py install for mozleak 18:52:51 INFO - Running setup.py install for mozlog 18:52:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:52:51 INFO - Running setup.py install for moznetwork 18:52:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:52:51 INFO - Running setup.py install for mozprocess 18:52:51 INFO - Running setup.py install for mozprofile 18:52:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:52:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:52:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:52:51 INFO - Running setup.py install for mozrunner 18:52:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:52:51 INFO - Running setup.py install for mozscreenshot 18:52:52 INFO - Running setup.py install for moztest 18:52:52 INFO - Running setup.py install for mozversion 18:52:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:52:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:52:52 INFO - Cleaning up... 18:52:52 INFO - Return code: 0 18:52:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:52: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')]} 18:52:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:52: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')]} 18:52:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:52:52 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 0x1a0a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bd2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d75a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d79090>, '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 0x1d79d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d73f90>, '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': '9531f05ccb2eabcb9acf5f1b000001c0-1505958554.210787-323026496', '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 18:52:52 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 18:52:52 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 18:52:52 INFO - Using env: {'DISPLAY': ':0', 18:52:52 INFO - 'HOME': '/home/cltbld', 18:52:52 INFO - 'LANG': 'en_US.UTF-8', 18:52:52 INFO - 'LANGUAGE': 'en_US:en', 18:52:52 INFO - 'LOGNAME': 'cltbld', 18:52:52 INFO - 'MAIL': '/var/mail/cltbld', 18:52:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:52:52 INFO - 'MOZ_NO_REMOTE': '1', 18:52:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:52:52 INFO - 'NO_EM_RESTART': '1', 18:52:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:52:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:52:52 INFO - 'PWD': '/builds/slave/test', 18:52:52 INFO - 'SHELL': '/bin/bash', 18:52:52 INFO - 'SHLVL': '1', 18:52:52 INFO - 'TERM': 'linux', 18:52:52 INFO - 'TMOUT': '86400', 18:52:52 INFO - 'USER': 'cltbld', 18:52:52 INFO - 'XDG_SESSION_COOKIE': '9531f05ccb2eabcb9acf5f1b000001c0-1505958554.210787-323026496', 18:52:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:52:52 INFO - '_': '/tools/buildbot/bin/python'} 18:52:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:52:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:52:52 INFO - Running setup.py (path:/tmp/pip-8_f7cN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:52:52 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)) 18:52:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:52:52 INFO - Running setup.py (path:/tmp/pip-Zszhcy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:52:52 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)) 18:52:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:52:52 INFO - Running setup.py (path:/tmp/pip-zbHQHj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:52:52 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)) 18:52:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:52:52 INFO - Running setup.py (path:/tmp/pip-3R0yRN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:52:52 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)) 18:52:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:52:52 INFO - Running setup.py (path:/tmp/pip-NdgL6b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:52:52 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)) 18:52:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:52:52 INFO - Running setup.py (path:/tmp/pip-FiwtS1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:52:52 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)) 18:52:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:52:52 INFO - Running setup.py (path:/tmp/pip-epgue2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:52:52 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)) 18:52:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:52:52 INFO - Running setup.py (path:/tmp/pip-x8S2XN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:52:53 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)) 18:52:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:52:53 INFO - Running setup.py (path:/tmp/pip-CbfoKG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:52:53 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)) 18:52:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:52:53 INFO - Running setup.py (path:/tmp/pip-fiowck-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:52:53 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)) 18:52:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:52:53 INFO - Running setup.py (path:/tmp/pip-LVR0lp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:52:53 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)) 18:52:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:52:53 INFO - Running setup.py (path:/tmp/pip-sDilJK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:52:53 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)) 18:52:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:52:53 INFO - Running setup.py (path:/tmp/pip-DB8pEy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:52:53 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)) 18:52:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:52:53 INFO - Running setup.py (path:/tmp/pip-y14XLl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:52:53 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)) 18:52:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:52:53 INFO - Running setup.py (path:/tmp/pip-89AdNH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:52:53 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)) 18:52:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:52:53 INFO - Running setup.py (path:/tmp/pip-6QwC5r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:52:53 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)) 18:52:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:52:53 INFO - Running setup.py (path:/tmp/pip-ObIplQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:52:53 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)) 18:52:53 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)) 18:52:53 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)) 18:52:53 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)) 18:52:53 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)) 18:52:53 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)) 18:52:53 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)) 18:52:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:52: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 18:52: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 18:52: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 18:52: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 18:52:54 INFO - Downloading blessings-1.6.tar.gz 18:52:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:52:54 INFO - Installing collected packages: blessings 18:52:54 INFO - Running setup.py install for blessings 18:52:54 INFO - Successfully installed blessings 18:52:54 INFO - Cleaning up... 18:52:55 INFO - Return code: 0 18:52:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:52:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:52:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:52:55 INFO - Reading from file tmpfile_stdout 18:52:55 INFO - Current package versions: 18:52:55 INFO - argparse == 1.2.1 18:52:55 INFO - blessings == 1.6 18:52:55 INFO - blobuploader == 1.2.4 18:52:55 INFO - docopt == 0.6.1 18:52:55 INFO - functools32 == 3.2.3-2 18:52:55 INFO - jsonschema == 2.5.1 18:52:55 INFO - manifestparser == 1.1 18:52:55 INFO - mozInstall == 1.13 18:52:55 INFO - mozcrash == 1.0 18:52:55 INFO - mozdebug == 0.1 18:52:55 INFO - mozdevice == 0.51 18:52:55 INFO - mozfile == 1.2 18:52:55 INFO - mozhttpd == 0.7 18:52:55 INFO - mozinfo == 0.10 18:52:55 INFO - mozleak == 0.1 18:52:55 INFO - mozlog == 3.5 18:52:55 INFO - moznetwork == 0.27 18:52:55 INFO - mozprocess == 0.25 18:52:55 INFO - mozprofile == 0.28 18:52:55 INFO - mozrunner == 6.13 18:52:55 INFO - mozscreenshot == 0.1 18:52:55 INFO - mozsystemmonitor == 0.3 18:52:55 INFO - moztest == 0.8 18:52:55 INFO - mozversion == 1.4 18:52:55 INFO - psutil == 3.1.1 18:52:55 INFO - requests == 1.2.3 18:52:55 INFO - wsgiref == 0.1.2 18:52:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:52:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:52:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:52:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:52:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:52:55 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 0x1a0a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bd2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d75a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d79090>, '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 0x1d79d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d73f90>, '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': '9531f05ccb2eabcb9acf5f1b000001c0-1505958554.210787-323026496', '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 18:52:55 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 18:52:55 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 18:52:55 INFO - Using env: {'DISPLAY': ':0', 18:52:55 INFO - 'HOME': '/home/cltbld', 18:52:55 INFO - 'LANG': 'en_US.UTF-8', 18:52:55 INFO - 'LANGUAGE': 'en_US:en', 18:52:55 INFO - 'LOGNAME': 'cltbld', 18:52:55 INFO - 'MAIL': '/var/mail/cltbld', 18:52:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:52:55 INFO - 'MOZ_NO_REMOTE': '1', 18:52:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:52:55 INFO - 'NO_EM_RESTART': '1', 18:52:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:52:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:52:55 INFO - 'PWD': '/builds/slave/test', 18:52:55 INFO - 'SHELL': '/bin/bash', 18:52:55 INFO - 'SHLVL': '1', 18:52:55 INFO - 'TERM': 'linux', 18:52:55 INFO - 'TMOUT': '86400', 18:52:55 INFO - 'USER': 'cltbld', 18:52:55 INFO - 'XDG_SESSION_COOKIE': '9531f05ccb2eabcb9acf5f1b000001c0-1505958554.210787-323026496', 18:52:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:52:55 INFO - '_': '/tools/buildbot/bin/python'} 18:52:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:52:55 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)) 18:52:55 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)) 18:52:55 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)) 18:52:55 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)) 18:52:55 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)) 18:52:55 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)) 18:52:55 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)) 18:52:55 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)) 18:52:55 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)) 18:52:55 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 18:52:55 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 18:52:55 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 18:52:55 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 18:52:55 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 18:52:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 18:52:56 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)) 18:52:56 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)) 18:52:56 INFO - Installing collected packages: simplejson 18:52:56 INFO - Running setup.py install for simplejson 18:52:56 INFO - building 'simplejson._speedups' extension 18:52:56 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 18:52:57 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 18:52:57 INFO - Successfully installed simplejson 18:52:57 INFO - Cleaning up... 18:52:57 INFO - Return code: 0 18:52:57 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:52:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:52:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:52:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:52:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:52:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a0a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bd2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d75a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d79090>, '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 0x1d79d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d73f90>, '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': '9531f05ccb2eabcb9acf5f1b000001c0-1505958554.210787-323026496', '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 18:52:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 18:52:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 18:52:57 INFO - Using env: {'DISPLAY': ':0', 18:52:57 INFO - 'HOME': '/home/cltbld', 18:52:57 INFO - 'LANG': 'en_US.UTF-8', 18:52:57 INFO - 'LANGUAGE': 'en_US:en', 18:52:57 INFO - 'LOGNAME': 'cltbld', 18:52:57 INFO - 'MAIL': '/var/mail/cltbld', 18:52:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:52:57 INFO - 'MOZ_NO_REMOTE': '1', 18:52:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:52:57 INFO - 'NO_EM_RESTART': '1', 18:52:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:52:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:52:57 INFO - 'PWD': '/builds/slave/test', 18:52:57 INFO - 'SHELL': '/bin/bash', 18:52:57 INFO - 'SHLVL': '1', 18:52:57 INFO - 'TERM': 'linux', 18:52:57 INFO - 'TMOUT': '86400', 18:52:57 INFO - 'USER': 'cltbld', 18:52:57 INFO - 'XDG_SESSION_COOKIE': '9531f05ccb2eabcb9acf5f1b000001c0-1505958554.210787-323026496', 18:52:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:52:57 INFO - '_': '/tools/buildbot/bin/python'} 18:52:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:52:57 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:52:57 INFO - Cleaning up... 18:52:57 INFO - Return code: 0 18:52:57 INFO - Running post-action listener: _resource_record_post_action 18:52:57 INFO - Running post-action listener: _start_resource_monitoring 18:52:57 INFO - Starting resource monitoring. 18:52:57 INFO - [mozharness: 2017-09-21 01:52:57.944306Z] Finished create-virtualenv step (success) 18:52:57 INFO - [mozharness: 2017-09-21 01:52:57.944772Z] Running install step. 18:52:57 INFO - Running pre-action listener: _resource_record_pre_action 18:52:57 INFO - Running main action method: install 18:52:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:52:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:52:58 INFO - Reading from file tmpfile_stdout 18:52:58 INFO - Detecting whether we're running mozinstall >=1.0... 18:52:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:52:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:52:58 INFO - Reading from file tmpfile_stdout 18:52:58 INFO - Output received: 18:52:58 INFO - Usage: mozinstall [options] installer 18:52:58 INFO - Options: 18:52:58 INFO - -h, --help show this help message and exit 18:52:58 INFO - -d DEST, --destination=DEST 18:52:58 INFO - Directory to install application into. [default: 18:52:58 INFO - "/builds/slave/test"] 18:52:58 INFO - --app=APP Application being installed. [default: firefox] 18:52:58 INFO - mkdir: /builds/slave/test/build/application 18:52:58 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'] 18:52:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 18:53:12 INFO - Reading from file tmpfile_stdout 18:53:13 INFO - Output received: 18:53:13 INFO - /builds/slave/test/build/application/firefox/firefox 18:53:13 INFO - Running post-action listener: _resource_record_post_action 18:53:13 INFO - [mozharness: 2017-09-21 01:53:13.001586Z] Finished install step (success) 18:53:13 INFO - [mozharness: 2017-09-21 01:53:13.001841Z] Running setup-mitmproxy step. 18:53:13 INFO - Running pre-action listener: _resource_record_pre_action 18:53:13 INFO - Running main action method: setup_mitmproxy 18:53:13 INFO - Skipping: mitmproxy is not required 18:53:13 INFO - Running post-action listener: _resource_record_post_action 18:53:13 INFO - [mozharness: 2017-09-21 01:53:13.002964Z] Finished setup-mitmproxy step (success) 18:53:13 INFO - [mozharness: 2017-09-21 01:53:13.003184Z] Running run-tests step. 18:53:13 INFO - Running pre-action listener: _resource_record_pre_action 18:53:13 INFO - Running pre-action listener: _set_gcov_prefix 18:53:13 INFO - Running main action method: run_tests 18:53:13 WARNING - Try message not found. 18:53:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:53:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:53:13 INFO - Python 2.7.3 18:53:13 INFO - Return code: 0 18:53:13 INFO - grabbing minidump binary from tooltool 18:53: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')]} 18:53:13 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 0x1d79090>, '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 0x1d79d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d73f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:53:13 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 18:53:13 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 18:53:13 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 18:53:13 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:53:13 INFO - Return code: 0 18:53:13 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:53:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:53:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:53:13 INFO - ENV: RUST_BACKTRACE is now full 18:53:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:53:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:53:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/b1aUbkquTmWwX3uTXEMXyA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-073', '--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 18:53:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/b1aUbkquTmWwX3uTXEMXyA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-073 --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 18:53:13 INFO - Using env: {'DISPLAY': ':0', 18:53:13 INFO - 'HOME': '/home/cltbld', 18:53:13 INFO - 'LANG': 'en_US.UTF-8', 18:53:13 INFO - 'LANGUAGE': 'en_US:en', 18:53:13 INFO - 'LOGNAME': 'cltbld', 18:53:13 INFO - 'MAIL': '/var/mail/cltbld', 18:53:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:53:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:53:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:53:13 INFO - 'MOZ_NO_REMOTE': '1', 18:53:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:53:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:53:13 INFO - 'NO_EM_RESTART': '1', 18:53:13 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:53:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:53:13 INFO - 'PWD': '/builds/slave/test', 18:53:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:53:13 INFO - 'RUST_BACKTRACE': 'full', 18:53:13 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 18:53:13 INFO - 'SHELL': '/bin/bash', 18:53:13 INFO - 'SHLVL': '1', 18:53:13 INFO - 'TERM': 'linux', 18:53:13 INFO - 'TMOUT': '86400', 18:53:13 INFO - 'USER': 'cltbld', 18:53:13 INFO - 'XDG_SESSION_COOKIE': '9531f05ccb2eabcb9acf5f1b000001c0-1505958554.210787-323026496', 18:53:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:53:13 INFO - '_': '/tools/buildbot/bin/python'} 18:53:13 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/b1aUbkquTmWwX3uTXEMXyA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-073', '--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 18:53:13 INFO - mozversion application_buildid: 20170921004013 18:53:13 INFO - mozversion application_changeset: efff4f307675a2226d4ef5867d64b6499bde39e3 18:53:13 INFO - mozversion application_display_name: Firefox 18:53:13 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:53:13 INFO - mozversion application_name: Firefox 18:53:13 INFO - mozversion application_remotingname: firefox 18:53:13 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 18:53:13 INFO - mozversion application_vendor: Mozilla 18:53:13 INFO - mozversion application_version: 57.0 18:53:13 INFO - mozversion platform_buildid: 20170921004013 18:53:13 INFO - mozversion platform_changeset: efff4f307675a2226d4ef5867d64b6499bde39e3 18:53:13 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 18:53:13 INFO - mozversion platform_version: 57.0 18:53:13 INFO - using testdate: 1505958793 18:53:13 INFO - actual date: 1505958793 18:53:13 INFO - starting webserver on 'localhost:56929' 18:53:13 INFO - SUITE-START | Running 2 tests 18:53:13 INFO - TEST-START | dromaeo_css 18:53:13 INFO - Initialising browser for dromaeo_css test... 18:53:13 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:56929/getInfo.html -profile /tmp/tmpT4E0Ex/profile 18:53:13 INFO - TEST-INFO | started process 24581 (/builds/slave/test/build/application/firefox/firefox http://localhost:56929/getInfo.html) 18:53:18 INFO - TEST-INFO | 24581: exit 0 18:53:18 INFO - Browser initialized. 18:53:18 INFO - Running cycle 1/1 for dromaeo_css test... 18:53:18 INFO - Using env: {'DISPLAY': ':0', 18:53:18 INFO - 'HOME': '/home/cltbld', 18:53:18 INFO - 'JSGC_DISABLE_POISONING': '1', 18:53:18 INFO - 'LANG': 'en_US.UTF-8', 18:53:18 INFO - 'LANGUAGE': 'en_US:en', 18:53:18 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 18:53:18 INFO - 'LOGNAME': 'cltbld', 18:53:18 INFO - 'MAIL': '/var/mail/cltbld', 18:53:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:53:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:53:18 INFO - 'MOZ_CRASHREPORTER': '1', 18:53:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:53:18 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 18:53:18 INFO - 'MOZ_NO_REMOTE': '1', 18:53:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:53:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:53:18 INFO - 'NO_EM_RESTART': '1', 18:53:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:53:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:53:18 INFO - 'PWD': '/builds/slave/test', 18:53:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:53:18 INFO - 'RUST_BACKTRACE': 'full', 18:53:18 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 18:53:18 INFO - 'SHELL': '/bin/bash', 18:53:18 INFO - 'SHLVL': '1', 18:53:18 INFO - 'TERM': 'linux', 18:53:18 INFO - 'TMOUT': '86400', 18:53:18 INFO - 'USER': 'cltbld', 18:53:18 INFO - 'XDG_SESSION_COOKIE': '9531f05ccb2eabcb9acf5f1b000001c0-1505958554.210787-323026496', 18:53:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:53:18 INFO - '_': '/tools/buildbot/bin/python'} 18:53:18 INFO - TEST-INFO | started process 24771 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpT4E0Ex/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 18:53:29 INFO - PID 24771 | RSS: Main: 144187392 18:53:29 INFO - PID 24771 | 18:56:27 INFO - PID 24771 | Cycle 1(1): loaded http://localhost:56929/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56929/tests/dromaeo/cssquery-ext.html) 18:56:28 INFO - PID 24771 | RSS: Main: 147247104 18:56:28 INFO - PID 24771 | 18:59:29 INFO - PID 24771 | Cycle 1(1): loaded http://localhost:56929/tests/dromaeo/cssquery-ext.html (next: http://localhost:56929/tests/dromaeo/cssquery-jquery.html) 18:59:30 INFO - PID 24771 | RSS: Main: 146092032 18:59:30 INFO - PID 24771 | 19:02:31 INFO - PID 24771 | Cycle 1(1): loaded http://localhost:56929/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56929/tests/dromaeo/cssquery-mootools.html) 19:02:32 INFO - PID 24771 | RSS: Main: 147259392 19:02:32 INFO - PID 24771 | 19:05:33 INFO - PID 24771 | Cycle 1(1): loaded http://localhost:56929/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56929/tests/dromaeo/cssquery-prototype.html) 19:05:34 INFO - PID 24771 | RSS: Main: 147021824 19:05:34 INFO - PID 24771 | 19:08:37 INFO - PID 24771 | Cycle 1(1): loaded http://localhost:56929/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56929/tests/dromaeo/cssquery-yui.html) 19:08:37 INFO - PID 24771 | RSS: Main: 148258816 19:08:37 INFO - PID 24771 | 19:11:39 INFO - PID 24771 | Cycle 1(1): loaded http://localhost:56929/tests/dromaeo/cssquery-yui.html (next: http://localhost:56929/tests/dromaeo/cssquery-dojo.html) 19:11:39 INFO - PID 24771 | RSS: Main: 151220224 19:11:39 INFO - PID 24771 | 19:11:39 INFO - PID 24771 | __start_tp_report 19:11:39 INFO - PID 24771 | _x_x_mozilla_page_load 19:11:39 INFO - PID 24771 | _x_x_mozilla_page_load_details 19:11:39 INFO - PID 24771 | |i|pagename|runs| 19:11:39 INFO - PID 24771 | |0;dojo.html;3954.505686789151;3987.7208595398315;3992.620701033401;4008.5390180129284;4032.112935154267;6297.338779428157;6352.110704501373;6397.360263973612;6435.517336199786;6454.19322584677;6362.268339141;6363.809085727424;6437.742490300394;6457.838554036151;6462.547621666486;5640.351359593637;5660.377358490563;5806.158107074471;5810.273715785505;5833.358330583633;5656.066748986413;5776.046952252873;5778.335491418477;5786.334571524266;5859.912101318484;5737.397573254811;5737.598368114233;5741.511971482408;5770.9422905770825;5791.449812267849;5746.856328591777;5759;5796.30444346679;5818.679972601484;5824.330202026778;5670.7731690732735;5709.77160913563;5711.828645140652;5736.885262294731;5839;6183.505319574423;6267.686615669244;6289;6296.716647750863;6340.778072767477;6878.140232470942;6947.027416161742;6954.930450695479;6968.965155174243;6981.79054628362;6854.725810967555;6893.827654308632;6903.102596662452;6922.376986071277;6989.475789315821;6322.810315690536;6346.841328966767;6361.618302901795;6362.886494863426;6414.358564143642;6913.965430172817;6956.234814170437;6968.3728464438445;6974.197967233732;6986.441084713312;6658.4673226141795;6811.4550835933005;6878.58728476293;6886.793396198122;6900.689468973908;6931.826704332432;6954.374106330353;7014.824629384306;7022.578645281299;7028.1917579477995;6879.793606191823;6890.20762612306;6958.756443524452;6968.233494315621;6977.092977912839;6606.86786264272;6759.864802703918;6768.864622707519;6771;6880.483963702743;4992.925106123411;5047.823326183566;5052.545270925634;5063.367079115111;5079;4677.204875171229;4728.007118505084;4762.214234651244;4765.0946320199055;4765.809367625326;6492.383223593751;6503.772367967193;6508.3491650835485;6602.075709400592;6605.24039735427;6808.455323574201;6879.6560171991205;6896.034555162281;6977.232504424509;6999.615021173884;6422.743090276336;6495.4803615710625;6496.902546461807;6500.739970401131;6533.705983230766;5615.494605485526;5761.049426844607;5766.048601980626;5774.797882074107;5777.768889244383;7061.964690176619;7113.110861142357;7123.145222573221;7163.31948464895;7204.135503739585;6750.561213521106;6876;6881.346272104142;6947.826304342432;6976.058232138799;7133.322334378226;7236.855262894818;7244.130704315516;7273.3817625502425;7300.087489063867;6855.5543889647015;6873.690683919136;6936.861262774817;6938.514303998873;6968.163820341591;6770.492213084137;6882.69027893736;6883.724651013903;6940;6965.199002114821;6664.833379165366;6673.599584024974;6676.132102826601;6695.163104611924;6712.194536655633;6592.967035164794;6641.203055633355;6683.465322774264;6706.329367063255;6723.4957378197805;6575.112359831362;6577.177852768404;6652.966735166293;6663.333666633298;6669.566478178903;6692;6694.531382803157;6736.360045795642;6792.456603471809;6796.626185559841;6383.138276332821;6462.386073323027;6527.412532872065;6619.3380661933425;6633.800985970429 19:11:39 INFO - PID 24771 | |1;ext.html;981.7889153831925;985.4383001689035;1003.8494225866119;1031.4172492541713;1041.1410586266331;44205;44736.55263447364;44778;44925.32612010823;44960.775196124014;41473;41701.7914910425;41786.58213417865;41788.37317440241;41807.37288940668;8059.8791018134625;8065.516069035847;8170.468919520242;8176.427650064498;8183.877241841377;7981.760547183565;8040.35677145827;8045.637946292431;8049.315808156313;8050.758477245663;8076.798080047987;8142.104368519458;8200.958995205016;8213.26080652741;8229.218224268685;8094.514329140241;8118.14759450261;8175.591220439013;8185.754427367188;8188.54962977036;8703;8805.735827925173;8829.867551986661;8829.955850220773;8838.955805220998;41673;42162.15675686469;42178.789106054275;42228;42248.78875605633;3801.923961520754;3840.4047372657283;3848.441975913505;3851.383778595411;3867.4198870169416;34081.829590851885;34105.488417673754;34154;34311.485327720104;34420.82789586036;5521.751521181556;5554.250176226238;5690.089585666315;5704.657720536781;5741.569382296345;219908;222109;222447;222794;223888;52574.21138682923;52664.473355266724;52706.20940685893;52810;52923.73538132362;55615;55848;55850;55951.16073258904;55962.16056759152;18511.35210267634;19038;19038.33365832189;19043.14305856212;19047.333343332917;15632;15681.215939202993;15682.294296756674;15700.136492492795;15760.76358854618;15546.84453155454;15589.766153507706;15814;15831.920840395724;15842.207889605474;5921.792737254175;6214.689265536796;6218.906716399258;6225.159603453476;6240.7503699851495;1134.7219931116929;1139.4245905817509;1139.7948369293606;1149.574657376776;1161.088545491785;26089.608655870175;26363.868180658974;26428;26436.312203673668;26739.598906016425;1265.1207410849372;1267.5816980396446;1270.707737220426;1271.7265787855656;1284.42016319927;13736.793948090786;13879.41979146879;14027.649308767159;14093.942954278471;14195.219262940638;271247;308314;311709;314504;315757;64554.354456455774;65219.34780652227;65222;65258.34741652523;65433;1567.6316065724545;1573.5200763767161;1578.1241411016995;1588.5552045427298;1589.7615357696438;30944.845275773478;31062.53406198954;31186.22034449157;31625.683743163194;31695.52456713197;43166.136677266906;43420.782896085315;43441.34837977496;43598.56401435945;43651;264160;264735;264959;265367;267409;36195.457068144526;37011.03911687112;37437.251254975294;37762.81118594499;37780.81109594544;46693.76653116713;47845.043099137125;47974.520254797004;48268.27597586109;48458.75770621125;35514.28971420609;35883.64116358803;35915.28169436649;36206;36281;35369.29261414706;35628;36043.118456035656;36130.45804312885;36731.08172295714;40759;41522;41604.167916640894;41830.790846046795;41912.580874192085;34259.4861077089;34303.828480858436;34563.65436345705;34573.30853382969;35457.46813797847;25673;25811.612825807253;25904.48191036131;26140.73859261459;26678.46643067089 19:11:39 INFO - PID 24771 | |2;jquery.html;621.7077973352523;630.248978075065;637.5123030881374;655.7475371981787;656.934306569343;24398.878005609968;24617.261482155518;24961.87519062402;25041.74958250417;25207.117750878744;27594;27926.720732792666;28053.438931221364;28065;28202;6806.795796126099;6837.863242735142;6977.476689248301;6991.965040174818;7051.1186101737285;7007.124109486314;7015.017897494355;7030.507864449491;7033.331833475837;7042.04932334136;6980.37176654101;6983.580985140882;6985.82535436613;6989.091418115638;6995.300469953015;6963.965180174117;6974.930250697505;7000.26497217795;7003.719851205971;7010.754623588201;6521.119648847392;6526.804195874131;6541.640209788459;6548.738050477975;6575;27922;28268.717312826815;29188.854055729586;29473.705262947526;29546.704532954824;2327.592671282519;2333.300009996994;2338.5673650374733;2339.4502291961376;2344.6131388320905;21356.679649805264;21537.246196383207;21966.89016554923;22022.559548809095;22063.558728825494;2602.8047896407843;2649.337665583604;2665.4269332093695;2667.8666066696783;2685.073649590888;136741;143594;158991;162140;165555.1722241393;16233.918830405772;17281.222344994505;17285.395011174547;17510.91244543769;17512.096612948393;28117.71882281151;28151.155465336073;28219.15342539727;28221;28249.15252542427;11596.420178991186;11619.53521859133;11725.824112638316;11786.233894796811;11950.04399648026;10859.239853210358;10871.021608055155;10879.564817407374;10925.180611454172;10955.561777528968;9982.35114717541;10514.21143414247;10614.416207108683;10640.414777187329;10762.139028877671;2977.285451491626;2989.445488346048;3004.684508126659;3023.7732170087334;3087.2899233176495;1068.636663534402;1080.2654195147375;1089.7929393415225;1103.5089385223498;1105.6130354375905;22519.43701407445;22577.209797657004;22590;22798.772012279664;22861.19985800489;1137.9431028448544;1156.115571587736;1157.7337212441187;1163.4124766992616;1165.1960147498198;12401.751964960651;12606.684832879251;12631.11582189238;12697.69882317671;12740.745185096246;622294;622459;629949;639178;646053;131097;132818;134074;135508;137095;1272.7963525836008;1279.9488020479077;1286.9163504372186;1298.6169080121388;1310.8361454818148;19788.703169452183;19873.205071796965;19882.801171988096;20120.39638810838;20281.08735106953;63972.36027639664;64805.35194648182;65006.674966624865;66373.66813165903;67382;82589;84228;84301.57849210715;84351;84664.57667711622;16463.83536164671;16469.91765041167;16485.83514164843;16536.421225257058;16750.916245418695;25624.487510250063;25683.10109146171;25794.61308080343;26053.6091958617;26101.347466313495;20734.792652073287;20876.164953401694;20924.372268831958;20936.685949710463;21032.57934841264;17893.642127157644;18445.446636600922;18449.07754612237;18656.533586660444;18891.244350226385;19905.60188796245;20075.69886451675;20848;21391.78608213898;21505.462363441038;16180.433684820975;16219.594510137342;16353.427630032891;16461.176941152655;16515.256813443182;18437.446876593724;18445.631087377908;18493.81506184921;20276.695849562562;20284.898575507617 19:11:39 INFO - PID 24771 | |3;mootools.html;1384.4877395363715;1468.2658670664669;1489.2851431312963;1489.687165695204;1495.4317359403428;17274.395396161137;17918.372856949994;17956.730649040273;17962.550936226584;17992;17308.653826923455;17420.65158696825;17437;17478.388256411028;17498.387556435526;2975.4346674131843;3014.834184119878;3037.726604605585;3061.525463553153;3067.0338843264412;2958.4083183363414;2984.239019050139;2985.4327677741267;2985.7909946303766;3016.8944086956963;2964.0515035188746;2971.5988341573934;2987.342784587398;3096.767742419316;3097.8605962731617;3044.8173109613385;3059.021113243774;3080.476319025771;3081.168084617163;3082.969170308291;2848.430313937221;2906.9273268168254;2916.781241406903;2918.5622156676454;2918.868650910714;17225.913870430693;17588.560285992953;17626.294948202056;17642.91178544112;17682.11589420524;8505.10696376884;8766.430182038212;8808.515531645757;8815.471071735716;8819.382643214978;5435;5450.155225939986;5471.124620060771;5603.299587551556;5673.6595804251465;2141.453929248047;2146.6623339537014;2168.5554461335387;2194.1004188282727;2221.900014499335;32165.356692866244;32439.51340729891;32447.351052979044;32496;32555.348893022245;7263.455240856852;7617.809554761176;7670.96164519185;7713.730019449405;7764.6894124234395;20858.687119693215;20942.476438088866;20950.895245523676;20996;21010.2646407375;8703.782405439915;8824.647014119491;8848.955755221312;8854.601542930584;8879.955600221958;8035.959820200978;8106.310963568045;8144.796380090545;8155;8175.63209655567;5858.326292476335;6036.094585812076;6046.667433291123;6051.7579296827635;6061.484773794189;1616.5231256779277;1634.656722088351;1685.2500637216322;1714.2200298863986;1728.7234042553132;968.2060710217695;980.4901451245313;988.5304480371766;990.8513722941616;998.8451789972421;9626.374285671409;9988.25088118394;10032.648857290105;10093.293469457214;10224.233182511342;808.5431731071925;815.8694608862553;829.5478963964654;829.9626516806758;882.2853488674066;6175.950088484969;6280.183576135073;6311.747530098836;6444.452221561126;6501.869962600722;26874.32814179661;28021.859890700824;28045.158645240674;28232.15303540897;28478.572821407695;26711.732882671313;27808.58287125695;27827.443451130865;27876.30309242285;28028.579571306447;11721.179517433868;12650.557230496888;12706.36468176606;12730.554430594884;13151;9764.267679923893;9793.412395256308;9799.11807937289;9822.508874556386;9906.009399060036;22645;22671.88664056735;22820.657690134994;22936.426589334733;23022.07911683514;23939.401514962265;24071.157509487082;24099.638505422783;24467.510649787262;25129.748702513472;12771.744565108831;13090.14914030585;13090.541831035867;13103.67240818949;13134.14628049212;16164.676706465569;16434.17829108564;16493.67012659764;16560.00639961606;16671.749923751395;13140.211587304791;13145.976425422015;13321.733565328444;13673.427555831207;13760.93119534396;12473.189242699196;12554.309512976874;12618.55835045769;12727.236365817711;13025.869741302844;11259.887401125883;11269.549218031514;11415.486303116213;11426.542938282375;11429.885701142883;8431.831363372576;8484.618192181244;8606.66596677516;8613.138686131337;8675.175858293453;8494.91505084966;8534.70128545498;8617.698380556902;8672.609732562176;8708.042115367178 19:11:39 INFO - PID 24771 | |4;prototype.html;552.2847911954017;588.3057991569951;590.83456632143;595.5503594785936;598.3328588623685;6393.552451328409;6447.936090545066;6470.838229044276;6472.611643301399;6488.480921526272;6336.605946691732;6355.936440635593;6382.648954307511;6402.359764023607;6405.711742971577;5213.687178769267;5237.093413155697;5258.6318957672975;5279.313689220396;5284.44513326101;5017.598592112622;5154.046501397234;5181.455947125554;5211.895762084756;5276.314079169702;5119.795208191668;5126.282320475137;5126.461721519243;5160.612954028444;5182.248573956774;5135.922961155586;5149.974250128763;5165.560927321182;5167.354080739908;5171.19846423803;4682.41469816273;4684.953150468486;4694.859154225379;4702.576768090854;4718.537253451441;6325.936740632626;6345.143405640226;6379.71291291893;6382.808515744535;6385.712642931079;6032.215811944463;6038;6079.179310793074;6090.48230900374;6108.175396321484;6808.6255255960905;6840.247572766992;6866.450683945272;6892.689828957709;6898.862022759517;5216.113260745682;5223.947760522384;5230.790768369261;5235.816746413857;5253.894922101575;6900;7020.543664661781;7032;7064.152301723775;7182.245864184238;5378.515933565998;5378.569714422837;5378.623496355296;5379.1662292344745;5404.513593776579;5437.401885792559;5460.6996615186545;5464.207689884945;5475.206095116186;5491.203775452537;6028.33688294296;6037.698115094316;6048.637081775108;6061.181740465069;6065.2418447694035;6698.966505167443;6824.556403833735;6847.1783385993;6850.794476165723;6936.271691472322;1851.592649617082;1855.3413538194018;1871.6898171280159;1881.8682692211414;1893.4982229709137;1267.7337759070515;1269.1877198592908;1323.3251041968472;1340.8458027326787;1344.6571124363224;6232.283287422005;6358.491320694333;6398.360163983564;6428.853389563706;6452.064310738602;6863.485238607124;6874.690638921261;6934.341237582422;6941.895871561931;6948.44412447003;6391.424771770563;6401.455876250571;6410.775622853178;6448;6455.903161452582;3608.2061946371755;3631.364511210528;3642.6903713184147;3647.8176091195332;3665.2669466106354;7086.468514861406;7140.214576396592;7166.462515311373;7190.1731300901065;7195.2444993276;7119.6084215368655;7127.394171495481;7134.892976605355;7145.178304494945;7151.856962860714;7117.608531530712;7132.8930066048015;7231.4937954342695;7240.710371585288;7316.817079572947;6844.315568443116;6936.4797640176175;6949.965250173716;6951.227437003734;6980;6726.428253598303;6734.4949128816515;6761.594304341756;6794.694238759366;6847.794566163023;7078.610676412847;7100.467464940253;7120.537165084253;7187.425005999403;7248.565086094851;5328.8401347959625;5338.852146788459;5375.758090885998;5391.4608539145775;5391.649542779707;6827.965860170866;6936.306369363023;6999.545029573062;7002.824929376807;7017.157941047107;6316.968415157895;6575.506836987341;6657.667116644246;6705.329467053256;6765.221999469927;6488.480921526172;6552.410283074356;6645.734170633121;6685.532012759255;6689.49828762835;6516.283208846929;6582.619766832149;6608.942569188906;6663.200415950117;6678.098456708282;6706.429953453816;6723.529352945443;6752.818256805138;6881.348476365536;6901.75843845463;6514.9348506514325;6541.476681865534;6569.981652843817;6692.330766923464;6722.394984451423 19:11:39 INFO - PID 24771 | |5;yui.html;962.9470379129145;1003.9548220330084;1011.9645812396564;1020.3469779341218;1029.8918613545577;20492.795072049274;21034.263800766978;21061.57876842462;21076.789232107676;21082.051307691152;19635.11641976111;19684.803151968477;19723.70414443781;19805.801941980575;20168.19327226909;1065.2383545764776;1076.5586109695007;1076.7900259449411;1077.1167642533126;1077.181342179945;1049.6536143072767;1079.4710591809996;1085.6580177244143;1089.9945500272488;1096.030013438109;1169.3510101893446;1172.5368479450613;1173.0674114079327;1179.5871444994227;1179.8466199394068;1168.842206302147;1172.8533933258343;1173.9354335511543;1174.8002839517303;1176.4117941029485;864.4769914201943;866.0257210638032;868.3357231717741;869.8999615044224;870.2689740617911;18997.145128469252;20206.19175232989;21537.35387938349;21617.783822161735;21799.346019619436;20480.38558843237;20617.175312987463;20841.37475875726;20955.58088838215;20977.056032478577;17309.480715578553;17341.479755607354;17355.566110847205;17385.826141738675;17410.651786964318;3880.417937309398;3886.689064874803;3947.5460322062754;3964.8414063437426;3976.76139431635;165940;168693;169959;171554;171686;16880.071596062335;17418.12909354527;17418.738718919227;17420.82579174192;17427;34924.47613285803;35775.82112089423;35777.8211108948;35960.280794383965;36062.819685901406;9060.728178154666;9212.35513514061;9251.67619133327;9332.440053596805;9418.811623767624;4660.091282199938;4718.622510199244;4732.52674732524;4746.5253474652945;4750.07373562159;5912.379200184005;5996.910046349309;6029.487493563096;6042.577019608585;6049.697515124226;1071.9517621707041;1079.0666073846066;1102.08526922654;1102.7684186320803;1104.4588151805558;751.6542390500322;765.8698021336274;773.6557232031691;780.8438312337555;781.9257170568787;13533.86466135326;13636.86363136356;13833.79249311261;13864.722705546033;13930.303484825718;738.8522295540913;741.7960060983165;743.6579173580105;749.8912657664717;758.0372926383462;6653.401193892573;6757.121574195421;6814.386705196556;6815.556988795812;6845.383915447634;156890;160188;161614;162908;164683;137163;138249.69522553438;142354;143729;146030;119284.99999999827;120658.39670801589;120959;121790;124355;12882.355882205664;12930.094893357375;13072;13096.934515327363;13105.14816536922;58780.70609646924;59013;59041;59514;59627.105593417;76031;76151;76611.2338876604;76840.61579692065;78814.60592697;18406.72389914179;18525.722114168027;18548;18634;18688.53278668044;19963.800361996193;20800.06399711986;20844.58310833805;20846.1661533543;21045.052972615962;18363.17365718519;18469.72295415597;18473.261069557066;18480.445586632424;18651.160697768362;16690.16549172561;16910;17044;17099.316027358767;17103.230354633823;17898.731519026966;17999.280028799225;18029.188686508875;18069.909650451664;18232.270709171484;13140.474381024653;13373.799393009307;13623.386947587183;13667.931660341636;13754.93122534381;13853.16880987144;14006.509772157926;14091.718165636836;14123.576292711236;14177.645558861112 19:11:39 INFO - PID 24771 | __end_tp_report 19:11:39 INFO - PID 24771 | __start_cc_report 19:11:39 INFO - PID 24771 | _x_x_mozilla_cycle_collect,233 19:11:39 INFO - PID 24771 | __end_cc_report 19:11:39 INFO - PID 24771 | __startTimestamp1505959899521__endTimestamp 19:11:39 INFO - PID 24771 | 19:11:39 INFO - PID 24771 | ------- Summary: start ------- 19:11:39 INFO - PID 24771 | Number of tests: 6 19:11:39 INFO - PID 24771 | 19:11:39 INFO - PID 24771 | [#0] dojo.html Cycles:165 Average:6374.07 Median:6619.34 stddev:727.83 (11.0%) stddev-sans-first:704.88 19:11:39 INFO - PID 24771 | Values: 3954.5 3987.7 3992.6 4008.5 4032.1 6297.3 6352.1 6397.4 6435.5 6454.2 6362.3 6363.8 6437.7 6457.8 6462.5 5640.4 5660.4 5806.2 5810.3 5833.4 5656.1 5776.0 5778.3 5786.3 5859.9 5737.4 5737.6 5741.5 5770.9 5791.4 5746.9 5759.0 5796.3 5818.7 5824.3 5670.8 5709.8 5711.8 5736.9 5839.0 6183.5 6267.7 6289.0 6296.7 6340.8 6878.1 6947.0 6954.9 6969.0 6981.8 6854.7 6893.8 6903.1 6922.4 6989.5 6322.8 6346.8 6361.6 6362.9 6414.4 6914.0 6956.2 6968.4 6974.2 6986.4 6658.5 6811.5 6878.6 6886.8 6900.7 6931.8 6954.4 7014.8 7022.6 7028.2 6879.8 6890.2 6958.8 6968.2 6977.1 6606.9 6759.9 6768.9 6771.0 6880.5 4992.9 5047.8 5052.5 5063.4 5079.0 4677.2 4728.0 4762.2 4765.1 4765.8 6492.4 6503.8 6508.3 6602.1 6605.2 6808.5 6879.7 6896.0 6977.2 6999.6 6422.7 6495.5 6496.9 6500.7 6533.7 5615.5 5761.0 5766.0 5774.8 5777.8 7062.0 7113.1 7123.1 7163.3 7204.1 6750.6 6876.0 6881.3 6947.8 6976.1 7133.3 7236.9 7244.1 7273.4 7300.1 6855.6 6873.7 6936.9 6938.5 6968.2 6770.5 6882.7 6883.7 6940.0 6965.2 6664.8 6673.6 6676.1 6695.2 6712.2 6593.0 6641.2 6683.5 6706.3 6723.5 6575.1 6577.2 6653.0 6663.3 6669.6 6692.0 6694.5 6736.4 6792.5 6796.6 6383.1 6462.4 6527.4 6619.3 6633.8 19:11:39 INFO - PID 24771 | 19:11:39 INFO - PID 24771 | [#1] ext.html Cycles:180 Average:44861.21 Median:37600.03 stddev:69305.55 (184.3%) stddev-sans-first:69421.66 19:11:39 INFO - PID 24771 | Values: 981.8 985.4 1003.8 1031.4 1041.1 44205.0 44736.6 44778.0 44925.3 44960.8 41473.0 41701.8 41786.6 41788.4 41807.4 8059.9 8065.5 8170.5 8176.4 8183.9 7981.8 8040.4 8045.6 8049.3 8050.8 8076.8 8142.1 8201.0 8213.3 8229.2 8094.5 8118.1 8175.6 8185.8 8188.5 8703.0 8805.7 8829.9 8830.0 8839.0 41673.0 42162.2 42178.8 42228.0 42248.8 3801.9 3840.4 3848.4 3851.4 3867.4 34081.8 34105.5 34154.0 34311.5 34420.8 5521.8 5554.3 5690.1 5704.7 5741.6 219908.0 222109.0 222447.0 222794.0 223888.0 52574.2 52664.5 52706.2 52810.0 52923.7 55615.0 55848.0 55850.0 55951.2 55962.2 18511.4 19038.0 19038.3 19043.1 19047.3 15632.0 15681.2 15682.3 15700.1 15760.8 15546.8 15589.8 15814.0 15831.9 15842.2 5921.8 6214.7 6218.9 6225.2 6240.8 1134.7 1139.4 1139.8 1149.6 1161.1 26089.6 26363.9 26428.0 26436.3 26739.6 1265.1 1267.6 1270.7 1271.7 1284.4 13736.8 13879.4 14027.6 14093.9 14195.2 271247.0 308314.0 311709.0 314504.0 315757.0 64554.4 65219.3 65222.0 65258.3 65433.0 1567.6 1573.5 1578.1 1588.6 1589.8 30944.8 31062.5 31186.2 31625.7 31695.5 43166.1 43420.8 43441.3 43598.6 43651.0 264160.0 264735.0 264959.0 265367.0 267409.0 36195.5 37011.0 37437.3 37762.8 37780.8 46693.8 47845.0 47974.5 48268.3 48458.8 35514.3 35883.6 35915.3 36206.0 36281.0 35369.3 35628.0 36043.1 36130.5 36731.1 40759.0 41522.0 41604.2 41830.8 41912.6 34259.5 34303.8 34563.7 34573.3 35457.5 25673.0 25811.6 25904.5 26140.7 26678.5 19:11:39 INFO - PID 24771 | 19:11:39 INFO - PID 24771 | [#2] jquery.html Cycles:180 Average:41416.56 Median:22583.60 stddev:105575.92 (467.5%) stddev-sans-first:105827.66 19:11:39 INFO - PID 24771 | Values: 621.7 630.2 637.5 655.7 656.9 24398.9 24617.3 24961.9 25041.7 25207.1 27594.0 27926.7 28053.4 28065.0 28202.0 6806.8 6837.9 6977.5 6992.0 7051.1 7007.1 7015.0 7030.5 7033.3 7042.0 6980.4 6983.6 6985.8 6989.1 6995.3 6964.0 6974.9 7000.3 7003.7 7010.8 6521.1 6526.8 6541.6 6548.7 6575.0 27922.0 28268.7 29188.9 29473.7 29546.7 2327.6 2333.3 2338.6 2339.5 2344.6 21356.7 21537.2 21966.9 22022.6 22063.6 2602.8 2649.3 2665.4 2667.9 2685.1 136741.0 143594.0 158991.0 162140.0 165555.2 16233.9 17281.2 17285.4 17510.9 17512.1 28117.7 28151.2 28219.2 28221.0 28249.2 11596.4 11619.5 11725.8 11786.2 11950.0 10859.2 10871.0 10879.6 10925.2 10955.6 9982.4 10514.2 10614.4 10640.4 10762.1 2977.3 2989.4 3004.7 3023.8 3087.3 1068.6 1080.3 1089.8 1103.5 1105.6 22519.4 22577.2 22590.0 22798.8 22861.2 1137.9 1156.1 1157.7 1163.4 1165.2 12401.8 12606.7 12631.1 12697.7 12740.7 622294.0 622459.0 629949.0 639178.0 646053.0 131097.0 132818.0 134074.0 135508.0 137095.0 1272.8 1279.9 1286.9 1298.6 1310.8 19788.7 19873.2 19882.8 20120.4 20281.1 63972.4 64805.4 65006.7 66373.7 67382.0 82589.0 84228.0 84301.6 84351.0 84664.6 16463.8 16469.9 16485.8 16536.4 16750.9 25624.5 25683.1 25794.6 26053.6 26101.3 20734.8 20876.2 20924.4 20936.7 21032.6 17893.6 18445.4 18449.1 18656.5 18891.2 19905.6 20075.7 20848.0 21391.8 21505.5 16180.4 16219.6 16353.4 16461.2 16515.3 18437.4 18445.6 18493.8 20276.7 20284.9 19:11:39 INFO - PID 24771 | 19:11:39 INFO - PID 24771 | [#3] mootools.html Cycles:180 Average:11076.68 Median:2917.67 stddev:8383.60 (287.3%) stddev-sans-first:8375.50 19:11:39 INFO - PID 24771 | Values: 1384.5 1468.3 1489.3 1489.7 1495.4 17274.4 17918.4 17956.7 17962.6 17992.0 17308.7 17420.7 17437.0 17478.4 17498.4 2975.4 3014.8 3037.7 3061.5 3067.0 2958.4 2984.2 2985.4 2985.8 3016.9 2964.1 2971.6 2987.3 3096.8 3097.9 3044.8 3059.0 3080.5 3081.2 3083.0 2848.4 2906.9 2916.8 2918.6 2918.9 17225.9 17588.6 17626.3 17642.9 17682.1 8505.1 8766.4 8808.5 8815.5 8819.4 5435.0 5450.2 5471.1 5603.3 5673.7 2141.5 2146.7 2168.6 2194.1 2221.9 32165.4 32439.5 32447.4 32496.0 32555.3 7263.5 7617.8 7671.0 7713.7 7764.7 20858.7 20942.5 20950.9 20996.0 21010.3 8703.8 8824.6 8849.0 8854.6 8880.0 8036.0 8106.3 8144.8 8155.0 8175.6 5858.3 6036.1 6046.7 6051.8 6061.5 1616.5 1634.7 1685.3 1714.2 1728.7 968.2 980.5 988.5 990.9 998.8 9626.4 9988.3 10032.6 10093.3 10224.2 808.5 815.9 829.5 830.0 882.3 6176.0 6280.2 6311.7 6444.5 6501.9 26874.3 28021.9 28045.2 28232.2 28478.6 26711.7 27808.6 27827.4 27876.3 28028.6 11721.2 12650.6 12706.4 12730.6 13151.0 9764.3 9793.4 9799.1 9822.5 9906.0 22645.0 22671.9 22820.7 22936.4 23022.1 23939.4 24071.2 24099.6 24467.5 25129.7 12771.7 13090.1 13090.5 13103.7 13134.1 16164.7 16434.2 16493.7 16560.0 16671.7 13140.2 13146.0 13321.7 13673.4 13760.9 12473.2 12554.3 12618.6 12727.2 13025.9 11259.9 11269.5 11415.5 11426.5 11429.9 8431.8 8484.6 8606.7 8613.1 8675.2 8494.9 8534.7 8617.7 8672.6 8708.0 19:11:39 INFO - PID 24771 | 19:11:39 INFO - PID 24771 | [#4] prototype.html Cycles:180 Average:5793.39 Median:6404.04 stddev:1608.41 (25.1%) stddev-sans-first:1564.07 19:11:39 INFO - PID 24771 | Values: 552.3 588.3 590.8 595.6 598.3 6393.6 6447.9 6470.8 6472.6 6488.5 6336.6 6355.9 6382.6 6402.4 6405.7 5213.7 5237.1 5258.6 5279.3 5284.4 5017.6 5154.0 5181.5 5211.9 5276.3 5119.8 5126.3 5126.5 5160.6 5182.2 5135.9 5150.0 5165.6 5167.4 5171.2 4682.4 4685.0 4694.9 4702.6 4718.5 6325.9 6345.1 6379.7 6382.8 6385.7 6032.2 6038.0 6079.2 6090.5 6108.2 6808.6 6840.2 6866.5 6892.7 6898.9 5216.1 5223.9 5230.8 5235.8 5253.9 6900.0 7020.5 7032.0 7064.2 7182.2 5378.5 5378.6 5378.6 5379.2 5404.5 5437.4 5460.7 5464.2 5475.2 5491.2 6028.3 6037.7 6048.6 6061.2 6065.2 6699.0 6824.6 6847.2 6850.8 6936.3 1851.6 1855.3 1871.7 1881.9 1893.5 1267.7 1269.2 1323.3 1340.8 1344.7 6232.3 6358.5 6398.4 6428.9 6452.1 6863.5 6874.7 6934.3 6941.9 6948.4 6391.4 6401.5 6410.8 6448.0 6455.9 3608.2 3631.4 3642.7 3647.8 3665.3 7086.5 7140.2 7166.5 7190.2 7195.2 7119.6 7127.4 7134.9 7145.2 7151.9 7117.6 7132.9 7231.5 7240.7 7316.8 6844.3 6936.5 6950.0 6951.2 6980.0 6726.4 6734.5 6761.6 6794.7 6847.8 7078.6 7100.5 7120.5 7187.4 7248.6 5328.8 5338.9 5375.8 5391.5 5391.6 6828.0 6936.3 6999.5 7002.8 7017.2 6317.0 6575.5 6657.7 6705.3 6765.2 6488.5 6552.4 6645.7 6685.5 6689.5 6516.3 6582.6 6608.9 6663.2 6678.1 6706.4 6723.5 6752.8 6881.3 6901.8 6514.9 6541.5 6570.0 6692.3 6722.4 19:11:39 INFO - PID 24771 | 19:11:39 INFO - PID 24771 | [#5] yui.html Cycles:180 Average:29703.77 Median:18438.22 stddev:45297.14 (245.7%) stddev-sans-first:45372.80 19:11:39 INFO - PID 24771 | Values: 962.9 1004.0 1012.0 1020.3 1029.9 20492.8 21034.3 21061.6 21076.8 21082.1 19635.1 19684.8 19723.7 19805.8 20168.2 1065.2 1076.6 1076.8 1077.1 1077.2 1049.7 1079.5 1085.7 1090.0 1096.0 1169.4 1172.5 1173.1 1179.6 1179.8 1168.8 1172.9 1173.9 1174.8 1176.4 864.5 866.0 868.3 869.9 870.3 18997.1 20206.2 21537.4 21617.8 21799.3 20480.4 20617.2 20841.4 20955.6 20977.1 17309.5 17341.5 17355.6 17385.8 17410.7 3880.4 3886.7 3947.5 3964.8 3976.8 165940.0 168693.0 169959.0 171554.0 171686.0 16880.1 17418.1 17418.7 17420.8 17427.0 34924.5 35775.8 35777.8 35960.3 36062.8 9060.7 9212.4 9251.7 9332.4 9418.8 4660.1 4718.6 4732.5 4746.5 4750.1 5912.4 5996.9 6029.5 6042.6 6049.7 1072.0 1079.1 1102.1 1102.8 1104.5 751.7 765.9 773.7 780.8 781.9 13533.9 13636.9 13833.8 13864.7 13930.3 738.9 741.8 743.7 749.9 758.0 6653.4 6757.1 6814.4 6815.6 6845.4 156890.0 160188.0 161614.0 162908.0 164683.0 137163.0 138249.7 142354.0 143729.0 146030.0 119285.0 120658.4 120959.0 121790.0 124355.0 12882.4 12930.1 13072.0 13096.9 13105.1 58780.7 59013.0 59041.0 59514.0 59627.1 76031.0 76151.0 76611.2 76840.6 78814.6 18406.7 18525.7 18548.0 18634.0 18688.5 19963.8 20800.1 20844.6 20846.2 21045.1 18363.2 18469.7 18473.3 18480.4 18651.2 16690.2 16910.0 17044.0 17099.3 17103.2 17898.7 17999.3 18029.2 18069.9 18232.3 13140.5 13373.8 13623.4 13667.9 13754.9 13853.2 14006.5 14091.7 14123.6 14177.6 19:11:39 INFO - PID 24771 | -------- Summary: end -------- 19:11:39 INFO - PID 24771 | 19:11:40 INFO - TEST-INFO | 24771: exit 0 19:11:40 INFO - TEST-OK | dromaeo_css | took 1106793ms 19:11:40 INFO - TEST-START | kraken 19:11:40 INFO - Initialising browser for kraken test... 19:11:40 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:56929/getInfo.html -profile /tmp/tmp_9Ovts/profile 19:11:40 INFO - TEST-INFO | started process 25128 (/builds/slave/test/build/application/firefox/firefox http://localhost:56929/getInfo.html) 19:11:45 INFO - TEST-INFO | 25128: exit 0 19:11:45 INFO - Browser initialized. 19:11:45 INFO - Running cycle 1/1 for kraken test... 19:11:45 INFO - Using env: {'DISPLAY': ':0', 19:11:45 INFO - 'HOME': '/home/cltbld', 19:11:45 INFO - 'JSGC_DISABLE_POISONING': '1', 19:11:45 INFO - 'LANG': 'en_US.UTF-8', 19:11:45 INFO - 'LANGUAGE': 'en_US:en', 19:11:45 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 19:11:45 INFO - 'LOGNAME': 'cltbld', 19:11:45 INFO - 'MAIL': '/var/mail/cltbld', 19:11:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:11:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:11:45 INFO - 'MOZ_CRASHREPORTER': '1', 19:11:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:11:45 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 19:11:45 INFO - 'MOZ_NO_REMOTE': '1', 19:11:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:11:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:11:45 INFO - 'NO_EM_RESTART': '1', 19:11:45 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:11:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:11:45 INFO - 'PWD': '/builds/slave/test', 19:11:45 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:11:45 INFO - 'RUST_BACKTRACE': 'full', 19:11:45 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 19:11:45 INFO - 'SHELL': '/bin/bash', 19:11:45 INFO - 'SHLVL': '1', 19:11:45 INFO - 'TERM': 'linux', 19:11:45 INFO - 'TMOUT': '86400', 19:11:45 INFO - 'USER': 'cltbld', 19:11:45 INFO - 'XDG_SESSION_COOKIE': '9531f05ccb2eabcb9acf5f1b000001c0-1505958554.210787-323026496', 19:11:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:11:45 INFO - '_': '/tools/buildbot/bin/python'} 19:11:45 INFO - TEST-INFO | started process 25320 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_9Ovts/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 19:11:56 INFO - PID 25320 | RSS: Main: 144056320 19:11:56 INFO - PID 25320 | 19:11:59 INFO - PID 25320 | Cycle 1(1): loaded http://localhost:56929/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56929/tests/kraken/driver.html?testName=audio-beat-detection) 19:11:59 INFO - PID 25320 | RSS: Main: 149553152 19:11:59 INFO - PID 25320 | 19:12:02 INFO - PID 25320 | Cycle 1(1): loaded http://localhost:56929/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56929/tests/kraken/driver.html?testName=audio-dft) 19:12:03 INFO - PID 25320 | RSS: Main: 149843968 19:12:03 INFO - PID 25320 | 19:12:05 INFO - PID 25320 | Cycle 1(1): loaded http://localhost:56929/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56929/tests/kraken/driver.html?testName=audio-fft) 19:12:06 INFO - PID 25320 | RSS: Main: 152002560 19:12:06 INFO - PID 25320 | 19:12:08 INFO - PID 25320 | Cycle 1(1): loaded http://localhost:56929/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56929/tests/kraken/driver.html?testName=audio-oscillator) 19:12:09 INFO - PID 25320 | RSS: Main: 151506944 19:12:09 INFO - PID 25320 | 19:12:11 INFO - PID 25320 | Cycle 1(1): loaded http://localhost:56929/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56929/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:12:11 INFO - PID 25320 | RSS: Main: 151490560 19:12:11 INFO - PID 25320 | 19:12:14 INFO - PID 25320 | Cycle 1(1): loaded http://localhost:56929/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56929/tests/kraken/driver.html?testName=imaging-darkroom) 19:12:15 INFO - PID 25320 | RSS: Main: 151068672 19:12:15 INFO - PID 25320 | 19:12:18 INFO - PID 25320 | Cycle 1(1): loaded http://localhost:56929/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56929/tests/kraken/driver.html?testName=imaging-desaturate) 19:12:19 INFO - PID 25320 | RSS: Main: 151969792 19:12:19 INFO - PID 25320 | 19:12:22 INFO - PID 25320 | Cycle 1(1): loaded http://localhost:56929/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56929/tests/kraken/driver.html?testName=json-parse-financial) 19:12:22 INFO - PID 25320 | RSS: Main: 153452544 19:12:22 INFO - PID 25320 | 19:12:24 INFO - PID 25320 | Cycle 1(1): loaded http://localhost:56929/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56929/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:12:25 INFO - PID 25320 | RSS: Main: 153325568 19:12:25 INFO - PID 25320 | 19:12:26 INFO - PID 25320 | Cycle 1(1): loaded http://localhost:56929/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56929/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:12:27 INFO - PID 25320 | RSS: Main: 153411584 19:12:27 INFO - PID 25320 | 19:12:29 INFO - PID 25320 | Cycle 1(1): loaded http://localhost:56929/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56929/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:12:29 INFO - PID 25320 | RSS: Main: 150302720 19:12:29 INFO - PID 25320 | 19:12:32 INFO - PID 25320 | Cycle 1(1): loaded http://localhost:56929/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56929/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:12:32 INFO - PID 25320 | RSS: Main: 150167552 19:12:32 INFO - PID 25320 | 19:12:35 INFO - PID 25320 | Cycle 1(1): loaded http://localhost:56929/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56929/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:12:36 INFO - PID 25320 | RSS: Main: 150921216 19:12:36 INFO - PID 25320 | 19:12:37 INFO - PID 25320 | Cycle 1(1): loaded http://localhost:56929/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56929/tests/kraken/driver.html?testName=ai-astar) 19:12:38 INFO - PID 25320 | RSS: Main: 152145920 19:12:38 INFO - PID 25320 | 19:12:38 INFO - PID 25320 | __start_tp_report 19:12:38 INFO - PID 25320 | _x_x_mozilla_page_load 19:12:38 INFO - PID 25320 | _x_x_mozilla_page_load_details 19:12:38 INFO - PID 25320 | |i|pagename|runs| 19:12:38 INFO - PID 25320 | |0;ai-astar;106;105;104;105;105;106;96;107;105;104 19:12:38 INFO - PID 25320 | |1;audio-beat-detection;148;110;153;156;114;139;136;110;164;116 19:12:38 INFO - PID 25320 | |2;audio-dft;161;161;161;161;164;162;162;163;162;165 19:12:38 INFO - PID 25320 | |3;audio-fft;75;74;73;72;72;75;74;76;74;76 19:12:38 INFO - PID 25320 | |4;audio-oscillator;78;82;78;77;77;78;80;77;78;77 19:12:38 INFO - PID 25320 | |5;imaging-gaussian-blur;115;114;114;114;114;115;111;114;114;113 19:12:38 INFO - PID 25320 | |6;imaging-darkroom;149;148;148;148;151;149;150;156;148;148 19:12:38 INFO - PID 25320 | |7;imaging-desaturate;94;94;96;93;93;93;94;94;94;95 19:12:38 INFO - PID 25320 | |8;json-parse-financial;46;52;45;45;42;45;46;44;46;42 19:12:38 INFO - PID 25320 | |9;json-stringify-tinderbox;38;38;38;38;38;38;38;38;38;39 19:12:38 INFO - PID 25320 | |10;stanford-crypto-aes;72;71;72;67;72;69;77;75;70;71 19:12:38 INFO - PID 25320 | |11;stanford-crypto-ccm;104;105;102;105;107;109;100;104;106;101 19:12:38 INFO - PID 25320 | |12;stanford-crypto-pbkdf2;160;156;156;152;147;157;154;149;152;151 19:12:38 INFO - PID 25320 | |13;stanford-crypto-sha256-iterative;58;60;58;61;59;58;59;59;57;64 19:12:38 INFO - PID 25320 | __end_tp_report 19:12:38 INFO - PID 25320 | __start_cc_report 19:12:38 INFO - PID 25320 | _x_x_mozilla_cycle_collect,658 19:12:38 INFO - PID 25320 | __end_cc_report 19:12:38 INFO - PID 25320 | __startTimestamp1505959958053__endTimestamp 19:12:38 INFO - PID 25320 | 19:12:38 INFO - PID 25320 | ------- Summary: start ------- 19:12:38 INFO - PID 25320 | Number of tests: 14 19:12:38 INFO - PID 25320 | 19:12:38 INFO - PID 25320 | [#0] ai-astar Cycles:10 Average:104.30 Median:105.50 stddev:3.06 (2.9%) stddev-sans-first:3.18 19:12:38 INFO - PID 25320 | Values: 106.0 105.0 104.0 105.0 105.0 106.0 96.0 107.0 105.0 104.0 19:12:38 INFO - PID 25320 | 19:12:38 INFO - PID 25320 | [#1] audio-beat-detection Cycles:10 Average:134.60 Median:143.50 stddev:20.66 (14.4%) stddev-sans-first:21.34 19:12:38 INFO - PID 25320 | Values: 148.0 110.0 153.0 156.0 114.0 139.0 136.0 110.0 164.0 116.0 19:12:38 INFO - PID 25320 | 19:12:38 INFO - PID 25320 | [#2] audio-dft Cycles:10 Average:162.20 Median:162.00 stddev:1.40 (0.9%) stddev-sans-first:1.41 19:12:38 INFO - PID 25320 | Values: 161.0 161.0 161.0 161.0 164.0 162.0 162.0 163.0 162.0 165.0 19:12:38 INFO - PID 25320 | 19:12:38 INFO - PID 25320 | [#3] audio-fft Cycles:10 Average:74.10 Median:74.50 stddev:1.45 (1.9%) stddev-sans-first:1.50 19:12:38 INFO - PID 25320 | Values: 75.0 74.0 73.0 72.0 72.0 75.0 74.0 76.0 74.0 76.0 19:12:38 INFO - PID 25320 | 19:12:38 INFO - PID 25320 | [#4] audio-oscillator Cycles:10 Average:78.20 Median:78.00 stddev:1.62 (2.1%) stddev-sans-first:1.72 19:12:38 INFO - PID 25320 | Values: 78.0 82.0 78.0 77.0 77.0 78.0 80.0 77.0 78.0 77.0 19:12:38 INFO - PID 25320 | 19:12:38 INFO - PID 25320 | [#5] imaging-gaussian-blur Cycles:10 Average:113.80 Median:114.00 stddev:1.14 (1.0%) stddev-sans-first:1.12 19:12:38 INFO - PID 25320 | Values: 115.0 114.0 114.0 114.0 114.0 115.0 111.0 114.0 114.0 113.0 19:12:38 INFO - PID 25320 | 19:12:38 INFO - PID 25320 | [#6] imaging-darkroom Cycles:10 Average:149.50 Median:149.00 stddev:2.51 (1.7%) stddev-sans-first:2.65 19:12:38 INFO - PID 25320 | Values: 149.0 148.0 148.0 148.0 151.0 149.0 150.0 156.0 148.0 148.0 19:12:38 INFO - PID 25320 | 19:12:38 INFO - PID 25320 | [#7] imaging-desaturate Cycles:10 Average:94.00 Median:94.00 stddev:0.94 (1.0%) stddev-sans-first:1.00 19:12:38 INFO - PID 25320 | Values: 94.0 94.0 96.0 93.0 93.0 93.0 94.0 94.0 94.0 95.0 19:12:38 INFO - PID 25320 | 19:12:38 INFO - PID 25320 | [#8] json-parse-financial Cycles:10 Average:45.30 Median:45.50 stddev:2.79 (6.1%) stddev-sans-first:2.95 19:12:38 INFO - PID 25320 | Values: 46.0 52.0 45.0 45.0 42.0 45.0 46.0 44.0 46.0 42.0 19:12:38 INFO - PID 25320 | 19:12:38 INFO - PID 25320 | [#9] json-stringify-tinderbox Cycles:10 Average:38.10 Median:38.00 stddev:0.32 (0.8%) stddev-sans-first:0.33 19:12:38 INFO - PID 25320 | Values: 38.0 38.0 38.0 38.0 38.0 38.0 38.0 38.0 38.0 39.0 19:12:38 INFO - PID 25320 | 19:12:38 INFO - PID 25320 | [#10] stanford-crypto-aes Cycles:10 Average:71.60 Median:72.00 stddev:2.84 (3.9%) stddev-sans-first:3.00 19:12:38 INFO - PID 25320 | Values: 72.0 71.0 72.0 67.0 72.0 69.0 77.0 75.0 70.0 71.0 19:12:38 INFO - PID 25320 | 19:12:38 INFO - PID 25320 | [#11] stanford-crypto-ccm Cycles:10 Average:104.30 Median:105.00 stddev:2.75 (2.6%) stddev-sans-first:2.92 19:12:38 INFO - PID 25320 | Values: 104.0 105.0 102.0 105.0 107.0 109.0 100.0 104.0 106.0 101.0 19:12:38 INFO - PID 25320 | 19:12:38 INFO - PID 25320 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.40 Median:155.00 stddev:3.95 (2.5%) stddev-sans-first:3.39 19:12:38 INFO - PID 25320 | Values: 160.0 156.0 156.0 152.0 147.0 157.0 154.0 149.0 152.0 151.0 19:12:38 INFO - PID 25320 | 19:12:38 INFO - PID 25320 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:59.30 Median:59.00 stddev:2.00 (3.4%) stddev-sans-first:2.07 19:12:38 INFO - PID 25320 | Values: 58.0 60.0 58.0 61.0 59.0 58.0 59.0 59.0 57.0 64.0 19:12:38 INFO - PID 25320 | -------- Summary: end -------- 19:12:38 INFO - PID 25320 | 19:12:38 INFO - PID 25320 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 19:12:38 INFO - TEST-INFO | 25320: exit 0 19:12:38 INFO - TEST-OK | kraken | took 58532ms 19:12:38 INFO - SUITE-END | took 1165s 19:12:38 INFO - Completed test suite (00:19:25) 19:12:38 INFO - javascript benchmark 19:12:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9382.57565717394, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3954.505686789151, 3987.7208595398315, 3992.620701033401, 4008.5390180129284, 4032.112935154267, 6297.338779428157, 6352.110704501373, 6397.360263973612, 6435.517336199786, 6454.19322584677, 6362.268339141, 6363.809085727424, 6437.742490300394, 6457.838554036151, 6462.547621666486, 5640.351359593637, 5660.377358490563, 5806.158107074471, 5810.273715785505, 5833.358330583633, 5656.066748986413, 5776.046952252873, 5778.335491418477, 5786.334571524266, 5859.912101318484, 5737.397573254811, 5737.598368114233, 5741.511971482408, 5770.9422905770825, 5791.449812267849, 5746.856328591777, 5759.0, 5796.30444346679, 5818.679972601484, 5824.330202026778, 5670.7731690732735, 5709.77160913563, 5711.828645140652, 5736.885262294731, 5839.0, 6183.505319574423, 6267.686615669244, 6289.0, 6296.716647750863, 6340.778072767477, 6878.140232470942, 6947.027416161742, 6954.930450695479, 6968.965155174243, 6981.79054628362, 6854.725810967555, 6893.827654308632, 6903.102596662452, 6922.376986071277, 6989.475789315821, 6322.810315690536, 6346.841328966767, 6361.618302901795, 6362.886494863426, 6414.358564143642, 6913.965430172817, 6956.234814170437, 6968.3728464438445, 6974.197967233732, 6986.441084713312, 6658.4673226141795, 6811.4550835933005, 6878.58728476293, 6886.793396198122, 6900.689468973908, 6931.826704332432, 6954.374106330353, 7014.824629384306, 7022.578645281299, 7028.1917579477995, 6879.793606191823, 6890.20762612306, 6958.756443524452, 6968.233494315621, 6977.092977912839, 6606.86786264272, 6759.864802703918, 6768.864622707519, 6771.0, 6880.483963702743, 4992.925106123411, 5047.823326183566, 5052.545270925634, 5063.367079115111, 5079.0, 4677.204875171229, 4728.007118505084, 4762.214234651244, 4765.0946320199055, 4765.809367625326, 6492.383223593751, 6503.772367967193, 6508.3491650835485, 6602.075709400592, 6605.24039735427, 6808.455323574201, 6879.6560171991205, 6896.034555162281, 6977.232504424509, 6999.615021173884, 6422.743090276336, 6495.4803615710625, 6496.902546461807, 6500.739970401131, 6533.705983230766, 5615.494605485526, 5761.049426844607, 5766.048601980626, 5774.797882074107, 5777.768889244383, 7061.964690176619, 7113.110861142357, 7123.145222573221, 7163.31948464895, 7204.135503739585, 6750.561213521106, 6876.0, 6881.346272104142, 6947.826304342432, 6976.058232138799, 7133.322334378226, 7236.855262894818, 7244.130704315516, 7273.3817625502425, 7300.087489063867, 6855.5543889647015, 6873.690683919136, 6936.861262774817, 6938.514303998873, 6968.163820341591, 6770.492213084137, 6882.69027893736, 6883.724651013903, 6940.0, 6965.199002114821, 6664.833379165366, 6673.599584024974, 6676.132102826601, 6695.163104611924, 6712.194536655633, 6592.967035164794, 6641.203055633355, 6683.465322774264, 6706.329367063255, 6723.4957378197805, 6575.112359831362, 6577.177852768404, 6652.966735166293, 6663.333666633298, 6669.566478178903, 6692.0, 6694.531382803157, 6736.360045795642, 6792.456603471809, 6796.626185559841, 6383.138276332821, 6462.386073323027, 6527.412532872065, 6619.3380661933425, 6633.800985970429], "value": 6326.741719425735, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [981.7889153831925, 985.4383001689035, 1003.8494225866119, 1031.4172492541713, 1041.1410586266331, 44205.0, 44736.55263447364, 44778.0, 44925.32612010823, 44960.775196124014, 41473.0, 41701.7914910425, 41786.58213417865, 41788.37317440241, 41807.37288940668, 8059.8791018134625, 8065.516069035847, 8170.468919520242, 8176.427650064498, 8183.877241841377, 7981.760547183565, 8040.35677145827, 8045.637946292431, 8049.315808156313, 8050.758477245663, 8076.798080047987, 8142.104368519458, 8200.958995205016, 8213.26080652741, 8229.218224268685, 8094.514329140241, 8118.14759450261, 8175.591220439013, 8185.754427367188, 8188.54962977036, 8703.0, 8805.735827925173, 8829.867551986661, 8829.955850220773, 8838.955805220998, 41673.0, 42162.15675686469, 42178.789106054275, 42228.0, 42248.78875605633, 3801.923961520754, 3840.4047372657283, 3848.441975913505, 3851.383778595411, 3867.4198870169416, 34081.829590851885, 34105.488417673754, 34154.0, 34311.485327720104, 34420.82789586036, 5521.751521181556, 5554.250176226238, 5690.089585666315, 5704.657720536781, 5741.569382296345, 219908.0, 222109.0, 222447.0, 222794.0, 223888.0, 52574.21138682923, 52664.473355266724, 52706.20940685893, 52810.0, 52923.73538132362, 55615.0, 55848.0, 55850.0, 55951.16073258904, 55962.16056759152, 18511.35210267634, 19038.0, 19038.33365832189, 19043.14305856212, 19047.333343332917, 15632.0, 15681.215939202993, 15682.294296756674, 15700.136492492795, 15760.76358854618, 15546.84453155454, 15589.766153507706, 15814.0, 15831.920840395724, 15842.207889605474, 5921.792737254175, 6214.689265536796, 6218.906716399258, 6225.159603453476, 6240.7503699851495, 1134.7219931116929, 1139.4245905817509, 1139.7948369293606, 1149.574657376776, 1161.088545491785, 26089.608655870175, 26363.868180658974, 26428.0, 26436.312203673668, 26739.598906016425, 1265.1207410849372, 1267.5816980396446, 1270.707737220426, 1271.7265787855656, 1284.42016319927, 13736.793948090786, 13879.41979146879, 14027.649308767159, 14093.942954278471, 14195.219262940638, 271247.0, 308314.0, 311709.0, 314504.0, 315757.0, 64554.354456455774, 65219.34780652227, 65222.0, 65258.34741652523, 65433.0, 1567.6316065724545, 1573.5200763767161, 1578.1241411016995, 1588.5552045427298, 1589.7615357696438, 30944.845275773478, 31062.53406198954, 31186.22034449157, 31625.683743163194, 31695.52456713197, 43166.136677266906, 43420.782896085315, 43441.34837977496, 43598.56401435945, 43651.0, 264160.0, 264735.0, 264959.0, 265367.0, 267409.0, 36195.457068144526, 37011.03911687112, 37437.251254975294, 37762.81118594499, 37780.81109594544, 46693.76653116713, 47845.043099137125, 47974.520254797004, 48268.27597586109, 48458.75770621125, 35514.28971420609, 35883.64116358803, 35915.28169436649, 36206.0, 36281.0, 35369.29261414706, 35628.0, 36043.118456035656, 36130.45804312885, 36731.08172295714, 40759.0, 41522.0, 41604.167916640894, 41830.790846046795, 41912.580874192085, 34259.4861077089, 34303.828480858436, 34563.65436345705, 34573.30853382969, 35457.46813797847, 25673.0, 25811.612825807253, 25904.48191036131, 26140.73859261459, 26678.46643067089], "value": 19385.349967809867, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [621.7077973352523, 630.248978075065, 637.5123030881374, 655.7475371981787, 656.934306569343, 24398.878005609968, 24617.261482155518, 24961.87519062402, 25041.74958250417, 25207.117750878744, 27594.0, 27926.720732792666, 28053.438931221364, 28065.0, 28202.0, 6806.795796126099, 6837.863242735142, 6977.476689248301, 6991.965040174818, 7051.1186101737285, 7007.124109486314, 7015.017897494355, 7030.507864449491, 7033.331833475837, 7042.04932334136, 6980.37176654101, 6983.580985140882, 6985.82535436613, 6989.091418115638, 6995.300469953015, 6963.965180174117, 6974.930250697505, 7000.26497217795, 7003.719851205971, 7010.754623588201, 6521.119648847392, 6526.804195874131, 6541.640209788459, 6548.738050477975, 6575.0, 27922.0, 28268.717312826815, 29188.854055729586, 29473.705262947526, 29546.704532954824, 2327.592671282519, 2333.300009996994, 2338.5673650374733, 2339.4502291961376, 2344.6131388320905, 21356.679649805264, 21537.246196383207, 21966.89016554923, 22022.559548809095, 22063.558728825494, 2602.8047896407843, 2649.337665583604, 2665.4269332093695, 2667.8666066696783, 2685.073649590888, 136741.0, 143594.0, 158991.0, 162140.0, 165555.1722241393, 16233.918830405772, 17281.222344994505, 17285.395011174547, 17510.91244543769, 17512.096612948393, 28117.71882281151, 28151.155465336073, 28219.15342539727, 28221.0, 28249.15252542427, 11596.420178991186, 11619.53521859133, 11725.824112638316, 11786.233894796811, 11950.04399648026, 10859.239853210358, 10871.021608055155, 10879.564817407374, 10925.180611454172, 10955.561777528968, 9982.35114717541, 10514.21143414247, 10614.416207108683, 10640.414777187329, 10762.139028877671, 2977.285451491626, 2989.445488346048, 3004.684508126659, 3023.7732170087334, 3087.2899233176495, 1068.636663534402, 1080.2654195147375, 1089.7929393415225, 1103.5089385223498, 1105.6130354375905, 22519.43701407445, 22577.209797657004, 22590.0, 22798.772012279664, 22861.19985800489, 1137.9431028448544, 1156.115571587736, 1157.7337212441187, 1163.4124766992616, 1165.1960147498198, 12401.751964960651, 12606.684832879251, 12631.11582189238, 12697.69882317671, 12740.745185096246, 622294.0, 622459.0, 629949.0, 639178.0, 646053.0, 131097.0, 132818.0, 134074.0, 135508.0, 137095.0, 1272.7963525836008, 1279.9488020479077, 1286.9163504372186, 1298.6169080121388, 1310.8361454818148, 19788.703169452183, 19873.205071796965, 19882.801171988096, 20120.39638810838, 20281.08735106953, 63972.36027639664, 64805.35194648182, 65006.674966624865, 66373.66813165903, 67382.0, 82589.0, 84228.0, 84301.57849210715, 84351.0, 84664.57667711622, 16463.83536164671, 16469.91765041167, 16485.83514164843, 16536.421225257058, 16750.916245418695, 25624.487510250063, 25683.10109146171, 25794.61308080343, 26053.6091958617, 26101.347466313495, 20734.792652073287, 20876.164953401694, 20924.372268831958, 20936.685949710463, 21032.57934841264, 17893.642127157644, 18445.446636600922, 18449.07754612237, 18656.533586660444, 18891.244350226385, 19905.60188796245, 20075.69886451675, 20848.0, 21391.78608213898, 21505.462363441038, 16180.433684820975, 16219.594510137342, 16353.427630032891, 16461.176941152655, 16515.256813443182, 18437.446876593724, 18445.631087377908, 18493.81506184921, 20276.695849562562, 20284.898575507617], "value": 13403.514277932542, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1384.4877395363715, 1468.2658670664669, 1489.2851431312963, 1489.687165695204, 1495.4317359403428, 17274.395396161137, 17918.372856949994, 17956.730649040273, 17962.550936226584, 17992.0, 17308.653826923455, 17420.65158696825, 17437.0, 17478.388256411028, 17498.387556435526, 2975.4346674131843, 3014.834184119878, 3037.726604605585, 3061.525463553153, 3067.0338843264412, 2958.4083183363414, 2984.239019050139, 2985.4327677741267, 2985.7909946303766, 3016.8944086956963, 2964.0515035188746, 2971.5988341573934, 2987.342784587398, 3096.767742419316, 3097.8605962731617, 3044.8173109613385, 3059.021113243774, 3080.476319025771, 3081.168084617163, 3082.969170308291, 2848.430313937221, 2906.9273268168254, 2916.781241406903, 2918.5622156676454, 2918.868650910714, 17225.913870430693, 17588.560285992953, 17626.294948202056, 17642.91178544112, 17682.11589420524, 8505.10696376884, 8766.430182038212, 8808.515531645757, 8815.471071735716, 8819.382643214978, 5435.0, 5450.155225939986, 5471.124620060771, 5603.299587551556, 5673.6595804251465, 2141.453929248047, 2146.6623339537014, 2168.5554461335387, 2194.1004188282727, 2221.900014499335, 32165.356692866244, 32439.51340729891, 32447.351052979044, 32496.0, 32555.348893022245, 7263.455240856852, 7617.809554761176, 7670.96164519185, 7713.730019449405, 7764.6894124234395, 20858.687119693215, 20942.476438088866, 20950.895245523676, 20996.0, 21010.2646407375, 8703.782405439915, 8824.647014119491, 8848.955755221312, 8854.601542930584, 8879.955600221958, 8035.959820200978, 8106.310963568045, 8144.796380090545, 8155.0, 8175.63209655567, 5858.326292476335, 6036.094585812076, 6046.667433291123, 6051.7579296827635, 6061.484773794189, 1616.5231256779277, 1634.656722088351, 1685.2500637216322, 1714.2200298863986, 1728.7234042553132, 968.2060710217695, 980.4901451245313, 988.5304480371766, 990.8513722941616, 998.8451789972421, 9626.374285671409, 9988.25088118394, 10032.648857290105, 10093.293469457214, 10224.233182511342, 808.5431731071925, 815.8694608862553, 829.5478963964654, 829.9626516806758, 882.2853488674066, 6175.950088484969, 6280.183576135073, 6311.747530098836, 6444.452221561126, 6501.869962600722, 26874.32814179661, 28021.859890700824, 28045.158645240674, 28232.15303540897, 28478.572821407695, 26711.732882671313, 27808.58287125695, 27827.443451130865, 27876.30309242285, 28028.579571306447, 11721.179517433868, 12650.557230496888, 12706.36468176606, 12730.554430594884, 13151.0, 9764.267679923893, 9793.412395256308, 9799.11807937289, 9822.508874556386, 9906.009399060036, 22645.0, 22671.88664056735, 22820.657690134994, 22936.426589334733, 23022.07911683514, 23939.401514962265, 24071.157509487082, 24099.638505422783, 24467.510649787262, 25129.748702513472, 12771.744565108831, 13090.14914030585, 13090.541831035867, 13103.67240818949, 13134.14628049212, 16164.676706465569, 16434.17829108564, 16493.67012659764, 16560.00639961606, 16671.749923751395, 13140.211587304791, 13145.976425422015, 13321.733565328444, 13673.427555831207, 13760.93119534396, 12473.189242699196, 12554.309512976874, 12618.55835045769, 12727.236365817711, 13025.869741302844, 11259.887401125883, 11269.549218031514, 11415.486303116213, 11426.542938282375, 11429.885701142883, 8431.831363372576, 8484.618192181244, 8606.66596677516, 8613.138686131337, 8675.175858293453, 8494.91505084966, 8534.70128545498, 8617.698380556902, 8672.609732562176, 8708.042115367178], "value": 7649.121964277939, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [552.2847911954017, 588.3057991569951, 590.83456632143, 595.5503594785936, 598.3328588623685, 6393.552451328409, 6447.936090545066, 6470.838229044276, 6472.611643301399, 6488.480921526272, 6336.605946691732, 6355.936440635593, 6382.648954307511, 6402.359764023607, 6405.711742971577, 5213.687178769267, 5237.093413155697, 5258.6318957672975, 5279.313689220396, 5284.44513326101, 5017.598592112622, 5154.046501397234, 5181.455947125554, 5211.895762084756, 5276.314079169702, 5119.795208191668, 5126.282320475137, 5126.461721519243, 5160.612954028444, 5182.248573956774, 5135.922961155586, 5149.974250128763, 5165.560927321182, 5167.354080739908, 5171.19846423803, 4682.41469816273, 4684.953150468486, 4694.859154225379, 4702.576768090854, 4718.537253451441, 6325.936740632626, 6345.143405640226, 6379.71291291893, 6382.808515744535, 6385.712642931079, 6032.215811944463, 6038.0, 6079.179310793074, 6090.48230900374, 6108.175396321484, 6808.6255255960905, 6840.247572766992, 6866.450683945272, 6892.689828957709, 6898.862022759517, 5216.113260745682, 5223.947760522384, 5230.790768369261, 5235.816746413857, 5253.894922101575, 6900.0, 7020.543664661781, 7032.0, 7064.152301723775, 7182.245864184238, 5378.515933565998, 5378.569714422837, 5378.623496355296, 5379.1662292344745, 5404.513593776579, 5437.401885792559, 5460.6996615186545, 5464.207689884945, 5475.206095116186, 5491.203775452537, 6028.33688294296, 6037.698115094316, 6048.637081775108, 6061.181740465069, 6065.2418447694035, 6698.966505167443, 6824.556403833735, 6847.1783385993, 6850.794476165723, 6936.271691472322, 1851.592649617082, 1855.3413538194018, 1871.6898171280159, 1881.8682692211414, 1893.4982229709137, 1267.7337759070515, 1269.1877198592908, 1323.3251041968472, 1340.8458027326787, 1344.6571124363224, 6232.283287422005, 6358.491320694333, 6398.360163983564, 6428.853389563706, 6452.064310738602, 6863.485238607124, 6874.690638921261, 6934.341237582422, 6941.895871561931, 6948.44412447003, 6391.424771770563, 6401.455876250571, 6410.775622853178, 6448.0, 6455.903161452582, 3608.2061946371755, 3631.364511210528, 3642.6903713184147, 3647.8176091195332, 3665.2669466106354, 7086.468514861406, 7140.214576396592, 7166.462515311373, 7190.1731300901065, 7195.2444993276, 7119.6084215368655, 7127.394171495481, 7134.892976605355, 7145.178304494945, 7151.856962860714, 7117.608531530712, 7132.8930066048015, 7231.4937954342695, 7240.710371585288, 7316.817079572947, 6844.315568443116, 6936.4797640176175, 6949.965250173716, 6951.227437003734, 6980.0, 6726.428253598303, 6734.4949128816515, 6761.594304341756, 6794.694238759366, 6847.794566163023, 7078.610676412847, 7100.467464940253, 7120.537165084253, 7187.425005999403, 7248.565086094851, 5328.8401347959625, 5338.852146788459, 5375.758090885998, 5391.4608539145775, 5391.649542779707, 6827.965860170866, 6936.306369363023, 6999.545029573062, 7002.824929376807, 7017.157941047107, 6316.968415157895, 6575.506836987341, 6657.667116644246, 6705.329467053256, 6765.221999469927, 6488.480921526172, 6552.410283074356, 6645.734170633121, 6685.532012759255, 6689.49828762835, 6516.283208846929, 6582.619766832149, 6608.942569188906, 6663.200415950117, 6678.098456708282, 6706.429953453816, 6723.529352945443, 6752.818256805138, 6881.348476365536, 6901.75843845463, 6514.9348506514325, 6541.476681865534, 6569.981652843817, 6692.330766923464, 6722.394984451423], "value": 5330.663250794004, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [962.9470379129145, 1003.9548220330084, 1011.9645812396564, 1020.3469779341218, 1029.8918613545577, 20492.795072049274, 21034.263800766978, 21061.57876842462, 21076.789232107676, 21082.051307691152, 19635.11641976111, 19684.803151968477, 19723.70414443781, 19805.801941980575, 20168.19327226909, 1065.2383545764776, 1076.5586109695007, 1076.7900259449411, 1077.1167642533126, 1077.181342179945, 1049.6536143072767, 1079.4710591809996, 1085.6580177244143, 1089.9945500272488, 1096.030013438109, 1169.3510101893446, 1172.5368479450613, 1173.0674114079327, 1179.5871444994227, 1179.8466199394068, 1168.842206302147, 1172.8533933258343, 1173.9354335511543, 1174.8002839517303, 1176.4117941029485, 864.4769914201943, 866.0257210638032, 868.3357231717741, 869.8999615044224, 870.2689740617911, 18997.145128469252, 20206.19175232989, 21537.35387938349, 21617.783822161735, 21799.346019619436, 20480.38558843237, 20617.175312987463, 20841.37475875726, 20955.58088838215, 20977.056032478577, 17309.480715578553, 17341.479755607354, 17355.566110847205, 17385.826141738675, 17410.651786964318, 3880.417937309398, 3886.689064874803, 3947.5460322062754, 3964.8414063437426, 3976.76139431635, 165940.0, 168693.0, 169959.0, 171554.0, 171686.0, 16880.071596062335, 17418.12909354527, 17418.738718919227, 17420.82579174192, 17427.0, 34924.47613285803, 35775.82112089423, 35777.8211108948, 35960.280794383965, 36062.819685901406, 9060.728178154666, 9212.35513514061, 9251.67619133327, 9332.440053596805, 9418.811623767624, 4660.091282199938, 4718.622510199244, 4732.52674732524, 4746.5253474652945, 4750.07373562159, 5912.379200184005, 5996.910046349309, 6029.487493563096, 6042.577019608585, 6049.697515124226, 1071.9517621707041, 1079.0666073846066, 1102.08526922654, 1102.7684186320803, 1104.4588151805558, 751.6542390500322, 765.8698021336274, 773.6557232031691, 780.8438312337555, 781.9257170568787, 13533.86466135326, 13636.86363136356, 13833.79249311261, 13864.722705546033, 13930.303484825718, 738.8522295540913, 741.7960060983165, 743.6579173580105, 749.8912657664717, 758.0372926383462, 6653.401193892573, 6757.121574195421, 6814.386705196556, 6815.556988795812, 6845.383915447634, 156890.0, 160188.0, 161614.0, 162908.0, 164683.0, 137163.0, 138249.69522553438, 142354.0, 143729.0, 146030.0, 119284.99999999827, 120658.39670801589, 120959.0, 121790.0, 124355.0, 12882.355882205664, 12930.094893357375, 13072.0, 13096.934515327363, 13105.14816536922, 58780.70609646924, 59013.0, 59041.0, 59514.0, 59627.105593417, 76031.0, 76151.0, 76611.2338876604, 76840.61579692065, 78814.60592697, 18406.72389914179, 18525.722114168027, 18548.0, 18634.0, 18688.53278668044, 19963.800361996193, 20800.06399711986, 20844.58310833805, 20846.1661533543, 21045.052972615962, 18363.17365718519, 18469.72295415597, 18473.261069557066, 18480.445586632424, 18651.160697768362, 16690.16549172561, 16910.0, 17044.0, 17099.316027358767, 17103.230354633823, 17898.731519026966, 17999.280028799225, 18029.188686508875, 18069.909650451664, 18232.270709171484, 13140.474381024653, 13373.799393009307, 13623.386947587183, 13667.931660341636, 13754.93122534381, 13853.16880987144, 14006.509772157926, 14091.718165636836, 14123.576292711236, 14177.645558861112], "value": 10177.486731586147, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1382.6999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 105.0, 104.0, 105.0, 105.0, 106.0, 96.0, 107.0, 105.0, 104.0], "value": 104.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 110.0, 153.0, 156.0, 114.0, 139.0, 136.0, 110.0, 164.0, 116.0], "value": 134.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 161.0, 164.0, 162.0, 162.0, 163.0, 162.0, 165.0], "value": 162.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 73.0, 72.0, 72.0, 75.0, 74.0, 76.0, 74.0, 76.0], "value": 74.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 82.0, 78.0, 77.0, 77.0, 78.0, 80.0, 77.0, 78.0, 77.0], "value": 78.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 114.0, 114.0, 114.0, 114.0, 115.0, 111.0, 114.0, 114.0, 113.0], "value": 113.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 148.0, 148.0, 148.0, 151.0, 149.0, 150.0, 156.0, 148.0, 148.0], "value": 149.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 96.0, 93.0, 93.0, 93.0, 94.0, 94.0, 94.0, 95.0], "value": 94.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [46.0, 52.0, 45.0, 45.0, 42.0, 45.0, 46.0, 44.0, 46.0, 42.0], "value": 45.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 38.0, 38.0, 38.0, 38.0, 38.0, 38.0, 38.0, 38.0, 39.0], "value": 38.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 71.0, 72.0, 67.0, 72.0, 69.0, 77.0, 75.0, 70.0, 71.0], "value": 71.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 105.0, 102.0, 105.0, 107.0, 109.0, 100.0, 104.0, 106.0, 101.0], "value": 104.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 156.0, 156.0, 152.0, 147.0, 157.0, 154.0, 149.0, 152.0, 151.0], "value": 153.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 60.0, 58.0, 61.0, 59.0, 58.0, 59.0, 59.0, 57.0, 64.0], "value": 59.3, "unit": "score"}]}]} 19:12:38 INFO - Return code: 0 19:12:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:12:38 INFO - # TBPL SUCCESS # 19:12:38 INFO - Running post-action listener: _package_coverage_data 19:12:38 INFO - Running post-action listener: _resource_record_post_action 19:12:38 INFO - [mozharness: 2017-09-21 02:12:38.846150Z] Finished run-tests step (success) 19:12:38 INFO - Running post-run listener: _resource_record_post_run 19:12:38 INFO - Total resource usage - Wall time: 1180s; CPU: 13.0%; Read bytes: 4096; Write bytes: 288632832; Read time: 8; Write time: 155960 19:12:38 INFO - TinderboxPrint: CPU usage
13.0% 19:12:38 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 19:12:38 INFO - TinderboxPrint: I/O write bytes / time
288,632,832 / 155,960 19:12:38 INFO - TinderboxPrint: CPU idle
8,181.9 (87.0%) 19:12:38 INFO - TinderboxPrint: CPU user
1,177.6 (12.5%) 19:12:38 INFO - TinderboxPrint: Swap in / out
0 / 0 19:12:38 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 9121792; Read time: 0; Write time: 1124 19:12:38 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 19:12:38 INFO - run-tests - Wall time: 1166s; CPU: 13.0%; Read bytes: 0; Write bytes: 278634496; Read time: 0; Write time: 154676 19:12:39 INFO - Running post-run listener: _upload_blobber_files 19:12:39 INFO - Blob upload gear active. 19:12:39 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:12:39 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 19:12:39 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', 'Mozilla-Beta-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:12:39 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 Mozilla-Beta-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:12:39 INFO - (blobuploader) - INFO - Open directory for files ... 19:12:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:12:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:12:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:12:46 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:12:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:12:46 INFO - (blobuploader) - INFO - Done attempting. 19:12:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:12:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:12:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:12:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:12:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:12:47 INFO - (blobuploader) - INFO - Done attempting. 19:12:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:12:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:12:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:12:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:12:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:12:48 INFO - (blobuploader) - INFO - Done attempting. 19:12:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 19:12:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:12:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:12:49 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 19:12:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:12:49 INFO - (blobuploader) - INFO - Done attempting. 19:12:49 INFO - (blobuploader) - INFO - Iteration through files over. 19:12:49 INFO - Return code: 0 19:12:49 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:12:49 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:12:49 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/cadd9c5c2016ab453f20cecb8dad62c21bbb3226da48fabd4f265a3c3e2f4ff4cb1cceb7753021fe9c7f20ba4f36069aecfa1c20eecde8f41f1a864fc60ea2c4", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/8727ff9ffd76f66c02820dbfb66f0acc573d1109abf00092d1cf4c207b056e6b70d733aa01bdaf424bf1511fcf6869e927adc3d1184897493f3cb2f986270f7f", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/fe3f9a658c74703e1240dd4511073a6450218e392a0d4593d62f7dd54052016ae8f262954182bd0f3dcd4f616600358bb52355e13e4f0d82dd794a4f1124b0cc", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/64d110d8dd10accb97f420bc84c55a17e643f849e53f977e7e75fe653cdcf747893c52e45a5cfd97f227d5a3029543ae62fe14aed45c53d86271a54cbf427904"} 19:12:49 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:12:49 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:12:49 INFO - Contents: 19:12:49 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/cadd9c5c2016ab453f20cecb8dad62c21bbb3226da48fabd4f265a3c3e2f4ff4cb1cceb7753021fe9c7f20ba4f36069aecfa1c20eecde8f41f1a864fc60ea2c4", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/8727ff9ffd76f66c02820dbfb66f0acc573d1109abf00092d1cf4c207b056e6b70d733aa01bdaf424bf1511fcf6869e927adc3d1184897493f3cb2f986270f7f", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/fe3f9a658c74703e1240dd4511073a6450218e392a0d4593d62f7dd54052016ae8f262954182bd0f3dcd4f616600358bb52355e13e4f0d82dd794a4f1124b0cc", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/64d110d8dd10accb97f420bc84c55a17e643f849e53f977e7e75fe653cdcf747893c52e45a5cfd97f227d5a3029543ae62fe14aed45c53d86271a54cbf427904"} 19:12:49 INFO - Running post-run listener: copy_logs_to_upload_dir 19:12:49 INFO - Copying logs to upload dir... 19:12:49 INFO - mkdir: /builds/slave/test/build/upload/logs 19:12:49 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1231.947596 ========= master_lag: 0.10 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2017-09-20 19:12:49.543829) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-20 19:12:49.550228) ========= 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=9531f05ccb2eabcb9acf5f1b000001c0-1505958554.210787-323026496 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/cadd9c5c2016ab453f20cecb8dad62c21bbb3226da48fabd4f265a3c3e2f4ff4cb1cceb7753021fe9c7f20ba4f36069aecfa1c20eecde8f41f1a864fc60ea2c4", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/8727ff9ffd76f66c02820dbfb66f0acc573d1109abf00092d1cf4c207b056e6b70d733aa01bdaf424bf1511fcf6869e927adc3d1184897493f3cb2f986270f7f", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/fe3f9a658c74703e1240dd4511073a6450218e392a0d4593d62f7dd54052016ae8f262954182bd0f3dcd4f616600358bb52355e13e4f0d82dd794a4f1124b0cc", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/64d110d8dd10accb97f420bc84c55a17e643f849e53f977e7e75fe653cdcf747893c52e45a5cfd97f227d5a3029543ae62fe14aed45c53d86271a54cbf427904"} build_url:https://queue.taskcluster.net/v1/task/b1aUbkquTmWwX3uTXEMXyA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011313 build_url: 'https://queue.taskcluster.net/v1/task/b1aUbkquTmWwX3uTXEMXyA/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/cadd9c5c2016ab453f20cecb8dad62c21bbb3226da48fabd4f265a3c3e2f4ff4cb1cceb7753021fe9c7f20ba4f36069aecfa1c20eecde8f41f1a864fc60ea2c4", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/8727ff9ffd76f66c02820dbfb66f0acc573d1109abf00092d1cf4c207b056e6b70d733aa01bdaf424bf1511fcf6869e927adc3d1184897493f3cb2f986270f7f", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/fe3f9a658c74703e1240dd4511073a6450218e392a0d4593d62f7dd54052016ae8f262954182bd0f3dcd4f616600358bb52355e13e4f0d82dd794a4f1124b0cc", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/64d110d8dd10accb97f420bc84c55a17e643f849e53f977e7e75fe653cdcf747893c52e45a5cfd97f227d5a3029543ae62fe14aed45c53d86271a54cbf427904"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-20 19:12:49.581246) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-20 19:12:49.581583) ========= 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=9531f05ccb2eabcb9acf5f1b000001c0-1505958554.210787-323026496 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004416 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-20 19:12:49.664725) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-20 19:12:49.665058) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-20 19:12:49.665396) ========= ========= Total master_lag: 0.28 =========