builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-038 starttime: 1508857760.89 results: success (0) revision: 0765b63cec042046edf4382343e6c3fc4880e792 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-10-24 08:09:20.889864) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-10-24 08:09:20.890526) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-10-24 08:09:20.890862) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-10-24 08:09:20.921270) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-24 08:09:20.921530) ========= 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=8783db0840cc980e80bb0bd400000236-1508857480.452402-1932106324 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-10-24 08:09:20-- 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% 40.2M=0s 2017-10-24 08:09:21 (40.2 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.163682 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-24 08:09:21.109643) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-10-24 08:09:21.109981) ========= 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=8783db0840cc980e80bb0bd400000236-1508857480.452402-1932106324 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022405 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-10-24 08:09:21.178608) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 11 secs) (at 2017-10-24 08:09:21.179022) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 0765b63cec042046edf4382343e6c3fc4880e792 --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 0765b63cec042046edf4382343e6c3fc4880e792 --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=8783db0840cc980e80bb0bd400000236-1508857480.452402-1932106324 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-10-24 08:09:21,226 truncating revision to first 12 chars 2017-10-24 08:09:21,227 Setting DEBUG logging. 2017-10-24 08:09:21,227 attempt 1/10 2017-10-24 08:09:21,227 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/0765b63cec04?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-10-24 08:09:21,957 sleeping for 9.00s (attempt 1/10) 2017-10-24 08:09:30,967 attempt 2/10 2017-10-24 08:09:30,967 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/0765b63cec04?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-10-24 08:09:31,910 unpacking tar archive at: mozilla-beta-0765b63cec04/testing/mozharness/ program finished with exit code 0 elapsedTime=10.996929 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 11 secs) (at 2017-10-24 08:09:32.193431) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-10-24 08:09:32.193759) ========= script_repo_revision: 0765b63cec042046edf4382343e6c3fc4880e792 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-10-24 08:09:32.194181) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-10-24 08:09:32.194474) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-10-24 08:09:32.209783) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2017-10-24 08:09:32.210184) ========= /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=8783db0840cc980e80bb0bd400000236-1508857480.452402-1932106324 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:09:32 INFO - MultiFileLogger online at 20171024 08:09:32 in /builds/slave/test 08:09:32 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 08:09:32 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:09:32 INFO - {'append_to_log': False, 08:09:32 INFO - 'base_work_dir': '/builds/slave/test', 08:09:32 INFO - 'blob_upload_branch': 'Mozilla-Beta-Non-PGO', 08:09:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:09:32 INFO - 'branch': 'Mozilla-Beta-Non-PGO', 08:09:32 INFO - 'buildbot_json_path': 'buildprops.json', 08:09:32 INFO - 'code_coverage': False, 08:09:32 INFO - 'config_files': ('talos/linux_config.py',), 08:09:32 INFO - 'default_actions': ('clobber', 08:09:32 INFO - 'read-buildbot-config', 08:09:32 INFO - 'download-and-extract', 08:09:32 INFO - 'populate-webroot', 08:09:32 INFO - 'create-virtualenv', 08:09:32 INFO - 'install', 08:09:32 INFO - 'setup-mitmproxy', 08:09:32 INFO - 'run-tests'), 08:09:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:09:32 INFO - 'disable_ccov_upload': False, 08:09:32 INFO - 'disable_stylo': False, 08:09:32 INFO - 'download_minidump_stackwalk': True, 08:09:32 INFO - 'download_symbols': 'ondemand', 08:09:32 INFO - 'enable_stylo': False, 08:09:32 INFO - 'enable_webrender': False, 08:09:32 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 08:09:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:09:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:09:32 INFO - 'gecko_profile': False, 08:09:32 INFO - 'gecko_profile_interval': 0, 08:09:32 INFO - 'installer_path': 'installer.exe', 08:09:32 INFO - 'log_level': 'info', 08:09:32 INFO - 'log_name': 'talos', 08:09:32 INFO - 'log_to_console': True, 08:09:32 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:09:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:09:32 INFO - 'opt_config_files': (), 08:09:32 INFO - 'pip_index': False, 08:09:32 INFO - 'suite': 'dromaeojs-e10s', 08:09:32 INFO - 'system_bits': '32', 08:09:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:09:32 INFO - 'title': 'talos-linux64-ix-038', 08:09:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:09:32 INFO - 'use_talos_json': True, 08:09:32 INFO - 'verify': 'False', 08:09:32 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:09:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:09:32 INFO - 'work_dir': 'build'} 08:09:32 INFO - [mozharness: 2017-10-24 15:09:32.401157Z] Running clobber step. 08:09:32 INFO - Running pre-action listener: _resource_record_pre_action 08:09:32 INFO - Running main action method: clobber 08:09:32 INFO - rmtree: /builds/slave/test/build 08:09:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:09:33 INFO - Running post-action listener: _resource_record_post_action 08:09:33 INFO - [mozharness: 2017-10-24 15:09:33.495268Z] Finished clobber step (success) 08:09:33 INFO - [mozharness: 2017-10-24 15:09:33.495367Z] Running read-buildbot-config step. 08:09:33 INFO - Running pre-action listener: _resource_record_pre_action 08:09:33 INFO - Running main action method: read_buildbot_config 08:09:33 INFO - Using buildbot properties: 08:09:33 INFO - { 08:09:33 INFO - "project": "", 08:09:33 INFO - "product": "firefox", 08:09:33 INFO - "who": "ffxbld@noreply.mozilla.org", 08:09:33 INFO - "installer_path": "public/build/target.tar.bz2", 08:09:33 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 08:09:33 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-beta", 08:09:33 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta talos dromaeojs-e10s", 08:09:33 INFO - "stage_platform": "linux64", 08:09:33 INFO - "basedir": "/builds/slave/test", 08:09:33 INFO - "buildnumber": 149, 08:09:33 INFO - "platform": "ubuntu64_hw", 08:09:33 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:09:33 INFO - "slavebuilddir": "test", 08:09:33 INFO - "taskId": "a3gdB6ruSzaVlh09QFegjw", 08:09:33 INFO - "branch": "mozilla-beta", 08:09:33 INFO - "script_repo_revision": "production", 08:09:33 INFO - "revision": "0765b63cec042046edf4382343e6c3fc4880e792", 08:09:33 INFO - "slavename": "talos-linux64-ix-038", 08:09:33 INFO - "repo_path": "releases/mozilla-beta" 08:09:33 INFO - } 08:09:33 INFO - Finding installer, test and symbols from parent task. 08:09:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/a3gdB6ruSzaVlh09QFegjw'}, attempt #1 08:09:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/a3gdB6ruSzaVlh09QFegjw'}, attempt #1 08:09:34 INFO - Task dependencies: KOgJ6WYFRAqISlxxdSnBeQ 08:09:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KOgJ6WYFRAqISlxxdSnBeQ'}, attempt #1 08:09:34 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/KOgJ6WYFRAqISlxxdSnBeQ/artifacts/public/build/target.tar.bz2 08:09:34 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/KOgJ6WYFRAqISlxxdSnBeQ/artifacts/public/build/target.test_packages.json 08:09:34 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/KOgJ6WYFRAqISlxxdSnBeQ/artifacts/public/build/target.crashreporter-symbols.zip 08:09:34 INFO - Running post-action listener: _resource_record_post_action 08:09:34 INFO - [mozharness: 2017-10-24 15:09:34.840235Z] Finished read-buildbot-config step (success) 08:09:34 INFO - [mozharness: 2017-10-24 15:09:34.840453Z] Running download-and-extract step. 08:09:34 INFO - Running pre-action listener: _resource_record_pre_action 08:09:34 INFO - Running main action method: download_and_extract 08:09:34 INFO - mkdir: /builds/slave/test/build/tests 08:09:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:09:34 INFO - trying https://queue.taskcluster.net/v1/task/KOgJ6WYFRAqISlxxdSnBeQ/artifacts/public/build/target.test_packages.json 08:09:34 INFO - Downloading https://queue.taskcluster.net/v1/task/KOgJ6WYFRAqISlxxdSnBeQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 08:09:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KOgJ6WYFRAqISlxxdSnBeQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 08:09:35 INFO - Downloaded 989 bytes. 08:09:35 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 08:09:35 INFO - Using the following test package requirements: 08:09:35 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 08:09:35 INFO - u'common': [u'target.common.tests.zip'], 08:09:35 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 08:09:35 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 08:09:35 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 08:09:35 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 08:09:35 INFO - u'mozbase': [u'target.common.tests.zip'], 08:09:35 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 08:09:35 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 08:09:35 INFO - u'web-platform': [u'target.common.tests.zip', 08:09:35 INFO - u'target.web-platform.tests.tar.gz'], 08:09:35 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 08:09:35 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 08:09:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KOgJ6WYFRAqISlxxdSnBeQ/artifacts/public/build/target.common.tests.zip 08:09:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KOgJ6WYFRAqISlxxdSnBeQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:09:35 INFO - Fetch https://queue.taskcluster.net/v1/task/KOgJ6WYFRAqISlxxdSnBeQ/artifacts/public/build/target.common.tests.zip into memory 08:09:36 INFO - Content-Length response header: 55171912 08:09:36 INFO - Bytes received: 55171912 08:09:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KOgJ6WYFRAqISlxxdSnBeQ/artifacts/public/build/target.talos.tests.zip 08:09:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KOgJ6WYFRAqISlxxdSnBeQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 08:09:48 INFO - Fetch https://queue.taskcluster.net/v1/task/KOgJ6WYFRAqISlxxdSnBeQ/artifacts/public/build/target.talos.tests.zip into memory 08:09:48 INFO - Content-Length response header: 14509096 08:09:48 INFO - Bytes received: 14509096 08:09: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')]} 08:09:49 INFO - trying https://queue.taskcluster.net/v1/task/KOgJ6WYFRAqISlxxdSnBeQ/artifacts/public/build/target.tar.bz2 08:09:49 INFO - Downloading https://queue.taskcluster.net/v1/task/KOgJ6WYFRAqISlxxdSnBeQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 08:09:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KOgJ6WYFRAqISlxxdSnBeQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 08:09:51 INFO - Downloaded 53667218 bytes. 08:09:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KOgJ6WYFRAqISlxxdSnBeQ/artifacts/public/build/target.tar.bz2 08:09:51 INFO - mkdir: /builds/slave/test/properties 08:09:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:09:51 INFO - Writing to file /builds/slave/test/properties/build_url 08:09:51 INFO - Contents: 08:09:51 INFO - build_url:https://queue.taskcluster.net/v1/task/KOgJ6WYFRAqISlxxdSnBeQ/artifacts/public/build/target.tar.bz2 08:09:51 INFO - Running post-action listener: _resource_record_post_action 08:09:51 INFO - Running post-action listener: find_tests_for_verification 08:09:51 INFO - Running post-action listener: set_extra_try_arguments 08:09:51 INFO - [mozharness: 2017-10-24 15:09:51.329166Z] Finished download-and-extract step (success) 08:09:51 INFO - [mozharness: 2017-10-24 15:09:51.329393Z] Running populate-webroot step. 08:09:51 INFO - Running pre-action listener: _resource_record_pre_action 08:09:51 INFO - Running main action method: populate_webroot 08:09:51 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:09:51 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 08:09:51 INFO - 'tests': ['tresize', 08:09:51 INFO - 'tcanvasmark']}, 08:09:51 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:09:51 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 08:09:51 INFO - 'tests': ['dromaeo_css', 08:09:51 INFO - 'kraken']}, 08:09:51 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:09:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:09:51 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 08:09:51 INFO - 'talos_options': ['--disable-stylo'], 08:09:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:09:51 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:09:51 INFO - 'tests': ['damp', 'tps']}, 08:09:51 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 08:09:51 INFO - 'talos_options': ['--disable-stylo'], 08:09:51 INFO - 'tests': ['damp', 'tps']}, 08:09:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:09:51 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 08:09:51 INFO - 'tests': ['dromaeo_dom']}, 08:09:51 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 08:09:51 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 08:09:51 INFO - 'tests': ['basic_compositor_video', 08:09:51 INFO - 'glvideo']}, 08:09:51 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 08:09:51 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 08:09:51 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 08:09:51 INFO - 'talos_options': ['--disable-stylo'], 08:09:51 INFO - 'tests': ['ts_paint_webext', 08:09:51 INFO - 'tp5o_webext']}, 08:09:51 INFO - 'other-e10s': {'tests': ['a11yr', 08:09:51 INFO - 'ts_paint', 08:09:51 INFO - 'tpaint', 08:09:51 INFO - 'sessionrestore', 08:09:51 INFO - 'sessionrestore_many_windows', 08:09:51 INFO - 'sessionrestore_no_auto_restore', 08:09:51 INFO - 'tabpaint']}, 08:09:51 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 08:09:51 INFO - 'tests': ['a11yr', 08:09:51 INFO - 'ts_paint', 08:09:51 INFO - 'tpaint', 08:09:51 INFO - 'sessionrestore', 08:09:51 INFO - 'sessionrestore_many_windows', 08:09:51 INFO - 'sessionrestore_no_auto_restore', 08:09:51 INFO - 'tabpaint']}, 08:09:51 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 08:09:51 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 08:09:51 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 08:09:51 INFO - 'tests': ['perf_reftest_singletons']}, 08:09:51 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 08:09:51 INFO - 'tests': ['bloom_basic']}, 08:09:51 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:09:51 INFO - 'tsvgr_opacity', 08:09:51 INFO - 'tart', 08:09:51 INFO - 'tscrollx', 08:09:51 INFO - 'tsvg_static']}, 08:09:51 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 08:09:51 INFO - 'tests': ['tsvgx', 08:09:51 INFO - 'tsvgr_opacity', 08:09:51 INFO - 'tart', 08:09:51 INFO - 'tscrollx', 08:09:51 INFO - 'tsvg_static']}, 08:09:51 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:09:51 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 08:09:51 INFO - 'talos_options': ['--disable-stylo'], 08:09:51 INFO - 'tests': ['tp5o']}, 08:09:51 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 08:09:51 INFO - 'talos_options': ['--mitmproxy', 08:09:51 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 08:09:51 INFO - '--firstNonBlankPaint'], 08:09:51 INFO - 'tests': ['tp6_google', 08:09:51 INFO - 'tp6_youtube', 08:09:51 INFO - 'tp6_amazon', 08:09:51 INFO - 'tp6_facebook']}, 08:09:51 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 08:09:51 INFO - 'talos_options': ['--disable-stylo', 08:09:51 INFO - '--mitmproxy', 08:09:51 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 08:09:51 INFO - '--firstNonBlankPaint'], 08:09:51 INFO - 'tests': ['tp6_google', 08:09:51 INFO - 'tp6_youtube', 08:09:51 INFO - 'tp6_amazon', 08:09:51 INFO - 'tp6_facebook']}, 08:09:51 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 08:09:51 INFO - 'talos_options': ['--stylo-threads=1', 08:09:51 INFO - '--mitmproxy', 08:09:51 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 08:09:51 INFO - '--firstNonBlankPaint'], 08:09:51 INFO - 'tests': ['tp6_google', 08:09:51 INFO - 'tp6_youtube', 08:09:51 INFO - 'tp6_amazon', 08:09:51 INFO - 'tp6_facebook']}, 08:09:51 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:09:51 INFO - 'talos_options': ['--xperf_path', 08:09:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:09:51 INFO - 'tests': ['tp5n']}, 08:09:51 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 08:09:51 INFO - 'talos_options': ['--disable-stylo', 08:09:51 INFO - '--xperf_path', 08:09:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:09:51 INFO - 'tests': ['tp5n']}}} 08:09:51 INFO - Running post-action listener: _resource_record_post_action 08:09:51 INFO - [mozharness: 2017-10-24 15:09:51.349727Z] Finished populate-webroot step (success) 08:09:51 INFO - [mozharness: 2017-10-24 15:09:51.349817Z] Running create-virtualenv step. 08:09:51 INFO - Running pre-action listener: _resource_record_pre_action 08:09:51 INFO - Running main action method: create_virtualenv 08:09:51 INFO - Creating virtualenv /builds/slave/test/build/venv 08:09:51 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:09:51 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 08:09:51 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 08:09:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:09:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:09:52 INFO - Installing distribute.............................................................................................................................................................................................done. 08:09:52 INFO - Installing pip...............done. 08:09:52 INFO - Return code: 0 08:09:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:09:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:09:52 INFO - Reading from file tmpfile_stdout 08:09:52 INFO - Output received: 08:09:52 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 08:09:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:09: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')]} 08:09:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:09: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')]} 08:09:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:09:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xecb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1093a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1236a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x123a090>, '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 0x123ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1234f90>, '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': '8783db0840cc980e80bb0bd400000236-1508857480.452402-1932106324', '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 08:09:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:09:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:09:52 INFO - Using env: {'DISPLAY': ':0', 08:09:52 INFO - 'HOME': '/home/cltbld', 08:09:52 INFO - 'LANG': 'en_US.UTF-8', 08:09:52 INFO - 'LANGUAGE': 'en_US:en', 08:09:52 INFO - 'LOGNAME': 'cltbld', 08:09:52 INFO - 'MAIL': '/var/mail/cltbld', 08:09:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:52 INFO - 'MOZ_NO_REMOTE': '1', 08:09:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:09:52 INFO - 'NO_EM_RESTART': '1', 08:09:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:09:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:09:52 INFO - 'PWD': '/builds/slave/test', 08:09:52 INFO - 'SHELL': '/bin/bash', 08:09:52 INFO - 'SHLVL': '1', 08:09:52 INFO - 'TERM': 'linux', 08:09:52 INFO - 'TMOUT': '86400', 08:09:52 INFO - 'USER': 'cltbld', 08:09:52 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1508857480.452402-1932106324', 08:09:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:52 INFO - '_': '/tools/buildbot/bin/python'} 08:09:53 INFO - Ignoring indexes: http://pypi.python.org/simple/ 08:09:53 INFO - Downloading/unpacking pip>=1.5 08:09:53 INFO - Running setup.py egg_info for package pip 08:09:53 INFO - warning: no files found matching 'pip/cacert.pem' 08:09:53 INFO - warning: no files found matching '*.html' under directory 'docs' 08:09:53 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 08:09:53 INFO - no previously-included directories found matching 'docs/_build/_sources' 08:09:53 INFO - Installing collected packages: pip 08:09:53 INFO - Found existing installation: pip 1.1 08:09:53 INFO - Uninstalling pip: 08:09:53 INFO - Successfully uninstalled pip 08:09:53 INFO - Running setup.py install for pip 08:09:53 INFO - warning: no files found matching 'pip/cacert.pem' 08:09:53 INFO - warning: no files found matching '*.html' under directory 'docs' 08:09:53 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 08:09:53 INFO - no previously-included directories found matching 'docs/_build/_sources' 08:09:53 INFO - Installing pip script to /builds/slave/test/build/venv/bin 08:09:53 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 08:09:53 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 08:09:53 INFO - Successfully installed pip 08:09:53 INFO - Cleaning up... 08:09:53 INFO - Return code: 0 08:09:53 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:09:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:09:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:09:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:09:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:09:53 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 0xecb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1093a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1236a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x123a090>, '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 0x123ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1234f90>, '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': '8783db0840cc980e80bb0bd400000236-1508857480.452402-1932106324', '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 08:09:53 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 08:09:53 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 08:09:53 INFO - Using env: {'DISPLAY': ':0', 08:09:53 INFO - 'HOME': '/home/cltbld', 08:09:53 INFO - 'LANG': 'en_US.UTF-8', 08:09:53 INFO - 'LANGUAGE': 'en_US:en', 08:09:53 INFO - 'LOGNAME': 'cltbld', 08:09:53 INFO - 'MAIL': '/var/mail/cltbld', 08:09:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:53 INFO - 'MOZ_NO_REMOTE': '1', 08:09:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:09:53 INFO - 'NO_EM_RESTART': '1', 08:09:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:09:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:09:53 INFO - 'PWD': '/builds/slave/test', 08:09:53 INFO - 'SHELL': '/bin/bash', 08:09:53 INFO - 'SHLVL': '1', 08:09:53 INFO - 'TERM': 'linux', 08:09:53 INFO - 'TMOUT': '86400', 08:09:53 INFO - 'USER': 'cltbld', 08:09:53 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1508857480.452402-1932106324', 08:09:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:53 INFO - '_': '/tools/buildbot/bin/python'} 08:09:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:09:54 INFO - Downloading/unpacking psutil>=3.1.1 08:09:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:09:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:09:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:09:55 INFO - Installing collected packages: psutil 08:09:55 INFO - Running setup.py install for psutil 08:09:55 INFO - building 'psutil._psutil_linux' extension 08:09:55 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 08:09:56 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 08:09:56 INFO - building 'psutil._psutil_posix' extension 08:09:56 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 08:09:57 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 08:09:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:09:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:09:58 INFO - Successfully installed psutil 08:09:58 INFO - Cleaning up... 08:10:00 INFO - Return code: 0 08:10:00 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:10:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:10:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:10:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:10:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:10:00 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 0xecb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1093a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1236a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x123a090>, '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 0x123ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1234f90>, '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': '8783db0840cc980e80bb0bd400000236-1508857480.452402-1932106324', '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 08:10:00 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 08:10:00 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 08:10:00 INFO - Using env: {'DISPLAY': ':0', 08:10:00 INFO - 'HOME': '/home/cltbld', 08:10:00 INFO - 'LANG': 'en_US.UTF-8', 08:10:00 INFO - 'LANGUAGE': 'en_US:en', 08:10:00 INFO - 'LOGNAME': 'cltbld', 08:10:00 INFO - 'MAIL': '/var/mail/cltbld', 08:10:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:10:00 INFO - 'MOZ_NO_REMOTE': '1', 08:10:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:10:00 INFO - 'NO_EM_RESTART': '1', 08:10:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:10:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:10:00 INFO - 'PWD': '/builds/slave/test', 08:10:00 INFO - 'SHELL': '/bin/bash', 08:10:00 INFO - 'SHLVL': '1', 08:10:00 INFO - 'TERM': 'linux', 08:10:00 INFO - 'TMOUT': '86400', 08:10:00 INFO - 'USER': 'cltbld', 08:10:00 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1508857480.452402-1932106324', 08:10:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:10:00 INFO - '_': '/tools/buildbot/bin/python'} 08:10:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:10:00 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:10:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:10:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:10:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:10:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:10:02 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:10:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:10:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:10:02 INFO - Installing collected packages: mozsystemmonitor 08:10:02 INFO - Running setup.py install for mozsystemmonitor 08:10:04 INFO - Successfully installed mozsystemmonitor 08:10:04 INFO - Cleaning up... 08:10:04 INFO - Return code: 0 08:10:04 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:10:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:10:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:10:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:10:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:10:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xecb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1093a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1236a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x123a090>, '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 0x123ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1234f90>, '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': '8783db0840cc980e80bb0bd400000236-1508857480.452402-1932106324', '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 08:10:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:10:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:10:04 INFO - Using env: {'DISPLAY': ':0', 08:10:04 INFO - 'HOME': '/home/cltbld', 08:10:04 INFO - 'LANG': 'en_US.UTF-8', 08:10:04 INFO - 'LANGUAGE': 'en_US:en', 08:10:04 INFO - 'LOGNAME': 'cltbld', 08:10:04 INFO - 'MAIL': '/var/mail/cltbld', 08:10:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:10:04 INFO - 'MOZ_NO_REMOTE': '1', 08:10:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:10:04 INFO - 'NO_EM_RESTART': '1', 08:10:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:10:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:10:04 INFO - 'PWD': '/builds/slave/test', 08:10:04 INFO - 'SHELL': '/bin/bash', 08:10:04 INFO - 'SHLVL': '1', 08:10:04 INFO - 'TERM': 'linux', 08:10:04 INFO - 'TMOUT': '86400', 08:10:04 INFO - 'USER': 'cltbld', 08:10:04 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1508857480.452402-1932106324', 08:10:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:10:04 INFO - '_': '/tools/buildbot/bin/python'} 08:10:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:10:04 INFO - Downloading/unpacking jsonschema==2.5.1 08:10:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:10:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:10:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:10:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:10:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:10:06 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:10:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:10:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:10:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:10:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:10:06 INFO - Downloading functools32-3.2.3-2.tar.gz 08:10:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:10:06 INFO - warning: no files found matching '*.txt' 08:10:06 INFO - no previously-included directories found matching 'build' 08:10:06 INFO - no previously-included directories found matching 'dist' 08:10:06 INFO - no previously-included directories found matching '.git*' 08:10:06 INFO - Installing collected packages: jsonschema, functools32 08:10:06 INFO - Running setup.py install for functools32 08:10:06 INFO - warning: no files found matching '*.txt' 08:10:06 INFO - no previously-included directories found matching 'build' 08:10:06 INFO - no previously-included directories found matching 'dist' 08:10:06 INFO - no previously-included directories found matching '.git*' 08:10:06 INFO - Successfully installed jsonschema functools32 08:10:06 INFO - Cleaning up... 08:10:06 INFO - Return code: 0 08:10:06 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:10:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:10:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:10:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:10:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:10:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xecb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1093a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1236a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x123a090>, '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 0x123ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1234f90>, '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': '8783db0840cc980e80bb0bd400000236-1508857480.452402-1932106324', '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 08:10:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:10:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:10:06 INFO - Using env: {'DISPLAY': ':0', 08:10:06 INFO - 'HOME': '/home/cltbld', 08:10:06 INFO - 'LANG': 'en_US.UTF-8', 08:10:06 INFO - 'LANGUAGE': 'en_US:en', 08:10:06 INFO - 'LOGNAME': 'cltbld', 08:10:06 INFO - 'MAIL': '/var/mail/cltbld', 08:10:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:10:06 INFO - 'MOZ_NO_REMOTE': '1', 08:10:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:10:06 INFO - 'NO_EM_RESTART': '1', 08:10:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:10:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:10:06 INFO - 'PWD': '/builds/slave/test', 08:10:06 INFO - 'SHELL': '/bin/bash', 08:10:06 INFO - 'SHLVL': '1', 08:10:06 INFO - 'TERM': 'linux', 08:10:06 INFO - 'TMOUT': '86400', 08:10:06 INFO - 'USER': 'cltbld', 08:10:06 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1508857480.452402-1932106324', 08:10:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:10:06 INFO - '_': '/tools/buildbot/bin/python'} 08:10:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:10:06 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:10:06 INFO - Cleaning up... 08:10:06 INFO - Return code: 0 08:10:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:10:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:10:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:10:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:10:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:10:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xecb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1093a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1236a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x123a090>, '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 0x123ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1234f90>, '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': '8783db0840cc980e80bb0bd400000236-1508857480.452402-1932106324', '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 08:10:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:10:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:10:06 INFO - Using env: {'DISPLAY': ':0', 08:10:06 INFO - 'HOME': '/home/cltbld', 08:10:06 INFO - 'LANG': 'en_US.UTF-8', 08:10:06 INFO - 'LANGUAGE': 'en_US:en', 08:10:06 INFO - 'LOGNAME': 'cltbld', 08:10:06 INFO - 'MAIL': '/var/mail/cltbld', 08:10:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:10:06 INFO - 'MOZ_NO_REMOTE': '1', 08:10:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:10:06 INFO - 'NO_EM_RESTART': '1', 08:10:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:10:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:10:06 INFO - 'PWD': '/builds/slave/test', 08:10:06 INFO - 'SHELL': '/bin/bash', 08:10:06 INFO - 'SHLVL': '1', 08:10:06 INFO - 'TERM': 'linux', 08:10:06 INFO - 'TMOUT': '86400', 08:10:06 INFO - 'USER': 'cltbld', 08:10:06 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1508857480.452402-1932106324', 08:10:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:10:06 INFO - '_': '/tools/buildbot/bin/python'} 08:10:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:10:06 INFO - Downloading/unpacking blobuploader==1.2.4 08:10:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:10:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:10:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:10:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:10:08 INFO - Downloading blobuploader-1.2.4.tar.gz 08:10:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:10:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:10:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:10:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:10:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:10:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:10:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:10:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:10:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:10:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:10:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:10:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:10:08 INFO - Downloading docopt-0.6.1.tar.gz 08:10:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:10:08 INFO - Installing collected packages: blobuploader, requests, docopt 08:10:08 INFO - Running setup.py install for blobuploader 08:10:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:10:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:10:08 INFO - Running setup.py install for requests 08:10:09 INFO - Running setup.py install for docopt 08:10:09 INFO - Successfully installed blobuploader requests docopt 08:10:09 INFO - Cleaning up... 08:10:09 INFO - Return code: 0 08:10:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:10:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:10:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:10:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:10:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:10:09 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 0xecb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1093a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1236a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x123a090>, '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 0x123ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1234f90>, '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': '8783db0840cc980e80bb0bd400000236-1508857480.452402-1932106324', '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 08:10:09 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 08:10:09 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 08:10:09 INFO - Using env: {'DISPLAY': ':0', 08:10:09 INFO - 'HOME': '/home/cltbld', 08:10:09 INFO - 'LANG': 'en_US.UTF-8', 08:10:09 INFO - 'LANGUAGE': 'en_US:en', 08:10:09 INFO - 'LOGNAME': 'cltbld', 08:10:09 INFO - 'MAIL': '/var/mail/cltbld', 08:10:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:10:09 INFO - 'MOZ_NO_REMOTE': '1', 08:10:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:10:09 INFO - 'NO_EM_RESTART': '1', 08:10:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:10:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:10:09 INFO - 'PWD': '/builds/slave/test', 08:10:09 INFO - 'SHELL': '/bin/bash', 08:10:09 INFO - 'SHLVL': '1', 08:10:09 INFO - 'TERM': 'linux', 08:10:09 INFO - 'TMOUT': '86400', 08:10:09 INFO - 'USER': 'cltbld', 08:10:09 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1508857480.452402-1932106324', 08:10:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:10:09 INFO - '_': '/tools/buildbot/bin/python'} 08:10:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:10:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:10:09 INFO - Running setup.py (path:/tmp/pip-Fu_ST3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:10:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:10:09 INFO - Running setup.py (path:/tmp/pip-NKAY_y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:10:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:10:09 INFO - Running setup.py (path:/tmp/pip-0U_sZa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:10:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:10:09 INFO - Running setup.py (path:/tmp/pip-9yTr1B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:10:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:10:09 INFO - Running setup.py (path:/tmp/pip-PYfTZl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:10:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:10:09 INFO - Running setup.py (path:/tmp/pip-cFhTiS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:10:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:10:09 INFO - Running setup.py (path:/tmp/pip-lyA1QP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:10:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:10:09 INFO - Running setup.py (path:/tmp/pip-m_6lR8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:10:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:10:10 INFO - Running setup.py (path:/tmp/pip-A2aXIe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:10:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:10:10 INFO - Running setup.py (path:/tmp/pip-fMkj4H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:10:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:10:10 INFO - Running setup.py (path:/tmp/pip-JTh495-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:10:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:10:10 INFO - Running setup.py (path:/tmp/pip-jqbqiQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:10:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:10:10 INFO - Running setup.py (path:/tmp/pip-3x6UWr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:10:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:10:10 INFO - Running setup.py (path:/tmp/pip-7R9LRE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:10:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:10:10 INFO - Running setup.py (path:/tmp/pip-h2tSB5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:10:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:10:10 INFO - Running setup.py (path:/tmp/pip-kYc0Vh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:10:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:10:10 INFO - Running setup.py (path:/tmp/pip-EXLnrr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:10:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:10:10 INFO - Running setup.py install for manifestparser 08:10:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:10:10 INFO - Running setup.py install for mozcrash 08:10:10 INFO - Running setup.py install for mozdebug 08:10:10 INFO - Running setup.py install for mozdevice 08:10:11 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:10:11 INFO - Running setup.py install for mozfile 08:10:11 INFO - Running setup.py install for mozhttpd 08:10:11 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:10:11 INFO - Running setup.py install for mozinfo 08:10:11 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:10:11 INFO - Running setup.py install for mozInstall 08:10:11 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:10:11 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:10:11 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:10:11 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:10:11 INFO - Running setup.py install for mozleak 08:10:11 INFO - Running setup.py install for mozlog 08:10:11 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:10:11 INFO - Running setup.py install for moznetwork 08:10:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:10:11 INFO - Running setup.py install for mozprocess 08:10:11 INFO - Running setup.py install for mozprofile 08:10:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:10:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:10:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:10:11 INFO - Running setup.py install for mozrunner 08:10:12 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:10:12 INFO - Running setup.py install for mozscreenshot 08:10:12 INFO - Running setup.py install for moztest 08:10:12 INFO - Running setup.py install for mozversion 08:10:12 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:10:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:10:12 INFO - Cleaning up... 08:10:12 INFO - Return code: 0 08:10:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:10:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:10:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:10:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:10:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:10:12 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 0xecb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1093a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1236a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x123a090>, '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 0x123ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1234f90>, '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': '8783db0840cc980e80bb0bd400000236-1508857480.452402-1932106324', '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 08:10:12 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 08:10:12 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 08:10:12 INFO - Using env: {'DISPLAY': ':0', 08:10:12 INFO - 'HOME': '/home/cltbld', 08:10:12 INFO - 'LANG': 'en_US.UTF-8', 08:10:12 INFO - 'LANGUAGE': 'en_US:en', 08:10:12 INFO - 'LOGNAME': 'cltbld', 08:10:12 INFO - 'MAIL': '/var/mail/cltbld', 08:10:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:10:12 INFO - 'MOZ_NO_REMOTE': '1', 08:10:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:10:12 INFO - 'NO_EM_RESTART': '1', 08:10:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:10:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:10:12 INFO - 'PWD': '/builds/slave/test', 08:10:12 INFO - 'SHELL': '/bin/bash', 08:10:12 INFO - 'SHLVL': '1', 08:10:12 INFO - 'TERM': 'linux', 08:10:12 INFO - 'TMOUT': '86400', 08:10:12 INFO - 'USER': 'cltbld', 08:10:12 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1508857480.452402-1932106324', 08:10:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:10:12 INFO - '_': '/tools/buildbot/bin/python'} 08:10:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:10:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:10:12 INFO - Running setup.py (path:/tmp/pip-QeHI0i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:10:12 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)) 08:10:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:10:12 INFO - Running setup.py (path:/tmp/pip-0oQWc2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:10:12 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)) 08:10:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:10:12 INFO - Running setup.py (path:/tmp/pip-EDPWUt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:10:12 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)) 08:10:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:10:12 INFO - Running setup.py (path:/tmp/pip-ZZsB7q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:10:12 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)) 08:10:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:10:12 INFO - Running setup.py (path:/tmp/pip-3TydCo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:10:12 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)) 08:10:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:10:12 INFO - Running setup.py (path:/tmp/pip-0uE0sG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:10:13 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)) 08:10:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:10:13 INFO - Running setup.py (path:/tmp/pip-bBbVjn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:10:13 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)) 08:10:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:10:13 INFO - Running setup.py (path:/tmp/pip-DMNEwa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:10:13 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)) 08:10:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:10:13 INFO - Running setup.py (path:/tmp/pip-0BpUg3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:10:13 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)) 08:10:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:10:13 INFO - Running setup.py (path:/tmp/pip-gH3Hpm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:10:13 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)) 08:10:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:10:13 INFO - Running setup.py (path:/tmp/pip-1cpmB9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:10:13 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)) 08:10:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:10:13 INFO - Running setup.py (path:/tmp/pip-fXvYH3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:10:13 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)) 08:10:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:10:13 INFO - Running setup.py (path:/tmp/pip-UydQp6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:10:13 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)) 08:10:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:10:13 INFO - Running setup.py (path:/tmp/pip-5Ngve3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:10:13 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)) 08:10:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:10:13 INFO - Running setup.py (path:/tmp/pip-sebLMM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:10:13 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)) 08:10:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:10:13 INFO - Running setup.py (path:/tmp/pip-SoJjMU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:10:13 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)) 08:10:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:10:13 INFO - Running setup.py (path:/tmp/pip-zMkSTF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:10:13 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)) 08:10:13 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)) 08:10:13 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)) 08:10:13 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)) 08:10:13 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)) 08:10:13 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)) 08:10:13 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)) 08:10:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:10:13 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 08:10:13 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 08:10:13 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 08:10:13 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 08:10:14 INFO - Downloading blessings-1.6.tar.gz 08:10:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:10:15 INFO - Installing collected packages: blessings 08:10:15 INFO - Running setup.py install for blessings 08:10:15 INFO - Successfully installed blessings 08:10:15 INFO - Cleaning up... 08:10:15 INFO - Return code: 0 08:10:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:10:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:10:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:10:15 INFO - Reading from file tmpfile_stdout 08:10:15 INFO - Current package versions: 08:10:15 INFO - argparse == 1.2.1 08:10:15 INFO - blessings == 1.6 08:10:15 INFO - blobuploader == 1.2.4 08:10:15 INFO - docopt == 0.6.1 08:10:15 INFO - functools32 == 3.2.3-2 08:10:15 INFO - jsonschema == 2.5.1 08:10:15 INFO - manifestparser == 1.1 08:10:15 INFO - mozInstall == 1.13 08:10:15 INFO - mozcrash == 1.0 08:10:15 INFO - mozdebug == 0.1 08:10:15 INFO - mozdevice == 0.51 08:10:15 INFO - mozfile == 1.2 08:10:15 INFO - mozhttpd == 0.7 08:10:15 INFO - mozinfo == 0.10 08:10:15 INFO - mozleak == 0.1 08:10:15 INFO - mozlog == 3.5 08:10:15 INFO - moznetwork == 0.27 08:10:15 INFO - mozprocess == 0.25 08:10:15 INFO - mozprofile == 0.28 08:10:15 INFO - mozrunner == 6.13 08:10:15 INFO - mozscreenshot == 0.1 08:10:15 INFO - mozsystemmonitor == 0.3 08:10:15 INFO - moztest == 0.8 08:10:15 INFO - mozversion == 1.4 08:10:15 INFO - psutil == 3.1.1 08:10:15 INFO - requests == 1.2.3 08:10:15 INFO - wsgiref == 0.1.2 08:10:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:10:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:10:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:10:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:10:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:10:15 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 0xecb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1093a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1236a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x123a090>, '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 0x123ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1234f90>, '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': '8783db0840cc980e80bb0bd400000236-1508857480.452402-1932106324', '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 08:10:15 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 08:10:15 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 08:10:15 INFO - Using env: {'DISPLAY': ':0', 08:10:15 INFO - 'HOME': '/home/cltbld', 08:10:15 INFO - 'LANG': 'en_US.UTF-8', 08:10:15 INFO - 'LANGUAGE': 'en_US:en', 08:10:15 INFO - 'LOGNAME': 'cltbld', 08:10:15 INFO - 'MAIL': '/var/mail/cltbld', 08:10:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:10:15 INFO - 'MOZ_NO_REMOTE': '1', 08:10:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:10:15 INFO - 'NO_EM_RESTART': '1', 08:10:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:10:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:10:15 INFO - 'PWD': '/builds/slave/test', 08:10:15 INFO - 'SHELL': '/bin/bash', 08:10:15 INFO - 'SHLVL': '1', 08:10:15 INFO - 'TERM': 'linux', 08:10:15 INFO - 'TMOUT': '86400', 08:10:15 INFO - 'USER': 'cltbld', 08:10:15 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1508857480.452402-1932106324', 08:10:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:10:15 INFO - '_': '/tools/buildbot/bin/python'} 08:10:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:10:15 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)) 08:10:15 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)) 08:10:15 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)) 08:10:15 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)) 08:10:15 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)) 08:10:15 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)) 08:10:15 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)) 08:10:15 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)) 08:10:15 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)) 08:10:15 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 08:10:15 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 08:10:15 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 08:10:15 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 08:10:15 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 08:10:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 08:10:16 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)) 08:10:16 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)) 08:10:16 INFO - Installing collected packages: simplejson 08:10:16 INFO - Running setup.py install for simplejson 08:10:16 INFO - building 'simplejson._speedups' extension 08:10:16 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 08:10:17 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 08:10:17 INFO - Successfully installed simplejson 08:10:17 INFO - Cleaning up... 08:10:17 INFO - Return code: 0 08:10:17 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:10:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:10:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:10:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:10:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:10:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xecb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1093a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1236a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x123a090>, '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 0x123ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1234f90>, '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': '8783db0840cc980e80bb0bd400000236-1508857480.452402-1932106324', '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 08:10:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:10:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:10:17 INFO - Using env: {'DISPLAY': ':0', 08:10:17 INFO - 'HOME': '/home/cltbld', 08:10:17 INFO - 'LANG': 'en_US.UTF-8', 08:10:17 INFO - 'LANGUAGE': 'en_US:en', 08:10:17 INFO - 'LOGNAME': 'cltbld', 08:10:17 INFO - 'MAIL': '/var/mail/cltbld', 08:10:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:10:17 INFO - 'MOZ_NO_REMOTE': '1', 08:10:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:10:17 INFO - 'NO_EM_RESTART': '1', 08:10:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:10:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:10:17 INFO - 'PWD': '/builds/slave/test', 08:10:17 INFO - 'SHELL': '/bin/bash', 08:10:17 INFO - 'SHLVL': '1', 08:10:17 INFO - 'TERM': 'linux', 08:10:17 INFO - 'TMOUT': '86400', 08:10:17 INFO - 'USER': 'cltbld', 08:10:17 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1508857480.452402-1932106324', 08:10:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:10:17 INFO - '_': '/tools/buildbot/bin/python'} 08:10:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:10:18 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:10:18 INFO - Cleaning up... 08:10:18 INFO - Return code: 0 08:10:18 INFO - Running post-action listener: _resource_record_post_action 08:10:18 INFO - Running post-action listener: _start_resource_monitoring 08:10:18 INFO - Starting resource monitoring. 08:10:18 INFO - [mozharness: 2017-10-24 15:10:18.114121Z] Finished create-virtualenv step (success) 08:10:18 INFO - [mozharness: 2017-10-24 15:10:18.114597Z] Running install step. 08:10:18 INFO - Running pre-action listener: _resource_record_pre_action 08:10:18 INFO - Running main action method: install 08:10:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:10:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:10:18 INFO - Reading from file tmpfile_stdout 08:10:18 INFO - Detecting whether we're running mozinstall >=1.0... 08:10:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:10:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:10:18 INFO - Reading from file tmpfile_stdout 08:10:18 INFO - Output received: 08:10:18 INFO - Usage: mozinstall [options] installer 08:10:18 INFO - Options: 08:10:18 INFO - -h, --help show this help message and exit 08:10:18 INFO - -d DEST, --destination=DEST 08:10:18 INFO - Directory to install application into. [default: 08:10:18 INFO - "/builds/slave/test"] 08:10:18 INFO - --app=APP Application being installed. [default: firefox] 08:10:18 INFO - mkdir: /builds/slave/test/build/application 08:10:18 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'] 08:10:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 08:10:33 INFO - Reading from file tmpfile_stdout 08:10:33 INFO - Output received: 08:10:33 INFO - /builds/slave/test/build/application/firefox/firefox 08:10:33 INFO - Running post-action listener: _resource_record_post_action 08:10:33 INFO - [mozharness: 2017-10-24 15:10:33.343403Z] Finished install step (success) 08:10:33 INFO - [mozharness: 2017-10-24 15:10:33.343655Z] Running setup-mitmproxy step. 08:10:33 INFO - Running pre-action listener: _resource_record_pre_action 08:10:33 INFO - Running main action method: setup_mitmproxy 08:10:33 INFO - Skipping: mitmproxy is not required 08:10:33 INFO - Running post-action listener: _resource_record_post_action 08:10:33 INFO - [mozharness: 2017-10-24 15:10:33.344784Z] Finished setup-mitmproxy step (success) 08:10:33 INFO - [mozharness: 2017-10-24 15:10:33.345004Z] Running run-tests step. 08:10:33 INFO - Running pre-action listener: _resource_record_pre_action 08:10:33 INFO - Running pre-action listener: _set_gcov_prefix 08:10:33 INFO - Running main action method: run_tests 08:10:33 WARNING - Try message not found. 08:10:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:10:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:10:33 INFO - Python 2.7.3 08:10:33 INFO - Return code: 0 08:10:33 INFO - grabbing minidump binary from tooltool 08:10:33 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')]} 08:10:33 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 0x123a090>, '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 0x123ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1234f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:10:33 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 08:10:33 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 08:10:33 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 08:10:33 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:10:33 INFO - Return code: 0 08:10:33 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:10:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:10:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:10:33 INFO - ENV: RUST_BACKTRACE is now full 08:10:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:10:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:10:33 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/KOgJ6WYFRAqISlxxdSnBeQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--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 08:10:33 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/KOgJ6WYFRAqISlxxdSnBeQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-038 --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 08:10:33 INFO - Using env: {'DISPLAY': ':0', 08:10:33 INFO - 'HOME': '/home/cltbld', 08:10:33 INFO - 'LANG': 'en_US.UTF-8', 08:10:33 INFO - 'LANGUAGE': 'en_US:en', 08:10:33 INFO - 'LOGNAME': 'cltbld', 08:10:33 INFO - 'MAIL': '/var/mail/cltbld', 08:10:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:10:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:10:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:10:33 INFO - 'MOZ_NO_REMOTE': '1', 08:10:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:10:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:10:33 INFO - 'NO_EM_RESTART': '1', 08:10:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:10:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:10:33 INFO - 'PWD': '/builds/slave/test', 08:10:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:10:33 INFO - 'RUST_BACKTRACE': 'full', 08:10:33 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 08:10:33 INFO - 'SHELL': '/bin/bash', 08:10:33 INFO - 'SHLVL': '1', 08:10:33 INFO - 'TERM': 'linux', 08:10:33 INFO - 'TMOUT': '86400', 08:10:33 INFO - 'USER': 'cltbld', 08:10:33 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1508857480.452402-1932106324', 08:10:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:10:33 INFO - '_': '/tools/buildbot/bin/python'} 08:10:33 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/KOgJ6WYFRAqISlxxdSnBeQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--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 08:10:33 INFO - mozversion application_buildid: 20171024134918 08:10:33 INFO - mozversion application_changeset: 0765b63cec042046edf4382343e6c3fc4880e792 08:10:33 INFO - mozversion application_display_name: Firefox 08:10:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:10:33 INFO - mozversion application_name: Firefox 08:10:33 INFO - mozversion application_remotingname: firefox 08:10:33 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 08:10:33 INFO - mozversion application_vendor: Mozilla 08:10:33 INFO - mozversion application_version: 57.0 08:10:33 INFO - mozversion platform_buildid: 20171024134918 08:10:33 INFO - mozversion platform_changeset: 0765b63cec042046edf4382343e6c3fc4880e792 08:10:33 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 08:10:33 INFO - mozversion platform_version: 57.0 08:10:33 INFO - using testdate: 1508857833 08:10:33 INFO - actual date: 1508857833 08:10:33 INFO - starting webserver on 'localhost:35437' 08:10:33 INFO - SUITE-START | Running 2 tests 08:10:33 INFO - TEST-START | dromaeo_css 08:10:33 INFO - Initialising browser for dromaeo_css test... 08:10:33 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:35437/getInfo.html -profile /tmp/tmphr3AkD/profile 08:10:33 INFO - TEST-INFO | started process 17060 (/builds/slave/test/build/application/firefox/firefox http://localhost:35437/getInfo.html) 08:10:40 INFO - TEST-INFO | 17060: exit 0 08:10:40 INFO - Browser initialized. 08:10:40 INFO - Running cycle 1/1 for dromaeo_css test... 08:10:40 INFO - Using env: {'DISPLAY': ':0', 08:10:40 INFO - 'HOME': '/home/cltbld', 08:10:40 INFO - 'JSGC_DISABLE_POISONING': '1', 08:10:40 INFO - 'LANG': 'en_US.UTF-8', 08:10:40 INFO - 'LANGUAGE': 'en_US:en', 08:10:40 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 08:10:40 INFO - 'LOGNAME': 'cltbld', 08:10:40 INFO - 'MAIL': '/var/mail/cltbld', 08:10:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:10:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:10:40 INFO - 'MOZ_CRASHREPORTER': '1', 08:10:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:10:40 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 08:10:40 INFO - 'MOZ_NO_REMOTE': '1', 08:10:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:10:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:10:40 INFO - 'NO_EM_RESTART': '1', 08:10:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:10:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:10:40 INFO - 'PWD': '/builds/slave/test', 08:10:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:10:40 INFO - 'RUST_BACKTRACE': 'full', 08:10:40 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 08:10:40 INFO - 'SHELL': '/bin/bash', 08:10:40 INFO - 'SHLVL': '1', 08:10:40 INFO - 'TERM': 'linux', 08:10:40 INFO - 'TMOUT': '86400', 08:10:40 INFO - 'USER': 'cltbld', 08:10:40 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1508857480.452402-1932106324', 08:10:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:10:40 INFO - '_': '/tools/buildbot/bin/python'} 08:10:40 INFO - TEST-INFO | started process 17295 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphr3AkD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 08:10:41 INFO - PID 17295 | 08:10:41 INFO - PID 17295 | (/builds/slave/test/build/application/firefox/firefox:17344): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 08:10:41 INFO - PID 17295 | 08:10:51 INFO - PID 17295 | RSS: Main: 141766656 08:10:51 INFO - PID 17295 | 08:13:49 INFO - PID 17295 | Cycle 1(1): loaded http://localhost:35437/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35437/tests/dromaeo/cssquery-ext.html) 08:13:50 INFO - PID 17295 | RSS: Main: 145252352 08:13:50 INFO - PID 17295 | 08:16:51 INFO - PID 17295 | Cycle 1(1): loaded http://localhost:35437/tests/dromaeo/cssquery-ext.html (next: http://localhost:35437/tests/dromaeo/cssquery-jquery.html) 08:16:52 INFO - PID 17295 | RSS: Main: 144162816 08:16:52 INFO - PID 17295 | 08:19:53 INFO - PID 17295 | Cycle 1(1): loaded http://localhost:35437/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35437/tests/dromaeo/cssquery-mootools.html) 08:19:54 INFO - PID 17295 | RSS: Main: 144945152 08:19:54 INFO - PID 17295 | 08:22:55 INFO - PID 17295 | Cycle 1(1): loaded http://localhost:35437/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35437/tests/dromaeo/cssquery-prototype.html) 08:22:56 INFO - PID 17295 | RSS: Main: 144982016 08:22:56 INFO - PID 17295 | 08:25:59 INFO - PID 17295 | Cycle 1(1): loaded http://localhost:35437/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35437/tests/dromaeo/cssquery-yui.html) 08:25:59 INFO - PID 17295 | RSS: Main: 146558976 08:25:59 INFO - PID 17295 | 08:29:01 INFO - PID 17295 | Cycle 1(1): loaded http://localhost:35437/tests/dromaeo/cssquery-yui.html (next: http://localhost:35437/tests/dromaeo/cssquery-dojo.html) 08:29:01 INFO - PID 17295 | RSS: Main: 148779008 08:29:01 INFO - PID 17295 | 08:29:01 INFO - PID 17295 | __start_tp_report 08:29:01 INFO - PID 17295 | _x_x_mozilla_page_load 08:29:01 INFO - PID 17295 | _x_x_mozilla_page_load_details 08:29:01 INFO - PID 17295 | |i|pagename|runs| 08:29:01 INFO - PID 17295 | |0;dojo.html;4046.0896298332877;4057.513098428189;4061.3095773718464;4070.3690927906177;4071.1857628474295;6550.639714815683;6558.803235902925;6577.53957222994;6634.402903738663;6653;6539.803805885819;6564.442022428099;6597.769078082268;6625.337466253372;6642.136522252113;5846.532277417818;5914.674692891889;5963.105534169866;5963.194968679238;5969.791057312995;5903.173555702205;5922.141289513018;5925.259342582177;5944.286685597713;5997.160397544348;5988.2215312009375;5996.910046349309;6060.36366181549;6072.939270607304;6084.482818960394;5892.204552385416;5981.581289309728;6018.4583387494895;6053.576249662526;6055.515558755311;5788.479036886701;5840.912386314209;5887.175795388649;5890.9410905891245;5906.704664766745;6436.903446448307;6521.445677117451;6541.967290163567;6561.80314590563;6637.56855804376;7067.328603782633;7086.574805511686;7098.503104782667;7180.24607416219;7208.891866622005;7099.645017749143;7133.964330178368;7231.963840180818;7235.855282894366;7246;6559.212894452601;6585.176852893388;6638.535302528873;6660.067590537328;6717;7303.911065490059;7360.374368178657;7365.52124111931;7395.81510462232;7409.184989651134;6904.896426553606;7031.40233080194;7034.964825175842;7052.788416347517;7124.287571242834;7085.043519124955;7152.4278057755255;7223.241559636268;7224.67488962998;7249.202587715347;7063.89404158938;7142.178649455275;7167.032450619204;7172.139343278735;7182.922561615799;7080.398166155935;7092.25531319204;7098.68055937484;7135.857282854314;7147.070880785464;5189.040027594907;5260.026895024433;5271.868203294872;5272.314599102169;5274.103402421598;4818.975905120452;4875.07373599015;4898.069366820293;4898.118338699069;4917.582005529499;6504.60972341661;6599.175103112111;6599.8350041248395;6660.766873159416;6663.833829079892;7019;7034.437245020386;7084.539504932163;7111.395531379891;7113.608751518716;6654.733810647616;6673.599584024974;6698.56459330142;6701;6713.1272934519175;5951.732172052268;5956.55325850563;6041.124037014696;6042;6046.032634778414;7308.6345682715655;7313.085864266966;7358.926410735824;7430;7506.962465187639;7104.928950710633;7166;7173.856522869409;7182.461315401261;7184.676689548878;7433.182349941394;7440.330370266702;7444.181140074696;7516.924830751623;7549.433792465477;6902.827429314308;6954.860902782018;7011.228764835762;7030.472714546328;7113.893291600733;7126.394256488049;7157.320054594805;7182.640867956686;7190.101237345332;7227.313405226495;6839.555428897106;6847.760328388682;6944.305569443218;6945.166580010431;6953.1656201254145;6696.933030669631;6798.354156355138;6851.828704282433;6861.4510839133745;6869.313068693291;6785.084013658093;6801.7279308829075;6806.319368063154;6828.317168283132;6895.034695142785;6962.651867406711;7005.964970175117;7017.298270173146;7018.859622807618;7021.648917554204;6634.369734875179;6655.467562595078;6701.664916754045;6747.426468750211;6799.796006119825 08:29:01 INFO - PID 17295 | |1;ext.html;971.0823272007951;987.9456629885358;1009.5557954500019;1028.8816786069603;1033.9948300258498;42083.15833683324;42883.57116428835;46126.308105378404;46232.53767462324;46275.53724462754;47188.76405617967;47224.76387618057;47245.763771181184;47267;47414;8568;8730.956345218265;8740.388172827872;8747.693830715894;8750.86873696895;8831.95584022079;8899.199072083511;8903.332250081237;8908.51003194824;8909.509976951265;8938.86591701125;8961.731148065568;8973.820523589524;9001.819963600725;9007.639694412215;8879.467231966102;8896.37725359225;8914.955425222865;8926.464412135292;8931.37480376374;8672.176143266379;8728.69449569262;8734;8743.825123497558;8755.956220218923;41935;42051.7897410511;42084.1583168338;42138.36792448116;42364;3788.2802267569073;3795.8481660733537;3808.1431677872256;3821.273957948009;3837.3860182370686;35081.298374032376;35254;35377.29245415103;35516;35530.822345888366;5172.870678233075;5220.425753167148;5280.6039547034125;5322.840314790563;5335.519803217729;228498;230860.9999999983;232369;232477;232896;54174;54318.72840635772;54387.45612543903;54462.45537544574;54473;55427.44572554223;55509.44490555124;55897.720511397994;56022.71988640031;56138.43861561332;17101.230444630022;17441.302347906196;17482.125893705263;17488.650226995644;17512.474625761246;14460.927695361455;14487.275636218146;14502.347394367278;14620.342084606218;14638.414463421344;13613.795793063113;13772.173669579657;13822.170669759847;13869.722605547833;13926.164430134224;5110.795568177231;5141.794328226829;5186.5654865090555;5232.92150617741;5259.684418934876;1078.2721662877527;1080.222239987208;1112.7440688641657;1112.9610463633896;1125.9380734059705;26000.609990850153;26091.739082608932;26146.477070458484;26384;26505.46989060208;1213.611644273824;1215.1251099208555;1233.5805826019196;1236.2767780848126;1249.3378509390038;13833;13851.376688049062;13918.58244252674;14044.157350558999;14216.64458388528;272032;276382;276953;285884;290005;63449;63830;64083;64166.35833641604;64268;1526.0385956847115;1529.250667173077;1544.6215677158943;1548.0556860315198;1554.4015554011787;30682;30863.69136308608;31038.844805775825;31296.453334663358;31549.684503154676;42832.500862469664;43118.78440607777;43136.78431607822;43184.56815431931;43223.13553728971;246302;248426;248475;249376;249936;35860.641393586775;36842.078948026516;36919.077023073565;37187.25625487529;37514.437283441315;47242.76378618222;48842.75578622226;48964.75517622389;49373.25940110829;49545.75227123986;35963;36384.818075909454;36574.268514630094;36683.08292292714;36684.81657591695;35443.645563544036;36138.63861361458;36483.635163648025;36712.449313259785;36873.078173044814;41520.377194341505;42465.15069698651;42492.787536063355;42573;42768.78615606902;34601.307973840885;34667.30665386729;34831;35154.82422587871;35604;26043.869780651734;26199;26416.8679156603;26591.468170636093;26738 08:29:01 INFO - PID 17295 | |2;jquery.html;632.7658766256483;635.7887210307892;644.416802793472;649.5207683524219;654.4764188649079;23746.287611371667;24130.155444559445;24142.396440089007;24672.87663561684;24722.629160562607;26370.868145659246;26788.794504247307;26797;26800.463990720174;26803.865980670118;6662.966685166592;6983.999999999987;7144.214136444987;7186.461015423864;7186.820329491752;6754;6802.319768023182;6808.931910680879;6810.216825065107;6825.078614387068;6750.797476075725;6767.120274364326;6768.56004359715;6779.220389655179;6784.592924424525;6750.32496750321;6790.999999999975;6792.728290868384;6806.251312355637;6807.489438292098;6325.430711236011;6333.87332253357;6345.42891139795;6366.0769188467875;6366.236051673783;29842.253943651365;30719.692803071906;30990.690093099005;31137.37725245505;31151.84424077888;2318.142287353673;2345.6247000479843;2345.94135146621;2346.4016675747744;2348.2368230325214;20766.896165519076;20874.37376878696;21446.463838404008;21540.246091386725;21595.1361945522;2638.80208984325;2680.932976675579;2697.7976651751;2713.81003329767;2721.6597925259343;136505;142194;154684.99999999886;160892.19553902274;161370;15943.601409964844;16612.916935415247;16803.91598042002;17183.656326873643;17200;26507.204783856516;26582;26659.20022399331;26689.199324020312;26701.19896403111;9907.653232136985;10058.698239052841;10086.646967356108;10087.243456740774;10244;8867.600957956907;8898.777530561787;8907.51008694515;9016.323775716848;9043.547822608843;9731.756706082404;9916.20670346385;9959.203263738884;10246.590136394461;10334;2990.4168687105807;3045.558394032853;3084.275195329096;3126.67116475497;3178.141901686578;1048.8898665639997;1067.8985496377832;1068.1188019883473;1070.7804899995483;1070.973225669349;21071.789282106984;21478.48804391802;21562.89218553897;21612.56774864494;21927.12291508354;1112.8219484882543;1117.1621284036971;1129.768397478515;1134.9432528373713;1153.948072336747;11373.260738052;11640.53437862476;11674.416279186007;11719.179657424069;11836.112291578165;551410;563773;565045;573377;575689;130442;131060;131794.34102829616;132959.33520332337;135669;1223.4555622747791;1231.378154032208;1263.8041103628952;1266.2465832829453;1268.3024336614824;18479.81520184835;18483.815161848746;18707.438776836174;18856.24575016984;19089.427317180507;64209.67895160494;64882.351176489516;65394;65890.34109658842;67525.66237168782;79640;80278;80559;81109;81487.59256203918;15988.840111598734;16144.838551614803;16205.189740512691;16270.674586507967;16285.511434656979;24104.397390065387;24128.276151715476;24205.394865128514;24284.635730463702;24326;19250.71123933114;19363.90318048401;19397.2241110354;19483.318083866998;19675.901620491804;17803.134108971222;18003.81996180074;18013.09934503296;18021.2791488339;18319.35882244115;20142.899285503478;20253.18987240494;20581.38255852327;20640.48398790042;20728.896355518125;15901.681966360838;15943.68112637764;15950.840491594936;15951.361945522049;15981.760273595673;18996.14517346695;19079.904600477465;19389.51526211856;19397.8060219396;19654.312099076462 08:29:01 INFO - PID 17295 | |3;mootools.html;1406.1633328169737;1451.0568130715035;1457.4898785425103;1465.9842716265136;1480.9333579988902;17304.82695173048;17952.46142615722;17975.19111639976;17977.280908763634;17999.370022049232;17291.654166916655;17343.39298124566;17364.479065628053;17393.217305221264;17410.47768566942;2848.9287767805813;2966.599509066281;2967.792254542183;2968.302448924501;2972.7770417218685;2884.278930267433;2902.593636890837;2954.4091181763624;2975.3305506261136;2979.478591246534;3020.7734419918484;3042.1786117748193;3050.801697889641;3051.1456792098247;3052.725254727074;2923.1230630810674;2939.235798692334;2970.4207679502506;2986.7013298670176;2987.1337312179444;2870.8708108134974;2874.928126796826;2875.1374587623627;2881;2894.9855250723613;17491.5627109322;17529.211185496682;17556.473305800846;17558.91220543889;17584.38454654081;8641.092685268019;8932.285417166677;8933.553322333857;8947.50788706621;8947.597358118901;5582.637128586629;5807.88384232313;5956.761729530814;5957.582969192158;5962.522998160137;2087.5720477302116;2141.496748264157;2169.9023543940402;2172.6197915364905;2192.0464597899804;31950.840245798856;32310.192245193823;32313;32329.51505727416;32332.191695207574;7254.202037775841;7284.453665975073;7351.77944661661;7470.626468676544;7516.586587737617;20833.58332833335;21023.78976210249;21042.263520777007;21093;21112.577748444946;8488.575571221414;8765.824683506422;8766.824663506693;8771.298296136294;8774.649014039494;7635.885461718079;7790.5325680459355;7961.840763184704;7968.163342849033;7971.083325417651;5997.550183736237;6192.102145189013;6194.628322300677;6247.937520624827;6278.277998030285;1614.9919250403673;1689.6282817780068;1710.6920754264352;1712.3065158610782;1750.5798608334162;1021.2544842265188;1025.1286406554368;1028.141501845952;1032.4373216596973;1042.6611351310855;9706.854397184048;9727.902720972841;9823.557939892722;9918;9932.205423566242;1069.946502674863;1107.2360071550604;1110.0231796019452;1111.6776134920945;1112.0991996482712;6050.092486127116;6177.505799536027;6506.707198175999;6671.43292820106;6840.31596840322;26770;27140.185794426197;27319.180424587295;27486.862565687043;27490.450190996067;25573.23280301594;26521.46957060848;26865;26879.328016799736;26932.730672693415;12924.224546527239;13252.469901203844;13392.330383480981;13394.397252123677;13417.865821341857;9897.752556186153;10146.137578305927;10248.64129755455;10299.897001029894;10508.789824203626;22632.321030369116;22699.432514187276;22722.20472283462;22861;22981;23640.88179559091;23733.881330593238;23879.16422925189;24144.275671729876;24570.38574035592;13127.409266583218;13309;13310.06829521963;13335.399907004403;13340.399682014528;16376.099314537338;16376.426825061066;16396.180190990643;16514.917425412797;16583;13199.34003299812;13279.136856104322;13317.267550284827;13396.196228226338;13760.31198440054;13003.089783715428;13036.413361398949;13162.210267383987;13165.868341316464;13324;10316.071553559916;10484.423356715453;10498.212634052325;10504.264701470824;10519.737006574896;8267.503949763033;8339.24946754795;8340.207680270607;8396.706115285935;8490;8225.95887020561;8251.876221856557;8309.293710034715;8353.916460835557;8360.581970901309 08:29:01 INFO - PID 17295 | |4;prototype.html;571.1347308827128;583.0845572451251;592.8784599157174;601.6690820048973;611.7155522681954;6354.237491501015;6402.199725034371;6498.382653647902;6498.447631951284;6503.642299673516;6347.650879201642;6386.10594516768;6400.935990640092;6425.357464253572;6445.645489498076;5286.259923610698;5291.4708529147165;5311.097113490716;5311.601629877755;5313.415524292324;5017.448080711119;5159.5614372778355;5180.2488639147305;5295.4704529546925;5348.197770334442;5096.668716533432;5122.6158038147105;5134;5147.742612869341;5148.768305426246;5063.620228482879;5078.695278283315;5118.616103792193;5121.462246464123;5143.588512918976;4634.536546345372;4662.114198302312;4671.6262698984;4722.220833562458;4757.240800335831;6334.144890439778;6370.299267080617;6395.8401039973905;6398.648074355909;6444.774432894873;5989.580729348947;6003.759849606011;6068.362821903725;6079.361667024988;6103.176071230371;6735.158105236846;6757.85116530191;6798.736606428942;6806.10740435313;6855.862882742367;5218.721413253777;5248.947510524884;5263.4208738058105;5265.104932161542;5294.258803767476;6840.931590684129;6972.442204623669;7009.21265077402;7032.488015076783;7117.466190035768;5358.5981051421295;5410.97294513525;5432.728363581805;5433.755481003364;5451.781928722807;5476.452354764571;5520.171974203821;5524.171374293888;5537.197106419547;5549.7780088796;6106.938930610637;6112.2970858351855;6123.510119190454;6127.448529632355;6156.107364432221;6755.392014718601;6806.149231346082;6829.317068293131;6879.552829066095;6882.174139103339;1847.9722804157948;1866.2628261836498;1879.4455635587535;1888.6222755448964;1897.3074827687794;1310.8988449702106;1311.3574348569132;1339.2723386831074;1348.359529223611;1365.7268546290584;6244.562880598314;6264.778368218153;6342.809715708536;6403.423691867754;6434.388733070351;6825.078614386995;6938.722451101899;6944.756933507404;6955.269696681776;6984.825379365557;6363.872722545523;6397.744090236339;6419.550631455753;6420.839479012969;6433.742650293936;3665.2303016366327;3701.444783282529;3709.4435834624483;3717.5724791648768;3721.981390093032;7244.239354867768;7260;7295.744648937261;7349.191588925214;7351.338379545867;7125.857482850418;7127.964360178166;7131.393831524275;7159.964200178966;7177.9641101795205;7235.095613048369;7240;7250.456215783837;7257.237990010973;7339.77980660581;6883.346082122191;6890.758823441155;6915.654217289015;6918.481113916376;7003.369696727319;6788.389044985975;6791.45668346541;6829.487788415988;6852.81344174961;6926.515143940077;7167.3549380556;7231.3130252625915;7324.597147156957;7334.3032411920785;7352.161959510123;5442.564594832483;5450.209719590558;5453.345598528202;5456.836294911159;5467.316585426822;6635.270120286668;6701.497387696039;6998.230194678479;7022.54353467023;7151.892721609076;6719.563228390139;6720.529562930548;6742.393184613408;6751.189857217166;6768;6698.330166983263;6707.195136583641;6720;6752.932470675427;6756.45948324123;6539.803805885831;6644.202695676357;6664.4668426524795;6738.696758645775;6759.763408280686;6790.93209067903;6835.111435513351;6870.828229294108;6890.276520965427;6910.308969103049;6586.242582103119;6640.911975931215;6660.800175994728;6671.199456065109;6679.799606011828 08:29:01 INFO - PID 17295 | |5;yui.html;993.7962717642879;1006.2201793609952;1016.684827703412;1025.1081559043632;1045.707201983445;21006.579868402623;21213.15147394104;21304.254351097716;21304.680429793527;21635.350939471802;19140.808591914112;19207.32774352898;19249.422517324467;19321.710174347398;19328.90335548324;1047.9528421221064;1069.9144068474504;1070.4112737994071;1071.3036526257956;1072.7318170457386;1069.2942657845824;1069.315637991686;1069.6416700405373;1072.3030030480172;1079.1528650009743;1124.342259778031;1143.222608626138;1157.1610582327787;1157.8321143434198;1159.4956194055612;1154.7863645225575;1158.7219067423841;1159.0959051939458;1159.2522822779345;1163.3136449494796;821.9589020548949;822.942394032418;824.2087595907935;824.418784756745;824.8020475085937;21081.367558973256;21921.671174932228;22121.446963826034;22167.556648867092;22190.445238868997;22779.77220227793;22792.31623051311;23048.65427018596;23090.499117557305;23208.419789505228;18034.90982545092;18113.1849066791;18129.637407251914;18268.269269229215;18358.35745748906;4061.1471590965934;4123.525794533637;4165.375193720935;4166.479190101238;4184.246835569596;129587;142063;166823;168453.15773421177;168828;18537.53656158607;19090;19183.424497265103;19196.71204931927;19538.218471261276;34835;35268.64731352653;35273.823630881685;35539.644603553636;35586.82206588951;10227.795444091076;10304.793904121876;10314.896851031393;10332.070113689804;10416.32293900894;4912.484189160158;4930.753462326869;4944.357233559686;4965.851024469272;4968;5923.318818335861;5993.670348130895;6033.245844269466;6037.516998640098;6043.153958445821;1125.7973564758422;1153.9711507212219;1166.4284500594647;1167.235460773195;1171.1275100050516;704.1514974455769;709.7870638808337;714.5855403865745;724.6304384763808;736.8452624948713;13401.597952061455;14338.426462941574;14848.183349915858;15054;15124.697506049817;767.0335377424485;767.3592550220517;769.0963118335933;773.6827900560855;783.0485959559163;6334.208223972004;6395.680215989275;6420.74317027323;6453.806385808433;6471.838204044842;152885.2355738214;153014;154828;155152.2242388781;160553;131825;133572;134492;136543;139491.30254348664;121143.39428302979;122106;122591;122861;124328.37835810945;12156.878431215575;12262.08034397406;12263.141580089308;12314.199577027464;12618.305993170097;56292;56810;57184.142237867294;58246;58606.7069664666;74374.62812685902;75280.62359688166;75503;77312.61343693246;77774.611126944;16598.83401165973;17004.82995170082;17137.657246855244;17207.913960430116;17266;20567.794322056587;20632.896835515727;20713.378598642066;20814.479638009172;20982.47543811417;17294.13529323554;17685.204165812313;17755.822441775934;17866.821331787036;17957.820421795615;18115.547111321794;18160;18161;18351.449456516326;18532.25870965146;17946.5513362167;18010.919344839353;18032.63934721272;18123.184456699215;18151.45545633633;12829.61511154667;12830.10189286741;13213.801792973305;13271.867281327062;13297.268650223943;13996.44014239419;14058.578242652737;14233.857661423253;14240.430382784572;14299 08:29:01 INFO - PID 17295 | __end_tp_report 08:29:01 INFO - PID 17295 | __start_cc_report 08:29:01 INFO - PID 17295 | _x_x_mozilla_cycle_collect,261 08:29:01 INFO - PID 17295 | __end_cc_report 08:29:01 INFO - PID 17295 | __startTimestamp1508858941546__endTimestamp 08:29:01 INFO - PID 17295 | 08:29:01 INFO - PID 17295 | ------- Summary: start ------- 08:29:01 INFO - PID 17295 | Number of tests: 6 08:29:01 INFO - PID 17295 | 08:29:01 INFO - PID 17295 | [#0] dojo.html Cycles:165 Average:6585.53 Median:6799.80 stddev:757.71 (11.1%) stddev-sans-first:733.37 08:29:01 INFO - PID 17295 | Values: 4046.1 4057.5 4061.3 4070.4 4071.2 6550.6 6558.8 6577.5 6634.4 6653.0 6539.8 6564.4 6597.8 6625.3 6642.1 5846.5 5914.7 5963.1 5963.2 5969.8 5903.2 5922.1 5925.3 5944.3 5997.2 5988.2 5996.9 6060.4 6072.9 6084.5 5892.2 5981.6 6018.5 6053.6 6055.5 5788.5 5840.9 5887.2 5890.9 5906.7 6436.9 6521.4 6542.0 6561.8 6637.6 7067.3 7086.6 7098.5 7180.2 7208.9 7099.6 7134.0 7232.0 7235.9 7246.0 6559.2 6585.2 6638.5 6660.1 6717.0 7303.9 7360.4 7365.5 7395.8 7409.2 6904.9 7031.4 7035.0 7052.8 7124.3 7085.0 7152.4 7223.2 7224.7 7249.2 7063.9 7142.2 7167.0 7172.1 7182.9 7080.4 7092.3 7098.7 7135.9 7147.1 5189.0 5260.0 5271.9 5272.3 5274.1 4819.0 4875.1 4898.1 4898.1 4917.6 6504.6 6599.2 6599.8 6660.8 6663.8 7019.0 7034.4 7084.5 7111.4 7113.6 6654.7 6673.6 6698.6 6701.0 6713.1 5951.7 5956.6 6041.1 6042.0 6046.0 7308.6 7313.1 7358.9 7430.0 7507.0 7104.9 7166.0 7173.9 7182.5 7184.7 7433.2 7440.3 7444.2 7516.9 7549.4 6902.8 6954.9 7011.2 7030.5 7113.9 7126.4 7157.3 7182.6 7190.1 7227.3 6839.6 6847.8 6944.3 6945.2 6953.2 6696.9 6798.4 6851.8 6861.5 6869.3 6785.1 6801.7 6806.3 6828.3 6895.0 6962.7 7006.0 7017.3 7018.9 7021.6 6634.4 6655.5 6701.7 6747.4 6799.8 08:29:01 INFO - PID 17295 | 08:29:01 INFO - PID 17295 | [#1] ext.html Cycles:180 Average:44150.43 Median:37053.17 stddev:66038.95 (178.2%) stddev-sans-first:66144.62 08:29:01 INFO - PID 17295 | Values: 971.1 987.9 1009.6 1028.9 1034.0 42083.2 42883.6 46126.3 46232.5 46275.5 47188.8 47224.8 47245.8 47267.0 47414.0 8568.0 8731.0 8740.4 8747.7 8750.9 8832.0 8899.2 8903.3 8908.5 8909.5 8938.9 8961.7 8973.8 9001.8 9007.6 8879.5 8896.4 8915.0 8926.5 8931.4 8672.2 8728.7 8734.0 8743.8 8756.0 41935.0 42051.8 42084.2 42138.4 42364.0 3788.3 3795.8 3808.1 3821.3 3837.4 35081.3 35254.0 35377.3 35516.0 35530.8 5172.9 5220.4 5280.6 5322.8 5335.5 228498.0 230861.0 232369.0 232477.0 232896.0 54174.0 54318.7 54387.5 54462.5 54473.0 55427.4 55509.4 55897.7 56022.7 56138.4 17101.2 17441.3 17482.1 17488.7 17512.5 14460.9 14487.3 14502.3 14620.3 14638.4 13613.8 13772.2 13822.2 13869.7 13926.2 5110.8 5141.8 5186.6 5232.9 5259.7 1078.3 1080.2 1112.7 1113.0 1125.9 26000.6 26091.7 26146.5 26384.0 26505.5 1213.6 1215.1 1233.6 1236.3 1249.3 13833.0 13851.4 13918.6 14044.2 14216.6 272032.0 276382.0 276953.0 285884.0 290005.0 63449.0 63830.0 64083.0 64166.4 64268.0 1526.0 1529.3 1544.6 1548.1 1554.4 30682.0 30863.7 31038.8 31296.5 31549.7 42832.5 43118.8 43136.8 43184.6 43223.1 246302.0 248426.0 248475.0 249376.0 249936.0 35860.6 36842.1 36919.1 37187.3 37514.4 47242.8 48842.8 48964.8 49373.3 49545.8 35963.0 36384.8 36574.3 36683.1 36684.8 35443.6 36138.6 36483.6 36712.4 36873.1 41520.4 42465.2 42492.8 42573.0 42768.8 34601.3 34667.3 34831.0 35154.8 35604.0 26043.9 26199.0 26416.9 26591.5 26738.0 08:29:01 INFO - PID 17295 | 08:29:01 INFO - PID 17295 | [#2] jquery.html Cycles:180 Average:38956.56 Median:13047.26 stddev:95233.10 (729.9%) stddev-sans-first:95456.79 08:29:01 INFO - PID 17295 | Values: 632.8 635.8 644.4 649.5 654.5 23746.3 24130.2 24142.4 24672.9 24722.6 26370.9 26788.8 26797.0 26800.5 26803.9 6663.0 6984.0 7144.2 7186.5 7186.8 6754.0 6802.3 6808.9 6810.2 6825.1 6750.8 6767.1 6768.6 6779.2 6784.6 6750.3 6791.0 6792.7 6806.3 6807.5 6325.4 6333.9 6345.4 6366.1 6366.2 29842.3 30719.7 30990.7 31137.4 31151.8 2318.1 2345.6 2345.9 2346.4 2348.2 20766.9 20874.4 21446.5 21540.2 21595.1 2638.8 2680.9 2697.8 2713.8 2721.7 136505.0 142194.0 154685.0 160892.2 161370.0 15943.6 16612.9 16803.9 17183.7 17200.0 26507.2 26582.0 26659.2 26689.2 26701.2 9907.7 10058.7 10086.6 10087.2 10244.0 8867.6 8898.8 8907.5 9016.3 9043.5 9731.8 9916.2 9959.2 10246.6 10334.0 2990.4 3045.6 3084.3 3126.7 3178.1 1048.9 1067.9 1068.1 1070.8 1071.0 21071.8 21478.5 21562.9 21612.6 21927.1 1112.8 1117.2 1129.8 1134.9 1153.9 11373.3 11640.5 11674.4 11719.2 11836.1 551410.0 563773.0 565045.0 573377.0 575689.0 130442.0 131060.0 131794.3 132959.3 135669.0 1223.5 1231.4 1263.8 1266.2 1268.3 18479.8 18483.8 18707.4 18856.2 19089.4 64209.7 64882.4 65394.0 65890.3 67525.7 79640.0 80278.0 80559.0 81109.0 81487.6 15988.8 16144.8 16205.2 16270.7 16285.5 24104.4 24128.3 24205.4 24284.6 24326.0 19250.7 19363.9 19397.2 19483.3 19675.9 17803.1 18003.8 18013.1 18021.3 18319.4 20142.9 20253.2 20581.4 20640.5 20728.9 15901.7 15943.7 15950.8 15951.4 15981.8 18996.1 19079.9 19389.5 19397.8 19654.3 08:29:01 INFO - PID 17295 | 08:29:01 INFO - PID 17295 | [#3] mootools.html Cycles:180 Average:11022.68 Median:26645.73 stddev:8261.17 (31.0%) stddev-sans-first:8252.75 08:29:01 INFO - PID 17295 | Values: 1406.2 1451.1 1457.5 1466.0 1480.9 17304.8 17952.5 17975.2 17977.3 17999.4 17291.7 17343.4 17364.5 17393.2 17410.5 2848.9 2966.6 2967.8 2968.3 2972.8 2884.3 2902.6 2954.4 2975.3 2979.5 3020.8 3042.2 3050.8 3051.1 3052.7 2923.1 2939.2 2970.4 2986.7 2987.1 2870.9 2874.9 2875.1 2881.0 2895.0 17491.6 17529.2 17556.5 17558.9 17584.4 8641.1 8932.3 8933.6 8947.5 8947.6 5582.6 5807.9 5956.8 5957.6 5962.5 2087.6 2141.5 2169.9 2172.6 2192.0 31950.8 32310.2 32313.0 32329.5 32332.2 7254.2 7284.5 7351.8 7470.6 7516.6 20833.6 21023.8 21042.3 21093.0 21112.6 8488.6 8765.8 8766.8 8771.3 8774.6 7635.9 7790.5 7961.8 7968.2 7971.1 5997.6 6192.1 6194.6 6247.9 6278.3 1615.0 1689.6 1710.7 1712.3 1750.6 1021.3 1025.1 1028.1 1032.4 1042.7 9706.9 9727.9 9823.6 9918.0 9932.2 1069.9 1107.2 1110.0 1111.7 1112.1 6050.1 6177.5 6506.7 6671.4 6840.3 26770.0 27140.2 27319.2 27486.9 27490.5 25573.2 26521.5 26865.0 26879.3 26932.7 12924.2 13252.5 13392.3 13394.4 13417.9 9897.8 10146.1 10248.6 10299.9 10508.8 22632.3 22699.4 22722.2 22861.0 22981.0 23640.9 23733.9 23879.2 24144.3 24570.4 13127.4 13309.0 13310.1 13335.4 13340.4 16376.1 16376.4 16396.2 16514.9 16583.0 13199.3 13279.1 13317.3 13396.2 13760.3 13003.1 13036.4 13162.2 13165.9 13324.0 10316.1 10484.4 10498.2 10504.3 10519.7 8267.5 8339.2 8340.2 8396.7 8490.0 8226.0 8251.9 8309.3 8353.9 8360.6 08:29:01 INFO - PID 17295 | 08:29:01 INFO - PID 17295 | [#4] prototype.html Cycles:180 Average:5821.90 Median:6420.20 stddev:1614.81 (25.2%) stddev-sans-first:1570.51 08:29:01 INFO - PID 17295 | Values: 571.1 583.1 592.9 601.7 611.7 6354.2 6402.2 6498.4 6498.4 6503.6 6347.7 6386.1 6400.9 6425.4 6445.6 5286.3 5291.5 5311.1 5311.6 5313.4 5017.4 5159.6 5180.2 5295.5 5348.2 5096.7 5122.6 5134.0 5147.7 5148.8 5063.6 5078.7 5118.6 5121.5 5143.6 4634.5 4662.1 4671.6 4722.2 4757.2 6334.1 6370.3 6395.8 6398.6 6444.8 5989.6 6003.8 6068.4 6079.4 6103.2 6735.2 6757.9 6798.7 6806.1 6855.9 5218.7 5248.9 5263.4 5265.1 5294.3 6840.9 6972.4 7009.2 7032.5 7117.5 5358.6 5411.0 5432.7 5433.8 5451.8 5476.5 5520.2 5524.2 5537.2 5549.8 6106.9 6112.3 6123.5 6127.4 6156.1 6755.4 6806.1 6829.3 6879.6 6882.2 1848.0 1866.3 1879.4 1888.6 1897.3 1310.9 1311.4 1339.3 1348.4 1365.7 6244.6 6264.8 6342.8 6403.4 6434.4 6825.1 6938.7 6944.8 6955.3 6984.8 6363.9 6397.7 6419.6 6420.8 6433.7 3665.2 3701.4 3709.4 3717.6 3722.0 7244.2 7260.0 7295.7 7349.2 7351.3 7125.9 7128.0 7131.4 7160.0 7178.0 7235.1 7240.0 7250.5 7257.2 7339.8 6883.3 6890.8 6915.7 6918.5 7003.4 6788.4 6791.5 6829.5 6852.8 6926.5 7167.4 7231.3 7324.6 7334.3 7352.2 5442.6 5450.2 5453.3 5456.8 5467.3 6635.3 6701.5 6998.2 7022.5 7151.9 6719.6 6720.5 6742.4 6751.2 6768.0 6698.3 6707.2 6720.0 6752.9 6756.5 6539.8 6644.2 6664.5 6738.7 6759.8 6790.9 6835.1 6870.8 6890.3 6910.3 6586.2 6640.9 6660.8 6671.2 6679.8 08:29:01 INFO - PID 17295 | 08:29:01 INFO - PID 17295 | [#5] yui.html Cycles:180 Average:29067.28 Median:18126.41 stddev:43221.96 (238.4%) stddev-sans-first:43291.81 08:29:01 INFO - PID 17295 | Values: 993.8 1006.2 1016.7 1025.1 1045.7 21006.6 21213.2 21304.3 21304.7 21635.4 19140.8 19207.3 19249.4 19321.7 19328.9 1048.0 1069.9 1070.4 1071.3 1072.7 1069.3 1069.3 1069.6 1072.3 1079.2 1124.3 1143.2 1157.2 1157.8 1159.5 1154.8 1158.7 1159.1 1159.3 1163.3 822.0 822.9 824.2 824.4 824.8 21081.4 21921.7 22121.4 22167.6 22190.4 22779.8 22792.3 23048.7 23090.5 23208.4 18034.9 18113.2 18129.6 18268.3 18358.4 4061.1 4123.5 4165.4 4166.5 4184.2 129587.0 142063.0 166823.0 168453.2 168828.0 18537.5 19090.0 19183.4 19196.7 19538.2 34835.0 35268.6 35273.8 35539.6 35586.8 10227.8 10304.8 10314.9 10332.1 10416.3 4912.5 4930.8 4944.4 4965.9 4968.0 5923.3 5993.7 6033.2 6037.5 6043.2 1125.8 1154.0 1166.4 1167.2 1171.1 704.2 709.8 714.6 724.6 736.8 13401.6 14338.4 14848.2 15054.0 15124.7 767.0 767.4 769.1 773.7 783.0 6334.2 6395.7 6420.7 6453.8 6471.8 152885.2 153014.0 154828.0 155152.2 160553.0 131825.0 133572.0 134492.0 136543.0 139491.3 121143.4 122106.0 122591.0 122861.0 124328.4 12156.9 12262.1 12263.1 12314.2 12618.3 56292.0 56810.0 57184.1 58246.0 58606.7 74374.6 75280.6 75503.0 77312.6 77774.6 16598.8 17004.8 17137.7 17207.9 17266.0 20567.8 20632.9 20713.4 20814.5 20982.5 17294.1 17685.2 17755.8 17866.8 17957.8 18115.5 18160.0 18161.0 18351.4 18532.3 17946.6 18010.9 18032.6 18123.2 18151.5 12829.6 12830.1 13213.8 13271.9 13297.3 13996.4 14058.6 14233.9 14240.4 14299.0 08:29:01 INFO - PID 17295 | -------- Summary: end -------- 08:29:01 INFO - PID 17295 | 08:29:02 INFO - TEST-INFO | 17295: exit 0 08:29:02 INFO - TEST-OK | dromaeo_css | took 1108613ms 08:29:02 INFO - TEST-START | kraken 08:29:02 INFO - Initialising browser for kraken test... 08:29:02 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:35437/getInfo.html -profile /tmp/tmpHvqi7N/profile 08:29:02 INFO - TEST-INFO | started process 17663 (/builds/slave/test/build/application/firefox/firefox http://localhost:35437/getInfo.html) 08:29:08 INFO - TEST-INFO | 17663: exit 0 08:29:08 INFO - Browser initialized. 08:29:08 INFO - Running cycle 1/1 for kraken test... 08:29:08 INFO - Using env: {'DISPLAY': ':0', 08:29:08 INFO - 'HOME': '/home/cltbld', 08:29:08 INFO - 'JSGC_DISABLE_POISONING': '1', 08:29:08 INFO - 'LANG': 'en_US.UTF-8', 08:29:08 INFO - 'LANGUAGE': 'en_US:en', 08:29:08 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 08:29:08 INFO - 'LOGNAME': 'cltbld', 08:29:08 INFO - 'MAIL': '/var/mail/cltbld', 08:29:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:29:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:29:08 INFO - 'MOZ_CRASHREPORTER': '1', 08:29:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:29:08 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 08:29:08 INFO - 'MOZ_NO_REMOTE': '1', 08:29:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:29:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:29:08 INFO - 'NO_EM_RESTART': '1', 08:29:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:29:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:29:08 INFO - 'PWD': '/builds/slave/test', 08:29:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:29:08 INFO - 'RUST_BACKTRACE': 'full', 08:29:08 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 08:29:08 INFO - 'SHELL': '/bin/bash', 08:29:08 INFO - 'SHLVL': '1', 08:29:08 INFO - 'TERM': 'linux', 08:29:08 INFO - 'TMOUT': '86400', 08:29:08 INFO - 'USER': 'cltbld', 08:29:08 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1508857480.452402-1932106324', 08:29:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:29:08 INFO - '_': '/tools/buildbot/bin/python'} 08:29:08 INFO - TEST-INFO | started process 17900 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHvqi7N/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 08:29:09 INFO - PID 17900 | 08:29:09 INFO - PID 17900 | (/builds/slave/test/build/application/firefox/firefox:17949): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 08:29:09 INFO - PID 17900 | 08:29:19 INFO - PID 17900 | RSS: Main: 141877248 08:29:19 INFO - PID 17900 | 08:29:22 INFO - PID 17900 | Cycle 1(1): loaded http://localhost:35437/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35437/tests/kraken/driver.html?testName=audio-beat-detection) 08:29:22 INFO - PID 17900 | RSS: Main: 148410368 08:29:22 INFO - PID 17900 | 08:29:25 INFO - PID 17900 | Cycle 1(1): loaded http://localhost:35437/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35437/tests/kraken/driver.html?testName=audio-dft) 08:29:25 INFO - PID 17900 | RSS: Main: 148713472 08:29:25 INFO - PID 17900 | 08:29:28 INFO - PID 17900 | Cycle 1(1): loaded http://localhost:35437/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35437/tests/kraken/driver.html?testName=audio-fft) 08:29:29 INFO - PID 17900 | RSS: Main: 150032384 08:29:29 INFO - PID 17900 | 08:29:31 INFO - PID 17900 | Cycle 1(1): loaded http://localhost:35437/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35437/tests/kraken/driver.html?testName=audio-oscillator) 08:29:32 INFO - PID 17900 | RSS: Main: 149872640 08:29:32 INFO - PID 17900 | 08:29:34 INFO - PID 17900 | Cycle 1(1): loaded http://localhost:35437/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35437/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:29:34 INFO - PID 17900 | RSS: Main: 149803008 08:29:34 INFO - PID 17900 | 08:29:37 INFO - PID 17900 | Cycle 1(1): loaded http://localhost:35437/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35437/tests/kraken/driver.html?testName=imaging-darkroom) 08:29:38 INFO - PID 17900 | RSS: Main: 149999616 08:29:38 INFO - PID 17900 | 08:29:41 INFO - PID 17900 | Cycle 1(1): loaded http://localhost:35437/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35437/tests/kraken/driver.html?testName=imaging-desaturate) 08:29:42 INFO - PID 17900 | RSS: Main: 152326144 08:29:42 INFO - PID 17900 | 08:29:45 INFO - PID 17900 | Cycle 1(1): loaded http://localhost:35437/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35437/tests/kraken/driver.html?testName=json-parse-financial) 08:29:45 INFO - PID 17900 | RSS: Main: 153276416 08:29:45 INFO - PID 17900 | 08:29:47 INFO - PID 17900 | Cycle 1(1): loaded http://localhost:35437/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35437/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:29:47 INFO - PID 17900 | RSS: Main: 153137152 08:29:47 INFO - PID 17900 | 08:29:49 INFO - PID 17900 | Cycle 1(1): loaded http://localhost:35437/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35437/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:29:50 INFO - PID 17900 | RSS: Main: 153116672 08:29:50 INFO - PID 17900 | 08:29:52 INFO - PID 17900 | Cycle 1(1): loaded http://localhost:35437/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35437/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:29:52 INFO - PID 17900 | RSS: Main: 150204416 08:29:52 INFO - PID 17900 | 08:29:55 INFO - PID 17900 | Cycle 1(1): loaded http://localhost:35437/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35437/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:29:55 INFO - PID 17900 | RSS: Main: 149839872 08:29:55 INFO - PID 17900 | 08:29:58 INFO - PID 17900 | Cycle 1(1): loaded http://localhost:35437/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35437/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:29:58 INFO - PID 17900 | RSS: Main: 150724608 08:29:58 INFO - PID 17900 | 08:30:00 INFO - PID 17900 | Cycle 1(1): loaded http://localhost:35437/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35437/tests/kraken/driver.html?testName=ai-astar) 08:30:00 INFO - PID 17900 | RSS: Main: 151715840 08:30:00 INFO - PID 17900 | 08:30:00 INFO - PID 17900 | __start_tp_report 08:30:00 INFO - PID 17900 | _x_x_mozilla_page_load 08:30:00 INFO - PID 17900 | _x_x_mozilla_page_load_details 08:30:00 INFO - PID 17900 | |i|pagename|runs| 08:30:00 INFO - PID 17900 | |0;ai-astar;105;105;104;105;106;107;108;105;106;104 08:30:00 INFO - PID 17900 | |1;audio-beat-detection;113;117;111;112;119;113;110;137;112;113 08:30:00 INFO - PID 17900 | |2;audio-dft;160;161;163;162;162;162;161;164;162;160 08:30:00 INFO - PID 17900 | |3;audio-fft;74;73;81;73;75;74;73;74;73;74 08:30:00 INFO - PID 17900 | |4;audio-oscillator;79;76;77;76;77;77;77;78;77;76 08:30:00 INFO - PID 17900 | |5;imaging-gaussian-blur;114;113;114;110;113;114;113;109;114;115 08:30:00 INFO - PID 17900 | |6;imaging-darkroom;148;150;152;149;148;147;148;149;150;147 08:30:00 INFO - PID 17900 | |7;imaging-desaturate;94;93;94;93;94;94;94;95;94;99 08:30:00 INFO - PID 17900 | |8;json-parse-financial;43;42;43;46;42;43;43;43;43;43 08:30:00 INFO - PID 17900 | |9;json-stringify-tinderbox;39;38;37;38;38;38;38;38;37;38 08:30:00 INFO - PID 17900 | |10;stanford-crypto-aes;74;70;68;73;71;69;69;70;69;67 08:30:00 INFO - PID 17900 | |11;stanford-crypto-ccm;110;105;100;105;108;109;110;102;104;99 08:30:00 INFO - PID 17900 | |12;stanford-crypto-pbkdf2;154;150;144;149;144;150;146;154;147;149 08:30:00 INFO - PID 17900 | |13;stanford-crypto-sha256-iterative;59;57;57;59;59;60;57;55;56;57 08:30:00 INFO - PID 17900 | __end_tp_report 08:30:00 INFO - PID 17900 | __start_cc_report 08:30:00 INFO - PID 17900 | _x_x_mozilla_cycle_collect,694 08:30:00 INFO - PID 17900 | __end_cc_report 08:30:00 INFO - PID 17900 | __startTimestamp1508859000853__endTimestamp 08:30:00 INFO - PID 17900 | 08:30:00 INFO - PID 17900 | ------- Summary: start ------- 08:30:00 INFO - PID 17900 | Number of tests: 14 08:30:00 INFO - PID 17900 | 08:30:00 INFO - PID 17900 | [#0] ai-astar Cycles:10 Average:105.50 Median:105.50 stddev:1.27 (1.2%) stddev-sans-first:1.33 08:30:00 INFO - PID 17900 | Values: 105.0 105.0 104.0 105.0 106.0 107.0 108.0 105.0 106.0 104.0 08:30:00 INFO - PID 17900 | 08:30:00 INFO - PID 17900 | [#1] audio-beat-detection Cycles:10 Average:115.70 Median:113.00 stddev:7.96 (7.0%) stddev-sans-first:8.38 08:30:00 INFO - PID 17900 | Values: 113.0 117.0 111.0 112.0 119.0 113.0 110.0 137.0 112.0 113.0 08:30:00 INFO - PID 17900 | 08:30:00 INFO - PID 17900 | [#2] audio-dft Cycles:10 Average:161.70 Median:162.00 stddev:1.25 (0.8%) stddev-sans-first:1.17 08:30:00 INFO - PID 17900 | Values: 160.0 161.0 163.0 162.0 162.0 162.0 161.0 164.0 162.0 160.0 08:30:00 INFO - PID 17900 | 08:30:00 INFO - PID 17900 | [#3] audio-fft Cycles:10 Average:74.40 Median:74.00 stddev:2.41 (3.3%) stddev-sans-first:2.55 08:30:00 INFO - PID 17900 | Values: 74.0 73.0 81.0 73.0 75.0 74.0 73.0 74.0 73.0 74.0 08:30:00 INFO - PID 17900 | 08:30:00 INFO - PID 17900 | [#4] audio-oscillator Cycles:10 Average:77.00 Median:77.00 stddev:0.94 (1.2%) stddev-sans-first:0.67 08:30:00 INFO - PID 17900 | Values: 79.0 76.0 77.0 76.0 77.0 77.0 77.0 78.0 77.0 76.0 08:30:00 INFO - PID 17900 | 08:30:00 INFO - PID 17900 | [#5] imaging-gaussian-blur Cycles:10 Average:112.90 Median:114.00 stddev:1.91 (1.7%) stddev-sans-first:1.99 08:30:00 INFO - PID 17900 | Values: 114.0 113.0 114.0 110.0 113.0 114.0 113.0 109.0 114.0 115.0 08:30:00 INFO - PID 17900 | 08:30:00 INFO - PID 17900 | [#6] imaging-darkroom Cycles:10 Average:148.80 Median:149.00 stddev:1.55 (1.0%) stddev-sans-first:1.62 08:30:00 INFO - PID 17900 | Values: 148.0 150.0 152.0 149.0 148.0 147.0 148.0 149.0 150.0 147.0 08:30:00 INFO - PID 17900 | 08:30:00 INFO - PID 17900 | [#7] imaging-desaturate Cycles:10 Average:94.40 Median:94.00 stddev:1.71 (1.8%) stddev-sans-first:1.81 08:30:00 INFO - PID 17900 | Values: 94.0 93.0 94.0 93.0 94.0 94.0 94.0 95.0 94.0 99.0 08:30:00 INFO - PID 17900 | 08:30:00 INFO - PID 17900 | [#8] json-parse-financial Cycles:10 Average:43.10 Median:43.00 stddev:1.10 (2.6%) stddev-sans-first:1.17 08:30:00 INFO - PID 17900 | Values: 43.0 42.0 43.0 46.0 42.0 43.0 43.0 43.0 43.0 43.0 08:30:00 INFO - PID 17900 | 08:30:00 INFO - PID 17900 | [#9] json-stringify-tinderbox Cycles:10 Average:37.90 Median:38.00 stddev:0.57 (1.5%) stddev-sans-first:0.44 08:30:00 INFO - PID 17900 | Values: 39.0 38.0 37.0 38.0 38.0 38.0 38.0 38.0 37.0 38.0 08:30:00 INFO - PID 17900 | 08:30:00 INFO - PID 17900 | [#10] stanford-crypto-aes Cycles:10 Average:70.00 Median:70.00 stddev:2.16 (3.1%) stddev-sans-first:1.74 08:30:00 INFO - PID 17900 | Values: 74.0 70.0 68.0 73.0 71.0 69.0 69.0 70.0 69.0 67.0 08:30:00 INFO - PID 17900 | 08:30:00 INFO - PID 17900 | [#11] stanford-crypto-ccm Cycles:10 Average:105.20 Median:108.50 stddev:4.02 (3.7%) stddev-sans-first:3.87 08:30:00 INFO - PID 17900 | Values: 110.0 105.0 100.0 105.0 108.0 109.0 110.0 102.0 104.0 99.0 08:30:00 INFO - PID 17900 | 08:30:00 INFO - PID 17900 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.70 Median:149.50 stddev:3.56 (2.4%) stddev-sans-first:3.22 08:30:00 INFO - PID 17900 | Values: 154.0 150.0 144.0 149.0 144.0 150.0 146.0 154.0 147.0 149.0 08:30:00 INFO - PID 17900 | 08:30:00 INFO - PID 17900 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:57.60 Median:58.00 stddev:1.58 (2.7%) stddev-sans-first:1.59 08:30:00 INFO - PID 17900 | Values: 59.0 57.0 57.0 59.0 59.0 60.0 57.0 55.0 56.0 57.0 08:30:00 INFO - PID 17900 | -------- Summary: end -------- 08:30:00 INFO - PID 17900 | 08:30:01 INFO - PID 17900 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 08:30:01 INFO - TEST-INFO | 17900: exit 0 08:30:01 INFO - TEST-OK | kraken | took 59469ms 08:30:01 INFO - SUITE-END | took 1168s 08:30:02 INFO - Completed test suite (00:19:28) 08:30:02 INFO - javascript benchmark 08:30:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9390.895818211031, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [4046.0896298332877, 4057.513098428189, 4061.3095773718464, 4070.3690927906177, 4071.1857628474295, 6550.639714815683, 6558.803235902925, 6577.53957222994, 6634.402903738663, 6653.0, 6539.803805885819, 6564.442022428099, 6597.769078082268, 6625.337466253372, 6642.136522252113, 5846.532277417818, 5914.674692891889, 5963.105534169866, 5963.194968679238, 5969.791057312995, 5903.173555702205, 5922.141289513018, 5925.259342582177, 5944.286685597713, 5997.160397544348, 5988.2215312009375, 5996.910046349309, 6060.36366181549, 6072.939270607304, 6084.482818960394, 5892.204552385416, 5981.581289309728, 6018.4583387494895, 6053.576249662526, 6055.515558755311, 5788.479036886701, 5840.912386314209, 5887.175795388649, 5890.9410905891245, 5906.704664766745, 6436.903446448307, 6521.445677117451, 6541.967290163567, 6561.80314590563, 6637.56855804376, 7067.328603782633, 7086.574805511686, 7098.503104782667, 7180.24607416219, 7208.891866622005, 7099.645017749143, 7133.964330178368, 7231.963840180818, 7235.855282894366, 7246.0, 6559.212894452601, 6585.176852893388, 6638.535302528873, 6660.067590537328, 6717.0, 7303.911065490059, 7360.374368178657, 7365.52124111931, 7395.81510462232, 7409.184989651134, 6904.896426553606, 7031.40233080194, 7034.964825175842, 7052.788416347517, 7124.287571242834, 7085.043519124955, 7152.4278057755255, 7223.241559636268, 7224.67488962998, 7249.202587715347, 7063.89404158938, 7142.178649455275, 7167.032450619204, 7172.139343278735, 7182.922561615799, 7080.398166155935, 7092.25531319204, 7098.68055937484, 7135.857282854314, 7147.070880785464, 5189.040027594907, 5260.026895024433, 5271.868203294872, 5272.314599102169, 5274.103402421598, 4818.975905120452, 4875.07373599015, 4898.069366820293, 4898.118338699069, 4917.582005529499, 6504.60972341661, 6599.175103112111, 6599.8350041248395, 6660.766873159416, 6663.833829079892, 7019.0, 7034.437245020386, 7084.539504932163, 7111.395531379891, 7113.608751518716, 6654.733810647616, 6673.599584024974, 6698.56459330142, 6701.0, 6713.1272934519175, 5951.732172052268, 5956.55325850563, 6041.124037014696, 6042.0, 6046.032634778414, 7308.6345682715655, 7313.085864266966, 7358.926410735824, 7430.0, 7506.962465187639, 7104.928950710633, 7166.0, 7173.856522869409, 7182.461315401261, 7184.676689548878, 7433.182349941394, 7440.330370266702, 7444.181140074696, 7516.924830751623, 7549.433792465477, 6902.827429314308, 6954.860902782018, 7011.228764835762, 7030.472714546328, 7113.893291600733, 7126.394256488049, 7157.320054594805, 7182.640867956686, 7190.101237345332, 7227.313405226495, 6839.555428897106, 6847.760328388682, 6944.305569443218, 6945.166580010431, 6953.1656201254145, 6696.933030669631, 6798.354156355138, 6851.828704282433, 6861.4510839133745, 6869.313068693291, 6785.084013658093, 6801.7279308829075, 6806.319368063154, 6828.317168283132, 6895.034695142785, 6962.651867406711, 7005.964970175117, 7017.298270173146, 7018.859622807618, 7021.648917554204, 6634.369734875179, 6655.467562595078, 6701.664916754045, 6747.426468750211, 6799.796006119825], "value": 6535.548885983426, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [971.0823272007951, 987.9456629885358, 1009.5557954500019, 1028.8816786069603, 1033.9948300258498, 42083.15833683324, 42883.57116428835, 46126.308105378404, 46232.53767462324, 46275.53724462754, 47188.76405617967, 47224.76387618057, 47245.763771181184, 47267.0, 47414.0, 8568.0, 8730.956345218265, 8740.388172827872, 8747.693830715894, 8750.86873696895, 8831.95584022079, 8899.199072083511, 8903.332250081237, 8908.51003194824, 8909.509976951265, 8938.86591701125, 8961.731148065568, 8973.820523589524, 9001.819963600725, 9007.639694412215, 8879.467231966102, 8896.37725359225, 8914.955425222865, 8926.464412135292, 8931.37480376374, 8672.176143266379, 8728.69449569262, 8734.0, 8743.825123497558, 8755.956220218923, 41935.0, 42051.7897410511, 42084.1583168338, 42138.36792448116, 42364.0, 3788.2802267569073, 3795.8481660733537, 3808.1431677872256, 3821.273957948009, 3837.3860182370686, 35081.298374032376, 35254.0, 35377.29245415103, 35516.0, 35530.822345888366, 5172.870678233075, 5220.425753167148, 5280.6039547034125, 5322.840314790563, 5335.519803217729, 228498.0, 230860.9999999983, 232369.0, 232477.0, 232896.0, 54174.0, 54318.72840635772, 54387.45612543903, 54462.45537544574, 54473.0, 55427.44572554223, 55509.44490555124, 55897.720511397994, 56022.71988640031, 56138.43861561332, 17101.230444630022, 17441.302347906196, 17482.125893705263, 17488.650226995644, 17512.474625761246, 14460.927695361455, 14487.275636218146, 14502.347394367278, 14620.342084606218, 14638.414463421344, 13613.795793063113, 13772.173669579657, 13822.170669759847, 13869.722605547833, 13926.164430134224, 5110.795568177231, 5141.794328226829, 5186.5654865090555, 5232.92150617741, 5259.684418934876, 1078.2721662877527, 1080.222239987208, 1112.7440688641657, 1112.9610463633896, 1125.9380734059705, 26000.609990850153, 26091.739082608932, 26146.477070458484, 26384.0, 26505.46989060208, 1213.611644273824, 1215.1251099208555, 1233.5805826019196, 1236.2767780848126, 1249.3378509390038, 13833.0, 13851.376688049062, 13918.58244252674, 14044.157350558999, 14216.64458388528, 272032.0, 276382.0, 276953.0, 285884.0, 290005.0, 63449.0, 63830.0, 64083.0, 64166.35833641604, 64268.0, 1526.0385956847115, 1529.250667173077, 1544.6215677158943, 1548.0556860315198, 1554.4015554011787, 30682.0, 30863.69136308608, 31038.844805775825, 31296.453334663358, 31549.684503154676, 42832.500862469664, 43118.78440607777, 43136.78431607822, 43184.56815431931, 43223.13553728971, 246302.0, 248426.0, 248475.0, 249376.0, 249936.0, 35860.641393586775, 36842.078948026516, 36919.077023073565, 37187.25625487529, 37514.437283441315, 47242.76378618222, 48842.75578622226, 48964.75517622389, 49373.25940110829, 49545.75227123986, 35963.0, 36384.818075909454, 36574.268514630094, 36683.08292292714, 36684.81657591695, 35443.645563544036, 36138.63861361458, 36483.635163648025, 36712.449313259785, 36873.078173044814, 41520.377194341505, 42465.15069698651, 42492.787536063355, 42573.0, 42768.78615606902, 34601.307973840885, 34667.30665386729, 34831.0, 35154.82422587871, 35604.0, 26043.869780651734, 26199.0, 26416.8679156603, 26591.468170636093, 26738.0], "value": 19288.089839823326, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [632.7658766256483, 635.7887210307892, 644.416802793472, 649.5207683524219, 654.4764188649079, 23746.287611371667, 24130.155444559445, 24142.396440089007, 24672.87663561684, 24722.629160562607, 26370.868145659246, 26788.794504247307, 26797.0, 26800.463990720174, 26803.865980670118, 6662.966685166592, 6983.999999999987, 7144.214136444987, 7186.461015423864, 7186.820329491752, 6754.0, 6802.319768023182, 6808.931910680879, 6810.216825065107, 6825.078614387068, 6750.797476075725, 6767.120274364326, 6768.56004359715, 6779.220389655179, 6784.592924424525, 6750.32496750321, 6790.999999999975, 6792.728290868384, 6806.251312355637, 6807.489438292098, 6325.430711236011, 6333.87332253357, 6345.42891139795, 6366.0769188467875, 6366.236051673783, 29842.253943651365, 30719.692803071906, 30990.690093099005, 31137.37725245505, 31151.84424077888, 2318.142287353673, 2345.6247000479843, 2345.94135146621, 2346.4016675747744, 2348.2368230325214, 20766.896165519076, 20874.37376878696, 21446.463838404008, 21540.246091386725, 21595.1361945522, 2638.80208984325, 2680.932976675579, 2697.7976651751, 2713.81003329767, 2721.6597925259343, 136505.0, 142194.0, 154684.99999999886, 160892.19553902274, 161370.0, 15943.601409964844, 16612.916935415247, 16803.91598042002, 17183.656326873643, 17200.0, 26507.204783856516, 26582.0, 26659.20022399331, 26689.199324020312, 26701.19896403111, 9907.653232136985, 10058.698239052841, 10086.646967356108, 10087.243456740774, 10244.0, 8867.600957956907, 8898.777530561787, 8907.51008694515, 9016.323775716848, 9043.547822608843, 9731.756706082404, 9916.20670346385, 9959.203263738884, 10246.590136394461, 10334.0, 2990.4168687105807, 3045.558394032853, 3084.275195329096, 3126.67116475497, 3178.141901686578, 1048.8898665639997, 1067.8985496377832, 1068.1188019883473, 1070.7804899995483, 1070.973225669349, 21071.789282106984, 21478.48804391802, 21562.89218553897, 21612.56774864494, 21927.12291508354, 1112.8219484882543, 1117.1621284036971, 1129.768397478515, 1134.9432528373713, 1153.948072336747, 11373.260738052, 11640.53437862476, 11674.416279186007, 11719.179657424069, 11836.112291578165, 551410.0, 563773.0, 565045.0, 573377.0, 575689.0, 130442.0, 131060.0, 131794.34102829616, 132959.33520332337, 135669.0, 1223.4555622747791, 1231.378154032208, 1263.8041103628952, 1266.2465832829453, 1268.3024336614824, 18479.81520184835, 18483.815161848746, 18707.438776836174, 18856.24575016984, 19089.427317180507, 64209.67895160494, 64882.351176489516, 65394.0, 65890.34109658842, 67525.66237168782, 79640.0, 80278.0, 80559.0, 81109.0, 81487.59256203918, 15988.840111598734, 16144.838551614803, 16205.189740512691, 16270.674586507967, 16285.511434656979, 24104.397390065387, 24128.276151715476, 24205.394865128514, 24284.635730463702, 24326.0, 19250.71123933114, 19363.90318048401, 19397.2241110354, 19483.318083866998, 19675.901620491804, 17803.134108971222, 18003.81996180074, 18013.09934503296, 18021.2791488339, 18319.35882244115, 20142.899285503478, 20253.18987240494, 20581.38255852327, 20640.48398790042, 20728.896355518125, 15901.681966360838, 15943.68112637764, 15950.840491594936, 15951.361945522049, 15981.760273595673, 18996.14517346695, 19079.904600477465, 19389.51526211856, 19397.8060219396, 19654.312099076462], "value": 12948.748117232506, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1406.1633328169737, 1451.0568130715035, 1457.4898785425103, 1465.9842716265136, 1480.9333579988902, 17304.82695173048, 17952.46142615722, 17975.19111639976, 17977.280908763634, 17999.370022049232, 17291.654166916655, 17343.39298124566, 17364.479065628053, 17393.217305221264, 17410.47768566942, 2848.9287767805813, 2966.599509066281, 2967.792254542183, 2968.302448924501, 2972.7770417218685, 2884.278930267433, 2902.593636890837, 2954.4091181763624, 2975.3305506261136, 2979.478591246534, 3020.7734419918484, 3042.1786117748193, 3050.801697889641, 3051.1456792098247, 3052.725254727074, 2923.1230630810674, 2939.235798692334, 2970.4207679502506, 2986.7013298670176, 2987.1337312179444, 2870.8708108134974, 2874.928126796826, 2875.1374587623627, 2881.0, 2894.9855250723613, 17491.5627109322, 17529.211185496682, 17556.473305800846, 17558.91220543889, 17584.38454654081, 8641.092685268019, 8932.285417166677, 8933.553322333857, 8947.50788706621, 8947.597358118901, 5582.637128586629, 5807.88384232313, 5956.761729530814, 5957.582969192158, 5962.522998160137, 2087.5720477302116, 2141.496748264157, 2169.9023543940402, 2172.6197915364905, 2192.0464597899804, 31950.840245798856, 32310.192245193823, 32313.0, 32329.51505727416, 32332.191695207574, 7254.202037775841, 7284.453665975073, 7351.77944661661, 7470.626468676544, 7516.586587737617, 20833.58332833335, 21023.78976210249, 21042.263520777007, 21093.0, 21112.577748444946, 8488.575571221414, 8765.824683506422, 8766.824663506693, 8771.298296136294, 8774.649014039494, 7635.885461718079, 7790.5325680459355, 7961.840763184704, 7968.163342849033, 7971.083325417651, 5997.550183736237, 6192.102145189013, 6194.628322300677, 6247.937520624827, 6278.277998030285, 1614.9919250403673, 1689.6282817780068, 1710.6920754264352, 1712.3065158610782, 1750.5798608334162, 1021.2544842265188, 1025.1286406554368, 1028.141501845952, 1032.4373216596973, 1042.6611351310855, 9706.854397184048, 9727.902720972841, 9823.557939892722, 9918.0, 9932.205423566242, 1069.946502674863, 1107.2360071550604, 1110.0231796019452, 1111.6776134920945, 1112.0991996482712, 6050.092486127116, 6177.505799536027, 6506.707198175999, 6671.43292820106, 6840.31596840322, 26770.0, 27140.185794426197, 27319.180424587295, 27486.862565687043, 27490.450190996067, 25573.23280301594, 26521.46957060848, 26865.0, 26879.328016799736, 26932.730672693415, 12924.224546527239, 13252.469901203844, 13392.330383480981, 13394.397252123677, 13417.865821341857, 9897.752556186153, 10146.137578305927, 10248.64129755455, 10299.897001029894, 10508.789824203626, 22632.321030369116, 22699.432514187276, 22722.20472283462, 22861.0, 22981.0, 23640.88179559091, 23733.881330593238, 23879.16422925189, 24144.275671729876, 24570.38574035592, 13127.409266583218, 13309.0, 13310.06829521963, 13335.399907004403, 13340.399682014528, 16376.099314537338, 16376.426825061066, 16396.180190990643, 16514.917425412797, 16583.0, 13199.34003299812, 13279.136856104322, 13317.267550284827, 13396.196228226338, 13760.31198440054, 13003.089783715428, 13036.413361398949, 13162.210267383987, 13165.868341316464, 13324.0, 10316.071553559916, 10484.423356715453, 10498.212634052325, 10504.264701470824, 10519.737006574896, 8267.503949763033, 8339.24946754795, 8340.207680270607, 8396.706115285935, 8490.0, 8225.95887020561, 8251.876221856557, 8309.293710034715, 8353.916460835557, 8360.581970901309], "value": 7686.671892901887, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [571.1347308827128, 583.0845572451251, 592.8784599157174, 601.6690820048973, 611.7155522681954, 6354.237491501015, 6402.199725034371, 6498.382653647902, 6498.447631951284, 6503.642299673516, 6347.650879201642, 6386.10594516768, 6400.935990640092, 6425.357464253572, 6445.645489498076, 5286.259923610698, 5291.4708529147165, 5311.097113490716, 5311.601629877755, 5313.415524292324, 5017.448080711119, 5159.5614372778355, 5180.2488639147305, 5295.4704529546925, 5348.197770334442, 5096.668716533432, 5122.6158038147105, 5134.0, 5147.742612869341, 5148.768305426246, 5063.620228482879, 5078.695278283315, 5118.616103792193, 5121.462246464123, 5143.588512918976, 4634.536546345372, 4662.114198302312, 4671.6262698984, 4722.220833562458, 4757.240800335831, 6334.144890439778, 6370.299267080617, 6395.8401039973905, 6398.648074355909, 6444.774432894873, 5989.580729348947, 6003.759849606011, 6068.362821903725, 6079.361667024988, 6103.176071230371, 6735.158105236846, 6757.85116530191, 6798.736606428942, 6806.10740435313, 6855.862882742367, 5218.721413253777, 5248.947510524884, 5263.4208738058105, 5265.104932161542, 5294.258803767476, 6840.931590684129, 6972.442204623669, 7009.21265077402, 7032.488015076783, 7117.466190035768, 5358.5981051421295, 5410.97294513525, 5432.728363581805, 5433.755481003364, 5451.781928722807, 5476.452354764571, 5520.171974203821, 5524.171374293888, 5537.197106419547, 5549.7780088796, 6106.938930610637, 6112.2970858351855, 6123.510119190454, 6127.448529632355, 6156.107364432221, 6755.392014718601, 6806.149231346082, 6829.317068293131, 6879.552829066095, 6882.174139103339, 1847.9722804157948, 1866.2628261836498, 1879.4455635587535, 1888.6222755448964, 1897.3074827687794, 1310.8988449702106, 1311.3574348569132, 1339.2723386831074, 1348.359529223611, 1365.7268546290584, 6244.562880598314, 6264.778368218153, 6342.809715708536, 6403.423691867754, 6434.388733070351, 6825.078614386995, 6938.722451101899, 6944.756933507404, 6955.269696681776, 6984.825379365557, 6363.872722545523, 6397.744090236339, 6419.550631455753, 6420.839479012969, 6433.742650293936, 3665.2303016366327, 3701.444783282529, 3709.4435834624483, 3717.5724791648768, 3721.981390093032, 7244.239354867768, 7260.0, 7295.744648937261, 7349.191588925214, 7351.338379545867, 7125.857482850418, 7127.964360178166, 7131.393831524275, 7159.964200178966, 7177.9641101795205, 7235.095613048369, 7240.0, 7250.456215783837, 7257.237990010973, 7339.77980660581, 6883.346082122191, 6890.758823441155, 6915.654217289015, 6918.481113916376, 7003.369696727319, 6788.389044985975, 6791.45668346541, 6829.487788415988, 6852.81344174961, 6926.515143940077, 7167.3549380556, 7231.3130252625915, 7324.597147156957, 7334.3032411920785, 7352.161959510123, 5442.564594832483, 5450.209719590558, 5453.345598528202, 5456.836294911159, 5467.316585426822, 6635.270120286668, 6701.497387696039, 6998.230194678479, 7022.54353467023, 7151.892721609076, 6719.563228390139, 6720.529562930548, 6742.393184613408, 6751.189857217166, 6768.0, 6698.330166983263, 6707.195136583641, 6720.0, 6752.932470675427, 6756.45948324123, 6539.803805885831, 6644.202695676357, 6664.4668426524795, 6738.696758645775, 6759.763408280686, 6790.93209067903, 6835.111435513351, 6870.828229294108, 6890.276520965427, 6910.308969103049, 6586.242582103119, 6640.911975931215, 6660.800175994728, 6671.199456065109, 6679.799606011828], "value": 5359.560251784839, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [993.7962717642879, 1006.2201793609952, 1016.684827703412, 1025.1081559043632, 1045.707201983445, 21006.579868402623, 21213.15147394104, 21304.254351097716, 21304.680429793527, 21635.350939471802, 19140.808591914112, 19207.32774352898, 19249.422517324467, 19321.710174347398, 19328.90335548324, 1047.9528421221064, 1069.9144068474504, 1070.4112737994071, 1071.3036526257956, 1072.7318170457386, 1069.2942657845824, 1069.315637991686, 1069.6416700405373, 1072.3030030480172, 1079.1528650009743, 1124.342259778031, 1143.222608626138, 1157.1610582327787, 1157.8321143434198, 1159.4956194055612, 1154.7863645225575, 1158.7219067423841, 1159.0959051939458, 1159.2522822779345, 1163.3136449494796, 821.9589020548949, 822.942394032418, 824.2087595907935, 824.418784756745, 824.8020475085937, 21081.367558973256, 21921.671174932228, 22121.446963826034, 22167.556648867092, 22190.445238868997, 22779.77220227793, 22792.31623051311, 23048.65427018596, 23090.499117557305, 23208.419789505228, 18034.90982545092, 18113.1849066791, 18129.637407251914, 18268.269269229215, 18358.35745748906, 4061.1471590965934, 4123.525794533637, 4165.375193720935, 4166.479190101238, 4184.246835569596, 129587.0, 142063.0, 166823.0, 168453.15773421177, 168828.0, 18537.53656158607, 19090.0, 19183.424497265103, 19196.71204931927, 19538.218471261276, 34835.0, 35268.64731352653, 35273.823630881685, 35539.644603553636, 35586.82206588951, 10227.795444091076, 10304.793904121876, 10314.896851031393, 10332.070113689804, 10416.32293900894, 4912.484189160158, 4930.753462326869, 4944.357233559686, 4965.851024469272, 4968.0, 5923.318818335861, 5993.670348130895, 6033.245844269466, 6037.516998640098, 6043.153958445821, 1125.7973564758422, 1153.9711507212219, 1166.4284500594647, 1167.235460773195, 1171.1275100050516, 704.1514974455769, 709.7870638808337, 714.5855403865745, 724.6304384763808, 736.8452624948713, 13401.597952061455, 14338.426462941574, 14848.183349915858, 15054.0, 15124.697506049817, 767.0335377424485, 767.3592550220517, 769.0963118335933, 773.6827900560855, 783.0485959559163, 6334.208223972004, 6395.680215989275, 6420.74317027323, 6453.806385808433, 6471.838204044842, 152885.2355738214, 153014.0, 154828.0, 155152.2242388781, 160553.0, 131825.0, 133572.0, 134492.0, 136543.0, 139491.30254348664, 121143.39428302979, 122106.0, 122591.0, 122861.0, 124328.37835810945, 12156.878431215575, 12262.08034397406, 12263.141580089308, 12314.199577027464, 12618.305993170097, 56292.0, 56810.0, 57184.142237867294, 58246.0, 58606.7069664666, 74374.62812685902, 75280.62359688166, 75503.0, 77312.61343693246, 77774.611126944, 16598.83401165973, 17004.82995170082, 17137.657246855244, 17207.913960430116, 17266.0, 20567.794322056587, 20632.896835515727, 20713.378598642066, 20814.479638009172, 20982.47543811417, 17294.13529323554, 17685.204165812313, 17755.822441775934, 17866.821331787036, 17957.820421795615, 18115.547111321794, 18160.0, 18161.0, 18351.449456516326, 18532.25870965146, 17946.5513362167, 18010.919344839353, 18032.63934721272, 18123.184456699215, 18151.45545633633, 12829.61511154667, 12830.10189286741, 13213.801792973305, 13271.867281327062, 13297.268650223943, 13996.44014239419, 14058.578242652737, 14233.857661423253, 14240.430382784572, 14299.0], "value": 10198.831719664386, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1352.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 105.0, 104.0, 105.0, 106.0, 107.0, 108.0, 105.0, 106.0, 104.0], "value": 105.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 117.0, 111.0, 112.0, 119.0, 113.0, 110.0, 137.0, 112.0, 113.0], "value": 115.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 163.0, 162.0, 162.0, 162.0, 161.0, 164.0, 162.0, 160.0], "value": 161.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 81.0, 73.0, 75.0, 74.0, 73.0, 74.0, 73.0, 74.0], "value": 74.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 76.0, 77.0, 76.0, 77.0, 77.0, 77.0, 78.0, 77.0, 76.0], "value": 77.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 114.0, 110.0, 113.0, 114.0, 113.0, 109.0, 114.0, 115.0], "value": 112.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 150.0, 152.0, 149.0, 148.0, 147.0, 148.0, 149.0, 150.0, 147.0], "value": 148.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 94.0, 93.0, 94.0, 94.0, 94.0, 95.0, 94.0, 99.0], "value": 94.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [43.0, 42.0, 43.0, 46.0, 42.0, 43.0, 43.0, 43.0, 43.0, 43.0], "value": 43.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [39.0, 38.0, 37.0, 38.0, 38.0, 38.0, 38.0, 38.0, 37.0, 38.0], "value": 37.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 70.0, 68.0, 73.0, 71.0, 69.0, 69.0, 70.0, 69.0, 67.0], "value": 70.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 105.0, 100.0, 105.0, 108.0, 109.0, 110.0, 102.0, 104.0, 99.0], "value": 105.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 150.0, 144.0, 149.0, 144.0, 150.0, 146.0, 154.0, 147.0, 149.0], "value": 148.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 57.0, 57.0, 59.0, 59.0, 60.0, 57.0, 55.0, 56.0, 57.0], "value": 57.6, "unit": "score"}]}]} 08:30:02 INFO - Return code: 0 08:30:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:30:02 INFO - # TBPL SUCCESS # 08:30:02 INFO - Running post-action listener: _package_coverage_data 08:30:02 INFO - Running post-action listener: _resource_record_post_action 08:30:02 INFO - [mozharness: 2017-10-24 15:30:02.166110Z] Finished run-tests step (success) 08:30:02 INFO - Running post-run listener: _resource_record_post_run 08:30:02 INFO - Total resource usage - Wall time: 1183s; CPU: 13.0%; Read bytes: 4096; Write bytes: 284758016; Read time: 8; Write time: 320844 08:30:02 INFO - TinderboxPrint: CPU usage
13.1% 08:30:02 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 08:30:02 INFO - TinderboxPrint: I/O write bytes / time
284,758,016 / 320,844 08:30:02 INFO - TinderboxPrint: CPU idle
8,199.6 (86.9%) 08:30:02 INFO - TinderboxPrint: CPU user
1,179.0 (12.5%) 08:30:02 INFO - TinderboxPrint: Swap in / out
0 / 0 08:30:02 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 9076736; Read time: 0; Write time: 1296 08:30:02 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 08:30:02 INFO - run-tests - Wall time: 1169s; CPU: 13.0%; Read bytes: 0; Write bytes: 274464768; Read time: 0; Write time: 319456 08:30:02 INFO - Running post-run listener: _upload_blobber_files 08:30:02 INFO - Blob upload gear active. 08:30:02 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:30:02 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 08:30:02 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'] 08:30:02 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 08:30:03 INFO - (blobuploader) - INFO - Open directory for files ... 08:30:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:30:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:30:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:30:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:30:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:30:04 INFO - (blobuploader) - INFO - Done attempting. 08:30:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:30:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:30:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:30:11 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:30:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:30:11 INFO - (blobuploader) - INFO - Done attempting. 08:30:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:30:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:30:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:30:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:30:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:30:12 INFO - (blobuploader) - INFO - Done attempting. 08:30:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 08:30:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:30:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:30:13 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 08:30:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:30:13 INFO - (blobuploader) - INFO - Done attempting. 08:30:13 INFO - (blobuploader) - INFO - Iteration through files over. 08:30:13 INFO - Return code: 0 08:30:13 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:30:13 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:30:13 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/23e74a8484643302a93eadf13a87c2e01d338820e530cfcae56e7a68067e6e3cc778d25e3e3831ffca20041bd4fb4026dc465bab99c9705dfe6547e3eaf5f426", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/5eb3ee95b422e30ac2b34ec68e0b39e960943393b53c0913f8e04cee07c6e853a5c0679e7a3f3d4d2ef4b9cf6fbe697db385853909068f7040eef0e3dc4033e9", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/2ad62babf453acd0c929d7f7d1832ef7b5838d66349e61a3d965e898d85aa7c2d4ffbe3834bed00691da794ec1a5b263cbb3fe09cb4e12973ec9e9a69497e824", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/ba4b18156876c51857969f5c96de51d5e473297b02398dc721cc902d9a24d45105c95c9723c1c63c29b52f13b122f2657f75667440f979b342fcfa8fd5a010ed"} 08:30:13 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:30:13 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:30:13 INFO - Contents: 08:30:13 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/23e74a8484643302a93eadf13a87c2e01d338820e530cfcae56e7a68067e6e3cc778d25e3e3831ffca20041bd4fb4026dc465bab99c9705dfe6547e3eaf5f426", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/5eb3ee95b422e30ac2b34ec68e0b39e960943393b53c0913f8e04cee07c6e853a5c0679e7a3f3d4d2ef4b9cf6fbe697db385853909068f7040eef0e3dc4033e9", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/2ad62babf453acd0c929d7f7d1832ef7b5838d66349e61a3d965e898d85aa7c2d4ffbe3834bed00691da794ec1a5b263cbb3fe09cb4e12973ec9e9a69497e824", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/ba4b18156876c51857969f5c96de51d5e473297b02398dc721cc902d9a24d45105c95c9723c1c63c29b52f13b122f2657f75667440f979b342fcfa8fd5a010ed"} 08:30:13 INFO - Running post-run listener: copy_logs_to_upload_dir 08:30:13 INFO - Copying logs to upload dir... 08:30:13 INFO - mkdir: /builds/slave/test/build/upload/logs 08:30:13 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.476314 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2017-10-24 08:30:13.721030) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-10-24 08:30:13.724912) ========= 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=8783db0840cc980e80bb0bd400000236-1508857480.452402-1932106324 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/23e74a8484643302a93eadf13a87c2e01d338820e530cfcae56e7a68067e6e3cc778d25e3e3831ffca20041bd4fb4026dc465bab99c9705dfe6547e3eaf5f426", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/5eb3ee95b422e30ac2b34ec68e0b39e960943393b53c0913f8e04cee07c6e853a5c0679e7a3f3d4d2ef4b9cf6fbe697db385853909068f7040eef0e3dc4033e9", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/2ad62babf453acd0c929d7f7d1832ef7b5838d66349e61a3d965e898d85aa7c2d4ffbe3834bed00691da794ec1a5b263cbb3fe09cb4e12973ec9e9a69497e824", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/ba4b18156876c51857969f5c96de51d5e473297b02398dc721cc902d9a24d45105c95c9723c1c63c29b52f13b122f2657f75667440f979b342fcfa8fd5a010ed"} build_url:https://queue.taskcluster.net/v1/task/KOgJ6WYFRAqISlxxdSnBeQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011471 build_url: 'https://queue.taskcluster.net/v1/task/KOgJ6WYFRAqISlxxdSnBeQ/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/23e74a8484643302a93eadf13a87c2e01d338820e530cfcae56e7a68067e6e3cc778d25e3e3831ffca20041bd4fb4026dc465bab99c9705dfe6547e3eaf5f426", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/5eb3ee95b422e30ac2b34ec68e0b39e960943393b53c0913f8e04cee07c6e853a5c0679e7a3f3d4d2ef4b9cf6fbe697db385853909068f7040eef0e3dc4033e9", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/2ad62babf453acd0c929d7f7d1832ef7b5838d66349e61a3d965e898d85aa7c2d4ffbe3834bed00691da794ec1a5b263cbb3fe09cb4e12973ec9e9a69497e824", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/ba4b18156876c51857969f5c96de51d5e473297b02398dc721cc902d9a24d45105c95c9723c1c63c29b52f13b122f2657f75667440f979b342fcfa8fd5a010ed"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-10-24 08:30:13.756610) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-10-24 08:30:13.757046) ========= 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=8783db0840cc980e80bb0bd400000236-1508857480.452402-1932106324 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004546 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-10-24 08:30:13.839330) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-10-24 08:30:13.839647) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-10-24 08:30:13.840016) ========= ========= Total master_lag: 0.22 =========