builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-040 starttime: 1508270601.14 results: success (0) revision: 2e35a8e42ad6ea9a6074991bbc62fe9757a2e6f0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-10-17 13:03:21.137633) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-10-17 13:03:21.138211) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-10-17 13:03:21.138491) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-10-17 13:03:21.157791) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-17 13:03:21.158198) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1508270599.140807-792501720 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-10-17 13:03:21-- 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% 224M=0s 2017-10-17 13:03:21 (224 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.201707 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-17 13:03:21.380867) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-10-17 13:03:21.381191) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1508270599.140807-792501720 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015722 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-10-17 13:03:21.433891) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-10-17 13:03:21.434230) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 2e35a8e42ad6ea9a6074991bbc62fe9757a2e6f0 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 2e35a8e42ad6ea9a6074991bbc62fe9757a2e6f0 --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=9e0dfe3369c33a1556e63f89000001d8-1508270599.140807-792501720 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-10-17 13:03:21,671 truncating revision to first 12 chars 2017-10-17 13:03:21,671 Setting DEBUG logging. 2017-10-17 13:03:21,671 attempt 1/10 2017-10-17 13:03:21,672 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/2e35a8e42ad6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-10-17 13:03:22,302 unpacking tar archive at: mozilla-beta-2e35a8e42ad6/testing/mozharness/ program finished with exit code 0 elapsedTime=1.039428 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-10-17 13:03:22.490547) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-10-17 13:03:22.493926) ========= script_repo_revision: 2e35a8e42ad6ea9a6074991bbc62fe9757a2e6f0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-10-17 13:03:22.494315) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-10-17 13:03:22.494575) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-10-17 13:03:22.512106) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2017-10-17 13:03:22.512534) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9e0dfe3369c33a1556e63f89000001d8-1508270599.140807-792501720 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:03:22 INFO - MultiFileLogger online at 20171017 13:03:22 in /builds/slave/test 13:03:22 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta-Non-PGO 13:03:22 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:03:22 INFO - {'append_to_log': False, 13:03:22 INFO - 'base_work_dir': '/builds/slave/test', 13:03:22 INFO - 'blob_upload_branch': 'Mozilla-Beta-Non-PGO', 13:03:22 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:03:22 INFO - 'branch': 'Mozilla-Beta-Non-PGO', 13:03:22 INFO - 'buildbot_json_path': 'buildprops.json', 13:03:22 INFO - 'code_coverage': False, 13:03:22 INFO - 'config_files': ('talos/linux_config.py',), 13:03:22 INFO - 'default_actions': ('clobber', 13:03:22 INFO - 'read-buildbot-config', 13:03:22 INFO - 'download-and-extract', 13:03:22 INFO - 'populate-webroot', 13:03:22 INFO - 'create-virtualenv', 13:03:22 INFO - 'install', 13:03:22 INFO - 'setup-mitmproxy', 13:03:22 INFO - 'run-tests'), 13:03:22 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:03:22 INFO - 'disable_ccov_upload': False, 13:03:22 INFO - 'disable_stylo': False, 13:03:22 INFO - 'download_minidump_stackwalk': True, 13:03:22 INFO - 'download_symbols': 'ondemand', 13:03:22 INFO - 'enable_stylo': False, 13:03:22 INFO - 'enable_webrender': False, 13:03:22 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 13:03:22 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:03:22 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:03:22 INFO - 'gecko_profile': False, 13:03:22 INFO - 'gecko_profile_interval': 0, 13:03:22 INFO - 'installer_path': 'installer.exe', 13:03:22 INFO - 'log_level': 'info', 13:03:22 INFO - 'log_name': 'talos', 13:03:22 INFO - 'log_to_console': True, 13:03:22 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:03:22 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:03:22 INFO - 'opt_config_files': (), 13:03:22 INFO - 'pip_index': False, 13:03:22 INFO - 'suite': 'dromaeojs-e10s', 13:03:22 INFO - 'system_bits': '32', 13:03:22 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:03:22 INFO - 'title': 'talos-linux64-ix-040', 13:03:22 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:03:22 INFO - 'use_talos_json': True, 13:03:22 INFO - 'verify': 'False', 13:03:22 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:03:22 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:03:22 INFO - 'work_dir': 'build'} 13:03:22 INFO - [mozharness: 2017-10-17 20:03:22.898837Z] Running clobber step. 13:03:22 INFO - Running pre-action listener: _resource_record_pre_action 13:03:22 INFO - Running main action method: clobber 13:03:22 INFO - rmtree: /builds/slave/test/build 13:03:22 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:03:23 INFO - Running post-action listener: _resource_record_post_action 13:03:23 INFO - [mozharness: 2017-10-17 20:03:23.891684Z] Finished clobber step (success) 13:03:23 INFO - [mozharness: 2017-10-17 20:03:23.891784Z] Running read-buildbot-config step. 13:03:23 INFO - Running pre-action listener: _resource_record_pre_action 13:03:23 INFO - Running main action method: read_buildbot_config 13:03:23 INFO - Using buildbot properties: 13:03:23 INFO - { 13:03:23 INFO - "project": "", 13:03:23 INFO - "product": "firefox", 13:03:23 INFO - "who": "ffxbld@noreply.mozilla.org", 13:03:23 INFO - "installer_path": "public/build/target.tar.bz2", 13:03:23 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 13:03:23 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-beta", 13:03:23 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta talos dromaeojs-e10s", 13:03:23 INFO - "stage_platform": "linux64", 13:03:23 INFO - "basedir": "/builds/slave/test", 13:03:23 INFO - "buildnumber": 166, 13:03:23 INFO - "platform": "ubuntu64_hw", 13:03:23 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 13:03:23 INFO - "slavebuilddir": "test", 13:03:23 INFO - "taskId": "MnGfQ3gWSiidyufHtVEumA", 13:03:23 INFO - "branch": "mozilla-beta", 13:03:23 INFO - "script_repo_revision": "production", 13:03:23 INFO - "revision": "2e35a8e42ad6ea9a6074991bbc62fe9757a2e6f0", 13:03:23 INFO - "slavename": "talos-linux64-ix-040", 13:03:23 INFO - "repo_path": "releases/mozilla-beta" 13:03:23 INFO - } 13:03:23 INFO - Finding installer, test and symbols from parent task. 13:03:23 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MnGfQ3gWSiidyufHtVEumA'}, attempt #1 13:03:24 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MnGfQ3gWSiidyufHtVEumA'}, attempt #1 13:03:24 INFO - Task dependencies: TsKy8kW3TauOSSW5GzkoQw 13:03:24 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TsKy8kW3TauOSSW5GzkoQw'}, attempt #1 13:03:25 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/TsKy8kW3TauOSSW5GzkoQw/artifacts/public/build/target.tar.bz2 13:03:25 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/TsKy8kW3TauOSSW5GzkoQw/artifacts/public/build/target.test_packages.json 13:03:25 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/TsKy8kW3TauOSSW5GzkoQw/artifacts/public/build/target.crashreporter-symbols.zip 13:03:25 INFO - Running post-action listener: _resource_record_post_action 13:03:25 INFO - [mozharness: 2017-10-17 20:03:25.327630Z] Finished read-buildbot-config step (success) 13:03:25 INFO - [mozharness: 2017-10-17 20:03:25.327846Z] Running download-and-extract step. 13:03:25 INFO - Running pre-action listener: _resource_record_pre_action 13:03:25 INFO - Running main action method: download_and_extract 13:03:25 INFO - mkdir: /builds/slave/test/build/tests 13:03:25 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')]} 13:03:25 INFO - trying https://queue.taskcluster.net/v1/task/TsKy8kW3TauOSSW5GzkoQw/artifacts/public/build/target.test_packages.json 13:03:25 INFO - Downloading https://queue.taskcluster.net/v1/task/TsKy8kW3TauOSSW5GzkoQw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 13:03:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TsKy8kW3TauOSSW5GzkoQw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 13:03:25 INFO - Downloaded 989 bytes. 13:03:25 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 13:03:25 INFO - Using the following test package requirements: 13:03:25 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 13:03:25 INFO - u'common': [u'target.common.tests.zip'], 13:03:25 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 13:03:25 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 13:03:25 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 13:03:25 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 13:03:25 INFO - u'mozbase': [u'target.common.tests.zip'], 13:03:25 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 13:03:25 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 13:03:25 INFO - u'web-platform': [u'target.common.tests.zip', 13:03:25 INFO - u'target.web-platform.tests.tar.gz'], 13:03:25 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 13:03:25 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 13:03:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TsKy8kW3TauOSSW5GzkoQw/artifacts/public/build/target.common.tests.zip 13:03:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TsKy8kW3TauOSSW5GzkoQw/artifacts/public/build/target.common.tests.zip'}, attempt #1 13:03:25 INFO - Fetch https://queue.taskcluster.net/v1/task/TsKy8kW3TauOSSW5GzkoQw/artifacts/public/build/target.common.tests.zip into memory 13:03:29 INFO - Content-Length response header: 55175000 13:03:29 INFO - Bytes received: 55175000 13:03:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TsKy8kW3TauOSSW5GzkoQw/artifacts/public/build/target.talos.tests.zip 13:03:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TsKy8kW3TauOSSW5GzkoQw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 13:03:40 INFO - Fetch https://queue.taskcluster.net/v1/task/TsKy8kW3TauOSSW5GzkoQw/artifacts/public/build/target.talos.tests.zip into memory 13:03:41 INFO - Content-Length response header: 14509251 13:03:41 INFO - Bytes received: 14509251 13:03:41 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')]} 13:03:41 INFO - trying https://queue.taskcluster.net/v1/task/TsKy8kW3TauOSSW5GzkoQw/artifacts/public/build/target.tar.bz2 13:03:41 INFO - Downloading https://queue.taskcluster.net/v1/task/TsKy8kW3TauOSSW5GzkoQw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 13:03:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TsKy8kW3TauOSSW5GzkoQw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 13:03:45 INFO - Downloaded 53754177 bytes. 13:03:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TsKy8kW3TauOSSW5GzkoQw/artifacts/public/build/target.tar.bz2 13:03:45 INFO - mkdir: /builds/slave/test/properties 13:03:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:03:45 INFO - Writing to file /builds/slave/test/properties/build_url 13:03:45 INFO - Contents: 13:03:45 INFO - build_url:https://queue.taskcluster.net/v1/task/TsKy8kW3TauOSSW5GzkoQw/artifacts/public/build/target.tar.bz2 13:03:45 INFO - Running post-action listener: _resource_record_post_action 13:03:45 INFO - Running post-action listener: find_tests_for_verification 13:03:45 INFO - Running post-action listener: set_extra_try_arguments 13:03:45 INFO - [mozharness: 2017-10-17 20:03:45.540291Z] Finished download-and-extract step (success) 13:03:45 INFO - [mozharness: 2017-10-17 20:03:45.540518Z] Running populate-webroot step. 13:03:45 INFO - Running pre-action listener: _resource_record_pre_action 13:03:45 INFO - Running main action method: populate_webroot 13:03:45 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:03:45 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 13:03:45 INFO - 'tests': ['tresize', 13:03:45 INFO - 'tcanvasmark']}, 13:03:45 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:03:45 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 13:03:45 INFO - 'tests': ['dromaeo_css', 13:03:45 INFO - 'kraken']}, 13:03:45 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 13:03:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:03:45 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 13:03:45 INFO - 'talos_options': ['--disable-stylo'], 13:03:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:03:45 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 13:03:45 INFO - 'tests': ['damp', 'tps']}, 13:03:45 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 13:03:45 INFO - 'talos_options': ['--disable-stylo'], 13:03:45 INFO - 'tests': ['damp', 'tps']}, 13:03:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:03:45 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 13:03:45 INFO - 'tests': ['dromaeo_dom']}, 13:03:45 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 13:03:45 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 13:03:45 INFO - 'tests': ['basic_compositor_video', 13:03:45 INFO - 'glvideo']}, 13:03:45 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 13:03:45 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 13:03:45 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 13:03:45 INFO - 'talos_options': ['--disable-stylo'], 13:03:45 INFO - 'tests': ['ts_paint_webext', 13:03:45 INFO - 'tp5o_webext']}, 13:03:45 INFO - 'other-e10s': {'tests': ['a11yr', 13:03:45 INFO - 'ts_paint', 13:03:45 INFO - 'tpaint', 13:03:45 INFO - 'sessionrestore', 13:03:45 INFO - 'sessionrestore_many_windows', 13:03:45 INFO - 'sessionrestore_no_auto_restore', 13:03:45 INFO - 'tabpaint']}, 13:03:45 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 13:03:45 INFO - 'tests': ['a11yr', 13:03:45 INFO - 'ts_paint', 13:03:45 INFO - 'tpaint', 13:03:45 INFO - 'sessionrestore', 13:03:45 INFO - 'sessionrestore_many_windows', 13:03:45 INFO - 'sessionrestore_no_auto_restore', 13:03:45 INFO - 'tabpaint']}, 13:03:45 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 13:03:45 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 13:03:45 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 13:03:45 INFO - 'tests': ['perf_reftest_singletons']}, 13:03:45 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 13:03:45 INFO - 'tests': ['bloom_basic']}, 13:03:45 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:03:45 INFO - 'tsvgr_opacity', 13:03:45 INFO - 'tart', 13:03:45 INFO - 'tscrollx', 13:03:45 INFO - 'tsvg_static']}, 13:03:45 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 13:03:45 INFO - 'tests': ['tsvgx', 13:03:45 INFO - 'tsvgr_opacity', 13:03:45 INFO - 'tart', 13:03:45 INFO - 'tscrollx', 13:03:45 INFO - 'tsvg_static']}, 13:03:45 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 13:03:45 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 13:03:45 INFO - 'talos_options': ['--disable-stylo'], 13:03:45 INFO - 'tests': ['tp5o']}, 13:03:45 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 13:03:45 INFO - 'talos_options': ['--mitmproxy', 13:03:45 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 13:03:45 INFO - '--firstNonBlankPaint'], 13:03:45 INFO - 'tests': ['tp6_google', 13:03:45 INFO - 'tp6_youtube', 13:03:45 INFO - 'tp6_amazon', 13:03:45 INFO - 'tp6_facebook']}, 13:03:45 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 13:03:45 INFO - 'talos_options': ['--disable-stylo', 13:03:45 INFO - '--mitmproxy', 13:03:45 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 13:03:45 INFO - '--firstNonBlankPaint'], 13:03:45 INFO - 'tests': ['tp6_google', 13:03:45 INFO - 'tp6_youtube', 13:03:45 INFO - 'tp6_amazon', 13:03:45 INFO - 'tp6_facebook']}, 13:03:45 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 13:03:45 INFO - 'talos_options': ['--stylo-threads=1', 13:03:45 INFO - '--mitmproxy', 13:03:45 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 13:03:45 INFO - '--firstNonBlankPaint'], 13:03:45 INFO - 'tests': ['tp6_google', 13:03:45 INFO - 'tp6_youtube', 13:03:45 INFO - 'tp6_amazon', 13:03:45 INFO - 'tp6_facebook']}, 13:03:45 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 13:03:45 INFO - 'talos_options': ['--xperf_path', 13:03:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:03:45 INFO - 'tests': ['tp5n']}, 13:03:45 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 13:03:45 INFO - 'talos_options': ['--disable-stylo', 13:03:45 INFO - '--xperf_path', 13:03:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:03:45 INFO - 'tests': ['tp5n']}}} 13:03:45 INFO - Running post-action listener: _resource_record_post_action 13:03:45 INFO - [mozharness: 2017-10-17 20:03:45.555687Z] Finished populate-webroot step (success) 13:03:45 INFO - [mozharness: 2017-10-17 20:03:45.555776Z] Running create-virtualenv step. 13:03:45 INFO - Running pre-action listener: _resource_record_pre_action 13:03:45 INFO - Running main action method: create_virtualenv 13:03:45 INFO - Creating virtualenv /builds/slave/test/build/venv 13:03:45 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 13:03:45 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 13:03:45 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 13:03:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:03:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:03:46 INFO - Installing distribute.............................................................................................................................................................................................done. 13:03:46 INFO - Installing pip...............done. 13:03:46 INFO - Return code: 0 13:03:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 13:03:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 13:03:46 INFO - Reading from file tmpfile_stdout 13:03:46 INFO - Output received: 13:03:46 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 13:03:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:03:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:03:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:03:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:03:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:03:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd0f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107aa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107e090>, '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 0x107ed80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1078f90>, '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': '9e0dfe3369c33a1556e63f89000001d8-1508270599.140807-792501720', '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 13:03:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 13:03:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 13:03:46 INFO - Using env: {'DISPLAY': ':0', 13:03:46 INFO - 'HOME': '/home/cltbld', 13:03:46 INFO - 'LANG': 'en_US.UTF-8', 13:03:46 INFO - 'LANGUAGE': 'en_US:en', 13:03:46 INFO - 'LOGNAME': 'cltbld', 13:03:46 INFO - 'MAIL': '/var/mail/cltbld', 13:03:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:03:46 INFO - 'MOZ_NO_REMOTE': '1', 13:03:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:03:46 INFO - 'NO_EM_RESTART': '1', 13:03:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:03:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:03:46 INFO - 'PWD': '/builds/slave/test', 13:03:46 INFO - 'SHELL': '/bin/bash', 13:03:46 INFO - 'SHLVL': '1', 13:03:46 INFO - 'TERM': 'linux', 13:03:46 INFO - 'TMOUT': '86400', 13:03:46 INFO - 'USER': 'cltbld', 13:03:46 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1508270599.140807-792501720', 13:03:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:03:46 INFO - '_': '/tools/buildbot/bin/python'} 13:03:47 INFO - Ignoring indexes: http://pypi.python.org/simple/ 13:03:47 INFO - Downloading/unpacking pip>=1.5 13:03:47 INFO - Running setup.py egg_info for package pip 13:03:47 INFO - warning: no files found matching 'pip/cacert.pem' 13:03:47 INFO - warning: no files found matching '*.html' under directory 'docs' 13:03:47 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 13:03:47 INFO - no previously-included directories found matching 'docs/_build/_sources' 13:03:47 INFO - Installing collected packages: pip 13:03:47 INFO - Found existing installation: pip 1.1 13:03:47 INFO - Uninstalling pip: 13:03:47 INFO - Successfully uninstalled pip 13:03:47 INFO - Running setup.py install for pip 13:03:47 INFO - warning: no files found matching 'pip/cacert.pem' 13:03:47 INFO - warning: no files found matching '*.html' under directory 'docs' 13:03:47 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 13:03:47 INFO - no previously-included directories found matching 'docs/_build/_sources' 13:03:47 INFO - Installing pip script to /builds/slave/test/build/venv/bin 13:03:47 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 13:03:47 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 13:03:47 INFO - Successfully installed pip 13:03:47 INFO - Cleaning up... 13:03:47 INFO - Return code: 0 13:03:47 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:03:47 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')]} 13:03:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:03:47 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')]} 13:03:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:03:47 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 0xd0f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107aa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107e090>, '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 0x107ed80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1078f90>, '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': '9e0dfe3369c33a1556e63f89000001d8-1508270599.140807-792501720', '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 13:03:47 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 13:03:47 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 13:03:47 INFO - Using env: {'DISPLAY': ':0', 13:03:47 INFO - 'HOME': '/home/cltbld', 13:03:47 INFO - 'LANG': 'en_US.UTF-8', 13:03:47 INFO - 'LANGUAGE': 'en_US:en', 13:03:47 INFO - 'LOGNAME': 'cltbld', 13:03:47 INFO - 'MAIL': '/var/mail/cltbld', 13:03:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:03:47 INFO - 'MOZ_NO_REMOTE': '1', 13:03:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:03:47 INFO - 'NO_EM_RESTART': '1', 13:03:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:03:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:03:47 INFO - 'PWD': '/builds/slave/test', 13:03:47 INFO - 'SHELL': '/bin/bash', 13:03:47 INFO - 'SHLVL': '1', 13:03:47 INFO - 'TERM': 'linux', 13:03:47 INFO - 'TMOUT': '86400', 13:03:47 INFO - 'USER': 'cltbld', 13:03:47 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1508270599.140807-792501720', 13:03:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:03:47 INFO - '_': '/tools/buildbot/bin/python'} 13:03:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:03:47 INFO - Downloading/unpacking psutil>=3.1.1 13:03:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:03:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:03:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:03:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:03:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:03:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:03:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:03:49 INFO - Installing collected packages: psutil 13:03:49 INFO - Running setup.py install for psutil 13:03:49 INFO - building 'psutil._psutil_linux' extension 13:03:49 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 13:03:49 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 13:03:49 INFO - building 'psutil._psutil_posix' extension 13:03:49 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 13:03:49 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 13:03:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:03:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:03:49 INFO - Successfully installed psutil 13:03:49 INFO - Cleaning up... 13:03:49 INFO - Return code: 0 13:03:49 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:03:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:03:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:03:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:03:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:03:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd0f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107aa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107e090>, '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 0x107ed80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1078f90>, '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': '9e0dfe3369c33a1556e63f89000001d8-1508270599.140807-792501720', '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 13:03:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 13:03:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 13:03:49 INFO - Using env: {'DISPLAY': ':0', 13:03:49 INFO - 'HOME': '/home/cltbld', 13:03:49 INFO - 'LANG': 'en_US.UTF-8', 13:03:49 INFO - 'LANGUAGE': 'en_US:en', 13:03:49 INFO - 'LOGNAME': 'cltbld', 13:03:49 INFO - 'MAIL': '/var/mail/cltbld', 13:03:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:03:49 INFO - 'MOZ_NO_REMOTE': '1', 13:03:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:03:49 INFO - 'NO_EM_RESTART': '1', 13:03:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:03:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:03:49 INFO - 'PWD': '/builds/slave/test', 13:03:49 INFO - 'SHELL': '/bin/bash', 13:03:49 INFO - 'SHLVL': '1', 13:03:49 INFO - 'TERM': 'linux', 13:03:49 INFO - 'TMOUT': '86400', 13:03:49 INFO - 'USER': 'cltbld', 13:03:49 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1508270599.140807-792501720', 13:03:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:03:49 INFO - '_': '/tools/buildbot/bin/python'} 13:03:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:03:49 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:03:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:03:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:03:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:03:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:03:51 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:03:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:03:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:03:51 INFO - Installing collected packages: mozsystemmonitor 13:03:51 INFO - Running setup.py install for mozsystemmonitor 13:03:51 INFO - Successfully installed mozsystemmonitor 13:03:51 INFO - Cleaning up... 13:03:52 INFO - Return code: 0 13:03:52 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:03:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:03:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:03:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:03:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:03:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xd0f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107aa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107e090>, '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 0x107ed80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1078f90>, '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': '9e0dfe3369c33a1556e63f89000001d8-1508270599.140807-792501720', '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 13:03:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 13:03:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 13:03:52 INFO - Using env: {'DISPLAY': ':0', 13:03:52 INFO - 'HOME': '/home/cltbld', 13:03:52 INFO - 'LANG': 'en_US.UTF-8', 13:03:52 INFO - 'LANGUAGE': 'en_US:en', 13:03:52 INFO - 'LOGNAME': 'cltbld', 13:03:52 INFO - 'MAIL': '/var/mail/cltbld', 13:03:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:03:52 INFO - 'MOZ_NO_REMOTE': '1', 13:03:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:03:52 INFO - 'NO_EM_RESTART': '1', 13:03:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:03:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:03:52 INFO - 'PWD': '/builds/slave/test', 13:03:52 INFO - 'SHELL': '/bin/bash', 13:03:52 INFO - 'SHLVL': '1', 13:03:52 INFO - 'TERM': 'linux', 13:03:52 INFO - 'TMOUT': '86400', 13:03:52 INFO - 'USER': 'cltbld', 13:03:52 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1508270599.140807-792501720', 13:03:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:03:52 INFO - '_': '/tools/buildbot/bin/python'} 13:03:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:03:52 INFO - Downloading/unpacking jsonschema==2.5.1 13:03:52 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 13:03:52 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 13:03:52 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 13:03:52 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 13:03:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:03:53 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:03:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:03:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:03:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:03:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:03:53 INFO - Downloading functools32-3.2.3-2.tar.gz 13:03:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:03:53 INFO - warning: no files found matching '*.txt' 13:03:53 INFO - no previously-included directories found matching 'build' 13:03:53 INFO - no previously-included directories found matching 'dist' 13:03:53 INFO - no previously-included directories found matching '.git*' 13:03:53 INFO - Installing collected packages: jsonschema, functools32 13:03:54 INFO - Running setup.py install for functools32 13:03:54 INFO - warning: no files found matching '*.txt' 13:03:54 INFO - no previously-included directories found matching 'build' 13:03:54 INFO - no previously-included directories found matching 'dist' 13:03:54 INFO - no previously-included directories found matching '.git*' 13:03:54 INFO - Successfully installed jsonschema functools32 13:03:54 INFO - Cleaning up... 13:03:54 INFO - Return code: 0 13:03:54 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:03:54 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')]} 13:03:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:03:54 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')]} 13:03:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:03:54 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 0xd0f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107aa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107e090>, '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 0x107ed80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1078f90>, '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': '9e0dfe3369c33a1556e63f89000001d8-1508270599.140807-792501720', '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 13:03:54 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 13:03:54 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 13:03:54 INFO - Using env: {'DISPLAY': ':0', 13:03:54 INFO - 'HOME': '/home/cltbld', 13:03:54 INFO - 'LANG': 'en_US.UTF-8', 13:03:54 INFO - 'LANGUAGE': 'en_US:en', 13:03:54 INFO - 'LOGNAME': 'cltbld', 13:03:54 INFO - 'MAIL': '/var/mail/cltbld', 13:03:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:03:54 INFO - 'MOZ_NO_REMOTE': '1', 13:03:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:03:54 INFO - 'NO_EM_RESTART': '1', 13:03:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:03:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:03:54 INFO - 'PWD': '/builds/slave/test', 13:03:54 INFO - 'SHELL': '/bin/bash', 13:03:54 INFO - 'SHLVL': '1', 13:03:54 INFO - 'TERM': 'linux', 13:03:54 INFO - 'TMOUT': '86400', 13:03:54 INFO - 'USER': 'cltbld', 13:03:54 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1508270599.140807-792501720', 13:03:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:03:54 INFO - '_': '/tools/buildbot/bin/python'} 13:03:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:03:54 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:03:54 INFO - Cleaning up... 13:03:54 INFO - Return code: 0 13:03:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:03:54 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')]} 13:03:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:03:54 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')]} 13:03:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:03:54 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 0xd0f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107aa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107e090>, '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 0x107ed80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1078f90>, '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': '9e0dfe3369c33a1556e63f89000001d8-1508270599.140807-792501720', '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 13:03:54 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 13:03:54 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 13:03:54 INFO - Using env: {'DISPLAY': ':0', 13:03:54 INFO - 'HOME': '/home/cltbld', 13:03:54 INFO - 'LANG': 'en_US.UTF-8', 13:03:54 INFO - 'LANGUAGE': 'en_US:en', 13:03:54 INFO - 'LOGNAME': 'cltbld', 13:03:54 INFO - 'MAIL': '/var/mail/cltbld', 13:03:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:03:54 INFO - 'MOZ_NO_REMOTE': '1', 13:03:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:03:54 INFO - 'NO_EM_RESTART': '1', 13:03:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:03:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:03:55 INFO - 'PWD': '/builds/slave/test', 13:03:55 INFO - 'SHELL': '/bin/bash', 13:03:55 INFO - 'SHLVL': '1', 13:03:55 INFO - 'TERM': 'linux', 13:03:55 INFO - 'TMOUT': '86400', 13:03:55 INFO - 'USER': 'cltbld', 13:03:55 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1508270599.140807-792501720', 13:03:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:03:55 INFO - '_': '/tools/buildbot/bin/python'} 13:03:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:03:55 INFO - Downloading/unpacking blobuploader==1.2.4 13:03:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:03:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:03:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:03:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:03:56 INFO - Downloading blobuploader-1.2.4.tar.gz 13:03:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:03:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:03:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:03:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:03:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:03:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:03:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:03:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:03:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:03:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:03:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:03:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:03:56 INFO - Downloading docopt-0.6.1.tar.gz 13:03:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:03:56 INFO - Installing collected packages: blobuploader, requests, docopt 13:03:56 INFO - Running setup.py install for blobuploader 13:03:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:03:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:03:56 INFO - Running setup.py install for requests 13:03:57 INFO - Running setup.py install for docopt 13:03:57 INFO - Successfully installed blobuploader requests docopt 13:03:57 INFO - Cleaning up... 13:03:57 INFO - Return code: 0 13:03:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:03:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:03:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:03:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:03:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:03:57 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 0xd0f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107aa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107e090>, '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 0x107ed80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1078f90>, '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': '9e0dfe3369c33a1556e63f89000001d8-1508270599.140807-792501720', '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 13:03:57 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 13:03:57 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 13:03:57 INFO - Using env: {'DISPLAY': ':0', 13:03:57 INFO - 'HOME': '/home/cltbld', 13:03:57 INFO - 'LANG': 'en_US.UTF-8', 13:03:57 INFO - 'LANGUAGE': 'en_US:en', 13:03:57 INFO - 'LOGNAME': 'cltbld', 13:03:57 INFO - 'MAIL': '/var/mail/cltbld', 13:03:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:03:57 INFO - 'MOZ_NO_REMOTE': '1', 13:03:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:03:57 INFO - 'NO_EM_RESTART': '1', 13:03:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:03:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:03:57 INFO - 'PWD': '/builds/slave/test', 13:03:57 INFO - 'SHELL': '/bin/bash', 13:03:57 INFO - 'SHLVL': '1', 13:03:57 INFO - 'TERM': 'linux', 13:03:57 INFO - 'TMOUT': '86400', 13:03:57 INFO - 'USER': 'cltbld', 13:03:57 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1508270599.140807-792501720', 13:03:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:03:57 INFO - '_': '/tools/buildbot/bin/python'} 13:03:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:03:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:03:57 INFO - Running setup.py (path:/tmp/pip-r3yI0D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:03:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:03:57 INFO - Running setup.py (path:/tmp/pip-fAkE77-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:03:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:03:57 INFO - Running setup.py (path:/tmp/pip-VTBCaW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:03:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:03:57 INFO - Running setup.py (path:/tmp/pip-Yf3xAq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:03:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:03:57 INFO - Running setup.py (path:/tmp/pip-xTCxfe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:03:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:03:58 INFO - Running setup.py (path:/tmp/pip-XFu9Ue-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:03:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:03:58 INFO - Running setup.py (path:/tmp/pip-EDxl5R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:03:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:03:58 INFO - Running setup.py (path:/tmp/pip-OdJbz2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:03:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:03:58 INFO - Running setup.py (path:/tmp/pip-SO7Rtk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:03:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:03:58 INFO - Running setup.py (path:/tmp/pip-YnsUH3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:03:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:03:58 INFO - Running setup.py (path:/tmp/pip-SvVPlp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:03:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:03:58 INFO - Running setup.py (path:/tmp/pip-PuYtr3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:03:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:03:58 INFO - Running setup.py (path:/tmp/pip-FOZ2tA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:03:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:03:58 INFO - Running setup.py (path:/tmp/pip-sK7sh1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:03:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:03:58 INFO - Running setup.py (path:/tmp/pip-Tr7n5v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:03:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:03:58 INFO - Running setup.py (path:/tmp/pip-57yE9v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:03:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:03:58 INFO - Running setup.py (path:/tmp/pip-FJogak-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:03:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:03:58 INFO - Running setup.py install for manifestparser 13:03:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:03:58 INFO - Running setup.py install for mozcrash 13:03:59 INFO - Running setup.py install for mozdebug 13:03:59 INFO - Running setup.py install for mozdevice 13:03:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:03:59 INFO - Running setup.py install for mozfile 13:03:59 INFO - Running setup.py install for mozhttpd 13:03:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:03:59 INFO - Running setup.py install for mozinfo 13:03:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:03:59 INFO - Running setup.py install for mozInstall 13:03:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:03:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:03:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:03:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:03:59 INFO - Running setup.py install for mozleak 13:03:59 INFO - Running setup.py install for mozlog 13:03:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:03:59 INFO - Running setup.py install for moznetwork 13:03:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:03:59 INFO - Running setup.py install for mozprocess 13:04:00 INFO - Running setup.py install for mozprofile 13:04:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:04:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:04:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:04:00 INFO - Running setup.py install for mozrunner 13:04:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:04:00 INFO - Running setup.py install for mozscreenshot 13:04:00 INFO - Running setup.py install for moztest 13:04:00 INFO - Running setup.py install for mozversion 13:04:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:04:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:04:00 INFO - Cleaning up... 13:04:00 INFO - Return code: 0 13:04:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:04: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')]} 13:04:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:04: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')]} 13:04:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:04:00 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 0xd0f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107aa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107e090>, '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 0x107ed80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1078f90>, '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': '9e0dfe3369c33a1556e63f89000001d8-1508270599.140807-792501720', '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 13:04:00 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 13:04:00 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 13:04:00 INFO - Using env: {'DISPLAY': ':0', 13:04:00 INFO - 'HOME': '/home/cltbld', 13:04:00 INFO - 'LANG': 'en_US.UTF-8', 13:04:00 INFO - 'LANGUAGE': 'en_US:en', 13:04:00 INFO - 'LOGNAME': 'cltbld', 13:04:00 INFO - 'MAIL': '/var/mail/cltbld', 13:04:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:04:00 INFO - 'MOZ_NO_REMOTE': '1', 13:04:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:04:00 INFO - 'NO_EM_RESTART': '1', 13:04:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:04:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:04:00 INFO - 'PWD': '/builds/slave/test', 13:04:00 INFO - 'SHELL': '/bin/bash', 13:04:00 INFO - 'SHLVL': '1', 13:04:00 INFO - 'TERM': 'linux', 13:04:00 INFO - 'TMOUT': '86400', 13:04:00 INFO - 'USER': 'cltbld', 13:04:00 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1508270599.140807-792501720', 13:04:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:04:00 INFO - '_': '/tools/buildbot/bin/python'} 13:04:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:04:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:04:00 INFO - Running setup.py (path:/tmp/pip-WVXVMc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:04:00 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)) 13:04:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:04:00 INFO - Running setup.py (path:/tmp/pip-gqbCMY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:04:01 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)) 13:04:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:04:01 INFO - Running setup.py (path:/tmp/pip-GU19d3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:04:01 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)) 13:04:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:04:01 INFO - Running setup.py (path:/tmp/pip-0Zvtyi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:04:01 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)) 13:04:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:04:01 INFO - Running setup.py (path:/tmp/pip-T2lF9U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:04:01 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)) 13:04:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:04:01 INFO - Running setup.py (path:/tmp/pip-34YsnU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:04:01 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)) 13:04:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:04:01 INFO - Running setup.py (path:/tmp/pip-MpRNcY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:04:01 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)) 13:04:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:04:01 INFO - Running setup.py (path:/tmp/pip-9rdbvf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:04:01 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)) 13:04:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:04:01 INFO - Running setup.py (path:/tmp/pip-GtAXsk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:04:01 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)) 13:04:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:04:01 INFO - Running setup.py (path:/tmp/pip-XcYvYf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:04:01 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)) 13:04:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:04:01 INFO - Running setup.py (path:/tmp/pip-o6doBh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:04:01 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)) 13:04:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:04:01 INFO - Running setup.py (path:/tmp/pip-ze9KEa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:04:01 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)) 13:04:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:04:01 INFO - Running setup.py (path:/tmp/pip-1KXAak-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:04:01 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)) 13:04:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:04:01 INFO - Running setup.py (path:/tmp/pip-UHcTHI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:04:01 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)) 13:04:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:04:01 INFO - Running setup.py (path:/tmp/pip-4JQeE_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:04:01 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)) 13:04:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:04:01 INFO - Running setup.py (path:/tmp/pip-rh_SWK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:04:02 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)) 13:04:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:04:02 INFO - Running setup.py (path:/tmp/pip-tr2uNb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:04:02 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)) 13:04:02 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)) 13:04:02 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)) 13:04:02 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)) 13:04:02 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)) 13:04:02 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)) 13:04:02 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)) 13:04:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:04:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:04:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:04:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:04:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:04:03 INFO - Downloading blessings-1.6.tar.gz 13:04:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:04:03 INFO - Installing collected packages: blessings 13:04:03 INFO - Running setup.py install for blessings 13:04:03 INFO - Successfully installed blessings 13:04:03 INFO - Cleaning up... 13:04:03 INFO - Return code: 0 13:04:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:04:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:04:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:04:03 INFO - Reading from file tmpfile_stdout 13:04:03 INFO - Current package versions: 13:04:03 INFO - argparse == 1.2.1 13:04:03 INFO - blessings == 1.6 13:04:03 INFO - blobuploader == 1.2.4 13:04:03 INFO - docopt == 0.6.1 13:04:03 INFO - functools32 == 3.2.3-2 13:04:03 INFO - jsonschema == 2.5.1 13:04:03 INFO - manifestparser == 1.1 13:04:03 INFO - mozInstall == 1.13 13:04:03 INFO - mozcrash == 1.0 13:04:03 INFO - mozdebug == 0.1 13:04:03 INFO - mozdevice == 0.51 13:04:03 INFO - mozfile == 1.2 13:04:03 INFO - mozhttpd == 0.7 13:04:03 INFO - mozinfo == 0.10 13:04:03 INFO - mozleak == 0.1 13:04:03 INFO - mozlog == 3.5 13:04:03 INFO - moznetwork == 0.27 13:04:03 INFO - mozprocess == 0.25 13:04:03 INFO - mozprofile == 0.28 13:04:03 INFO - mozrunner == 6.13 13:04:03 INFO - mozscreenshot == 0.1 13:04:03 INFO - mozsystemmonitor == 0.3 13:04:03 INFO - moztest == 0.8 13:04:03 INFO - mozversion == 1.4 13:04:03 INFO - psutil == 3.1.1 13:04:03 INFO - requests == 1.2.3 13:04:03 INFO - wsgiref == 0.1.2 13:04:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:04: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')]} 13:04:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:04: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')]} 13:04:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:04:03 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 0xd0f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107aa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107e090>, '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 0x107ed80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1078f90>, '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': '9e0dfe3369c33a1556e63f89000001d8-1508270599.140807-792501720', '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 13:04:03 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 13:04:03 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 13:04:03 INFO - Using env: {'DISPLAY': ':0', 13:04:03 INFO - 'HOME': '/home/cltbld', 13:04:03 INFO - 'LANG': 'en_US.UTF-8', 13:04:03 INFO - 'LANGUAGE': 'en_US:en', 13:04:03 INFO - 'LOGNAME': 'cltbld', 13:04:03 INFO - 'MAIL': '/var/mail/cltbld', 13:04:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:04:03 INFO - 'MOZ_NO_REMOTE': '1', 13:04:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:04:03 INFO - 'NO_EM_RESTART': '1', 13:04:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:04:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:04:03 INFO - 'PWD': '/builds/slave/test', 13:04:03 INFO - 'SHELL': '/bin/bash', 13:04:03 INFO - 'SHLVL': '1', 13:04:03 INFO - 'TERM': 'linux', 13:04:03 INFO - 'TMOUT': '86400', 13:04:03 INFO - 'USER': 'cltbld', 13:04:03 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1508270599.140807-792501720', 13:04:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:04:03 INFO - '_': '/tools/buildbot/bin/python'} 13:04:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:04:03 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)) 13:04:03 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)) 13:04:03 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)) 13:04:03 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)) 13:04:03 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)) 13:04:03 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)) 13:04:03 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)) 13:04:03 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)) 13:04:03 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)) 13:04:03 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 13:04:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:04:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:04:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:04:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:04:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 13:04:05 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)) 13:04:05 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)) 13:04:05 INFO - Installing collected packages: simplejson 13:04:05 INFO - Running setup.py install for simplejson 13:04:05 INFO - building 'simplejson._speedups' extension 13:04:05 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 13:04:05 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 13:04:06 INFO - Successfully installed simplejson 13:04:06 INFO - Cleaning up... 13:04:06 INFO - Return code: 0 13:04:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:04: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')]} 13:04:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:04: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')]} 13:04:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:04: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd0f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107aa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107e090>, '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 0x107ed80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1078f90>, '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': '9e0dfe3369c33a1556e63f89000001d8-1508270599.140807-792501720', '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 13:04: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', 'jsonschema'] in /builds/slave/test/build 13:04: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 jsonschema 13:04:06 INFO - Using env: {'DISPLAY': ':0', 13:04:06 INFO - 'HOME': '/home/cltbld', 13:04:06 INFO - 'LANG': 'en_US.UTF-8', 13:04:06 INFO - 'LANGUAGE': 'en_US:en', 13:04:06 INFO - 'LOGNAME': 'cltbld', 13:04:06 INFO - 'MAIL': '/var/mail/cltbld', 13:04:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:04:06 INFO - 'MOZ_NO_REMOTE': '1', 13:04:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:04:06 INFO - 'NO_EM_RESTART': '1', 13:04:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:04:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:04:06 INFO - 'PWD': '/builds/slave/test', 13:04:06 INFO - 'SHELL': '/bin/bash', 13:04:06 INFO - 'SHLVL': '1', 13:04:06 INFO - 'TERM': 'linux', 13:04:06 INFO - 'TMOUT': '86400', 13:04:06 INFO - 'USER': 'cltbld', 13:04:06 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1508270599.140807-792501720', 13:04:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:04:06 INFO - '_': '/tools/buildbot/bin/python'} 13:04:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:04:06 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:04:06 INFO - Cleaning up... 13:04:06 INFO - Return code: 0 13:04:06 INFO - Running post-action listener: _resource_record_post_action 13:04:06 INFO - Running post-action listener: _start_resource_monitoring 13:04:06 INFO - Starting resource monitoring. 13:04:06 INFO - [mozharness: 2017-10-17 20:04:06.398030Z] Finished create-virtualenv step (success) 13:04:06 INFO - [mozharness: 2017-10-17 20:04:06.398546Z] Running install step. 13:04:06 INFO - Running pre-action listener: _resource_record_pre_action 13:04:06 INFO - Running main action method: install 13:04:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:04:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:04:06 INFO - Reading from file tmpfile_stdout 13:04:06 INFO - Detecting whether we're running mozinstall >=1.0... 13:04:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:04:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:04:06 INFO - Reading from file tmpfile_stdout 13:04:06 INFO - Output received: 13:04:06 INFO - Usage: mozinstall [options] installer 13:04:06 INFO - Options: 13:04:06 INFO - -h, --help show this help message and exit 13:04:06 INFO - -d DEST, --destination=DEST 13:04:06 INFO - Directory to install application into. [default: 13:04:06 INFO - "/builds/slave/test"] 13:04:06 INFO - --app=APP Application being installed. [default: firefox] 13:04:06 INFO - mkdir: /builds/slave/test/build/application 13:04:06 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'] 13:04:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 13:04:21 INFO - Reading from file tmpfile_stdout 13:04:21 INFO - Output received: 13:04:21 INFO - /builds/slave/test/build/application/firefox/firefox 13:04:21 INFO - Running post-action listener: _resource_record_post_action 13:04:21 INFO - [mozharness: 2017-10-17 20:04:21.365621Z] Finished install step (success) 13:04:21 INFO - [mozharness: 2017-10-17 20:04:21.365872Z] Running setup-mitmproxy step. 13:04:21 INFO - Running pre-action listener: _resource_record_pre_action 13:04:21 INFO - Running main action method: setup_mitmproxy 13:04:21 INFO - Skipping: mitmproxy is not required 13:04:21 INFO - Running post-action listener: _resource_record_post_action 13:04:21 INFO - [mozharness: 2017-10-17 20:04:21.366996Z] Finished setup-mitmproxy step (success) 13:04:21 INFO - [mozharness: 2017-10-17 20:04:21.367216Z] Running run-tests step. 13:04:21 INFO - Running pre-action listener: _resource_record_pre_action 13:04:21 INFO - Running pre-action listener: _set_gcov_prefix 13:04:21 INFO - Running main action method: run_tests 13:04:21 WARNING - Try message not found. 13:04:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:04:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:04:21 INFO - Python 2.7.3 13:04:21 INFO - Return code: 0 13:04:21 INFO - grabbing minidump binary from tooltool 13:04:21 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')]} 13:04:21 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 0x107e090>, '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 0x107ed80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1078f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:04:21 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 13:04:21 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 13:04:21 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 13:04:21 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:04:21 INFO - Return code: 0 13:04:21 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:04:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:04:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:04:21 INFO - ENV: RUST_BACKTRACE is now full 13:04:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:04:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:04:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TsKy8kW3TauOSSW5GzkoQw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-040', '--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 13:04:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/TsKy8kW3TauOSSW5GzkoQw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-040 --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 13:04:21 INFO - Using env: {'DISPLAY': ':0', 13:04:21 INFO - 'HOME': '/home/cltbld', 13:04:21 INFO - 'LANG': 'en_US.UTF-8', 13:04:21 INFO - 'LANGUAGE': 'en_US:en', 13:04:21 INFO - 'LOGNAME': 'cltbld', 13:04:21 INFO - 'MAIL': '/var/mail/cltbld', 13:04:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:04:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:04:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:04:21 INFO - 'MOZ_NO_REMOTE': '1', 13:04:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:04:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:04:21 INFO - 'NO_EM_RESTART': '1', 13:04:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:04:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:04:21 INFO - 'PWD': '/builds/slave/test', 13:04:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:04:21 INFO - 'RUST_BACKTRACE': 'full', 13:04:21 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 13:04:21 INFO - 'SHELL': '/bin/bash', 13:04:21 INFO - 'SHLVL': '1', 13:04:21 INFO - 'TERM': 'linux', 13:04:21 INFO - 'TMOUT': '86400', 13:04:21 INFO - 'USER': 'cltbld', 13:04:21 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1508270599.140807-792501720', 13:04:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:04:21 INFO - '_': '/tools/buildbot/bin/python'} 13:04:21 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TsKy8kW3TauOSSW5GzkoQw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-040', '--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 13:04:21 INFO - mozversion application_buildid: 20171017184226 13:04:21 INFO - mozversion application_changeset: 2e35a8e42ad6ea9a6074991bbc62fe9757a2e6f0 13:04:21 INFO - mozversion application_display_name: Firefox 13:04:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:04:21 INFO - mozversion application_name: Firefox 13:04:21 INFO - mozversion application_remotingname: firefox 13:04:21 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 13:04:21 INFO - mozversion application_vendor: Mozilla 13:04:21 INFO - mozversion application_version: 57.0 13:04:21 INFO - mozversion platform_buildid: 20171017184226 13:04:21 INFO - mozversion platform_changeset: 2e35a8e42ad6ea9a6074991bbc62fe9757a2e6f0 13:04:21 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 13:04:21 INFO - mozversion platform_version: 57.0 13:04:21 INFO - using testdate: 1508270661 13:04:21 INFO - actual date: 1508270661 13:04:21 INFO - starting webserver on 'localhost:33855' 13:04:21 INFO - SUITE-START | Running 2 tests 13:04:21 INFO - TEST-START | dromaeo_css 13:04:21 INFO - Initialising browser for dromaeo_css test... 13:04:21 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:33855/getInfo.html -profile /tmp/tmpmWjv4M/profile 13:04:21 INFO - TEST-INFO | started process 14966 (/builds/slave/test/build/application/firefox/firefox http://localhost:33855/getInfo.html) 13:04:27 INFO - TEST-INFO | 14966: exit 0 13:04:27 INFO - Browser initialized. 13:04:27 INFO - Running cycle 1/1 for dromaeo_css test... 13:04:27 INFO - Using env: {'DISPLAY': ':0', 13:04:27 INFO - 'HOME': '/home/cltbld', 13:04:27 INFO - 'JSGC_DISABLE_POISONING': '1', 13:04:27 INFO - 'LANG': 'en_US.UTF-8', 13:04:27 INFO - 'LANGUAGE': 'en_US:en', 13:04:27 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 13:04:27 INFO - 'LOGNAME': 'cltbld', 13:04:27 INFO - 'MAIL': '/var/mail/cltbld', 13:04:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:04:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:04:27 INFO - 'MOZ_CRASHREPORTER': '1', 13:04:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:04:27 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 13:04:27 INFO - 'MOZ_NO_REMOTE': '1', 13:04:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:04:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:04:27 INFO - 'NO_EM_RESTART': '1', 13:04:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:04:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:04:27 INFO - 'PWD': '/builds/slave/test', 13:04:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:04:27 INFO - 'RUST_BACKTRACE': 'full', 13:04:27 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 13:04:27 INFO - 'SHELL': '/bin/bash', 13:04:27 INFO - 'SHLVL': '1', 13:04:27 INFO - 'TERM': 'linux', 13:04:27 INFO - 'TMOUT': '86400', 13:04:27 INFO - 'USER': 'cltbld', 13:04:27 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1508270599.140807-792501720', 13:04:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:04:27 INFO - '_': '/tools/buildbot/bin/python'} 13:04:27 INFO - TEST-INFO | started process 15203 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmWjv4M/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 13:04:27 INFO - PID 15203 | 13:04:27 INFO - PID 15203 | (/builds/slave/test/build/application/firefox/firefox:15252): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 13:04:27 INFO - PID 15203 | 13:04:38 INFO - PID 15203 | RSS: Main: 141864960 13:04:38 INFO - PID 15203 | 13:07:35 INFO - PID 15203 | Cycle 1(1): loaded http://localhost:33855/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33855/tests/dromaeo/cssquery-ext.html) 13:07:36 INFO - PID 15203 | RSS: Main: 145629184 13:07:36 INFO - PID 15203 | 13:10:38 INFO - PID 15203 | Cycle 1(1): loaded http://localhost:33855/tests/dromaeo/cssquery-ext.html (next: http://localhost:33855/tests/dromaeo/cssquery-jquery.html) 13:10:38 INFO - PID 15203 | RSS: Main: 144056320 13:10:38 INFO - PID 15203 | 13:13:40 INFO - PID 15203 | Cycle 1(1): loaded http://localhost:33855/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33855/tests/dromaeo/cssquery-mootools.html) 13:13:41 INFO - PID 15203 | RSS: Main: 145592320 13:13:41 INFO - PID 15203 | 13:16:42 INFO - PID 15203 | Cycle 1(1): loaded http://localhost:33855/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33855/tests/dromaeo/cssquery-prototype.html) 13:16:43 INFO - PID 15203 | RSS: Main: 145301504 13:16:43 INFO - PID 15203 | 13:19:45 INFO - PID 15203 | Cycle 1(1): loaded http://localhost:33855/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33855/tests/dromaeo/cssquery-yui.html) 13:19:46 INFO - PID 15203 | RSS: Main: 146763776 13:19:46 INFO - PID 15203 | 13:22:48 INFO - PID 15203 | Cycle 1(1): loaded http://localhost:33855/tests/dromaeo/cssquery-yui.html (next: http://localhost:33855/tests/dromaeo/cssquery-dojo.html) 13:22:48 INFO - PID 15203 | RSS: Main: 149004288 13:22:48 INFO - PID 15203 | 13:22:48 INFO - PID 15203 | __start_tp_report 13:22:48 INFO - PID 15203 | _x_x_mozilla_page_load 13:22:48 INFO - PID 15203 | _x_x_mozilla_page_load_details 13:22:48 INFO - PID 15203 | |i|pagename|runs| 13:22:48 INFO - PID 15203 | |0;dojo.html;4025.7383270087444;4045.4943132108488;4048.3320252158396;4060.7360521566115;4062.553119156893;6460.192475940507;6530.346965303479;6610.834729131774;6615.735370585171;6618.966905165474;6523.151990241262;6529.967350163242;6555.115059466971;6614.074029635843;6627.138471998634;5805.274340707411;5915.73379197935;5921.526277897758;5948.048312270038;5971.522278217754;5770.307563092414;5895.587308888379;5985.162077309158;6004.039353703409;6060.787872424466;5963.403659634046;5979.372165922581;6012.729427175787;6018.247719035121;6021.668808215546;5832.445917637818;5938.0499120140785;5939.792107276267;6020.277566692003;6032.185654936615;5694.715264236772;5778.855528611776;5785;5806.767729290866;5905.557083218733;6461.063145843873;6468.838279043014;6472.352764723537;6488.448481879046;6535.346465353474;7065.4700897432895;7075.0448689426785;7149.49953503255;7152.785416437463;7161.57030578167;7092.290770922918;7123.109611298588;7144.3212894774915;7217.422606191544;7228.349448549603;6616.569922954993;6670.166229221348;6698.196216454008;6702.497312701566;6709.563878347843;7211.567305961659;7309;7310.4517161213125;7408.62956852166;7436.219196984347;6964.547304425196;7023.613701246379;7038.225795162528;7116.964415177891;7120.786376408716;7123.287671232835;7183;7187.712491500386;7246.239144889816;7256.6734496947765;7073;7085.0435191248525;7158.141023077264;7164.820879478055;7172.175199851979;7028.051213086168;7069.399101076363;7078.575285482888;7093.290670932969;7184.137903451619;5179.792808287626;5231.267622532849;5234.0840352938085;5243.449437809051;5260.579153667774;4818.156822556109;4835.178019736653;4903.877403064952;4940.7035577865445;4947.183714687037;6583.07836902834;6584.8024559263295;6588.538802283794;6668.633225172565;6671.933280667228;6905.033295338657;7025.051618031603;7088.822779430556;7165.140183177948;7176.1388633363285;6567.146270984741;6568.408843204134;6593.076969224312;6612.305707900698;6621.9006714899315;5867.559933005042;5982.371850955674;6017.939820601826;6022.548308876764;6026.096085587109;7037.718491260394;7101.786946391617;7108.964455177795;7112.964435177894;7423.665935032936;7086.610236436943;7089.468289878177;7090.326418990187;7090.822729431806;7099.290070993066;7190.784276471714;7202.2797720229655;7206.675699593636;7212.855742885218;7330.047093877762;6973.6164510952385;6977.755778547727;7039.6832142552685;7091.042709234187;7091.9290807091265;7204.56772593646;7222.783316500513;7225.6387180641805;7227.602481863548;7228.168760592389;6869.896951545631;6878.896816547655;6881.071055407456;6960.582365058112;6969.0940177776565;6699.866002680016;6770.390664840188;6852.143482064742;6938.202106757787;6943.652817359213;6803.217629972419;6839.350261725128;6850.862982740417;6854.725810967705;6887.104676392037;6837.965810170917;6865.519413641197;6870;6961.61711105894;6964.477664175106;6715.56348837324;6715.697793599202;6765.289644587444;6799.082123913208;6811.863762724817 13:22:48 INFO - PID 15203 | |1;ext.html;976.3458482816517;981.210125848692;990.5146478225672;997.9621193958284;1042.8331466965283;45276.3208551872;45726;45780.54219457805;45968.77015614926;46289.76855115728;43855.12289754203;44017;44237.11525769483;44281.557184428224;44417.7779111104;7091.468139889503;7105.14738231413;7112.822179445529;7113.359797618214;7117.430605551556;7798.649060792278;7856.685732570691;7865.174156713549;7865.370770338388;7885.526868387887;8641.740747777545;8866.822663546725;8871.201591856732;8873.245774109208;8880.023197448276;8741.825163496726;8793.164649358301;8808.339374546935;8812.823743525125;8818.338624603148;8451.619677114544;8466.872996905051;8521.573921303972;8571.914280857236;8576.742697719079;39545;39715.40426893599;39951.40072898909;40006.59993400058;40164.19671606581;3809.2000679857265;3868.5551161616495;3869.5550011748446;3869.555001174873;3871.070942973666;33133.17167070843;33271.16822079467;33711.32577348464;33892.322153557034;34118.82940585306;5550.972245138789;5560.138178582286;5592.021396255639;5616.185653080281;5662.66024038559;229459;230512;247726;251725;253553;54249;55021;55069.173962390596;55074.17388739172;55087.173692394645;56273.43726562764;56404.717976409855;56605.716971415706;56671.31636443618;56808;17357.47927562175;17389.130543472776;17397.13014349303;17490.912545437444;17496.387626433014;14538;14581.198034108014;14585.197814120325;14596.197209153386;14600.196989165697;15668.921655391878;15684;15818.130002849954;15841;15875.920620396824;6123.755049797958;6130.601510901777;6147.784827531015;6229.190205273286;6272.466840318532;1084.728817795551;1084.9349039057681;1087.244365166202;1107.4684151607273;1115.5482029777952;25744.48511029769;26207.868960655454;26239.475210495682;26402.33994150123;26566.73433265681;1206.897413719826;1236.1347057059913;1243.1981372015;1243.8880500754976;1245.1719606461602;13814.309284535733;13918.164910105426;13983.720325593431;14086.506972255922;14284.285785710881;285638;344754;349853;350272;352456;63660;63665;64370.35629643644;64471.35528644748;64510;1543.4212170436087;1569.5134508302463;1574.8188958269716;1588.253520845201;1590;30375;30684.693153068183;30713;30755.692443075284;30892.536611951287;41933;42213.78893105638;42356.57643423526;42380;42409.78795106005;272356;273612;274653;274662;274947;37644.2471150581;37692.62307376891;37707.2458550822;38068.238635227695;38117.428238577;45117;46059.30911036404;46415.303770444145;46521.302180467996;46574.76712616415;34460.31079378448;34591.481127783605;34851.12872178216;35148.47277290792;35425.645743542234;34813.65186348205;34930.301393972484;35189.82405087958;35474;35653.465198021535;40662.18675626412;40690.389644155955;40701;41015.589844101174;41273.380899285934;33108.503372449915;33110.17224569309;33351.16622084467;33414.83292583522;33914;24780.628290575296;24829.25512234636;25131.87434062818;25355.36611584725;25813.870930645226 13:22:48 INFO - PID 15203 | |2;jquery.html;636.1698322077899;648.0759935685606;648.355708831137;654.2814605314916;657.6120089147405;24608.50782984339;25190.74809251907;25246.495070098634;25269.873650631765;25287.999999999978;26552.73447265527;26944.865275673645;27014.72985270147;27014.864925675392;27172.32069198271;6696.1629796275465;6738.292479289653;6745.123133992574;6839.863202735943;6853.691583878737;6784.525083244175;6908.309169083102;6919.757808476705;6933.930660693404;6938.965305173467;6748.190217173946;6910.930890691079;6918.273581273969;6923.792286231421;6965.721371145148;6986.9999999999745;6991.685374158175;7001.929980700204;7034.085568876013;7044.682989265495;6558.081868538361;6566.343365663443;6583.440407565363;6591.11020012297;6610.8016759497295;29708.257293567618;30781.692183078107;31461.685383146334;31482.527762083588;31530.369392612247;2298.586254474194;2351.3651314145086;2352.870592117433;2353.5528249632684;2353.776391242829;20456.590868182553;20921.895390523103;20959;21093.578128437497;21120.471988200265;2540.9491810163695;2600.882960266774;2637.5779875219873;2642.2997905555044;2656.5882288245352;142296.2885185578;150374;151016;162621;169375.1531242348;16326.77549183816;16656.58358541022;17011.829881701273;17064.146792660318;17552.91223543874;27243.727562724118;27407.725922740516;27409;27489.587656185173;27605.447891042066;11651.417429128509;11888.76222475563;11950.760984780256;11974.281543107441;12050.457729402198;10713.071647103596;10844.457777111113;10900.1279897608;10901.945490272497;10909;10045.146162576117;10113.747156321151;10166.135878450414;10232.079112879728;10291.764988201463;2963.8962636307624;3100.8139511629374;3136.702013308732;3150.952735708966;3152.4640811062172;1042.0985847242082;1055.440616473255;1062.5484169228203;1072.1690689715533;1074.511097450658;21573.784262157176;21913;22122;22379.77620223777;22392.888035560045;1092.9398883061508;1125.6566747142201;1128.949197286124;1137.806572882612;1143.8398624192619;11589.304641721355;12032.879671203176;12046.277223366451;12080.879191207976;12119.333436660892;698264.851126716;707427;725444;726385;734979;129427;129906.35046824705;130538.34730826285;133061;136222.3188884069;1230.249547775856;1237.2020047069589;1260.703734622363;1268.7272236469203;1274.5539061328645;19248.518787030436;19298.13158407903;19554.511137221114;19561.413157605293;19782.901085495057;61266.693666531384;62493;63011;63317.36682633115;65115.348846510926;75649.24350756643;76212;76292;76571.61714191393;77040.2295977033;15931.12378819176;16031.759523607388;16344.346226150821;16390.918045410173;16412;24425.38936526601;24534;24608.876955615106;24652.260432187064;24814.25557233286;19974.10116544788;20106.095225714584;20338;20436.489087772923;20448.69326960067;17782.644347112728;18048.09759511993;18117.909410452863;18366.724499132255;18415.53961150982;18879.811201887806;19872.403827885188;20008.099635516144;20379.898100509403;20472.897635511727;15083.54749357521;15913.681726365176;15962.201889905225;16054.598635034217;16068.598285042968;19673.508162295486;19912.800871991094;20062.09720562549;20071.59856802885;20116.497087572927 13:22:48 INFO - PID 15203 | |3;mootools.html;1403.1791402029814;1459.080779109161;1485.457807900116;1492.5298530962752;1497.4758834407958;18007.63984720305;18614.34849780258;18664.066796660147;18667.81332186678;18668.719969200454;18177.182026808794;18280.908595457036;18316.81683183168;18326.541836454096;18398.632027359447;3034.5144776835764;3190.9840450797715;3192.6647701991305;3200.167956331359;3201.5837941067743;3091.551724999874;3129.8278594677286;3166.097662166283;3171.2230503526553;3172.381385629803;3172.1118086935694;3194.9201269968203;3217.983910080446;3221.693939075784;3225.774195806283;3079.55346474761;3097.845107744626;3108;3112.828794416306;3129;3019.607451031352;3117.2830249042845;3138.6233651961684;3171.1437911763924;3183.4906414973493;17254.13729313542;17619.207135678924;17650.382236621655;17657.911710441495;17678.646427071515;9048.230900373475;9419;9423.293253005984;9432.858507122399;9435.198008169315;5919.467247947706;5973.342932277446;6145.754169833202;6265.404786545271;6281;2138.492362884163;2161.297578287063;2187.157944191498;2216.822654187661;2240.932772016842;32812.343753125046;33104.66895331064;33225.6677433225;33289.16777080544;33383.33233335344;7686.308232259012;7761.72833950809;7773.144954055049;8053.275205231557;8057.838843223103;20806.375808725763;20810;20860.89569552173;20866.165353385997;20924.686129708065;8932.687355942511;9149.222316103205;9158.496282704382;9173.89913210419;9178.118485710413;8127.83744325122;8358.623861926228;8366.79083022917;8425.07324194338;8473;6268.341824108403;6306.590071645328;6333.429991300805;6352.7141278642575;6437.645929473924;1634.3054201964117;1680.6806706725683;1850.287639258895;1881.040669258688;1894.9147288372055;1000.7998400319965;1004.5529739266102;1010.8231059564547;1023.4064242739194;1044.383813550009;10209;10347.534360953625;10402.427866467417;10555.736106597396;10567.89432105669;1088.5482524752297;1112.0825319111766;1114.147677027075;1114.8439218509416;1118.2060736876747;5595.524380427628;5607.691576963306;5646.6047376684055;6033.3664965178905;6242.282137554149;26264.737352626613;27039.32401689934;27191.456170876867;27277.727222727917;27294.5905811413;24905.5018899621;25921.481570368866;26171.607425888626;26373.472530549283;26443.206703798533;12442.564510242099;12565.874341256653;12641.304728240035;12655.177413468095;12685.23888566689;9453.905460945578;9491.430514169171;9511.191548718436;9538.523073846141;9573.808523829624;22038;22097.66853497231;22472.325830224465;23079.19222827193;23451;23569.292921212393;23616.88191559031;23658.171963981178;23831;24386.634200486653;12959.870401295866;13196.80204796948;13208;13222.338883055616;13225.338733063116;15962.361505539648;16049.117298548692;16217.18914054269;16431.83568164303;16550.172491375622;12679;12686.365681716063;13101.868981310447;13216.735665286447;13377.66555836112;12588;12606.810897836356;12617.116801824151;12713.300768457824;12959.287239201934;11647.242929209575;11808.468618911998;11868.40657967081;11986.340751258764;11994.580189693319;8059.395545334006;8294.212049855254;8356.58217089131;8382.82046667883;8449.493030418194;7875.212478752079;8093.150219226896;8152.470089444168;8175.754727358189;8181.140980197231 13:22:48 INFO - PID 15203 | |4;prototype.html;589.9587028907976;602.1629934391196;613.2671457608154;617.7220250887101;633.9397757213065;6577.57245779024;6600.669966501674;6605.86788264235;6617.536772425932;6686.13080299561;6456.451201647854;6504.967475162617;6514.719848053179;6556.868862622757;6582;5047.49525047496;5236.581073514109;5259.500347466985;5356.143017117262;5363.9463605364035;5164.819231326905;5179.404368497614;5235.738213089349;5249.973750131263;5266.3153790007245;5210.661307015051;5216.478352164791;5233.790648374061;5236.586121747145;5241.5806735461265;5198.636095473318;5251.369835619712;5256.579473642099;5272.103742363807;5294.867628309323;4793.472718001017;4797.880052998668;4798.760061996886;4802.855914322541;4809.278608208761;6242.1261023456755;6301.873962520724;6322.083297921821;6366.904496432558;6389.936100638981;6056.242969628796;6076.95882238311;6142.662153581596;6154.984427569446;6186.133941248228;6922.619255940921;6926.445884329292;6941.548799328078;6949.270326615683;6951.270116637731;5040.865805193839;5259.894802103937;5291.682499050069;5317.627766056377;5330.253764472977;7020.7542736004;7117.2882711728935;7190.130566052811;7219.278072192791;7224.7110115595315;5457.426970168154;5457.781688732485;5459.372172200168;5473.698946557977;5479.698616576126;5502.257195278667;5544.417836127149;5545.445455454423;5549.223108764776;5585.162225666101;6116.327204007555;6124.418180272867;6125.571210015256;6128.63228206309;6182.845428864314;7014.789556313319;7018.543794653331;7030.3321184487395;7035.226125126232;7047.89428158578;1898.7531620889197;1917.3481016454473;1924.2495426783566;1937.98062019378;1940.805919408076;1263.1536870296923;1349.6153596225029;1353.7563238617142;1353.824002879639;1367.9658008549866;6316.905246421307;6364.904526432108;6368.713407896656;6379.330170332141;6468.126802881551;6766.616691654173;6775.865602335249;6897.62063086525;6940.479464040217;6952.409045231212;6363.472766535998;6398.624295776431;6418.711157997901;6457.1282876811965;6488.805335839932;3661.1945372018113;3722.9627703722617;3723.4414837774552;3726.2547490501465;3729;7054.294570542905;7101.89347159793;7149.60677162761;7232.385247254042;7246.130464344313;7050.4007159391;7080.468964827659;7183.856322873513;7276.781696549112;7284.890726639104;7113.786586402416;7207.207207207098;7223.89164162538;7254.709811607477;7307.19620841707;6922.411595014481;6968.407685346802;6990.895136573057;7000.719971201095;7076.363127318566;6994.860102797814;7017.7017251808575;7036.130128429446;7066.964665176642;7074.549717308042;7258.3104605062435;7258.491905566771;7300.890486642811;7306.086739157606;7323.48735588525;5445.618806683494;5450.645708028966;5464.125739881759;5490.176473529003;5509.393966663744;6679.561959884704;6847.417969472651;7082.583483303257;7099.840570945879;7113.715451382094;6792.490563207681;6807.115075040213;6822.931770682229;6833.384995350442;6849.657517124224;6682.797096522479;6718.395344419026;6765.086713293839;6774.254831968381;6783.152105986752;6644.900326495203;6730.192376914802;6744.494162937701;6748.628825414453;6753.662316884234;6845.281245469154;6904.689288982108;6918.861622767416;6928;6943.236244013256;6607.339266073354;6683.7660681875905;6703.765368212285;6731.865362692816;6778.237658208803 13:22:48 INFO - PID 15203 | |5;yui.html;995.8655581496496;997.2299168975069;1015.4262841494555;1022.6369638778234;1030.119248042923;18999.52501187471;19103.23587056518;19157.52106197344;19582.216711331566;19751.604967900632;20423.080961356736;20669;20695.586088278225;20701.378958631227;20708.27521036764;1052.6000119954406;1074.0923919288189;1078.8813230544633;1081.6917178604099;1082.6210826210802;1112.6383925224295;1113.8496302999113;1116.0736588631457;1117.972050698731;1118.2172479264507;1098.6045023791428;1135.250734515216;1143.5025763792735;1146.524192460128;1147.8450409194777;1103.382106020627;1127.7124333294958;1129.3844854554206;1130.5929865248504;1135.239389608964;835.8495470815251;838.6310023589601;839.5466448118009;840.3025488844306;840.9789755256106;21100.577988440145;21129;21989.780102199093;22234.666480002812;22241.332760017227;23939.88030059856;24273.635895461583;24786.50426991468;24810.255692329258;24830.751692483023;17587.5603109922;17806.55483612907;17931.551711207194;17946.820531794776;17957.910210448994;4059;4129.29801933672;4129.97935010326;4130.0294430808735;4130.421740956239;123317.38341308325;149405;171889.1405542977;173357.13321433312;178303.9999999987;19468;19630.803691963185;19767;19780.20879164846;19798;34944.475832862525;35702.821485892404;35765.64234357675;35880.82059589738;36195.276094477966;10115.747106322253;10183.490825458846;10212.540435680412;10215.08064274204;10221.284510084372;4698.647601429838;4716.221823399101;4744.95255047452;4764.976175119103;4791.520847915181;6165.876682466325;6241.625502469867;6258.311585725566;6280.466160376328;6281;1298.558490113347;1331.3476396565613;1332.7068045030078;1335.0721248732038;1359.768839297302;574.9482546570829;581.7498475655509;584.8245526342081;588.3704436253254;599.3826358850304;12727.936360318325;12771;13178.868211317764;14581.416743330361;14641.707165856624;660.247318057415;661.2032500836576;667.8230268978724;669.3607604737464;678.8506528563709;6132.325444201134;6153.446189842846;6189;6194.783182588588;6311.495080393557;154745.22627387015;155579;156014;156146.2192689052;156722.21638891732;137505;138239;138403;139897;142706;117856.41071794587;118916;119508;119792.401037996;120059;11881.287122772661;11913.702157446132;12019.879801201876;12073.698157546132;12339.07456940715;59709;59829.102563460714;59942.700286498286;59980;60172.09741853963;75868;76085.61957190179;76457;76630.2336976623;79203.60398197972;15294.311755970786;15355.155466449452;15666.451674191349;15683.1374274416;15821.208939553206;16052.277647505656;16390.75413868769;16478.917605411898;16526.83473165253;16688;16451.67096658084;16678.416255431002;16758.413455528997;16845.66308673844;16970.236339365005;15941.202939853192;15976.600584985468;16026.599335016717;16061.357545698042;16153.75769363437;16898.66202675915;17188.742168867728;17355;17444.47666570005;17499.912500437415;11760.58837940668;12089.455974480994;12144.939275303566;12178.878211218129;12222.266664000188;11864.060545969955;11934.940325298317;11942.522299107939;12071.57749478764;12091.57679481214 13:22:48 INFO - PID 15203 | __end_tp_report 13:22:48 INFO - PID 15203 | __start_cc_report 13:22:48 INFO - PID 15203 | _x_x_mozilla_cycle_collect,256 13:22:48 INFO - PID 15203 | __end_cc_report 13:22:48 INFO - PID 15203 | __startTimestamp1508271768245__endTimestamp 13:22:48 INFO - PID 15203 | 13:22:48 INFO - PID 15203 | ------- Summary: start ------- 13:22:48 INFO - PID 15203 | Number of tests: 6 13:22:48 INFO - PID 15203 | 13:22:48 INFO - PID 15203 | [#0] dojo.html Cycles:165 Average:6558.28 Median:6811.86 stddev:748.91 (11.0%) stddev-sans-first:724.37 13:22:48 INFO - PID 15203 | Values: 4025.7 4045.5 4048.3 4060.7 4062.6 6460.2 6530.3 6610.8 6615.7 6619.0 6523.2 6530.0 6555.1 6614.1 6627.1 5805.3 5915.7 5921.5 5948.0 5971.5 5770.3 5895.6 5985.2 6004.0 6060.8 5963.4 5979.4 6012.7 6018.2 6021.7 5832.4 5938.0 5939.8 6020.3 6032.2 5694.7 5778.9 5785.0 5806.8 5905.6 6461.1 6468.8 6472.4 6488.4 6535.3 7065.5 7075.0 7149.5 7152.8 7161.6 7092.3 7123.1 7144.3 7217.4 7228.3 6616.6 6670.2 6698.2 6702.5 6709.6 7211.6 7309.0 7310.5 7408.6 7436.2 6964.5 7023.6 7038.2 7117.0 7120.8 7123.3 7183.0 7187.7 7246.2 7256.7 7073.0 7085.0 7158.1 7164.8 7172.2 7028.1 7069.4 7078.6 7093.3 7184.1 5179.8 5231.3 5234.1 5243.4 5260.6 4818.2 4835.2 4903.9 4940.7 4947.2 6583.1 6584.8 6588.5 6668.6 6671.9 6905.0 7025.1 7088.8 7165.1 7176.1 6567.1 6568.4 6593.1 6612.3 6621.9 5867.6 5982.4 6017.9 6022.5 6026.1 7037.7 7101.8 7109.0 7113.0 7423.7 7086.6 7089.5 7090.3 7090.8 7099.3 7190.8 7202.3 7206.7 7212.9 7330.0 6973.6 6977.8 7039.7 7091.0 7091.9 7204.6 7222.8 7225.6 7227.6 7228.2 6869.9 6878.9 6881.1 6960.6 6969.1 6699.9 6770.4 6852.1 6938.2 6943.7 6803.2 6839.4 6850.9 6854.7 6887.1 6838.0 6865.5 6870.0 6961.6 6964.5 6715.6 6715.7 6765.3 6799.1 6811.9 13:22:48 INFO - PID 15203 | 13:22:48 INFO - PID 15203 | [#1] ext.html Cycles:180 Average:46345.33 Median:20963.31 stddev:75122.46 (358.4%) stddev-sans-first:75255.96 13:22:48 INFO - PID 15203 | Values: 976.3 981.2 990.5 998.0 1042.8 45276.3 45726.0 45780.5 45968.8 46289.8 43855.1 44017.0 44237.1 44281.6 44417.8 7091.5 7105.1 7112.8 7113.4 7117.4 7798.6 7856.7 7865.2 7865.4 7885.5 8641.7 8866.8 8871.2 8873.2 8880.0 8741.8 8793.2 8808.3 8812.8 8818.3 8451.6 8466.9 8521.6 8571.9 8576.7 39545.0 39715.4 39951.4 40006.6 40164.2 3809.2 3868.6 3869.6 3869.6 3871.1 33133.2 33271.2 33711.3 33892.3 34118.8 5551.0 5560.1 5592.0 5616.2 5662.7 229459.0 230512.0 247726.0 251725.0 253553.0 54249.0 55021.0 55069.2 55074.2 55087.2 56273.4 56404.7 56605.7 56671.3 56808.0 17357.5 17389.1 17397.1 17490.9 17496.4 14538.0 14581.2 14585.2 14596.2 14600.2 15668.9 15684.0 15818.1 15841.0 15875.9 6123.8 6130.6 6147.8 6229.2 6272.5 1084.7 1084.9 1087.2 1107.5 1115.5 25744.5 26207.9 26239.5 26402.3 26566.7 1206.9 1236.1 1243.2 1243.9 1245.2 13814.3 13918.2 13983.7 14086.5 14284.3 285638.0 344754.0 349853.0 350272.0 352456.0 63660.0 63665.0 64370.4 64471.4 64510.0 1543.4 1569.5 1574.8 1588.3 1590.0 30375.0 30684.7 30713.0 30755.7 30892.5 41933.0 42213.8 42356.6 42380.0 42409.8 272356.0 273612.0 274653.0 274662.0 274947.0 37644.2 37692.6 37707.2 38068.2 38117.4 45117.0 46059.3 46415.3 46521.3 46574.8 34460.3 34591.5 34851.1 35148.5 35425.6 34813.7 34930.3 35189.8 35474.0 35653.5 40662.2 40690.4 40701.0 41015.6 41273.4 33108.5 33110.2 33351.2 33414.8 33914.0 24780.6 24829.3 25131.9 25355.4 25813.9 13:22:48 INFO - PID 15203 | 13:22:48 INFO - PID 15203 | [#2] jquery.html Cycles:180 Average:43358.18 Median:21743.39 stddev:119142.84 (547.9%) stddev-sans-first:119433.88 13:22:48 INFO - PID 15203 | Values: 636.2 648.1 648.4 654.3 657.6 24608.5 25190.7 25246.5 25269.9 25288.0 26552.7 26944.9 27014.7 27014.9 27172.3 6696.2 6738.3 6745.1 6839.9 6853.7 6784.5 6908.3 6919.8 6933.9 6939.0 6748.2 6910.9 6918.3 6923.8 6965.7 6987.0 6991.7 7001.9 7034.1 7044.7 6558.1 6566.3 6583.4 6591.1 6610.8 29708.3 30781.7 31461.7 31482.5 31530.4 2298.6 2351.4 2352.9 2353.6 2353.8 20456.6 20921.9 20959.0 21093.6 21120.5 2540.9 2600.9 2637.6 2642.3 2656.6 142296.3 150374.0 151016.0 162621.0 169375.2 16326.8 16656.6 17011.8 17064.1 17552.9 27243.7 27407.7 27409.0 27489.6 27605.4 11651.4 11888.8 11950.8 11974.3 12050.5 10713.1 10844.5 10900.1 10901.9 10909.0 10045.1 10113.7 10166.1 10232.1 10291.8 2963.9 3100.8 3136.7 3151.0 3152.5 1042.1 1055.4 1062.5 1072.2 1074.5 21573.8 21913.0 22122.0 22379.8 22392.9 1092.9 1125.7 1128.9 1137.8 1143.8 11589.3 12032.9 12046.3 12080.9 12119.3 698264.9 707427.0 725444.0 726385.0 734979.0 129427.0 129906.4 130538.3 133061.0 136222.3 1230.2 1237.2 1260.7 1268.7 1274.6 19248.5 19298.1 19554.5 19561.4 19782.9 61266.7 62493.0 63011.0 63317.4 65115.3 75649.2 76212.0 76292.0 76571.6 77040.2 15931.1 16031.8 16344.3 16390.9 16412.0 24425.4 24534.0 24608.9 24652.3 24814.3 19974.1 20106.1 20338.0 20436.5 20448.7 17782.6 18048.1 18117.9 18366.7 18415.5 18879.8 19872.4 20008.1 20379.9 20472.9 15083.5 15913.7 15962.2 16054.6 16068.6 19673.5 19912.8 20062.1 20071.6 20116.5 13:22:48 INFO - PID 15203 | 13:22:48 INFO - PID 15203 | [#3] mootools.html Cycles:180 Average:11111.81 Median:25413.49 stddev:8250.77 (32.5%) stddev-sans-first:8241.67 13:22:48 INFO - PID 15203 | Values: 1403.2 1459.1 1485.5 1492.5 1497.5 18007.6 18614.3 18664.1 18667.8 18668.7 18177.2 18280.9 18316.8 18326.5 18398.6 3034.5 3191.0 3192.7 3200.2 3201.6 3091.6 3129.8 3166.1 3171.2 3172.4 3172.1 3194.9 3218.0 3221.7 3225.8 3079.6 3097.8 3108.0 3112.8 3129.0 3019.6 3117.3 3138.6 3171.1 3183.5 17254.1 17619.2 17650.4 17657.9 17678.6 9048.2 9419.0 9423.3 9432.9 9435.2 5919.5 5973.3 6145.8 6265.4 6281.0 2138.5 2161.3 2187.2 2216.8 2240.9 32812.3 33104.7 33225.7 33289.2 33383.3 7686.3 7761.7 7773.1 8053.3 8057.8 20806.4 20810.0 20860.9 20866.2 20924.7 8932.7 9149.2 9158.5 9173.9 9178.1 8127.8 8358.6 8366.8 8425.1 8473.0 6268.3 6306.6 6333.4 6352.7 6437.6 1634.3 1680.7 1850.3 1881.0 1894.9 1000.8 1004.6 1010.8 1023.4 1044.4 10209.0 10347.5 10402.4 10555.7 10567.9 1088.5 1112.1 1114.1 1114.8 1118.2 5595.5 5607.7 5646.6 6033.4 6242.3 26264.7 27039.3 27191.5 27277.7 27294.6 24905.5 25921.5 26171.6 26373.5 26443.2 12442.6 12565.9 12641.3 12655.2 12685.2 9453.9 9491.4 9511.2 9538.5 9573.8 22038.0 22097.7 22472.3 23079.2 23451.0 23569.3 23616.9 23658.2 23831.0 24386.6 12959.9 13196.8 13208.0 13222.3 13225.3 15962.4 16049.1 16217.2 16431.8 16550.2 12679.0 12686.4 13101.9 13216.7 13377.7 12588.0 12606.8 12617.1 12713.3 12959.3 11647.2 11808.5 11868.4 11986.3 11994.6 8059.4 8294.2 8356.6 8382.8 8449.5 7875.2 8093.2 8152.5 8175.8 8181.1 13:22:48 INFO - PID 15203 | 13:22:48 INFO - PID 15203 | [#4] prototype.html Cycles:180 Average:5870.16 Median:6496.89 stddev:1623.03 (25.0%) stddev-sans-first:1578.45 13:22:48 INFO - PID 15203 | Values: 590.0 602.2 613.3 617.7 633.9 6577.6 6600.7 6605.9 6617.5 6686.1 6456.5 6505.0 6514.7 6556.9 6582.0 5047.5 5236.6 5259.5 5356.1 5363.9 5164.8 5179.4 5235.7 5250.0 5266.3 5210.7 5216.5 5233.8 5236.6 5241.6 5198.6 5251.4 5256.6 5272.1 5294.9 4793.5 4797.9 4798.8 4802.9 4809.3 6242.1 6301.9 6322.1 6366.9 6389.9 6056.2 6077.0 6142.7 6155.0 6186.1 6922.6 6926.4 6941.5 6949.3 6951.3 5040.9 5259.9 5291.7 5317.6 5330.3 7020.8 7117.3 7190.1 7219.3 7224.7 5457.4 5457.8 5459.4 5473.7 5479.7 5502.3 5544.4 5545.4 5549.2 5585.2 6116.3 6124.4 6125.6 6128.6 6182.8 7014.8 7018.5 7030.3 7035.2 7047.9 1898.8 1917.3 1924.2 1938.0 1940.8 1263.2 1349.6 1353.8 1353.8 1368.0 6316.9 6364.9 6368.7 6379.3 6468.1 6766.6 6775.9 6897.6 6940.5 6952.4 6363.5 6398.6 6418.7 6457.1 6488.8 3661.2 3723.0 3723.4 3726.3 3729.0 7054.3 7101.9 7149.6 7232.4 7246.1 7050.4 7080.5 7183.9 7276.8 7284.9 7113.8 7207.2 7223.9 7254.7 7307.2 6922.4 6968.4 6990.9 7000.7 7076.4 6994.9 7017.7 7036.1 7067.0 7074.5 7258.3 7258.5 7300.9 7306.1 7323.5 5445.6 5450.6 5464.1 5490.2 5509.4 6679.6 6847.4 7082.6 7099.8 7113.7 6792.5 6807.1 6822.9 6833.4 6849.7 6682.8 6718.4 6765.1 6774.3 6783.2 6644.9 6730.2 6744.5 6748.6 6753.7 6845.3 6904.7 6918.9 6928.0 6943.2 6607.3 6683.8 6703.8 6731.9 6778.2 13:22:48 INFO - PID 15203 | 13:22:48 INFO - PID 15203 | [#5] yui.html Cycles:180 Average:28944.70 Median:17079.49 stddev:43933.17 (257.2%) stddev-sans-first:44006.30 13:22:48 INFO - PID 15203 | Values: 995.9 997.2 1015.4 1022.6 1030.1 18999.5 19103.2 19157.5 19582.2 19751.6 20423.1 20669.0 20695.6 20701.4 20708.3 1052.6 1074.1 1078.9 1081.7 1082.6 1112.6 1113.8 1116.1 1118.0 1118.2 1098.6 1135.3 1143.5 1146.5 1147.8 1103.4 1127.7 1129.4 1130.6 1135.2 835.8 838.6 839.5 840.3 841.0 21100.6 21129.0 21989.8 22234.7 22241.3 23939.9 24273.6 24786.5 24810.3 24830.8 17587.6 17806.6 17931.6 17946.8 17957.9 4059.0 4129.3 4130.0 4130.0 4130.4 123317.4 149405.0 171889.1 173357.1 178304.0 19468.0 19630.8 19767.0 19780.2 19798.0 34944.5 35702.8 35765.6 35880.8 36195.3 10115.7 10183.5 10212.5 10215.1 10221.3 4698.6 4716.2 4745.0 4765.0 4791.5 6165.9 6241.6 6258.3 6280.5 6281.0 1298.6 1331.3 1332.7 1335.1 1359.8 574.9 581.7 584.8 588.4 599.4 12727.9 12771.0 13178.9 14581.4 14641.7 660.2 661.2 667.8 669.4 678.9 6132.3 6153.4 6189.0 6194.8 6311.5 154745.2 155579.0 156014.0 156146.2 156722.2 137505.0 138239.0 138403.0 139897.0 142706.0 117856.4 118916.0 119508.0 119792.4 120059.0 11881.3 11913.7 12019.9 12073.7 12339.1 59709.0 59829.1 59942.7 59980.0 60172.1 75868.0 76085.6 76457.0 76630.2 79203.6 15294.3 15355.2 15666.5 15683.1 15821.2 16052.3 16390.8 16478.9 16526.8 16688.0 16451.7 16678.4 16758.4 16845.7 16970.2 15941.2 15976.6 16026.6 16061.4 16153.8 16898.7 17188.7 17355.0 17444.5 17499.9 11760.6 12089.5 12144.9 12178.9 12222.3 11864.1 11934.9 11942.5 12071.6 12091.6 13:22:48 INFO - PID 15203 | -------- Summary: end -------- 13:22:48 INFO - PID 15203 | 13:22:48 INFO - TEST-INFO | 15203: exit 0 13:22:48 INFO - TEST-OK | dromaeo_css | took 1107084ms 13:22:48 INFO - TEST-START | kraken 13:22:48 INFO - Initialising browser for kraken test... 13:22:48 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:33855/getInfo.html -profile /tmp/tmpM9MdAN/profile 13:22:48 INFO - TEST-INFO | started process 15574 (/builds/slave/test/build/application/firefox/firefox http://localhost:33855/getInfo.html) 13:22:54 INFO - TEST-INFO | 15574: exit 0 13:22:54 INFO - Browser initialized. 13:22:54 INFO - Running cycle 1/1 for kraken test... 13:22:54 INFO - Using env: {'DISPLAY': ':0', 13:22:54 INFO - 'HOME': '/home/cltbld', 13:22:54 INFO - 'JSGC_DISABLE_POISONING': '1', 13:22:54 INFO - 'LANG': 'en_US.UTF-8', 13:22:54 INFO - 'LANGUAGE': 'en_US:en', 13:22:54 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 13:22:54 INFO - 'LOGNAME': 'cltbld', 13:22:54 INFO - 'MAIL': '/var/mail/cltbld', 13:22:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:22:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:22:54 INFO - 'MOZ_CRASHREPORTER': '1', 13:22:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:22:54 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 13:22:54 INFO - 'MOZ_NO_REMOTE': '1', 13:22:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:22:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:22:54 INFO - 'NO_EM_RESTART': '1', 13:22:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:22:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:22:54 INFO - 'PWD': '/builds/slave/test', 13:22:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:22:54 INFO - 'RUST_BACKTRACE': 'full', 13:22:54 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 13:22:54 INFO - 'SHELL': '/bin/bash', 13:22:54 INFO - 'SHLVL': '1', 13:22:54 INFO - 'TERM': 'linux', 13:22:54 INFO - 'TMOUT': '86400', 13:22:54 INFO - 'USER': 'cltbld', 13:22:54 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1508270599.140807-792501720', 13:22:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:22:54 INFO - '_': '/tools/buildbot/bin/python'} 13:22:54 INFO - TEST-INFO | started process 15811 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpM9MdAN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 13:22:54 INFO - PID 15811 | 13:22:54 INFO - PID 15811 | (/builds/slave/test/build/application/firefox/firefox:15861): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 13:22:54 INFO - PID 15811 | 13:23:05 INFO - PID 15811 | RSS: Main: 142381056 13:23:05 INFO - PID 15811 | 13:23:07 INFO - PID 15811 | Cycle 1(1): loaded http://localhost:33855/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33855/tests/kraken/driver.html?testName=audio-beat-detection) 13:23:08 INFO - PID 15811 | RSS: Main: 148496384 13:23:08 INFO - PID 15811 | 13:23:11 INFO - PID 15811 | Cycle 1(1): loaded http://localhost:33855/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33855/tests/kraken/driver.html?testName=audio-dft) 13:23:11 INFO - PID 15811 | RSS: Main: 148656128 13:23:11 INFO - PID 15811 | 13:23:14 INFO - PID 15811 | Cycle 1(1): loaded http://localhost:33855/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33855/tests/kraken/driver.html?testName=audio-fft) 13:23:15 INFO - PID 15811 | RSS: Main: 150482944 13:23:15 INFO - PID 15811 | 13:23:17 INFO - PID 15811 | Cycle 1(1): loaded http://localhost:33855/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33855/tests/kraken/driver.html?testName=audio-oscillator) 13:23:17 INFO - PID 15811 | RSS: Main: 150151168 13:23:17 INFO - PID 15811 | 13:23:19 INFO - PID 15811 | Cycle 1(1): loaded http://localhost:33855/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33855/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:23:20 INFO - PID 15811 | RSS: Main: 149938176 13:23:20 INFO - PID 15811 | 13:23:23 INFO - PID 15811 | Cycle 1(1): loaded http://localhost:33855/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33855/tests/kraken/driver.html?testName=imaging-darkroom) 13:23:24 INFO - PID 15811 | RSS: Main: 150188032 13:23:24 INFO - PID 15811 | 13:23:27 INFO - PID 15811 | Cycle 1(1): loaded http://localhost:33855/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33855/tests/kraken/driver.html?testName=imaging-desaturate) 13:23:28 INFO - PID 15811 | RSS: Main: 151392256 13:23:28 INFO - PID 15811 | 13:23:31 INFO - PID 15811 | Cycle 1(1): loaded http://localhost:33855/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33855/tests/kraken/driver.html?testName=json-parse-financial) 13:23:31 INFO - PID 15811 | RSS: Main: 152383488 13:23:31 INFO - PID 15811 | 13:23:33 INFO - PID 15811 | Cycle 1(1): loaded http://localhost:33855/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33855/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:23:33 INFO - PID 15811 | RSS: Main: 152973312 13:23:33 INFO - PID 15811 | 13:23:35 INFO - PID 15811 | Cycle 1(1): loaded http://localhost:33855/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33855/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:23:35 INFO - PID 15811 | RSS: Main: 152539136 13:23:35 INFO - PID 15811 | 13:23:37 INFO - PID 15811 | Cycle 1(1): loaded http://localhost:33855/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33855/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:23:38 INFO - PID 15811 | RSS: Main: 149458944 13:23:38 INFO - PID 15811 | 13:23:40 INFO - PID 15811 | Cycle 1(1): loaded http://localhost:33855/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33855/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:23:41 INFO - PID 15811 | RSS: Main: 149848064 13:23:41 INFO - PID 15811 | 13:23:44 INFO - PID 15811 | Cycle 1(1): loaded http://localhost:33855/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33855/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:23:44 INFO - PID 15811 | RSS: Main: 150212608 13:23:44 INFO - PID 15811 | 13:23:46 INFO - PID 15811 | Cycle 1(1): loaded http://localhost:33855/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33855/tests/kraken/driver.html?testName=ai-astar) 13:23:46 INFO - PID 15811 | RSS: Main: 151486464 13:23:46 INFO - PID 15811 | 13:23:46 INFO - PID 15811 | __start_tp_report 13:23:46 INFO - PID 15811 | _x_x_mozilla_page_load 13:23:46 INFO - PID 15811 | _x_x_mozilla_page_load_details 13:23:46 INFO - PID 15811 | |i|pagename|runs| 13:23:46 INFO - PID 15811 | |0;ai-astar;106;104;105;105;106;105;93;105;105;106 13:23:46 INFO - PID 15811 | |1;audio-beat-detection;113;111;111;112;110;111;114;111;110;118 13:23:46 INFO - PID 15811 | |2;audio-dft;162;164;163;161;162;161;162;162;161;162 13:23:46 INFO - PID 15811 | |3;audio-fft;74;73;73;72;73;74;76;73;73;74 13:23:46 INFO - PID 15811 | |4;audio-oscillator;78;78;78;77;76;81;77;77;77;77 13:23:46 INFO - PID 15811 | |5;imaging-gaussian-blur;114;113;110;114;114;113;113;114;113;115 13:23:46 INFO - PID 15811 | |6;imaging-darkroom;148;147;147;147;148;148;147;149;149;150 13:23:46 INFO - PID 15811 | |7;imaging-desaturate;94;93;94;94;94;97;94;95;94;93 13:23:46 INFO - PID 15811 | |8;json-parse-financial;43;43;43;46;47;44;44;43;45;45 13:23:46 INFO - PID 15811 | |9;json-stringify-tinderbox;47;47;47;47;48;47;47;47;47;48 13:23:46 INFO - PID 15811 | |10;stanford-crypto-aes;70;69;70;72;69;70;70;69;71;75 13:23:46 INFO - PID 15811 | |11;stanford-crypto-ccm;105;103;104;102;106;104;105;104;99;107 13:23:46 INFO - PID 15811 | |12;stanford-crypto-pbkdf2;154;152;147;150;170;151;155;150;153;152 13:23:46 INFO - PID 15811 | |13;stanford-crypto-sha256-iterative;65;60;58;56;61;60;58;58;57;59 13:23:46 INFO - PID 15811 | __end_tp_report 13:23:46 INFO - PID 15811 | __start_cc_report 13:23:46 INFO - PID 15811 | _x_x_mozilla_cycle_collect,687 13:23:46 INFO - PID 15811 | __end_cc_report 13:23:46 INFO - PID 15811 | __startTimestamp1508271826734__endTimestamp 13:23:46 INFO - PID 15811 | 13:23:46 INFO - PID 15811 | ------- Summary: start ------- 13:23:46 INFO - PID 15811 | Number of tests: 14 13:23:46 INFO - PID 15811 | 13:23:46 INFO - PID 15811 | [#0] ai-astar Cycles:10 Average:104.00 Median:105.50 stddev:3.92 (3.7%) stddev-sans-first:4.09 13:23:46 INFO - PID 15811 | Values: 106.0 104.0 105.0 105.0 106.0 105.0 93.0 105.0 105.0 106.0 13:23:46 INFO - PID 15811 | 13:23:46 INFO - PID 15811 | [#1] audio-beat-detection Cycles:10 Average:112.10 Median:111.50 stddev:2.42 (2.2%) stddev-sans-first:2.55 13:23:46 INFO - PID 15811 | Values: 113.0 111.0 111.0 112.0 110.0 111.0 114.0 111.0 110.0 118.0 13:23:46 INFO - PID 15811 | 13:23:46 INFO - PID 15811 | [#2] audio-dft Cycles:10 Average:162.00 Median:162.00 stddev:0.94 (0.6%) stddev-sans-first:1.00 13:23:46 INFO - PID 15811 | Values: 162.0 164.0 163.0 161.0 162.0 161.0 162.0 162.0 161.0 162.0 13:23:46 INFO - PID 15811 | 13:23:46 INFO - PID 15811 | [#3] audio-fft Cycles:10 Average:73.50 Median:73.50 stddev:1.08 (1.5%) stddev-sans-first:1.13 13:23:46 INFO - PID 15811 | Values: 74.0 73.0 73.0 72.0 73.0 74.0 76.0 73.0 73.0 74.0 13:23:46 INFO - PID 15811 | 13:23:46 INFO - PID 15811 | [#4] audio-oscillator Cycles:10 Average:77.60 Median:77.50 stddev:1.35 (1.7%) stddev-sans-first:1.42 13:23:46 INFO - PID 15811 | Values: 78.0 78.0 78.0 77.0 76.0 81.0 77.0 77.0 77.0 77.0 13:23:46 INFO - PID 15811 | 13:23:46 INFO - PID 15811 | [#5] imaging-gaussian-blur Cycles:10 Average:113.30 Median:114.00 stddev:1.34 (1.2%) stddev-sans-first:1.39 13:23:46 INFO - PID 15811 | Values: 114.0 113.0 110.0 114.0 114.0 113.0 113.0 114.0 113.0 115.0 13:23:46 INFO - PID 15811 | 13:23:46 INFO - PID 15811 | [#6] imaging-darkroom Cycles:10 Average:148.00 Median:148.00 stddev:1.05 (0.7%) stddev-sans-first:1.12 13:23:46 INFO - PID 15811 | Values: 148.0 147.0 147.0 147.0 148.0 148.0 147.0 149.0 149.0 150.0 13:23:46 INFO - PID 15811 | 13:23:46 INFO - PID 15811 | [#7] imaging-desaturate Cycles:10 Average:94.20 Median:94.00 stddev:1.14 (1.2%) stddev-sans-first:1.20 13:23:46 INFO - PID 15811 | Values: 94.0 93.0 94.0 94.0 94.0 97.0 94.0 95.0 94.0 93.0 13:23:46 INFO - PID 15811 | 13:23:46 INFO - PID 15811 | [#8] json-parse-financial Cycles:10 Average:44.30 Median:44.50 stddev:1.42 (3.2%) stddev-sans-first:1.42 13:23:46 INFO - PID 15811 | Values: 43.0 43.0 43.0 46.0 47.0 44.0 44.0 43.0 45.0 45.0 13:23:46 INFO - PID 15811 | 13:23:46 INFO - PID 15811 | [#9] json-stringify-tinderbox Cycles:10 Average:47.20 Median:47.00 stddev:0.42 (0.9%) stddev-sans-first:0.44 13:23:46 INFO - PID 15811 | Values: 47.0 47.0 47.0 47.0 48.0 47.0 47.0 47.0 47.0 48.0 13:23:46 INFO - PID 15811 | 13:23:46 INFO - PID 15811 | [#10] stanford-crypto-aes Cycles:10 Average:70.50 Median:70.00 stddev:1.84 (2.6%) stddev-sans-first:1.94 13:23:46 INFO - PID 15811 | Values: 70.0 69.0 70.0 72.0 69.0 70.0 70.0 69.0 71.0 75.0 13:23:46 INFO - PID 15811 | 13:23:46 INFO - PID 15811 | [#11] stanford-crypto-ccm Cycles:10 Average:103.90 Median:105.00 stddev:2.23 (2.1%) stddev-sans-first:2.33 13:23:46 INFO - PID 15811 | Values: 105.0 103.0 104.0 102.0 106.0 104.0 105.0 104.0 99.0 107.0 13:23:46 INFO - PID 15811 | 13:23:46 INFO - PID 15811 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.40 Median:152.50 stddev:6.26 (4.1%) stddev-sans-first:6.63 13:23:46 INFO - PID 15811 | Values: 154.0 152.0 147.0 150.0 170.0 151.0 155.0 150.0 153.0 152.0 13:23:46 INFO - PID 15811 | 13:23:46 INFO - PID 15811 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:59.20 Median:59.50 stddev:2.53 (4.3%) stddev-sans-first:1.59 13:23:46 INFO - PID 15811 | Values: 65.0 60.0 58.0 56.0 61.0 60.0 58.0 58.0 57.0 59.0 13:23:46 INFO - PID 15811 | -------- Summary: end -------- 13:23:46 INFO - PID 15811 | 13:23:47 INFO - PID 15811 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 13:23:47 INFO - TEST-INFO | 15811: exit 0 13:23:47 INFO - TEST-OK | kraken | took 58457ms 13:23:47 INFO - SUITE-END | took 1165s 13:23:47 INFO - Completed test suite (00:19:25) 13:23:47 INFO - javascript benchmark 13:23:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9414.86596306367, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [4025.7383270087444, 4045.4943132108488, 4048.3320252158396, 4060.7360521566115, 4062.553119156893, 6460.192475940507, 6530.346965303479, 6610.834729131774, 6615.735370585171, 6618.966905165474, 6523.151990241262, 6529.967350163242, 6555.115059466971, 6614.074029635843, 6627.138471998634, 5805.274340707411, 5915.73379197935, 5921.526277897758, 5948.048312270038, 5971.522278217754, 5770.307563092414, 5895.587308888379, 5985.162077309158, 6004.039353703409, 6060.787872424466, 5963.403659634046, 5979.372165922581, 6012.729427175787, 6018.247719035121, 6021.668808215546, 5832.445917637818, 5938.0499120140785, 5939.792107276267, 6020.277566692003, 6032.185654936615, 5694.715264236772, 5778.855528611776, 5785.0, 5806.767729290866, 5905.557083218733, 6461.063145843873, 6468.838279043014, 6472.352764723537, 6488.448481879046, 6535.346465353474, 7065.4700897432895, 7075.0448689426785, 7149.49953503255, 7152.785416437463, 7161.57030578167, 7092.290770922918, 7123.109611298588, 7144.3212894774915, 7217.422606191544, 7228.349448549603, 6616.569922954993, 6670.166229221348, 6698.196216454008, 6702.497312701566, 6709.563878347843, 7211.567305961659, 7309.0, 7310.4517161213125, 7408.62956852166, 7436.219196984347, 6964.547304425196, 7023.613701246379, 7038.225795162528, 7116.964415177891, 7120.786376408716, 7123.287671232835, 7183.0, 7187.712491500386, 7246.239144889816, 7256.6734496947765, 7073.0, 7085.0435191248525, 7158.141023077264, 7164.820879478055, 7172.175199851979, 7028.051213086168, 7069.399101076363, 7078.575285482888, 7093.290670932969, 7184.137903451619, 5179.792808287626, 5231.267622532849, 5234.0840352938085, 5243.449437809051, 5260.579153667774, 4818.156822556109, 4835.178019736653, 4903.877403064952, 4940.7035577865445, 4947.183714687037, 6583.07836902834, 6584.8024559263295, 6588.538802283794, 6668.633225172565, 6671.933280667228, 6905.033295338657, 7025.051618031603, 7088.822779430556, 7165.140183177948, 7176.1388633363285, 6567.146270984741, 6568.408843204134, 6593.076969224312, 6612.305707900698, 6621.9006714899315, 5867.559933005042, 5982.371850955674, 6017.939820601826, 6022.548308876764, 6026.096085587109, 7037.718491260394, 7101.786946391617, 7108.964455177795, 7112.964435177894, 7423.665935032936, 7086.610236436943, 7089.468289878177, 7090.326418990187, 7090.822729431806, 7099.290070993066, 7190.784276471714, 7202.2797720229655, 7206.675699593636, 7212.855742885218, 7330.047093877762, 6973.6164510952385, 6977.755778547727, 7039.6832142552685, 7091.042709234187, 7091.9290807091265, 7204.56772593646, 7222.783316500513, 7225.6387180641805, 7227.602481863548, 7228.168760592389, 6869.896951545631, 6878.896816547655, 6881.071055407456, 6960.582365058112, 6969.0940177776565, 6699.866002680016, 6770.390664840188, 6852.143482064742, 6938.202106757787, 6943.652817359213, 6803.217629972419, 6839.350261725128, 6850.862982740417, 6854.725810967705, 6887.104676392037, 6837.965810170917, 6865.519413641197, 6870.0, 6961.61711105894, 6964.477664175106, 6715.56348837324, 6715.697793599202, 6765.289644587444, 6799.082123913208, 6811.863762724817], "value": 6509.21961580794, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [976.3458482816517, 981.210125848692, 990.5146478225672, 997.9621193958284, 1042.8331466965283, 45276.3208551872, 45726.0, 45780.54219457805, 45968.77015614926, 46289.76855115728, 43855.12289754203, 44017.0, 44237.11525769483, 44281.557184428224, 44417.7779111104, 7091.468139889503, 7105.14738231413, 7112.822179445529, 7113.359797618214, 7117.430605551556, 7798.649060792278, 7856.685732570691, 7865.174156713549, 7865.370770338388, 7885.526868387887, 8641.740747777545, 8866.822663546725, 8871.201591856732, 8873.245774109208, 8880.023197448276, 8741.825163496726, 8793.164649358301, 8808.339374546935, 8812.823743525125, 8818.338624603148, 8451.619677114544, 8466.872996905051, 8521.573921303972, 8571.914280857236, 8576.742697719079, 39545.0, 39715.40426893599, 39951.40072898909, 40006.59993400058, 40164.19671606581, 3809.2000679857265, 3868.5551161616495, 3869.5550011748446, 3869.555001174873, 3871.070942973666, 33133.17167070843, 33271.16822079467, 33711.32577348464, 33892.322153557034, 34118.82940585306, 5550.972245138789, 5560.138178582286, 5592.021396255639, 5616.185653080281, 5662.66024038559, 229459.0, 230512.0, 247726.0, 251725.0, 253553.0, 54249.0, 55021.0, 55069.173962390596, 55074.17388739172, 55087.173692394645, 56273.43726562764, 56404.717976409855, 56605.716971415706, 56671.31636443618, 56808.0, 17357.47927562175, 17389.130543472776, 17397.13014349303, 17490.912545437444, 17496.387626433014, 14538.0, 14581.198034108014, 14585.197814120325, 14596.197209153386, 14600.196989165697, 15668.921655391878, 15684.0, 15818.130002849954, 15841.0, 15875.920620396824, 6123.755049797958, 6130.601510901777, 6147.784827531015, 6229.190205273286, 6272.466840318532, 1084.728817795551, 1084.9349039057681, 1087.244365166202, 1107.4684151607273, 1115.5482029777952, 25744.48511029769, 26207.868960655454, 26239.475210495682, 26402.33994150123, 26566.73433265681, 1206.897413719826, 1236.1347057059913, 1243.1981372015, 1243.8880500754976, 1245.1719606461602, 13814.309284535733, 13918.164910105426, 13983.720325593431, 14086.506972255922, 14284.285785710881, 285638.0, 344754.0, 349853.0, 350272.0, 352456.0, 63660.0, 63665.0, 64370.35629643644, 64471.35528644748, 64510.0, 1543.4212170436087, 1569.5134508302463, 1574.8188958269716, 1588.253520845201, 1590.0, 30375.0, 30684.693153068183, 30713.0, 30755.692443075284, 30892.536611951287, 41933.0, 42213.78893105638, 42356.57643423526, 42380.0, 42409.78795106005, 272356.0, 273612.0, 274653.0, 274662.0, 274947.0, 37644.2471150581, 37692.62307376891, 37707.2458550822, 38068.238635227695, 38117.428238577, 45117.0, 46059.30911036404, 46415.303770444145, 46521.302180467996, 46574.76712616415, 34460.31079378448, 34591.481127783605, 34851.12872178216, 35148.47277290792, 35425.645743542234, 34813.65186348205, 34930.301393972484, 35189.82405087958, 35474.0, 35653.465198021535, 40662.18675626412, 40690.389644155955, 40701.0, 41015.589844101174, 41273.380899285934, 33108.503372449915, 33110.17224569309, 33351.16622084467, 33414.83292583522, 33914.0, 24780.628290575296, 24829.25512234636, 25131.87434062818, 25355.36611584725, 25813.870930645226], "value": 19265.898194160418, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [636.1698322077899, 648.0759935685606, 648.355708831137, 654.2814605314916, 657.6120089147405, 24608.50782984339, 25190.74809251907, 25246.495070098634, 25269.873650631765, 25287.999999999978, 26552.73447265527, 26944.865275673645, 27014.72985270147, 27014.864925675392, 27172.32069198271, 6696.1629796275465, 6738.292479289653, 6745.123133992574, 6839.863202735943, 6853.691583878737, 6784.525083244175, 6908.309169083102, 6919.757808476705, 6933.930660693404, 6938.965305173467, 6748.190217173946, 6910.930890691079, 6918.273581273969, 6923.792286231421, 6965.721371145148, 6986.9999999999745, 6991.685374158175, 7001.929980700204, 7034.085568876013, 7044.682989265495, 6558.081868538361, 6566.343365663443, 6583.440407565363, 6591.11020012297, 6610.8016759497295, 29708.257293567618, 30781.692183078107, 31461.685383146334, 31482.527762083588, 31530.369392612247, 2298.586254474194, 2351.3651314145086, 2352.870592117433, 2353.5528249632684, 2353.776391242829, 20456.590868182553, 20921.895390523103, 20959.0, 21093.578128437497, 21120.471988200265, 2540.9491810163695, 2600.882960266774, 2637.5779875219873, 2642.2997905555044, 2656.5882288245352, 142296.2885185578, 150374.0, 151016.0, 162621.0, 169375.1531242348, 16326.77549183816, 16656.58358541022, 17011.829881701273, 17064.146792660318, 17552.91223543874, 27243.727562724118, 27407.725922740516, 27409.0, 27489.587656185173, 27605.447891042066, 11651.417429128509, 11888.76222475563, 11950.760984780256, 11974.281543107441, 12050.457729402198, 10713.071647103596, 10844.457777111113, 10900.1279897608, 10901.945490272497, 10909.0, 10045.146162576117, 10113.747156321151, 10166.135878450414, 10232.079112879728, 10291.764988201463, 2963.8962636307624, 3100.8139511629374, 3136.702013308732, 3150.952735708966, 3152.4640811062172, 1042.0985847242082, 1055.440616473255, 1062.5484169228203, 1072.1690689715533, 1074.511097450658, 21573.784262157176, 21913.0, 22122.0, 22379.77620223777, 22392.888035560045, 1092.9398883061508, 1125.6566747142201, 1128.949197286124, 1137.806572882612, 1143.8398624192619, 11589.304641721355, 12032.879671203176, 12046.277223366451, 12080.879191207976, 12119.333436660892, 698264.851126716, 707427.0, 725444.0, 726385.0, 734979.0, 129427.0, 129906.35046824705, 130538.34730826285, 133061.0, 136222.3188884069, 1230.249547775856, 1237.2020047069589, 1260.703734622363, 1268.7272236469203, 1274.5539061328645, 19248.518787030436, 19298.13158407903, 19554.511137221114, 19561.413157605293, 19782.901085495057, 61266.693666531384, 62493.0, 63011.0, 63317.36682633115, 65115.348846510926, 75649.24350756643, 76212.0, 76292.0, 76571.61714191393, 77040.2295977033, 15931.12378819176, 16031.759523607388, 16344.346226150821, 16390.918045410173, 16412.0, 24425.38936526601, 24534.0, 24608.876955615106, 24652.260432187064, 24814.25557233286, 19974.10116544788, 20106.095225714584, 20338.0, 20436.489087772923, 20448.69326960067, 17782.644347112728, 18048.09759511993, 18117.909410452863, 18366.724499132255, 18415.53961150982, 18879.811201887806, 19872.403827885188, 20008.099635516144, 20379.898100509403, 20472.897635511727, 15083.54749357521, 15913.681726365176, 15962.201889905225, 16054.598635034217, 16068.598285042968, 19673.508162295486, 19912.800871991094, 20062.09720562549, 20071.59856802885, 20116.497087572927], "value": 13245.889595262532, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1403.1791402029814, 1459.080779109161, 1485.457807900116, 1492.5298530962752, 1497.4758834407958, 18007.63984720305, 18614.34849780258, 18664.066796660147, 18667.81332186678, 18668.719969200454, 18177.182026808794, 18280.908595457036, 18316.81683183168, 18326.541836454096, 18398.632027359447, 3034.5144776835764, 3190.9840450797715, 3192.6647701991305, 3200.167956331359, 3201.5837941067743, 3091.551724999874, 3129.8278594677286, 3166.097662166283, 3171.2230503526553, 3172.381385629803, 3172.1118086935694, 3194.9201269968203, 3217.983910080446, 3221.693939075784, 3225.774195806283, 3079.55346474761, 3097.845107744626, 3108.0, 3112.828794416306, 3129.0, 3019.607451031352, 3117.2830249042845, 3138.6233651961684, 3171.1437911763924, 3183.4906414973493, 17254.13729313542, 17619.207135678924, 17650.382236621655, 17657.911710441495, 17678.646427071515, 9048.230900373475, 9419.0, 9423.293253005984, 9432.858507122399, 9435.198008169315, 5919.467247947706, 5973.342932277446, 6145.754169833202, 6265.404786545271, 6281.0, 2138.492362884163, 2161.297578287063, 2187.157944191498, 2216.822654187661, 2240.932772016842, 32812.343753125046, 33104.66895331064, 33225.6677433225, 33289.16777080544, 33383.33233335344, 7686.308232259012, 7761.72833950809, 7773.144954055049, 8053.275205231557, 8057.838843223103, 20806.375808725763, 20810.0, 20860.89569552173, 20866.165353385997, 20924.686129708065, 8932.687355942511, 9149.222316103205, 9158.496282704382, 9173.89913210419, 9178.118485710413, 8127.83744325122, 8358.623861926228, 8366.79083022917, 8425.07324194338, 8473.0, 6268.341824108403, 6306.590071645328, 6333.429991300805, 6352.7141278642575, 6437.645929473924, 1634.3054201964117, 1680.6806706725683, 1850.287639258895, 1881.040669258688, 1894.9147288372055, 1000.7998400319965, 1004.5529739266102, 1010.8231059564547, 1023.4064242739194, 1044.383813550009, 10209.0, 10347.534360953625, 10402.427866467417, 10555.736106597396, 10567.89432105669, 1088.5482524752297, 1112.0825319111766, 1114.147677027075, 1114.8439218509416, 1118.2060736876747, 5595.524380427628, 5607.691576963306, 5646.6047376684055, 6033.3664965178905, 6242.282137554149, 26264.737352626613, 27039.32401689934, 27191.456170876867, 27277.727222727917, 27294.5905811413, 24905.5018899621, 25921.481570368866, 26171.607425888626, 26373.472530549283, 26443.206703798533, 12442.564510242099, 12565.874341256653, 12641.304728240035, 12655.177413468095, 12685.23888566689, 9453.905460945578, 9491.430514169171, 9511.191548718436, 9538.523073846141, 9573.808523829624, 22038.0, 22097.66853497231, 22472.325830224465, 23079.19222827193, 23451.0, 23569.292921212393, 23616.88191559031, 23658.171963981178, 23831.0, 24386.634200486653, 12959.870401295866, 13196.80204796948, 13208.0, 13222.338883055616, 13225.338733063116, 15962.361505539648, 16049.117298548692, 16217.18914054269, 16431.83568164303, 16550.172491375622, 12679.0, 12686.365681716063, 13101.868981310447, 13216.735665286447, 13377.66555836112, 12588.0, 12606.810897836356, 12617.116801824151, 12713.300768457824, 12959.287239201934, 11647.242929209575, 11808.468618911998, 11868.40657967081, 11986.340751258764, 11994.580189693319, 8059.395545334006, 8294.212049855254, 8356.58217089131, 8382.82046667883, 8449.493030418194, 7875.212478752079, 8093.150219226896, 8152.470089444168, 8175.754727358189, 8181.140980197231], "value": 7814.668697343389, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [589.9587028907976, 602.1629934391196, 613.2671457608154, 617.7220250887101, 633.9397757213065, 6577.57245779024, 6600.669966501674, 6605.86788264235, 6617.536772425932, 6686.13080299561, 6456.451201647854, 6504.967475162617, 6514.719848053179, 6556.868862622757, 6582.0, 5047.49525047496, 5236.581073514109, 5259.500347466985, 5356.143017117262, 5363.9463605364035, 5164.819231326905, 5179.404368497614, 5235.738213089349, 5249.973750131263, 5266.3153790007245, 5210.661307015051, 5216.478352164791, 5233.790648374061, 5236.586121747145, 5241.5806735461265, 5198.636095473318, 5251.369835619712, 5256.579473642099, 5272.103742363807, 5294.867628309323, 4793.472718001017, 4797.880052998668, 4798.760061996886, 4802.855914322541, 4809.278608208761, 6242.1261023456755, 6301.873962520724, 6322.083297921821, 6366.904496432558, 6389.936100638981, 6056.242969628796, 6076.95882238311, 6142.662153581596, 6154.984427569446, 6186.133941248228, 6922.619255940921, 6926.445884329292, 6941.548799328078, 6949.270326615683, 6951.270116637731, 5040.865805193839, 5259.894802103937, 5291.682499050069, 5317.627766056377, 5330.253764472977, 7020.7542736004, 7117.2882711728935, 7190.130566052811, 7219.278072192791, 7224.7110115595315, 5457.426970168154, 5457.781688732485, 5459.372172200168, 5473.698946557977, 5479.698616576126, 5502.257195278667, 5544.417836127149, 5545.445455454423, 5549.223108764776, 5585.162225666101, 6116.327204007555, 6124.418180272867, 6125.571210015256, 6128.63228206309, 6182.845428864314, 7014.789556313319, 7018.543794653331, 7030.3321184487395, 7035.226125126232, 7047.89428158578, 1898.7531620889197, 1917.3481016454473, 1924.2495426783566, 1937.98062019378, 1940.805919408076, 1263.1536870296923, 1349.6153596225029, 1353.7563238617142, 1353.824002879639, 1367.9658008549866, 6316.905246421307, 6364.904526432108, 6368.713407896656, 6379.330170332141, 6468.126802881551, 6766.616691654173, 6775.865602335249, 6897.62063086525, 6940.479464040217, 6952.409045231212, 6363.472766535998, 6398.624295776431, 6418.711157997901, 6457.1282876811965, 6488.805335839932, 3661.1945372018113, 3722.9627703722617, 3723.4414837774552, 3726.2547490501465, 3729.0, 7054.294570542905, 7101.89347159793, 7149.60677162761, 7232.385247254042, 7246.130464344313, 7050.4007159391, 7080.468964827659, 7183.856322873513, 7276.781696549112, 7284.890726639104, 7113.786586402416, 7207.207207207098, 7223.89164162538, 7254.709811607477, 7307.19620841707, 6922.411595014481, 6968.407685346802, 6990.895136573057, 7000.719971201095, 7076.363127318566, 6994.860102797814, 7017.7017251808575, 7036.130128429446, 7066.964665176642, 7074.549717308042, 7258.3104605062435, 7258.491905566771, 7300.890486642811, 7306.086739157606, 7323.48735588525, 5445.618806683494, 5450.645708028966, 5464.125739881759, 5490.176473529003, 5509.393966663744, 6679.561959884704, 6847.417969472651, 7082.583483303257, 7099.840570945879, 7113.715451382094, 6792.490563207681, 6807.115075040213, 6822.931770682229, 6833.384995350442, 6849.657517124224, 6682.797096522479, 6718.395344419026, 6765.086713293839, 6774.254831968381, 6783.152105986752, 6644.900326495203, 6730.192376914802, 6744.494162937701, 6748.628825414453, 6753.662316884234, 6845.281245469154, 6904.689288982108, 6918.861622767416, 6928.0, 6943.236244013256, 6607.339266073354, 6683.7660681875905, 6703.765368212285, 6731.865362692816, 6778.237658208803], "value": 5408.596668145416, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [995.8655581496496, 997.2299168975069, 1015.4262841494555, 1022.6369638778234, 1030.119248042923, 18999.52501187471, 19103.23587056518, 19157.52106197344, 19582.216711331566, 19751.604967900632, 20423.080961356736, 20669.0, 20695.586088278225, 20701.378958631227, 20708.27521036764, 1052.6000119954406, 1074.0923919288189, 1078.8813230544633, 1081.6917178604099, 1082.6210826210802, 1112.6383925224295, 1113.8496302999113, 1116.0736588631457, 1117.972050698731, 1118.2172479264507, 1098.6045023791428, 1135.250734515216, 1143.5025763792735, 1146.524192460128, 1147.8450409194777, 1103.382106020627, 1127.7124333294958, 1129.3844854554206, 1130.5929865248504, 1135.239389608964, 835.8495470815251, 838.6310023589601, 839.5466448118009, 840.3025488844306, 840.9789755256106, 21100.577988440145, 21129.0, 21989.780102199093, 22234.666480002812, 22241.332760017227, 23939.88030059856, 24273.635895461583, 24786.50426991468, 24810.255692329258, 24830.751692483023, 17587.5603109922, 17806.55483612907, 17931.551711207194, 17946.820531794776, 17957.910210448994, 4059.0, 4129.29801933672, 4129.97935010326, 4130.0294430808735, 4130.421740956239, 123317.38341308325, 149405.0, 171889.1405542977, 173357.13321433312, 178303.9999999987, 19468.0, 19630.803691963185, 19767.0, 19780.20879164846, 19798.0, 34944.475832862525, 35702.821485892404, 35765.64234357675, 35880.82059589738, 36195.276094477966, 10115.747106322253, 10183.490825458846, 10212.540435680412, 10215.08064274204, 10221.284510084372, 4698.647601429838, 4716.221823399101, 4744.95255047452, 4764.976175119103, 4791.520847915181, 6165.876682466325, 6241.625502469867, 6258.311585725566, 6280.466160376328, 6281.0, 1298.558490113347, 1331.3476396565613, 1332.7068045030078, 1335.0721248732038, 1359.768839297302, 574.9482546570829, 581.7498475655509, 584.8245526342081, 588.3704436253254, 599.3826358850304, 12727.936360318325, 12771.0, 13178.868211317764, 14581.416743330361, 14641.707165856624, 660.247318057415, 661.2032500836576, 667.8230268978724, 669.3607604737464, 678.8506528563709, 6132.325444201134, 6153.446189842846, 6189.0, 6194.783182588588, 6311.495080393557, 154745.22627387015, 155579.0, 156014.0, 156146.2192689052, 156722.21638891732, 137505.0, 138239.0, 138403.0, 139897.0, 142706.0, 117856.41071794587, 118916.0, 119508.0, 119792.401037996, 120059.0, 11881.287122772661, 11913.702157446132, 12019.879801201876, 12073.698157546132, 12339.07456940715, 59709.0, 59829.102563460714, 59942.700286498286, 59980.0, 60172.09741853963, 75868.0, 76085.61957190179, 76457.0, 76630.2336976623, 79203.60398197972, 15294.311755970786, 15355.155466449452, 15666.451674191349, 15683.1374274416, 15821.208939553206, 16052.277647505656, 16390.75413868769, 16478.917605411898, 16526.83473165253, 16688.0, 16451.67096658084, 16678.416255431002, 16758.413455528997, 16845.66308673844, 16970.236339365005, 15941.202939853192, 15976.600584985468, 16026.599335016717, 16061.357545698042, 16153.75769363437, 16898.66202675915, 17188.742168867728, 17355.0, 17444.47666570005, 17499.912500437415, 11760.58837940668, 12089.455974480994, 12144.939275303566, 12178.878211218129, 12222.266664000188, 11864.060545969955, 11934.940325298317, 11942.522299107939, 12071.57749478764, 12091.57679481214], "value": 9918.9439769677, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1363.2000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 104.0, 105.0, 105.0, 106.0, 105.0, 93.0, 105.0, 105.0, 106.0], "value": 104.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 111.0, 111.0, 112.0, 110.0, 111.0, 114.0, 111.0, 110.0, 118.0], "value": 112.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 164.0, 163.0, 161.0, 162.0, 161.0, 162.0, 162.0, 161.0, 162.0], "value": 162.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 73.0, 72.0, 73.0, 74.0, 76.0, 73.0, 73.0, 74.0], "value": 73.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 78.0, 77.0, 76.0, 81.0, 77.0, 77.0, 77.0, 77.0], "value": 77.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 110.0, 114.0, 114.0, 113.0, 113.0, 114.0, 113.0, 115.0], "value": 113.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 147.0, 147.0, 148.0, 148.0, 147.0, 149.0, 149.0, 150.0], "value": 148.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 94.0, 94.0, 94.0, 97.0, 94.0, 95.0, 94.0, 93.0], "value": 94.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [43.0, 43.0, 43.0, 46.0, 47.0, 44.0, 44.0, 43.0, 45.0, 45.0], "value": 44.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [47.0, 47.0, 47.0, 47.0, 48.0, 47.0, 47.0, 47.0, 47.0, 48.0], "value": 47.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 69.0, 70.0, 72.0, 69.0, 70.0, 70.0, 69.0, 71.0, 75.0], "value": 70.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 103.0, 104.0, 102.0, 106.0, 104.0, 105.0, 104.0, 99.0, 107.0], "value": 103.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 152.0, 147.0, 150.0, 170.0, 151.0, 155.0, 150.0, 153.0, 152.0], "value": 153.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 60.0, 58.0, 56.0, 61.0, 60.0, 58.0, 58.0, 57.0, 59.0], "value": 59.2, "unit": "score"}]}]} 13:23:47 INFO - Return code: 0 13:23:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:23:47 INFO - # TBPL SUCCESS # 13:23:47 INFO - Running post-action listener: _package_coverage_data 13:23:47 INFO - Running post-action listener: _resource_record_post_action 13:23:47 INFO - [mozharness: 2017-10-17 20:23:47.551924Z] Finished run-tests step (success) 13:23:47 INFO - Running post-run listener: _resource_record_post_run 13:23:47 INFO - Total resource usage - Wall time: 1181s; CPU: 13.0%; Read bytes: 8192; Write bytes: 292294656; Read time: 168; Write time: 156532 13:23:47 INFO - TinderboxPrint: CPU usage
13.0% 13:23:47 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 168 13:23:47 INFO - TinderboxPrint: I/O write bytes / time
292,294,656 / 156,532 13:23:47 INFO - TinderboxPrint: CPU idle
8,188.3 (86.9%) 13:23:47 INFO - TinderboxPrint: CPU user
1,180.2 (12.5%) 13:23:47 INFO - TinderboxPrint: Swap in / out
0 / 0 13:23:47 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 9113600; Read time: 0; Write time: 632 13:23:47 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 13:23:47 INFO - run-tests - Wall time: 1166s; CPU: 13.0%; Read bytes: 8192; Write bytes: 283181056; Read time: 168; Write time: 155900 13:23:48 INFO - Running post-run listener: _upload_blobber_files 13:23:48 INFO - Blob upload gear active. 13:23:48 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:23:48 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 13:23:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:23:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:23:48 INFO - (blobuploader) - INFO - Open directory for files ... 13:23:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 13:23:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:23:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:23:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 13:23:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:23:49 INFO - (blobuploader) - INFO - Done attempting. 13:23:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 13:23:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:23:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:23:50 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 13:23:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:23:50 INFO - (blobuploader) - INFO - Done attempting. 13:23:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:23:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:23:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:23:57 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:23:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:23:57 INFO - (blobuploader) - INFO - Done attempting. 13:23:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 13:23:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:23:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:23:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 13:23:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:23:58 INFO - (blobuploader) - INFO - Done attempting. 13:23:58 INFO - (blobuploader) - INFO - Iteration through files over. 13:23:58 INFO - Return code: 0 13:23:58 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:23:58 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:23:58 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/1e690c050f508fb01c694e18d0eaa3ee32f3cba93c8c91008228198744bd214cc98c103bccd232a0c1e39f7be8a908760d7220bd4cead037a67098e5faee77e3", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/a36550bca2969b905155de72b007fa9fdfb9f76f90e293bd8a6aa221a835a86f0a33d7337535f09b14b0fa11b845576dded4d361bf75d815ffa5ee8a19b0fbfb", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/60bd2fe6d314ced63d5998dab90845cd019a4fff9cb2b80941beb901e8bc48b2db1cb10233957c6cd8343f364f0a041560abe6e7d2082183a07740c7a8a9498f", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/e646ba5bef6e79b9e507934355400a5977ee5638b8352c9e8d1dca85fc77ed0fabaa20e98424332606e568efcf4f8a64bea29d91bd877277457a0319e8f10595"} 13:23:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:23:58 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:23:58 INFO - Contents: 13:23:58 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/1e690c050f508fb01c694e18d0eaa3ee32f3cba93c8c91008228198744bd214cc98c103bccd232a0c1e39f7be8a908760d7220bd4cead037a67098e5faee77e3", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/a36550bca2969b905155de72b007fa9fdfb9f76f90e293bd8a6aa221a835a86f0a33d7337535f09b14b0fa11b845576dded4d361bf75d815ffa5ee8a19b0fbfb", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/60bd2fe6d314ced63d5998dab90845cd019a4fff9cb2b80941beb901e8bc48b2db1cb10233957c6cd8343f364f0a041560abe6e7d2082183a07740c7a8a9498f", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/e646ba5bef6e79b9e507934355400a5977ee5638b8352c9e8d1dca85fc77ed0fabaa20e98424332606e568efcf4f8a64bea29d91bd877277457a0319e8f10595"} 13:23:58 INFO - Running post-run listener: copy_logs_to_upload_dir 13:23:58 INFO - Copying logs to upload dir... 13:23:58 INFO - mkdir: /builds/slave/test/build/upload/logs 13:23:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.072251 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2017-10-17 13:23:58.618498) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-10-17 13:23:58.624249) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1508270599.140807-792501720 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/1e690c050f508fb01c694e18d0eaa3ee32f3cba93c8c91008228198744bd214cc98c103bccd232a0c1e39f7be8a908760d7220bd4cead037a67098e5faee77e3", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/a36550bca2969b905155de72b007fa9fdfb9f76f90e293bd8a6aa221a835a86f0a33d7337535f09b14b0fa11b845576dded4d361bf75d815ffa5ee8a19b0fbfb", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/60bd2fe6d314ced63d5998dab90845cd019a4fff9cb2b80941beb901e8bc48b2db1cb10233957c6cd8343f364f0a041560abe6e7d2082183a07740c7a8a9498f", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/e646ba5bef6e79b9e507934355400a5977ee5638b8352c9e8d1dca85fc77ed0fabaa20e98424332606e568efcf4f8a64bea29d91bd877277457a0319e8f10595"} build_url:https://queue.taskcluster.net/v1/task/TsKy8kW3TauOSSW5GzkoQw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011320 build_url: 'https://queue.taskcluster.net/v1/task/TsKy8kW3TauOSSW5GzkoQw/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/1e690c050f508fb01c694e18d0eaa3ee32f3cba93c8c91008228198744bd214cc98c103bccd232a0c1e39f7be8a908760d7220bd4cead037a67098e5faee77e3", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/a36550bca2969b905155de72b007fa9fdfb9f76f90e293bd8a6aa221a835a86f0a33d7337535f09b14b0fa11b845576dded4d361bf75d815ffa5ee8a19b0fbfb", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/60bd2fe6d314ced63d5998dab90845cd019a4fff9cb2b80941beb901e8bc48b2db1cb10233957c6cd8343f364f0a041560abe6e7d2082183a07740c7a8a9498f", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/e646ba5bef6e79b9e507934355400a5977ee5638b8352c9e8d1dca85fc77ed0fabaa20e98424332606e568efcf4f8a64bea29d91bd877277457a0319e8f10595"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-10-17 13:23:58.656672) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-10-17 13:23:58.657005) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1508270599.140807-792501720 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.005040 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-10-17 13:23:58.738663) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-10-17 13:23:58.741005) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-10-17 13:23:58.741344) ========= ========= Total master_lag: 0.21 =========