builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-053 starttime: 1503577709.79 results: success (0) revision: 32674de9af80667006ab1a4efcdc70115faf48e9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-24 05:28:29.793097) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-24 05:28:29.793558) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-24 05:28:29.793855) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-24 05:28:29.810342) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-24 05:28:29.810717) ========= 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=920470bf432669ad7e3a5387000001ca-1503577708.995092-995620445 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-24 05:28:29-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 49.4M=0s 2017-08-24 05:28:30 (49.4 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.120218 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-24 05:28:29.949375) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-24 05:28:29.949791) ========= 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=920470bf432669ad7e3a5387000001ca-1503577708.995092-995620445 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014042 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-24 05:28:30.000265) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-24 05:28:30.000666) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 32674de9af80667006ab1a4efcdc70115faf48e9 --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 32674de9af80667006ab1a4efcdc70115faf48e9 --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=920470bf432669ad7e3a5387000001ca-1503577708.995092-995620445 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-24 05:28:30,185 truncating revision to first 12 chars 2017-08-24 05:28:30,185 Setting DEBUG logging. 2017-08-24 05:28:30,185 attempt 1/10 2017-08-24 05:28:30,185 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/32674de9af80?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-24 05:28:30,825 unpacking tar archive at: mozilla-central-32674de9af80/testing/mozharness/ program finished with exit code 0 elapsedTime=0.965672 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-24 05:28:30.983956) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-24 05:28:30.987292) ========= script_repo_revision: 32674de9af80667006ab1a4efcdc70115faf48e9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-24 05:28:30.987696) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-24 05:28:30.987961) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-24 05:28:30.999475) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2017-08-24 05:28:30.999799) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=920470bf432669ad7e3a5387000001ca-1503577708.995092-995620445 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:28:31 INFO - MultiFileLogger online at 20170824 05:28:31 in /builds/slave/test 05:28:31 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:28:31 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:28:31 INFO - {'append_to_log': False, 05:28:31 INFO - 'base_work_dir': '/builds/slave/test', 05:28:31 INFO - 'blob_upload_branch': 'Firefox', 05:28:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:28:31 INFO - 'branch': 'Firefox', 05:28:31 INFO - 'buildbot_json_path': 'buildprops.json', 05:28:31 INFO - 'code_coverage': False, 05:28:31 INFO - 'config_files': ('talos/linux_config.py',), 05:28:31 INFO - 'default_actions': ('clobber', 05:28:31 INFO - 'read-buildbot-config', 05:28:31 INFO - 'download-and-extract', 05:28:31 INFO - 'populate-webroot', 05:28:31 INFO - 'create-virtualenv', 05:28:31 INFO - 'install', 05:28:31 INFO - 'setup-mitmproxy', 05:28:31 INFO - 'run-tests'), 05:28:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:28:31 INFO - 'disable_ccov_upload': False, 05:28:31 INFO - 'download_minidump_stackwalk': True, 05:28:31 INFO - 'download_symbols': 'ondemand', 05:28:31 INFO - 'enable_stylo': False, 05:28:31 INFO - 'enable_webrender': False, 05:28:31 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 05:28:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:28:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:28:31 INFO - 'gecko_profile': False, 05:28:31 INFO - 'gecko_profile_interval': 0, 05:28:31 INFO - 'installer_path': 'installer.exe', 05:28:31 INFO - 'log_level': 'info', 05:28:31 INFO - 'log_name': 'talos', 05:28:31 INFO - 'log_to_console': True, 05:28:31 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:28:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:28:31 INFO - 'opt_config_files': (), 05:28:31 INFO - 'pip_index': False, 05:28:31 INFO - 'suite': 'dromaeojs-e10s', 05:28:31 INFO - 'system_bits': '32', 05:28:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:28:31 INFO - 'title': 'talos-linux64-ix-053', 05:28:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:28:31 INFO - 'use_talos_json': True, 05:28:31 INFO - 'verify': 'False', 05:28:31 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:28:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:28:31 INFO - 'work_dir': 'build'} 05:28:31 INFO - [mozharness: 2017-08-24 12:28:31.329548Z] Running clobber step. 05:28:31 INFO - Running pre-action listener: _resource_record_pre_action 05:28:31 INFO - Running main action method: clobber 05:28:31 INFO - rmtree: /builds/slave/test/build 05:28:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:28:32 INFO - Running post-action listener: _resource_record_post_action 05:28:32 INFO - [mozharness: 2017-08-24 12:28:32.433113Z] Finished clobber step (success) 05:28:32 INFO - [mozharness: 2017-08-24 12:28:32.433210Z] Running read-buildbot-config step. 05:28:32 INFO - Running pre-action listener: _resource_record_pre_action 05:28:32 INFO - Running main action method: read_buildbot_config 05:28:32 INFO - Using buildbot properties: 05:28:32 INFO - { 05:28:32 INFO - "project": "", 05:28:32 INFO - "product": "firefox", 05:28:32 INFO - "who": "archaeopteryx@coole-files.de", 05:28:32 INFO - "installer_path": "public/build/target.tar.bz2", 05:28:32 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 05:28:32 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 05:28:32 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 05:28:32 INFO - "stage_platform": "linux64-stylo", 05:28:32 INFO - "basedir": "/builds/slave/test", 05:28:32 INFO - "buildnumber": 54, 05:28:32 INFO - "platform": "ubuntu64_hw_stylo", 05:28:32 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 05:28:32 INFO - "slavebuilddir": "test", 05:28:32 INFO - "taskId": "XsTSRWJeTwePowky7WrxuA", 05:28:32 INFO - "branch": "mozilla-central", 05:28:32 INFO - "script_repo_revision": "production", 05:28:32 INFO - "revision": "32674de9af80667006ab1a4efcdc70115faf48e9", 05:28:32 INFO - "slavename": "talos-linux64-ix-053", 05:28:32 INFO - "repo_path": "mozilla-central" 05:28:32 INFO - } 05:28:32 INFO - Finding installer, test and symbols from parent task. 05:28:32 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XsTSRWJeTwePowky7WrxuA'}, attempt #1 05:28:32 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XsTSRWJeTwePowky7WrxuA'}, attempt #1 05:28:33 INFO - Task dependencies: edDsDxIfTzGMCiv9-pbWyw 05:28:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/edDsDxIfTzGMCiv9-pbWyw'}, attempt #1 05:28:33 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/edDsDxIfTzGMCiv9-pbWyw/artifacts/public/build/target.tar.bz2 05:28:33 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/edDsDxIfTzGMCiv9-pbWyw/artifacts/public/build/target.test_packages.json 05:28:33 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/edDsDxIfTzGMCiv9-pbWyw/artifacts/public/build/target.crashreporter-symbols.zip 05:28:33 INFO - Running post-action listener: _resource_record_post_action 05:28:33 INFO - [mozharness: 2017-08-24 12:28:33.921038Z] Finished read-buildbot-config step (success) 05:28:33 INFO - [mozharness: 2017-08-24 12:28:33.921256Z] Running download-and-extract step. 05:28:33 INFO - Running pre-action listener: _resource_record_pre_action 05:28:33 INFO - Running main action method: download_and_extract 05:28:33 INFO - mkdir: /builds/slave/test/build/tests 05:28:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:28:33 INFO - trying https://queue.taskcluster.net/v1/task/edDsDxIfTzGMCiv9-pbWyw/artifacts/public/build/target.test_packages.json 05:28:33 INFO - Downloading https://queue.taskcluster.net/v1/task/edDsDxIfTzGMCiv9-pbWyw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 05:28:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/edDsDxIfTzGMCiv9-pbWyw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 05:28:34 INFO - Downloaded 989 bytes. 05:28:34 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 05:28:34 INFO - Using the following test package requirements: 05:28:34 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 05:28:34 INFO - u'common': [u'target.common.tests.zip'], 05:28:34 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 05:28:34 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 05:28:34 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 05:28:34 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 05:28:34 INFO - u'mozbase': [u'target.common.tests.zip'], 05:28:34 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 05:28:34 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 05:28:34 INFO - u'web-platform': [u'target.common.tests.zip', 05:28:34 INFO - u'target.web-platform.tests.tar.gz'], 05:28:34 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 05:28:34 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 05:28:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/edDsDxIfTzGMCiv9-pbWyw/artifacts/public/build/target.common.tests.zip 05:28:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/edDsDxIfTzGMCiv9-pbWyw/artifacts/public/build/target.common.tests.zip'}, attempt #1 05:28:34 INFO - Fetch https://queue.taskcluster.net/v1/task/edDsDxIfTzGMCiv9-pbWyw/artifacts/public/build/target.common.tests.zip into memory 05:28:35 INFO - Content-Length response header: 54979689 05:28:35 INFO - Bytes received: 54979689 05:28:46 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 05:28:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/edDsDxIfTzGMCiv9-pbWyw/artifacts/public/build/target.common.tests.zip 05:28:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/edDsDxIfTzGMCiv9-pbWyw/artifacts/public/build/target.common.tests.zip'}, attempt #1 05:28:46 INFO - Fetch https://queue.taskcluster.net/v1/task/edDsDxIfTzGMCiv9-pbWyw/artifacts/public/build/target.common.tests.zip into memory 05:28:47 INFO - Content-Length response header: 54979689 05:28:47 INFO - Bytes received: 54979689 05:28:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/edDsDxIfTzGMCiv9-pbWyw/artifacts/public/build/target.talos.tests.zip 05:28:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/edDsDxIfTzGMCiv9-pbWyw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 05:28:59 INFO - Fetch https://queue.taskcluster.net/v1/task/edDsDxIfTzGMCiv9-pbWyw/artifacts/public/build/target.talos.tests.zip into memory 05:29:00 INFO - Content-Length response header: 14496384 05:29:00 INFO - Bytes received: 14496384 05:29:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:29:00 INFO - trying https://queue.taskcluster.net/v1/task/edDsDxIfTzGMCiv9-pbWyw/artifacts/public/build/target.tar.bz2 05:29:00 INFO - Downloading https://queue.taskcluster.net/v1/task/edDsDxIfTzGMCiv9-pbWyw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 05:29:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/edDsDxIfTzGMCiv9-pbWyw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 05:29:01 INFO - Downloaded 61132206 bytes. 05:29:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/edDsDxIfTzGMCiv9-pbWyw/artifacts/public/build/target.tar.bz2 05:29:01 INFO - mkdir: /builds/slave/test/properties 05:29:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:29:01 INFO - Writing to file /builds/slave/test/properties/build_url 05:29:01 INFO - Contents: 05:29:01 INFO - build_url:https://queue.taskcluster.net/v1/task/edDsDxIfTzGMCiv9-pbWyw/artifacts/public/build/target.tar.bz2 05:29:01 INFO - Running post-action listener: _resource_record_post_action 05:29:01 INFO - Running post-action listener: find_tests_for_verification 05:29:01 INFO - Running post-action listener: set_extra_try_arguments 05:29:01 INFO - [mozharness: 2017-08-24 12:29:01.829609Z] Finished download-and-extract step (success) 05:29:01 INFO - [mozharness: 2017-08-24 12:29:01.829706Z] Running populate-webroot step. 05:29:01 INFO - Running pre-action listener: _resource_record_pre_action 05:29:01 INFO - Running main action method: populate_webroot 05:29:01 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:29:01 INFO - 'chromez-stylo-e10s': {'talos_options': ['--stylo'], 05:29:01 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:29:01 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:29:01 INFO - 'dromaeojs-stylo-e10s': {'talos_options': ['--stylo'], 05:29:01 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:29:01 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 05:29:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:29:01 INFO - 'g1-stylo-e10s': {'pagesets_name': 'tp5n.zip', 05:29:01 INFO - 'talos_options': ['--stylo'], 05:29:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:29:01 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 05:29:01 INFO - 'tests': ['damp', 'tps']}, 05:29:01 INFO - 'g2-stylo-e10s': {'pagesets_name': 'tp5n.zip', 05:29:01 INFO - 'talos_options': ['--stylo'], 05:29:01 INFO - 'tests': ['damp', 'tps']}, 05:29:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:29:01 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 05:29:01 INFO - 'g4-stylo-e10s': {'talos_options': ['--stylo'], 05:29:01 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 05:29:01 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 05:29:01 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 05:29:01 INFO - 'g5-stylo-e10s': {'pagesets_name': 'tp5n.zip', 05:29:01 INFO - 'talos_options': ['--stylo'], 05:29:01 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 05:29:01 INFO - 'other-e10s': {'tests': ['a11yr', 05:29:01 INFO - 'ts_paint', 05:29:01 INFO - 'tpaint', 05:29:01 INFO - 'sessionrestore', 05:29:01 INFO - 'sessionrestore_many_windows', 05:29:01 INFO - 'sessionrestore_no_auto_restore', 05:29:01 INFO - 'tabpaint']}, 05:29:01 INFO - 'other-stylo-e10s': {'talos_options': ['--stylo'], 05:29:01 INFO - 'tests': ['a11yr', 05:29:01 INFO - 'ts_paint', 05:29:01 INFO - 'tpaint', 05:29:01 INFO - 'sessionrestore', 05:29:01 INFO - 'sessionrestore_many_windows', 05:29:01 INFO - 'sessionrestore_no_auto_restore', 05:29:01 INFO - 'tabpaint']}, 05:29:01 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 05:29:01 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 05:29:01 INFO - 'perf-reftest-singletons-stylo-e10s': {'talos_options': ['--stylo'], 05:29:01 INFO - 'tests': ['bloom_basic_singleton']}, 05:29:01 INFO - 'perf-reftest-stylo-e10s': {'talos_options': ['--stylo'], 05:29:01 INFO - 'tests': ['bloom_basic']}, 05:29:01 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:29:01 INFO - 'tsvgr_opacity', 05:29:01 INFO - 'tart', 05:29:01 INFO - 'tscrollx', 05:29:01 INFO - 'tsvg_static']}, 05:29:01 INFO - 'svgr-stylo-e10s': {'talos_options': ['--stylo'], 05:29:01 INFO - 'tests': ['tsvgx', 05:29:01 INFO - 'tsvgr_opacity', 05:29:01 INFO - 'tart', 05:29:01 INFO - 'tscrollx', 05:29:01 INFO - 'tsvg_static']}, 05:29:01 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 05:29:01 INFO - 'tp5o-stylo-e10s': {'pagesets_name': 'tp5n.zip', 05:29:01 INFO - 'talos_options': ['--stylo'], 05:29:01 INFO - 'tests': ['tp5o']}, 05:29:01 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 05:29:01 INFO - 'talos_options': ['--mitmproxy', 05:29:01 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 05:29:01 INFO - '--firstNonBlankPaint'], 05:29:01 INFO - 'tests': ['tp6_google', 05:29:01 INFO - 'tp6_youtube', 05:29:01 INFO - 'tp6_amazon', 05:29:01 INFO - 'tp6_facebook']}, 05:29:01 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 05:29:01 INFO - 'talos_options': ['--stylo', 05:29:01 INFO - '--mitmproxy', 05:29:01 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 05:29:01 INFO - '--firstNonBlankPaint'], 05:29:01 INFO - 'tests': ['tp6_google', 05:29:01 INFO - 'tp6_youtube', 05:29:01 INFO - 'tp6_amazon', 05:29:01 INFO - 'tp6_facebook']}, 05:29:01 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 05:29:01 INFO - 'talos_options': ['--stylo', 05:29:01 INFO - '--stylo-threads=1', 05:29:01 INFO - '--mitmproxy', 05:29:01 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 05:29:01 INFO - '--firstNonBlankPaint'], 05:29:01 INFO - 'tests': ['tp6_google', 05:29:01 INFO - 'tp6_youtube', 05:29:01 INFO - 'tp6_amazon', 05:29:01 INFO - 'tp6_facebook']}, 05:29:01 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 05:29:01 INFO - 'talos_options': ['--xperf_path', 05:29:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:29:01 INFO - 'tests': ['tp5n']}, 05:29:01 INFO - 'xperf-stylo-e10s': {'pagesets_name': 'tp5n.zip', 05:29:01 INFO - 'talos_options': ['--stylo', 05:29:01 INFO - '--xperf_path', 05:29:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:29:01 INFO - 'tests': ['tp5n']}}} 05:29:01 INFO - Running post-action listener: _resource_record_post_action 05:29:01 INFO - [mozharness: 2017-08-24 12:29:01.843801Z] Finished populate-webroot step (success) 05:29:01 INFO - [mozharness: 2017-08-24 12:29:01.843891Z] Running create-virtualenv step. 05:29:01 INFO - Running pre-action listener: _resource_record_pre_action 05:29:01 INFO - Running main action method: create_virtualenv 05:29:01 INFO - Creating virtualenv /builds/slave/test/build/venv 05:29:01 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:29:01 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 05:29:01 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 05:29:01 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:29:01 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:29:02 INFO - Installing distribute.............................................................................................................................................................................................done. 05:29:02 INFO - Installing pip...............done. 05:29:02 INFO - Return code: 0 05:29:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:29:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:29:03 INFO - Reading from file tmpfile_stdout 05:29:03 INFO - Output received: 05:29:03 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 05:29:03 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:29:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:29:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:29:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:29:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:29:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x110b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1479f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1477130>, '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 0x1478030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14784c0>, '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': '920470bf432669ad7e3a5387000001ca-1503577708.995092-995620445', '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 05:29:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:29:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:29:03 INFO - Using env: {'DISPLAY': ':0', 05:29:03 INFO - 'HOME': '/home/cltbld', 05:29:03 INFO - 'LANG': 'en_US.UTF-8', 05:29:03 INFO - 'LANGUAGE': 'en_US:en', 05:29:03 INFO - 'LOGNAME': 'cltbld', 05:29:03 INFO - 'MAIL': '/var/mail/cltbld', 05:29:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:29:03 INFO - 'MOZ_NO_REMOTE': '1', 05:29:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:29:03 INFO - 'NO_EM_RESTART': '1', 05:29:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:29:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:29:03 INFO - 'PWD': '/builds/slave/test', 05:29:03 INFO - 'SHELL': '/bin/bash', 05:29:03 INFO - 'SHLVL': '1', 05:29:03 INFO - 'TERM': 'linux', 05:29:03 INFO - 'TMOUT': '86400', 05:29:03 INFO - 'USER': 'cltbld', 05:29:03 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1503577708.995092-995620445', 05:29:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:29:03 INFO - '_': '/tools/buildbot/bin/python'} 05:29:04 INFO - Ignoring indexes: http://pypi.python.org/simple/ 05:29:04 INFO - Downloading/unpacking pip>=1.5 05:29:04 INFO - Running setup.py egg_info for package pip 05:29:04 INFO - warning: no files found matching 'pip/cacert.pem' 05:29:04 INFO - warning: no files found matching '*.html' under directory 'docs' 05:29:04 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 05:29:04 INFO - no previously-included directories found matching 'docs/_build/_sources' 05:29:04 INFO - Installing collected packages: pip 05:29:04 INFO - Found existing installation: pip 1.1 05:29:04 INFO - Uninstalling pip: 05:29:04 INFO - Successfully uninstalled pip 05:29:04 INFO - Running setup.py install for pip 05:29:04 INFO - warning: no files found matching 'pip/cacert.pem' 05:29:04 INFO - warning: no files found matching '*.html' under directory 'docs' 05:29:04 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 05:29:04 INFO - no previously-included directories found matching 'docs/_build/_sources' 05:29:04 INFO - Installing pip script to /builds/slave/test/build/venv/bin 05:29:04 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 05:29:04 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 05:29:04 INFO - Successfully installed pip 05:29:04 INFO - Cleaning up... 05:29:04 INFO - Return code: 0 05:29:04 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:29: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')]} 05:29:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:29: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')]} 05:29:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:29:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x110b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1479f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1477130>, '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 0x1478030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14784c0>, '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': '920470bf432669ad7e3a5387000001ca-1503577708.995092-995620445', '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 05:29:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:29:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:29:04 INFO - Using env: {'DISPLAY': ':0', 05:29:04 INFO - 'HOME': '/home/cltbld', 05:29:04 INFO - 'LANG': 'en_US.UTF-8', 05:29:04 INFO - 'LANGUAGE': 'en_US:en', 05:29:04 INFO - 'LOGNAME': 'cltbld', 05:29:04 INFO - 'MAIL': '/var/mail/cltbld', 05:29:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:29:04 INFO - 'MOZ_NO_REMOTE': '1', 05:29:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:29:04 INFO - 'NO_EM_RESTART': '1', 05:29:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:29:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:29:04 INFO - 'PWD': '/builds/slave/test', 05:29:04 INFO - 'SHELL': '/bin/bash', 05:29:04 INFO - 'SHLVL': '1', 05:29:04 INFO - 'TERM': 'linux', 05:29:04 INFO - 'TMOUT': '86400', 05:29:04 INFO - 'USER': 'cltbld', 05:29:04 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1503577708.995092-995620445', 05:29:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:29:04 INFO - '_': '/tools/buildbot/bin/python'} 05:29:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:29:04 INFO - Downloading/unpacking psutil>=3.1.1 05:29:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:29:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:29:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:29:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:29:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:29:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:29:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:29:05 INFO - Installing collected packages: psutil 05:29:05 INFO - Running setup.py install for psutil 05:29:05 INFO - building 'psutil._psutil_linux' extension 05:29:05 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 05:29:05 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 05:29:05 INFO - building 'psutil._psutil_posix' extension 05:29:05 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 05:29:06 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 05:29:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:29:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:29:06 INFO - Successfully installed psutil 05:29:06 INFO - Cleaning up... 05:29:06 INFO - Return code: 0 05:29:06 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:29:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:29:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:29:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:29:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:29:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x110b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1479f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1477130>, '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 0x1478030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14784c0>, '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': '920470bf432669ad7e3a5387000001ca-1503577708.995092-995620445', '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 05:29:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:29:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:29:06 INFO - Using env: {'DISPLAY': ':0', 05:29:06 INFO - 'HOME': '/home/cltbld', 05:29:06 INFO - 'LANG': 'en_US.UTF-8', 05:29:06 INFO - 'LANGUAGE': 'en_US:en', 05:29:06 INFO - 'LOGNAME': 'cltbld', 05:29:06 INFO - 'MAIL': '/var/mail/cltbld', 05:29:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:29:06 INFO - 'MOZ_NO_REMOTE': '1', 05:29:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:29:06 INFO - 'NO_EM_RESTART': '1', 05:29:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:29:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:29:06 INFO - 'PWD': '/builds/slave/test', 05:29:06 INFO - 'SHELL': '/bin/bash', 05:29:06 INFO - 'SHLVL': '1', 05:29:06 INFO - 'TERM': 'linux', 05:29:06 INFO - 'TMOUT': '86400', 05:29:06 INFO - 'USER': 'cltbld', 05:29:06 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1503577708.995092-995620445', 05:29:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:29:06 INFO - '_': '/tools/buildbot/bin/python'} 05:29:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:29:06 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:29:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:29:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:29:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:29:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:29:07 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:29:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:29:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:29:07 INFO - Installing collected packages: mozsystemmonitor 05:29:07 INFO - Running setup.py install for mozsystemmonitor 05:29:07 INFO - Successfully installed mozsystemmonitor 05:29:07 INFO - Cleaning up... 05:29:07 INFO - Return code: 0 05:29:07 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:29: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')]} 05:29:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:29: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')]} 05:29:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:29:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x110b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1479f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1477130>, '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 0x1478030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14784c0>, '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': '920470bf432669ad7e3a5387000001ca-1503577708.995092-995620445', '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 05:29:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:29:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:29:07 INFO - Using env: {'DISPLAY': ':0', 05:29:07 INFO - 'HOME': '/home/cltbld', 05:29:07 INFO - 'LANG': 'en_US.UTF-8', 05:29:07 INFO - 'LANGUAGE': 'en_US:en', 05:29:07 INFO - 'LOGNAME': 'cltbld', 05:29:07 INFO - 'MAIL': '/var/mail/cltbld', 05:29:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:29:07 INFO - 'MOZ_NO_REMOTE': '1', 05:29:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:29:07 INFO - 'NO_EM_RESTART': '1', 05:29:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:29:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:29:07 INFO - 'PWD': '/builds/slave/test', 05:29:07 INFO - 'SHELL': '/bin/bash', 05:29:07 INFO - 'SHLVL': '1', 05:29:07 INFO - 'TERM': 'linux', 05:29:07 INFO - 'TMOUT': '86400', 05:29:07 INFO - 'USER': 'cltbld', 05:29:07 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1503577708.995092-995620445', 05:29:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:29:07 INFO - '_': '/tools/buildbot/bin/python'} 05:29:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:29:07 INFO - Downloading/unpacking jsonschema==2.5.1 05:29:07 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 05:29:07 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 05:29:07 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 05:29:07 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 05:29:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:29:09 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:29:09 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 05:29:09 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 05:29:09 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 05:29:09 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 05:29:09 INFO - Downloading functools32-3.2.3-2.tar.gz 05:29:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:29:09 INFO - warning: no files found matching '*.txt' 05:29:09 INFO - no previously-included directories found matching 'build' 05:29:09 INFO - no previously-included directories found matching 'dist' 05:29:09 INFO - no previously-included directories found matching '.git*' 05:29:09 INFO - Installing collected packages: jsonschema, functools32 05:29:09 INFO - Running setup.py install for functools32 05:29:09 INFO - warning: no files found matching '*.txt' 05:29:09 INFO - no previously-included directories found matching 'build' 05:29:09 INFO - no previously-included directories found matching 'dist' 05:29:09 INFO - no previously-included directories found matching '.git*' 05:29:09 INFO - Successfully installed jsonschema functools32 05:29:09 INFO - Cleaning up... 05:29:09 INFO - Return code: 0 05:29:09 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:29:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:29:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:29:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:29:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:29:09 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 0x110b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1479f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1477130>, '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 0x1478030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14784c0>, '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': '920470bf432669ad7e3a5387000001ca-1503577708.995092-995620445', '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 05:29:09 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 05:29:09 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 05:29:09 INFO - Using env: {'DISPLAY': ':0', 05:29:09 INFO - 'HOME': '/home/cltbld', 05:29:09 INFO - 'LANG': 'en_US.UTF-8', 05:29:09 INFO - 'LANGUAGE': 'en_US:en', 05:29:09 INFO - 'LOGNAME': 'cltbld', 05:29:09 INFO - 'MAIL': '/var/mail/cltbld', 05:29:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:29:09 INFO - 'MOZ_NO_REMOTE': '1', 05:29:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:29:09 INFO - 'NO_EM_RESTART': '1', 05:29:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:29:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:29:09 INFO - 'PWD': '/builds/slave/test', 05:29:09 INFO - 'SHELL': '/bin/bash', 05:29:09 INFO - 'SHLVL': '1', 05:29:09 INFO - 'TERM': 'linux', 05:29:09 INFO - 'TMOUT': '86400', 05:29:09 INFO - 'USER': 'cltbld', 05:29:09 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1503577708.995092-995620445', 05:29:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:29:09 INFO - '_': '/tools/buildbot/bin/python'} 05:29:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:29:09 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:29:09 INFO - Cleaning up... 05:29:09 INFO - Return code: 0 05:29:09 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:29:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:29:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:29:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:29:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:29:09 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 0x110b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1479f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1477130>, '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 0x1478030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14784c0>, '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': '920470bf432669ad7e3a5387000001ca-1503577708.995092-995620445', '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 05:29:09 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 05:29:09 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 05:29:09 INFO - Using env: {'DISPLAY': ':0', 05:29:09 INFO - 'HOME': '/home/cltbld', 05:29:09 INFO - 'LANG': 'en_US.UTF-8', 05:29:09 INFO - 'LANGUAGE': 'en_US:en', 05:29:09 INFO - 'LOGNAME': 'cltbld', 05:29:09 INFO - 'MAIL': '/var/mail/cltbld', 05:29:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:29:09 INFO - 'MOZ_NO_REMOTE': '1', 05:29:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:29:09 INFO - 'NO_EM_RESTART': '1', 05:29:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:29:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:29:09 INFO - 'PWD': '/builds/slave/test', 05:29:09 INFO - 'SHELL': '/bin/bash', 05:29:09 INFO - 'SHLVL': '1', 05:29:09 INFO - 'TERM': 'linux', 05:29:09 INFO - 'TMOUT': '86400', 05:29:09 INFO - 'USER': 'cltbld', 05:29:09 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1503577708.995092-995620445', 05:29:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:29:09 INFO - '_': '/tools/buildbot/bin/python'} 05:29:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:29:09 INFO - Downloading/unpacking blobuploader==1.2.4 05:29:09 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 05:29:09 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 05:29:09 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 05:29:09 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 05:29:10 INFO - Downloading blobuploader-1.2.4.tar.gz 05:29:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:29:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:29: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 05:29: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 05:29: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 05:29: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 05:29:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:29:11 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:29:11 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 05:29:11 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 05:29:11 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 05:29:11 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 05:29:11 INFO - Downloading docopt-0.6.1.tar.gz 05:29:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:29:11 INFO - Installing collected packages: blobuploader, requests, docopt 05:29:11 INFO - Running setup.py install for blobuploader 05:29:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:29:11 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:29:11 INFO - Running setup.py install for requests 05:29:11 INFO - Running setup.py install for docopt 05:29:12 INFO - Successfully installed blobuploader requests docopt 05:29:12 INFO - Cleaning up... 05:29:12 INFO - Return code: 0 05:29:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:29: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')]} 05:29:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:29: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')]} 05:29:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:29:12 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 0x110b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1479f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1477130>, '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 0x1478030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14784c0>, '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': '920470bf432669ad7e3a5387000001ca-1503577708.995092-995620445', '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 05:29:12 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 05:29:12 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 05:29:12 INFO - Using env: {'DISPLAY': ':0', 05:29:12 INFO - 'HOME': '/home/cltbld', 05:29:12 INFO - 'LANG': 'en_US.UTF-8', 05:29:12 INFO - 'LANGUAGE': 'en_US:en', 05:29:12 INFO - 'LOGNAME': 'cltbld', 05:29:12 INFO - 'MAIL': '/var/mail/cltbld', 05:29:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:29:12 INFO - 'MOZ_NO_REMOTE': '1', 05:29:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:29:12 INFO - 'NO_EM_RESTART': '1', 05:29:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:29:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:29:12 INFO - 'PWD': '/builds/slave/test', 05:29:12 INFO - 'SHELL': '/bin/bash', 05:29:12 INFO - 'SHLVL': '1', 05:29:12 INFO - 'TERM': 'linux', 05:29:12 INFO - 'TMOUT': '86400', 05:29:12 INFO - 'USER': 'cltbld', 05:29:12 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1503577708.995092-995620445', 05:29:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:29:12 INFO - '_': '/tools/buildbot/bin/python'} 05:29:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:29:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:29:12 INFO - Running setup.py (path:/tmp/pip-3uWzkF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:29:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:29:12 INFO - Running setup.py (path:/tmp/pip-4iU1Q7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:29:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:29:12 INFO - Running setup.py (path:/tmp/pip-gk67io-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:29:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:29:12 INFO - Running setup.py (path:/tmp/pip-vmgERJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:29:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:29:12 INFO - Running setup.py (path:/tmp/pip-2_vMll-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:29:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:29:12 INFO - Running setup.py (path:/tmp/pip-S0eiC5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:29:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:29:12 INFO - Running setup.py (path:/tmp/pip-SAHWNv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:29:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:29:12 INFO - Running setup.py (path:/tmp/pip-jD3MKu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:29:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:29:12 INFO - Running setup.py (path:/tmp/pip-iUOZXm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:29:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:29:12 INFO - Running setup.py (path:/tmp/pip-Vvbwag-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:29:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:29:12 INFO - Running setup.py (path:/tmp/pip-6u0pTX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:29:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:29:13 INFO - Running setup.py (path:/tmp/pip-OwTl9M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:29:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:29:13 INFO - Running setup.py (path:/tmp/pip-eoQM2o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:29:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:29:13 INFO - Running setup.py (path:/tmp/pip-rODS38-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:29:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:29:13 INFO - Running setup.py (path:/tmp/pip-M4CHz4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:29:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:29:13 INFO - Running setup.py (path:/tmp/pip-fw6D3P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:29:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:29:13 INFO - Running setup.py (path:/tmp/pip-B_Lw7L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:29:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:29:13 INFO - Running setup.py install for manifestparser 05:29:13 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:29:13 INFO - Running setup.py install for mozcrash 05:29:13 INFO - Running setup.py install for mozdebug 05:29:13 INFO - Running setup.py install for mozdevice 05:29:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:29:13 INFO - Running setup.py install for mozfile 05:29:13 INFO - Running setup.py install for mozhttpd 05:29:14 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:29:14 INFO - Running setup.py install for mozinfo 05:29:14 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:29:14 INFO - Running setup.py install for mozInstall 05:29:14 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:29:14 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:29:14 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:29:14 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:29:14 INFO - Running setup.py install for mozleak 05:29:14 INFO - Running setup.py install for mozlog 05:29:14 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:29:14 INFO - Running setup.py install for moznetwork 05:29:14 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:29:14 INFO - Running setup.py install for mozprocess 05:29:14 INFO - Running setup.py install for mozprofile 05:29:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:29:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:29:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:29:14 INFO - Running setup.py install for mozrunner 05:29:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:29:14 INFO - Running setup.py install for mozscreenshot 05:29:15 INFO - Running setup.py install for moztest 05:29:15 INFO - Running setup.py install for mozversion 05:29:15 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:29:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:29:15 INFO - Cleaning up... 05:29:15 INFO - Return code: 0 05:29:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:29:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:29:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:29:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:29:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:29:15 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 0x110b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1479f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1477130>, '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 0x1478030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14784c0>, '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': '920470bf432669ad7e3a5387000001ca-1503577708.995092-995620445', '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 05:29:15 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 05:29:15 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 05:29:15 INFO - Using env: {'DISPLAY': ':0', 05:29:15 INFO - 'HOME': '/home/cltbld', 05:29:15 INFO - 'LANG': 'en_US.UTF-8', 05:29:15 INFO - 'LANGUAGE': 'en_US:en', 05:29:15 INFO - 'LOGNAME': 'cltbld', 05:29:15 INFO - 'MAIL': '/var/mail/cltbld', 05:29:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:29:15 INFO - 'MOZ_NO_REMOTE': '1', 05:29:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:29:15 INFO - 'NO_EM_RESTART': '1', 05:29:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:29:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:29:15 INFO - 'PWD': '/builds/slave/test', 05:29:15 INFO - 'SHELL': '/bin/bash', 05:29:15 INFO - 'SHLVL': '1', 05:29:15 INFO - 'TERM': 'linux', 05:29:15 INFO - 'TMOUT': '86400', 05:29:15 INFO - 'USER': 'cltbld', 05:29:15 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1503577708.995092-995620445', 05:29:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:29:15 INFO - '_': '/tools/buildbot/bin/python'} 05:29:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:29:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:29:15 INFO - Running setup.py (path:/tmp/pip-EAV6TF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:29:15 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)) 05:29:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:29:15 INFO - Running setup.py (path:/tmp/pip-mxbofG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:29:15 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)) 05:29:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:29:15 INFO - Running setup.py (path:/tmp/pip-JdIrI9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:29:15 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)) 05:29:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:29:15 INFO - Running setup.py (path:/tmp/pip-sTWh2B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:29:15 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)) 05:29:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:29:15 INFO - Running setup.py (path:/tmp/pip-Nlpket-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:29:15 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)) 05:29:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:29:15 INFO - Running setup.py (path:/tmp/pip-qBcTzc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:29:15 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)) 05:29:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:29:15 INFO - Running setup.py (path:/tmp/pip-cgTdwh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:29:15 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)) 05:29:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:29:15 INFO - Running setup.py (path:/tmp/pip-MEtTS6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:29:16 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)) 05:29:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:29:16 INFO - Running setup.py (path:/tmp/pip-Pgh6Fr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:29:16 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)) 05:29:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:29:16 INFO - Running setup.py (path:/tmp/pip-EXIxEF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:29:16 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)) 05:29:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:29:16 INFO - Running setup.py (path:/tmp/pip-zs6jEM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:29:16 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)) 05:29:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:29:16 INFO - Running setup.py (path:/tmp/pip-DfRLpm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:29:16 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)) 05:29:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:29:16 INFO - Running setup.py (path:/tmp/pip-SNsUw8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:29:16 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)) 05:29:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:29:16 INFO - Running setup.py (path:/tmp/pip-xqLQ6a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:29:16 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)) 05:29:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:29:16 INFO - Running setup.py (path:/tmp/pip-Z1LlJB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:29:16 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)) 05:29:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:29:16 INFO - Running setup.py (path:/tmp/pip-_aF7GD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:29:16 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)) 05:29:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:29:16 INFO - Running setup.py (path:/tmp/pip-4gSeMf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:29:16 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)) 05:29:16 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)) 05:29:16 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)) 05:29:16 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)) 05:29:16 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)) 05:29:16 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)) 05:29:16 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)) 05:29:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:29:16 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 05:29:16 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 05:29:16 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 05:29:16 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 05:29:17 INFO - Downloading blessings-1.6.tar.gz 05:29:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:29:17 INFO - Installing collected packages: blessings 05:29:17 INFO - Running setup.py install for blessings 05:29:17 INFO - Successfully installed blessings 05:29:17 INFO - Cleaning up... 05:29:18 INFO - Return code: 0 05:29:18 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:29:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:29:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:29:18 INFO - Reading from file tmpfile_stdout 05:29:18 INFO - Current package versions: 05:29:18 INFO - argparse == 1.2.1 05:29:18 INFO - blessings == 1.6 05:29:18 INFO - blobuploader == 1.2.4 05:29:18 INFO - docopt == 0.6.1 05:29:18 INFO - functools32 == 3.2.3-2 05:29:18 INFO - jsonschema == 2.5.1 05:29:18 INFO - manifestparser == 1.1 05:29:18 INFO - mozInstall == 1.13 05:29:18 INFO - mozcrash == 1.0 05:29:18 INFO - mozdebug == 0.1 05:29:18 INFO - mozdevice == 0.51 05:29:18 INFO - mozfile == 1.2 05:29:18 INFO - mozhttpd == 0.7 05:29:18 INFO - mozinfo == 0.10 05:29:18 INFO - mozleak == 0.1 05:29:18 INFO - mozlog == 3.5 05:29:18 INFO - moznetwork == 0.27 05:29:18 INFO - mozprocess == 0.25 05:29:18 INFO - mozprofile == 0.28 05:29:18 INFO - mozrunner == 6.13 05:29:18 INFO - mozscreenshot == 0.1 05:29:18 INFO - mozsystemmonitor == 0.3 05:29:18 INFO - moztest == 0.8 05:29:18 INFO - mozversion == 1.4 05:29:18 INFO - psutil == 3.1.1 05:29:18 INFO - requests == 1.2.3 05:29:18 INFO - wsgiref == 0.1.2 05:29:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:29:18 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')]} 05:29:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:29:18 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')]} 05:29:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:29:18 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 0x110b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1479f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1477130>, '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 0x1478030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14784c0>, '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': '920470bf432669ad7e3a5387000001ca-1503577708.995092-995620445', '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 05:29:18 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 05:29:18 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 05:29:18 INFO - Using env: {'DISPLAY': ':0', 05:29:18 INFO - 'HOME': '/home/cltbld', 05:29:18 INFO - 'LANG': 'en_US.UTF-8', 05:29:18 INFO - 'LANGUAGE': 'en_US:en', 05:29:18 INFO - 'LOGNAME': 'cltbld', 05:29:18 INFO - 'MAIL': '/var/mail/cltbld', 05:29:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:29:18 INFO - 'MOZ_NO_REMOTE': '1', 05:29:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:29:18 INFO - 'NO_EM_RESTART': '1', 05:29:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:29:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:29:18 INFO - 'PWD': '/builds/slave/test', 05:29:18 INFO - 'SHELL': '/bin/bash', 05:29:18 INFO - 'SHLVL': '1', 05:29:18 INFO - 'TERM': 'linux', 05:29:18 INFO - 'TMOUT': '86400', 05:29:18 INFO - 'USER': 'cltbld', 05:29:18 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1503577708.995092-995620445', 05:29:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:29:18 INFO - '_': '/tools/buildbot/bin/python'} 05:29:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:29:18 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)) 05:29:18 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)) 05:29:18 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)) 05:29:18 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)) 05:29:18 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)) 05:29:18 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)) 05:29:18 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)) 05:29:18 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)) 05:29:18 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)) 05:29:18 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 05:29:18 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 05:29:18 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 05:29:18 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 05:29:18 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 05:29:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 05:29:19 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)) 05:29:19 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)) 05:29:19 INFO - Installing collected packages: simplejson 05:29:19 INFO - Running setup.py install for simplejson 05:29:19 INFO - building 'simplejson._speedups' extension 05:29:19 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 05:29:20 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 05:29:20 INFO - Successfully installed simplejson 05:29:20 INFO - Cleaning up... 05:29:20 INFO - Return code: 0 05:29:20 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:29:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:29:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:29:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:29:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:29:20 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 0x110b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1479f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1477130>, '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 0x1478030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14784c0>, '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': '920470bf432669ad7e3a5387000001ca-1503577708.995092-995620445', '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 05:29:20 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 05:29:20 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 05:29:20 INFO - Using env: {'DISPLAY': ':0', 05:29:20 INFO - 'HOME': '/home/cltbld', 05:29:20 INFO - 'LANG': 'en_US.UTF-8', 05:29:20 INFO - 'LANGUAGE': 'en_US:en', 05:29:20 INFO - 'LOGNAME': 'cltbld', 05:29:20 INFO - 'MAIL': '/var/mail/cltbld', 05:29:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:29:20 INFO - 'MOZ_NO_REMOTE': '1', 05:29:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:29:20 INFO - 'NO_EM_RESTART': '1', 05:29:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:29:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:29:20 INFO - 'PWD': '/builds/slave/test', 05:29:20 INFO - 'SHELL': '/bin/bash', 05:29:20 INFO - 'SHLVL': '1', 05:29:20 INFO - 'TERM': 'linux', 05:29:20 INFO - 'TMOUT': '86400', 05:29:20 INFO - 'USER': 'cltbld', 05:29:20 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1503577708.995092-995620445', 05:29:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:29:20 INFO - '_': '/tools/buildbot/bin/python'} 05:29:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:29:20 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:29:20 INFO - Cleaning up... 05:29:20 INFO - Return code: 0 05:29:20 INFO - Running post-action listener: _resource_record_post_action 05:29:20 INFO - Running post-action listener: _start_resource_monitoring 05:29:20 INFO - Starting resource monitoring. 05:29:20 INFO - [mozharness: 2017-08-24 12:29:20.922636Z] Finished create-virtualenv step (success) 05:29:20 INFO - [mozharness: 2017-08-24 12:29:20.923154Z] Running install step. 05:29:20 INFO - Running pre-action listener: _resource_record_pre_action 05:29:20 INFO - Running main action method: install 05:29:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:29:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:29:21 INFO - Reading from file tmpfile_stdout 05:29:21 INFO - Detecting whether we're running mozinstall >=1.0... 05:29:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:29:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:29:21 INFO - Reading from file tmpfile_stdout 05:29:21 INFO - Output received: 05:29:21 INFO - Usage: mozinstall [options] installer 05:29:21 INFO - Options: 05:29:21 INFO - -h, --help show this help message and exit 05:29:21 INFO - -d DEST, --destination=DEST 05:29:21 INFO - Directory to install application into. [default: 05:29:21 INFO - "/builds/slave/test"] 05:29:21 INFO - --app=APP Application being installed. [default: firefox] 05:29:21 INFO - mkdir: /builds/slave/test/build/application 05:29:21 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'] 05:29:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 05:29:38 INFO - Reading from file tmpfile_stdout 05:29:38 INFO - Output received: 05:29:38 INFO - /builds/slave/test/build/application/firefox/firefox 05:29:38 INFO - Running post-action listener: _resource_record_post_action 05:29:38 INFO - [mozharness: 2017-08-24 12:29:38.948765Z] Finished install step (success) 05:29:38 INFO - [mozharness: 2017-08-24 12:29:38.949018Z] Running setup-mitmproxy step. 05:29:38 INFO - Running pre-action listener: _resource_record_pre_action 05:29:38 INFO - Running main action method: setup_mitmproxy 05:29:38 INFO - Skipping: mitmproxy is not required 05:29:38 INFO - Running post-action listener: _resource_record_post_action 05:29:38 INFO - [mozharness: 2017-08-24 12:29:38.950283Z] Finished setup-mitmproxy step (success) 05:29:38 INFO - [mozharness: 2017-08-24 12:29:38.950502Z] Running run-tests step. 05:29:38 INFO - Running pre-action listener: _resource_record_pre_action 05:29:38 INFO - Running pre-action listener: _set_gcov_prefix 05:29:38 INFO - Running main action method: run_tests 05:29:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:29:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:29:38 INFO - Python 2.7.3 05:29:38 INFO - Return code: 0 05:29:38 INFO - grabbing minidump binary from tooltool 05:29: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')]} 05:29:38 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 0x1477130>, '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 0x1478030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14784c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:29:38 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 05:29:38 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 05:29:38 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 05:29:39 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:29:39 INFO - Return code: 0 05:29:39 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:29:39 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:29:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:29:39 INFO - ENV: RUST_BACKTRACE is now full 05:29:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:29:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:29:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/edDsDxIfTzGMCiv9-pbWyw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--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 05:29:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/edDsDxIfTzGMCiv9-pbWyw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-053 --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 05:29:39 INFO - Using env: {'DISPLAY': ':0', 05:29:39 INFO - 'HOME': '/home/cltbld', 05:29:39 INFO - 'LANG': 'en_US.UTF-8', 05:29:39 INFO - 'LANGUAGE': 'en_US:en', 05:29:39 INFO - 'LOGNAME': 'cltbld', 05:29:39 INFO - 'MAIL': '/var/mail/cltbld', 05:29:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:29:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:29:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:29:39 INFO - 'MOZ_NO_REMOTE': '1', 05:29:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:29:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:29:39 INFO - 'NO_EM_RESTART': '1', 05:29:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:29:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:29:39 INFO - 'PWD': '/builds/slave/test', 05:29:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:29:39 INFO - 'RUST_BACKTRACE': 'full', 05:29:39 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 05:29:39 INFO - 'SHELL': '/bin/bash', 05:29:39 INFO - 'SHLVL': '1', 05:29:39 INFO - 'STYLO_FORCE_ENABLED': '1', 05:29:39 INFO - 'TERM': 'linux', 05:29:39 INFO - 'TMOUT': '86400', 05:29:39 INFO - 'USER': 'cltbld', 05:29:39 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1503577708.995092-995620445', 05:29:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:29:39 INFO - '_': '/tools/buildbot/bin/python'} 05:29:39 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/edDsDxIfTzGMCiv9-pbWyw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--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 05:29:39 INFO - mozversion application_buildid: 20170824112915 05:29:39 INFO - mozversion application_changeset: 32674de9af80667006ab1a4efcdc70115faf48e9 05:29:39 INFO - mozversion application_display_name: Nightly 05:29:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:29:39 INFO - mozversion application_name: Firefox 05:29:39 INFO - mozversion application_remotingname: firefox 05:29:39 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:29:39 INFO - mozversion application_vendor: Mozilla 05:29:39 INFO - mozversion application_version: 57.0a1 05:29:39 INFO - mozversion platform_buildid: 20170824112915 05:29:39 INFO - mozversion platform_changeset: 32674de9af80667006ab1a4efcdc70115faf48e9 05:29:39 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:29:39 INFO - mozversion platform_version: 57.0a1 05:29:39 INFO - using testdate: 1503577779 05:29:39 INFO - actual date: 1503577779 05:29:39 INFO - starting webserver on 'localhost:47822' 05:29:39 INFO - SUITE-START | Running 2 tests 05:29:39 INFO - TEST-START | dromaeo_css 05:29:39 INFO - Initialising browser for dromaeo_css test... 05:29:39 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:47822/getInfo.html -profile /tmp/tmpuvZ3eD/profile 05:29:39 INFO - TEST-INFO | started process 32741 (/builds/slave/test/build/application/firefox/firefox http://localhost:47822/getInfo.html) 05:29:45 INFO - TEST-INFO | 32741: exit 0 05:29:45 INFO - Browser initialized. 05:29:45 INFO - Running cycle 1/1 for dromaeo_css test... 05:29:45 INFO - TEST-INFO | started process 459 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuvZ3eD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 05:29:46 INFO - PID 459 | 05:29:46 INFO - PID 459 | (/builds/slave/test/build/application/firefox/firefox:508): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 05:29:46 INFO - PID 459 | 05:29:47 INFO - PID 459 | 05:29:47 INFO - PID 459 | (/builds/slave/test/build/application/firefox/firefox:567): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 05:29:47 INFO - PID 459 | 05:29:47 INFO - PID 459 | __metrics Screen width/height:1600/1200 05:29:47 INFO - PID 459 | colorDepth:24 05:29:47 INFO - PID 459 | Browser inner width/height: 1024/768 05:29:47 INFO - PID 459 | __metrics 05:29:56 INFO - PID 459 | RSS: Main: 174559232 05:29:56 INFO - PID 459 | 05:32:56 INFO - PID 459 | Cycle 1(1): loaded http://localhost:47822/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47822/tests/dromaeo/cssquery-ext.html) 05:32:57 INFO - PID 459 | RSS: Main: 178540544 05:32:57 INFO - PID 459 | 05:35:58 INFO - PID 459 | Cycle 1(1): loaded http://localhost:47822/tests/dromaeo/cssquery-ext.html (next: http://localhost:47822/tests/dromaeo/cssquery-jquery.html) 05:35:59 INFO - PID 459 | RSS: Main: 174665728 05:35:59 INFO - PID 459 | 05:39:01 INFO - PID 459 | Cycle 1(1): loaded http://localhost:47822/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47822/tests/dromaeo/cssquery-mootools.html) 05:39:01 INFO - PID 459 | RSS: Main: 177360896 05:39:01 INFO - PID 459 | 05:42:03 INFO - PID 459 | Cycle 1(1): loaded http://localhost:47822/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47822/tests/dromaeo/cssquery-prototype.html) 05:42:04 INFO - PID 459 | RSS: Main: 175648768 05:42:04 INFO - PID 459 | 05:45:07 INFO - PID 459 | Cycle 1(1): loaded http://localhost:47822/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47822/tests/dromaeo/cssquery-yui.html) 05:45:08 INFO - PID 459 | RSS: Main: 179171328 05:45:08 INFO - PID 459 | 05:48:10 INFO - PID 459 | Cycle 1(1): loaded http://localhost:47822/tests/dromaeo/cssquery-yui.html (next: http://localhost:47822/tests/dromaeo/cssquery-dojo.html) 05:48:10 INFO - PID 459 | RSS: Main: 177664000 05:48:10 INFO - PID 459 | 05:48:10 INFO - PID 459 | __start_tp_report 05:48:10 INFO - PID 459 | _x_x_mozilla_page_load 05:48:10 INFO - PID 459 | _x_x_mozilla_page_load_details 05:48:10 INFO - PID 459 | |i|pagename|runs| 05:48:10 INFO - PID 459 | |0;dojo.html;3241.124896278005;3254.528093426454;3276.2464633134396;3288.687574680405;3331.1172539277095;6070.635761854292;6149.846253843651;6210.596311239767;6222.160008398865;6245.656488893114;6149.877002459959;6216.098665693483;6217.036359364294;6219.657918814463;6244.219472565929;5636;5646.943530564703;5673.375928647845;5681.460261275172;5772.797952071678;5741.770329186827;5744.626599271055;5778.248827652399;5797.101449275369;5852.795152169675;5571.777128914839;5654;5700.258966334371;5744.138379243105;5823.534117270629;5713.74288157034;5725.971370143165;5738.110592858072;5751.539876809887;5755.597108202427;5597.916031259534;5678.517326027292;5685.715714214314;5694.544436445074;5698.43015698431;5854.2389489366105;6133.969330153321;6143.047827586731;6195.721192546302;6244.500439964792;6440.935590644081;6508.153939987818;6656.733730650768;6657.700403481855;6663.600183988928;6701.597904125768;6777.1189745332795;6788.7623933162595;6797.728090876359;6798.592084474898;5974.970125149346;6143.539234557336;6192.411720886508;6196.81409557714;6306.747730090837;6667.099941507931;6668.633225172662;6685.933140668629;6686.3313668632745;6692.364225398579;6295.622262664255;6370.0763389308295;6370.140031095742;6372.267189273293;6373.490120790326;6452.580582262138;6485.4487368573255;6545.410913017851;6595.1096601958125;6614.669266536654;6604.900926486107;6610.471162307004;6688.398044176048;6691.130153080068;6702.061711360413;6363.522735794834;6621.933780662228;6624.403803657694;6713.597184168965;6722.1261236039;5206.0368831766245;5240.6069544784295;5260.342457192851;5265.0259701955265;5265.947340526545;4624.560666736655;4665.95334046662;4674.906501869944;4677.134730074879;4678.157931572282;5728.656280623176;5744.597878148573;5810.360860305363;5818.970905145447;5845.357010728816;6399.456046236122;6529.8694026120165;6648.335166483313;6664.8000559983275;6728.125343705287;5664.122061080539;5684.403137670568;5707.143928410772;5710.086386178192;5768.682722450221;5724;5745.166950792195;5750.769969201268;5750.971245143831;5778.797742079091;6484.967575162094;6486.091947127406;6520.641364724986;6532.150820393414;6593.406593406617;6503.317151699192;6590.604563726191;6619.669016549057;6759;6759.019942108465;6477.4170324671;6533.020046992799;6536.019597060479;6541.149650545399;6546.8363290918105;6557.245916719447;6567.080608714879;6588.967055164693;6632.971889357157;6640.900386494303;6671.966640166768;6701.229358623626;6770.526063175727;6776.898346524707;6792.864142717217;6464;6468.8059358219325;6532.118164047793;6548.279689234276;6564;6198.504119670506;6244.718987645658;6265.279492858197;6282.340354262737;6540.215174179129;6273.654948977667;6288.245410550763;6337.04944258365;6364.87270254583;6380.042993551005;6505.349465053457;6551.967240163769;6561.179852518435;6566.9014964776525;6618.63597502142;6160.938390616216;6249.468795152281;6271.529635277281;6300.9684951574945;6345.714442850175 05:48:10 INFO - PID 459 | |1;ext.html;818.7257268814947;835.1648351648352;873.4191762477955;873.9344549158815;1101.372217835834;29307.267318317052;29918.70081299189;29945.1016469506;40842.183156336854;40945.59054409455;40102.7994860026;40662.39006414899;40677;40741.796291018574;40767.38848917261;7521.135069466999;7666.501677390979;7669.271419215165;7671;7679.078510578738;7700.306972372486;7748.612569371537;7749.922500775005;7775.339096176832;7786.299233069023;7765.611719414035;7771.8057048573955;7781.338586220149;7808.60956952153;7811;7689.154193038761;7719.305262526372;7741.496802707806;7749.380049596019;7783.610819459061;7678.117016543058;7695.422843286776;7718.575478348688;7737.767866964;7746.147923728386;36045.63954360449;36155.63844361549;36184.63815361839;36185.81907090474;36288;3562.1272788166807;3564.198055437532;3578.35589593873;3582.7671201371827;3584.946225806615;31161.688383116107;31219.219519511968;31276.218094547592;31303.53044704331;31394.529082063786;5179.119549676564;5187.662801917901;5217.3217481727515;5222.8694282642855;5225.059489291964;170701.14649426797;171466;171638;171676.14161929235;171887;45591.31613025807;45614.31578526325;45825;45832.7708361456;45890.08219835585;47828;47962.520374796506;47975;48076.75961620169;48177.5182248173;15655.138967356905;15820.92089539545;15852.60368490797;15869.841301587066;15906.443274485337;13151.67120821968;13152.868471315356;13169.341532923316;13170.07809453329;13210.471581136839;12703.42834572428;12929.353532323346;12960.80558791619;12990.155639883378;13064.477420903057;5004;5055.34280543527;5099.260607212008;5112.71880046601;5115.820946266863;1005.2661557063385;1009.1271050541229;1010.6260683547134;1017.2777328096986;1017.760826205841;21956.780432195792;22170.778292217194;22406.43983900383;22486.988085535864;22722.659160112613;1104.6354702948008;1109.1293334732197;1113.8273567597034;1114.916381271408;1117.944102794857;11837.348945808064;11866;11882.465289062013;11887.049036077093;11903.523859045714;208838;209671;209862;220463;220514;53225.7338713304;53348.46651533512;53365;53453.732731336095;53571;1411.4072089722342;1431.0412023943982;1441.6612096157394;1446.2985452055746;1448.9637759056109;26096.608550871373;26163.738362616892;26197.345066373495;26326.736732632427;26923.86538067297;36791;36819.81590092139;36830;36894.8155259222;36990.63009369872;183758;183938;184542;184550;185118;32624.510632341007;32681.18297042593;32734.836325818218;32805.17987050247;32989.67010329962;40817.79591102026;41078;44217;45282.09435811331;45464.54535454736;32020.19949501188;32201.51697724583;32568.51147232841;32816.50775238326;32892;32124.19689507781;32374.676253237165;32414;32620;33391.49912751262;36817.447738284485;37095.072623184635;37193;37307.440388393654;37324.25351493009;31545.684543155192;31794.52308215425;32200.516992245604;32371.028869133963;32685.673143268265;23163.65254521217;23256.65115023242;23499.297580777744;23643.527129456972;23677.526449471257 05:48:10 INFO - PID 459 | |2;jquery.html;533.919912013198;539.9325084364455;548.7953941099289;549.5850632772258;572.1732097119663;21752.238671646497;22028.33914982551;22711.205107821228;22737.090516379347;22756.544869102607;24562.754372456315;24944.625830612556;25220.62169067461;25276.873615631943;25282;6572.1784776903005;6745.662716864162;6761.323867613224;6766.526343155981;6775.32246775321;6058.242719660043;6637.93362066378;6638.734450621993;6639.568428052161;6643.402093811556;6611.338866113399;6611.636360000198;6612.471002319827;6612.834679133036;6618.3050779668165;6589.835254118638;6601.240857301424;6612.43794277487;6620.470362371023;6626.2048554173325;6071.423214794588;6092.939070609282;6138.07928810682;6148.815535533941;6158.753649854;28251.57622635662;28387.716122838712;28531.714682853115;28717.856410717814;28768.568471472943;2038.1032345767815;2055.640262953977;2063.515073957619;2066.6486697261503;2069.9172033118657;18870.622587548172;19481.902590487098;19512.609747805105;19513.414597562096;19515.219391224477;2382.4520360317224;2420.8789560521905;2475.331660451668;2541.2122242105006;2548.120898290087;132517;134307.32846335805;134360;134730.32634836764;135124.32437837747;13394.861436777788;14120.929395353163;14500.347484363228;14508;14789;22775.886120569623;22805.88597057004;22818.543629127325;22856.428589285068;22910.541789164457;9972.80054398908;10079.899201008042;10155.746106347253;10277.331973421704;10368;7716.691332346755;8076.475029123206;9349.626014959462;9667.033296670277;9846.113849753556;8156.877646835303;8710.433821801562;8863.379563430499;8876.51179185151;9047.276217902552;2642.8546429946537;2670.145553422925;2678.55803792376;2688.2848323193325;2722.9319267018086;954.909283618069;967.2455484721928;971.8930917599058;977.2035790830593;981.1316984468797;18618;18788.248470061317;18829.811701882805;18955.71566426477;19498.70751938722;1008.5007921078966;1030.685640879524;1032.0866033560353;1042.9478526073665;1043.4678314059884;10632.30889992148;10708.250422470508;10846.18653600983;10862.565497380016;11002.779944401067;424975.5318086475;439822;440675;441645;441787;104413;107841;113180;115430;115704;1140.7091191746051;1150.913681473893;1156.2311063142915;1169.3743847041962;1173.3781096019125;16477.093759842843;16803.41188058412;17038.31846726117;17171;17295.913520432317;51409.74295128501;51599.48400516097;51996.70008249824;52780.47219527909;54289.18566221589;63827.68086159539;63962.360376397504;64263.357366425735;64273.67863160654;64681.67659161862;11812;13489.190648561118;13965.650858728613;14063.156210627396;14149.43402263939;21864.906754662523;22165.22421715232;22239;22239;22251.888740556195;17895.926244425376;17953.192106354985;18126.81873181304;18181.272749089887;18198.45404637863;15747.685046299239;16028.43900463525;16256.674866502368;16427.91786041062;16577.25402356921;18111.72832407541;18336.72494912604;18666.71999919975;19993.600127997066;20020.199192032156;14256.71486570242;14386.136831790127;14397.280135992949;14477.782833257721;14534.200618966059;17949.282028718706;18206.544836379195;18633;18737.1568279425;18759.812401876352 05:48:10 INFO - PID 459 | |3;mootools.html;1265.335698758152;1325.1452812935656;1337.1709540085149;1339.2098661789546;1343.3753304713307;14040.227787471686;14434;14966.625834354147;15004.099754014767;15021.699566008701;14645.340959656814;14859.257037148154;14861.628459288524;14886.478973235911;14888.404463821462;2657.2559683288664;2709.5122877882072;2712.050782226225;2712.3761534847;2723.2919440945298;2568.0883286433327;2669.4394177222807;2719.714429984853;2720.088770261965;2721.4421043686098;2618.3192369983844;2642.2469596165097;2654.561997270448;2685.5568831142837;2686.758191762741;2579.045753071357;2579.6775403074616;2585.28904551249;2586.1465716313573;2599.051346258621;2564.1410127607273;2569.293444302813;2590.4430547432203;2593.4164812916943;2593.520198763216;13899.444022239099;14151.575452736435;14158.150510969375;14164.716705665933;14177.14937103777;7273.854522909565;7550.169481357047;7586.58273794941;7598.240175982412;7611.314981651678;5125.154349532323;5195.9740201298755;5259.447757985395;5313.335833020872;5347.41178470368;1845.4740398986226;1855.6381505606412;1859.414284500378;1886.2455017992913;1893.3278686066524;24165;24379.512409751882;24385.512289754282;24400.877995610084;24412.755872441227;6210.72051757672;6377.23473183221;6423.197100362455;6510.44661203803;6536.411722944958;16266.837331626532;16322;16332.510024699279;16368.345266189457;16437.26032328548;7362.300581444754;7473.925260747323;7520.586367749717;7521.135069467081;7525.924740752632;5754.4533269339345;6004.8799024020145;6226.782062627877;6227.844303892349;6911.516193866381;4848.830290939871;5006.123928312531;5127.179651255781;5194.27280180775;5212.50481204285;1461.3935216884875;1477.7783332499996;1480.592836969842;1481.4370539195252;1492.6268432891777;880.5993273060742;901.9942763818295;902.3773596218588;916.6104405627582;919.5861862162054;7622.618869056525;7656.693732250759;7700.845983080307;7703.34521565662;7793.493422927491;672.0826072411123;690.1649004704364;704.5737328916034;713.5682911838367;727.3453891497694;5248.606354523426;5566.304211973504;5648.661080335193;5660.066089095253;5675.31896172462;19132.521686957938;19980.700289495377;20300.492487687927;20400.897995509928;20436.182552697726;19822.90088549548;20378;20589.07349169291;20789.272375467088;20881.791182088287;10917.126629869592;11088.611898583511;11158.330500170016;11161.944190278997;11173.664790056311;8280.213379728915;8311.127331630334;8314.708985185489;8346.374021948257;8484.830303394021;17225.741613876053;17299.30802767875;17398.565035874206;17672.646547069246;17798.91100544489;17867.195976180843;17935.910320448314;18042.819571804113;18058.367957121438;18100.909495452437;11420;11910.642680719593;11926.105542084204;12000.339981300764;12007.75984480323;13133.34333283351;13400.664983375493;13485.258310793;13485.86514134846;13533.593992180251;11304;11489.310641361544;11664;11770;11943;10874.749403818661;11188.720281993015;11309.434528273388;11330.546778129112;11425.885741142481;10037.19702423819;10118.443485608363;10136.594536218468;10190.898091019291;10273.280870339304;7243.855122897618;7262.49162558637;7297.598632075287;7322.121345438369;7392.96303518479;7752.108507521707;7842.333401660922;7878.369730421437;7903.881441778493;7983.2415920487465 05:48:10 INFO - PID 459 | |4;prototype.html;501.4834720238156;504.41991709534034;519.5376115257421;520.341767663905;522.5897670328793;6292.622442653438;6323.470611755294;6363.618182909028;6364.713587888545;6366.777162799303;6029.517638588903;6084.554323880136;6099.359567245442;6113.69431528423;6215.689215539228;4776.331313616097;4946.431160416562;5024.422191447976;5127.666701664399;5149.510796474338;4904.926426103593;4920.188168952119;4952.975235123819;5008.348914641091;5024.362209839826;4840.225563909775;4879.292502587123;4940.728259945701;4975.2039673652225;4983.52656497634;4877.756112194376;4899.657024008321;4914.557689807916;4933.136701077315;4984.127777638899;4424.646028317727;4454.198244316021;4459;4481.798319075617;4491.214037543416;6110.938890611082;6114.877702445926;6149.938500614981;6169.5064394848305;6190.721417536221;5588.776448942038;5594.272744543224;5605.943940560583;5667.659940403589;5687.601867869251;6429.903551446732;6461.57999730016;6493;6495.772647957298;6501.349865013508;4803.111424386465;4809.398825146856;4830.9275360869615;4839.814245509838;4842.733649649268;6517.250516190698;6640.7675731349655;6691.297413771533;6762.46407597151;6798.2182049064495;4884.65807393479;4927.236278376858;4944.258361245842;4983.277424773388;4991.5258050485145;4954.677945933575;4956.199747142853;4997.675151115239;5009.872778624853;5037.168867136955;5552.7778888843995;5580.525655319343;5607.495325420732;5614.578906582023;5634.23937768396;6489.766944280666;6513.8504293583;6541.967290163614;6563.3764792344655;6571.737130514822;1736.7308067249596;1742.4772568229735;1742.9389971350943;1744.816794236587;1758.7273972534279;1133.7732453509332;1186.9762604747857;1194.498310709504;1203.2900588652737;1213.805791073424;5713.371529131792;5747.482726554546;5758.798442054508;5824;5850.765969361178;6680.298568650319;6707.564008339442;6710.027046078291;6770.796876093725;6816.352446517573;5696.572757043238;5755.755255450377;5793.362730099686;5803.419658034163;5804.506616937608;3547.396942519778;3551.7691350062164;3552.289542091592;3561.465780132949;3563.94654080189;6529.971921620326;6592.670366481752;6596.373344532261;6605.07528945948;6613.503987200979;6789.321067893171;6842.178938527309;6860.759873404407;6927.93072069283;6947.51367404287;6448.806535803933;6471.417572418505;6510.837229069217;6517.8696426072165;6548.345165483509;6166.753329866934;6602.471802255712;6640.335966403321;6641;6652.800415987528;6482.222133344029;6505.316941721051;6536.901946470902;6606.735730570916;6652.567583107082;6351.142595749515;6485.254195767548;6506.25178104524;6518.315576864361;6518.57629254097;4942.481039490802;4945.406551213733;4961.181405068268;4964.67729597575;4991.775370108427;6484.254310754323;6530.967345163243;6543.574667646588;6742.190937087581;6802.795916122524;6390.584612000205;6448.258450278278;6454.580452270588;6480.57876238043;6489.3510648934725;6430.64631445275;6455.709493072729;6473.741050357933;6512.120863683342;6519.674016299261;6386.201724784402;6438;6446.8388290293115;6487.513436492376;6526.9347306528225;6579.967100164468;6600;6626.87343151675;6683.131192944886;6691.1636045494315;6365;6403.847307484698;6417.358264173732;6422.6467544285515;6456.709448074754 05:48:10 INFO - PID 459 | |5;yui.html;869.148234729965;874.7856775090104;888.5868071346822;891.6567121658163;897.5960817632065;16834.579135521602;17238.569035774097;18061.4581562553;18426.355077572287;18475.53811154722;17584.82415175848;18027.36904208353;20827;21037.68443473349;21076.8946155269;936.4381371177291;943.3113826906363;945.1399226703701;946.1579194516886;946.4557879219442;878.9296856251484;905.6377449020379;940.031767279703;940.8165407745493;963.8602402651611;983.7934033852899;985.1084768284713;985.8126955878361;988.5600907596123;999.5002498750624;977.2035790830521;980.5538479991586;981.0630847540582;981.4356744871656;995.9153471954857;717.8851383778623;718.7125149940014;722.404016686236;726.4333819620651;734.3904559215891;18486.722699159523;18771.624567508574;19080;19154.329598463988;19191.904040479847;19594.412167634993;20234.291799786937;20423.080961356776;20742.274020409364;20840.791592084188;16414.589635259214;16473.34106635733;16631.501054968372;16631.66736665272;16823.327066917307;3783.129880127586;3814.370628846237;3817.2174704185577;3818.3127037133304;3819.083419979185;122429;122486;123547;125329.98680052787;126637.36681316627;15537.844621553866;15930.203489825462;16115.597110072342;16194.919025405034;16213.837861621469;22564;23152.18967336135;28978.13065608035;29581.85209073941;29712.851435743116;8958.776030599287;9108.225800806873;9130.132637399436;9135.634574617074;9157.633694652273;4250.7334011854455;4294.291441912112;4355.738655680606;4408.603225709701;4410.360497727812;5104.387473503203;5230.3985041719925;5232.058229518647;5240.528352448298;5249.947500524946;1017.9134773544332;1052.2476429353048;1057.4191583582594;1063.8723353197665;1065.9786804263872;678.3657280442802;684.6337209592843;696.7073828991836;711.4273010226817;711.6406214861565;11247;11540.653780386601;11850.81491850808;12227.877721222852;12495.50017999288;687.5805758487419;691.7060249393987;693.8196069022091;699.919509256442;707.2538471912183;5954.612950158225;6024.668643224665;6332.303446620868;6339.587926784744;6371.808845734636;109352.45323773331;109922.45038774755;111005;111071.44464277789;113747;92738;93307.53346233361;95503.52248238714;96701.5164924185;101877.49061254646;83375.58312208521;83667;84900.57549712212;86496.56751716201;86657.13342866617;12111.939440302742;12158.756824863276;12286.078544109407;12303.630891073282;12420.75158496807;40237.798811005756;40373.59626403698;40856.79571602123;41492.170156597305;42160;71508.64245678738;71687;71821;71832;74660.62669686617;16310.673786524441;16330.755038674191;16699.91650041742;16844.410445634345;16893.32426702967;18579.25682972666;18690.34583789561;18692.158852851382;19678.50803729861;20943.476413089793;18931.148098335885;19213.615727685647;19258.614827703088;19272.903635481733;19295.131719072957;18440;18642.906785465984;18644.627107458047;18693.81306186921;19069.33257336042;18665.16006779671;18857.24571017144;18860.811391885905;18891.716624250923;19117.522061948563;12444.875551244733;12455.750884982432;12692.111552191258;12884.613461596167;12933.353332333534;13528.323583820966;13667.86332136666;13739.038267321192;13740.244286564335;13813.378397971914 05:48:10 INFO - PID 459 | __end_tp_report 05:48:10 INFO - PID 459 | __start_cc_report 05:48:10 INFO - PID 459 | _x_x_mozilla_cycle_collect,389 05:48:10 INFO - PID 459 | __end_cc_report 05:48:10 INFO - PID 459 | __startTimestamp1503578890619__endTimestamp 05:48:10 INFO - PID 459 | 05:48:10 INFO - PID 459 | ------- Summary: start ------- 05:48:10 INFO - PID 459 | Number of tests: 6 05:48:10 INFO - PID 459 | 05:48:10 INFO - PID 459 | [#0] dojo.html Cycles:165 Average:6105.58 Median:6288.25 stddev:697.62 (11.1%) stddev-sans-first:662.58 05:48:10 INFO - PID 459 | Values: 3241.1 3254.5 3276.2 3288.7 3331.1 6070.6 6149.8 6210.6 6222.2 6245.7 6149.9 6216.1 6217.0 6219.7 6244.2 5636.0 5646.9 5673.4 5681.5 5772.8 5741.8 5744.6 5778.2 5797.1 5852.8 5571.8 5654.0 5700.3 5744.1 5823.5 5713.7 5726.0 5738.1 5751.5 5755.6 5597.9 5678.5 5685.7 5694.5 5698.4 5854.2 6134.0 6143.0 6195.7 6244.5 6440.9 6508.2 6656.7 6657.7 6663.6 6701.6 6777.1 6788.8 6797.7 6798.6 5975.0 6143.5 6192.4 6196.8 6306.7 6667.1 6668.6 6685.9 6686.3 6692.4 6295.6 6370.1 6370.1 6372.3 6373.5 6452.6 6485.4 6545.4 6595.1 6614.7 6604.9 6610.5 6688.4 6691.1 6702.1 6363.5 6621.9 6624.4 6713.6 6722.1 5206.0 5240.6 5260.3 5265.0 5265.9 4624.6 4666.0 4674.9 4677.1 4678.2 5728.7 5744.6 5810.4 5819.0 5845.4 6399.5 6529.9 6648.3 6664.8 6728.1 5664.1 5684.4 5707.1 5710.1 5768.7 5724.0 5745.2 5750.8 5751.0 5778.8 6485.0 6486.1 6520.6 6532.2 6593.4 6503.3 6590.6 6619.7 6759.0 6759.0 6477.4 6533.0 6536.0 6541.1 6546.8 6557.2 6567.1 6589.0 6633.0 6640.9 6672.0 6701.2 6770.5 6776.9 6792.9 6464.0 6468.8 6532.1 6548.3 6564.0 6198.5 6244.7 6265.3 6282.3 6540.2 6273.7 6288.2 6337.0 6364.9 6380.0 6505.3 6552.0 6561.2 6566.9 6618.6 6160.9 6249.5 6271.5 6301.0 6345.7 05:48:10 INFO - PID 459 | 05:48:10 INFO - PID 459 | [#1] ext.html Cycles:180 Average:35814.99 Median:32854.25 stddev:49315.42 (150.1%) stddev-sans-first:49383.75 05:48:10 INFO - PID 459 | Values: 818.7 835.2 873.4 873.9 1101.4 29307.3 29918.7 29945.1 40842.2 40945.6 40102.8 40662.4 40677.0 40741.8 40767.4 7521.1 7666.5 7669.3 7671.0 7679.1 7700.3 7748.6 7749.9 7775.3 7786.3 7765.6 7771.8 7781.3 7808.6 7811.0 7689.2 7719.3 7741.5 7749.4 7783.6 7678.1 7695.4 7718.6 7737.8 7746.1 36045.6 36155.6 36184.6 36185.8 36288.0 3562.1 3564.2 3578.4 3582.8 3584.9 31161.7 31219.2 31276.2 31303.5 31394.5 5179.1 5187.7 5217.3 5222.9 5225.1 170701.1 171466.0 171638.0 171676.1 171887.0 45591.3 45614.3 45825.0 45832.8 45890.1 47828.0 47962.5 47975.0 48076.8 48177.5 15655.1 15820.9 15852.6 15869.8 15906.4 13151.7 13152.9 13169.3 13170.1 13210.5 12703.4 12929.4 12960.8 12990.2 13064.5 5004.0 5055.3 5099.3 5112.7 5115.8 1005.3 1009.1 1010.6 1017.3 1017.8 21956.8 22170.8 22406.4 22487.0 22722.7 1104.6 1109.1 1113.8 1114.9 1117.9 11837.3 11866.0 11882.5 11887.0 11903.5 208838.0 209671.0 209862.0 220463.0 220514.0 53225.7 53348.5 53365.0 53453.7 53571.0 1411.4 1431.0 1441.7 1446.3 1449.0 26096.6 26163.7 26197.3 26326.7 26923.9 36791.0 36819.8 36830.0 36894.8 36990.6 183758.0 183938.0 184542.0 184550.0 185118.0 32624.5 32681.2 32734.8 32805.2 32989.7 40817.8 41078.0 44217.0 45282.1 45464.5 32020.2 32201.5 32568.5 32816.5 32892.0 32124.2 32374.7 32414.0 32620.0 33391.5 36817.4 37095.1 37193.0 37307.4 37324.3 31545.7 31794.5 32200.5 32371.0 32685.7 23163.7 23256.7 23499.3 23643.5 23677.5 05:48:10 INFO - PID 459 | 05:48:10 INFO - PID 459 | [#2] jquery.html Cycles:180 Average:32562.60 Median:22481.55 stddev:74235.69 (330.2%) stddev-sans-first:74404.99 05:48:10 INFO - PID 459 | Values: 533.9 539.9 548.8 549.6 572.2 21752.2 22028.3 22711.2 22737.1 22756.5 24562.8 24944.6 25220.6 25276.9 25282.0 6572.2 6745.7 6761.3 6766.5 6775.3 6058.2 6637.9 6638.7 6639.6 6643.4 6611.3 6611.6 6612.5 6612.8 6618.3 6589.8 6601.2 6612.4 6620.5 6626.2 6071.4 6092.9 6138.1 6148.8 6158.8 28251.6 28387.7 28531.7 28717.9 28768.6 2038.1 2055.6 2063.5 2066.6 2069.9 18870.6 19481.9 19512.6 19513.4 19515.2 2382.5 2420.9 2475.3 2541.2 2548.1 132517.0 134307.3 134360.0 134730.3 135124.3 13394.9 14120.9 14500.3 14508.0 14789.0 22775.9 22805.9 22818.5 22856.4 22910.5 9972.8 10079.9 10155.7 10277.3 10368.0 7716.7 8076.5 9349.6 9667.0 9846.1 8156.9 8710.4 8863.4 8876.5 9047.3 2642.9 2670.1 2678.6 2688.3 2722.9 954.9 967.2 971.9 977.2 981.1 18618.0 18788.2 18829.8 18955.7 19498.7 1008.5 1030.7 1032.1 1042.9 1043.5 10632.3 10708.3 10846.2 10862.6 11002.8 424975.5 439822.0 440675.0 441645.0 441787.0 104413.0 107841.0 113180.0 115430.0 115704.0 1140.7 1150.9 1156.2 1169.4 1173.4 16477.1 16803.4 17038.3 17171.0 17295.9 51409.7 51599.5 51996.7 52780.5 54289.2 63827.7 63962.4 64263.4 64273.7 64681.7 11812.0 13489.2 13965.7 14063.2 14149.4 21864.9 22165.2 22239.0 22239.0 22251.9 17895.9 17953.2 18126.8 18181.3 18198.5 15747.7 16028.4 16256.7 16427.9 16577.3 18111.7 18336.7 18666.7 19993.6 20020.2 14256.7 14386.1 14397.3 14477.8 14534.2 17949.3 18206.5 18633.0 18737.2 18759.8 05:48:10 INFO - PID 459 | 05:48:10 INFO - PID 459 | [#3] mootools.html Cycles:180 Average:8998.58 Median:2566.11 stddev:6264.14 (244.1%) stddev-sans-first:6254.76 05:48:10 INFO - PID 459 | Values: 1265.3 1325.1 1337.2 1339.2 1343.4 14040.2 14434.0 14966.6 15004.1 15021.7 14645.3 14859.3 14861.6 14886.5 14888.4 2657.3 2709.5 2712.1 2712.4 2723.3 2568.1 2669.4 2719.7 2720.1 2721.4 2618.3 2642.2 2654.6 2685.6 2686.8 2579.0 2579.7 2585.3 2586.1 2599.1 2564.1 2569.3 2590.4 2593.4 2593.5 13899.4 14151.6 14158.2 14164.7 14177.1 7273.9 7550.2 7586.6 7598.2 7611.3 5125.2 5196.0 5259.4 5313.3 5347.4 1845.5 1855.6 1859.4 1886.2 1893.3 24165.0 24379.5 24385.5 24400.9 24412.8 6210.7 6377.2 6423.2 6510.4 6536.4 16266.8 16322.0 16332.5 16368.3 16437.3 7362.3 7473.9 7520.6 7521.1 7525.9 5754.5 6004.9 6226.8 6227.8 6911.5 4848.8 5006.1 5127.2 5194.3 5212.5 1461.4 1477.8 1480.6 1481.4 1492.6 880.6 902.0 902.4 916.6 919.6 7622.6 7656.7 7700.8 7703.3 7793.5 672.1 690.2 704.6 713.6 727.3 5248.6 5566.3 5648.7 5660.1 5675.3 19132.5 19980.7 20300.5 20400.9 20436.2 19822.9 20378.0 20589.1 20789.3 20881.8 10917.1 11088.6 11158.3 11161.9 11173.7 8280.2 8311.1 8314.7 8346.4 8484.8 17225.7 17299.3 17398.6 17672.6 17798.9 17867.2 17935.9 18042.8 18058.4 18100.9 11420.0 11910.6 11926.1 12000.3 12007.8 13133.3 13400.7 13485.3 13485.9 13533.6 11304.0 11489.3 11664.0 11770.0 11943.0 10874.7 11188.7 11309.4 11330.5 11425.9 10037.2 10118.4 10136.6 10190.9 10273.3 7243.9 7262.5 7297.6 7322.1 7393.0 7752.1 7842.3 7878.4 7903.9 7983.2 05:48:10 INFO - PID 459 | 05:48:10 INFO - PID 459 | [#4] prototype.html Cycles:180 Average:5483.25 Median:6132.41 stddev:1541.51 (25.1%) stddev-sans-first:1499.80 05:48:10 INFO - PID 459 | Values: 501.5 504.4 519.5 520.3 522.6 6292.6 6323.5 6363.6 6364.7 6366.8 6029.5 6084.6 6099.4 6113.7 6215.7 4776.3 4946.4 5024.4 5127.7 5149.5 4904.9 4920.2 4953.0 5008.3 5024.4 4840.2 4879.3 4940.7 4975.2 4983.5 4877.8 4899.7 4914.6 4933.1 4984.1 4424.6 4454.2 4459.0 4481.8 4491.2 6110.9 6114.9 6149.9 6169.5 6190.7 5588.8 5594.3 5605.9 5667.7 5687.6 6429.9 6461.6 6493.0 6495.8 6501.3 4803.1 4809.4 4830.9 4839.8 4842.7 6517.3 6640.8 6691.3 6762.5 6798.2 4884.7 4927.2 4944.3 4983.3 4991.5 4954.7 4956.2 4997.7 5009.9 5037.2 5552.8 5580.5 5607.5 5614.6 5634.2 6489.8 6513.9 6542.0 6563.4 6571.7 1736.7 1742.5 1742.9 1744.8 1758.7 1133.8 1187.0 1194.5 1203.3 1213.8 5713.4 5747.5 5758.8 5824.0 5850.8 6680.3 6707.6 6710.0 6770.8 6816.4 5696.6 5755.8 5793.4 5803.4 5804.5 3547.4 3551.8 3552.3 3561.5 3563.9 6530.0 6592.7 6596.4 6605.1 6613.5 6789.3 6842.2 6860.8 6927.9 6947.5 6448.8 6471.4 6510.8 6517.9 6548.3 6166.8 6602.5 6640.3 6641.0 6652.8 6482.2 6505.3 6536.9 6606.7 6652.6 6351.1 6485.3 6506.3 6518.3 6518.6 4942.5 4945.4 4961.2 4964.7 4991.8 6484.3 6531.0 6543.6 6742.2 6802.8 6390.6 6448.3 6454.6 6480.6 6489.4 6430.6 6455.7 6473.7 6512.1 6519.7 6386.2 6438.0 6446.8 6487.5 6526.9 6580.0 6600.0 6626.9 6683.1 6691.2 6365.0 6403.8 6417.4 6422.6 6456.7 05:48:10 INFO - PID 459 | 05:48:10 INFO - PID 459 | [#5] yui.html Cycles:180 Average:23485.10 Median:21820.45 stddev:31948.68 (146.4%) stddev-sans-first:31993.17 05:48:10 INFO - PID 459 | Values: 869.1 874.8 888.6 891.7 897.6 16834.6 17238.6 18061.5 18426.4 18475.5 17584.8 18027.4 20827.0 21037.7 21076.9 936.4 943.3 945.1 946.2 946.5 878.9 905.6 940.0 940.8 963.9 983.8 985.1 985.8 988.6 999.5 977.2 980.6 981.1 981.4 995.9 717.9 718.7 722.4 726.4 734.4 18486.7 18771.6 19080.0 19154.3 19191.9 19594.4 20234.3 20423.1 20742.3 20840.8 16414.6 16473.3 16631.5 16631.7 16823.3 3783.1 3814.4 3817.2 3818.3 3819.1 122429.0 122486.0 123547.0 125330.0 126637.4 15537.8 15930.2 16115.6 16194.9 16213.8 22564.0 23152.2 28978.1 29581.9 29712.9 8958.8 9108.2 9130.1 9135.6 9157.6 4250.7 4294.3 4355.7 4408.6 4410.4 5104.4 5230.4 5232.1 5240.5 5249.9 1017.9 1052.2 1057.4 1063.9 1066.0 678.4 684.6 696.7 711.4 711.6 11247.0 11540.7 11850.8 12227.9 12495.5 687.6 691.7 693.8 699.9 707.3 5954.6 6024.7 6332.3 6339.6 6371.8 109352.5 109922.5 111005.0 111071.4 113747.0 92738.0 93307.5 95503.5 96701.5 101877.5 83375.6 83667.0 84900.6 86496.6 86657.1 12111.9 12158.8 12286.1 12303.6 12420.8 40237.8 40373.6 40856.8 41492.2 42160.0 71508.6 71687.0 71821.0 71832.0 74660.6 16310.7 16330.8 16699.9 16844.4 16893.3 18579.3 18690.3 18692.2 19678.5 20943.5 18931.1 19213.6 19258.6 19272.9 19295.1 18440.0 18642.9 18644.6 18693.8 19069.3 18665.2 18857.2 18860.8 18891.7 19117.5 12444.9 12455.8 12692.1 12884.6 12933.4 13528.3 13667.9 13739.0 13740.2 13813.4 05:48:10 INFO - PID 459 | -------- Summary: end -------- 05:48:10 INFO - PID 459 | 05:48:11 INFO - TEST-INFO | 459: exit 0 05:48:11 INFO - TEST-OK | dromaeo_css | took 1112002ms 05:48:11 INFO - TEST-START | kraken 05:48:11 INFO - Initialising browser for kraken test... 05:48:11 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:47822/getInfo.html -profile /tmp/tmpvl9_GF/profile 05:48:11 INFO - TEST-INFO | started process 892 (/builds/slave/test/build/application/firefox/firefox http://localhost:47822/getInfo.html) 05:48:17 INFO - TEST-INFO | 892: exit 0 05:48:17 INFO - Browser initialized. 05:48:17 INFO - Running cycle 1/1 for kraken test... 05:48:17 INFO - TEST-INFO | started process 1087 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvl9_GF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 05:48:18 INFO - PID 1087 | 05:48:18 INFO - PID 1087 | (/builds/slave/test/build/application/firefox/firefox:1137): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 05:48:18 INFO - PID 1087 | 05:48:18 INFO - PID 1087 | 05:48:18 INFO - PID 1087 | (/builds/slave/test/build/application/firefox/firefox:1265): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 05:48:18 INFO - PID 1087 | 05:48:19 INFO - PID 1087 | __metrics Screen width/height:1600/1200 05:48:19 INFO - PID 1087 | colorDepth:24 05:48:19 INFO - PID 1087 | Browser inner width/height: 1024/768 05:48:19 INFO - PID 1087 | __metrics 05:48:28 INFO - PID 1087 | RSS: Main: 174751744 05:48:28 INFO - PID 1087 | 05:48:31 INFO - PID 1087 | Cycle 1(1): loaded http://localhost:47822/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47822/tests/kraken/driver.html?testName=audio-beat-detection) 05:48:32 INFO - PID 1087 | RSS: Main: 180441088 05:48:32 INFO - PID 1087 | 05:48:34 INFO - PID 1087 | Cycle 1(1): loaded http://localhost:47822/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47822/tests/kraken/driver.html?testName=audio-dft) 05:48:35 INFO - PID 1087 | RSS: Main: 180219904 05:48:35 INFO - PID 1087 | 05:48:38 INFO - PID 1087 | Cycle 1(1): loaded http://localhost:47822/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47822/tests/kraken/driver.html?testName=audio-fft) 05:48:39 INFO - PID 1087 | RSS: Main: 173645824 05:48:39 INFO - PID 1087 | 05:48:41 INFO - PID 1087 | Cycle 1(1): loaded http://localhost:47822/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47822/tests/kraken/driver.html?testName=audio-oscillator) 05:48:42 INFO - PID 1087 | RSS: Main: 174362624 05:48:42 INFO - PID 1087 | 05:48:44 INFO - PID 1087 | Cycle 1(1): loaded http://localhost:47822/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47822/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:48:44 INFO - PID 1087 | RSS: Main: 174833664 05:48:44 INFO - PID 1087 | 05:48:48 INFO - PID 1087 | Cycle 1(1): loaded http://localhost:47822/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47822/tests/kraken/driver.html?testName=imaging-darkroom) 05:48:48 INFO - PID 1087 | RSS: Main: 175894528 05:48:48 INFO - PID 1087 | 05:48:52 INFO - PID 1087 | Cycle 1(1): loaded http://localhost:47822/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47822/tests/kraken/driver.html?testName=imaging-desaturate) 05:48:52 INFO - PID 1087 | RSS: Main: 175591424 05:48:52 INFO - PID 1087 | 05:48:55 INFO - PID 1087 | Cycle 1(1): loaded http://localhost:47822/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47822/tests/kraken/driver.html?testName=json-parse-financial) 05:48:56 INFO - PID 1087 | RSS: Main: 176156672 05:48:56 INFO - PID 1087 | 05:48:58 INFO - PID 1087 | Cycle 1(1): loaded http://localhost:47822/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47822/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:48:58 INFO - PID 1087 | RSS: Main: 175984640 05:48:58 INFO - PID 1087 | 05:49:00 INFO - PID 1087 | Cycle 1(1): loaded http://localhost:47822/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47822/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:49:01 INFO - PID 1087 | RSS: Main: 176128000 05:49:01 INFO - PID 1087 | 05:49:03 INFO - PID 1087 | Cycle 1(1): loaded http://localhost:47822/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47822/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:49:04 INFO - PID 1087 | RSS: Main: 176091136 05:49:04 INFO - PID 1087 | 05:49:06 INFO - PID 1087 | Cycle 1(1): loaded http://localhost:47822/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47822/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:49:07 INFO - PID 1087 | RSS: Main: 176541696 05:49:07 INFO - PID 1087 | 05:49:10 INFO - PID 1087 | Cycle 1(1): loaded http://localhost:47822/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47822/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:49:11 INFO - PID 1087 | RSS: Main: 176652288 05:49:11 INFO - PID 1087 | 05:49:13 INFO - PID 1087 | Cycle 1(1): loaded http://localhost:47822/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47822/tests/kraken/driver.html?testName=ai-astar) 05:49:13 INFO - PID 1087 | RSS: Main: 178110464 05:49:13 INFO - PID 1087 | 05:49:13 INFO - PID 1087 | __start_tp_report 05:49:13 INFO - PID 1087 | _x_x_mozilla_page_load 05:49:13 INFO - PID 1087 | _x_x_mozilla_page_load_details 05:49:13 INFO - PID 1087 | |i|pagename|runs| 05:49:13 INFO - PID 1087 | |0;ai-astar;99;115;101;105;115;108;115;99;107;111 05:49:13 INFO - PID 1087 | |1;audio-beat-detection;144;119;143;164;122;148;149;119;174;117 05:49:13 INFO - PID 1087 | |2;audio-dft;162;161;163;162;163;162;167;166;167;163 05:49:13 INFO - PID 1087 | |3;audio-fft;73;74;78;175;76;81;73;77;153;76 05:49:13 INFO - PID 1087 | |4;audio-oscillator;79;85;129;79;83;80;133;81;78;121 05:49:13 INFO - PID 1087 | |5;imaging-gaussian-blur;114;113;114;114;114;114;116;120;115;120 05:49:13 INFO - PID 1087 | |6;imaging-darkroom;149;147;147;151;149;150;149;147;150;153 05:49:13 INFO - PID 1087 | |7;imaging-desaturate;95;94;94;94;94;94;98;94;94;94 05:49:13 INFO - PID 1087 | |8;json-parse-financial;53;54;54;53;56;57;57;62;53;55 05:49:13 INFO - PID 1087 | |9;json-stringify-tinderbox;56;55;54;55;56;55;55;64;59;55 05:49:13 INFO - PID 1087 | |10;stanford-crypto-aes;78;77;77;75;75;77;76;80;82;75 05:49:13 INFO - PID 1087 | |11;stanford-crypto-ccm;127;130;127;122;120;121;124;129;128;168 05:49:13 INFO - PID 1087 | |12;stanford-crypto-pbkdf2;175;181;170;173;178;179;173;185;173;176 05:49:13 INFO - PID 1087 | |13;stanford-crypto-sha256-iterative;65;66;64;66;78;66;64;68;64;64 05:49:13 INFO - PID 1087 | __end_tp_report 05:49:13 INFO - PID 1087 | __start_cc_report 05:49:13 INFO - PID 1087 | _x_x_mozilla_cycle_collect,946 05:49:13 INFO - PID 1087 | __end_cc_report 05:49:13 INFO - PID 1087 | __startTimestamp1503578953315__endTimestamp 05:49:13 INFO - PID 1087 | 05:49:13 INFO - PID 1087 | ------- Summary: start ------- 05:49:13 INFO - PID 1087 | Number of tests: 14 05:49:13 INFO - PID 1087 | 05:49:13 INFO - PID 1087 | [#0] ai-astar Cycles:10 Average:107.50 Median:115.00 stddev:6.45 (5.6%) stddev-sans-first:6.06 05:49:13 INFO - PID 1087 | Values: 99.0 115.0 101.0 105.0 115.0 108.0 115.0 99.0 107.0 111.0 05:49:13 INFO - PID 1087 | 05:49:13 INFO - PID 1087 | [#1] audio-beat-detection Cycles:10 Average:139.90 Median:146.00 stddev:20.10 (13.8%) stddev-sans-first:21.27 05:49:13 INFO - PID 1087 | Values: 144.0 119.0 143.0 164.0 122.0 148.0 149.0 119.0 174.0 117.0 05:49:13 INFO - PID 1087 | 05:49:13 INFO - PID 1087 | [#2] audio-dft Cycles:10 Average:163.60 Median:163.00 stddev:2.22 (1.4%) stddev-sans-first:2.28 05:49:13 INFO - PID 1087 | Values: 162.0 161.0 163.0 162.0 163.0 162.0 167.0 166.0 167.0 163.0 05:49:13 INFO - PID 1087 | 05:49:13 INFO - PID 1087 | [#3] audio-fft Cycles:10 Average:93.60 Median:76.00 stddev:37.54 (49.4%) stddev-sans-first:39.07 05:49:13 INFO - PID 1087 | Values: 73.0 74.0 78.0 175.0 76.0 81.0 73.0 77.0 153.0 76.0 05:49:13 INFO - PID 1087 | 05:49:13 INFO - PID 1087 | [#4] audio-oscillator Cycles:10 Average:94.80 Median:79.50 stddev:22.95 (28.9%) stddev-sans-first:23.62 05:49:13 INFO - PID 1087 | Values: 79.0 85.0 129.0 79.0 83.0 80.0 133.0 81.0 78.0 121.0 05:49:13 INFO - PID 1087 | 05:49:13 INFO - PID 1087 | [#5] imaging-gaussian-blur Cycles:10 Average:115.40 Median:114.50 stddev:2.55 (2.2%) stddev-sans-first:2.65 05:49:13 INFO - PID 1087 | Values: 114.0 113.0 114.0 114.0 114.0 114.0 116.0 120.0 115.0 120.0 05:49:13 INFO - PID 1087 | 05:49:13 INFO - PID 1087 | [#6] imaging-darkroom Cycles:10 Average:149.20 Median:149.50 stddev:1.93 (1.3%) stddev-sans-first:2.05 05:49:13 INFO - PID 1087 | Values: 149.0 147.0 147.0 151.0 149.0 150.0 149.0 147.0 150.0 153.0 05:49:13 INFO - PID 1087 | 05:49:13 INFO - PID 1087 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:94.00 stddev:1.27 (1.4%) stddev-sans-first:1.33 05:49:13 INFO - PID 1087 | Values: 95.0 94.0 94.0 94.0 94.0 94.0 98.0 94.0 94.0 94.0 05:49:13 INFO - PID 1087 | 05:49:13 INFO - PID 1087 | [#8] json-parse-financial Cycles:10 Average:55.40 Median:55.50 stddev:2.80 (5.0%) stddev-sans-first:2.83 05:49:13 INFO - PID 1087 | Values: 53.0 54.0 54.0 53.0 56.0 57.0 57.0 62.0 53.0 55.0 05:49:13 INFO - PID 1087 | 05:49:13 INFO - PID 1087 | [#9] json-stringify-tinderbox Cycles:10 Average:56.40 Median:55.50 stddev:2.99 (5.4%) stddev-sans-first:3.17 05:49:13 INFO - PID 1087 | Values: 56.0 55.0 54.0 55.0 56.0 55.0 55.0 64.0 59.0 55.0 05:49:13 INFO - PID 1087 | 05:49:13 INFO - PID 1087 | [#10] stanford-crypto-aes Cycles:10 Average:77.20 Median:77.00 stddev:2.30 (3.0%) stddev-sans-first:2.42 05:49:13 INFO - PID 1087 | Values: 78.0 77.0 77.0 75.0 75.0 77.0 76.0 80.0 82.0 75.0 05:49:13 INFO - PID 1087 | 05:49:13 INFO - PID 1087 | [#11] stanford-crypto-ccm Cycles:10 Average:129.60 Median:127.50 stddev:13.93 (10.9%) stddev-sans-first:14.74 05:49:13 INFO - PID 1087 | Values: 127.0 130.0 127.0 122.0 120.0 121.0 124.0 129.0 128.0 168.0 05:49:13 INFO - PID 1087 | 05:49:13 INFO - PID 1087 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.30 Median:177.00 stddev:4.50 (2.5%) stddev-sans-first:4.75 05:49:13 INFO - PID 1087 | Values: 175.0 181.0 170.0 173.0 178.0 179.0 173.0 185.0 173.0 176.0 05:49:13 INFO - PID 1087 | 05:49:13 INFO - PID 1087 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.50 Median:66.00 stddev:4.25 (6.4%) stddev-sans-first:4.47 05:49:13 INFO - PID 1087 | Values: 65.0 66.0 64.0 66.0 78.0 66.0 64.0 68.0 64.0 64.0 05:49:13 INFO - PID 1087 | -------- Summary: end -------- 05:49:13 INFO - PID 1087 | 05:49:13 INFO - PID 1087 | 05:49:13 INFO - PID 1087 | ###!!! [Parent][MessageChannel] Error: (msgtype=0x150081,name=PBrowser::Msg_Destroy) Closed channel: cannot send/recv 05:49:13 INFO - PID 1087 | 05:49:13 INFO - PID 1087 | 05:49:13 INFO - PID 1087 | ###!!! [Child][MessageChannel] Error: (msgtype=0x150001,name=PBrowser::Msg_AsyncMessage) Closed channel: cannot send/recv 05:49:13 INFO - PID 1087 | 05:49:13 INFO - PID 1087 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 05:49:14 INFO - TEST-INFO | 1087: exit 0 05:49:14 INFO - TEST-OK | kraken | took 62735ms 05:49:14 INFO - SUITE-END | took 1174s 05:49:14 INFO - Completed test suite (00:19:35) 05:49:14 INFO - javascript benchmark 05:49:14 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8387.993977861832, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3241.124896278005, 3254.528093426454, 3276.2464633134396, 3288.687574680405, 3331.1172539277095, 6070.635761854292, 6149.846253843651, 6210.596311239767, 6222.160008398865, 6245.656488893114, 6149.877002459959, 6216.098665693483, 6217.036359364294, 6219.657918814463, 6244.219472565929, 5636.0, 5646.943530564703, 5673.375928647845, 5681.460261275172, 5772.797952071678, 5741.770329186827, 5744.626599271055, 5778.248827652399, 5797.101449275369, 5852.795152169675, 5571.777128914839, 5654.0, 5700.258966334371, 5744.138379243105, 5823.534117270629, 5713.74288157034, 5725.971370143165, 5738.110592858072, 5751.539876809887, 5755.597108202427, 5597.916031259534, 5678.517326027292, 5685.715714214314, 5694.544436445074, 5698.43015698431, 5854.2389489366105, 6133.969330153321, 6143.047827586731, 6195.721192546302, 6244.500439964792, 6440.935590644081, 6508.153939987818, 6656.733730650768, 6657.700403481855, 6663.600183988928, 6701.597904125768, 6777.1189745332795, 6788.7623933162595, 6797.728090876359, 6798.592084474898, 5974.970125149346, 6143.539234557336, 6192.411720886508, 6196.81409557714, 6306.747730090837, 6667.099941507931, 6668.633225172662, 6685.933140668629, 6686.3313668632745, 6692.364225398579, 6295.622262664255, 6370.0763389308295, 6370.140031095742, 6372.267189273293, 6373.490120790326, 6452.580582262138, 6485.4487368573255, 6545.410913017851, 6595.1096601958125, 6614.669266536654, 6604.900926486107, 6610.471162307004, 6688.398044176048, 6691.130153080068, 6702.061711360413, 6363.522735794834, 6621.933780662228, 6624.403803657694, 6713.597184168965, 6722.1261236039, 5206.0368831766245, 5240.6069544784295, 5260.342457192851, 5265.0259701955265, 5265.947340526545, 4624.560666736655, 4665.95334046662, 4674.906501869944, 4677.134730074879, 4678.157931572282, 5728.656280623176, 5744.597878148573, 5810.360860305363, 5818.970905145447, 5845.357010728816, 6399.456046236122, 6529.8694026120165, 6648.335166483313, 6664.8000559983275, 6728.125343705287, 5664.122061080539, 5684.403137670568, 5707.143928410772, 5710.086386178192, 5768.682722450221, 5724.0, 5745.166950792195, 5750.769969201268, 5750.971245143831, 5778.797742079091, 6484.967575162094, 6486.091947127406, 6520.641364724986, 6532.150820393414, 6593.406593406617, 6503.317151699192, 6590.604563726191, 6619.669016549057, 6759.0, 6759.019942108465, 6477.4170324671, 6533.020046992799, 6536.019597060479, 6541.149650545399, 6546.8363290918105, 6557.245916719447, 6567.080608714879, 6588.967055164693, 6632.971889357157, 6640.900386494303, 6671.966640166768, 6701.229358623626, 6770.526063175727, 6776.898346524707, 6792.864142717217, 6464.0, 6468.8059358219325, 6532.118164047793, 6548.279689234276, 6564.0, 6198.504119670506, 6244.718987645658, 6265.279492858197, 6282.340354262737, 6540.215174179129, 6273.654948977667, 6288.245410550763, 6337.04944258365, 6364.87270254583, 6380.042993551005, 6505.349465053457, 6551.967240163769, 6561.179852518435, 6566.9014964776525, 6618.63597502142, 6160.938390616216, 6249.468795152281, 6271.529635277281, 6300.9684951574945, 6345.714442850175], "value": 6056.175068250566, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [818.7257268814947, 835.1648351648352, 873.4191762477955, 873.9344549158815, 1101.372217835834, 29307.267318317052, 29918.70081299189, 29945.1016469506, 40842.183156336854, 40945.59054409455, 40102.7994860026, 40662.39006414899, 40677.0, 40741.796291018574, 40767.38848917261, 7521.135069466999, 7666.501677390979, 7669.271419215165, 7671.0, 7679.078510578738, 7700.306972372486, 7748.612569371537, 7749.922500775005, 7775.339096176832, 7786.299233069023, 7765.611719414035, 7771.8057048573955, 7781.338586220149, 7808.60956952153, 7811.0, 7689.154193038761, 7719.305262526372, 7741.496802707806, 7749.380049596019, 7783.610819459061, 7678.117016543058, 7695.422843286776, 7718.575478348688, 7737.767866964, 7746.147923728386, 36045.63954360449, 36155.63844361549, 36184.63815361839, 36185.81907090474, 36288.0, 3562.1272788166807, 3564.198055437532, 3578.35589593873, 3582.7671201371827, 3584.946225806615, 31161.688383116107, 31219.219519511968, 31276.218094547592, 31303.53044704331, 31394.529082063786, 5179.119549676564, 5187.662801917901, 5217.3217481727515, 5222.8694282642855, 5225.059489291964, 170701.14649426797, 171466.0, 171638.0, 171676.14161929235, 171887.0, 45591.31613025807, 45614.31578526325, 45825.0, 45832.7708361456, 45890.08219835585, 47828.0, 47962.520374796506, 47975.0, 48076.75961620169, 48177.5182248173, 15655.138967356905, 15820.92089539545, 15852.60368490797, 15869.841301587066, 15906.443274485337, 13151.67120821968, 13152.868471315356, 13169.341532923316, 13170.07809453329, 13210.471581136839, 12703.42834572428, 12929.353532323346, 12960.80558791619, 12990.155639883378, 13064.477420903057, 5004.0, 5055.34280543527, 5099.260607212008, 5112.71880046601, 5115.820946266863, 1005.2661557063385, 1009.1271050541229, 1010.6260683547134, 1017.2777328096986, 1017.760826205841, 21956.780432195792, 22170.778292217194, 22406.43983900383, 22486.988085535864, 22722.659160112613, 1104.6354702948008, 1109.1293334732197, 1113.8273567597034, 1114.916381271408, 1117.944102794857, 11837.348945808064, 11866.0, 11882.465289062013, 11887.049036077093, 11903.523859045714, 208838.0, 209671.0, 209862.0, 220463.0, 220514.0, 53225.7338713304, 53348.46651533512, 53365.0, 53453.732731336095, 53571.0, 1411.4072089722342, 1431.0412023943982, 1441.6612096157394, 1446.2985452055746, 1448.9637759056109, 26096.608550871373, 26163.738362616892, 26197.345066373495, 26326.736732632427, 26923.86538067297, 36791.0, 36819.81590092139, 36830.0, 36894.8155259222, 36990.63009369872, 183758.0, 183938.0, 184542.0, 184550.0, 185118.0, 32624.510632341007, 32681.18297042593, 32734.836325818218, 32805.17987050247, 32989.67010329962, 40817.79591102026, 41078.0, 44217.0, 45282.09435811331, 45464.54535454736, 32020.19949501188, 32201.51697724583, 32568.51147232841, 32816.50775238326, 32892.0, 32124.19689507781, 32374.676253237165, 32414.0, 32620.0, 33391.49912751262, 36817.447738284485, 37095.072623184635, 37193.0, 37307.440388393654, 37324.25351493009, 31545.684543155192, 31794.52308215425, 32200.516992245604, 32371.028869133963, 32685.673143268265, 23163.65254521217, 23256.65115023242, 23499.297580777744, 23643.527129456972, 23677.526449471257], "value": 16831.958660719458, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [533.919912013198, 539.9325084364455, 548.7953941099289, 549.5850632772258, 572.1732097119663, 21752.238671646497, 22028.33914982551, 22711.205107821228, 22737.090516379347, 22756.544869102607, 24562.754372456315, 24944.625830612556, 25220.62169067461, 25276.873615631943, 25282.0, 6572.1784776903005, 6745.662716864162, 6761.323867613224, 6766.526343155981, 6775.32246775321, 6058.242719660043, 6637.93362066378, 6638.734450621993, 6639.568428052161, 6643.402093811556, 6611.338866113399, 6611.636360000198, 6612.471002319827, 6612.834679133036, 6618.3050779668165, 6589.835254118638, 6601.240857301424, 6612.43794277487, 6620.470362371023, 6626.2048554173325, 6071.423214794588, 6092.939070609282, 6138.07928810682, 6148.815535533941, 6158.753649854, 28251.57622635662, 28387.716122838712, 28531.714682853115, 28717.856410717814, 28768.568471472943, 2038.1032345767815, 2055.640262953977, 2063.515073957619, 2066.6486697261503, 2069.9172033118657, 18870.622587548172, 19481.902590487098, 19512.609747805105, 19513.414597562096, 19515.219391224477, 2382.4520360317224, 2420.8789560521905, 2475.331660451668, 2541.2122242105006, 2548.120898290087, 132517.0, 134307.32846335805, 134360.0, 134730.32634836764, 135124.32437837747, 13394.861436777788, 14120.929395353163, 14500.347484363228, 14508.0, 14789.0, 22775.886120569623, 22805.88597057004, 22818.543629127325, 22856.428589285068, 22910.541789164457, 9972.80054398908, 10079.899201008042, 10155.746106347253, 10277.331973421704, 10368.0, 7716.691332346755, 8076.475029123206, 9349.626014959462, 9667.033296670277, 9846.113849753556, 8156.877646835303, 8710.433821801562, 8863.379563430499, 8876.51179185151, 9047.276217902552, 2642.8546429946537, 2670.145553422925, 2678.55803792376, 2688.2848323193325, 2722.9319267018086, 954.909283618069, 967.2455484721928, 971.8930917599058, 977.2035790830593, 981.1316984468797, 18618.0, 18788.248470061317, 18829.811701882805, 18955.71566426477, 19498.70751938722, 1008.5007921078966, 1030.685640879524, 1032.0866033560353, 1042.9478526073665, 1043.4678314059884, 10632.30889992148, 10708.250422470508, 10846.18653600983, 10862.565497380016, 11002.779944401067, 424975.5318086475, 439822.0, 440675.0, 441645.0, 441787.0, 104413.0, 107841.0, 113180.0, 115430.0, 115704.0, 1140.7091191746051, 1150.913681473893, 1156.2311063142915, 1169.3743847041962, 1173.3781096019125, 16477.093759842843, 16803.41188058412, 17038.31846726117, 17171.0, 17295.913520432317, 51409.74295128501, 51599.48400516097, 51996.70008249824, 52780.47219527909, 54289.18566221589, 63827.68086159539, 63962.360376397504, 64263.357366425735, 64273.67863160654, 64681.67659161862, 11812.0, 13489.190648561118, 13965.650858728613, 14063.156210627396, 14149.43402263939, 21864.906754662523, 22165.22421715232, 22239.0, 22239.0, 22251.888740556195, 17895.926244425376, 17953.192106354985, 18126.81873181304, 18181.272749089887, 18198.45404637863, 15747.685046299239, 16028.43900463525, 16256.674866502368, 16427.91786041062, 16577.25402356921, 18111.72832407541, 18336.72494912604, 18666.71999919975, 19993.600127997066, 20020.199192032156, 14256.71486570242, 14386.136831790127, 14397.280135992949, 14477.782833257721, 14534.200618966059, 17949.282028718706, 18206.544836379195, 18633.0, 18737.1568279425, 18759.812401876352], "value": 11692.100290300368, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1265.335698758152, 1325.1452812935656, 1337.1709540085149, 1339.2098661789546, 1343.3753304713307, 14040.227787471686, 14434.0, 14966.625834354147, 15004.099754014767, 15021.699566008701, 14645.340959656814, 14859.257037148154, 14861.628459288524, 14886.478973235911, 14888.404463821462, 2657.2559683288664, 2709.5122877882072, 2712.050782226225, 2712.3761534847, 2723.2919440945298, 2568.0883286433327, 2669.4394177222807, 2719.714429984853, 2720.088770261965, 2721.4421043686098, 2618.3192369983844, 2642.2469596165097, 2654.561997270448, 2685.5568831142837, 2686.758191762741, 2579.045753071357, 2579.6775403074616, 2585.28904551249, 2586.1465716313573, 2599.051346258621, 2564.1410127607273, 2569.293444302813, 2590.4430547432203, 2593.4164812916943, 2593.520198763216, 13899.444022239099, 14151.575452736435, 14158.150510969375, 14164.716705665933, 14177.14937103777, 7273.854522909565, 7550.169481357047, 7586.58273794941, 7598.240175982412, 7611.314981651678, 5125.154349532323, 5195.9740201298755, 5259.447757985395, 5313.335833020872, 5347.41178470368, 1845.4740398986226, 1855.6381505606412, 1859.414284500378, 1886.2455017992913, 1893.3278686066524, 24165.0, 24379.512409751882, 24385.512289754282, 24400.877995610084, 24412.755872441227, 6210.72051757672, 6377.23473183221, 6423.197100362455, 6510.44661203803, 6536.411722944958, 16266.837331626532, 16322.0, 16332.510024699279, 16368.345266189457, 16437.26032328548, 7362.300581444754, 7473.925260747323, 7520.586367749717, 7521.135069467081, 7525.924740752632, 5754.4533269339345, 6004.8799024020145, 6226.782062627877, 6227.844303892349, 6911.516193866381, 4848.830290939871, 5006.123928312531, 5127.179651255781, 5194.27280180775, 5212.50481204285, 1461.3935216884875, 1477.7783332499996, 1480.592836969842, 1481.4370539195252, 1492.6268432891777, 880.5993273060742, 901.9942763818295, 902.3773596218588, 916.6104405627582, 919.5861862162054, 7622.618869056525, 7656.693732250759, 7700.845983080307, 7703.34521565662, 7793.493422927491, 672.0826072411123, 690.1649004704364, 704.5737328916034, 713.5682911838367, 727.3453891497694, 5248.606354523426, 5566.304211973504, 5648.661080335193, 5660.066089095253, 5675.31896172462, 19132.521686957938, 19980.700289495377, 20300.492487687927, 20400.897995509928, 20436.182552697726, 19822.90088549548, 20378.0, 20589.07349169291, 20789.272375467088, 20881.791182088287, 10917.126629869592, 11088.611898583511, 11158.330500170016, 11161.944190278997, 11173.664790056311, 8280.213379728915, 8311.127331630334, 8314.708985185489, 8346.374021948257, 8484.830303394021, 17225.741613876053, 17299.30802767875, 17398.565035874206, 17672.646547069246, 17798.91100544489, 17867.195976180843, 17935.910320448314, 18042.819571804113, 18058.367957121438, 18100.909495452437, 11420.0, 11910.642680719593, 11926.105542084204, 12000.339981300764, 12007.75984480323, 13133.34333283351, 13400.664983375493, 13485.258310793, 13485.86514134846, 13533.593992180251, 11304.0, 11489.310641361544, 11664.0, 11770.0, 11943.0, 10874.749403818661, 11188.720281993015, 11309.434528273388, 11330.546778129112, 11425.885741142481, 10037.19702423819, 10118.443485608363, 10136.594536218468, 10190.898091019291, 10273.280870339304, 7243.855122897618, 7262.49162558637, 7297.598632075287, 7322.121345438369, 7392.96303518479, 7752.108507521707, 7842.333401660922, 7878.369730421437, 7903.881441778493, 7983.2415920487465], "value": 6445.467981970274, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [501.4834720238156, 504.41991709534034, 519.5376115257421, 520.341767663905, 522.5897670328793, 6292.622442653438, 6323.470611755294, 6363.618182909028, 6364.713587888545, 6366.777162799303, 6029.517638588903, 6084.554323880136, 6099.359567245442, 6113.69431528423, 6215.689215539228, 4776.331313616097, 4946.431160416562, 5024.422191447976, 5127.666701664399, 5149.510796474338, 4904.926426103593, 4920.188168952119, 4952.975235123819, 5008.348914641091, 5024.362209839826, 4840.225563909775, 4879.292502587123, 4940.728259945701, 4975.2039673652225, 4983.52656497634, 4877.756112194376, 4899.657024008321, 4914.557689807916, 4933.136701077315, 4984.127777638899, 4424.646028317727, 4454.198244316021, 4459.0, 4481.798319075617, 4491.214037543416, 6110.938890611082, 6114.877702445926, 6149.938500614981, 6169.5064394848305, 6190.721417536221, 5588.776448942038, 5594.272744543224, 5605.943940560583, 5667.659940403589, 5687.601867869251, 6429.903551446732, 6461.57999730016, 6493.0, 6495.772647957298, 6501.349865013508, 4803.111424386465, 4809.398825146856, 4830.9275360869615, 4839.814245509838, 4842.733649649268, 6517.250516190698, 6640.7675731349655, 6691.297413771533, 6762.46407597151, 6798.2182049064495, 4884.65807393479, 4927.236278376858, 4944.258361245842, 4983.277424773388, 4991.5258050485145, 4954.677945933575, 4956.199747142853, 4997.675151115239, 5009.872778624853, 5037.168867136955, 5552.7778888843995, 5580.525655319343, 5607.495325420732, 5614.578906582023, 5634.23937768396, 6489.766944280666, 6513.8504293583, 6541.967290163614, 6563.3764792344655, 6571.737130514822, 1736.7308067249596, 1742.4772568229735, 1742.9389971350943, 1744.816794236587, 1758.7273972534279, 1133.7732453509332, 1186.9762604747857, 1194.498310709504, 1203.2900588652737, 1213.805791073424, 5713.371529131792, 5747.482726554546, 5758.798442054508, 5824.0, 5850.765969361178, 6680.298568650319, 6707.564008339442, 6710.027046078291, 6770.796876093725, 6816.352446517573, 5696.572757043238, 5755.755255450377, 5793.362730099686, 5803.419658034163, 5804.506616937608, 3547.396942519778, 3551.7691350062164, 3552.289542091592, 3561.465780132949, 3563.94654080189, 6529.971921620326, 6592.670366481752, 6596.373344532261, 6605.07528945948, 6613.503987200979, 6789.321067893171, 6842.178938527309, 6860.759873404407, 6927.93072069283, 6947.51367404287, 6448.806535803933, 6471.417572418505, 6510.837229069217, 6517.8696426072165, 6548.345165483509, 6166.753329866934, 6602.471802255712, 6640.335966403321, 6641.0, 6652.800415987528, 6482.222133344029, 6505.316941721051, 6536.901946470902, 6606.735730570916, 6652.567583107082, 6351.142595749515, 6485.254195767548, 6506.25178104524, 6518.315576864361, 6518.57629254097, 4942.481039490802, 4945.406551213733, 4961.181405068268, 4964.67729597575, 4991.775370108427, 6484.254310754323, 6530.967345163243, 6543.574667646588, 6742.190937087581, 6802.795916122524, 6390.584612000205, 6448.258450278278, 6454.580452270588, 6480.57876238043, 6489.3510648934725, 6430.64631445275, 6455.709493072729, 6473.741050357933, 6512.120863683342, 6519.674016299261, 6386.201724784402, 6438.0, 6446.8388290293115, 6487.513436492376, 6526.9347306528225, 6579.967100164468, 6600.0, 6626.87343151675, 6683.131192944886, 6691.1636045494315, 6365.0, 6403.847307484698, 6417.358264173732, 6422.6467544285515, 6456.709448074754], "value": 5028.261099816183, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [869.148234729965, 874.7856775090104, 888.5868071346822, 891.6567121658163, 897.5960817632065, 16834.579135521602, 17238.569035774097, 18061.4581562553, 18426.355077572287, 18475.53811154722, 17584.82415175848, 18027.36904208353, 20827.0, 21037.68443473349, 21076.8946155269, 936.4381371177291, 943.3113826906363, 945.1399226703701, 946.1579194516886, 946.4557879219442, 878.9296856251484, 905.6377449020379, 940.031767279703, 940.8165407745493, 963.8602402651611, 983.7934033852899, 985.1084768284713, 985.8126955878361, 988.5600907596123, 999.5002498750624, 977.2035790830521, 980.5538479991586, 981.0630847540582, 981.4356744871656, 995.9153471954857, 717.8851383778623, 718.7125149940014, 722.404016686236, 726.4333819620651, 734.3904559215891, 18486.722699159523, 18771.624567508574, 19080.0, 19154.329598463988, 19191.904040479847, 19594.412167634993, 20234.291799786937, 20423.080961356776, 20742.274020409364, 20840.791592084188, 16414.589635259214, 16473.34106635733, 16631.501054968372, 16631.66736665272, 16823.327066917307, 3783.129880127586, 3814.370628846237, 3817.2174704185577, 3818.3127037133304, 3819.083419979185, 122429.0, 122486.0, 123547.0, 125329.98680052787, 126637.36681316627, 15537.844621553866, 15930.203489825462, 16115.597110072342, 16194.919025405034, 16213.837861621469, 22564.0, 23152.18967336135, 28978.13065608035, 29581.85209073941, 29712.851435743116, 8958.776030599287, 9108.225800806873, 9130.132637399436, 9135.634574617074, 9157.633694652273, 4250.7334011854455, 4294.291441912112, 4355.738655680606, 4408.603225709701, 4410.360497727812, 5104.387473503203, 5230.3985041719925, 5232.058229518647, 5240.528352448298, 5249.947500524946, 1017.9134773544332, 1052.2476429353048, 1057.4191583582594, 1063.8723353197665, 1065.9786804263872, 678.3657280442802, 684.6337209592843, 696.7073828991836, 711.4273010226817, 711.6406214861565, 11247.0, 11540.653780386601, 11850.81491850808, 12227.877721222852, 12495.50017999288, 687.5805758487419, 691.7060249393987, 693.8196069022091, 699.919509256442, 707.2538471912183, 5954.612950158225, 6024.668643224665, 6332.303446620868, 6339.587926784744, 6371.808845734636, 109352.45323773331, 109922.45038774755, 111005.0, 111071.44464277789, 113747.0, 92738.0, 93307.53346233361, 95503.52248238714, 96701.5164924185, 101877.49061254646, 83375.58312208521, 83667.0, 84900.57549712212, 86496.56751716201, 86657.13342866617, 12111.939440302742, 12158.756824863276, 12286.078544109407, 12303.630891073282, 12420.75158496807, 40237.798811005756, 40373.59626403698, 40856.79571602123, 41492.170156597305, 42160.0, 71508.64245678738, 71687.0, 71821.0, 71832.0, 74660.62669686617, 16310.673786524441, 16330.755038674191, 16699.91650041742, 16844.410445634345, 16893.32426702967, 18579.25682972666, 18690.34583789561, 18692.158852851382, 19678.50803729861, 20943.476413089793, 18931.148098335885, 19213.615727685647, 19258.614827703088, 19272.903635481733, 19295.131719072957, 18440.0, 18642.906785465984, 18644.627107458047, 18693.81306186921, 19069.33257336042, 18665.16006779671, 18857.24571017144, 18860.811391885905, 18891.716624250923, 19117.522061948563, 12444.875551244733, 12455.750884982432, 12692.111552191258, 12884.613461596167, 12933.353332333534, 13528.323583820966, 13667.86332136666, 13739.038267321192, 13740.244286564335, 13813.378397971914], "value": 9016.227465678056, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1519.8999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 115.0, 101.0, 105.0, 115.0, 108.0, 115.0, 99.0, 107.0, 111.0], "value": 107.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 119.0, 143.0, 164.0, 122.0, 148.0, 149.0, 119.0, 174.0, 117.0], "value": 139.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 163.0, 162.0, 163.0, 162.0, 167.0, 166.0, 167.0, 163.0], "value": 163.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 78.0, 175.0, 76.0, 81.0, 73.0, 77.0, 153.0, 76.0], "value": 93.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 85.0, 129.0, 79.0, 83.0, 80.0, 133.0, 81.0, 78.0, 121.0], "value": 94.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 114.0, 114.0, 114.0, 114.0, 116.0, 120.0, 115.0, 120.0], "value": 115.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 147.0, 147.0, 151.0, 149.0, 150.0, 149.0, 147.0, 150.0, 153.0], "value": 149.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 94.0, 94.0, 94.0, 94.0, 98.0, 94.0, 94.0, 94.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 54.0, 54.0, 53.0, 56.0, 57.0, 57.0, 62.0, 53.0, 55.0], "value": 55.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 54.0, 55.0, 56.0, 55.0, 55.0, 64.0, 59.0, 55.0], "value": 56.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 77.0, 77.0, 75.0, 75.0, 77.0, 76.0, 80.0, 82.0, 75.0], "value": 77.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 130.0, 127.0, 122.0, 120.0, 121.0, 124.0, 129.0, 128.0, 168.0], "value": 129.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 181.0, 170.0, 173.0, 178.0, 179.0, 173.0, 185.0, 173.0, 176.0], "value": 176.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 64.0, 66.0, 78.0, 66.0, 64.0, 68.0, 64.0, 64.0], "value": 66.5, "unit": "score"}]}]} 05:49:14 INFO - Return code: 0 05:49:14 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:49:14 INFO - # TBPL SUCCESS # 05:49:14 INFO - Running post-action listener: _package_coverage_data 05:49:14 INFO - Running post-action listener: _resource_record_post_action 05:49:14 INFO - [mozharness: 2017-08-24 12:49:14.613701Z] Finished run-tests step (success) 05:49:14 INFO - Running post-run listener: _resource_record_post_run 05:49:14 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 4096; Write bytes: 430886912; Read time: 12; Write time: 334332 05:49:14 INFO - TinderboxPrint: CPU usage
13.1% 05:49:14 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 05:49:14 INFO - TinderboxPrint: I/O write bytes / time
430,886,912 / 334,332 05:49:14 INFO - TinderboxPrint: CPU idle
8,262.3 (86.9%) 05:49:14 INFO - TinderboxPrint: CPU user
1,197.6 (12.6%) 05:49:14 INFO - TinderboxPrint: Swap in / out
0 / 0 05:49:14 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 109228032; Read time: 0; Write time: 89828 05:49:14 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 05:49:14 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 0; Write bytes: 321658880; Read time: 0; Write time: 244504 05:49:15 INFO - Running post-run listener: _upload_blobber_files 05:49:15 INFO - Blob upload gear active. 05:49:15 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:49:15 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 05:49:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:49:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:49:15 INFO - (blobuploader) - INFO - Open directory for files ... 05:49:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:49:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:49:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:49:16 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:49:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:49:16 INFO - (blobuploader) - INFO - Done attempting. 05:49:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:49:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:49:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:49:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:49:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:49:17 INFO - (blobuploader) - INFO - Done attempting. 05:49:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:49:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:49:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:49:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:49:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:49:18 INFO - (blobuploader) - INFO - Done attempting. 05:49:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:49:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:49:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:49:24 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:49:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:49:24 INFO - (blobuploader) - INFO - Done attempting. 05:49:24 INFO - (blobuploader) - INFO - Iteration through files over. 05:49:24 INFO - Return code: 0 05:49:24 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:49:24 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:49:24 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2b4b1ac6dd1c6620925c90bf4fc6c54f755c96a6a03065fbc949c415a7f99c03ea02c9ff2e8b01ac4cc7d3399058d5e4f42883dc5da1d6b03aeae42d1dda5d4b", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3519186a041f32125b406e99e153969c1177cbf796603ac69438e73a73d5d8e235276bc33d2e10055d0b0011d6b8970a166292b0eb9b43c8eee71e0495ce909a", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c3d14ec739b05d123b997d0c043970d25e190704b3333f648b74db92a7f471cd91e9d8d92be13ef78b2a07d8ec84443afd96ea35e8f6f26aa6c9313c73250e83", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1751bac0ada2193e88279db53cd20402949440c096a38f0d50e9dce6fc08796c2af17e1fef1e6453bbaf7bb924c61f05b5c13bb080975374be60edd5e436c5f4"} 05:49:24 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:49:24 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:49:24 INFO - Contents: 05:49:24 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2b4b1ac6dd1c6620925c90bf4fc6c54f755c96a6a03065fbc949c415a7f99c03ea02c9ff2e8b01ac4cc7d3399058d5e4f42883dc5da1d6b03aeae42d1dda5d4b", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3519186a041f32125b406e99e153969c1177cbf796603ac69438e73a73d5d8e235276bc33d2e10055d0b0011d6b8970a166292b0eb9b43c8eee71e0495ce909a", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c3d14ec739b05d123b997d0c043970d25e190704b3333f648b74db92a7f471cd91e9d8d92be13ef78b2a07d8ec84443afd96ea35e8f6f26aa6c9313c73250e83", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1751bac0ada2193e88279db53cd20402949440c096a38f0d50e9dce6fc08796c2af17e1fef1e6453bbaf7bb924c61f05b5c13bb080975374be60edd5e436c5f4"} 05:49:24 INFO - Running post-run listener: copy_logs_to_upload_dir 05:49:24 INFO - Copying logs to upload dir... 05:49:24 INFO - mkdir: /builds/slave/test/build/upload/logs 05:49:24 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1253.602935 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2017-08-24 05:49:24.627164) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-24 05:49:24.631629) ========= 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=920470bf432669ad7e3a5387000001ca-1503577708.995092-995620445 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2b4b1ac6dd1c6620925c90bf4fc6c54f755c96a6a03065fbc949c415a7f99c03ea02c9ff2e8b01ac4cc7d3399058d5e4f42883dc5da1d6b03aeae42d1dda5d4b", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3519186a041f32125b406e99e153969c1177cbf796603ac69438e73a73d5d8e235276bc33d2e10055d0b0011d6b8970a166292b0eb9b43c8eee71e0495ce909a", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c3d14ec739b05d123b997d0c043970d25e190704b3333f648b74db92a7f471cd91e9d8d92be13ef78b2a07d8ec84443afd96ea35e8f6f26aa6c9313c73250e83", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1751bac0ada2193e88279db53cd20402949440c096a38f0d50e9dce6fc08796c2af17e1fef1e6453bbaf7bb924c61f05b5c13bb080975374be60edd5e436c5f4"} build_url:https://queue.taskcluster.net/v1/task/edDsDxIfTzGMCiv9-pbWyw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011237 build_url: 'https://queue.taskcluster.net/v1/task/edDsDxIfTzGMCiv9-pbWyw/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2b4b1ac6dd1c6620925c90bf4fc6c54f755c96a6a03065fbc949c415a7f99c03ea02c9ff2e8b01ac4cc7d3399058d5e4f42883dc5da1d6b03aeae42d1dda5d4b", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3519186a041f32125b406e99e153969c1177cbf796603ac69438e73a73d5d8e235276bc33d2e10055d0b0011d6b8970a166292b0eb9b43c8eee71e0495ce909a", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c3d14ec739b05d123b997d0c043970d25e190704b3333f648b74db92a7f471cd91e9d8d92be13ef78b2a07d8ec84443afd96ea35e8f6f26aa6c9313c73250e83", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1751bac0ada2193e88279db53cd20402949440c096a38f0d50e9dce6fc08796c2af17e1fef1e6453bbaf7bb924c61f05b5c13bb080975374be60edd5e436c5f4"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-24 05:49:24.665870) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-24 05:49:24.666255) ========= 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=920470bf432669ad7e3a5387000001ca-1503577708.995092-995620445 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004533 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-24 05:49:24.746261) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-24 05:49:24.746580) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-24 05:49:24.746911) ========= ========= Total master_lag: 0.20 =========