builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-025 starttime: 1504086925.18 results: success (0) revision: ab2d700fda2b4934d24227216972dce9fac19b74 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-30 02:55:25.183710) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-30 02:55:25.184254) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-30 02:55:25.184552) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-30 02:55:25.288338) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-30 02:55:25.288633) ========= 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=232498196343f89f466a4a9a000001c8-1504084647.695205-1194294257 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-30 02:55:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 28.9M=0s 2017-08-30 02:55:25 (28.9 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.094327 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-30 02:55:25.431764) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-30 02:55:25.432170) ========= 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=232498196343f89f466a4a9a000001c8-1504084647.695205-1194294257 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.024227 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-30 02:55:25.494492) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-30 02:55:25.494929) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev ab2d700fda2b4934d24227216972dce9fac19b74 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev ab2d700fda2b4934d24227216972dce9fac19b74 --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=232498196343f89f466a4a9a000001c8-1504084647.695205-1194294257 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-30 02:55:25,544 truncating revision to first 12 chars 2017-08-30 02:55:25,544 Setting DEBUG logging. 2017-08-30 02:55:25,544 attempt 1/10 2017-08-30 02:55:25,544 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/ab2d700fda2b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-30 02:55:26,564 unpacking tar archive at: mozilla-central-ab2d700fda2b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.343445 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-30 02:55:26.859381) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-30 02:55:26.859816) ========= script_repo_revision: ab2d700fda2b4934d24227216972dce9fac19b74 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-30 02:55:26.860258) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-30 02:55:26.860540) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-30 02:55:26.903744) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2017-08-30 02:55:26.904194) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=232498196343f89f466a4a9a000001c8-1504084647.695205-1194294257 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:55:27 INFO - MultiFileLogger online at 20170830 02:55:27 in /builds/slave/test 02:55:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 02:55:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:55:27 INFO - {'append_to_log': False, 02:55:27 INFO - 'base_work_dir': '/builds/slave/test', 02:55:27 INFO - 'blob_upload_branch': 'Firefox', 02:55:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:55:27 INFO - 'branch': 'Firefox', 02:55:27 INFO - 'buildbot_json_path': 'buildprops.json', 02:55:27 INFO - 'code_coverage': False, 02:55:27 INFO - 'config_files': ('talos/linux_config.py',), 02:55:27 INFO - 'default_actions': ('clobber', 02:55:27 INFO - 'read-buildbot-config', 02:55:27 INFO - 'download-and-extract', 02:55:27 INFO - 'populate-webroot', 02:55:27 INFO - 'create-virtualenv', 02:55:27 INFO - 'install', 02:55:27 INFO - 'setup-mitmproxy', 02:55:27 INFO - 'run-tests'), 02:55:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:55:27 INFO - 'disable_ccov_upload': False, 02:55:27 INFO - 'disable_stylo': False, 02:55:27 INFO - 'download_minidump_stackwalk': True, 02:55:27 INFO - 'download_symbols': 'ondemand', 02:55:27 INFO - 'enable_stylo': False, 02:55:27 INFO - 'enable_webrender': False, 02:55:27 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 02:55:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:55:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:55:27 INFO - 'gecko_profile': False, 02:55:27 INFO - 'gecko_profile_interval': 0, 02:55:27 INFO - 'installer_path': 'installer.exe', 02:55:27 INFO - 'log_level': 'info', 02:55:27 INFO - 'log_name': 'talos', 02:55:27 INFO - 'log_to_console': True, 02:55:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:55:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:55:27 INFO - 'opt_config_files': (), 02:55:27 INFO - 'pip_index': False, 02:55:27 INFO - 'suite': 'dromaeojs-e10s', 02:55:27 INFO - 'system_bits': '32', 02:55:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:55:27 INFO - 'title': 'talos-linux64-ix-025', 02:55:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:55:27 INFO - 'use_talos_json': True, 02:55:27 INFO - 'verify': 'False', 02:55:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:55:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:55:27 INFO - 'work_dir': 'build'} 02:55:27 INFO - [mozharness: 2017-08-30 09:55:27.090077Z] Running clobber step. 02:55:27 INFO - Running pre-action listener: _resource_record_pre_action 02:55:27 INFO - Running main action method: clobber 02:55:27 INFO - rmtree: /builds/slave/test/build 02:55:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:55:28 INFO - Running post-action listener: _resource_record_post_action 02:55:28 INFO - [mozharness: 2017-08-30 09:55:28.110388Z] Finished clobber step (success) 02:55:28 INFO - [mozharness: 2017-08-30 09:55:28.110485Z] Running read-buildbot-config step. 02:55:28 INFO - Running pre-action listener: _resource_record_pre_action 02:55:28 INFO - Running main action method: read_buildbot_config 02:55:28 INFO - Using buildbot properties: 02:55:28 INFO - { 02:55:28 INFO - "project": "", 02:55:28 INFO - "product": "firefox", 02:55:28 INFO - "who": "archaeopteryx@coole-files.de", 02:55:28 INFO - "installer_path": "public/build/target.tar.bz2", 02:55:28 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 02:55:28 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 02:55:28 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 02:55:28 INFO - "stage_platform": "linux64-stylosequential", 02:55:28 INFO - "basedir": "/builds/slave/test", 02:55:28 INFO - "buildnumber": 179, 02:55:28 INFO - "platform": "ubuntu64_hw_styloseq", 02:55:28 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 02:55:28 INFO - "slavebuilddir": "test", 02:55:28 INFO - "taskId": "aW6YcxsiTvqVGtWHRPMJoQ", 02:55:28 INFO - "branch": "mozilla-central", 02:55:28 INFO - "script_repo_revision": "production", 02:55:28 INFO - "revision": "ab2d700fda2b4934d24227216972dce9fac19b74", 02:55:28 INFO - "slavename": "talos-linux64-ix-025", 02:55:28 INFO - "repo_path": "mozilla-central" 02:55:28 INFO - } 02:55:28 INFO - Finding installer, test and symbols from parent task. 02:55:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aW6YcxsiTvqVGtWHRPMJoQ'}, attempt #1 02:55:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aW6YcxsiTvqVGtWHRPMJoQ'}, attempt #1 02:55:29 INFO - Task dependencies: eSP-W7eQTHm081zyISUr-A 02:55:29 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eSP-W7eQTHm081zyISUr-A'}, attempt #1 02:55:29 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/eSP-W7eQTHm081zyISUr-A/artifacts/public/build/target.tar.bz2 02:55:29 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/eSP-W7eQTHm081zyISUr-A/artifacts/public/build/target.test_packages.json 02:55:29 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/eSP-W7eQTHm081zyISUr-A/artifacts/public/build/target.crashreporter-symbols.zip 02:55:29 INFO - Running post-action listener: _resource_record_post_action 02:55:29 INFO - [mozharness: 2017-08-30 09:55:29.448185Z] Finished read-buildbot-config step (success) 02:55:29 INFO - [mozharness: 2017-08-30 09:55:29.448404Z] Running download-and-extract step. 02:55:29 INFO - Running pre-action listener: _resource_record_pre_action 02:55:29 INFO - Running main action method: download_and_extract 02:55:29 INFO - mkdir: /builds/slave/test/build/tests 02:55:29 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')]} 02:55:29 INFO - trying https://queue.taskcluster.net/v1/task/eSP-W7eQTHm081zyISUr-A/artifacts/public/build/target.test_packages.json 02:55:29 INFO - Downloading https://queue.taskcluster.net/v1/task/eSP-W7eQTHm081zyISUr-A/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 02:55:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eSP-W7eQTHm081zyISUr-A/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 02:55:30 INFO - Downloaded 989 bytes. 02:55:30 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 02:55:30 INFO - Using the following test package requirements: 02:55:30 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 02:55:30 INFO - u'common': [u'target.common.tests.zip'], 02:55:30 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 02:55:30 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 02:55:30 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 02:55:30 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 02:55:30 INFO - u'mozbase': [u'target.common.tests.zip'], 02:55:30 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 02:55:30 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 02:55:30 INFO - u'web-platform': [u'target.common.tests.zip', 02:55:30 INFO - u'target.web-platform.tests.tar.gz'], 02:55:30 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 02:55:30 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 02:55:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eSP-W7eQTHm081zyISUr-A/artifacts/public/build/target.common.tests.zip 02:55:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eSP-W7eQTHm081zyISUr-A/artifacts/public/build/target.common.tests.zip'}, attempt #1 02:55:30 INFO - Fetch https://queue.taskcluster.net/v1/task/eSP-W7eQTHm081zyISUr-A/artifacts/public/build/target.common.tests.zip into memory 02:55:31 INFO - Content-Length response header: 54962578 02:55:31 INFO - Bytes received: 54962578 02:55:42 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 02:55:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eSP-W7eQTHm081zyISUr-A/artifacts/public/build/target.common.tests.zip 02:55:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eSP-W7eQTHm081zyISUr-A/artifacts/public/build/target.common.tests.zip'}, attempt #1 02:55:42 INFO - Fetch https://queue.taskcluster.net/v1/task/eSP-W7eQTHm081zyISUr-A/artifacts/public/build/target.common.tests.zip into memory 02:55:43 INFO - Content-Length response header: 54962578 02:55:43 INFO - Bytes received: 54962578 02:55:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eSP-W7eQTHm081zyISUr-A/artifacts/public/build/target.talos.tests.zip 02:55:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eSP-W7eQTHm081zyISUr-A/artifacts/public/build/target.talos.tests.zip'}, attempt #1 02:55:55 INFO - Fetch https://queue.taskcluster.net/v1/task/eSP-W7eQTHm081zyISUr-A/artifacts/public/build/target.talos.tests.zip into memory 02:55:56 INFO - Content-Length response header: 14496650 02:55:56 INFO - Bytes received: 14496650 02:55:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:55:56 INFO - trying https://queue.taskcluster.net/v1/task/eSP-W7eQTHm081zyISUr-A/artifacts/public/build/target.tar.bz2 02:55:56 INFO - Downloading https://queue.taskcluster.net/v1/task/eSP-W7eQTHm081zyISUr-A/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 02:55:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eSP-W7eQTHm081zyISUr-A/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 02:55:58 INFO - Downloaded 62596709 bytes. 02:55:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eSP-W7eQTHm081zyISUr-A/artifacts/public/build/target.tar.bz2 02:55:58 INFO - mkdir: /builds/slave/test/properties 02:55:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:55:58 INFO - Writing to file /builds/slave/test/properties/build_url 02:55:58 INFO - Contents: 02:55:58 INFO - build_url:https://queue.taskcluster.net/v1/task/eSP-W7eQTHm081zyISUr-A/artifacts/public/build/target.tar.bz2 02:55:58 INFO - Running post-action listener: _resource_record_post_action 02:55:58 INFO - Running post-action listener: find_tests_for_verification 02:55:58 INFO - Running post-action listener: set_extra_try_arguments 02:55:58 INFO - [mozharness: 2017-08-30 09:55:58.008938Z] Finished download-and-extract step (success) 02:55:58 INFO - [mozharness: 2017-08-30 09:55:58.009128Z] Running populate-webroot step. 02:55:58 INFO - Running pre-action listener: _resource_record_pre_action 02:55:58 INFO - Running main action method: populate_webroot 02:55:58 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:55:58 INFO - 'chromez-stylo-e10s': {'talos_options': ['--enable-stylo'], 02:55:58 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:55:58 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:55:58 INFO - 'dromaeojs-stylo-e10s': {'talos_options': ['--enable-stylo'], 02:55:58 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:55:58 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 02:55:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:55:58 INFO - 'g1-stylo-e10s': {'pagesets_name': 'tp5n.zip', 02:55:58 INFO - 'talos_options': ['--enable-stylo'], 02:55:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:55:58 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 02:55:58 INFO - 'tests': ['damp', 'tps']}, 02:55:58 INFO - 'g2-stylo-e10s': {'pagesets_name': 'tp5n.zip', 02:55:58 INFO - 'talos_options': ['--enable-stylo'], 02:55:58 INFO - 'tests': ['damp', 'tps']}, 02:55:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:55:58 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 02:55:58 INFO - 'g4-stylo-e10s': {'talos_options': ['--enable-stylo'], 02:55:58 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 02:55:58 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 02:55:58 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 02:55:58 INFO - 'g5-stylo-e10s': {'pagesets_name': 'tp5n.zip', 02:55:58 INFO - 'talos_options': ['--enable-stylo'], 02:55:58 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 02:55:58 INFO - 'other-e10s': {'tests': ['a11yr', 02:55:58 INFO - 'ts_paint', 02:55:58 INFO - 'tpaint', 02:55:58 INFO - 'sessionrestore', 02:55:58 INFO - 'sessionrestore_many_windows', 02:55:58 INFO - 'sessionrestore_no_auto_restore', 02:55:58 INFO - 'tabpaint']}, 02:55:58 INFO - 'other-stylo-e10s': {'talos_options': ['--enable-stylo'], 02:55:58 INFO - 'tests': ['a11yr', 02:55:58 INFO - 'ts_paint', 02:55:58 INFO - 'tpaint', 02:55:58 INFO - 'sessionrestore', 02:55:58 INFO - 'sessionrestore_many_windows', 02:55:58 INFO - 'sessionrestore_no_auto_restore', 02:55:58 INFO - 'tabpaint']}, 02:55:58 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 02:55:58 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 02:55:58 INFO - 'perf-reftest-singletons-stylo-e10s': {'talos_options': ['--enable-stylo'], 02:55:58 INFO - 'tests': ['bloom_basic_singleton']}, 02:55:58 INFO - 'perf-reftest-stylo-e10s': {'talos_options': ['--enable-stylo'], 02:55:58 INFO - 'tests': ['bloom_basic']}, 02:55:58 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:55:58 INFO - 'tsvgr_opacity', 02:55:58 INFO - 'tart', 02:55:58 INFO - 'tscrollx', 02:55:58 INFO - 'tsvg_static']}, 02:55:58 INFO - 'svgr-stylo-e10s': {'talos_options': ['--enable-stylo'], 02:55:58 INFO - 'tests': ['tsvgx', 02:55:58 INFO - 'tsvgr_opacity', 02:55:58 INFO - 'tart', 02:55:58 INFO - 'tscrollx', 02:55:58 INFO - 'tsvg_static']}, 02:55:58 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 02:55:58 INFO - 'tp5o-stylo-e10s': {'pagesets_name': 'tp5n.zip', 02:55:58 INFO - 'talos_options': ['--enable-stylo'], 02:55:58 INFO - 'tests': ['tp5o']}, 02:55:58 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 02:55:58 INFO - 'talos_options': ['--mitmproxy', 02:55:58 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 02:55:58 INFO - '--firstNonBlankPaint'], 02:55:58 INFO - 'tests': ['tp6_google', 02:55:58 INFO - 'tp6_youtube', 02:55:58 INFO - 'tp6_amazon', 02:55:58 INFO - 'tp6_facebook']}, 02:55:58 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 02:55:58 INFO - 'talos_options': ['--enable-stylo', 02:55:58 INFO - '--mitmproxy', 02:55:58 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 02:55:58 INFO - '--firstNonBlankPaint'], 02:55:58 INFO - 'tests': ['tp6_google', 02:55:58 INFO - 'tp6_youtube', 02:55:58 INFO - 'tp6_amazon', 02:55:58 INFO - 'tp6_facebook']}, 02:55:58 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 02:55:58 INFO - 'talos_options': ['--enable-stylo', 02:55:58 INFO - '--stylo-threads=1', 02:55:58 INFO - '--mitmproxy', 02:55:58 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 02:55:58 INFO - '--firstNonBlankPaint'], 02:55:58 INFO - 'tests': ['tp6_google', 02:55:58 INFO - 'tp6_youtube', 02:55:58 INFO - 'tp6_amazon', 02:55:58 INFO - 'tp6_facebook']}, 02:55:58 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 02:55:58 INFO - 'talos_options': ['--xperf_path', 02:55:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:55:58 INFO - 'tests': ['tp5n']}, 02:55:58 INFO - 'xperf-stylo-e10s': {'pagesets_name': 'tp5n.zip', 02:55:58 INFO - 'talos_options': ['--enable-stylo', 02:55:58 INFO - '--xperf_path', 02:55:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:55:58 INFO - 'tests': ['tp5n']}}} 02:55:58 INFO - Running post-action listener: _resource_record_post_action 02:55:58 INFO - [mozharness: 2017-08-30 09:55:58.028770Z] Finished populate-webroot step (success) 02:55:58 INFO - [mozharness: 2017-08-30 09:55:58.028860Z] Running create-virtualenv step. 02:55:58 INFO - Running pre-action listener: _resource_record_pre_action 02:55:58 INFO - Running main action method: create_virtualenv 02:55:58 INFO - Creating virtualenv /builds/slave/test/build/venv 02:55:58 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 02:55:58 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 02:55:58 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 02:55:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:55:58 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:55:58 INFO - Installing distribute.............................................................................................................................................................................................done. 02:55:58 INFO - Installing pip...............done. 02:55:58 INFO - Return code: 0 02:55:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:55:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:55:59 INFO - Reading from file tmpfile_stdout 02:55:59 INFO - Output received: 02:55:59 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 02:55:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:55:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:55:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:55:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:55:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:55:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xce01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xea8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104fb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c580>, '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 0x104d480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104d910>, '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': '232498196343f89f466a4a9a000001c8-1504084647.695205-1194294257', '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 02:55:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:55:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:55:59 INFO - Using env: {'DISPLAY': ':0', 02:55:59 INFO - 'HOME': '/home/cltbld', 02:55:59 INFO - 'LANG': 'en_US.UTF-8', 02:55:59 INFO - 'LANGUAGE': 'en_US:en', 02:55:59 INFO - 'LOGNAME': 'cltbld', 02:55:59 INFO - 'MAIL': '/var/mail/cltbld', 02:55:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:55:59 INFO - 'MOZ_NO_REMOTE': '1', 02:55:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:55:59 INFO - 'NO_EM_RESTART': '1', 02:55:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:55:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:55:59 INFO - 'PWD': '/builds/slave/test', 02:55:59 INFO - 'SHELL': '/bin/bash', 02:55:59 INFO - 'SHLVL': '1', 02:55:59 INFO - 'TERM': 'linux', 02:55:59 INFO - 'TMOUT': '86400', 02:55:59 INFO - 'USER': 'cltbld', 02:55:59 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1504084647.695205-1194294257', 02:55:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:55:59 INFO - '_': '/tools/buildbot/bin/python'} 02:56:00 INFO - Ignoring indexes: http://pypi.python.org/simple/ 02:56:00 INFO - Downloading/unpacking pip>=1.5 02:56:00 INFO - Running setup.py egg_info for package pip 02:56:00 INFO - warning: no files found matching 'pip/cacert.pem' 02:56:00 INFO - warning: no files found matching '*.html' under directory 'docs' 02:56:00 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 02:56:00 INFO - no previously-included directories found matching 'docs/_build/_sources' 02:56:00 INFO - Installing collected packages: pip 02:56:00 INFO - Found existing installation: pip 1.1 02:56:00 INFO - Uninstalling pip: 02:56:00 INFO - Successfully uninstalled pip 02:56:00 INFO - Running setup.py install for pip 02:56:00 INFO - warning: no files found matching 'pip/cacert.pem' 02:56:00 INFO - warning: no files found matching '*.html' under directory 'docs' 02:56:00 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 02:56:00 INFO - no previously-included directories found matching 'docs/_build/_sources' 02:56:00 INFO - Installing pip script to /builds/slave/test/build/venv/bin 02:56:00 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 02:56:00 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 02:56:00 INFO - Successfully installed pip 02:56:00 INFO - Cleaning up... 02:56:00 INFO - Return code: 0 02:56:00 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:56: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')]} 02:56:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:56: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')]} 02:56:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:56:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xce01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xea8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104fb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c580>, '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 0x104d480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104d910>, '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': '232498196343f89f466a4a9a000001c8-1504084647.695205-1194294257', '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 02:56:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 02:56:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 02:56:00 INFO - Using env: {'DISPLAY': ':0', 02:56:00 INFO - 'HOME': '/home/cltbld', 02:56:00 INFO - 'LANG': 'en_US.UTF-8', 02:56:00 INFO - 'LANGUAGE': 'en_US:en', 02:56:00 INFO - 'LOGNAME': 'cltbld', 02:56:00 INFO - 'MAIL': '/var/mail/cltbld', 02:56:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:56:00 INFO - 'MOZ_NO_REMOTE': '1', 02:56:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:56:00 INFO - 'NO_EM_RESTART': '1', 02:56:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:56:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:56:00 INFO - 'PWD': '/builds/slave/test', 02:56:00 INFO - 'SHELL': '/bin/bash', 02:56:00 INFO - 'SHLVL': '1', 02:56:00 INFO - 'TERM': 'linux', 02:56:00 INFO - 'TMOUT': '86400', 02:56:00 INFO - 'USER': 'cltbld', 02:56:00 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1504084647.695205-1194294257', 02:56:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:56:00 INFO - '_': '/tools/buildbot/bin/python'} 02:56:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:56:00 INFO - Downloading/unpacking psutil>=3.1.1 02:56:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:56:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:56:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:56:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:56:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:56:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:56:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:56:01 INFO - Installing collected packages: psutil 02:56:01 INFO - Running setup.py install for psutil 02:56:01 INFO - building 'psutil._psutil_linux' extension 02:56:01 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 02:56:01 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 02:56:01 INFO - building 'psutil._psutil_posix' extension 02:56:01 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 02:56:02 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 02:56:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:56:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:56:02 INFO - Successfully installed psutil 02:56:02 INFO - Cleaning up... 02:56:02 INFO - Return code: 0 02:56:02 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:56:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:56:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:56:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:56:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:56:02 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 0xce01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xea8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104fb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c580>, '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 0x104d480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104d910>, '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': '232498196343f89f466a4a9a000001c8-1504084647.695205-1194294257', '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 02:56:02 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 02:56:02 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 02:56:02 INFO - Using env: {'DISPLAY': ':0', 02:56:02 INFO - 'HOME': '/home/cltbld', 02:56:02 INFO - 'LANG': 'en_US.UTF-8', 02:56:02 INFO - 'LANGUAGE': 'en_US:en', 02:56:02 INFO - 'LOGNAME': 'cltbld', 02:56:02 INFO - 'MAIL': '/var/mail/cltbld', 02:56:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:56:02 INFO - 'MOZ_NO_REMOTE': '1', 02:56:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:56:02 INFO - 'NO_EM_RESTART': '1', 02:56:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:56:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:56:02 INFO - 'PWD': '/builds/slave/test', 02:56:02 INFO - 'SHELL': '/bin/bash', 02:56:02 INFO - 'SHLVL': '1', 02:56:02 INFO - 'TERM': 'linux', 02:56:02 INFO - 'TMOUT': '86400', 02:56:02 INFO - 'USER': 'cltbld', 02:56:02 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1504084647.695205-1194294257', 02:56:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:56:02 INFO - '_': '/tools/buildbot/bin/python'} 02:56:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:56:02 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:56: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 02:56: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 02:56: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 02:56: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 02:56:03 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:56:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:56:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:56:03 INFO - Installing collected packages: mozsystemmonitor 02:56:03 INFO - Running setup.py install for mozsystemmonitor 02:56:03 INFO - Successfully installed mozsystemmonitor 02:56:03 INFO - Cleaning up... 02:56:03 INFO - Return code: 0 02:56:03 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:56: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')]} 02:56:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:56: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')]} 02:56:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:56:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xce01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xea8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104fb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c580>, '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 0x104d480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104d910>, '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': '232498196343f89f466a4a9a000001c8-1504084647.695205-1194294257', '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 02:56:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 02:56:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 02:56:03 INFO - Using env: {'DISPLAY': ':0', 02:56:03 INFO - 'HOME': '/home/cltbld', 02:56:03 INFO - 'LANG': 'en_US.UTF-8', 02:56:03 INFO - 'LANGUAGE': 'en_US:en', 02:56:03 INFO - 'LOGNAME': 'cltbld', 02:56:03 INFO - 'MAIL': '/var/mail/cltbld', 02:56:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:56:03 INFO - 'MOZ_NO_REMOTE': '1', 02:56:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:56:03 INFO - 'NO_EM_RESTART': '1', 02:56:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:56:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:56:03 INFO - 'PWD': '/builds/slave/test', 02:56:03 INFO - 'SHELL': '/bin/bash', 02:56:03 INFO - 'SHLVL': '1', 02:56:03 INFO - 'TERM': 'linux', 02:56:03 INFO - 'TMOUT': '86400', 02:56:03 INFO - 'USER': 'cltbld', 02:56:03 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1504084647.695205-1194294257', 02:56:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:56:03 INFO - '_': '/tools/buildbot/bin/python'} 02:56:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:56:03 INFO - Downloading/unpacking jsonschema==2.5.1 02:56: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 02:56: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 02:56: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 02:56: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 02:56:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:56:04 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:56:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:56:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:56:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:56:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:56:05 INFO - Downloading functools32-3.2.3-2.tar.gz 02:56:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:56:05 INFO - warning: no files found matching '*.txt' 02:56:05 INFO - no previously-included directories found matching 'build' 02:56:05 INFO - no previously-included directories found matching 'dist' 02:56:05 INFO - no previously-included directories found matching '.git*' 02:56:05 INFO - Installing collected packages: jsonschema, functools32 02:56:05 INFO - Running setup.py install for functools32 02:56:05 INFO - warning: no files found matching '*.txt' 02:56:05 INFO - no previously-included directories found matching 'build' 02:56:05 INFO - no previously-included directories found matching 'dist' 02:56:05 INFO - no previously-included directories found matching '.git*' 02:56:05 INFO - Successfully installed jsonschema functools32 02:56:05 INFO - Cleaning up... 02:56:05 INFO - Return code: 0 02:56:05 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:56:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:56:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:56:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:56:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:56:05 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 0xce01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xea8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104fb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c580>, '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 0x104d480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104d910>, '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': '232498196343f89f466a4a9a000001c8-1504084647.695205-1194294257', '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 02:56:05 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 02:56:05 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 02:56:05 INFO - Using env: {'DISPLAY': ':0', 02:56:05 INFO - 'HOME': '/home/cltbld', 02:56:05 INFO - 'LANG': 'en_US.UTF-8', 02:56:05 INFO - 'LANGUAGE': 'en_US:en', 02:56:05 INFO - 'LOGNAME': 'cltbld', 02:56:05 INFO - 'MAIL': '/var/mail/cltbld', 02:56:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:56:05 INFO - 'MOZ_NO_REMOTE': '1', 02:56:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:56:05 INFO - 'NO_EM_RESTART': '1', 02:56:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:56:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:56:05 INFO - 'PWD': '/builds/slave/test', 02:56:05 INFO - 'SHELL': '/bin/bash', 02:56:05 INFO - 'SHLVL': '1', 02:56:05 INFO - 'TERM': 'linux', 02:56:05 INFO - 'TMOUT': '86400', 02:56:05 INFO - 'USER': 'cltbld', 02:56:05 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1504084647.695205-1194294257', 02:56:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:56:05 INFO - '_': '/tools/buildbot/bin/python'} 02:56:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:56:05 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:56:05 INFO - Cleaning up... 02:56:05 INFO - Return code: 0 02:56:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:56:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:56:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:56:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:56:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:56:05 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 0xce01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xea8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104fb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c580>, '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 0x104d480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104d910>, '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': '232498196343f89f466a4a9a000001c8-1504084647.695205-1194294257', '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 02:56:05 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 02:56:05 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 02:56:05 INFO - Using env: {'DISPLAY': ':0', 02:56:05 INFO - 'HOME': '/home/cltbld', 02:56:05 INFO - 'LANG': 'en_US.UTF-8', 02:56:05 INFO - 'LANGUAGE': 'en_US:en', 02:56:05 INFO - 'LOGNAME': 'cltbld', 02:56:05 INFO - 'MAIL': '/var/mail/cltbld', 02:56:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:56:05 INFO - 'MOZ_NO_REMOTE': '1', 02:56:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:56:05 INFO - 'NO_EM_RESTART': '1', 02:56:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:56:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:56:05 INFO - 'PWD': '/builds/slave/test', 02:56:05 INFO - 'SHELL': '/bin/bash', 02:56:05 INFO - 'SHLVL': '1', 02:56:05 INFO - 'TERM': 'linux', 02:56:05 INFO - 'TMOUT': '86400', 02:56:05 INFO - 'USER': 'cltbld', 02:56:05 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1504084647.695205-1194294257', 02:56:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:56:05 INFO - '_': '/tools/buildbot/bin/python'} 02:56:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:56:05 INFO - Downloading/unpacking blobuploader==1.2.4 02:56:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:56:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:56:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:56:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:56:06 INFO - Downloading blobuploader-1.2.4.tar.gz 02:56:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:56:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:56:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:56:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:56:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:56:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:56:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:56:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:56:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:56:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:56:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:56:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:56:07 INFO - Downloading docopt-0.6.1.tar.gz 02:56:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:56:07 INFO - Installing collected packages: blobuploader, requests, docopt 02:56:07 INFO - Running setup.py install for blobuploader 02:56:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:56:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:56:07 INFO - Running setup.py install for requests 02:56:08 INFO - Running setup.py install for docopt 02:56:08 INFO - Successfully installed blobuploader requests docopt 02:56:08 INFO - Cleaning up... 02:56:08 INFO - Return code: 0 02:56:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:56:08 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')]} 02:56:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:56:08 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')]} 02:56:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:56:08 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 0xce01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xea8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104fb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c580>, '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 0x104d480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104d910>, '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': '232498196343f89f466a4a9a000001c8-1504084647.695205-1194294257', '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 02:56:08 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 02:56:08 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 02:56:08 INFO - Using env: {'DISPLAY': ':0', 02:56:08 INFO - 'HOME': '/home/cltbld', 02:56:08 INFO - 'LANG': 'en_US.UTF-8', 02:56:08 INFO - 'LANGUAGE': 'en_US:en', 02:56:08 INFO - 'LOGNAME': 'cltbld', 02:56:08 INFO - 'MAIL': '/var/mail/cltbld', 02:56:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:56:08 INFO - 'MOZ_NO_REMOTE': '1', 02:56:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:56:08 INFO - 'NO_EM_RESTART': '1', 02:56:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:56:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:56:08 INFO - 'PWD': '/builds/slave/test', 02:56:08 INFO - 'SHELL': '/bin/bash', 02:56:08 INFO - 'SHLVL': '1', 02:56:08 INFO - 'TERM': 'linux', 02:56:08 INFO - 'TMOUT': '86400', 02:56:08 INFO - 'USER': 'cltbld', 02:56:08 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1504084647.695205-1194294257', 02:56:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:56:08 INFO - '_': '/tools/buildbot/bin/python'} 02:56:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:56:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:56:08 INFO - Running setup.py (path:/tmp/pip-7eDexn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:56:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:56:08 INFO - Running setup.py (path:/tmp/pip-Ysk4pQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:56:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:56:08 INFO - Running setup.py (path:/tmp/pip-SQ7mXG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:56:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:56:08 INFO - Running setup.py (path:/tmp/pip-yMUZTs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:56:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:56:08 INFO - Running setup.py (path:/tmp/pip-LLufrW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:56:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:56:08 INFO - Running setup.py (path:/tmp/pip-nCbdZh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:56:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:56:08 INFO - Running setup.py (path:/tmp/pip-Vhl28z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:56:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:56:08 INFO - Running setup.py (path:/tmp/pip-_EUui7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:56:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:56:08 INFO - Running setup.py (path:/tmp/pip-AmCObu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:56:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:56:08 INFO - Running setup.py (path:/tmp/pip-p2vv8c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:56:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:56:09 INFO - Running setup.py (path:/tmp/pip-oYcWPa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:56:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:56:09 INFO - Running setup.py (path:/tmp/pip-ivMf3M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:56:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:56:09 INFO - Running setup.py (path:/tmp/pip-OIphBC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:56:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:56:09 INFO - Running setup.py (path:/tmp/pip-PfUaMR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:56:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:56:09 INFO - Running setup.py (path:/tmp/pip-LZz7aP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:56:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:56:09 INFO - Running setup.py (path:/tmp/pip-IjTZyv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:56:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:56:09 INFO - Running setup.py (path:/tmp/pip-7RQgaj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:56:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:56:09 INFO - Running setup.py install for manifestparser 02:56:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:56:09 INFO - Running setup.py install for mozcrash 02:56:09 INFO - Running setup.py install for mozdebug 02:56:09 INFO - Running setup.py install for mozdevice 02:56:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:56:09 INFO - Running setup.py install for mozfile 02:56:10 INFO - Running setup.py install for mozhttpd 02:56:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:56:10 INFO - Running setup.py install for mozinfo 02:56:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:56:10 INFO - Running setup.py install for mozInstall 02:56:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:56:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:56:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:56:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:56:10 INFO - Running setup.py install for mozleak 02:56:10 INFO - Running setup.py install for mozlog 02:56:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:56:10 INFO - Running setup.py install for moznetwork 02:56:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:56:10 INFO - Running setup.py install for mozprocess 02:56:10 INFO - Running setup.py install for mozprofile 02:56:10 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:56:10 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:56:10 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:56:10 INFO - Running setup.py install for mozrunner 02:56:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:56:10 INFO - Running setup.py install for mozscreenshot 02:56:11 INFO - Running setup.py install for moztest 02:56:11 INFO - Running setup.py install for mozversion 02:56:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:56:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:56:11 INFO - Cleaning up... 02:56:11 INFO - Return code: 0 02:56:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:56:11 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')]} 02:56:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:56:11 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')]} 02:56:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:56:11 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 0xce01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xea8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104fb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c580>, '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 0x104d480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104d910>, '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': '232498196343f89f466a4a9a000001c8-1504084647.695205-1194294257', '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 02:56:11 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 02:56:11 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 02:56:11 INFO - Using env: {'DISPLAY': ':0', 02:56:11 INFO - 'HOME': '/home/cltbld', 02:56:11 INFO - 'LANG': 'en_US.UTF-8', 02:56:11 INFO - 'LANGUAGE': 'en_US:en', 02:56:11 INFO - 'LOGNAME': 'cltbld', 02:56:11 INFO - 'MAIL': '/var/mail/cltbld', 02:56:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:56:11 INFO - 'MOZ_NO_REMOTE': '1', 02:56:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:56:11 INFO - 'NO_EM_RESTART': '1', 02:56:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:56:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:56:11 INFO - 'PWD': '/builds/slave/test', 02:56:11 INFO - 'SHELL': '/bin/bash', 02:56:11 INFO - 'SHLVL': '1', 02:56:11 INFO - 'TERM': 'linux', 02:56:11 INFO - 'TMOUT': '86400', 02:56:11 INFO - 'USER': 'cltbld', 02:56:11 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1504084647.695205-1194294257', 02:56:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:56:11 INFO - '_': '/tools/buildbot/bin/python'} 02:56:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:56:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:56:11 INFO - Running setup.py (path:/tmp/pip-ozkrNh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:56:11 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)) 02:56:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:56:11 INFO - Running setup.py (path:/tmp/pip-yWIrTX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:56:11 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)) 02:56:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:56:11 INFO - Running setup.py (path:/tmp/pip-fg5Bp0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:56:11 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)) 02:56:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:56:11 INFO - Running setup.py (path:/tmp/pip-FCGLpl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:56:11 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)) 02:56:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:56:11 INFO - Running setup.py (path:/tmp/pip-B4aUas-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:56:11 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)) 02:56:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:56:11 INFO - Running setup.py (path:/tmp/pip-fdDw5s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:56:11 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)) 02:56:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:56:11 INFO - Running setup.py (path:/tmp/pip-CNL9Sg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:56:12 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)) 02:56:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:56:12 INFO - Running setup.py (path:/tmp/pip-S0Ctck-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:56:12 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)) 02:56:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:56:12 INFO - Running setup.py (path:/tmp/pip-E6O0vn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:56:12 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)) 02:56:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:56:12 INFO - Running setup.py (path:/tmp/pip-hN5g4D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:56:12 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)) 02:56:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:56:12 INFO - Running setup.py (path:/tmp/pip-ngPbVc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:56:12 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)) 02:56:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:56:12 INFO - Running setup.py (path:/tmp/pip-0DyZy7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:56:12 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)) 02:56:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:56:12 INFO - Running setup.py (path:/tmp/pip-4HgKqZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:56:12 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)) 02:56:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:56:12 INFO - Running setup.py (path:/tmp/pip-xxSbi3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:56:12 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)) 02:56:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:56:12 INFO - Running setup.py (path:/tmp/pip-N3tBuI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:56:12 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)) 02:56:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:56:12 INFO - Running setup.py (path:/tmp/pip-UQbjhJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:56:12 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)) 02:56:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:56:12 INFO - Running setup.py (path:/tmp/pip-r2jfkt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:56:12 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)) 02:56:12 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)) 02:56:12 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)) 02:56:12 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)) 02:56:12 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)) 02:56:12 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)) 02:56:12 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)) 02:56:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:56:12 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 02:56:12 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 02:56:12 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 02:56:12 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 02:56:13 INFO - Downloading blessings-1.6.tar.gz 02:56:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:56:13 INFO - Installing collected packages: blessings 02:56:13 INFO - Running setup.py install for blessings 02:56:14 INFO - Successfully installed blessings 02:56:14 INFO - Cleaning up... 02:56:14 INFO - Return code: 0 02:56:14 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:56:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:56:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:56:14 INFO - Reading from file tmpfile_stdout 02:56:14 INFO - Current package versions: 02:56:14 INFO - argparse == 1.2.1 02:56:14 INFO - blessings == 1.6 02:56:14 INFO - blobuploader == 1.2.4 02:56:14 INFO - docopt == 0.6.1 02:56:14 INFO - functools32 == 3.2.3-2 02:56:14 INFO - jsonschema == 2.5.1 02:56:14 INFO - manifestparser == 1.1 02:56:14 INFO - mozInstall == 1.13 02:56:14 INFO - mozcrash == 1.0 02:56:14 INFO - mozdebug == 0.1 02:56:14 INFO - mozdevice == 0.51 02:56:14 INFO - mozfile == 1.2 02:56:14 INFO - mozhttpd == 0.7 02:56:14 INFO - mozinfo == 0.10 02:56:14 INFO - mozleak == 0.1 02:56:14 INFO - mozlog == 3.5 02:56:14 INFO - moznetwork == 0.27 02:56:14 INFO - mozprocess == 0.25 02:56:14 INFO - mozprofile == 0.28 02:56:14 INFO - mozrunner == 6.13 02:56:14 INFO - mozscreenshot == 0.1 02:56:14 INFO - mozsystemmonitor == 0.3 02:56:14 INFO - moztest == 0.8 02:56:14 INFO - mozversion == 1.4 02:56:14 INFO - psutil == 3.1.1 02:56:14 INFO - requests == 1.2.3 02:56:14 INFO - wsgiref == 0.1.2 02:56:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:56:14 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')]} 02:56:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:56:14 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')]} 02:56:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:56:14 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 0xce01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xea8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104fb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c580>, '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 0x104d480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104d910>, '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': '232498196343f89f466a4a9a000001c8-1504084647.695205-1194294257', '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 02:56:14 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 02:56:14 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 02:56:14 INFO - Using env: {'DISPLAY': ':0', 02:56:14 INFO - 'HOME': '/home/cltbld', 02:56:14 INFO - 'LANG': 'en_US.UTF-8', 02:56:14 INFO - 'LANGUAGE': 'en_US:en', 02:56:14 INFO - 'LOGNAME': 'cltbld', 02:56:14 INFO - 'MAIL': '/var/mail/cltbld', 02:56:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:56:14 INFO - 'MOZ_NO_REMOTE': '1', 02:56:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:56:14 INFO - 'NO_EM_RESTART': '1', 02:56:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:56:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:56:14 INFO - 'PWD': '/builds/slave/test', 02:56:14 INFO - 'SHELL': '/bin/bash', 02:56:14 INFO - 'SHLVL': '1', 02:56:14 INFO - 'TERM': 'linux', 02:56:14 INFO - 'TMOUT': '86400', 02:56:14 INFO - 'USER': 'cltbld', 02:56:14 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1504084647.695205-1194294257', 02:56:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:56:14 INFO - '_': '/tools/buildbot/bin/python'} 02:56:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:56:14 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)) 02:56:14 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)) 02:56:14 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)) 02:56:14 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)) 02:56:14 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)) 02:56:14 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)) 02:56:14 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)) 02:56:14 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)) 02:56:14 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)) 02:56:14 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 02:56:14 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 02:56:14 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 02:56:14 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 02:56:14 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 02:56:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 02:56:15 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)) 02:56:15 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)) 02:56:15 INFO - Installing collected packages: simplejson 02:56:15 INFO - Running setup.py install for simplejson 02:56:15 INFO - building 'simplejson._speedups' extension 02:56:15 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 02:56:16 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 02:56:16 INFO - Successfully installed simplejson 02:56:16 INFO - Cleaning up... 02:56:16 INFO - Return code: 0 02:56:16 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:56:16 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')]} 02:56:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:56:16 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')]} 02:56:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:56:16 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 0xce01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xea8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104fb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c580>, '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 0x104d480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104d910>, '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': '232498196343f89f466a4a9a000001c8-1504084647.695205-1194294257', '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 02:56:16 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 02:56:16 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 02:56:16 INFO - Using env: {'DISPLAY': ':0', 02:56:16 INFO - 'HOME': '/home/cltbld', 02:56:16 INFO - 'LANG': 'en_US.UTF-8', 02:56:16 INFO - 'LANGUAGE': 'en_US:en', 02:56:16 INFO - 'LOGNAME': 'cltbld', 02:56:16 INFO - 'MAIL': '/var/mail/cltbld', 02:56:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:56:16 INFO - 'MOZ_NO_REMOTE': '1', 02:56:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:56:16 INFO - 'NO_EM_RESTART': '1', 02:56:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:56:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:56:16 INFO - 'PWD': '/builds/slave/test', 02:56:16 INFO - 'SHELL': '/bin/bash', 02:56:16 INFO - 'SHLVL': '1', 02:56:16 INFO - 'TERM': 'linux', 02:56:16 INFO - 'TMOUT': '86400', 02:56:16 INFO - 'USER': 'cltbld', 02:56:16 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1504084647.695205-1194294257', 02:56:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:56:16 INFO - '_': '/tools/buildbot/bin/python'} 02:56:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:56:16 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:56:16 INFO - Cleaning up... 02:56:16 INFO - Return code: 0 02:56:16 INFO - Running post-action listener: _resource_record_post_action 02:56:16 INFO - Running post-action listener: _start_resource_monitoring 02:56:17 INFO - Starting resource monitoring. 02:56:17 INFO - [mozharness: 2017-08-30 09:56:17.008968Z] Finished create-virtualenv step (success) 02:56:17 INFO - [mozharness: 2017-08-30 09:56:17.009479Z] Running install step. 02:56:17 INFO - Running pre-action listener: _resource_record_pre_action 02:56:17 INFO - Running main action method: install 02:56:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:56:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:56:17 INFO - Reading from file tmpfile_stdout 02:56:17 INFO - Detecting whether we're running mozinstall >=1.0... 02:56:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:56:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:56:17 INFO - Reading from file tmpfile_stdout 02:56:17 INFO - Output received: 02:56:17 INFO - Usage: mozinstall [options] installer 02:56:17 INFO - Options: 02:56:17 INFO - -h, --help show this help message and exit 02:56:17 INFO - -d DEST, --destination=DEST 02:56:17 INFO - Directory to install application into. [default: 02:56:17 INFO - "/builds/slave/test"] 02:56:17 INFO - --app=APP Application being installed. [default: firefox] 02:56:17 INFO - mkdir: /builds/slave/test/build/application 02:56:17 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'] 02:56:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 02:56:33 INFO - Reading from file tmpfile_stdout 02:56:33 INFO - Output received: 02:56:33 INFO - /builds/slave/test/build/application/firefox/firefox 02:56:33 INFO - Running post-action listener: _resource_record_post_action 02:56:33 INFO - [mozharness: 2017-08-30 09:56:33.858044Z] Finished install step (success) 02:56:33 INFO - [mozharness: 2017-08-30 09:56:33.858294Z] Running setup-mitmproxy step. 02:56:33 INFO - Running pre-action listener: _resource_record_pre_action 02:56:33 INFO - Running main action method: setup_mitmproxy 02:56:33 INFO - Skipping: mitmproxy is not required 02:56:33 INFO - Running post-action listener: _resource_record_post_action 02:56:33 INFO - [mozharness: 2017-08-30 09:56:33.859495Z] Finished setup-mitmproxy step (success) 02:56:33 INFO - [mozharness: 2017-08-30 09:56:33.859714Z] Running run-tests step. 02:56:33 INFO - Running pre-action listener: _resource_record_pre_action 02:56:33 INFO - Running pre-action listener: _set_gcov_prefix 02:56:33 INFO - Running main action method: run_tests 02:56:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:56:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:56:33 INFO - Python 2.7.3 02:56:33 INFO - Return code: 0 02:56:33 INFO - grabbing minidump binary from tooltool 02:56:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:56:33 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c580>, '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 0x104d480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104d910>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:56:33 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 02:56:33 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 02:56:33 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 02:56:33 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:56:33 INFO - Return code: 0 02:56:33 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:56:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:56:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:56:33 INFO - ENV: RUST_BACKTRACE is now full 02:56:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:56:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:56:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eSP-W7eQTHm081zyISUr-A/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--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 02:56:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/eSP-W7eQTHm081zyISUr-A/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-025 --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 02:56:33 INFO - Using env: {'DISPLAY': ':0', 02:56:33 INFO - 'HOME': '/home/cltbld', 02:56:33 INFO - 'LANG': 'en_US.UTF-8', 02:56:33 INFO - 'LANGUAGE': 'en_US:en', 02:56:33 INFO - 'LOGNAME': 'cltbld', 02:56:33 INFO - 'MAIL': '/var/mail/cltbld', 02:56:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:56:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:56:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:56:33 INFO - 'MOZ_NO_REMOTE': '1', 02:56:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:56:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:56:33 INFO - 'NO_EM_RESTART': '1', 02:56:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:56:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:56:33 INFO - 'PWD': '/builds/slave/test', 02:56:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:56:33 INFO - 'RUST_BACKTRACE': 'full', 02:56:33 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 02:56:33 INFO - 'SHELL': '/bin/bash', 02:56:33 INFO - 'SHLVL': '1', 02:56:33 INFO - 'STYLO_FORCE_ENABLED': '1', 02:56:33 INFO - 'STYLO_THREADS': '1', 02:56:33 INFO - 'TERM': 'linux', 02:56:33 INFO - 'TMOUT': '86400', 02:56:33 INFO - 'USER': 'cltbld', 02:56:33 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1504084647.695205-1194294257', 02:56:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:56:33 INFO - '_': '/tools/buildbot/bin/python'} 02:56:33 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eSP-W7eQTHm081zyISUr-A/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--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 02:56:34 INFO - mozversion application_buildid: 20170830090533 02:56:34 INFO - mozversion application_changeset: ab2d700fda2b4934d24227216972dce9fac19b74 02:56:34 INFO - mozversion application_display_name: Nightly 02:56:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:56:34 INFO - mozversion application_name: Firefox 02:56:34 INFO - mozversion application_remotingname: firefox 02:56:34 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 02:56:34 INFO - mozversion application_vendor: Mozilla 02:56:34 INFO - mozversion application_version: 57.0a1 02:56:34 INFO - mozversion platform_buildid: 20170830090533 02:56:34 INFO - mozversion platform_changeset: ab2d700fda2b4934d24227216972dce9fac19b74 02:56:34 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 02:56:34 INFO - mozversion platform_version: 57.0a1 02:56:34 INFO - using testdate: 1504086994 02:56:34 INFO - actual date: 1504086994 02:56:34 INFO - starting webserver on 'localhost:45325' 02:56:34 INFO - SUITE-START | Running 2 tests 02:56:34 INFO - TEST-START | dromaeo_css 02:56:34 INFO - Initialising browser for dromaeo_css test... 02:56:34 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:45325/getInfo.html -profile /tmp/tmp5Xw0sB/profile 02:56:34 INFO - TEST-INFO | started process 2156 (/builds/slave/test/build/application/firefox/firefox http://localhost:45325/getInfo.html) 02:56:40 INFO - TEST-INFO | 2156: exit 0 02:56:40 INFO - Browser initialized. 02:56:40 INFO - Running cycle 1/1 for dromaeo_css test... 02:56:40 INFO - Using env: {'DISPLAY': ':0', 02:56:40 INFO - 'HOME': '/home/cltbld', 02:56:40 INFO - 'JSGC_DISABLE_POISONING': '1', 02:56:40 INFO - 'LANG': 'en_US.UTF-8', 02:56:40 INFO - 'LANGUAGE': 'en_US:en', 02:56:40 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 02:56:40 INFO - 'LOGNAME': 'cltbld', 02:56:40 INFO - 'MAIL': '/var/mail/cltbld', 02:56:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:56:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:56:40 INFO - 'MOZ_CRASHREPORTER': '1', 02:56:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:56:40 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 02:56:40 INFO - 'MOZ_NO_REMOTE': '1', 02:56:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:56:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:56:40 INFO - 'NO_EM_RESTART': '1', 02:56:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:56:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:56:40 INFO - 'PWD': '/builds/slave/test', 02:56:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:56:40 INFO - 'RUST_BACKTRACE': 'full', 02:56:40 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 02:56:40 INFO - 'SHELL': '/bin/bash', 02:56:40 INFO - 'SHLVL': '1', 02:56:40 INFO - 'STYLO_FORCE_ENABLED': '1', 02:56:40 INFO - 'STYLO_THREADS': '1', 02:56:40 INFO - 'TERM': 'linux', 02:56:40 INFO - 'TMOUT': '86400', 02:56:40 INFO - 'USER': 'cltbld', 02:56:40 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1504084647.695205-1194294257', 02:56:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:56:40 INFO - '_': '/tools/buildbot/bin/python'} 02:56:40 INFO - TEST-INFO | started process 2342 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5Xw0sB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 02:56:41 INFO - PID 2342 | 02:56:41 INFO - PID 2342 | (/builds/slave/test/build/application/firefox/firefox:2393): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 02:56:41 INFO - PID 2342 | 02:56:51 INFO - PID 2342 | RSS: Main: 167546880 02:56:51 INFO - PID 2342 | 02:59:50 INFO - PID 2342 | Cycle 1(1): loaded http://localhost:45325/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45325/tests/dromaeo/cssquery-ext.html) 02:59:51 INFO - PID 2342 | RSS: Main: 173600768 02:59:51 INFO - PID 2342 | 03:02:53 INFO - PID 2342 | Cycle 1(1): loaded http://localhost:45325/tests/dromaeo/cssquery-ext.html (next: http://localhost:45325/tests/dromaeo/cssquery-jquery.html) 03:02:54 INFO - PID 2342 | RSS: Main: 170074112 03:02:54 INFO - PID 2342 | 03:05:56 INFO - PID 2342 | Cycle 1(1): loaded http://localhost:45325/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45325/tests/dromaeo/cssquery-mootools.html) 03:05:56 INFO - PID 2342 | RSS: Main: 172388352 03:05:56 INFO - PID 2342 | 03:08:58 INFO - PID 2342 | Cycle 1(1): loaded http://localhost:45325/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45325/tests/dromaeo/cssquery-prototype.html) 03:08:59 INFO - PID 2342 | RSS: Main: 170455040 03:08:59 INFO - PID 2342 | 03:12:02 INFO - PID 2342 | Cycle 1(1): loaded http://localhost:45325/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45325/tests/dromaeo/cssquery-yui.html) 03:12:03 INFO - PID 2342 | RSS: Main: 172789760 03:12:03 INFO - PID 2342 | 03:15:05 INFO - PID 2342 | Cycle 1(1): loaded http://localhost:45325/tests/dromaeo/cssquery-yui.html (next: http://localhost:45325/tests/dromaeo/cssquery-dojo.html) 03:15:05 INFO - PID 2342 | RSS: Main: 175362048 03:15:05 INFO - PID 2342 | 03:15:05 INFO - PID 2342 | __start_tp_report 03:15:05 INFO - PID 2342 | _x_x_mozilla_page_load 03:15:05 INFO - PID 2342 | _x_x_mozilla_page_load_details 03:15:05 INFO - PID 2342 | |i|pagename|runs| 03:15:05 INFO - PID 2342 | |0;dojo.html;3343.8160901150427;3355.949660755088;3371.8482668279935;3379.442392005319;3399.269157131218;6379.2344918609715;6474.384933431323;6485.513586481015;6523.510736694743;6529.412352888239;6315.842103947392;6391.488680905528;6394.360563943604;6404.51966102543;6431.196100487439;5811.883762324751;5813.593048486597;5833.037548804442;5929.169916211734;6018.578699491038;6021.157038014681;6034.487068599175;6043.153958445821;6061.848453788646;6082.330943596201;1068.8312499024612;5848.67832269225;5912.290525136989;5994.130851026599;6029.939700603004;5860.531157507389;5864.941350586482;5883.323417806964;5972.134040564094;5986.820395388102;5866.76532938682;5876.382979787104;5952.553558483131;5959.731812068424;5960.910586341209;6411.8397040073905;6419.486441084702;6424.743010279583;6492.902606460907;6526.445252153572;6912.481563882729;6933.583984960868;6991.650417479156;7022.754203602849;7028.226895041593;6869.0383346331055;7000.649967501605;7013.158420989463;7102.964485177593;7106.928930710678;6302.653354065525;6306.1171435998995;6307.369263073656;6309.242890853081;6354.618722876596;6942;7146.3210994956435;7181.06646135999;7227.602481863548;7232.529885557422;6781.152355955505;6790.864182716318;6812.182538095361;6816.829579260459;6818.761343352959;6834.419074378634;6834.555753875982;6936.965315173392;6942.097527321416;6947.756828510978;6625.569337993015;6781.796546103625;6797.6601169941305;6879.552829066095;6883.036374907517;6864.931350686429;6868.175818901764;6882.414994725505;6888.035675005503;6891.517593768388;5039.496050395004;5071.06185355703;5129.692218466829;5130.692158470503;5131.846044618667;4463.152001119777;4513.390692256569;4529.479109902403;4553.817847286137;4570.337301091323;6067.059605761114;6080.331163572004;6083.7566497340495;6162.5378096642935;6165.198524191826;6764.763233286812;6919.7232110715;6969.6166710830375;7046.260142685047;7054.470914681419;6050.909236361458;6083.178770865877;6088.908666370008;6102.69486525672;6124.663143527059;5973.37279585646;6043.637381757108;6055.485283750842;6058.818235452944;6060.030395136757;6842.110525631736;6857.314268573203;6881.621510816853;6882.8623427531165;6883.380495755406;6976.441884649216;6984.476164287597;7001.089858318386;7101.11236095488;7102.715891364288;6665.700043498151;6738;6782.728690852508;6871.690773915086;6873.243943166348;6802.01370801241;6812.25065242813;6815.079964204769;6821.931780682328;6825.215100263533;6923.93076069253;6929.514933954575;6929.861402772017;6939.757108501179;6953.79138625842;5888.0832253498875;6673.366030227121;6722.932770672231;6733.0573719678305;6808.93191068083;6554.868902621825;6712.966435167793;6726.6636668167375;6790.219124800514;6840.939654353583;6568.244651865097;6608.768693095719;6617.205935287604;6620.172478440195;6621.5364924454825;6684.83287917806;6697.866042679217;6723.092382528492;6911.688973996283;6915.757948471779;6550.803475895731;6550.967245163743;6649.03588979605;6656.400923916871;6659.667016649245 03:15:05 INFO - PID 2342 | |1;ext.html;779.2674885607529;818.5579786915066;846.0397448895503;879.780054986253;879.7800549862534;38937.61062389375;40305.19389612206;40385.7980710096;40402.19195616086;40470.392944105864;36621.26757464849;36822.263554728954;36828.81585592075;36850;36859.631403685955;6752.966235168818;6892.758753443631;6893.20728116268;6895.862082758342;6897.724091036353;6768.8307792305095;6871.175458944934;6874.725010999554;6876.071730316393;6879.9312006880045;7371.631418429084;7551.69793208271;7555.773326800205;7556.1688214296655;7557.886631700529;7418.999999999973;7535.20880307568;7537.397008239355;7542.962285188594;7544.585047822367;7321.74373896911;7486.064241969754;7492.812679683051;7496.325330720207;7497.1753107158165;36409.817950910074;36574.63425365739;36600.45099323512;36647.633523664954;36652.63347366519;3543.8936831895085;3585.265020670782;3586.677199052098;3593.82030898454;3594.8382322795537;30488.69511304903;30570.388592228253;30594.38811223763;30655.69344306573;30665.69334306673;5122.1804511278015;5137.7944882204665;5166.535011848951;5175.223716442526;5177.637565370425;180428;183179;186250;186500;192695.03652481787;45172.77413612911;45417;45501.54498455039;45504.77247613807;45597.31604025942;46548.301775473396;46591;46637.30044049342;46683.29975050377;46746;14503.782443263359;14518.419263229353;14627.414903403958;14673.266336683124;14676.11943283385;13107.934460327637;13121.212727236205;13155;13167.209967401986;13175.275359855108;13024.804627930589;13028.54400096011;13036.217826930415;13036.869631303754;13172.868271317357;5268.868278292996;5270.525652691276;5327.094393953037;5406.459354064562;5470.7264636768;999.260547195085;1006.7885743993843;1018.0786388318584;1029.3926583315729;1048.2452634103433;22207.666884996415;22891.656625150637;22921.426964325692;22975;23285.3014409568;1105.9944700276608;1107.5901916290863;1120.2270433400927;1122.186414849244;1135.233717240859;11541.105785996946;12115.939420302842;12141.75716485683;15667.451639192801;15833.287502062434;240543;242534;242717;242983;243748;54223.45776542263;54703;55056.724716376964;55174.724126379115;55189.44810551924;1422.2319947228382;1450.376338174574;1454.0766613200694;1454.7308747881675;1460.7218683651804;27045;27257.86371068132;27397.726022739516;27714.307142321602;27890.581641275803;37405.251894962494;37422.438663419525;37539.24921501609;37572;37578.62421375861;213604;214187;214405;214573;214984;32420.351592967538;35452;35966;36231;36249;42438.57561424346;43487.347689784045;43819.56180438155;44015.77992110019;44540.55459445364;32727.672723273416;32972.1756956078;32980.340393192484;33840.66159338375;34035.65964340325;32510;33019.504707428925;33192.502112468814;33498.49752253767;33729;36433;37335;37865.43201851919;37887.052823678525;37958;32095.592830537335;32245.838770805996;32682.182945426553;33495;34173.9495630263;24481;24922.626160607244;24987;25607;25794.613080804178 03:15:05 INFO - PID 2342 | |2;jquery.html;568.7724910035988;573.5067841656178;578.560294176426;580.1355979590412;583.7635757518204;21353.893230533846;22271.554568908614;22358.441038974033;22360.99375528101;22472.101115955382;25453;25960.35099122523;25966.74033259667;25986.35034124148;26010.479790404228;6523.6738163091895;6661.966690166542;6663.500237482184;6665.40011398974;6666.500012499057;6164.29110652274;6417.229932408118;6448.967755161241;6455;6458.709358078874;6425.903611445832;6426.646534440604;6427.2287325520765;6429.7106630201515;6434.678266086677;6421.903671444932;6423.389777971085;6427.742890284383;6428.164338635994;6429.260635026985;5943.55423343251;5946.316173640043;5946.583739138262;5957.791477298317;5962.046072628402;28763.56854647182;29695.554566681516;29881.551776723365;29935.401291974038;30262.243443914078;2039.6838490034067;2079.750429948401;2080.5630817528186;2083.3541602103396;2090.237063471822;19175.712364314546;19183.424497265103;19531;20035.499112522302;20139.39581812548;2419.879006049708;2436.7049217057966;2450.6079027355718;2450.9754902450927;2476.863772492512;138381;141637;142643;145904.270478648;146368;14509.92745036268;14641.780373294408;15042.172680502677;15231.705305049194;15363.692726145639;21171;21190.364289071353;21214.15143394247;21219.36341909745;21229;10171.643992460376;10262.127719143808;10311.535980880879;10335.844962325571;10403.53184106717;8436.957815210884;8803.955980220058;8863.2466240369;9696.6121355145;9840.11438970496;9218.262538996863;9435.386699864486;9485.430874147572;9498.240140788721;9530.90469095314;2733.931651708723;2782.582612608125;2785.749282564579;2790.1629511146575;2791.860406979643;959.7456673981401;978.6085565773748;985.3644399362514;988.5106872098357;1009.8838633557089;19766.011699414972;19973;19988.60022799565;20119.295824646066;20327.983600819898;1040.4485622620023;1044.3316277582353;1065.1532032034552;1067.3435836960214;1068.8450174724621;11006.669799906016;11141.498632561554;11233.438328083726;11281.774364512828;11287.322760634388;471358;486984;489222;490182;491669;112701.43649281701;115163;115443.42278288555;116120.41939790247;116912;1187.3410257307105;1197.239752756988;1208.8368070310396;1209.3106929050532;1285.2095960983927;21097.789022109584;21337.89331053335;21414.785852141278;21491.570168596852;21565.137394504673;59817.700911495165;60157;60183.69908150431;60270.39729602648;61566;73842;74499.62750186214;74742.25257747571;75350.86973695508;83214.58392707998;21161;21869.234576789735;21910.45223869416;21959.34121976343;22014.669779952994;23636.52726945417;23668.881655591613;24248;24382.26853194407;24500.142495012587;19051.61896762085;19742;19832.504187394854;19841;19889.403317900487;17980.460586182435;17981.65137614658;18019.2792288307;18200.81799182044;18246.635067298314;20367;20387.59224815466;20513.89743051335;20593.48516287105;20628.690569641167;20642.79357206469;21868.781312186675;21988.89005555026;22140.778592213872;22215.333539993826;18366.357177498725;19401.32095376655;19727.506812329808;19868.50328741793;19978.20087196496 03:15:05 INFO - PID 2342 | |3;mootools.html;1333.3333333333333;1379.827521559805;1384.7715127004042;1388.8125103111076;1391.0471327140908;14896.329665165067;15664.060156390624;15701.685966280667;15727.60680982976;15734.84265157348;15944.840551594481;16081.517554473356;16112.597185070379;16121.27454264558;16137.515874523753;2390.9760902390926;2447.79193768529;2472.888720007595;2474.9628755568683;2475.269795410349;2659.2421159969413;2746;2810.6205662235543;2811.7750579953554;2812.072016234638;2711.4983728010284;2760.489309477753;2762.4889395461805;2778.9305267368277;2782.3322402623426;2709.2684975056823;2713.592961055838;2721.7958653100995;2722.1561315992008;2729.7543221109995;2648.298200976743;2654.6814382274056;2665.693445253801;2666.266776636421;2667.5865240887692;14855;15191.544253672408;15195.848041519554;15208.619784505365;15230.46693365727;7790.727324543671;8011.838283448926;8292.17078292172;8296.419250652456;8303.83392332156;5332.280142180794;5342.652727572696;5364.30264065669;5423.430539793304;5461.399246082928;1824.2611742244412;1862.4878158506383;1874.2877706471454;1930.951726206842;1932.8743631663897;25698.614520782205;25912.611310830354;25980.74019259802;26005.73994260052;26089.608655870175;6701.961196014626;6872.965635171792;7062.011318415426;7129.394001509826;7130.429565634737;17019.82980170207;17257.137143142794;17294.82705172932;17403.65192696139;17457;7743.651535680908;7914.881276780853;7918.6436610352675;7923.286904178652;7928.246816552418;7225.843864981578;7342.302481264272;7353.0441042664115;7375.336219740249;7410.777676669709;4908.9754551227015;5014.0974624567925;5045.747712614428;5047.520485553867;5072.543471087546;1365.3105181883086;1371.602235351737;1374.6700791810094;1393.540131756518;1399.7970294307472;893.3657103456619;916.6608354908593;920.6823645842173;921.0927236671873;936.4147407870081;7806.726764563213;7849.568273744999;7911.090224624242;7941.245581669732;7987.720429784929;702.9261927497539;715.0347031507528;715.6850985566334;717.1680850213727;718.306833905284;4762.190427627312;4763.45220299663;5443.482869127427;5460.426655201147;5608.046632072557;22331.330060098222;22431.10275588958;22757.772422275895;22832.885835571047;22915.656265156034;21408.464788380104;22051.448713782283;22348.888255558944;22678.773212267995;22860.542789144456;11608.24546404481;11835.940820295844;11891.345975971404;11935.820962685566;11977.101717371232;7849.7645070645685;7852.332551732939;8115.594220288844;8471.66113355459;8659.696910608098;18415.90792046031;18655.813441865408;18904.52738681544;19244.615107698046;19276.421707348803;18637.90681046586;19153.52116197106;19389.51526211856;19734.605307893475;19782.40652780419;11687.88312116902;11818.704532386759;12002.939985300018;12295.75408491843;12333.691657708629;13497.39261733244;13606.727865442437;13610.93194534021;13610.93194534021;13626.182429054288;11344.432778360884;11345.829812552984;11507.712307192387;11549.480273387886;11656.592019279284;11211.159163062639;11213.102951763676;11289.830652540382;11474.368909709712;11489.253198542403;9501.61993520279;9777.315587908779;9778.706638800848;9779.902200977898;9786.46174460383;7030.15638123408;7034.120734908137;7039.718411263492;7087.184973728087;7104.3961263293195;7148.821279468055;7283.526570772883;7330.816729581803;7364.742234021998;7377.225391334047 03:15:05 INFO - PID 2342 | |4;prototype.html;502.34033802706574;519.9272101905734;529.3647622852573;531.3305235403392;537.1888448442852;6365.52258580606;6370.681465926703;6425.678716064202;6455.3544645535485;6465.321141280168;6221.377862213776;6269.404406581368;6322.34461526159;6343;6355.968220158893;5259.631825772188;5270.710110943896;5272.762725677335;5284.2866213061125;5314.282571852789;4902.039184326262;5037.168867136918;5073.594112471012;5212.452692467293;5263.631545791796;4996.4503904570465;5010.3737032870895;5035;5041.621878359119;5044.092063428581;4907.478681608713;5009.2486127080865;5010.874728131789;5024.001118886731;5036.722980236085;4492.797824097924;4502.099580083996;4503.684742068057;4506.842260520899;4524.6380289576755;6187.381261873822;6196.318404975449;6212.4408803207925;6216.658083805389;6224.066390041485;5661.745221465044;5693.117566777156;5782.190493330937;5803.593748437611;5849.327327357366;6532.572980854739;6608.4052435281055;6618.4705223582;6677.198736151644;6693.297203793629;4855.393075865517;4889.413270407574;4899.632527560448;4905.558499735041;4916.139675556763;6660.300668429793;6777.220619628756;6828.283030281848;6851.657417129124;6943.89584156238;4965.4289756678445;4992.650514463952;5004.549590536869;5028.84913452597;5029.899402012013;5011.498850114959;5082.593392528589;5088.898222035538;5110.61670374716;5130.410002849645;5700.3444603871085;5739.167820666064;5753;5761.193432919395;5765.336986246635;6665.166854143232;6669.63317017559;6693.129893113962;6696.397324240842;6750.189977202669;1778.813224611423;1798.1548672124081;1800.3608718904861;1800.5318617159633;1811.031098362396;1128.9943550282196;1234.3889774561649;1243.6890777305673;1244.9439775210137;1257.3147634539198;5950.434708702666;5960.821175364746;5972.760214919405;5980.700964951735;6008.188894499274;6868.175818901764;6883.965580172167;6886.2769409212315;6895.379415852497;6947.965260173768;5895.734691938873;5905.59637931288;5912.231409916683;5921.881562368814;6001.159837622737;3551.8046507441823;3578.928421431609;3587;3618.565772107364;3618.7696183297803;6588.439982601437;6652;6658.667066646745;6689.799306020827;6725.327467253235;6639.767608133789;6825.829354266084;6917.757878474229;7008.334208250208;7037.894431583531;6587.275399706028;6603.570767900071;6612.206535215805;6652.4388110577775;6681;6716.1604799400075;6756.324367563401;6791.830204244933;6805.183377994672;6818.693158807766;6687.565308254948;6697.995300704738;6720.1599800025;6758.189017317756;6760.898586521304;6631.237407697983;6655.667216639245;6656.434203092597;6679.398854103154;6714.328567143247;4948.956391819077;4989.12690279207;4991.57571606403;4994.450610432777;4999.500049994971;6661.3338666132995;6739.42714869222;6809.93190068093;6916.896246556205;6938.895916561155;6341.207349081365;6566.343365663586;6566.358410397401;6568.868622627616;6620;6595.835104122243;6596.241432235354;6608.107905432705;6610.537262391779;6646.7341306349135;6523.445507131947;6523.478121750154;6545.37818907203;6553.934460655523;6566.671666416564;6604.63674497888;6610.933890661032;6621.569597976116;6682.131322927989;6720.428763555153;6324.810255692337;6427.55007149495;6434.549581529435;6487.416132547904;6500.544961852814 03:15:05 INFO - PID 2342 | |5;yui.html;881.8941726992762;891.6166048599101;897.6768363389183;898.4913911176857;915.574257970044;18856.81143188568;20371.287004954847;20386.286479973205;20392.69410958833;20413;20455.079521421536;20477.692834607493;20784.688229676565;20910.37268881936;20993.895030524865;969.064852417417;987.7086259553413;988.5600907596123;990.9009099090069;990.9653162139326;878.1438097854573;971.8153550825356;973.3819024919156;975.6000039983608;975.9463229522373;1040.3081950502906;1044.5560636729397;1044.984325235122;1045.8378951262566;1045.921555883308;1041.7031146123356;1044.1698849414695;1044.222054569347;1045.0229035851503;1045.4981608827804;771.417579727308;773.3001633521671;776.6194564663331;776.798032511551;776.9805754856118;16922;17386.739198912026;19203;19512.609747805105;19531.316403925794;21444.892775536024;21938.341849744535;21956.23153189631;21965.780342196693;22197.334079977627;16256.349746010146;16625.168741562873;16773.580660483585;16785.496435106965;16806.41177558792;3718.1819999600043;3731.8134093295225;3736;3741.3265612189794;3752.7935963521995;125466;129318;129565.35217323947;132177.99999999904;133569;16306.347746090261;16445.09551974629;16571.42000029993;16748.83251167497;16979.405720799714;28426.857865710954;28479.288017799307;28781.136565902638;29174.85412572966;30135.849320753256;8979.371443998987;9204.033576474507;9215.078492150866;9244.676436324697;9249.722508324761;4016.5180178378196;4055.1078762672164;4108.753474791522;4180.707350485498;4199.790010499524;5159.922601160985;5269.1832765921345;5284.497972692588;5305.151175811851;5314.5748340132695;1019.90820826126;1036.5594622285498;1059.5496913811598;1060.4326685223368;1063.2185343772321;650.612885333226;662.29134825736;671.5634837355758;677.0453660338899;684.1277371351566;11334.94332528332;11523.366214858263;11944.940275298568;12841.614751557468;12931.418086186144;641.1504756198057;650.612885333226;652.2596852572365;659.1727382135485;669.8224970382853;4782.928256076161;4928.28539861718;5932.139839723216;5994.940050599438;6013.30846952606;103970;107115;111682.44158779155;114104.42947785374;115938;95378;97248.51375743076;100656.49671751594;101054;106764;83534;84156.57921710475;84565.57717211374;86405;86643;11137.610183643534;11479.311241325548;11493.195476316578;11519.596814111466;11627.88372116268;40373;41157.1768564633;41253;41606.58393416027;42247;70284;70815.29184708293;72575;73665;76526.23473765414;17382.478525644252;17482.125893705008;17608.55978600545;17647.64704705873;17681.46955591283;19087.331943381916;19697;19898.90050549738;20288.087036083118;20637.380878573666;16677.332906683598;17145;17241.0517421538;18051.909740451214;18171;17162.656746865243;17344.69914756373;17523.649527009642;17551.561210969827;17678;16207.675846482769;16273.3490660377;16307.266173022004;16432;17066.146692665567;12795.872041279468;13006.869931300565;13290.601281961557;13590.660233494242;13680.794788078387;13312.534061307808;13515.59453216405;13672.453101875813;13676.589702308947;13796.448142074205 03:15:05 INFO - PID 2342 | __end_tp_report 03:15:05 INFO - PID 2342 | __start_cc_report 03:15:05 INFO - PID 2342 | _x_x_mozilla_cycle_collect,360 03:15:05 INFO - PID 2342 | __end_cc_report 03:15:05 INFO - PID 2342 | __startTimestamp1504088105281__endTimestamp 03:15:05 INFO - PID 2342 | 03:15:05 INFO - PID 2342 | ------- Summary: start ------- 03:15:05 INFO - PID 2342 | Number of tests: 6 03:15:05 INFO - PID 2342 | 03:15:05 INFO - PID 2342 | [#0] dojo.html Cycles:165 Average:6327.79 Median:6620.17 stddev:880.64 (13.3%) stddev-sans-first:851.67 03:15:05 INFO - PID 2342 | Values: 3343.8 3355.9 3371.8 3379.4 3399.3 6379.2 6474.4 6485.5 6523.5 6529.4 6315.8 6391.5 6394.4 6404.5 6431.2 5811.9 5813.6 5833.0 5929.2 6018.6 6021.2 6034.5 6043.2 6061.8 6082.3 1068.8 5848.7 5912.3 5994.1 6029.9 5860.5 5864.9 5883.3 5972.1 5986.8 5866.8 5876.4 5952.6 5959.7 5960.9 6411.8 6419.5 6424.7 6492.9 6526.4 6912.5 6933.6 6991.7 7022.8 7028.2 6869.0 7000.6 7013.2 7103.0 7106.9 6302.7 6306.1 6307.4 6309.2 6354.6 6942.0 7146.3 7181.1 7227.6 7232.5 6781.2 6790.9 6812.2 6816.8 6818.8 6834.4 6834.6 6937.0 6942.1 6947.8 6625.6 6781.8 6797.7 6879.6 6883.0 6864.9 6868.2 6882.4 6888.0 6891.5 5039.5 5071.1 5129.7 5130.7 5131.8 4463.2 4513.4 4529.5 4553.8 4570.3 6067.1 6080.3 6083.8 6162.5 6165.2 6764.8 6919.7 6969.6 7046.3 7054.5 6050.9 6083.2 6088.9 6102.7 6124.7 5973.4 6043.6 6055.5 6058.8 6060.0 6842.1 6857.3 6881.6 6882.9 6883.4 6976.4 6984.5 7001.1 7101.1 7102.7 6665.7 6738.0 6782.7 6871.7 6873.2 6802.0 6812.3 6815.1 6821.9 6825.2 6923.9 6929.5 6929.9 6939.8 6953.8 5888.1 6673.4 6722.9 6733.1 6808.9 6554.9 6713.0 6726.7 6790.2 6840.9 6568.2 6608.8 6617.2 6620.2 6621.5 6684.8 6697.9 6723.1 6911.7 6915.8 6550.8 6551.0 6649.0 6656.4 6659.7 03:15:05 INFO - PID 2342 | 03:15:05 INFO - PID 2342 | [#1] ext.html Cycles:180 Average:38097.63 Median:19780.42 stddev:55878.87 (282.5%) stddev-sans-first:55965.37 03:15:05 INFO - PID 2342 | Values: 779.3 818.6 846.0 879.8 879.8 38937.6 40305.2 40385.8 40402.2 40470.4 36621.3 36822.3 36828.8 36850.0 36859.6 6753.0 6892.8 6893.2 6895.9 6897.7 6768.8 6871.2 6874.7 6876.1 6879.9 7371.6 7551.7 7555.8 7556.2 7557.9 7419.0 7535.2 7537.4 7543.0 7544.6 7321.7 7486.1 7492.8 7496.3 7497.2 36409.8 36574.6 36600.5 36647.6 36652.6 3543.9 3585.3 3586.7 3593.8 3594.8 30488.7 30570.4 30594.4 30655.7 30665.7 5122.2 5137.8 5166.5 5175.2 5177.6 180428.0 183179.0 186250.0 186500.0 192695.0 45172.8 45417.0 45501.5 45504.8 45597.3 46548.3 46591.0 46637.3 46683.3 46746.0 14503.8 14518.4 14627.4 14673.3 14676.1 13107.9 13121.2 13155.0 13167.2 13175.3 13024.8 13028.5 13036.2 13036.9 13172.9 5268.9 5270.5 5327.1 5406.5 5470.7 999.3 1006.8 1018.1 1029.4 1048.2 22207.7 22891.7 22921.4 22975.0 23285.3 1106.0 1107.6 1120.2 1122.2 1135.2 11541.1 12115.9 12141.8 15667.5 15833.3 240543.0 242534.0 242717.0 242983.0 243748.0 54223.5 54703.0 55056.7 55174.7 55189.4 1422.2 1450.4 1454.1 1454.7 1460.7 27045.0 27257.9 27397.7 27714.3 27890.6 37405.3 37422.4 37539.2 37572.0 37578.6 213604.0 214187.0 214405.0 214573.0 214984.0 32420.4 35452.0 35966.0 36231.0 36249.0 42438.6 43487.3 43819.6 44015.8 44540.6 32727.7 32972.2 32980.3 33840.7 34035.7 32510.0 33019.5 33192.5 33498.5 33729.0 36433.0 37335.0 37865.4 37887.1 37958.0 32095.6 32245.8 32682.2 33495.0 34173.9 24481.0 24922.6 24987.0 25607.0 25794.6 03:15:05 INFO - PID 2342 | 03:15:05 INFO - PID 2342 | [#2] jquery.html Cycles:180 Average:35671.80 Median:22178.06 stddev:82080.12 (370.1%) stddev-sans-first:82268.06 03:15:05 INFO - PID 2342 | Values: 568.8 573.5 578.6 580.1 583.8 21353.9 22271.6 22358.4 22361.0 22472.1 25453.0 25960.4 25966.7 25986.4 26010.5 6523.7 6662.0 6663.5 6665.4 6666.5 6164.3 6417.2 6449.0 6455.0 6458.7 6425.9 6426.6 6427.2 6429.7 6434.7 6421.9 6423.4 6427.7 6428.2 6429.3 5943.6 5946.3 5946.6 5957.8 5962.0 28763.6 29695.6 29881.6 29935.4 30262.2 2039.7 2079.8 2080.6 2083.4 2090.2 19175.7 19183.4 19531.0 20035.5 20139.4 2419.9 2436.7 2450.6 2451.0 2476.9 138381.0 141637.0 142643.0 145904.3 146368.0 14509.9 14641.8 15042.2 15231.7 15363.7 21171.0 21190.4 21214.2 21219.4 21229.0 10171.6 10262.1 10311.5 10335.8 10403.5 8437.0 8804.0 8863.2 9696.6 9840.1 9218.3 9435.4 9485.4 9498.2 9530.9 2733.9 2782.6 2785.7 2790.2 2791.9 959.7 978.6 985.4 988.5 1009.9 19766.0 19973.0 19988.6 20119.3 20328.0 1040.4 1044.3 1065.2 1067.3 1068.8 11006.7 11141.5 11233.4 11281.8 11287.3 471358.0 486984.0 489222.0 490182.0 491669.0 112701.4 115163.0 115443.4 116120.4 116912.0 1187.3 1197.2 1208.8 1209.3 1285.2 21097.8 21337.9 21414.8 21491.6 21565.1 59817.7 60157.0 60183.7 60270.4 61566.0 73842.0 74499.6 74742.3 75350.9 83214.6 21161.0 21869.2 21910.5 21959.3 22014.7 23636.5 23668.9 24248.0 24382.3 24500.1 19051.6 19742.0 19832.5 19841.0 19889.4 17980.5 17981.7 18019.3 18200.8 18246.6 20367.0 20387.6 20513.9 20593.5 20628.7 20642.8 21868.8 21988.9 22140.8 22215.3 18366.4 19401.3 19727.5 19868.5 19978.2 03:15:05 INFO - PID 2342 | 03:15:05 INFO - PID 2342 | [#3] mootools.html Cycles:180 Average:9422.04 Median:2651.49 stddev:6810.75 (256.9%) stddev-sans-first:6802.74 03:15:05 INFO - PID 2342 | Values: 1333.3 1379.8 1384.8 1388.8 1391.0 14896.3 15664.1 15701.7 15727.6 15734.8 15944.8 16081.5 16112.6 16121.3 16137.5 2391.0 2447.8 2472.9 2475.0 2475.3 2659.2 2746.0 2810.6 2811.8 2812.1 2711.5 2760.5 2762.5 2778.9 2782.3 2709.3 2713.6 2721.8 2722.2 2729.8 2648.3 2654.7 2665.7 2666.3 2667.6 14855.0 15191.5 15195.8 15208.6 15230.5 7790.7 8011.8 8292.2 8296.4 8303.8 5332.3 5342.7 5364.3 5423.4 5461.4 1824.3 1862.5 1874.3 1931.0 1932.9 25698.6 25912.6 25980.7 26005.7 26089.6 6702.0 6873.0 7062.0 7129.4 7130.4 17019.8 17257.1 17294.8 17403.7 17457.0 7743.7 7914.9 7918.6 7923.3 7928.2 7225.8 7342.3 7353.0 7375.3 7410.8 4909.0 5014.1 5045.7 5047.5 5072.5 1365.3 1371.6 1374.7 1393.5 1399.8 893.4 916.7 920.7 921.1 936.4 7806.7 7849.6 7911.1 7941.2 7987.7 702.9 715.0 715.7 717.2 718.3 4762.2 4763.5 5443.5 5460.4 5608.0 22331.3 22431.1 22757.8 22832.9 22915.7 21408.5 22051.4 22348.9 22678.8 22860.5 11608.2 11835.9 11891.3 11935.8 11977.1 7849.8 7852.3 8115.6 8471.7 8659.7 18415.9 18655.8 18904.5 19244.6 19276.4 18637.9 19153.5 19389.5 19734.6 19782.4 11687.9 11818.7 12002.9 12295.8 12333.7 13497.4 13606.7 13610.9 13610.9 13626.2 11344.4 11345.8 11507.7 11549.5 11656.6 11211.2 11213.1 11289.8 11474.4 11489.3 9501.6 9777.3 9778.7 9779.9 9786.5 7030.2 7034.1 7039.7 7087.2 7104.4 7148.8 7283.5 7330.8 7364.7 7377.2 03:15:05 INFO - PID 2342 | 03:15:05 INFO - PID 2342 | [#4] prototype.html Cycles:180 Average:5591.60 Median:6246.74 stddev:1569.38 (25.1%) stddev-sans-first:1526.59 03:15:05 INFO - PID 2342 | Values: 502.3 519.9 529.4 531.3 537.2 6365.5 6370.7 6425.7 6455.4 6465.3 6221.4 6269.4 6322.3 6343.0 6356.0 5259.6 5270.7 5272.8 5284.3 5314.3 4902.0 5037.2 5073.6 5212.5 5263.6 4996.5 5010.4 5035.0 5041.6 5044.1 4907.5 5009.2 5010.9 5024.0 5036.7 4492.8 4502.1 4503.7 4506.8 4524.6 6187.4 6196.3 6212.4 6216.7 6224.1 5661.7 5693.1 5782.2 5803.6 5849.3 6532.6 6608.4 6618.5 6677.2 6693.3 4855.4 4889.4 4899.6 4905.6 4916.1 6660.3 6777.2 6828.3 6851.7 6943.9 4965.4 4992.7 5004.5 5028.8 5029.9 5011.5 5082.6 5088.9 5110.6 5130.4 5700.3 5739.2 5753.0 5761.2 5765.3 6665.2 6669.6 6693.1 6696.4 6750.2 1778.8 1798.2 1800.4 1800.5 1811.0 1129.0 1234.4 1243.7 1244.9 1257.3 5950.4 5960.8 5972.8 5980.7 6008.2 6868.2 6884.0 6886.3 6895.4 6948.0 5895.7 5905.6 5912.2 5921.9 6001.2 3551.8 3578.9 3587.0 3618.6 3618.8 6588.4 6652.0 6658.7 6689.8 6725.3 6639.8 6825.8 6917.8 7008.3 7037.9 6587.3 6603.6 6612.2 6652.4 6681.0 6716.2 6756.3 6791.8 6805.2 6818.7 6687.6 6698.0 6720.2 6758.2 6760.9 6631.2 6655.7 6656.4 6679.4 6714.3 4949.0 4989.1 4991.6 4994.5 4999.5 6661.3 6739.4 6809.9 6916.9 6938.9 6341.2 6566.3 6566.4 6568.9 6620.0 6595.8 6596.2 6608.1 6610.5 6646.7 6523.4 6523.5 6545.4 6553.9 6566.7 6604.6 6610.9 6621.6 6682.1 6720.4 6324.8 6427.6 6434.5 6487.4 6500.5 03:15:05 INFO - PID 2342 | 03:15:05 INFO - PID 2342 | [#5] yui.html Cycles:180 Average:23850.60 Median:20402.85 stddev:32768.63 (160.6%) stddev-sans-first:32815.17 03:15:05 INFO - PID 2342 | Values: 881.9 891.6 897.7 898.5 915.6 18856.8 20371.3 20386.3 20392.7 20413.0 20455.1 20477.7 20784.7 20910.4 20993.9 969.1 987.7 988.6 990.9 991.0 878.1 971.8 973.4 975.6 975.9 1040.3 1044.6 1045.0 1045.8 1045.9 1041.7 1044.2 1044.2 1045.0 1045.5 771.4 773.3 776.6 776.8 777.0 16922.0 17386.7 19203.0 19512.6 19531.3 21444.9 21938.3 21956.2 21965.8 22197.3 16256.3 16625.2 16773.6 16785.5 16806.4 3718.2 3731.8 3736.0 3741.3 3752.8 125466.0 129318.0 129565.4 132178.0 133569.0 16306.3 16445.1 16571.4 16748.8 16979.4 28426.9 28479.3 28781.1 29174.9 30135.8 8979.4 9204.0 9215.1 9244.7 9249.7 4016.5 4055.1 4108.8 4180.7 4199.8 5159.9 5269.2 5284.5 5305.2 5314.6 1019.9 1036.6 1059.5 1060.4 1063.2 650.6 662.3 671.6 677.0 684.1 11334.9 11523.4 11944.9 12841.6 12931.4 641.2 650.6 652.3 659.2 669.8 4782.9 4928.3 5932.1 5994.9 6013.3 103970.0 107115.0 111682.4 114104.4 115938.0 95378.0 97248.5 100656.5 101054.0 106764.0 83534.0 84156.6 84565.6 86405.0 86643.0 11137.6 11479.3 11493.2 11519.6 11627.9 40373.0 41157.2 41253.0 41606.6 42247.0 70284.0 70815.3 72575.0 73665.0 76526.2 17382.5 17482.1 17608.6 17647.6 17681.5 19087.3 19697.0 19898.9 20288.1 20637.4 16677.3 17145.0 17241.1 18051.9 18171.0 17162.7 17344.7 17523.6 17551.6 17678.0 16207.7 16273.3 16307.3 16432.0 17066.1 12795.9 13006.9 13290.6 13590.7 13680.8 13312.5 13515.6 13672.5 13676.6 13796.4 03:15:05 INFO - PID 2342 | -------- Summary: end -------- 03:15:05 INFO - PID 2342 | 03:15:05 INFO - TEST-INFO | 2342: exit 0 03:15:05 INFO - TEST-OK | dromaeo_css | took 1111746ms 03:15:05 INFO - TEST-START | kraken 03:15:05 INFO - Initialising browser for kraken test... 03:15:05 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:45325/getInfo.html -profile /tmp/tmpGtA3re/profile 03:15:05 INFO - TEST-INFO | started process 2811 (/builds/slave/test/build/application/firefox/firefox http://localhost:45325/getInfo.html) 03:15:11 INFO - TEST-INFO | 2811: exit 0 03:15:11 INFO - Browser initialized. 03:15:11 INFO - Running cycle 1/1 for kraken test... 03:15:11 INFO - Using env: {'DISPLAY': ':0', 03:15:11 INFO - 'HOME': '/home/cltbld', 03:15:11 INFO - 'JSGC_DISABLE_POISONING': '1', 03:15:11 INFO - 'LANG': 'en_US.UTF-8', 03:15:11 INFO - 'LANGUAGE': 'en_US:en', 03:15:11 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 03:15:11 INFO - 'LOGNAME': 'cltbld', 03:15:11 INFO - 'MAIL': '/var/mail/cltbld', 03:15:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:15:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:15:11 INFO - 'MOZ_CRASHREPORTER': '1', 03:15:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:15:11 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 03:15:11 INFO - 'MOZ_NO_REMOTE': '1', 03:15:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:15:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:15:11 INFO - 'NO_EM_RESTART': '1', 03:15:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:15:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:15:11 INFO - 'PWD': '/builds/slave/test', 03:15:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:15:11 INFO - 'RUST_BACKTRACE': 'full', 03:15:11 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:15:11 INFO - 'SHELL': '/bin/bash', 03:15:11 INFO - 'SHLVL': '1', 03:15:11 INFO - 'STYLO_FORCE_ENABLED': '1', 03:15:11 INFO - 'STYLO_THREADS': '1', 03:15:11 INFO - 'TERM': 'linux', 03:15:11 INFO - 'TMOUT': '86400', 03:15:11 INFO - 'USER': 'cltbld', 03:15:11 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1504084647.695205-1194294257', 03:15:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:15:11 INFO - '_': '/tools/buildbot/bin/python'} 03:15:11 INFO - TEST-INFO | started process 3104 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGtA3re/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:15:12 INFO - PID 3104 | 03:15:12 INFO - PID 3104 | (/builds/slave/test/build/application/firefox/firefox:3155): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:15:12 INFO - PID 3104 | 03:15:23 INFO - PID 3104 | RSS: Main: 167849984 03:15:23 INFO - PID 3104 | 03:15:25 INFO - PID 3104 | Cycle 1(1): loaded http://localhost:45325/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45325/tests/kraken/driver.html?testName=audio-beat-detection) 03:15:26 INFO - PID 3104 | RSS: Main: 173588480 03:15:26 INFO - PID 3104 | 03:15:29 INFO - PID 3104 | Cycle 1(1): loaded http://localhost:45325/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45325/tests/kraken/driver.html?testName=audio-dft) 03:15:30 INFO - PID 3104 | RSS: Main: 173985792 03:15:30 INFO - PID 3104 | 03:15:33 INFO - PID 3104 | Cycle 1(1): loaded http://localhost:45325/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45325/tests/kraken/driver.html?testName=audio-fft) 03:15:33 INFO - PID 3104 | RSS: Main: 167268352 03:15:33 INFO - PID 3104 | 03:15:35 INFO - PID 3104 | Cycle 1(1): loaded http://localhost:45325/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45325/tests/kraken/driver.html?testName=audio-oscillator) 03:15:36 INFO - PID 3104 | RSS: Main: 167796736 03:15:36 INFO - PID 3104 | 03:15:38 INFO - PID 3104 | Cycle 1(1): loaded http://localhost:45325/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45325/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:15:39 INFO - PID 3104 | RSS: Main: 168742912 03:15:39 INFO - PID 3104 | 03:15:42 INFO - PID 3104 | Cycle 1(1): loaded http://localhost:45325/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45325/tests/kraken/driver.html?testName=imaging-darkroom) 03:15:43 INFO - PID 3104 | RSS: Main: 170938368 03:15:43 INFO - PID 3104 | 03:15:46 INFO - PID 3104 | Cycle 1(1): loaded http://localhost:45325/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45325/tests/kraken/driver.html?testName=imaging-desaturate) 03:15:47 INFO - PID 3104 | RSS: Main: 171261952 03:15:47 INFO - PID 3104 | 03:15:49 INFO - PID 3104 | Cycle 1(1): loaded http://localhost:45325/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45325/tests/kraken/driver.html?testName=json-parse-financial) 03:15:50 INFO - PID 3104 | RSS: Main: 170917888 03:15:50 INFO - PID 3104 | 03:15:52 INFO - PID 3104 | Cycle 1(1): loaded http://localhost:45325/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45325/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:15:52 INFO - PID 3104 | RSS: Main: 170840064 03:15:52 INFO - PID 3104 | 03:15:54 INFO - PID 3104 | Cycle 1(1): loaded http://localhost:45325/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45325/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:15:55 INFO - PID 3104 | RSS: Main: 170795008 03:15:55 INFO - PID 3104 | 03:15:57 INFO - PID 3104 | Cycle 1(1): loaded http://localhost:45325/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45325/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:15:57 INFO - PID 3104 | RSS: Main: 171900928 03:15:57 INFO - PID 3104 | 03:16:00 INFO - PID 3104 | Cycle 1(1): loaded http://localhost:45325/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45325/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:16:01 INFO - PID 3104 | RSS: Main: 171880448 03:16:01 INFO - PID 3104 | 03:16:04 INFO - PID 3104 | Cycle 1(1): loaded http://localhost:45325/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45325/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:16:04 INFO - PID 3104 | RSS: Main: 171397120 03:16:04 INFO - PID 3104 | 03:16:06 INFO - PID 3104 | Cycle 1(1): loaded http://localhost:45325/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45325/tests/kraken/driver.html?testName=ai-astar) 03:16:06 INFO - PID 3104 | RSS: Main: 173199360 03:16:06 INFO - PID 3104 | 03:16:06 INFO - PID 3104 | __start_tp_report 03:16:06 INFO - PID 3104 | _x_x_mozilla_page_load 03:16:06 INFO - PID 3104 | _x_x_mozilla_page_load_details 03:16:06 INFO - PID 3104 | |i|pagename|runs| 03:16:06 INFO - PID 3104 | |0;ai-astar;98;107;102;108;107;109;108;98;109;110 03:16:06 INFO - PID 3104 | |1;audio-beat-detection;139;116;143;176;124;147;141;118;168;119 03:16:06 INFO - PID 3104 | |2;audio-dft;163;162;162;161;162;164;166;166;164;166 03:16:06 INFO - PID 3104 | |3;audio-fft;74;73;74;169;74;74;73;74;163;74 03:16:06 INFO - PID 3104 | |4;audio-oscillator;79;78;131;80;79;80;127;79;79;135 03:16:06 INFO - PID 3104 | |5;imaging-gaussian-blur;113;114;114;113;117;115;114;113;115;115 03:16:06 INFO - PID 3104 | |6;imaging-darkroom;148;147;148;148;149;147;148;149;152;147 03:16:06 INFO - PID 3104 | |7;imaging-desaturate;93;99;94;94;93;94;94;99;94;94 03:16:06 INFO - PID 3104 | |8;json-parse-financial;54;55;57;53;53;53;53;53;53;53 03:16:06 INFO - PID 3104 | |9;json-stringify-tinderbox;39;42;39;38;39;39;38;38;38;37 03:16:06 INFO - PID 3104 | |10;stanford-crypto-aes;77;76;76;75;76;78;74;74;74;82 03:16:06 INFO - PID 3104 | |11;stanford-crypto-ccm;126;124;122;122;124;126;117;117;123;171 03:16:06 INFO - PID 3104 | |12;stanford-crypto-pbkdf2;176;172;176;177;187;181;173;176;171;175 03:16:06 INFO - PID 3104 | |13;stanford-crypto-sha256-iterative;65;66;66;67;67;65;65;69;66;63 03:16:06 INFO - PID 3104 | __end_tp_report 03:16:06 INFO - PID 3104 | __start_cc_report 03:16:06 INFO - PID 3104 | _x_x_mozilla_cycle_collect,906 03:16:06 INFO - PID 3104 | __end_cc_report 03:16:06 INFO - PID 3104 | __startTimestamp1504088166931__endTimestamp 03:16:06 INFO - PID 3104 | 03:16:06 INFO - PID 3104 | ------- Summary: start ------- 03:16:06 INFO - PID 3104 | Number of tests: 14 03:16:06 INFO - PID 3104 | 03:16:06 INFO - PID 3104 | [#0] ai-astar Cycles:10 Average:105.60 Median:109.00 stddev:4.55 (4.2%) stddev-sans-first:3.91 03:16:06 INFO - PID 3104 | Values: 98.0 107.0 102.0 108.0 107.0 109.0 108.0 98.0 109.0 110.0 03:16:06 INFO - PID 3104 | 03:16:06 INFO - PID 3104 | [#1] audio-beat-detection Cycles:10 Average:139.10 Median:142.00 stddev:20.79 (14.6%) stddev-sans-first:22.05 03:16:06 INFO - PID 3104 | Values: 139.0 116.0 143.0 176.0 124.0 147.0 141.0 118.0 168.0 119.0 03:16:06 INFO - PID 3104 | 03:16:06 INFO - PID 3104 | [#2] audio-dft Cycles:10 Average:163.60 Median:164.00 stddev:1.90 (1.2%) stddev-sans-first:2.00 03:16:06 INFO - PID 3104 | Values: 163.0 162.0 162.0 161.0 162.0 164.0 166.0 166.0 164.0 166.0 03:16:06 INFO - PID 3104 | 03:16:06 INFO - PID 3104 | [#3] audio-fft Cycles:10 Average:92.20 Median:74.00 stddev:38.92 (52.6%) stddev-sans-first:40.72 03:16:06 INFO - PID 3104 | Values: 74.0 73.0 74.0 169.0 74.0 74.0 73.0 74.0 163.0 74.0 03:16:06 INFO - PID 3104 | 03:16:06 INFO - PID 3104 | [#4] audio-oscillator Cycles:10 Average:94.70 Median:79.00 stddev:25.13 (31.8%) stddev-sans-first:26.00 03:16:06 INFO - PID 3104 | Values: 79.0 78.0 131.0 80.0 79.0 80.0 127.0 79.0 79.0 135.0 03:16:06 INFO - PID 3104 | 03:16:06 INFO - PID 3104 | [#5] imaging-gaussian-blur Cycles:10 Average:114.30 Median:114.50 stddev:1.25 (1.1%) stddev-sans-first:1.24 03:16:06 INFO - PID 3104 | Values: 113.0 114.0 114.0 113.0 117.0 115.0 114.0 113.0 115.0 115.0 03:16:06 INFO - PID 3104 | 03:16:06 INFO - PID 3104 | [#6] imaging-darkroom Cycles:10 Average:148.30 Median:148.00 stddev:1.49 (1.0%) stddev-sans-first:1.58 03:16:06 INFO - PID 3104 | Values: 148.0 147.0 148.0 148.0 149.0 147.0 148.0 149.0 152.0 147.0 03:16:06 INFO - PID 3104 | 03:16:06 INFO - PID 3104 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:94.00 stddev:2.25 (2.4%) stddev-sans-first:2.29 03:16:06 INFO - PID 3104 | Values: 93.0 99.0 94.0 94.0 93.0 94.0 94.0 99.0 94.0 94.0 03:16:06 INFO - PID 3104 | 03:16:06 INFO - PID 3104 | [#8] json-parse-financial Cycles:10 Average:53.70 Median:53.00 stddev:1.34 (2.5%) stddev-sans-first:1.41 03:16:06 INFO - PID 3104 | Values: 54.0 55.0 57.0 53.0 53.0 53.0 53.0 53.0 53.0 53.0 03:16:06 INFO - PID 3104 | 03:16:06 INFO - PID 3104 | [#9] json-stringify-tinderbox Cycles:10 Average:38.70 Median:39.00 stddev:1.34 (3.4%) stddev-sans-first:1.41 03:16:06 INFO - PID 3104 | Values: 39.0 42.0 39.0 38.0 39.0 39.0 38.0 38.0 38.0 37.0 03:16:06 INFO - PID 3104 | 03:16:06 INFO - PID 3104 | [#10] stanford-crypto-aes Cycles:10 Average:76.20 Median:76.00 stddev:2.44 (3.2%) stddev-sans-first:2.57 03:16:06 INFO - PID 3104 | Values: 77.0 76.0 76.0 75.0 76.0 78.0 74.0 74.0 74.0 82.0 03:16:06 INFO - PID 3104 | 03:16:06 INFO - PID 3104 | [#11] stanford-crypto-ccm Cycles:10 Average:127.20 Median:124.00 stddev:15.71 (12.7%) stddev-sans-first:16.66 03:16:06 INFO - PID 3104 | Values: 126.0 124.0 122.0 122.0 124.0 126.0 117.0 117.0 123.0 171.0 03:16:06 INFO - PID 3104 | 03:16:06 INFO - PID 3104 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.40 Median:176.00 stddev:4.67 (2.7%) stddev-sans-first:4.95 03:16:06 INFO - PID 3104 | Values: 176.0 172.0 176.0 177.0 187.0 181.0 173.0 176.0 171.0 175.0 03:16:06 INFO - PID 3104 | 03:16:06 INFO - PID 3104 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.90 Median:66.00 stddev:1.60 (2.4%) stddev-sans-first:1.66 03:16:06 INFO - PID 3104 | Values: 65.0 66.0 66.0 67.0 67.0 65.0 65.0 69.0 66.0 63.0 03:16:06 INFO - PID 3104 | -------- Summary: end -------- 03:16:06 INFO - PID 3104 | 03:16:07 INFO - PID 3104 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 03:16:07 INFO - TEST-INFO | 3104: exit 0 03:16:07 INFO - TEST-OK | kraken | took 61779ms 03:16:07 INFO - SUITE-END | took 1173s 03:16:08 INFO - Completed test suite (00:19:33) 03:16:08 INFO - javascript benchmark 03:16:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8622.067909622469, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3343.8160901150427, 3355.949660755088, 3371.8482668279935, 3379.442392005319, 3399.269157131218, 6379.2344918609715, 6474.384933431323, 6485.513586481015, 6523.510736694743, 6529.412352888239, 6315.842103947392, 6391.488680905528, 6394.360563943604, 6404.51966102543, 6431.196100487439, 5811.883762324751, 5813.593048486597, 5833.037548804442, 5929.169916211734, 6018.578699491038, 6021.157038014681, 6034.487068599175, 6043.153958445821, 6061.848453788646, 6082.330943596201, 1068.8312499024612, 5848.67832269225, 5912.290525136989, 5994.130851026599, 6029.939700603004, 5860.531157507389, 5864.941350586482, 5883.323417806964, 5972.134040564094, 5986.820395388102, 5866.76532938682, 5876.382979787104, 5952.553558483131, 5959.731812068424, 5960.910586341209, 6411.8397040073905, 6419.486441084702, 6424.743010279583, 6492.902606460907, 6526.445252153572, 6912.481563882729, 6933.583984960868, 6991.650417479156, 7022.754203602849, 7028.226895041593, 6869.0383346331055, 7000.649967501605, 7013.158420989463, 7102.964485177593, 7106.928930710678, 6302.653354065525, 6306.1171435998995, 6307.369263073656, 6309.242890853081, 6354.618722876596, 6942.0, 7146.3210994956435, 7181.06646135999, 7227.602481863548, 7232.529885557422, 6781.152355955505, 6790.864182716318, 6812.182538095361, 6816.829579260459, 6818.761343352959, 6834.419074378634, 6834.555753875982, 6936.965315173392, 6942.097527321416, 6947.756828510978, 6625.569337993015, 6781.796546103625, 6797.6601169941305, 6879.552829066095, 6883.036374907517, 6864.931350686429, 6868.175818901764, 6882.414994725505, 6888.035675005503, 6891.517593768388, 5039.496050395004, 5071.06185355703, 5129.692218466829, 5130.692158470503, 5131.846044618667, 4463.152001119777, 4513.390692256569, 4529.479109902403, 4553.817847286137, 4570.337301091323, 6067.059605761114, 6080.331163572004, 6083.7566497340495, 6162.5378096642935, 6165.198524191826, 6764.763233286812, 6919.7232110715, 6969.6166710830375, 7046.260142685047, 7054.470914681419, 6050.909236361458, 6083.178770865877, 6088.908666370008, 6102.69486525672, 6124.663143527059, 5973.37279585646, 6043.637381757108, 6055.485283750842, 6058.818235452944, 6060.030395136757, 6842.110525631736, 6857.314268573203, 6881.621510816853, 6882.8623427531165, 6883.380495755406, 6976.441884649216, 6984.476164287597, 7001.089858318386, 7101.11236095488, 7102.715891364288, 6665.700043498151, 6738.0, 6782.728690852508, 6871.690773915086, 6873.243943166348, 6802.01370801241, 6812.25065242813, 6815.079964204769, 6821.931780682328, 6825.215100263533, 6923.93076069253, 6929.514933954575, 6929.861402772017, 6939.757108501179, 6953.79138625842, 5888.0832253498875, 6673.366030227121, 6722.932770672231, 6733.0573719678305, 6808.93191068083, 6554.868902621825, 6712.966435167793, 6726.6636668167375, 6790.219124800514, 6840.939654353583, 6568.244651865097, 6608.768693095719, 6617.205935287604, 6620.172478440195, 6621.5364924454825, 6684.83287917806, 6697.866042679217, 6723.092382528492, 6911.688973996283, 6915.757948471779, 6550.803475895731, 6550.967245163743, 6649.03588979605, 6656.400923916871, 6659.667016649245], "value": 6264.109257219482, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [779.2674885607529, 818.5579786915066, 846.0397448895503, 879.780054986253, 879.7800549862534, 38937.61062389375, 40305.19389612206, 40385.7980710096, 40402.19195616086, 40470.392944105864, 36621.26757464849, 36822.263554728954, 36828.81585592075, 36850.0, 36859.631403685955, 6752.966235168818, 6892.758753443631, 6893.20728116268, 6895.862082758342, 6897.724091036353, 6768.8307792305095, 6871.175458944934, 6874.725010999554, 6876.071730316393, 6879.9312006880045, 7371.631418429084, 7551.69793208271, 7555.773326800205, 7556.1688214296655, 7557.886631700529, 7418.999999999973, 7535.20880307568, 7537.397008239355, 7542.962285188594, 7544.585047822367, 7321.74373896911, 7486.064241969754, 7492.812679683051, 7496.325330720207, 7497.1753107158165, 36409.817950910074, 36574.63425365739, 36600.45099323512, 36647.633523664954, 36652.63347366519, 3543.8936831895085, 3585.265020670782, 3586.677199052098, 3593.82030898454, 3594.8382322795537, 30488.69511304903, 30570.388592228253, 30594.38811223763, 30655.69344306573, 30665.69334306673, 5122.1804511278015, 5137.7944882204665, 5166.535011848951, 5175.223716442526, 5177.637565370425, 180428.0, 183179.0, 186250.0, 186500.0, 192695.03652481787, 45172.77413612911, 45417.0, 45501.54498455039, 45504.77247613807, 45597.31604025942, 46548.301775473396, 46591.0, 46637.30044049342, 46683.29975050377, 46746.0, 14503.782443263359, 14518.419263229353, 14627.414903403958, 14673.266336683124, 14676.11943283385, 13107.934460327637, 13121.212727236205, 13155.0, 13167.209967401986, 13175.275359855108, 13024.804627930589, 13028.54400096011, 13036.217826930415, 13036.869631303754, 13172.868271317357, 5268.868278292996, 5270.525652691276, 5327.094393953037, 5406.459354064562, 5470.7264636768, 999.260547195085, 1006.7885743993843, 1018.0786388318584, 1029.3926583315729, 1048.2452634103433, 22207.666884996415, 22891.656625150637, 22921.426964325692, 22975.0, 23285.3014409568, 1105.9944700276608, 1107.5901916290863, 1120.2270433400927, 1122.186414849244, 1135.233717240859, 11541.105785996946, 12115.939420302842, 12141.75716485683, 15667.451639192801, 15833.287502062434, 240543.0, 242534.0, 242717.0, 242983.0, 243748.0, 54223.45776542263, 54703.0, 55056.724716376964, 55174.724126379115, 55189.44810551924, 1422.2319947228382, 1450.376338174574, 1454.0766613200694, 1454.7308747881675, 1460.7218683651804, 27045.0, 27257.86371068132, 27397.726022739516, 27714.307142321602, 27890.581641275803, 37405.251894962494, 37422.438663419525, 37539.24921501609, 37572.0, 37578.62421375861, 213604.0, 214187.0, 214405.0, 214573.0, 214984.0, 32420.351592967538, 35452.0, 35966.0, 36231.0, 36249.0, 42438.57561424346, 43487.347689784045, 43819.56180438155, 44015.77992110019, 44540.55459445364, 32727.672723273416, 32972.1756956078, 32980.340393192484, 33840.66159338375, 34035.65964340325, 32510.0, 33019.504707428925, 33192.502112468814, 33498.49752253767, 33729.0, 36433.0, 37335.0, 37865.43201851919, 37887.052823678525, 37958.0, 32095.592830537335, 32245.838770805996, 32682.182945426553, 33495.0, 34173.9495630263, 24481.0, 24922.626160607244, 24987.0, 25607.0, 25794.613080804178], "value": 17034.666991694663, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [568.7724910035988, 573.5067841656178, 578.560294176426, 580.1355979590412, 583.7635757518204, 21353.893230533846, 22271.554568908614, 22358.441038974033, 22360.99375528101, 22472.101115955382, 25453.0, 25960.35099122523, 25966.74033259667, 25986.35034124148, 26010.479790404228, 6523.6738163091895, 6661.966690166542, 6663.500237482184, 6665.40011398974, 6666.500012499057, 6164.29110652274, 6417.229932408118, 6448.967755161241, 6455.0, 6458.709358078874, 6425.903611445832, 6426.646534440604, 6427.2287325520765, 6429.7106630201515, 6434.678266086677, 6421.903671444932, 6423.389777971085, 6427.742890284383, 6428.164338635994, 6429.260635026985, 5943.55423343251, 5946.316173640043, 5946.583739138262, 5957.791477298317, 5962.046072628402, 28763.56854647182, 29695.554566681516, 29881.551776723365, 29935.401291974038, 30262.243443914078, 2039.6838490034067, 2079.750429948401, 2080.5630817528186, 2083.3541602103396, 2090.237063471822, 19175.712364314546, 19183.424497265103, 19531.0, 20035.499112522302, 20139.39581812548, 2419.879006049708, 2436.7049217057966, 2450.6079027355718, 2450.9754902450927, 2476.863772492512, 138381.0, 141637.0, 142643.0, 145904.270478648, 146368.0, 14509.92745036268, 14641.780373294408, 15042.172680502677, 15231.705305049194, 15363.692726145639, 21171.0, 21190.364289071353, 21214.15143394247, 21219.36341909745, 21229.0, 10171.643992460376, 10262.127719143808, 10311.535980880879, 10335.844962325571, 10403.53184106717, 8436.957815210884, 8803.955980220058, 8863.2466240369, 9696.6121355145, 9840.11438970496, 9218.262538996863, 9435.386699864486, 9485.430874147572, 9498.240140788721, 9530.90469095314, 2733.931651708723, 2782.582612608125, 2785.749282564579, 2790.1629511146575, 2791.860406979643, 959.7456673981401, 978.6085565773748, 985.3644399362514, 988.5106872098357, 1009.8838633557089, 19766.011699414972, 19973.0, 19988.60022799565, 20119.295824646066, 20327.983600819898, 1040.4485622620023, 1044.3316277582353, 1065.1532032034552, 1067.3435836960214, 1068.8450174724621, 11006.669799906016, 11141.498632561554, 11233.438328083726, 11281.774364512828, 11287.322760634388, 471358.0, 486984.0, 489222.0, 490182.0, 491669.0, 112701.43649281701, 115163.0, 115443.42278288555, 116120.41939790247, 116912.0, 1187.3410257307105, 1197.239752756988, 1208.8368070310396, 1209.3106929050532, 1285.2095960983927, 21097.789022109584, 21337.89331053335, 21414.785852141278, 21491.570168596852, 21565.137394504673, 59817.700911495165, 60157.0, 60183.69908150431, 60270.39729602648, 61566.0, 73842.0, 74499.62750186214, 74742.25257747571, 75350.86973695508, 83214.58392707998, 21161.0, 21869.234576789735, 21910.45223869416, 21959.34121976343, 22014.669779952994, 23636.52726945417, 23668.881655591613, 24248.0, 24382.26853194407, 24500.142495012587, 19051.61896762085, 19742.0, 19832.504187394854, 19841.0, 19889.403317900487, 17980.460586182435, 17981.65137614658, 18019.2792288307, 18200.81799182044, 18246.635067298314, 20367.0, 20387.59224815466, 20513.89743051335, 20593.48516287105, 20628.690569641167, 20642.79357206469, 21868.781312186675, 21988.89005555026, 22140.778592213872, 22215.333539993826, 18366.357177498725, 19401.32095376655, 19727.506812329808, 19868.50328741793, 19978.20087196496], "value": 12480.375427623205, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1333.3333333333333, 1379.827521559805, 1384.7715127004042, 1388.8125103111076, 1391.0471327140908, 14896.329665165067, 15664.060156390624, 15701.685966280667, 15727.60680982976, 15734.84265157348, 15944.840551594481, 16081.517554473356, 16112.597185070379, 16121.27454264558, 16137.515874523753, 2390.9760902390926, 2447.79193768529, 2472.888720007595, 2474.9628755568683, 2475.269795410349, 2659.2421159969413, 2746.0, 2810.6205662235543, 2811.7750579953554, 2812.072016234638, 2711.4983728010284, 2760.489309477753, 2762.4889395461805, 2778.9305267368277, 2782.3322402623426, 2709.2684975056823, 2713.592961055838, 2721.7958653100995, 2722.1561315992008, 2729.7543221109995, 2648.298200976743, 2654.6814382274056, 2665.693445253801, 2666.266776636421, 2667.5865240887692, 14855.0, 15191.544253672408, 15195.848041519554, 15208.619784505365, 15230.46693365727, 7790.727324543671, 8011.838283448926, 8292.17078292172, 8296.419250652456, 8303.83392332156, 5332.280142180794, 5342.652727572696, 5364.30264065669, 5423.430539793304, 5461.399246082928, 1824.2611742244412, 1862.4878158506383, 1874.2877706471454, 1930.951726206842, 1932.8743631663897, 25698.614520782205, 25912.611310830354, 25980.74019259802, 26005.73994260052, 26089.608655870175, 6701.961196014626, 6872.965635171792, 7062.011318415426, 7129.394001509826, 7130.429565634737, 17019.82980170207, 17257.137143142794, 17294.82705172932, 17403.65192696139, 17457.0, 7743.651535680908, 7914.881276780853, 7918.6436610352675, 7923.286904178652, 7928.246816552418, 7225.843864981578, 7342.302481264272, 7353.0441042664115, 7375.336219740249, 7410.777676669709, 4908.9754551227015, 5014.0974624567925, 5045.747712614428, 5047.520485553867, 5072.543471087546, 1365.3105181883086, 1371.602235351737, 1374.6700791810094, 1393.540131756518, 1399.7970294307472, 893.3657103456619, 916.6608354908593, 920.6823645842173, 921.0927236671873, 936.4147407870081, 7806.726764563213, 7849.568273744999, 7911.090224624242, 7941.245581669732, 7987.720429784929, 702.9261927497539, 715.0347031507528, 715.6850985566334, 717.1680850213727, 718.306833905284, 4762.190427627312, 4763.45220299663, 5443.482869127427, 5460.426655201147, 5608.046632072557, 22331.330060098222, 22431.10275588958, 22757.772422275895, 22832.885835571047, 22915.656265156034, 21408.464788380104, 22051.448713782283, 22348.888255558944, 22678.773212267995, 22860.542789144456, 11608.24546404481, 11835.940820295844, 11891.345975971404, 11935.820962685566, 11977.101717371232, 7849.7645070645685, 7852.332551732939, 8115.594220288844, 8471.66113355459, 8659.696910608098, 18415.90792046031, 18655.813441865408, 18904.52738681544, 19244.615107698046, 19276.421707348803, 18637.90681046586, 19153.52116197106, 19389.51526211856, 19734.605307893475, 19782.40652780419, 11687.88312116902, 11818.704532386759, 12002.939985300018, 12295.75408491843, 12333.691657708629, 13497.39261733244, 13606.727865442437, 13610.93194534021, 13610.93194534021, 13626.182429054288, 11344.432778360884, 11345.829812552984, 11507.712307192387, 11549.480273387886, 11656.592019279284, 11211.159163062639, 11213.102951763676, 11289.830652540382, 11474.368909709712, 11489.253198542403, 9501.61993520279, 9777.315587908779, 9778.706638800848, 9779.902200977898, 9786.46174460383, 7030.15638123408, 7034.120734908137, 7039.718411263492, 7087.184973728087, 7104.3961263293195, 7148.821279468055, 7283.526570772883, 7330.816729581803, 7364.742234021998, 7377.225391334047], "value": 6630.950924028805, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [502.34033802706574, 519.9272101905734, 529.3647622852573, 531.3305235403392, 537.1888448442852, 6365.52258580606, 6370.681465926703, 6425.678716064202, 6455.3544645535485, 6465.321141280168, 6221.377862213776, 6269.404406581368, 6322.34461526159, 6343.0, 6355.968220158893, 5259.631825772188, 5270.710110943896, 5272.762725677335, 5284.2866213061125, 5314.282571852789, 4902.039184326262, 5037.168867136918, 5073.594112471012, 5212.452692467293, 5263.631545791796, 4996.4503904570465, 5010.3737032870895, 5035.0, 5041.621878359119, 5044.092063428581, 4907.478681608713, 5009.2486127080865, 5010.874728131789, 5024.001118886731, 5036.722980236085, 4492.797824097924, 4502.099580083996, 4503.684742068057, 4506.842260520899, 4524.6380289576755, 6187.381261873822, 6196.318404975449, 6212.4408803207925, 6216.658083805389, 6224.066390041485, 5661.745221465044, 5693.117566777156, 5782.190493330937, 5803.593748437611, 5849.327327357366, 6532.572980854739, 6608.4052435281055, 6618.4705223582, 6677.198736151644, 6693.297203793629, 4855.393075865517, 4889.413270407574, 4899.632527560448, 4905.558499735041, 4916.139675556763, 6660.300668429793, 6777.220619628756, 6828.283030281848, 6851.657417129124, 6943.89584156238, 4965.4289756678445, 4992.650514463952, 5004.549590536869, 5028.84913452597, 5029.899402012013, 5011.498850114959, 5082.593392528589, 5088.898222035538, 5110.61670374716, 5130.410002849645, 5700.3444603871085, 5739.167820666064, 5753.0, 5761.193432919395, 5765.336986246635, 6665.166854143232, 6669.63317017559, 6693.129893113962, 6696.397324240842, 6750.189977202669, 1778.813224611423, 1798.1548672124081, 1800.3608718904861, 1800.5318617159633, 1811.031098362396, 1128.9943550282196, 1234.3889774561649, 1243.6890777305673, 1244.9439775210137, 1257.3147634539198, 5950.434708702666, 5960.821175364746, 5972.760214919405, 5980.700964951735, 6008.188894499274, 6868.175818901764, 6883.965580172167, 6886.2769409212315, 6895.379415852497, 6947.965260173768, 5895.734691938873, 5905.59637931288, 5912.231409916683, 5921.881562368814, 6001.159837622737, 3551.8046507441823, 3578.928421431609, 3587.0, 3618.565772107364, 3618.7696183297803, 6588.439982601437, 6652.0, 6658.667066646745, 6689.799306020827, 6725.327467253235, 6639.767608133789, 6825.829354266084, 6917.757878474229, 7008.334208250208, 7037.894431583531, 6587.275399706028, 6603.570767900071, 6612.206535215805, 6652.4388110577775, 6681.0, 6716.1604799400075, 6756.324367563401, 6791.830204244933, 6805.183377994672, 6818.693158807766, 6687.565308254948, 6697.995300704738, 6720.1599800025, 6758.189017317756, 6760.898586521304, 6631.237407697983, 6655.667216639245, 6656.434203092597, 6679.398854103154, 6714.328567143247, 4948.956391819077, 4989.12690279207, 4991.57571606403, 4994.450610432777, 4999.500049994971, 6661.3338666132995, 6739.42714869222, 6809.93190068093, 6916.896246556205, 6938.895916561155, 6341.207349081365, 6566.343365663586, 6566.358410397401, 6568.868622627616, 6620.0, 6595.835104122243, 6596.241432235354, 6608.107905432705, 6610.537262391779, 6646.7341306349135, 6523.445507131947, 6523.478121750154, 6545.37818907203, 6553.934460655523, 6566.671666416564, 6604.63674497888, 6610.933890661032, 6621.569597976116, 6682.131322927989, 6720.428763555153, 6324.810255692337, 6427.55007149495, 6434.549581529435, 6487.416132547904, 6500.544961852814], "value": 5129.420014665805, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [881.8941726992762, 891.6166048599101, 897.6768363389183, 898.4913911176857, 915.574257970044, 18856.81143188568, 20371.287004954847, 20386.286479973205, 20392.69410958833, 20413.0, 20455.079521421536, 20477.692834607493, 20784.688229676565, 20910.37268881936, 20993.895030524865, 969.064852417417, 987.7086259553413, 988.5600907596123, 990.9009099090069, 990.9653162139326, 878.1438097854573, 971.8153550825356, 973.3819024919156, 975.6000039983608, 975.9463229522373, 1040.3081950502906, 1044.5560636729397, 1044.984325235122, 1045.8378951262566, 1045.921555883308, 1041.7031146123356, 1044.1698849414695, 1044.222054569347, 1045.0229035851503, 1045.4981608827804, 771.417579727308, 773.3001633521671, 776.6194564663331, 776.798032511551, 776.9805754856118, 16922.0, 17386.739198912026, 19203.0, 19512.609747805105, 19531.316403925794, 21444.892775536024, 21938.341849744535, 21956.23153189631, 21965.780342196693, 22197.334079977627, 16256.349746010146, 16625.168741562873, 16773.580660483585, 16785.496435106965, 16806.41177558792, 3718.1819999600043, 3731.8134093295225, 3736.0, 3741.3265612189794, 3752.7935963521995, 125466.0, 129318.0, 129565.35217323947, 132177.99999999904, 133569.0, 16306.347746090261, 16445.09551974629, 16571.42000029993, 16748.83251167497, 16979.405720799714, 28426.857865710954, 28479.288017799307, 28781.136565902638, 29174.85412572966, 30135.849320753256, 8979.371443998987, 9204.033576474507, 9215.078492150866, 9244.676436324697, 9249.722508324761, 4016.5180178378196, 4055.1078762672164, 4108.753474791522, 4180.707350485498, 4199.790010499524, 5159.922601160985, 5269.1832765921345, 5284.497972692588, 5305.151175811851, 5314.5748340132695, 1019.90820826126, 1036.5594622285498, 1059.5496913811598, 1060.4326685223368, 1063.2185343772321, 650.612885333226, 662.29134825736, 671.5634837355758, 677.0453660338899, 684.1277371351566, 11334.94332528332, 11523.366214858263, 11944.940275298568, 12841.614751557468, 12931.418086186144, 641.1504756198057, 650.612885333226, 652.2596852572365, 659.1727382135485, 669.8224970382853, 4782.928256076161, 4928.28539861718, 5932.139839723216, 5994.940050599438, 6013.30846952606, 103970.0, 107115.0, 111682.44158779155, 114104.42947785374, 115938.0, 95378.0, 97248.51375743076, 100656.49671751594, 101054.0, 106764.0, 83534.0, 84156.57921710475, 84565.57717211374, 86405.0, 86643.0, 11137.610183643534, 11479.311241325548, 11493.195476316578, 11519.596814111466, 11627.88372116268, 40373.0, 41157.1768564633, 41253.0, 41606.58393416027, 42247.0, 70284.0, 70815.29184708293, 72575.0, 73665.0, 76526.23473765414, 17382.478525644252, 17482.125893705008, 17608.55978600545, 17647.64704705873, 17681.46955591283, 19087.331943381916, 19697.0, 19898.90050549738, 20288.087036083118, 20637.380878573666, 16677.332906683598, 17145.0, 17241.0517421538, 18051.909740451214, 18171.0, 17162.656746865243, 17344.69914756373, 17523.649527009642, 17551.561210969827, 17678.0, 16207.675846482769, 16273.3490660377, 16307.266173022004, 16432.0, 17066.146692665567, 12795.872041279468, 13006.869931300565, 13290.601281961557, 13590.660233494242, 13680.794788078387, 13312.534061307808, 13515.59453216405, 13672.453101875813, 13676.589702308947, 13796.448142074205], "value": 9069.3986581494, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1490.7000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 107.0, 102.0, 108.0, 107.0, 109.0, 108.0, 98.0, 109.0, 110.0], "value": 105.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 116.0, 143.0, 176.0, 124.0, 147.0, 141.0, 118.0, 168.0, 119.0], "value": 139.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 162.0, 161.0, 162.0, 164.0, 166.0, 166.0, 164.0, 166.0], "value": 163.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 74.0, 169.0, 74.0, 74.0, 73.0, 74.0, 163.0, 74.0], "value": 92.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 131.0, 80.0, 79.0, 80.0, 127.0, 79.0, 79.0, 135.0], "value": 94.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 114.0, 113.0, 117.0, 115.0, 114.0, 113.0, 115.0, 115.0], "value": 114.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 148.0, 148.0, 149.0, 147.0, 148.0, 149.0, 152.0, 147.0], "value": 148.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 99.0, 94.0, 94.0, 93.0, 94.0, 94.0, 99.0, 94.0, 94.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 57.0, 53.0, 53.0, 53.0, 53.0, 53.0, 53.0, 53.0], "value": 53.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [39.0, 42.0, 39.0, 38.0, 39.0, 39.0, 38.0, 38.0, 38.0, 37.0], "value": 38.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 76.0, 75.0, 76.0, 78.0, 74.0, 74.0, 74.0, 82.0], "value": 76.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 124.0, 122.0, 122.0, 124.0, 126.0, 117.0, 117.0, 123.0, 171.0], "value": 127.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 172.0, 176.0, 177.0, 187.0, 181.0, 173.0, 176.0, 171.0, 175.0], "value": 176.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 66.0, 67.0, 67.0, 65.0, 65.0, 69.0, 66.0, 63.0], "value": 65.9, "unit": "score"}]}]} 03:16:08 INFO - Return code: 0 03:16:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:16:08 INFO - # TBPL SUCCESS # 03:16:08 INFO - Running post-action listener: _package_coverage_data 03:16:08 INFO - Running post-action listener: _resource_record_post_action 03:16:08 INFO - [mozharness: 2017-08-30 10:16:08.221903Z] Finished run-tests step (success) 03:16:08 INFO - Running post-run listener: _resource_record_post_run 03:16:08 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 393822208; Read time: 8; Write time: 347820 03:16:08 INFO - TinderboxPrint: CPU usage
13.1% 03:16:08 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 03:16:08 INFO - TinderboxPrint: I/O write bytes / time
393,822,208 / 347,820 03:16:08 INFO - TinderboxPrint: CPU idle
8,249.1 (86.9%) 03:16:08 INFO - TinderboxPrint: CPU user
1,193.9 (12.6%) 03:16:08 INFO - TinderboxPrint: Swap in / out
0 / 0 03:16:08 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 106704896; Read time: 0; Write time: 110336 03:16:08 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 03:16:08 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 4096; Write bytes: 287117312; Read time: 8; Write time: 237484 03:16:08 INFO - Running post-run listener: _upload_blobber_files 03:16:08 INFO - Blob upload gear active. 03:16:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:16:08 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 03:16:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:16:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:16:09 INFO - (blobuploader) - INFO - Open directory for files ... 03:16:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:16:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:16:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:16:16 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:16:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:16:16 INFO - (blobuploader) - INFO - Done attempting. 03:16:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:16:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:16:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:16:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:16:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:16:17 INFO - (blobuploader) - INFO - Done attempting. 03:16:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:16:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:16:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:16:18 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:16:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:16:18 INFO - (blobuploader) - INFO - Done attempting. 03:16:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:16:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:16:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:16:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:16:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:16:19 INFO - (blobuploader) - INFO - Done attempting. 03:16:19 INFO - (blobuploader) - INFO - Iteration through files over. 03:16:19 INFO - Return code: 0 03:16:19 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:16:19 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:16:19 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1f8789fd29d689a57ddb180b8989d31c77cc3b4a25744b785abcde6857cd457791d7bc1c548dc0c0084645c4698227368bda45b1a334c8d5eadd5c81bb978a95", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/be2f665d0093bae97c07fa0bd7460338bc61a09e2e29f15865baa6bbcc07ac6ebc042b4f13ce3870e376a94361b9b9687ecbd7cac2f8a37112057e9988f08b57", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9273907d707531c1b58feac9bc0e4bd4f9e8de11f328220433bdbdb46ac3e89f330ff6efae2d0956ae49be68fcb6b724bf8f2337ade043172c78842cade93f77", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d0ea672e5a5dd8ebb38ff6d2e01f9b9e4f4f6f79f2fa1d46a180d1085265a2ebcd31598baf7c921200cc1bed36487970d866cde98cc50ff76f31307d1e043e74"} 03:16:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:16:19 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:16:19 INFO - Contents: 03:16:19 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1f8789fd29d689a57ddb180b8989d31c77cc3b4a25744b785abcde6857cd457791d7bc1c548dc0c0084645c4698227368bda45b1a334c8d5eadd5c81bb978a95", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/be2f665d0093bae97c07fa0bd7460338bc61a09e2e29f15865baa6bbcc07ac6ebc042b4f13ce3870e376a94361b9b9687ecbd7cac2f8a37112057e9988f08b57", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9273907d707531c1b58feac9bc0e4bd4f9e8de11f328220433bdbdb46ac3e89f330ff6efae2d0956ae49be68fcb6b724bf8f2337ade043172c78842cade93f77", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d0ea672e5a5dd8ebb38ff6d2e01f9b9e4f4f6f79f2fa1d46a180d1085265a2ebcd31598baf7c921200cc1bed36487970d866cde98cc50ff76f31307d1e043e74"} 03:16:19 INFO - Running post-run listener: copy_logs_to_upload_dir 03:16:19 INFO - Copying logs to upload dir... 03:16:19 INFO - mkdir: /builds/slave/test/build/upload/logs 03:16:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1252.664550 ========= master_lag: 0.90 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2017-08-30 03:16:20.472868) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-30 03:16:20.475075) ========= 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=232498196343f89f466a4a9a000001c8-1504084647.695205-1194294257 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1f8789fd29d689a57ddb180b8989d31c77cc3b4a25744b785abcde6857cd457791d7bc1c548dc0c0084645c4698227368bda45b1a334c8d5eadd5c81bb978a95", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/be2f665d0093bae97c07fa0bd7460338bc61a09e2e29f15865baa6bbcc07ac6ebc042b4f13ce3870e376a94361b9b9687ecbd7cac2f8a37112057e9988f08b57", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9273907d707531c1b58feac9bc0e4bd4f9e8de11f328220433bdbdb46ac3e89f330ff6efae2d0956ae49be68fcb6b724bf8f2337ade043172c78842cade93f77", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d0ea672e5a5dd8ebb38ff6d2e01f9b9e4f4f6f79f2fa1d46a180d1085265a2ebcd31598baf7c921200cc1bed36487970d866cde98cc50ff76f31307d1e043e74"} build_url:https://queue.taskcluster.net/v1/task/eSP-W7eQTHm081zyISUr-A/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011230 build_url: 'https://queue.taskcluster.net/v1/task/eSP-W7eQTHm081zyISUr-A/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1f8789fd29d689a57ddb180b8989d31c77cc3b4a25744b785abcde6857cd457791d7bc1c548dc0c0084645c4698227368bda45b1a334c8d5eadd5c81bb978a95", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/be2f665d0093bae97c07fa0bd7460338bc61a09e2e29f15865baa6bbcc07ac6ebc042b4f13ce3870e376a94361b9b9687ecbd7cac2f8a37112057e9988f08b57", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9273907d707531c1b58feac9bc0e4bd4f9e8de11f328220433bdbdb46ac3e89f330ff6efae2d0956ae49be68fcb6b724bf8f2337ade043172c78842cade93f77", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d0ea672e5a5dd8ebb38ff6d2e01f9b9e4f4f6f79f2fa1d46a180d1085265a2ebcd31598baf7c921200cc1bed36487970d866cde98cc50ff76f31307d1e043e74"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-30 03:16:20.501415) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-30 03:16:20.505790) ========= 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=232498196343f89f466a4a9a000001c8-1504084647.695205-1194294257 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004569 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-30 03:16:20.555607) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-30 03:16:20.558038) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-30 03:16:20.558414) ========= ========= Total master_lag: 1.07 =========