builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-051 starttime: 1507308144.88 results: success (0) revision: c5e550fbf12843a9189e5f6708f384d4133d6161 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-10-06 09:42:24.881435) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-10-06 09:42:24.881933) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-10-06 09:42:24.882234) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-10-06 09:42:24.901513) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-06 09:42:24.901922) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1507304343.542987-240953618 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-10-06 09:42:24-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 93.2M=0s 2017-10-06 09:42:25 (93.2 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.127672 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-06 09:42:25.047183) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-10-06 09:42:25.050510) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1507304343.542987-240953618 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021228 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-10-06 09:42:25.103853) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-06 09:42:25.104203) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev c5e550fbf12843a9189e5f6708f384d4133d6161 --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 c5e550fbf12843a9189e5f6708f384d4133d6161 --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=5ac5dba3e01a12f1ff77ab15000001b1-1507304343.542987-240953618 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-10-06 09:42:25,219 truncating revision to first 12 chars 2017-10-06 09:42:25,219 Setting DEBUG logging. 2017-10-06 09:42:25,219 attempt 1/10 2017-10-06 09:42:25,219 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/c5e550fbf128?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-10-06 09:42:25,680 unpacking tar archive at: mozilla-beta-c5e550fbf128/testing/mozharness/ program finished with exit code 0 elapsedTime=0.724387 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-06 09:42:25.852121) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-10-06 09:42:25.852404) ========= script_repo_revision: c5e550fbf12843a9189e5f6708f384d4133d6161 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-10-06 09:42:25.852779) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-10-06 09:42:25.853081) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-10-06 09:42:25.870739) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2017-10-06 09:42:25.871098) ========= /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=5ac5dba3e01a12f1ff77ab15000001b1-1507304343.542987-240953618 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:42:26 INFO - MultiFileLogger online at 20171006 09:42:26 in /builds/slave/test 09:42:26 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 09:42:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:42:26 INFO - {'append_to_log': False, 09:42:26 INFO - 'base_work_dir': '/builds/slave/test', 09:42:26 INFO - 'blob_upload_branch': 'Mozilla-Beta-Non-PGO', 09:42:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:42:26 INFO - 'branch': 'Mozilla-Beta-Non-PGO', 09:42:26 INFO - 'buildbot_json_path': 'buildprops.json', 09:42:26 INFO - 'code_coverage': False, 09:42:26 INFO - 'config_files': ('talos/linux_config.py',), 09:42:26 INFO - 'default_actions': ('clobber', 09:42:26 INFO - 'read-buildbot-config', 09:42:26 INFO - 'download-and-extract', 09:42:26 INFO - 'populate-webroot', 09:42:26 INFO - 'create-virtualenv', 09:42:26 INFO - 'install', 09:42:26 INFO - 'setup-mitmproxy', 09:42:26 INFO - 'run-tests'), 09:42:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:42:26 INFO - 'disable_ccov_upload': False, 09:42:26 INFO - 'disable_stylo': False, 09:42:26 INFO - 'download_minidump_stackwalk': True, 09:42:26 INFO - 'download_symbols': 'ondemand', 09:42:26 INFO - 'enable_stylo': False, 09:42:26 INFO - 'enable_webrender': False, 09:42:26 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 09:42:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:42:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:42:26 INFO - 'gecko_profile': False, 09:42:26 INFO - 'gecko_profile_interval': 0, 09:42:26 INFO - 'installer_path': 'installer.exe', 09:42:26 INFO - 'log_level': 'info', 09:42:26 INFO - 'log_name': 'talos', 09:42:26 INFO - 'log_to_console': True, 09:42:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:42:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:42:26 INFO - 'opt_config_files': (), 09:42:26 INFO - 'pip_index': False, 09:42:26 INFO - 'suite': 'dromaeojs-e10s', 09:42:26 INFO - 'system_bits': '32', 09:42:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:42:26 INFO - 'title': 'talos-linux64-ix-051', 09:42:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:42:26 INFO - 'use_talos_json': True, 09:42:26 INFO - 'verify': 'False', 09:42:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:42:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:42:26 INFO - 'work_dir': 'build'} 09:42:26 INFO - [mozharness: 2017-10-06 16:42:26.129231Z] Running clobber step. 09:42:26 INFO - Running pre-action listener: _resource_record_pre_action 09:42:26 INFO - Running main action method: clobber 09:42:26 INFO - rmtree: /builds/slave/test/build 09:42:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:42:27 INFO - Running post-action listener: _resource_record_post_action 09:42:27 INFO - [mozharness: 2017-10-06 16:42:27.125684Z] Finished clobber step (success) 09:42:27 INFO - [mozharness: 2017-10-06 16:42:27.125781Z] Running read-buildbot-config step. 09:42:27 INFO - Running pre-action listener: _resource_record_pre_action 09:42:27 INFO - Running main action method: read_buildbot_config 09:42:27 INFO - Using buildbot properties: 09:42:27 INFO - { 09:42:27 INFO - "project": "", 09:42:27 INFO - "product": "firefox", 09:42:27 INFO - "who": "ffxbld@noreply.mozilla.org", 09:42:27 INFO - "installer_path": "public/build/target.tar.bz2", 09:42:27 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 09:42:27 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-beta", 09:42:27 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta talos dromaeojs-e10s", 09:42:27 INFO - "stage_platform": "linux64", 09:42:27 INFO - "basedir": "/builds/slave/test", 09:42:27 INFO - "buildnumber": 161, 09:42:27 INFO - "platform": "ubuntu64_hw", 09:42:27 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 09:42:27 INFO - "slavebuilddir": "test", 09:42:27 INFO - "taskId": "bl6ZytxoQzuyiBPEAh7xpw", 09:42:27 INFO - "branch": "mozilla-beta", 09:42:27 INFO - "script_repo_revision": "production", 09:42:27 INFO - "revision": "c5e550fbf12843a9189e5f6708f384d4133d6161", 09:42:27 INFO - "slavename": "talos-linux64-ix-051", 09:42:27 INFO - "repo_path": "releases/mozilla-beta" 09:42:27 INFO - } 09:42:27 INFO - Finding installer, test and symbols from parent task. 09:42:27 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bl6ZytxoQzuyiBPEAh7xpw'}, attempt #1 09:42:27 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bl6ZytxoQzuyiBPEAh7xpw'}, attempt #1 09:42:28 INFO - Task dependencies: R_hXeSiJQPSOG6y2jN0pBw 09:42:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/R_hXeSiJQPSOG6y2jN0pBw'}, attempt #1 09:42:28 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/R_hXeSiJQPSOG6y2jN0pBw/artifacts/public/build/target.tar.bz2 09:42:28 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/R_hXeSiJQPSOG6y2jN0pBw/artifacts/public/build/target.test_packages.json 09:42:28 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/R_hXeSiJQPSOG6y2jN0pBw/artifacts/public/build/target.crashreporter-symbols.zip 09:42:28 INFO - Running post-action listener: _resource_record_post_action 09:42:28 INFO - [mozharness: 2017-10-06 16:42:28.753625Z] Finished read-buildbot-config step (success) 09:42:28 INFO - [mozharness: 2017-10-06 16:42:28.753844Z] Running download-and-extract step. 09:42:28 INFO - Running pre-action listener: _resource_record_pre_action 09:42:28 INFO - Running main action method: download_and_extract 09:42:28 INFO - mkdir: /builds/slave/test/build/tests 09:42:28 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')]} 09:42:28 INFO - trying https://queue.taskcluster.net/v1/task/R_hXeSiJQPSOG6y2jN0pBw/artifacts/public/build/target.test_packages.json 09:42:28 INFO - Downloading https://queue.taskcluster.net/v1/task/R_hXeSiJQPSOG6y2jN0pBw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 09:42:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/R_hXeSiJQPSOG6y2jN0pBw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 09:42:29 INFO - Downloaded 989 bytes. 09:42:29 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 09:42:29 INFO - Using the following test package requirements: 09:42:29 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 09:42:29 INFO - u'common': [u'target.common.tests.zip'], 09:42:29 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 09:42:29 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 09:42:29 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 09:42:29 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 09:42:29 INFO - u'mozbase': [u'target.common.tests.zip'], 09:42:29 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 09:42:29 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 09:42:29 INFO - u'web-platform': [u'target.common.tests.zip', 09:42:29 INFO - u'target.web-platform.tests.tar.gz'], 09:42:29 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 09:42:29 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 09:42:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/R_hXeSiJQPSOG6y2jN0pBw/artifacts/public/build/target.common.tests.zip 09:42:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/R_hXeSiJQPSOG6y2jN0pBw/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:42:29 INFO - Fetch https://queue.taskcluster.net/v1/task/R_hXeSiJQPSOG6y2jN0pBw/artifacts/public/build/target.common.tests.zip into memory 09:42:32 INFO - Content-Length response header: 55179335 09:42:32 INFO - Bytes received: 55179335 09:42:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/R_hXeSiJQPSOG6y2jN0pBw/artifacts/public/build/target.talos.tests.zip 09:42:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/R_hXeSiJQPSOG6y2jN0pBw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 09:42:42 INFO - Fetch https://queue.taskcluster.net/v1/task/R_hXeSiJQPSOG6y2jN0pBw/artifacts/public/build/target.talos.tests.zip into memory 09:42:44 INFO - Content-Length response header: 14509224 09:42:44 INFO - Bytes received: 14509224 09:42:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:42:44 INFO - trying https://queue.taskcluster.net/v1/task/R_hXeSiJQPSOG6y2jN0pBw/artifacts/public/build/target.tar.bz2 09:42:44 INFO - Downloading https://queue.taskcluster.net/v1/task/R_hXeSiJQPSOG6y2jN0pBw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 09:42:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/R_hXeSiJQPSOG6y2jN0pBw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 09:42:47 INFO - Downloaded 53686053 bytes. 09:42:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/R_hXeSiJQPSOG6y2jN0pBw/artifacts/public/build/target.tar.bz2 09:42:47 INFO - mkdir: /builds/slave/test/properties 09:42:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:42:47 INFO - Writing to file /builds/slave/test/properties/build_url 09:42:47 INFO - Contents: 09:42:47 INFO - build_url:https://queue.taskcluster.net/v1/task/R_hXeSiJQPSOG6y2jN0pBw/artifacts/public/build/target.tar.bz2 09:42:47 INFO - Running post-action listener: _resource_record_post_action 09:42:47 INFO - Running post-action listener: find_tests_for_verification 09:42:47 INFO - Running post-action listener: set_extra_try_arguments 09:42:47 INFO - [mozharness: 2017-10-06 16:42:47.150509Z] Finished download-and-extract step (success) 09:42:47 INFO - [mozharness: 2017-10-06 16:42:47.150628Z] Running populate-webroot step. 09:42:47 INFO - Running pre-action listener: _resource_record_pre_action 09:42:47 INFO - Running main action method: populate_webroot 09:42:47 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:42:47 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 09:42:47 INFO - 'tests': ['tresize', 09:42:47 INFO - 'tcanvasmark']}, 09:42:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:42:47 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 09:42:47 INFO - 'tests': ['dromaeo_css', 09:42:47 INFO - 'kraken']}, 09:42:47 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:42:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:42:47 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 09:42:47 INFO - 'talos_options': ['--disable-stylo'], 09:42:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:42:47 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:42:47 INFO - 'tests': ['damp', 'tps']}, 09:42:47 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 09:42:47 INFO - 'talos_options': ['--disable-stylo'], 09:42:47 INFO - 'tests': ['damp', 'tps']}, 09:42:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:42:47 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 09:42:47 INFO - 'tests': ['dromaeo_dom']}, 09:42:47 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 09:42:47 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 09:42:47 INFO - 'tests': ['basic_compositor_video', 09:42:47 INFO - 'glvideo']}, 09:42:47 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 09:42:47 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 09:42:47 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 09:42:47 INFO - 'talos_options': ['--disable-stylo'], 09:42:47 INFO - 'tests': ['ts_paint_webext', 09:42:47 INFO - 'tp5o_webext']}, 09:42:47 INFO - 'other-e10s': {'tests': ['a11yr', 09:42:47 INFO - 'ts_paint', 09:42:47 INFO - 'tpaint', 09:42:47 INFO - 'sessionrestore', 09:42:47 INFO - 'sessionrestore_many_windows', 09:42:47 INFO - 'sessionrestore_no_auto_restore', 09:42:47 INFO - 'tabpaint']}, 09:42:47 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 09:42:47 INFO - 'tests': ['a11yr', 09:42:47 INFO - 'ts_paint', 09:42:47 INFO - 'tpaint', 09:42:47 INFO - 'sessionrestore', 09:42:47 INFO - 'sessionrestore_many_windows', 09:42:47 INFO - 'sessionrestore_no_auto_restore', 09:42:47 INFO - 'tabpaint']}, 09:42:47 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 09:42:47 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 09:42:47 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 09:42:47 INFO - 'tests': ['perf_reftest_singletons']}, 09:42:47 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 09:42:47 INFO - 'tests': ['bloom_basic']}, 09:42:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:42:47 INFO - 'tsvgr_opacity', 09:42:47 INFO - 'tart', 09:42:47 INFO - 'tscrollx', 09:42:47 INFO - 'tsvg_static']}, 09:42:47 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 09:42:47 INFO - 'tests': ['tsvgx', 09:42:47 INFO - 'tsvgr_opacity', 09:42:47 INFO - 'tart', 09:42:47 INFO - 'tscrollx', 09:42:47 INFO - 'tsvg_static']}, 09:42:47 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:42:47 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 09:42:47 INFO - 'talos_options': ['--disable-stylo'], 09:42:47 INFO - 'tests': ['tp5o']}, 09:42:47 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 09:42:47 INFO - 'talos_options': ['--mitmproxy', 09:42:47 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 09:42:47 INFO - '--firstNonBlankPaint'], 09:42:47 INFO - 'tests': ['tp6_google', 09:42:47 INFO - 'tp6_youtube', 09:42:47 INFO - 'tp6_amazon', 09:42:47 INFO - 'tp6_facebook']}, 09:42:47 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 09:42:47 INFO - 'talos_options': ['--disable-stylo', 09:42:47 INFO - '--mitmproxy', 09:42:47 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 09:42:47 INFO - '--firstNonBlankPaint'], 09:42:47 INFO - 'tests': ['tp6_google', 09:42:47 INFO - 'tp6_youtube', 09:42:47 INFO - 'tp6_amazon', 09:42:47 INFO - 'tp6_facebook']}, 09:42:47 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 09:42:47 INFO - 'talos_options': ['--stylo-threads=1', 09:42:47 INFO - '--mitmproxy', 09:42:47 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 09:42:47 INFO - '--firstNonBlankPaint'], 09:42:47 INFO - 'tests': ['tp6_google', 09:42:47 INFO - 'tp6_youtube', 09:42:47 INFO - 'tp6_amazon', 09:42:47 INFO - 'tp6_facebook']}, 09:42:47 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:42:47 INFO - 'talos_options': ['--xperf_path', 09:42:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:42:47 INFO - 'tests': ['tp5n']}, 09:42:47 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 09:42:47 INFO - 'talos_options': ['--disable-stylo', 09:42:47 INFO - '--xperf_path', 09:42:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:42:47 INFO - 'tests': ['tp5n']}}} 09:42:47 INFO - Running post-action listener: _resource_record_post_action 09:42:47 INFO - [mozharness: 2017-10-06 16:42:47.166490Z] Finished populate-webroot step (success) 09:42:47 INFO - [mozharness: 2017-10-06 16:42:47.166580Z] Running create-virtualenv step. 09:42:47 INFO - Running pre-action listener: _resource_record_pre_action 09:42:47 INFO - Running main action method: create_virtualenv 09:42:47 INFO - Creating virtualenv /builds/slave/test/build/venv 09:42:47 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 09:42:47 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 09:42:47 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 09:42:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:42:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:42:47 INFO - Installing distribute.............................................................................................................................................................................................done. 09:42:48 INFO - Installing pip...............done. 09:42:48 INFO - Return code: 0 09:42:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:42:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:42:48 INFO - Reading from file tmpfile_stdout 09:42:48 INFO - Output received: 09:42:48 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 09:42:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:42:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:42:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:42:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:42:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:42:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xcfb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1066a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a090>, '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 0x106ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1064f90>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1507304343.542987-240953618', '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 09:42:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:42:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:42:48 INFO - Using env: {'DISPLAY': ':0', 09:42:48 INFO - 'HOME': '/home/cltbld', 09:42:48 INFO - 'LANG': 'en_US.UTF-8', 09:42:48 INFO - 'LANGUAGE': 'en_US:en', 09:42:48 INFO - 'LOGNAME': 'cltbld', 09:42:48 INFO - 'MAIL': '/var/mail/cltbld', 09:42:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:42:48 INFO - 'MOZ_NO_REMOTE': '1', 09:42:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:42:48 INFO - 'NO_EM_RESTART': '1', 09:42:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:42:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:42:48 INFO - 'PWD': '/builds/slave/test', 09:42:48 INFO - 'SHELL': '/bin/bash', 09:42:48 INFO - 'SHLVL': '1', 09:42:48 INFO - 'TERM': 'linux', 09:42:48 INFO - 'TMOUT': '86400', 09:42:48 INFO - 'USER': 'cltbld', 09:42:48 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1507304343.542987-240953618', 09:42:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:42:48 INFO - '_': '/tools/buildbot/bin/python'} 09:42:49 INFO - Ignoring indexes: http://pypi.python.org/simple/ 09:42:49 INFO - Downloading/unpacking pip>=1.5 09:42:49 INFO - Running setup.py egg_info for package pip 09:42:49 INFO - warning: no files found matching 'pip/cacert.pem' 09:42:49 INFO - warning: no files found matching '*.html' under directory 'docs' 09:42:49 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 09:42:49 INFO - no previously-included directories found matching 'docs/_build/_sources' 09:42:49 INFO - Installing collected packages: pip 09:42:49 INFO - Found existing installation: pip 1.1 09:42:49 INFO - Uninstalling pip: 09:42:49 INFO - Successfully uninstalled pip 09:42:49 INFO - Running setup.py install for pip 09:42:49 INFO - warning: no files found matching 'pip/cacert.pem' 09:42:49 INFO - warning: no files found matching '*.html' under directory 'docs' 09:42:49 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 09:42:49 INFO - no previously-included directories found matching 'docs/_build/_sources' 09:42:49 INFO - Installing pip script to /builds/slave/test/build/venv/bin 09:42:49 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 09:42:49 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 09:42:49 INFO - Successfully installed pip 09:42:49 INFO - Cleaning up... 09:42:49 INFO - Return code: 0 09:42:49 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:42: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')]} 09:42:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:42: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')]} 09:42:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:42:49 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 0xcfb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1066a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a090>, '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 0x106ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1064f90>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1507304343.542987-240953618', '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 09:42:49 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 09:42:49 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 09:42:49 INFO - Using env: {'DISPLAY': ':0', 09:42:49 INFO - 'HOME': '/home/cltbld', 09:42:49 INFO - 'LANG': 'en_US.UTF-8', 09:42:49 INFO - 'LANGUAGE': 'en_US:en', 09:42:49 INFO - 'LOGNAME': 'cltbld', 09:42:49 INFO - 'MAIL': '/var/mail/cltbld', 09:42:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:42:49 INFO - 'MOZ_NO_REMOTE': '1', 09:42:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:42:49 INFO - 'NO_EM_RESTART': '1', 09:42:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:42:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:42:49 INFO - 'PWD': '/builds/slave/test', 09:42:49 INFO - 'SHELL': '/bin/bash', 09:42:49 INFO - 'SHLVL': '1', 09:42:49 INFO - 'TERM': 'linux', 09:42:49 INFO - 'TMOUT': '86400', 09:42:49 INFO - 'USER': 'cltbld', 09:42:49 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1507304343.542987-240953618', 09:42:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:42:49 INFO - '_': '/tools/buildbot/bin/python'} 09:42:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:42:49 INFO - Downloading/unpacking psutil>=3.1.1 09:42:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:42:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:42:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:42:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:42:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:42:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:42:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:42:50 INFO - Installing collected packages: psutil 09:42:50 INFO - Running setup.py install for psutil 09:42:50 INFO - building 'psutil._psutil_linux' extension 09:42:50 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 09:42:51 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 09:42:51 INFO - building 'psutil._psutil_posix' extension 09:42:51 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 09:42:51 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 09:42:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:42:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:42:51 INFO - Successfully installed psutil 09:42:51 INFO - Cleaning up... 09:42:51 INFO - Return code: 0 09:42:51 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:42:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:42:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:42:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:42:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:42:51 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 0xcfb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1066a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a090>, '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 0x106ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1064f90>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1507304343.542987-240953618', '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 09:42:51 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 09:42:51 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 09:42:51 INFO - Using env: {'DISPLAY': ':0', 09:42:51 INFO - 'HOME': '/home/cltbld', 09:42:51 INFO - 'LANG': 'en_US.UTF-8', 09:42:51 INFO - 'LANGUAGE': 'en_US:en', 09:42:51 INFO - 'LOGNAME': 'cltbld', 09:42:51 INFO - 'MAIL': '/var/mail/cltbld', 09:42:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:42:51 INFO - 'MOZ_NO_REMOTE': '1', 09:42:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:42:51 INFO - 'NO_EM_RESTART': '1', 09:42:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:42:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:42:51 INFO - 'PWD': '/builds/slave/test', 09:42:51 INFO - 'SHELL': '/bin/bash', 09:42:51 INFO - 'SHLVL': '1', 09:42:51 INFO - 'TERM': 'linux', 09:42:51 INFO - 'TMOUT': '86400', 09:42:51 INFO - 'USER': 'cltbld', 09:42:51 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1507304343.542987-240953618', 09:42:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:42:51 INFO - '_': '/tools/buildbot/bin/python'} 09:42:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:42:51 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:42:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:42:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:42:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:42:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:42:52 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:42:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:42:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:42:52 INFO - Installing collected packages: mozsystemmonitor 09:42:52 INFO - Running setup.py install for mozsystemmonitor 09:42:52 INFO - Successfully installed mozsystemmonitor 09:42:52 INFO - Cleaning up... 09:42:53 INFO - Return code: 0 09:42:53 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:42: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')]} 09:42:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:42: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')]} 09:42:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:42: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', '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 0xcfb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1066a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a090>, '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 0x106ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1064f90>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1507304343.542987-240953618', '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 09:42: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:42: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 jsonschema==2.5.1 09:42:53 INFO - Using env: {'DISPLAY': ':0', 09:42:53 INFO - 'HOME': '/home/cltbld', 09:42:53 INFO - 'LANG': 'en_US.UTF-8', 09:42:53 INFO - 'LANGUAGE': 'en_US:en', 09:42:53 INFO - 'LOGNAME': 'cltbld', 09:42:53 INFO - 'MAIL': '/var/mail/cltbld', 09:42:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:42:53 INFO - 'MOZ_NO_REMOTE': '1', 09:42:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:42:53 INFO - 'NO_EM_RESTART': '1', 09:42:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:42:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:42:53 INFO - 'PWD': '/builds/slave/test', 09:42:53 INFO - 'SHELL': '/bin/bash', 09:42:53 INFO - 'SHLVL': '1', 09:42:53 INFO - 'TERM': 'linux', 09:42:53 INFO - 'TMOUT': '86400', 09:42:53 INFO - 'USER': 'cltbld', 09:42:53 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1507304343.542987-240953618', 09:42:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:42:53 INFO - '_': '/tools/buildbot/bin/python'} 09:42:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:42:53 INFO - Downloading/unpacking jsonschema==2.5.1 09:42:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:42:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:42:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:42:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:42:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:42:54 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:42: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 09:42: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 09:42: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 09:42: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 09:42:55 INFO - Downloading functools32-3.2.3-2.tar.gz 09:42:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:42:55 INFO - warning: no files found matching '*.txt' 09:42:55 INFO - no previously-included directories found matching 'build' 09:42:55 INFO - no previously-included directories found matching 'dist' 09:42:55 INFO - no previously-included directories found matching '.git*' 09:42:55 INFO - Installing collected packages: jsonschema, functools32 09:42:55 INFO - Running setup.py install for functools32 09:42:55 INFO - warning: no files found matching '*.txt' 09:42:55 INFO - no previously-included directories found matching 'build' 09:42:55 INFO - no previously-included directories found matching 'dist' 09:42:55 INFO - no previously-included directories found matching '.git*' 09:42:56 INFO - Successfully installed jsonschema functools32 09:42:56 INFO - Cleaning up... 09:42:56 INFO - Return code: 0 09:42:56 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:42:56 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')]} 09:42:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:42:56 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')]} 09:42:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:42:56 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 0xcfb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1066a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a090>, '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 0x106ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1064f90>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1507304343.542987-240953618', '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 09:42:56 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 09:42:56 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 09:42:56 INFO - Using env: {'DISPLAY': ':0', 09:42:56 INFO - 'HOME': '/home/cltbld', 09:42:56 INFO - 'LANG': 'en_US.UTF-8', 09:42:56 INFO - 'LANGUAGE': 'en_US:en', 09:42:56 INFO - 'LOGNAME': 'cltbld', 09:42:56 INFO - 'MAIL': '/var/mail/cltbld', 09:42:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:42:56 INFO - 'MOZ_NO_REMOTE': '1', 09:42:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:42:56 INFO - 'NO_EM_RESTART': '1', 09:42:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:42:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:42:56 INFO - 'PWD': '/builds/slave/test', 09:42:56 INFO - 'SHELL': '/bin/bash', 09:42:56 INFO - 'SHLVL': '1', 09:42:56 INFO - 'TERM': 'linux', 09:42:56 INFO - 'TMOUT': '86400', 09:42:56 INFO - 'USER': 'cltbld', 09:42:56 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1507304343.542987-240953618', 09:42:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:42:56 INFO - '_': '/tools/buildbot/bin/python'} 09:42:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:42:56 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:42:56 INFO - Cleaning up... 09:42:56 INFO - Return code: 0 09:42:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:42:56 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')]} 09:42:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:42:56 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')]} 09:42:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:42:56 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 0xcfb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1066a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a090>, '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 0x106ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1064f90>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1507304343.542987-240953618', '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 09:42:56 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 09:42:56 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 09:42:56 INFO - Using env: {'DISPLAY': ':0', 09:42:56 INFO - 'HOME': '/home/cltbld', 09:42:56 INFO - 'LANG': 'en_US.UTF-8', 09:42:56 INFO - 'LANGUAGE': 'en_US:en', 09:42:56 INFO - 'LOGNAME': 'cltbld', 09:42:56 INFO - 'MAIL': '/var/mail/cltbld', 09:42:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:42:56 INFO - 'MOZ_NO_REMOTE': '1', 09:42:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:42:56 INFO - 'NO_EM_RESTART': '1', 09:42:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:42:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:42:56 INFO - 'PWD': '/builds/slave/test', 09:42:56 INFO - 'SHELL': '/bin/bash', 09:42:56 INFO - 'SHLVL': '1', 09:42:56 INFO - 'TERM': 'linux', 09:42:56 INFO - 'TMOUT': '86400', 09:42:56 INFO - 'USER': 'cltbld', 09:42:56 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1507304343.542987-240953618', 09:42:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:42:56 INFO - '_': '/tools/buildbot/bin/python'} 09:42:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:42:56 INFO - Downloading/unpacking blobuploader==1.2.4 09:42:56 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 09:42:56 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 09:42:56 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 09:42:56 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 09:42:57 INFO - Downloading blobuploader-1.2.4.tar.gz 09:42:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:42:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:42:57 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 09:42:57 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 09:42:57 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 09:42:57 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 09:42:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:42:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:42:58 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 09:42:58 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 09:42:58 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 09:42:58 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 09:42:58 INFO - Downloading docopt-0.6.1.tar.gz 09:42:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:42:58 INFO - Installing collected packages: blobuploader, requests, docopt 09:42:58 INFO - Running setup.py install for blobuploader 09:42:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:42:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:42:58 INFO - Running setup.py install for requests 09:42:58 INFO - Running setup.py install for docopt 09:42:58 INFO - Successfully installed blobuploader requests docopt 09:42:58 INFO - Cleaning up... 09:42:58 INFO - Return code: 0 09:42:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:42:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:42:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:42:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:42:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:42:58 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 0xcfb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1066a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a090>, '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 0x106ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1064f90>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1507304343.542987-240953618', '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 09:42:58 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 09:42:58 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 09:42:58 INFO - Using env: {'DISPLAY': ':0', 09:42:58 INFO - 'HOME': '/home/cltbld', 09:42:58 INFO - 'LANG': 'en_US.UTF-8', 09:42:58 INFO - 'LANGUAGE': 'en_US:en', 09:42:58 INFO - 'LOGNAME': 'cltbld', 09:42:58 INFO - 'MAIL': '/var/mail/cltbld', 09:42:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:42:58 INFO - 'MOZ_NO_REMOTE': '1', 09:42:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:42:58 INFO - 'NO_EM_RESTART': '1', 09:42:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:42:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:42:58 INFO - 'PWD': '/builds/slave/test', 09:42:58 INFO - 'SHELL': '/bin/bash', 09:42:58 INFO - 'SHLVL': '1', 09:42:58 INFO - 'TERM': 'linux', 09:42:58 INFO - 'TMOUT': '86400', 09:42:58 INFO - 'USER': 'cltbld', 09:42:58 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1507304343.542987-240953618', 09:42:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:42:58 INFO - '_': '/tools/buildbot/bin/python'} 09:42:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:42:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:42:59 INFO - Running setup.py (path:/tmp/pip-AmdXJL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:42:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:42:59 INFO - Running setup.py (path:/tmp/pip-Bazwsx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:42:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:42:59 INFO - Running setup.py (path:/tmp/pip-EcrnVO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:42:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:42:59 INFO - Running setup.py (path:/tmp/pip-0I7K0K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:42:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:42:59 INFO - Running setup.py (path:/tmp/pip-1P5b4l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:42:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:42:59 INFO - Running setup.py (path:/tmp/pip-kXaJbY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:42:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:42:59 INFO - Running setup.py (path:/tmp/pip-4ft_r0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:42:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:42:59 INFO - Running setup.py (path:/tmp/pip-ruVsXV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:42:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:42:59 INFO - Running setup.py (path:/tmp/pip-VtQPTu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:42:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:42:59 INFO - Running setup.py (path:/tmp/pip-CJetzk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:42:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:42:59 INFO - Running setup.py (path:/tmp/pip-OBTRcF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:42:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:42:59 INFO - Running setup.py (path:/tmp/pip-a1FOxR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:42:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:42:59 INFO - Running setup.py (path:/tmp/pip-lefjtv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:42:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:42:59 INFO - Running setup.py (path:/tmp/pip-vyecYJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:43:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:43:00 INFO - Running setup.py (path:/tmp/pip-0lBTuU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:43:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:43:00 INFO - Running setup.py (path:/tmp/pip-I6LnD8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:43:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:43:00 INFO - Running setup.py (path:/tmp/pip-6LwvqJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:43:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:43:00 INFO - Running setup.py install for manifestparser 09:43:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:43:00 INFO - Running setup.py install for mozcrash 09:43:00 INFO - Running setup.py install for mozdebug 09:43:00 INFO - Running setup.py install for mozdevice 09:43:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:43:00 INFO - Running setup.py install for mozfile 09:43:00 INFO - Running setup.py install for mozhttpd 09:43:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:43:00 INFO - Running setup.py install for mozinfo 09:43:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:43:00 INFO - Running setup.py install for mozInstall 09:43:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:43:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:43:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:43:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:43:01 INFO - Running setup.py install for mozleak 09:43:01 INFO - Running setup.py install for mozlog 09:43:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:43:01 INFO - Running setup.py install for moznetwork 09:43:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:43:01 INFO - Running setup.py install for mozprocess 09:43:01 INFO - Running setup.py install for mozprofile 09:43:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:43:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:43:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:43:01 INFO - Running setup.py install for mozrunner 09:43:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:43:01 INFO - Running setup.py install for mozscreenshot 09:43:01 INFO - Running setup.py install for moztest 09:43:01 INFO - Running setup.py install for mozversion 09:43:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:43:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:43:01 INFO - Cleaning up... 09:43:02 INFO - Return code: 0 09:43:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:43:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:43:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:43:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:43:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:43:02 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 0xcfb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1066a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a090>, '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 0x106ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1064f90>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1507304343.542987-240953618', '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 09:43:02 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 09:43:02 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 09:43:02 INFO - Using env: {'DISPLAY': ':0', 09:43:02 INFO - 'HOME': '/home/cltbld', 09:43:02 INFO - 'LANG': 'en_US.UTF-8', 09:43:02 INFO - 'LANGUAGE': 'en_US:en', 09:43:02 INFO - 'LOGNAME': 'cltbld', 09:43:02 INFO - 'MAIL': '/var/mail/cltbld', 09:43:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:43:02 INFO - 'MOZ_NO_REMOTE': '1', 09:43:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:43:02 INFO - 'NO_EM_RESTART': '1', 09:43:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:43:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:43:02 INFO - 'PWD': '/builds/slave/test', 09:43:02 INFO - 'SHELL': '/bin/bash', 09:43:02 INFO - 'SHLVL': '1', 09:43:02 INFO - 'TERM': 'linux', 09:43:02 INFO - 'TMOUT': '86400', 09:43:02 INFO - 'USER': 'cltbld', 09:43:02 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1507304343.542987-240953618', 09:43:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:43:02 INFO - '_': '/tools/buildbot/bin/python'} 09:43:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:43:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:43:02 INFO - Running setup.py (path:/tmp/pip-4HdUAF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:43:02 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)) 09:43:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:43:02 INFO - Running setup.py (path:/tmp/pip-hJaKbZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:43:02 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)) 09:43:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:43:02 INFO - Running setup.py (path:/tmp/pip-JWiCk9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:43:02 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)) 09:43:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:43:02 INFO - Running setup.py (path:/tmp/pip-EG6PmD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:43:02 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)) 09:43:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:43:02 INFO - Running setup.py (path:/tmp/pip-coQPSj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:43:02 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)) 09:43:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:43:02 INFO - Running setup.py (path:/tmp/pip-kdlra7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:43:02 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)) 09:43:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:43:02 INFO - Running setup.py (path:/tmp/pip-_Pyp9s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:43:02 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)) 09:43:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:43:02 INFO - Running setup.py (path:/tmp/pip-xGIpRc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:43:02 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)) 09:43:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:43:02 INFO - Running setup.py (path:/tmp/pip-MLhCXx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:43:02 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)) 09:43:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:43:02 INFO - Running setup.py (path:/tmp/pip-yeXp5V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:43:02 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)) 09:43:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:43:02 INFO - Running setup.py (path:/tmp/pip-WvYb4k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:43:03 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)) 09:43:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:43:03 INFO - Running setup.py (path:/tmp/pip-0f1SOM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:43:03 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)) 09:43:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:43:03 INFO - Running setup.py (path:/tmp/pip-1GcKtj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:43:03 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)) 09:43:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:43:03 INFO - Running setup.py (path:/tmp/pip-BwDY7d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:43:03 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)) 09:43:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:43:03 INFO - Running setup.py (path:/tmp/pip-DZYWcv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:43:03 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)) 09:43:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:43:03 INFO - Running setup.py (path:/tmp/pip-9QVExq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:43:03 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)) 09:43:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:43:03 INFO - Running setup.py (path:/tmp/pip-gCe3rN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:43:03 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)) 09:43:03 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)) 09:43:03 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)) 09:43:03 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)) 09:43:03 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)) 09:43:03 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)) 09:43:03 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)) 09:43:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:43:03 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 09:43:03 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 09:43:03 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 09:43:03 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 09:43:04 INFO - Downloading blessings-1.6.tar.gz 09:43:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:43:04 INFO - Installing collected packages: blessings 09:43:04 INFO - Running setup.py install for blessings 09:43:04 INFO - Successfully installed blessings 09:43:04 INFO - Cleaning up... 09:43:04 INFO - Return code: 0 09:43:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:43:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:43:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:43:04 INFO - Reading from file tmpfile_stdout 09:43:04 INFO - Current package versions: 09:43:04 INFO - argparse == 1.2.1 09:43:04 INFO - blessings == 1.6 09:43:04 INFO - blobuploader == 1.2.4 09:43:04 INFO - docopt == 0.6.1 09:43:04 INFO - functools32 == 3.2.3-2 09:43:04 INFO - jsonschema == 2.5.1 09:43:04 INFO - manifestparser == 1.1 09:43:04 INFO - mozInstall == 1.13 09:43:04 INFO - mozcrash == 1.0 09:43:04 INFO - mozdebug == 0.1 09:43:04 INFO - mozdevice == 0.51 09:43:04 INFO - mozfile == 1.2 09:43:04 INFO - mozhttpd == 0.7 09:43:04 INFO - mozinfo == 0.10 09:43:04 INFO - mozleak == 0.1 09:43:04 INFO - mozlog == 3.5 09:43:04 INFO - moznetwork == 0.27 09:43:04 INFO - mozprocess == 0.25 09:43:04 INFO - mozprofile == 0.28 09:43:04 INFO - mozrunner == 6.13 09:43:04 INFO - mozscreenshot == 0.1 09:43:04 INFO - mozsystemmonitor == 0.3 09:43:04 INFO - moztest == 0.8 09:43:04 INFO - mozversion == 1.4 09:43:04 INFO - psutil == 3.1.1 09:43:04 INFO - requests == 1.2.3 09:43:04 INFO - wsgiref == 0.1.2 09:43:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:43: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')]} 09:43:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:43:05 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')]} 09:43:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:43:05 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 0xcfb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1066a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a090>, '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 0x106ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1064f90>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1507304343.542987-240953618', '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 09:43:05 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 09:43:05 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 09:43:05 INFO - Using env: {'DISPLAY': ':0', 09:43:05 INFO - 'HOME': '/home/cltbld', 09:43:05 INFO - 'LANG': 'en_US.UTF-8', 09:43:05 INFO - 'LANGUAGE': 'en_US:en', 09:43:05 INFO - 'LOGNAME': 'cltbld', 09:43:05 INFO - 'MAIL': '/var/mail/cltbld', 09:43:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:43:05 INFO - 'MOZ_NO_REMOTE': '1', 09:43:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:43:05 INFO - 'NO_EM_RESTART': '1', 09:43:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:43:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:43:05 INFO - 'PWD': '/builds/slave/test', 09:43:05 INFO - 'SHELL': '/bin/bash', 09:43:05 INFO - 'SHLVL': '1', 09:43:05 INFO - 'TERM': 'linux', 09:43:05 INFO - 'TMOUT': '86400', 09:43:05 INFO - 'USER': 'cltbld', 09:43:05 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1507304343.542987-240953618', 09:43:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:43:05 INFO - '_': '/tools/buildbot/bin/python'} 09:43:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:43:05 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)) 09:43:05 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)) 09:43:05 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)) 09:43:05 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)) 09:43:05 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)) 09:43:05 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)) 09:43:05 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)) 09:43:05 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)) 09:43:05 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)) 09:43:05 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 09:43:05 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 09:43:05 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 09:43:05 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 09:43:05 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 09:43:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 09:43:06 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)) 09:43:06 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)) 09:43:06 INFO - Installing collected packages: simplejson 09:43:06 INFO - Running setup.py install for simplejson 09:43:06 INFO - building 'simplejson._speedups' extension 09:43:06 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 09:43:07 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 09:43:07 INFO - Successfully installed simplejson 09:43:07 INFO - Cleaning up... 09:43:07 INFO - Return code: 0 09:43:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:43:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:43:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:43:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:43:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:43:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xcfb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1066a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a090>, '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 0x106ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1064f90>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1507304343.542987-240953618', '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 09:43:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:43:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:43:07 INFO - Using env: {'DISPLAY': ':0', 09:43:07 INFO - 'HOME': '/home/cltbld', 09:43:07 INFO - 'LANG': 'en_US.UTF-8', 09:43:07 INFO - 'LANGUAGE': 'en_US:en', 09:43:07 INFO - 'LOGNAME': 'cltbld', 09:43:07 INFO - 'MAIL': '/var/mail/cltbld', 09:43:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:43:07 INFO - 'MOZ_NO_REMOTE': '1', 09:43:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:43:07 INFO - 'NO_EM_RESTART': '1', 09:43:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:43:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:43:07 INFO - 'PWD': '/builds/slave/test', 09:43:07 INFO - 'SHELL': '/bin/bash', 09:43:07 INFO - 'SHLVL': '1', 09:43:07 INFO - 'TERM': 'linux', 09:43:07 INFO - 'TMOUT': '86400', 09:43:07 INFO - 'USER': 'cltbld', 09:43:07 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1507304343.542987-240953618', 09:43:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:43:07 INFO - '_': '/tools/buildbot/bin/python'} 09:43:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:43:07 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:43:07 INFO - Cleaning up... 09:43:07 INFO - Return code: 0 09:43:07 INFO - Running post-action listener: _resource_record_post_action 09:43:07 INFO - Running post-action listener: _start_resource_monitoring 09:43:07 INFO - Starting resource monitoring. 09:43:07 INFO - [mozharness: 2017-10-06 16:43:07.733590Z] Finished create-virtualenv step (success) 09:43:07 INFO - [mozharness: 2017-10-06 16:43:07.734105Z] Running install step. 09:43:07 INFO - Running pre-action listener: _resource_record_pre_action 09:43:07 INFO - Running main action method: install 09:43:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:43:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:43:07 INFO - Reading from file tmpfile_stdout 09:43:07 INFO - Detecting whether we're running mozinstall >=1.0... 09:43:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:43:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:43:08 INFO - Reading from file tmpfile_stdout 09:43:08 INFO - Output received: 09:43:08 INFO - Usage: mozinstall [options] installer 09:43:08 INFO - Options: 09:43:08 INFO - -h, --help show this help message and exit 09:43:08 INFO - -d DEST, --destination=DEST 09:43:08 INFO - Directory to install application into. [default: 09:43:08 INFO - "/builds/slave/test"] 09:43:08 INFO - --app=APP Application being installed. [default: firefox] 09:43:08 INFO - mkdir: /builds/slave/test/build/application 09:43:08 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'] 09:43:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 09:43:22 INFO - Reading from file tmpfile_stdout 09:43:22 INFO - Output received: 09:43:22 INFO - /builds/slave/test/build/application/firefox/firefox 09:43:22 INFO - Running post-action listener: _resource_record_post_action 09:43:22 INFO - [mozharness: 2017-10-06 16:43:22.684082Z] Finished install step (success) 09:43:22 INFO - [mozharness: 2017-10-06 16:43:22.684335Z] Running setup-mitmproxy step. 09:43:22 INFO - Running pre-action listener: _resource_record_pre_action 09:43:22 INFO - Running main action method: setup_mitmproxy 09:43:22 INFO - Skipping: mitmproxy is not required 09:43:22 INFO - Running post-action listener: _resource_record_post_action 09:43:22 INFO - [mozharness: 2017-10-06 16:43:22.685481Z] Finished setup-mitmproxy step (success) 09:43:22 INFO - [mozharness: 2017-10-06 16:43:22.685703Z] Running run-tests step. 09:43:22 INFO - Running pre-action listener: _resource_record_pre_action 09:43:22 INFO - Running pre-action listener: _set_gcov_prefix 09:43:22 INFO - Running main action method: run_tests 09:43:22 WARNING - Try message not found. 09:43:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:43:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:43:22 INFO - Python 2.7.3 09:43:22 INFO - Return code: 0 09:43:22 INFO - grabbing minidump binary from tooltool 09:43:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:43:22 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 0x106a090>, '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 0x106ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1064f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:43:22 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 09:43:22 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 09:43:22 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 09:43:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:43:22 INFO - Return code: 0 09:43:22 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:43:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:43:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:43:22 INFO - ENV: RUST_BACKTRACE is now full 09:43:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:43:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:43:22 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/R_hXeSiJQPSOG6y2jN0pBw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--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 09:43:22 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/R_hXeSiJQPSOG6y2jN0pBw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-051 --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 09:43:22 INFO - Using env: {'DISPLAY': ':0', 09:43:22 INFO - 'HOME': '/home/cltbld', 09:43:22 INFO - 'LANG': 'en_US.UTF-8', 09:43:22 INFO - 'LANGUAGE': 'en_US:en', 09:43:22 INFO - 'LOGNAME': 'cltbld', 09:43:22 INFO - 'MAIL': '/var/mail/cltbld', 09:43:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:43:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:43:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:43:22 INFO - 'MOZ_NO_REMOTE': '1', 09:43:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:43:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:43:22 INFO - 'NO_EM_RESTART': '1', 09:43:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:43:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:43:22 INFO - 'PWD': '/builds/slave/test', 09:43:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:43:22 INFO - 'RUST_BACKTRACE': 'full', 09:43:22 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 09:43:22 INFO - 'SHELL': '/bin/bash', 09:43:22 INFO - 'SHLVL': '1', 09:43:22 INFO - 'TERM': 'linux', 09:43:22 INFO - 'TMOUT': '86400', 09:43:22 INFO - 'USER': 'cltbld', 09:43:22 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1507304343.542987-240953618', 09:43:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:43:22 INFO - '_': '/tools/buildbot/bin/python'} 09:43:22 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/R_hXeSiJQPSOG6y2jN0pBw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--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 09:43:23 INFO - mozversion application_buildid: 20171006141922 09:43:23 INFO - mozversion application_changeset: c5e550fbf12843a9189e5f6708f384d4133d6161 09:43:23 INFO - mozversion application_display_name: Firefox 09:43:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:43:23 INFO - mozversion application_name: Firefox 09:43:23 INFO - mozversion application_remotingname: firefox 09:43:23 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 09:43:23 INFO - mozversion application_vendor: Mozilla 09:43:23 INFO - mozversion application_version: 57.0 09:43:23 INFO - mozversion platform_buildid: 20171006141922 09:43:23 INFO - mozversion platform_changeset: c5e550fbf12843a9189e5f6708f384d4133d6161 09:43:23 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 09:43:23 INFO - mozversion platform_version: 57.0 09:43:23 INFO - using testdate: 1507308203 09:43:23 INFO - actual date: 1507308203 09:43:23 INFO - starting webserver on 'localhost:57333' 09:43:23 INFO - SUITE-START | Running 2 tests 09:43:23 INFO - TEST-START | dromaeo_css 09:43:23 INFO - Initialising browser for dromaeo_css test... 09:43:23 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:57333/getInfo.html -profile /tmp/tmp5PfQa9/profile 09:43:23 INFO - TEST-INFO | started process 20429 (/builds/slave/test/build/application/firefox/firefox http://localhost:57333/getInfo.html) 09:43:28 INFO - TEST-INFO | 20429: exit 0 09:43:28 INFO - Browser initialized. 09:43:28 INFO - Running cycle 1/1 for dromaeo_css test... 09:43:28 INFO - Using env: {'DISPLAY': ':0', 09:43:28 INFO - 'HOME': '/home/cltbld', 09:43:28 INFO - 'JSGC_DISABLE_POISONING': '1', 09:43:28 INFO - 'LANG': 'en_US.UTF-8', 09:43:28 INFO - 'LANGUAGE': 'en_US:en', 09:43:28 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 09:43:28 INFO - 'LOGNAME': 'cltbld', 09:43:28 INFO - 'MAIL': '/var/mail/cltbld', 09:43:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:43:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:43:28 INFO - 'MOZ_CRASHREPORTER': '1', 09:43:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:43:28 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 09:43:28 INFO - 'MOZ_NO_REMOTE': '1', 09:43:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:43:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:43:28 INFO - 'NO_EM_RESTART': '1', 09:43:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:43:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:43:28 INFO - 'PWD': '/builds/slave/test', 09:43:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:43:28 INFO - 'RUST_BACKTRACE': 'full', 09:43:28 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 09:43:28 INFO - 'SHELL': '/bin/bash', 09:43:28 INFO - 'SHLVL': '1', 09:43:28 INFO - 'TERM': 'linux', 09:43:28 INFO - 'TMOUT': '86400', 09:43:28 INFO - 'USER': 'cltbld', 09:43:28 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1507304343.542987-240953618', 09:43:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:43:28 INFO - '_': '/tools/buildbot/bin/python'} 09:43:28 INFO - TEST-INFO | started process 20664 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5PfQa9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 09:43:29 INFO - PID 20664 | 09:43:29 INFO - PID 20664 | (/builds/slave/test/build/application/firefox/firefox:20713): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 09:43:29 INFO - PID 20664 | 09:43:39 INFO - PID 20664 | RSS: Main: 141328384 09:43:39 INFO - PID 20664 | 09:46:37 INFO - PID 20664 | Cycle 1(1): loaded http://localhost:57333/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57333/tests/dromaeo/cssquery-ext.html) 09:46:38 INFO - PID 20664 | RSS: Main: 145653760 09:46:38 INFO - PID 20664 | 09:49:39 INFO - PID 20664 | Cycle 1(1): loaded http://localhost:57333/tests/dromaeo/cssquery-ext.html (next: http://localhost:57333/tests/dromaeo/cssquery-jquery.html) 09:49:40 INFO - PID 20664 | RSS: Main: 144093184 09:49:40 INFO - PID 20664 | 09:52:41 INFO - PID 20664 | Cycle 1(1): loaded http://localhost:57333/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57333/tests/dromaeo/cssquery-mootools.html) 09:52:42 INFO - PID 20664 | RSS: Main: 145727488 09:52:42 INFO - PID 20664 | 09:55:44 INFO - PID 20664 | Cycle 1(1): loaded http://localhost:57333/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57333/tests/dromaeo/cssquery-prototype.html) 09:55:44 INFO - PID 20664 | RSS: Main: 145248256 09:55:44 INFO - PID 20664 | 09:58:47 INFO - PID 20664 | Cycle 1(1): loaded http://localhost:57333/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57333/tests/dromaeo/cssquery-yui.html) 09:58:48 INFO - PID 20664 | RSS: Main: 146468864 09:58:48 INFO - PID 20664 | 10:01:49 INFO - PID 20664 | Cycle 1(1): loaded http://localhost:57333/tests/dromaeo/cssquery-yui.html (next: http://localhost:57333/tests/dromaeo/cssquery-dojo.html) 10:01:49 INFO - PID 20664 | RSS: Main: 146853888 10:01:49 INFO - PID 20664 | 10:01:49 INFO - PID 20664 | __start_tp_report 10:01:49 INFO - PID 20664 | _x_x_mozilla_page_load 10:01:49 INFO - PID 20664 | _x_x_mozilla_page_load_details 10:01:49 INFO - PID 20664 | |i|pagename|runs| 10:01:49 INFO - PID 20664 | |0;dojo.html;4003.859864904729;4006.078601921558;4006.078601921558;4009.358502639578;4026.959730402696;6414.198225221848;6478.093066970628;6556.0165975103755;6576.605403675777;6607.537472376929;6438.967805160968;6510.80467585972;6545.149130613014;6588.670566471681;6594.736210551584;5678.5741069419955;5829.766809327622;5838;5847.386024467433;5864.70676466175;5791.971040144794;5809.651420914737;5853.5317174625925;5893.58744887858;5919.526437884959;5798.333191682968;5819.243498345209;5828.650280983134;5849.210356601847;5856.795012174574;5800.303963524404;5814.796482123126;5838.211841401441;5847.356790753014;5862.501687356601;5765.509931655814;5789.884202315972;5857;5865.85335366615;5869.50109240715;6334.651594162319;6410.974244120918;6422.42198202164;6480.2547707013355;6522.93477065228;7049.506534542584;7061.293870612898;7067.717291308341;7078.362947334713;7087.929120708778;7100.644967751643;7108.218096009435;7178.174509931372;7196.136463624399;7210.2789721028;6498.772542960974;6596.142501474777;6600.174978127734;6601.075849381091;6624.93375066248;7240.2035776064595;7312.415006799443;7312.670929808065;7323.304286092813;7325.523840950321;6953.304669533108;6964.338387853146;7043.225245223021;7047.330503602149;7050.964745176241;6961.338672826073;7029.718811247493;7049.118860142482;7098.183708873443;7127.4298056155385;6925.757598484029;6993.19578248508;7007.824804379931;7028.753993610199;7029.92970070303;6922.169339679271;7039.788806335818;7085.114360704912;7100.822479437952;7105.609191494517;5277.894442111136;5278;5331.040412725669;5341.893162136736;5358.27663265462;4737.194676904935;4770.95229047712;4815.590674792682;4818.253170758538;4853.781579828917;6552.6068435894;6578.703958321887;6582.539222254492;6585.5719378240265;6588.439982601437;6953.582785032914;7042.049323341385;7112.0754301940415;7124.323189297009;7164.283571642794;6434.678266086677;6452.580582262138;6511.837204069841;6512.185976752906;6598.307177746267;6065.423784740443;6074.817755467343;6086.208792856989;6094.908576371358;6102.389761023862;7286.890696639554;7312.106350668383;7315.30504602062;7409.925900741031;7420.295071968154;6994.985727069445;7089.220185779457;7147.035150254753;7157.033800436874;7173.892391614026;7225.24134965821;7314.232005639331;7323.304286092813;7336.889946650911;7411.777646670608;6839.863202736017;6954.756583519553;6976;6977.476689248429;7035.261297563887;6937.445004399737;6989.907460093964;7067.363937245467;7093.609851458219;7110.5022648414115;6816.454683625398;6924.619145947021;6934.826629334307;6936.098307220231;6945.722171113301;6846.520743547904;6856.657167141722;6938.583684978716;6939.132608423947;6944.791656250321;6673.833154171185;6723.630200338833;6746.325367463411;6791.252962174256;6880.9655951721925;6931.68807403658;6958.443324533924;6971.51199416036;6991.720331186695;7006.649667516502;6711.194656641234;6739.663016849236;6811.9659401702675;6815.148106486689;6821.454283657196 10:01:49 INFO - PID 20664 | |1;ext.html;962.1052421248237;983.6704703924185;1017.7048655889793;1034.5086084110044;1038.2213339995003;44643;45114.54885451144;45273;45475;45501.54498455014;41772.37341439873;42003.36994945078;42057.369139462855;42062;42120.15759684805;7998.360131189505;8087.069986951487;8117.107118217021;8161.183881611821;8204.425690201688;8080.272775450208;8102.797430064266;8109.391795615323;8110.310623597002;8118.10700822909;8111.797205069862;8113.797155071112;8116.553589552572;8128.674853005873;8755.430896991707;8808.295336373107;8880.689175878877;8883.73348799537;8886.86669699955;8894.59974301158;8736.388452808305;8811.559422028937;8818.074102219303;8821.426607270507;8843.425177363515;41469;41518.377224341355;41542.37686434706;41654.583454165375;41719.791401043105;3869.9806500967597;3877.9030524236837;3898.8635397761227;3903.5315762108444;3934.03616114051;34032.31935361279;34257.14357141066;34281.45733442001;34320.48519272213;34372.82813585941;5648.4633959773755;5723.627964182315;5744.770209191627;5789.478946894799;5838.5329173666005;233109;234421;234808;235015;235189;53781.46218537843;54149;54205.72897135489;54244;54381;55385.16922246169;55615.16577251344;55652.16521752177;55710.44289557134;55780;16814.66370672604;17056.061916594706;17117;17245.22396492136;17247.56881077983;14176.716465670628;14214.360353784105;14227.07524010936;14257.073290236101;14263.78604320936;14764;14946;15271.770923436157;15287.312070956834;15429.228538573027;5815.563832712563;5829.387914268941;5857.326407463196;5976;6007.098935159674;1086.684861390188;1118.59730497021;1134.5518520184646;1136.7669627726295;1142.5315620595516;26142.046020520123;26179.607305890047;26246.60630090512;26282.73717262803;26361.868190658923;1247.4947646203302;1248.6815861955142;1252.7995520716643;1256.8177614245883;1261.413442749126;13621.591352259447;13780.931095344458;13790.724185516234;13820.93089534566;13991;287359;288396;290475;292415;293252;49767.25349119766;51233;57388.139177912366;57615.13577296344;60025.399746002855;1485.576610665955;1492.9776053359208;1498.3107770425727;1498.7601983682775;1558.0340189082842;30512.08463746091;30962.53556196614;31346.05961821149;31540.526892097096;31658.525122123647;43095.35356969711;43112.35331469968;43121.56878431301;43134;43281.783591083105;248796;249710;251376;252140;253040;36178.09554761152;37088.07279818026;37240.255194895406;37432.81283593565;37516;46774;48123;48317.75841120913;48610.75694621504;48634.270485942034;35454.64545354617;35905.46141807927;36025.63974360223;36257.27485450329;36444.635553644126;35847;36048;36317.27365452729;36385.63614363928;36576.63423365732;40835.79582102071;41543.58456415397;41697.37453938133;41782.37326440166;42000.369994449495;34361;34962;34989.650103498636;35160.47259291061;35249.29501409906;25527.744722552536;25626.487470250864;25905.481890362465;25932.092376767476;26791 10:01:49 INFO - PID 20664 | |2;jquery.html;624.8937680594298;627.8650090230602;636.8871052172397;647.1393047247162;648.779957932989;24166.87916560417;24301.63547546784;24820.751792482093;25122.49755004899;25382.746172538267;26391.20826375207;27474;27507.449851002966;27515.17454476364;27518.587221191647;6563.803085907431;6724.394804467597;6867.313268673142;6923.723051077951;6927;6744;6765.932340676604;6770.356816102462;6778.423833974118;6781.389674929255;6714.194296684404;6723.8655226895435;6750.189977202743;6766.763163289286;6768.221654509721;6736.865262694719;6752.223494298145;6759.797206083826;6768.255491895888;6791.626460544668;6296.96851515744;6304.558680892339;6305.5901366411035;6318.33657465964;6321.74713011479;30801;31198.22004449884;32920.670793292;33174.502382464285;33209.3358132836;2385.2844146755906;2403.42317843718;2405.7353691093967;2422.043292899295;2422.442838147236;20627.48431289215;21095.15619375223;21229.469263268387;21455.892720536296;21652.89173554138;2540.809439292042;2571.1515199984146;2581.8063645226493;2600.362911086796;2606.2051074422293;145723;150039;163513;170570;171237;16426.671466570602;17024.48926532206;17385.913070434566;17502.649947000988;17548.122593870256;27394.178174654793;27396;27431.314217144733;27440;27447.725522744917;11369.658910232707;11480.712982175512;11495.367754773568;11570.537178512934;11680.94159529197;10400.843987340197;10476.214283928735;10504;10535.84196237057;10584.312019718695;10126.392416455037;10140.898591014144;10167.186625069977;10175.44035078063;10176.440295783803;2796.1692481300342;2926.25380527964;2933.7652987761353;2948.2187220386613;3035.195673146618;1030.6083688198587;1053.942033188182;1062.1821197677746;1064.824303989833;1066.8826429092794;22387.32838014862;22663.660045099336;22684.092636294365;22837.20069797549;22871.542569148525;1088.7604726960055;1105.7788442311569;1109.8668159820872;1116.6873275482878;1121.5065371236792;12301.384930753427;12466.626001219978;12607.306598137007;12645;12677.112602117948;619017;625628;635897;640689;653063;135306;137026.31486842703;140368;140474.2976285112;140860;1111.7832022755647;1158.0793269350886;1202.104432198018;1210.7396909664287;1235.425527129889;23112.306630801104;23562.882185588962;23614.763852361943;23695.170669026502;23763.287101386984;65257.67371163114;65859.67070164619;65866.67066664636;66624.66687666725;68727;78434;79670;82729.58635207026;83400.58299708462;84012;16588.917055414644;16989.660206795546;17022.82977170262;17037.148142592574;17115.315387384864;25577.744222557536;25612.871935640203;26189.476210476067;26191.73808261893;26736.331591710365;20831.270905518235;20957.476063098544;21261.68107478358;21337;21421.25025624158;18328.908355458138;18557.44327670172;18761.437156885317;18795.34216302423;19162.808371916104;20490.692639610716;21229.46926326854;21464.570708586052;21475.785242148002;21880.452988674773;16436.260368283696;16618.50144495667;16630.25163867653;16721.665566688356;16760.916195418944;20515;20752;20942.685859712423;20948.790512094685;20986.790132099093 10:01:49 INFO - PID 20664 | |3;mootools.html;1482.4514929476093;1524.7484165112764;1543.7993060902077;1544.5057581573901;1561.0945651522118;17558.736618950727;18146.909265453687;18167.091645417724;18168;18189.909050454764;17970.550736231602;17977.910110449462;18110;18135.72796408055;18185.45443636693;3097.1792474994145;3114.19031051927;3136.9529457058047;3145.921351966196;3151.4800057990406;3094.8143111413387;3116.937661246785;3118.5166299223656;3121.968780312202;3126.937461250785;3023.7883348165637;3057.4343746406876;3058.923526911834;3059.556364327171;3063.9693603063906;2970.55441683747;3012.7439167670773;3013.5931649227405;3014.3669829335868;3015.1256135720723;2831.886724531016;2891.0604053682428;2900;2902.7097290271017;2908.200244932639;16685.582860428465;17043.233054512453;17045.23296451663;17062.402815901507;17076;8045.396595255379;8288.336933045342;8298.543580103093;8298.8340233195;8300.958495207486;5499.890002199933;5641.661500309994;5838.153467747153;5897.498712609433;5944.138099975479;2071.7617473990535;2145.3671167005614;2150.290404166621;2186.5954798362195;2201.2075652764993;29274.853625731947;30128.849355753082;32075.198120047186;32541.67458325434;32572.18569535757;7563.546187228784;7629.580373079423;7677.424193185422;7779.7666070017995;7885.605719713992;23839.284821455385;23861.52276954486;23862.7613723864;23894;23902.52194956126;8769.605367758466;8776.25401840838;8780.517071560998;8800.91199088001;8801.955990220136;7624.656890439833;7884.566348850868;7936.56348900816;7941.64262608184;7947.3244774194845;6161.7227224775;6450.161479007699;6495.902561461582;6530.608163510205;6548.116004339448;2005.7593088829433;2006.418138739749;2022.1709099269228;2045.1614837916384;2064.215598072723;958.8897276813116;962.8988956159642;977.8728765260471;983.5770618633914;986.2110311750571;8675.262602678842;8708.69519566812;8717.782055448664;8765.605547750367;8931.464112153291;781.5076501803941;788.7655818643918;798.8482188384188;804.5052292839862;811.6063709101081;4887;4929.3345398371475;5000.374953130859;5012.097822392005;5058.873528161826;25647;26744.866275668886;26751.732482674925;26846;26874.193774186806;25813.483730325665;26323.73676263213;26390;26430.339241519116;26586.46827063448;11411.315321080761;11753.236039657566;12643.114981951176;12689.365531723377;12782.488700452064;9498.09768072032;9582.472963987047;9607.087326703951;9643.710688679352;10031.29780915358;21525.784742153006;21641.891790540947;22429.887850560644;22986.54026919486;23417.648735268645;22563.210287639853;22876.4280892979;22942.770572294063;22944.885275573517;23038.769612303662;15608.84391156074;16077.19614019271;16175.43385981532;16196.595085122966;16199.109049002418;15812.446564370191;15950.361985520449;16077.11575863292;16089.275982581046;16263.75604365959;12448;12461.626151215478;12837;12865.871341286842;12903.161294515827;12268;12409.441575129322;12468.875311246771;12794.552190673281;12926.870731292567;10333.638322658671;10431.37411755297;10462.319949203278;10498.212634052325;10521.105706014769;8067.919320806717;8074.3540516759695;8170.959145204473;8176.427650064438;8286;7552;7664;7754.728584499516;7766.5728384939375;7766.611669416619 10:01:49 INFO - PID 20664 | |4;prototype.html;566.8894565559717;577.2697537614918;588.6821116597038;594.4827999640313;600.141797229961;6436.324185960471;6468.870622587551;6502.479801615871;6511.739530418789;6533.901991470126;6390.968045159768;6413.903791443132;6423.747369262996;6443.420092191702;6465.612063276207;5083.161278389061;5179.948200517984;5225.320708307915;5241.449647786984;5270;5103.744812759366;5146.562542183919;5166.505140527746;5179.352580927384;5182.844514664547;5094.312267843849;5109.3613298337705;5110.540051395374;5165.8450246492475;5166.974165129169;5126.256692779526;5146.706108090825;5151.716655583941;5166.095933211673;5173.9741301293625;4682.1103990241745;4717.528247175289;4726.929096063562;4732.432108147044;4750.572448479654;6435.967820160916;6442.25914019889;6445.709943052574;6488.480921526267;6501.837454063639;6131.325554189036;6146.094710639716;6158.291796443422;6159.414855588712;6160.014397696392;6933.272006439302;6965.65171741416;6969;6990.580565166056;7015.4036906862975;5063.26582645518;5283.788648454057;5321.946780532184;5331.706756128411;5339.866503337447;6914.239433662293;6945.583265004116;6967.930320696779;7077.3984211341585;7082.185548661918;5352.946470535323;5366;5390.164524498709;5423.674579525241;5455.781768729285;5420.430854760272;5456.6725996439545;5470.972645136829;5477.917831232535;5542.97228513863;5989.520838332923;6066.666333351708;6093.177421048191;6110.044785668632;6110.969445152746;6896.2069362023;6910.44716422685;6916.4092258780765;6944.236134025253;7018.613976231356;1852.4442667199787;1861.4415675297357;1875.0999520230366;1912.502749285196;1922.5674223299925;1311.9737605247842;1347.7641412752926;1348.730253949214;1350.2910971739916;1361.319340329835;6221.640314230265;6274.6548939807835;6282.968585157045;6305.464035556937;6390.4248617624635;6755.763548275787;6807.5575087619145;6807.625580593115;6883.690233939485;6966.12371340064;6354.618722876642;6377.840553986095;6392.808215753535;6396.360363963567;6437.7103030362805;3659.634036596319;3693.649103335179;3695.74129810916;3712.7215458840155;3735.6824669903363;7180.605066721276;7269.491135620456;7282.927170728331;7316.487845850739;7318.194998550155;7007.964960175268;7054.20314186348;7078.25678303781;7142.000119983207;7216.087736749765;6922.376986071277;7055.576665400093;7114.64426778659;7269.491135620456;7304.561726296439;6923.203831559234;6972.1284839395075;6985;6994.195667498303;7026.437884969292;6793.0410800115205;6841.760538381132;6921.826954326182;6953.860922781617;6992.3357281058215;7163.928360716326;7197;7201.783946481614;7225.783226503213;7237.601931893796;5388.191771234347;5413.269208656939;5435.320584926884;5443.564514838724;5447.782088716407;6769.864602707819;6946.756863509955;6972.477064220305;7009.474289428415;7051.612161331176;6420.711068002044;6716.361945615354;6763.323667633197;6777.661116944035;6825.658717064226;6641.236257830411;6727.495437842083;6794.286599906938;6804.4216241620015;6821.420179284618;6688.197416310074;6701.1623547056615;6703;6779.322067793181;6845.212800528003;6745.86508269822;6822.3859852613505;6841.24746277919;6892.551984121016;6938.363421899646;6432.549721519449;6656.334366563305;6657.600543967377;6668.899966500409;6698.832529186614 10:01:49 INFO - PID 20664 | |5;yui.html;987.5259875259875;1015.0661391519801;1022.2180032275306;1037.8806437259707;1039.7972395382901;21978.89010554947;22271.777282227195;24363.756362436372;24377.878110609443;24425.145119920806;21337.35987920365;21705.457363565918;23277.95249213785;23314.41713957152;23421;1050.569266600694;1080.9081228095622;1081.864766904137;1082.7726177502695;1082.832161015044;1092.579356947577;1093.491526440209;1094.8248280275157;1132.0943245403685;1132.1112926352814;1176.9529218831237;1177.1995043370505;1178.6228406909793;1186.22895118173;1186.4483015397839;1161.3612513117794;1161.57021901896;1165.2833507392893;1167.0605162843908;1167.6088510349086;839.6725277141919;847.2501835875295;854.0605334132466;856.3192262151605;857.2113655437013;20524.179032838667;21121.577568448545;21346.786532134636;21507.354779356487;21942.89028554847;22528.662070068964;22876.428089297733;22897.42756431086;23172.65241021386;23187.3043808686;17292.56768580783;17296.56758581033;17361.47915562535;17383.73924391135;17408.129593520272;3800.1259710266795;4143.482064741907;4169.915821886331;4182.2890108681295;4185.016521117535;153378;153775;154125;156143;158176;15902.76145857813;16081.758773618405;16176.514704558882;16238.837611623969;16264.674706505804;35765.46351804725;35772.46341304883;36004.279914401566;36268.09329766777;36321.273574528364;10031.69904902854;10032.498375081363;10070.345427547187;10077.395356278646;10159.847602285972;4982.327385802942;5005.324281221989;5137.12668846297;5151.278820965068;5158.845234642967;6288.496920246369;6362.936370636327;6383.170187875639;6406.519511036691;6413.358664133642;1087.6519513755522;1107.900288973996;1129.9830502542468;1132.416805345248;1143.9656810295705;755.5617741709796;767.7888580640257;780.812604974802;781.1680560203365;790.5809920742016;14008.85991140096;14112.364943577564;14120.929395352958;14236.217008064656;14434.422623095168;763.4312437234296;763.8885421711396;769.7575263791888;776.9728059517889;777.8794286885542;6504.154459920274;6508.316626754217;6523.380278873499;6555;6625.701843417058;155316;155428;156244.43755562298;157506;157728.21135894247;132688;137709.3114534421;137946.31026844803;139305;139696;119167.8083219174;120710;121756.39121804334;121910.3904480472;122105.38947305384;12178.208416452902;12234.327112008568;12375.443105060474;12444.31556264378;12579.433925473193;55669.44330556643;56380.15429768475;57186;57715.134272986776;58343;71701.64149179221;71722.28277717365;71905.28094718987;73201;73895.26104739099;17327.91336043312;18010.459686209433;18109.36617218391;18170.72743908869;18199;19057.90471047636;19078.141483633546;19248.23007079757;19308.710369344753;19326.226950921806;13938.512152074629;14223.644408889446;14280.571582852532;14388.568342949728;14435.855641443872;17715.645687086442;17876.821231787515;18033.09834508243;18098.90950545239;18247.635047298714;18335;18359.35742249015;18390.63218735591;18429.26282948667;18670.43988680342;13523.391447385087;13530.729385412433;13582.93208533951;13734.381952812348;13787.310634468437;13125.803112953123;13402.26287554194;13416.64254558904;13554.72890542164;13568.38942247621 10:01:49 INFO - PID 20664 | __end_tp_report 10:01:49 INFO - PID 20664 | __start_cc_report 10:01:49 INFO - PID 20664 | _x_x_mozilla_cycle_collect,240 10:01:49 INFO - PID 20664 | __end_cc_report 10:01:49 INFO - PID 20664 | __startTimestamp1507309309917__endTimestamp 10:01:49 INFO - PID 20664 | 10:01:49 INFO - PID 20664 | ------- Summary: start ------- 10:01:49 INFO - PID 20664 | Number of tests: 6 10:01:49 INFO - PID 20664 | 10:01:49 INFO - PID 20664 | [#0] dojo.html Cycles:165 Average:6526.19 Median:6815.15 stddev:757.21 (11.1%) stddev-sans-first:733.22 10:01:49 INFO - PID 20664 | Values: 4003.9 4006.1 4006.1 4009.4 4027.0 6414.2 6478.1 6556.0 6576.6 6607.5 6439.0 6510.8 6545.1 6588.7 6594.7 5678.6 5829.8 5838.0 5847.4 5864.7 5792.0 5809.7 5853.5 5893.6 5919.5 5798.3 5819.2 5828.7 5849.2 5856.8 5800.3 5814.8 5838.2 5847.4 5862.5 5765.5 5789.9 5857.0 5865.9 5869.5 6334.7 6411.0 6422.4 6480.3 6522.9 7049.5 7061.3 7067.7 7078.4 7087.9 7100.6 7108.2 7178.2 7196.1 7210.3 6498.8 6596.1 6600.2 6601.1 6624.9 7240.2 7312.4 7312.7 7323.3 7325.5 6953.3 6964.3 7043.2 7047.3 7051.0 6961.3 7029.7 7049.1 7098.2 7127.4 6925.8 6993.2 7007.8 7028.8 7029.9 6922.2 7039.8 7085.1 7100.8 7105.6 5277.9 5278.0 5331.0 5341.9 5358.3 4737.2 4771.0 4815.6 4818.3 4853.8 6552.6 6578.7 6582.5 6585.6 6588.4 6953.6 7042.0 7112.1 7124.3 7164.3 6434.7 6452.6 6511.8 6512.2 6598.3 6065.4 6074.8 6086.2 6094.9 6102.4 7286.9 7312.1 7315.3 7409.9 7420.3 6995.0 7089.2 7147.0 7157.0 7173.9 7225.2 7314.2 7323.3 7336.9 7411.8 6839.9 6954.8 6976.0 6977.5 7035.3 6937.4 6989.9 7067.4 7093.6 7110.5 6816.5 6924.6 6934.8 6936.1 6945.7 6846.5 6856.7 6938.6 6939.1 6944.8 6673.8 6723.6 6746.3 6791.3 6881.0 6931.7 6958.4 6971.5 6991.7 7006.6 6711.2 6739.7 6812.0 6815.1 6821.5 10:01:49 INFO - PID 20664 | 10:01:49 INFO - PID 20664 | [#1] ext.html Cycles:180 Average:44090.77 Median:37336.53 stddev:67466.78 (180.7%) stddev-sans-first:67578.32 10:01:49 INFO - PID 20664 | Values: 962.1 983.7 1017.7 1034.5 1038.2 44643.0 45114.5 45273.0 45475.0 45501.5 41772.4 42003.4 42057.4 42062.0 42120.2 7998.4 8087.1 8117.1 8161.2 8204.4 8080.3 8102.8 8109.4 8110.3 8118.1 8111.8 8113.8 8116.6 8128.7 8755.4 8808.3 8880.7 8883.7 8886.9 8894.6 8736.4 8811.6 8818.1 8821.4 8843.4 41469.0 41518.4 41542.4 41654.6 41719.8 3870.0 3877.9 3898.9 3903.5 3934.0 34032.3 34257.1 34281.5 34320.5 34372.8 5648.5 5723.6 5744.8 5789.5 5838.5 233109.0 234421.0 234808.0 235015.0 235189.0 53781.5 54149.0 54205.7 54244.0 54381.0 55385.2 55615.2 55652.2 55710.4 55780.0 16814.7 17056.1 17117.0 17245.2 17247.6 14176.7 14214.4 14227.1 14257.1 14263.8 14764.0 14946.0 15271.8 15287.3 15429.2 5815.6 5829.4 5857.3 5976.0 6007.1 1086.7 1118.6 1134.6 1136.8 1142.5 26142.0 26179.6 26246.6 26282.7 26361.9 1247.5 1248.7 1252.8 1256.8 1261.4 13621.6 13780.9 13790.7 13820.9 13991.0 287359.0 288396.0 290475.0 292415.0 293252.0 49767.3 51233.0 57388.1 57615.1 60025.4 1485.6 1493.0 1498.3 1498.8 1558.0 30512.1 30962.5 31346.1 31540.5 31658.5 43095.4 43112.4 43121.6 43134.0 43281.8 248796.0 249710.0 251376.0 252140.0 253040.0 36178.1 37088.1 37240.3 37432.8 37516.0 46774.0 48123.0 48317.8 48610.8 48634.3 35454.6 35905.5 36025.6 36257.3 36444.6 35847.0 36048.0 36317.3 36385.6 36576.6 40835.8 41543.6 41697.4 41782.4 42000.4 34361.0 34962.0 34989.7 35160.5 35249.3 25527.7 25626.5 25905.5 25932.1 26791.0 10:01:49 INFO - PID 20664 | 10:01:49 INFO - PID 20664 | [#2] jquery.html Cycles:180 Average:41944.94 Median:23337.59 stddev:106314.54 (455.6%) stddev-sans-first:106567.51 10:01:49 INFO - PID 20664 | Values: 624.9 627.9 636.9 647.1 648.8 24166.9 24301.6 24820.8 25122.5 25382.7 26391.2 27474.0 27507.4 27515.2 27518.6 6563.8 6724.4 6867.3 6923.7 6927.0 6744.0 6765.9 6770.4 6778.4 6781.4 6714.2 6723.9 6750.2 6766.8 6768.2 6736.9 6752.2 6759.8 6768.3 6791.6 6297.0 6304.6 6305.6 6318.3 6321.7 30801.0 31198.2 32920.7 33174.5 33209.3 2385.3 2403.4 2405.7 2422.0 2422.4 20627.5 21095.2 21229.5 21455.9 21652.9 2540.8 2571.2 2581.8 2600.4 2606.2 145723.0 150039.0 163513.0 170570.0 171237.0 16426.7 17024.5 17385.9 17502.6 17548.1 27394.2 27396.0 27431.3 27440.0 27447.7 11369.7 11480.7 11495.4 11570.5 11680.9 10400.8 10476.2 10504.0 10535.8 10584.3 10126.4 10140.9 10167.2 10175.4 10176.4 2796.2 2926.3 2933.8 2948.2 3035.2 1030.6 1053.9 1062.2 1064.8 1066.9 22387.3 22663.7 22684.1 22837.2 22871.5 1088.8 1105.8 1109.9 1116.7 1121.5 12301.4 12466.6 12607.3 12645.0 12677.1 619017.0 625628.0 635897.0 640689.0 653063.0 135306.0 137026.3 140368.0 140474.3 140860.0 1111.8 1158.1 1202.1 1210.7 1235.4 23112.3 23562.9 23614.8 23695.2 23763.3 65257.7 65859.7 65866.7 66624.7 68727.0 78434.0 79670.0 82729.6 83400.6 84012.0 16588.9 16989.7 17022.8 17037.1 17115.3 25577.7 25612.9 26189.5 26191.7 26736.3 20831.3 20957.5 21261.7 21337.0 21421.3 18328.9 18557.4 18761.4 18795.3 19162.8 20490.7 21229.5 21464.6 21475.8 21880.5 16436.3 16618.5 16630.3 16721.7 16760.9 20515.0 20752.0 20942.7 20948.8 20986.8 10:01:49 INFO - PID 20664 | 10:01:49 INFO - PID 20664 | [#3] mootools.html Cycles:180 Average:10924.10 Median:16091.53 stddev:8250.15 (51.3%) stddev-sans-first:8242.80 10:01:49 INFO - PID 20664 | Values: 1482.5 1524.7 1543.8 1544.5 1561.1 17558.7 18146.9 18167.1 18168.0 18189.9 17970.6 17977.9 18110.0 18135.7 18185.5 3097.2 3114.2 3137.0 3145.9 3151.5 3094.8 3116.9 3118.5 3122.0 3126.9 3023.8 3057.4 3058.9 3059.6 3064.0 2970.6 3012.7 3013.6 3014.4 3015.1 2831.9 2891.1 2900.0 2902.7 2908.2 16685.6 17043.2 17045.2 17062.4 17076.0 8045.4 8288.3 8298.5 8298.8 8301.0 5499.9 5641.7 5838.2 5897.5 5944.1 2071.8 2145.4 2150.3 2186.6 2201.2 29274.9 30128.8 32075.2 32541.7 32572.2 7563.5 7629.6 7677.4 7779.8 7885.6 23839.3 23861.5 23862.8 23894.0 23902.5 8769.6 8776.3 8780.5 8800.9 8802.0 7624.7 7884.6 7936.6 7941.6 7947.3 6161.7 6450.2 6495.9 6530.6 6548.1 2005.8 2006.4 2022.2 2045.2 2064.2 958.9 962.9 977.9 983.6 986.2 8675.3 8708.7 8717.8 8765.6 8931.5 781.5 788.8 798.8 804.5 811.6 4887.0 4929.3 5000.4 5012.1 5058.9 25647.0 26744.9 26751.7 26846.0 26874.2 25813.5 26323.7 26390.0 26430.3 26586.5 11411.3 11753.2 12643.1 12689.4 12782.5 9498.1 9582.5 9607.1 9643.7 10031.3 21525.8 21641.9 22429.9 22986.5 23417.6 22563.2 22876.4 22942.8 22944.9 23038.8 15608.8 16077.2 16175.4 16196.6 16199.1 15812.4 15950.4 16077.1 16089.3 16263.8 12448.0 12461.6 12837.0 12865.9 12903.2 12268.0 12409.4 12468.9 12794.6 12926.9 10333.6 10431.4 10462.3 10498.2 10521.1 8067.9 8074.4 8171.0 8176.4 8286.0 7552.0 7664.0 7754.7 7766.6 7766.6 10:01:49 INFO - PID 20664 | 10:01:49 INFO - PID 20664 | [#4] prototype.html Cycles:180 Average:5825.03 Median:6437.02 stddev:1617.19 (25.1%) stddev-sans-first:1572.83 10:01:49 INFO - PID 20664 | Values: 566.9 577.3 588.7 594.5 600.1 6436.3 6468.9 6502.5 6511.7 6533.9 6391.0 6413.9 6423.7 6443.4 6465.6 5083.2 5179.9 5225.3 5241.4 5270.0 5103.7 5146.6 5166.5 5179.4 5182.8 5094.3 5109.4 5110.5 5165.8 5167.0 5126.3 5146.7 5151.7 5166.1 5174.0 4682.1 4717.5 4726.9 4732.4 4750.6 6436.0 6442.3 6445.7 6488.5 6501.8 6131.3 6146.1 6158.3 6159.4 6160.0 6933.3 6965.7 6969.0 6990.6 7015.4 5063.3 5283.8 5321.9 5331.7 5339.9 6914.2 6945.6 6967.9 7077.4 7082.2 5352.9 5366.0 5390.2 5423.7 5455.8 5420.4 5456.7 5471.0 5477.9 5543.0 5989.5 6066.7 6093.2 6110.0 6111.0 6896.2 6910.4 6916.4 6944.2 7018.6 1852.4 1861.4 1875.1 1912.5 1922.6 1312.0 1347.8 1348.7 1350.3 1361.3 6221.6 6274.7 6283.0 6305.5 6390.4 6755.8 6807.6 6807.6 6883.7 6966.1 6354.6 6377.8 6392.8 6396.4 6437.7 3659.6 3693.6 3695.7 3712.7 3735.7 7180.6 7269.5 7282.9 7316.5 7318.2 7008.0 7054.2 7078.3 7142.0 7216.1 6922.4 7055.6 7114.6 7269.5 7304.6 6923.2 6972.1 6985.0 6994.2 7026.4 6793.0 6841.8 6921.8 6953.9 6992.3 7163.9 7197.0 7201.8 7225.8 7237.6 5388.2 5413.3 5435.3 5443.6 5447.8 6769.9 6946.8 6972.5 7009.5 7051.6 6420.7 6716.4 6763.3 6777.7 6825.7 6641.2 6727.5 6794.3 6804.4 6821.4 6688.2 6701.2 6703.0 6779.3 6845.2 6745.9 6822.4 6841.2 6892.6 6938.4 6432.5 6656.3 6657.6 6668.9 6698.8 10:01:49 INFO - PID 20664 | 10:01:49 INFO - PID 20664 | [#5] yui.html Cycles:180 Average:28950.34 Median:17796.23 stddev:43221.09 (242.9%) stddev-sans-first:43291.34 10:01:49 INFO - PID 20664 | Values: 987.5 1015.1 1022.2 1037.9 1039.8 21978.9 22271.8 24363.8 24377.9 24425.1 21337.4 21705.5 23278.0 23314.4 23421.0 1050.6 1080.9 1081.9 1082.8 1082.8 1092.6 1093.5 1094.8 1132.1 1132.1 1177.0 1177.2 1178.6 1186.2 1186.4 1161.4 1161.6 1165.3 1167.1 1167.6 839.7 847.3 854.1 856.3 857.2 20524.2 21121.6 21346.8 21507.4 21942.9 22528.7 22876.4 22897.4 23172.7 23187.3 17292.6 17296.6 17361.5 17383.7 17408.1 3800.1 4143.5 4169.9 4182.3 4185.0 153378.0 153775.0 154125.0 156143.0 158176.0 15902.8 16081.8 16176.5 16238.8 16264.7 35765.5 35772.5 36004.3 36268.1 36321.3 10031.7 10032.5 10070.3 10077.4 10159.8 4982.3 5005.3 5137.1 5151.3 5158.8 6288.5 6362.9 6383.2 6406.5 6413.4 1087.7 1107.9 1130.0 1132.4 1144.0 755.6 767.8 780.8 781.2 790.6 14008.9 14112.4 14120.9 14236.2 14434.4 763.4 763.9 769.8 777.0 777.9 6504.2 6508.3 6523.4 6555.0 6625.7 155316.0 155428.0 156244.4 157506.0 157728.2 132688.0 137709.3 137946.3 139305.0 139696.0 119167.8 120710.0 121756.4 121910.4 122105.4 12178.2 12234.3 12375.4 12444.3 12579.4 55669.4 56380.2 57186.0 57715.1 58343.0 71701.6 71722.3 71905.3 73201.0 73895.3 17327.9 18010.5 18109.4 18170.7 18199.0 19057.9 19078.1 19248.2 19308.7 19326.2 13938.5 14223.6 14280.6 14388.6 14435.9 17715.6 17876.8 18033.1 18098.9 18247.6 18335.0 18359.4 18390.6 18429.3 18670.4 13523.4 13530.7 13582.9 13734.4 13787.3 13125.8 13402.3 13416.6 13554.7 13568.4 10:01:49 INFO - PID 20664 | -------- Summary: end -------- 10:01:49 INFO - PID 20664 | 10:01:50 INFO - TEST-INFO | 20664: exit 0 10:01:50 INFO - TEST-OK | dromaeo_css | took 1107481ms 10:01:50 INFO - TEST-START | kraken 10:01:50 INFO - Initialising browser for kraken test... 10:01:50 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:57333/getInfo.html -profile /tmp/tmpZloQhN/profile 10:01:50 INFO - TEST-INFO | started process 21026 (/builds/slave/test/build/application/firefox/firefox http://localhost:57333/getInfo.html) 10:01:55 INFO - TEST-INFO | 21026: exit 0 10:01:55 INFO - Browser initialized. 10:01:55 INFO - Running cycle 1/1 for kraken test... 10:01:55 INFO - Using env: {'DISPLAY': ':0', 10:01:55 INFO - 'HOME': '/home/cltbld', 10:01:55 INFO - 'JSGC_DISABLE_POISONING': '1', 10:01:55 INFO - 'LANG': 'en_US.UTF-8', 10:01:55 INFO - 'LANGUAGE': 'en_US:en', 10:01:55 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 10:01:55 INFO - 'LOGNAME': 'cltbld', 10:01:55 INFO - 'MAIL': '/var/mail/cltbld', 10:01:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:01:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:01:55 INFO - 'MOZ_CRASHREPORTER': '1', 10:01:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:01:55 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 10:01:55 INFO - 'MOZ_NO_REMOTE': '1', 10:01:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:01:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:01:55 INFO - 'NO_EM_RESTART': '1', 10:01:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:01:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:01:55 INFO - 'PWD': '/builds/slave/test', 10:01:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:01:55 INFO - 'RUST_BACKTRACE': 'full', 10:01:55 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 10:01:55 INFO - 'SHELL': '/bin/bash', 10:01:55 INFO - 'SHLVL': '1', 10:01:55 INFO - 'TERM': 'linux', 10:01:55 INFO - 'TMOUT': '86400', 10:01:55 INFO - 'USER': 'cltbld', 10:01:55 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1507304343.542987-240953618', 10:01:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:01:55 INFO - '_': '/tools/buildbot/bin/python'} 10:01:55 INFO - TEST-INFO | started process 21260 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZloQhN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 10:01:56 INFO - PID 21260 | 10:01:56 INFO - PID 21260 | (/builds/slave/test/build/application/firefox/firefox:21309): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 10:01:56 INFO - PID 21260 | 10:02:06 INFO - PID 21260 | RSS: Main: 143622144 10:02:06 INFO - PID 21260 | 10:02:09 INFO - PID 21260 | Cycle 1(1): loaded http://localhost:57333/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57333/tests/kraken/driver.html?testName=audio-beat-detection) 10:02:09 INFO - PID 21260 | RSS: Main: 150380544 10:02:09 INFO - PID 21260 | 10:02:12 INFO - PID 21260 | Cycle 1(1): loaded http://localhost:57333/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57333/tests/kraken/driver.html?testName=audio-dft) 10:02:13 INFO - PID 21260 | RSS: Main: 151023616 10:02:13 INFO - PID 21260 | 10:02:15 INFO - PID 21260 | Cycle 1(1): loaded http://localhost:57333/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57333/tests/kraken/driver.html?testName=audio-fft) 10:02:16 INFO - PID 21260 | RSS: Main: 152473600 10:02:16 INFO - PID 21260 | 10:02:18 INFO - PID 21260 | Cycle 1(1): loaded http://localhost:57333/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57333/tests/kraken/driver.html?testName=audio-oscillator) 10:02:19 INFO - PID 21260 | RSS: Main: 152449024 10:02:19 INFO - PID 21260 | 10:02:21 INFO - PID 21260 | Cycle 1(1): loaded http://localhost:57333/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57333/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:02:21 INFO - PID 21260 | RSS: Main: 152158208 10:02:21 INFO - PID 21260 | 10:02:24 INFO - PID 21260 | Cycle 1(1): loaded http://localhost:57333/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57333/tests/kraken/driver.html?testName=imaging-darkroom) 10:02:25 INFO - PID 21260 | RSS: Main: 151887872 10:02:25 INFO - PID 21260 | 10:02:28 INFO - PID 21260 | Cycle 1(1): loaded http://localhost:57333/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57333/tests/kraken/driver.html?testName=imaging-desaturate) 10:02:29 INFO - PID 21260 | RSS: Main: 151871488 10:02:29 INFO - PID 21260 | 10:02:32 INFO - PID 21260 | Cycle 1(1): loaded http://localhost:57333/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57333/tests/kraken/driver.html?testName=json-parse-financial) 10:02:33 INFO - PID 21260 | RSS: Main: 153395200 10:02:33 INFO - PID 21260 | 10:02:34 INFO - PID 21260 | Cycle 1(1): loaded http://localhost:57333/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57333/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:02:35 INFO - PID 21260 | RSS: Main: 153305088 10:02:35 INFO - PID 21260 | 10:02:36 INFO - PID 21260 | Cycle 1(1): loaded http://localhost:57333/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57333/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:02:37 INFO - PID 21260 | RSS: Main: 153743360 10:02:37 INFO - PID 21260 | 10:02:39 INFO - PID 21260 | Cycle 1(1): loaded http://localhost:57333/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57333/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:02:39 INFO - PID 21260 | RSS: Main: 150781952 10:02:39 INFO - PID 21260 | 10:02:42 INFO - PID 21260 | Cycle 1(1): loaded http://localhost:57333/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57333/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:02:42 INFO - PID 21260 | RSS: Main: 150548480 10:02:42 INFO - PID 21260 | 10:02:45 INFO - PID 21260 | Cycle 1(1): loaded http://localhost:57333/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57333/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:02:46 INFO - PID 21260 | RSS: Main: 151031808 10:02:46 INFO - PID 21260 | 10:02:47 INFO - PID 21260 | Cycle 1(1): loaded http://localhost:57333/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57333/tests/kraken/driver.html?testName=ai-astar) 10:02:47 INFO - PID 21260 | RSS: Main: 152612864 10:02:47 INFO - PID 21260 | 10:02:47 INFO - PID 21260 | __start_tp_report 10:02:47 INFO - PID 21260 | _x_x_mozilla_page_load 10:02:47 INFO - PID 21260 | _x_x_mozilla_page_load_details 10:02:47 INFO - PID 21260 | |i|pagename|runs| 10:02:47 INFO - PID 21260 | |0;ai-astar;104;105;104;103;105;106;104;104;105;107 10:02:47 INFO - PID 21260 | |1;audio-beat-detection;116;109;110;111;110;111;111;111;111;113 10:02:47 INFO - PID 21260 | |2;audio-dft;161;163;161;162;161;162;162;162;163;161 10:02:47 INFO - PID 21260 | |3;audio-fft;74;74;73;75;73;73;73;73;72;74 10:02:47 INFO - PID 21260 | |4;audio-oscillator;79;77;76;81;80;78;80;79;78;79 10:02:47 INFO - PID 21260 | |5;imaging-gaussian-blur;114;112;113;113;113;113;114;113;113;114 10:02:47 INFO - PID 21260 | |6;imaging-darkroom;149;148;147;152;148;150;149;150;148;148 10:02:47 INFO - PID 21260 | |7;imaging-desaturate;95;95;95;95;94;93;95;94;95;94 10:02:47 INFO - PID 21260 | |8;json-parse-financial;43;43;44;44;44;43;47;43;43;44 10:02:47 INFO - PID 21260 | |9;json-stringify-tinderbox;37;36;38;36;37;37;36;37;38;37 10:02:47 INFO - PID 21260 | |10;stanford-crypto-aes;74;70;71;70;71;69;69;70;69;70 10:02:47 INFO - PID 21260 | |11;stanford-crypto-ccm;104;99;103;108;108;113;98;106;101;100 10:02:47 INFO - PID 21260 | |12;stanford-crypto-pbkdf2;159;149;148;146;147;145;153;144;151;157 10:02:47 INFO - PID 21260 | |13;stanford-crypto-sha256-iterative;62;60;57;57;58;58;58;56;59;59 10:02:47 INFO - PID 21260 | __end_tp_report 10:02:47 INFO - PID 21260 | __start_cc_report 10:02:47 INFO - PID 21260 | _x_x_mozilla_cycle_collect,710 10:02:47 INFO - PID 21260 | __end_cc_report 10:02:47 INFO - PID 21260 | __startTimestamp1507309367973__endTimestamp 10:02:47 INFO - PID 21260 | 10:02:47 INFO - PID 21260 | ------- Summary: start ------- 10:02:47 INFO - PID 21260 | Number of tests: 14 10:02:47 INFO - PID 21260 | 10:02:47 INFO - PID 21260 | [#0] ai-astar Cycles:10 Average:104.70 Median:105.00 stddev:1.16 (1.1%) stddev-sans-first:1.20 10:02:47 INFO - PID 21260 | Values: 104.0 105.0 104.0 103.0 105.0 106.0 104.0 104.0 105.0 107.0 10:02:47 INFO - PID 21260 | 10:02:47 INFO - PID 21260 | [#1] audio-beat-detection Cycles:10 Average:111.30 Median:111.00 stddev:1.95 (1.8%) stddev-sans-first:1.09 10:02:47 INFO - PID 21260 | Values: 116.0 109.0 110.0 111.0 110.0 111.0 111.0 111.0 111.0 113.0 10:02:47 INFO - PID 21260 | 10:02:47 INFO - PID 21260 | [#2] audio-dft Cycles:10 Average:161.80 Median:162.00 stddev:0.79 (0.5%) stddev-sans-first:0.78 10:02:47 INFO - PID 21260 | Values: 161.0 163.0 161.0 162.0 161.0 162.0 162.0 162.0 163.0 161.0 10:02:47 INFO - PID 21260 | 10:02:47 INFO - PID 21260 | [#3] audio-fft Cycles:10 Average:73.40 Median:73.50 stddev:0.84 (1.1%) stddev-sans-first:0.87 10:02:47 INFO - PID 21260 | Values: 74.0 74.0 73.0 75.0 73.0 73.0 73.0 73.0 72.0 74.0 10:02:47 INFO - PID 21260 | 10:02:47 INFO - PID 21260 | [#4] audio-oscillator Cycles:10 Average:78.70 Median:79.00 stddev:1.49 (1.9%) stddev-sans-first:1.58 10:02:47 INFO - PID 21260 | Values: 79.0 77.0 76.0 81.0 80.0 78.0 80.0 79.0 78.0 79.0 10:02:47 INFO - PID 21260 | 10:02:47 INFO - PID 21260 | [#5] imaging-gaussian-blur Cycles:10 Average:113.20 Median:113.00 stddev:0.63 (0.6%) stddev-sans-first:0.60 10:02:47 INFO - PID 21260 | Values: 114.0 112.0 113.0 113.0 113.0 113.0 114.0 113.0 113.0 114.0 10:02:47 INFO - PID 21260 | 10:02:47 INFO - PID 21260 | [#6] imaging-darkroom Cycles:10 Average:148.90 Median:149.00 stddev:1.45 (1.0%) stddev-sans-first:1.54 10:02:47 INFO - PID 21260 | Values: 149.0 148.0 147.0 152.0 148.0 150.0 149.0 150.0 148.0 148.0 10:02:47 INFO - PID 21260 | 10:02:47 INFO - PID 21260 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:95.00 stddev:0.71 (0.7%) stddev-sans-first:0.73 10:02:47 INFO - PID 21260 | Values: 95.0 95.0 95.0 95.0 94.0 93.0 95.0 94.0 95.0 94.0 10:02:47 INFO - PID 21260 | 10:02:47 INFO - PID 21260 | [#8] json-parse-financial Cycles:10 Average:43.80 Median:44.00 stddev:1.23 (2.8%) stddev-sans-first:1.27 10:02:47 INFO - PID 21260 | Values: 43.0 43.0 44.0 44.0 44.0 43.0 47.0 43.0 43.0 44.0 10:02:47 INFO - PID 21260 | 10:02:47 INFO - PID 21260 | [#9] json-stringify-tinderbox Cycles:10 Average:36.90 Median:37.00 stddev:0.74 (2.0%) stddev-sans-first:0.78 10:02:47 INFO - PID 21260 | Values: 37.0 36.0 38.0 36.0 37.0 37.0 36.0 37.0 38.0 37.0 10:02:47 INFO - PID 21260 | 10:02:47 INFO - PID 21260 | [#10] stanford-crypto-aes Cycles:10 Average:70.30 Median:70.00 stddev:1.49 (2.1%) stddev-sans-first:0.78 10:02:47 INFO - PID 21260 | Values: 74.0 70.0 71.0 70.0 71.0 69.0 69.0 70.0 69.0 70.0 10:02:47 INFO - PID 21260 | 10:02:47 INFO - PID 21260 | [#11] stanford-crypto-ccm Cycles:10 Average:104.00 Median:108.00 stddev:4.76 (4.4%) stddev-sans-first:5.05 10:02:47 INFO - PID 21260 | Values: 104.0 99.0 103.0 108.0 108.0 113.0 98.0 106.0 101.0 100.0 10:02:47 INFO - PID 21260 | 10:02:47 INFO - PID 21260 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.90 Median:150.00 stddev:5.07 (3.4%) stddev-sans-first:4.17 10:02:47 INFO - PID 21260 | Values: 159.0 149.0 148.0 146.0 147.0 145.0 153.0 144.0 151.0 157.0 10:02:47 INFO - PID 21260 | 10:02:47 INFO - PID 21260 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:58.40 Median:58.50 stddev:1.71 (2.9%) stddev-sans-first:1.22 10:02:47 INFO - PID 21260 | Values: 62.0 60.0 57.0 57.0 58.0 58.0 58.0 56.0 59.0 59.0 10:02:47 INFO - PID 21260 | -------- Summary: end -------- 10:02:47 INFO - PID 21260 | 10:02:48 INFO - PID 21260 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 10:02:48 INFO - TEST-INFO | 21260: exit 0 10:02:48 INFO - TEST-OK | kraken | took 58053ms 10:02:48 INFO - SUITE-END | took 1165s 10:02:48 INFO - Completed test suite (00:19:25) 10:02:48 INFO - javascript benchmark 10:02:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9394.67819009274, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [4003.859864904729, 4006.078601921558, 4006.078601921558, 4009.358502639578, 4026.959730402696, 6414.198225221848, 6478.093066970628, 6556.0165975103755, 6576.605403675777, 6607.537472376929, 6438.967805160968, 6510.80467585972, 6545.149130613014, 6588.670566471681, 6594.736210551584, 5678.5741069419955, 5829.766809327622, 5838.0, 5847.386024467433, 5864.70676466175, 5791.971040144794, 5809.651420914737, 5853.5317174625925, 5893.58744887858, 5919.526437884959, 5798.333191682968, 5819.243498345209, 5828.650280983134, 5849.210356601847, 5856.795012174574, 5800.303963524404, 5814.796482123126, 5838.211841401441, 5847.356790753014, 5862.501687356601, 5765.509931655814, 5789.884202315972, 5857.0, 5865.85335366615, 5869.50109240715, 6334.651594162319, 6410.974244120918, 6422.42198202164, 6480.2547707013355, 6522.93477065228, 7049.506534542584, 7061.293870612898, 7067.717291308341, 7078.362947334713, 7087.929120708778, 7100.644967751643, 7108.218096009435, 7178.174509931372, 7196.136463624399, 7210.2789721028, 6498.772542960974, 6596.142501474777, 6600.174978127734, 6601.075849381091, 6624.93375066248, 7240.2035776064595, 7312.415006799443, 7312.670929808065, 7323.304286092813, 7325.523840950321, 6953.304669533108, 6964.338387853146, 7043.225245223021, 7047.330503602149, 7050.964745176241, 6961.338672826073, 7029.718811247493, 7049.118860142482, 7098.183708873443, 7127.4298056155385, 6925.757598484029, 6993.19578248508, 7007.824804379931, 7028.753993610199, 7029.92970070303, 6922.169339679271, 7039.788806335818, 7085.114360704912, 7100.822479437952, 7105.609191494517, 5277.894442111136, 5278.0, 5331.040412725669, 5341.893162136736, 5358.27663265462, 4737.194676904935, 4770.95229047712, 4815.590674792682, 4818.253170758538, 4853.781579828917, 6552.6068435894, 6578.703958321887, 6582.539222254492, 6585.5719378240265, 6588.439982601437, 6953.582785032914, 7042.049323341385, 7112.0754301940415, 7124.323189297009, 7164.283571642794, 6434.678266086677, 6452.580582262138, 6511.837204069841, 6512.185976752906, 6598.307177746267, 6065.423784740443, 6074.817755467343, 6086.208792856989, 6094.908576371358, 6102.389761023862, 7286.890696639554, 7312.106350668383, 7315.30504602062, 7409.925900741031, 7420.295071968154, 6994.985727069445, 7089.220185779457, 7147.035150254753, 7157.033800436874, 7173.892391614026, 7225.24134965821, 7314.232005639331, 7323.304286092813, 7336.889946650911, 7411.777646670608, 6839.863202736017, 6954.756583519553, 6976.0, 6977.476689248429, 7035.261297563887, 6937.445004399737, 6989.907460093964, 7067.363937245467, 7093.609851458219, 7110.5022648414115, 6816.454683625398, 6924.619145947021, 6934.826629334307, 6936.098307220231, 6945.722171113301, 6846.520743547904, 6856.657167141722, 6938.583684978716, 6939.132608423947, 6944.791656250321, 6673.833154171185, 6723.630200338833, 6746.325367463411, 6791.252962174256, 6880.9655951721925, 6931.68807403658, 6958.443324533924, 6971.51199416036, 6991.720331186695, 7006.649667516502, 6711.194656641234, 6739.663016849236, 6811.9659401702675, 6815.148106486689, 6821.454283657196], "value": 6475.804653075295, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [962.1052421248237, 983.6704703924185, 1017.7048655889793, 1034.5086084110044, 1038.2213339995003, 44643.0, 45114.54885451144, 45273.0, 45475.0, 45501.54498455014, 41772.37341439873, 42003.36994945078, 42057.369139462855, 42062.0, 42120.15759684805, 7998.360131189505, 8087.069986951487, 8117.107118217021, 8161.183881611821, 8204.425690201688, 8080.272775450208, 8102.797430064266, 8109.391795615323, 8110.310623597002, 8118.10700822909, 8111.797205069862, 8113.797155071112, 8116.553589552572, 8128.674853005873, 8755.430896991707, 8808.295336373107, 8880.689175878877, 8883.73348799537, 8886.86669699955, 8894.59974301158, 8736.388452808305, 8811.559422028937, 8818.074102219303, 8821.426607270507, 8843.425177363515, 41469.0, 41518.377224341355, 41542.37686434706, 41654.583454165375, 41719.791401043105, 3869.9806500967597, 3877.9030524236837, 3898.8635397761227, 3903.5315762108444, 3934.03616114051, 34032.31935361279, 34257.14357141066, 34281.45733442001, 34320.48519272213, 34372.82813585941, 5648.4633959773755, 5723.627964182315, 5744.770209191627, 5789.478946894799, 5838.5329173666005, 233109.0, 234421.0, 234808.0, 235015.0, 235189.0, 53781.46218537843, 54149.0, 54205.72897135489, 54244.0, 54381.0, 55385.16922246169, 55615.16577251344, 55652.16521752177, 55710.44289557134, 55780.0, 16814.66370672604, 17056.061916594706, 17117.0, 17245.22396492136, 17247.56881077983, 14176.716465670628, 14214.360353784105, 14227.07524010936, 14257.073290236101, 14263.78604320936, 14764.0, 14946.0, 15271.770923436157, 15287.312070956834, 15429.228538573027, 5815.563832712563, 5829.387914268941, 5857.326407463196, 5976.0, 6007.098935159674, 1086.684861390188, 1118.59730497021, 1134.5518520184646, 1136.7669627726295, 1142.5315620595516, 26142.046020520123, 26179.607305890047, 26246.60630090512, 26282.73717262803, 26361.868190658923, 1247.4947646203302, 1248.6815861955142, 1252.7995520716643, 1256.8177614245883, 1261.413442749126, 13621.591352259447, 13780.931095344458, 13790.724185516234, 13820.93089534566, 13991.0, 287359.0, 288396.0, 290475.0, 292415.0, 293252.0, 49767.25349119766, 51233.0, 57388.139177912366, 57615.13577296344, 60025.399746002855, 1485.576610665955, 1492.9776053359208, 1498.3107770425727, 1498.7601983682775, 1558.0340189082842, 30512.08463746091, 30962.53556196614, 31346.05961821149, 31540.526892097096, 31658.525122123647, 43095.35356969711, 43112.35331469968, 43121.56878431301, 43134.0, 43281.783591083105, 248796.0, 249710.0, 251376.0, 252140.0, 253040.0, 36178.09554761152, 37088.07279818026, 37240.255194895406, 37432.81283593565, 37516.0, 46774.0, 48123.0, 48317.75841120913, 48610.75694621504, 48634.270485942034, 35454.64545354617, 35905.46141807927, 36025.63974360223, 36257.27485450329, 36444.635553644126, 35847.0, 36048.0, 36317.27365452729, 36385.63614363928, 36576.63423365732, 40835.79582102071, 41543.58456415397, 41697.37453938133, 41782.37326440166, 42000.369994449495, 34361.0, 34962.0, 34989.650103498636, 35160.47259291061, 35249.29501409906, 25527.744722552536, 25626.487470250864, 25905.481890362465, 25932.092376767476, 26791.0], "value": 19155.617062398815, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [624.8937680594298, 627.8650090230602, 636.8871052172397, 647.1393047247162, 648.779957932989, 24166.87916560417, 24301.63547546784, 24820.751792482093, 25122.49755004899, 25382.746172538267, 26391.20826375207, 27474.0, 27507.449851002966, 27515.17454476364, 27518.587221191647, 6563.803085907431, 6724.394804467597, 6867.313268673142, 6923.723051077951, 6927.0, 6744.0, 6765.932340676604, 6770.356816102462, 6778.423833974118, 6781.389674929255, 6714.194296684404, 6723.8655226895435, 6750.189977202743, 6766.763163289286, 6768.221654509721, 6736.865262694719, 6752.223494298145, 6759.797206083826, 6768.255491895888, 6791.626460544668, 6296.96851515744, 6304.558680892339, 6305.5901366411035, 6318.33657465964, 6321.74713011479, 30801.0, 31198.22004449884, 32920.670793292, 33174.502382464285, 33209.3358132836, 2385.2844146755906, 2403.42317843718, 2405.7353691093967, 2422.043292899295, 2422.442838147236, 20627.48431289215, 21095.15619375223, 21229.469263268387, 21455.892720536296, 21652.89173554138, 2540.809439292042, 2571.1515199984146, 2581.8063645226493, 2600.362911086796, 2606.2051074422293, 145723.0, 150039.0, 163513.0, 170570.0, 171237.0, 16426.671466570602, 17024.48926532206, 17385.913070434566, 17502.649947000988, 17548.122593870256, 27394.178174654793, 27396.0, 27431.314217144733, 27440.0, 27447.725522744917, 11369.658910232707, 11480.712982175512, 11495.367754773568, 11570.537178512934, 11680.94159529197, 10400.843987340197, 10476.214283928735, 10504.0, 10535.84196237057, 10584.312019718695, 10126.392416455037, 10140.898591014144, 10167.186625069977, 10175.44035078063, 10176.440295783803, 2796.1692481300342, 2926.25380527964, 2933.7652987761353, 2948.2187220386613, 3035.195673146618, 1030.6083688198587, 1053.942033188182, 1062.1821197677746, 1064.824303989833, 1066.8826429092794, 22387.32838014862, 22663.660045099336, 22684.092636294365, 22837.20069797549, 22871.542569148525, 1088.7604726960055, 1105.7788442311569, 1109.8668159820872, 1116.6873275482878, 1121.5065371236792, 12301.384930753427, 12466.626001219978, 12607.306598137007, 12645.0, 12677.112602117948, 619017.0, 625628.0, 635897.0, 640689.0, 653063.0, 135306.0, 137026.31486842703, 140368.0, 140474.2976285112, 140860.0, 1111.7832022755647, 1158.0793269350886, 1202.104432198018, 1210.7396909664287, 1235.425527129889, 23112.306630801104, 23562.882185588962, 23614.763852361943, 23695.170669026502, 23763.287101386984, 65257.67371163114, 65859.67070164619, 65866.67066664636, 66624.66687666725, 68727.0, 78434.0, 79670.0, 82729.58635207026, 83400.58299708462, 84012.0, 16588.917055414644, 16989.660206795546, 17022.82977170262, 17037.148142592574, 17115.315387384864, 25577.744222557536, 25612.871935640203, 26189.476210476067, 26191.73808261893, 26736.331591710365, 20831.270905518235, 20957.476063098544, 21261.68107478358, 21337.0, 21421.25025624158, 18328.908355458138, 18557.44327670172, 18761.437156885317, 18795.34216302423, 19162.808371916104, 20490.692639610716, 21229.46926326854, 21464.570708586052, 21475.785242148002, 21880.452988674773, 16436.260368283696, 16618.50144495667, 16630.25163867653, 16721.665566688356, 16760.916195418944, 20515.0, 20752.0, 20942.685859712423, 20948.790512094685, 20986.790132099093], "value": 13402.412249333627, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1482.4514929476093, 1524.7484165112764, 1543.7993060902077, 1544.5057581573901, 1561.0945651522118, 17558.736618950727, 18146.909265453687, 18167.091645417724, 18168.0, 18189.909050454764, 17970.550736231602, 17977.910110449462, 18110.0, 18135.72796408055, 18185.45443636693, 3097.1792474994145, 3114.19031051927, 3136.9529457058047, 3145.921351966196, 3151.4800057990406, 3094.8143111413387, 3116.937661246785, 3118.5166299223656, 3121.968780312202, 3126.937461250785, 3023.7883348165637, 3057.4343746406876, 3058.923526911834, 3059.556364327171, 3063.9693603063906, 2970.55441683747, 3012.7439167670773, 3013.5931649227405, 3014.3669829335868, 3015.1256135720723, 2831.886724531016, 2891.0604053682428, 2900.0, 2902.7097290271017, 2908.200244932639, 16685.582860428465, 17043.233054512453, 17045.23296451663, 17062.402815901507, 17076.0, 8045.396595255379, 8288.336933045342, 8298.543580103093, 8298.8340233195, 8300.958495207486, 5499.890002199933, 5641.661500309994, 5838.153467747153, 5897.498712609433, 5944.138099975479, 2071.7617473990535, 2145.3671167005614, 2150.290404166621, 2186.5954798362195, 2201.2075652764993, 29274.853625731947, 30128.849355753082, 32075.198120047186, 32541.67458325434, 32572.18569535757, 7563.546187228784, 7629.580373079423, 7677.424193185422, 7779.7666070017995, 7885.605719713992, 23839.284821455385, 23861.52276954486, 23862.7613723864, 23894.0, 23902.52194956126, 8769.605367758466, 8776.25401840838, 8780.517071560998, 8800.91199088001, 8801.955990220136, 7624.656890439833, 7884.566348850868, 7936.56348900816, 7941.64262608184, 7947.3244774194845, 6161.7227224775, 6450.161479007699, 6495.902561461582, 6530.608163510205, 6548.116004339448, 2005.7593088829433, 2006.418138739749, 2022.1709099269228, 2045.1614837916384, 2064.215598072723, 958.8897276813116, 962.8988956159642, 977.8728765260471, 983.5770618633914, 986.2110311750571, 8675.262602678842, 8708.69519566812, 8717.782055448664, 8765.605547750367, 8931.464112153291, 781.5076501803941, 788.7655818643918, 798.8482188384188, 804.5052292839862, 811.6063709101081, 4887.0, 4929.3345398371475, 5000.374953130859, 5012.097822392005, 5058.873528161826, 25647.0, 26744.866275668886, 26751.732482674925, 26846.0, 26874.193774186806, 25813.483730325665, 26323.73676263213, 26390.0, 26430.339241519116, 26586.46827063448, 11411.315321080761, 11753.236039657566, 12643.114981951176, 12689.365531723377, 12782.488700452064, 9498.09768072032, 9582.472963987047, 9607.087326703951, 9643.710688679352, 10031.29780915358, 21525.784742153006, 21641.891790540947, 22429.887850560644, 22986.54026919486, 23417.648735268645, 22563.210287639853, 22876.4280892979, 22942.770572294063, 22944.885275573517, 23038.769612303662, 15608.84391156074, 16077.19614019271, 16175.43385981532, 16196.595085122966, 16199.109049002418, 15812.446564370191, 15950.361985520449, 16077.11575863292, 16089.275982581046, 16263.75604365959, 12448.0, 12461.626151215478, 12837.0, 12865.871341286842, 12903.161294515827, 12268.0, 12409.441575129322, 12468.875311246771, 12794.552190673281, 12926.870731292567, 10333.638322658671, 10431.37411755297, 10462.319949203278, 10498.212634052325, 10521.105706014769, 8067.919320806717, 8074.3540516759695, 8170.959145204473, 8176.427650064438, 8286.0, 7552.0, 7664.0, 7754.728584499516, 7766.5728384939375, 7766.611669416619], "value": 7574.275247984474, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [566.8894565559717, 577.2697537614918, 588.6821116597038, 594.4827999640313, 600.141797229961, 6436.324185960471, 6468.870622587551, 6502.479801615871, 6511.739530418789, 6533.901991470126, 6390.968045159768, 6413.903791443132, 6423.747369262996, 6443.420092191702, 6465.612063276207, 5083.161278389061, 5179.948200517984, 5225.320708307915, 5241.449647786984, 5270.0, 5103.744812759366, 5146.562542183919, 5166.505140527746, 5179.352580927384, 5182.844514664547, 5094.312267843849, 5109.3613298337705, 5110.540051395374, 5165.8450246492475, 5166.974165129169, 5126.256692779526, 5146.706108090825, 5151.716655583941, 5166.095933211673, 5173.9741301293625, 4682.1103990241745, 4717.528247175289, 4726.929096063562, 4732.432108147044, 4750.572448479654, 6435.967820160916, 6442.25914019889, 6445.709943052574, 6488.480921526267, 6501.837454063639, 6131.325554189036, 6146.094710639716, 6158.291796443422, 6159.414855588712, 6160.014397696392, 6933.272006439302, 6965.65171741416, 6969.0, 6990.580565166056, 7015.4036906862975, 5063.26582645518, 5283.788648454057, 5321.946780532184, 5331.706756128411, 5339.866503337447, 6914.239433662293, 6945.583265004116, 6967.930320696779, 7077.3984211341585, 7082.185548661918, 5352.946470535323, 5366.0, 5390.164524498709, 5423.674579525241, 5455.781768729285, 5420.430854760272, 5456.6725996439545, 5470.972645136829, 5477.917831232535, 5542.97228513863, 5989.520838332923, 6066.666333351708, 6093.177421048191, 6110.044785668632, 6110.969445152746, 6896.2069362023, 6910.44716422685, 6916.4092258780765, 6944.236134025253, 7018.613976231356, 1852.4442667199787, 1861.4415675297357, 1875.0999520230366, 1912.502749285196, 1922.5674223299925, 1311.9737605247842, 1347.7641412752926, 1348.730253949214, 1350.2910971739916, 1361.319340329835, 6221.640314230265, 6274.6548939807835, 6282.968585157045, 6305.464035556937, 6390.4248617624635, 6755.763548275787, 6807.5575087619145, 6807.625580593115, 6883.690233939485, 6966.12371340064, 6354.618722876642, 6377.840553986095, 6392.808215753535, 6396.360363963567, 6437.7103030362805, 3659.634036596319, 3693.649103335179, 3695.74129810916, 3712.7215458840155, 3735.6824669903363, 7180.605066721276, 7269.491135620456, 7282.927170728331, 7316.487845850739, 7318.194998550155, 7007.964960175268, 7054.20314186348, 7078.25678303781, 7142.000119983207, 7216.087736749765, 6922.376986071277, 7055.576665400093, 7114.64426778659, 7269.491135620456, 7304.561726296439, 6923.203831559234, 6972.1284839395075, 6985.0, 6994.195667498303, 7026.437884969292, 6793.0410800115205, 6841.760538381132, 6921.826954326182, 6953.860922781617, 6992.3357281058215, 7163.928360716326, 7197.0, 7201.783946481614, 7225.783226503213, 7237.601931893796, 5388.191771234347, 5413.269208656939, 5435.320584926884, 5443.564514838724, 5447.782088716407, 6769.864602707819, 6946.756863509955, 6972.477064220305, 7009.474289428415, 7051.612161331176, 6420.711068002044, 6716.361945615354, 6763.323667633197, 6777.661116944035, 6825.658717064226, 6641.236257830411, 6727.495437842083, 6794.286599906938, 6804.4216241620015, 6821.420179284618, 6688.197416310074, 6701.1623547056615, 6703.0, 6779.322067793181, 6845.212800528003, 6745.86508269822, 6822.3859852613505, 6841.24746277919, 6892.551984121016, 6938.363421899646, 6432.549721519449, 6656.334366563305, 6657.600543967377, 6668.899966500409, 6698.832529186614], "value": 5361.420384477306, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [987.5259875259875, 1015.0661391519801, 1022.2180032275306, 1037.8806437259707, 1039.7972395382901, 21978.89010554947, 22271.777282227195, 24363.756362436372, 24377.878110609443, 24425.145119920806, 21337.35987920365, 21705.457363565918, 23277.95249213785, 23314.41713957152, 23421.0, 1050.569266600694, 1080.9081228095622, 1081.864766904137, 1082.7726177502695, 1082.832161015044, 1092.579356947577, 1093.491526440209, 1094.8248280275157, 1132.0943245403685, 1132.1112926352814, 1176.9529218831237, 1177.1995043370505, 1178.6228406909793, 1186.22895118173, 1186.4483015397839, 1161.3612513117794, 1161.57021901896, 1165.2833507392893, 1167.0605162843908, 1167.6088510349086, 839.6725277141919, 847.2501835875295, 854.0605334132466, 856.3192262151605, 857.2113655437013, 20524.179032838667, 21121.577568448545, 21346.786532134636, 21507.354779356487, 21942.89028554847, 22528.662070068964, 22876.428089297733, 22897.42756431086, 23172.65241021386, 23187.3043808686, 17292.56768580783, 17296.56758581033, 17361.47915562535, 17383.73924391135, 17408.129593520272, 3800.1259710266795, 4143.482064741907, 4169.915821886331, 4182.2890108681295, 4185.016521117535, 153378.0, 153775.0, 154125.0, 156143.0, 158176.0, 15902.76145857813, 16081.758773618405, 16176.514704558882, 16238.837611623969, 16264.674706505804, 35765.46351804725, 35772.46341304883, 36004.279914401566, 36268.09329766777, 36321.273574528364, 10031.69904902854, 10032.498375081363, 10070.345427547187, 10077.395356278646, 10159.847602285972, 4982.327385802942, 5005.324281221989, 5137.12668846297, 5151.278820965068, 5158.845234642967, 6288.496920246369, 6362.936370636327, 6383.170187875639, 6406.519511036691, 6413.358664133642, 1087.6519513755522, 1107.900288973996, 1129.9830502542468, 1132.416805345248, 1143.9656810295705, 755.5617741709796, 767.7888580640257, 780.812604974802, 781.1680560203365, 790.5809920742016, 14008.85991140096, 14112.364943577564, 14120.929395352958, 14236.217008064656, 14434.422623095168, 763.4312437234296, 763.8885421711396, 769.7575263791888, 776.9728059517889, 777.8794286885542, 6504.154459920274, 6508.316626754217, 6523.380278873499, 6555.0, 6625.701843417058, 155316.0, 155428.0, 156244.43755562298, 157506.0, 157728.21135894247, 132688.0, 137709.3114534421, 137946.31026844803, 139305.0, 139696.0, 119167.8083219174, 120710.0, 121756.39121804334, 121910.3904480472, 122105.38947305384, 12178.208416452902, 12234.327112008568, 12375.443105060474, 12444.31556264378, 12579.433925473193, 55669.44330556643, 56380.15429768475, 57186.0, 57715.134272986776, 58343.0, 71701.64149179221, 71722.28277717365, 71905.28094718987, 73201.0, 73895.26104739099, 17327.91336043312, 18010.459686209433, 18109.36617218391, 18170.72743908869, 18199.0, 19057.90471047636, 19078.141483633546, 19248.23007079757, 19308.710369344753, 19326.226950921806, 13938.512152074629, 14223.644408889446, 14280.571582852532, 14388.568342949728, 14435.855641443872, 17715.645687086442, 17876.821231787515, 18033.09834508243, 18098.90950545239, 18247.635047298714, 18335.0, 18359.35742249015, 18390.63218735591, 18429.26282948667, 18670.43988680342, 13523.391447385087, 13530.729385412433, 13582.93208533951, 13734.381952812348, 13787.310634468437, 13125.803112953123, 13402.26287554194, 13416.64254558904, 13554.72890542164, 13568.38942247621], "value": 10182.909559734126, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1349.8000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 105.0, 104.0, 103.0, 105.0, 106.0, 104.0, 104.0, 105.0, 107.0], "value": 104.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 109.0, 110.0, 111.0, 110.0, 111.0, 111.0, 111.0, 111.0, 113.0], "value": 111.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 163.0, 161.0, 162.0, 161.0, 162.0, 162.0, 162.0, 163.0, 161.0], "value": 161.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 73.0, 75.0, 73.0, 73.0, 73.0, 73.0, 72.0, 74.0], "value": 73.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 77.0, 76.0, 81.0, 80.0, 78.0, 80.0, 79.0, 78.0, 79.0], "value": 78.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 112.0, 113.0, 113.0, 113.0, 113.0, 114.0, 113.0, 113.0, 114.0], "value": 113.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 148.0, 147.0, 152.0, 148.0, 150.0, 149.0, 150.0, 148.0, 148.0], "value": 148.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 94.0, 93.0, 95.0, 94.0, 95.0, 94.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [43.0, 43.0, 44.0, 44.0, 44.0, 43.0, 47.0, 43.0, 43.0, 44.0], "value": 43.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [37.0, 36.0, 38.0, 36.0, 37.0, 37.0, 36.0, 37.0, 38.0, 37.0], "value": 36.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 70.0, 71.0, 70.0, 71.0, 69.0, 69.0, 70.0, 69.0, 70.0], "value": 70.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 99.0, 103.0, 108.0, 108.0, 113.0, 98.0, 106.0, 101.0, 100.0], "value": 104.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 149.0, 148.0, 146.0, 147.0, 145.0, 153.0, 144.0, 151.0, 157.0], "value": 149.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 60.0, 57.0, 57.0, 58.0, 58.0, 58.0, 56.0, 59.0, 59.0], "value": 58.4, "unit": "score"}]}]} 10:02:48 INFO - Return code: 0 10:02:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:02:48 INFO - # TBPL SUCCESS # 10:02:48 INFO - Running post-action listener: _package_coverage_data 10:02:48 INFO - Running post-action listener: _resource_record_post_action 10:02:48 INFO - [mozharness: 2017-10-06 17:02:48.770205Z] Finished run-tests step (success) 10:02:48 INFO - Running post-run listener: _resource_record_post_run 10:02:48 INFO - Total resource usage - Wall time: 1181s; CPU: 13.0%; Read bytes: 8192; Write bytes: 290267136; Read time: 200; Write time: 222820 10:02:48 INFO - TinderboxPrint: CPU usage
13.1% 10:02:48 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 200 10:02:48 INFO - TinderboxPrint: I/O write bytes / time
290,267,136 / 222,820 10:02:48 INFO - TinderboxPrint: CPU idle
8,185.8 (86.9%) 10:02:48 INFO - TinderboxPrint: CPU user
1,180.4 (12.5%) 10:02:48 INFO - TinderboxPrint: Swap in / out
0 / 0 10:02:48 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 9142272; Read time: 0; Write time: 1296 10:02:48 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 10:02:48 INFO - run-tests - Wall time: 1166s; CPU: 13.0%; Read bytes: 8192; Write bytes: 280731648; Read time: 200; Write time: 221500 10:02:49 INFO - Running post-run listener: _upload_blobber_files 10:02:49 INFO - Blob upload gear active. 10:02:49 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:02:49 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 10:02:49 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'] 10:02:49 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 10:02:49 INFO - (blobuploader) - INFO - Open directory for files ... 10:02:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 10:02:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:02:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:02:50 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 10:02:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:02:50 INFO - (blobuploader) - INFO - Done attempting. 10:02:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:02:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:02:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:02:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:02:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:02:51 INFO - (blobuploader) - INFO - Done attempting. 10:02:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:02:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:02:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:02:58 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:02:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:02:58 INFO - (blobuploader) - INFO - Done attempting. 10:02:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:02:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:02:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:02:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:02:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:02:59 INFO - (blobuploader) - INFO - Done attempting. 10:02:59 INFO - (blobuploader) - INFO - Iteration through files over. 10:02:59 INFO - Return code: 0 10:02:59 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:02:59 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:02:59 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/7973cfaca7d3433604690ff63a3a68fcf18cac3baba4e7f5ef556ac409bd383fc7162b9725c3afd6a520af90195b481163d3181d39b9c2090fe53fa51879d579", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/6af3c1d964b47abb04e060a0770acb80b5c7df2fd63d5af5ad5ec72ce99b6dec0d9dbbc9dbd3f000d9ad2aef9d4c35b6f1f991008ce73c5974869e679be1047e", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/e5a55386a9636bcc8b99ef3e9ee91c36f9468bec2c049f124e7af4d5bb350afe3fdb97fb5115d42797de53042968d4665f2d3ce6344b13c322ee5bf95d36e780", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/afc0d7b811ac9b614414cfdf3ba36fdc38bf2aaa4224fbb9bc4e5834d942e7fb44547fa2ea447e4b27ae5e93396999207bf23b6abecc895a7ccf7b608bf4a3bd"} 10:02:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:02:59 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:02:59 INFO - Contents: 10:02:59 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/7973cfaca7d3433604690ff63a3a68fcf18cac3baba4e7f5ef556ac409bd383fc7162b9725c3afd6a520af90195b481163d3181d39b9c2090fe53fa51879d579", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/6af3c1d964b47abb04e060a0770acb80b5c7df2fd63d5af5ad5ec72ce99b6dec0d9dbbc9dbd3f000d9ad2aef9d4c35b6f1f991008ce73c5974869e679be1047e", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/e5a55386a9636bcc8b99ef3e9ee91c36f9468bec2c049f124e7af4d5bb350afe3fdb97fb5115d42797de53042968d4665f2d3ce6344b13c322ee5bf95d36e780", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/afc0d7b811ac9b614414cfdf3ba36fdc38bf2aaa4224fbb9bc4e5834d942e7fb44547fa2ea447e4b27ae5e93396999207bf23b6abecc895a7ccf7b608bf4a3bd"} 10:02:59 INFO - Running post-run listener: copy_logs_to_upload_dir 10:02:59 INFO - Copying logs to upload dir... 10:02:59 INFO - mkdir: /builds/slave/test/build/upload/logs 10:02:59 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.455722 ========= master_lag: -0.08 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2017-10-06 10:02:59.245731) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-10-06 10:02:59.248977) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1507304343.542987-240953618 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/7973cfaca7d3433604690ff63a3a68fcf18cac3baba4e7f5ef556ac409bd383fc7162b9725c3afd6a520af90195b481163d3181d39b9c2090fe53fa51879d579", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/6af3c1d964b47abb04e060a0770acb80b5c7df2fd63d5af5ad5ec72ce99b6dec0d9dbbc9dbd3f000d9ad2aef9d4c35b6f1f991008ce73c5974869e679be1047e", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/e5a55386a9636bcc8b99ef3e9ee91c36f9468bec2c049f124e7af4d5bb350afe3fdb97fb5115d42797de53042968d4665f2d3ce6344b13c322ee5bf95d36e780", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/afc0d7b811ac9b614414cfdf3ba36fdc38bf2aaa4224fbb9bc4e5834d942e7fb44547fa2ea447e4b27ae5e93396999207bf23b6abecc895a7ccf7b608bf4a3bd"} build_url:https://queue.taskcluster.net/v1/task/R_hXeSiJQPSOG6y2jN0pBw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011443 build_url: 'https://queue.taskcluster.net/v1/task/R_hXeSiJQPSOG6y2jN0pBw/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/7973cfaca7d3433604690ff63a3a68fcf18cac3baba4e7f5ef556ac409bd383fc7162b9725c3afd6a520af90195b481163d3181d39b9c2090fe53fa51879d579", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/6af3c1d964b47abb04e060a0770acb80b5c7df2fd63d5af5ad5ec72ce99b6dec0d9dbbc9dbd3f000d9ad2aef9d4c35b6f1f991008ce73c5974869e679be1047e", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/e5a55386a9636bcc8b99ef3e9ee91c36f9468bec2c049f124e7af4d5bb350afe3fdb97fb5115d42797de53042968d4665f2d3ce6344b13c322ee5bf95d36e780", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/afc0d7b811ac9b614414cfdf3ba36fdc38bf2aaa4224fbb9bc4e5834d942e7fb44547fa2ea447e4b27ae5e93396999207bf23b6abecc895a7ccf7b608bf4a3bd"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-10-06 10:02:59.281597) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-10-06 10:02:59.282029) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1507304343.542987-240953618 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004572 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-10-06 10:02:59.361503) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-10-06 10:02:59.361851) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-10-06 10:02:59.362176) ========= ========= Total master_lag: 0.09 =========