builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-017 starttime: 1506011014.23 results: success (0) revision: b14c75b83d0226333b1240466ea9f07cfb206ff3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-21 09:23:34.230609) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-21 09:23:34.231059) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-21 09:23:34.231333) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-21 09:23:34.247606) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-21 09:23:34.247994) ========= 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=0333a256a5e4f052382dd180000001b1-1506011013.417489-617014136 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-21 09:23:34-- 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% 41.6M=0s 2017-09-21 09:23:34 (41.6 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.115901 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-21 09:23:34.380631) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-21 09:23:34.380969) ========= 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=0333a256a5e4f052382dd180000001b1-1506011013.417489-617014136 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014935 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-21 09:23:34.431253) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-21 09:23:34.431639) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev b14c75b83d0226333b1240466ea9f07cfb206ff3 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev b14c75b83d0226333b1240466ea9f07cfb206ff3 --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=0333a256a5e4f052382dd180000001b1-1506011013.417489-617014136 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-21 09:23:34,483 truncating revision to first 12 chars 2017-09-21 09:23:34,483 Setting DEBUG logging. 2017-09-21 09:23:34,483 attempt 1/10 2017-09-21 09:23:34,483 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/b14c75b83d02?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-21 09:23:35,090 unpacking tar archive at: mozilla-central-b14c75b83d02/testing/mozharness/ program finished with exit code 0 elapsedTime=0.883553 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-21 09:23:35.331835) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-21 09:23:35.332226) ========= script_repo_revision: b14c75b83d0226333b1240466ea9f07cfb206ff3 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-21 09:23:35.332639) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-21 09:23:35.332946) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-21 09:23:35.346524) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2017-09-21 09:23:35.346949) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-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', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-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=0333a256a5e4f052382dd180000001b1-1506011013.417489-617014136 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:23:35 INFO - MultiFileLogger online at 20170921 09:23:35 in /builds/slave/test 09:23:35 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 09:23:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:23:35 INFO - {'append_to_log': False, 09:23:35 INFO - 'base_work_dir': '/builds/slave/test', 09:23:35 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 09:23:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:23:35 INFO - 'branch': 'Firefox-Non-PGO', 09:23:35 INFO - 'buildbot_json_path': 'buildprops.json', 09:23:35 INFO - 'code_coverage': False, 09:23:35 INFO - 'config_files': ('talos/linux_config.py',), 09:23:35 INFO - 'default_actions': ('clobber', 09:23:35 INFO - 'read-buildbot-config', 09:23:35 INFO - 'download-and-extract', 09:23:35 INFO - 'populate-webroot', 09:23:35 INFO - 'create-virtualenv', 09:23:35 INFO - 'install', 09:23:35 INFO - 'setup-mitmproxy', 09:23:35 INFO - 'run-tests'), 09:23:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:23:35 INFO - 'disable_ccov_upload': False, 09:23:35 INFO - 'disable_stylo': False, 09:23:35 INFO - 'download_minidump_stackwalk': True, 09:23:35 INFO - 'download_symbols': 'ondemand', 09:23:35 INFO - 'enable_stylo': False, 09:23:35 INFO - 'enable_webrender': False, 09:23:35 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 09:23:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:23:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:23:35 INFO - 'gecko_profile': False, 09:23:35 INFO - 'gecko_profile_interval': 0, 09:23:35 INFO - 'installer_path': 'installer.exe', 09:23:35 INFO - 'log_level': 'info', 09:23:35 INFO - 'log_name': 'talos', 09:23:35 INFO - 'log_to_console': True, 09:23:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:23:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:23:35 INFO - 'opt_config_files': (), 09:23:35 INFO - 'pip_index': False, 09:23:35 INFO - 'suite': 'dromaeojs-e10s', 09:23:35 INFO - 'system_bits': '32', 09:23:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:23:35 INFO - 'title': 'talos-linux64-ix-017', 09:23:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:23:35 INFO - 'use_talos_json': True, 09:23:35 INFO - 'verify': 'False', 09:23:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:23:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:23:35 INFO - 'work_dir': 'build'} 09:23:35 INFO - [mozharness: 2017-09-21 16:23:35.545278Z] Running clobber step. 09:23:35 INFO - Running pre-action listener: _resource_record_pre_action 09:23:35 INFO - Running main action method: clobber 09:23:35 INFO - rmtree: /builds/slave/test/build 09:23:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:23:36 INFO - Running post-action listener: _resource_record_post_action 09:23:36 INFO - [mozharness: 2017-09-21 16:23:36.562021Z] Finished clobber step (success) 09:23:36 INFO - [mozharness: 2017-09-21 16:23:36.562117Z] Running read-buildbot-config step. 09:23:36 INFO - Running pre-action listener: _resource_record_pre_action 09:23:36 INFO - Running main action method: read_buildbot_config 09:23:36 INFO - Using buildbot properties: 09:23:36 INFO - { 09:23:36 INFO - "project": "", 09:23:36 INFO - "product": "firefox", 09:23:36 INFO - "who": "archaeopteryx@coole-files.de", 09:23:36 INFO - "installer_path": "public/build/target.tar.bz2", 09:23:36 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 09:23:36 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 09:23:36 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 09:23:36 INFO - "stage_platform": "linux64", 09:23:36 INFO - "basedir": "/builds/slave/test", 09:23:36 INFO - "buildnumber": 1169, 09:23:36 INFO - "platform": "ubuntu64_hw", 09:23:36 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 09:23:36 INFO - "slavebuilddir": "test", 09:23:36 INFO - "taskId": "RiV9cLSiT7S7nITsrFgdRQ", 09:23:36 INFO - "branch": "mozilla-central", 09:23:36 INFO - "script_repo_revision": "production", 09:23:36 INFO - "revision": "b14c75b83d0226333b1240466ea9f07cfb206ff3", 09:23:36 INFO - "slavename": "talos-linux64-ix-017", 09:23:36 INFO - "repo_path": "mozilla-central" 09:23:36 INFO - } 09:23:36 INFO - Finding installer, test and symbols from parent task. 09:23:36 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RiV9cLSiT7S7nITsrFgdRQ'}, attempt #1 09:23:37 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RiV9cLSiT7S7nITsrFgdRQ'}, attempt #1 09:23:37 INFO - Task dependencies: HBJ4E0WUSRGZbfHgz26VAA 09:23:37 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HBJ4E0WUSRGZbfHgz26VAA'}, attempt #1 09:23:38 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/HBJ4E0WUSRGZbfHgz26VAA/artifacts/public/build/target.tar.bz2 09:23:38 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/HBJ4E0WUSRGZbfHgz26VAA/artifacts/public/build/target.test_packages.json 09:23:38 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/HBJ4E0WUSRGZbfHgz26VAA/artifacts/public/build/target.crashreporter-symbols.zip 09:23:38 INFO - Running post-action listener: _resource_record_post_action 09:23:38 INFO - [mozharness: 2017-09-21 16:23:38.061342Z] Finished read-buildbot-config step (success) 09:23:38 INFO - [mozharness: 2017-09-21 16:23:38.061558Z] Running download-and-extract step. 09:23:38 INFO - Running pre-action listener: _resource_record_pre_action 09:23:38 INFO - Running main action method: download_and_extract 09:23:38 INFO - mkdir: /builds/slave/test/build/tests 09:23:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:23:38 INFO - trying https://queue.taskcluster.net/v1/task/HBJ4E0WUSRGZbfHgz26VAA/artifacts/public/build/target.test_packages.json 09:23:38 INFO - Downloading https://queue.taskcluster.net/v1/task/HBJ4E0WUSRGZbfHgz26VAA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 09:23:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HBJ4E0WUSRGZbfHgz26VAA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 09:23:38 INFO - Downloaded 989 bytes. 09:23:38 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 09:23:38 INFO - Using the following test package requirements: 09:23:38 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 09:23:38 INFO - u'common': [u'target.common.tests.zip'], 09:23:38 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 09:23:38 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 09:23:38 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 09:23:38 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 09:23:38 INFO - u'mozbase': [u'target.common.tests.zip'], 09:23:38 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 09:23:38 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 09:23:38 INFO - u'web-platform': [u'target.common.tests.zip', 09:23:38 INFO - u'target.web-platform.tests.tar.gz'], 09:23:38 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 09:23:38 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 09:23:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HBJ4E0WUSRGZbfHgz26VAA/artifacts/public/build/target.common.tests.zip 09:23:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HBJ4E0WUSRGZbfHgz26VAA/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:23:38 INFO - Fetch https://queue.taskcluster.net/v1/task/HBJ4E0WUSRGZbfHgz26VAA/artifacts/public/build/target.common.tests.zip into memory 09:23:39 INFO - Content-Length response header: 54741041 09:23:39 INFO - Bytes received: 54741041 09:23:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HBJ4E0WUSRGZbfHgz26VAA/artifacts/public/build/target.talos.tests.zip 09:23:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HBJ4E0WUSRGZbfHgz26VAA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 09:23:50 INFO - Fetch https://queue.taskcluster.net/v1/task/HBJ4E0WUSRGZbfHgz26VAA/artifacts/public/build/target.talos.tests.zip into memory 09:23:51 INFO - Content-Length response header: 14509184 09:23:51 INFO - Bytes received: 14509184 09:23: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:23:51 INFO - trying https://queue.taskcluster.net/v1/task/HBJ4E0WUSRGZbfHgz26VAA/artifacts/public/build/target.tar.bz2 09:23:51 INFO - Downloading https://queue.taskcluster.net/v1/task/HBJ4E0WUSRGZbfHgz26VAA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 09:23:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HBJ4E0WUSRGZbfHgz26VAA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 09:23:52 INFO - Downloaded 61526732 bytes. 09:23:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HBJ4E0WUSRGZbfHgz26VAA/artifacts/public/build/target.tar.bz2 09:23:52 INFO - mkdir: /builds/slave/test/properties 09:23:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:23:52 INFO - Writing to file /builds/slave/test/properties/build_url 09:23:52 INFO - Contents: 09:23:52 INFO - build_url:https://queue.taskcluster.net/v1/task/HBJ4E0WUSRGZbfHgz26VAA/artifacts/public/build/target.tar.bz2 09:23:52 INFO - Running post-action listener: _resource_record_post_action 09:23:52 INFO - Running post-action listener: find_tests_for_verification 09:23:52 INFO - Running post-action listener: set_extra_try_arguments 09:23:52 INFO - [mozharness: 2017-09-21 16:23:52.712338Z] Finished download-and-extract step (success) 09:23:52 INFO - [mozharness: 2017-09-21 16:23:52.712436Z] Running populate-webroot step. 09:23:52 INFO - Running pre-action listener: _resource_record_pre_action 09:23:52 INFO - Running main action method: populate_webroot 09:23:52 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:23:52 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 09:23:52 INFO - 'tests': ['tresize', 09:23:52 INFO - 'tcanvasmark']}, 09:23:52 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:23:52 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 09:23:52 INFO - 'tests': ['dromaeo_css', 09:23:52 INFO - 'kraken']}, 09:23:52 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:23:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:23:52 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 09:23:52 INFO - 'talos_options': ['--disable-stylo'], 09:23:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:23:52 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:23:52 INFO - 'tests': ['damp', 'tps']}, 09:23:52 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 09:23:52 INFO - 'talos_options': ['--disable-stylo'], 09:23:52 INFO - 'tests': ['damp', 'tps']}, 09:23:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:23:52 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 09:23:52 INFO - 'tests': ['dromaeo_dom']}, 09:23:52 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 09:23:52 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 09:23:52 INFO - 'tests': ['basic_compositor_video', 09:23:52 INFO - 'glvideo']}, 09:23:52 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 09:23:52 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 09:23:52 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 09:23:52 INFO - 'talos_options': ['--disable-stylo'], 09:23:52 INFO - 'tests': ['ts_paint_webext', 09:23:52 INFO - 'tp5o_webext']}, 09:23:52 INFO - 'other-e10s': {'tests': ['a11yr', 09:23:52 INFO - 'ts_paint', 09:23:52 INFO - 'tpaint', 09:23:52 INFO - 'sessionrestore', 09:23:52 INFO - 'sessionrestore_many_windows', 09:23:52 INFO - 'sessionrestore_no_auto_restore', 09:23:52 INFO - 'tabpaint']}, 09:23:52 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 09:23:52 INFO - 'tests': ['a11yr', 09:23:52 INFO - 'ts_paint', 09:23:52 INFO - 'tpaint', 09:23:52 INFO - 'sessionrestore', 09:23:52 INFO - 'sessionrestore_many_windows', 09:23:52 INFO - 'sessionrestore_no_auto_restore', 09:23:52 INFO - 'tabpaint']}, 09:23:52 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 09:23:52 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 09:23:52 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 09:23:52 INFO - 'tests': ['perf_reftest_singletons']}, 09:23:52 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 09:23:52 INFO - 'tests': ['bloom_basic']}, 09:23:52 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:23:52 INFO - 'tsvgr_opacity', 09:23:52 INFO - 'tart', 09:23:52 INFO - 'tscrollx', 09:23:52 INFO - 'tsvg_static']}, 09:23:52 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 09:23:52 INFO - 'tests': ['tsvgx', 09:23:52 INFO - 'tsvgr_opacity', 09:23:52 INFO - 'tart', 09:23:52 INFO - 'tscrollx', 09:23:52 INFO - 'tsvg_static']}, 09:23:52 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:23:52 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 09:23:52 INFO - 'talos_options': ['--disable-stylo'], 09:23:52 INFO - 'tests': ['tp5o']}, 09:23:52 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 09:23:52 INFO - 'talos_options': ['--mitmproxy', 09:23:52 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 09:23:52 INFO - '--firstNonBlankPaint'], 09:23:52 INFO - 'tests': ['tp6_google', 09:23:52 INFO - 'tp6_youtube', 09:23:52 INFO - 'tp6_amazon', 09:23:52 INFO - 'tp6_facebook']}, 09:23:52 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 09:23:52 INFO - 'talos_options': ['--disable-stylo', 09:23:52 INFO - '--mitmproxy', 09:23:52 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 09:23:52 INFO - '--firstNonBlankPaint'], 09:23:52 INFO - 'tests': ['tp6_google', 09:23:52 INFO - 'tp6_youtube', 09:23:52 INFO - 'tp6_amazon', 09:23:52 INFO - 'tp6_facebook']}, 09:23:52 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 09:23:52 INFO - 'talos_options': ['--stylo-threads=1', 09:23:52 INFO - '--mitmproxy', 09:23:52 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 09:23:52 INFO - '--firstNonBlankPaint'], 09:23:52 INFO - 'tests': ['tp6_google', 09:23:52 INFO - 'tp6_youtube', 09:23:52 INFO - 'tp6_amazon', 09:23:52 INFO - 'tp6_facebook']}, 09:23:52 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:23:52 INFO - 'talos_options': ['--xperf_path', 09:23:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:23:52 INFO - 'tests': ['tp5n']}, 09:23:52 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 09:23:52 INFO - 'talos_options': ['--disable-stylo', 09:23:52 INFO - '--xperf_path', 09:23:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:23:52 INFO - 'tests': ['tp5n']}}} 09:23:52 INFO - Running post-action listener: _resource_record_post_action 09:23:52 INFO - [mozharness: 2017-09-21 16:23:52.727480Z] Finished populate-webroot step (success) 09:23:52 INFO - [mozharness: 2017-09-21 16:23:52.727570Z] Running create-virtualenv step. 09:23:52 INFO - Running pre-action listener: _resource_record_pre_action 09:23:52 INFO - Running main action method: create_virtualenv 09:23:52 INFO - Creating virtualenv /builds/slave/test/build/venv 09:23:52 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 09:23:52 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 09:23:52 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 09:23:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:23:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:23:53 INFO - Installing distribute.............................................................................................................................................................................................done. 09:23:53 INFO - Installing pip...............done. 09:23:53 INFO - Return code: 0 09:23:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:23:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:23:53 INFO - Reading from file tmpfile_stdout 09:23:53 INFO - Output received: 09:23:53 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:23:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:23: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:23:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:23: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:23:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:23: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d7b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f44a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20e7a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20eb090>, '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 0x20ebd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20e5f90>, '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': '0333a256a5e4f052382dd180000001b1-1506011013.417489-617014136', '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:23: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', 'pip>=1.5'] in /builds/slave/test/build 09:23: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 pip>=1.5 09:23:53 INFO - Using env: {'DISPLAY': ':0', 09:23:53 INFO - 'HOME': '/home/cltbld', 09:23:53 INFO - 'LANG': 'en_US.UTF-8', 09:23:53 INFO - 'LANGUAGE': 'en_US:en', 09:23:53 INFO - 'LOGNAME': 'cltbld', 09:23:53 INFO - 'MAIL': '/var/mail/cltbld', 09:23:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:53 INFO - 'MOZ_NO_REMOTE': '1', 09:23:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:23:53 INFO - 'NO_EM_RESTART': '1', 09:23:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:23:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:23:53 INFO - 'PWD': '/builds/slave/test', 09:23:53 INFO - 'SHELL': '/bin/bash', 09:23:53 INFO - 'SHLVL': '1', 09:23:53 INFO - 'TERM': 'linux', 09:23:53 INFO - 'TMOUT': '86400', 09:23:53 INFO - 'USER': 'cltbld', 09:23:53 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1506011013.417489-617014136', 09:23:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:53 INFO - '_': '/tools/buildbot/bin/python'} 09:23:55 INFO - Ignoring indexes: http://pypi.python.org/simple/ 09:23:55 INFO - Downloading/unpacking pip>=1.5 09:23:55 INFO - Running setup.py egg_info for package pip 09:23:55 INFO - warning: no files found matching 'pip/cacert.pem' 09:23:55 INFO - warning: no files found matching '*.html' under directory 'docs' 09:23:55 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 09:23:55 INFO - no previously-included directories found matching 'docs/_build/_sources' 09:23:55 INFO - Installing collected packages: pip 09:23:55 INFO - Found existing installation: pip 1.1 09:23:55 INFO - Uninstalling pip: 09:23:55 INFO - Successfully uninstalled pip 09:23:55 INFO - Running setup.py install for pip 09:23:55 INFO - warning: no files found matching 'pip/cacert.pem' 09:23:55 INFO - warning: no files found matching '*.html' under directory 'docs' 09:23:55 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 09:23:55 INFO - no previously-included directories found matching 'docs/_build/_sources' 09:23:55 INFO - Installing pip script to /builds/slave/test/build/venv/bin 09:23:55 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 09:23:55 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 09:23:55 INFO - Successfully installed pip 09:23:55 INFO - Cleaning up... 09:23:55 INFO - Return code: 0 09:23:55 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:23:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:23:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:23:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:23:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:23:55 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 0x1d7b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f44a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20e7a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20eb090>, '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 0x20ebd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20e5f90>, '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': '0333a256a5e4f052382dd180000001b1-1506011013.417489-617014136', '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:23:55 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:23:55 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:23:55 INFO - Using env: {'DISPLAY': ':0', 09:23:55 INFO - 'HOME': '/home/cltbld', 09:23:55 INFO - 'LANG': 'en_US.UTF-8', 09:23:55 INFO - 'LANGUAGE': 'en_US:en', 09:23:55 INFO - 'LOGNAME': 'cltbld', 09:23:55 INFO - 'MAIL': '/var/mail/cltbld', 09:23:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:55 INFO - 'MOZ_NO_REMOTE': '1', 09:23:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:23:55 INFO - 'NO_EM_RESTART': '1', 09:23:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:23:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:23:55 INFO - 'PWD': '/builds/slave/test', 09:23:55 INFO - 'SHELL': '/bin/bash', 09:23:55 INFO - 'SHLVL': '1', 09:23:55 INFO - 'TERM': 'linux', 09:23:55 INFO - 'TMOUT': '86400', 09:23:55 INFO - 'USER': 'cltbld', 09:23:55 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1506011013.417489-617014136', 09:23:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:55 INFO - '_': '/tools/buildbot/bin/python'} 09:23:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:23:55 INFO - Downloading/unpacking psutil>=3.1.1 09:23:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:23:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:23:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:23:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:23:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:23:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:23:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:23:56 INFO - Installing collected packages: psutil 09:23:56 INFO - Running setup.py install for psutil 09:23:56 INFO - building 'psutil._psutil_linux' extension 09:23:56 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:23:56 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 09:23:56 INFO - building 'psutil._psutil_posix' extension 09:23:56 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 09:23:56 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 09:23:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:23:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:23:57 INFO - Successfully installed psutil 09:23:57 INFO - Cleaning up... 09:23:57 INFO - Return code: 0 09:23:57 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:23:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:23:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:23:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:23:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:23:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d7b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f44a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20e7a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20eb090>, '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 0x20ebd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20e5f90>, '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': '0333a256a5e4f052382dd180000001b1-1506011013.417489-617014136', '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:23:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:23:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:23:57 INFO - Using env: {'DISPLAY': ':0', 09:23:57 INFO - 'HOME': '/home/cltbld', 09:23:57 INFO - 'LANG': 'en_US.UTF-8', 09:23:57 INFO - 'LANGUAGE': 'en_US:en', 09:23:57 INFO - 'LOGNAME': 'cltbld', 09:23:57 INFO - 'MAIL': '/var/mail/cltbld', 09:23:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:57 INFO - 'MOZ_NO_REMOTE': '1', 09:23:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:23:57 INFO - 'NO_EM_RESTART': '1', 09:23:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:23:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:23:57 INFO - 'PWD': '/builds/slave/test', 09:23:57 INFO - 'SHELL': '/bin/bash', 09:23:57 INFO - 'SHLVL': '1', 09:23:57 INFO - 'TERM': 'linux', 09:23:57 INFO - 'TMOUT': '86400', 09:23:57 INFO - 'USER': 'cltbld', 09:23:57 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1506011013.417489-617014136', 09:23:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:57 INFO - '_': '/tools/buildbot/bin/python'} 09:23:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:23:57 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:23: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:23: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:23: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:23: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:23:58 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:23:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:23:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:23:58 INFO - Installing collected packages: mozsystemmonitor 09:23:58 INFO - Running setup.py install for mozsystemmonitor 09:23:58 INFO - Successfully installed mozsystemmonitor 09:23:58 INFO - Cleaning up... 09:23:59 INFO - Return code: 0 09:23:59 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:23:59 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:23:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:23:59 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:23:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:23:59 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 0x1d7b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f44a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20e7a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20eb090>, '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 0x20ebd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20e5f90>, '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': '0333a256a5e4f052382dd180000001b1-1506011013.417489-617014136', '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:23:59 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:23:59 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:23:59 INFO - Using env: {'DISPLAY': ':0', 09:23:59 INFO - 'HOME': '/home/cltbld', 09:23:59 INFO - 'LANG': 'en_US.UTF-8', 09:23:59 INFO - 'LANGUAGE': 'en_US:en', 09:23:59 INFO - 'LOGNAME': 'cltbld', 09:23:59 INFO - 'MAIL': '/var/mail/cltbld', 09:23:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:59 INFO - 'MOZ_NO_REMOTE': '1', 09:23:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:23:59 INFO - 'NO_EM_RESTART': '1', 09:23:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:23:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:23:59 INFO - 'PWD': '/builds/slave/test', 09:23:59 INFO - 'SHELL': '/bin/bash', 09:23:59 INFO - 'SHLVL': '1', 09:23:59 INFO - 'TERM': 'linux', 09:23:59 INFO - 'TMOUT': '86400', 09:23:59 INFO - 'USER': 'cltbld', 09:23:59 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1506011013.417489-617014136', 09:23:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:59 INFO - '_': '/tools/buildbot/bin/python'} 09:23:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:23:59 INFO - Downloading/unpacking jsonschema==2.5.1 09:23:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:23:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:23:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:23:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:24:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:24:00 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:24:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:24:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:24:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:24:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:24:01 INFO - Downloading functools32-3.2.3-2.tar.gz 09:24:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:24:01 INFO - warning: no files found matching '*.txt' 09:24:01 INFO - no previously-included directories found matching 'build' 09:24:01 INFO - no previously-included directories found matching 'dist' 09:24:01 INFO - no previously-included directories found matching '.git*' 09:24:01 INFO - Installing collected packages: jsonschema, functools32 09:24:01 INFO - Running setup.py install for functools32 09:24:01 INFO - warning: no files found matching '*.txt' 09:24:01 INFO - no previously-included directories found matching 'build' 09:24:01 INFO - no previously-included directories found matching 'dist' 09:24:01 INFO - no previously-included directories found matching '.git*' 09:24:01 INFO - Successfully installed jsonschema functools32 09:24:01 INFO - Cleaning up... 09:24:01 INFO - Return code: 0 09:24:01 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:24:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:24:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:24:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:24:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:24:01 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 0x1d7b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f44a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20e7a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20eb090>, '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 0x20ebd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20e5f90>, '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': '0333a256a5e4f052382dd180000001b1-1506011013.417489-617014136', '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:24:01 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:24:01 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:24:01 INFO - Using env: {'DISPLAY': ':0', 09:24:01 INFO - 'HOME': '/home/cltbld', 09:24:01 INFO - 'LANG': 'en_US.UTF-8', 09:24:01 INFO - 'LANGUAGE': 'en_US:en', 09:24:01 INFO - 'LOGNAME': 'cltbld', 09:24:01 INFO - 'MAIL': '/var/mail/cltbld', 09:24:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:24:01 INFO - 'MOZ_NO_REMOTE': '1', 09:24:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:24:01 INFO - 'NO_EM_RESTART': '1', 09:24:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:24:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:24:01 INFO - 'PWD': '/builds/slave/test', 09:24:01 INFO - 'SHELL': '/bin/bash', 09:24:01 INFO - 'SHLVL': '1', 09:24:01 INFO - 'TERM': 'linux', 09:24:01 INFO - 'TMOUT': '86400', 09:24:01 INFO - 'USER': 'cltbld', 09:24:01 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1506011013.417489-617014136', 09:24:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:24:01 INFO - '_': '/tools/buildbot/bin/python'} 09:24:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:24:01 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:24:01 INFO - Cleaning up... 09:24:01 INFO - Return code: 0 09:24:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:24:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:24:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:24:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:24:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:24:01 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 0x1d7b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f44a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20e7a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20eb090>, '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 0x20ebd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20e5f90>, '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': '0333a256a5e4f052382dd180000001b1-1506011013.417489-617014136', '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:24:01 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:24:01 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:24:01 INFO - Using env: {'DISPLAY': ':0', 09:24:01 INFO - 'HOME': '/home/cltbld', 09:24:01 INFO - 'LANG': 'en_US.UTF-8', 09:24:01 INFO - 'LANGUAGE': 'en_US:en', 09:24:01 INFO - 'LOGNAME': 'cltbld', 09:24:01 INFO - 'MAIL': '/var/mail/cltbld', 09:24:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:24:01 INFO - 'MOZ_NO_REMOTE': '1', 09:24:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:24:01 INFO - 'NO_EM_RESTART': '1', 09:24:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:24:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:24:01 INFO - 'PWD': '/builds/slave/test', 09:24:01 INFO - 'SHELL': '/bin/bash', 09:24:01 INFO - 'SHLVL': '1', 09:24:01 INFO - 'TERM': 'linux', 09:24:01 INFO - 'TMOUT': '86400', 09:24:01 INFO - 'USER': 'cltbld', 09:24:01 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1506011013.417489-617014136', 09:24:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:24:01 INFO - '_': '/tools/buildbot/bin/python'} 09:24:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:24:01 INFO - Downloading/unpacking blobuploader==1.2.4 09:24:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:24:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:24:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:24:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:24:02 INFO - Downloading blobuploader-1.2.4.tar.gz 09:24:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:24:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:24:02 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:24:02 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:24:02 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:24:02 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:24:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:24:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:24: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:24: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:24: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:24: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:24:03 INFO - Downloading docopt-0.6.1.tar.gz 09:24:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:24:03 INFO - Installing collected packages: blobuploader, requests, docopt 09:24:03 INFO - Running setup.py install for blobuploader 09:24:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:24:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:24:03 INFO - Running setup.py install for requests 09:24:03 INFO - Running setup.py install for docopt 09:24:03 INFO - Successfully installed blobuploader requests docopt 09:24:03 INFO - Cleaning up... 09:24:04 INFO - Return code: 0 09:24:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:24: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:24:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:24: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:24:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:24:04 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 0x1d7b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f44a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20e7a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20eb090>, '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 0x20ebd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20e5f90>, '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': '0333a256a5e4f052382dd180000001b1-1506011013.417489-617014136', '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:24:04 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:24:04 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:24:04 INFO - Using env: {'DISPLAY': ':0', 09:24:04 INFO - 'HOME': '/home/cltbld', 09:24:04 INFO - 'LANG': 'en_US.UTF-8', 09:24:04 INFO - 'LANGUAGE': 'en_US:en', 09:24:04 INFO - 'LOGNAME': 'cltbld', 09:24:04 INFO - 'MAIL': '/var/mail/cltbld', 09:24:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:24:04 INFO - 'MOZ_NO_REMOTE': '1', 09:24:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:24:04 INFO - 'NO_EM_RESTART': '1', 09:24:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:24:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:24:04 INFO - 'PWD': '/builds/slave/test', 09:24:04 INFO - 'SHELL': '/bin/bash', 09:24:04 INFO - 'SHLVL': '1', 09:24:04 INFO - 'TERM': 'linux', 09:24:04 INFO - 'TMOUT': '86400', 09:24:04 INFO - 'USER': 'cltbld', 09:24:04 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1506011013.417489-617014136', 09:24:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:24:04 INFO - '_': '/tools/buildbot/bin/python'} 09:24:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:24:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:24:04 INFO - Running setup.py (path:/tmp/pip-J81U9H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:24:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:24:04 INFO - Running setup.py (path:/tmp/pip-t1J9B_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:24:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:24:04 INFO - Running setup.py (path:/tmp/pip-q3dySN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:24:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:24:04 INFO - Running setup.py (path:/tmp/pip-zSE_lh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:24:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:24:04 INFO - Running setup.py (path:/tmp/pip-ebdv03-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:24:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:24:04 INFO - Running setup.py (path:/tmp/pip-Se8Xrg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:24:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:24:04 INFO - Running setup.py (path:/tmp/pip-tDkD0m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:24:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:24:04 INFO - Running setup.py (path:/tmp/pip-8vNWK4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:24:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:24:04 INFO - Running setup.py (path:/tmp/pip-hkm8F0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:24:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:24:04 INFO - Running setup.py (path:/tmp/pip-V3ERH3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:24:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:24:04 INFO - Running setup.py (path:/tmp/pip-dVVMu7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:24:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:24:05 INFO - Running setup.py (path:/tmp/pip-tRUQSu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:24:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:24:05 INFO - Running setup.py (path:/tmp/pip-ocJcdq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:24:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:24:05 INFO - Running setup.py (path:/tmp/pip-Uxw1l8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:24:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:24:05 INFO - Running setup.py (path:/tmp/pip-4Kj8Dg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:24:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:24:05 INFO - Running setup.py (path:/tmp/pip-rxQ7vR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:24:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:24:05 INFO - Running setup.py (path:/tmp/pip-jli8JW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:24:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:24:05 INFO - Running setup.py install for manifestparser 09:24:05 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:24:05 INFO - Running setup.py install for mozcrash 09:24:05 INFO - Running setup.py install for mozdebug 09:24:05 INFO - Running setup.py install for mozdevice 09:24:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:24:05 INFO - Running setup.py install for mozfile 09:24:05 INFO - Running setup.py install for mozhttpd 09:24:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:24:06 INFO - Running setup.py install for mozinfo 09:24:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:24:06 INFO - Running setup.py install for mozInstall 09:24:06 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:24:06 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:24:06 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:24:06 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:24:06 INFO - Running setup.py install for mozleak 09:24:06 INFO - Running setup.py install for mozlog 09:24:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:24:06 INFO - Running setup.py install for moznetwork 09:24:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:24:06 INFO - Running setup.py install for mozprocess 09:24:06 INFO - Running setup.py install for mozprofile 09:24:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:24:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:24:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:24:06 INFO - Running setup.py install for mozrunner 09:24:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:24:06 INFO - Running setup.py install for mozscreenshot 09:24:06 INFO - Running setup.py install for moztest 09:24:07 INFO - Running setup.py install for mozversion 09:24:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:24:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:24:07 INFO - Cleaning up... 09:24:07 INFO - Return code: 0 09:24:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:24: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:24:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:24: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:24:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:24:07 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 0x1d7b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f44a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20e7a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20eb090>, '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 0x20ebd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20e5f90>, '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': '0333a256a5e4f052382dd180000001b1-1506011013.417489-617014136', '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:24:07 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:24:07 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:24:07 INFO - Using env: {'DISPLAY': ':0', 09:24:07 INFO - 'HOME': '/home/cltbld', 09:24:07 INFO - 'LANG': 'en_US.UTF-8', 09:24:07 INFO - 'LANGUAGE': 'en_US:en', 09:24:07 INFO - 'LOGNAME': 'cltbld', 09:24:07 INFO - 'MAIL': '/var/mail/cltbld', 09:24:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:24:07 INFO - 'MOZ_NO_REMOTE': '1', 09:24:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:24:07 INFO - 'NO_EM_RESTART': '1', 09:24:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:24:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:24:07 INFO - 'PWD': '/builds/slave/test', 09:24:07 INFO - 'SHELL': '/bin/bash', 09:24:07 INFO - 'SHLVL': '1', 09:24:07 INFO - 'TERM': 'linux', 09:24:07 INFO - 'TMOUT': '86400', 09:24:07 INFO - 'USER': 'cltbld', 09:24:07 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1506011013.417489-617014136', 09:24:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:24:07 INFO - '_': '/tools/buildbot/bin/python'} 09:24:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:24:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:24:07 INFO - Running setup.py (path:/tmp/pip-KSkMNx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:24:07 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:24:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:24:07 INFO - Running setup.py (path:/tmp/pip-8g5aaE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:24:07 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:24:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:24:07 INFO - Running setup.py (path:/tmp/pip-6m3sMp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:24:07 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:24:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:24:07 INFO - Running setup.py (path:/tmp/pip-msXNUF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:24:07 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:24:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:24:07 INFO - Running setup.py (path:/tmp/pip-Yw3H5q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:24:07 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:24:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:24:07 INFO - Running setup.py (path:/tmp/pip-lHvqMR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:24:07 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:24:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:24:07 INFO - Running setup.py (path:/tmp/pip-uk7x0y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:24:07 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:24:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:24:07 INFO - Running setup.py (path:/tmp/pip-35G9zc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:24:07 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:24:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:24:07 INFO - Running setup.py (path:/tmp/pip-YzT1IK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:24:08 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:24:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:24:08 INFO - Running setup.py (path:/tmp/pip-T_vlnF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:24:08 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:24:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:24:08 INFO - Running setup.py (path:/tmp/pip-znZsuF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:24:08 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:24:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:24:08 INFO - Running setup.py (path:/tmp/pip-7YMcES-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:24:08 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:24:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:24:08 INFO - Running setup.py (path:/tmp/pip-PE2YYS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:24:08 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:24:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:24:08 INFO - Running setup.py (path:/tmp/pip-bnt88S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:24:08 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:24:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:24:08 INFO - Running setup.py (path:/tmp/pip-bXXjMM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:24:08 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:24:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:24:08 INFO - Running setup.py (path:/tmp/pip-D05TpW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:24:08 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:24:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:24:08 INFO - Running setup.py (path:/tmp/pip-M37j_d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:24:08 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:24:08 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:24:08 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:24:08 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:24:08 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:24:08 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:24:08 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:24:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:24:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:24:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:24:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:24:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:24:09 INFO - Downloading blessings-1.6.tar.gz 09:24:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:24:09 INFO - Installing collected packages: blessings 09:24:09 INFO - Running setup.py install for blessings 09:24:09 INFO - Successfully installed blessings 09:24:09 INFO - Cleaning up... 09:24:09 INFO - Return code: 0 09:24:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:24:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:24:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:24:10 INFO - Reading from file tmpfile_stdout 09:24:10 INFO - Current package versions: 09:24:10 INFO - argparse == 1.2.1 09:24:10 INFO - blessings == 1.6 09:24:10 INFO - blobuploader == 1.2.4 09:24:10 INFO - docopt == 0.6.1 09:24:10 INFO - functools32 == 3.2.3-2 09:24:10 INFO - jsonschema == 2.5.1 09:24:10 INFO - manifestparser == 1.1 09:24:10 INFO - mozInstall == 1.13 09:24:10 INFO - mozcrash == 1.0 09:24:10 INFO - mozdebug == 0.1 09:24:10 INFO - mozdevice == 0.51 09:24:10 INFO - mozfile == 1.2 09:24:10 INFO - mozhttpd == 0.7 09:24:10 INFO - mozinfo == 0.10 09:24:10 INFO - mozleak == 0.1 09:24:10 INFO - mozlog == 3.5 09:24:10 INFO - moznetwork == 0.27 09:24:10 INFO - mozprocess == 0.25 09:24:10 INFO - mozprofile == 0.28 09:24:10 INFO - mozrunner == 6.13 09:24:10 INFO - mozscreenshot == 0.1 09:24:10 INFO - mozsystemmonitor == 0.3 09:24:10 INFO - moztest == 0.8 09:24:10 INFO - mozversion == 1.4 09:24:10 INFO - psutil == 3.1.1 09:24:10 INFO - requests == 1.2.3 09:24:10 INFO - wsgiref == 0.1.2 09:24:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:24:10 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:24:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:24:10 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:24:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:24:10 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 0x1d7b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f44a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20e7a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20eb090>, '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 0x20ebd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20e5f90>, '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': '0333a256a5e4f052382dd180000001b1-1506011013.417489-617014136', '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:24:10 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:24:10 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:24:10 INFO - Using env: {'DISPLAY': ':0', 09:24:10 INFO - 'HOME': '/home/cltbld', 09:24:10 INFO - 'LANG': 'en_US.UTF-8', 09:24:10 INFO - 'LANGUAGE': 'en_US:en', 09:24:10 INFO - 'LOGNAME': 'cltbld', 09:24:10 INFO - 'MAIL': '/var/mail/cltbld', 09:24:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:24:10 INFO - 'MOZ_NO_REMOTE': '1', 09:24:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:24:10 INFO - 'NO_EM_RESTART': '1', 09:24:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:24:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:24:10 INFO - 'PWD': '/builds/slave/test', 09:24:10 INFO - 'SHELL': '/bin/bash', 09:24:10 INFO - 'SHLVL': '1', 09:24:10 INFO - 'TERM': 'linux', 09:24:10 INFO - 'TMOUT': '86400', 09:24:10 INFO - 'USER': 'cltbld', 09:24:10 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1506011013.417489-617014136', 09:24:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:24:10 INFO - '_': '/tools/buildbot/bin/python'} 09:24:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:24:10 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:24:10 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:24:10 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:24:10 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:24:10 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:24:10 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:24:10 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:24:10 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:24:10 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:24:10 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 09:24:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:24:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:24:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:24:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:24:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 09:24:11 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:24:11 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:24:11 INFO - Installing collected packages: simplejson 09:24:11 INFO - Running setup.py install for simplejson 09:24:11 INFO - building 'simplejson._speedups' extension 09:24:11 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:24:12 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:24:12 INFO - Successfully installed simplejson 09:24:12 INFO - Cleaning up... 09:24:12 INFO - Return code: 0 09:24:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:24:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:24:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:24:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:24:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:24:12 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 0x1d7b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f44a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20e7a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20eb090>, '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 0x20ebd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20e5f90>, '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': '0333a256a5e4f052382dd180000001b1-1506011013.417489-617014136', '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:24:12 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:24:12 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:24:12 INFO - Using env: {'DISPLAY': ':0', 09:24:12 INFO - 'HOME': '/home/cltbld', 09:24:12 INFO - 'LANG': 'en_US.UTF-8', 09:24:12 INFO - 'LANGUAGE': 'en_US:en', 09:24:12 INFO - 'LOGNAME': 'cltbld', 09:24:12 INFO - 'MAIL': '/var/mail/cltbld', 09:24:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:24:12 INFO - 'MOZ_NO_REMOTE': '1', 09:24:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:24:12 INFO - 'NO_EM_RESTART': '1', 09:24:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:24:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:24:12 INFO - 'PWD': '/builds/slave/test', 09:24:12 INFO - 'SHELL': '/bin/bash', 09:24:12 INFO - 'SHLVL': '1', 09:24:12 INFO - 'TERM': 'linux', 09:24:12 INFO - 'TMOUT': '86400', 09:24:12 INFO - 'USER': 'cltbld', 09:24:12 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1506011013.417489-617014136', 09:24:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:24:12 INFO - '_': '/tools/buildbot/bin/python'} 09:24:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:24:12 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:24:12 INFO - Cleaning up... 09:24:12 INFO - Return code: 0 09:24:12 INFO - Running post-action listener: _resource_record_post_action 09:24:12 INFO - Running post-action listener: _start_resource_monitoring 09:24:12 INFO - Starting resource monitoring. 09:24:12 INFO - [mozharness: 2017-09-21 16:24:12.912782Z] Finished create-virtualenv step (success) 09:24:12 INFO - [mozharness: 2017-09-21 16:24:12.913297Z] Running install step. 09:24:12 INFO - Running pre-action listener: _resource_record_pre_action 09:24:12 INFO - Running main action method: install 09:24:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:24:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:24:13 INFO - Reading from file tmpfile_stdout 09:24:13 INFO - Detecting whether we're running mozinstall >=1.0... 09:24:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:24:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:24:13 INFO - Reading from file tmpfile_stdout 09:24:13 INFO - Output received: 09:24:13 INFO - Usage: mozinstall [options] installer 09:24:13 INFO - Options: 09:24:13 INFO - -h, --help show this help message and exit 09:24:13 INFO - -d DEST, --destination=DEST 09:24:13 INFO - Directory to install application into. [default: 09:24:13 INFO - "/builds/slave/test"] 09:24:13 INFO - --app=APP Application being installed. [default: firefox] 09:24:13 INFO - mkdir: /builds/slave/test/build/application 09:24:13 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:24:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 09:24:31 INFO - Reading from file tmpfile_stdout 09:24:31 INFO - Output received: 09:24:31 INFO - /builds/slave/test/build/application/firefox/firefox 09:24:31 INFO - Running post-action listener: _resource_record_post_action 09:24:31 INFO - [mozharness: 2017-09-21 16:24:31.007066Z] Finished install step (success) 09:24:31 INFO - [mozharness: 2017-09-21 16:24:31.007210Z] Running setup-mitmproxy step. 09:24:31 INFO - Running pre-action listener: _resource_record_pre_action 09:24:31 INFO - Running main action method: setup_mitmproxy 09:24:31 INFO - Skipping: mitmproxy is not required 09:24:31 INFO - Running post-action listener: _resource_record_post_action 09:24:31 INFO - [mozharness: 2017-09-21 16:24:31.007739Z] Finished setup-mitmproxy step (success) 09:24:31 INFO - [mozharness: 2017-09-21 16:24:31.007840Z] Running run-tests step. 09:24:31 INFO - Running pre-action listener: _resource_record_pre_action 09:24:31 INFO - Running pre-action listener: _set_gcov_prefix 09:24:31 INFO - Running main action method: run_tests 09:24:31 WARNING - Try message not found. 09:24:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:24:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:24:31 INFO - Python 2.7.3 09:24:31 INFO - Return code: 0 09:24:31 INFO - grabbing minidump binary from tooltool 09:24:31 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:24:31 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 0x20eb090>, '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 0x20ebd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20e5f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:24:31 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:24:31 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:24:31 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:24:31 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:24:31 INFO - Return code: 0 09:24:31 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:24:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:24:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:24:31 INFO - ENV: RUST_BACKTRACE is now full 09:24:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:24:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:24:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HBJ4E0WUSRGZbfHgz26VAA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--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:24:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/HBJ4E0WUSRGZbfHgz26VAA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-017 --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:24:31 INFO - Using env: {'DISPLAY': ':0', 09:24:31 INFO - 'HOME': '/home/cltbld', 09:24:31 INFO - 'LANG': 'en_US.UTF-8', 09:24:31 INFO - 'LANGUAGE': 'en_US:en', 09:24:31 INFO - 'LOGNAME': 'cltbld', 09:24:31 INFO - 'MAIL': '/var/mail/cltbld', 09:24:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:24:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:24:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:24:31 INFO - 'MOZ_NO_REMOTE': '1', 09:24:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:24:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:24:31 INFO - 'NO_EM_RESTART': '1', 09:24:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:24:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:24:31 INFO - 'PWD': '/builds/slave/test', 09:24:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:24:31 INFO - 'RUST_BACKTRACE': 'full', 09:24:31 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 09:24:31 INFO - 'SHELL': '/bin/bash', 09:24:31 INFO - 'SHLVL': '1', 09:24:31 INFO - 'TERM': 'linux', 09:24:31 INFO - 'TMOUT': '86400', 09:24:31 INFO - 'USER': 'cltbld', 09:24:31 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1506011013.417489-617014136', 09:24:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:24:31 INFO - '_': '/tools/buildbot/bin/python'} 09:24:31 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HBJ4E0WUSRGZbfHgz26VAA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--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:24:31 INFO - mozversion application_buildid: 20170921152748 09:24:31 INFO - mozversion application_changeset: b14c75b83d0226333b1240466ea9f07cfb206ff3 09:24:31 INFO - mozversion application_display_name: Nightly 09:24:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:24:31 INFO - mozversion application_name: Firefox 09:24:31 INFO - mozversion application_remotingname: firefox 09:24:31 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:24:31 INFO - mozversion application_vendor: Mozilla 09:24:31 INFO - mozversion application_version: 58.0a1 09:24:31 INFO - mozversion platform_buildid: 20170921152748 09:24:31 INFO - mozversion platform_changeset: b14c75b83d0226333b1240466ea9f07cfb206ff3 09:24:31 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:24:31 INFO - mozversion platform_version: 58.0a1 09:24:31 INFO - using testdate: 1506011071 09:24:31 INFO - actual date: 1506011071 09:24:31 INFO - starting webserver on 'localhost:36889' 09:24:31 INFO - SUITE-START | Running 2 tests 09:24:31 INFO - TEST-START | dromaeo_css 09:24:31 INFO - Initialising browser for dromaeo_css test... 09:24:31 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:36889/getInfo.html -profile /tmp/tmpzftE_a/profile 09:24:31 INFO - TEST-INFO | started process 20961 (/builds/slave/test/build/application/firefox/firefox http://localhost:36889/getInfo.html) 09:24:36 INFO - TEST-INFO | 20961: exit 0 09:24:36 INFO - Browser initialized. 09:24:36 INFO - Running cycle 1/1 for dromaeo_css test... 09:24:36 INFO - Using env: {'DISPLAY': ':0', 09:24:36 INFO - 'HOME': '/home/cltbld', 09:24:36 INFO - 'JSGC_DISABLE_POISONING': '1', 09:24:36 INFO - 'LANG': 'en_US.UTF-8', 09:24:36 INFO - 'LANGUAGE': 'en_US:en', 09:24:36 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 09:24:36 INFO - 'LOGNAME': 'cltbld', 09:24:36 INFO - 'MAIL': '/var/mail/cltbld', 09:24:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:24:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:24:36 INFO - 'MOZ_CRASHREPORTER': '1', 09:24:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:24:36 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 09:24:36 INFO - 'MOZ_NO_REMOTE': '1', 09:24:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:24:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:24:36 INFO - 'NO_EM_RESTART': '1', 09:24:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:24:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:24:36 INFO - 'PWD': '/builds/slave/test', 09:24:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:24:36 INFO - 'RUST_BACKTRACE': 'full', 09:24:36 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 09:24:36 INFO - 'SHELL': '/bin/bash', 09:24:36 INFO - 'SHLVL': '1', 09:24:36 INFO - 'TERM': 'linux', 09:24:36 INFO - 'TMOUT': '86400', 09:24:36 INFO - 'USER': 'cltbld', 09:24:36 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1506011013.417489-617014136', 09:24:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:24:36 INFO - '_': '/tools/buildbot/bin/python'} 09:24:36 INFO - TEST-INFO | started process 21198 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzftE_a/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 09:24:37 INFO - PID 21198 | 09:24:37 INFO - PID 21198 | (/builds/slave/test/build/application/firefox/firefox:21247): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 09:24:37 INFO - PID 21198 | 09:24:48 INFO - PID 21198 | RSS: Main: 151097344 09:24:48 INFO - PID 21198 | 09:27:45 INFO - PID 21198 | Cycle 1(1): loaded http://localhost:36889/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36889/tests/dromaeo/cssquery-ext.html) 09:27:46 INFO - PID 21198 | RSS: Main: 154746880 09:27:46 INFO - PID 21198 | 09:30:48 INFO - PID 21198 | Cycle 1(1): loaded http://localhost:36889/tests/dromaeo/cssquery-ext.html (next: http://localhost:36889/tests/dromaeo/cssquery-jquery.html) 09:30:49 INFO - PID 21198 | RSS: Main: 154177536 09:30:49 INFO - PID 21198 | 09:33:50 INFO - PID 21198 | Cycle 1(1): loaded http://localhost:36889/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36889/tests/dromaeo/cssquery-mootools.html) 09:33:51 INFO - PID 21198 | RSS: Main: 156250112 09:33:51 INFO - PID 21198 | 09:36:53 INFO - PID 21198 | Cycle 1(1): loaded http://localhost:36889/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36889/tests/dromaeo/cssquery-prototype.html) 09:36:53 INFO - PID 21198 | RSS: Main: 154984448 09:36:53 INFO - PID 21198 | 09:39:57 INFO - PID 21198 | Cycle 1(1): loaded http://localhost:36889/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36889/tests/dromaeo/cssquery-yui.html) 09:39:57 INFO - PID 21198 | RSS: Main: 156405760 09:39:57 INFO - PID 21198 | 09:42:59 INFO - PID 21198 | Cycle 1(1): loaded http://localhost:36889/tests/dromaeo/cssquery-yui.html (next: http://localhost:36889/tests/dromaeo/cssquery-dojo.html) 09:42:59 INFO - PID 21198 | RSS: Main: 158961664 09:42:59 INFO - PID 21198 | 09:42:59 INFO - PID 21198 | __start_tp_report 09:42:59 INFO - PID 21198 | _x_x_mozilla_page_load 09:42:59 INFO - PID 21198 | _x_x_mozilla_page_load_details 09:42:59 INFO - PID 21198 | |i|pagename|runs| 09:42:59 INFO - PID 21198 | |0;dojo.html;3126.218445388653;3166.572512710784;3195.7603179761495;3229.079712282;3234.110619579617;6216;6334.524910631698;6344.3338449462835;6394.744210231591;6472.5792823466445;6288.654124023188;6301.495880329563;6313.147725057116;6317.652529110897;6353.269374021989;5818.592698511116;5831.970840145794;5853.5902486825935;5905.586608937355;5941.079132734433;5893.322267939177;5926.081457374114;5950.821475355746;5951.375105613914;5992.700364981755;1254.2432658819373;5778.248827652378;5797.768089276424;5895.233619629442;5983.670898100603;5780.479756821865;5841.6495010299095;5919.911201331984;5921.763129474816;5923.08192230205;5815.93979869814;5826.067829147316;5887.0580707086665;5889.469947704727;5890.970545147246;6243.719032643542;6308;6379;6395.584287021329;6417.647029413381;6769.796906092825;6795.422389096932;6803.48973826965;6870.7595234167065;6890.31096890312;6654.633995130266;6800.149981252343;6813.080234168373;6904.758333458305;6939.861202775916;6353.30113687494;6366.586171898812;6386.10594516768;6433;6439.066335381343;7041.788746337618;7049.224585295613;7124.038254835531;7129.89305160423;7134.750283740044;6500.122483464766;6622.635755033423;6636.701348439332;6678.031685405589;6738.797836064926;6754.966225168941;6768.221654509696;6772.153480814898;6778.694958726869;6778.864422711518;6651.733930642817;6721.563098398588;6731.528792984444;6735.696893639798;6741.0899528564;6770.661466926733;6783.3555812197765;6785.355391237825;6790.456763458911;6880.724771009203;5351.946480535223;5380.704061276668;5419.187121931663;5420.349558053059;5422.349318081855;4675.29870519418;4699.459562150397;4712.858614241578;4723.45680246776;4728.763561821896;5585.972070139624;5771.797987070432;5788.871170121786;5863.824085277449;5867.911981320283;6764.458843292525;6779.3220677932795;6781.118454600969;6782.287859774653;6787.185537735503;5721.77112915487;5740.913886291709;5753.079507278815;5753.654780713086;5754.539636829044;5783.537317014629;5836.854078648068;5853.1220316952795;5894.204282421904;5922.141289512996;6291.905621415683;6412.583182093243;6552.868942621121;6672.065910772496;6686.899696504556;6870.690818913061;6931.7522845887215;6933.826654333682;6934.237233904368;6943.930560694429;6511.47908167336;6555.573887697285;6569.967150164219;6598.571092878948;6661.034150048313;6493.642849643126;6659.766908158192;6728.05807187004;6741.662916854236;6821.658917054227;6655.168103987002;6678.065070889982;6682.69927853238;6688.3646053624825;6694.29709880475;5967.433093856251;6426.614403135827;6593.769218077345;6691.397774200345;6714.429273511806;6569.408753212234;6581.736730530725;6585.078089067439;6673.833154171185;6688.6990085445295;6351.904721429275;6466.4503517201565;6493.415592596689;6521.119648847345;6613.66931653425;6630.701618427279;6649.335066493312;6668.399844014062;6719.260881302955;6738.258791533026;6446.129772480843;6460.547761656639;6463.806085817433;6528.608283503005;6550.181227346582 09:42:59 INFO - PID 21198 | |1;ext.html;862.495440167502;874.794423310522;906.8821053263075;909.2589539525286;912.0241341764313;41147.58852411475;41667.37498937518;41739.79130104345;42144.15711685764;42147.57852421479;38642;38778.61221387785;40651.390229146586;41271.58728412715;41286.38070428946;7901.683932642687;7984.201579841998;8030.478018928751;8058.15389384115;8063.314618257456;7853.175416581234;8018.158093400168;8022.759317220492;8034;8034.919650803476;7927.40544459165;7942.285194332509;8017.639206235734;8020.077691065544;8050.476719013274;7936.523808571505;7938.325242354407;7947.761567152966;8004.839903201932;8016.799580010488;7823.295903368724;7845.254700803414;7849.254320839511;7860.0567931848545;7871.858580505795;37620.62379376199;38015.809920950494;38093.61906380928;38144.61855381438;38163.23673526542;3555.5377800885976;3564.3405969895653;3568.1436455250814;3588.659077387644;3601.6398360164035;31022.379552409053;31079.378412431626;31095.22261943447;31154.22114447157;31171.68828311733;5052;5186.118359878829;5210.843674689765;5216.061109000379;5247.763850626693;184721;187918;188445.99999999863;189003;189657;42061.78969105196;48418;49204.507954919995;49612.751936240085;49689.25466118011;50793;51222.23166652503;51300.48699513032;51328.74335628298;51520.74239628853;14875.925620371829;14900.254987250593;15011.774823377658;15019.09885406879;15118.546443606709;12192;12325.767423257603;12326.691832704255;12327.75344493123;12336.259824410565;12924.676883077811;12966.935165324114;13025.934870325777;13074.280914549601;13259.66850828737;4940.802367905316;4992.825251116194;5006.89986200274;5009.44896061433;5054.039732450822;1009.1371877045168;1009.6314845081639;1014.1734486393566;1018.994905025485;1028.3983869436313;22955.311340659806;22972.54054918892;22977.54044919092;23098.884505577364;23299;1091.1568550412428;1094.2340361746808;1106.7620461600634;1109.1459576126338;1115.8995690387903;12146.75706485883;12152.635420937386;12225.572104976283;12323.198992065487;12328.19866708679;236983;237182;237817;238492;238584;51340;51582.742086290076;51621;51650.48349516532;51693.48306516962;1383.156274672449;1427.229296180072;1427.5431861804332;1438.590540419213;1438.9352479138463;22199.667004994615;22331.330060098222;22466.887665561568;22697.659535107316;22991.54016919686;36689;36704;36811.26377472489;36841.263174736894;36844.26311473702;193875;194906;195413.02293488442;196202;196598;34527.30945381028;34757.13107172341;35449.645503544634;36249;36371.27257454889;45338;46609;46626.53373466222;46936.06127877492;47065.764671176425;33398.49902251517;33636.831815840764;33703.66296337005;33780;34421;32385.838070809496;33005.834970824995;33120.66879331176;33262.168445788084;33544.32911341711;36859.447108293934;37279.44080838736;37325.25349493049;37392.25215495729;37541.24917501689;32609.18477038093;32726.50910236396;32737;32783.67216327806;32789.18027049343;24428.75571244265;24670.506589867742;24864.37839054038;25068.74931250737;25092.37269068215 09:42:59 INFO - PID 21198 | |2;jquery.html;590.4744777148336;595.868908840055;598.3717097048099;608.987820243595;630.2940706408823;21840.563188736214;22729.659055114167;22741.545169096607;22753.2036378727;22809.657855132187;21594.1362345506;23880.283591492283;24084.518309633797;24093.15673951412;24129;6616.53684242102;6696.631685257309;6705.631190284533;6729;6739.663016849163;6380.585261957958;6616.569922955016;6644.66776661165;6720.462363010972;6721.193456785192;6585.637789921552;6598.93401065988;6607.372299631527;6608.801735947929;6609.570377925419;6594.439472644807;6601.141851559315;6608.240052393964;6610.272869984298;6616.735330586819;5860.531157507389;6137.048757442603;6154.046122850965;6156.938430615682;6158.414950579688;27325.726742732517;27767.305817354525;27789.166325010283;27790.444191116265;27865.721342786514;2068.6896965455153;2071.54426026274;2077.979220207794;2084.374687593716;2098.548812005411;17456.738148927776;17546.824531754773;17777.288908443647;17863.374781882703;17911.910440447715;2417.045267119478;2473.0478765675166;2473.789727873133;2475.39352858549;2489;117145.41427292895;122116.38941805322;122723.38638306841;123179.3841030798;138621;13948.86051139496;14522.709545809024;14601.269936503133;14686.339114739862;14769.113853168845;22662.433439164153;23211.651825222634;23229.3031209064;23471.178508752113;23527.17654882071;9229.353945223904;9286.72139835806;9529.094736000068;9532.618695252251;9575.473348965734;8336.66653333872;8403.201695838885;8454.535000575028;8582.356323275779;8587.742367728979;9004.549772511347;9052.411593246417;9084.772880677903;9264.166225039779;9335.346525743133;2573.8327008744745;2606.6397988907383;2688.71358618147;2755.7244275572284;2769;951.5432592355708;953.6614501851743;961.908234154226;990.1880458024351;998.5606333213362;18622.06889655512;18652.626947460976;19020.334288299844;19158.904205478884;19289;1005.7686732051523;1010.6664800615779;1018.8930162332997;1026.2303272545591;1029.1098200056897;10483.633072842415;10497.370157790558;10635.46822658864;10715;10763.56945722178;458231;459746;461880;462351;475994;113077;115008.42495787468;117465;117659;118526;1119.1438549509633;1140.2132528555271;1144.9713757156137;1157.716359491913;1159.5245949160803;16780.077095759363;16863.893497511206;16892.493225203263;17372.957622542686;17569.121543922498;51588.48411515987;52184;52282.73858630683;52510.21234681559;52545.73727131493;63855.680721596094;68299.65850170718;68527.65736171287;68731;68919.65540172468;14403.351849167022;14877.404903803726;14953.700925981637;14984.775228371802;14991.550253492413;22458.663120052886;22525.211617593304;22566.435839104153;22687.319380417954;22876.656850147592;17599.560010999827;17931.641367172324;17981.73027404564;18149.909250453664;18166.09169541544;15758.842411576195;16296.42962496307;16590.83409165893;16720.832791671928;17058.829411705723;17182.22679979379;18077.186526606598;18413.26346946107;18448.446546603624;18512.259509619464;14538.127712337293;14558.980871338905;14628.488002919847;14637.634059148606;14649.267536622912;17859.107044647455;17942.102894854943;18017.549561261072;18036.63926721432;18258.72611910796 09:42:59 INFO - PID 21198 | |3;mootools.html;1320.2144723889287;1371.0402718097334;1372.9519466818658;1378.166209443286;1384.2317513779851;14733.263336833155;15297;15311;15323.387064517434;15347.616309592238;15009.774853377181;15183.240837958085;15196.620084497894;15221.847781522209;15288.999999999973;2766.0595397564825;2819.36564273039;2841.8152820066734;2861.1702606244166;2865.7564107050925;2729.495043416974;2753.490604238222;2768.9754790727357;2770.1827960751625;2771.9029833955815;2674.090809124897;2723.2783312422225;2800.187945495814;2802.523570992926;2803.6215110959965;2753.9449211015767;2827.9858600706966;2854.757345625624;2856.900008499703;2857.271395794059;2712.308361367858;2725.38678797271;2725.591161325797;2736.3843135294596;2738.2606696191915;15055.924720376437;15309.540713778604;15369.923150384177;15398.615034624112;15413.306401211972;7870.370370370414;8135.227153420416;8167.428280020401;8198.631061602242;8203.30271926887;5065.797368105272;5156.561692256163;5286.973565132188;5366.4633536646415;5373.274607927958;1918.9040547972686;1943.3101249056665;1948.7076938459345;1948.8343490803156;1987.0462178154423;27127.05055323074;27177.592336114973;27369.17892463229;27415.725842741715;27711.722882771115;6898.586084834826;7103.396211322096;7129.857402851914;7291.817704557428;7330.193678695339;17594.91202543979;17599.20803563843;17612.471625851245;17621;17670.82329176692;8024.5185288881685;8305.750827475185;8585.871211931826;8662.090480499457;8666.913330866737;7553.471257011956;7675.53946763196;7676;7685.346745526581;7695.268949449794;5375.086235340002;5548.667079975215;5554.055810512223;5584.268876648252;5610.579206559524;1530.6326481644326;1535.9155246461553;1609.5251900689325;1615.7334039883287;1637.6560922206231;862.0818827948215;877.1842186766241;895.4403497813867;901.2924853989587;902.9503377314179;8418.536980466133;8553.315734741205;8619.784505387415;8668.566571671392;8688.26149777276;969.1035791892472;969.2730452160879;979.1285755677453;979.6913972098766;982.5332966840693;5081.8475445736685;5213.035588416155;5257.947420525822;5267.3152490176035;5273.736313184326;21541.353759387242;21783.23758668439;22636.54726905453;22700.091996320294;22713.772862271166;21111.68332475014;21376.679349809765;21975.120995160334;22684.546309073725;22733.772662273495;10913.23607347494;11119;11180;11239.887601124048;11270.09839212861;8388.916110838814;8553.401261911606;8556.657733690583;8581.75653778067;8591.269742071994;18240.361587344378;18709.43871683852;18859.811401885807;18986.715199271744;19036.1433735485;18343.26626934908;18801.247950081844;18818;18935.621287574446;19613.901930490258;9720.611175552898;9950.800983980425;9959;10066.798664026825;10081.848772268275;13476.79784803209;13644.931775341456;13663.658408539468;13670.93164534171;13714.65713357174;10422.791544169226;10524.894751052392;10537.683869483928;10607.045365917105;10868.67393978182;11123.388213648326;11294.096472282363;11503.194776365908;11518.827217591575;11667.183297169116;9928.702138935843;10114.595416183565;10123.493825308853;10145.9492702536;10207.234457415872;6768.526203165928;6793.558418702769;6878.793636190922;6915.550489218184;6918.169819621477;6756.088422630199;6801.5238933274195;6838.521303508706;6922.342377474132;6944.236134025152 09:42:59 INFO - PID 21198 | |4;prototype.html;521.825188561832;526.9051570717271;536.8511385634741;550.246162757023;556.749462741766;6321.873562528746;6328.873422531552;6399.3600639935985;6405.3914878086625;6421.518386121042;6253.186575892985;6279.434850863421;6305.337939516354;6344.429001389874;6356.68216589171;5247.291615631898;5263.973680131604;5265.76304066318;5291.259223708684;5291.708956007418;5089.669171503859;5192.818251361203;5194.298769666103;5243.5093330668005;5279.049771041211;5120.641555091145;5156.974215128919;5169.793208271664;5173.896522069556;5182.844514664547;5113.667611605234;5136.357955255593;5153.484651534854;5165.922511162355;5201.141811601081;4746.762661866927;4747.7388743619085;4756.476787553366;4770.189067858472;4798.904021919542;6187.412195841388;6200.782972595937;6222.937770622327;6250.718717657716;6263.31103578606;5947.591225553658;5952.226210592638;5955.37468565803;5983.760649574056;5984.576246620126;6533.967330163367;6542.182227221598;6624.470042396645;6667.233268174125;6693.598384096969;5035.697858128524;5091.134507133796;5177.19753438214;5190.377154741417;5199.662021968597;6829.99999999995;6838.658067096625;6842.965785171043;6850.725970961155;6984.196817365966;5470.863228419322;5480.150576660624;5506.119020956708;5513.428672828225;5529.281193444826;5522.91715624266;5545.944540554624;5552.69460179694;5568.860778480571;5583.888322233533;6001.339852616209;6022.307434645072;6042;6044.274687037584;6052.303985041776;6676.9666151668935;6703.832404189934;6763.222229443677;6763.391294783493;6786.287439818847;1939.3697048459308;1940.9126589303514;1942.5629233422649;1959.7060440933974;1962.1170473287077;1362.4073528015344;1415.6602415420225;1425.7790042543422;1441.351391873661;1446.6383404148962;5601.355844077902;5657.179708942181;5682.488576028178;5697.544196464273;5710;6535.738570457129;6636.966815165893;6669.866602668017;6675.966620166965;6730.427913627299;5550.250716153349;5632.3804381518;5670.8015219467125;5698.857528561819;5724.828255152269;3551;3562.2341196642847;3577.94633080504;3605.549306336708;3622.3660859349507;6503.0411162920755;6515.576487528296;6589.604623722592;6603.966980165068;6637.269900310962;6715.429188518933;6732.192136943598;6768.593884366954;6785.253622101565;6791.694373753094;6452.387023232785;6489.123968264318;6524.184476940288;6525.445337146396;6527.902081468782;6727.596344219362;6747.628880411625;6784.864302714017;6831.897521537082;6832.145981752281;6674.199096108498;6744.662766861539;6751.122354093936;6763.560368576027;6765.830854228684;6415.166028416276;6455.580387274812;6472.870542589216;6478.384553467413;6523;5415.512603865671;5477.534409575231;5485.286912701324;5494.780208791603;5502.147167189092;6483.837904052436;6607.372299631527;6620.3710647488415;6689.431398331002;6703.631300278532;6269.467095296951;6418.679066046586;6445.8728619554495;6513.478921686348;6566.704498297684;6397.488200944006;6540.141316623215;6552.8361790955605;6575.934240657532;6605.669716514251;6340.334264902119;6405.19935008124;6409.134766806422;6442.871142577029;6466.450351719968;6575.50683698715;6601.537892347682;6623.470122390101;6661.233958094881;6665;6282.748690052346;6328.557001009885;6344.555881088464;6412.935870641234;6419.293877673359 09:42:59 INFO - PID 21198 | |5;yui.html;890.1365675294961;904.4347282948156;912.1927094521351;920.4385324951778;933.6265493802479;17865.01742404169;18364.17361218745;18476.260949562035;18493.260269589216;18498.075096245168;14983.101013939171;15002.849971500282;17978.01120938348;18134.63730725388;18367.357142500015;959.0601210813389;965.9565319560602;968.0754879090487;968.2834702320267;969.1471505075524;979.0845559401946;996.5515518016886;1000.9549570269319;1005.0652892809684;1005.140604782911;1056.9154467642609;1057.5399701129995;1057.8889216632258;1062.436908438529;1063.4257500949477;1043.2332235806675;1043.7651528406125;1050.0811789684026;1052.016364699005;1053.1995683280722;722.9096362954631;742.413493340266;760.1903972269515;760.2207737069492;772.7720322504874;20111.79888201114;20334.796652033438;20360.28738994128;20367.49081272965;20371.89814050935;21260.574788504142;21265;22354.32937011892;22429.775702243096;22464.213752518746;17513.824861751345;17559.20983555743;17596.648067038717;17634.647307053914;17709.7343539847;3769.660730534265;3789.5073640426845;3791.734578579473;3793.0517370657335;3812.4662547243406;139285;139414.30292848573;142153.28923355317;142596.28701856424;143162;16419.835801642068;16628.418005369753;16678.082705451317;16772.412965546147;16980.320787168373;30256.54615180774;30486.54270185949;31619.36761264808;31773.364532709216;32168.67831321657;8967.551622418852;8996.100389960951;9002.099790020946;9015.864762028576;9103.226225770884;3976.681865450757;3996.2806694794635;3997.5003124609425;4022.1151346703678;4075.1238483726142;5732.656040637575;5732.914006289909;5797.072468405035;5835.737391817378;5841.240638717025;996.1781530237583;1028.876534815827;1040.3185913226848;1040.505759764106;1041.7603951091291;678.3182901184279;688.370141320696;694.0872752330669;695.4575431163701;706.0397858911875;10677.252592318619;10803.405812680377;10953.890461095447;11319;11674.708132296591;664.0968283134932;672.0591172358639;678.0202607232502;678.6572780745691;680.5542369747823;5169.172932330809;5191.766370513336;5247.16045432729;5294;5322.201669749491;120931;121648.39175804064;121755.39122304332;122810.38594806968;127884;106269.46865265779;108167;111549;113397.86602134038;117961;94668;95519.52240238755;97690.02309976952;98130.50934745281;99472.50263748635;12248.632541023784;12469.251844889335;12725.23648581051;12804.61586152417;12881.742365152832;41936.3709544351;42226.155476890905;42720.35919461148;44057.339139912285;44272;56361;57464;57470.7126464365;57881.4211857876;58572.70713646404;18845.717314240024;18902.960337181587;19003.144858481126;19065.71401428952;19282.71075933834;19426.514337141685;19443.805561944766;19460.1242944065;19668.90165549163;19743;17544.736828947833;17708;17760.822391775917;17830.37593684215;17895;17074.48776536706;17341;17349.21928513245;17619.119044048002;17827.376041838474;17617.647647047244;17682.5579360517;17807.376741813976;17826.643467130845;17862.374816881347;13052.21686698801;13208.141470804367;13240.933795330962;13448.798268026183;13545.59363219105;11882.702932426759;11936.52253909834;12285.815712764137;12356.196847204903;12497.18768280059 09:42:59 INFO - PID 21198 | __end_tp_report 09:42:59 INFO - PID 21198 | __start_cc_report 09:42:59 INFO - PID 21198 | _x_x_mozilla_cycle_collect,301 09:42:59 INFO - PID 21198 | __end_cc_report 09:42:59 INFO - PID 21198 | __startTimestamp1506012179587__endTimestamp 09:42:59 INFO - PID 21198 | 09:42:59 INFO - PID 21198 | ------- Summary: start ------- 09:42:59 INFO - PID 21198 | Number of tests: 6 09:42:59 INFO - PID 21198 | 09:42:59 INFO - PID 21198 | [#0] dojo.html Cycles:165 Average:6217.64 Median:6466.45 stddev:838.10 (13.0%) stddev-sans-first:804.81 09:42:59 INFO - PID 21198 | Values: 3126.2 3166.6 3195.8 3229.1 3234.1 6216.0 6334.5 6344.3 6394.7 6472.6 6288.7 6301.5 6313.1 6317.7 6353.3 5818.6 5832.0 5853.6 5905.6 5941.1 5893.3 5926.1 5950.8 5951.4 5992.7 1254.2 5778.2 5797.8 5895.2 5983.7 5780.5 5841.6 5919.9 5921.8 5923.1 5815.9 5826.1 5887.1 5889.5 5891.0 6243.7 6308.0 6379.0 6395.6 6417.6 6769.8 6795.4 6803.5 6870.8 6890.3 6654.6 6800.1 6813.1 6904.8 6939.9 6353.3 6366.6 6386.1 6433.0 6439.1 7041.8 7049.2 7124.0 7129.9 7134.8 6500.1 6622.6 6636.7 6678.0 6738.8 6755.0 6768.2 6772.2 6778.7 6778.9 6651.7 6721.6 6731.5 6735.7 6741.1 6770.7 6783.4 6785.4 6790.5 6880.7 5351.9 5380.7 5419.2 5420.3 5422.3 4675.3 4699.5 4712.9 4723.5 4728.8 5586.0 5771.8 5788.9 5863.8 5867.9 6764.5 6779.3 6781.1 6782.3 6787.2 5721.8 5740.9 5753.1 5753.7 5754.5 5783.5 5836.9 5853.1 5894.2 5922.1 6291.9 6412.6 6552.9 6672.1 6686.9 6870.7 6931.8 6933.8 6934.2 6943.9 6511.5 6555.6 6570.0 6598.6 6661.0 6493.6 6659.8 6728.1 6741.7 6821.7 6655.2 6678.1 6682.7 6688.4 6694.3 5967.4 6426.6 6593.8 6691.4 6714.4 6569.4 6581.7 6585.1 6673.8 6688.7 6351.9 6466.5 6493.4 6521.1 6613.7 6630.7 6649.3 6668.4 6719.3 6738.3 6446.1 6460.5 6463.8 6528.6 6550.2 09:42:59 INFO - PID 21198 | 09:42:59 INFO - PID 21198 | [#1] ext.html Cycles:180 Average:37761.10 Median:3578.40 stddev:53973.06 (1508.3%) stddev-sans-first:54053.35 09:42:59 INFO - PID 21198 | Values: 862.5 874.8 906.9 909.3 912.0 41147.6 41667.4 41739.8 42144.2 42147.6 38642.0 38778.6 40651.4 41271.6 41286.4 7901.7 7984.2 8030.5 8058.2 8063.3 7853.2 8018.2 8022.8 8034.0 8034.9 7927.4 7942.3 8017.6 8020.1 8050.5 7936.5 7938.3 7947.8 8004.8 8016.8 7823.3 7845.3 7849.3 7860.1 7871.9 37620.6 38015.8 38093.6 38144.6 38163.2 3555.5 3564.3 3568.1 3588.7 3601.6 31022.4 31079.4 31095.2 31154.2 31171.7 5052.0 5186.1 5210.8 5216.1 5247.8 184721.0 187918.0 188446.0 189003.0 189657.0 42061.8 48418.0 49204.5 49612.8 49689.3 50793.0 51222.2 51300.5 51328.7 51520.7 14875.9 14900.3 15011.8 15019.1 15118.5 12192.0 12325.8 12326.7 12327.8 12336.3 12924.7 12966.9 13025.9 13074.3 13259.7 4940.8 4992.8 5006.9 5009.4 5054.0 1009.1 1009.6 1014.2 1019.0 1028.4 22955.3 22972.5 22977.5 23098.9 23299.0 1091.2 1094.2 1106.8 1109.1 1115.9 12146.8 12152.6 12225.6 12323.2 12328.2 236983.0 237182.0 237817.0 238492.0 238584.0 51340.0 51582.7 51621.0 51650.5 51693.5 1383.2 1427.2 1427.5 1438.6 1438.9 22199.7 22331.3 22466.9 22697.7 22991.5 36689.0 36704.0 36811.3 36841.3 36844.3 193875.0 194906.0 195413.0 196202.0 196598.0 34527.3 34757.1 35449.6 36249.0 36371.3 45338.0 46609.0 46626.5 46936.1 47065.8 33398.5 33636.8 33703.7 33780.0 34421.0 32385.8 33005.8 33120.7 33262.2 33544.3 36859.4 37279.4 37325.3 37392.3 37541.2 32609.2 32726.5 32737.0 32783.7 32789.2 24428.8 24670.5 24864.4 25068.7 25092.4 09:42:59 INFO - PID 21198 | 09:42:59 INFO - PID 21198 | [#2] jquery.html Cycles:180 Average:33163.10 Median:22843.16 stddev:78072.36 (341.8%) stddev-sans-first:78253.07 09:42:59 INFO - PID 21198 | Values: 590.5 595.9 598.4 609.0 630.3 21840.6 22729.7 22741.5 22753.2 22809.7 21594.1 23880.3 24084.5 24093.2 24129.0 6616.5 6696.6 6705.6 6729.0 6739.7 6380.6 6616.6 6644.7 6720.5 6721.2 6585.6 6598.9 6607.4 6608.8 6609.6 6594.4 6601.1 6608.2 6610.3 6616.7 5860.5 6137.0 6154.0 6156.9 6158.4 27325.7 27767.3 27789.2 27790.4 27865.7 2068.7 2071.5 2078.0 2084.4 2098.5 17456.7 17546.8 17777.3 17863.4 17911.9 2417.0 2473.0 2473.8 2475.4 2489.0 117145.4 122116.4 122723.4 123179.4 138621.0 13948.9 14522.7 14601.3 14686.3 14769.1 22662.4 23211.7 23229.3 23471.2 23527.2 9229.4 9286.7 9529.1 9532.6 9575.5 8336.7 8403.2 8454.5 8582.4 8587.7 9004.5 9052.4 9084.8 9264.2 9335.3 2573.8 2606.6 2688.7 2755.7 2769.0 951.5 953.7 961.9 990.2 998.6 18622.1 18652.6 19020.3 19158.9 19289.0 1005.8 1010.7 1018.9 1026.2 1029.1 10483.6 10497.4 10635.5 10715.0 10763.6 458231.0 459746.0 461880.0 462351.0 475994.0 113077.0 115008.4 117465.0 117659.0 118526.0 1119.1 1140.2 1145.0 1157.7 1159.5 16780.1 16863.9 16892.5 17373.0 17569.1 51588.5 52184.0 52282.7 52510.2 52545.7 63855.7 68299.7 68527.7 68731.0 68919.7 14403.4 14877.4 14953.7 14984.8 14991.6 22458.7 22525.2 22566.4 22687.3 22876.7 17599.6 17931.6 17981.7 18149.9 18166.1 15758.8 16296.4 16590.8 16720.8 17058.8 17182.2 18077.2 18413.3 18448.4 18512.3 14538.1 14559.0 14628.5 14637.6 14649.3 17859.1 17942.1 18017.5 18036.6 18258.7 09:42:59 INFO - PID 21198 | 09:42:59 INFO - PID 21198 | [#3] mootools.html Cycles:180 Average:9397.87 Median:15053.72 stddev:6770.29 (45.0%) stddev-sans-first:6762.08 09:42:59 INFO - PID 21198 | Values: 1320.2 1371.0 1373.0 1378.2 1384.2 14733.3 15297.0 15311.0 15323.4 15347.6 15009.8 15183.2 15196.6 15221.8 15289.0 2766.1 2819.4 2841.8 2861.2 2865.8 2729.5 2753.5 2769.0 2770.2 2771.9 2674.1 2723.3 2800.2 2802.5 2803.6 2753.9 2828.0 2854.8 2856.9 2857.3 2712.3 2725.4 2725.6 2736.4 2738.3 15055.9 15309.5 15369.9 15398.6 15413.3 7870.4 8135.2 8167.4 8198.6 8203.3 5065.8 5156.6 5287.0 5366.5 5373.3 1918.9 1943.3 1948.7 1948.8 1987.0 27127.1 27177.6 27369.2 27415.7 27711.7 6898.6 7103.4 7129.9 7291.8 7330.2 17594.9 17599.2 17612.5 17621.0 17670.8 8024.5 8305.8 8585.9 8662.1 8666.9 7553.5 7675.5 7676.0 7685.3 7695.3 5375.1 5548.7 5554.1 5584.3 5610.6 1530.6 1535.9 1609.5 1615.7 1637.7 862.1 877.2 895.4 901.3 903.0 8418.5 8553.3 8619.8 8668.6 8688.3 969.1 969.3 979.1 979.7 982.5 5081.8 5213.0 5257.9 5267.3 5273.7 21541.4 21783.2 22636.5 22700.1 22713.8 21111.7 21376.7 21975.1 22684.5 22733.8 10913.2 11119.0 11180.0 11239.9 11270.1 8388.9 8553.4 8556.7 8581.8 8591.3 18240.4 18709.4 18859.8 18986.7 19036.1 18343.3 18801.2 18818.0 18935.6 19613.9 9720.6 9950.8 9959.0 10066.8 10081.8 13476.8 13644.9 13663.7 13670.9 13714.7 10422.8 10524.9 10537.7 10607.0 10868.7 11123.4 11294.1 11503.2 11518.8 11667.2 9928.7 10114.6 10123.5 10145.9 10207.2 6768.5 6793.6 6878.8 6915.6 6918.2 6756.1 6801.5 6838.5 6922.3 6944.2 09:42:59 INFO - PID 21198 | 09:42:59 INFO - PID 21198 | [#4] prototype.html Cycles:180 Average:5628.61 Median:6266.39 stddev:1499.23 (23.9%) stddev-sans-first:1453.62 09:42:59 INFO - PID 21198 | Values: 521.8 526.9 536.9 550.2 556.7 6321.9 6328.9 6399.4 6405.4 6421.5 6253.2 6279.4 6305.3 6344.4 6356.7 5247.3 5264.0 5265.8 5291.3 5291.7 5089.7 5192.8 5194.3 5243.5 5279.0 5120.6 5157.0 5169.8 5173.9 5182.8 5113.7 5136.4 5153.5 5165.9 5201.1 4746.8 4747.7 4756.5 4770.2 4798.9 6187.4 6200.8 6222.9 6250.7 6263.3 5947.6 5952.2 5955.4 5983.8 5984.6 6534.0 6542.2 6624.5 6667.2 6693.6 5035.7 5091.1 5177.2 5190.4 5199.7 6830.0 6838.7 6843.0 6850.7 6984.2 5470.9 5480.2 5506.1 5513.4 5529.3 5522.9 5545.9 5552.7 5568.9 5583.9 6001.3 6022.3 6042.0 6044.3 6052.3 6677.0 6703.8 6763.2 6763.4 6786.3 1939.4 1940.9 1942.6 1959.7 1962.1 1362.4 1415.7 1425.8 1441.4 1446.6 5601.4 5657.2 5682.5 5697.5 5710.0 6535.7 6637.0 6669.9 6676.0 6730.4 5550.3 5632.4 5670.8 5698.9 5724.8 3551.0 3562.2 3577.9 3605.5 3622.4 6503.0 6515.6 6589.6 6604.0 6637.3 6715.4 6732.2 6768.6 6785.3 6791.7 6452.4 6489.1 6524.2 6525.4 6527.9 6727.6 6747.6 6784.9 6831.9 6832.1 6674.2 6744.7 6751.1 6763.6 6765.8 6415.2 6455.6 6472.9 6478.4 6523.0 5415.5 5477.5 5485.3 5494.8 5502.1 6483.8 6607.4 6620.4 6689.4 6703.6 6269.5 6418.7 6445.9 6513.5 6566.7 6397.5 6540.1 6552.8 6575.9 6605.7 6340.3 6405.2 6409.1 6442.9 6466.5 6575.5 6601.5 6623.5 6661.2 6665.0 6282.7 6328.6 6344.6 6412.9 6419.3 09:42:59 INFO - PID 21198 | 09:42:59 INFO - PID 21198 | [#5] yui.html Cycles:180 Average:24812.46 Median:19174.21 stddev:35665.71 (186.0%) stddev-sans-first:35720.53 09:42:59 INFO - PID 21198 | Values: 890.1 904.4 912.2 920.4 933.6 17865.0 18364.2 18476.3 18493.3 18498.1 14983.1 15002.8 17978.0 18134.6 18367.4 959.1 966.0 968.1 968.3 969.1 979.1 996.6 1001.0 1005.1 1005.1 1056.9 1057.5 1057.9 1062.4 1063.4 1043.2 1043.8 1050.1 1052.0 1053.2 722.9 742.4 760.2 760.2 772.8 20111.8 20334.8 20360.3 20367.5 20371.9 21260.6 21265.0 22354.3 22429.8 22464.2 17513.8 17559.2 17596.6 17634.6 17709.7 3769.7 3789.5 3791.7 3793.1 3812.5 139285.0 139414.3 142153.3 142596.3 143162.0 16419.8 16628.4 16678.1 16772.4 16980.3 30256.5 30486.5 31619.4 31773.4 32168.7 8967.6 8996.1 9002.1 9015.9 9103.2 3976.7 3996.3 3997.5 4022.1 4075.1 5732.7 5732.9 5797.1 5835.7 5841.2 996.2 1028.9 1040.3 1040.5 1041.8 678.3 688.4 694.1 695.5 706.0 10677.3 10803.4 10953.9 11319.0 11674.7 664.1 672.1 678.0 678.7 680.6 5169.2 5191.8 5247.2 5294.0 5322.2 120931.0 121648.4 121755.4 122810.4 127884.0 106269.5 108167.0 111549.0 113397.9 117961.0 94668.0 95519.5 97690.0 98130.5 99472.5 12248.6 12469.3 12725.2 12804.6 12881.7 41936.4 42226.2 42720.4 44057.3 44272.0 56361.0 57464.0 57470.7 57881.4 58572.7 18845.7 18903.0 19003.1 19065.7 19282.7 19426.5 19443.8 19460.1 19668.9 19743.0 17544.7 17708.0 17760.8 17830.4 17895.0 17074.5 17341.0 17349.2 17619.1 17827.4 17617.6 17682.6 17807.4 17826.6 17862.4 13052.2 13208.1 13240.9 13448.8 13545.6 11882.7 11936.5 12285.8 12356.2 12497.2 09:42:59 INFO - PID 21198 | -------- Summary: end -------- 09:42:59 INFO - PID 21198 | 09:43:00 INFO - TEST-INFO | 21198: exit 0 09:43:00 INFO - TEST-OK | dromaeo_css | took 1108833ms 09:43:00 INFO - TEST-START | kraken 09:43:00 INFO - Initialising browser for kraken test... 09:43:00 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:36889/getInfo.html -profile /tmp/tmpo_seeD/profile 09:43:00 INFO - TEST-INFO | started process 21569 (/builds/slave/test/build/application/firefox/firefox http://localhost:36889/getInfo.html) 09:43:05 INFO - TEST-INFO | 21569: exit 0 09:43:05 INFO - Browser initialized. 09:43:05 INFO - Running cycle 1/1 for kraken test... 09:43:05 INFO - Using env: {'DISPLAY': ':0', 09:43:05 INFO - 'HOME': '/home/cltbld', 09:43:05 INFO - 'JSGC_DISABLE_POISONING': '1', 09:43:05 INFO - 'LANG': 'en_US.UTF-8', 09:43:05 INFO - 'LANGUAGE': 'en_US:en', 09:43:05 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 09:43:05 INFO - 'LOGNAME': 'cltbld', 09:43:05 INFO - 'MAIL': '/var/mail/cltbld', 09:43:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:43:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:43:05 INFO - 'MOZ_CRASHREPORTER': '1', 09:43:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:43:05 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 09:43:05 INFO - 'MOZ_NO_REMOTE': '1', 09:43:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 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': '/builds/slave/test/build/venv/bin:/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 - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:43:05 INFO - 'RUST_BACKTRACE': 'full', 09:43:05 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 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': '0333a256a5e4f052382dd180000001b1-1506011013.417489-617014136', 09:43:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:43:05 INFO - '_': '/tools/buildbot/bin/python'} 09:43:05 INFO - TEST-INFO | started process 21808 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpo_seeD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 09:43:06 INFO - PID 21808 | 09:43:06 INFO - PID 21808 | (/builds/slave/test/build/application/firefox/firefox:21858): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 09:43:06 INFO - PID 21808 | 09:43:16 INFO - PID 21808 | RSS: Main: 154333184 09:43:16 INFO - PID 21808 | 09:43:19 INFO - PID 21808 | Cycle 1(1): loaded http://localhost:36889/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36889/tests/kraken/driver.html?testName=audio-beat-detection) 09:43:20 INFO - PID 21808 | RSS: Main: 161005568 09:43:20 INFO - PID 21808 | 09:43:22 INFO - PID 21808 | Cycle 1(1): loaded http://localhost:36889/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36889/tests/kraken/driver.html?testName=audio-dft) 09:43:23 INFO - PID 21808 | RSS: Main: 160931840 09:43:23 INFO - PID 21808 | 09:43:26 INFO - PID 21808 | Cycle 1(1): loaded http://localhost:36889/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36889/tests/kraken/driver.html?testName=audio-fft) 09:43:26 INFO - PID 21808 | RSS: Main: 156729344 09:43:26 INFO - PID 21808 | 09:43:29 INFO - PID 21808 | Cycle 1(1): loaded http://localhost:36889/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36889/tests/kraken/driver.html?testName=audio-oscillator) 09:43:29 INFO - PID 21808 | RSS: Main: 156925952 09:43:29 INFO - PID 21808 | 09:43:31 INFO - PID 21808 | Cycle 1(1): loaded http://localhost:36889/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36889/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:43:32 INFO - PID 21808 | RSS: Main: 157331456 09:43:32 INFO - PID 21808 | 09:43:35 INFO - PID 21808 | Cycle 1(1): loaded http://localhost:36889/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36889/tests/kraken/driver.html?testName=imaging-darkroom) 09:43:36 INFO - PID 21808 | RSS: Main: 159723520 09:43:36 INFO - PID 21808 | 09:43:39 INFO - PID 21808 | Cycle 1(1): loaded http://localhost:36889/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36889/tests/kraken/driver.html?testName=imaging-desaturate) 09:43:40 INFO - PID 21808 | RSS: Main: 160378880 09:43:40 INFO - PID 21808 | 09:43:43 INFO - PID 21808 | Cycle 1(1): loaded http://localhost:36889/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36889/tests/kraken/driver.html?testName=json-parse-financial) 09:43:44 INFO - PID 21808 | RSS: Main: 160579584 09:43:44 INFO - PID 21808 | 09:43:45 INFO - PID 21808 | Cycle 1(1): loaded http://localhost:36889/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36889/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:43:46 INFO - PID 21808 | RSS: Main: 160477184 09:43:46 INFO - PID 21808 | 09:43:47 INFO - PID 21808 | Cycle 1(1): loaded http://localhost:36889/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36889/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:43:48 INFO - PID 21808 | RSS: Main: 160358400 09:43:48 INFO - PID 21808 | 09:43:50 INFO - PID 21808 | Cycle 1(1): loaded http://localhost:36889/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36889/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:43:51 INFO - PID 21808 | RSS: Main: 157687808 09:43:51 INFO - PID 21808 | 09:43:53 INFO - PID 21808 | Cycle 1(1): loaded http://localhost:36889/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36889/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:43:54 INFO - PID 21808 | RSS: Main: 157999104 09:43:54 INFO - PID 21808 | 09:43:57 INFO - PID 21808 | Cycle 1(1): loaded http://localhost:36889/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36889/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:43:57 INFO - PID 21808 | RSS: Main: 157904896 09:43:57 INFO - PID 21808 | 09:43:59 INFO - PID 21808 | Cycle 1(1): loaded http://localhost:36889/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36889/tests/kraken/driver.html?testName=ai-astar) 09:43:59 INFO - PID 21808 | RSS: Main: 158769152 09:43:59 INFO - PID 21808 | 09:43:59 INFO - PID 21808 | __start_tp_report 09:43:59 INFO - PID 21808 | _x_x_mozilla_page_load 09:43:59 INFO - PID 21808 | _x_x_mozilla_page_load_details 09:43:59 INFO - PID 21808 | |i|pagename|runs| 09:43:59 INFO - PID 21808 | |0;ai-astar;108;107;109;108;109;107;108;107;109;108 09:43:59 INFO - PID 21808 | |1;audio-beat-detection;119;124;119;117;138;122;120;118;117;118 09:43:59 INFO - PID 21808 | |2;audio-dft;162;162;163;162;165;161;163;163;165;169 09:43:59 INFO - PID 21808 | |3;audio-fft;74;76;74;74;76;74;73;73;74;76 09:43:59 INFO - PID 21808 | |4;audio-oscillator;80;80;79;80;79;79;80;80;80;79 09:43:59 INFO - PID 21808 | |5;imaging-gaussian-blur;113;114;113;114;114;114;111;115;115;114 09:43:59 INFO - PID 21808 | |6;imaging-darkroom;153;148;148;148;148;147;149;149;147;148 09:43:59 INFO - PID 21808 | |7;imaging-desaturate;93;94;95;93;94;95;95;100;93;101 09:43:59 INFO - PID 21808 | |8;json-parse-financial;54;53;53;51;55;53;54;53;54;54 09:43:59 INFO - PID 21808 | |9;json-stringify-tinderbox;39;39;38;39;38;39;39;38;39;39 09:43:59 INFO - PID 21808 | |10;stanford-crypto-aes;74;72;71;81;75;73;74;74;77;73 09:43:59 INFO - PID 21808 | |11;stanford-crypto-ccm;111;128;110;114;111;109;114;116;121;116 09:43:59 INFO - PID 21808 | |12;stanford-crypto-pbkdf2;165;168;164;167;166;174;168;166;176;178 09:43:59 INFO - PID 21808 | |13;stanford-crypto-sha256-iterative;71;68;66;66;68;65;67;68;64;67 09:43:59 INFO - PID 21808 | __end_tp_report 09:43:59 INFO - PID 21808 | __start_cc_report 09:43:59 INFO - PID 21808 | _x_x_mozilla_cycle_collect,736 09:43:59 INFO - PID 21808 | __end_cc_report 09:43:59 INFO - PID 21808 | __startTimestamp1506012239975__endTimestamp 09:43:59 INFO - PID 21808 | 09:43:59 INFO - PID 21808 | ------- Summary: start ------- 09:43:59 INFO - PID 21808 | Number of tests: 14 09:43:59 INFO - PID 21808 | 09:43:59 INFO - PID 21808 | [#0] ai-astar Cycles:10 Average:108.00 Median:108.00 stddev:0.82 (0.8%) stddev-sans-first:0.87 09:43:59 INFO - PID 21808 | Values: 108.0 107.0 109.0 108.0 109.0 107.0 108.0 107.0 109.0 108.0 09:43:59 INFO - PID 21808 | 09:43:59 INFO - PID 21808 | [#1] audio-beat-detection Cycles:10 Average:121.20 Median:119.50 stddev:6.30 (5.3%) stddev-sans-first:6.64 09:43:59 INFO - PID 21808 | Values: 119.0 124.0 119.0 117.0 138.0 122.0 120.0 118.0 117.0 118.0 09:43:59 INFO - PID 21808 | 09:43:59 INFO - PID 21808 | [#2] audio-dft Cycles:10 Average:163.50 Median:163.00 stddev:2.32 (1.4%) stddev-sans-first:2.40 09:43:59 INFO - PID 21808 | Values: 162.0 162.0 163.0 162.0 165.0 161.0 163.0 163.0 165.0 169.0 09:43:59 INFO - PID 21808 | 09:43:59 INFO - PID 21808 | [#3] audio-fft Cycles:10 Average:74.40 Median:74.00 stddev:1.17 (1.6%) stddev-sans-first:1.24 09:43:59 INFO - PID 21808 | Values: 74.0 76.0 74.0 74.0 76.0 74.0 73.0 73.0 74.0 76.0 09:43:59 INFO - PID 21808 | 09:43:59 INFO - PID 21808 | [#4] audio-oscillator Cycles:10 Average:79.60 Median:80.00 stddev:0.52 (0.6%) stddev-sans-first:0.53 09:43:59 INFO - PID 21808 | Values: 80.0 80.0 79.0 80.0 79.0 79.0 80.0 80.0 80.0 79.0 09:43:59 INFO - PID 21808 | 09:43:59 INFO - PID 21808 | [#5] imaging-gaussian-blur Cycles:10 Average:113.70 Median:114.00 stddev:1.16 (1.0%) stddev-sans-first:1.20 09:43:59 INFO - PID 21808 | Values: 113.0 114.0 113.0 114.0 114.0 114.0 111.0 115.0 115.0 114.0 09:43:59 INFO - PID 21808 | 09:43:59 INFO - PID 21808 | [#6] imaging-darkroom Cycles:10 Average:148.50 Median:148.00 stddev:1.72 (1.2%) stddev-sans-first:0.71 09:43:59 INFO - PID 21808 | Values: 153.0 148.0 148.0 148.0 148.0 147.0 149.0 149.0 147.0 148.0 09:43:59 INFO - PID 21808 | 09:43:59 INFO - PID 21808 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:94.00 stddev:2.87 (3.1%) stddev-sans-first:2.92 09:43:59 INFO - PID 21808 | Values: 93.0 94.0 95.0 93.0 94.0 95.0 95.0 100.0 93.0 101.0 09:43:59 INFO - PID 21808 | 09:43:59 INFO - PID 21808 | [#8] json-parse-financial Cycles:10 Average:53.40 Median:54.00 stddev:1.07 (2.0%) stddev-sans-first:1.12 09:43:59 INFO - PID 21808 | Values: 54.0 53.0 53.0 51.0 55.0 53.0 54.0 53.0 54.0 54.0 09:43:59 INFO - PID 21808 | 09:43:59 INFO - PID 21808 | [#9] json-stringify-tinderbox Cycles:10 Average:38.70 Median:39.00 stddev:0.48 (1.2%) stddev-sans-first:0.50 09:43:59 INFO - PID 21808 | Values: 39.0 39.0 38.0 39.0 38.0 39.0 39.0 38.0 39.0 39.0 09:43:59 INFO - PID 21808 | 09:43:59 INFO - PID 21808 | [#10] stanford-crypto-aes Cycles:10 Average:74.40 Median:74.00 stddev:2.84 (3.8%) stddev-sans-first:3.00 09:43:59 INFO - PID 21808 | Values: 74.0 72.0 71.0 81.0 75.0 73.0 74.0 74.0 77.0 73.0 09:43:59 INFO - PID 21808 | 09:43:59 INFO - PID 21808 | [#11] stanford-crypto-ccm Cycles:10 Average:115.00 Median:115.00 stddev:5.79 (5.0%) stddev-sans-first:5.96 09:43:59 INFO - PID 21808 | Values: 111.0 128.0 110.0 114.0 111.0 109.0 114.0 116.0 121.0 116.0 09:43:59 INFO - PID 21808 | 09:43:59 INFO - PID 21808 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.20 Median:168.00 stddev:4.94 (2.9%) stddev-sans-first:5.00 09:43:59 INFO - PID 21808 | Values: 165.0 168.0 164.0 167.0 166.0 174.0 168.0 166.0 176.0 178.0 09:43:59 INFO - PID 21808 | 09:43:59 INFO - PID 21808 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.00 Median:67.50 stddev:1.94 (2.9%) stddev-sans-first:1.42 09:43:59 INFO - PID 21808 | Values: 71.0 68.0 66.0 66.0 68.0 65.0 67.0 68.0 64.0 67.0 09:43:59 INFO - PID 21808 | -------- Summary: end -------- 09:43:59 INFO - PID 21808 | 09:44:00 INFO - PID 21808 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 09:44:00 INFO - TEST-INFO | 21808: exit 0 09:44:00 INFO - TEST-OK | kraken | took 60409ms 09:44:00 INFO - SUITE-END | took 1169s 09:44:00 INFO - Completed test suite (00:19:29) 09:44:00 INFO - javascript benchmark 09:44:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8570.82636891083, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3126.218445388653, 3166.572512710784, 3195.7603179761495, 3229.079712282, 3234.110619579617, 6216.0, 6334.524910631698, 6344.3338449462835, 6394.744210231591, 6472.5792823466445, 6288.654124023188, 6301.495880329563, 6313.147725057116, 6317.652529110897, 6353.269374021989, 5818.592698511116, 5831.970840145794, 5853.5902486825935, 5905.586608937355, 5941.079132734433, 5893.322267939177, 5926.081457374114, 5950.821475355746, 5951.375105613914, 5992.700364981755, 1254.2432658819373, 5778.248827652378, 5797.768089276424, 5895.233619629442, 5983.670898100603, 5780.479756821865, 5841.6495010299095, 5919.911201331984, 5921.763129474816, 5923.08192230205, 5815.93979869814, 5826.067829147316, 5887.0580707086665, 5889.469947704727, 5890.970545147246, 6243.719032643542, 6308.0, 6379.0, 6395.584287021329, 6417.647029413381, 6769.796906092825, 6795.422389096932, 6803.48973826965, 6870.7595234167065, 6890.31096890312, 6654.633995130266, 6800.149981252343, 6813.080234168373, 6904.758333458305, 6939.861202775916, 6353.30113687494, 6366.586171898812, 6386.10594516768, 6433.0, 6439.066335381343, 7041.788746337618, 7049.224585295613, 7124.038254835531, 7129.89305160423, 7134.750283740044, 6500.122483464766, 6622.635755033423, 6636.701348439332, 6678.031685405589, 6738.797836064926, 6754.966225168941, 6768.221654509696, 6772.153480814898, 6778.694958726869, 6778.864422711518, 6651.733930642817, 6721.563098398588, 6731.528792984444, 6735.696893639798, 6741.0899528564, 6770.661466926733, 6783.3555812197765, 6785.355391237825, 6790.456763458911, 6880.724771009203, 5351.946480535223, 5380.704061276668, 5419.187121931663, 5420.349558053059, 5422.349318081855, 4675.29870519418, 4699.459562150397, 4712.858614241578, 4723.45680246776, 4728.763561821896, 5585.972070139624, 5771.797987070432, 5788.871170121786, 5863.824085277449, 5867.911981320283, 6764.458843292525, 6779.3220677932795, 6781.118454600969, 6782.287859774653, 6787.185537735503, 5721.77112915487, 5740.913886291709, 5753.079507278815, 5753.654780713086, 5754.539636829044, 5783.537317014629, 5836.854078648068, 5853.1220316952795, 5894.204282421904, 5922.141289512996, 6291.905621415683, 6412.583182093243, 6552.868942621121, 6672.065910772496, 6686.899696504556, 6870.690818913061, 6931.7522845887215, 6933.826654333682, 6934.237233904368, 6943.930560694429, 6511.47908167336, 6555.573887697285, 6569.967150164219, 6598.571092878948, 6661.034150048313, 6493.642849643126, 6659.766908158192, 6728.05807187004, 6741.662916854236, 6821.658917054227, 6655.168103987002, 6678.065070889982, 6682.69927853238, 6688.3646053624825, 6694.29709880475, 5967.433093856251, 6426.614403135827, 6593.769218077345, 6691.397774200345, 6714.429273511806, 6569.408753212234, 6581.736730530725, 6585.078089067439, 6673.833154171185, 6688.6990085445295, 6351.904721429275, 6466.4503517201565, 6493.415592596689, 6521.119648847345, 6613.66931653425, 6630.701618427279, 6649.335066493312, 6668.399844014062, 6719.260881302955, 6738.258791533026, 6446.129772480843, 6460.547761656639, 6463.806085817433, 6528.608283503005, 6550.181227346582], "value": 6157.551662174427, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [862.495440167502, 874.794423310522, 906.8821053263075, 909.2589539525286, 912.0241341764313, 41147.58852411475, 41667.37498937518, 41739.79130104345, 42144.15711685764, 42147.57852421479, 38642.0, 38778.61221387785, 40651.390229146586, 41271.58728412715, 41286.38070428946, 7901.683932642687, 7984.201579841998, 8030.478018928751, 8058.15389384115, 8063.314618257456, 7853.175416581234, 8018.158093400168, 8022.759317220492, 8034.0, 8034.919650803476, 7927.40544459165, 7942.285194332509, 8017.639206235734, 8020.077691065544, 8050.476719013274, 7936.523808571505, 7938.325242354407, 7947.761567152966, 8004.839903201932, 8016.799580010488, 7823.295903368724, 7845.254700803414, 7849.254320839511, 7860.0567931848545, 7871.858580505795, 37620.62379376199, 38015.809920950494, 38093.61906380928, 38144.61855381438, 38163.23673526542, 3555.5377800885976, 3564.3405969895653, 3568.1436455250814, 3588.659077387644, 3601.6398360164035, 31022.379552409053, 31079.378412431626, 31095.22261943447, 31154.22114447157, 31171.68828311733, 5052.0, 5186.118359878829, 5210.843674689765, 5216.061109000379, 5247.763850626693, 184721.0, 187918.0, 188445.99999999863, 189003.0, 189657.0, 42061.78969105196, 48418.0, 49204.507954919995, 49612.751936240085, 49689.25466118011, 50793.0, 51222.23166652503, 51300.48699513032, 51328.74335628298, 51520.74239628853, 14875.925620371829, 14900.254987250593, 15011.774823377658, 15019.09885406879, 15118.546443606709, 12192.0, 12325.767423257603, 12326.691832704255, 12327.75344493123, 12336.259824410565, 12924.676883077811, 12966.935165324114, 13025.934870325777, 13074.280914549601, 13259.66850828737, 4940.802367905316, 4992.825251116194, 5006.89986200274, 5009.44896061433, 5054.039732450822, 1009.1371877045168, 1009.6314845081639, 1014.1734486393566, 1018.994905025485, 1028.3983869436313, 22955.311340659806, 22972.54054918892, 22977.54044919092, 23098.884505577364, 23299.0, 1091.1568550412428, 1094.2340361746808, 1106.7620461600634, 1109.1459576126338, 1115.8995690387903, 12146.75706485883, 12152.635420937386, 12225.572104976283, 12323.198992065487, 12328.19866708679, 236983.0, 237182.0, 237817.0, 238492.0, 238584.0, 51340.0, 51582.742086290076, 51621.0, 51650.48349516532, 51693.48306516962, 1383.156274672449, 1427.229296180072, 1427.5431861804332, 1438.590540419213, 1438.9352479138463, 22199.667004994615, 22331.330060098222, 22466.887665561568, 22697.659535107316, 22991.54016919686, 36689.0, 36704.0, 36811.26377472489, 36841.263174736894, 36844.26311473702, 193875.0, 194906.0, 195413.02293488442, 196202.0, 196598.0, 34527.30945381028, 34757.13107172341, 35449.645503544634, 36249.0, 36371.27257454889, 45338.0, 46609.0, 46626.53373466222, 46936.06127877492, 47065.764671176425, 33398.49902251517, 33636.831815840764, 33703.66296337005, 33780.0, 34421.0, 32385.838070809496, 33005.834970824995, 33120.66879331176, 33262.168445788084, 33544.32911341711, 36859.447108293934, 37279.44080838736, 37325.25349493049, 37392.25215495729, 37541.24917501689, 32609.18477038093, 32726.50910236396, 32737.0, 32783.67216327806, 32789.18027049343, 24428.75571244265, 24670.506589867742, 24864.37839054038, 25068.74931250737, 25092.37269068215], "value": 17183.616219737494, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [590.4744777148336, 595.868908840055, 598.3717097048099, 608.987820243595, 630.2940706408823, 21840.563188736214, 22729.659055114167, 22741.545169096607, 22753.2036378727, 22809.657855132187, 21594.1362345506, 23880.283591492283, 24084.518309633797, 24093.15673951412, 24129.0, 6616.53684242102, 6696.631685257309, 6705.631190284533, 6729.0, 6739.663016849163, 6380.585261957958, 6616.569922955016, 6644.66776661165, 6720.462363010972, 6721.193456785192, 6585.637789921552, 6598.93401065988, 6607.372299631527, 6608.801735947929, 6609.570377925419, 6594.439472644807, 6601.141851559315, 6608.240052393964, 6610.272869984298, 6616.735330586819, 5860.531157507389, 6137.048757442603, 6154.046122850965, 6156.938430615682, 6158.414950579688, 27325.726742732517, 27767.305817354525, 27789.166325010283, 27790.444191116265, 27865.721342786514, 2068.6896965455153, 2071.54426026274, 2077.979220207794, 2084.374687593716, 2098.548812005411, 17456.738148927776, 17546.824531754773, 17777.288908443647, 17863.374781882703, 17911.910440447715, 2417.045267119478, 2473.0478765675166, 2473.789727873133, 2475.39352858549, 2489.0, 117145.41427292895, 122116.38941805322, 122723.38638306841, 123179.3841030798, 138621.0, 13948.86051139496, 14522.709545809024, 14601.269936503133, 14686.339114739862, 14769.113853168845, 22662.433439164153, 23211.651825222634, 23229.3031209064, 23471.178508752113, 23527.17654882071, 9229.353945223904, 9286.72139835806, 9529.094736000068, 9532.618695252251, 9575.473348965734, 8336.66653333872, 8403.201695838885, 8454.535000575028, 8582.356323275779, 8587.742367728979, 9004.549772511347, 9052.411593246417, 9084.772880677903, 9264.166225039779, 9335.346525743133, 2573.8327008744745, 2606.6397988907383, 2688.71358618147, 2755.7244275572284, 2769.0, 951.5432592355708, 953.6614501851743, 961.908234154226, 990.1880458024351, 998.5606333213362, 18622.06889655512, 18652.626947460976, 19020.334288299844, 19158.904205478884, 19289.0, 1005.7686732051523, 1010.6664800615779, 1018.8930162332997, 1026.2303272545591, 1029.1098200056897, 10483.633072842415, 10497.370157790558, 10635.46822658864, 10715.0, 10763.56945722178, 458231.0, 459746.0, 461880.0, 462351.0, 475994.0, 113077.0, 115008.42495787468, 117465.0, 117659.0, 118526.0, 1119.1438549509633, 1140.2132528555271, 1144.9713757156137, 1157.716359491913, 1159.5245949160803, 16780.077095759363, 16863.893497511206, 16892.493225203263, 17372.957622542686, 17569.121543922498, 51588.48411515987, 52184.0, 52282.73858630683, 52510.21234681559, 52545.73727131493, 63855.680721596094, 68299.65850170718, 68527.65736171287, 68731.0, 68919.65540172468, 14403.351849167022, 14877.404903803726, 14953.700925981637, 14984.775228371802, 14991.550253492413, 22458.663120052886, 22525.211617593304, 22566.435839104153, 22687.319380417954, 22876.656850147592, 17599.560010999827, 17931.641367172324, 17981.73027404564, 18149.909250453664, 18166.09169541544, 15758.842411576195, 16296.42962496307, 16590.83409165893, 16720.832791671928, 17058.829411705723, 17182.22679979379, 18077.186526606598, 18413.26346946107, 18448.446546603624, 18512.259509619464, 14538.127712337293, 14558.980871338905, 14628.488002919847, 14637.634059148606, 14649.267536622912, 17859.107044647455, 17942.102894854943, 18017.549561261072, 18036.63926721432, 18258.72611910796], "value": 11691.392455844856, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1320.2144723889287, 1371.0402718097334, 1372.9519466818658, 1378.166209443286, 1384.2317513779851, 14733.263336833155, 15297.0, 15311.0, 15323.387064517434, 15347.616309592238, 15009.774853377181, 15183.240837958085, 15196.620084497894, 15221.847781522209, 15288.999999999973, 2766.0595397564825, 2819.36564273039, 2841.8152820066734, 2861.1702606244166, 2865.7564107050925, 2729.495043416974, 2753.490604238222, 2768.9754790727357, 2770.1827960751625, 2771.9029833955815, 2674.090809124897, 2723.2783312422225, 2800.187945495814, 2802.523570992926, 2803.6215110959965, 2753.9449211015767, 2827.9858600706966, 2854.757345625624, 2856.900008499703, 2857.271395794059, 2712.308361367858, 2725.38678797271, 2725.591161325797, 2736.3843135294596, 2738.2606696191915, 15055.924720376437, 15309.540713778604, 15369.923150384177, 15398.615034624112, 15413.306401211972, 7870.370370370414, 8135.227153420416, 8167.428280020401, 8198.631061602242, 8203.30271926887, 5065.797368105272, 5156.561692256163, 5286.973565132188, 5366.4633536646415, 5373.274607927958, 1918.9040547972686, 1943.3101249056665, 1948.7076938459345, 1948.8343490803156, 1987.0462178154423, 27127.05055323074, 27177.592336114973, 27369.17892463229, 27415.725842741715, 27711.722882771115, 6898.586084834826, 7103.396211322096, 7129.857402851914, 7291.817704557428, 7330.193678695339, 17594.91202543979, 17599.20803563843, 17612.471625851245, 17621.0, 17670.82329176692, 8024.5185288881685, 8305.750827475185, 8585.871211931826, 8662.090480499457, 8666.913330866737, 7553.471257011956, 7675.53946763196, 7676.0, 7685.346745526581, 7695.268949449794, 5375.086235340002, 5548.667079975215, 5554.055810512223, 5584.268876648252, 5610.579206559524, 1530.6326481644326, 1535.9155246461553, 1609.5251900689325, 1615.7334039883287, 1637.6560922206231, 862.0818827948215, 877.1842186766241, 895.4403497813867, 901.2924853989587, 902.9503377314179, 8418.536980466133, 8553.315734741205, 8619.784505387415, 8668.566571671392, 8688.26149777276, 969.1035791892472, 969.2730452160879, 979.1285755677453, 979.6913972098766, 982.5332966840693, 5081.8475445736685, 5213.035588416155, 5257.947420525822, 5267.3152490176035, 5273.736313184326, 21541.353759387242, 21783.23758668439, 22636.54726905453, 22700.091996320294, 22713.772862271166, 21111.68332475014, 21376.679349809765, 21975.120995160334, 22684.546309073725, 22733.772662273495, 10913.23607347494, 11119.0, 11180.0, 11239.887601124048, 11270.09839212861, 8388.916110838814, 8553.401261911606, 8556.657733690583, 8581.75653778067, 8591.269742071994, 18240.361587344378, 18709.43871683852, 18859.811401885807, 18986.715199271744, 19036.1433735485, 18343.26626934908, 18801.247950081844, 18818.0, 18935.621287574446, 19613.901930490258, 9720.611175552898, 9950.800983980425, 9959.0, 10066.798664026825, 10081.848772268275, 13476.79784803209, 13644.931775341456, 13663.658408539468, 13670.93164534171, 13714.65713357174, 10422.791544169226, 10524.894751052392, 10537.683869483928, 10607.045365917105, 10868.67393978182, 11123.388213648326, 11294.096472282363, 11503.194776365908, 11518.827217591575, 11667.183297169116, 9928.702138935843, 10114.595416183565, 10123.493825308853, 10145.9492702536, 10207.234457415872, 6768.526203165928, 6793.558418702769, 6878.793636190922, 6915.550489218184, 6918.169819621477, 6756.088422630199, 6801.5238933274195, 6838.521303508706, 6922.342377474132, 6944.236134025152], "value": 6733.190622024186, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [521.825188561832, 526.9051570717271, 536.8511385634741, 550.246162757023, 556.749462741766, 6321.873562528746, 6328.873422531552, 6399.3600639935985, 6405.3914878086625, 6421.518386121042, 6253.186575892985, 6279.434850863421, 6305.337939516354, 6344.429001389874, 6356.68216589171, 5247.291615631898, 5263.973680131604, 5265.76304066318, 5291.259223708684, 5291.708956007418, 5089.669171503859, 5192.818251361203, 5194.298769666103, 5243.5093330668005, 5279.049771041211, 5120.641555091145, 5156.974215128919, 5169.793208271664, 5173.896522069556, 5182.844514664547, 5113.667611605234, 5136.357955255593, 5153.484651534854, 5165.922511162355, 5201.141811601081, 4746.762661866927, 4747.7388743619085, 4756.476787553366, 4770.189067858472, 4798.904021919542, 6187.412195841388, 6200.782972595937, 6222.937770622327, 6250.718717657716, 6263.31103578606, 5947.591225553658, 5952.226210592638, 5955.37468565803, 5983.760649574056, 5984.576246620126, 6533.967330163367, 6542.182227221598, 6624.470042396645, 6667.233268174125, 6693.598384096969, 5035.697858128524, 5091.134507133796, 5177.19753438214, 5190.377154741417, 5199.662021968597, 6829.99999999995, 6838.658067096625, 6842.965785171043, 6850.725970961155, 6984.196817365966, 5470.863228419322, 5480.150576660624, 5506.119020956708, 5513.428672828225, 5529.281193444826, 5522.91715624266, 5545.944540554624, 5552.69460179694, 5568.860778480571, 5583.888322233533, 6001.339852616209, 6022.307434645072, 6042.0, 6044.274687037584, 6052.303985041776, 6676.9666151668935, 6703.832404189934, 6763.222229443677, 6763.391294783493, 6786.287439818847, 1939.3697048459308, 1940.9126589303514, 1942.5629233422649, 1959.7060440933974, 1962.1170473287077, 1362.4073528015344, 1415.6602415420225, 1425.7790042543422, 1441.351391873661, 1446.6383404148962, 5601.355844077902, 5657.179708942181, 5682.488576028178, 5697.544196464273, 5710.0, 6535.738570457129, 6636.966815165893, 6669.866602668017, 6675.966620166965, 6730.427913627299, 5550.250716153349, 5632.3804381518, 5670.8015219467125, 5698.857528561819, 5724.828255152269, 3551.0, 3562.2341196642847, 3577.94633080504, 3605.549306336708, 3622.3660859349507, 6503.0411162920755, 6515.576487528296, 6589.604623722592, 6603.966980165068, 6637.269900310962, 6715.429188518933, 6732.192136943598, 6768.593884366954, 6785.253622101565, 6791.694373753094, 6452.387023232785, 6489.123968264318, 6524.184476940288, 6525.445337146396, 6527.902081468782, 6727.596344219362, 6747.628880411625, 6784.864302714017, 6831.897521537082, 6832.145981752281, 6674.199096108498, 6744.662766861539, 6751.122354093936, 6763.560368576027, 6765.830854228684, 6415.166028416276, 6455.580387274812, 6472.870542589216, 6478.384553467413, 6523.0, 5415.512603865671, 5477.534409575231, 5485.286912701324, 5494.780208791603, 5502.147167189092, 6483.837904052436, 6607.372299631527, 6620.3710647488415, 6689.431398331002, 6703.631300278532, 6269.467095296951, 6418.679066046586, 6445.8728619554495, 6513.478921686348, 6566.704498297684, 6397.488200944006, 6540.141316623215, 6552.8361790955605, 6575.934240657532, 6605.669716514251, 6340.334264902119, 6405.19935008124, 6409.134766806422, 6442.871142577029, 6466.450351719968, 6575.50683698715, 6601.537892347682, 6623.470122390101, 6661.233958094881, 6665.0, 6282.748690052346, 6328.557001009885, 6344.555881088464, 6412.935870641234, 6419.293877673359], "value": 5201.502731626321, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [890.1365675294961, 904.4347282948156, 912.1927094521351, 920.4385324951778, 933.6265493802479, 17865.01742404169, 18364.17361218745, 18476.260949562035, 18493.260269589216, 18498.075096245168, 14983.101013939171, 15002.849971500282, 17978.01120938348, 18134.63730725388, 18367.357142500015, 959.0601210813389, 965.9565319560602, 968.0754879090487, 968.2834702320267, 969.1471505075524, 979.0845559401946, 996.5515518016886, 1000.9549570269319, 1005.0652892809684, 1005.140604782911, 1056.9154467642609, 1057.5399701129995, 1057.8889216632258, 1062.436908438529, 1063.4257500949477, 1043.2332235806675, 1043.7651528406125, 1050.0811789684026, 1052.016364699005, 1053.1995683280722, 722.9096362954631, 742.413493340266, 760.1903972269515, 760.2207737069492, 772.7720322504874, 20111.79888201114, 20334.796652033438, 20360.28738994128, 20367.49081272965, 20371.89814050935, 21260.574788504142, 21265.0, 22354.32937011892, 22429.775702243096, 22464.213752518746, 17513.824861751345, 17559.20983555743, 17596.648067038717, 17634.647307053914, 17709.7343539847, 3769.660730534265, 3789.5073640426845, 3791.734578579473, 3793.0517370657335, 3812.4662547243406, 139285.0, 139414.30292848573, 142153.28923355317, 142596.28701856424, 143162.0, 16419.835801642068, 16628.418005369753, 16678.082705451317, 16772.412965546147, 16980.320787168373, 30256.54615180774, 30486.54270185949, 31619.36761264808, 31773.364532709216, 32168.67831321657, 8967.551622418852, 8996.100389960951, 9002.099790020946, 9015.864762028576, 9103.226225770884, 3976.681865450757, 3996.2806694794635, 3997.5003124609425, 4022.1151346703678, 4075.1238483726142, 5732.656040637575, 5732.914006289909, 5797.072468405035, 5835.737391817378, 5841.240638717025, 996.1781530237583, 1028.876534815827, 1040.3185913226848, 1040.505759764106, 1041.7603951091291, 678.3182901184279, 688.370141320696, 694.0872752330669, 695.4575431163701, 706.0397858911875, 10677.252592318619, 10803.405812680377, 10953.890461095447, 11319.0, 11674.708132296591, 664.0968283134932, 672.0591172358639, 678.0202607232502, 678.6572780745691, 680.5542369747823, 5169.172932330809, 5191.766370513336, 5247.16045432729, 5294.0, 5322.201669749491, 120931.0, 121648.39175804064, 121755.39122304332, 122810.38594806968, 127884.0, 106269.46865265779, 108167.0, 111549.0, 113397.86602134038, 117961.0, 94668.0, 95519.52240238755, 97690.02309976952, 98130.50934745281, 99472.50263748635, 12248.632541023784, 12469.251844889335, 12725.23648581051, 12804.61586152417, 12881.742365152832, 41936.3709544351, 42226.155476890905, 42720.35919461148, 44057.339139912285, 44272.0, 56361.0, 57464.0, 57470.7126464365, 57881.4211857876, 58572.70713646404, 18845.717314240024, 18902.960337181587, 19003.144858481126, 19065.71401428952, 19282.71075933834, 19426.514337141685, 19443.805561944766, 19460.1242944065, 19668.90165549163, 19743.0, 17544.736828947833, 17708.0, 17760.822391775917, 17830.37593684215, 17895.0, 17074.48776536706, 17341.0, 17349.21928513245, 17619.119044048002, 17827.376041838474, 17617.647647047244, 17682.5579360517, 17807.376741813976, 17826.643467130845, 17862.374816881347, 13052.21686698801, 13208.141470804367, 13240.933795330962, 13448.798268026183, 13545.59363219105, 11882.702932426759, 11936.52253909834, 12285.815712764137, 12356.196847204903, 12497.18768280059], "value": 9148.990837567979, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1421.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 107.0, 109.0, 108.0, 109.0, 107.0, 108.0, 107.0, 109.0, 108.0], "value": 108.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 124.0, 119.0, 117.0, 138.0, 122.0, 120.0, 118.0, 117.0, 118.0], "value": 121.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 163.0, 162.0, 165.0, 161.0, 163.0, 163.0, 165.0, 169.0], "value": 163.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 74.0, 74.0, 76.0, 74.0, 73.0, 73.0, 74.0, 76.0], "value": 74.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 79.0, 80.0, 79.0, 79.0, 80.0, 80.0, 80.0, 79.0], "value": 79.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 113.0, 114.0, 114.0, 114.0, 111.0, 115.0, 115.0, 114.0], "value": 113.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 148.0, 148.0, 148.0, 148.0, 147.0, 149.0, 149.0, 147.0, 148.0], "value": 148.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 95.0, 93.0, 94.0, 95.0, 95.0, 100.0, 93.0, 101.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 53.0, 51.0, 55.0, 53.0, 54.0, 53.0, 54.0, 54.0], "value": 53.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [39.0, 39.0, 38.0, 39.0, 38.0, 39.0, 39.0, 38.0, 39.0, 39.0], "value": 38.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 72.0, 71.0, 81.0, 75.0, 73.0, 74.0, 74.0, 77.0, 73.0], "value": 74.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 128.0, 110.0, 114.0, 111.0, 109.0, 114.0, 116.0, 121.0, 116.0], "value": 115.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 168.0, 164.0, 167.0, 166.0, 174.0, 168.0, 166.0, 176.0, 178.0], "value": 169.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 68.0, 66.0, 66.0, 68.0, 65.0, 67.0, 68.0, 64.0, 67.0], "value": 67.0, "unit": "score"}]}]} 09:44:00 INFO - Return code: 0 09:44:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:44:00 INFO - # TBPL SUCCESS # 09:44:00 INFO - Running post-action listener: _package_coverage_data 09:44:00 INFO - Running post-action listener: _resource_record_post_action 09:44:00 INFO - [mozharness: 2017-09-21 16:44:00.743249Z] Finished run-tests step (success) 09:44:00 INFO - Running post-run listener: _resource_record_post_run 09:44:00 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 4096; Write bytes: 345706496; Read time: 16; Write time: 220148 09:44:00 INFO - TinderboxPrint: CPU usage
13.1% 09:44:00 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 09:44:00 INFO - TinderboxPrint: I/O write bytes / time
345,706,496 / 220,148 09:44:00 INFO - TinderboxPrint: CPU idle
8,223.2 (86.9%) 09:44:00 INFO - TinderboxPrint: CPU user
1,192.2 (12.6%) 09:44:00 INFO - TinderboxPrint: Swap in / out
0 / 0 09:44:00 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 10178560; Read time: 0; Write time: 964 09:44:00 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 09:44:00 INFO - run-tests - Wall time: 1170s; CPU: 13.0%; Read bytes: 0; Write bytes: 335527936; Read time: 0; Write time: 219184 09:44:01 INFO - Running post-run listener: _upload_blobber_files 09:44:01 INFO - Blob upload gear active. 09:44:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:44:01 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 09:44:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:44:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:44:01 INFO - (blobuploader) - INFO - Open directory for files ... 09:44:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:44:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:44:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:44:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:44:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:44:02 INFO - (blobuploader) - INFO - Done attempting. 09:44:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:44:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:44:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:44:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:44:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:44:03 INFO - (blobuploader) - INFO - Done attempting. 09:44:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:44:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:44:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:44:04 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:44:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:44:04 INFO - (blobuploader) - INFO - Done attempting. 09:44:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:44:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:44:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:44:11 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:44:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:44:11 INFO - (blobuploader) - INFO - Done attempting. 09:44:11 INFO - (blobuploader) - INFO - Iteration through files over. 09:44:11 INFO - Return code: 0 09:44:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:44:11 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:44:11 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9ee6cd187a2936ca9f0e01437766465e54075fc3dd7f287721e291b3dc8db6725485045ae87c2c8f2d6162f488a777469cc3f7af61e9bde868eaa8b1afafba15", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ca68fe26808f51374d5efb4eb31f8f9e86c49a269518a55f05e0fbbe81fac1d8048c46960364bdeba9c95a4acdee920846fc15294672527a93195dc32135b070", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e959521990ab656ac747cd59c2e7e08eec4673196ec49825568dfd426c696b4b8e4329775674aac9055af598cf5688c8e04e4c1d136dd7ef735c3678a7d8c611", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/61180277cdd000160683cf2454c8c4df9ad26d2b32927620dd80b55289df02e4514615c29255416d892039f09816f7c7b7196ba6d9a38379662cb3bfdc5624a9"} 09:44:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:44:11 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:44:11 INFO - Contents: 09:44:11 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9ee6cd187a2936ca9f0e01437766465e54075fc3dd7f287721e291b3dc8db6725485045ae87c2c8f2d6162f488a777469cc3f7af61e9bde868eaa8b1afafba15", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ca68fe26808f51374d5efb4eb31f8f9e86c49a269518a55f05e0fbbe81fac1d8048c46960364bdeba9c95a4acdee920846fc15294672527a93195dc32135b070", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e959521990ab656ac747cd59c2e7e08eec4673196ec49825568dfd426c696b4b8e4329775674aac9055af598cf5688c8e04e4c1d136dd7ef735c3678a7d8c611", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/61180277cdd000160683cf2454c8c4df9ad26d2b32927620dd80b55289df02e4514615c29255416d892039f09816f7c7b7196ba6d9a38379662cb3bfdc5624a9"} 09:44:11 INFO - Running post-run listener: copy_logs_to_upload_dir 09:44:11 INFO - Copying logs to upload dir... 09:44:11 INFO - mkdir: /builds/slave/test/build/upload/logs 09:44:11 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.274615 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2017-09-21 09:44:11.653111) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-21 09:44:11.657015) ========= 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=0333a256a5e4f052382dd180000001b1-1506011013.417489-617014136 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9ee6cd187a2936ca9f0e01437766465e54075fc3dd7f287721e291b3dc8db6725485045ae87c2c8f2d6162f488a777469cc3f7af61e9bde868eaa8b1afafba15", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ca68fe26808f51374d5efb4eb31f8f9e86c49a269518a55f05e0fbbe81fac1d8048c46960364bdeba9c95a4acdee920846fc15294672527a93195dc32135b070", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e959521990ab656ac747cd59c2e7e08eec4673196ec49825568dfd426c696b4b8e4329775674aac9055af598cf5688c8e04e4c1d136dd7ef735c3678a7d8c611", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/61180277cdd000160683cf2454c8c4df9ad26d2b32927620dd80b55289df02e4514615c29255416d892039f09816f7c7b7196ba6d9a38379662cb3bfdc5624a9"} build_url:https://queue.taskcluster.net/v1/task/HBJ4E0WUSRGZbfHgz26VAA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011162 build_url: 'https://queue.taskcluster.net/v1/task/HBJ4E0WUSRGZbfHgz26VAA/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9ee6cd187a2936ca9f0e01437766465e54075fc3dd7f287721e291b3dc8db6725485045ae87c2c8f2d6162f488a777469cc3f7af61e9bde868eaa8b1afafba15", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ca68fe26808f51374d5efb4eb31f8f9e86c49a269518a55f05e0fbbe81fac1d8048c46960364bdeba9c95a4acdee920846fc15294672527a93195dc32135b070", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e959521990ab656ac747cd59c2e7e08eec4673196ec49825568dfd426c696b4b8e4329775674aac9055af598cf5688c8e04e4c1d136dd7ef735c3678a7d8c611", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/61180277cdd000160683cf2454c8c4df9ad26d2b32927620dd80b55289df02e4514615c29255416d892039f09816f7c7b7196ba6d9a38379662cb3bfdc5624a9"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-21 09:44:11.685100) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-21 09:44:11.685469) ========= 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=0333a256a5e4f052382dd180000001b1-1506011013.417489-617014136 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004443 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-21 09:44:11.770924) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-21 09:44:11.771469) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-21 09:44:11.772065) ========= ========= Total master_lag: 0.20 =========